Jan 11 10:30:12 lalumio systemd[1]: setdatetime-helper.service: Deactivated successfully. Jan 11 10:30:12 lalumio systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Jan 11 10:30:12 lalumio systemd[1]: setdatetime-helper.service: Consumed 2.050s CPU time. Jan 11 10:30:12 lalumio winbindd[1155]: [2026/01/11 10:30:12.114726, 0] ../../source3/winbindd/winbindd_idmap.c:372(wb_parent_idmap_setup_lookupname_done) Jan 11 10:30:12 lalumio winbindd[1155]: wb_parent_idmap_setup_lookupname_done: Lookup domain name 'LALUMIO' failed 'NT_STATUS_IO_TIMEOUT' Jan 11 10:30:12 lalumio systemd[1]: Starting dpkg-db-backup.service - Daily dpkg database backup service... Jan 11 10:30:12 lalumio systemd[1]: Started ntpsec-rotate-stats.service - Rotate ntpd stats. Jan 11 10:30:12 lalumio systemd[1]: ntpsec-rotate-stats.service: Deactivated successfully. Jan 11 10:30:12 lalumio systemd[1]: Started smbd.service - Samba SMB Daemon. Jan 11 10:30:12 lalumio systemd[1]: Reached target multi-user.target - Multi-User System. Jan 11 10:30:12 lalumio systemd[1]: Reached target graphical.target - Graphical Interface. Jan 11 10:30:12 lalumio systemd[1]: Starting systemd-update-utmp-runlevel.service - Record Runlevel Change in UTMP... Jan 11 10:30:12 lalumio systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Jan 11 10:30:12 lalumio systemd[1]: Finished systemd-update-utmp-runlevel.service - Record Runlevel Change in UTMP. Jan 11 10:30:12 lalumio systemd[1]: dpkg-db-backup.service: Deactivated successfully. Jan 11 10:30:12 lalumio systemd[1]: Finished dpkg-db-backup.service - Daily dpkg database backup service. Jan 11 10:30:12 lalumio systemd[1]: Startup finished in 14.893s (kernel) + 18.910s (userspace) = 33.804s. Jan 11 10:30:13 lalumio volumio-remote-updater[690]: [2026-01-11 10:30:13] [info] asio async_connect error: asio.system:111 (Connection refused) Jan 11 10:30:13 lalumio volumio-remote-updater[690]: [2026-01-11 10:30:13] [info] Error getting remote endpoint: asio.system:107 (Transport endpoint is not connected) Jan 11 10:30:13 lalumio volumio-remote-updater[690]: [2026-01-11 10:30:13] [error] handle_connect error: Connection refused Jan 11 10:30:15 lalumio volumio[1160]: info: ------------------------------------------- Jan 11 10:30:15 lalumio volumio[1160]: info: ----- Volumio3 ---- Jan 11 10:30:15 lalumio volumio[1160]: info: ------------------------------------------- Jan 11 10:30:15 lalumio volumio[1160]: info: ----- System startup ---- Jan 11 10:30:15 lalumio volumio[1160]: info: ------------------------------------------- Jan 11 10:30:16 lalumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 1. Jan 11 10:30:16 lalumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Jan 11 10:30:16 lalumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Jan 11 10:30:16 lalumio upmpdcli[1240]: Could not open config: /tmp/upmpdcli.conf Jan 11 10:30:16 lalumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Jan 11 10:30:16 lalumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Jan 11 10:30:16 lalumio volumio[1160]: info: MYVOLUMIO Environment detected Jan 11 10:30:17 lalumio volumio[1160]: info: Plugin folders cleanup Jan 11 10:30:17 lalumio volumio[1160]: info: Scanning into folder /volumio/app/plugins/ Jan 11 10:30:17 lalumio volumio[1160]: info: Scanning category audio_interface Jan 11 10:30:17 lalumio volumio[1160]: info: Scanning category miscellanea Jan 11 10:30:17 lalumio volumio[1160]: info: Scanning category music_service Jan 11 10:30:17 lalumio volumio[1160]: info: Scanning category plugins.json Jan 11 10:30:17 lalumio volumio[1160]: info: Scanning category system_controller Jan 11 10:30:17 lalumio volumio[1160]: info: Scanning category user_interface Jan 11 10:30:17 lalumio volumio[1160]: info: Scanning into folder /data/plugins/ Jan 11 10:30:17 lalumio volumio[1160]: info: Scanning category music_service Jan 11 10:30:17 lalumio volumio[1160]: info: Plugin folders cleanup completed Jan 11 10:30:17 lalumio volumio[1160]: info: ------------------------------------------- Jan 11 10:30:17 lalumio volumio[1160]: info: ----- Core plugins startup ---- Jan 11 10:30:17 lalumio volumio[1160]: info: ------------------------------------------- Jan 11 10:30:17 lalumio volumio[1160]: info: Loading plugins from folder /volumio/app/plugins/ Jan 11 10:30:17 lalumio volumio[1160]: info: Adding plugin upnp to MyMusic Plugins Jan 11 10:30:17 lalumio volumio[1160]: info: Adding plugin airplay_emulation to MyMusic Plugins Jan 11 10:30:17 lalumio volumio[1160]: info: Adding plugin upnp_browser to MyMusic Plugins Jan 11 10:30:17 lalumio volumio[1160]: info: Loading plugins from folder /data/plugins/ Jan 11 10:30:17 lalumio volumio[1160]: info: Loading plugin "system"... Jan 11 10:30:17 lalumio volumio[1160]: info: Loading plugin "appearance"... Jan 11 10:30:20 lalumio volumio[1160]: info: Loading plugin "network"... Jan 11 10:30:20 lalumio volumio[1160]: info: Refreshing Cached IP Addresses Jan 11 10:30:20 lalumio sudo[1248]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 11 10:30:20 lalumio sudo[1250]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 11 10:30:20 lalumio sudo[1250]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 10:30:20 lalumio sudo[1248]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 10:30:20 lalumio volumio[1160]: info: Loading plugin "services"... Jan 11 10:30:20 lalumio volumio[1160]: info: Loading plugin "alsa_controller"... Jan 11 10:30:20 lalumio sudo[1248]: pam_unix(sudo:session): session closed for user root Jan 11 10:30:20 lalumio sudo[1250]: pam_unix(sudo:session): session closed for user root Jan 11 10:30:20 lalumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 11 10:30:20 lalumio volumio[1160]: info: Loading plugin "wizard"... Jan 11 10:30:20 lalumio volumio[1160]: info: Loading plugin "networkfs"... Jan 11 10:30:20 lalumio volumio[1160]: info: Starting Udev Watcher for removable devices Jan 11 10:30:20 lalumio sudo[1279]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=lalamfa,password=Habaner0,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.240/Music /mnt/NAS/Lalama-NAS Jan 11 10:30:20 lalumio sudo[1279]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 10:30:20 lalumio volumio[1160]: info: Ignoring mount for partition: boot Jan 11 10:30:20 lalumio volumio[1160]: info: Ignoring mount for partition: volumio Jan 11 10:30:20 lalumio volumio[1160]: info: Ignoring mount for partition: volumio_data Jan 11 10:30:20 lalumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 11 10:30:20 lalumio volumio[1160]: info: Loading plugin "volumio_command_line_client"... Jan 11 10:30:20 lalumio volumio[1160]: info: Loading plugin "upnp"... Jan 11 10:30:20 lalumio volumio[1160]: info: [1768145420989] Starting Upmpd Daemon Jan 11 10:30:20 lalumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 11 10:30:21 lalumio volumio[1160]: info: Loading plugin "my_music"... Jan 11 10:30:21 lalumio kernel: netfs: FS-Cache loaded Jan 11 10:30:21 lalumio volumio[1160]: info: Loading plugin "mpd"... Jan 11 10:30:21 lalumio kernel: Key type cifs.spnego registered Jan 11 10:30:21 lalumio kernel: Key type cifs.idmap registered Jan 11 10:30:21 lalumio kernel: CIFS: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3.1.1), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3.1.1 (or even SMB3 or SMB2.1) specify vers=1.0 on mount. Jan 11 10:30:21 lalumio kernel: CIFS: Attempting to mount //192.168.1.240/Music Jan 11 10:30:21 lalumio volumio[1160]: info: Loading plugin "upnp_browser"... Jan 11 10:30:22 lalumio sudo[1279]: pam_unix(sudo:session): session closed for user root Jan 11 10:30:23 lalumio volumio-remote-updater[690]: [2026-01-11 10:30:23] [connect] Successful connection Jan 11 10:30:24 lalumio volumio[1160]: info: Starting UPNP Browser Jan 11 10:30:24 lalumio volumio[1160]: info: Loading plugin "alarm-clock"... Jan 11 10:30:24 lalumio volumio[1160]: info: Loading plugin "airplay_emulation"... Jan 11 10:30:24 lalumio volumio[1160]: info: Starting Shairport Sync Jan 11 10:30:24 lalumio volumio[1160]: info: Loading plugin "last_100"... Jan 11 10:30:24 lalumio volumio[1160]: info: Loading plugin "webradio"... Jan 11 10:30:24 lalumio volumio[1160]: info: Loading plugin "i2s_dacs"... Jan 11 10:30:24 lalumio volumio[1160]: info: Loading plugin "volumiodiscovery"... Jan 11 10:30:25 lalumio volumio[1160]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 11 10:30:25 lalumio volumio[1160]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 11 10:30:25 lalumio volumio[1160]: *** WARNING *** For more information see Jan 11 10:30:25 lalumio volumio[1160]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 11 10:30:25 lalumio volumio[1160]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 11 10:30:25 lalumio node[1160]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 11 10:30:25 lalumio volumio[1160]: *** WARNING *** For more information see Jan 11 10:30:25 lalumio node[1160]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 11 10:30:25 lalumio node[1160]: *** WARNING *** For more information see Jan 11 10:30:25 lalumio node[1160]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 11 10:30:25 lalumio node[1160]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 11 10:30:25 lalumio node[1160]: *** WARNING *** For more information see Jan 11 10:30:25 lalumio volumio[1160]: info: Applying required configuration parameters for plugin volumiodiscovery Jan 11 10:30:25 lalumio volumio[1160]: info: Discovery: Started advertising with name: lalumio Jan 11 10:30:25 lalumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 11 10:30:25 lalumio volumio[1160]: info: Loading plugin "soundcloud"... Jan 11 10:30:26 lalumio volumio[1160]: info: Loading plugin "outputs"... Jan 11 10:30:26 lalumio volumio[1160]: info: Loading plugin "albumart"... Jan 11 10:30:26 lalumio volumio[1160]: info: Plugin example_plugin is not enabled Jan 11 10:30:26 lalumio volumio[1160]: info: Loading plugin "inputs"... Jan 11 10:30:26 lalumio volumio[1160]: info: Loading plugin "updater_comm"... Jan 11 10:30:26 lalumio volumio[1160]: info: Plugin mpdemulation is not enabled Jan 11 10:30:26 lalumio volumio[1160]: info: Loading plugin "rest_api"... Jan 11 10:30:26 lalumio volumio[1160]: info: Loading plugin "websocket"... Jan 11 10:30:26 lalumio volumio[1160]: info: Starting Socket.io Server version 1.7.4 Jan 11 10:30:26 lalumio volumio[1160]: info: Loading i18n strings for locale en Jan 11 10:30:26 lalumio volumio[1160]: Updating browse sources language Jan 11 10:30:26 lalumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 11 10:30:27 lalumio systemd[1]: systemd-fsckd.service: Deactivated successfully. Jan 11 10:30:27 lalumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 11 10:30:27 lalumio volumio[1160]: info: CoreCommandRouter::initPlayerControls Jan 11 10:30:27 lalumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 11 10:30:27 lalumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 11 10:30:27 lalumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 11 10:30:27 lalumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 11 10:30:27 lalumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 11 10:30:27 lalumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 11 10:30:27 lalumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 11 10:30:27 lalumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 11 10:30:27 lalumio systemd[1]: Starting e2scrub_all.service - Online ext4 Metadata Check for All Filesystems... Jan 11 10:30:27 lalumio systemd[1]: e2scrub_all.service: Deactivated successfully. Jan 11 10:30:27 lalumio systemd[1]: Finished e2scrub_all.service - Online ext4 Metadata Check for All Filesystems. Jan 11 10:30:27 lalumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 11 10:30:27 lalumio volumio[1160]: Express server listening on port 3000 Jan 11 10:30:27 lalumio volumio[1160]: [Metrics] WebUI: 13s 761.88ms Jan 11 10:30:27 lalumio volumio[1160]: info: CoreStateMachine::resetVolumioState Jan 11 10:30:27 lalumio volumio[1160]: info: CoreStateMachine::getcurrentVolume Jan 11 10:30:27 lalumio volumio[1160]: info: CoreCommandRouter::volumioRetrievevolume Jan 11 10:30:27 lalumio volumio[1160]: info: Volumio Network Manager: Network status updated: 1 Jan 11 10:30:28 lalumio volumio-remote-updater[690]: [2026-01-11 10:30:28] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=3&transport=websocket&t=1768145423 101 Jan 11 10:30:28 lalumio volumio[1160]: 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: 1 Jan 11 10:30:28 lalumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 11 10:30:28 lalumio volumio[1160]: info: Reloading queue from file Jan 11 10:30:28 lalumio volumio[1160]: info: VolumeController:: Volume=100 Mute =false Jan 11 10:30:28 lalumio volumio[1160]: info: CoreStateMachine::pushState Jan 11 10:30:28 lalumio volumio[1160]: info: CorePlayQueue::getTrack 0 Jan 11 10:30:28 lalumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 11 10:30:28 lalumio volumio[1160]: info: CoreCommandRouter::volumioPushState Jan 11 10:30:28 lalumio volumio[1160]: info: CoreStateMachine::updateTrackBlock Jan 11 10:30:28 lalumio volumio[1160]: info: CorePlayQueue::getTrackBlock Jan 11 10:30:28 lalumio volumio[1160]: info: CoreCommandRouter::volumioRetrievevolume Jan 11 10:30:28 lalumio volumio[1160]: info: CoreStateMachine::setRepeat null single undefined Jan 11 10:30:28 lalumio volumio[1160]: info: CoreStateMachine::pushState Jan 11 10:30:28 lalumio volumio[1160]: info: CorePlayQueue::getTrack 0 Jan 11 10:30:28 lalumio volumio[1160]: info: CoreCommandRouter::volumioPushState Jan 11 10:30:28 lalumio volumio[1160]: info: CoreStateMachine::setRandom null Jan 11 10:30:28 lalumio volumio[1160]: info: CoreStateMachine::pushState Jan 11 10:30:28 lalumio volumio[1160]: info: CorePlayQueue::getTrack 0 Jan 11 10:30:28 lalumio volumio[1160]: info: CoreCommandRouter::volumioPushState Jan 11 10:30:28 lalumio volumio[1160]: info: Setting Device type: Raspberry PI Jan 11 10:30:28 lalumio volumio[1160]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Jan 11 10:30:28 lalumio volumio[1160]: info: USB Boot Capable - System SBC Revision found in cpuinfo: c03112 Jan 11 10:30:28 lalumio volumio[1160]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Jan 11 10:30:28 lalumio volumio[1160]: info: Completed loading Core Plugins Jan 11 10:30:28 lalumio volumio[1160]: info: Preparing to generate the ALSA configuration file Jan 11 10:30:28 lalumio volumio[1160]: info: Discovery: adding e2af8920-54d0-4411-9848-a5c5802085a9 Jan 11 10:30:28 lalumio volumio[1160]: info: Discovery: Found device lalumio Jan 11 10:30:28 lalumio volumio[1160]: info: CoreCommandRouter::volumioGetState Jan 11 10:30:28 lalumio volumio[1160]: info: CorePlayQueue::getTrack 0 Jan 11 10:30:28 lalumio volumio[1160]: info: Discovery: this is already registered, e2af8920-54d0-4411-9848-a5c5802085a9 Jan 11 10:30:28 lalumio volumio[1160]: info: Discovery: Found device lalumio Jan 11 10:30:28 lalumio volumio[1160]: info: CoreCommandRouter::volumioGetState Jan 11 10:30:28 lalumio volumio[1160]: info: CorePlayQueue::getTrack 0 Jan 11 10:30:28 lalumio volumio[1160]: info: VolumeController:: Volume=100 Mute =false Jan 11 10:30:28 lalumio volumio[1160]: info: CoreStateMachine::pushState Jan 11 10:30:28 lalumio volumio[1160]: info: CorePlayQueue::getTrack 0 Jan 11 10:30:28 lalumio volumio[1160]: info: CoreCommandRouter::volumioPushState Jan 11 10:30:28 lalumio volumio[1160]: info: Asound.conf file written Jan 11 10:30:29 lalumio sudo[1348]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Jan 11 10:30:29 lalumio sudo[1348]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 10:30:29 lalumio sudo[1348]: pam_unix(sudo:session): session closed for user root Jan 11 10:30:29 lalumio volumio[1318]: Forking 3 albumart workers Jan 11 10:30:29 lalumio volumio[1160]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Jan 11 10:30:29 lalumio volumio[1160]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 Jan 11 10:30:29 lalumio volumio[1160]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:2 use case configuration -2 Jan 11 10:30:29 lalumio volumio[1160]: info: Output device has changed, restarting MPD Jan 11 10:30:29 lalumio volumio[1160]: info: Output device has changed, restarting Shairport Sync Jan 11 10:30:29 lalumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 11 10:30:29 lalumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 11 10:30:29 lalumio sudo[1356]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 11 10:30:29 lalumio sudo[1356]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 10:30:29 lalumio sudo[1356]: pam_unix(sudo:session): session closed for user root Jan 11 10:30:29 lalumio sudo[1359]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 11 10:30:29 lalumio volumio[1160]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 11 10:30:29 lalumio sudo[1359]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 10:30:29 lalumio volumio[1160]: info: ___________ START PLUGINS ___________ Jan 11 10:30:29 lalumio volumio[1160]: info: ControllerMpd::onStart: Initializing MPD Jan 11 10:30:29 lalumio volumio[1160]: info: Creating MPD Configuration file Jan 11 10:30:29 lalumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 11 10:30:29 lalumio volumio[1160]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 11 10:30:29 lalumio volumio[1160]: info: [1768145429951] CoreMusicLibrary::Adding element Media Servers Jan 11 10:30:29 lalumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 11 10:30:30 lalumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Jan 11 10:30:30 lalumio systemd[1]: Starting mpd.service - Music Player Daemon... Jan 11 10:30:30 lalumio volumio[1160]: info: UPNP Browser: Client initialized successfully Jan 11 10:30:30 lalumio sudo[1391]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 11 10:30:30 lalumio sudo[1391]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 10:30:30 lalumio sudo[1393]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 11 10:30:30 lalumio sudo[1391]: pam_unix(sudo:session): session closed for user root Jan 11 10:30:30 lalumio sudo[1395]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 11 10:30:30 lalumio sudo[1395]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jan 11 10:30:30 lalumio sudo[1393]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 10:30:30 lalumio sudo[1397]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Jan 11 10:30:30 lalumio sudo[1395]: pam_unix(sudo:session): session closed for user root Jan 11 10:30:30 lalumio systemd[1]: mpd.service: Deactivated successfully. Jan 11 10:30:30 lalumio systemd[1]: Stopped mpd.service - Music Player Daemon. Jan 11 10:30:30 lalumio systemd[1]: mpd.socket: Deactivated successfully. Jan 11 10:30:30 lalumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Jan 11 10:30:30 lalumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Jan 11 10:30:30 lalumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 11 10:30:30 lalumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 11 10:30:30 lalumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Jan 11 10:30:30 lalumio systemd[1]: Starting mpd.service - Music Player Daemon... Jan 11 10:30:30 lalumio volumio[1160]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 11 10:30:30 lalumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 11 10:30:30 lalumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 11 10:30:30 lalumio sudo[1406]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 11 10:30:30 lalumio sudo[1406]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jan 11 10:30:30 lalumio sudo[1419]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Jan 11 10:30:30 lalumio sudo[1406]: pam_unix(sudo:session): session closed for user root Jan 11 10:30:31 lalumio volumio[1160]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 11 10:30:31 lalumio volumio[1160]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 11 10:30:31 lalumio volumio[1160]: info: [1768145431083] CoreMusicLibrary::Adding element Last_100 Jan 11 10:30:31 lalumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 11 10:30:31 lalumio volumio[1160]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 11 10:30:31 lalumio volumio[1160]: info: [1768145431088] CoreMusicLibrary::Adding element Webradio Jan 11 10:30:31 lalumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 11 10:30:31 lalumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 11 10:30:31 lalumio volumio[1160]: info: Initializing BBC Radios Jan 11 10:30:31 lalumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 2. Jan 11 10:30:31 lalumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Jan 11 10:30:31 lalumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Jan 11 10:30:31 lalumio upmpdcli[1433]: Could not open config: /tmp/upmpdcli.conf Jan 11 10:30:31 lalumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Jan 11 10:30:31 lalumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Jan 11 10:30:31 lalumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 11 10:30:32 lalumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 11 10:30:32 lalumio volumio[1160]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 11 10:30:32 lalumio volumio[1160]: info: [1768145432111] CoreMusicLibrary::Adding element SoundCloud Jan 11 10:30:32 lalumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 11 10:30:32 lalumio volumio[1160]: Cannot find translation for source SoundCloud Jan 11 10:30:32 lalumio volumio[1160]: info: Volumio Calling Home Jan 11 10:30:33 lalumio systemd[1]: systemd-hostnamed.service: Deactivated successfully. Jan 11 10:30:36 lalumio sudo[1450]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 11 10:30:36 lalumio sudo[1450]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 10:30:36 lalumio sudo[1450]: pam_unix(sudo:session): session closed for user root Jan 11 10:30:36 lalumio volumio[1160]: info: MPD Permissions set Jan 11 10:30:36 lalumio volumio[1160]: info: MPD Permissions set Jan 11 10:30:36 lalumio sudo[1453]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 11 10:30:37 lalumio sudo[1453]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 10:30:37 lalumio sudo[1453]: pam_unix(sudo:session): session closed for user root Jan 11 10:30:37 lalumio volumio[1160]: info: Volumio called home Jan 11 10:30:38 lalumio volumio[1160]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Jan 11 10:30:38 lalumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 11 10:30:38 lalumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 11 10:30:38 lalumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 11 10:30:38 lalumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 11 10:30:38 lalumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 11 10:30:38 lalumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 11 10:30:38 lalumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 11 10:30:38 lalumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 11 10:30:38 lalumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 11 10:30:39 lalumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 11 10:30:39 lalumio mpd[1420]: 2026-01-11T10:30:39 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 11 10:30:39 lalumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 11 10:30:39 lalumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 11 10:30:39 lalumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 11 10:30:39 lalumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 11 10:30:39 lalumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 11 10:30:39 lalumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 11 10:30:39 lalumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 11 10:30:39 lalumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 11 10:30:39 lalumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 11 10:30:39 lalumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 11 10:30:40 lalumio systemd[1]: Started mpd.service - Music Player Daemon. Jan 11 10:30:40 lalumio sudo[1393]: pam_unix(sudo:session): session closed for user root Jan 11 10:30:40 lalumio sudo[1359]: pam_unix(sudo:session): session closed for user root Jan 11 10:30:40 lalumio systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Jan 11 10:30:41 lalumio systemd[1]: setdatetime-helper.service: Deactivated successfully. Jan 11 10:30:41 lalumio systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Jan 11 10:30:41 lalumio systemd[1]: setdatetime-helper.service: Consumed 1.134s CPU time. Jan 11 10:30:42 lalumio volumio[1160]: info: Completed starting Core Plugins Jan 11 10:30:42 lalumio volumio[1160]: info: ------------------------------------------- Jan 11 10:30:42 lalumio volumio[1160]: info: ----- MyVolumio plugins startup ---- Jan 11 10:30:42 lalumio volumio[1160]: info: ------------------------------------------- Jan 11 10:30:42 lalumio volumio[1160]: info: [MyVolumio PluginManager] Fetching plans data.... Jan 11 10:30:42 lalumio volumio[1160]: info: Starting Shairport Sync Jan 11 10:30:42 lalumio volumio[1160]: info: Starting Shairport Sync Jan 11 10:30:42 lalumio sudo[1514]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 11 10:30:42 lalumio sudo[1514]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 10:30:42 lalumio sudo[1512]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jan 11 10:30:42 lalumio sudo[1512]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 10:30:42 lalumio volumio[1160]: info: Starting Shairport Sync Jan 11 10:30:42 lalumio sudo[1516]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 11 10:30:42 lalumio sudo[1516]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 10:30:42 lalumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Jan 11 10:30:42 lalumio systemd[1]: shairport-sync.service: Deactivated successfully. Jan 11 10:30:42 lalumio volumio[1353]: Starting albumart workers Jan 11 10:30:42 lalumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jan 11 10:30:42 lalumio systemd[1]: shairport-sync.service: Consumed 2.359s CPU time. Jan 11 10:30:42 lalumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jan 11 10:30:42 lalumio sudo[1514]: pam_unix(sudo:session): session closed for user root Jan 11 10:30:42 lalumio volumio[1355]: Starting albumart workers Jan 11 10:30:43 lalumio sudo[1520]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 11 10:30:43 lalumio sudo[1520]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 10:30:43 lalumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Jan 11 10:30:43 lalumio systemd[1]: shairport-sync.service: Deactivated successfully. Jan 11 10:30:43 lalumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jan 11 10:30:43 lalumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jan 11 10:30:43 lalumio sudo[1520]: pam_unix(sudo:session): session closed for user root Jan 11 10:30:43 lalumio sudo[1516]: pam_unix(sudo:session): session closed for user root Jan 11 10:30:44 lalumio volumio[1160]: error: MPD error: The expression evaluated to a falsy value: Jan 11 10:30:44 lalumio volumio[1160]: assert.ok(self.idling) Jan 11 10:30:44 lalumio volumio[1160]: error: The expression evaluated to a falsy value: Jan 11 10:30:44 lalumio volumio[1160]: assert.ok(self.idling) Jan 11 10:30:44 lalumio volumio[1358]: Starting albumart workers Jan 11 10:30:44 lalumio volumio[1160]: error: updateQueue error: null Jan 11 10:30:44 lalumio volumio[1160]: info: Shairport-Sync Started Jan 11 10:30:44 lalumio volumio[1160]: Error adding Membership: Error: addMembership EINVAL Jan 11 10:30:44 lalumio volumio[1160]: info: Shairport-Sync Started Jan 11 10:30:44 lalumio volumio[1160]: info: Shairport-Sync Started Jan 11 10:30:44 lalumio volumio[1160]: info: MPD running with PID1420 Jan 11 10:30:44 lalumio volumio[1160]: ,establishing connection Jan 11 10:30:45 lalumio volumio[1160]: error: updateQueue error: null Jan 11 10:30:45 lalumio volumio[1160]: info: CoreCommandRouter::volumioGetState Jan 11 10:30:45 lalumio volumio[1160]: info: CorePlayQueue::getTrack 0 Jan 11 10:30:45 lalumio sudo[1555]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Jan 11 10:30:45 lalumio sudo[1555]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 10:30:45 lalumio sudo[1556]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Jan 11 10:30:45 lalumio sudo[1556]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 11 10:30:45 lalumio systemd[1]: Started mpd_monitor.service - MPD Monitor Service. Jan 11 10:30:45 lalumio sudo[1555]: pam_unix(sudo:session): session closed for user root Jan 11 10:30:45 lalumio volumio[1160]: info: Successfully started MPD Monitor Jan 11 10:30:45 lalumio mpd_monitor.sh[1559]: MPD Monitor Service: Starting MPD Monitor Service Jan 11 10:30:45 lalumio sudo[1556]: pam_unix(sudo:session): session closed for user root Jan 11 10:30:45 lalumio volumio[1160]: info: Successfully started MPD Monitor Jan 11 10:30:46 lalumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 3. Jan 11 10:30:46 lalumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Jan 11 10:30:46 lalumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Jan 11 10:30:46 lalumio sudo[1512]: pam_unix(sudo:session): session closed for user root Jan 11 10:30:46 lalumio volumio[1160]: info: Upmpdcli Daemon Started Jan 11 10:30:50 lalumio volumio[1160]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Jan 11 10:31:04 lalumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 11 10:31:04 lalumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 11 10:31:04 lalumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jan 11 10:31:04 lalumio volumio[1160]: error: MyVolumio Plugin failed to start in a timely fashion Jan 11 10:31:04 lalumio volumio[1160]: [Metrics] CommandRouter: 49s 62.29ms Jan 11 10:31:04 lalumio volumio[1160]: info: CoreCommandRouter::volumiosetStartupVolume Jan 11 10:31:04 lalumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 11 10:31:04 lalumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 11 10:31:04 lalumio volumio[1160]: info: CoreCommandRouter::Close All Modals sent Jan 11 10:31:04 lalumio volumio[1160]: info: CoreCommandRouter::Close All Modals sent Jan 11 10:31:04 lalumio volumio[1160]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 11 10:31:04 lalumio volumio[1160]: Error [ERR_INTERNAL_ASSERTION]: This is caused by either a bug in Node.js or incorrect usage of Node.js internals. Jan 11 10:31:04 lalumio volumio[1160]: Please open an issue with this stack trace at https://github.com/nodejs/node/issues Jan 11 10:31:04 lalumio volumio[1160]: at new NodeError (node:internal/errors:405:5) Jan 11 10:31:04 lalumio volumio[1160]: at assert (node:internal/assert:14:11) Jan 11 10:31:04 lalumio volumio[1160]: at internalConnectMultiple (node:net:1118:3) Jan 11 10:31:04 lalumio volumio[1160]: at Timeout.internalConnectMultipleTimeout (node:net:1687:3) Jan 11 10:31:04 lalumio volumio[1160]: at listOnTimeout (node:internal/timers:575:11) Jan 11 10:31:04 lalumio volumio[1160]: at process.processTimers (node:internal/timers:514:7) { Jan 11 10:31:04 lalumio volumio[1160]: code: 'ERR_INTERNAL_ASSERTION' Jan 11 10:31:04 lalumio volumio[1160]: } Jan 11 10:31:04 lalumio volumio[1160]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 11 10:31:13 lalumio sudo[1662]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-01-11 10:30' Jan 11 10:31:14 lalumio sudo[1662]: 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="cfdc872d40b979cca36352a7333c940c38dc64b5" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 5 20:42:14 UTC 2025" VOLUMIO_VERSION="4.073" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="67fdc5f60f00b7a328ccd8c4ad441086"