Mar 29 21:09:07 freestep go-librespot[2154]: time="2026-03-29T21:09:07+02:00" level=trace msg="sent dealer ping" Mar 29 21:09:07 freestep go-librespot[2154]: time="2026-03-29T21:09:07+02:00" level=trace msg="received dealer pong" Mar 29 21:09:36 freestep go-librespot[2154]: time="2026-03-29T21:09:36+02:00" level=trace msg="received accesspoint ping" Mar 29 21:09:36 freestep go-librespot[2154]: time="2026-03-29T21:09:36+02:00" level=trace msg="received accesspoint pong ack" Mar 29 21:09:37 freestep go-librespot[2154]: time="2026-03-29T21:09:37+02:00" level=trace msg="sent dealer ping" Mar 29 21:09:37 freestep go-librespot[2154]: time="2026-03-29T21:09:37+02:00" level=trace msg="received dealer pong" Mar 29 21:10:07 freestep go-librespot[2154]: time="2026-03-29T21:10:07+02:00" level=trace msg="sent dealer ping" Mar 29 21:10:07 freestep go-librespot[2154]: time="2026-03-29T21:10:07+02:00" level=trace msg="received dealer pong" Mar 29 21:10:13 freestep sudo[3757]: volumio : TTY=pts/0 ; PWD=/home/volumio ; USER=root ; COMMAND=/usr/bin/chattr +i /etc/asound.conf Mar 29 21:10:13 freestep sudo[3757]: pam_unix(sudo:session): session opened for user root(uid=0) by volumio(uid=1000) Mar 29 21:10:13 freestep sudo[3757]: pam_unix(sudo:session): session closed for user root Mar 29 21:10:28 freestep sudo[3792]: volumio : TTY=pts/0 ; PWD=/home/volumio ; USER=root ; COMMAND=/bin/systemctl stop volumio.service Mar 29 21:10:28 freestep sudo[3792]: pam_unix(sudo:session): session opened for user root(uid=0) by volumio(uid=1000) Mar 29 21:10:28 freestep systemd[1]: Stopping volumio.service - Volumio Backend Module... Mar 29 21:10:28 freestep volumio-remote-updater[939]: [2026-03-29 21:10:28] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Mar 29 21:10:28 freestep volumio-remote-updater[939]: [2026-03-29 21:10:28] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Mar 29 21:10:28 freestep volumio5-onboarding[2479]: time=2026-03-29T21:10:28.540+02:00 level=ERROR msg="failed reading message" error="websocket: close 1006 (abnormal closure): unexpected EOF" Mar 29 21:10:28 freestep volumio5-onboarding[2479]: time=2026-03-29T21:10:28.542+02:00 level=WARN msg="reconnection attempt failed" error="read tcp 127.0.0.1:60174->127.0.0.1:3000: read: connection reset by peer" Mar 29 21:10:28 freestep systemd[1]: volumio.service: Deactivated successfully. Mar 29 21:10:28 freestep systemd[1]: Stopped volumio.service - Volumio Backend Module. Mar 29 21:10:28 freestep go-librespot[2154]: time="2026-03-29T21:10:28+02:00" level=error msg="websocket connection errored" error="failed to get reader: failed to read frame header: EOF" Mar 29 21:10:28 freestep systemd[1]: volumio.service: Consumed 19.496s CPU time. Mar 29 21:10:28 freestep sudo[3792]: pam_unix(sudo:session): session closed for user root Mar 29 21:10:28 freestep sudo[3820]: volumio : TTY=pts/0 ; PWD=/home/volumio ; USER=root ; COMMAND=/bin/systemctl start volumio.service Mar 29 21:10:28 freestep sudo[3820]: pam_unix(sudo:session): session opened for user root(uid=0) by volumio(uid=1000) Mar 29 21:10:28 freestep systemd[1]: Started dynamicswap.service - dynamicswap service. Mar 29 21:10:28 freestep systemd[1]: Started volumio.service - Volumio Backend Module. Mar 29 21:10:28 freestep systemd[1]: dynamicswap.service: Deactivated successfully. Mar 29 21:10:28 freestep sudo[3820]: pam_unix(sudo:session): session closed for user root Mar 29 21:10:29 freestep volumio[3826]: info: ------------------------------------------- Mar 29 21:10:29 freestep volumio[3826]: info: ----- Volumio3 ---- Mar 29 21:10:29 freestep volumio[3826]: info: ------------------------------------------- Mar 29 21:10:29 freestep volumio[3826]: info: ----- System startup ---- Mar 29 21:10:29 freestep volumio[3826]: info: ------------------------------------------- Mar 29 21:10:29 freestep volumio[3826]: info: MYVOLUMIO Environment detected Mar 29 21:10:29 freestep volumio[3826]: info: Plugin folders cleanup Mar 29 21:10:29 freestep volumio[3826]: info: Scanning into folder /volumio/app/plugins/ Mar 29 21:10:29 freestep volumio[3826]: info: Scanning category audio_interface Mar 29 21:10:29 freestep volumio[3826]: info: Scanning category miscellanea Mar 29 21:10:29 freestep volumio[3826]: info: Scanning category music_service Mar 29 21:10:29 freestep volumio[3826]: info: Scanning category plugins.json Mar 29 21:10:29 freestep volumio[3826]: info: Scanning category system_controller Mar 29 21:10:29 freestep volumio[3826]: info: Scanning category user_interface Mar 29 21:10:29 freestep volumio[3826]: info: Scanning into folder /data/plugins/ Mar 29 21:10:29 freestep volumio[3826]: info: Scanning category music_service Mar 29 21:10:29 freestep volumio[3826]: info: Scanning category system_controller Mar 29 21:10:29 freestep volumio[3826]: info: Scanning category system_hardware Mar 29 21:10:29 freestep volumio[3826]: info: Scanning category user_interface Mar 29 21:10:29 freestep volumio[3826]: info: Plugin folders cleanup completed Mar 29 21:10:29 freestep volumio[3826]: info: ------------------------------------------- Mar 29 21:10:29 freestep volumio[3826]: info: ----- Core plugins startup ---- Mar 29 21:10:29 freestep volumio[3826]: info: ------------------------------------------- Mar 29 21:10:29 freestep volumio[3826]: info: Loading plugins from folder /volumio/app/plugins/ Mar 29 21:10:29 freestep volumio[3826]: info: Adding plugin upnp to MyMusic Plugins Mar 29 21:10:29 freestep volumio[3826]: info: Adding plugin airplay_emulation to MyMusic Plugins Mar 29 21:10:29 freestep volumio[3826]: info: Adding plugin upnp_browser to MyMusic Plugins Mar 29 21:10:29 freestep volumio[3826]: info: Loading plugins from folder /data/plugins/ Mar 29 21:10:29 freestep volumio[3826]: info: Loading plugin "system"... Mar 29 21:10:29 freestep volumio[3826]: info: Loading plugin "appearance"... Mar 29 21:10:29 freestep volumio[3826]: info: Loading plugin "network"... Mar 29 21:10:29 freestep volumio[3826]: info: Refreshing Cached IP Addresses Mar 29 21:10:29 freestep sudo[3856]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 29 21:10:29 freestep sudo[3856]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 29 21:10:29 freestep sudo[3858]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 29 21:10:29 freestep sudo[3858]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 29 21:10:29 freestep sudo[3856]: pam_unix(sudo:session): session closed for user root Mar 29 21:10:29 freestep sudo[3858]: pam_unix(sudo:session): session closed for user root Mar 29 21:10:29 freestep volumio[3826]: info: Loading plugin "services"... Mar 29 21:10:29 freestep volumio[3826]: info: Loading plugin "volumio5onboarding"... Mar 29 21:10:29 freestep volumio[3826]: info: Loading plugin "alsa_controller"... Mar 29 21:10:29 freestep volumio[3826]: ALSA lib conf.c:2007:(_snd_config_load_with_include) _toplevel_:39:0:Unexpected end of file Mar 29 21:10:29 freestep volumio[3826]: ALSA lib conf.c:4096:(config_file_open) /etc/asound.conf may be old or corrupted: consider to remove or fix it Mar 29 21:10:29 freestep volumio[3826]: ALSA lib conf.c:4018:(snd_config_hooks_call) function snd_config_hook_load returned error: Invalid argument Mar 29 21:10:29 freestep volumio[3826]: ALSA lib conf.c:4625:(snd_config_update_r) hooks failed, removing configuration Mar 29 21:10:29 freestep volumio[3826]: aplay: device_list:283: control open (0): Invalid argument Mar 29 21:10:29 freestep volumio[3826]: ALSA lib conf.c:2007:(_snd_config_load_with_include) _toplevel_:39:0:Unexpected end of file Mar 29 21:10:29 freestep volumio[3826]: ALSA lib conf.c:4096:(config_file_open) /etc/asound.conf may be old or corrupted: consider to remove or fix it Mar 29 21:10:29 freestep volumio[3826]: ALSA lib conf.c:4018:(snd_config_hooks_call) function snd_config_hook_load returned error: Invalid argument Mar 29 21:10:29 freestep volumio[3826]: ALSA lib conf.c:4625:(snd_config_update_r) hooks failed, removing configuration Mar 29 21:10:29 freestep volumio[3826]: aplay: device_list:283: control open (1): Invalid argument Mar 29 21:10:29 freestep volumio[3826]: ALSA lib conf.c:2007:(_snd_config_load_with_include) _toplevel_:39:0:Unexpected end of file Mar 29 21:10:29 freestep volumio[3826]: ALSA lib conf.c:4096:(config_file_open) /etc/asound.conf may be old or corrupted: consider to remove or fix it Mar 29 21:10:29 freestep volumio[3826]: ALSA lib conf.c:4018:(snd_config_hooks_call) function snd_config_hook_load returned error: Invalid argument Mar 29 21:10:29 freestep volumio[3826]: ALSA lib conf.c:4625:(snd_config_update_r) hooks failed, removing configuration Mar 29 21:10:29 freestep volumio[3826]: aplay: device_list:283: control open (5): Invalid argument Mar 29 21:10:29 freestep volumio[3826]: warn: Unable to locate the audio output device Maverick Audio TE7022. Please configure a valid output device. Mar 29 21:10:29 freestep volumio[3826]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 29 21:10:29 freestep volumio[3826]: info: Loading plugin "wizard"... Mar 29 21:10:29 freestep volumio[3826]: info: Loading plugin "networkfs"... Mar 29 21:10:29 freestep volumio[3826]: info: Cannot mount NAS Musik_(multimedia) at system boot, trial number 1 ,retrying in 5 seconds Mar 29 21:10:29 freestep volumio[3826]: info: Cannot mount NAS Musik_(home) at system boot, trial number 1 ,retrying in 5 seconds Mar 29 21:10:29 freestep volumio[3826]: info: Starting Udev Watcher for removable devices Mar 29 21:10:29 freestep volumio[3826]: info: Ignoring mount for partition: boot Mar 29 21:10:29 freestep volumio[3826]: info: Ignoring mount for partition: volumio Mar 29 21:10:29 freestep volumio[3826]: info: Ignoring mount for partition: volumio_data Mar 29 21:10:29 freestep volumio[3826]: info: Ignoring mount for partition: A0BA-ADFA Mar 29 21:10:29 freestep volumio[3826]: info: Ignoring mount for partition: 9f2188d8-93eb-4c08-a565-e5c4fc0286ee Mar 29 21:10:29 freestep volumio[3826]: info: Ignoring mount for partition: 1ed01528-616d-4c79-b805-4ef31e39b46f Mar 29 21:10:29 freestep volumio[3826]: info: Ignoring mount for partition: 1dbb2722-4577-4c14-9fbc-b69430961db2 Mar 29 21:10:29 freestep volumio[3826]: info: Ignoring mount for partition: 63b25e45-bc42-4b85-93e0-2c5bf3072b2e Mar 29 21:10:29 freestep volumio[3826]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 29 21:10:29 freestep volumio[3826]: info: Loading plugin "volumio_command_line_client"... Mar 29 21:10:29 freestep volumio[3826]: info: Loading plugin "upnp"... Mar 29 21:10:29 freestep volumio[3826]: info: [1774811429647] Starting Upmpd Daemon Mar 29 21:10:29 freestep volumio[3826]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 29 21:10:29 freestep volumio[3826]: info: Loading plugin "my_music"... Mar 29 21:10:29 freestep volumio[3826]: info: Loading plugin "mpd"... Mar 29 21:10:29 freestep volumio[3826]: info: Loading plugin "upnp_browser"... Mar 29 21:10:30 freestep volumio[3826]: info: Starting UPNP Browser Mar 29 21:10:30 freestep volumio[3826]: info: Loading plugin "alarm-clock"... Mar 29 21:10:30 freestep volumio[3826]: info: Loading plugin "airplay_emulation"... Mar 29 21:10:30 freestep volumio[3826]: info: Starting Shairport Sync Mar 29 21:10:30 freestep volumio[3826]: info: Loading plugin "last_100"... Mar 29 21:10:30 freestep volumio[3826]: info: Loading plugin "webradio"... Mar 29 21:10:30 freestep volumio[3826]: info: Loading plugin "i2s_dacs"... Mar 29 21:10:30 freestep volumio[3826]: info: I2S DAC not set, start Auto-detection Mar 29 21:10:30 freestep volumio[3826]: info: Loading plugin "volumiodiscovery"... Mar 29 21:10:30 freestep volumio[3826]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 29 21:10:30 freestep volumio[3826]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 29 21:10:30 freestep volumio[3826]: *** WARNING *** For more information see Mar 29 21:10:30 freestep volumio[3826]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 29 21:10:30 freestep node[3826]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 29 21:10:30 freestep volumio[3826]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 29 21:10:30 freestep volumio[3826]: *** WARNING *** For more information see Mar 29 21:10:30 freestep node[3826]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 29 21:10:30 freestep node[3826]: *** WARNING *** For more information see Mar 29 21:10:30 freestep node[3826]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 29 21:10:30 freestep node[3826]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 29 21:10:30 freestep node[3826]: *** WARNING *** For more information see Mar 29 21:10:30 freestep volumio[3826]: info: Applying required configuration parameters for plugin volumiodiscovery Mar 29 21:10:30 freestep volumio[3826]: info: Discovery: Started advertising with name: freestep Mar 29 21:10:30 freestep volumio[3826]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 29 21:10:30 freestep volumio[3826]: info: Loading plugin "spop"... Mar 29 21:10:30 freestep volumio[3826]: info: Loading plugin "ytcr"... Mar 29 21:10:30 freestep volumio[3826]: info: Loading plugin "now_playing"... Mar 29 21:10:31 freestep volumio[3826]: info: Loading plugin "outputs"... Mar 29 21:10:31 freestep volumio[3826]: info: Loading plugin "albumart"... Mar 29 21:10:31 freestep volumio[3826]: info: Plugin example_plugin is not enabled Mar 29 21:10:31 freestep volumio[3826]: info: Loading plugin "inputs"... Mar 29 21:10:31 freestep volumio[3826]: info: Loading plugin "updater_comm"... Mar 29 21:10:31 freestep volumio[3826]: info: Plugin mpdemulation is not enabled Mar 29 21:10:31 freestep volumio[3826]: info: Loading plugin "rest_api"... Mar 29 21:10:31 freestep volumio[3826]: info: Loading plugin "websocket"... Mar 29 21:10:31 freestep volumio[3826]: info: Starting Socket.io Server version 1.7.4 Mar 29 21:10:31 freestep volumio[3826]: info: Loading plugin "backup_restore"... Mar 29 21:10:31 freestep volumio[3906]: Forking 3 albumart workers Mar 29 21:10:31 freestep volumio[3826]: info: Applying required configuration parameters for plugin backup_restore Mar 29 21:10:31 freestep volumio[3826]: info: Loading plugin "music_services_shield"... Mar 29 21:10:31 freestep volumio[3826]: info: Applying required configuration parameters for plugin music_services_shield Mar 29 21:10:31 freestep volumio[3826]: info: Loading plugin "Systeminfo"... Mar 29 21:10:31 freestep volumio[3916]: Starting albumart workers Mar 29 21:10:31 freestep volumio[3917]: Starting albumart workers Mar 29 21:10:31 freestep volumio[3918]: Starting albumart workers Mar 29 21:10:31 freestep volumio[3826]: info: Loading i18n strings for locale sv Mar 29 21:10:31 freestep volumio[3826]: Updating browse sources language Mar 29 21:10:31 freestep volumio[3826]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 29 21:10:31 freestep volumio[3826]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 29 21:10:31 freestep volumio[3826]: info: CoreCommandRouter::initPlayerControls Mar 29 21:10:31 freestep volumio[3826]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 29 21:10:31 freestep volumio[3826]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 29 21:10:31 freestep volumio[3826]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 29 21:10:31 freestep volumio[3826]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 29 21:10:31 freestep volumio[3826]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 29 21:10:31 freestep volumio[3826]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 29 21:10:31 freestep volumio[3826]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 29 21:10:31 freestep volumio[3826]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 29 21:10:31 freestep volumio[3826]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 29 21:10:31 freestep volumio[3826]: Express server listening on port 3000 Mar 29 21:10:31 freestep volumio[3826]: [Metrics] WebUI: 2s 890.36ms Mar 29 21:10:31 freestep volumio[3826]: info: Setting Device type: x86 Mar 29 21:10:31 freestep volumio[3826]: info: CoreStateMachine::resetVolumioState Mar 29 21:10:31 freestep volumio[3826]: info: CoreStateMachine::getcurrentVolume Mar 29 21:10:31 freestep volumio[3826]: info: CoreCommandRouter::volumioRetrievevolume Mar 29 21:10:31 freestep volumio[3826]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 29 21:10:31 freestep volumio[3826]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Mar 29 21:10:31 freestep volumio[3826]: info: Completed loading Core Plugins Mar 29 21:10:31 freestep volumio[3826]: info: Preparing to generate the ALSA configuration file Mar 29 21:10:31 freestep volumio[3826]: info: Volumio Network Manager: Network status updated: 1 Mar 29 21:10:31 freestep volumio[3826]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: ALSA lib conf.c:2007:(_snd_config_load_with_include) _toplevel_:39:0:Unexpected end of file Mar 29 21:10:31 freestep volumio[3826]: ALSA lib conf.c:4096:(config_file_open) /etc/asound.conf may be old or corrupted: consider to remove or fix it Mar 29 21:10:31 freestep volumio[3826]: ALSA lib conf.c:4018:(snd_config_hooks_call) function snd_config_hook_load returned error: Invalid argument Mar 29 21:10:31 freestep volumio[3826]: ALSA lib conf.c:4625:(snd_config_update_r) hooks failed, removing configuration Mar 29 21:10:31 freestep volumio[3826]: amixer: Mixer attach sysdefault:5 error: Invalid argument Mar 29 21:10:31 freestep volumio[3826]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Mar 29 21:10:32 freestep volumio[3826]: verbose: New Socket.io Connection to 192.168.0.112 from 192.168.0.109 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 OPR/114.0.0.0 Engine version: 3 Transport: polling Total Clients: 1 Mar 29 21:10:32 freestep volumio[3826]: info: VolumeController:: Volume=undefined Mute =false Mar 29 21:10:32 freestep volumio[3826]: info: CoreStateMachine::pushState Mar 29 21:10:32 freestep volumio[3826]: info: CorePlayQueue::getTrack 0 Mar 29 21:10:32 freestep volumio[3826]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 21:10:32 freestep volumio[3826]: info: CoreCommandRouter::volumioPushState Mar 29 21:10:32 freestep volumio[3826]: info: CoreStateMachine::updateTrackBlock Mar 29 21:10:32 freestep volumio[3826]: info: CorePlayQueue::getTrackBlock Mar 29 21:10:32 freestep volumio[3826]: info: CoreCommandRouter::volumioRetrievevolume Mar 29 21:10:32 freestep volumio[3826]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Mar 29 21:10:32 freestep volumio[3826]: info: Reloading queue from file Mar 29 21:10:32 freestep volumio[3826]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/143.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Mar 29 21:10:32 freestep volumio[3826]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: ALSA lib conf.c:2007:(_snd_config_load_with_include) _toplevel_:39:0:Unexpected end of file Mar 29 21:10:32 freestep volumio[3826]: ALSA lib conf.c:4096:(config_file_open) /etc/asound.conf may be old or corrupted: consider to remove or fix it Mar 29 21:10:32 freestep volumio[3826]: ALSA lib conf.c:4018:(snd_config_hooks_call) function snd_config_hook_load returned error: Invalid argument Mar 29 21:10:32 freestep volumio[3826]: ALSA lib conf.c:4625:(snd_config_update_r) hooks failed, removing configuration Mar 29 21:10:32 freestep volumio[3826]: amixer: Mixer attach sysdefault:5 error: Invalid argument Mar 29 21:10:32 freestep volumio[3826]: info: CoreStateMachine::setRepeat null single undefined Mar 29 21:10:32 freestep volumio[3826]: info: CoreStateMachine::pushState Mar 29 21:10:32 freestep volumio[3826]: info: CorePlayQueue::getTrack 0 Mar 29 21:10:32 freestep volumio[3826]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 29 21:10:32 freestep volumio[3826]: info: CoreCommandRouter::volumioPushState Mar 29 21:10:32 freestep volumio[3826]: info: CoreStateMachine::setRandom null Mar 29 21:10:32 freestep volumio[3826]: info: CoreStateMachine::pushState Mar 29 21:10:32 freestep volumio[3826]: info: CorePlayQueue::getTrack 0 Mar 29 21:10:32 freestep volumio[3826]: info: CoreCommandRouter::volumioPushState Mar 29 21:10:32 freestep volumio[3826]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Mar 29 21:10:32 freestep volumio[3826]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Mar 29 21:10:32 freestep volumio[3826]: info: VolumeController:: Volume=undefined Mute =false Mar 29 21:10:32 freestep volumio[3826]: info: CoreStateMachine::pushState Mar 29 21:10:32 freestep volumio[3826]: info: CorePlayQueue::getTrack 0 Mar 29 21:10:32 freestep volumio[3826]: info: CoreCommandRouter::volumioPushState Mar 29 21:10:32 freestep volumio[3826]: info: Asound.conf file written Mar 29 21:10:32 freestep sudo[3980]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Mar 29 21:10:32 freestep sudo[3980]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 29 21:10:32 freestep sudo[3980]: pam_unix(sudo:session): session closed for user root Mar 29 21:10:32 freestep volumio[3826]: /bin/mv: cannot move '/home/volumio/.asoundrc' to '/etc/asound.conf': Operation not permitted Mar 29 21:10:32 freestep volumio[3826]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 29 21:10:32 freestep volumio[3826]: Error: Command failed: /usr/bin/sudo /bin/mv /home/volumio/.asoundrc /etc/asound.conf Mar 29 21:10:32 freestep volumio[3826]: /bin/mv: cannot move '/home/volumio/.asoundrc' to '/etc/asound.conf': Operation not permitted Mar 29 21:10:32 freestep volumio[3826]: at checkExecSyncError (node:child_process:887:11) Mar 29 21:10:32 freestep volumio[3826]: at execSync (node:child_process:959:15) Mar 29 21:10:32 freestep volumio[3826]: at /volumio/app/plugins/audio_interface/alsa_controller/index.js:2223:13 Mar 29 21:10:32 freestep volumio[3826]: at /volumio/node_modules/graceful-fs/graceful-fs.js:143:16 Mar 29 21:10:32 freestep volumio[3826]: at /volumio/node_modules/graceful-fs/graceful-fs.js:61:14 Mar 29 21:10:32 freestep volumio[3826]: at FSReqCallback.oncomplete (node:fs:190:23) { Mar 29 21:10:32 freestep volumio[3826]: status: 1, Mar 29 21:10:32 freestep volumio[3826]: signal: null, Mar 29 21:10:32 freestep volumio[3826]: output: [ Mar 29 21:10:32 freestep volumio[3826]: null, Mar 29 21:10:32 freestep volumio[3826]: '', Mar 29 21:10:32 freestep volumio[3826]: "/bin/mv: cannot move '/home/volumio/.asoundrc' to '/etc/asound.conf': Operation not permitted\n" Mar 29 21:10:32 freestep volumio[3826]: ], Mar 29 21:10:32 freestep volumio[3826]: pid: 3979, Mar 29 21:10:32 freestep volumio[3826]: stdout: '', Mar 29 21:10:32 freestep volumio[3826]: stderr: "/bin/mv: cannot move '/home/volumio/.asoundrc' to '/etc/asound.conf': Operation not permitted\n" Mar 29 21:10:32 freestep volumio[3826]: } Mar 29 21:10:32 freestep volumio[3826]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 29 21:10:32 freestep sudo[3996]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-03-29 21:09' Mar 29 21:10:32 freestep sudo[3996]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="dc61260dec5515dafd2b634881860b4c46c919ff" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Mar 6 17:11:42 UTC 2026" VOLUMIO_VERSION="4.103" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="21a5161aef4cb85a1f93b140ccadc4f1"