Dec 27 15:41:00 volumio ntpd[781]: CLOCK: time stepped by 29.780845 Dec 27 15:41:00 volumio ntpd[781]: INIT: MRU 13107 entries, 13 hash bits, 32768 bytes Dec 27 15:41:00 volumio ntpd[781]: DNS: dns_check: processing 1.debian.pool.ntp.org, 8, 101 Dec 27 15:41:00 volumio ntpd[781]: DNS: Pool taking: 93.95.98.77 Dec 27 15:41:00 volumio ntpd[781]: DNS: Pool taking: 151.0.2.53 Dec 27 15:41:00 volumio ntpd[781]: DNS: Pool taking: 176.58.60.71 Dec 27 15:41:00 volumio ntpd[781]: DNS: Pool taking: 90.188.6.85 Dec 27 15:41:00 volumio ntpd[781]: DNS: dns_take_status: 1.debian.pool.ntp.org=>good, 8 Dec 27 15:41:00 volumio volumio[1033]: info: MYVOLUMIO Environment detected Dec 27 15:41:00 volumio volumio[1033]: info: Plugin folders cleanup Dec 27 15:41:00 volumio volumio[1033]: info: Scanning into folder /volumio/app/plugins/ Dec 27 15:41:00 volumio volumio[1033]: info: Scanning category audio_interface Dec 27 15:41:00 volumio volumio[1033]: info: Scanning category miscellanea Dec 27 15:41:00 volumio volumio[1033]: info: Scanning category music_service Dec 27 15:41:00 volumio volumio[1033]: info: Scanning category plugins.json Dec 27 15:41:00 volumio volumio[1033]: info: Scanning category system_controller Dec 27 15:41:00 volumio volumio[1033]: info: Scanning category user_interface Dec 27 15:41:00 volumio volumio[1033]: info: Scanning into folder /data/plugins/ Dec 27 15:41:00 volumio volumio[1033]: info: Scanning category music_service Dec 27 15:41:00 volumio volumio[1033]: info: Scanning category system_controller Dec 27 15:41:00 volumio volumio[1033]: info: Scanning category system_hardware Dec 27 15:41:00 volumio volumio[1033]: info: Plugin folders cleanup completed Dec 27 15:41:00 volumio volumio[1033]: info: ------------------------------------------- Dec 27 15:41:00 volumio volumio[1033]: info: ----- Core plugins startup ---- Dec 27 15:41:00 volumio volumio[1033]: info: ------------------------------------------- Dec 27 15:41:00 volumio volumio[1033]: info: Loading plugins from folder /volumio/app/plugins/ Dec 27 15:41:00 volumio volumio[1033]: info: Adding plugin upnp to MyMusic Plugins Dec 27 15:41:00 volumio volumio[1033]: info: Adding plugin airplay_emulation to MyMusic Plugins Dec 27 15:41:00 volumio volumio[1033]: info: Adding plugin upnp_browser to MyMusic Plugins Dec 27 15:41:00 volumio volumio[1033]: info: Loading plugins from folder /data/plugins/ Dec 27 15:41:00 volumio volumio[1033]: info: Loading plugin "system"... Dec 27 15:41:00 volumio volumio[1033]: info: Loading plugin "appearance"... Dec 27 15:41:01 volumio ntpd[781]: DNS: dns_probe: 0.debian.pool.ntp.org, cast_flags:8, flags:101 Dec 27 15:41:01 volumio ntpd[781]: DNS: dns_check: processing 0.debian.pool.ntp.org, 8, 101 Dec 27 15:41:01 volumio ntpd[781]: DNS: Pool taking: 91.206.16.3 Dec 27 15:41:01 volumio ntpd[781]: DNS: Pool taking: 212.113.99.6 Dec 27 15:41:01 volumio ntpd[781]: DNS: Pool taking: 185.211.244.47 Dec 27 15:41:01 volumio ntpd[781]: DNS: Pool taking: 46.148.143.150 Dec 27 15:41:01 volumio ntpd[781]: DNS: dns_take_status: 0.debian.pool.ntp.org=>good, 8 Dec 27 15:41:03 volumio volumio[1033]: info: Loading plugin "network"... Dec 27 15:41:03 volumio volumio[1033]: info: Refreshing Cached IP Addresses Dec 27 15:41:03 volumio volumio[1033]: info: Loading plugin "services"... Dec 27 15:41:03 volumio volumio[1033]: info: Loading plugin "alsa_controller"... Dec 27 15:41:03 volumio sudo[1228]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Dec 27 15:41:03 volumio sudo[1228]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 15:41:03 volumio sudo[1217]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 27 15:41:03 volumio sudo[1219]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 27 15:41:03 volumio sudo[1217]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 15:41:03 volumio sudo[1219]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 15:41:03 volumio sudo[1217]: pam_unix(sudo:session): session closed for user root Dec 27 15:41:03 volumio sudo[1219]: pam_unix(sudo:session): session closed for user root Dec 27 15:41:03 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 27 15:41:03 volumio volumio[1033]: info: Loading plugin "wizard"... Dec 27 15:41:03 volumio volumio[1033]: info: Loading plugin "networkfs"... Dec 27 15:41:03 volumio volumio[1033]: info: Starting Udev Watcher for removable devices Dec 27 15:41:03 volumio volumio[1033]: info: Ignoring mount for partition: boot Dec 27 15:41:03 volumio volumio[1033]: info: Ignoring mount for partition: volumio Dec 27 15:41:03 volumio volumio[1033]: info: Ignoring mount for partition: volumio_data Dec 27 15:41:03 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 27 15:41:03 volumio volumio[1033]: info: Loading plugin "volumio_command_line_client"... Dec 27 15:41:03 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 2. Dec 27 15:41:03 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Dec 27 15:41:03 volumio volumio[1033]: info: Loading plugin "upnp"... Dec 27 15:41:03 volumio volumio[1033]: info: [1766839263930] Starting Upmpd Daemon Dec 27 15:41:03 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 27 15:41:03 volumio volumio[1033]: info: Loading plugin "my_music"... Dec 27 15:41:03 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Dec 27 15:41:03 volumio volumio[1033]: info: Loading plugin "mpd"... Dec 27 15:41:04 volumio upmpdcli[1248]: Could not open config: /tmp/upmpdcli.conf Dec 27 15:41:04 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Dec 27 15:41:04 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Dec 27 15:41:04 volumio sudo[1228]: pam_unix(sudo:session): session closed for user root Dec 27 15:41:04 volumio volumio[1033]: info: Loading plugin "upnp_browser"... Dec 27 15:41:07 volumio systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Dec 27 15:41:07 volumio systemd[1]: systemd-hostnamed.service: Deactivated successfully. Dec 27 15:41:08 volumio volumio[1033]: info: Starting UPNP Browser Dec 27 15:41:08 volumio volumio[1033]: info: Loading plugin "alarm-clock"... Dec 27 15:41:08 volumio volumio[1033]: info: Loading plugin "airplay_emulation"... Dec 27 15:41:08 volumio volumio[1033]: info: Starting Shairport Sync Dec 27 15:41:08 volumio volumio[1033]: info: Loading plugin "last_100"... Dec 27 15:41:08 volumio volumio[1033]: info: Loading plugin "webradio"... Dec 27 15:41:08 volumio volumio[1033]: info: Loading plugin "i2s_dacs"... Dec 27 15:41:08 volumio volumio[1033]: info: Loading plugin "volumiodiscovery"... Dec 27 15:41:08 volumio volumio[1033]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 27 15:41:08 volumio node[1033]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 27 15:41:08 volumio volumio[1033]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 27 15:41:08 volumio node[1033]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 27 15:41:08 volumio volumio[1033]: *** WARNING *** For more information see Dec 27 15:41:08 volumio node[1033]: *** WARNING *** For more information see Dec 27 15:41:08 volumio volumio[1033]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 27 15:41:08 volumio node[1033]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 27 15:41:08 volumio volumio[1033]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 27 15:41:08 volumio node[1033]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 27 15:41:08 volumio volumio[1033]: *** WARNING *** For more information see Dec 27 15:41:08 volumio node[1033]: *** WARNING *** For more information see Dec 27 15:41:08 volumio volumio[1033]: info: Applying required configuration parameters for plugin volumiodiscovery Dec 27 15:41:08 volumio volumio[1033]: info: Discovery: Started advertising with name: Volumio Dec 27 15:41:09 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 27 15:41:09 volumio volumio[1033]: info: Loading plugin "autostart"... Dec 27 15:41:10 volumio systemd[1]: setdatetime-helper.service: Deactivated successfully. Dec 27 15:41:10 volumio systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Dec 27 15:41:10 volumio systemd[1]: setdatetime-helper.service: Consumed 1.293s CPU time. Dec 27 15:41:10 volumio volumio[1033]: info: Applying required configuration parameters for plugin autostart Dec 27 15:41:10 volumio volumio[1033]: info: AutoStart - onVolumioStart - read config.json Dec 27 15:41:10 volumio volumio[1033]: info: Loading plugin "outputs"... Dec 27 15:41:10 volumio volumio[1033]: info: Loading plugin "albumart"... Dec 27 15:41:10 volumio volumio-remote-updater[610]: [2025-12-27 15:41:10] [connect] Successful connection Dec 27 15:41:10 volumio volumio[1033]: info: Plugin example_plugin is not enabled Dec 27 15:41:10 volumio volumio[1033]: info: Loading plugin "inputs"... Dec 27 15:41:10 volumio volumio[1033]: info: Loading plugin "updater_comm"... Dec 27 15:41:10 volumio volumio[1033]: info: Plugin mpdemulation is not enabled Dec 27 15:41:10 volumio volumio[1033]: info: Loading plugin "rest_api"... Dec 27 15:41:10 volumio volumio[1033]: info: Loading plugin "websocket"... Dec 27 15:41:10 volumio volumio[1033]: info: Starting Socket.io Server version 1.7.4 Dec 27 15:41:10 volumio volumio[1033]: info: Loading plugin "yandex_music"... Dec 27 15:41:12 volumio volumio[1279]: Forking 3 albumart workers Dec 27 15:41:19 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 3. Dec 27 15:41:19 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Dec 27 15:41:19 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Dec 27 15:41:19 volumio upmpdcli[1333]: Could not open config: /tmp/upmpdcli.conf Dec 27 15:41:19 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Dec 27 15:41:19 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Dec 27 15:41:20 volumio volumio[1033]: info: Applying required configuration parameters for plugin yandex_music Dec 27 15:41:20 volumio volumio[1033]: info: Loading plugin "ir_controller"... Dec 27 15:41:21 volumio volumio[1291]: Starting albumart workers Dec 27 15:41:21 volumio volumio[1033]: info: Applying required configuration parameters for plugin ir_controller Dec 27 15:41:23 volumio volumio[1033]: info: Loading plugin "mpd_oled"... Dec 27 15:41:23 volumio volumio[1290]: Starting albumart workers Dec 27 15:41:24 volumio volumio[1289]: Starting albumart workers Dec 27 15:41:25 volumio volumio-remote-updater[610]: [2025-12-27 15:41:25] [connect] Successful connection Dec 27 15:41:26 volumio volumio[1033]: info: Applying required configuration parameters for plugin mpd_oled Dec 27 15:41:26 volumio volumio[1033]: info: [MPD_OLED Plugin] Reading configuration file at: /data/configuration/system_hardware/mpd_oled/config.json Dec 27 15:41:26 volumio volumio[1033]: info: Loading i18n strings for locale ru Dec 27 15:41:26 volumio volumio[1033]: error: ir_controller: Fetching language file: Error: i18n file complementing the system language not found. Dec 27 15:41:26 volumio volumio[1033]: Updating browse sources language Dec 27 15:41:26 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 27 15:41:28 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 27 15:41:28 volumio volumio[1033]: info: CoreCommandRouter::initPlayerControls Dec 27 15:41:28 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 27 15:41:28 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 27 15:41:28 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 27 15:41:28 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 27 15:41:28 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 27 15:41:28 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 27 15:41:28 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 27 15:41:28 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 27 15:41:28 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 27 15:41:28 volumio volumio[1033]: Express server listening on port 3000 Dec 27 15:41:28 volumio volumio[1033]: [Metrics] WebUI: 34s 710.09ms Dec 27 15:41:28 volumio volumio[1033]: info: CoreStateMachine::resetVolumioState Dec 27 15:41:28 volumio volumio[1033]: info: CoreStateMachine::getcurrentVolume Dec 27 15:41:28 volumio volumio[1033]: info: CoreCommandRouter::volumioRetrievevolume Dec 27 15:41:29 volumio volumio[1033]: info: Volumio Network Manager: Network status updated: 2 Dec 27 15:41:29 volumio sudo[1371]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 27 15:41:29 volumio sudo[1371]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 15:41:29 volumio sudo[1372]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 27 15:41:29 volumio sudo[1372]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 15:41:29 volumio sudo[1371]: pam_unix(sudo:session): session closed for user root Dec 27 15:41:29 volumio sudo[1372]: pam_unix(sudo:session): session closed for user root Dec 27 15:41:30 volumio volumio[1033]: verbose: New Socket.io Connection to 192.168.1.132 from 192.168.1.99 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 OPR/125.0.0.0 (Edition Yx 08) Engine version: 3 Transport: polling Total Clients: 1 Dec 27 15:41:30 volumio volumio[1033]: info: CoreStateMachine::pushState Dec 27 15:41:30 volumio volumio[1033]: info: CorePlayQueue::getTrack 0 Dec 27 15:41:30 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 27 15:41:30 volumio volumio[1033]: info: CoreCommandRouter::volumioPushState Dec 27 15:41:30 volumio volumio[1033]: info: CoreStateMachine::updateTrackBlock Dec 27 15:41:30 volumio volumio[1033]: info: CorePlayQueue::getTrackBlock Dec 27 15:41:30 volumio volumio[1033]: info: CoreCommandRouter::volumioRetrievevolume Dec 27 15:41:30 volumio volumio[1033]: verbose: New Socket.io Connection to 192.168.1.132 from 192.168.1.99 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 OPR/125.0.0.0 (Edition Yx 08) Engine version: 3 Transport: polling Total Clients: 2 Dec 27 15:41:31 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 27 15:41:31 volumio volumio[1033]: info: Reloading queue from file Dec 27 15:41:31 volumio volumio[1033]: verbose: New Socket.io Connection to 192.168.1.132 from 192.168.1.99 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 OPR/125.0.0.0 (Edition Yx 08) Engine version: 3 Transport: polling Total Clients: 3 Dec 27 15:41:31 volumio volumio[1033]: verbose: New Socket.io Connection to 192.168.1.132 from 192.168.1.99 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 OPR/125.0.0.0 (Edition Yx 08) Engine version: 3 Transport: polling Total Clients: 4 Dec 27 15:41:31 volumio volumio[1033]: info: CoreStateMachine::pushState Dec 27 15:41:31 volumio volumio[1033]: info: CorePlayQueue::getTrack 0 Dec 27 15:41:31 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 27 15:41:31 volumio volumio[1033]: info: CoreCommandRouter::volumioPushState Dec 27 15:41:31 volumio volumio[1033]: info: CoreStateMachine::setRepeat null single undefined Dec 27 15:41:31 volumio volumio[1033]: info: CoreStateMachine::pushState Dec 27 15:41:31 volumio volumio[1033]: info: CorePlayQueue::getTrack 0 Dec 27 15:41:31 volumio volumio[1033]: info: CoreCommandRouter::volumioPushState Dec 27 15:41:31 volumio volumio[1033]: info: CoreStateMachine::setRandom null Dec 27 15:41:31 volumio volumio[1033]: info: CoreStateMachine::pushState Dec 27 15:41:31 volumio volumio[1033]: info: CorePlayQueue::getTrack 0 Dec 27 15:41:31 volumio volumio[1033]: info: CoreCommandRouter::volumioPushState Dec 27 15:41:31 volumio volumio[1033]: info: Setting Device type: Raspberry PI Dec 27 15:41:31 volumio volumio[1033]: verbose: New Socket.io Connection to 192.168.1.132 from 192.168.1.99 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 OPR/125.0.0.0 (Edition Yx 08) Engine version: 3 Transport: polling Total Clients: 5 Dec 27 15:41:31 volumio volumio[1033]: info: Completed loading Core Plugins Dec 27 15:41:31 volumio volumio[1033]: info: Preparing to generate the ALSA configuration file Dec 27 15:41:31 volumio volumio[1033]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Dec 27 15:41:31 volumio volumio[1033]: info: USB Boot Capable - System SBC Revision found in cpuinfo: 902120 Dec 27 15:41:31 volumio volumio[1033]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Dec 27 15:41:31 volumio volumio[1033]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Dec 27 15:41:31 volumio volumio[1033]: info: The plugin mpd_oled has an ALSA contribution file volumioalsa.postalsa.5.conf Dec 27 15:41:31 volumio volumio[1033]: info: Reading ALSA contributions from plugins. Dec 27 15:41:31 volumio volumio[1033]: info: Discovery: adding f41ed280-34a2-47a1-bf84-eff3d21f2ccf Dec 27 15:41:31 volumio volumio[1033]: info: Discovery: Found device Volumio Dec 27 15:41:31 volumio volumio[1033]: info: CoreCommandRouter::volumioGetState Dec 27 15:41:31 volumio volumio[1033]: info: CorePlayQueue::getTrack 0 Dec 27 15:41:31 volumio volumio[1033]: verbose: New Socket.io Connection to 192.168.1.132 from 192.168.1.99 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 OPR/125.0.0.0 (Edition Yx 08) Engine version: 3 Transport: polling Total Clients: 6 Dec 27 15:41:32 volumio sudo[1399]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Dec 27 15:41:32 volumio sudo[1399]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 15:41:32 volumio volumio[1033]: verbose: New Socket.io Connection to 192.168.1.132 from 192.168.1.99 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 OPR/125.0.0.0 (Edition Yx 08) Engine version: 3 Transport: polling Total Clients: 7 Dec 27 15:41:32 volumio volumio[1033]: info: Discovery: this is already registered, f41ed280-34a2-47a1-bf84-eff3d21f2ccf Dec 27 15:41:32 volumio volumio[1033]: info: Discovery: Found device Volumio Dec 27 15:41:32 volumio volumio[1033]: info: CoreCommandRouter::volumioGetState Dec 27 15:41:32 volumio volumio[1033]: info: CorePlayQueue::getTrack 0 Dec 27 15:41:32 volumio volumio[1033]: verbose: New Socket.io Connection to 192.168.1.132 from 192.168.1.99 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 OPR/125.0.0.0 (Edition Yx 08) Engine version: 3 Transport: polling Total Clients: 8 Dec 27 15:41:32 volumio volumio[1033]: info: Asound.conf file unchanged, so no further update is needed Dec 27 15:41:32 volumio volumio[1033]: info: Output device has changed, restarting MPD Dec 27 15:41:32 volumio volumio[1033]: info: Output device has changed, restarting Shairport Sync Dec 27 15:41:32 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 27 15:41:32 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 27 15:41:32 volumio sudo[1403]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 27 15:41:32 volumio sudo[1405]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 27 15:41:32 volumio sudo[1403]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 15:41:32 volumio sudo[1405]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 15:41:32 volumio sudo[1403]: pam_unix(sudo:session): session closed for user root Dec 27 15:41:32 volumio volumio[1033]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 27 15:41:32 volumio volumio[1033]: info: ___________ START PLUGINS ___________ Dec 27 15:41:32 volumio volumio[1033]: info: ControllerMpd::onStart: Initializing MPD Dec 27 15:41:32 volumio volumio[1033]: info: Creating MPD Configuration file Dec 27 15:41:32 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 27 15:41:32 volumio volumio[1033]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 27 15:41:32 volumio volumio[1033]: info: [1766839292950] CoreMusicLibrary::Adding element Медиа-серверы Dec 27 15:41:32 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 27 15:41:32 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 27 15:41:32 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Dec 27 15:41:33 volumio sudo[1413]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 27 15:41:33 volumio sudo[1413]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 15:41:33 volumio volumio[1033]: info: UPNP Browser: Client initialized successfully Dec 27 15:41:33 volumio sudo[1413]: pam_unix(sudo:session): session closed for user root Dec 27 15:41:33 volumio sudo[1416]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 27 15:41:33 volumio sudo[1416]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 15:41:33 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 27 15:41:33 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 27 15:41:33 volumio sudo[1417]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 27 15:41:33 volumio sudo[1417]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 27 15:41:33 volumio sudo[1421]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Dec 27 15:41:33 volumio sudo[1417]: pam_unix(sudo:session): session closed for user root Dec 27 15:41:33 volumio volumio[1033]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 27 15:41:33 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 27 15:41:33 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 27 15:41:33 volumio systemd[1]: mpd.service: Deactivated successfully. Dec 27 15:41:33 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 27 15:41:33 volumio systemd[1]: mpd.socket: Deactivated successfully. Dec 27 15:41:33 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 27 15:41:33 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 27 15:41:33 volumio volumio[1033]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 27 15:41:33 volumio volumio[1033]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 27 15:41:33 volumio volumio[1033]: info: [1766839293588] CoreMusicLibrary::Adding element Last_100 Dec 27 15:41:33 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 27 15:41:33 volumio volumio[1033]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 27 15:41:33 volumio volumio[1033]: info: [1766839293593] CoreMusicLibrary::Adding element Webradio Dec 27 15:41:33 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 27 15:41:33 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 27 15:41:33 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Dec 27 15:41:33 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 27 15:41:33 volumio volumio[1033]: info: Initializing BBC Radios Dec 27 15:41:33 volumio sudo[1431]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 27 15:41:33 volumio sudo[1431]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 27 15:41:33 volumio sudo[1435]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Dec 27 15:41:33 volumio sudo[1431]: pam_unix(sudo:session): session closed for user root Dec 27 15:41:33 volumio volumio[1033]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory Dec 27 15:41:33 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 27 15:41:34 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 27 15:41:34 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 27 15:41:34 volumio volumio[1033]: info: AutoStart - onStart Dec 27 15:41:34 volumio volumio[1033]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 27 15:41:34 volumio volumio[1033]: info: [1766839294286] CoreMusicLibrary::Adding element Яндекс Музыка Dec 27 15:41:34 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 27 15:41:34 volumio volumio[1033]: Cannot find translation for source Яндекс Музыка Dec 27 15:41:34 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 4. Dec 27 15:41:34 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Dec 27 15:41:34 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Dec 27 15:41:34 volumio volumio[1033]: info: Loading i18n strings for locale ru Dec 27 15:41:34 volumio sudo[1399]: pam_unix(sudo:session): session closed for user root Dec 27 15:41:34 volumio volumio[1033]: error: ir_controller: Fetching language file: Error: i18n file complementing the system language not found. Dec 27 15:41:34 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 27 15:41:34 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Dec 27 15:41:35 volumio sudo[1476]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod +x /tmp/mpd_oled_plugin.sh Dec 27 15:41:35 volumio sudo[1476]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 15:41:35 volumio sudo[1476]: pam_unix(sudo:session): session closed for user root Dec 27 15:41:35 volumio volumio[1033]: info: Volumio Calling Home Dec 27 15:41:35 volumio sudo[1479]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start mpd_oled_plugin.service Dec 27 15:41:35 volumio sudo[1479]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 15:41:40 volumio volumio[1033]: info: Preparing to generate the ALSA configuration file Dec 27 15:41:40 volumio volumio-remote-updater[610]: [2025-12-27 15:41:40] [connect] Successful connection Dec 27 15:41:40 volumio sudo[1488]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod -R a+rwX /etc/lirc/irexec.lircrc /etc/lirc/lirc_options.conf /etc/lirc/lircd.conf /etc/lirc/lircd.conf.d /etc/lirc/lircmd.conf /etc/lirc/lircrc Dec 27 15:41:40 volumio sudo[1488]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 15:41:40 volumio sudo[1488]: pam_unix(sudo:session): session closed for user root Dec 27 15:41:46 volumio volumio[1033]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Dec 27 15:41:46 volumio volumio[1033]: info: The plugin mpd_oled has an ALSA contribution file volumioalsa.postalsa.5.conf Dec 27 15:41:46 volumio volumio[1033]: info: Reading ALSA contributions from plugins. Dec 27 15:41:46 volumio volumio[1033]: info: ir_controller: File permissions successfully set on /etc/lirc/*. Dec 27 15:41:46 volumio volumio[1033]: info: [MPD_OLED Plugin] Set execute permissions on /tmp/mpd_oled_plugin.sh Dec 27 15:41:46 volumio volumio[1033]: info: MPD Permissions set Dec 27 15:41:46 volumio volumio[1033]: info: MPD Permissions set Dec 27 15:41:46 volumio volumio[1033]: info: Upmpdcli Daemon Started Dec 27 15:41:46 volumio volumio[1033]: info: [MPD_OLED Plugin] tmp script created /tmp/mpd_oled_plugin.sh Dec 27 15:41:46 volumio volumio[1033]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Dec 27 15:41:46 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 27 15:41:46 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 27 15:41:46 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 27 15:41:46 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 27 15:41:46 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 27 15:41:46 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 27 15:41:46 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 27 15:41:46 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 27 15:41:47 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 27 15:41:47 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 27 15:41:47 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 27 15:41:47 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 27 15:41:47 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 27 15:41:47 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 27 15:41:47 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 27 15:41:47 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 27 15:41:47 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 27 15:41:47 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 27 15:41:47 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 27 15:41:47 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 27 15:41:55 volumio volumio-remote-updater[610]: [2025-12-27 15:41:55] [connect] Successful connection Dec 27 15:41:56 volumio volumio[1033]: verbose: New Socket.io Connection to 192.168.1.132 from 192.168.1.99 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 OPR/125.0.0.0 (Edition Yx 08) Engine version: 3 Transport: polling Total Clients: 10 Dec 27 15:41:57 volumio volumio[1033]: verbose: New Socket.io Connection to 192.168.1.132 from 192.168.1.99 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 OPR/125.0.0.0 (Edition Yx 08) Engine version: 3 Transport: polling Total Clients: 11 Dec 27 15:41:58 volumio volumio[1033]: info: Volumio called home Dec 27 15:41:59 volumio volumio[1033]: verbose: New Socket.io Connection to 192.168.1.132 from 192.168.1.99 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 OPR/125.0.0.0 (Edition Yx 08) Engine version: 3 Transport: polling Total Clients: 12 Dec 27 15:41:59 volumio mpd[1436]: 2025-12-27T15:41:59 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 27 15:41:59 volumio volumio[1033]: verbose: New Socket.io Connection to 192.168.1.132 from 192.168.1.99 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 OPR/125.0.0.0 (Edition Yx 08) Engine version: 3 Transport: polling Total Clients: 13 Dec 27 15:41:59 volumio systemd[1]: Started mpd.service - Music Player Daemon. Dec 27 15:41:59 volumio volumio[1033]: info: Starting Shairport Sync Dec 27 15:41:59 volumio volumio[1033]: info: Starting Shairport Sync Dec 27 15:41:59 volumio volumio[1033]: info: Starting Shairport Sync Dec 27 15:41:59 volumio sudo[1405]: pam_unix(sudo:session): session closed for user root Dec 27 15:41:59 volumio sudo[1416]: pam_unix(sudo:session): session closed for user root Dec 27 15:41:59 volumio sudo[1546]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 27 15:41:59 volumio sudo[1546]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 15:41:59 volumio volumio[1033]: verbose: New Socket.io Connection to 192.168.1.132 from 192.168.1.99 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 OPR/125.0.0.0 (Edition Yx 08) Engine version: 3 Transport: polling Total Clients: 14 Dec 27 15:41:59 volumio sudo[1544]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 27 15:41:59 volumio sudo[1542]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 27 15:41:59 volumio sudo[1544]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 15:42:00 volumio sudo[1542]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 15:42:00 volumio volumio[1033]: info: ir_controller: LIRC correctly updated. Dec 27 15:42:00 volumio systemd[1]: Started mpd_oled_plugin.service - MPD OLED Plugin. Dec 27 15:42:00 volumio sudo[1479]: pam_unix(sudo:session): session closed for user root Dec 27 15:42:00 volumio volumio[1033]: info: ir_controller: HAT did not load /proc/device-tree/ir_receiver! Dec 27 15:42:00 volumio volumio[1033]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 3 Transport: websocket Total Clients: 15 Dec 27 15:42:00 volumio volumio[1033]: info: Completed starting Core Plugins Dec 27 15:42:00 volumio volumio[1033]: info: ------------------------------------------- Dec 27 15:42:00 volumio volumio[1033]: info: ----- MyVolumio plugins startup ---- Dec 27 15:42:00 volumio volumio[1033]: info: ------------------------------------------- Dec 27 15:42:00 volumio volumio[1033]: info: [MyVolumio PluginManager] Fetching plans data.... Dec 27 15:42:00 volumio volumio-remote-updater[610]: [2025-12-27 15:42:00] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=3&transport=websocket&t=1766839315 101 Dec 27 15:42:00 volumio volumio[1033]: info: ir_controller: Raspberry Pi revision code: 902120 Dec 27 15:42:01 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Dec 27 15:42:01 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Dec 27 15:42:01 volumio volumio[1033]: info: [MPD_OLED Plugin] Started mpd_oled_plugin service Dec 27 15:42:01 volumio volumio[1033]: info: Asound.conf file unchanged, so no further update is needed Dec 27 15:42:01 volumio volumio[1033]: info: Output device has changed, restarting MPD Dec 27 15:42:01 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 27 15:42:01 volumio sudo[1544]: pam_unix(sudo:session): session closed for user root Dec 27 15:42:01 volumio systemd[1]: shairport-sync.service: Consumed 1.896s CPU time. Dec 27 15:42:01 volumio sudo[1542]: pam_unix(sudo:session): session closed for user root Dec 27 15:42:01 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 27 15:42:01 volumio sudo[1546]: pam_unix(sudo:session): session closed for user root Dec 27 15:42:01 volumio volumio[1033]: info: Output device has changed, restarting Shairport Sync Dec 27 15:42:01 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 27 15:42:01 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 27 15:42:01 volumio sudo[1560]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 27 15:42:01 volumio sudo[1560]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 15:42:01 volumio sudo[1560]: pam_unix(sudo:session): session closed for user root Dec 27 15:42:01 volumio sudo[1562]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 27 15:42:01 volumio sudo[1562]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 15:42:01 volumio systemd[1]: Stopping mpd_oled_plugin.service - MPD OLED Plugin... Dec 27 15:42:01 volumio systemd[1]: mpd_oled_plugin.service: Deactivated successfully. Dec 27 15:42:01 volumio systemd[1]: Stopped mpd_oled_plugin.service - MPD OLED Plugin. Dec 27 15:42:01 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Dec 27 15:42:01 volumio volumio[1033]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 27 15:42:03 volumio systemd[1]: mpd.service: Deactivated successfully. Dec 27 15:42:03 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 27 15:42:03 volumio systemd[1]: mpd.service: Consumed 7.381s CPU time. Dec 27 15:42:03 volumio systemd[1]: mpd.socket: Deactivated successfully. Dec 27 15:42:03 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 27 15:42:03 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 27 15:42:03 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 27 15:42:03 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Dec 27 15:42:03 volumio volumio[1033]: error: MPD error: The expression evaluated to a falsy value: Dec 27 15:42:03 volumio volumio[1033]: assert.ok(self.idling) Dec 27 15:42:03 volumio volumio[1033]: error: The expression evaluated to a falsy value: Dec 27 15:42:03 volumio volumio[1033]: assert.ok(self.idling) Dec 27 15:42:03 volumio volumio[1033]: error: MPD error: Error: write EPIPE Dec 27 15:42:03 volumio volumio[1033]: error: write EPIPE {"code":"EPIPE","errno":-32,"syscall":"write"} Dec 27 15:42:03 volumio volumio[1033]: error: MPD error: Error: write EPIPE Dec 27 15:42:03 volumio volumio[1033]: error: write EPIPE {"code":"EPIPE","errno":-32,"syscall":"write"} Dec 27 15:42:03 volumio volumio[1033]: info: MPD running with PID1436 Dec 27 15:42:03 volumio volumio[1033]: ,establishing connection Dec 27 15:42:03 volumio sudo[1584]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 27 15:42:03 volumio sudo[1584]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 27 15:42:03 volumio sudo[1584]: pam_unix(sudo:session): session closed for user root Dec 27 15:42:03 volumio sudo[1587]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart lircd.service Dec 27 15:42:04 volumio sudo[1587]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 15:42:04 volumio systemd[1]: Starting lircd-setup.service - lircd(8) initialization helper tool... Dec 27 15:42:04 volumio volumio[1033]: verbose: New Socket.io Connection to 192.168.1.132 from 192.168.1.99 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 OPR/125.0.0.0 (Edition Yx 08) Engine version: 3 Transport: polling Total Clients: 16 Dec 27 15:42:04 volumio volumio[1033]: info: MPD Permissions set Dec 27 15:42:04 volumio volumio[1033]: info: Shairport-Sync Started Dec 27 15:42:04 volumio sudo[1592]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -r -1 Dec 27 15:42:04 volumio sudo[1592]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 15:42:04 volumio sudo[1592]: pam_unix(sudo:session): session closed for user root Dec 27 15:42:05 volumio volumio[1033]: Error adding Membership: Error: addMembership EINVAL Dec 27 15:42:05 volumio volumio[1033]: info: Shairport-Sync Started Dec 27 15:42:05 volumio volumio[1033]: info: Shairport-Sync Started Dec 27 15:42:05 volumio volumio[1033]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory Dec 27 15:42:05 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 27 15:42:05 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 27 15:42:05 volumio lircd-setup[1590]: /usr/sbin/lircd-setup:37: DeprecationWarning: The SafeConfigParser class has been renamed to ConfigParser in Python 3.2. This alias will be removed in Python 3.12. Use ConfigParser directly instead. Dec 27 15:42:05 volumio lircd-setup[1590]: parser = configparser.SafeConfigParser() Dec 27 15:42:05 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 27 15:42:05 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 27 15:42:05 volumio systemd[1]: lircd-setup.service: Deactivated successfully. Dec 27 15:42:05 volumio systemd[1]: Finished lircd-setup.service - lircd(8) initialization helper tool. Dec 27 15:42:05 volumio systemd[1]: Starting lircd.service - Flexible IR remote input/output application support... Dec 27 15:42:05 volumio lircd-0.10.1[1597]: Info: lircd: Opening log, level: Info Dec 27 15:42:05 volumio lircd-0.10.1[1597]: Notice: Version: lircd 0.10.1 Dec 27 15:42:05 volumio lircd-0.10.1[1597]: Notice: System info: Linux volumio 6.12.47-v7+ #1904 SMP Mon Sep 15 13:05:52 BST 2025 armv7l GNU/Linux Dec 27 15:42:05 volumio lircd-0.10.1[1597]: Info: Initial device: /dev/lirc0 Dec 27 15:42:05 volumio lircd[1597]: lircd-0.10.1[1597]: Info: lircd: Opening log, level: Info Dec 27 15:42:05 volumio lircd[1597]: lircd-0.10.1[1597]: Notice: Using systemd fd Dec 27 15:42:05 volumio lircd[1597]: lircd-0.10.1[1597]: Warning: Running as root Dec 27 15:42:05 volumio lircd-0.10.1[1597]: Warning: Cannot access device: /dev/lirc0 Dec 27 15:42:05 volumio lircd[1597]: lircd-0.10.1[1597]: Info: Using remote: Panasonic_N2QAGB000015. Dec 27 15:42:05 volumio lircd[1597]: lircd-0.10.1[1597]: Notice: /etc/lirc/lircd.conf: Panasonic_N2QAGB000015: Multiple values for same code: KEY_5 Dec 27 15:42:05 volumio lircd-0.10.1[1597]: Info: Initial device: /dev/lirc0 Dec 27 15:42:05 volumio lircd[1597]: lircd-0.10.1[1597]: Notice: lircd(default) ready, using /var/run/lirc/lircd Dec 27 15:42:05 volumio lircd-0.10.1[1597]: Warning: Cannot access device: /dev/lirc0 Dec 27 15:42:05 volumio lircd-0.10.1[1597]: Notice: Options: driver: default Dec 27 15:42:05 volumio lircd-0.10.1[1597]: Notice: Options: output: /var/run/lirc/lircd Dec 27 15:42:05 volumio lircd-0.10.1[1597]: Notice: Options: nodaemon: 1 Dec 27 15:42:05 volumio lircd-0.10.1[1597]: Notice: Options: plugindir: /usr/lib/arm-linux-gnueabihf/lirc/plugins Dec 27 15:42:05 volumio lircd-0.10.1[1597]: Notice: Options: logfile: syslog Dec 27 15:42:05 volumio systemd[1]: Started lircd.service - Flexible IR remote input/output application support. Dec 27 15:42:05 volumio lircd-0.10.1[1597]: Notice: Options: immediate-init: 0 Dec 27 15:42:05 volumio lircd-0.10.1[1597]: Notice: Options: permission: 666 Dec 27 15:42:05 volumio lircd-0.10.1[1597]: Notice: Options: driver-options: Dec 27 15:42:05 volumio lircd-0.10.1[1597]: Notice: Options: pidfile: /var/run/lirc/lircd.pid Dec 27 15:42:05 volumio lircd-0.10.1[1597]: Notice: Options: listen: 0 Dec 27 15:42:05 volumio lircd-0.10.1[1597]: Notice: Options: connect: (null) Dec 27 15:42:05 volumio lircd-0.10.1[1597]: Notice: Options: userelease: 0 Dec 27 15:42:05 volumio lircd-0.10.1[1597]: Notice: Options: effective_user: (null) Dec 27 15:42:05 volumio lircd-0.10.1[1597]: Notice: Options: release_suffix: _EVUP Dec 27 15:42:05 volumio lircd-0.10.1[1597]: Notice: Options: allow_simulate: 0 Dec 27 15:42:05 volumio lircd-0.10.1[1597]: Notice: Options: repeat_max: 600 Dec 27 15:42:05 volumio lircd-0.10.1[1597]: Notice: Options: configfile: /etc/lirc/lircd.conf Dec 27 15:42:05 volumio lircd-0.10.1[1597]: Notice: Options: dynamic_codes: (null) Dec 27 15:42:05 volumio lircd-0.10.1[1597]: Notice: Current driver: default Dec 27 15:42:05 volumio lircd-0.10.1[1597]: Notice: Driver API version: 3 Dec 27 15:42:05 volumio lircd-0.10.1[1597]: Notice: Driver version: 0.10.0 Dec 27 15:42:05 volumio lircd-0.10.1[1597]: Notice: Driver info: See file:///usr/share/doc/lirc/plugindocs/default.html Dec 27 15:42:05 volumio lircd-0.10.1[1597]: Info: lircd: Opening log, level: Info Dec 27 15:42:05 volumio lircd-0.10.1[1597]: Notice: Using systemd fd Dec 27 15:42:05 volumio lircd-0.10.1[1597]: Warning: Running as root Dec 27 15:42:05 volumio lircd-0.10.1[1597]: Info: Using remote: Panasonic_N2QAGB000015. Dec 27 15:42:05 volumio lircd-0.10.1[1597]: Notice: /etc/lirc/lircd.conf: Panasonic_N2QAGB000015: Multiple values for same code: KEY_5 Dec 27 15:42:05 volumio lircd-0.10.1[1597]: Notice: lircd(default) ready, using /var/run/lirc/lircd Dec 27 15:42:05 volumio sudo[1587]: pam_unix(sudo:session): session closed for user root Dec 27 15:42:05 volumio volumio[1033]: info: CoreCommandRouter::volumioGetState Dec 27 15:42:05 volumio volumio[1033]: info: CorePlayQueue::getTrack 0 Dec 27 15:42:06 volumio volumio[1033]: info: ir_controller: systemctl restart lircd.service succeeded. Dec 27 15:42:06 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 27 15:42:06 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 27 15:42:06 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 27 15:42:06 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 27 15:42:06 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 27 15:42:06 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 27 15:42:06 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 27 15:42:06 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 27 15:42:06 volumio sudo[1604]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart irexec.service Dec 27 15:42:06 volumio sudo[1604]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 15:42:06 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 27 15:42:06 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 27 15:42:06 volumio volumio[1033]: info: CoreCommandRouter::volumioGetState Dec 27 15:42:06 volumio volumio[1033]: info: CorePlayQueue::getTrack 0 Dec 27 15:42:06 volumio systemd[1]: Started irexec.service - Handle events from IR remotes decoded by lircd(8). Dec 27 15:42:06 volumio sudo[1604]: pam_unix(sudo:session): session closed for user root Dec 27 15:42:06 volumio lircd[1597]: lircd-0.10.1[1597]: Notice: accepted new client on /var/run/lirc/lircd Dec 27 15:42:06 volumio lircd[1597]: lircd-0.10.1[1597]: Info: Cannot configure the rc device for /dev/lirc0 Dec 27 15:42:06 volumio lircd[1597]: lircd-0.10.1[1597]: Error: could not get file information for /dev/lirc0 Dec 27 15:42:06 volumio lircd[1597]: lircd-0.10.1[1597]: default_init(): No such file or directory Dec 27 15:42:06 volumio lircd[1597]: lircd-0.10.1[1597]: Warning: Failed to initialize hardware Dec 27 15:42:06 volumio lircd-0.10.1[1597]: Notice: accepted new client on /var/run/lirc/lircd Dec 27 15:42:06 volumio lircd-0.10.1[1597]: Info: Cannot configure the rc device for /dev/lirc0 Dec 27 15:42:06 volumio lircd-0.10.1[1597]: Error: could not get file information for /dev/lirc0 Dec 27 15:42:06 volumio lircd-0.10.1[1597]: default_init(): No such file or directory Dec 27 15:42:06 volumio lircd-0.10.1[1597]: Warning: Failed to initialize hardware Dec 27 15:42:07 volumio sudo[1616]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay gpio-ir gpio_pin=25 gpio_pull=up Dec 27 15:42:07 volumio sudo[1616]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 15:42:07 volumio volumio[1033]: error: MPD error: The expression evaluated to a falsy value: Dec 27 15:42:07 volumio volumio[1033]: assert.ok(self.idling) Dec 27 15:42:07 volumio volumio[1033]: error: The expression evaluated to a falsy value: Dec 27 15:42:07 volumio volumio[1033]: assert.ok(self.idling) Dec 27 15:42:07 volumio sudo[1616]: pam_unix(sudo:session): session closed for user root Dec 27 15:42:07 volumio volumio[1033]: error: MPD error: The expression evaluated to a falsy value: Dec 27 15:42:07 volumio volumio[1033]: assert.ok(self.idling) Dec 27 15:42:07 volumio volumio[1033]: error: The expression evaluated to a falsy value: Dec 27 15:42:07 volumio volumio[1033]: assert.ok(self.idling) Dec 27 15:42:07 volumio lircd[1597]: lircd-0.10.1[1597]: Error: could not get file information for /dev/lirc0 Dec 27 15:42:07 volumio lircd[1597]: lircd-0.10.1[1597]: default_init(): No such file or directory Dec 27 15:42:07 volumio lircd-0.10.1[1597]: Error: could not get file information for /dev/lirc0 Dec 27 15:42:07 volumio lircd-0.10.1[1597]: default_init(): No such file or directory Dec 27 15:42:07 volumio volumio[1033]: info: ir_controller: Overlay gpio-ir gpio_pin=25 gpio_pull=up loaded. Dec 27 15:42:07 volumio volumio[1033]: info: ir_controller: systemctl restart irexec.service succeeded. Dec 27 15:42:07 volumio volumio[1033]: info: Starting Shairport Sync Dec 27 15:42:07 volumio kernel: Registered IR keymap rc-rc6-mce Dec 27 15:42:08 volumio kernel: IR RC6 protocol handler initialized Dec 27 15:42:08 volumio kernel: rc rc0: gpio_ir_recv as /devices/platform/ir-receiver@19/rc/rc0 Dec 27 15:42:08 volumio kernel: rc rc0: lirc_dev: driver gpio_ir_recv registered at minor = 0, raw IR receiver, no transmitter Dec 27 15:42:08 volumio kernel: input: gpio_ir_recv as /devices/platform/ir-receiver@19/rc/rc0/input0 Dec 27 15:42:08 volumio sudo[1639]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart lircd.service Dec 27 15:42:08 volumio sudo[1639]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 15:42:08 volumio sudo[1641]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 27 15:42:08 volumio sudo[1641]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 27 15:42:08 volumio systemd-logind[604]: Watching system buttons on /dev/input/event0 (gpio_ir_recv) Dec 27 15:42:08 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Dec 27 15:42:08 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Dec 27 15:42:08 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 27 15:42:08 volumio systemd[1]: shairport-sync.service: Consumed 1.382s CPU time. Dec 27 15:42:08 volumio volumio[1033]: verbose: New Socket.io Connection to 192.168.1.132 from 192.168.1.99 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/141.0.0.0 Safari/537.36 OPR/125.0.0.0 (Edition Yx 08) Engine version: 3 Transport: polling Total Clients: 17 Dec 27 15:42:08 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 27 15:42:08 volumio sudo[1641]: pam_unix(sudo:session): session closed for user root Dec 27 15:42:08 volumio lircd[1597]: lircd-0.10.1[1597]: Notice: caught signal Dec 27 15:42:08 volumio lircd-0.10.1[1597]: Notice: caught signal Dec 27 15:42:08 volumio systemd[1]: Stopping lircd.service - Flexible IR remote input/output application support... Dec 27 15:42:08 volumio systemd[1]: lircd.service: Deactivated successfully. Dec 27 15:42:08 volumio systemd[1]: Stopped lircd.service - Flexible IR remote input/output application support. Dec 27 15:42:08 volumio systemd[1]: irexec.service: Deactivated successfully. Dec 27 15:42:08 volumio systemd[1]: Starting lircd-setup.service - lircd(8) initialization helper tool... Dec 27 15:42:08 volumio volumio[1033]: info: CoreCommandRouter::volumioGetState Dec 27 15:42:08 volumio volumio[1033]: info: CorePlayQueue::getTrack 0 Dec 27 15:42:08 volumio lircd-setup[1650]: /usr/sbin/lircd-setup:37: DeprecationWarning: The SafeConfigParser class has been renamed to ConfigParser in Python 3.2. This alias will be removed in Python 3.12. Use ConfigParser directly instead. Dec 27 15:42:08 volumio lircd-setup[1650]: parser = configparser.SafeConfigParser() Dec 27 15:42:08 volumio systemd[1]: lircd-setup.service: Deactivated successfully. Dec 27 15:42:08 volumio systemd[1]: Finished lircd-setup.service - lircd(8) initialization helper tool. Dec 27 15:42:09 volumio systemd[1]: Starting lircd.service - Flexible IR remote input/output application support... Dec 27 15:42:09 volumio lircd-0.10.1[1663]: Info: lircd: Opening log, level: Info Dec 27 15:42:09 volumio lircd-0.10.1[1663]: Notice: Version: lircd 0.10.1 Dec 27 15:42:09 volumio lircd-0.10.1[1663]: Notice: System info: Linux volumio 6.12.47-v7+ #1904 SMP Mon Sep 15 13:05:52 BST 2025 armv7l GNU/Linux Dec 27 15:42:09 volumio volumio[1033]: info: Shairport-Sync Started Dec 27 15:42:09 volumio lircd-0.10.1[1663]: Info: Initial device: /dev/lirc0 Dec 27 15:42:09 volumio lircd-0.10.1[1663]: Notice: 'lirc' written to protocols file /sys/class/rc/rc0/protocols Dec 27 15:42:09 volumio lircd-0.10.1[1663]: Info: Initial device: /dev/lirc0 Dec 27 15:42:09 volumio lircd-0.10.1[1663]: Info: [lirc] protocol is enabled Dec 27 15:42:09 volumio lircd[1663]: lircd-0.10.1[1663]: Info: lircd: Opening log, level: Info Dec 27 15:42:09 volumio lircd-0.10.1[1663]: Notice: Options: driver: default Dec 27 15:42:09 volumio lircd[1663]: lircd-0.10.1[1663]: Notice: Using systemd fd Dec 27 15:42:09 volumio lircd[1663]: lircd-0.10.1[1663]: Warning: Running as root Dec 27 15:42:09 volumio lircd-0.10.1[1663]: Notice: Options: output: /var/run/lirc/lircd Dec 27 15:42:09 volumio lircd-0.10.1[1663]: Notice: Options: nodaemon: 1 Dec 27 15:42:09 volumio lircd-0.10.1[1663]: Notice: Options: plugindir: /usr/lib/arm-linux-gnueabihf/lirc/plugins Dec 27 15:42:09 volumio lircd-0.10.1[1663]: Notice: Options: logfile: syslog Dec 27 15:42:09 volumio lircd-0.10.1[1663]: Notice: Options: immediate-init: 0 Dec 27 15:42:09 volumio lircd-0.10.1[1663]: Notice: Options: permission: 666 Dec 27 15:42:09 volumio lircd-0.10.1[1663]: Notice: Options: driver-options: Dec 27 15:42:09 volumio lircd-0.10.1[1663]: Notice: Options: pidfile: /var/run/lirc/lircd.pid Dec 27 15:42:09 volumio lircd-0.10.1[1663]: Notice: Options: listen: 0 Dec 27 15:42:09 volumio lircd-0.10.1[1663]: Notice: Options: connect: (null) Dec 27 15:42:09 volumio lircd-0.10.1[1663]: Notice: Options: userelease: 0 Dec 27 15:42:09 volumio lircd-0.10.1[1663]: Notice: Options: effective_user: (null) Dec 27 15:42:09 volumio lircd-0.10.1[1663]: Notice: Options: release_suffix: _EVUP Dec 27 15:42:09 volumio lircd-0.10.1[1663]: Notice: Options: allow_simulate: 0 Dec 27 15:42:09 volumio lircd-0.10.1[1663]: Notice: Options: repeat_max: 600 Dec 27 15:42:09 volumio lircd-0.10.1[1663]: Notice: Options: configfile: /etc/lirc/lircd.conf Dec 27 15:42:09 volumio lircd-0.10.1[1663]: Notice: Options: dynamic_codes: (null) Dec 27 15:42:09 volumio lircd-0.10.1[1663]: Notice: Current driver: default Dec 27 15:42:09 volumio lircd-0.10.1[1663]: Notice: Driver API version: 3 Dec 27 15:42:09 volumio lircd-0.10.1[1663]: Notice: Driver version: 0.10.0 Dec 27 15:42:09 volumio lircd-0.10.1[1663]: Notice: Driver info: See file:///usr/share/doc/lirc/plugindocs/default.html Dec 27 15:42:09 volumio lircd-0.10.1[1663]: Info: lircd: Opening log, level: Info Dec 27 15:42:09 volumio lircd-0.10.1[1663]: Notice: Using systemd fd Dec 27 15:42:09 volumio lircd-0.10.1[1663]: Warning: Running as root Dec 27 15:42:09 volumio lircd[1663]: lircd-0.10.1[1663]: Info: Using remote: Panasonic_N2QAGB000015. Dec 27 15:42:09 volumio lircd[1663]: lircd-0.10.1[1663]: Notice: /etc/lirc/lircd.conf: Panasonic_N2QAGB000015: Multiple values for same code: KEY_5 Dec 27 15:42:09 volumio lircd[1663]: lircd-0.10.1[1663]: Notice: lircd(default) ready, using /var/run/lirc/lircd Dec 27 15:42:09 volumio systemd[1]: Started lircd.service - Flexible IR remote input/output application support. Dec 27 15:42:09 volumio lircd-0.10.1[1663]: Info: Using remote: Panasonic_N2QAGB000015. Dec 27 15:42:09 volumio lircd-0.10.1[1663]: Notice: /etc/lirc/lircd.conf: Panasonic_N2QAGB000015: Multiple values for same code: KEY_5 Dec 27 15:42:09 volumio lircd-0.10.1[1663]: Notice: lircd(default) ready, using /var/run/lirc/lircd Dec 27 15:42:09 volumio sudo[1639]: pam_unix(sudo:session): session closed for user root Dec 27 15:42:09 volumio volumio[1033]: info: Received Get System Info Dec 27 15:42:09 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 27 15:42:09 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 27 15:42:09 volumio volumio[1033]: info: Discovery: Getting this device information Dec 27 15:42:09 volumio volumio[1033]: info: CoreCommandRouter::volumioGetState Dec 27 15:42:09 volumio volumio[1033]: info: CorePlayQueue::getTrack 0 Dec 27 15:42:09 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 27 15:42:09 volumio volumio[1033]: info: CoreCommandRouter::volumioGetState Dec 27 15:42:09 volumio volumio[1033]: info: CorePlayQueue::getTrack 0 Dec 27 15:42:10 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 27 15:42:10 volumio volumio[1033]: info: CoreCommandRouter::volumioGetVisibleSources Dec 27 15:42:10 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 27 15:42:10 volumio volumio[1033]: info: CoreCommandRouter::volumioGetState Dec 27 15:42:10 volumio volumio[1033]: info: CorePlayQueue::getTrack 0 Dec 27 15:42:10 volumio volumio[1033]: info: CoreCommandRouter::volumioGetState Dec 27 15:42:10 volumio volumio[1033]: info: CorePlayQueue::getTrack 0 Dec 27 15:42:10 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Dec 27 15:42:10 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 27 15:42:10 volumio volumio[1033]: info: Received Get System Info Dec 27 15:42:10 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 27 15:42:10 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 27 15:42:10 volumio volumio[1033]: info: Discovery: Getting this device information Dec 27 15:42:10 volumio volumio[1033]: info: CoreCommandRouter::volumioGetState Dec 27 15:42:10 volumio volumio[1033]: info: CorePlayQueue::getTrack 0 Dec 27 15:42:10 volumio volumio[1033]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 27 15:42:10 volumio volumio[1033]: info: CoreCommandRouter::volumioGetState Dec 27 15:42:10 volumio volumio[1033]: info: CorePlayQueue::getTrack 0 Dec 27 15:42:10 volumio volumio[1033]: info: Listing playlists Dec 27 15:42:11 volumio mpd[1588]: 2025-12-27T15:42:11 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 27 15:42:11 volumio systemd[1]: Started mpd.service - Music Player Daemon. Dec 27 15:42:11 volumio sudo[1562]: pam_unix(sudo:session): session closed for user root Dec 27 15:42:11 volumio systemd[1]: Started mpd_oled_plugin.service - MPD OLED Plugin. Dec 27 15:42:13 volumio volumio[1033]: info: CoreCommandRouter::volumioGetQueue Dec 27 15:42:13 volumio volumio[1033]: info: CoreStateMachine::getQueue Dec 27 15:42:13 volumio volumio[1033]: info: CorePlayQueue::getQueue Dec 27 15:42:16 volumio kernel: rc rc0: two consecutive events of type space Dec 27 15:42:16 volumio volumio[1033]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 27 15:42:17 volumio volumio[1033]: Error [ERR_INTERNAL_ASSERTION]: This is caused by either a bug in Node.js or incorrect usage of Node.js internals. Dec 27 15:42:17 volumio volumio[1033]: Please open an issue with this stack trace at https://github.com/nodejs/node/issues Dec 27 15:42:17 volumio volumio[1033]: at new NodeError (node:internal/errors:405:5) Dec 27 15:42:17 volumio volumio[1033]: at assert (node:internal/assert:14:11) Dec 27 15:42:17 volumio volumio[1033]: at internalConnectMultiple (node:net:1118:3) Dec 27 15:42:17 volumio volumio[1033]: at Timeout.internalConnectMultipleTimeout (node:net:1687:3) Dec 27 15:42:17 volumio volumio[1033]: at listOnTimeout (node:internal/timers:575:11) Dec 27 15:42:17 volumio volumio[1033]: at process.processTimers (node:internal/timers:514:7) { Dec 27 15:42:17 volumio volumio[1033]: code: 'ERR_INTERNAL_ASSERTION' Dec 27 15:42:17 volumio volumio[1033]: } Dec 27 15:42:17 volumio volumio[1033]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 27 15:42:30 volumio sudo[1712]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-27 15:41' Dec 27 15:42:30 volumio sudo[1712]: 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"