-- Logs begin at Thu 2019-02-14 04:11:59 CST, end at Fri 2025-12-19 04:41:46 CST. -- Dec 19 04:40:00 volumiow sudo[6785]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-19 04:38 Dec 19 04:40:00 volumiow sudo[6785]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:40:00 volumiow sudo[6785]: pam_unix(sudo:session): session closed for user root Dec 19 04:40:00 volumiow mpd[6735]: Dec 19 04:40 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 19 04:40:00 volumiow systemd[1]: Started Music Player Daemon. Dec 19 04:40:00 volumiow sudo[6717]: pam_unix(sudo:session): session closed for user root Dec 19 04:40:00 volumiow sudo[6708]: pam_unix(sudo:session): session closed for user root Dec 19 04:40:00 volumiow volumio-remote-updater[518]: [2025-12-19 04:40:00] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Dec 19 04:40:00 volumiow volumio-remote-updater[518]: [2025-12-19 04:40:00] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Dec 19 04:40:00 volumiow systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Dec 19 04:40:00 volumiow systemd[1]: volumio.service: Failed with result 'exit-code'. Dec 19 04:40:00 volumiow systemd[1]: Started dynamicswap service. Dec 19 04:40:00 volumiow systemd[1]: dynamicswap.service: Succeeded. Dec 19 04:40:00 volumiow systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Dec 19 04:40:00 volumiow systemd[1]: volumio.service: Scheduled restart job, restart counter is at 27. Dec 19 04:40:00 volumiow systemd[1]: Stopped Volumio Backend Module. Dec 19 04:40:00 volumiow systemd[1]: Started Volumio Backend Module. Dec 19 04:40:00 volumiow systemd[1]: Started dynamicswap service. Dec 19 04:40:00 volumiow systemd[1]: dynamicswap.service: Succeeded. Dec 19 04:40:00 volumiow ntpd[631]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Dec 19 04:40:00 volumiow ntpd[631]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Dec 19 04:40:01 volumiow ntpd[631]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Dec 19 04:40:02 volumiow wpa_supplicant[739]: wlan0: Failed to initiate sched scan Dec 19 04:40:02 volumiow volumio[6800]: info: ------------------------------------------- Dec 19 04:40:02 volumiow volumio[6800]: info: ----- Volumio3 ---- Dec 19 04:40:02 volumiow volumio[6800]: info: ------------------------------------------- Dec 19 04:40:02 volumiow volumio[6800]: info: ----- System startup ---- Dec 19 04:40:02 volumiow volumio[6800]: info: ------------------------------------------- Dec 19 04:40:03 volumiow volumio-time-update[492]: volumio-time-update-util: Fetching time from Volumio... Dec 19 04:40:03 volumiow volumio-time-update[492]: volumio-time-update-util: Date not found in response Dec 19 04:40:03 volumiow volumio-time-update[492]: volumio-time-update-util: Retrying in 5 seconds... Dec 19 04:40:03 volumiow volumio[6800]: info: MYVOLUMIO Environment detected Dec 19 04:40:03 volumiow volumio[6800]: info: Plugin folders cleanup Dec 19 04:40:03 volumiow volumio[6800]: info: Scanning into folder /volumio/app/plugins/ Dec 19 04:40:03 volumiow volumio[6800]: info: Scanning category audio_interface Dec 19 04:40:03 volumiow volumio[6800]: info: Scanning category miscellanea Dec 19 04:40:03 volumiow volumio[6800]: info: Scanning category music_service Dec 19 04:40:03 volumiow volumio[6800]: info: Scanning category plugins.json Dec 19 04:40:03 volumiow volumio[6800]: info: Scanning category system_controller Dec 19 04:40:03 volumiow volumio[6800]: info: Scanning category user_interface Dec 19 04:40:03 volumiow volumio[6800]: info: Scanning into folder /data/plugins/ Dec 19 04:40:03 volumiow volumio[6800]: info: Scanning category music_service Dec 19 04:40:03 volumiow volumio[6800]: info: Plugin folders cleanup completed Dec 19 04:40:03 volumiow volumio[6800]: info: ------------------------------------------- Dec 19 04:40:03 volumiow volumio[6800]: info: ----- Core plugins startup ---- Dec 19 04:40:03 volumiow volumio[6800]: info: ------------------------------------------- Dec 19 04:40:03 volumiow volumio[6800]: info: Loading plugins from folder /volumio/app/plugins/ Dec 19 04:40:03 volumiow volumio[6800]: info: Adding plugin upnp to MyMusic Plugins Dec 19 04:40:03 volumiow volumio[6800]: info: Adding plugin airplay_emulation to MyMusic Plugins Dec 19 04:40:03 volumiow volumio[6800]: info: Adding plugin upnp_browser to MyMusic Plugins Dec 19 04:40:03 volumiow volumio[6800]: info: Loading plugins from folder /data/plugins/ Dec 19 04:40:03 volumiow volumio[6800]: info: Loading plugin "system"... Dec 19 04:40:03 volumiow volumio[6800]: info: Loading plugin "appearance"... Dec 19 04:40:04 volumiow volumio[6800]: info: Loading plugin "network"... Dec 19 04:40:04 volumiow volumio[6800]: info: Refreshing Cached IP Addresses Dec 19 04:40:04 volumiow sudo[6832]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 19 04:40:04 volumiow sudo[6832]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:40:05 volumiow sudo[6834]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 19 04:40:05 volumiow sudo[6834]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:40:05 volumiow sudo[6834]: pam_unix(sudo:session): session closed for user root Dec 19 04:40:05 volumiow sudo[6832]: pam_unix(sudo:session): session closed for user root Dec 19 04:40:05 volumiow volumio[6800]: info: Loading plugin "services"... Dec 19 04:40:05 volumiow volumio[6800]: info: Loading plugin "alsa_controller"... Dec 19 04:40:05 volumiow sudo[6849]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Dec 19 04:40:05 volumiow sudo[6849]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:40:05 volumiow volumio[6800]: warn: Unable to locate the audio output device E30. Please configure a valid output device. Dec 19 04:40:05 volumiow volumio[6800]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 19 04:40:05 volumiow volumio[6800]: info: Loading plugin "wizard"... Dec 19 04:40:05 volumiow volumio[6800]: info: Loading plugin "networkfs"... Dec 19 04:40:05 volumiow sudo[6860]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=nouser,password=nouser,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=3.11 //172.16.1.11/Audio\\High Resolution\\DSF /mnt/NAS/DSF Dec 19 04:40:05 volumiow sudo[6860]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:40:05 volumiow volumio[6800]: info: Starting Udev Watcher for removable devices Dec 19 04:40:05 volumiow sudo[6862]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=nouser,password=nouser,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=3.11 //172.16.1.11/Audio\\High Resolution\\SACD /mnt/NAS/SACD Dec 19 04:40:05 volumiow sudo[6862]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:40:05 volumiow kernel: CIFS: Attempting to mount //172.16.1.11/Audio/High Resolution/DSF Dec 19 04:40:05 volumiow kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Dec 19 04:40:05 volumiow kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Dec 19 04:40:05 volumiow sudo[6860]: pam_unix(sudo:session): session closed for user root Dec 19 04:40:05 volumiow sudo[6862]: pam_unix(sudo:session): session closed for user root Dec 19 04:40:05 volumiow kernel: CIFS: Attempting to mount //172.16.1.11/Audio/High Resolution/SACD Dec 19 04:40:05 volumiow kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Dec 19 04:40:05 volumiow kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Dec 19 04:40:05 volumiow sudo[6865]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=nouser,password=nouser,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=3.11 //172.16.1.11/Audio\\High Resolution\\24 Bit\\%24bit-88Khz (plus) /mnt/NAS/24bit_88khz_+ Dec 19 04:40:05 volumiow sudo[6865]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:40:05 volumiow volumio[6800]: info: Ignoring mount for partition: boot Dec 19 04:40:05 volumiow volumio[6800]: info: Ignoring mount for partition: volumio Dec 19 04:40:05 volumiow volumio[6800]: info: Ignoring mount for partition: volumio_data Dec 19 04:40:05 volumiow volumio[6800]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 19 04:40:05 volumiow kernel: CIFS: Attempting to mount //172.16.1.11/Audio/High Resolution/24 Bit/%24bit-88Khz (plus) Dec 19 04:40:05 volumiow kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Dec 19 04:40:05 volumiow kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Dec 19 04:40:05 volumiow volumio[6800]: info: Loading plugin "volumio_command_line_client"... Dec 19 04:40:05 volumiow sudo[6865]: pam_unix(sudo:session): session closed for user root Dec 19 04:40:05 volumiow volumio[6800]: info: Plugin upnp is not enabled Dec 19 04:40:05 volumiow volumio[6800]: info: Loading plugin "my_music"... Dec 19 04:40:05 volumiow volumio[6800]: info: Loading plugin "mpd"... Dec 19 04:40:05 volumiow volumio-remote-updater[518]: [2025-12-19 04:40:05] [connect] Successful connection Dec 19 04:40:05 volumiow volumio[6800]: info: Plugin upnp_browser is not enabled Dec 19 04:40:05 volumiow volumio[6800]: info: Loading plugin "alarm-clock"... Dec 19 04:40:05 volumiow sudo[6849]: pam_unix(sudo:session): session closed for user root Dec 19 04:40:05 volumiow volumio[6800]: info: Loading plugin "airplay_emulation"... Dec 19 04:40:05 volumiow volumio[6800]: info: Starting Shairport Sync Dec 19 04:40:05 volumiow volumio[6800]: info: Loading plugin "last_100"... Dec 19 04:40:05 volumiow volumio[6800]: info: Loading plugin "webradio"... Dec 19 04:40:06 volumiow volumio[6800]: info: Loading plugin "i2s_dacs"... Dec 19 04:40:06 volumiow volumio[6800]: info: I2S DAC not set, start Auto-detection Dec 19 04:40:06 volumiow volumio[6800]: info: Loading plugin "volumiodiscovery"... Dec 19 04:40:06 volumiow volumio[6800]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 19 04:40:06 volumiow volumio[6800]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 19 04:40:06 volumiow volumio[6800]: *** WARNING *** For more information see Dec 19 04:40:06 volumiow node[6800]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 19 04:40:06 volumiow volumio[6800]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 19 04:40:06 volumiow volumio[6800]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 19 04:40:06 volumiow volumio[6800]: *** WARNING *** For more information see Dec 19 04:40:06 volumiow node[6800]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 19 04:40:06 volumiow node[6800]: *** WARNING *** For more information see Dec 19 04:40:06 volumiow node[6800]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 19 04:40:06 volumiow node[6800]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 19 04:40:06 volumiow node[6800]: *** WARNING *** For more information see Dec 19 04:40:06 volumiow volumio[6800]: info: Applying required configuration parameters for plugin volumiodiscovery Dec 19 04:40:06 volumiow volumio[6800]: info: Discovery: Started advertising with name: VolumioW Dec 19 04:40:06 volumiow volumio[6800]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 19 04:40:06 volumiow volumio[6800]: info: Loading plugin "squeezelite_mc"... Dec 19 04:40:07 volumiow volumio[6800]: info: Loading plugin "outputs"... Dec 19 04:40:07 volumiow volumio[6800]: info: Loading plugin "albumart"... Dec 19 04:40:07 volumiow volumio[6800]: info: Plugin example_plugin is not enabled Dec 19 04:40:07 volumiow volumio[6800]: info: Loading plugin "inputs"... Dec 19 04:40:07 volumiow volumio[6800]: info: Loading plugin "updater_comm"... Dec 19 04:40:07 volumiow volumio[6800]: info: Plugin mpdemulation is not enabled Dec 19 04:40:07 volumiow volumio[6800]: info: Loading plugin "rest_api"... Dec 19 04:40:07 volumiow volumio[6800]: info: Loading plugin "websocket"... Dec 19 04:40:07 volumiow volumio[6800]: info: Starting Socket.io Server version 2.3.0 Dec 19 04:40:07 volumiow volumio[6800]: info: Loading plugin "radio_paradise"... Dec 19 04:40:07 volumiow volumio[6800]: Forking 3 albumart workers Dec 19 04:40:07 volumiow volumio[6800]: info: Applying required configuration parameters for plugin radio_paradise Dec 19 04:40:07 volumiow volumio[6800]: info: [1766140807781] [RadioParadise] API delay: 5 Dec 19 04:40:07 volumiow volumio[6800]: info: Loading i18n strings for locale en Dec 19 04:40:07 volumiow volumio[6800]: Updating browse sources language Dec 19 04:40:07 volumiow volumio[6800]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 19 04:40:08 volumiow volumio[6800]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 19 04:40:08 volumiow volumio[6800]: info: CoreCommandRouter::initPlayerControls Dec 19 04:40:08 volumiow volumio[6800]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:08 volumiow volumio[6800]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:08 volumiow volumio[6800]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:08 volumiow volumio[6800]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:08 volumiow volumio[6800]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:08 volumiow volumio[6800]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:08 volumiow volumio[6800]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:08 volumiow volumio[6800]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:08 volumiow volumio[6800]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 19 04:40:08 volumiow volumio[6800]: Express server listening on port 3000 Dec 19 04:40:08 volumiow volumio[6800]: [Metrics] WebUI: 6s 29.93ms Dec 19 04:40:08 volumiow volumio[6800]: info: CoreStateMachine::resetVolumioState Dec 19 04:40:08 volumiow volumio[6800]: info: CoreStateMachine::getcurrentVolume Dec 19 04:40:08 volumiow volumio[6800]: info: CoreCommandRouter::volumioRetrievevolume Dec 19 04:40:08 volumiow volumio[6800]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 04:40:08 volumiow volumio[6800]: info: Volumio Network Manager: Network status updated: 0 Dec 19 04:40:08 volumiow volumio[6800]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Dec 19 04:40:08 volumiow wpa_supplicant[739]: wlan0: Failed to initiate sched scan Dec 19 04:40:08 volumiow volumio[6800]: info: Cannot mount NAS 24bit_88khz_+ at system boot, trial number 1 ,retrying in 5 seconds Dec 19 04:40:08 volumiow volumio[6800]: info: Cannot mount NAS SACD at system boot, trial number 1 ,retrying in 5 seconds Dec 19 04:40:08 volumiow volumio[6800]: info: Cannot mount NAS DSF at system boot, trial number 1 ,retrying in 5 seconds Dec 19 04:40:08 volumiow volumio-remote-updater[518]: [2025-12-19 04:40:08] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1766140805 101 Dec 19 04:40:08 volumiow volumio[6800]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 1 Dec 19 04:40:08 volumiow volumio[6800]: info: VolumeController:: Volume=undefined Mute =false Dec 19 04:40:08 volumiow volumio[6800]: info: CoreStateMachine::pushState Dec 19 04:40:08 volumiow volumio[6800]: info: CorePlayQueue::getTrack 0 Dec 19 04:40:08 volumiow volumio[6800]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 19 04:40:08 volumiow volumio[6800]: info: CoreCommandRouter::volumioPushState Dec 19 04:40:08 volumiow volumio[6800]: info: CoreStateMachine::updateTrackBlock Dec 19 04:40:08 volumiow volumio[6800]: info: CorePlayQueue::getTrackBlock Dec 19 04:40:08 volumiow volumio[6800]: info: CoreCommandRouter::volumioRetrievevolume Dec 19 04:40:08 volumiow volumio[6800]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Dec 19 04:40:08 volumiow volumio-time-update[492]: volumio-time-update-util: Fetching time from Volumio... Dec 19 04:40:08 volumiow volumio[6800]: info: Reloading queue from file Dec 19 04:40:08 volumiow volumio[6800]: info: VolumeController:: Volume=undefined Mute =false Dec 19 04:40:08 volumiow volumio[6800]: info: CoreStateMachine::pushState Dec 19 04:40:08 volumiow volumio[6800]: info: CorePlayQueue::getTrack 0 Dec 19 04:40:08 volumiow volumio[6800]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 19 04:40:08 volumiow volumio[6800]: info: CoreCommandRouter::volumioPushState Dec 19 04:40:08 volumiow volumio[6800]: info: CoreStateMachine::setRepeat null single undefined Dec 19 04:40:08 volumiow volumio[6800]: info: CoreStateMachine::pushState Dec 19 04:40:08 volumiow volumio[6800]: info: CorePlayQueue::getTrack 0 Dec 19 04:40:08 volumiow volumio[6800]: info: CoreCommandRouter::volumioPushState Dec 19 04:40:08 volumiow volumio[6800]: info: CoreStateMachine::setRandom null Dec 19 04:40:08 volumiow volumio[6800]: info: CoreStateMachine::pushState Dec 19 04:40:08 volumiow volumio[6800]: info: CorePlayQueue::getTrack 0 Dec 19 04:40:08 volumiow volumio[6800]: info: CoreCommandRouter::volumioPushState Dec 19 04:40:08 volumiow volumio[6800]: info: Setting Device type: Raspberry PI Dec 19 04:40:08 volumiow volumio[6800]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Dec 19 04:40:08 volumiow volumio[6800]: info: USB Boot Capable - System SBC Revision found in cpuinfo: 902120 Dec 19 04:40:08 volumiow volumio[6800]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Dec 19 04:40:08 volumiow volumio-time-update[492]: volumio-time-update-util: Date not found in response Dec 19 04:40:08 volumiow volumio-time-update[492]: volumio-time-update-util: Retrying in 5 seconds... Dec 19 04:40:08 volumiow volumio[6800]: info: Completed loading Core Plugins Dec 19 04:40:08 volumiow volumio[6800]: info: Preparing to generate the ALSA configuration file Dec 19 04:40:08 volumiow volumio[6800]: info: Asound.conf file unchanged, so no further update is needed Dec 19 04:40:08 volumiow volumio[6800]: info: Output device has changed, restarting MPD Dec 19 04:40:08 volumiow volumio[6800]: info: Output device has changed, restarting Shairport Sync Dec 19 04:40:08 volumiow volumio[6800]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:08 volumiow volumio[6800]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 04:40:08 volumiow sudo[6921]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 19 04:40:08 volumiow sudo[6921]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:40:08 volumiow sudo[6921]: pam_unix(sudo:session): session closed for user root Dec 19 04:40:08 volumiow sudo[6924]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 19 04:40:08 volumiow sudo[6924]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:40:08 volumiow systemd[1]: Stopping Music Player Daemon... Dec 19 04:40:08 volumiow volumio[6800]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 19 04:40:08 volumiow volumio[6800]: info: ___________ START PLUGINS ___________ Dec 19 04:40:08 volumiow volumio[6800]: info: ControllerMpd::onStart: Initializing MPD Dec 19 04:40:08 volumiow volumio[6800]: info: Creating MPD Configuration file Dec 19 04:40:08 volumiow systemd[1]: mpd.service: Succeeded. Dec 19 04:40:08 volumiow systemd[1]: Stopped Music Player Daemon. Dec 19 04:40:09 volumiow volumio[6800]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:09 volumiow volumio[6800]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 04:40:09 volumiow sudo[6930]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 19 04:40:09 volumiow sudo[6930]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:40:09 volumiow sudo[6930]: pam_unix(sudo:session): session closed for user root Dec 19 04:40:09 volumiow sudo[6933]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 19 04:40:09 volumiow systemd[1]: Starting Music Player Daemon... Dec 19 04:40:09 volumiow sudo[6933]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:40:09 volumiow systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Dec 19 04:40:09 volumiow systemd[1]: mpd.service: Succeeded. Dec 19 04:40:09 volumiow systemd[1]: Stopped Music Player Daemon. Dec 19 04:40:09 volumiow volumio[6800]: Starting albumart workers Dec 19 04:40:09 volumiow systemd[1]: Starting Music Player Daemon... Dec 19 04:40:09 volumiow volumio[6800]: Starting albumart workers Dec 19 04:40:09 volumiow volumio[6800]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 19 04:40:09 volumiow volumio[6800]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:09 volumiow volumio[6800]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 04:40:09 volumiow volumio[6800]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 19 04:40:09 volumiow volumio[6800]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 19 04:40:09 volumiow volumio[6800]: info: [1766140809217] CoreMusicLibrary::Adding element Last_100 Dec 19 04:40:09 volumiow volumio[6800]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 19 04:40:09 volumiow volumio[6800]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 19 04:40:09 volumiow volumio[6800]: info: [1766140809225] CoreMusicLibrary::Adding element Webradio Dec 19 04:40:09 volumiow volumio[6800]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 19 04:40:09 volumiow volumio[6800]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 19 04:40:09 volumiow sudo[6940]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 19 04:40:09 volumiow sudo[6940]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:40:09 volumiow volumio[6800]: info: Initializing BBC Radios Dec 19 04:40:09 volumiow sudo[6940]: pam_unix(sudo:session): session closed for user root Dec 19 04:40:09 volumiow volumio[6800]: Starting albumart workers Dec 19 04:40:09 volumiow volumio[6800]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory Dec 19 04:40:09 volumiow volumio[6800]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 04:40:09 volumiow volumio[6800]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 19 04:40:09 volumiow volumio[6800]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 04:40:09 volumiow volumio[6800]: info: [squeezelite_mc] Starting proxy server... Dec 19 04:40:09 volumiow volumio[6800]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 19 04:40:09 volumiow volumio[6800]: info: [1766140809456] CoreMusicLibrary::Adding element Radio Paradise Dec 19 04:40:09 volumiow volumio[6800]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 19 04:40:09 volumiow volumio[6800]: Cannot find translation for source Radio Paradise Dec 19 04:40:09 volumiow volumio[6800]: info: Volumio Calling Home Dec 19 04:40:09 volumiow volumio[6800]: info: [squeezelite_mc] Proxy server started on port 38953 Dec 19 04:40:09 volumiow volumio[6800]: info: CoreCommandRouter::volumioRetrievevolume Dec 19 04:40:10 volumiow volumio[6800]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Dec 19 04:40:10 volumiow volumio[6800]: info: MPD Permissions set Dec 19 04:40:10 volumiow volumio[6800]: info: MPD Permissions set Dec 19 04:40:10 volumiow volumio[6800]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Dec 19 04:40:10 volumiow volumio[6800]: info: VolumeController:: Volume=undefined Mute =false Dec 19 04:40:10 volumiow volumio[6800]: info: CoreStateMachine::pushState Dec 19 04:40:10 volumiow volumio[6800]: info: CorePlayQueue::getTrack 0 Dec 19 04:40:10 volumiow volumio[6800]: info: CoreCommandRouter::volumioPushState Dec 19 04:40:10 volumiow volumio[6800]: info: [squeezelite_mc] Server discovery started Dec 19 04:40:10 volumiow volumio[6800]: info: [squeezelite_mc] Player finder started Dec 19 04:40:10 volumiow volumio[6800]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:10 volumiow volumio[6800]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:10 volumiow volumio[6800]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:10 volumiow volumio[6800]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 19 04:40:10 volumiow volumio[6800]: info: [squeezelite_mc] Executing aplay -D hw:5 --nonblock -f MPEG /dev/zero 2>&1 || true Dec 19 04:40:10 volumiow volumio[6800]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 19 04:40:10 volumiow volumio[6800]: Error: send ENETUNREACH 255.255.255.255:3483 Dec 19 04:40:10 volumiow volumio[6800]: at doSend (dgram.js:692:16) Dec 19 04:40:10 volumiow volumio[6800]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:430:12) Dec 19 04:40:10 volumiow volumio[6800]: at afterDns (dgram.js:638:5) Dec 19 04:40:10 volumiow volumio[6800]: at processTicksAndRejections (internal/process/task_queues.js:81:21) { Dec 19 04:40:10 volumiow volumio[6800]: errno: -101, Dec 19 04:40:10 volumiow volumio[6800]: code: 'ENETUNREACH', Dec 19 04:40:10 volumiow volumio[6800]: syscall: 'send', Dec 19 04:40:10 volumiow volumio[6800]: address: '255.255.255.255', Dec 19 04:40:10 volumiow volumio[6800]: port: 3483 Dec 19 04:40:10 volumiow volumio[6800]: } Dec 19 04:40:10 volumiow volumio[6800]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 19 04:40:11 volumiow sudo[6996]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-19 04:39 Dec 19 04:40:11 volumiow sudo[6996]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:40:11 volumiow sudo[6996]: pam_unix(sudo:session): session closed for user root Dec 19 04:40:11 volumiow mpd[6945]: Dec 19 04:40 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 19 04:40:11 volumiow volumio-remote-updater[518]: [2025-12-19 04:40:11] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Dec 19 04:40:11 volumiow volumio-remote-updater[518]: [2025-12-19 04:40:11] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Dec 19 04:40:11 volumiow systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Dec 19 04:40:11 volumiow sudo[6933]: pam_unix(sudo:session): session closed for user root Dec 19 04:40:11 volumiow sudo[6924]: pam_unix(sudo:session): session closed for user root Dec 19 04:40:11 volumiow systemd[1]: Started Music Player Daemon. Dec 19 04:40:11 volumiow systemd[1]: volumio.service: Failed with result 'exit-code'. Dec 19 04:40:11 volumiow systemd[1]: Started dynamicswap service. Dec 19 04:40:11 volumiow systemd[1]: dynamicswap.service: Succeeded. Dec 19 04:40:11 volumiow systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Dec 19 04:40:11 volumiow systemd[1]: volumio.service: Scheduled restart job, restart counter is at 28. Dec 19 04:40:11 volumiow systemd[1]: Started dynamicswap service. Dec 19 04:40:11 volumiow systemd[1]: Stopped Volumio Backend Module. Dec 19 04:40:11 volumiow systemd[1]: Started Volumio Backend Module. Dec 19 04:40:11 volumiow systemd[1]: dynamicswap.service: Succeeded. Dec 19 04:40:13 volumiow volumio-time-update[492]: volumio-time-update-util: Fetching time from Volumio... Dec 19 04:40:13 volumiow volumio-time-update[492]: volumio-time-update-util: Date not found in response Dec 19 04:40:13 volumiow volumio-time-update[492]: volumio-time-update-util: Retrying in 5 seconds... Dec 19 04:40:13 volumiow volumio[7012]: info: ------------------------------------------- Dec 19 04:40:13 volumiow volumio[7012]: info: ----- Volumio3 ---- Dec 19 04:40:13 volumiow volumio[7012]: info: ------------------------------------------- Dec 19 04:40:13 volumiow volumio[7012]: info: ----- System startup ---- Dec 19 04:40:13 volumiow volumio[7012]: info: ------------------------------------------- Dec 19 04:40:13 volumiow wpa_supplicant[739]: wlan0: Failed to initiate sched scan Dec 19 04:40:14 volumiow volumio[7012]: info: MYVOLUMIO Environment detected Dec 19 04:40:14 volumiow volumio[7012]: info: Plugin folders cleanup Dec 19 04:40:14 volumiow volumio[7012]: info: Scanning into folder /volumio/app/plugins/ Dec 19 04:40:14 volumiow volumio[7012]: info: Scanning category audio_interface Dec 19 04:40:14 volumiow volumio[7012]: info: Scanning category miscellanea Dec 19 04:40:14 volumiow volumio[7012]: info: Scanning category music_service Dec 19 04:40:14 volumiow volumio[7012]: info: Scanning category plugins.json Dec 19 04:40:14 volumiow volumio[7012]: info: Scanning category system_controller Dec 19 04:40:14 volumiow volumio[7012]: info: Scanning category user_interface Dec 19 04:40:14 volumiow volumio[7012]: info: Scanning into folder /data/plugins/ Dec 19 04:40:14 volumiow volumio[7012]: info: Scanning category music_service Dec 19 04:40:14 volumiow volumio[7012]: info: Plugin folders cleanup completed Dec 19 04:40:14 volumiow volumio[7012]: info: ------------------------------------------- Dec 19 04:40:14 volumiow volumio[7012]: info: ----- Core plugins startup ---- Dec 19 04:40:14 volumiow volumio[7012]: info: ------------------------------------------- Dec 19 04:40:14 volumiow volumio[7012]: info: Loading plugins from folder /volumio/app/plugins/ Dec 19 04:40:14 volumiow volumio[7012]: info: Adding plugin upnp to MyMusic Plugins Dec 19 04:40:14 volumiow volumio[7012]: info: Adding plugin airplay_emulation to MyMusic Plugins Dec 19 04:40:14 volumiow volumio[7012]: info: Adding plugin upnp_browser to MyMusic Plugins Dec 19 04:40:14 volumiow volumio[7012]: info: Loading plugins from folder /data/plugins/ Dec 19 04:40:14 volumiow volumio[7012]: info: Loading plugin "system"... Dec 19 04:40:14 volumiow volumio[7012]: info: Loading plugin "appearance"... Dec 19 04:40:15 volumiow volumio[7012]: info: Loading plugin "network"... Dec 19 04:40:15 volumiow volumio[7012]: info: Refreshing Cached IP Addresses Dec 19 04:40:16 volumiow sudo[7043]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 19 04:40:16 volumiow sudo[7043]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:40:16 volumiow sudo[7045]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 19 04:40:16 volumiow sudo[7045]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:40:16 volumiow sudo[7045]: pam_unix(sudo:session): session closed for user root Dec 19 04:40:16 volumiow sudo[7043]: pam_unix(sudo:session): session closed for user root Dec 19 04:40:16 volumiow volumio[7012]: info: Loading plugin "services"... Dec 19 04:40:16 volumiow volumio[7012]: info: Loading plugin "alsa_controller"... Dec 19 04:40:16 volumiow sudo[7056]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Dec 19 04:40:16 volumiow sudo[7056]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:40:16 volumiow volumio[7012]: warn: Unable to locate the audio output device E30. Please configure a valid output device. Dec 19 04:40:16 volumiow volumio[7012]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 19 04:40:16 volumiow volumio[7012]: info: Loading plugin "wizard"... Dec 19 04:40:16 volumiow volumio[7012]: info: Loading plugin "networkfs"... Dec 19 04:40:16 volumiow sudo[7071]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=nouser,password=nouser,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=3.11 //172.16.1.11/Audio\\High Resolution\\DSF /mnt/NAS/DSF Dec 19 04:40:16 volumiow sudo[7071]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:40:16 volumiow volumio[7012]: info: Starting Udev Watcher for removable devices Dec 19 04:40:16 volumiow sudo[7073]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=nouser,password=nouser,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=3.11 //172.16.1.11/Audio\\High Resolution\\SACD /mnt/NAS/SACD Dec 19 04:40:16 volumiow sudo[7073]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:40:16 volumiow sudo[7071]: pam_unix(sudo:session): session closed for user root Dec 19 04:40:16 volumiow kernel: CIFS: Attempting to mount //172.16.1.11/Audio/High Resolution/DSF Dec 19 04:40:16 volumiow kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Dec 19 04:40:16 volumiow kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Dec 19 04:40:16 volumiow sudo[7073]: pam_unix(sudo:session): session closed for user root Dec 19 04:40:16 volumiow sudo[7076]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=nouser,password=nouser,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=3.11 //172.16.1.11/Audio\\High Resolution\\24 Bit\\%24bit-88Khz (plus) /mnt/NAS/24bit_88khz_+ Dec 19 04:40:16 volumiow kernel: CIFS: Attempting to mount //172.16.1.11/Audio/High Resolution/SACD Dec 19 04:40:16 volumiow kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Dec 19 04:40:16 volumiow kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Dec 19 04:40:16 volumiow sudo[7076]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:40:16 volumiow volumio[7012]: info: Ignoring mount for partition: boot Dec 19 04:40:16 volumiow volumio[7012]: info: Ignoring mount for partition: volumio Dec 19 04:40:16 volumiow volumio[7012]: info: Ignoring mount for partition: volumio_data Dec 19 04:40:16 volumiow volumio[7012]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 19 04:40:16 volumiow volumio[7012]: info: Loading plugin "volumio_command_line_client"... Dec 19 04:40:16 volumiow sudo[7076]: pam_unix(sudo:session): session closed for user root Dec 19 04:40:16 volumiow kernel: CIFS: Attempting to mount //172.16.1.11/Audio/High Resolution/24 Bit/%24bit-88Khz (plus) Dec 19 04:40:16 volumiow kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Dec 19 04:40:16 volumiow kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Dec 19 04:40:16 volumiow volumio[7012]: info: Plugin upnp is not enabled Dec 19 04:40:16 volumiow volumio[7012]: info: Loading plugin "my_music"... Dec 19 04:40:16 volumiow volumio[7012]: info: Loading plugin "mpd"... Dec 19 04:40:16 volumiow volumio-remote-updater[518]: [2025-12-19 04:40:16] [connect] Successful connection Dec 19 04:40:16 volumiow volumio[7012]: info: Plugin upnp_browser is not enabled Dec 19 04:40:16 volumiow volumio[7012]: info: Loading plugin "alarm-clock"... Dec 19 04:40:16 volumiow sudo[7056]: pam_unix(sudo:session): session closed for user root Dec 19 04:40:16 volumiow volumio[7012]: info: Loading plugin "airplay_emulation"... Dec 19 04:40:16 volumiow volumio[7012]: info: Starting Shairport Sync Dec 19 04:40:16 volumiow volumio[7012]: info: Loading plugin "last_100"... Dec 19 04:40:16 volumiow volumio[7012]: info: Loading plugin "webradio"... Dec 19 04:40:17 volumiow volumio[7012]: info: Loading plugin "i2s_dacs"... Dec 19 04:40:17 volumiow volumio[7012]: info: I2S DAC not set, start Auto-detection Dec 19 04:40:17 volumiow volumio[7012]: info: Loading plugin "volumiodiscovery"... Dec 19 04:40:17 volumiow volumio[7012]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 19 04:40:17 volumiow volumio[7012]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 19 04:40:17 volumiow volumio[7012]: *** WARNING *** For more information see Dec 19 04:40:17 volumiow volumio[7012]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 19 04:40:17 volumiow node[7012]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 19 04:40:17 volumiow volumio[7012]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 19 04:40:17 volumiow volumio[7012]: *** WARNING *** For more information see Dec 19 04:40:17 volumiow node[7012]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 19 04:40:17 volumiow node[7012]: *** WARNING *** For more information see Dec 19 04:40:17 volumiow node[7012]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 19 04:40:17 volumiow node[7012]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 19 04:40:17 volumiow node[7012]: *** WARNING *** For more information see Dec 19 04:40:17 volumiow volumio[7012]: info: Applying required configuration parameters for plugin volumiodiscovery Dec 19 04:40:17 volumiow volumio[7012]: info: Discovery: Started advertising with name: VolumioW Dec 19 04:40:17 volumiow volumio[7012]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 19 04:40:17 volumiow volumio[7012]: info: Loading plugin "squeezelite_mc"... Dec 19 04:40:18 volumiow volumio[7012]: info: Loading plugin "outputs"... Dec 19 04:40:18 volumiow volumio[7012]: info: Loading plugin "albumart"... Dec 19 04:40:18 volumiow volumio[7012]: info: Plugin example_plugin is not enabled Dec 19 04:40:18 volumiow volumio[7012]: info: Loading plugin "inputs"... Dec 19 04:40:18 volumiow volumio[7012]: info: Loading plugin "updater_comm"... Dec 19 04:40:18 volumiow volumio[7012]: info: Plugin mpdemulation is not enabled Dec 19 04:40:18 volumiow volumio[7012]: info: Loading plugin "rest_api"... Dec 19 04:40:18 volumiow volumio[7012]: info: Loading plugin "websocket"... Dec 19 04:40:18 volumiow volumio[7012]: info: Starting Socket.io Server version 2.3.0 Dec 19 04:40:18 volumiow volumio[7012]: info: Loading plugin "radio_paradise"... Dec 19 04:40:18 volumiow volumio[7012]: Forking 3 albumart workers Dec 19 04:40:18 volumiow volumio-time-update[492]: volumio-time-update-util: Fetching time from Volumio... Dec 19 04:40:18 volumiow volumio-time-update[492]: volumio-time-update-util: Date not found in response Dec 19 04:40:18 volumiow volumio-time-update[492]: volumio-time-update-util: Retrying in 5 seconds... Dec 19 04:40:18 volumiow volumio[7012]: info: Applying required configuration parameters for plugin radio_paradise Dec 19 04:40:18 volumiow volumio[7012]: info: [1766140818829] [RadioParadise] API delay: 5 Dec 19 04:40:18 volumiow volumio[7012]: info: Loading i18n strings for locale en Dec 19 04:40:18 volumiow volumio[7012]: Updating browse sources language Dec 19 04:40:18 volumiow volumio[7012]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 19 04:40:19 volumiow volumio[7012]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 19 04:40:19 volumiow volumio[7012]: info: CoreCommandRouter::initPlayerControls Dec 19 04:40:19 volumiow volumio[7012]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:19 volumiow volumio[7012]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:19 volumiow volumio[7012]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:19 volumiow volumio[7012]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:19 volumiow volumio[7012]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:19 volumiow volumio[7012]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:19 volumiow volumio[7012]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:19 volumiow volumio[7012]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:19 volumiow volumio[7012]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 19 04:40:19 volumiow volumio[7012]: Express server listening on port 3000 Dec 19 04:40:19 volumiow volumio[7012]: [Metrics] WebUI: 6s 79.34ms Dec 19 04:40:19 volumiow volumio[7012]: info: CoreStateMachine::resetVolumioState Dec 19 04:40:19 volumiow volumio[7012]: info: CoreStateMachine::getcurrentVolume Dec 19 04:40:19 volumiow volumio[7012]: info: CoreCommandRouter::volumioRetrievevolume Dec 19 04:40:19 volumiow volumio[7012]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 04:40:19 volumiow volumio[7012]: info: Volumio Network Manager: Network status updated: 0 Dec 19 04:40:19 volumiow volumio[7012]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Dec 19 04:40:19 volumiow volumio[7012]: info: Cannot mount NAS 24bit_88khz_+ at system boot, trial number 1 ,retrying in 5 seconds Dec 19 04:40:19 volumiow volumio[7012]: info: Cannot mount NAS SACD at system boot, trial number 1 ,retrying in 5 seconds Dec 19 04:40:19 volumiow volumio[7012]: info: Cannot mount NAS DSF at system boot, trial number 1 ,retrying in 5 seconds Dec 19 04:40:19 volumiow volumio-remote-updater[518]: [2025-12-19 04:40:19] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1766140816 101 Dec 19 04:40:19 volumiow volumio[7012]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 1 Dec 19 04:40:19 volumiow volumio[7012]: info: VolumeController:: Volume=undefined Mute =false Dec 19 04:40:19 volumiow volumio[7012]: info: CoreStateMachine::pushState Dec 19 04:40:19 volumiow volumio[7012]: info: CorePlayQueue::getTrack 0 Dec 19 04:40:19 volumiow volumio[7012]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 19 04:40:19 volumiow volumio[7012]: info: CoreCommandRouter::volumioPushState Dec 19 04:40:19 volumiow volumio[7012]: info: CoreStateMachine::updateTrackBlock Dec 19 04:40:19 volumiow volumio[7012]: info: CorePlayQueue::getTrackBlock Dec 19 04:40:19 volumiow volumio[7012]: info: CoreCommandRouter::volumioRetrievevolume Dec 19 04:40:19 volumiow volumio[7012]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Dec 19 04:40:19 volumiow wpa_supplicant[739]: wlan0: Failed to initiate sched scan Dec 19 04:40:19 volumiow volumio[7012]: info: Reloading queue from file Dec 19 04:40:19 volumiow volumio[7012]: info: CoreStateMachine::setRepeat null single undefined Dec 19 04:40:19 volumiow volumio[7012]: info: CoreStateMachine::pushState Dec 19 04:40:19 volumiow volumio[7012]: info: CorePlayQueue::getTrack 0 Dec 19 04:40:19 volumiow volumio[7012]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 19 04:40:19 volumiow volumio[7012]: info: CoreCommandRouter::volumioPushState Dec 19 04:40:19 volumiow volumio[7012]: info: CoreStateMachine::setRandom null Dec 19 04:40:19 volumiow volumio[7012]: info: CoreStateMachine::pushState Dec 19 04:40:19 volumiow volumio[7012]: info: CorePlayQueue::getTrack 0 Dec 19 04:40:19 volumiow volumio[7012]: info: CoreCommandRouter::volumioPushState Dec 19 04:40:19 volumiow volumio[7012]: info: Setting Device type: Raspberry PI Dec 19 04:40:19 volumiow volumio[7012]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Dec 19 04:40:19 volumiow volumio[7012]: info: USB Boot Capable - System SBC Revision found in cpuinfo: 902120 Dec 19 04:40:19 volumiow volumio[7012]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Dec 19 04:40:19 volumiow volumio[7012]: info: VolumeController:: Volume=undefined Mute =false Dec 19 04:40:19 volumiow volumio[7012]: info: CoreStateMachine::pushState Dec 19 04:40:19 volumiow volumio[7012]: info: CorePlayQueue::getTrack 0 Dec 19 04:40:19 volumiow volumio[7012]: info: CoreCommandRouter::volumioPushState Dec 19 04:40:19 volumiow volumio[7012]: info: Completed loading Core Plugins Dec 19 04:40:19 volumiow volumio[7012]: info: Preparing to generate the ALSA configuration file Dec 19 04:40:19 volumiow volumio[7012]: info: Asound.conf file unchanged, so no further update is needed Dec 19 04:40:19 volumiow volumio[7012]: info: Output device has changed, restarting MPD Dec 19 04:40:19 volumiow volumio[7012]: Starting albumart workers Dec 19 04:40:19 volumiow sudo[7132]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 19 04:40:19 volumiow volumio[7012]: info: Output device has changed, restarting Shairport Sync Dec 19 04:40:19 volumiow volumio[7012]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:19 volumiow volumio[7012]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 04:40:19 volumiow sudo[7132]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:40:19 volumiow sudo[7132]: pam_unix(sudo:session): session closed for user root Dec 19 04:40:20 volumiow volumio[7012]: Starting albumart workers Dec 19 04:40:20 volumiow sudo[7134]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 19 04:40:20 volumiow sudo[7134]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:40:20 volumiow volumio[7012]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 19 04:40:20 volumiow volumio[7012]: info: ___________ START PLUGINS ___________ Dec 19 04:40:20 volumiow volumio[7012]: info: ControllerMpd::onStart: Initializing MPD Dec 19 04:40:20 volumiow volumio[7012]: info: Creating MPD Configuration file Dec 19 04:40:20 volumiow systemd[1]: Stopping Music Player Daemon... Dec 19 04:40:20 volumiow sudo[7141]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 19 04:40:20 volumiow sudo[7141]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:40:20 volumiow volumio[7012]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:20 volumiow systemd[1]: mpd.service: Succeeded. Dec 19 04:40:20 volumiow volumio[7012]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 04:40:20 volumiow systemd[1]: Stopped Music Player Daemon. Dec 19 04:40:20 volumiow sudo[7141]: pam_unix(sudo:session): session closed for user root Dec 19 04:40:20 volumiow volumio[7012]: Starting albumart workers Dec 19 04:40:20 volumiow sudo[7144]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 19 04:40:20 volumiow systemd[1]: Starting Music Player Daemon... Dec 19 04:40:20 volumiow sudo[7144]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:40:20 volumiow volumio[7012]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 19 04:40:20 volumiow volumio[7012]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:20 volumiow volumio[7012]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 04:40:20 volumiow systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Dec 19 04:40:20 volumiow systemd[1]: mpd.service: Succeeded. Dec 19 04:40:20 volumiow systemd[1]: Stopped Music Player Daemon. Dec 19 04:40:20 volumiow systemd[1]: Starting Music Player Daemon... Dec 19 04:40:20 volumiow volumio[7012]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 19 04:40:20 volumiow volumio[7012]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 19 04:40:20 volumiow volumio[7012]: info: [1766140820305] CoreMusicLibrary::Adding element Last_100 Dec 19 04:40:20 volumiow volumio[7012]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 19 04:40:20 volumiow volumio[7012]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 19 04:40:20 volumiow volumio[7012]: info: [1766140820314] CoreMusicLibrary::Adding element Webradio Dec 19 04:40:20 volumiow volumio[7012]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 19 04:40:20 volumiow volumio[7012]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 19 04:40:20 volumiow volumio[7012]: info: Initializing BBC Radios Dec 19 04:40:20 volumiow volumio[7012]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory Dec 19 04:40:20 volumiow volumio[7012]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 04:40:20 volumiow sudo[7150]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 19 04:40:20 volumiow sudo[7150]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:40:20 volumiow sudo[7150]: pam_unix(sudo:session): session closed for user root Dec 19 04:40:20 volumiow volumio[7012]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 19 04:40:20 volumiow volumio[7012]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 04:40:20 volumiow volumio[7012]: info: [squeezelite_mc] Starting proxy server... Dec 19 04:40:20 volumiow volumio[7012]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 19 04:40:20 volumiow volumio[7012]: info: [1766140820518] CoreMusicLibrary::Adding element Radio Paradise Dec 19 04:40:20 volumiow volumio[7012]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 19 04:40:20 volumiow volumio[7012]: Cannot find translation for source Radio Paradise Dec 19 04:40:20 volumiow volumio[7012]: info: Volumio Calling Home Dec 19 04:40:20 volumiow volumio[7012]: info: [squeezelite_mc] Proxy server started on port 35961 Dec 19 04:40:20 volumiow volumio[7012]: info: CoreCommandRouter::volumioRetrievevolume Dec 19 04:40:21 volumiow volumio[7012]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Dec 19 04:40:21 volumiow volumio[7012]: info: MPD Permissions set Dec 19 04:40:21 volumiow volumio[7012]: info: MPD Permissions set Dec 19 04:40:21 volumiow volumio[7012]: info: VolumeController:: Volume=undefined Mute =false Dec 19 04:40:21 volumiow volumio[7012]: info: CoreStateMachine::pushState Dec 19 04:40:21 volumiow volumio[7012]: info: CorePlayQueue::getTrack 0 Dec 19 04:40:21 volumiow volumio[7012]: info: CoreCommandRouter::volumioPushState Dec 19 04:40:21 volumiow volumio[7012]: info: [squeezelite_mc] Server discovery started Dec 19 04:40:21 volumiow volumio[7012]: info: [squeezelite_mc] Player finder started Dec 19 04:40:21 volumiow volumio[7012]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:21 volumiow volumio[7012]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:21 volumiow volumio[7012]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:21 volumiow volumio[7012]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 19 04:40:21 volumiow volumio[7012]: info: [squeezelite_mc] Executing aplay -D hw:5 --nonblock -f MPEG /dev/zero 2>&1 || true Dec 19 04:40:21 volumiow volumio[7012]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 19 04:40:21 volumiow volumio[7012]: Error: send ENETUNREACH 255.255.255.255:3483 Dec 19 04:40:21 volumiow volumio[7012]: at doSend (dgram.js:692:16) Dec 19 04:40:21 volumiow volumio[7012]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:430:12) Dec 19 04:40:21 volumiow volumio[7012]: at afterDns (dgram.js:638:5) Dec 19 04:40:21 volumiow volumio[7012]: at processTicksAndRejections (internal/process/task_queues.js:81:21) { Dec 19 04:40:21 volumiow volumio[7012]: errno: -101, Dec 19 04:40:21 volumiow volumio[7012]: code: 'ENETUNREACH', Dec 19 04:40:21 volumiow volumio[7012]: syscall: 'send', Dec 19 04:40:21 volumiow volumio[7012]: address: '255.255.255.255', Dec 19 04:40:21 volumiow volumio[7012]: port: 3483 Dec 19 04:40:21 volumiow volumio[7012]: } Dec 19 04:40:21 volumiow volumio[7012]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 19 04:40:22 volumiow sudo[7206]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-19 04:39 Dec 19 04:40:22 volumiow sudo[7206]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:40:22 volumiow sudo[7206]: pam_unix(sudo:session): session closed for user root Dec 19 04:40:22 volumiow volumio-remote-updater[518]: [2025-12-19 04:40:22] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Dec 19 04:40:22 volumiow volumio-remote-updater[518]: [2025-12-19 04:40:22] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Dec 19 04:40:22 volumiow systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Dec 19 04:40:22 volumiow sudo[7144]: pam_unix(sudo:session): session closed for user root Dec 19 04:40:22 volumiow sudo[7134]: pam_unix(sudo:session): session closed for user root Dec 19 04:40:22 volumiow systemd[1]: volumio.service: Failed with result 'exit-code'. Dec 19 04:40:22 volumiow systemd[1]: Started dynamicswap service. Dec 19 04:40:22 volumiow systemd[1]: dynamicswap.service: Succeeded. Dec 19 04:40:22 volumiow mpd[7161]: Dec 19 04:40 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 19 04:40:22 volumiow systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Dec 19 04:40:22 volumiow systemd[1]: volumio.service: Scheduled restart job, restart counter is at 29. Dec 19 04:40:22 volumiow systemd[1]: Started Music Player Daemon. Dec 19 04:40:22 volumiow systemd[1]: Started dynamicswap service. Dec 19 04:40:22 volumiow systemd[1]: Stopped Volumio Backend Module. Dec 19 04:40:22 volumiow systemd[1]: Started Volumio Backend Module. Dec 19 04:40:22 volumiow systemd[1]: dynamicswap.service: Succeeded. Dec 19 04:40:23 volumiow volumio-time-update[492]: volumio-time-update-util: Fetching time from Volumio... Dec 19 04:40:23 volumiow volumio-time-update[492]: volumio-time-update-util: Date not found in response Dec 19 04:40:23 volumiow volumio-time-update[492]: volumio-time-update-util: Retrying in 5 seconds... Dec 19 04:40:24 volumiow volumio[7222]: info: ------------------------------------------- Dec 19 04:40:24 volumiow volumio[7222]: info: ----- Volumio3 ---- Dec 19 04:40:24 volumiow volumio[7222]: info: ------------------------------------------- Dec 19 04:40:24 volumiow volumio[7222]: info: ----- System startup ---- Dec 19 04:40:24 volumiow volumio[7222]: info: ------------------------------------------- Dec 19 04:40:25 volumiow wpa_supplicant[739]: wlan0: Failed to initiate sched scan Dec 19 04:40:25 volumiow volumio[7222]: info: MYVOLUMIO Environment detected Dec 19 04:40:25 volumiow volumio[7222]: info: Plugin folders cleanup Dec 19 04:40:25 volumiow volumio[7222]: info: Scanning into folder /volumio/app/plugins/ Dec 19 04:40:25 volumiow volumio[7222]: info: Scanning category audio_interface Dec 19 04:40:25 volumiow volumio[7222]: info: Scanning category miscellanea Dec 19 04:40:25 volumiow volumio[7222]: info: Scanning category music_service Dec 19 04:40:25 volumiow volumio[7222]: info: Scanning category plugins.json Dec 19 04:40:25 volumiow volumio[7222]: info: Scanning category system_controller Dec 19 04:40:25 volumiow volumio[7222]: info: Scanning category user_interface Dec 19 04:40:25 volumiow volumio[7222]: info: Scanning into folder /data/plugins/ Dec 19 04:40:25 volumiow volumio[7222]: info: Scanning category music_service Dec 19 04:40:25 volumiow volumio[7222]: info: Plugin folders cleanup completed Dec 19 04:40:25 volumiow volumio[7222]: info: ------------------------------------------- Dec 19 04:40:25 volumiow volumio[7222]: info: ----- Core plugins startup ---- Dec 19 04:40:25 volumiow volumio[7222]: info: ------------------------------------------- Dec 19 04:40:25 volumiow volumio[7222]: info: Loading plugins from folder /volumio/app/plugins/ Dec 19 04:40:25 volumiow volumio[7222]: info: Adding plugin upnp to MyMusic Plugins Dec 19 04:40:25 volumiow volumio[7222]: info: Adding plugin airplay_emulation to MyMusic Plugins Dec 19 04:40:25 volumiow volumio[7222]: info: Adding plugin upnp_browser to MyMusic Plugins Dec 19 04:40:25 volumiow volumio[7222]: info: Loading plugins from folder /data/plugins/ Dec 19 04:40:25 volumiow volumio[7222]: info: Loading plugin "system"... Dec 19 04:40:25 volumiow volumio[7222]: info: Loading plugin "appearance"... Dec 19 04:40:26 volumiow volumio[7222]: info: Loading plugin "network"... Dec 19 04:40:26 volumiow volumio[7222]: info: Refreshing Cached IP Addresses Dec 19 04:40:26 volumiow sudo[7253]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 19 04:40:26 volumiow sudo[7253]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:40:26 volumiow sudo[7255]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 19 04:40:26 volumiow sudo[7255]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:40:26 volumiow sudo[7255]: pam_unix(sudo:session): session closed for user root Dec 19 04:40:26 volumiow sudo[7253]: pam_unix(sudo:session): session closed for user root Dec 19 04:40:26 volumiow volumio[7222]: info: Loading plugin "services"... Dec 19 04:40:26 volumiow volumio[7222]: info: Loading plugin "alsa_controller"... Dec 19 04:40:26 volumiow sudo[7270]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Dec 19 04:40:26 volumiow sudo[7270]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:40:27 volumiow volumio[7222]: warn: Unable to locate the audio output device E30. Please configure a valid output device. Dec 19 04:40:27 volumiow volumio[7222]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 19 04:40:27 volumiow volumio[7222]: info: Loading plugin "wizard"... Dec 19 04:40:27 volumiow volumio[7222]: info: Loading plugin "networkfs"... Dec 19 04:40:27 volumiow sudo[7281]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=nouser,password=nouser,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=3.11 //172.16.1.11/Audio\\High Resolution\\DSF /mnt/NAS/DSF Dec 19 04:40:27 volumiow sudo[7281]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:40:27 volumiow kernel: CIFS: Attempting to mount //172.16.1.11/Audio/High Resolution/DSF Dec 19 04:40:27 volumiow kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Dec 19 04:40:27 volumiow kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Dec 19 04:40:27 volumiow volumio[7222]: info: Starting Udev Watcher for removable devices Dec 19 04:40:27 volumiow sudo[7283]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=nouser,password=nouser,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=3.11 //172.16.1.11/Audio\\High Resolution\\SACD /mnt/NAS/SACD Dec 19 04:40:27 volumiow sudo[7283]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:40:27 volumiow sudo[7281]: pam_unix(sudo:session): session closed for user root Dec 19 04:40:27 volumiow sudo[7286]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=nouser,password=nouser,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=3.11 //172.16.1.11/Audio\\High Resolution\\24 Bit\\%24bit-88Khz (plus) /mnt/NAS/24bit_88khz_+ Dec 19 04:40:27 volumiow sudo[7286]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:40:27 volumiow kernel: CIFS: Attempting to mount //172.16.1.11/Audio/High Resolution/SACD Dec 19 04:40:27 volumiow kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Dec 19 04:40:27 volumiow kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Dec 19 04:40:27 volumiow sudo[7283]: pam_unix(sudo:session): session closed for user root Dec 19 04:40:27 volumiow volumio[7222]: info: Ignoring mount for partition: boot Dec 19 04:40:27 volumiow volumio[7222]: info: Ignoring mount for partition: volumio Dec 19 04:40:27 volumiow volumio[7222]: info: Ignoring mount for partition: volumio_data Dec 19 04:40:27 volumiow volumio[7222]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 19 04:40:27 volumiow volumio[7222]: info: Loading plugin "volumio_command_line_client"... Dec 19 04:40:27 volumiow sudo[7286]: pam_unix(sudo:session): session closed for user root Dec 19 04:40:27 volumiow kernel: CIFS: Attempting to mount //172.16.1.11/Audio/High Resolution/24 Bit/%24bit-88Khz (plus) Dec 19 04:40:27 volumiow kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Dec 19 04:40:27 volumiow kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Dec 19 04:40:27 volumiow volumio[7222]: info: Plugin upnp is not enabled Dec 19 04:40:27 volumiow volumio[7222]: info: Loading plugin "my_music"... Dec 19 04:40:27 volumiow volumio[7222]: info: Loading plugin "mpd"... Dec 19 04:40:27 volumiow volumio-remote-updater[518]: [2025-12-19 04:40:27] [connect] Successful connection Dec 19 04:40:27 volumiow volumio[7222]: info: Plugin upnp_browser is not enabled Dec 19 04:40:27 volumiow volumio[7222]: info: Loading plugin "alarm-clock"... Dec 19 04:40:27 volumiow sudo[7270]: pam_unix(sudo:session): session closed for user root Dec 19 04:40:27 volumiow volumio[7222]: info: Loading plugin "airplay_emulation"... Dec 19 04:40:27 volumiow volumio[7222]: info: Starting Shairport Sync Dec 19 04:40:27 volumiow volumio[7222]: info: Loading plugin "last_100"... Dec 19 04:40:27 volumiow volumio[7222]: info: Loading plugin "webradio"... Dec 19 04:40:27 volumiow volumio[7222]: info: Loading plugin "i2s_dacs"... Dec 19 04:40:27 volumiow volumio[7222]: info: I2S DAC not set, start Auto-detection Dec 19 04:40:27 volumiow volumio[7222]: info: Loading plugin "volumiodiscovery"... Dec 19 04:40:28 volumiow volumio[7222]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 19 04:40:28 volumiow volumio[7222]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 19 04:40:28 volumiow volumio[7222]: *** WARNING *** For more information see Dec 19 04:40:28 volumiow node[7222]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 19 04:40:28 volumiow volumio[7222]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 19 04:40:28 volumiow volumio[7222]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 19 04:40:28 volumiow volumio[7222]: *** WARNING *** For more information see Dec 19 04:40:28 volumiow node[7222]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 19 04:40:28 volumiow node[7222]: *** WARNING *** For more information see Dec 19 04:40:28 volumiow node[7222]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 19 04:40:28 volumiow node[7222]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 19 04:40:28 volumiow node[7222]: *** WARNING *** For more information see Dec 19 04:40:28 volumiow volumio[7222]: info: Applying required configuration parameters for plugin volumiodiscovery Dec 19 04:40:28 volumiow volumio[7222]: info: Discovery: Started advertising with name: VolumioW Dec 19 04:40:28 volumiow volumio[7222]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 19 04:40:28 volumiow volumio[7222]: info: Loading plugin "squeezelite_mc"... Dec 19 04:40:28 volumiow volumio-time-update[492]: volumio-time-update-util: Fetching time from Volumio... Dec 19 04:40:28 volumiow volumio-time-update[492]: volumio-time-update-util: Date not found in response Dec 19 04:40:28 volumiow volumio-time-update[492]: volumio-time-update-util: Retrying in 5 seconds... Dec 19 04:40:29 volumiow volumio[7222]: info: Loading plugin "outputs"... Dec 19 04:40:29 volumiow volumio[7222]: info: Loading plugin "albumart"... Dec 19 04:40:29 volumiow volumio[7222]: info: Plugin example_plugin is not enabled Dec 19 04:40:29 volumiow volumio[7222]: info: Loading plugin "inputs"... Dec 19 04:40:29 volumiow volumio[7222]: info: Loading plugin "updater_comm"... Dec 19 04:40:29 volumiow volumio[7222]: info: Plugin mpdemulation is not enabled Dec 19 04:40:29 volumiow volumio[7222]: info: Loading plugin "rest_api"... Dec 19 04:40:29 volumiow volumio[7222]: info: Loading plugin "websocket"... Dec 19 04:40:29 volumiow volumio[7222]: info: Starting Socket.io Server version 2.3.0 Dec 19 04:40:29 volumiow volumio[7222]: info: Loading plugin "radio_paradise"... Dec 19 04:40:29 volumiow volumio[7222]: Forking 3 albumart workers Dec 19 04:40:29 volumiow volumio[7222]: info: Applying required configuration parameters for plugin radio_paradise Dec 19 04:40:29 volumiow volumio[7222]: info: [1766140829679] [RadioParadise] API delay: 5 Dec 19 04:40:29 volumiow volumio[7222]: info: Loading i18n strings for locale en Dec 19 04:40:29 volumiow volumio[7222]: Updating browse sources language Dec 19 04:40:29 volumiow volumio[7222]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 19 04:40:29 volumiow volumio[7222]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 19 04:40:29 volumiow volumio[7222]: info: CoreCommandRouter::initPlayerControls Dec 19 04:40:29 volumiow volumio[7222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:29 volumiow volumio[7222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:29 volumiow volumio[7222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:29 volumiow volumio[7222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:29 volumiow volumio[7222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:29 volumiow volumio[7222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:29 volumiow volumio[7222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:29 volumiow volumio[7222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:29 volumiow volumio[7222]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 19 04:40:29 volumiow volumio[7222]: Express server listening on port 3000 Dec 19 04:40:29 volumiow volumio[7222]: [Metrics] WebUI: 6s 14.06ms Dec 19 04:40:30 volumiow volumio[7222]: info: CoreStateMachine::resetVolumioState Dec 19 04:40:30 volumiow volumio[7222]: info: CoreStateMachine::getcurrentVolume Dec 19 04:40:30 volumiow volumio[7222]: info: CoreCommandRouter::volumioRetrievevolume Dec 19 04:40:30 volumiow volumio[7222]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 04:40:30 volumiow volumio[7222]: info: Volumio Network Manager: Network status updated: 0 Dec 19 04:40:30 volumiow volumio[7222]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Dec 19 04:40:30 volumiow volumio[7222]: info: Cannot mount NAS 24bit_88khz_+ at system boot, trial number 1 ,retrying in 5 seconds Dec 19 04:40:30 volumiow volumio[7222]: info: Cannot mount NAS SACD at system boot, trial number 1 ,retrying in 5 seconds Dec 19 04:40:30 volumiow volumio[7222]: info: Cannot mount NAS DSF at system boot, trial number 1 ,retrying in 5 seconds Dec 19 04:40:30 volumiow volumio-remote-updater[518]: [2025-12-19 04:40:30] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1766140827 101 Dec 19 04:40:30 volumiow volumio[7222]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 1 Dec 19 04:40:30 volumiow volumio[7222]: info: VolumeController:: Volume=undefined Mute =false Dec 19 04:40:30 volumiow volumio[7222]: info: CoreStateMachine::pushState Dec 19 04:40:30 volumiow volumio[7222]: info: CorePlayQueue::getTrack 0 Dec 19 04:40:30 volumiow volumio[7222]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 19 04:40:30 volumiow volumio[7222]: info: CoreCommandRouter::volumioPushState Dec 19 04:40:30 volumiow volumio[7222]: info: CoreStateMachine::updateTrackBlock Dec 19 04:40:30 volumiow volumio[7222]: info: CorePlayQueue::getTrackBlock Dec 19 04:40:30 volumiow volumio[7222]: info: CoreCommandRouter::volumioRetrievevolume Dec 19 04:40:30 volumiow volumio[7222]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Dec 19 04:40:30 volumiow volumio[7222]: info: Reloading queue from file Dec 19 04:40:30 volumiow volumio[7222]: info: VolumeController:: Volume=undefined Mute =false Dec 19 04:40:30 volumiow volumio[7222]: info: CoreStateMachine::pushState Dec 19 04:40:30 volumiow volumio[7222]: info: CorePlayQueue::getTrack 0 Dec 19 04:40:30 volumiow volumio[7222]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 19 04:40:30 volumiow volumio[7222]: info: CoreCommandRouter::volumioPushState Dec 19 04:40:30 volumiow volumio[7222]: info: CoreStateMachine::setRepeat null single undefined Dec 19 04:40:30 volumiow volumio[7222]: info: CoreStateMachine::pushState Dec 19 04:40:30 volumiow volumio[7222]: info: CorePlayQueue::getTrack 0 Dec 19 04:40:30 volumiow volumio[7222]: info: CoreCommandRouter::volumioPushState Dec 19 04:40:30 volumiow volumio[7222]: info: CoreStateMachine::setRandom null Dec 19 04:40:30 volumiow volumio[7222]: info: CoreStateMachine::pushState Dec 19 04:40:30 volumiow volumio[7222]: info: CorePlayQueue::getTrack 0 Dec 19 04:40:30 volumiow volumio[7222]: info: CoreCommandRouter::volumioPushState Dec 19 04:40:30 volumiow volumio[7222]: info: Setting Device type: Raspberry PI Dec 19 04:40:30 volumiow volumio[7222]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Dec 19 04:40:30 volumiow volumio[7222]: info: USB Boot Capable - System SBC Revision found in cpuinfo: 902120 Dec 19 04:40:30 volumiow volumio[7222]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Dec 19 04:40:30 volumiow volumio[7222]: info: Completed loading Core Plugins Dec 19 04:40:30 volumiow volumio[7222]: info: Preparing to generate the ALSA configuration file Dec 19 04:40:30 volumiow volumio[7222]: info: Asound.conf file unchanged, so no further update is needed Dec 19 04:40:30 volumiow volumio[7222]: info: Output device has changed, restarting MPD Dec 19 04:40:30 volumiow volumio[7222]: info: Output device has changed, restarting Shairport Sync Dec 19 04:40:30 volumiow volumio[7222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:30 volumiow volumio[7222]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 04:40:30 volumiow sudo[7350]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 19 04:40:30 volumiow sudo[7350]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:40:30 volumiow sudo[7357]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 19 04:40:30 volumiow sudo[7357]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:40:30 volumiow sudo[7350]: pam_unix(sudo:session): session closed for user root Dec 19 04:40:30 volumiow volumio[7222]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 19 04:40:30 volumiow wpa_supplicant[739]: wlan0: Failed to initiate sched scan Dec 19 04:40:30 volumiow volumio[7222]: info: ___________ START PLUGINS ___________ Dec 19 04:40:30 volumiow systemd[1]: Stopping Music Player Daemon... Dec 19 04:40:30 volumiow volumio[7222]: info: ControllerMpd::onStart: Initializing MPD Dec 19 04:40:30 volumiow volumio[7222]: info: Creating MPD Configuration file Dec 19 04:40:30 volumiow systemd[1]: mpd.service: Succeeded. Dec 19 04:40:30 volumiow systemd[1]: Stopped Music Player Daemon. Dec 19 04:40:30 volumiow volumio[7222]: Starting albumart workers Dec 19 04:40:30 volumiow volumio[7222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:30 volumiow volumio[7222]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 04:40:30 volumiow sudo[7386]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 19 04:40:30 volumiow sudo[7386]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:40:30 volumiow sudo[7386]: pam_unix(sudo:session): session closed for user root Dec 19 04:40:30 volumiow systemd[1]: Starting Music Player Daemon... Dec 19 04:40:30 volumiow sudo[7391]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 19 04:40:30 volumiow sudo[7391]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:40:31 volumiow volumio[7222]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 19 04:40:31 volumiow volumio[7222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:31 volumiow volumio[7222]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 04:40:31 volumiow systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Dec 19 04:40:31 volumiow systemd[1]: mpd.service: Succeeded. Dec 19 04:40:31 volumiow systemd[1]: Stopped Music Player Daemon. Dec 19 04:40:31 volumiow systemd[1]: Starting Music Player Daemon... Dec 19 04:40:31 volumiow volumio[7222]: Starting albumart workers Dec 19 04:40:31 volumiow volumio[7222]: Starting albumart workers Dec 19 04:40:31 volumiow volumio[7222]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 19 04:40:31 volumiow volumio[7222]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 19 04:40:31 volumiow volumio[7222]: info: [1766140831126] CoreMusicLibrary::Adding element Last_100 Dec 19 04:40:31 volumiow volumio[7222]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 19 04:40:31 volumiow volumio[7222]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 19 04:40:31 volumiow volumio[7222]: info: [1766140831133] CoreMusicLibrary::Adding element Webradio Dec 19 04:40:31 volumiow volumio[7222]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 19 04:40:31 volumiow sudo[7400]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 19 04:40:31 volumiow sudo[7400]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:40:31 volumiow sudo[7400]: pam_unix(sudo:session): session closed for user root Dec 19 04:40:31 volumiow volumio[7222]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 19 04:40:31 volumiow volumio[7222]: info: Initializing BBC Radios Dec 19 04:40:31 volumiow volumio[7222]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory Dec 19 04:40:31 volumiow volumio[7222]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 04:40:31 volumiow volumio[7222]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 19 04:40:31 volumiow volumio[7222]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 04:40:31 volumiow volumio[7222]: info: [squeezelite_mc] Starting proxy server... Dec 19 04:40:31 volumiow volumio[7222]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 19 04:40:31 volumiow volumio[7222]: info: [1766140831546] CoreMusicLibrary::Adding element Radio Paradise Dec 19 04:40:31 volumiow volumio[7222]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 19 04:40:31 volumiow volumio[7222]: Cannot find translation for source Radio Paradise Dec 19 04:40:31 volumiow volumio[7222]: info: Volumio Calling Home Dec 19 04:40:31 volumiow volumio[7222]: info: [squeezelite_mc] Proxy server started on port 34505 Dec 19 04:40:32 volumiow volumio[7222]: info: CoreCommandRouter::volumioRetrievevolume Dec 19 04:40:32 volumiow volumio[7222]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Dec 19 04:40:32 volumiow volumio[7222]: info: MPD Permissions set Dec 19 04:40:32 volumiow volumio[7222]: info: MPD Permissions set Dec 19 04:40:32 volumiow volumio[7222]: info: VolumeController:: Volume=undefined Mute =false Dec 19 04:40:32 volumiow volumio[7222]: info: CoreStateMachine::pushState Dec 19 04:40:32 volumiow volumio[7222]: info: CorePlayQueue::getTrack 0 Dec 19 04:40:32 volumiow volumio[7222]: info: CoreCommandRouter::volumioPushState Dec 19 04:40:32 volumiow volumio[7222]: info: [squeezelite_mc] Server discovery started Dec 19 04:40:32 volumiow volumio[7222]: info: [squeezelite_mc] Player finder started Dec 19 04:40:32 volumiow volumio[7222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:32 volumiow volumio[7222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:32 volumiow volumio[7222]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:32 volumiow volumio[7222]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 19 04:40:32 volumiow volumio[7222]: info: [squeezelite_mc] Executing aplay -D hw:5 --nonblock -f MPEG /dev/zero 2>&1 || true Dec 19 04:40:32 volumiow volumio[7222]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 19 04:40:32 volumiow volumio[7222]: Error: send ENETUNREACH 255.255.255.255:3483 Dec 19 04:40:32 volumiow volumio[7222]: at doSend (dgram.js:692:16) Dec 19 04:40:32 volumiow volumio[7222]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:430:12) Dec 19 04:40:32 volumiow volumio[7222]: at afterDns (dgram.js:638:5) Dec 19 04:40:32 volumiow volumio[7222]: at processTicksAndRejections (internal/process/task_queues.js:81:21) { Dec 19 04:40:32 volumiow volumio[7222]: errno: -101, Dec 19 04:40:32 volumiow volumio[7222]: code: 'ENETUNREACH', Dec 19 04:40:32 volumiow volumio[7222]: syscall: 'send', Dec 19 04:40:32 volumiow volumio[7222]: address: '255.255.255.255', Dec 19 04:40:32 volumiow volumio[7222]: port: 3483 Dec 19 04:40:32 volumiow volumio[7222]: } Dec 19 04:40:32 volumiow volumio[7222]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 19 04:40:33 volumiow sudo[7454]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-19 04:39 Dec 19 04:40:33 volumiow sudo[7454]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:40:33 volumiow sudo[7454]: pam_unix(sudo:session): session closed for user root Dec 19 04:40:33 volumiow mpd[7403]: Dec 19 04:40 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 19 04:40:33 volumiow systemd[1]: Started Music Player Daemon. Dec 19 04:40:33 volumiow sudo[7391]: pam_unix(sudo:session): session closed for user root Dec 19 04:40:33 volumiow sudo[7357]: pam_unix(sudo:session): session closed for user root Dec 19 04:40:33 volumiow volumio-remote-updater[518]: [2025-12-19 04:40:33] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Dec 19 04:40:33 volumiow volumio-remote-updater[518]: [2025-12-19 04:40:33] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Dec 19 04:40:33 volumiow systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Dec 19 04:40:33 volumiow systemd[1]: volumio.service: Failed with result 'exit-code'. Dec 19 04:40:33 volumiow systemd[1]: Started dynamicswap service. Dec 19 04:40:33 volumiow systemd[1]: dynamicswap.service: Succeeded. Dec 19 04:40:33 volumiow systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Dec 19 04:40:33 volumiow systemd[1]: volumio.service: Scheduled restart job, restart counter is at 30. Dec 19 04:40:33 volumiow systemd[1]: Started dynamicswap service. Dec 19 04:40:33 volumiow systemd[1]: Stopped Volumio Backend Module. Dec 19 04:40:33 volumiow systemd[1]: Started Volumio Backend Module. Dec 19 04:40:33 volumiow systemd[1]: dynamicswap.service: Succeeded. Dec 19 04:40:33 volumiow volumio-time-update[492]: volumio-time-update-util: Fetching time from Volumio... Dec 19 04:40:33 volumiow volumio-time-update[492]: volumio-time-update-util: Date not found in response Dec 19 04:40:33 volumiow volumio-time-update[492]: volumio-time-update-util: Retrying in 5 seconds... Dec 19 04:40:35 volumiow volumio[7470]: info: ------------------------------------------- Dec 19 04:40:35 volumiow volumio[7470]: info: ----- Volumio3 ---- Dec 19 04:40:35 volumiow volumio[7470]: info: ------------------------------------------- Dec 19 04:40:35 volumiow volumio[7470]: info: ----- System startup ---- Dec 19 04:40:35 volumiow volumio[7470]: info: ------------------------------------------- Dec 19 04:40:36 volumiow wpa_supplicant[739]: wlan0: Failed to initiate sched scan Dec 19 04:40:36 volumiow volumio[7470]: info: MYVOLUMIO Environment detected Dec 19 04:40:36 volumiow volumio[7470]: info: Plugin folders cleanup Dec 19 04:40:36 volumiow volumio[7470]: info: Scanning into folder /volumio/app/plugins/ Dec 19 04:40:36 volumiow volumio[7470]: info: Scanning category audio_interface Dec 19 04:40:36 volumiow volumio[7470]: info: Scanning category miscellanea Dec 19 04:40:36 volumiow volumio[7470]: info: Scanning category music_service Dec 19 04:40:36 volumiow volumio[7470]: info: Scanning category plugins.json Dec 19 04:40:36 volumiow volumio[7470]: info: Scanning category system_controller Dec 19 04:40:36 volumiow volumio[7470]: info: Scanning category user_interface Dec 19 04:40:36 volumiow volumio[7470]: info: Scanning into folder /data/plugins/ Dec 19 04:40:36 volumiow volumio[7470]: info: Scanning category music_service Dec 19 04:40:36 volumiow volumio[7470]: info: Plugin folders cleanup completed Dec 19 04:40:36 volumiow volumio[7470]: info: ------------------------------------------- Dec 19 04:40:36 volumiow volumio[7470]: info: ----- Core plugins startup ---- Dec 19 04:40:36 volumiow volumio[7470]: info: ------------------------------------------- Dec 19 04:40:36 volumiow volumio[7470]: info: Loading plugins from folder /volumio/app/plugins/ Dec 19 04:40:36 volumiow volumio[7470]: info: Adding plugin upnp to MyMusic Plugins Dec 19 04:40:36 volumiow volumio[7470]: info: Adding plugin airplay_emulation to MyMusic Plugins Dec 19 04:40:36 volumiow volumio[7470]: info: Adding plugin upnp_browser to MyMusic Plugins Dec 19 04:40:36 volumiow volumio[7470]: info: Loading plugins from folder /data/plugins/ Dec 19 04:40:36 volumiow volumio[7470]: info: Loading plugin "system"... Dec 19 04:40:36 volumiow volumio[7470]: info: Loading plugin "appearance"... Dec 19 04:40:37 volumiow volumio[7470]: info: Loading plugin "network"... Dec 19 04:40:37 volumiow volumio[7470]: info: Refreshing Cached IP Addresses Dec 19 04:40:38 volumiow sudo[7501]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 19 04:40:38 volumiow sudo[7501]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:40:38 volumiow sudo[7503]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 19 04:40:38 volumiow sudo[7503]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:40:38 volumiow sudo[7503]: pam_unix(sudo:session): session closed for user root Dec 19 04:40:38 volumiow sudo[7501]: pam_unix(sudo:session): session closed for user root Dec 19 04:40:38 volumiow volumio[7470]: info: Loading plugin "services"... Dec 19 04:40:38 volumiow volumio[7470]: info: Loading plugin "alsa_controller"... Dec 19 04:40:38 volumiow sudo[7514]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Dec 19 04:40:38 volumiow sudo[7514]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:40:38 volumiow volumio[7470]: warn: Unable to locate the audio output device E30. Please configure a valid output device. Dec 19 04:40:38 volumiow volumio[7470]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 19 04:40:38 volumiow volumio[7470]: info: Loading plugin "wizard"... Dec 19 04:40:38 volumiow volumio[7470]: info: Loading plugin "networkfs"... Dec 19 04:40:38 volumiow sudo[7529]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=nouser,password=nouser,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=3.11 //172.16.1.11/Audio\\High Resolution\\DSF /mnt/NAS/DSF Dec 19 04:40:38 volumiow sudo[7529]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:40:38 volumiow kernel: CIFS: Attempting to mount //172.16.1.11/Audio/High Resolution/DSF Dec 19 04:40:38 volumiow kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Dec 19 04:40:38 volumiow kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Dec 19 04:40:38 volumiow volumio[7470]: info: Starting Udev Watcher for removable devices Dec 19 04:40:38 volumiow sudo[7531]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=nouser,password=nouser,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=3.11 //172.16.1.11/Audio\\High Resolution\\SACD /mnt/NAS/SACD Dec 19 04:40:38 volumiow sudo[7531]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:40:38 volumiow sudo[7529]: pam_unix(sudo:session): session closed for user root Dec 19 04:40:38 volumiow sudo[7535]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=nouser,password=nouser,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=3.11 //172.16.1.11/Audio\\High Resolution\\24 Bit\\%24bit-88Khz (plus) /mnt/NAS/24bit_88khz_+ Dec 19 04:40:38 volumiow sudo[7535]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:40:38 volumiow kernel: CIFS: Attempting to mount //172.16.1.11/Audio/High Resolution/SACD Dec 19 04:40:38 volumiow kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Dec 19 04:40:38 volumiow kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Dec 19 04:40:38 volumiow sudo[7531]: pam_unix(sudo:session): session closed for user root Dec 19 04:40:38 volumiow sudo[7535]: pam_unix(sudo:session): session closed for user root Dec 19 04:40:38 volumiow volumio[7470]: info: Ignoring mount for partition: boot Dec 19 04:40:38 volumiow volumio[7470]: info: Ignoring mount for partition: volumio Dec 19 04:40:38 volumiow volumio[7470]: info: Ignoring mount for partition: volumio_data Dec 19 04:40:38 volumiow volumio[7470]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 19 04:40:38 volumiow kernel: CIFS: Attempting to mount //172.16.1.11/Audio/High Resolution/24 Bit/%24bit-88Khz (plus) Dec 19 04:40:38 volumiow kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Dec 19 04:40:38 volumiow kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Dec 19 04:40:38 volumiow volumio[7470]: info: Loading plugin "volumio_command_line_client"... Dec 19 04:40:38 volumiow volumio[7470]: info: Plugin upnp is not enabled Dec 19 04:40:38 volumiow volumio[7470]: info: Loading plugin "my_music"... Dec 19 04:40:38 volumiow volumio[7470]: info: Loading plugin "mpd"... Dec 19 04:40:38 volumiow volumio-remote-updater[518]: [2025-12-19 04:40:38] [connect] Successful connection Dec 19 04:40:38 volumiow volumio[7470]: info: Plugin upnp_browser is not enabled Dec 19 04:40:38 volumiow volumio[7470]: info: Loading plugin "alarm-clock"... Dec 19 04:40:38 volumiow sudo[7514]: pam_unix(sudo:session): session closed for user root Dec 19 04:40:38 volumiow volumio-time-update[492]: volumio-time-update-util: Fetching time from Volumio... Dec 19 04:40:38 volumiow volumio-time-update[492]: volumio-time-update-util: Date not found in response Dec 19 04:40:38 volumiow volumio-time-update[492]: volumio-time-update-util: Retrying in 5 seconds... Dec 19 04:40:38 volumiow volumio[7470]: info: Loading plugin "airplay_emulation"... Dec 19 04:40:38 volumiow volumio[7470]: info: Starting Shairport Sync Dec 19 04:40:38 volumiow volumio[7470]: info: Loading plugin "last_100"... Dec 19 04:40:38 volumiow volumio[7470]: info: Loading plugin "webradio"... Dec 19 04:40:39 volumiow volumio[7470]: info: Loading plugin "i2s_dacs"... Dec 19 04:40:39 volumiow volumio[7470]: info: I2S DAC not set, start Auto-detection Dec 19 04:40:39 volumiow volumio[7470]: info: Loading plugin "volumiodiscovery"... Dec 19 04:40:39 volumiow volumio[7470]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 19 04:40:39 volumiow volumio[7470]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 19 04:40:39 volumiow volumio[7470]: *** WARNING *** For more information see Dec 19 04:40:39 volumiow node[7470]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 19 04:40:39 volumiow volumio[7470]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 19 04:40:39 volumiow volumio[7470]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 19 04:40:39 volumiow volumio[7470]: *** WARNING *** For more information see Dec 19 04:40:39 volumiow node[7470]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 19 04:40:39 volumiow node[7470]: *** WARNING *** For more information see Dec 19 04:40:39 volumiow node[7470]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 19 04:40:39 volumiow node[7470]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 19 04:40:39 volumiow node[7470]: *** WARNING *** For more information see Dec 19 04:40:39 volumiow volumio[7470]: info: Applying required configuration parameters for plugin volumiodiscovery Dec 19 04:40:39 volumiow volumio[7470]: info: Discovery: Started advertising with name: VolumioW Dec 19 04:40:39 volumiow volumio[7470]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 19 04:40:39 volumiow volumio[7470]: info: Loading plugin "squeezelite_mc"... Dec 19 04:40:40 volumiow volumio[7470]: info: Loading plugin "outputs"... Dec 19 04:40:40 volumiow volumio[7470]: info: Loading plugin "albumart"... Dec 19 04:40:40 volumiow volumio[7470]: info: Plugin example_plugin is not enabled Dec 19 04:40:40 volumiow volumio[7470]: info: Loading plugin "inputs"... Dec 19 04:40:40 volumiow volumio[7470]: info: Loading plugin "updater_comm"... Dec 19 04:40:40 volumiow volumio[7470]: info: Plugin mpdemulation is not enabled Dec 19 04:40:40 volumiow volumio[7470]: info: Loading plugin "rest_api"... Dec 19 04:40:40 volumiow volumio[7470]: info: Loading plugin "websocket"... Dec 19 04:40:40 volumiow volumio[7470]: info: Starting Socket.io Server version 2.3.0 Dec 19 04:40:40 volumiow volumio[7470]: info: Loading plugin "radio_paradise"... Dec 19 04:40:40 volumiow volumio[7470]: Forking 3 albumart workers Dec 19 04:40:40 volumiow volumio[7470]: info: Applying required configuration parameters for plugin radio_paradise Dec 19 04:40:40 volumiow volumio[7470]: info: [1766140840835] [RadioParadise] API delay: 5 Dec 19 04:40:40 volumiow volumio[7470]: info: Loading i18n strings for locale en Dec 19 04:40:40 volumiow volumio[7470]: Updating browse sources language Dec 19 04:40:40 volumiow volumio[7470]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 19 04:40:41 volumiow volumio[7470]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 19 04:40:41 volumiow volumio[7470]: info: CoreCommandRouter::initPlayerControls Dec 19 04:40:41 volumiow volumio[7470]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:41 volumiow volumio[7470]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:41 volumiow volumio[7470]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:41 volumiow volumio[7470]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:41 volumiow volumio[7470]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:41 volumiow volumio[7470]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:41 volumiow volumio[7470]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:41 volumiow volumio[7470]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:41 volumiow volumio[7470]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 19 04:40:41 volumiow volumio[7470]: Express server listening on port 3000 Dec 19 04:40:41 volumiow volumio[7470]: [Metrics] WebUI: 6s 6.43ms Dec 19 04:40:41 volumiow volumio[7470]: info: CoreStateMachine::resetVolumioState Dec 19 04:40:41 volumiow volumio[7470]: info: CoreStateMachine::getcurrentVolume Dec 19 04:40:41 volumiow volumio[7470]: info: CoreCommandRouter::volumioRetrievevolume Dec 19 04:40:41 volumiow volumio[7470]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 04:40:41 volumiow volumio[7470]: info: Volumio Network Manager: Network status updated: 0 Dec 19 04:40:41 volumiow volumio[7470]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Dec 19 04:40:41 volumiow volumio[7470]: info: Cannot mount NAS 24bit_88khz_+ at system boot, trial number 1 ,retrying in 5 seconds Dec 19 04:40:41 volumiow volumio[7470]: info: Cannot mount NAS SACD at system boot, trial number 1 ,retrying in 5 seconds Dec 19 04:40:41 volumiow volumio[7470]: info: Cannot mount NAS DSF at system boot, trial number 1 ,retrying in 5 seconds Dec 19 04:40:41 volumiow volumio-remote-updater[518]: [2025-12-19 04:40:41] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1766140838 101 Dec 19 04:40:41 volumiow volumio[7470]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 1 Dec 19 04:40:41 volumiow volumio[7470]: info: VolumeController:: Volume=undefined Mute =false Dec 19 04:40:41 volumiow volumio[7470]: info: CoreStateMachine::pushState Dec 19 04:40:41 volumiow volumio[7470]: info: CorePlayQueue::getTrack 0 Dec 19 04:40:41 volumiow volumio[7470]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 19 04:40:41 volumiow volumio[7470]: info: CoreCommandRouter::volumioPushState Dec 19 04:40:41 volumiow volumio[7470]: info: CoreStateMachine::updateTrackBlock Dec 19 04:40:41 volumiow volumio[7470]: info: CorePlayQueue::getTrackBlock Dec 19 04:40:41 volumiow volumio[7470]: info: CoreCommandRouter::volumioRetrievevolume Dec 19 04:40:41 volumiow volumio[7470]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Dec 19 04:40:41 volumiow volumio[7470]: info: Reloading queue from file Dec 19 04:40:41 volumiow volumio[7470]: info: CoreStateMachine::setRepeat null single undefined Dec 19 04:40:41 volumiow volumio[7470]: info: CoreStateMachine::pushState Dec 19 04:40:41 volumiow volumio[7470]: info: CorePlayQueue::getTrack 0 Dec 19 04:40:41 volumiow volumio[7470]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 19 04:40:41 volumiow volumio[7470]: info: CoreCommandRouter::volumioPushState Dec 19 04:40:41 volumiow volumio[7470]: info: CoreStateMachine::setRandom null Dec 19 04:40:41 volumiow volumio[7470]: info: CoreStateMachine::pushState Dec 19 04:40:41 volumiow volumio[7470]: info: CorePlayQueue::getTrack 0 Dec 19 04:40:41 volumiow volumio[7470]: info: CoreCommandRouter::volumioPushState Dec 19 04:40:41 volumiow volumio[7470]: info: Setting Device type: Raspberry PI Dec 19 04:40:41 volumiow volumio[7470]: info: VolumeController:: Volume=undefined Mute =false Dec 19 04:40:41 volumiow volumio[7470]: info: CoreStateMachine::pushState Dec 19 04:40:41 volumiow volumio[7470]: info: CorePlayQueue::getTrack 0 Dec 19 04:40:41 volumiow volumio[7470]: info: CoreCommandRouter::volumioPushState Dec 19 04:40:41 volumiow volumio[7470]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Dec 19 04:40:41 volumiow volumio[7470]: info: USB Boot Capable - System SBC Revision found in cpuinfo: 902120 Dec 19 04:40:41 volumiow volumio[7470]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Dec 19 04:40:41 volumiow volumio[7470]: info: Completed loading Core Plugins Dec 19 04:40:41 volumiow volumio[7470]: info: Preparing to generate the ALSA configuration file Dec 19 04:40:41 volumiow volumio[7470]: info: Asound.conf file unchanged, so no further update is needed Dec 19 04:40:41 volumiow volumio[7470]: info: Output device has changed, restarting MPD Dec 19 04:40:41 volumiow volumio[7470]: info: Output device has changed, restarting Shairport Sync Dec 19 04:40:41 volumiow volumio[7470]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:41 volumiow volumio[7470]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 04:40:41 volumiow sudo[7590]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 19 04:40:41 volumiow sudo[7590]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:40:41 volumiow sudo[7590]: pam_unix(sudo:session): session closed for user root Dec 19 04:40:41 volumiow sudo[7592]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 19 04:40:41 volumiow sudo[7592]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:40:41 volumiow volumio[7470]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 19 04:40:41 volumiow volumio[7470]: info: ___________ START PLUGINS ___________ Dec 19 04:40:41 volumiow volumio[7470]: info: ControllerMpd::onStart: Initializing MPD Dec 19 04:40:41 volumiow volumio[7470]: info: Creating MPD Configuration file Dec 19 04:40:41 volumiow systemd[1]: Stopping Music Player Daemon... Dec 19 04:40:41 volumiow volumio[7470]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:41 volumiow volumio[7470]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 04:40:41 volumiow systemd[1]: mpd.service: Succeeded. Dec 19 04:40:41 volumiow systemd[1]: Stopped Music Player Daemon. Dec 19 04:40:41 volumiow sudo[7599]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 19 04:40:41 volumiow sudo[7599]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:40:41 volumiow sudo[7601]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 19 04:40:41 volumiow sudo[7601]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:40:41 volumiow systemd[1]: Starting Music Player Daemon... Dec 19 04:40:41 volumiow sudo[7599]: pam_unix(sudo:session): session closed for user root Dec 19 04:40:41 volumiow volumio[7470]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 19 04:40:41 volumiow volumio[7470]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:41 volumiow volumio[7470]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 04:40:41 volumiow systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Dec 19 04:40:41 volumiow systemd[1]: mpd.service: Succeeded. Dec 19 04:40:41 volumiow systemd[1]: Stopped Music Player Daemon. Dec 19 04:40:41 volumiow systemd[1]: Starting Music Player Daemon... Dec 19 04:40:42 volumiow volumio[7470]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 19 04:40:42 volumiow volumio[7470]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 19 04:40:42 volumiow volumio[7470]: info: [1766140842008] CoreMusicLibrary::Adding element Last_100 Dec 19 04:40:42 volumiow volumio[7470]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 19 04:40:42 volumiow volumio[7470]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 19 04:40:42 volumiow volumio[7470]: info: [1766140842026] CoreMusicLibrary::Adding element Webradio Dec 19 04:40:42 volumiow volumio[7470]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 19 04:40:42 volumiow volumio[7470]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 19 04:40:42 volumiow volumio[7470]: info: Initializing BBC Radios Dec 19 04:40:42 volumiow wpa_supplicant[739]: wlan0: Failed to initiate sched scan Dec 19 04:40:42 volumiow volumio[7470]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory Dec 19 04:40:42 volumiow volumio[7470]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 04:40:42 volumiow volumio[7470]: Starting albumart workers Dec 19 04:40:42 volumiow sudo[7611]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 19 04:40:42 volumiow sudo[7611]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:40:42 volumiow sudo[7611]: pam_unix(sudo:session): session closed for user root Dec 19 04:40:42 volumiow volumio[7470]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 19 04:40:42 volumiow volumio[7470]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 04:40:42 volumiow volumio[7470]: Starting albumart workers Dec 19 04:40:42 volumiow volumio[7470]: info: [squeezelite_mc] Starting proxy server... Dec 19 04:40:42 volumiow volumio[7470]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 19 04:40:42 volumiow volumio[7470]: Starting albumart workers Dec 19 04:40:42 volumiow volumio[7470]: info: [1766140842224] CoreMusicLibrary::Adding element Radio Paradise Dec 19 04:40:42 volumiow volumio[7470]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 19 04:40:42 volumiow volumio[7470]: Cannot find translation for source Radio Paradise Dec 19 04:40:42 volumiow volumio[7470]: info: Volumio Calling Home Dec 19 04:40:42 volumiow volumio[7470]: info: [squeezelite_mc] Proxy server started on port 35879 Dec 19 04:40:42 volumiow volumio[7470]: info: CoreCommandRouter::volumioRetrievevolume Dec 19 04:40:43 volumiow volumio[7470]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Dec 19 04:40:43 volumiow volumio[7470]: info: MPD Permissions set Dec 19 04:40:43 volumiow volumio[7470]: info: MPD Permissions set Dec 19 04:40:43 volumiow volumio[7470]: info: VolumeController:: Volume=undefined Mute =false Dec 19 04:40:43 volumiow volumio[7470]: info: CoreStateMachine::pushState Dec 19 04:40:43 volumiow volumio[7470]: info: CorePlayQueue::getTrack 0 Dec 19 04:40:43 volumiow volumio[7470]: info: CoreCommandRouter::volumioPushState Dec 19 04:40:43 volumiow volumio[7470]: info: [squeezelite_mc] Server discovery started Dec 19 04:40:43 volumiow volumio[7470]: info: [squeezelite_mc] Player finder started Dec 19 04:40:43 volumiow volumio[7470]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:43 volumiow volumio[7470]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:43 volumiow volumio[7470]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:43 volumiow volumio[7470]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 19 04:40:43 volumiow volumio[7470]: info: [squeezelite_mc] Executing aplay -D hw:5 --nonblock -f MPEG /dev/zero 2>&1 || true Dec 19 04:40:43 volumiow volumio[7470]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 19 04:40:43 volumiow volumio[7470]: Error: send ENETUNREACH 255.255.255.255:3483 Dec 19 04:40:43 volumiow volumio[7470]: at doSend (dgram.js:692:16) Dec 19 04:40:43 volumiow volumio[7470]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:430:12) Dec 19 04:40:43 volumiow volumio[7470]: at afterDns (dgram.js:638:5) Dec 19 04:40:43 volumiow volumio[7470]: at processTicksAndRejections (internal/process/task_queues.js:81:21) { Dec 19 04:40:43 volumiow volumio[7470]: errno: -101, Dec 19 04:40:43 volumiow volumio[7470]: code: 'ENETUNREACH', Dec 19 04:40:43 volumiow volumio[7470]: syscall: 'send', Dec 19 04:40:43 volumiow volumio[7470]: address: '255.255.255.255', Dec 19 04:40:43 volumiow volumio[7470]: port: 3483 Dec 19 04:40:43 volumiow volumio[7470]: } Dec 19 04:40:43 volumiow volumio[7470]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 19 04:40:43 volumiow volumio-time-update[492]: volumio-time-update-util: Fetching time from Volumio... Dec 19 04:40:43 volumiow volumio-time-update[492]: volumio-time-update-util: Date not found in response Dec 19 04:40:43 volumiow volumio-time-update[492]: volumio-time-update-util: Retrying in 5 seconds... Dec 19 04:40:44 volumiow sudo[7669]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-19 04:39 Dec 19 04:40:44 volumiow sudo[7669]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:40:44 volumiow mpd[7621]: Dec 19 04:40 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 19 04:40:44 volumiow systemd[1]: Started Music Player Daemon. Dec 19 04:40:44 volumiow sudo[7601]: pam_unix(sudo:session): session closed for user root Dec 19 04:40:44 volumiow sudo[7592]: pam_unix(sudo:session): session closed for user root Dec 19 04:40:44 volumiow sudo[7669]: pam_unix(sudo:session): session closed for user root Dec 19 04:40:44 volumiow volumio-remote-updater[518]: [2025-12-19 04:40:44] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Dec 19 04:40:44 volumiow volumio-remote-updater[518]: [2025-12-19 04:40:44] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Dec 19 04:40:44 volumiow systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Dec 19 04:40:44 volumiow systemd[1]: volumio.service: Failed with result 'exit-code'. Dec 19 04:40:44 volumiow systemd[1]: Started dynamicswap service. Dec 19 04:40:44 volumiow systemd[1]: dynamicswap.service: Succeeded. Dec 19 04:40:44 volumiow systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Dec 19 04:40:44 volumiow systemd[1]: volumio.service: Scheduled restart job, restart counter is at 31. Dec 19 04:40:44 volumiow systemd[1]: Started dynamicswap service. Dec 19 04:40:44 volumiow systemd[1]: Stopped Volumio Backend Module. Dec 19 04:40:44 volumiow systemd[1]: Started Volumio Backend Module. Dec 19 04:40:44 volumiow systemd[1]: dynamicswap.service: Succeeded. Dec 19 04:40:46 volumiow volumio[7685]: info: ------------------------------------------- Dec 19 04:40:46 volumiow volumio[7685]: info: ----- Volumio3 ---- Dec 19 04:40:46 volumiow volumio[7685]: info: ------------------------------------------- Dec 19 04:40:46 volumiow volumio[7685]: info: ----- System startup ---- Dec 19 04:40:46 volumiow volumio[7685]: info: ------------------------------------------- Dec 19 04:40:47 volumiow volumio[7685]: info: MYVOLUMIO Environment detected Dec 19 04:40:47 volumiow volumio[7685]: info: Plugin folders cleanup Dec 19 04:40:47 volumiow volumio[7685]: info: Scanning into folder /volumio/app/plugins/ Dec 19 04:40:47 volumiow volumio[7685]: info: Scanning category audio_interface Dec 19 04:40:47 volumiow volumio[7685]: info: Scanning category miscellanea Dec 19 04:40:47 volumiow volumio[7685]: info: Scanning category music_service Dec 19 04:40:47 volumiow volumio[7685]: info: Scanning category plugins.json Dec 19 04:40:47 volumiow volumio[7685]: info: Scanning category system_controller Dec 19 04:40:47 volumiow volumio[7685]: info: Scanning category user_interface Dec 19 04:40:47 volumiow volumio[7685]: info: Scanning into folder /data/plugins/ Dec 19 04:40:47 volumiow volumio[7685]: info: Scanning category music_service Dec 19 04:40:47 volumiow volumio[7685]: info: Plugin folders cleanup completed Dec 19 04:40:47 volumiow volumio[7685]: info: ------------------------------------------- Dec 19 04:40:47 volumiow volumio[7685]: info: ----- Core plugins startup ---- Dec 19 04:40:47 volumiow volumio[7685]: info: ------------------------------------------- Dec 19 04:40:47 volumiow volumio[7685]: info: Loading plugins from folder /volumio/app/plugins/ Dec 19 04:40:47 volumiow volumio[7685]: info: Adding plugin upnp to MyMusic Plugins Dec 19 04:40:47 volumiow volumio[7685]: info: Adding plugin airplay_emulation to MyMusic Plugins Dec 19 04:40:47 volumiow volumio[7685]: info: Adding plugin upnp_browser to MyMusic Plugins Dec 19 04:40:47 volumiow volumio[7685]: info: Loading plugins from folder /data/plugins/ Dec 19 04:40:47 volumiow volumio[7685]: info: Loading plugin "system"... Dec 19 04:40:47 volumiow wpa_supplicant[739]: wlan0: Failed to initiate sched scan Dec 19 04:40:47 volumiow volumio[7685]: info: Loading plugin "appearance"... Dec 19 04:40:48 volumiow volumio[7685]: info: Loading plugin "network"... Dec 19 04:40:48 volumiow volumio[7685]: info: Refreshing Cached IP Addresses Dec 19 04:40:48 volumiow sudo[7712]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 19 04:40:48 volumiow sudo[7712]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:40:48 volumiow sudo[7714]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 19 04:40:48 volumiow sudo[7714]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:40:48 volumiow sudo[7714]: pam_unix(sudo:session): session closed for user root Dec 19 04:40:48 volumiow sudo[7712]: pam_unix(sudo:session): session closed for user root Dec 19 04:40:48 volumiow volumio[7685]: info: Loading plugin "services"... Dec 19 04:40:48 volumiow volumio[7685]: info: Loading plugin "alsa_controller"... Dec 19 04:40:48 volumiow volumio-time-update[492]: volumio-time-update-util: Fetching time from Volumio... Dec 19 04:40:48 volumiow sudo[7728]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Dec 19 04:40:48 volumiow sudo[7728]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:40:49 volumiow volumio-time-update[492]: volumio-time-update-util: Date not found in response Dec 19 04:40:49 volumiow volumio-time-update[492]: volumio-time-update-util: Retrying in 5 seconds... Dec 19 04:40:49 volumiow volumio[7685]: warn: Unable to locate the audio output device E30. Please configure a valid output device. Dec 19 04:40:49 volumiow volumio[7685]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 19 04:40:49 volumiow volumio[7685]: info: Loading plugin "wizard"... Dec 19 04:40:49 volumiow volumio[7685]: info: Loading plugin "networkfs"... Dec 19 04:40:49 volumiow sudo[7745]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=nouser,password=nouser,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=3.11 //172.16.1.11/Audio\\High Resolution\\DSF /mnt/NAS/DSF Dec 19 04:40:49 volumiow sudo[7745]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:40:49 volumiow kernel: CIFS: Attempting to mount //172.16.1.11/Audio/High Resolution/DSF Dec 19 04:40:49 volumiow volumio[7685]: info: Starting Udev Watcher for removable devices Dec 19 04:40:49 volumiow sudo[7747]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=nouser,password=nouser,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=3.11 //172.16.1.11/Audio\\High Resolution\\SACD /mnt/NAS/SACD Dec 19 04:40:49 volumiow sudo[7747]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:40:49 volumiow kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Dec 19 04:40:49 volumiow kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Dec 19 04:40:49 volumiow sudo[7745]: pam_unix(sudo:session): session closed for user root Dec 19 04:40:49 volumiow sudo[7747]: pam_unix(sudo:session): session closed for user root Dec 19 04:40:49 volumiow sudo[7752]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=nouser,password=nouser,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=3.11 //172.16.1.11/Audio\\High Resolution\\24 Bit\\%24bit-88Khz (plus) /mnt/NAS/24bit_88khz_+ Dec 19 04:40:49 volumiow sudo[7752]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:40:49 volumiow kernel: CIFS: Attempting to mount //172.16.1.11/Audio/High Resolution/SACD Dec 19 04:40:49 volumiow kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Dec 19 04:40:49 volumiow kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Dec 19 04:40:49 volumiow kernel: CIFS: Attempting to mount //172.16.1.11/Audio/High Resolution/24 Bit/%24bit-88Khz (plus) Dec 19 04:40:49 volumiow kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Dec 19 04:40:49 volumiow kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Dec 19 04:40:49 volumiow volumio[7685]: info: Ignoring mount for partition: boot Dec 19 04:40:49 volumiow volumio[7685]: info: Ignoring mount for partition: volumio Dec 19 04:40:49 volumiow volumio[7685]: info: Ignoring mount for partition: volumio_data Dec 19 04:40:49 volumiow volumio[7685]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 19 04:40:49 volumiow sudo[7752]: pam_unix(sudo:session): session closed for user root Dec 19 04:40:49 volumiow volumio[7685]: info: Loading plugin "volumio_command_line_client"... Dec 19 04:40:49 volumiow volumio[7685]: info: Plugin upnp is not enabled Dec 19 04:40:49 volumiow volumio[7685]: info: Loading plugin "my_music"... Dec 19 04:40:49 volumiow volumio[7685]: info: Loading plugin "mpd"... Dec 19 04:40:49 volumiow volumio-remote-updater[518]: [2025-12-19 04:40:49] [connect] Successful connection Dec 19 04:40:49 volumiow volumio[7685]: info: Plugin upnp_browser is not enabled Dec 19 04:40:49 volumiow volumio[7685]: info: Loading plugin "alarm-clock"... Dec 19 04:40:49 volumiow sudo[7728]: pam_unix(sudo:session): session closed for user root Dec 19 04:40:49 volumiow volumio[7685]: info: Loading plugin "airplay_emulation"... Dec 19 04:40:49 volumiow volumio[7685]: info: Starting Shairport Sync Dec 19 04:40:49 volumiow volumio[7685]: info: Loading plugin "last_100"... Dec 19 04:40:49 volumiow volumio[7685]: info: Loading plugin "webradio"... Dec 19 04:40:50 volumiow volumio[7685]: info: Loading plugin "i2s_dacs"... Dec 19 04:40:50 volumiow volumio[7685]: info: I2S DAC not set, start Auto-detection Dec 19 04:40:50 volumiow volumio[7685]: info: Loading plugin "volumiodiscovery"... Dec 19 04:40:50 volumiow volumio[7685]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 19 04:40:50 volumiow volumio[7685]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 19 04:40:50 volumiow volumio[7685]: *** WARNING *** For more information see Dec 19 04:40:50 volumiow node[7685]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 19 04:40:50 volumiow volumio[7685]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 19 04:40:50 volumiow volumio[7685]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 19 04:40:50 volumiow volumio[7685]: *** WARNING *** For more information see Dec 19 04:40:50 volumiow node[7685]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 19 04:40:50 volumiow node[7685]: *** WARNING *** For more information see Dec 19 04:40:50 volumiow node[7685]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 19 04:40:50 volumiow node[7685]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 19 04:40:50 volumiow node[7685]: *** WARNING *** For more information see Dec 19 04:40:50 volumiow volumio[7685]: info: Applying required configuration parameters for plugin volumiodiscovery Dec 19 04:40:50 volumiow volumio[7685]: info: Discovery: Started advertising with name: VolumioW Dec 19 04:40:50 volumiow volumio[7685]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 19 04:40:50 volumiow volumio[7685]: info: Loading plugin "squeezelite_mc"... Dec 19 04:40:51 volumiow volumio[7685]: info: Loading plugin "outputs"... Dec 19 04:40:51 volumiow volumio[7685]: info: Loading plugin "albumart"... Dec 19 04:40:51 volumiow volumio[7685]: info: Plugin example_plugin is not enabled Dec 19 04:40:51 volumiow volumio[7685]: info: Loading plugin "inputs"... Dec 19 04:40:51 volumiow volumio[7685]: info: Loading plugin "updater_comm"... Dec 19 04:40:51 volumiow volumio[7685]: info: Plugin mpdemulation is not enabled Dec 19 04:40:51 volumiow volumio[7685]: info: Loading plugin "rest_api"... Dec 19 04:40:51 volumiow volumio[7685]: info: Loading plugin "websocket"... Dec 19 04:40:51 volumiow volumio[7685]: info: Starting Socket.io Server version 2.3.0 Dec 19 04:40:51 volumiow volumio[7685]: info: Loading plugin "radio_paradise"... Dec 19 04:40:51 volumiow volumio[7685]: Forking 3 albumart workers Dec 19 04:40:51 volumiow volumio[7685]: info: Applying required configuration parameters for plugin radio_paradise Dec 19 04:40:51 volumiow volumio[7685]: info: [1766140851765] [RadioParadise] API delay: 5 Dec 19 04:40:51 volumiow volumio[7685]: info: Loading i18n strings for locale en Dec 19 04:40:51 volumiow volumio[7685]: Updating browse sources language Dec 19 04:40:51 volumiow volumio[7685]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 19 04:40:52 volumiow volumio[7685]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 19 04:40:52 volumiow volumio[7685]: info: CoreCommandRouter::initPlayerControls Dec 19 04:40:52 volumiow volumio[7685]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:52 volumiow volumio[7685]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:52 volumiow volumio[7685]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:52 volumiow volumio[7685]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:52 volumiow volumio[7685]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:52 volumiow volumio[7685]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:52 volumiow volumio[7685]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:52 volumiow volumio[7685]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:52 volumiow volumio[7685]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 19 04:40:52 volumiow volumio[7685]: Express server listening on port 3000 Dec 19 04:40:52 volumiow volumio[7685]: [Metrics] WebUI: 6s 68.16ms Dec 19 04:40:52 volumiow volumio[7685]: info: CoreStateMachine::resetVolumioState Dec 19 04:40:52 volumiow volumio[7685]: info: CoreStateMachine::getcurrentVolume Dec 19 04:40:52 volumiow volumio[7685]: info: CoreCommandRouter::volumioRetrievevolume Dec 19 04:40:52 volumiow volumio[7685]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 04:40:52 volumiow volumio[7685]: info: Volumio Network Manager: Network status updated: 0 Dec 19 04:40:52 volumiow volumio[7685]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Dec 19 04:40:52 volumiow volumio[7685]: info: Cannot mount NAS 24bit_88khz_+ at system boot, trial number 1 ,retrying in 5 seconds Dec 19 04:40:52 volumiow volumio[7685]: info: Cannot mount NAS SACD at system boot, trial number 1 ,retrying in 5 seconds Dec 19 04:40:52 volumiow volumio[7685]: info: Cannot mount NAS DSF at system boot, trial number 1 ,retrying in 5 seconds Dec 19 04:40:52 volumiow volumio-remote-updater[518]: [2025-12-19 04:40:52] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1766140849 101 Dec 19 04:40:52 volumiow volumio[7685]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 1 Dec 19 04:40:52 volumiow volumio[7685]: info: VolumeController:: Volume=undefined Mute =false Dec 19 04:40:52 volumiow volumio[7685]: info: CoreStateMachine::pushState Dec 19 04:40:52 volumiow volumio[7685]: info: CorePlayQueue::getTrack 0 Dec 19 04:40:52 volumiow volumio[7685]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 19 04:40:52 volumiow volumio[7685]: info: CoreCommandRouter::volumioPushState Dec 19 04:40:52 volumiow volumio[7685]: info: CoreStateMachine::updateTrackBlock Dec 19 04:40:52 volumiow volumio[7685]: info: CorePlayQueue::getTrackBlock Dec 19 04:40:52 volumiow volumio[7685]: info: CoreCommandRouter::volumioRetrievevolume Dec 19 04:40:52 volumiow volumio[7685]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Dec 19 04:40:52 volumiow volumio[7685]: info: Reloading queue from file Dec 19 04:40:52 volumiow volumio[7685]: info: CoreStateMachine::setRepeat null single undefined Dec 19 04:40:52 volumiow volumio[7685]: info: CoreStateMachine::pushState Dec 19 04:40:52 volumiow volumio[7685]: info: CorePlayQueue::getTrack 0 Dec 19 04:40:52 volumiow volumio[7685]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 19 04:40:52 volumiow volumio[7685]: info: CoreCommandRouter::volumioPushState Dec 19 04:40:52 volumiow volumio[7685]: info: CoreStateMachine::setRandom null Dec 19 04:40:52 volumiow volumio[7685]: info: CoreStateMachine::pushState Dec 19 04:40:52 volumiow volumio[7685]: info: CorePlayQueue::getTrack 0 Dec 19 04:40:52 volumiow volumio[7685]: info: CoreCommandRouter::volumioPushState Dec 19 04:40:52 volumiow volumio[7685]: info: Setting Device type: Raspberry PI Dec 19 04:40:52 volumiow volumio[7685]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Dec 19 04:40:52 volumiow volumio[7685]: info: USB Boot Capable - System SBC Revision found in cpuinfo: 902120 Dec 19 04:40:52 volumiow volumio[7685]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Dec 19 04:40:52 volumiow volumio[7685]: info: VolumeController:: Volume=undefined Mute =false Dec 19 04:40:52 volumiow volumio[7685]: info: CoreStateMachine::pushState Dec 19 04:40:52 volumiow volumio[7685]: info: CorePlayQueue::getTrack 0 Dec 19 04:40:52 volumiow volumio[7685]: info: CoreCommandRouter::volumioPushState Dec 19 04:40:52 volumiow volumio[7685]: info: Completed loading Core Plugins Dec 19 04:40:52 volumiow volumio[7685]: info: Preparing to generate the ALSA configuration file Dec 19 04:40:52 volumiow volumio[7685]: info: Asound.conf file unchanged, so no further update is needed Dec 19 04:40:52 volumiow volumio[7685]: info: Output device has changed, restarting MPD Dec 19 04:40:52 volumiow sudo[7801]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 19 04:40:52 volumiow sudo[7801]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:40:52 volumiow volumio[7685]: info: Output device has changed, restarting Shairport Sync Dec 19 04:40:52 volumiow volumio[7685]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:52 volumiow volumio[7685]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 04:40:52 volumiow sudo[7801]: pam_unix(sudo:session): session closed for user root Dec 19 04:40:52 volumiow sudo[7803]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 19 04:40:52 volumiow sudo[7803]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:40:52 volumiow volumio[7685]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 19 04:40:52 volumiow volumio[7685]: info: ___________ START PLUGINS ___________ Dec 19 04:40:52 volumiow systemd[1]: Stopping Music Player Daemon... Dec 19 04:40:52 volumiow volumio[7685]: info: ControllerMpd::onStart: Initializing MPD Dec 19 04:40:52 volumiow volumio[7685]: info: Creating MPD Configuration file Dec 19 04:40:52 volumiow systemd[1]: mpd.service: Succeeded. Dec 19 04:40:52 volumiow systemd[1]: Stopped Music Player Daemon. Dec 19 04:40:52 volumiow volumio[7685]: Starting albumart workers Dec 19 04:40:52 volumiow systemd[1]: Starting Music Player Daemon... Dec 19 04:40:52 volumiow sudo[7811]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 19 04:40:52 volumiow sudo[7811]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:40:52 volumiow sudo[7811]: pam_unix(sudo:session): session closed for user root Dec 19 04:40:52 volumiow volumio[7685]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:52 volumiow volumio[7685]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 04:40:52 volumiow sudo[7814]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 19 04:40:52 volumiow sudo[7814]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:40:53 volumiow systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Dec 19 04:40:53 volumiow systemd[1]: mpd.service: Succeeded. Dec 19 04:40:53 volumiow systemd[1]: Stopped Music Player Daemon. Dec 19 04:40:53 volumiow volumio[7685]: Starting albumart workers Dec 19 04:40:53 volumiow volumio[7685]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 19 04:40:53 volumiow volumio[7685]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:53 volumiow volumio[7685]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 04:40:53 volumiow volumio[7685]: Starting albumart workers Dec 19 04:40:53 volumiow systemd[1]: Starting Music Player Daemon... Dec 19 04:40:53 volumiow volumio[7685]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 19 04:40:53 volumiow volumio[7685]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 19 04:40:53 volumiow volumio[7685]: info: [1766140853170] CoreMusicLibrary::Adding element Last_100 Dec 19 04:40:53 volumiow volumio[7685]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 19 04:40:53 volumiow volumio[7685]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 19 04:40:53 volumiow volumio[7685]: info: [1766140853177] CoreMusicLibrary::Adding element Webradio Dec 19 04:40:53 volumiow volumio[7685]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 19 04:40:53 volumiow volumio[7685]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 19 04:40:53 volumiow volumio[7685]: info: Initializing BBC Radios Dec 19 04:40:53 volumiow volumio[7685]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory Dec 19 04:40:53 volumiow volumio[7685]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 04:40:53 volumiow sudo[7819]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 19 04:40:53 volumiow sudo[7819]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:40:53 volumiow sudo[7819]: pam_unix(sudo:session): session closed for user root Dec 19 04:40:53 volumiow wpa_supplicant[739]: wlan0: Failed to initiate sched scan Dec 19 04:40:53 volumiow volumio[7685]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 19 04:40:53 volumiow volumio[7685]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 04:40:53 volumiow volumio[7685]: info: [squeezelite_mc] Starting proxy server... Dec 19 04:40:53 volumiow volumio[7685]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 19 04:40:53 volumiow volumio[7685]: info: [1766140853483] CoreMusicLibrary::Adding element Radio Paradise Dec 19 04:40:53 volumiow volumio[7685]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 19 04:40:53 volumiow volumio[7685]: Cannot find translation for source Radio Paradise Dec 19 04:40:53 volumiow volumio[7685]: info: Volumio Calling Home Dec 19 04:40:53 volumiow volumio[7685]: info: [squeezelite_mc] Proxy server started on port 37961 Dec 19 04:40:54 volumiow volumio-time-update[492]: volumio-time-update-util: Fetching time from Volumio... Dec 19 04:40:54 volumiow volumio-time-update[492]: volumio-time-update-util: Date not found in response Dec 19 04:40:54 volumiow volumio-time-update[492]: volumio-time-update-util: Retrying in 5 seconds... Dec 19 04:40:54 volumiow volumio[7685]: info: CoreCommandRouter::volumioRetrievevolume Dec 19 04:40:54 volumiow volumio[7685]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Dec 19 04:40:54 volumiow volumio[7685]: info: MPD Permissions set Dec 19 04:40:54 volumiow volumio[7685]: info: MPD Permissions set Dec 19 04:40:54 volumiow volumio[7685]: info: VolumeController:: Volume=undefined Mute =false Dec 19 04:40:54 volumiow volumio[7685]: info: CoreStateMachine::pushState Dec 19 04:40:54 volumiow volumio[7685]: info: CorePlayQueue::getTrack 0 Dec 19 04:40:54 volumiow volumio[7685]: info: CoreCommandRouter::volumioPushState Dec 19 04:40:54 volumiow volumio[7685]: info: [squeezelite_mc] Server discovery started Dec 19 04:40:54 volumiow volumio[7685]: info: [squeezelite_mc] Player finder started Dec 19 04:40:54 volumiow volumio[7685]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:54 volumiow volumio[7685]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:54 volumiow volumio[7685]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:40:54 volumiow volumio[7685]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 19 04:40:54 volumiow volumio[7685]: info: [squeezelite_mc] Executing aplay -D hw:5 --nonblock -f MPEG /dev/zero 2>&1 || true Dec 19 04:40:54 volumiow volumio[7685]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 19 04:40:54 volumiow volumio[7685]: Error: send ENETUNREACH 255.255.255.255:3483 Dec 19 04:40:54 volumiow volumio[7685]: at doSend (dgram.js:692:16) Dec 19 04:40:54 volumiow volumio[7685]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:430:12) Dec 19 04:40:54 volumiow volumio[7685]: at afterDns (dgram.js:638:5) Dec 19 04:40:54 volumiow volumio[7685]: at processTicksAndRejections (internal/process/task_queues.js:81:21) { Dec 19 04:40:54 volumiow volumio[7685]: errno: -101, Dec 19 04:40:54 volumiow volumio[7685]: code: 'ENETUNREACH', Dec 19 04:40:54 volumiow volumio[7685]: syscall: 'send', Dec 19 04:40:54 volumiow volumio[7685]: address: '255.255.255.255', Dec 19 04:40:54 volumiow volumio[7685]: port: 3483 Dec 19 04:40:54 volumiow volumio[7685]: } Dec 19 04:40:54 volumiow volumio[7685]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 19 04:40:55 volumiow sudo[7881]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-19 04:39 Dec 19 04:40:55 volumiow sudo[7881]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:40:55 volumiow mpd[7831]: Dec 19 04:40 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 19 04:40:55 volumiow sudo[7881]: pam_unix(sudo:session): session closed for user root Dec 19 04:40:55 volumiow systemd[1]: Started Music Player Daemon. Dec 19 04:40:55 volumiow sudo[7803]: pam_unix(sudo:session): session closed for user root Dec 19 04:40:55 volumiow sudo[7814]: pam_unix(sudo:session): session closed for user root Dec 19 04:40:55 volumiow volumio-remote-updater[518]: [2025-12-19 04:40:55] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Dec 19 04:40:55 volumiow volumio-remote-updater[518]: [2025-12-19 04:40:55] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Dec 19 04:40:55 volumiow systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Dec 19 04:40:55 volumiow systemd[1]: volumio.service: Failed with result 'exit-code'. Dec 19 04:40:55 volumiow systemd[1]: Started dynamicswap service. Dec 19 04:40:55 volumiow systemd[1]: dynamicswap.service: Succeeded. Dec 19 04:40:55 volumiow systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Dec 19 04:40:55 volumiow systemd[1]: volumio.service: Scheduled restart job, restart counter is at 32. Dec 19 04:40:55 volumiow systemd[1]: Started dynamicswap service. Dec 19 04:40:55 volumiow systemd[1]: Stopped Volumio Backend Module. Dec 19 04:40:55 volumiow systemd[1]: Started Volumio Backend Module. Dec 19 04:40:55 volumiow systemd[1]: dynamicswap.service: Succeeded. Dec 19 04:40:57 volumiow volumio[7897]: info: ------------------------------------------- Dec 19 04:40:57 volumiow volumio[7897]: info: ----- Volumio3 ---- Dec 19 04:40:57 volumiow volumio[7897]: info: ------------------------------------------- Dec 19 04:40:57 volumiow volumio[7897]: info: ----- System startup ---- Dec 19 04:40:57 volumiow volumio[7897]: info: ------------------------------------------- Dec 19 04:40:58 volumiow volumio[7897]: info: MYVOLUMIO Environment detected Dec 19 04:40:58 volumiow volumio[7897]: info: Plugin folders cleanup Dec 19 04:40:58 volumiow volumio[7897]: info: Scanning into folder /volumio/app/plugins/ Dec 19 04:40:58 volumiow volumio[7897]: info: Scanning category audio_interface Dec 19 04:40:58 volumiow volumio[7897]: info: Scanning category miscellanea Dec 19 04:40:58 volumiow volumio[7897]: info: Scanning category music_service Dec 19 04:40:58 volumiow volumio[7897]: info: Scanning category plugins.json Dec 19 04:40:58 volumiow volumio[7897]: info: Scanning category system_controller Dec 19 04:40:58 volumiow volumio[7897]: info: Scanning category user_interface Dec 19 04:40:58 volumiow volumio[7897]: info: Scanning into folder /data/plugins/ Dec 19 04:40:58 volumiow volumio[7897]: info: Scanning category music_service Dec 19 04:40:58 volumiow volumio[7897]: info: Plugin folders cleanup completed Dec 19 04:40:58 volumiow volumio[7897]: info: ------------------------------------------- Dec 19 04:40:58 volumiow volumio[7897]: info: ----- Core plugins startup ---- Dec 19 04:40:58 volumiow volumio[7897]: info: ------------------------------------------- Dec 19 04:40:58 volumiow volumio[7897]: info: Loading plugins from folder /volumio/app/plugins/ Dec 19 04:40:58 volumiow volumio[7897]: info: Adding plugin upnp to MyMusic Plugins Dec 19 04:40:58 volumiow volumio[7897]: info: Adding plugin airplay_emulation to MyMusic Plugins Dec 19 04:40:58 volumiow volumio[7897]: info: Adding plugin upnp_browser to MyMusic Plugins Dec 19 04:40:58 volumiow volumio[7897]: info: Loading plugins from folder /data/plugins/ Dec 19 04:40:58 volumiow volumio[7897]: info: Loading plugin "system"... Dec 19 04:40:58 volumiow volumio[7897]: info: Loading plugin "appearance"... Dec 19 04:40:58 volumiow wpa_supplicant[739]: wlan0: Trying to associate with SSID 'SYNACK' Dec 19 04:40:59 volumiow volumio-time-update[492]: volumio-time-update-util: Fetching time from Volumio... Dec 19 04:40:59 volumiow volumio-time-update[492]: volumio-time-update-util: Date not found in response Dec 19 04:40:59 volumiow volumio-time-update[492]: volumio-time-update-util: Retrying in 5 seconds... Dec 19 04:40:59 volumiow wpa_supplicant[739]: wlan0: CTRL-EVENT-ASSOC-REJECT bssid=00:00:00:00:00:00 status_code=16 Dec 19 04:40:59 volumiow volumio[7897]: info: Loading plugin "network"... Dec 19 04:40:59 volumiow volumio[7897]: info: Refreshing Cached IP Addresses Dec 19 04:40:59 volumiow sudo[7929]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 19 04:40:59 volumiow sudo[7929]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:40:59 volumiow sudo[7931]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 19 04:40:59 volumiow sudo[7931]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:40:59 volumiow sudo[7931]: pam_unix(sudo:session): session closed for user root Dec 19 04:41:00 volumiow volumio[7897]: info: Loading plugin "services"... Dec 19 04:41:00 volumiow sudo[7929]: pam_unix(sudo:session): session closed for user root Dec 19 04:41:00 volumiow volumio[7897]: info: Loading plugin "alsa_controller"... Dec 19 04:41:00 volumiow wpa_supplicant[739]: wlan0: Trying to associate with SSID 'SYNACK' Dec 19 04:41:00 volumiow sudo[7946]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Dec 19 04:41:00 volumiow sudo[7946]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:41:00 volumiow sudo[7946]: pam_unix(sudo:session): session closed for user root Dec 19 04:41:00 volumiow kernel: ieee80211 phy0: brcmf_cfg80211_scan: Connecting: status (3) Dec 19 04:41:00 volumiow volumio[7897]: warn: Unable to locate the audio output device E30. Please configure a valid output device. Dec 19 04:41:00 volumiow volumio[7897]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 19 04:41:00 volumiow volumio[7897]: info: Loading plugin "wizard"... Dec 19 04:41:00 volumiow volumio[7897]: info: Loading plugin "networkfs"... Dec 19 04:41:00 volumiow sudo[7957]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=nouser,password=nouser,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=3.11 //172.16.1.11/Audio\\High Resolution\\DSF /mnt/NAS/DSF Dec 19 04:41:00 volumiow sudo[7957]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:41:00 volumiow sudo[7959]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=nouser,password=nouser,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=3.11 //172.16.1.11/Audio\\High Resolution\\SACD /mnt/NAS/SACD Dec 19 04:41:00 volumiow sudo[7959]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:41:00 volumiow volumio[7897]: info: Starting Udev Watcher for removable devices Dec 19 04:41:00 volumiow kernel: CIFS: Attempting to mount //172.16.1.11/Audio/High Resolution/DSF Dec 19 04:41:00 volumiow kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Dec 19 04:41:00 volumiow kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Dec 19 04:41:00 volumiow sudo[7962]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=nouser,password=nouser,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=3.11 //172.16.1.11/Audio\\High Resolution\\24 Bit\\%24bit-88Khz (plus) /mnt/NAS/24bit_88khz_+ Dec 19 04:41:00 volumiow sudo[7962]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:41:00 volumiow kernel: CIFS: Attempting to mount //172.16.1.11/Audio/High Resolution/SACD Dec 19 04:41:00 volumiow kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Dec 19 04:41:00 volumiow kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Dec 19 04:41:00 volumiow sudo[7959]: pam_unix(sudo:session): session closed for user root Dec 19 04:41:00 volumiow sudo[7957]: pam_unix(sudo:session): session closed for user root Dec 19 04:41:00 volumiow sudo[7962]: pam_unix(sudo:session): session closed for user root Dec 19 04:41:00 volumiow volumio[7897]: info: Ignoring mount for partition: boot Dec 19 04:41:00 volumiow volumio[7897]: info: Ignoring mount for partition: volumio Dec 19 04:41:00 volumiow kernel: CIFS: Attempting to mount //172.16.1.11/Audio/High Resolution/24 Bit/%24bit-88Khz (plus) Dec 19 04:41:00 volumiow kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Dec 19 04:41:00 volumiow kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Dec 19 04:41:00 volumiow volumio[7897]: info: Ignoring mount for partition: volumio_data Dec 19 04:41:00 volumiow volumio[7897]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 19 04:41:00 volumiow volumio[7897]: info: Loading plugin "volumio_command_line_client"... Dec 19 04:41:00 volumiow volumio[7897]: info: Plugin upnp is not enabled Dec 19 04:41:00 volumiow volumio[7897]: info: Loading plugin "my_music"... Dec 19 04:41:00 volumiow volumio[7897]: info: Loading plugin "mpd"... Dec 19 04:41:00 volumiow wpa_supplicant[739]: wlan0: CTRL-EVENT-ASSOC-REJECT bssid=00:00:00:00:00:00 status_code=16 Dec 19 04:41:00 volumiow volumio-remote-updater[518]: [2025-12-19 04:41:00] [connect] Successful connection Dec 19 04:41:00 volumiow volumio[7897]: info: Plugin upnp_browser is not enabled Dec 19 04:41:00 volumiow volumio[7897]: info: Loading plugin "alarm-clock"... Dec 19 04:41:00 volumiow volumio[7897]: info: Loading plugin "airplay_emulation"... Dec 19 04:41:00 volumiow volumio[7897]: info: Starting Shairport Sync Dec 19 04:41:00 volumiow volumio[7897]: info: Loading plugin "last_100"... Dec 19 04:41:00 volumiow volumio[7897]: info: Loading plugin "webradio"... Dec 19 04:41:01 volumiow volumio[7897]: info: Loading plugin "i2s_dacs"... Dec 19 04:41:01 volumiow volumio[7897]: info: I2S DAC not set, start Auto-detection Dec 19 04:41:01 volumiow wpa_supplicant[739]: wlan0: Trying to associate with SSID 'SYNACK' Dec 19 04:41:01 volumiow volumio[7897]: info: Loading plugin "volumiodiscovery"... Dec 19 04:41:01 volumiow volumio[7897]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 19 04:41:01 volumiow volumio[7897]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 19 04:41:01 volumiow node[7897]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 19 04:41:01 volumiow volumio[7897]: *** WARNING *** For more information see Dec 19 04:41:01 volumiow volumio[7897]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 19 04:41:01 volumiow volumio[7897]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 19 04:41:01 volumiow volumio[7897]: *** WARNING *** For more information see Dec 19 04:41:01 volumiow node[7897]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 19 04:41:01 volumiow node[7897]: *** WARNING *** For more information see Dec 19 04:41:01 volumiow node[7897]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 19 04:41:01 volumiow node[7897]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 19 04:41:01 volumiow node[7897]: *** WARNING *** For more information see Dec 19 04:41:01 volumiow volumio[7897]: info: Applying required configuration parameters for plugin volumiodiscovery Dec 19 04:41:01 volumiow volumio[7897]: info: Discovery: Started advertising with name: VolumioW Dec 19 04:41:01 volumiow volumio[7897]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 19 04:41:01 volumiow volumio[7897]: info: Loading plugin "squeezelite_mc"... Dec 19 04:41:01 volumiow wpa_supplicant[739]: wlan0: CTRL-EVENT-ASSOC-REJECT bssid=00:00:00:00:00:00 status_code=16 Dec 19 04:41:01 volumiow ntpd[631]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Dec 19 04:41:02 volumiow volumio[7897]: info: Loading plugin "outputs"... Dec 19 04:41:02 volumiow volumio[7897]: info: Loading plugin "albumart"... Dec 19 04:41:02 volumiow volumio[7897]: info: Plugin example_plugin is not enabled Dec 19 04:41:02 volumiow volumio[7897]: info: Loading plugin "inputs"... Dec 19 04:41:02 volumiow volumio[7897]: info: Loading plugin "updater_comm"... Dec 19 04:41:02 volumiow volumio[7897]: info: Plugin mpdemulation is not enabled Dec 19 04:41:02 volumiow volumio[7897]: info: Loading plugin "rest_api"... Dec 19 04:41:02 volumiow volumio[7897]: info: Loading plugin "websocket"... Dec 19 04:41:02 volumiow volumio[7897]: info: Starting Socket.io Server version 2.3.0 Dec 19 04:41:02 volumiow volumio[7897]: info: Loading plugin "radio_paradise"... Dec 19 04:41:02 volumiow wpa_supplicant[739]: wlan0: Trying to associate with SSID 'SYNACK' Dec 19 04:41:02 volumiow volumio[7897]: Forking 3 albumart workers Dec 19 04:41:02 volumiow volumio[7897]: info: Applying required configuration parameters for plugin radio_paradise Dec 19 04:41:02 volumiow volumio[7897]: info: [1766140862776] [RadioParadise] API delay: 5 Dec 19 04:41:02 volumiow volumio[7897]: info: Loading i18n strings for locale en Dec 19 04:41:02 volumiow volumio[7897]: Updating browse sources language Dec 19 04:41:02 volumiow volumio[7897]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 19 04:41:03 volumiow volumio[7897]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 19 04:41:03 volumiow volumio[7897]: info: CoreCommandRouter::initPlayerControls Dec 19 04:41:03 volumiow volumio[7897]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:41:03 volumiow volumio[7897]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:41:03 volumiow volumio[7897]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:41:03 volumiow volumio[7897]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:41:03 volumiow volumio[7897]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:41:03 volumiow volumio[7897]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:41:03 volumiow volumio[7897]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:41:03 volumiow volumio[7897]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:41:03 volumiow volumio[7897]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 19 04:41:03 volumiow volumio[7897]: Express server listening on port 3000 Dec 19 04:41:03 volumiow volumio[7897]: [Metrics] WebUI: 6s 42.07ms Dec 19 04:41:03 volumiow volumio[7897]: info: CoreStateMachine::resetVolumioState Dec 19 04:41:03 volumiow volumio[7897]: info: CoreStateMachine::getcurrentVolume Dec 19 04:41:03 volumiow volumio[7897]: info: CoreCommandRouter::volumioRetrievevolume Dec 19 04:41:03 volumiow volumio[7897]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 04:41:03 volumiow volumio[7897]: info: Volumio Network Manager: Network status updated: 0 Dec 19 04:41:03 volumiow volumio[7897]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Dec 19 04:41:03 volumiow volumio[7897]: info: Cannot mount NAS 24bit_88khz_+ at system boot, trial number 1 ,retrying in 5 seconds Dec 19 04:41:03 volumiow volumio[7897]: info: Cannot mount NAS SACD at system boot, trial number 1 ,retrying in 5 seconds Dec 19 04:41:03 volumiow volumio[7897]: info: Cannot mount NAS DSF at system boot, trial number 1 ,retrying in 5 seconds Dec 19 04:41:03 volumiow volumio[7897]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Dec 19 04:41:03 volumiow volumio[7897]: wlan0 Interface doesn't support scanning : Resource temporarily unavailable Dec 19 04:41:03 volumiow volumio[7897]: info: Cannot use regular scanning, forcing with ap-force Dec 19 04:41:03 volumiow sudo[8007]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Dec 19 04:41:03 volumiow sudo[8007]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:41:03 volumiow kernel: ieee80211 phy0: brcmf_cfg80211_scan: Connecting: status (3) Dec 19 04:41:03 volumiow sudo[8007]: pam_unix(sudo:session): session closed for user root Dec 19 04:41:03 volumiow volumio[7897]: command failed: Resource temporarily unavailable (-11) Dec 19 04:41:03 volumiow volumio[7897]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Dec 19 04:41:03 volumiow volumio[7897]: command failed: Resource temporarily unavailable (-11) Dec 19 04:41:03 volumiow volumio-remote-updater[518]: [2025-12-19 04:41:03] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1766140860 101 Dec 19 04:41:03 volumiow volumio[7897]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 1 Dec 19 04:41:03 volumiow volumio[7897]: info: VolumeController:: Volume=undefined Mute =false Dec 19 04:41:03 volumiow volumio[7897]: info: CoreStateMachine::pushState Dec 19 04:41:03 volumiow volumio[7897]: info: CorePlayQueue::getTrack 0 Dec 19 04:41:03 volumiow volumio[7897]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 19 04:41:03 volumiow volumio[7897]: info: CoreCommandRouter::volumioPushState Dec 19 04:41:03 volumiow volumio[7897]: info: CoreStateMachine::updateTrackBlock Dec 19 04:41:03 volumiow volumio[7897]: info: CorePlayQueue::getTrackBlock Dec 19 04:41:03 volumiow volumio[7897]: info: CoreCommandRouter::volumioRetrievevolume Dec 19 04:41:03 volumiow volumio[7897]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Dec 19 04:41:03 volumiow volumio[7897]: info: Reloading queue from file Dec 19 04:41:03 volumiow volumio[7897]: info: VolumeController:: Volume=undefined Mute =false Dec 19 04:41:03 volumiow volumio[7897]: info: CoreStateMachine::pushState Dec 19 04:41:03 volumiow volumio[7897]: info: CorePlayQueue::getTrack 0 Dec 19 04:41:03 volumiow volumio[7897]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 19 04:41:03 volumiow volumio[7897]: info: CoreCommandRouter::volumioPushState Dec 19 04:41:03 volumiow volumio[7897]: info: CoreStateMachine::setRepeat null single undefined Dec 19 04:41:03 volumiow volumio[7897]: info: CoreStateMachine::pushState Dec 19 04:41:03 volumiow volumio[7897]: info: CorePlayQueue::getTrack 0 Dec 19 04:41:03 volumiow volumio[7897]: info: CoreCommandRouter::volumioPushState Dec 19 04:41:03 volumiow volumio[7897]: info: CoreStateMachine::setRandom null Dec 19 04:41:03 volumiow volumio[7897]: info: CoreStateMachine::pushState Dec 19 04:41:03 volumiow volumio[7897]: info: CorePlayQueue::getTrack 0 Dec 19 04:41:03 volumiow volumio[7897]: info: CoreCommandRouter::volumioPushState Dec 19 04:41:03 volumiow volumio[7897]: info: Setting Device type: Raspberry PI Dec 19 04:41:03 volumiow volumio[7897]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Dec 19 04:41:03 volumiow volumio[7897]: info: USB Boot Capable - System SBC Revision found in cpuinfo: 902120 Dec 19 04:41:03 volumiow volumio[7897]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Dec 19 04:41:03 volumiow volumio[7897]: info: Completed loading Core Plugins Dec 19 04:41:03 volumiow volumio[7897]: info: Preparing to generate the ALSA configuration file Dec 19 04:41:03 volumiow volumio[7897]: info: Asound.conf file unchanged, so no further update is needed Dec 19 04:41:03 volumiow volumio[7897]: info: Output device has changed, restarting MPD Dec 19 04:41:03 volumiow volumio[7897]: info: Output device has changed, restarting Shairport Sync Dec 19 04:41:03 volumiow volumio[7897]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:41:03 volumiow volumio[7897]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 04:41:03 volumiow sudo[8016]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 19 04:41:03 volumiow sudo[8016]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:41:03 volumiow sudo[8016]: pam_unix(sudo:session): session closed for user root Dec 19 04:41:03 volumiow sudo[8018]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 19 04:41:03 volumiow sudo[8018]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:41:03 volumiow volumio[7897]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 19 04:41:03 volumiow volumio[7897]: info: ___________ START PLUGINS ___________ Dec 19 04:41:03 volumiow volumio[7897]: info: ControllerMpd::onStart: Initializing MPD Dec 19 04:41:03 volumiow volumio[7897]: info: Creating MPD Configuration file Dec 19 04:41:03 volumiow systemd[1]: Stopping Music Player Daemon... Dec 19 04:41:03 volumiow volumio[7897]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:41:03 volumiow volumio[7897]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 04:41:03 volumiow systemd[1]: mpd.service: Succeeded. Dec 19 04:41:03 volumiow systemd[1]: Stopped Music Player Daemon. Dec 19 04:41:03 volumiow sudo[8025]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 19 04:41:03 volumiow sudo[8025]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:41:03 volumiow systemd[1]: Starting Music Player Daemon... Dec 19 04:41:03 volumiow volumio[7897]: Starting albumart workers Dec 19 04:41:03 volumiow sudo[8025]: pam_unix(sudo:session): session closed for user root Dec 19 04:41:03 volumiow volumio[7897]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 19 04:41:03 volumiow volumio[7897]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:41:03 volumiow volumio[7897]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 04:41:03 volumiow sudo[8027]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 19 04:41:03 volumiow sudo[8027]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:41:03 volumiow volumio[7897]: Starting albumart workers Dec 19 04:41:04 volumiow systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Dec 19 04:41:04 volumiow systemd[1]: mpd.service: Succeeded. Dec 19 04:41:04 volumiow systemd[1]: Stopped Music Player Daemon. Dec 19 04:41:04 volumiow systemd[1]: Starting Music Player Daemon... Dec 19 04:41:04 volumiow volumio[7897]: Starting albumart workers Dec 19 04:41:04 volumiow volumio[7897]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 19 04:41:04 volumiow volumio[7897]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 19 04:41:04 volumiow volumio[7897]: info: [1766140864098] CoreMusicLibrary::Adding element Last_100 Dec 19 04:41:04 volumiow volumio[7897]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 19 04:41:04 volumiow volumio[7897]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 19 04:41:04 volumiow volumio[7897]: info: [1766140864105] CoreMusicLibrary::Adding element Webradio Dec 19 04:41:04 volumiow volumio[7897]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 19 04:41:04 volumiow volumio[7897]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 19 04:41:04 volumiow volumio[7897]: info: Initializing BBC Radios Dec 19 04:41:04 volumiow volumio[7897]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory Dec 19 04:41:04 volumiow volumio[7897]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 04:41:04 volumiow volumio-time-update[492]: volumio-time-update-util: Fetching time from Volumio... Dec 19 04:41:04 volumiow volumio-time-update[492]: volumio-time-update-util: Date not found in response Dec 19 04:41:04 volumiow volumio-time-update[492]: volumio-time-update-util: Retrying in 5 seconds... Dec 19 04:41:04 volumiow sudo[8035]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 19 04:41:04 volumiow sudo[8035]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:41:04 volumiow sudo[8035]: pam_unix(sudo:session): session closed for user root Dec 19 04:41:04 volumiow volumio[7897]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 19 04:41:04 volumiow volumio[7897]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 04:41:04 volumiow volumio[7897]: info: [squeezelite_mc] Starting proxy server... Dec 19 04:41:04 volumiow volumio[7897]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 19 04:41:04 volumiow volumio[7897]: info: [1766140864344] CoreMusicLibrary::Adding element Radio Paradise Dec 19 04:41:04 volumiow volumio[7897]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 19 04:41:04 volumiow volumio[7897]: Cannot find translation for source Radio Paradise Dec 19 04:41:04 volumiow volumio[7897]: info: Volumio Calling Home Dec 19 04:41:04 volumiow volumio[7897]: info: [squeezelite_mc] Proxy server started on port 36095 Dec 19 04:41:04 volumiow volumio[7897]: info: CoreCommandRouter::volumioRetrievevolume Dec 19 04:41:04 volumiow ntpd[631]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Dec 19 04:41:05 volumiow volumio[7897]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Dec 19 04:41:05 volumiow volumio[7897]: info: MPD Permissions set Dec 19 04:41:05 volumiow volumio[7897]: info: MPD Permissions set Dec 19 04:41:05 volumiow volumio[7897]: info: VolumeController:: Volume=undefined Mute =false Dec 19 04:41:05 volumiow volumio[7897]: info: CoreStateMachine::pushState Dec 19 04:41:05 volumiow volumio[7897]: info: CorePlayQueue::getTrack 0 Dec 19 04:41:05 volumiow volumio[7897]: info: CoreCommandRouter::volumioPushState Dec 19 04:41:05 volumiow volumio[7897]: info: [squeezelite_mc] Server discovery started Dec 19 04:41:05 volumiow volumio[7897]: info: [squeezelite_mc] Player finder started Dec 19 04:41:05 volumiow volumio[7897]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:41:05 volumiow volumio[7897]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:41:05 volumiow volumio[7897]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:41:05 volumiow volumio[7897]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 19 04:41:05 volumiow volumio[7897]: info: [squeezelite_mc] Executing aplay -D hw:5 --nonblock -f MPEG /dev/zero 2>&1 || true Dec 19 04:41:05 volumiow volumio[7897]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 19 04:41:05 volumiow volumio[7897]: Error: send ENETUNREACH 255.255.255.255:3483 Dec 19 04:41:05 volumiow volumio[7897]: at doSend (dgram.js:692:16) Dec 19 04:41:05 volumiow volumio[7897]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:430:12) Dec 19 04:41:05 volumiow volumio[7897]: at afterDns (dgram.js:638:5) Dec 19 04:41:05 volumiow volumio[7897]: at processTicksAndRejections (internal/process/task_queues.js:81:21) { Dec 19 04:41:05 volumiow volumio[7897]: errno: -101, Dec 19 04:41:05 volumiow volumio[7897]: code: 'ENETUNREACH', Dec 19 04:41:05 volumiow volumio[7897]: syscall: 'send', Dec 19 04:41:05 volumiow volumio[7897]: address: '255.255.255.255', Dec 19 04:41:05 volumiow volumio[7897]: port: 3483 Dec 19 04:41:05 volumiow volumio[7897]: } Dec 19 04:41:05 volumiow volumio[7897]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 19 04:41:05 volumiow dhcpcd[755]: wlan0: carrier acquired Dec 19 04:41:05 volumiow wpa_supplicant[739]: wlan0: Associated with fa:9f:c2:34:23:e9 Dec 19 04:41:05 volumiow wpa_supplicant[739]: wlan0: CTRL-EVENT-CONNECTED - Connection to fa:9f:c2:34:23:e9 completed [id=0 id_str=] Dec 19 04:41:05 volumiow wpa_supplicant[739]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Dec 19 04:41:05 volumiow wpa_supplicant[739]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=CA Dec 19 04:41:05 volumiow dhcpcd[755]: DUID 00:01:00:01:2f:db:09:0b:c8:d7:19:ee:25:73 Dec 19 04:41:05 volumiow dhcpcd[755]: wlan0: IAID 67:94:3f:6e Dec 19 04:41:05 volumiow dhcpcd[755]: wlan0: adding address fe80::15ef:ad89:2bc9:4c12 Dec 19 04:41:05 volumiow dhcpcd[755]: ipv6_addaddr1: Permission denied Dec 19 04:41:05 volumiow dhcpcd[755]: wlan0: carrier lost Dec 19 04:41:05 volumiow dhcpcd[755]: wlan0: carrier acquired Dec 19 04:41:05 volumiow dhcpcd[755]: wlan0: connected to Access Point `SYNACK' Dec 19 04:41:05 volumiow dhcpcd[755]: wlan0: IAID 67:94:3f:6e Dec 19 04:41:05 volumiow dhcpcd[755]: wlan0: rebinding lease of 172.16.1.194 Dec 19 04:41:05 volumiow ntpd[631]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Dec 19 04:41:06 volumiow sudo[8107]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-19 04:40 Dec 19 04:41:06 volumiow dhcpcd[755]: wlan0: soliciting an IPv6 router Dec 19 04:41:06 volumiow sudo[8107]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:41:06 volumiow sudo[8107]: pam_unix(sudo:session): session closed for user root Dec 19 04:41:06 volumiow volumio-remote-updater[518]: [2025-12-19 04:41:06] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Dec 19 04:41:06 volumiow volumio-remote-updater[518]: [2025-12-19 04:41:06] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Dec 19 04:41:06 volumiow systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Dec 19 04:41:06 volumiow sudo[8027]: pam_unix(sudo:session): session closed for user root Dec 19 04:41:06 volumiow sudo[8018]: pam_unix(sudo:session): session closed for user root Dec 19 04:41:06 volumiow systemd[1]: volumio.service: Failed with result 'exit-code'. Dec 19 04:41:06 volumiow mpd[8051]: Dec 19 04:41 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 19 04:41:06 volumiow systemd[1]: Started dynamicswap service. Dec 19 04:41:06 volumiow systemd[1]: Started Music Player Daemon. Dec 19 04:41:06 volumiow systemd[1]: dynamicswap.service: Succeeded. Dec 19 04:41:06 volumiow systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Dec 19 04:41:06 volumiow systemd[1]: volumio.service: Scheduled restart job, restart counter is at 33. Dec 19 04:41:06 volumiow systemd[1]: Stopped Volumio Backend Module. Dec 19 04:41:06 volumiow systemd[1]: Started Volumio Backend Module. Dec 19 04:41:06 volumiow systemd[1]: Started dynamicswap service. Dec 19 04:41:06 volumiow systemd[1]: dynamicswap.service: Succeeded. Dec 19 04:41:07 volumiow ntpd[631]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Dec 19 04:41:08 volumiow volumio[8122]: info: ------------------------------------------- Dec 19 04:41:08 volumiow volumio[8122]: info: ----- Volumio3 ---- Dec 19 04:41:08 volumiow volumio[8122]: info: ------------------------------------------- Dec 19 04:41:08 volumiow volumio[8122]: info: ----- System startup ---- Dec 19 04:41:08 volumiow volumio[8122]: info: ------------------------------------------- Dec 19 04:41:09 volumiow volumio-time-update[492]: volumio-time-update-util: Fetching time from Volumio... Dec 19 04:41:09 volumiow volumio-time-update[492]: volumio-time-update-util: Date not found in response Dec 19 04:41:09 volumiow volumio-time-update[492]: volumio-time-update-util: Retrying in 5 seconds... Dec 19 04:41:09 volumiow volumio[8122]: info: MYVOLUMIO Environment detected Dec 19 04:41:09 volumiow volumio[8122]: info: Plugin folders cleanup Dec 19 04:41:09 volumiow volumio[8122]: info: Scanning into folder /volumio/app/plugins/ Dec 19 04:41:09 volumiow volumio[8122]: info: Scanning category audio_interface Dec 19 04:41:09 volumiow volumio[8122]: info: Scanning category miscellanea Dec 19 04:41:09 volumiow volumio[8122]: info: Scanning category music_service Dec 19 04:41:09 volumiow volumio[8122]: info: Scanning category plugins.json Dec 19 04:41:09 volumiow volumio[8122]: info: Scanning category system_controller Dec 19 04:41:09 volumiow volumio[8122]: info: Scanning category user_interface Dec 19 04:41:09 volumiow volumio[8122]: info: Scanning into folder /data/plugins/ Dec 19 04:41:09 volumiow volumio[8122]: info: Scanning category music_service Dec 19 04:41:09 volumiow volumio[8122]: info: Plugin folders cleanup completed Dec 19 04:41:09 volumiow volumio[8122]: info: ------------------------------------------- Dec 19 04:41:09 volumiow volumio[8122]: info: ----- Core plugins startup ---- Dec 19 04:41:09 volumiow volumio[8122]: info: ------------------------------------------- Dec 19 04:41:09 volumiow volumio[8122]: info: Loading plugins from folder /volumio/app/plugins/ Dec 19 04:41:09 volumiow volumio[8122]: info: Adding plugin upnp to MyMusic Plugins Dec 19 04:41:09 volumiow volumio[8122]: info: Adding plugin airplay_emulation to MyMusic Plugins Dec 19 04:41:09 volumiow volumio[8122]: info: Adding plugin upnp_browser to MyMusic Plugins Dec 19 04:41:09 volumiow volumio[8122]: info: Loading plugins from folder /data/plugins/ Dec 19 04:41:09 volumiow volumio[8122]: info: Loading plugin "system"... Dec 19 04:41:09 volumiow volumio[8122]: info: Loading plugin "appearance"... Dec 19 04:41:10 volumiow dhcpcd[755]: wlan0: probing for an IPv4LL address Dec 19 04:41:10 volumiow dhcpcd[755]: wlan0: DHCP lease expired Dec 19 04:41:10 volumiow dhcpcd[755]: wlan0: soliciting a DHCP lease Dec 19 04:41:10 volumiow volumio[8122]: info: Loading plugin "network"... Dec 19 04:41:10 volumiow volumio[8122]: info: Refreshing Cached IP Addresses Dec 19 04:41:11 volumiow sudo[8163]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 19 04:41:11 volumiow sudo[8163]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:41:11 volumiow sudo[8165]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 19 04:41:11 volumiow sudo[8165]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:41:11 volumiow sudo[8165]: pam_unix(sudo:session): session closed for user root Dec 19 04:41:11 volumiow volumio[8122]: info: Loading plugin "services"... Dec 19 04:41:11 volumiow volumio[8122]: info: Loading plugin "alsa_controller"... Dec 19 04:41:11 volumiow sudo[8163]: pam_unix(sudo:session): session closed for user root Dec 19 04:41:11 volumiow sudo[8176]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Dec 19 04:41:11 volumiow sudo[8176]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:41:11 volumiow volumio[8122]: warn: Unable to locate the audio output device E30. Please configure a valid output device. Dec 19 04:41:11 volumiow volumio[8122]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 19 04:41:11 volumiow volumio[8122]: info: Loading plugin "wizard"... Dec 19 04:41:11 volumiow volumio[8122]: info: Loading plugin "networkfs"... Dec 19 04:41:11 volumiow sudo[8191]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=nouser,password=nouser,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=3.11 //172.16.1.11/Audio\\High Resolution\\DSF /mnt/NAS/DSF Dec 19 04:41:11 volumiow sudo[8191]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:41:11 volumiow sudo[8193]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=nouser,password=nouser,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=3.11 //172.16.1.11/Audio\\High Resolution\\SACD /mnt/NAS/SACD Dec 19 04:41:11 volumiow volumio[8122]: info: Starting Udev Watcher for removable devices Dec 19 04:41:11 volumiow sudo[8193]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:41:11 volumiow kernel: CIFS: Attempting to mount //172.16.1.11/Audio/High Resolution/SACD Dec 19 04:41:11 volumiow kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Dec 19 04:41:11 volumiow kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Dec 19 04:41:11 volumiow sudo[8193]: pam_unix(sudo:session): session closed for user root Dec 19 04:41:11 volumiow sudo[8196]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=nouser,password=nouser,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=3.11 //172.16.1.11/Audio\\High Resolution\\24 Bit\\%24bit-88Khz (plus) /mnt/NAS/24bit_88khz_+ Dec 19 04:41:11 volumiow sudo[8196]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:41:11 volumiow sudo[8191]: pam_unix(sudo:session): session closed for user root Dec 19 04:41:11 volumiow kernel: CIFS: Attempting to mount //172.16.1.11/Audio/High Resolution/DSF Dec 19 04:41:11 volumiow kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Dec 19 04:41:11 volumiow kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Dec 19 04:41:11 volumiow volumio[8122]: info: Ignoring mount for partition: boot Dec 19 04:41:11 volumiow volumio[8122]: info: Ignoring mount for partition: volumio Dec 19 04:41:11 volumiow volumio[8122]: info: Ignoring mount for partition: volumio_data Dec 19 04:41:11 volumiow volumio[8122]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 19 04:41:11 volumiow volumio[8122]: info: Loading plugin "volumio_command_line_client"... Dec 19 04:41:11 volumiow sudo[8196]: pam_unix(sudo:session): session closed for user root Dec 19 04:41:11 volumiow kernel: CIFS: Attempting to mount //172.16.1.11/Audio/High Resolution/24 Bit/%24bit-88Khz (plus) Dec 19 04:41:11 volumiow kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Dec 19 04:41:11 volumiow kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Dec 19 04:41:11 volumiow volumio[8122]: info: Plugin upnp is not enabled Dec 19 04:41:11 volumiow volumio[8122]: info: Loading plugin "my_music"... Dec 19 04:41:11 volumiow volumio[8122]: info: Loading plugin "mpd"... Dec 19 04:41:11 volumiow volumio-remote-updater[518]: [2025-12-19 04:41:11] [connect] Successful connection Dec 19 04:41:11 volumiow volumio[8122]: info: Plugin upnp_browser is not enabled Dec 19 04:41:11 volumiow volumio[8122]: info: Loading plugin "alarm-clock"... Dec 19 04:41:11 volumiow sudo[8176]: pam_unix(sudo:session): session closed for user root Dec 19 04:41:11 volumiow volumio[8122]: info: Loading plugin "airplay_emulation"... Dec 19 04:41:11 volumiow volumio[8122]: info: Starting Shairport Sync Dec 19 04:41:11 volumiow volumio[8122]: info: Loading plugin "last_100"... Dec 19 04:41:11 volumiow volumio[8122]: info: Loading plugin "webradio"... Dec 19 04:41:12 volumiow volumio[8122]: info: Loading plugin "i2s_dacs"... Dec 19 04:41:12 volumiow volumio[8122]: info: I2S DAC not set, start Auto-detection Dec 19 04:41:12 volumiow volumio[8122]: info: Loading plugin "volumiodiscovery"... Dec 19 04:41:12 volumiow volumio[8122]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 19 04:41:12 volumiow volumio[8122]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 19 04:41:12 volumiow node[8122]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 19 04:41:12 volumiow volumio[8122]: *** WARNING *** For more information see Dec 19 04:41:12 volumiow volumio[8122]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 19 04:41:12 volumiow volumio[8122]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 19 04:41:12 volumiow volumio[8122]: *** WARNING *** For more information see Dec 19 04:41:12 volumiow node[8122]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 19 04:41:12 volumiow node[8122]: *** WARNING *** For more information see Dec 19 04:41:12 volumiow node[8122]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 19 04:41:12 volumiow node[8122]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 19 04:41:12 volumiow node[8122]: *** WARNING *** For more information see Dec 19 04:41:12 volumiow volumio[8122]: info: Applying required configuration parameters for plugin volumiodiscovery Dec 19 04:41:12 volumiow volumio[8122]: info: Discovery: Started advertising with name: VolumioW Dec 19 04:41:12 volumiow volumio[8122]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 19 04:41:12 volumiow volumio[8122]: info: Loading plugin "squeezelite_mc"... Dec 19 04:41:13 volumiow volumio[8122]: info: Loading plugin "outputs"... Dec 19 04:41:13 volumiow volumio[8122]: info: Loading plugin "albumart"... Dec 19 04:41:13 volumiow volumio[8122]: info: Plugin example_plugin is not enabled Dec 19 04:41:13 volumiow volumio[8122]: info: Loading plugin "inputs"... Dec 19 04:41:13 volumiow volumio[8122]: info: Loading plugin "updater_comm"... Dec 19 04:41:13 volumiow volumio[8122]: info: Plugin mpdemulation is not enabled Dec 19 04:41:13 volumiow volumio[8122]: info: Loading plugin "rest_api"... Dec 19 04:41:13 volumiow volumio[8122]: info: Loading plugin "websocket"... Dec 19 04:41:13 volumiow volumio[8122]: info: Starting Socket.io Server version 2.3.0 Dec 19 04:41:13 volumiow volumio[8122]: info: Loading plugin "radio_paradise"... Dec 19 04:41:13 volumiow volumio[8122]: Forking 3 albumart workers Dec 19 04:41:13 volumiow volumio[8122]: info: Applying required configuration parameters for plugin radio_paradise Dec 19 04:41:13 volumiow volumio[8122]: info: [1766140873795] [RadioParadise] API delay: 5 Dec 19 04:41:13 volumiow volumio[8122]: info: Loading i18n strings for locale en Dec 19 04:41:13 volumiow volumio[8122]: Updating browse sources language Dec 19 04:41:13 volumiow volumio[8122]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 19 04:41:14 volumiow volumio[8122]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 19 04:41:14 volumiow volumio[8122]: info: CoreCommandRouter::initPlayerControls Dec 19 04:41:14 volumiow volumio[8122]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:41:14 volumiow volumio[8122]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:41:14 volumiow volumio[8122]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:41:14 volumiow volumio[8122]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:41:14 volumiow volumio[8122]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:41:14 volumiow volumio[8122]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:41:14 volumiow volumio[8122]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:41:14 volumiow volumio[8122]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:41:14 volumiow volumio[8122]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 19 04:41:14 volumiow volumio[8122]: Express server listening on port 3000 Dec 19 04:41:14 volumiow volumio[8122]: [Metrics] WebUI: 6s 35.56ms Dec 19 04:41:14 volumiow volumio[8122]: info: CoreStateMachine::resetVolumioState Dec 19 04:41:14 volumiow volumio[8122]: info: CoreStateMachine::getcurrentVolume Dec 19 04:41:14 volumiow volumio[8122]: info: CoreCommandRouter::volumioRetrievevolume Dec 19 04:41:14 volumiow volumio[8122]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 04:41:14 volumiow volumio[8122]: info: Volumio Network Manager: Network status updated: 0 Dec 19 04:41:14 volumiow volumio-time-update[492]: volumio-time-update-util: Fetching time from Volumio... Dec 19 04:41:14 volumiow volumio[8122]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Dec 19 04:41:14 volumiow volumio[8122]: info: Cannot mount NAS 24bit_88khz_+ at system boot, trial number 1 ,retrying in 5 seconds Dec 19 04:41:14 volumiow volumio[8122]: info: Cannot mount NAS SACD at system boot, trial number 1 ,retrying in 5 seconds Dec 19 04:41:14 volumiow volumio[8122]: info: Cannot mount NAS DSF at system boot, trial number 1 ,retrying in 5 seconds Dec 19 04:41:14 volumiow volumio-time-update[492]: volumio-time-update-util: Date not found in response Dec 19 04:41:14 volumiow volumio-time-update[492]: volumio-time-update-util: Retrying in 5 seconds... Dec 19 04:41:14 volumiow volumio-remote-updater[518]: [2025-12-19 04:41:14] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1766140871 101 Dec 19 04:41:14 volumiow volumio[8122]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 1 Dec 19 04:41:14 volumiow volumio[8122]: info: VolumeController:: Volume=undefined Mute =false Dec 19 04:41:14 volumiow volumio[8122]: info: CoreStateMachine::pushState Dec 19 04:41:14 volumiow volumio[8122]: info: CorePlayQueue::getTrack 0 Dec 19 04:41:14 volumiow volumio[8122]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 19 04:41:14 volumiow volumio[8122]: info: CoreCommandRouter::volumioPushState Dec 19 04:41:14 volumiow volumio[8122]: info: CoreStateMachine::updateTrackBlock Dec 19 04:41:14 volumiow volumio[8122]: info: CorePlayQueue::getTrackBlock Dec 19 04:41:14 volumiow volumio[8122]: info: CoreCommandRouter::volumioRetrievevolume Dec 19 04:41:14 volumiow volumio[8122]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Dec 19 04:41:14 volumiow volumio[8122]: info: Reloading queue from file Dec 19 04:41:14 volumiow volumio[8122]: info: VolumeController:: Volume=undefined Mute =false Dec 19 04:41:14 volumiow volumio[8122]: info: CoreStateMachine::pushState Dec 19 04:41:14 volumiow volumio[8122]: info: CorePlayQueue::getTrack 0 Dec 19 04:41:14 volumiow volumio[8122]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 19 04:41:14 volumiow volumio[8122]: info: CoreCommandRouter::volumioPushState Dec 19 04:41:14 volumiow volumio[8122]: info: CoreStateMachine::setRepeat null single undefined Dec 19 04:41:14 volumiow volumio[8122]: info: CoreStateMachine::pushState Dec 19 04:41:14 volumiow volumio[8122]: info: CorePlayQueue::getTrack 0 Dec 19 04:41:14 volumiow volumio[8122]: info: CoreCommandRouter::volumioPushState Dec 19 04:41:14 volumiow volumio[8122]: info: CoreStateMachine::setRandom null Dec 19 04:41:14 volumiow volumio[8122]: info: CoreStateMachine::pushState Dec 19 04:41:14 volumiow volumio[8122]: info: CorePlayQueue::getTrack 0 Dec 19 04:41:14 volumiow volumio[8122]: info: CoreCommandRouter::volumioPushState Dec 19 04:41:14 volumiow volumio[8122]: info: Setting Device type: Raspberry PI Dec 19 04:41:14 volumiow volumio[8122]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Dec 19 04:41:14 volumiow volumio[8122]: info: USB Boot Capable - System SBC Revision found in cpuinfo: 902120 Dec 19 04:41:14 volumiow volumio[8122]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Dec 19 04:41:14 volumiow volumio[8122]: info: Completed loading Core Plugins Dec 19 04:41:14 volumiow volumio[8122]: info: Preparing to generate the ALSA configuration file Dec 19 04:41:14 volumiow volumio[8122]: info: Asound.conf file unchanged, so no further update is needed Dec 19 04:41:14 volumiow volumio[8122]: info: Output device has changed, restarting MPD Dec 19 04:41:14 volumiow volumio[8122]: info: Output device has changed, restarting Shairport Sync Dec 19 04:41:14 volumiow volumio[8122]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:41:14 volumiow volumio[8122]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 04:41:14 volumiow sudo[8252]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 19 04:41:14 volumiow sudo[8252]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:41:14 volumiow sudo[8252]: pam_unix(sudo:session): session closed for user root Dec 19 04:41:14 volumiow sudo[8254]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 19 04:41:14 volumiow sudo[8254]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:41:14 volumiow volumio[8122]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 19 04:41:14 volumiow volumio[8122]: info: ___________ START PLUGINS ___________ Dec 19 04:41:14 volumiow volumio[8122]: info: ControllerMpd::onStart: Initializing MPD Dec 19 04:41:14 volumiow volumio[8122]: info: Creating MPD Configuration file Dec 19 04:41:14 volumiow volumio[8122]: Starting albumart workers Dec 19 04:41:14 volumiow systemd[1]: Stopping Music Player Daemon... Dec 19 04:41:14 volumiow volumio[8122]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:41:14 volumiow volumio[8122]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 04:41:14 volumiow systemd[1]: mpd.service: Succeeded. Dec 19 04:41:14 volumiow systemd[1]: Stopped Music Player Daemon. Dec 19 04:41:14 volumiow sudo[8261]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 19 04:41:14 volumiow sudo[8261]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:41:15 volumiow sudo[8261]: pam_unix(sudo:session): session closed for user root Dec 19 04:41:15 volumiow sudo[8263]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 19 04:41:15 volumiow sudo[8263]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:41:15 volumiow systemd[1]: Starting Music Player Daemon... Dec 19 04:41:15 volumiow volumio[8122]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 19 04:41:15 volumiow volumio[8122]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:41:15 volumiow volumio[8122]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 04:41:15 volumiow systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Dec 19 04:41:15 volumiow systemd[1]: mpd.service: Succeeded. Dec 19 04:41:15 volumiow systemd[1]: Stopped Music Player Daemon. Dec 19 04:41:15 volumiow systemd[1]: Starting Music Player Daemon... Dec 19 04:41:15 volumiow volumio[8122]: Starting albumart workers Dec 19 04:41:15 volumiow volumio[8122]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 19 04:41:15 volumiow volumio[8122]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 19 04:41:15 volumiow volumio[8122]: info: [1766140875172] CoreMusicLibrary::Adding element Last_100 Dec 19 04:41:15 volumiow volumio[8122]: Starting albumart workers Dec 19 04:41:15 volumiow volumio[8122]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 19 04:41:15 volumiow volumio[8122]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 19 04:41:15 volumiow volumio[8122]: info: [1766140875190] CoreMusicLibrary::Adding element Webradio Dec 19 04:41:15 volumiow volumio[8122]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 19 04:41:15 volumiow volumio[8122]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 19 04:41:15 volumiow volumio[8122]: info: Initializing BBC Radios Dec 19 04:41:15 volumiow sudo[8270]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 19 04:41:15 volumiow sudo[8270]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:41:15 volumiow sudo[8270]: pam_unix(sudo:session): session closed for user root Dec 19 04:41:15 volumiow volumio[8122]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory Dec 19 04:41:15 volumiow volumio[8122]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 04:41:15 volumiow volumio[8122]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 19 04:41:15 volumiow volumio[8122]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 04:41:15 volumiow volumio[8122]: info: [squeezelite_mc] Starting proxy server... Dec 19 04:41:15 volumiow volumio[8122]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 19 04:41:15 volumiow volumio[8122]: info: [1766140875487] CoreMusicLibrary::Adding element Radio Paradise Dec 19 04:41:15 volumiow volumio[8122]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 19 04:41:15 volumiow volumio[8122]: Cannot find translation for source Radio Paradise Dec 19 04:41:15 volumiow volumio[8122]: info: Volumio Calling Home Dec 19 04:41:15 volumiow dhcpcd[755]: wlan0: using IPv4LL address 169.254.138.22 Dec 19 04:41:15 volumiow avahi-daemon[531]: Joining mDNS multicast group on interface wlan0.IPv4 with address 169.254.138.22. Dec 19 04:41:15 volumiow dhcpcd[755]: wlan0: adding route to 169.254.0.0/16 Dec 19 04:41:15 volumiow dhcpcd[755]: wlan0: adding default route Dec 19 04:41:15 volumiow avahi-daemon[531]: New relevant interface wlan0.IPv4 for mDNS. Dec 19 04:41:15 volumiow avahi-daemon[531]: Registering new address record for 169.254.138.22 on wlan0.IPv4. Dec 19 04:41:15 volumiow volumio[8122]: info: [squeezelite_mc] Proxy server started on port 44671 Dec 19 04:41:16 volumiow volumio[8122]: info: CoreCommandRouter::volumioRetrievevolume Dec 19 04:41:16 volumiow volumio[8122]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Dec 19 04:41:16 volumiow volumio[8122]: info: MPD Permissions set Dec 19 04:41:16 volumiow volumio[8122]: info: MPD Permissions set Dec 19 04:41:16 volumiow volumio[8122]: info: VolumeController:: Volume=undefined Mute =false Dec 19 04:41:16 volumiow volumio[8122]: info: CoreStateMachine::pushState Dec 19 04:41:16 volumiow volumio[8122]: info: CorePlayQueue::getTrack 0 Dec 19 04:41:16 volumiow volumio[8122]: info: CoreCommandRouter::volumioPushState Dec 19 04:41:16 volumiow volumio[8122]: info: [squeezelite_mc] Server discovery started Dec 19 04:41:16 volumiow volumio[8122]: info: [squeezelite_mc] Player finder started Dec 19 04:41:16 volumiow volumio[8122]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:41:16 volumiow volumio[8122]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:41:16 volumiow volumio[8122]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:41:16 volumiow volumio[8122]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 19 04:41:16 volumiow volumio[8122]: info: [squeezelite_mc] Executing aplay -D hw:5 --nonblock -f MPEG /dev/zero 2>&1 || true Dec 19 04:41:16 volumiow volumio[8122]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Dec 19 04:41:16 volumiow volumio[8122]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:41:16 volumiow volumio[8122]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:41:16 volumiow volumio[8122]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:41:16 volumiow volumio[8122]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:41:16 volumiow volumio[8122]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:41:16 volumiow volumio[8122]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:41:16 volumiow volumio[8122]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 04:41:16 volumiow volumio[8122]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:41:16 volumiow volumio[8122]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:41:16 volumiow volumio[8122]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:41:16 volumiow volumio[8122]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:41:16 volumiow volumio[8122]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:41:16 volumiow volumio[8122]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:41:16 volumiow volumio[8122]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:41:16 volumiow volumio[8122]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:41:16 volumiow volumio[8122]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:41:16 volumiow volumio[8122]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 04:41:16 volumiow volumio[8122]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:41:16 volumiow volumio[8122]: warn: [squeezelite_mc] No supported ALSA formats found for card 5 Dec 19 04:41:16 volumiow volumio[8122]: warn: [squeezelite_mc] No ALSA formats returned for card 5 Dec 19 04:41:16 volumiow volumio[8122]: info: [squeezelite_mc] Starting Squeezelite service with params: {"type":"basic","playerName":"volumiow","dsdFormat":null,"card":"5","mixerType":"undefined","mixer":""} Dec 19 04:41:16 volumiow volumio[8122]: info: [squeezelite_mc] Executing cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/alsa/100-squeezelite.conf.template.out /etc/alsa/conf.d/100-squeezelite.conf Dec 19 04:41:16 volumiow volumio[8122]: info: Starting Shairport Sync Dec 19 04:41:16 volumiow volumio[8122]: info: Starting Shairport Sync Dec 19 04:41:16 volumiow volumio[8122]: info: Starting Shairport Sync Dec 19 04:41:16 volumiow sudo[8341]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 19 04:41:16 volumiow sudo[8341]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:41:16 volumiow sudo[8343]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 19 04:41:16 volumiow sudo[8343]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:41:16 volumiow sudo[8346]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 19 04:41:16 volumiow sudo[8346]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:41:16 volumiow systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Dec 19 04:41:16 volumiow systemd[1]: shairport-sync.service: Succeeded. Dec 19 04:41:16 volumiow systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Dec 19 04:41:16 volumiow sudo[8339]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/alsa/100-squeezelite.conf.template.out /etc/alsa/conf.d/100-squeezelite.conf Dec 19 04:41:16 volumiow sudo[8339]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:41:16 volumiow sudo[8339]: pam_unix(sudo:session): session closed for user root Dec 19 04:41:16 volumiow volumio[8122]: info: [squeezelite_mc] Executing alsactl -L -R nrestore Dec 19 04:41:16 volumiow sudo[8353]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/alsactl -L -R nrestore Dec 19 04:41:16 volumiow sudo[8353]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:41:16 volumiow systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 19 04:41:16 volumiow sudo[8341]: pam_unix(sudo:session): session closed for user root Dec 19 04:41:16 volumiow sudo[8343]: pam_unix(sudo:session): session closed for user root Dec 19 04:41:16 volumiow volumio[8122]: info: Shairport-Sync Started Dec 19 04:41:16 volumiow volumio[8122]: Error adding Membership: Error: addMembership EINVAL Dec 19 04:41:16 volumiow systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Dec 19 04:41:16 volumiow volumio[8122]: info: Shairport-Sync Started Dec 19 04:41:16 volumiow systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Dec 19 04:41:16 volumiow systemd[1]: shairport-sync.service: Succeeded. Dec 19 04:41:16 volumiow systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Dec 19 04:41:16 volumiow systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 19 04:41:16 volumiow sudo[8346]: pam_unix(sudo:session): session closed for user root Dec 19 04:41:16 volumiow volumio[8122]: info: Shairport-Sync Started Dec 19 04:41:16 volumiow sudo[8353]: pam_unix(sudo:session): session closed for user root Dec 19 04:41:16 volumiow volumio[8122]: info: [squeezelite_mc] Executing cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/systemd/squeezelite.service.template.out /etc/systemd/system/squeezelite.service Dec 19 04:41:16 volumiow ntpd[631]: Listen normally on 3 wlan0 169.254.138.22:123 Dec 19 04:41:16 volumiow ntpd[631]: new interface(s) found: waking up resolver Dec 19 04:41:16 volumiow sudo[8358]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/cp /data/plugins/music_service/squeezelite_mc/dist/lib/../templates/systemd/squeezelite.service.template.out /etc/systemd/system/squeezelite.service Dec 19 04:41:16 volumiow sudo[8358]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:41:16 volumiow sudo[8358]: pam_unix(sudo:session): session closed for user root Dec 19 04:41:16 volumiow volumio[8122]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl daemon-reload || true Dec 19 04:41:16 volumiow sudo[8363]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Dec 19 04:41:16 volumiow sudo[8363]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:41:16 volumiow systemd[1]: Reloading. Dec 19 04:41:17 volumiow systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Dec 19 04:41:17 volumiow mpd[8277]: Dec 19 04:41 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 19 04:41:17 volumiow systemd[1]: getty@tty1.service: Current command vanished from the unit file, execution of the command list won't be resumed. Dec 19 04:41:18 volumiow systemd[1]: Started Music Player Daemon. Dec 19 04:41:18 volumiow sudo[8363]: pam_unix(sudo:session): session closed for user root Dec 19 04:41:18 volumiow sudo[8263]: pam_unix(sudo:session): session closed for user root Dec 19 04:41:18 volumiow sudo[8254]: pam_unix(sudo:session): session closed for user root Dec 19 04:41:18 volumiow volumio[8122]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true Dec 19 04:41:18 volumiow sudo[8381]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite Dec 19 04:41:18 volumiow sudo[8381]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:41:18 volumiow sudo[8381]: pam_unix(sudo:session): session closed for user root Dec 19 04:41:18 volumiow volumio[8122]: error: MPD error: The expression evaluated to a falsy value: Dec 19 04:41:18 volumiow volumio[8122]: assert.ok(self.idling) Dec 19 04:41:18 volumiow volumio[8122]: error: The expression evaluated to a falsy value: Dec 19 04:41:18 volumiow volumio[8122]: assert.ok(self.idling) Dec 19 04:41:18 volumiow volumio[8122]: error: updateQueue error: null Dec 19 04:41:18 volumiow volumio[8122]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl start squeezelite || true Dec 19 04:41:18 volumiow volumio[8122]: info: MPD running with PID8277 Dec 19 04:41:18 volumiow volumio[8122]: ,establishing connection Dec 19 04:41:18 volumiow volumio[8122]: error: updateQueue error: null Dec 19 04:41:18 volumiow sudo[8386]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start squeezelite Dec 19 04:41:18 volumiow sudo[8386]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:41:18 volumiow systemd[1]: Starting Squeezelite lightweight headless Squeezebox emulator... Dec 19 04:41:18 volumiow kernel: process '/opt/squeezelite/squeezelite' started with executable stack Dec 19 04:41:18 volumiow systemd[1]: Started Squeezelite lightweight headless Squeezebox emulator. Dec 19 04:41:18 volumiow sudo[8386]: pam_unix(sudo:session): session closed for user root Dec 19 04:41:18 volumiow systemd[1]: squeezelite.service: Succeeded. Dec 19 04:41:18 volumiow systemd[1]: squeezelite.service: Service RestartSec=100ms expired, scheduling restart. Dec 19 04:41:18 volumiow systemd[1]: squeezelite.service: Scheduled restart job, restart counter is at 1. Dec 19 04:41:18 volumiow systemd[1]: Stopped Squeezelite lightweight headless Squeezebox emulator. Dec 19 04:41:18 volumiow systemd[1]: Starting Squeezelite lightweight headless Squeezebox emulator... Dec 19 04:41:18 volumiow systemd[1]: Started Squeezelite lightweight headless Squeezebox emulator. Dec 19 04:41:18 volumiow systemd[1]: squeezelite.service: Succeeded. Dec 19 04:41:18 volumiow volumio[8122]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true Dec 19 04:41:18 volumiow systemd[1]: squeezelite.service: Service RestartSec=100ms expired, scheduling restart. Dec 19 04:41:18 volumiow sudo[8393]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite Dec 19 04:41:18 volumiow systemd[1]: squeezelite.service: Scheduled restart job, restart counter is at 2. Dec 19 04:41:18 volumiow sudo[8393]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:41:18 volumiow systemd[1]: Stopped Squeezelite lightweight headless Squeezebox emulator. Dec 19 04:41:19 volumiow systemd[1]: Starting Squeezelite lightweight headless Squeezebox emulator... Dec 19 04:41:19 volumiow systemd[1]: Started Squeezelite lightweight headless Squeezebox emulator. Dec 19 04:41:19 volumiow sudo[8393]: pam_unix(sudo:session): session closed for user root Dec 19 04:41:19 volumiow systemd[1]: squeezelite.service: Succeeded. Dec 19 04:41:19 volumiow sudo[8398]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=nouser,password=nouser,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=3.11 //172.16.1.11/Audio\\High Resolution\\24 Bit\\%24bit-88Khz (plus) /mnt/NAS/24bit_88khz_+ Dec 19 04:41:19 volumiow sudo[8398]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:41:19 volumiow volumio-time-update[492]: volumio-time-update-util: Fetching time from Volumio... Dec 19 04:41:19 volumiow sudo[8400]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=nouser,password=nouser,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=3.11 //172.16.1.11/Audio\\High Resolution\\SACD /mnt/NAS/SACD Dec 19 04:41:19 volumiow sudo[8400]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:41:19 volumiow kernel: CIFS: Attempting to mount //172.16.1.11/Audio/High Resolution/24 Bit/%24bit-88Khz (plus) Dec 19 04:41:19 volumiow sudo[8410]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=nouser,password=nouser,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=3.11 //172.16.1.11/Audio\\High Resolution\\DSF /mnt/NAS/DSF Dec 19 04:41:19 volumiow sudo[8410]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:41:19 volumiow systemd[1]: squeezelite.service: Service RestartSec=100ms expired, scheduling restart. Dec 19 04:41:19 volumiow systemd[1]: squeezelite.service: Scheduled restart job, restart counter is at 3. Dec 19 04:41:19 volumiow systemd[1]: Stopped Squeezelite lightweight headless Squeezebox emulator. Dec 19 04:41:19 volumiow systemd[1]: Starting Squeezelite lightweight headless Squeezebox emulator... Dec 19 04:41:19 volumiow systemd[1]: Started Squeezelite lightweight headless Squeezebox emulator. Dec 19 04:41:19 volumiow volumio[8122]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true Dec 19 04:41:19 volumiow systemd[1]: squeezelite.service: Succeeded. Dec 19 04:41:19 volumiow sudo[8419]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite Dec 19 04:41:19 volumiow sudo[8419]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:41:19 volumiow sudo[8419]: pam_unix(sudo:session): session closed for user root Dec 19 04:41:19 volumiow systemd[1]: squeezelite.service: Service RestartSec=100ms expired, scheduling restart. Dec 19 04:41:19 volumiow systemd[1]: squeezelite.service: Scheduled restart job, restart counter is at 4. Dec 19 04:41:19 volumiow systemd[1]: Stopped Squeezelite lightweight headless Squeezebox emulator. Dec 19 04:41:19 volumiow systemd[1]: Starting Squeezelite lightweight headless Squeezebox emulator... Dec 19 04:41:19 volumiow systemd[1]: Started Squeezelite lightweight headless Squeezebox emulator. Dec 19 04:41:20 volumiow systemd[1]: squeezelite.service: Succeeded. Dec 19 04:41:20 volumiow volumio[8122]: info: [squeezelite_mc] Executing /usr/bin/sudo /bin/systemctl status squeezelite || true Dec 19 04:41:20 volumiow systemd[1]: squeezelite.service: Service RestartSec=100ms expired, scheduling restart. Dec 19 04:41:20 volumiow systemd[1]: squeezelite.service: Scheduled restart job, restart counter is at 5. Dec 19 04:41:20 volumiow systemd[1]: Stopped Squeezelite lightweight headless Squeezebox emulator. Dec 19 04:41:20 volumiow systemd[1]: squeezelite.service: Start request repeated too quickly. Dec 19 04:41:20 volumiow systemd[1]: squeezelite.service: Failed with result 'start-limit-hit'. Dec 19 04:41:20 volumiow systemd[1]: Failed to start Squeezelite lightweight headless Squeezebox emulator. Dec 19 04:41:20 volumiow sudo[8424]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl status squeezelite Dec 19 04:41:20 volumiow sudo[8424]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:41:20 volumiow sudo[8424]: pam_unix(sudo:session): session closed for user root Dec 19 04:41:20 volumiow volumio[8122]: info: Completed starting Core Plugins Dec 19 04:41:20 volumiow volumio[8122]: info: ------------------------------------------- Dec 19 04:41:20 volumiow volumio[8122]: info: ----- MyVolumio plugins startup ---- Dec 19 04:41:20 volumiow volumio[8122]: info: ------------------------------------------- Dec 19 04:41:20 volumiow volumio[8122]: info: [MyVolumio PluginManager] Fetching plans data.... Dec 19 04:41:21 volumiow sudo[8427]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 19 04:41:21 volumiow sudo[8427]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:41:21 volumiow sudo[8429]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 19 04:41:21 volumiow sudo[8429]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:41:21 volumiow volumio[8122]: info: Volumio Network Manager: Network status updated: 2 Dec 19 04:41:21 volumiow systemd[1]: Started MPD Monitor Service. Dec 19 04:41:21 volumiow sudo[8427]: pam_unix(sudo:session): session closed for user root Dec 19 04:41:21 volumiow volumio[8122]: info: Successfully started MPD Monitor Dec 19 04:41:21 volumiow systemd[1]: Stopping MPD Monitor Service... Dec 19 04:41:21 volumiow systemd[1]: mpd_monitor.service: Main process exited, code=killed, status=15/TERM Dec 19 04:41:21 volumiow systemd[1]: mpd_monitor.service: Succeeded. Dec 19 04:41:21 volumiow systemd[1]: Stopped MPD Monitor Service. Dec 19 04:41:21 volumiow systemd[1]: Started MPD Monitor Service. Dec 19 04:41:21 volumiow sudo[8429]: pam_unix(sudo:session): session closed for user root Dec 19 04:41:21 volumiow volumio[8122]: info: Successfully started MPD Monitor Dec 19 04:41:21 volumiow mpd_monitor.sh[8447]: MPD Monitor Service: Starting MPD Monitor Service Dec 19 04:41:23 volumiow volumio[8122]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Dec 19 04:41:24 volumiow dhcpcd[755]: wlan0: offered 172.16.1.194 from 172.16.1.254 Dec 19 04:41:24 volumiow dhcpcd[755]: wlan0: probing address 172.16.1.194/24 Dec 19 04:41:25 volumiow sudo[8398]: pam_unix(sudo:session): session closed for user root Dec 19 04:41:25 volumiow volumio[8122]: info: Cannot mount NAS 24bit_88khz_+ at system boot, trial number 2 ,retrying in 5 seconds Dec 19 04:41:25 volumiow kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Dec 19 04:41:25 volumiow kernel: CIFS: VFS: cifs_mount failed w/return code = -113 Dec 19 04:41:25 volumiow kernel: CIFS: Attempting to mount //172.16.1.11/Audio/High Resolution/SACD Dec 19 04:41:29 volumiow dhcpcd[755]: wlan0: leased 172.16.1.194 for 86400 seconds Dec 19 04:41:29 volumiow avahi-daemon[531]: Registering new address record for 172.16.1.194 on wlan0.IPv4. Dec 19 04:41:29 volumiow dhcpcd[755]: wlan0: adding route to 172.16.1.0/24 Dec 19 04:41:29 volumiow dhcpcd[755]: wlan0: changing default route via 172.16.1.254 Dec 19 04:41:29 volumiow avahi-daemon[531]: Withdrawing address record for 169.254.138.22 on wlan0. Dec 19 04:41:29 volumiow avahi-daemon[531]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 169.254.138.22. Dec 19 04:41:29 volumiow dhcpcd[755]: wlan0: deleting route to 169.254.0.0/16 Dec 19 04:41:29 volumiow avahi-daemon[531]: Joining mDNS multicast group on interface wlan0.IPv4 with address 172.16.1.194. Dec 19 04:41:29 volumiow dhcpcd[755]: wlan0: pid 755 deleted default route via 172.16.1.254 Dec 19 04:41:30 volumiow sudo[8490]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=nouser,password=nouser,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=3.11 //172.16.1.11/Audio\\High Resolution\\24 Bit\\%24bit-88Khz (plus) /mnt/NAS/24bit_88khz_+ Dec 19 04:41:30 volumiow sudo[8490]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:41:30 volumiow ntpd[631]: Listen normally on 4 wlan0 172.16.1.194:123 Dec 19 04:41:30 volumiow ntpd[631]: Deleting interface #3 wlan0, 169.254.138.22#123, interface stats: received=0, sent=0, dropped=0, active_time=14 secs Dec 19 04:41:30 volumiow ntpd[631]: new interface(s) found: waking up resolver Dec 19 04:41:31 volumiow volumio[8122]: info: CoreCommandRouter::volumioGetState Dec 19 04:41:31 volumiow volumio[8122]: info: CorePlayQueue::getTrack 0 Dec 19 04:41:31 volumiow volumio[8122]: info: Discovery: adding 8a979897-51bc-40bb-a4b2-a300ba33bf6f Dec 19 04:41:31 volumiow volumio[8122]: info: Discovery: Found device VolumioW Dec 19 04:41:31 volumiow volumio[8122]: info: CoreCommandRouter::volumioGetState Dec 19 04:41:31 volumiow volumio[8122]: info: CorePlayQueue::getTrack 0 Dec 19 04:41:33 volumiow sudo[8400]: pam_unix(sudo:session): session closed for user root Dec 19 04:41:33 volumiow volumio[8122]: info: Cannot mount NAS SACD at system boot, trial number 2 ,retrying in 5 seconds Dec 19 04:41:33 volumiow kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Dec 19 04:41:33 volumiow kernel: CIFS: VFS: cifs_mount failed w/return code = -115 Dec 19 04:41:33 volumiow kernel: CIFS: Attempting to mount //172.16.1.11/Audio/High Resolution/DSF Dec 19 04:41:34 volumiow volumio-time-update[492]: volumio-time-update-util: Date not found in response Dec 19 04:41:34 volumiow volumio-time-update[492]: volumio-time-update-util: Retrying in 5 seconds... Dec 19 04:41:38 volumiow sudo[8548]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=nouser,password=nouser,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=3.11 //172.16.1.11/Audio\\High Resolution\\SACD /mnt/NAS/SACD Dec 19 04:41:38 volumiow sudo[8548]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 19 04:41:39 volumiow volumio-time-update[492]: volumio-time-update-util: Fetching time from Volumio... Dec 19 04:41:39 volumiow wpa_supplicant[739]: wlan0: CTRL-EVENT-DISCONNECTED bssid=fa:9f:c2:34:23:e9 reason=6 Dec 19 04:41:39 volumiow dhcpcd[755]: wlan0: carrier lost Dec 19 04:41:39 volumiow wpa_supplicant[739]: wlan0: Trying to associate with SSID 'SYNACK' Dec 19 04:41:39 volumiow wpa_supplicant[739]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD Dec 19 04:41:39 volumiow wpa_supplicant[739]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=USER type=COUNTRY alpha2=FR Dec 19 04:41:39 volumiow wpa_supplicant[739]: wlan0: CTRL-EVENT-ASSOC-REJECT bssid=00:00:00:00:00:00 status_code=16 Dec 19 04:41:39 volumiow avahi-daemon[531]: Withdrawing address record for 172.16.1.194 on wlan0. Dec 19 04:41:39 volumiow avahi-daemon[531]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 172.16.1.194. Dec 19 04:41:39 volumiow avahi-daemon[531]: Interface wlan0.IPv4 no longer relevant for mDNS. Dec 19 04:41:39 volumiow dhcpcd[755]: wlan0: deleting route to 172.16.1.0/24 Dec 19 04:41:39 volumiow volumio[8122]: info: Discovery: A device disappeared from network Dec 19 04:41:39 volumiow volumio[8122]: info: Discovery: Device volumiow disappeared from network Dec 19 04:41:40 volumiow volumio[8122]: error: MyVolumio Plugin failed to start in a timely fashion Dec 19 04:41:40 volumiow volumio[8122]: [Metrics] CommandRouter: 31s 483.57ms Dec 19 04:41:40 volumiow volumio[8122]: info: CoreCommandRouter::volumiosetStartupVolume Dec 19 04:41:40 volumiow volumio[8122]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 19 04:41:40 volumiow volumio[8122]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 04:41:40 volumiow volumio[8122]: info: CoreCommandRouter::Close All Modals sent Dec 19 04:41:40 volumiow volumio[8122]: info: CoreCommandRouter::Close All Modals sent Dec 19 04:41:40 volumiow volumio[8122]: info: Cannot play startup sound: Error: Command failed: /usr/bin/aplay -D volumio /volumio/app/startup.wav Dec 19 04:41:40 volumiow volumio[8122]: ALSA lib pcm_hw.c:1822:(_snd_pcm_hw_open) Invalid value for card Dec 19 04:41:40 volumiow volumio[8122]: aplay: main:828: audio open error: No such device Dec 19 04:41:40 volumiow wpa_supplicant[739]: wlan0: Trying to associate with SSID 'SYNACK' Dec 19 04:41:40 volumiow volumio[8122]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=pi&variante=volumio&version=3.886&uuid=f0bac3ff9cdacc46cfad790ec6656b11" http://updates.volumio.org/downloader-v1/track-device Dec 19 04:41:40 volumiow volumio[8122]: % Total % Received % Xferd Average Speed Time Time Time Current Dec 19 04:41:40 volumiow volumio[8122]: Dload Upload Total Spent Left Speed Dec 19 04:41:40 volumiow volumio[8122]: [1.2K blob data] Dec 19 04:41:40 volumiow volumio[8122]: retrying in 5 seconds, trial 0 Dec 19 04:41:40 volumiow volumio[8122]: info: Volumio Calling Home Dec 19 04:41:40 volumiow dhcpcd[755]: wlan0: carrier acquired Dec 19 04:41:40 volumiow wpa_supplicant[739]: wlan0: Associated with fa:9f:c2:34:24:3e Dec 19 04:41:40 volumiow wpa_supplicant[739]: wlan0: CTRL-EVENT-CONNECTED - Connection to fa:9f:c2:34:24:3e completed [id=0 id_str=] Dec 19 04:41:40 volumiow wpa_supplicant[739]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Dec 19 04:41:40 volumiow wpa_supplicant[739]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=CA Dec 19 04:41:40 volumiow dhcpcd[755]: wlan0: IAID 67:94:3f:6e Dec 19 04:41:40 volumiow dhcpcd[755]: wlan0: carrier lost Dec 19 04:41:40 volumiow dhcpcd[755]: wlan0: carrier acquired Dec 19 04:41:40 volumiow dhcpcd[755]: wlan0: IAID 67:94:3f:6e Dec 19 04:41:41 volumiow dhcpcd[755]: wlan0: soliciting an IPv6 router Dec 19 04:41:41 volumiow dhcpcd[755]: wlan0: rebinding lease of 172.16.1.194 Dec 19 04:41:41 volumiow dhcpcd[755]: wlan0: probing address 172.16.1.194/24 Dec 19 04:41:41 volumiow volumio[8122]: info: Volumio Network Manager: Network status updated: 0 Dec 19 04:41:41 volumiow volumio[8122]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Dec 19 04:41:41 volumiow volumio[8122]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 19 04:41:41 volumiow volumio[8122]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Dec 19 04:41:41 volumiow volumio[8122]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Dec 19 04:41:41 volumiow ntpd[631]: Deleting interface #4 wlan0, 172.16.1.194#123, interface stats: received=0, sent=0, dropped=0, active_time=11 secs Dec 19 04:41:41 volumiow sudo[8410]: pam_unix(sudo:session): session closed for user root Dec 19 04:41:41 volumiow sudo[8490]: pam_unix(sudo:session): session closed for user root Dec 19 04:41:41 volumiow sudo[8548]: pam_unix(sudo:session): session closed for user root Dec 19 04:41:41 volumiow kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Dec 19 04:41:41 volumiow kernel: CIFS: VFS: cifs_mount failed w/return code = -115 Dec 19 04:41:41 volumiow kernel: CIFS: Attempting to mount //172.16.1.11/Audio/High Resolution/24 Bit/%24bit-88Khz (plus) Dec 19 04:41:41 volumiow kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Dec 19 04:41:41 volumiow kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Dec 19 04:41:41 volumiow kernel: CIFS: Attempting to mount //172.16.1.11/Audio/High Resolution/SACD Dec 19 04:41:41 volumiow kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Dec 19 04:41:41 volumiow kernel: CIFS: VFS: cifs_mount failed w/return code = -101 Dec 19 04:41:41 volumiow volumio[8122]: info: Cannot mount NAS DSF at system boot, trial number 2 ,retrying in 5 seconds Dec 19 04:41:41 volumiow volumio[8122]: info: Cannot mount NAS 24bit_88khz_+ at system boot, trial number 3 ,retrying in 5 seconds Dec 19 04:41:41 volumiow volumio[8122]: info: Cannot mount NAS SACD at system boot, trial number 3 ,retrying in 5 seconds Dec 19 04:41:44 volumiow volumio-time-update[492]: volumio-time-update-util: Date not found in response Dec 19 04:41:44 volumiow volumio-time-update[492]: volumio-time-update-util: Retrying in 5 seconds... Dec 19 04:41:45 volumiow volumio[8122]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory Dec 19 04:41:45 volumiow volumio[8122]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 04:41:45 volumiow volumio[8122]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 19 04:41:45 volumiow volumio[8122]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 19 04:41:45 volumiow volumio[8122]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 19 04:41:46 volumiow volumio[8122]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 19 04:41:46 volumiow volumio[8122]: Error: send ENETUNREACH 255.255.255.255:3483 Dec 19 04:41:46 volumiow volumio[8122]: at doSend (dgram.js:692:16) Dec 19 04:41:46 volumiow volumio[8122]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:430:12) Dec 19 04:41:46 volumiow volumio[8122]: at afterDns (dgram.js:638:5) Dec 19 04:41:46 volumiow volumio[8122]: at processTicksAndRejections (internal/process/task_queues.js:81:21) { Dec 19 04:41:46 volumiow volumio[8122]: errno: -101, Dec 19 04:41:46 volumiow volumio[8122]: code: 'ENETUNREACH', Dec 19 04:41:46 volumiow volumio[8122]: syscall: 'send', Dec 19 04:41:46 volumiow volumio[8122]: address: '255.255.255.255', Dec 19 04:41:46 volumiow volumio[8122]: port: 3483 Dec 19 04:41:46 volumiow volumio[8122]: } Dec 19 04:41:46 volumiow volumio[8122]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 19 04:41:46 volumiow dhcpcd[755]: wlan0: leased 172.16.1.194 for 86400 seconds Dec 19 04:41:46 volumiow avahi-daemon[531]: Joining mDNS multicast group on interface wlan0.IPv4 with address 172.16.1.194. Dec 19 04:41:46 volumiow dhcpcd[755]: wlan0: adding route to 172.16.1.0/24 Dec 19 04:41:46 volumiow dhcpcd[755]: wlan0: adding default route via 172.16.1.254 Dec 19 04:41:46 volumiow avahi-daemon[531]: New relevant interface wlan0.IPv4 for mDNS. Dec 19 04:41:46 volumiow avahi-daemon[531]: Registering new address record for 172.16.1.194 on wlan0.IPv4. Dec 19 04:41:46 volumiow sudo[8655]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-19 04:40 Dec 19 04:41:46 volumiow sudo[8655]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster 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="b43c85cc0006d3f1efecba101311ec96e334d1fd" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 11 Dec 2025 05:43:24 PM CET" VOLUMIO_VERSION="3.886" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="15d0241b0cd805792809f3ddf4a0fc4e"