Oct 12 15:25:01 volumio volumio-remote-updater[782]: [2026-10-12 15:25:01] [connect] Successful connection Oct 12 15:25:01 volumio wpa_supplicant[1182]: RRM: Ignoring radio measurement request: Not RRM network Oct 12 15:25:05 volumio sudo[1949]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-12 15:24' Oct 12 15:25:05 volumio sudo[1949]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 15:25:05 volumio sudo[1949]: pam_unix(sudo:session): session closed for user root Oct 12 15:25:05 volumio volumio[1880]: Starting albumart workers Oct 12 15:25:05 volumio volumio[1885]: Starting albumart workers Oct 12 15:25:06 volumio volumio[1881]: Starting albumart workers Oct 12 15:25:06 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Oct 12 15:25:06 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Oct 12 15:25:06 volumio systemd[1]: volumio.service: Consumed 47.588s CPU time. Oct 12 15:25:06 volumio systemd[1]: Started dynamicswap.service - dynamicswap service. Oct 12 15:25:06 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 3. Oct 12 15:25:06 volumio systemd[1]: Stopped volumio.service - Volumio Backend Module. Oct 12 15:25:06 volumio systemd[1]: volumio.service: Consumed 47.588s CPU time. Oct 12 15:25:06 volumio systemd[1]: Started volumio.service - Volumio Backend Module. Oct 12 15:25:06 volumio systemd[1]: dynamicswap.service: Deactivated successfully. Oct 12 15:25:10 volumio volumio[1968]: info: ------------------------------------------- Oct 12 15:25:10 volumio volumio[1968]: info: ----- Volumio3 ---- Oct 12 15:25:10 volumio volumio[1968]: info: ------------------------------------------- Oct 12 15:25:10 volumio volumio[1968]: info: ----- System startup ---- Oct 12 15:25:10 volumio volumio[1968]: info: ------------------------------------------- Oct 12 15:25:11 volumio volumio[1968]: info: MYVOLUMIO Environment detected Oct 12 15:25:11 volumio volumio[1968]: info: Plugin folders cleanup Oct 12 15:25:11 volumio volumio[1968]: info: Scanning into folder /volumio/app/plugins/ Oct 12 15:25:11 volumio volumio[1968]: info: Scanning category audio_interface Oct 12 15:25:11 volumio volumio[1968]: info: Scanning category miscellanea Oct 12 15:25:11 volumio volumio[1968]: info: Scanning category music_service Oct 12 15:25:11 volumio volumio[1968]: info: Scanning category plugins.json Oct 12 15:25:11 volumio volumio[1968]: info: Scanning category system_controller Oct 12 15:25:11 volumio volumio[1968]: info: Scanning category user_interface Oct 12 15:25:11 volumio volumio[1968]: info: Scanning into folder /data/plugins/ Oct 12 15:25:11 volumio volumio[1968]: info: Scanning category music_service Oct 12 15:25:11 volumio volumio[1968]: info: Plugin folders cleanup completed Oct 12 15:25:11 volumio volumio[1968]: info: ------------------------------------------- Oct 12 15:25:11 volumio volumio[1968]: info: ----- Core plugins startup ---- Oct 12 15:25:11 volumio volumio[1968]: info: ------------------------------------------- Oct 12 15:25:11 volumio volumio[1968]: info: Loading plugins from folder /volumio/app/plugins/ Oct 12 15:25:11 volumio volumio[1968]: info: Adding plugin upnp to MyMusic Plugins Oct 12 15:25:11 volumio volumio[1968]: info: Adding plugin airplay_emulation to MyMusic Plugins Oct 12 15:25:11 volumio volumio[1968]: info: Adding plugin upnp_browser to MyMusic Plugins Oct 12 15:25:11 volumio volumio[1968]: info: Loading plugins from folder /data/plugins/ Oct 12 15:25:11 volumio volumio[1968]: info: Loading plugin "system"... Oct 12 15:25:11 volumio volumio[1968]: info: Loading plugin "appearance"... Oct 12 15:25:12 volumio volumio[1968]: info: Loading plugin "network"... Oct 12 15:25:12 volumio volumio[1968]: info: Refreshing Cached IP Addresses Oct 12 15:25:13 volumio volumio[1968]: info: Loading plugin "services"... Oct 12 15:25:13 volumio volumio[1968]: info: Loading plugin "volumio5onboarding"... Oct 12 15:25:13 volumio sudo[1996]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 12 15:25:13 volumio sudo[1996]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 15:25:13 volumio sudo[2003]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Oct 12 15:25:13 volumio sudo[2003]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 15:25:13 volumio volumio[1968]: info: Loading plugin "alsa_controller"... Oct 12 15:25:13 volumio sudo[1996]: pam_unix(sudo:session): session closed for user root Oct 12 15:25:13 volumio sudo[1998]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 12 15:25:13 volumio sudo[1998]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 15:25:13 volumio sudo[1998]: pam_unix(sudo:session): session closed for user root Oct 12 15:25:13 volumio volumio[1968]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 12 15:25:13 volumio volumio[1968]: info: Loading plugin "wizard"... Oct 12 15:25:13 volumio volumio[1968]: info: Loading plugin "networkfs"... Oct 12 15:25:13 volumio volumio[1968]: info: Starting Udev Watcher for removable devices Oct 12 15:25:13 volumio volumio[1968]: info: Ignoring mount for partition: boot Oct 12 15:25:13 volumio volumio[1968]: info: Ignoring mount for partition: volumio Oct 12 15:25:13 volumio volumio[1968]: info: Ignoring mount for partition: volumio_data Oct 12 15:25:13 volumio volumio[1968]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 12 15:25:13 volumio volumio[1968]: info: Loading plugin "volumio_command_line_client"... Oct 12 15:25:13 volumio volumio[1968]: info: Plugin upnp is not enabled Oct 12 15:25:13 volumio volumio[1968]: info: Loading plugin "my_music"... Oct 12 15:25:13 volumio volumio[1968]: info: Loading plugin "mpd"... Oct 12 15:25:13 volumio volumio[1968]: info: Plugin upnp_browser is not enabled Oct 12 15:25:13 volumio volumio[1968]: info: Loading plugin "alarm-clock"... Oct 12 15:25:14 volumio volumio[1968]: info: Loading plugin "airplay_emulation"... Oct 12 15:25:14 volumio volumio[1968]: info: Starting Shairport Sync Oct 12 15:25:14 volumio volumio[1968]: info: Loading plugin "last_100"... Oct 12 15:25:14 volumio volumio[1968]: info: Loading plugin "webradio"... Oct 12 15:25:14 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 7. Oct 12 15:25:14 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Oct 12 15:25:15 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Oct 12 15:25:15 volumio upmpdcli[2026]: Could not open config: /tmp/upmpdcli.conf Oct 12 15:25:15 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Oct 12 15:25:15 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Oct 12 15:25:15 volumio volumio[1968]: info: Loading plugin "i2s_dacs"... Oct 12 15:25:15 volumio volumio[1968]: info: I2S DAC not set, start Auto-detection Oct 12 15:25:15 volumio volumio[1968]: info: Loading plugin "volumiodiscovery"... Oct 12 15:25:15 volumio volumio[1968]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 12 15:25:15 volumio volumio[1968]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 12 15:25:15 volumio volumio[1968]: *** WARNING *** For more information see Oct 12 15:25:15 volumio volumio[1968]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 12 15:25:15 volumio volumio[1968]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 12 15:25:15 volumio node[1968]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 12 15:25:15 volumio volumio[1968]: *** WARNING *** For more information see Oct 12 15:25:15 volumio node[1968]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 12 15:25:15 volumio node[1968]: *** WARNING *** For more information see Oct 12 15:25:15 volumio node[1968]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 12 15:25:15 volumio node[1968]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 12 15:25:15 volumio node[1968]: *** WARNING *** For more information see Oct 12 15:25:15 volumio volumio[1968]: info: Applying required configuration parameters for plugin volumiodiscovery Oct 12 15:25:15 volumio volumio[1968]: info: Discovery: Started advertising with name: Volumio Oct 12 15:25:15 volumio volumio[1968]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 12 15:25:15 volumio volumio[1968]: info: Loading plugin "spop"... Oct 12 15:25:16 volumio volumio-remote-updater[782]: [2026-10-12 15:25:16] [connect] Successful connection Oct 12 15:25:16 volumio sudo[2003]: pam_unix(sudo:session): session closed for user root Oct 12 15:25:17 volumio volumio[1968]: info: Loading plugin "outputs"... Oct 12 15:25:17 volumio volumio[1968]: info: Loading plugin "albumart"... Oct 12 15:25:17 volumio volumio[1968]: info: Plugin example_plugin is not enabled Oct 12 15:25:17 volumio volumio[1968]: info: Loading plugin "inputs"... Oct 12 15:25:17 volumio volumio[1968]: info: Loading plugin "updater_comm"... Oct 12 15:25:17 volumio volumio[1968]: info: Plugin mpdemulation is not enabled Oct 12 15:25:17 volumio volumio[1968]: info: Loading plugin "rest_api"... Oct 12 15:25:17 volumio volumio[1968]: info: Loading plugin "websocket"... Oct 12 15:25:17 volumio volumio[1968]: info: Starting Socket.io Server version 1.7.4 Oct 12 15:25:17 volumio volumio[1968]: info: Loading i18n strings for locale de Oct 12 15:25:17 volumio volumio[1968]: Updating browse sources language Oct 12 15:25:17 volumio volumio[1968]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 12 15:25:18 volumio volumio[1968]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 12 15:25:18 volumio volumio[1968]: info: CoreCommandRouter::initPlayerControls Oct 12 15:25:18 volumio volumio[1968]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 15:25:18 volumio volumio[1968]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 15:25:18 volumio volumio[1968]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 15:25:18 volumio volumio[1968]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 15:25:18 volumio volumio[1968]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 15:25:18 volumio volumio[1968]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 15:25:18 volumio volumio[1968]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 15:25:18 volumio volumio[1968]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 15:25:18 volumio volumio[1968]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 12 15:25:18 volumio volumio[1968]: Express server listening on port 3000 Oct 12 15:25:18 volumio volumio[1968]: [Metrics] WebUI: 8s 982.60ms Oct 12 15:25:18 volumio volumio[1968]: info: CoreStateMachine::resetVolumioState Oct 12 15:25:18 volumio volumio[1968]: info: CoreStateMachine::getcurrentVolume Oct 12 15:25:18 volumio volumio[1968]: info: CoreCommandRouter::volumioRetrievevolume Oct 12 15:25:18 volumio volumio[1968]: info: CoreStateMachine::pushState Oct 12 15:25:18 volumio volumio[1968]: info: CorePlayQueue::getTrack 0 Oct 12 15:25:18 volumio volumio[1968]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 15:25:18 volumio volumio[1968]: info: CoreCommandRouter::volumioPushState Oct 12 15:25:18 volumio volumio[1968]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 15:25:18 volumio volumio[1968]: info: Volumio Network Manager: Network status updated: 2 Oct 12 15:25:19 volumio volumio[1968]: verbose: New Socket.io Connection to 192.168.178.15:3000 from 192.168.178.6 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Oct 12 15:25:19 volumio volumio[2029]: Forking 3 albumart workers Oct 12 15:25:19 volumio volumio-remote-updater[782]: [2026-10-12 15:25:19] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=3&transport=websocket&t=1791811516 101 Oct 12 15:25:19 volumio volumio[1968]: 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: 2 Oct 12 15:25:19 volumio volumio[1968]: info: Reloading queue from file Oct 12 15:25:19 volumio volumio[1968]: verbose: New Socket.io Connection to 192.168.178.15:3000 from 192.168.178.6 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Oct 12 15:25:19 volumio volumio[1968]: info: CoreStateMachine::setRepeat null single undefined Oct 12 15:25:19 volumio volumio[1968]: info: CoreStateMachine::pushState Oct 12 15:25:19 volumio volumio[1968]: info: CorePlayQueue::getTrack 0 Oct 12 15:25:19 volumio volumio[1968]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 15:25:19 volumio volumio[1968]: info: CoreCommandRouter::volumioPushState Oct 12 15:25:19 volumio volumio[1968]: info: CoreStateMachine::setRandom null Oct 12 15:25:19 volumio volumio[1968]: info: CoreStateMachine::pushState Oct 12 15:25:19 volumio volumio[1968]: info: CorePlayQueue::getTrack 0 Oct 12 15:25:19 volumio volumio[1968]: info: CoreCommandRouter::volumioPushState Oct 12 15:25:19 volumio volumio[1968]: info: Setting Device type: Raspberry PI Oct 12 15:25:19 volumio volumio[1968]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Oct 12 15:25:19 volumio volumio[1968]: info: USB Boot Capable - System SBC Revision found in cpuinfo: d03114 Oct 12 15:25:19 volumio volumio[1968]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Oct 12 15:25:19 volumio ntpd[998]: DNS: dns_check: processing 0.debian.pool.ntp.org, 8, 101 Oct 12 15:25:19 volumio ntpd[998]: DNS: dns_check: DNS error: -11, System error Oct 12 15:25:19 volumio ntpd[998]: DNS: dns_take_status: 0.debian.pool.ntp.org=>error, 12 Oct 12 15:25:20 volumio volumio[1968]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Oct 12 15:25:20 volumio volumio[1968]: info: Completed loading Core Plugins Oct 12 15:25:20 volumio volumio[1968]: info: Preparing to generate the ALSA configuration file Oct 12 15:25:20 volumio volumio[1968]: info: CoreCommandRouter::volumioGetState Oct 12 15:25:20 volumio volumio[1968]: info: CorePlayQueue::getTrack 0 Oct 12 15:25:21 volumio volumio[1968]: info: Asound.conf file written Oct 12 15:25:21 volumio sudo[2081]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Oct 12 15:25:21 volumio sudo[2081]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 15:25:21 volumio sudo[2081]: pam_unix(sudo:session): session closed for user root Oct 12 15:25:21 volumio volumio[1968]: /bin/mv: cannot move '/home/volumio/.asoundrc' to '/etc/asound.conf': Operation not permitted Oct 12 15:25:21 volumio volumio[1968]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 12 15:25:22 volumio volumio[1968]: Error: Command failed: /usr/bin/sudo /bin/mv /home/volumio/.asoundrc /etc/asound.conf Oct 12 15:25:22 volumio volumio[1968]: /bin/mv: cannot move '/home/volumio/.asoundrc' to '/etc/asound.conf': Operation not permitted Oct 12 15:25:22 volumio volumio[1968]: at checkExecSyncError (node:child_process:887:11) Oct 12 15:25:22 volumio volumio[1968]: at execSync (node:child_process:959:15) Oct 12 15:25:22 volumio volumio[1968]: at /volumio/app/plugins/audio_interface/alsa_controller/index.js:2223:13 Oct 12 15:25:22 volumio volumio[1968]: at /volumio/node_modules/graceful-fs/graceful-fs.js:143:16 Oct 12 15:25:22 volumio volumio[1968]: at /volumio/node_modules/graceful-fs/graceful-fs.js:61:14 Oct 12 15:25:22 volumio volumio[1968]: at FSReqCallback.oncomplete (node:fs:190:23) { Oct 12 15:25:22 volumio volumio[1968]: status: 1, Oct 12 15:25:22 volumio volumio[1968]: signal: null, Oct 12 15:25:22 volumio volumio[1968]: output: [ Oct 12 15:25:22 volumio volumio[1968]: null, Oct 12 15:25:22 volumio volumio[1968]: '', Oct 12 15:25:22 volumio volumio[1968]: "/bin/mv: cannot move '/home/volumio/.asoundrc' to '/etc/asound.conf': Operation not permitted\n" Oct 12 15:25:22 volumio volumio[1968]: ], Oct 12 15:25:22 volumio volumio[1968]: pid: 2080, Oct 12 15:25:22 volumio volumio[1968]: stdout: '', Oct 12 15:25:22 volumio volumio[1968]: stderr: "/bin/mv: cannot move '/home/volumio/.asoundrc' to '/etc/asound.conf': Operation not permitted\n" Oct 12 15:25:22 volumio volumio[1968]: } Oct 12 15:25:22 volumio volumio[1968]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 12 15:25:25 volumio wpa_supplicant[1182]: RRM: Ignoring radio measurement request: Not RRM network Oct 12 15:25:27 volumio wpa_supplicant[1182]: RRM: Ignoring radio measurement request: Not RRM network Oct 12 15:25:29 volumio sudo[2111]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-12 15:24' Oct 12 15:25:29 volumio sudo[2111]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 15:25:29 volumio volumio[2045]: Starting albumart workers Oct 12 15:25:29 volumio volumio[2043]: Starting albumart workers Oct 12 15:25:30 volumio sudo[2111]: pam_unix(sudo:session): session closed for user root Oct 12 15:25:30 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 8. Oct 12 15:25:30 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Oct 12 15:25:30 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Oct 12 15:25:30 volumio upmpdcli[2116]: Could not open config: /tmp/upmpdcli.conf Oct 12 15:25:30 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Oct 12 15:25:30 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Oct 12 15:25:31 volumio volumio[2044]: Starting albumart workers Oct 12 15:25:40 volumio volumio-remote-updater[782]: [2026-10-12 15:25:40] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Oct 12 15:25:40 volumio volumio-remote-updater[782]: [2026-10-12 15:25:40] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Oct 12 15:25:40 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Oct 12 15:25:40 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Oct 12 15:25:40 volumio systemd[1]: volumio.service: Consumed 1min 11.747s CPU time. Oct 12 15:25:40 volumio systemd[1]: Started dynamicswap.service - dynamicswap service. Oct 12 15:25:40 volumio systemd[1]: dynamicswap.service: Deactivated successfully. Oct 12 15:25:40 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 4. Oct 12 15:25:40 volumio systemd[1]: Started dynamicswap.service - dynamicswap service. Oct 12 15:25:40 volumio systemd[1]: Stopped volumio.service - Volumio Backend Module. Oct 12 15:25:40 volumio systemd[1]: volumio.service: Consumed 1min 11.747s CPU time. Oct 12 15:25:40 volumio systemd[1]: Started volumio.service - Volumio Backend Module. Oct 12 15:25:40 volumio systemd[1]: dynamicswap.service: Deactivated successfully. Oct 12 15:25:44 volumio volumio[2165]: info: ------------------------------------------- Oct 12 15:25:44 volumio volumio[2165]: info: ----- Volumio3 ---- Oct 12 15:25:44 volumio volumio[2165]: info: ------------------------------------------- Oct 12 15:25:44 volumio volumio[2165]: info: ----- System startup ---- Oct 12 15:25:44 volumio volumio[2165]: info: ------------------------------------------- Oct 12 15:25:45 volumio volumio[2165]: info: MYVOLUMIO Environment detected Oct 12 15:25:45 volumio volumio[2165]: info: Plugin folders cleanup Oct 12 15:25:45 volumio volumio[2165]: info: Scanning into folder /volumio/app/plugins/ Oct 12 15:25:45 volumio volumio[2165]: info: Scanning category audio_interface Oct 12 15:25:45 volumio volumio[2165]: info: Scanning category miscellanea Oct 12 15:25:45 volumio volumio[2165]: info: Scanning category music_service Oct 12 15:25:45 volumio volumio[2165]: info: Scanning category plugins.json Oct 12 15:25:45 volumio volumio[2165]: info: Scanning category system_controller Oct 12 15:25:45 volumio volumio[2165]: info: Scanning category user_interface Oct 12 15:25:45 volumio volumio[2165]: info: Scanning into folder /data/plugins/ Oct 12 15:25:45 volumio volumio[2165]: info: Scanning category music_service Oct 12 15:25:45 volumio volumio[2165]: info: Plugin folders cleanup completed Oct 12 15:25:45 volumio volumio[2165]: info: ------------------------------------------- Oct 12 15:25:45 volumio volumio[2165]: info: ----- Core plugins startup ---- Oct 12 15:25:45 volumio volumio[2165]: info: ------------------------------------------- Oct 12 15:25:45 volumio volumio[2165]: info: Loading plugins from folder /volumio/app/plugins/ Oct 12 15:25:45 volumio volumio[2165]: info: Adding plugin upnp to MyMusic Plugins Oct 12 15:25:45 volumio volumio[2165]: info: Adding plugin airplay_emulation to MyMusic Plugins Oct 12 15:25:45 volumio volumio[2165]: info: Adding plugin upnp_browser to MyMusic Plugins Oct 12 15:25:45 volumio volumio[2165]: info: Loading plugins from folder /data/plugins/ Oct 12 15:25:45 volumio volumio[2165]: info: Loading plugin "system"... Oct 12 15:25:45 volumio volumio[2165]: info: Loading plugin "appearance"... Oct 12 15:25:45 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 9. Oct 12 15:25:45 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Oct 12 15:25:45 volumio volumio-remote-updater[782]: [2026-10-12 15:25:45] [connect] Successful connection Oct 12 15:25:45 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Oct 12 15:25:45 volumio upmpdcli[2192]: Could not open config: /tmp/upmpdcli.conf Oct 12 15:25:45 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Oct 12 15:25:45 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Oct 12 15:25:46 volumio volumio[2165]: info: Loading plugin "network"... Oct 12 15:25:46 volumio volumio[2165]: info: Refreshing Cached IP Addresses Oct 12 15:25:46 volumio volumio[2165]: info: Loading plugin "services"... Oct 12 15:25:46 volumio volumio[2165]: info: Loading plugin "volumio5onboarding"... Oct 12 15:25:46 volumio sudo[2196]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 12 15:25:46 volumio sudo[2196]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 15:25:46 volumio sudo[2194]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 12 15:25:46 volumio sudo[2194]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 15:25:46 volumio volumio[2165]: info: Loading plugin "alsa_controller"... Oct 12 15:25:46 volumio sudo[2202]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Oct 12 15:25:46 volumio sudo[2202]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 15:25:46 volumio sudo[2196]: pam_unix(sudo:session): session closed for user root Oct 12 15:25:47 volumio sudo[2194]: pam_unix(sudo:session): session closed for user root Oct 12 15:25:47 volumio volumio[2165]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 12 15:25:47 volumio volumio[2165]: info: Loading plugin "wizard"... Oct 12 15:25:47 volumio volumio[2165]: info: Loading plugin "networkfs"... Oct 12 15:25:47 volumio volumio[2165]: info: Starting Udev Watcher for removable devices Oct 12 15:25:47 volumio volumio[2165]: info: Ignoring mount for partition: boot Oct 12 15:25:47 volumio volumio[2165]: info: Ignoring mount for partition: volumio Oct 12 15:25:47 volumio volumio[2165]: info: Ignoring mount for partition: volumio_data Oct 12 15:25:47 volumio volumio[2165]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 12 15:25:47 volumio volumio[2165]: info: Loading plugin "volumio_command_line_client"... Oct 12 15:25:47 volumio volumio[2165]: info: Plugin upnp is not enabled Oct 12 15:25:47 volumio volumio[2165]: info: Loading plugin "my_music"... Oct 12 15:25:47 volumio volumio[2165]: info: Loading plugin "mpd"... Oct 12 15:25:47 volumio volumio[2165]: info: Plugin upnp_browser is not enabled Oct 12 15:25:47 volumio volumio[2165]: info: Loading plugin "alarm-clock"... Oct 12 15:25:48 volumio volumio[2165]: info: Loading plugin "airplay_emulation"... Oct 12 15:25:48 volumio volumio[2165]: info: Starting Shairport Sync Oct 12 15:25:48 volumio volumio[2165]: info: Loading plugin "last_100"... Oct 12 15:25:48 volumio volumio[2165]: info: Loading plugin "webradio"... Oct 12 15:25:49 volumio volumio[2165]: info: Loading plugin "i2s_dacs"... Oct 12 15:25:49 volumio volumio[2165]: info: I2S DAC not set, start Auto-detection Oct 12 15:25:49 volumio volumio[2165]: info: Loading plugin "volumiodiscovery"... Oct 12 15:25:49 volumio volumio[2165]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 12 15:25:49 volumio volumio[2165]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 12 15:25:49 volumio volumio[2165]: *** WARNING *** For more information see Oct 12 15:25:49 volumio volumio[2165]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 12 15:25:49 volumio node[2165]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 12 15:25:49 volumio volumio[2165]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 12 15:25:49 volumio volumio[2165]: *** WARNING *** For more information see Oct 12 15:25:49 volumio node[2165]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 12 15:25:49 volumio node[2165]: *** WARNING *** For more information see Oct 12 15:25:49 volumio node[2165]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 12 15:25:49 volumio node[2165]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 12 15:25:49 volumio node[2165]: *** WARNING *** For more information see Oct 12 15:25:49 volumio volumio[2165]: info: Applying required configuration parameters for plugin volumiodiscovery Oct 12 15:25:49 volumio volumio[2165]: info: Discovery: Started advertising with name: Volumio Oct 12 15:25:49 volumio volumio[2165]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 12 15:25:49 volumio volumio[2165]: info: Loading plugin "spop"... Oct 12 15:25:50 volumio sudo[2202]: pam_unix(sudo:session): session closed for user root Oct 12 15:25:51 volumio volumio[2165]: info: Loading plugin "outputs"... Oct 12 15:25:51 volumio volumio[2165]: info: Loading plugin "albumart"... Oct 12 15:25:51 volumio volumio[2165]: info: Plugin example_plugin is not enabled Oct 12 15:25:51 volumio volumio[2165]: info: Loading plugin "inputs"... Oct 12 15:25:51 volumio volumio[2165]: info: Loading plugin "updater_comm"... Oct 12 15:25:51 volumio volumio[2165]: info: Plugin mpdemulation is not enabled Oct 12 15:25:51 volumio volumio[2165]: info: Loading plugin "rest_api"... Oct 12 15:25:51 volumio volumio[2165]: info: Loading plugin "websocket"... Oct 12 15:25:51 volumio volumio[2165]: info: Starting Socket.io Server version 1.7.4 Oct 12 15:25:51 volumio volumio[2165]: info: Loading i18n strings for locale de Oct 12 15:25:51 volumio volumio[2165]: Updating browse sources language Oct 12 15:25:51 volumio volumio[2165]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 12 15:25:52 volumio volumio[2165]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 12 15:25:52 volumio volumio[2165]: info: CoreCommandRouter::initPlayerControls Oct 12 15:25:52 volumio volumio[2165]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 15:25:52 volumio volumio[2165]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 15:25:52 volumio volumio[2165]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 15:25:52 volumio volumio[2165]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 15:25:52 volumio volumio[2165]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 15:25:52 volumio volumio[2165]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 15:25:52 volumio volumio[2165]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 15:25:52 volumio volumio[2165]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 15:25:52 volumio volumio[2165]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 12 15:25:52 volumio volumio[2165]: Express server listening on port 3000 Oct 12 15:25:52 volumio volumio[2165]: [Metrics] WebUI: 8s 742.70ms Oct 12 15:25:52 volumio volumio[2165]: info: CoreStateMachine::resetVolumioState Oct 12 15:25:52 volumio volumio[2165]: info: CoreStateMachine::getcurrentVolume Oct 12 15:25:52 volumio volumio[2165]: info: CoreCommandRouter::volumioRetrievevolume Oct 12 15:25:52 volumio volumio[2165]: info: CoreStateMachine::pushState Oct 12 15:25:52 volumio volumio[2165]: info: CorePlayQueue::getTrack 0 Oct 12 15:25:52 volumio volumio[2165]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 15:25:52 volumio volumio[2165]: info: CoreCommandRouter::volumioPushState Oct 12 15:25:52 volumio volumio[2165]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 15:25:52 volumio volumio[2165]: info: Volumio Network Manager: Network status updated: 2 Oct 12 15:25:52 volumio volumio[2165]: verbose: New Socket.io Connection to 192.168.178.15:3000 from 192.168.178.6 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Oct 12 15:25:52 volumio volumio[2226]: Forking 3 albumart workers Oct 12 15:25:52 volumio volumio[2165]: verbose: New Socket.io Connection to 192.168.178.15:3000 from 192.168.178.6 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Oct 12 15:25:52 volumio volumio[2165]: info: Reloading queue from file Oct 12 15:25:53 volumio volumio[2165]: info: CoreStateMachine::setRepeat null single undefined Oct 12 15:25:53 volumio volumio[2165]: info: CoreStateMachine::pushState Oct 12 15:25:53 volumio volumio[2165]: info: CorePlayQueue::getTrack 0 Oct 12 15:25:53 volumio volumio[2165]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 15:25:53 volumio volumio[2165]: info: CoreCommandRouter::volumioPushState Oct 12 15:25:53 volumio volumio[2165]: info: CoreStateMachine::setRandom null Oct 12 15:25:53 volumio volumio[2165]: info: CoreStateMachine::pushState Oct 12 15:25:53 volumio volumio[2165]: info: CorePlayQueue::getTrack 0 Oct 12 15:25:53 volumio volumio[2165]: info: CoreCommandRouter::volumioPushState Oct 12 15:25:53 volumio volumio[2165]: info: Setting Device type: Raspberry PI Oct 12 15:25:53 volumio volumio[2165]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Oct 12 15:25:53 volumio volumio[2165]: info: USB Boot Capable - System SBC Revision found in cpuinfo: d03114 Oct 12 15:25:53 volumio volumio[2165]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Oct 12 15:25:53 volumio volumio[2165]: verbose: New Socket.io Connection to 192.168.178.15:3000 from 192.168.178.6 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Oct 12 15:25:54 volumio volumio[2165]: info: Completed loading Core Plugins Oct 12 15:25:54 volumio volumio[2165]: info: Preparing to generate the ALSA configuration file Oct 12 15:25:54 volumio volumio[2165]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Oct 12 15:25:54 volumio volumio[2165]: info: CoreCommandRouter::volumioGetState Oct 12 15:25:54 volumio volumio[2165]: info: CorePlayQueue::getTrack 0 Oct 12 15:25:55 volumio volumio[2165]: info: Asound.conf file written Oct 12 15:25:55 volumio sudo[2278]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Oct 12 15:25:55 volumio sudo[2278]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 15:25:55 volumio sudo[2278]: pam_unix(sudo:session): session closed for user root Oct 12 15:25:55 volumio volumio[2165]: /bin/mv: cannot move '/home/volumio/.asoundrc' to '/etc/asound.conf': Operation not permitted Oct 12 15:25:55 volumio volumio[2165]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 12 15:25:55 volumio volumio[2165]: Error: Command failed: /usr/bin/sudo /bin/mv /home/volumio/.asoundrc /etc/asound.conf Oct 12 15:25:55 volumio volumio[2165]: /bin/mv: cannot move '/home/volumio/.asoundrc' to '/etc/asound.conf': Operation not permitted Oct 12 15:25:55 volumio volumio[2165]: at checkExecSyncError (node:child_process:887:11) Oct 12 15:25:55 volumio volumio[2165]: at execSync (node:child_process:959:15) Oct 12 15:25:55 volumio volumio[2165]: at /volumio/app/plugins/audio_interface/alsa_controller/index.js:2223:13 Oct 12 15:25:55 volumio volumio[2165]: at /volumio/node_modules/graceful-fs/graceful-fs.js:143:16 Oct 12 15:25:55 volumio volumio[2165]: at /volumio/node_modules/graceful-fs/graceful-fs.js:61:14 Oct 12 15:25:55 volumio volumio[2165]: at FSReqCallback.oncomplete (node:fs:190:23) { Oct 12 15:25:55 volumio volumio[2165]: status: 1, Oct 12 15:25:55 volumio volumio[2165]: signal: null, Oct 12 15:25:55 volumio volumio[2165]: output: [ Oct 12 15:25:55 volumio volumio[2165]: null, Oct 12 15:25:55 volumio volumio[2165]: '', Oct 12 15:25:55 volumio volumio[2165]: "/bin/mv: cannot move '/home/volumio/.asoundrc' to '/etc/asound.conf': Operation not permitted\n" Oct 12 15:25:55 volumio volumio[2165]: ], Oct 12 15:25:55 volumio volumio[2165]: pid: 2277, Oct 12 15:25:55 volumio volumio[2165]: stdout: '', Oct 12 15:25:55 volumio volumio[2165]: stderr: "/bin/mv: cannot move '/home/volumio/.asoundrc' to '/etc/asound.conf': Operation not permitted\n" Oct 12 15:25:55 volumio volumio[2165]: } Oct 12 15:25:55 volumio volumio[2165]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 12 15:25:58 volumio volumio-remote-updater[782]: [2026-10-12 15:25:58] [connect] Successful connection Oct 12 15:26:00 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 10. Oct 12 15:26:00 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Oct 12 15:26:01 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Oct 12 15:26:01 volumio upmpdcli[2306]: Could not open config: /tmp/upmpdcli.conf Oct 12 15:26:01 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Oct 12 15:26:01 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Oct 12 15:26:01 volumio volumio[2241]: Starting albumart workers Oct 12 15:26:02 volumio volumio[2240]: Starting albumart workers Oct 12 15:26:03 volumio sudo[2309]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-12 15:25' Oct 12 15:26:03 volumio sudo[2309]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 15:26:04 volumio sudo[2309]: pam_unix(sudo:session): session closed for user root Oct 12 15:26:05 volumio volumio[2242]: Starting albumart workers Oct 12 15:26:06 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Oct 12 15:26:06 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Oct 12 15:26:06 volumio systemd[1]: volumio.service: Consumed 53.492s CPU time. Oct 12 15:26:06 volumio systemd[1]: Started dynamicswap.service - dynamicswap service. Oct 12 15:26:06 volumio systemd[1]: dynamicswap.service: Deactivated successfully. Oct 12 15:26:06 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 5. Oct 12 15:26:06 volumio systemd[1]: Started dynamicswap.service - dynamicswap service. Oct 12 15:26:06 volumio systemd[1]: Stopped volumio.service - Volumio Backend Module. Oct 12 15:26:06 volumio systemd[1]: volumio.service: Consumed 53.492s CPU time. Oct 12 15:26:06 volumio systemd[1]: Started volumio.service - Volumio Backend Module. Oct 12 15:26:06 volumio systemd[1]: dynamicswap.service: Deactivated successfully. Oct 12 15:26:10 volumio volumio[2324]: info: ------------------------------------------- Oct 12 15:26:10 volumio volumio[2324]: info: ----- Volumio3 ---- Oct 12 15:26:10 volumio volumio[2324]: info: ------------------------------------------- Oct 12 15:26:10 volumio volumio[2324]: info: ----- System startup ---- Oct 12 15:26:10 volumio volumio[2324]: info: ------------------------------------------- Oct 12 15:26:11 volumio volumio[2324]: info: MYVOLUMIO Environment detected Oct 12 15:26:11 volumio volumio[2324]: info: Plugin folders cleanup Oct 12 15:26:11 volumio volumio[2324]: info: Scanning into folder /volumio/app/plugins/ Oct 12 15:26:11 volumio volumio[2324]: info: Scanning category audio_interface Oct 12 15:26:11 volumio volumio[2324]: info: Scanning category miscellanea Oct 12 15:26:11 volumio volumio[2324]: info: Scanning category music_service Oct 12 15:26:11 volumio volumio[2324]: info: Scanning category plugins.json Oct 12 15:26:11 volumio volumio[2324]: info: Scanning category system_controller Oct 12 15:26:11 volumio volumio[2324]: info: Scanning category user_interface Oct 12 15:26:11 volumio volumio[2324]: info: Scanning into folder /data/plugins/ Oct 12 15:26:11 volumio volumio[2324]: info: Scanning category music_service Oct 12 15:26:11 volumio volumio[2324]: info: Plugin folders cleanup completed Oct 12 15:26:11 volumio volumio[2324]: info: ------------------------------------------- Oct 12 15:26:11 volumio volumio[2324]: info: ----- Core plugins startup ---- Oct 12 15:26:11 volumio volumio[2324]: info: ------------------------------------------- Oct 12 15:26:11 volumio volumio[2324]: info: Loading plugins from folder /volumio/app/plugins/ Oct 12 15:26:11 volumio volumio[2324]: info: Adding plugin upnp to MyMusic Plugins Oct 12 15:26:11 volumio volumio[2324]: info: Adding plugin airplay_emulation to MyMusic Plugins Oct 12 15:26:11 volumio volumio[2324]: info: Adding plugin upnp_browser to MyMusic Plugins Oct 12 15:26:11 volumio volumio[2324]: info: Loading plugins from folder /data/plugins/ Oct 12 15:26:11 volumio volumio[2324]: info: Loading plugin "system"... Oct 12 15:26:11 volumio volumio[2324]: info: Loading plugin "appearance"... Oct 12 15:26:12 volumio volumio[2324]: info: Loading plugin "network"... Oct 12 15:26:12 volumio volumio[2324]: info: Refreshing Cached IP Addresses Oct 12 15:26:12 volumio sudo[2352]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 12 15:26:12 volumio sudo[2352]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 15:26:12 volumio sudo[2352]: pam_unix(sudo:session): session closed for user root Oct 12 15:26:12 volumio volumio[2324]: info: Loading plugin "services"... Oct 12 15:26:12 volumio volumio[2324]: info: Loading plugin "volumio5onboarding"... Oct 12 15:26:12 volumio sudo[2354]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 12 15:26:12 volumio sudo[2354]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 15:26:12 volumio volumio[2324]: info: Loading plugin "alsa_controller"... Oct 12 15:26:12 volumio sudo[2358]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Oct 12 15:26:12 volumio sudo[2358]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 15:26:12 volumio sudo[2354]: pam_unix(sudo:session): session closed for user root Oct 12 15:26:12 volumio volumio[2324]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 12 15:26:12 volumio volumio[2324]: info: Loading plugin "wizard"... Oct 12 15:26:12 volumio volumio[2324]: info: Loading plugin "networkfs"... Oct 12 15:26:13 volumio volumio[2324]: info: Starting Udev Watcher for removable devices Oct 12 15:26:13 volumio volumio[2324]: info: Ignoring mount for partition: boot Oct 12 15:26:13 volumio volumio[2324]: info: Ignoring mount for partition: volumio Oct 12 15:26:13 volumio volumio[2324]: info: Ignoring mount for partition: volumio_data Oct 12 15:26:13 volumio volumio[2324]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 12 15:26:13 volumio volumio[2324]: info: Loading plugin "volumio_command_line_client"... Oct 12 15:26:13 volumio volumio[2324]: info: Plugin upnp is not enabled Oct 12 15:26:13 volumio volumio[2324]: info: Loading plugin "my_music"... Oct 12 15:26:13 volumio volumio[2324]: info: Loading plugin "mpd"... Oct 12 15:26:13 volumio volumio-remote-updater[782]: [2026-10-12 15:26:13] [connect] Successful connection Oct 12 15:26:13 volumio volumio[2324]: info: Plugin upnp_browser is not enabled Oct 12 15:26:13 volumio volumio[2324]: info: Loading plugin "alarm-clock"... Oct 12 15:26:14 volumio volumio[2324]: info: Loading plugin "airplay_emulation"... Oct 12 15:26:14 volumio volumio[2324]: info: Starting Shairport Sync Oct 12 15:26:14 volumio volumio[2324]: info: Loading plugin "last_100"... Oct 12 15:26:14 volumio volumio[2324]: info: Loading plugin "webradio"... Oct 12 15:26:14 volumio wpa_supplicant[1182]: wlan0: WPA: Group rekeying completed with 44:4e:6d:07:1d:d5 [GTK=CCMP] Oct 12 15:26:15 volumio volumio[2324]: info: Loading plugin "i2s_dacs"... Oct 12 15:26:15 volumio volumio[2324]: info: I2S DAC not set, start Auto-detection Oct 12 15:26:15 volumio volumio[2324]: info: Loading plugin "volumiodiscovery"... Oct 12 15:26:15 volumio volumio[2324]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 12 15:26:15 volumio node[2324]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 12 15:26:15 volumio volumio[2324]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 12 15:26:15 volumio volumio[2324]: *** WARNING *** For more information see Oct 12 15:26:15 volumio volumio[2324]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 12 15:26:15 volumio volumio[2324]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 12 15:26:15 volumio volumio[2324]: *** WARNING *** For more information see Oct 12 15:26:15 volumio volumio[2324]: info: Applying required configuration parameters for plugin volumiodiscovery Oct 12 15:26:15 volumio volumio[2324]: info: Discovery: Started advertising with name: Volumio Oct 12 15:26:15 volumio node[2324]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 12 15:26:15 volumio node[2324]: *** WARNING *** For more information see Oct 12 15:26:15 volumio node[2324]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 12 15:26:15 volumio node[2324]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 12 15:26:15 volumio node[2324]: *** WARNING *** For more information see Oct 12 15:26:15 volumio volumio[2324]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 12 15:26:15 volumio volumio[2324]: info: Loading plugin "spop"... Oct 12 15:26:16 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 11. Oct 12 15:26:16 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Oct 12 15:26:16 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Oct 12 15:26:16 volumio upmpdcli[2384]: Could not open config: /tmp/upmpdcli.conf Oct 12 15:26:16 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Oct 12 15:26:16 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Oct 12 15:26:16 volumio sudo[2358]: pam_unix(sudo:session): session closed for user root Oct 12 15:26:17 volumio volumio[2324]: info: Loading plugin "outputs"... Oct 12 15:26:17 volumio volumio[2324]: info: Loading plugin "albumart"... Oct 12 15:26:17 volumio volumio[2324]: info: Plugin example_plugin is not enabled Oct 12 15:26:17 volumio volumio[2324]: info: Loading plugin "inputs"... Oct 12 15:26:17 volumio volumio[2324]: info: Loading plugin "updater_comm"... Oct 12 15:26:17 volumio volumio[2324]: info: Plugin mpdemulation is not enabled Oct 12 15:26:17 volumio volumio[2324]: info: Loading plugin "rest_api"... Oct 12 15:26:17 volumio volumio[2324]: info: Loading plugin "websocket"... Oct 12 15:26:17 volumio volumio[2324]: info: Starting Socket.io Server version 1.7.4 Oct 12 15:26:18 volumio volumio[2324]: info: Loading i18n strings for locale de Oct 12 15:26:18 volumio volumio[2324]: Updating browse sources language Oct 12 15:26:18 volumio volumio[2324]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 12 15:26:18 volumio volumio[2324]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 12 15:26:18 volumio volumio[2324]: info: CoreCommandRouter::initPlayerControls Oct 12 15:26:18 volumio volumio[2324]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 15:26:18 volumio volumio[2324]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 15:26:18 volumio volumio[2324]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 15:26:18 volumio volumio[2324]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 15:26:18 volumio volumio[2324]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 15:26:18 volumio volumio[2324]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 15:26:18 volumio volumio[2324]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 15:26:18 volumio volumio[2324]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 12 15:26:18 volumio volumio[2324]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 12 15:26:18 volumio volumio[2324]: Express server listening on port 3000 Oct 12 15:26:18 volumio volumio[2324]: [Metrics] WebUI: 9s 460.06ms Oct 12 15:26:18 volumio volumio[2324]: info: CoreStateMachine::resetVolumioState Oct 12 15:26:18 volumio volumio[2324]: info: CoreStateMachine::getcurrentVolume Oct 12 15:26:18 volumio volumio[2324]: info: CoreCommandRouter::volumioRetrievevolume Oct 12 15:26:18 volumio volumio[2324]: info: CoreStateMachine::pushState Oct 12 15:26:18 volumio volumio[2324]: info: CorePlayQueue::getTrack 0 Oct 12 15:26:18 volumio volumio[2324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 15:26:18 volumio volumio[2324]: info: CoreCommandRouter::volumioPushState Oct 12 15:26:18 volumio volumio[2324]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 12 15:26:18 volumio volumio[2324]: info: Volumio Network Manager: Network status updated: 2 Oct 12 15:26:18 volumio volumio[2324]: verbose: New Socket.io Connection to 192.168.178.15:3000 from 192.168.178.6 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Oct 12 15:26:19 volumio volumio[2324]: info: Reloading queue from file Oct 12 15:26:19 volumio volumio[2324]: verbose: New Socket.io Connection to 192.168.178.15:3000 from 192.168.178.6 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Oct 12 15:26:19 volumio volumio[2385]: Forking 3 albumart workers Oct 12 15:26:19 volumio volumio[2324]: info: CoreStateMachine::setRepeat null single undefined Oct 12 15:26:19 volumio volumio[2324]: info: CoreStateMachine::pushState Oct 12 15:26:19 volumio volumio[2324]: info: CorePlayQueue::getTrack 0 Oct 12 15:26:19 volumio volumio[2324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 12 15:26:19 volumio volumio[2324]: info: CoreCommandRouter::volumioPushState Oct 12 15:26:19 volumio volumio[2324]: info: CoreStateMachine::setRandom null Oct 12 15:26:19 volumio volumio[2324]: info: CoreStateMachine::pushState Oct 12 15:26:19 volumio volumio[2324]: info: CorePlayQueue::getTrack 0 Oct 12 15:26:19 volumio volumio[2324]: info: CoreCommandRouter::volumioPushState Oct 12 15:26:19 volumio volumio[2324]: info: Setting Device type: Raspberry PI Oct 12 15:26:19 volumio volumio[2324]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Oct 12 15:26:19 volumio volumio[2324]: info: USB Boot Capable - System SBC Revision found in cpuinfo: d03114 Oct 12 15:26:19 volumio volumio[2324]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Oct 12 15:26:19 volumio volumio[2324]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Oct 12 15:26:19 volumio volumio[2324]: info: Completed loading Core Plugins Oct 12 15:26:19 volumio volumio[2324]: info: Preparing to generate the ALSA configuration file Oct 12 15:26:20 volumio volumio[2324]: info: CoreCommandRouter::volumioGetState Oct 12 15:26:20 volumio volumio[2324]: info: CorePlayQueue::getTrack 0 Oct 12 15:26:20 volumio volumio[2324]: info: Asound.conf file written Oct 12 15:26:20 volumio sudo[2437]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Oct 12 15:26:20 volumio sudo[2437]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 15:26:21 volumio sudo[2437]: pam_unix(sudo:session): session closed for user root Oct 12 15:26:21 volumio volumio[2324]: /bin/mv: cannot move '/home/volumio/.asoundrc' to '/etc/asound.conf': Operation not permitted Oct 12 15:26:21 volumio volumio[2324]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 12 15:26:21 volumio volumio[2324]: Error: Command failed: /usr/bin/sudo /bin/mv /home/volumio/.asoundrc /etc/asound.conf Oct 12 15:26:21 volumio volumio[2324]: /bin/mv: cannot move '/home/volumio/.asoundrc' to '/etc/asound.conf': Operation not permitted Oct 12 15:26:21 volumio volumio[2324]: at checkExecSyncError (node:child_process:887:11) Oct 12 15:26:21 volumio volumio[2324]: at execSync (node:child_process:959:15) Oct 12 15:26:21 volumio volumio[2324]: at /volumio/app/plugins/audio_interface/alsa_controller/index.js:2223:13 Oct 12 15:26:21 volumio volumio[2324]: at /volumio/node_modules/graceful-fs/graceful-fs.js:143:16 Oct 12 15:26:21 volumio volumio[2324]: at /volumio/node_modules/graceful-fs/graceful-fs.js:61:14 Oct 12 15:26:21 volumio volumio[2324]: at FSReqCallback.oncomplete (node:fs:190:23) { Oct 12 15:26:21 volumio volumio[2324]: status: 1, Oct 12 15:26:21 volumio volumio[2324]: signal: null, Oct 12 15:26:21 volumio volumio[2324]: output: [ Oct 12 15:26:21 volumio volumio[2324]: null, Oct 12 15:26:21 volumio volumio[2324]: '', Oct 12 15:26:21 volumio volumio[2324]: "/bin/mv: cannot move '/home/volumio/.asoundrc' to '/etc/asound.conf': Operation not permitted\n" Oct 12 15:26:21 volumio volumio[2324]: ], Oct 12 15:26:21 volumio volumio[2324]: pid: 2436, Oct 12 15:26:21 volumio volumio[2324]: stdout: '', Oct 12 15:26:21 volumio volumio[2324]: stderr: "/bin/mv: cannot move '/home/volumio/.asoundrc' to '/etc/asound.conf': Operation not permitted\n" Oct 12 15:26:21 volumio volumio[2324]: } Oct 12 15:26:21 volumio volumio[2324]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 12 15:26:28 volumio volumio-remote-updater[782]: [2026-10-12 15:26:28] [connect] Successful connection Oct 12 15:26:29 volumio volumio[2404]: Starting albumart workers Oct 12 15:26:30 volumio sudo[2468]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-12 15:25' Oct 12 15:26:30 volumio sudo[2468]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 12 15:26:30 volumio volumio[2406]: Starting albumart workers Oct 12 15:26:30 volumio volumio[2405]: Starting albumart workers 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="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:20:52 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="d0c2fd9dbc5e70e58c32413c12353563"