-- Logs begin at Sat 2026-02-07 09:34:40 UTC, end at Sat 2026-02-07 20:46:23 UTC. -- Feb 07 20:45:00 volumioloft volumio[29835]: info: ------------------------------------------- Feb 07 20:45:00 volumioloft volumio[29835]: info: ----- Volumio3 ---- Feb 07 20:45:00 volumioloft volumio[29835]: info: ------------------------------------------- Feb 07 20:45:00 volumioloft volumio[29835]: info: ----- System startup ---- Feb 07 20:45:00 volumioloft volumio[29835]: info: ------------------------------------------- Feb 07 20:45:01 volumioloft volumio[29835]: info: MYVOLUMIO Environment detected Feb 07 20:45:01 volumioloft volumio[29835]: info: Plugin folders cleanup Feb 07 20:45:01 volumioloft volumio[29835]: info: Scanning into folder /volumio/app/plugins/ Feb 07 20:45:01 volumioloft volumio[29835]: info: Scanning category audio_interface Feb 07 20:45:01 volumioloft volumio[29835]: info: Scanning category miscellanea Feb 07 20:45:01 volumioloft volumio[29835]: info: Scanning category music_service Feb 07 20:45:01 volumioloft volumio[29835]: info: Scanning category plugins.json Feb 07 20:45:01 volumioloft volumio[29835]: info: Scanning category system_controller Feb 07 20:45:01 volumioloft volumio[29835]: info: Scanning category user_interface Feb 07 20:45:01 volumioloft volumio[29835]: info: Scanning into folder /data/plugins/ Feb 07 20:45:01 volumioloft volumio[29835]: info: Scanning category music_service Feb 07 20:45:01 volumioloft volumio[29835]: info: Plugin folders cleanup completed Feb 07 20:45:01 volumioloft volumio[29835]: info: ------------------------------------------- Feb 07 20:45:01 volumioloft volumio[29835]: info: ----- Core plugins startup ---- Feb 07 20:45:01 volumioloft volumio[29835]: info: ------------------------------------------- Feb 07 20:45:01 volumioloft volumio[29835]: info: Loading plugins from folder /volumio/app/plugins/ Feb 07 20:45:01 volumioloft volumio[29835]: info: Adding plugin upnp to MyMusic Plugins Feb 07 20:45:01 volumioloft volumio[29835]: info: Adding plugin airplay_emulation to MyMusic Plugins Feb 07 20:45:01 volumioloft volumio[29835]: info: Adding plugin upnp_browser to MyMusic Plugins Feb 07 20:45:01 volumioloft volumio[29835]: info: Loading plugins from folder /data/plugins/ Feb 07 20:45:01 volumioloft volumio[29835]: info: Loading plugin "system"... Feb 07 20:45:01 volumioloft volumio[29835]: info: Loading plugin "appearance"... Feb 07 20:45:02 volumioloft volumio[29835]: info: Loading plugin "network"... Feb 07 20:45:02 volumioloft volumio[29835]: info: Refreshing Cached IP Addresses Feb 07 20:45:02 volumioloft sudo[29861]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 07 20:45:02 volumioloft sudo[29861]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:45:02 volumioloft sudo[29861]: pam_unix(sudo:session): session closed for user root Feb 07 20:45:02 volumioloft sudo[29863]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 07 20:45:02 volumioloft sudo[29863]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:45:02 volumioloft sudo[29863]: pam_unix(sudo:session): session closed for user root Feb 07 20:45:02 volumioloft volumio[29835]: info: Loading plugin "services"... Feb 07 20:45:02 volumioloft volumio[29835]: info: Loading plugin "alsa_controller"... Feb 07 20:45:02 volumioloft sudo[29876]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Feb 07 20:45:02 volumioloft sudo[29876]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:45:02 volumioloft volumio[29835]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 07 20:45:02 volumioloft volumio[29835]: info: Loading plugin "wizard"... Feb 07 20:45:02 volumioloft volumio[29835]: info: Loading plugin "networkfs"... Feb 07 20:45:02 volumioloft volumio[29835]: info: Starting Udev Watcher for removable devices Feb 07 20:45:02 volumioloft volumio[29835]: info: Ignoring mount for partition: boot Feb 07 20:45:02 volumioloft volumio[29835]: info: Ignoring mount for partition: volumio Feb 07 20:45:02 volumioloft volumio[29835]: info: Ignoring mount for partition: volumio_data Feb 07 20:45:02 volumioloft volumio[29835]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 07 20:45:02 volumioloft volumio[29835]: info: Loading plugin "volumio_command_line_client"... Feb 07 20:45:02 volumioloft volumio[29835]: info: Loading plugin "upnp"... Feb 07 20:45:02 volumioloft volumio[29835]: info: [1770497102466] Starting Upmpd Daemon Feb 07 20:45:02 volumioloft volumio[29835]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 07 20:45:02 volumioloft volumio[29835]: info: Loading plugin "my_music"... Feb 07 20:45:02 volumioloft volumio[29835]: info: Loading plugin "mpd"... Feb 07 20:45:02 volumioloft volumio[29835]: info: Loading plugin "upnp_browser"... Feb 07 20:45:03 volumioloft volumio[29835]: info: Loading plugin "alarm-clock"... Feb 07 20:45:03 volumioloft volumio[29835]: info: Loading plugin "airplay_emulation"... Feb 07 20:45:03 volumioloft volumio[29835]: info: Starting Shairport Sync Feb 07 20:45:03 volumioloft volumio[29835]: info: Loading plugin "last_100"... Feb 07 20:45:03 volumioloft volumio[29835]: info: Loading plugin "webradio"... Feb 07 20:45:03 volumioloft volumio-remote-updater[667]: [2026-02-07 20:45:03] [connect] Successful connection Feb 07 20:45:03 volumioloft volumio[29835]: info: Loading plugin "i2s_dacs"... Feb 07 20:45:03 volumioloft volumio[29835]: info: Loading plugin "volumiodiscovery"... Feb 07 20:45:03 volumioloft volumio[29835]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 07 20:45:03 volumioloft volumio[29835]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 07 20:45:03 volumioloft volumio[29835]: *** WARNING *** For more information see Feb 07 20:45:03 volumioloft node[29835]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 07 20:45:03 volumioloft volumio[29835]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 07 20:45:03 volumioloft volumio[29835]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 07 20:45:03 volumioloft volumio[29835]: *** WARNING *** For more information see Feb 07 20:45:03 volumioloft node[29835]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 07 20:45:03 volumioloft node[29835]: *** WARNING *** For more information see Feb 07 20:45:03 volumioloft node[29835]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 07 20:45:03 volumioloft node[29835]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 07 20:45:03 volumioloft node[29835]: *** WARNING *** For more information see Feb 07 20:45:03 volumioloft volumio[29835]: info: Applying required configuration parameters for plugin volumiodiscovery Feb 07 20:45:03 volumioloft volumio[29835]: info: Discovery: Started advertising with name: Volumioloft Feb 07 20:45:03 volumioloft volumio[29835]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 07 20:45:03 volumioloft volumio[29835]: info: Loading plugin "squeezelite_mc"... Feb 07 20:45:03 volumioloft wpa_supplicant[892]: wlan0: Failed to initiate sched scan Feb 07 20:45:03 volumioloft sudo[29876]: pam_unix(sudo:session): session closed for user root Feb 07 20:45:04 volumioloft volumio[29835]: info: Loading plugin "outputs"... Feb 07 20:45:04 volumioloft volumio[29835]: info: Loading plugin "albumart"... Feb 07 20:45:04 volumioloft volumio[29835]: info: Plugin example_plugin is not enabled Feb 07 20:45:04 volumioloft volumio[29835]: info: Loading plugin "inputs"... Feb 07 20:45:04 volumioloft volumio[29835]: info: Loading plugin "updater_comm"... Feb 07 20:45:04 volumioloft volumio[29835]: info: Plugin mpdemulation is not enabled Feb 07 20:45:04 volumioloft volumio[29835]: info: Loading plugin "rest_api"... Feb 07 20:45:04 volumioloft volumio[29835]: info: Loading plugin "websocket"... Feb 07 20:45:04 volumioloft volumio[29835]: info: Starting Socket.io Server version 2.3.0 Feb 07 20:45:04 volumioloft volumio[29835]: info: Loading plugin "volusonic"... Feb 07 20:45:04 volumioloft volumio[29835]: Forking 3 albumart workers Feb 07 20:45:05 volumioloft volumio[29835]: info: Applying required configuration parameters for plugin volusonic Feb 07 20:45:05 volumioloft volumio[29835]: info: Loading i18n strings for locale en Feb 07 20:45:05 volumioloft volumio[29835]: Updating browse sources language Feb 07 20:45:05 volumioloft volumio[29835]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 20:45:05 volumioloft volumio[29835]: Starting albumart workers Feb 07 20:45:05 volumioloft volumio[29835]: Starting albumart workers Feb 07 20:45:05 volumioloft volumio[29835]: Starting albumart workers Feb 07 20:45:05 volumioloft volumio[29835]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 07 20:45:05 volumioloft volumio[29835]: info: CoreCommandRouter::initPlayerControls Feb 07 20:45:05 volumioloft volumio[29835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:05 volumioloft volumio[29835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:05 volumioloft volumio[29835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:05 volumioloft volumio[29835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:05 volumioloft volumio[29835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:05 volumioloft volumio[29835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:05 volumioloft volumio[29835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:05 volumioloft volumio[29835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:05 volumioloft volumio[29835]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 07 20:45:05 volumioloft volumio[29835]: Express server listening on port 3000 Feb 07 20:45:05 volumioloft volumio[29835]: [Metrics] WebUI: 6s 213.25ms Feb 07 20:45:05 volumioloft volumio[29835]: info: CoreStateMachine::resetVolumioState Feb 07 20:45:06 volumioloft volumio[29835]: info: CoreStateMachine::getcurrentVolume Feb 07 20:45:06 volumioloft volumio[29835]: info: CoreCommandRouter::volumioRetrievevolume Feb 07 20:45:06 volumioloft volumio[29835]: info: Volumio Network Manager: Network status updated: 0 Feb 07 20:45:06 volumioloft volumio-remote-updater[667]: [2026-02-07 20:45:06] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1770497103 101 Feb 07 20:45:06 volumioloft volumio[29835]: 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 Feb 07 20:45:06 volumioloft volumio[29835]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 20:45:06 volumioloft volumio[29835]: info: Executing start script for DAC IQaudIO DAC Plus Feb 07 20:45:06 volumioloft volumio[29835]: info: Reloading queue from file Feb 07 20:45:06 volumioloft volumio[29835]: info: CoreStateMachine::setRepeat null single undefined Feb 07 20:45:06 volumioloft volumio[29835]: info: CoreStateMachine::pushState Feb 07 20:45:06 volumioloft volumio[29835]: info: CorePlayQueue::getTrack 0 Feb 07 20:45:06 volumioloft volumio[29835]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 07 20:45:06 volumioloft volumio[29835]: info: CoreCommandRouter::volumioPushState Feb 07 20:45:06 volumioloft volumio[29835]: info: CoreStateMachine::setRandom null Feb 07 20:45:06 volumioloft volumio[29835]: info: CoreStateMachine::pushState Feb 07 20:45:06 volumioloft volumio[29835]: info: CorePlayQueue::getTrack 0 Feb 07 20:45:06 volumioloft volumio[29835]: info: CoreCommandRouter::volumioPushState Feb 07 20:45:06 volumioloft volumio[29835]: info: Setting Device type: Raspberry PI Feb 07 20:45:06 volumioloft volumio[29835]: info: VolumeController:: Volume=22 Mute =false Feb 07 20:45:06 volumioloft volumio[29835]: info: CoreStateMachine::pushState Feb 07 20:45:06 volumioloft volumio[29835]: info: CorePlayQueue::getTrack 0 Feb 07 20:45:06 volumioloft volumio[29835]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 07 20:45:06 volumioloft volumio[29835]: info: CoreCommandRouter::volumioPushState Feb 07 20:45:06 volumioloft volumio[29835]: info: CoreStateMachine::updateTrackBlock Feb 07 20:45:06 volumioloft volumio[29835]: info: CorePlayQueue::getTrackBlock Feb 07 20:45:06 volumioloft volumio[29835]: info: CoreCommandRouter::volumioRetrievevolume Feb 07 20:45:06 volumioloft volumio[29835]: info: DAC script executed Feb 07 20:45:06 volumioloft volumio[29835]: info: Completed loading Core Plugins Feb 07 20:45:06 volumioloft volumio[29835]: info: Preparing to generate the ALSA configuration file Feb 07 20:45:06 volumioloft volumio[29835]: info: Asound.conf file unchanged, so no further update is needed Feb 07 20:45:06 volumioloft volumio[29835]: info: Output device has changed, restarting MPD Feb 07 20:45:06 volumioloft sudo[29958]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 07 20:45:06 volumioloft sudo[29958]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:45:06 volumioloft volumio[29835]: info: Output device has changed, restarting Shairport Sync Feb 07 20:45:06 volumioloft volumio[29835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:06 volumioloft volumio[29835]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 20:45:06 volumioloft sudo[29958]: pam_unix(sudo:session): session closed for user root Feb 07 20:45:06 volumioloft sudo[29960]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 07 20:45:06 volumioloft sudo[29960]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:45:06 volumioloft systemd[1]: Stopping Music Player Daemon... Feb 07 20:45:06 volumioloft volumio[29835]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 07 20:45:06 volumioloft volumio[29835]: info: ___________ START PLUGINS ___________ Feb 07 20:45:06 volumioloft volumio[29835]: info: ControllerMpd::onStart: Initializing MPD Feb 07 20:45:06 volumioloft volumio[29835]: info: Creating MPD Configuration file Feb 07 20:45:06 volumioloft systemd[1]: mpd.service: Succeeded. Feb 07 20:45:06 volumioloft systemd[1]: Stopped Music Player Daemon. Feb 07 20:45:06 volumioloft sudo[29968]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 07 20:45:06 volumioloft sudo[29968]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:45:06 volumioloft volumio[29835]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 07 20:45:06 volumioloft volumio[29835]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 07 20:45:06 volumioloft volumio[29835]: info: [1770497106887] CoreMusicLibrary::Adding element Media Servers Feb 07 20:45:06 volumioloft volumio[29835]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 20:45:06 volumioloft volumio[29835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:06 volumioloft volumio[29835]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 20:45:06 volumioloft sudo[29968]: pam_unix(sudo:session): session closed for user root Feb 07 20:45:06 volumioloft systemd[1]: Starting Music Player Daemon... Feb 07 20:45:06 volumioloft sudo[29970]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 07 20:45:06 volumioloft sudo[29970]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:45:06 volumioloft systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Feb 07 20:45:06 volumioloft systemd[1]: mpd.service: Succeeded. Feb 07 20:45:06 volumioloft systemd[1]: Stopped Music Player Daemon. Feb 07 20:45:06 volumioloft systemd[1]: Starting Music Player Daemon... Feb 07 20:45:06 volumioloft volumio[29835]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 07 20:45:06 volumioloft volumio[29835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:06 volumioloft volumio[29835]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 20:45:07 volumioloft volumio[29835]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 07 20:45:07 volumioloft volumio[29835]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 07 20:45:07 volumioloft volumio[29835]: info: [1770497107022] CoreMusicLibrary::Adding element Last_100 Feb 07 20:45:07 volumioloft volumio[29835]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 20:45:07 volumioloft volumio[29835]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 07 20:45:07 volumioloft volumio[29835]: info: [1770497107025] CoreMusicLibrary::Adding element Webradio Feb 07 20:45:07 volumioloft volumio[29835]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 20:45:07 volumioloft volumio[29835]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 07 20:45:07 volumioloft volumio[29835]: info: Initializing BBC Radios Feb 07 20:45:07 volumioloft sudo[29976]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 07 20:45:07 volumioloft sudo[29976]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:45:07 volumioloft sudo[29976]: pam_unix(sudo:session): session closed for user root Feb 07 20:45:07 volumioloft volumio[29835]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 07 20:45:07 volumioloft volumio[29835]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 20:45:07 volumioloft volumio[29835]: info: [squeezelite_mc] Starting proxy server... Feb 07 20:45:07 volumioloft volumio[29835]: info: Loading i18n strings for locale en Feb 07 20:45:07 volumioloft volumio[29835]: Updating browse sources language Feb 07 20:45:07 volumioloft volumio[29835]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 20:45:07 volumioloft volumio[29835]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 07 20:45:07 volumioloft volumio[29835]: info: [1770497107176] CoreMusicLibrary::Adding element Volusonic Feb 07 20:45:07 volumioloft volumio[29835]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 20:45:07 volumioloft volumio[29835]: Cannot find translation for source Volusonic Feb 07 20:45:07 volumioloft volumio[29835]: info: Volumio Calling Home Feb 07 20:45:07 volumioloft volumio[29835]: info: [squeezelite_mc] Proxy server started on port 37867 Feb 07 20:45:07 volumioloft volumio[29835]: info: CoreCommandRouter::volumioRetrievevolume Feb 07 20:45:07 volumioloft volumio[29835]: Unhandled rejection Error: No sockets available, cannot start. Feb 07 20:45:07 volumioloft volumio[29835]: at SsdpClient.SSDP._createSockets (/volumio/node_modules/node-ssdp/lib/index.js:186:11) Feb 07 20:45:07 volumioloft volumio[29835]: at SsdpClient.SSDP._start (/volumio/node_modules/node-ssdp/lib/index.js:229:10) Feb 07 20:45:07 volumioloft volumio[29835]: at /volumio/node_modules/node-ssdp/lib/client.js:60:10 Feb 07 20:45:07 volumioloft volumio[29835]: at Promise._execute (/volumio/node_modules/bluebird/js/release/debuggability.js:384:9) Feb 07 20:45:07 volumioloft volumio[29835]: at Promise._resolveFromExecutor (/volumio/node_modules/bluebird/js/release/promise.js:518:18) Feb 07 20:45:07 volumioloft volumio[29835]: at new Promise (/volumio/node_modules/bluebird/js/release/promise.js:103:10) Feb 07 20:45:07 volumioloft volumio[29835]: at SsdpClient.start (/volumio/node_modules/node-ssdp/lib/client.js:54:10) Feb 07 20:45:07 volumioloft volumio[29835]: at SsdpClient.search (/volumio/node_modules/node-ssdp/lib/client.js:82:17) Feb 07 20:45:07 volumioloft volumio[29835]: at ControllerUPNPBrowser.onStart (/volumio/app/plugins/music_service/upnp_browser/index.js:126:12) Feb 07 20:45:07 volumioloft volumio[29835]: at PluginManager.startCorePlugin (/volumio/app/pluginmanager.js:398:24) Feb 07 20:45:07 volumioloft volumio[29835]: at HashMap. (/volumio/app/pluginmanager.js:496:31) Feb 07 20:45:07 volumioloft volumio[29835]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Feb 07 20:45:07 volumioloft volumio[29835]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Feb 07 20:45:07 volumioloft volumio[29835]: at PluginManager.startCorePlugins (/volumio/app/pluginmanager.js:495:20) Feb 07 20:45:07 volumioloft volumio[29835]: at Promise._successFn (/volumio/app/pluginmanager.js:142:29) Feb 07 20:45:07 volumioloft volumio[29835]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Feb 07 20:45:07 volumioloft volumio[29835]: info: MPD Permissions set Feb 07 20:45:07 volumioloft volumio[29835]: info: MPD Permissions set Feb 07 20:45:07 volumioloft volumio[29835]: info: VolumeController:: Volume=22 Mute =false Feb 07 20:45:07 volumioloft volumio[29835]: info: CoreStateMachine::pushState Feb 07 20:45:07 volumioloft volumio[29835]: info: CorePlayQueue::getTrack 0 Feb 07 20:45:07 volumioloft volumio[29835]: info: CoreCommandRouter::volumioPushState Feb 07 20:45:07 volumioloft volumio[29835]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Feb 07 20:45:07 volumioloft volumio[29835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:07 volumioloft volumio[29835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:07 volumioloft volumio[29835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:07 volumioloft volumio[29835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:07 volumioloft volumio[29835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:07 volumioloft volumio[29835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:07 volumioloft volumio[29835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:07 volumioloft volumio[29835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:07 volumioloft volumio[29835]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 20:45:07 volumioloft volumio[29835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:07 volumioloft volumio[29835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:07 volumioloft volumio[29835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:07 volumioloft volumio[29835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:07 volumioloft volumio[29835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:07 volumioloft volumio[29835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:07 volumioloft volumio[29835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:07 volumioloft volumio[29835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:07 volumioloft volumio[29835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:07 volumioloft volumio[29835]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 20:45:07 volumioloft volumio[29835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:07 volumioloft volumio[29835]: info: VolumeController:: Volume=22 Mute =false Feb 07 20:45:07 volumioloft volumio[29835]: info: CoreStateMachine::pushState Feb 07 20:45:07 volumioloft volumio[29835]: info: CorePlayQueue::getTrack 0 Feb 07 20:45:07 volumioloft volumio[29835]: info: CoreCommandRouter::volumioPushState Feb 07 20:45:07 volumioloft volumio[29835]: info: [squeezelite_mc] Server discovery started Feb 07 20:45:07 volumioloft volumio[29835]: info: [squeezelite_mc] Player finder started Feb 07 20:45:07 volumioloft volumio[29835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:07 volumioloft volumio[29835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:07 volumioloft volumio[29835]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:07 volumioloft volumio[29835]: info: [squeezelite_mc] Starting Squeezelite service with params: {"type":"manual","startupOptions":"-s 10.0.0.101:3483 -o squeezelite -C 1 -n \"volumioloft\" -V \"Digital\" -f /tmp/squeezelite.log","card":"2","mixerType":"Hardware","mixer":"Digital"} Feb 07 20:45:07 volumioloft volumio[29835]: 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 Feb 07 20:45:07 volumioloft volumio[29835]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 07 20:45:07 volumioloft volumio[29835]: Error: send ENETUNREACH 255.255.255.255:3483 Feb 07 20:45:07 volumioloft volumio[29835]: at doSend (dgram.js:692:16) Feb 07 20:45:07 volumioloft volumio[29835]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:430:12) Feb 07 20:45:07 volumioloft volumio[29835]: at afterDns (dgram.js:638:5) Feb 07 20:45:07 volumioloft volumio[29835]: at processTicksAndRejections (internal/process/task_queues.js:81:21) { Feb 07 20:45:07 volumioloft volumio[29835]: errno: -101, Feb 07 20:45:07 volumioloft volumio[29835]: code: 'ENETUNREACH', Feb 07 20:45:07 volumioloft volumio[29835]: syscall: 'send', Feb 07 20:45:07 volumioloft volumio[29835]: address: '255.255.255.255', Feb 07 20:45:07 volumioloft volumio[29835]: port: 3483 Feb 07 20:45:07 volumioloft volumio[29835]: } Feb 07 20:45:07 volumioloft volumio[29835]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 07 20:45:07 volumioloft sudo[30007]: 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 Feb 07 20:45:07 volumioloft sudo[30007]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:45:07 volumioloft sudo[30007]: pam_unix(sudo:session): session closed for user root Feb 07 20:45:08 volumioloft sudo[30018]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-02-07 20:44 Feb 07 20:45:08 volumioloft sudo[30018]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:45:08 volumioloft sudo[30018]: pam_unix(sudo:session): session closed for user root Feb 07 20:45:08 volumioloft volumio-remote-updater[667]: [2026-02-07 20:45:08] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Feb 07 20:45:08 volumioloft volumio-remote-updater[667]: [2026-02-07 20:45:08] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Feb 07 20:45:08 volumioloft systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Feb 07 20:45:08 volumioloft sudo[29960]: pam_unix(sudo:session): session closed for user root Feb 07 20:45:08 volumioloft sudo[29970]: pam_unix(sudo:session): session closed for user root Feb 07 20:45:08 volumioloft systemd[1]: volumio.service: Failed with result 'exit-code'. Feb 07 20:45:08 volumioloft systemd[1]: Started dynamicswap service. Feb 07 20:45:08 volumioloft mpd[29988]: decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 07 20:45:08 volumioloft mpd[29988]: output: No 'audio_output' defined in config file Feb 07 20:45:08 volumioloft systemd[1]: dynamicswap.service: Succeeded. Feb 07 20:45:08 volumioloft mpd[29988]: output: Successfully detected a sndio audio device Feb 07 20:45:08 volumioloft mpd[29988]: zeroconf: No global port, disabling zeroconf Feb 07 20:45:08 volumioloft systemd[1]: Started Music Player Daemon. Feb 07 20:45:08 volumioloft systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Feb 07 20:45:08 volumioloft systemd[1]: volumio.service: Scheduled restart job, restart counter is at 91. Feb 07 20:45:08 volumioloft systemd[1]: Started dynamicswap service. Feb 07 20:45:08 volumioloft systemd[1]: Stopped Volumio Backend Module. Feb 07 20:45:08 volumioloft systemd[1]: Started Volumio Backend Module. Feb 07 20:45:08 volumioloft systemd[1]: dynamicswap.service: Succeeded. Feb 07 20:45:09 volumioloft wpa_supplicant[892]: wlan0: Failed to initiate sched scan Feb 07 20:45:10 volumioloft volumio[30035]: info: ------------------------------------------- Feb 07 20:45:10 volumioloft volumio[30035]: info: ----- Volumio3 ---- Feb 07 20:45:10 volumioloft volumio[30035]: info: ------------------------------------------- Feb 07 20:45:10 volumioloft volumio[30035]: info: ----- System startup ---- Feb 07 20:45:10 volumioloft volumio[30035]: info: ------------------------------------------- Feb 07 20:45:11 volumioloft volumio[30035]: info: MYVOLUMIO Environment detected Feb 07 20:45:11 volumioloft volumio[30035]: info: Plugin folders cleanup Feb 07 20:45:11 volumioloft volumio[30035]: info: Scanning into folder /volumio/app/plugins/ Feb 07 20:45:11 volumioloft volumio[30035]: info: Scanning category audio_interface Feb 07 20:45:11 volumioloft volumio[30035]: info: Scanning category miscellanea Feb 07 20:45:11 volumioloft volumio[30035]: info: Scanning category music_service Feb 07 20:45:11 volumioloft volumio[30035]: info: Scanning category plugins.json Feb 07 20:45:11 volumioloft volumio[30035]: info: Scanning category system_controller Feb 07 20:45:11 volumioloft volumio[30035]: info: Scanning category user_interface Feb 07 20:45:11 volumioloft volumio[30035]: info: Scanning into folder /data/plugins/ Feb 07 20:45:11 volumioloft volumio[30035]: info: Scanning category music_service Feb 07 20:45:11 volumioloft volumio[30035]: info: Plugin folders cleanup completed Feb 07 20:45:11 volumioloft volumio[30035]: info: ------------------------------------------- Feb 07 20:45:11 volumioloft volumio[30035]: info: ----- Core plugins startup ---- Feb 07 20:45:11 volumioloft volumio[30035]: info: ------------------------------------------- Feb 07 20:45:11 volumioloft volumio[30035]: info: Loading plugins from folder /volumio/app/plugins/ Feb 07 20:45:11 volumioloft volumio[30035]: info: Adding plugin upnp to MyMusic Plugins Feb 07 20:45:11 volumioloft volumio[30035]: info: Adding plugin airplay_emulation to MyMusic Plugins Feb 07 20:45:11 volumioloft volumio[30035]: info: Adding plugin upnp_browser to MyMusic Plugins Feb 07 20:45:11 volumioloft volumio[30035]: info: Loading plugins from folder /data/plugins/ Feb 07 20:45:11 volumioloft volumio[30035]: info: Loading plugin "system"... Feb 07 20:45:11 volumioloft volumio[30035]: info: Loading plugin "appearance"... Feb 07 20:45:12 volumioloft volumio[30035]: info: Loading plugin "network"... Feb 07 20:45:12 volumioloft volumio[30035]: info: Refreshing Cached IP Addresses Feb 07 20:45:12 volumioloft sudo[30061]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 07 20:45:12 volumioloft sudo[30061]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:45:12 volumioloft sudo[30061]: pam_unix(sudo:session): session closed for user root Feb 07 20:45:12 volumioloft sudo[30063]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 07 20:45:12 volumioloft sudo[30063]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:45:12 volumioloft sudo[30063]: pam_unix(sudo:session): session closed for user root Feb 07 20:45:12 volumioloft volumio[30035]: info: Loading plugin "services"... Feb 07 20:45:12 volumioloft volumio[30035]: info: Loading plugin "alsa_controller"... Feb 07 20:45:12 volumioloft sudo[30072]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Feb 07 20:45:12 volumioloft sudo[30072]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:45:12 volumioloft volumio[30035]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 07 20:45:12 volumioloft volumio[30035]: info: Loading plugin "wizard"... Feb 07 20:45:12 volumioloft volumio[30035]: info: Loading plugin "networkfs"... Feb 07 20:45:12 volumioloft volumio[30035]: info: Starting Udev Watcher for removable devices Feb 07 20:45:12 volumioloft volumio[30035]: info: Ignoring mount for partition: boot Feb 07 20:45:12 volumioloft volumio[30035]: info: Ignoring mount for partition: volumio Feb 07 20:45:12 volumioloft volumio[30035]: info: Ignoring mount for partition: volumio_data Feb 07 20:45:12 volumioloft volumio[30035]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 07 20:45:12 volumioloft volumio[30035]: info: Loading plugin "volumio_command_line_client"... Feb 07 20:45:12 volumioloft volumio[30035]: info: Loading plugin "upnp"... Feb 07 20:45:12 volumioloft volumio[30035]: info: [1770497112759] Starting Upmpd Daemon Feb 07 20:45:12 volumioloft volumio[30035]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 07 20:45:12 volumioloft volumio[30035]: info: Loading plugin "my_music"... Feb 07 20:45:12 volumioloft volumio[30035]: info: Loading plugin "mpd"... Feb 07 20:45:13 volumioloft volumio[30035]: info: Loading plugin "upnp_browser"... Feb 07 20:45:13 volumioloft sudo[30072]: pam_unix(sudo:session): session closed for user root Feb 07 20:45:13 volumioloft volumio[30035]: info: Loading plugin "alarm-clock"... Feb 07 20:45:13 volumioloft volumio[30035]: info: Loading plugin "airplay_emulation"... Feb 07 20:45:13 volumioloft volumio[30035]: info: Starting Shairport Sync Feb 07 20:45:13 volumioloft volumio[30035]: info: Loading plugin "last_100"... Feb 07 20:45:13 volumioloft volumio[30035]: info: Loading plugin "webradio"... Feb 07 20:45:13 volumioloft volumio-remote-updater[667]: [2026-02-07 20:45:13] [connect] Successful connection Feb 07 20:45:13 volumioloft volumio[30035]: info: Loading plugin "i2s_dacs"... Feb 07 20:45:13 volumioloft volumio[30035]: info: Loading plugin "volumiodiscovery"... Feb 07 20:45:13 volumioloft volumio[30035]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 07 20:45:13 volumioloft volumio[30035]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 07 20:45:13 volumioloft volumio[30035]: *** WARNING *** For more information see Feb 07 20:45:13 volumioloft node[30035]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 07 20:45:13 volumioloft volumio[30035]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 07 20:45:13 volumioloft volumio[30035]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 07 20:45:13 volumioloft volumio[30035]: *** WARNING *** For more information see Feb 07 20:45:13 volumioloft node[30035]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 07 20:45:13 volumioloft node[30035]: *** WARNING *** For more information see Feb 07 20:45:13 volumioloft node[30035]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 07 20:45:13 volumioloft node[30035]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 07 20:45:13 volumioloft node[30035]: *** WARNING *** For more information see Feb 07 20:45:13 volumioloft volumio[30035]: info: Applying required configuration parameters for plugin volumiodiscovery Feb 07 20:45:13 volumioloft volumio[30035]: info: Discovery: Started advertising with name: Volumioloft Feb 07 20:45:13 volumioloft volumio[30035]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 07 20:45:13 volumioloft volumio[30035]: info: Loading plugin "squeezelite_mc"... Feb 07 20:45:14 volumioloft volumio[30035]: info: Loading plugin "outputs"... Feb 07 20:45:14 volumioloft volumio[30035]: info: Loading plugin "albumart"... Feb 07 20:45:14 volumioloft volumio[30035]: info: Plugin example_plugin is not enabled Feb 07 20:45:14 volumioloft volumio[30035]: info: Loading plugin "inputs"... Feb 07 20:45:14 volumioloft volumio[30035]: info: Loading plugin "updater_comm"... Feb 07 20:45:14 volumioloft wpa_supplicant[892]: wlan0: Failed to initiate sched scan Feb 07 20:45:14 volumioloft volumio[30035]: info: Plugin mpdemulation is not enabled Feb 07 20:45:14 volumioloft volumio[30035]: info: Loading plugin "rest_api"... Feb 07 20:45:14 volumioloft volumio[30035]: info: Loading plugin "websocket"... Feb 07 20:45:14 volumioloft volumio[30035]: info: Starting Socket.io Server version 2.3.0 Feb 07 20:45:14 volumioloft volumio[30035]: info: Loading plugin "volusonic"... Feb 07 20:45:15 volumioloft volumio[30035]: Forking 3 albumart workers Feb 07 20:45:16 volumioloft volumio[30035]: info: Applying required configuration parameters for plugin volusonic Feb 07 20:45:16 volumioloft volumio[30035]: Starting albumart workers Feb 07 20:45:16 volumioloft volumio[30035]: Starting albumart workers Feb 07 20:45:16 volumioloft volumio[30035]: info: Loading i18n strings for locale en Feb 07 20:45:16 volumioloft volumio[30035]: Starting albumart workers Feb 07 20:45:16 volumioloft volumio[30035]: Updating browse sources language Feb 07 20:45:16 volumioloft volumio[30035]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 20:45:16 volumioloft volumio[30035]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 07 20:45:16 volumioloft volumio[30035]: info: CoreCommandRouter::initPlayerControls Feb 07 20:45:16 volumioloft volumio[30035]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:16 volumioloft volumio[30035]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:16 volumioloft volumio[30035]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:16 volumioloft volumio[30035]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:16 volumioloft volumio[30035]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:16 volumioloft volumio[30035]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:16 volumioloft volumio[30035]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:16 volumioloft volumio[30035]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:16 volumioloft volumio[30035]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 07 20:45:16 volumioloft volumio[30035]: Express server listening on port 3000 Feb 07 20:45:16 volumioloft volumio[30035]: [Metrics] WebUI: 6s 308.06ms Feb 07 20:45:16 volumioloft volumio[30035]: info: CoreStateMachine::resetVolumioState Feb 07 20:45:16 volumioloft volumio[30035]: info: CoreStateMachine::getcurrentVolume Feb 07 20:45:16 volumioloft volumio[30035]: info: CoreCommandRouter::volumioRetrievevolume Feb 07 20:45:16 volumioloft volumio[30035]: info: Volumio Network Manager: Network status updated: 0 Feb 07 20:45:16 volumioloft volumio-remote-updater[667]: [2026-02-07 20:45:16] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1770497113 101 Feb 07 20:45:16 volumioloft volumio[30035]: 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 Feb 07 20:45:16 volumioloft volumio[30035]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 20:45:16 volumioloft volumio[30035]: info: Executing start script for DAC IQaudIO DAC Plus Feb 07 20:45:16 volumioloft volumio[30035]: info: Reloading queue from file Feb 07 20:45:16 volumioloft volumio[30035]: info: CoreStateMachine::setRepeat null single undefined Feb 07 20:45:16 volumioloft volumio[30035]: info: CoreStateMachine::pushState Feb 07 20:45:16 volumioloft volumio[30035]: info: CorePlayQueue::getTrack 0 Feb 07 20:45:16 volumioloft volumio[30035]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 07 20:45:16 volumioloft volumio[30035]: info: CoreCommandRouter::volumioPushState Feb 07 20:45:16 volumioloft volumio[30035]: info: CoreStateMachine::setRandom null Feb 07 20:45:16 volumioloft volumio[30035]: info: CoreStateMachine::pushState Feb 07 20:45:16 volumioloft volumio[30035]: info: CorePlayQueue::getTrack 0 Feb 07 20:45:16 volumioloft volumio[30035]: info: CoreCommandRouter::volumioPushState Feb 07 20:45:16 volumioloft volumio[30035]: info: Setting Device type: Raspberry PI Feb 07 20:45:17 volumioloft volumio[30035]: info: VolumeController:: Volume=22 Mute =false Feb 07 20:45:17 volumioloft volumio[30035]: info: CoreStateMachine::pushState Feb 07 20:45:17 volumioloft volumio[30035]: info: CorePlayQueue::getTrack 0 Feb 07 20:45:17 volumioloft volumio[30035]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 07 20:45:17 volumioloft volumio[30035]: info: CoreCommandRouter::volumioPushState Feb 07 20:45:17 volumioloft volumio[30035]: info: CoreStateMachine::updateTrackBlock Feb 07 20:45:17 volumioloft volumio[30035]: info: CorePlayQueue::getTrackBlock Feb 07 20:45:17 volumioloft volumio[30035]: info: CoreCommandRouter::volumioRetrievevolume Feb 07 20:45:17 volumioloft volumio[30035]: info: DAC script executed Feb 07 20:45:17 volumioloft volumio[30035]: info: Completed loading Core Plugins Feb 07 20:45:17 volumioloft volumio[30035]: info: Preparing to generate the ALSA configuration file Feb 07 20:45:17 volumioloft volumio[30035]: info: Asound.conf file unchanged, so no further update is needed Feb 07 20:45:17 volumioloft volumio[30035]: info: Output device has changed, restarting MPD Feb 07 20:45:17 volumioloft sudo[30158]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 07 20:45:17 volumioloft sudo[30158]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:45:17 volumioloft volumio[30035]: info: Output device has changed, restarting Shairport Sync Feb 07 20:45:17 volumioloft volumio[30035]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:17 volumioloft volumio[30035]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 20:45:17 volumioloft sudo[30158]: pam_unix(sudo:session): session closed for user root Feb 07 20:45:17 volumioloft sudo[30161]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 07 20:45:17 volumioloft sudo[30161]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:45:17 volumioloft systemd[1]: Stopping Music Player Daemon... Feb 07 20:45:17 volumioloft volumio[30035]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 07 20:45:17 volumioloft volumio[30035]: info: ___________ START PLUGINS ___________ Feb 07 20:45:17 volumioloft volumio[30035]: info: ControllerMpd::onStart: Initializing MPD Feb 07 20:45:17 volumioloft volumio[30035]: info: Creating MPD Configuration file Feb 07 20:45:17 volumioloft systemd[1]: mpd.service: Succeeded. Feb 07 20:45:17 volumioloft systemd[1]: Stopped Music Player Daemon. Feb 07 20:45:17 volumioloft sudo[30168]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 07 20:45:17 volumioloft volumio[30035]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 07 20:45:17 volumioloft volumio[30035]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 07 20:45:17 volumioloft volumio[30035]: info: [1770497117241] CoreMusicLibrary::Adding element Media Servers Feb 07 20:45:17 volumioloft volumio[30035]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 20:45:17 volumioloft volumio[30035]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:17 volumioloft volumio[30035]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 20:45:17 volumioloft sudo[30168]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:45:17 volumioloft systemd[1]: Starting Music Player Daemon... Feb 07 20:45:17 volumioloft sudo[30168]: pam_unix(sudo:session): session closed for user root Feb 07 20:45:17 volumioloft sudo[30170]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 07 20:45:17 volumioloft sudo[30170]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:45:17 volumioloft systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Feb 07 20:45:17 volumioloft systemd[1]: mpd.service: Succeeded. Feb 07 20:45:17 volumioloft systemd[1]: Stopped Music Player Daemon. Feb 07 20:45:17 volumioloft systemd[1]: Starting Music Player Daemon... Feb 07 20:45:17 volumioloft volumio[30035]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 07 20:45:17 volumioloft volumio[30035]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:17 volumioloft volumio[30035]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 20:45:17 volumioloft volumio[30035]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 07 20:45:17 volumioloft volumio[30035]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 07 20:45:17 volumioloft volumio[30035]: info: [1770497117372] CoreMusicLibrary::Adding element Last_100 Feb 07 20:45:17 volumioloft volumio[30035]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 20:45:17 volumioloft volumio[30035]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 07 20:45:17 volumioloft volumio[30035]: info: [1770497117376] CoreMusicLibrary::Adding element Webradio Feb 07 20:45:17 volumioloft volumio[30035]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 20:45:17 volumioloft volumio[30035]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 07 20:45:17 volumioloft volumio[30035]: info: Initializing BBC Radios Feb 07 20:45:17 volumioloft sudo[30176]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 07 20:45:17 volumioloft sudo[30176]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:45:17 volumioloft sudo[30176]: pam_unix(sudo:session): session closed for user root Feb 07 20:45:17 volumioloft volumio[30035]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 07 20:45:17 volumioloft volumio[30035]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 20:45:17 volumioloft volumio[30035]: info: [squeezelite_mc] Starting proxy server... Feb 07 20:45:17 volumioloft volumio[30035]: info: Loading i18n strings for locale en Feb 07 20:45:17 volumioloft volumio[30035]: Updating browse sources language Feb 07 20:45:17 volumioloft volumio[30035]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 20:45:17 volumioloft volumio[30035]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 07 20:45:17 volumioloft volumio[30035]: info: [1770497117543] CoreMusicLibrary::Adding element Volusonic Feb 07 20:45:17 volumioloft volumio[30035]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 20:45:17 volumioloft volumio[30035]: Cannot find translation for source Volusonic Feb 07 20:45:17 volumioloft volumio[30035]: info: Volumio Calling Home Feb 07 20:45:17 volumioloft volumio[30035]: info: [squeezelite_mc] Proxy server started on port 45545 Feb 07 20:45:17 volumioloft volumio[30035]: info: CoreCommandRouter::volumioRetrievevolume Feb 07 20:45:17 volumioloft volumio[30035]: Unhandled rejection Error: No sockets available, cannot start. Feb 07 20:45:17 volumioloft volumio[30035]: at SsdpClient.SSDP._createSockets (/volumio/node_modules/node-ssdp/lib/index.js:186:11) Feb 07 20:45:17 volumioloft volumio[30035]: at SsdpClient.SSDP._start (/volumio/node_modules/node-ssdp/lib/index.js:229:10) Feb 07 20:45:17 volumioloft volumio[30035]: at /volumio/node_modules/node-ssdp/lib/client.js:60:10 Feb 07 20:45:17 volumioloft volumio[30035]: at Promise._execute (/volumio/node_modules/bluebird/js/release/debuggability.js:384:9) Feb 07 20:45:17 volumioloft volumio[30035]: at Promise._resolveFromExecutor (/volumio/node_modules/bluebird/js/release/promise.js:518:18) Feb 07 20:45:17 volumioloft volumio[30035]: at new Promise (/volumio/node_modules/bluebird/js/release/promise.js:103:10) Feb 07 20:45:17 volumioloft volumio[30035]: at SsdpClient.start (/volumio/node_modules/node-ssdp/lib/client.js:54:10) Feb 07 20:45:17 volumioloft volumio[30035]: at SsdpClient.search (/volumio/node_modules/node-ssdp/lib/client.js:82:17) Feb 07 20:45:17 volumioloft volumio[30035]: at ControllerUPNPBrowser.onStart (/volumio/app/plugins/music_service/upnp_browser/index.js:126:12) Feb 07 20:45:17 volumioloft volumio[30035]: at PluginManager.startCorePlugin (/volumio/app/pluginmanager.js:398:24) Feb 07 20:45:17 volumioloft volumio[30035]: at HashMap. (/volumio/app/pluginmanager.js:496:31) Feb 07 20:45:17 volumioloft volumio[30035]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Feb 07 20:45:17 volumioloft volumio[30035]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Feb 07 20:45:17 volumioloft volumio[30035]: at PluginManager.startCorePlugins (/volumio/app/pluginmanager.js:495:20) Feb 07 20:45:17 volumioloft volumio[30035]: at Promise._successFn (/volumio/app/pluginmanager.js:142:29) Feb 07 20:45:17 volumioloft volumio[30035]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Feb 07 20:45:17 volumioloft volumio[30035]: info: MPD Permissions set Feb 07 20:45:17 volumioloft volumio[30035]: info: MPD Permissions set Feb 07 20:45:17 volumioloft volumio[30035]: info: VolumeController:: Volume=22 Mute =false Feb 07 20:45:17 volumioloft volumio[30035]: info: CoreStateMachine::pushState Feb 07 20:45:17 volumioloft volumio[30035]: info: CorePlayQueue::getTrack 0 Feb 07 20:45:17 volumioloft volumio[30035]: info: CoreCommandRouter::volumioPushState Feb 07 20:45:17 volumioloft volumio[30035]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Feb 07 20:45:17 volumioloft volumio[30035]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:17 volumioloft volumio[30035]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:17 volumioloft volumio[30035]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:17 volumioloft volumio[30035]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:17 volumioloft volumio[30035]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:17 volumioloft volumio[30035]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:17 volumioloft volumio[30035]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:17 volumioloft volumio[30035]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:17 volumioloft volumio[30035]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 20:45:17 volumioloft volumio[30035]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:17 volumioloft volumio[30035]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:17 volumioloft volumio[30035]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:17 volumioloft volumio[30035]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:17 volumioloft volumio[30035]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:17 volumioloft volumio[30035]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:17 volumioloft volumio[30035]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:17 volumioloft volumio[30035]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:17 volumioloft volumio[30035]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:17 volumioloft volumio[30035]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 20:45:17 volumioloft volumio[30035]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:18 volumioloft volumio[30035]: info: VolumeController:: Volume=22 Mute =false Feb 07 20:45:18 volumioloft volumio[30035]: info: CoreStateMachine::pushState Feb 07 20:45:18 volumioloft volumio[30035]: info: CorePlayQueue::getTrack 0 Feb 07 20:45:18 volumioloft volumio[30035]: info: CoreCommandRouter::volumioPushState Feb 07 20:45:18 volumioloft volumio[30035]: info: [squeezelite_mc] Server discovery started Feb 07 20:45:18 volumioloft volumio[30035]: info: [squeezelite_mc] Player finder started Feb 07 20:45:18 volumioloft volumio[30035]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:18 volumioloft volumio[30035]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:18 volumioloft volumio[30035]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:18 volumioloft volumio[30035]: info: [squeezelite_mc] Starting Squeezelite service with params: {"type":"manual","startupOptions":"-s 10.0.0.101:3483 -o squeezelite -C 1 -n \"volumioloft\" -V \"Digital\" -f /tmp/squeezelite.log","card":"2","mixerType":"Hardware","mixer":"Digital"} Feb 07 20:45:18 volumioloft volumio[30035]: 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 Feb 07 20:45:18 volumioloft volumio[30035]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 07 20:45:18 volumioloft volumio[30035]: Error: send ENETUNREACH 255.255.255.255:3483 Feb 07 20:45:18 volumioloft volumio[30035]: at doSend (dgram.js:692:16) Feb 07 20:45:18 volumioloft volumio[30035]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:430:12) Feb 07 20:45:18 volumioloft volumio[30035]: at afterDns (dgram.js:638:5) Feb 07 20:45:18 volumioloft volumio[30035]: at processTicksAndRejections (internal/process/task_queues.js:81:21) { Feb 07 20:45:18 volumioloft volumio[30035]: errno: -101, Feb 07 20:45:18 volumioloft volumio[30035]: code: 'ENETUNREACH', Feb 07 20:45:18 volumioloft volumio[30035]: syscall: 'send', Feb 07 20:45:18 volumioloft volumio[30035]: address: '255.255.255.255', Feb 07 20:45:18 volumioloft volumio[30035]: port: 3483 Feb 07 20:45:18 volumioloft volumio[30035]: } Feb 07 20:45:18 volumioloft volumio[30035]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 07 20:45:18 volumioloft sudo[30207]: 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 Feb 07 20:45:18 volumioloft sudo[30207]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:45:18 volumioloft sudo[30207]: pam_unix(sudo:session): session closed for user root Feb 07 20:45:18 volumioloft sudo[30258]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-02-07 20:44 Feb 07 20:45:18 volumioloft sudo[30258]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:45:18 volumioloft sudo[30258]: pam_unix(sudo:session): session closed for user root Feb 07 20:45:19 volumioloft volumio-remote-updater[667]: [2026-02-07 20:45:19] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Feb 07 20:45:19 volumioloft volumio-remote-updater[667]: [2026-02-07 20:45:19] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Feb 07 20:45:19 volumioloft systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Feb 07 20:45:19 volumioloft sudo[30170]: pam_unix(sudo:session): session closed for user root Feb 07 20:45:19 volumioloft sudo[30161]: pam_unix(sudo:session): session closed for user root Feb 07 20:45:19 volumioloft systemd[1]: volumio.service: Failed with result 'exit-code'. Feb 07 20:45:19 volumioloft mpd[30187]: Feb 07 20:45 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 07 20:45:19 volumioloft systemd[1]: Started dynamicswap service. Feb 07 20:45:19 volumioloft systemd[1]: Started Music Player Daemon. Feb 07 20:45:19 volumioloft systemd[1]: dynamicswap.service: Succeeded. Feb 07 20:45:19 volumioloft systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Feb 07 20:45:19 volumioloft systemd[1]: volumio.service: Scheduled restart job, restart counter is at 92. Feb 07 20:45:19 volumioloft systemd[1]: Started dynamicswap service. Feb 07 20:45:19 volumioloft systemd[1]: Stopped Volumio Backend Module. Feb 07 20:45:19 volumioloft systemd[1]: Started Volumio Backend Module. Feb 07 20:45:19 volumioloft systemd[1]: dynamicswap.service: Succeeded. Feb 07 20:45:20 volumioloft wpa_supplicant[892]: wlan0: Failed to initiate sched scan Feb 07 20:45:21 volumioloft volumio[30275]: info: ------------------------------------------- Feb 07 20:45:21 volumioloft volumio[30275]: info: ----- Volumio3 ---- Feb 07 20:45:21 volumioloft volumio[30275]: info: ------------------------------------------- Feb 07 20:45:21 volumioloft volumio[30275]: info: ----- System startup ---- Feb 07 20:45:21 volumioloft volumio[30275]: info: ------------------------------------------- Feb 07 20:45:21 volumioloft volumio[30275]: info: MYVOLUMIO Environment detected Feb 07 20:45:21 volumioloft volumio[30275]: info: Plugin folders cleanup Feb 07 20:45:21 volumioloft volumio[30275]: info: Scanning into folder /volumio/app/plugins/ Feb 07 20:45:21 volumioloft volumio[30275]: info: Scanning category audio_interface Feb 07 20:45:21 volumioloft volumio[30275]: info: Scanning category miscellanea Feb 07 20:45:21 volumioloft volumio[30275]: info: Scanning category music_service Feb 07 20:45:21 volumioloft volumio[30275]: info: Scanning category plugins.json Feb 07 20:45:21 volumioloft volumio[30275]: info: Scanning category system_controller Feb 07 20:45:21 volumioloft volumio[30275]: info: Scanning category user_interface Feb 07 20:45:21 volumioloft volumio[30275]: info: Scanning into folder /data/plugins/ Feb 07 20:45:21 volumioloft volumio[30275]: info: Scanning category music_service Feb 07 20:45:21 volumioloft volumio[30275]: info: Plugin folders cleanup completed Feb 07 20:45:21 volumioloft volumio[30275]: info: ------------------------------------------- Feb 07 20:45:21 volumioloft volumio[30275]: info: ----- Core plugins startup ---- Feb 07 20:45:21 volumioloft volumio[30275]: info: ------------------------------------------- Feb 07 20:45:21 volumioloft volumio[30275]: info: Loading plugins from folder /volumio/app/plugins/ Feb 07 20:45:21 volumioloft volumio[30275]: info: Adding plugin upnp to MyMusic Plugins Feb 07 20:45:21 volumioloft volumio[30275]: info: Adding plugin airplay_emulation to MyMusic Plugins Feb 07 20:45:21 volumioloft volumio[30275]: info: Adding plugin upnp_browser to MyMusic Plugins Feb 07 20:45:21 volumioloft volumio[30275]: info: Loading plugins from folder /data/plugins/ Feb 07 20:45:21 volumioloft volumio[30275]: info: Loading plugin "system"... Feb 07 20:45:21 volumioloft volumio[30275]: info: Loading plugin "appearance"... Feb 07 20:45:22 volumioloft volumio[30275]: info: Loading plugin "network"... Feb 07 20:45:22 volumioloft volumio[30275]: info: Refreshing Cached IP Addresses Feb 07 20:45:22 volumioloft sudo[30301]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 07 20:45:22 volumioloft sudo[30301]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:45:22 volumioloft sudo[30301]: pam_unix(sudo:session): session closed for user root Feb 07 20:45:22 volumioloft sudo[30303]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 07 20:45:22 volumioloft sudo[30303]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:45:22 volumioloft sudo[30303]: pam_unix(sudo:session): session closed for user root Feb 07 20:45:22 volumioloft volumio[30275]: info: Loading plugin "services"... Feb 07 20:45:22 volumioloft volumio[30275]: info: Loading plugin "alsa_controller"... Feb 07 20:45:22 volumioloft sudo[30312]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Feb 07 20:45:22 volumioloft sudo[30312]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:45:23 volumioloft volumio[30275]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 07 20:45:23 volumioloft volumio[30275]: info: Loading plugin "wizard"... Feb 07 20:45:23 volumioloft volumio[30275]: info: Loading plugin "networkfs"... Feb 07 20:45:23 volumioloft volumio[30275]: info: Starting Udev Watcher for removable devices Feb 07 20:45:23 volumioloft volumio[30275]: info: Ignoring mount for partition: boot Feb 07 20:45:23 volumioloft volumio[30275]: info: Ignoring mount for partition: volumio Feb 07 20:45:23 volumioloft volumio[30275]: info: Ignoring mount for partition: volumio_data Feb 07 20:45:23 volumioloft volumio[30275]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 07 20:45:23 volumioloft volumio[30275]: info: Loading plugin "volumio_command_line_client"... Feb 07 20:45:23 volumioloft volumio[30275]: info: Loading plugin "upnp"... Feb 07 20:45:23 volumioloft volumio[30275]: info: [1770497123158] Starting Upmpd Daemon Feb 07 20:45:23 volumioloft volumio[30275]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 07 20:45:23 volumioloft volumio[30275]: info: Loading plugin "my_music"... Feb 07 20:45:23 volumioloft volumio[30275]: info: Loading plugin "mpd"... Feb 07 20:45:23 volumioloft volumio[30275]: info: Loading plugin "upnp_browser"... Feb 07 20:45:23 volumioloft sudo[30312]: pam_unix(sudo:session): session closed for user root Feb 07 20:45:23 volumioloft volumio[30275]: info: Loading plugin "alarm-clock"... Feb 07 20:45:23 volumioloft volumio[30275]: info: Loading plugin "airplay_emulation"... Feb 07 20:45:23 volumioloft volumio[30275]: info: Starting Shairport Sync Feb 07 20:45:23 volumioloft volumio[30275]: info: Loading plugin "last_100"... Feb 07 20:45:23 volumioloft volumio[30275]: info: Loading plugin "webradio"... Feb 07 20:45:24 volumioloft volumio-remote-updater[667]: [2026-02-07 20:45:24] [connect] Successful connection Feb 07 20:45:24 volumioloft volumio[30275]: info: Loading plugin "i2s_dacs"... Feb 07 20:45:24 volumioloft volumio[30275]: info: Loading plugin "volumiodiscovery"... Feb 07 20:45:24 volumioloft volumio[30275]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 07 20:45:24 volumioloft volumio[30275]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 07 20:45:24 volumioloft volumio[30275]: *** WARNING *** For more information see Feb 07 20:45:24 volumioloft node[30275]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 07 20:45:24 volumioloft volumio[30275]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 07 20:45:24 volumioloft volumio[30275]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 07 20:45:24 volumioloft volumio[30275]: *** WARNING *** For more information see Feb 07 20:45:24 volumioloft node[30275]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 07 20:45:24 volumioloft node[30275]: *** WARNING *** For more information see Feb 07 20:45:24 volumioloft node[30275]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 07 20:45:24 volumioloft node[30275]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 07 20:45:24 volumioloft node[30275]: *** WARNING *** For more information see Feb 07 20:45:24 volumioloft volumio[30275]: info: Applying required configuration parameters for plugin volumiodiscovery Feb 07 20:45:24 volumioloft volumio[30275]: info: Discovery: Started advertising with name: Volumioloft Feb 07 20:45:24 volumioloft volumio[30275]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 07 20:45:24 volumioloft volumio[30275]: info: Loading plugin "squeezelite_mc"... Feb 07 20:45:25 volumioloft volumio[30275]: info: Loading plugin "outputs"... Feb 07 20:45:25 volumioloft volumio[30275]: info: Loading plugin "albumart"... Feb 07 20:45:25 volumioloft volumio[30275]: info: Plugin example_plugin is not enabled Feb 07 20:45:25 volumioloft volumio[30275]: info: Loading plugin "inputs"... Feb 07 20:45:25 volumioloft volumio[30275]: info: Loading plugin "updater_comm"... Feb 07 20:45:25 volumioloft volumio[30275]: info: Plugin mpdemulation is not enabled Feb 07 20:45:25 volumioloft volumio[30275]: info: Loading plugin "rest_api"... Feb 07 20:45:25 volumioloft volumio[30275]: info: Loading plugin "websocket"... Feb 07 20:45:25 volumioloft volumio[30275]: info: Starting Socket.io Server version 2.3.0 Feb 07 20:45:25 volumioloft volumio[30275]: info: Loading plugin "volusonic"... Feb 07 20:45:25 volumioloft volumio[30275]: Forking 3 albumart workers Feb 07 20:45:26 volumioloft wpa_supplicant[892]: wlan0: Failed to initiate sched scan Feb 07 20:45:26 volumioloft volumio[30275]: info: Applying required configuration parameters for plugin volusonic Feb 07 20:45:26 volumioloft volumio[30275]: info: Loading i18n strings for locale en Feb 07 20:45:26 volumioloft volumio[30275]: Updating browse sources language Feb 07 20:45:26 volumioloft volumio[30275]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 20:45:26 volumioloft volumio[30275]: Starting albumart workers Feb 07 20:45:26 volumioloft volumio[30275]: Starting albumart workers Feb 07 20:45:26 volumioloft volumio[30275]: Starting albumart workers Feb 07 20:45:26 volumioloft volumio[30275]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 07 20:45:26 volumioloft volumio[30275]: info: CoreCommandRouter::initPlayerControls Feb 07 20:45:26 volumioloft volumio[30275]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:26 volumioloft volumio[30275]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:26 volumioloft volumio[30275]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:26 volumioloft volumio[30275]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:26 volumioloft volumio[30275]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:26 volumioloft volumio[30275]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:26 volumioloft volumio[30275]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:26 volumioloft volumio[30275]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:26 volumioloft volumio[30275]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 07 20:45:26 volumioloft volumio[30275]: Express server listening on port 3000 Feb 07 20:45:26 volumioloft volumio[30275]: [Metrics] WebUI: 6s 224.48ms Feb 07 20:45:26 volumioloft volumio[30275]: info: CoreStateMachine::resetVolumioState Feb 07 20:45:26 volumioloft volumio[30275]: info: CoreStateMachine::getcurrentVolume Feb 07 20:45:26 volumioloft volumio[30275]: info: CoreCommandRouter::volumioRetrievevolume Feb 07 20:45:26 volumioloft volumio[30275]: info: Volumio Network Manager: Network status updated: 0 Feb 07 20:45:27 volumioloft volumio-remote-updater[667]: [2026-02-07 20:45:27] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1770497124 101 Feb 07 20:45:27 volumioloft volumio[30275]: 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 Feb 07 20:45:27 volumioloft volumio[30275]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 20:45:27 volumioloft volumio[30275]: info: Executing start script for DAC IQaudIO DAC Plus Feb 07 20:45:27 volumioloft volumio[30275]: info: Reloading queue from file Feb 07 20:45:27 volumioloft volumio[30275]: info: VolumeController:: Volume=22 Mute =false Feb 07 20:45:27 volumioloft volumio[30275]: info: CoreStateMachine::pushState Feb 07 20:45:27 volumioloft volumio[30275]: info: CorePlayQueue::getTrack 0 Feb 07 20:45:27 volumioloft volumio[30275]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 07 20:45:27 volumioloft volumio[30275]: info: CoreCommandRouter::volumioPushState Feb 07 20:45:27 volumioloft volumio[30275]: info: CoreStateMachine::updateTrackBlock Feb 07 20:45:27 volumioloft volumio[30275]: info: CorePlayQueue::getTrackBlock Feb 07 20:45:27 volumioloft volumio[30275]: info: CoreCommandRouter::volumioRetrievevolume Feb 07 20:45:27 volumioloft volumio[30275]: info: CoreStateMachine::setRepeat null single undefined Feb 07 20:45:27 volumioloft volumio[30275]: info: CoreStateMachine::pushState Feb 07 20:45:27 volumioloft volumio[30275]: info: CorePlayQueue::getTrack 0 Feb 07 20:45:27 volumioloft volumio[30275]: info: CoreCommandRouter::volumioPushState Feb 07 20:45:27 volumioloft volumio[30275]: info: CoreStateMachine::setRandom null Feb 07 20:45:27 volumioloft volumio[30275]: info: CoreStateMachine::pushState Feb 07 20:45:27 volumioloft volumio[30275]: info: CorePlayQueue::getTrack 0 Feb 07 20:45:27 volumioloft volumio[30275]: info: CoreCommandRouter::volumioPushState Feb 07 20:45:27 volumioloft volumio[30275]: info: Setting Device type: Raspberry PI Feb 07 20:45:27 volumioloft volumio[30275]: info: DAC script executed Feb 07 20:45:27 volumioloft volumio[30275]: info: Completed loading Core Plugins Feb 07 20:45:27 volumioloft volumio[30275]: info: Preparing to generate the ALSA configuration file Feb 07 20:45:27 volumioloft volumio[30275]: info: Asound.conf file unchanged, so no further update is needed Feb 07 20:45:27 volumioloft volumio[30275]: info: Output device has changed, restarting MPD Feb 07 20:45:27 volumioloft sudo[30398]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 07 20:45:27 volumioloft sudo[30398]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:45:27 volumioloft volumio[30275]: info: Output device has changed, restarting Shairport Sync Feb 07 20:45:27 volumioloft volumio[30275]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:27 volumioloft volumio[30275]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 20:45:27 volumioloft sudo[30398]: pam_unix(sudo:session): session closed for user root Feb 07 20:45:27 volumioloft sudo[30400]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 07 20:45:27 volumioloft sudo[30400]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:45:27 volumioloft systemd[1]: Stopping Music Player Daemon... Feb 07 20:45:27 volumioloft volumio[30275]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 07 20:45:27 volumioloft volumio[30275]: info: ___________ START PLUGINS ___________ Feb 07 20:45:27 volumioloft volumio[30275]: info: ControllerMpd::onStart: Initializing MPD Feb 07 20:45:27 volumioloft volumio[30275]: info: Creating MPD Configuration file Feb 07 20:45:27 volumioloft systemd[1]: mpd.service: Succeeded. Feb 07 20:45:27 volumioloft systemd[1]: Stopped Music Player Daemon. Feb 07 20:45:27 volumioloft sudo[30408]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 07 20:45:27 volumioloft sudo[30408]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:45:27 volumioloft volumio[30275]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 07 20:45:27 volumioloft volumio[30275]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 07 20:45:27 volumioloft volumio[30275]: info: [1770497127608] CoreMusicLibrary::Adding element Media Servers Feb 07 20:45:27 volumioloft volumio[30275]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 20:45:27 volumioloft volumio[30275]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:27 volumioloft volumio[30275]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 20:45:27 volumioloft systemd[1]: Starting Music Player Daemon... Feb 07 20:45:27 volumioloft sudo[30408]: pam_unix(sudo:session): session closed for user root Feb 07 20:45:27 volumioloft sudo[30410]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 07 20:45:27 volumioloft sudo[30410]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:45:27 volumioloft systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Feb 07 20:45:27 volumioloft systemd[1]: mpd.service: Succeeded. Feb 07 20:45:27 volumioloft systemd[1]: Stopped Music Player Daemon. Feb 07 20:45:27 volumioloft systemd[1]: Starting Music Player Daemon... Feb 07 20:45:27 volumioloft volumio[30275]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 07 20:45:27 volumioloft volumio[30275]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:27 volumioloft volumio[30275]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 20:45:27 volumioloft volumio[30275]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 07 20:45:27 volumioloft volumio[30275]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 07 20:45:27 volumioloft volumio[30275]: info: [1770497127744] CoreMusicLibrary::Adding element Last_100 Feb 07 20:45:27 volumioloft volumio[30275]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 20:45:27 volumioloft volumio[30275]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 07 20:45:27 volumioloft volumio[30275]: info: [1770497127748] CoreMusicLibrary::Adding element Webradio Feb 07 20:45:27 volumioloft volumio[30275]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 20:45:27 volumioloft volumio[30275]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 07 20:45:27 volumioloft volumio[30275]: info: Initializing BBC Radios Feb 07 20:45:27 volumioloft sudo[30416]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 07 20:45:27 volumioloft sudo[30416]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:45:27 volumioloft sudo[30416]: pam_unix(sudo:session): session closed for user root Feb 07 20:45:27 volumioloft volumio[30275]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 07 20:45:27 volumioloft volumio[30275]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 20:45:27 volumioloft volumio[30275]: info: [squeezelite_mc] Starting proxy server... Feb 07 20:45:27 volumioloft volumio[30275]: info: Loading i18n strings for locale en Feb 07 20:45:27 volumioloft volumio[30275]: Updating browse sources language Feb 07 20:45:27 volumioloft volumio[30275]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 20:45:27 volumioloft volumio[30275]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 07 20:45:27 volumioloft volumio[30275]: info: [1770497127894] CoreMusicLibrary::Adding element Volusonic Feb 07 20:45:27 volumioloft volumio[30275]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 20:45:27 volumioloft volumio[30275]: Cannot find translation for source Volusonic Feb 07 20:45:27 volumioloft volumio[30275]: info: Volumio Calling Home Feb 07 20:45:28 volumioloft volumio[30275]: info: [squeezelite_mc] Proxy server started on port 39659 Feb 07 20:45:28 volumioloft volumio[30275]: info: CoreCommandRouter::volumioRetrievevolume Feb 07 20:45:28 volumioloft volumio[30275]: Unhandled rejection Error: No sockets available, cannot start. Feb 07 20:45:28 volumioloft volumio[30275]: at SsdpClient.SSDP._createSockets (/volumio/node_modules/node-ssdp/lib/index.js:186:11) Feb 07 20:45:28 volumioloft volumio[30275]: at SsdpClient.SSDP._start (/volumio/node_modules/node-ssdp/lib/index.js:229:10) Feb 07 20:45:28 volumioloft volumio[30275]: at /volumio/node_modules/node-ssdp/lib/client.js:60:10 Feb 07 20:45:28 volumioloft volumio[30275]: at Promise._execute (/volumio/node_modules/bluebird/js/release/debuggability.js:384:9) Feb 07 20:45:28 volumioloft volumio[30275]: at Promise._resolveFromExecutor (/volumio/node_modules/bluebird/js/release/promise.js:518:18) Feb 07 20:45:28 volumioloft volumio[30275]: at new Promise (/volumio/node_modules/bluebird/js/release/promise.js:103:10) Feb 07 20:45:28 volumioloft volumio[30275]: at SsdpClient.start (/volumio/node_modules/node-ssdp/lib/client.js:54:10) Feb 07 20:45:28 volumioloft volumio[30275]: at SsdpClient.search (/volumio/node_modules/node-ssdp/lib/client.js:82:17) Feb 07 20:45:28 volumioloft volumio[30275]: at ControllerUPNPBrowser.onStart (/volumio/app/plugins/music_service/upnp_browser/index.js:126:12) Feb 07 20:45:28 volumioloft volumio[30275]: at PluginManager.startCorePlugin (/volumio/app/pluginmanager.js:398:24) Feb 07 20:45:28 volumioloft volumio[30275]: at HashMap. (/volumio/app/pluginmanager.js:496:31) Feb 07 20:45:28 volumioloft volumio[30275]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Feb 07 20:45:28 volumioloft volumio[30275]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Feb 07 20:45:28 volumioloft volumio[30275]: at PluginManager.startCorePlugins (/volumio/app/pluginmanager.js:495:20) Feb 07 20:45:28 volumioloft volumio[30275]: at Promise._successFn (/volumio/app/pluginmanager.js:142:29) Feb 07 20:45:28 volumioloft volumio[30275]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Feb 07 20:45:28 volumioloft volumio[30275]: info: MPD Permissions set Feb 07 20:45:28 volumioloft volumio[30275]: info: MPD Permissions set Feb 07 20:45:28 volumioloft volumio[30275]: info: VolumeController:: Volume=22 Mute =false Feb 07 20:45:28 volumioloft volumio[30275]: info: CoreStateMachine::pushState Feb 07 20:45:28 volumioloft volumio[30275]: info: CorePlayQueue::getTrack 0 Feb 07 20:45:28 volumioloft volumio[30275]: info: CoreCommandRouter::volumioPushState Feb 07 20:45:28 volumioloft volumio[30275]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Feb 07 20:45:28 volumioloft volumio[30275]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:28 volumioloft volumio[30275]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:28 volumioloft volumio[30275]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:28 volumioloft volumio[30275]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:28 volumioloft volumio[30275]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:28 volumioloft volumio[30275]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:28 volumioloft volumio[30275]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:28 volumioloft volumio[30275]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:28 volumioloft volumio[30275]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 20:45:28 volumioloft volumio[30275]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:28 volumioloft volumio[30275]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:28 volumioloft volumio[30275]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:28 volumioloft volumio[30275]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:28 volumioloft volumio[30275]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:28 volumioloft volumio[30275]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:28 volumioloft volumio[30275]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:28 volumioloft volumio[30275]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:28 volumioloft volumio[30275]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:28 volumioloft volumio[30275]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 20:45:28 volumioloft volumio[30275]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:28 volumioloft volumio[30275]: info: VolumeController:: Volume=22 Mute =false Feb 07 20:45:28 volumioloft volumio[30275]: info: CoreStateMachine::pushState Feb 07 20:45:28 volumioloft volumio[30275]: info: CorePlayQueue::getTrack 0 Feb 07 20:45:28 volumioloft volumio[30275]: info: CoreCommandRouter::volumioPushState Feb 07 20:45:28 volumioloft volumio[30275]: info: [squeezelite_mc] Server discovery started Feb 07 20:45:28 volumioloft volumio[30275]: info: [squeezelite_mc] Player finder started Feb 07 20:45:28 volumioloft volumio[30275]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:28 volumioloft volumio[30275]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:28 volumioloft volumio[30275]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:28 volumioloft volumio[30275]: info: [squeezelite_mc] Starting Squeezelite service with params: {"type":"manual","startupOptions":"-s 10.0.0.101:3483 -o squeezelite -C 1 -n \"volumioloft\" -V \"Digital\" -f /tmp/squeezelite.log","card":"2","mixerType":"Hardware","mixer":"Digital"} Feb 07 20:45:28 volumioloft volumio[30275]: 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 Feb 07 20:45:28 volumioloft volumio[30275]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 07 20:45:28 volumioloft volumio[30275]: Error: send ENETUNREACH 255.255.255.255:3483 Feb 07 20:45:28 volumioloft volumio[30275]: at doSend (dgram.js:692:16) Feb 07 20:45:28 volumioloft volumio[30275]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:430:12) Feb 07 20:45:28 volumioloft volumio[30275]: at afterDns (dgram.js:638:5) Feb 07 20:45:28 volumioloft volumio[30275]: at processTicksAndRejections (internal/process/task_queues.js:81:21) { Feb 07 20:45:28 volumioloft volumio[30275]: errno: -101, Feb 07 20:45:28 volumioloft volumio[30275]: code: 'ENETUNREACH', Feb 07 20:45:28 volumioloft volumio[30275]: syscall: 'send', Feb 07 20:45:28 volumioloft volumio[30275]: address: '255.255.255.255', Feb 07 20:45:28 volumioloft volumio[30275]: port: 3483 Feb 07 20:45:28 volumioloft volumio[30275]: } Feb 07 20:45:28 volumioloft volumio[30275]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 07 20:45:28 volumioloft sudo[30447]: 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 Feb 07 20:45:28 volumioloft sudo[30447]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:45:28 volumioloft sudo[30447]: pam_unix(sudo:session): session closed for user root Feb 07 20:45:29 volumioloft sudo[30458]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-02-07 20:44 Feb 07 20:45:29 volumioloft sudo[30458]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:45:29 volumioloft sudo[30458]: pam_unix(sudo:session): session closed for user root Feb 07 20:45:29 volumioloft volumio-remote-updater[667]: [2026-02-07 20:45:29] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Feb 07 20:45:29 volumioloft volumio-remote-updater[667]: [2026-02-07 20:45:29] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Feb 07 20:45:29 volumioloft systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Feb 07 20:45:29 volumioloft sudo[30410]: pam_unix(sudo:session): session closed for user root Feb 07 20:45:29 volumioloft sudo[30400]: pam_unix(sudo:session): session closed for user root Feb 07 20:45:29 volumioloft mpd[30427]: decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 07 20:45:29 volumioloft mpd[30427]: output: No 'audio_output' defined in config file Feb 07 20:45:29 volumioloft mpd[30427]: output: Successfully detected a sndio audio device Feb 07 20:45:29 volumioloft mpd[30427]: zeroconf: No global port, disabling zeroconf Feb 07 20:45:29 volumioloft systemd[1]: volumio.service: Failed with result 'exit-code'. Feb 07 20:45:29 volumioloft systemd[1]: Started Music Player Daemon. Feb 07 20:45:29 volumioloft systemd[1]: Started dynamicswap service. Feb 07 20:45:29 volumioloft systemd[1]: dynamicswap.service: Succeeded. Feb 07 20:45:29 volumioloft systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Feb 07 20:45:29 volumioloft systemd[1]: volumio.service: Scheduled restart job, restart counter is at 93. Feb 07 20:45:29 volumioloft systemd[1]: Stopped Volumio Backend Module. Feb 07 20:45:29 volumioloft systemd[1]: Started Volumio Backend Module. Feb 07 20:45:29 volumioloft systemd[1]: Started dynamicswap service. Feb 07 20:45:29 volumioloft systemd[1]: dynamicswap.service: Succeeded. Feb 07 20:45:31 volumioloft volumio[30473]: info: ------------------------------------------- Feb 07 20:45:31 volumioloft volumio[30473]: info: ----- Volumio3 ---- Feb 07 20:45:31 volumioloft volumio[30473]: info: ------------------------------------------- Feb 07 20:45:31 volumioloft volumio[30473]: info: ----- System startup ---- Feb 07 20:45:31 volumioloft volumio[30473]: info: ------------------------------------------- Feb 07 20:45:31 volumioloft wpa_supplicant[892]: wlan0: Failed to initiate sched scan Feb 07 20:45:32 volumioloft volumio[30473]: info: MYVOLUMIO Environment detected Feb 07 20:45:32 volumioloft volumio[30473]: info: Plugin folders cleanup Feb 07 20:45:32 volumioloft volumio[30473]: info: Scanning into folder /volumio/app/plugins/ Feb 07 20:45:32 volumioloft volumio[30473]: info: Scanning category audio_interface Feb 07 20:45:32 volumioloft volumio[30473]: info: Scanning category miscellanea Feb 07 20:45:32 volumioloft volumio[30473]: info: Scanning category music_service Feb 07 20:45:32 volumioloft volumio[30473]: info: Scanning category plugins.json Feb 07 20:45:32 volumioloft volumio[30473]: info: Scanning category system_controller Feb 07 20:45:32 volumioloft volumio[30473]: info: Scanning category user_interface Feb 07 20:45:32 volumioloft volumio[30473]: info: Scanning into folder /data/plugins/ Feb 07 20:45:32 volumioloft volumio[30473]: info: Scanning category music_service Feb 07 20:45:32 volumioloft volumio[30473]: info: Plugin folders cleanup completed Feb 07 20:45:32 volumioloft volumio[30473]: info: ------------------------------------------- Feb 07 20:45:32 volumioloft volumio[30473]: info: ----- Core plugins startup ---- Feb 07 20:45:32 volumioloft volumio[30473]: info: ------------------------------------------- Feb 07 20:45:32 volumioloft volumio[30473]: info: Loading plugins from folder /volumio/app/plugins/ Feb 07 20:45:32 volumioloft volumio[30473]: info: Adding plugin upnp to MyMusic Plugins Feb 07 20:45:32 volumioloft volumio[30473]: info: Adding plugin airplay_emulation to MyMusic Plugins Feb 07 20:45:32 volumioloft volumio[30473]: info: Adding plugin upnp_browser to MyMusic Plugins Feb 07 20:45:32 volumioloft volumio[30473]: info: Loading plugins from folder /data/plugins/ Feb 07 20:45:32 volumioloft volumio[30473]: info: Loading plugin "system"... Feb 07 20:45:32 volumioloft volumio[30473]: info: Loading plugin "appearance"... Feb 07 20:45:33 volumioloft volumio[30473]: info: Loading plugin "network"... Feb 07 20:45:33 volumioloft volumio[30473]: info: Refreshing Cached IP Addresses Feb 07 20:45:33 volumioloft sudo[30500]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 07 20:45:33 volumioloft sudo[30500]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:45:33 volumioloft sudo[30502]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 07 20:45:33 volumioloft sudo[30502]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:45:33 volumioloft sudo[30500]: pam_unix(sudo:session): session closed for user root Feb 07 20:45:33 volumioloft sudo[30502]: pam_unix(sudo:session): session closed for user root Feb 07 20:45:33 volumioloft volumio[30473]: info: Loading plugin "services"... Feb 07 20:45:33 volumioloft volumio[30473]: info: Loading plugin "alsa_controller"... Feb 07 20:45:33 volumioloft sudo[30511]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Feb 07 20:45:33 volumioloft sudo[30511]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:45:33 volumioloft volumio[30473]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 07 20:45:33 volumioloft volumio[30473]: info: Loading plugin "wizard"... Feb 07 20:45:33 volumioloft volumio[30473]: info: Loading plugin "networkfs"... Feb 07 20:45:33 volumioloft volumio[30473]: info: Starting Udev Watcher for removable devices Feb 07 20:45:33 volumioloft volumio[30473]: info: Ignoring mount for partition: boot Feb 07 20:45:33 volumioloft volumio[30473]: info: Ignoring mount for partition: volumio Feb 07 20:45:33 volumioloft volumio[30473]: info: Ignoring mount for partition: volumio_data Feb 07 20:45:33 volumioloft volumio[30473]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 07 20:45:33 volumioloft volumio[30473]: info: Loading plugin "volumio_command_line_client"... Feb 07 20:45:33 volumioloft volumio[30473]: info: Loading plugin "upnp"... Feb 07 20:45:33 volumioloft volumio[30473]: info: [1770497133719] Starting Upmpd Daemon Feb 07 20:45:33 volumioloft volumio[30473]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 07 20:45:33 volumioloft volumio[30473]: info: Loading plugin "my_music"... Feb 07 20:45:33 volumioloft volumio[30473]: info: Loading plugin "mpd"... Feb 07 20:45:34 volumioloft volumio[30473]: info: Loading plugin "upnp_browser"... Feb 07 20:45:34 volumioloft sudo[30511]: pam_unix(sudo:session): session closed for user root Feb 07 20:45:34 volumioloft volumio[30473]: info: Loading plugin "alarm-clock"... Feb 07 20:45:34 volumioloft volumio-remote-updater[667]: [2026-02-07 20:45:34] [connect] Successful connection Feb 07 20:45:34 volumioloft volumio[30473]: info: Loading plugin "airplay_emulation"... Feb 07 20:45:34 volumioloft volumio[30473]: info: Starting Shairport Sync Feb 07 20:45:34 volumioloft volumio[30473]: info: Loading plugin "last_100"... Feb 07 20:45:34 volumioloft volumio[30473]: info: Loading plugin "webradio"... Feb 07 20:45:34 volumioloft volumio[30473]: info: Loading plugin "i2s_dacs"... Feb 07 20:45:34 volumioloft volumio[30473]: info: Loading plugin "volumiodiscovery"... Feb 07 20:45:34 volumioloft volumio[30473]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 07 20:45:34 volumioloft volumio[30473]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 07 20:45:34 volumioloft volumio[30473]: *** WARNING *** For more information see Feb 07 20:45:34 volumioloft node[30473]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 07 20:45:34 volumioloft volumio[30473]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 07 20:45:34 volumioloft volumio[30473]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 07 20:45:34 volumioloft volumio[30473]: *** WARNING *** For more information see Feb 07 20:45:34 volumioloft node[30473]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 07 20:45:34 volumioloft node[30473]: *** WARNING *** For more information see Feb 07 20:45:34 volumioloft node[30473]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 07 20:45:34 volumioloft node[30473]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 07 20:45:34 volumioloft node[30473]: *** WARNING *** For more information see Feb 07 20:45:34 volumioloft volumio[30473]: info: Applying required configuration parameters for plugin volumiodiscovery Feb 07 20:45:34 volumioloft volumio[30473]: info: Discovery: Started advertising with name: Volumioloft Feb 07 20:45:34 volumioloft volumio[30473]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 07 20:45:34 volumioloft volumio[30473]: info: Loading plugin "squeezelite_mc"... Feb 07 20:45:35 volumioloft volumio[30473]: info: Loading plugin "outputs"... Feb 07 20:45:35 volumioloft volumio[30473]: info: Loading plugin "albumart"... Feb 07 20:45:35 volumioloft volumio[30473]: info: Plugin example_plugin is not enabled Feb 07 20:45:35 volumioloft volumio[30473]: info: Loading plugin "inputs"... Feb 07 20:45:35 volumioloft volumio[30473]: info: Loading plugin "updater_comm"... Feb 07 20:45:35 volumioloft volumio[30473]: info: Plugin mpdemulation is not enabled Feb 07 20:45:35 volumioloft volumio[30473]: info: Loading plugin "rest_api"... Feb 07 20:45:35 volumioloft volumio[30473]: info: Loading plugin "websocket"... Feb 07 20:45:35 volumioloft volumio[30473]: info: Starting Socket.io Server version 2.3.0 Feb 07 20:45:35 volumioloft volumio[30473]: info: Loading plugin "volusonic"... Feb 07 20:45:36 volumioloft volumio[30473]: Forking 3 albumart workers Feb 07 20:45:37 volumioloft volumio[30473]: Starting albumart workers Feb 07 20:45:37 volumioloft volumio[30473]: info: Applying required configuration parameters for plugin volusonic Feb 07 20:45:37 volumioloft volumio[30473]: info: Loading i18n strings for locale en Feb 07 20:45:37 volumioloft volumio[30473]: Starting albumart workers Feb 07 20:45:37 volumioloft volumio[30473]: Updating browse sources language Feb 07 20:45:37 volumioloft volumio[30473]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 20:45:37 volumioloft volumio[30473]: Starting albumart workers Feb 07 20:45:37 volumioloft wpa_supplicant[892]: wlan0: Failed to initiate sched scan Feb 07 20:45:37 volumioloft volumio[30473]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 07 20:45:37 volumioloft volumio[30473]: info: CoreCommandRouter::initPlayerControls Feb 07 20:45:37 volumioloft volumio[30473]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:37 volumioloft volumio[30473]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:37 volumioloft volumio[30473]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:37 volumioloft volumio[30473]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:37 volumioloft volumio[30473]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:37 volumioloft volumio[30473]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:37 volumioloft volumio[30473]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:37 volumioloft volumio[30473]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:37 volumioloft volumio[30473]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 07 20:45:37 volumioloft volumio[30473]: Express server listening on port 3000 Feb 07 20:45:37 volumioloft volumio[30473]: [Metrics] WebUI: 6s 323.61ms Feb 07 20:45:37 volumioloft volumio[30473]: info: CoreStateMachine::resetVolumioState Feb 07 20:45:37 volumioloft volumio[30473]: info: CoreStateMachine::getcurrentVolume Feb 07 20:45:37 volumioloft volumio[30473]: info: CoreCommandRouter::volumioRetrievevolume Feb 07 20:45:37 volumioloft volumio[30473]: info: Volumio Network Manager: Network status updated: 0 Feb 07 20:45:37 volumioloft volumio-remote-updater[667]: [2026-02-07 20:45:37] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1770497134 101 Feb 07 20:45:37 volumioloft volumio[30473]: 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 Feb 07 20:45:37 volumioloft volumio[30473]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 20:45:37 volumioloft volumio[30473]: info: Executing start script for DAC IQaudIO DAC Plus Feb 07 20:45:37 volumioloft volumio[30473]: info: Reloading queue from file Feb 07 20:45:37 volumioloft volumio[30473]: info: CoreStateMachine::setRepeat null single undefined Feb 07 20:45:37 volumioloft volumio[30473]: info: CoreStateMachine::pushState Feb 07 20:45:37 volumioloft volumio[30473]: info: CorePlayQueue::getTrack 0 Feb 07 20:45:37 volumioloft volumio[30473]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 07 20:45:37 volumioloft volumio[30473]: info: CoreCommandRouter::volumioPushState Feb 07 20:45:37 volumioloft volumio[30473]: info: CoreStateMachine::setRandom null Feb 07 20:45:37 volumioloft volumio[30473]: info: CoreStateMachine::pushState Feb 07 20:45:37 volumioloft volumio[30473]: info: CorePlayQueue::getTrack 0 Feb 07 20:45:37 volumioloft volumio[30473]: info: CoreCommandRouter::volumioPushState Feb 07 20:45:37 volumioloft volumio[30473]: info: Setting Device type: Raspberry PI Feb 07 20:45:37 volumioloft volumio[30473]: info: VolumeController:: Volume=22 Mute =false Feb 07 20:45:37 volumioloft volumio[30473]: info: CoreStateMachine::pushState Feb 07 20:45:37 volumioloft volumio[30473]: info: CorePlayQueue::getTrack 0 Feb 07 20:45:37 volumioloft volumio[30473]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 07 20:45:37 volumioloft volumio[30473]: info: CoreCommandRouter::volumioPushState Feb 07 20:45:37 volumioloft volumio[30473]: info: CoreStateMachine::updateTrackBlock Feb 07 20:45:37 volumioloft volumio[30473]: info: CorePlayQueue::getTrackBlock Feb 07 20:45:37 volumioloft volumio[30473]: info: CoreCommandRouter::volumioRetrievevolume Feb 07 20:45:37 volumioloft volumio[30473]: info: DAC script executed Feb 07 20:45:37 volumioloft volumio[30473]: info: Completed loading Core Plugins Feb 07 20:45:37 volumioloft volumio[30473]: info: Preparing to generate the ALSA configuration file Feb 07 20:45:38 volumioloft volumio[30473]: info: Asound.conf file unchanged, so no further update is needed Feb 07 20:45:38 volumioloft volumio[30473]: info: Output device has changed, restarting MPD Feb 07 20:45:38 volumioloft sudo[30597]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 07 20:45:38 volumioloft volumio[30473]: info: Output device has changed, restarting Shairport Sync Feb 07 20:45:38 volumioloft sudo[30597]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:45:38 volumioloft volumio[30473]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:38 volumioloft volumio[30473]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 20:45:38 volumioloft sudo[30597]: pam_unix(sudo:session): session closed for user root Feb 07 20:45:38 volumioloft sudo[30599]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 07 20:45:38 volumioloft sudo[30599]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:45:38 volumioloft systemd[1]: Stopping Music Player Daemon... Feb 07 20:45:38 volumioloft volumio[30473]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 07 20:45:38 volumioloft volumio[30473]: info: ___________ START PLUGINS ___________ Feb 07 20:45:38 volumioloft volumio[30473]: info: ControllerMpd::onStart: Initializing MPD Feb 07 20:45:38 volumioloft volumio[30473]: info: Creating MPD Configuration file Feb 07 20:45:38 volumioloft systemd[1]: mpd.service: Succeeded. Feb 07 20:45:38 volumioloft systemd[1]: Stopped Music Player Daemon. Feb 07 20:45:38 volumioloft sudo[30607]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 07 20:45:38 volumioloft sudo[30607]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:45:38 volumioloft volumio[30473]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 07 20:45:38 volumioloft volumio[30473]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 07 20:45:38 volumioloft volumio[30473]: info: [1770497138202] CoreMusicLibrary::Adding element Media Servers Feb 07 20:45:38 volumioloft volumio[30473]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 20:45:38 volumioloft systemd[1]: Starting Music Player Daemon... Feb 07 20:45:38 volumioloft sudo[30607]: pam_unix(sudo:session): session closed for user root Feb 07 20:45:38 volumioloft sudo[30609]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 07 20:45:38 volumioloft sudo[30609]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:45:38 volumioloft volumio[30473]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:38 volumioloft volumio[30473]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 20:45:38 volumioloft systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Feb 07 20:45:38 volumioloft systemd[1]: mpd.service: Succeeded. Feb 07 20:45:38 volumioloft systemd[1]: Stopped Music Player Daemon. Feb 07 20:45:38 volumioloft systemd[1]: Starting Music Player Daemon... Feb 07 20:45:38 volumioloft volumio[30473]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 07 20:45:38 volumioloft volumio[30473]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:38 volumioloft volumio[30473]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 20:45:38 volumioloft volumio[30473]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 07 20:45:38 volumioloft volumio[30473]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 07 20:45:38 volumioloft volumio[30473]: info: [1770497138338] CoreMusicLibrary::Adding element Last_100 Feb 07 20:45:38 volumioloft volumio[30473]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 20:45:38 volumioloft volumio[30473]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 07 20:45:38 volumioloft volumio[30473]: info: [1770497138341] CoreMusicLibrary::Adding element Webradio Feb 07 20:45:38 volumioloft volumio[30473]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 20:45:38 volumioloft volumio[30473]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 07 20:45:38 volumioloft volumio[30473]: info: Initializing BBC Radios Feb 07 20:45:38 volumioloft sudo[30615]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 07 20:45:38 volumioloft sudo[30615]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:45:38 volumioloft sudo[30615]: pam_unix(sudo:session): session closed for user root Feb 07 20:45:38 volumioloft volumio[30473]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 07 20:45:38 volumioloft volumio[30473]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 20:45:38 volumioloft volumio[30473]: info: [squeezelite_mc] Starting proxy server... Feb 07 20:45:38 volumioloft volumio[30473]: info: Loading i18n strings for locale en Feb 07 20:45:38 volumioloft volumio[30473]: Updating browse sources language Feb 07 20:45:38 volumioloft volumio[30473]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 20:45:38 volumioloft volumio[30473]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 07 20:45:38 volumioloft volumio[30473]: info: [1770497138496] CoreMusicLibrary::Adding element Volusonic Feb 07 20:45:38 volumioloft volumio[30473]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 20:45:38 volumioloft volumio[30473]: Cannot find translation for source Volusonic Feb 07 20:45:38 volumioloft volumio[30473]: info: Volumio Calling Home Feb 07 20:45:38 volumioloft volumio[30473]: info: [squeezelite_mc] Proxy server started on port 36111 Feb 07 20:45:38 volumioloft volumio[30473]: info: CoreCommandRouter::volumioRetrievevolume Feb 07 20:45:38 volumioloft volumio[30473]: Unhandled rejection Error: No sockets available, cannot start. Feb 07 20:45:38 volumioloft volumio[30473]: at SsdpClient.SSDP._createSockets (/volumio/node_modules/node-ssdp/lib/index.js:186:11) Feb 07 20:45:38 volumioloft volumio[30473]: at SsdpClient.SSDP._start (/volumio/node_modules/node-ssdp/lib/index.js:229:10) Feb 07 20:45:38 volumioloft volumio[30473]: at /volumio/node_modules/node-ssdp/lib/client.js:60:10 Feb 07 20:45:38 volumioloft volumio[30473]: at Promise._execute (/volumio/node_modules/bluebird/js/release/debuggability.js:384:9) Feb 07 20:45:38 volumioloft volumio[30473]: at Promise._resolveFromExecutor (/volumio/node_modules/bluebird/js/release/promise.js:518:18) Feb 07 20:45:38 volumioloft volumio[30473]: at new Promise (/volumio/node_modules/bluebird/js/release/promise.js:103:10) Feb 07 20:45:38 volumioloft volumio[30473]: at SsdpClient.start (/volumio/node_modules/node-ssdp/lib/client.js:54:10) Feb 07 20:45:38 volumioloft volumio[30473]: at SsdpClient.search (/volumio/node_modules/node-ssdp/lib/client.js:82:17) Feb 07 20:45:38 volumioloft volumio[30473]: at ControllerUPNPBrowser.onStart (/volumio/app/plugins/music_service/upnp_browser/index.js:126:12) Feb 07 20:45:38 volumioloft volumio[30473]: at PluginManager.startCorePlugin (/volumio/app/pluginmanager.js:398:24) Feb 07 20:45:38 volumioloft volumio[30473]: at HashMap. (/volumio/app/pluginmanager.js:496:31) Feb 07 20:45:38 volumioloft volumio[30473]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Feb 07 20:45:38 volumioloft volumio[30473]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Feb 07 20:45:38 volumioloft volumio[30473]: at PluginManager.startCorePlugins (/volumio/app/pluginmanager.js:495:20) Feb 07 20:45:38 volumioloft volumio[30473]: at Promise._successFn (/volumio/app/pluginmanager.js:142:29) Feb 07 20:45:38 volumioloft volumio[30473]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Feb 07 20:45:38 volumioloft volumio[30473]: info: MPD Permissions set Feb 07 20:45:38 volumioloft volumio[30473]: info: VolumeController:: Volume=22 Mute =false Feb 07 20:45:38 volumioloft volumio[30473]: info: CoreStateMachine::pushState Feb 07 20:45:38 volumioloft volumio[30473]: info: CorePlayQueue::getTrack 0 Feb 07 20:45:38 volumioloft volumio[30473]: info: CoreCommandRouter::volumioPushState Feb 07 20:45:38 volumioloft volumio[30473]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Feb 07 20:45:38 volumioloft volumio[30473]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:38 volumioloft volumio[30473]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:38 volumioloft volumio[30473]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:38 volumioloft volumio[30473]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:38 volumioloft volumio[30473]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:38 volumioloft volumio[30473]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:38 volumioloft volumio[30473]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:38 volumioloft volumio[30473]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:38 volumioloft volumio[30473]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 20:45:38 volumioloft volumio[30473]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:38 volumioloft volumio[30473]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:38 volumioloft volumio[30473]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:38 volumioloft volumio[30473]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:38 volumioloft volumio[30473]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:38 volumioloft volumio[30473]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:38 volumioloft volumio[30473]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:38 volumioloft volumio[30473]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:38 volumioloft volumio[30473]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:38 volumioloft volumio[30473]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 20:45:38 volumioloft volumio[30473]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:38 volumioloft volumio[30473]: info: VolumeController:: Volume=22 Mute =false Feb 07 20:45:38 volumioloft volumio[30473]: info: CoreStateMachine::pushState Feb 07 20:45:38 volumioloft volumio[30473]: info: CorePlayQueue::getTrack 0 Feb 07 20:45:38 volumioloft volumio[30473]: info: CoreCommandRouter::volumioPushState Feb 07 20:45:38 volumioloft volumio[30473]: info: [squeezelite_mc] Server discovery started Feb 07 20:45:38 volumioloft volumio[30473]: info: [squeezelite_mc] Player finder started Feb 07 20:45:38 volumioloft volumio[30473]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:38 volumioloft volumio[30473]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:38 volumioloft volumio[30473]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:38 volumioloft volumio[30473]: info: [squeezelite_mc] Starting Squeezelite service with params: {"type":"manual","startupOptions":"-s 10.0.0.101:3483 -o squeezelite -C 1 -n \"volumioloft\" -V \"Digital\" -f /tmp/squeezelite.log","card":"2","mixerType":"Hardware","mixer":"Digital"} Feb 07 20:45:39 volumioloft volumio[30473]: 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 Feb 07 20:45:39 volumioloft volumio[30473]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 07 20:45:39 volumioloft volumio[30473]: Error: send ENETUNREACH 255.255.255.255:3483 Feb 07 20:45:39 volumioloft volumio[30473]: at doSend (dgram.js:692:16) Feb 07 20:45:39 volumioloft volumio[30473]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:430:12) Feb 07 20:45:39 volumioloft volumio[30473]: at afterDns (dgram.js:638:5) Feb 07 20:45:39 volumioloft volumio[30473]: at processTicksAndRejections (internal/process/task_queues.js:81:21) { Feb 07 20:45:39 volumioloft volumio[30473]: errno: -101, Feb 07 20:45:39 volumioloft volumio[30473]: code: 'ENETUNREACH', Feb 07 20:45:39 volumioloft volumio[30473]: syscall: 'send', Feb 07 20:45:39 volumioloft volumio[30473]: address: '255.255.255.255', Feb 07 20:45:39 volumioloft volumio[30473]: port: 3483 Feb 07 20:45:39 volumioloft volumio[30473]: } Feb 07 20:45:39 volumioloft volumio[30473]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 07 20:45:39 volumioloft sudo[30646]: 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 Feb 07 20:45:39 volumioloft sudo[30646]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:45:39 volumioloft sudo[30646]: pam_unix(sudo:session): session closed for user root Feb 07 20:45:39 volumioloft sudo[30659]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-02-07 20:44 Feb 07 20:45:39 volumioloft sudo[30659]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:45:39 volumioloft sudo[30659]: pam_unix(sudo:session): session closed for user root Feb 07 20:45:40 volumioloft mpd[30626]: Feb 07 20:45 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 07 20:45:40 volumioloft systemd[1]: Started Music Player Daemon. Feb 07 20:45:40 volumioloft sudo[30599]: pam_unix(sudo:session): session closed for user root Feb 07 20:45:40 volumioloft volumio-remote-updater[667]: [2026-02-07 20:45:40] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Feb 07 20:45:40 volumioloft volumio-remote-updater[667]: [2026-02-07 20:45:40] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Feb 07 20:45:40 volumioloft systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Feb 07 20:45:40 volumioloft sudo[30609]: pam_unix(sudo:session): session closed for user root Feb 07 20:45:40 volumioloft systemd[1]: volumio.service: Failed with result 'exit-code'. Feb 07 20:45:40 volumioloft systemd[1]: Started dynamicswap service. Feb 07 20:45:40 volumioloft systemd[1]: dynamicswap.service: Succeeded. Feb 07 20:45:40 volumioloft systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Feb 07 20:45:40 volumioloft systemd[1]: volumio.service: Scheduled restart job, restart counter is at 94. Feb 07 20:45:40 volumioloft systemd[1]: Stopped Volumio Backend Module. Feb 07 20:45:40 volumioloft systemd[1]: Started Volumio Backend Module. Feb 07 20:45:40 volumioloft systemd[1]: Started dynamicswap service. Feb 07 20:45:40 volumioloft systemd[1]: dynamicswap.service: Succeeded. Feb 07 20:45:42 volumioloft volumio[30675]: info: ------------------------------------------- Feb 07 20:45:42 volumioloft volumio[30675]: info: ----- Volumio3 ---- Feb 07 20:45:42 volumioloft volumio[30675]: info: ------------------------------------------- Feb 07 20:45:42 volumioloft volumio[30675]: info: ----- System startup ---- Feb 07 20:45:42 volumioloft volumio[30675]: info: ------------------------------------------- Feb 07 20:45:42 volumioloft volumio[30675]: info: MYVOLUMIO Environment detected Feb 07 20:45:42 volumioloft volumio[30675]: info: Plugin folders cleanup Feb 07 20:45:42 volumioloft volumio[30675]: info: Scanning into folder /volumio/app/plugins/ Feb 07 20:45:42 volumioloft volumio[30675]: info: Scanning category audio_interface Feb 07 20:45:42 volumioloft volumio[30675]: info: Scanning category miscellanea Feb 07 20:45:42 volumioloft volumio[30675]: info: Scanning category music_service Feb 07 20:45:42 volumioloft volumio[30675]: info: Scanning category plugins.json Feb 07 20:45:42 volumioloft volumio[30675]: info: Scanning category system_controller Feb 07 20:45:42 volumioloft volumio[30675]: info: Scanning category user_interface Feb 07 20:45:42 volumioloft volumio[30675]: info: Scanning into folder /data/plugins/ Feb 07 20:45:42 volumioloft volumio[30675]: info: Scanning category music_service Feb 07 20:45:42 volumioloft volumio[30675]: info: Plugin folders cleanup completed Feb 07 20:45:42 volumioloft volumio[30675]: info: ------------------------------------------- Feb 07 20:45:42 volumioloft volumio[30675]: info: ----- Core plugins startup ---- Feb 07 20:45:42 volumioloft volumio[30675]: info: ------------------------------------------- Feb 07 20:45:42 volumioloft volumio[30675]: info: Loading plugins from folder /volumio/app/plugins/ Feb 07 20:45:42 volumioloft volumio[30675]: info: Adding plugin upnp to MyMusic Plugins Feb 07 20:45:42 volumioloft volumio[30675]: info: Adding plugin airplay_emulation to MyMusic Plugins Feb 07 20:45:42 volumioloft volumio[30675]: info: Adding plugin upnp_browser to MyMusic Plugins Feb 07 20:45:42 volumioloft volumio[30675]: info: Loading plugins from folder /data/plugins/ Feb 07 20:45:42 volumioloft volumio[30675]: info: Loading plugin "system"... Feb 07 20:45:42 volumioloft wpa_supplicant[892]: wlan0: Failed to initiate sched scan Feb 07 20:45:42 volumioloft volumio[30675]: info: Loading plugin "appearance"... Feb 07 20:45:43 volumioloft volumio[30675]: info: Loading plugin "network"... Feb 07 20:45:43 volumioloft volumio[30675]: info: Refreshing Cached IP Addresses Feb 07 20:45:43 volumioloft sudo[30702]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 07 20:45:43 volumioloft sudo[30702]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:45:43 volumioloft sudo[30702]: pam_unix(sudo:session): session closed for user root Feb 07 20:45:43 volumioloft sudo[30704]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 07 20:45:43 volumioloft sudo[30704]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:45:43 volumioloft sudo[30704]: pam_unix(sudo:session): session closed for user root Feb 07 20:45:43 volumioloft volumio[30675]: info: Loading plugin "services"... Feb 07 20:45:43 volumioloft volumio[30675]: info: Loading plugin "alsa_controller"... Feb 07 20:45:43 volumioloft sudo[30717]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Feb 07 20:45:44 volumioloft sudo[30717]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:45:44 volumioloft volumio[30675]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 07 20:45:44 volumioloft volumio[30675]: info: Loading plugin "wizard"... Feb 07 20:45:44 volumioloft volumio[30675]: info: Loading plugin "networkfs"... Feb 07 20:45:44 volumioloft volumio[30675]: info: Starting Udev Watcher for removable devices Feb 07 20:45:44 volumioloft volumio[30675]: info: Ignoring mount for partition: boot Feb 07 20:45:44 volumioloft volumio[30675]: info: Ignoring mount for partition: volumio Feb 07 20:45:44 volumioloft volumio[30675]: info: Ignoring mount for partition: volumio_data Feb 07 20:45:44 volumioloft volumio[30675]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 07 20:45:44 volumioloft volumio[30675]: info: Loading plugin "volumio_command_line_client"... Feb 07 20:45:44 volumioloft volumio[30675]: info: Loading plugin "upnp"... Feb 07 20:45:44 volumioloft volumio[30675]: info: [1770497144176] Starting Upmpd Daemon Feb 07 20:45:44 volumioloft volumio[30675]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 07 20:45:44 volumioloft volumio[30675]: info: Loading plugin "my_music"... Feb 07 20:45:44 volumioloft volumio[30675]: info: Loading plugin "mpd"... Feb 07 20:45:44 volumioloft volumio[30675]: info: Loading plugin "upnp_browser"... Feb 07 20:45:44 volumioloft sudo[30717]: pam_unix(sudo:session): session closed for user root Feb 07 20:45:44 volumioloft volumio[30675]: info: Loading plugin "alarm-clock"... Feb 07 20:45:45 volumioloft volumio[30675]: info: Loading plugin "airplay_emulation"... Feb 07 20:45:45 volumioloft volumio[30675]: info: Starting Shairport Sync Feb 07 20:45:45 volumioloft volumio[30675]: info: Loading plugin "last_100"... Feb 07 20:45:45 volumioloft volumio[30675]: info: Loading plugin "webradio"... Feb 07 20:45:45 volumioloft volumio-remote-updater[667]: [2026-02-07 20:45:45] [connect] Successful connection Feb 07 20:45:45 volumioloft volumio[30675]: info: Loading plugin "i2s_dacs"... Feb 07 20:45:45 volumioloft volumio[30675]: info: Loading plugin "volumiodiscovery"... Feb 07 20:45:45 volumioloft volumio[30675]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 07 20:45:45 volumioloft volumio[30675]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 07 20:45:45 volumioloft volumio[30675]: *** WARNING *** For more information see Feb 07 20:45:45 volumioloft node[30675]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 07 20:45:45 volumioloft volumio[30675]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 07 20:45:45 volumioloft volumio[30675]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 07 20:45:45 volumioloft volumio[30675]: *** WARNING *** For more information see Feb 07 20:45:45 volumioloft node[30675]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 07 20:45:45 volumioloft node[30675]: *** WARNING *** For more information see Feb 07 20:45:45 volumioloft node[30675]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 07 20:45:45 volumioloft node[30675]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 07 20:45:45 volumioloft node[30675]: *** WARNING *** For more information see Feb 07 20:45:45 volumioloft volumio[30675]: info: Applying required configuration parameters for plugin volumiodiscovery Feb 07 20:45:45 volumioloft volumio[30675]: info: Discovery: Started advertising with name: Volumioloft Feb 07 20:45:45 volumioloft volumio[30675]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 07 20:45:45 volumioloft volumio[30675]: info: Loading plugin "squeezelite_mc"... Feb 07 20:45:46 volumioloft volumio[30675]: info: Loading plugin "outputs"... Feb 07 20:45:46 volumioloft volumio[30675]: info: Loading plugin "albumart"... Feb 07 20:45:46 volumioloft volumio[30675]: info: Plugin example_plugin is not enabled Feb 07 20:45:46 volumioloft volumio[30675]: info: Loading plugin "inputs"... Feb 07 20:45:46 volumioloft volumio[30675]: info: Loading plugin "updater_comm"... Feb 07 20:45:46 volumioloft volumio[30675]: info: Plugin mpdemulation is not enabled Feb 07 20:45:46 volumioloft volumio[30675]: info: Loading plugin "rest_api"... Feb 07 20:45:46 volumioloft volumio[30675]: info: Loading plugin "websocket"... Feb 07 20:45:46 volumioloft volumio[30675]: info: Starting Socket.io Server version 2.3.0 Feb 07 20:45:46 volumioloft volumio[30675]: info: Loading plugin "volusonic"... Feb 07 20:45:46 volumioloft volumio[30675]: Forking 3 albumart workers Feb 07 20:45:47 volumioloft volumio[30675]: info: Applying required configuration parameters for plugin volusonic Feb 07 20:45:47 volumioloft volumio[30675]: info: Loading i18n strings for locale en Feb 07 20:45:47 volumioloft volumio[30675]: Updating browse sources language Feb 07 20:45:47 volumioloft volumio[30675]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 20:45:47 volumioloft volumio[30675]: Starting albumart workers Feb 07 20:45:47 volumioloft volumio[30675]: Starting albumart workers Feb 07 20:45:47 volumioloft volumio[30675]: Starting albumart workers Feb 07 20:45:47 volumioloft volumio[30675]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 07 20:45:47 volumioloft volumio[30675]: info: CoreCommandRouter::initPlayerControls Feb 07 20:45:47 volumioloft volumio[30675]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:47 volumioloft volumio[30675]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:47 volumioloft volumio[30675]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:47 volumioloft volumio[30675]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:47 volumioloft volumio[30675]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:47 volumioloft volumio[30675]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:47 volumioloft volumio[30675]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:47 volumioloft volumio[30675]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:47 volumioloft volumio[30675]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 07 20:45:47 volumioloft volumio[30675]: Express server listening on port 3000 Feb 07 20:45:47 volumioloft volumio[30675]: [Metrics] WebUI: 6s 251.16ms Feb 07 20:45:47 volumioloft volumio[30675]: info: CoreStateMachine::resetVolumioState Feb 07 20:45:47 volumioloft volumio[30675]: info: CoreStateMachine::getcurrentVolume Feb 07 20:45:47 volumioloft volumio[30675]: info: CoreCommandRouter::volumioRetrievevolume Feb 07 20:45:47 volumioloft volumio[30675]: info: Volumio Network Manager: Network status updated: 0 Feb 07 20:45:48 volumioloft volumio-remote-updater[667]: [2026-02-07 20:45:48] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1770497145 101 Feb 07 20:45:48 volumioloft volumio[30675]: 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 Feb 07 20:45:48 volumioloft volumio[30675]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 20:45:48 volumioloft volumio[30675]: info: Executing start script for DAC IQaudIO DAC Plus Feb 07 20:45:48 volumioloft volumio[30675]: info: Reloading queue from file Feb 07 20:45:48 volumioloft volumio[30675]: info: Setting Device type: Raspberry PI Feb 07 20:45:48 volumioloft volumio[30675]: info: CoreStateMachine::setRepeat null single undefined Feb 07 20:45:48 volumioloft volumio[30675]: info: CoreStateMachine::pushState Feb 07 20:45:48 volumioloft volumio[30675]: info: CorePlayQueue::getTrack 0 Feb 07 20:45:48 volumioloft volumio[30675]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 07 20:45:48 volumioloft volumio[30675]: info: CoreCommandRouter::volumioPushState Feb 07 20:45:48 volumioloft volumio[30675]: info: CoreStateMachine::setRandom null Feb 07 20:45:48 volumioloft volumio[30675]: info: CoreStateMachine::pushState Feb 07 20:45:48 volumioloft volumio[30675]: info: CorePlayQueue::getTrack 0 Feb 07 20:45:48 volumioloft volumio[30675]: info: CoreCommandRouter::volumioPushState Feb 07 20:45:48 volumioloft volumio[30675]: info: VolumeController:: Volume=22 Mute =false Feb 07 20:45:48 volumioloft volumio[30675]: info: CoreStateMachine::pushState Feb 07 20:45:48 volumioloft volumio[30675]: info: CorePlayQueue::getTrack 0 Feb 07 20:45:48 volumioloft volumio[30675]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 07 20:45:48 volumioloft volumio[30675]: info: CoreCommandRouter::volumioPushState Feb 07 20:45:48 volumioloft volumio[30675]: info: CoreStateMachine::updateTrackBlock Feb 07 20:45:48 volumioloft volumio[30675]: info: CorePlayQueue::getTrackBlock Feb 07 20:45:48 volumioloft volumio[30675]: info: CoreCommandRouter::volumioRetrievevolume Feb 07 20:45:48 volumioloft volumio[30675]: info: DAC script executed Feb 07 20:45:48 volumioloft volumio[30675]: info: Completed loading Core Plugins Feb 07 20:45:48 volumioloft volumio[30675]: info: Preparing to generate the ALSA configuration file Feb 07 20:45:48 volumioloft wpa_supplicant[892]: wlan0: Failed to initiate sched scan Feb 07 20:45:48 volumioloft volumio[30675]: info: Asound.conf file unchanged, so no further update is needed Feb 07 20:45:48 volumioloft volumio[30675]: info: Output device has changed, restarting MPD Feb 07 20:45:48 volumioloft sudo[30799]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 07 20:45:48 volumioloft sudo[30799]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:45:48 volumioloft volumio[30675]: info: Output device has changed, restarting Shairport Sync Feb 07 20:45:48 volumioloft volumio[30675]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:48 volumioloft volumio[30675]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 20:45:48 volumioloft sudo[30799]: pam_unix(sudo:session): session closed for user root Feb 07 20:45:48 volumioloft sudo[30801]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 07 20:45:48 volumioloft sudo[30801]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:45:48 volumioloft systemd[1]: Stopping Music Player Daemon... Feb 07 20:45:48 volumioloft volumio[30675]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 07 20:45:48 volumioloft volumio[30675]: info: ___________ START PLUGINS ___________ Feb 07 20:45:48 volumioloft volumio[30675]: info: ControllerMpd::onStart: Initializing MPD Feb 07 20:45:48 volumioloft volumio[30675]: info: Creating MPD Configuration file Feb 07 20:45:48 volumioloft systemd[1]: mpd.service: Succeeded. Feb 07 20:45:48 volumioloft systemd[1]: Stopped Music Player Daemon. Feb 07 20:45:48 volumioloft sudo[30809]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 07 20:45:48 volumioloft sudo[30809]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:45:48 volumioloft volumio[30675]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 07 20:45:48 volumioloft volumio[30675]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 07 20:45:48 volumioloft volumio[30675]: info: [1770497148663] CoreMusicLibrary::Adding element Media Servers Feb 07 20:45:48 volumioloft volumio[30675]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 20:45:48 volumioloft volumio[30675]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:48 volumioloft volumio[30675]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 20:45:48 volumioloft volumio[30675]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 07 20:45:48 volumioloft volumio[30675]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:48 volumioloft sudo[30809]: pam_unix(sudo:session): session closed for user root Feb 07 20:45:48 volumioloft systemd[1]: Starting Music Player Daemon... Feb 07 20:45:48 volumioloft sudo[30811]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 07 20:45:48 volumioloft sudo[30811]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:45:48 volumioloft volumio[30675]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 20:45:48 volumioloft systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Feb 07 20:45:48 volumioloft systemd[1]: mpd.service: Succeeded. Feb 07 20:45:48 volumioloft systemd[1]: Stopped Music Player Daemon. Feb 07 20:45:48 volumioloft systemd[1]: Starting Music Player Daemon... Feb 07 20:45:48 volumioloft volumio[30675]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 07 20:45:48 volumioloft volumio[30675]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 07 20:45:48 volumioloft volumio[30675]: info: [1770497148799] CoreMusicLibrary::Adding element Last_100 Feb 07 20:45:48 volumioloft volumio[30675]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 20:45:48 volumioloft volumio[30675]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 07 20:45:48 volumioloft volumio[30675]: info: [1770497148802] CoreMusicLibrary::Adding element Webradio Feb 07 20:45:48 volumioloft volumio[30675]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 20:45:48 volumioloft volumio[30675]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 07 20:45:48 volumioloft volumio[30675]: info: Initializing BBC Radios Feb 07 20:45:48 volumioloft volumio[30675]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 07 20:45:48 volumioloft volumio[30675]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 20:45:48 volumioloft sudo[30820]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 07 20:45:48 volumioloft sudo[30820]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:45:48 volumioloft sudo[30820]: pam_unix(sudo:session): session closed for user root Feb 07 20:45:48 volumioloft volumio[30675]: info: [squeezelite_mc] Starting proxy server... Feb 07 20:45:48 volumioloft volumio[30675]: info: Loading i18n strings for locale en Feb 07 20:45:48 volumioloft volumio[30675]: Updating browse sources language Feb 07 20:45:48 volumioloft volumio[30675]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 20:45:48 volumioloft volumio[30675]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 07 20:45:48 volumioloft volumio[30675]: info: [1770497148954] CoreMusicLibrary::Adding element Volusonic Feb 07 20:45:48 volumioloft volumio[30675]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 20:45:48 volumioloft volumio[30675]: Cannot find translation for source Volusonic Feb 07 20:45:48 volumioloft volumio[30675]: info: Volumio Calling Home Feb 07 20:45:49 volumioloft volumio[30675]: info: [squeezelite_mc] Proxy server started on port 43971 Feb 07 20:45:49 volumioloft volumio[30675]: info: CoreCommandRouter::volumioRetrievevolume Feb 07 20:45:49 volumioloft volumio[30675]: Unhandled rejection Error: No sockets available, cannot start. Feb 07 20:45:49 volumioloft volumio[30675]: at SsdpClient.SSDP._createSockets (/volumio/node_modules/node-ssdp/lib/index.js:186:11) Feb 07 20:45:49 volumioloft volumio[30675]: at SsdpClient.SSDP._start (/volumio/node_modules/node-ssdp/lib/index.js:229:10) Feb 07 20:45:49 volumioloft volumio[30675]: at /volumio/node_modules/node-ssdp/lib/client.js:60:10 Feb 07 20:45:49 volumioloft volumio[30675]: at Promise._execute (/volumio/node_modules/bluebird/js/release/debuggability.js:384:9) Feb 07 20:45:49 volumioloft volumio[30675]: at Promise._resolveFromExecutor (/volumio/node_modules/bluebird/js/release/promise.js:518:18) Feb 07 20:45:49 volumioloft volumio[30675]: at new Promise (/volumio/node_modules/bluebird/js/release/promise.js:103:10) Feb 07 20:45:49 volumioloft volumio[30675]: at SsdpClient.start (/volumio/node_modules/node-ssdp/lib/client.js:54:10) Feb 07 20:45:49 volumioloft volumio[30675]: at SsdpClient.search (/volumio/node_modules/node-ssdp/lib/client.js:82:17) Feb 07 20:45:49 volumioloft volumio[30675]: at ControllerUPNPBrowser.onStart (/volumio/app/plugins/music_service/upnp_browser/index.js:126:12) Feb 07 20:45:49 volumioloft volumio[30675]: at PluginManager.startCorePlugin (/volumio/app/pluginmanager.js:398:24) Feb 07 20:45:49 volumioloft volumio[30675]: at HashMap. (/volumio/app/pluginmanager.js:496:31) Feb 07 20:45:49 volumioloft volumio[30675]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Feb 07 20:45:49 volumioloft volumio[30675]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Feb 07 20:45:49 volumioloft volumio[30675]: at PluginManager.startCorePlugins (/volumio/app/pluginmanager.js:495:20) Feb 07 20:45:49 volumioloft volumio[30675]: at Promise._successFn (/volumio/app/pluginmanager.js:142:29) Feb 07 20:45:49 volumioloft volumio[30675]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Feb 07 20:45:49 volumioloft volumio[30675]: info: MPD Permissions set Feb 07 20:45:49 volumioloft volumio[30675]: info: MPD Permissions set Feb 07 20:45:49 volumioloft volumio[30675]: info: VolumeController:: Volume=22 Mute =false Feb 07 20:45:49 volumioloft volumio[30675]: info: CoreStateMachine::pushState Feb 07 20:45:49 volumioloft volumio[30675]: info: CorePlayQueue::getTrack 0 Feb 07 20:45:49 volumioloft volumio[30675]: info: CoreCommandRouter::volumioPushState Feb 07 20:45:49 volumioloft volumio[30675]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Feb 07 20:45:49 volumioloft volumio[30675]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:49 volumioloft volumio[30675]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:49 volumioloft volumio[30675]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:49 volumioloft volumio[30675]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:49 volumioloft volumio[30675]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 20:45:49 volumioloft volumio[30675]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:49 volumioloft volumio[30675]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:49 volumioloft volumio[30675]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:49 volumioloft volumio[30675]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:49 volumioloft volumio[30675]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:49 volumioloft volumio[30675]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:49 volumioloft volumio[30675]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:49 volumioloft volumio[30675]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:49 volumioloft volumio[30675]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:49 volumioloft volumio[30675]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 20:45:49 volumioloft volumio[30675]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:49 volumioloft volumio[30675]: info: VolumeController:: Volume=22 Mute =false Feb 07 20:45:49 volumioloft volumio[30675]: info: CoreStateMachine::pushState Feb 07 20:45:49 volumioloft volumio[30675]: info: CorePlayQueue::getTrack 0 Feb 07 20:45:49 volumioloft volumio[30675]: info: CoreCommandRouter::volumioPushState Feb 07 20:45:49 volumioloft volumio[30675]: info: [squeezelite_mc] Server discovery started Feb 07 20:45:49 volumioloft volumio[30675]: info: [squeezelite_mc] Player finder started Feb 07 20:45:49 volumioloft volumio[30675]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:49 volumioloft volumio[30675]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:49 volumioloft volumio[30675]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:49 volumioloft volumio[30675]: info: [squeezelite_mc] Starting Squeezelite service with params: {"type":"manual","startupOptions":"-s 10.0.0.101:3483 -o squeezelite -C 1 -n \"volumioloft\" -V \"Digital\" -f /tmp/squeezelite.log","card":"2","mixerType":"Hardware","mixer":"Digital"} Feb 07 20:45:49 volumioloft volumio[30675]: 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 Feb 07 20:45:49 volumioloft volumio[30675]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 07 20:45:49 volumioloft volumio[30675]: Error: send ENETUNREACH 255.255.255.255:3483 Feb 07 20:45:49 volumioloft volumio[30675]: at doSend (dgram.js:692:16) Feb 07 20:45:49 volumioloft volumio[30675]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:430:12) Feb 07 20:45:49 volumioloft volumio[30675]: at afterDns (dgram.js:638:5) Feb 07 20:45:49 volumioloft volumio[30675]: at processTicksAndRejections (internal/process/task_queues.js:81:21) { Feb 07 20:45:49 volumioloft volumio[30675]: errno: -101, Feb 07 20:45:49 volumioloft volumio[30675]: code: 'ENETUNREACH', Feb 07 20:45:49 volumioloft volumio[30675]: syscall: 'send', Feb 07 20:45:49 volumioloft volumio[30675]: address: '255.255.255.255', Feb 07 20:45:49 volumioloft volumio[30675]: port: 3483 Feb 07 20:45:49 volumioloft volumio[30675]: } Feb 07 20:45:49 volumioloft volumio[30675]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 07 20:45:49 volumioloft sudo[30848]: 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 Feb 07 20:45:49 volumioloft sudo[30848]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:45:49 volumioloft sudo[30848]: pam_unix(sudo:session): session closed for user root Feb 07 20:45:50 volumioloft sudo[30859]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-02-07 20:44 Feb 07 20:45:50 volumioloft sudo[30859]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:45:50 volumioloft sudo[30859]: pam_unix(sudo:session): session closed for user root Feb 07 20:45:50 volumioloft mpd[30832]: Feb 07 20:45 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 07 20:45:50 volumioloft systemd[1]: Started Music Player Daemon. Feb 07 20:45:50 volumioloft volumio-remote-updater[667]: [2026-02-07 20:45:50] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Feb 07 20:45:50 volumioloft volumio-remote-updater[667]: [2026-02-07 20:45:50] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Feb 07 20:45:50 volumioloft sudo[30811]: pam_unix(sudo:session): session closed for user root Feb 07 20:45:50 volumioloft systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Feb 07 20:45:50 volumioloft sudo[30801]: pam_unix(sudo:session): session closed for user root Feb 07 20:45:50 volumioloft systemd[1]: volumio.service: Failed with result 'exit-code'. Feb 07 20:45:50 volumioloft systemd[1]: Started dynamicswap service. Feb 07 20:45:50 volumioloft systemd[1]: dynamicswap.service: Succeeded. Feb 07 20:45:50 volumioloft systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Feb 07 20:45:50 volumioloft systemd[1]: volumio.service: Scheduled restart job, restart counter is at 95. Feb 07 20:45:50 volumioloft systemd[1]: Stopped Volumio Backend Module. Feb 07 20:45:50 volumioloft systemd[1]: Started Volumio Backend Module. Feb 07 20:45:50 volumioloft systemd[1]: Started dynamicswap service. Feb 07 20:45:50 volumioloft systemd[1]: dynamicswap.service: Succeeded. Feb 07 20:45:52 volumioloft volumio[30874]: info: ------------------------------------------- Feb 07 20:45:52 volumioloft volumio[30874]: info: ----- Volumio3 ---- Feb 07 20:45:52 volumioloft volumio[30874]: info: ------------------------------------------- Feb 07 20:45:52 volumioloft volumio[30874]: info: ----- System startup ---- Feb 07 20:45:52 volumioloft volumio[30874]: info: ------------------------------------------- Feb 07 20:45:53 volumioloft volumio[30874]: info: MYVOLUMIO Environment detected Feb 07 20:45:53 volumioloft volumio[30874]: info: Plugin folders cleanup Feb 07 20:45:53 volumioloft volumio[30874]: info: Scanning into folder /volumio/app/plugins/ Feb 07 20:45:53 volumioloft volumio[30874]: info: Scanning category audio_interface Feb 07 20:45:53 volumioloft volumio[30874]: info: Scanning category miscellanea Feb 07 20:45:53 volumioloft volumio[30874]: info: Scanning category music_service Feb 07 20:45:53 volumioloft volumio[30874]: info: Scanning category plugins.json Feb 07 20:45:53 volumioloft volumio[30874]: info: Scanning category system_controller Feb 07 20:45:53 volumioloft volumio[30874]: info: Scanning category user_interface Feb 07 20:45:53 volumioloft volumio[30874]: info: Scanning into folder /data/plugins/ Feb 07 20:45:53 volumioloft volumio[30874]: info: Scanning category music_service Feb 07 20:45:53 volumioloft volumio[30874]: info: Plugin folders cleanup completed Feb 07 20:45:53 volumioloft volumio[30874]: info: ------------------------------------------- Feb 07 20:45:53 volumioloft volumio[30874]: info: ----- Core plugins startup ---- Feb 07 20:45:53 volumioloft volumio[30874]: info: ------------------------------------------- Feb 07 20:45:53 volumioloft volumio[30874]: info: Loading plugins from folder /volumio/app/plugins/ Feb 07 20:45:53 volumioloft volumio[30874]: info: Adding plugin upnp to MyMusic Plugins Feb 07 20:45:53 volumioloft volumio[30874]: info: Adding plugin airplay_emulation to MyMusic Plugins Feb 07 20:45:53 volumioloft volumio[30874]: info: Adding plugin upnp_browser to MyMusic Plugins Feb 07 20:45:53 volumioloft volumio[30874]: info: Loading plugins from folder /data/plugins/ Feb 07 20:45:53 volumioloft volumio[30874]: info: Loading plugin "system"... Feb 07 20:45:53 volumioloft volumio[30874]: info: Loading plugin "appearance"... Feb 07 20:45:54 volumioloft wpa_supplicant[892]: wlan0: Failed to initiate sched scan Feb 07 20:45:54 volumioloft volumio[30874]: info: Loading plugin "network"... Feb 07 20:45:54 volumioloft volumio[30874]: info: Refreshing Cached IP Addresses Feb 07 20:45:54 volumioloft sudo[30901]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 07 20:45:54 volumioloft sudo[30901]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:45:54 volumioloft sudo[30901]: pam_unix(sudo:session): session closed for user root Feb 07 20:45:54 volumioloft sudo[30903]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 07 20:45:54 volumioloft sudo[30903]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:45:54 volumioloft sudo[30903]: pam_unix(sudo:session): session closed for user root Feb 07 20:45:54 volumioloft volumio[30874]: info: Loading plugin "services"... Feb 07 20:45:54 volumioloft volumio[30874]: info: Loading plugin "alsa_controller"... Feb 07 20:45:54 volumioloft sudo[30912]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Feb 07 20:45:54 volumioloft sudo[30912]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:45:54 volumioloft volumio[30874]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 07 20:45:54 volumioloft volumio[30874]: info: Loading plugin "wizard"... Feb 07 20:45:54 volumioloft volumio[30874]: info: Loading plugin "networkfs"... Feb 07 20:45:54 volumioloft volumio[30874]: info: Starting Udev Watcher for removable devices Feb 07 20:45:54 volumioloft volumio[30874]: info: Ignoring mount for partition: boot Feb 07 20:45:54 volumioloft volumio[30874]: info: Ignoring mount for partition: volumio Feb 07 20:45:54 volumioloft volumio[30874]: info: Ignoring mount for partition: volumio_data Feb 07 20:45:54 volumioloft volumio[30874]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 07 20:45:54 volumioloft volumio[30874]: info: Loading plugin "volumio_command_line_client"... Feb 07 20:45:54 volumioloft volumio[30874]: info: Loading plugin "upnp"... Feb 07 20:45:54 volumioloft volumio[30874]: info: [1770497154742] Starting Upmpd Daemon Feb 07 20:45:54 volumioloft volumio[30874]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 07 20:45:54 volumioloft volumio[30874]: info: Loading plugin "my_music"... Feb 07 20:45:54 volumioloft volumio[30874]: info: Loading plugin "mpd"... Feb 07 20:45:55 volumioloft volumio[30874]: info: Loading plugin "upnp_browser"... Feb 07 20:45:55 volumioloft sudo[30912]: pam_unix(sudo:session): session closed for user root Feb 07 20:45:55 volumioloft volumio[30874]: info: Loading plugin "alarm-clock"... Feb 07 20:45:55 volumioloft volumio-remote-updater[667]: [2026-02-07 20:45:55] [connect] Successful connection Feb 07 20:45:55 volumioloft volumio[30874]: info: Loading plugin "airplay_emulation"... Feb 07 20:45:55 volumioloft volumio[30874]: info: Starting Shairport Sync Feb 07 20:45:55 volumioloft volumio[30874]: info: Loading plugin "last_100"... Feb 07 20:45:55 volumioloft volumio[30874]: info: Loading plugin "webradio"... Feb 07 20:45:55 volumioloft volumio[30874]: info: Loading plugin "i2s_dacs"... Feb 07 20:45:55 volumioloft volumio[30874]: info: Loading plugin "volumiodiscovery"... Feb 07 20:45:55 volumioloft volumio[30874]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 07 20:45:55 volumioloft volumio[30874]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 07 20:45:55 volumioloft volumio[30874]: *** WARNING *** For more information see Feb 07 20:45:55 volumioloft node[30874]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 07 20:45:55 volumioloft volumio[30874]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 07 20:45:55 volumioloft volumio[30874]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 07 20:45:55 volumioloft volumio[30874]: *** WARNING *** For more information see Feb 07 20:45:55 volumioloft node[30874]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 07 20:45:55 volumioloft node[30874]: *** WARNING *** For more information see Feb 07 20:45:55 volumioloft node[30874]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 07 20:45:55 volumioloft node[30874]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 07 20:45:55 volumioloft node[30874]: *** WARNING *** For more information see Feb 07 20:45:55 volumioloft volumio[30874]: info: Applying required configuration parameters for plugin volumiodiscovery Feb 07 20:45:55 volumioloft volumio[30874]: info: Discovery: Started advertising with name: Volumioloft Feb 07 20:45:55 volumioloft volumio[30874]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 07 20:45:55 volumioloft volumio[30874]: info: Loading plugin "squeezelite_mc"... Feb 07 20:45:56 volumioloft volumio[30874]: info: Loading plugin "outputs"... Feb 07 20:45:56 volumioloft volumio[30874]: info: Loading plugin "albumart"... Feb 07 20:45:56 volumioloft volumio[30874]: info: Plugin example_plugin is not enabled Feb 07 20:45:56 volumioloft volumio[30874]: info: Loading plugin "inputs"... Feb 07 20:45:56 volumioloft volumio[30874]: info: Loading plugin "updater_comm"... Feb 07 20:45:56 volumioloft volumio[30874]: info: Plugin mpdemulation is not enabled Feb 07 20:45:56 volumioloft volumio[30874]: info: Loading plugin "rest_api"... Feb 07 20:45:56 volumioloft volumio[30874]: info: Loading plugin "websocket"... Feb 07 20:45:56 volumioloft volumio[30874]: info: Starting Socket.io Server version 2.3.0 Feb 07 20:45:56 volumioloft volumio[30874]: info: Loading plugin "volusonic"... Feb 07 20:45:57 volumioloft volumio[30874]: Forking 3 albumart workers Feb 07 20:45:58 volumioloft volumio[30874]: Starting albumart workers Feb 07 20:45:58 volumioloft volumio[30874]: Starting albumart workers Feb 07 20:45:58 volumioloft volumio[30874]: info: Applying required configuration parameters for plugin volusonic Feb 07 20:45:58 volumioloft volumio[30874]: info: Loading i18n strings for locale en Feb 07 20:45:58 volumioloft volumio[30874]: Starting albumart workers Feb 07 20:45:58 volumioloft volumio[30874]: Updating browse sources language Feb 07 20:45:58 volumioloft volumio[30874]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 20:45:58 volumioloft volumio[30874]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 07 20:45:58 volumioloft volumio[30874]: info: CoreCommandRouter::initPlayerControls Feb 07 20:45:58 volumioloft volumio[30874]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:58 volumioloft volumio[30874]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:58 volumioloft volumio[30874]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:58 volumioloft volumio[30874]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:58 volumioloft volumio[30874]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:58 volumioloft volumio[30874]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:58 volumioloft volumio[30874]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:58 volumioloft volumio[30874]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:58 volumioloft volumio[30874]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 07 20:45:58 volumioloft volumio[30874]: Express server listening on port 3000 Feb 07 20:45:58 volumioloft volumio[30874]: [Metrics] WebUI: 6s 335.76ms Feb 07 20:45:58 volumioloft volumio[30874]: info: CoreStateMachine::resetVolumioState Feb 07 20:45:58 volumioloft volumio[30874]: info: CoreStateMachine::getcurrentVolume Feb 07 20:45:58 volumioloft volumio[30874]: info: CoreCommandRouter::volumioRetrievevolume Feb 07 20:45:58 volumioloft volumio[30874]: info: Volumio Network Manager: Network status updated: 0 Feb 07 20:45:58 volumioloft volumio-remote-updater[667]: [2026-02-07 20:45:58] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1770497155 101 Feb 07 20:45:58 volumioloft volumio[30874]: 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 Feb 07 20:45:58 volumioloft volumio[30874]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 20:45:58 volumioloft volumio[30874]: info: Executing start script for DAC IQaudIO DAC Plus Feb 07 20:45:58 volumioloft volumio[30874]: info: Reloading queue from file Feb 07 20:45:58 volumioloft volumio[30874]: info: CoreStateMachine::setRepeat null single undefined Feb 07 20:45:58 volumioloft volumio[30874]: info: CoreStateMachine::pushState Feb 07 20:45:58 volumioloft volumio[30874]: info: CorePlayQueue::getTrack 0 Feb 07 20:45:58 volumioloft volumio[30874]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 07 20:45:58 volumioloft volumio[30874]: info: CoreCommandRouter::volumioPushState Feb 07 20:45:58 volumioloft volumio[30874]: info: CoreStateMachine::setRandom null Feb 07 20:45:58 volumioloft volumio[30874]: info: CoreStateMachine::pushState Feb 07 20:45:58 volumioloft volumio[30874]: info: CorePlayQueue::getTrack 0 Feb 07 20:45:58 volumioloft volumio[30874]: info: CoreCommandRouter::volumioPushState Feb 07 20:45:58 volumioloft volumio[30874]: info: Setting Device type: Raspberry PI Feb 07 20:45:58 volumioloft volumio[30874]: info: VolumeController:: Volume=22 Mute =false Feb 07 20:45:58 volumioloft volumio[30874]: info: CoreStateMachine::pushState Feb 07 20:45:58 volumioloft volumio[30874]: info: CorePlayQueue::getTrack 0 Feb 07 20:45:58 volumioloft volumio[30874]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 07 20:45:58 volumioloft volumio[30874]: info: CoreCommandRouter::volumioPushState Feb 07 20:45:58 volumioloft volumio[30874]: info: CoreStateMachine::updateTrackBlock Feb 07 20:45:58 volumioloft volumio[30874]: info: CorePlayQueue::getTrackBlock Feb 07 20:45:58 volumioloft volumio[30874]: info: CoreCommandRouter::volumioRetrievevolume Feb 07 20:45:59 volumioloft volumio[30874]: info: DAC script executed Feb 07 20:45:59 volumioloft volumio[30874]: info: Completed loading Core Plugins Feb 07 20:45:59 volumioloft volumio[30874]: info: Preparing to generate the ALSA configuration file Feb 07 20:45:59 volumioloft volumio[30874]: info: Asound.conf file unchanged, so no further update is needed Feb 07 20:45:59 volumioloft volumio[30874]: info: Output device has changed, restarting MPD Feb 07 20:45:59 volumioloft sudo[30998]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 07 20:45:59 volumioloft volumio[30874]: info: Output device has changed, restarting Shairport Sync Feb 07 20:45:59 volumioloft sudo[30998]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:45:59 volumioloft volumio[30874]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:59 volumioloft volumio[30874]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 20:45:59 volumioloft sudo[30998]: pam_unix(sudo:session): session closed for user root Feb 07 20:45:59 volumioloft sudo[31000]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 07 20:45:59 volumioloft sudo[31000]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:45:59 volumioloft systemd[1]: Stopping Music Player Daemon... Feb 07 20:45:59 volumioloft volumio[30874]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 07 20:45:59 volumioloft volumio[30874]: info: ___________ START PLUGINS ___________ Feb 07 20:45:59 volumioloft systemd[1]: mpd.service: Succeeded. Feb 07 20:45:59 volumioloft systemd[1]: Stopped Music Player Daemon. Feb 07 20:45:59 volumioloft volumio[30874]: info: ControllerMpd::onStart: Initializing MPD Feb 07 20:45:59 volumioloft volumio[30874]: info: Creating MPD Configuration file Feb 07 20:45:59 volumioloft sudo[31008]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 07 20:45:59 volumioloft sudo[31008]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:45:59 volumioloft systemd[1]: Starting Music Player Daemon... Feb 07 20:45:59 volumioloft volumio[30874]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 07 20:45:59 volumioloft volumio[30874]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 07 20:45:59 volumioloft volumio[30874]: info: [1770497159208] CoreMusicLibrary::Adding element Media Servers Feb 07 20:45:59 volumioloft volumio[30874]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 20:45:59 volumioloft sudo[31008]: pam_unix(sudo:session): session closed for user root Feb 07 20:45:59 volumioloft sudo[31010]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 07 20:45:59 volumioloft sudo[31010]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:45:59 volumioloft volumio[30874]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:59 volumioloft volumio[30874]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 20:45:59 volumioloft systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Feb 07 20:45:59 volumioloft systemd[1]: mpd.service: Succeeded. Feb 07 20:45:59 volumioloft systemd[1]: Stopped Music Player Daemon. Feb 07 20:45:59 volumioloft systemd[1]: Starting Music Player Daemon... Feb 07 20:45:59 volumioloft volumio[30874]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 07 20:45:59 volumioloft volumio[30874]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:59 volumioloft volumio[30874]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 20:45:59 volumioloft volumio[30874]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 07 20:45:59 volumioloft volumio[30874]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 07 20:45:59 volumioloft volumio[30874]: info: [1770497159346] CoreMusicLibrary::Adding element Last_100 Feb 07 20:45:59 volumioloft volumio[30874]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 20:45:59 volumioloft volumio[30874]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 07 20:45:59 volumioloft volumio[30874]: info: [1770497159351] CoreMusicLibrary::Adding element Webradio Feb 07 20:45:59 volumioloft volumio[30874]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 20:45:59 volumioloft volumio[30874]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 07 20:45:59 volumioloft volumio[30874]: info: Initializing BBC Radios Feb 07 20:45:59 volumioloft sudo[31016]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 07 20:45:59 volumioloft sudo[31016]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:45:59 volumioloft sudo[31016]: pam_unix(sudo:session): session closed for user root Feb 07 20:45:59 volumioloft volumio[30874]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 07 20:45:59 volumioloft volumio[30874]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 20:45:59 volumioloft volumio[30874]: info: [squeezelite_mc] Starting proxy server... Feb 07 20:45:59 volumioloft volumio[30874]: info: Loading i18n strings for locale en Feb 07 20:45:59 volumioloft volumio[30874]: Updating browse sources language Feb 07 20:45:59 volumioloft volumio[30874]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 20:45:59 volumioloft volumio[30874]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 07 20:45:59 volumioloft volumio[30874]: info: [1770497159512] CoreMusicLibrary::Adding element Volusonic Feb 07 20:45:59 volumioloft volumio[30874]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 20:45:59 volumioloft volumio[30874]: Cannot find translation for source Volusonic Feb 07 20:45:59 volumioloft volumio[30874]: info: Volumio Calling Home Feb 07 20:45:59 volumioloft volumio[30874]: info: [squeezelite_mc] Proxy server started on port 34075 Feb 07 20:45:59 volumioloft wpa_supplicant[892]: wlan0: Failed to initiate sched scan Feb 07 20:45:59 volumioloft volumio[30874]: info: CoreCommandRouter::volumioRetrievevolume Feb 07 20:45:59 volumioloft volumio[30874]: Unhandled rejection Error: No sockets available, cannot start. Feb 07 20:45:59 volumioloft volumio[30874]: at SsdpClient.SSDP._createSockets (/volumio/node_modules/node-ssdp/lib/index.js:186:11) Feb 07 20:45:59 volumioloft volumio[30874]: at SsdpClient.SSDP._start (/volumio/node_modules/node-ssdp/lib/index.js:229:10) Feb 07 20:45:59 volumioloft volumio[30874]: at /volumio/node_modules/node-ssdp/lib/client.js:60:10 Feb 07 20:45:59 volumioloft volumio[30874]: at Promise._execute (/volumio/node_modules/bluebird/js/release/debuggability.js:384:9) Feb 07 20:45:59 volumioloft volumio[30874]: at Promise._resolveFromExecutor (/volumio/node_modules/bluebird/js/release/promise.js:518:18) Feb 07 20:45:59 volumioloft volumio[30874]: at new Promise (/volumio/node_modules/bluebird/js/release/promise.js:103:10) Feb 07 20:45:59 volumioloft volumio[30874]: at SsdpClient.start (/volumio/node_modules/node-ssdp/lib/client.js:54:10) Feb 07 20:45:59 volumioloft volumio[30874]: at SsdpClient.search (/volumio/node_modules/node-ssdp/lib/client.js:82:17) Feb 07 20:45:59 volumioloft volumio[30874]: at ControllerUPNPBrowser.onStart (/volumio/app/plugins/music_service/upnp_browser/index.js:126:12) Feb 07 20:45:59 volumioloft volumio[30874]: at PluginManager.startCorePlugin (/volumio/app/pluginmanager.js:398:24) Feb 07 20:45:59 volumioloft volumio[30874]: at HashMap. (/volumio/app/pluginmanager.js:496:31) Feb 07 20:45:59 volumioloft volumio[30874]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Feb 07 20:45:59 volumioloft volumio[30874]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Feb 07 20:45:59 volumioloft volumio[30874]: at PluginManager.startCorePlugins (/volumio/app/pluginmanager.js:495:20) Feb 07 20:45:59 volumioloft volumio[30874]: at Promise._successFn (/volumio/app/pluginmanager.js:142:29) Feb 07 20:45:59 volumioloft volumio[30874]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Feb 07 20:45:59 volumioloft volumio[30874]: info: MPD Permissions set Feb 07 20:45:59 volumioloft volumio[30874]: info: MPD Permissions set Feb 07 20:45:59 volumioloft volumio[30874]: info: VolumeController:: Volume=22 Mute =false Feb 07 20:45:59 volumioloft volumio[30874]: info: CoreStateMachine::pushState Feb 07 20:45:59 volumioloft volumio[30874]: info: CorePlayQueue::getTrack 0 Feb 07 20:45:59 volumioloft volumio[30874]: info: CoreCommandRouter::volumioPushState Feb 07 20:45:59 volumioloft volumio[30874]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Feb 07 20:45:59 volumioloft volumio[30874]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:59 volumioloft volumio[30874]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:59 volumioloft volumio[30874]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:59 volumioloft volumio[30874]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:59 volumioloft volumio[30874]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:59 volumioloft volumio[30874]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:59 volumioloft volumio[30874]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:59 volumioloft volumio[30874]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:59 volumioloft volumio[30874]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 20:45:59 volumioloft volumio[30874]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:59 volumioloft volumio[30874]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:59 volumioloft volumio[30874]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:59 volumioloft volumio[30874]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:59 volumioloft volumio[30874]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:59 volumioloft volumio[30874]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:59 volumioloft volumio[30874]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:59 volumioloft volumio[30874]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:59 volumioloft volumio[30874]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:59 volumioloft volumio[30874]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 20:45:59 volumioloft volumio[30874]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:45:59 volumioloft volumio[30874]: info: VolumeController:: Volume=22 Mute =false Feb 07 20:45:59 volumioloft volumio[30874]: info: CoreStateMachine::pushState Feb 07 20:45:59 volumioloft volumio[30874]: info: CorePlayQueue::getTrack 0 Feb 07 20:45:59 volumioloft volumio[30874]: info: CoreCommandRouter::volumioPushState Feb 07 20:46:00 volumioloft volumio[30874]: info: [squeezelite_mc] Server discovery started Feb 07 20:46:00 volumioloft volumio[30874]: info: [squeezelite_mc] Player finder started Feb 07 20:46:00 volumioloft volumio[30874]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:46:00 volumioloft volumio[30874]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:46:00 volumioloft volumio[30874]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:46:00 volumioloft volumio[30874]: info: [squeezelite_mc] Starting Squeezelite service with params: {"type":"manual","startupOptions":"-s 10.0.0.101:3483 -o squeezelite -C 1 -n \"volumioloft\" -V \"Digital\" -f /tmp/squeezelite.log","card":"2","mixerType":"Hardware","mixer":"Digital"} Feb 07 20:46:00 volumioloft volumio[30874]: 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 Feb 07 20:46:00 volumioloft volumio[30874]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 07 20:46:00 volumioloft volumio[30874]: Error: send ENETUNREACH 255.255.255.255:3483 Feb 07 20:46:00 volumioloft volumio[30874]: at doSend (dgram.js:692:16) Feb 07 20:46:00 volumioloft volumio[30874]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:430:12) Feb 07 20:46:00 volumioloft volumio[30874]: at afterDns (dgram.js:638:5) Feb 07 20:46:00 volumioloft volumio[30874]: at processTicksAndRejections (internal/process/task_queues.js:81:21) { Feb 07 20:46:00 volumioloft volumio[30874]: errno: -101, Feb 07 20:46:00 volumioloft volumio[30874]: code: 'ENETUNREACH', Feb 07 20:46:00 volumioloft volumio[30874]: syscall: 'send', Feb 07 20:46:00 volumioloft volumio[30874]: address: '255.255.255.255', Feb 07 20:46:00 volumioloft volumio[30874]: port: 3483 Feb 07 20:46:00 volumioloft volumio[30874]: } Feb 07 20:46:00 volumioloft volumio[30874]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 07 20:46:00 volumioloft sudo[31047]: 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 Feb 07 20:46:00 volumioloft sudo[31047]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:46:00 volumioloft sudo[31047]: pam_unix(sudo:session): session closed for user root Feb 07 20:46:00 volumioloft sudo[31060]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-02-07 20:45 Feb 07 20:46:00 volumioloft sudo[31060]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:46:00 volumioloft sudo[31060]: pam_unix(sudo:session): session closed for user root Feb 07 20:46:01 volumioloft volumio-remote-updater[667]: [2026-02-07 20:46:01] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Feb 07 20:46:01 volumioloft volumio-remote-updater[667]: [2026-02-07 20:46:01] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Feb 07 20:46:01 volumioloft systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Feb 07 20:46:01 volumioloft sudo[31000]: pam_unix(sudo:session): session closed for user root Feb 07 20:46:01 volumioloft sudo[31010]: pam_unix(sudo:session): session closed for user root Feb 07 20:46:01 volumioloft systemd[1]: volumio.service: Failed with result 'exit-code'. Feb 07 20:46:01 volumioloft mpd[31027]: decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 07 20:46:01 volumioloft mpd[31027]: output: No 'audio_output' defined in config file Feb 07 20:46:01 volumioloft mpd[31027]: output: Successfully detected a sndio audio device Feb 07 20:46:01 volumioloft mpd[31027]: zeroconf: No global port, disabling zeroconf Feb 07 20:46:01 volumioloft systemd[1]: Started dynamicswap service. Feb 07 20:46:01 volumioloft systemd[1]: Started Music Player Daemon. Feb 07 20:46:01 volumioloft systemd[1]: dynamicswap.service: Succeeded. Feb 07 20:46:01 volumioloft systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Feb 07 20:46:01 volumioloft systemd[1]: volumio.service: Scheduled restart job, restart counter is at 96. Feb 07 20:46:01 volumioloft systemd[1]: Stopped Volumio Backend Module. Feb 07 20:46:01 volumioloft systemd[1]: Started Volumio Backend Module. Feb 07 20:46:01 volumioloft systemd[1]: Started dynamicswap service. Feb 07 20:46:01 volumioloft systemd[1]: dynamicswap.service: Succeeded. Feb 07 20:46:03 volumioloft volumio[31076]: info: ------------------------------------------- Feb 07 20:46:03 volumioloft volumio[31076]: info: ----- Volumio3 ---- Feb 07 20:46:03 volumioloft volumio[31076]: info: ------------------------------------------- Feb 07 20:46:03 volumioloft volumio[31076]: info: ----- System startup ---- Feb 07 20:46:03 volumioloft volumio[31076]: info: ------------------------------------------- Feb 07 20:46:03 volumioloft volumio[31076]: info: MYVOLUMIO Environment detected Feb 07 20:46:03 volumioloft volumio[31076]: info: Plugin folders cleanup Feb 07 20:46:03 volumioloft volumio[31076]: info: Scanning into folder /volumio/app/plugins/ Feb 07 20:46:03 volumioloft volumio[31076]: info: Scanning category audio_interface Feb 07 20:46:03 volumioloft volumio[31076]: info: Scanning category miscellanea Feb 07 20:46:03 volumioloft volumio[31076]: info: Scanning category music_service Feb 07 20:46:03 volumioloft volumio[31076]: info: Scanning category plugins.json Feb 07 20:46:03 volumioloft volumio[31076]: info: Scanning category system_controller Feb 07 20:46:03 volumioloft volumio[31076]: info: Scanning category user_interface Feb 07 20:46:03 volumioloft volumio[31076]: info: Scanning into folder /data/plugins/ Feb 07 20:46:03 volumioloft volumio[31076]: info: Scanning category music_service Feb 07 20:46:03 volumioloft volumio[31076]: info: Plugin folders cleanup completed Feb 07 20:46:03 volumioloft volumio[31076]: info: ------------------------------------------- Feb 07 20:46:03 volumioloft volumio[31076]: info: ----- Core plugins startup ---- Feb 07 20:46:03 volumioloft volumio[31076]: info: ------------------------------------------- Feb 07 20:46:03 volumioloft volumio[31076]: info: Loading plugins from folder /volumio/app/plugins/ Feb 07 20:46:03 volumioloft volumio[31076]: info: Adding plugin upnp to MyMusic Plugins Feb 07 20:46:03 volumioloft volumio[31076]: info: Adding plugin airplay_emulation to MyMusic Plugins Feb 07 20:46:03 volumioloft volumio[31076]: info: Adding plugin upnp_browser to MyMusic Plugins Feb 07 20:46:03 volumioloft volumio[31076]: info: Loading plugins from folder /data/plugins/ Feb 07 20:46:03 volumioloft volumio[31076]: info: Loading plugin "system"... Feb 07 20:46:03 volumioloft volumio[31076]: info: Loading plugin "appearance"... Feb 07 20:46:04 volumioloft volumio[31076]: info: Loading plugin "network"... Feb 07 20:46:04 volumioloft volumio[31076]: info: Refreshing Cached IP Addresses Feb 07 20:46:04 volumioloft sudo[31103]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 07 20:46:04 volumioloft sudo[31103]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:46:04 volumioloft sudo[31103]: pam_unix(sudo:session): session closed for user root Feb 07 20:46:04 volumioloft sudo[31105]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 07 20:46:04 volumioloft sudo[31105]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:46:04 volumioloft sudo[31105]: pam_unix(sudo:session): session closed for user root Feb 07 20:46:05 volumioloft volumio[31076]: info: Loading plugin "services"... Feb 07 20:46:05 volumioloft volumio[31076]: info: Loading plugin "alsa_controller"... Feb 07 20:46:05 volumioloft sudo[31118]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Feb 07 20:46:05 volumioloft sudo[31118]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:46:05 volumioloft sudo[31118]: pam_unix(sudo:session): session closed for user root Feb 07 20:46:05 volumioloft volumio[31076]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 07 20:46:05 volumioloft volumio[31076]: info: Loading plugin "wizard"... Feb 07 20:46:05 volumioloft volumio[31076]: info: Loading plugin "networkfs"... Feb 07 20:46:05 volumioloft volumio[31076]: info: Starting Udev Watcher for removable devices Feb 07 20:46:05 volumioloft volumio[31076]: info: Ignoring mount for partition: boot Feb 07 20:46:05 volumioloft volumio[31076]: info: Ignoring mount for partition: volumio Feb 07 20:46:05 volumioloft volumio[31076]: info: Ignoring mount for partition: volumio_data Feb 07 20:46:05 volumioloft volumio[31076]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 07 20:46:05 volumioloft volumio[31076]: info: Loading plugin "volumio_command_line_client"... Feb 07 20:46:05 volumioloft volumio[31076]: info: Loading plugin "upnp"... Feb 07 20:46:05 volumioloft volumio[31076]: info: [1770497165201] Starting Upmpd Daemon Feb 07 20:46:05 volumioloft volumio[31076]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 07 20:46:05 volumioloft volumio[31076]: info: Loading plugin "my_music"... Feb 07 20:46:05 volumioloft volumio[31076]: info: Loading plugin "mpd"... Feb 07 20:46:05 volumioloft wpa_supplicant[892]: wlan0: Failed to initiate sched scan Feb 07 20:46:05 volumioloft volumio[31076]: info: Loading plugin "upnp_browser"... Feb 07 20:46:05 volumioloft volumio[31076]: info: Loading plugin "alarm-clock"... Feb 07 20:46:06 volumioloft volumio-remote-updater[667]: [2026-02-07 20:46:06] [connect] Successful connection Feb 07 20:46:06 volumioloft volumio[31076]: info: Loading plugin "airplay_emulation"... Feb 07 20:46:06 volumioloft volumio[31076]: info: Starting Shairport Sync Feb 07 20:46:06 volumioloft volumio[31076]: info: Loading plugin "last_100"... Feb 07 20:46:06 volumioloft volumio[31076]: info: Loading plugin "webradio"... Feb 07 20:46:06 volumioloft volumio[31076]: info: Loading plugin "i2s_dacs"... Feb 07 20:46:06 volumioloft volumio[31076]: info: Loading plugin "volumiodiscovery"... Feb 07 20:46:06 volumioloft volumio[31076]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 07 20:46:06 volumioloft volumio[31076]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 07 20:46:06 volumioloft volumio[31076]: *** WARNING *** For more information see Feb 07 20:46:06 volumioloft node[31076]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 07 20:46:06 volumioloft volumio[31076]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 07 20:46:06 volumioloft volumio[31076]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 07 20:46:06 volumioloft volumio[31076]: *** WARNING *** For more information see Feb 07 20:46:06 volumioloft node[31076]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 07 20:46:06 volumioloft node[31076]: *** WARNING *** For more information see Feb 07 20:46:06 volumioloft node[31076]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 07 20:46:06 volumioloft node[31076]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 07 20:46:06 volumioloft node[31076]: *** WARNING *** For more information see Feb 07 20:46:06 volumioloft volumio[31076]: info: Applying required configuration parameters for plugin volumiodiscovery Feb 07 20:46:06 volumioloft volumio[31076]: info: Discovery: Started advertising with name: Volumioloft Feb 07 20:46:06 volumioloft volumio[31076]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 07 20:46:06 volumioloft volumio[31076]: info: Loading plugin "squeezelite_mc"... Feb 07 20:46:07 volumioloft volumio[31076]: info: Loading plugin "outputs"... Feb 07 20:46:07 volumioloft volumio[31076]: info: Loading plugin "albumart"... Feb 07 20:46:07 volumioloft volumio[31076]: info: Plugin example_plugin is not enabled Feb 07 20:46:07 volumioloft volumio[31076]: info: Loading plugin "inputs"... Feb 07 20:46:07 volumioloft volumio[31076]: info: Loading plugin "updater_comm"... Feb 07 20:46:07 volumioloft volumio[31076]: info: Plugin mpdemulation is not enabled Feb 07 20:46:07 volumioloft volumio[31076]: info: Loading plugin "rest_api"... Feb 07 20:46:07 volumioloft volumio[31076]: info: Loading plugin "websocket"... Feb 07 20:46:07 volumioloft volumio[31076]: info: Starting Socket.io Server version 2.3.0 Feb 07 20:46:07 volumioloft volumio[31076]: info: Loading plugin "volusonic"... Feb 07 20:46:07 volumioloft volumio[31076]: Forking 3 albumart workers Feb 07 20:46:08 volumioloft volumio[31076]: info: Applying required configuration parameters for plugin volusonic Feb 07 20:46:08 volumioloft volumio[31076]: info: Loading i18n strings for locale en Feb 07 20:46:08 volumioloft volumio[31076]: Updating browse sources language Feb 07 20:46:08 volumioloft volumio[31076]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 20:46:08 volumioloft volumio[31076]: Starting albumart workers Feb 07 20:46:08 volumioloft volumio[31076]: Starting albumart workers Feb 07 20:46:08 volumioloft volumio[31076]: Starting albumart workers Feb 07 20:46:08 volumioloft volumio[31076]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 07 20:46:08 volumioloft volumio[31076]: info: CoreCommandRouter::initPlayerControls Feb 07 20:46:08 volumioloft volumio[31076]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:46:08 volumioloft volumio[31076]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:46:08 volumioloft volumio[31076]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:46:08 volumioloft volumio[31076]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:46:08 volumioloft volumio[31076]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:46:08 volumioloft volumio[31076]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:46:08 volumioloft volumio[31076]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:46:08 volumioloft volumio[31076]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:46:08 volumioloft volumio[31076]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 07 20:46:08 volumioloft volumio[31076]: Express server listening on port 3000 Feb 07 20:46:08 volumioloft volumio[31076]: [Metrics] WebUI: 6s 197.00ms Feb 07 20:46:08 volumioloft volumio[31076]: info: CoreStateMachine::resetVolumioState Feb 07 20:46:08 volumioloft volumio[31076]: info: CoreStateMachine::getcurrentVolume Feb 07 20:46:08 volumioloft volumio[31076]: info: CoreCommandRouter::volumioRetrievevolume Feb 07 20:46:08 volumioloft volumio[31076]: info: Volumio Network Manager: Network status updated: 0 Feb 07 20:46:08 volumioloft volumio[31076]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Feb 07 20:46:08 volumioloft volumio[31076]: wlan0 Interface doesn't support scanning : Device or resource busy Feb 07 20:46:08 volumioloft volumio[31076]: info: Cannot use regular scanning, forcing with ap-force Feb 07 20:46:09 volumioloft sudo[31165]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Feb 07 20:46:09 volumioloft sudo[31165]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:46:09 volumioloft sudo[31165]: pam_unix(sudo:session): session closed for user root Feb 07 20:46:09 volumioloft volumio-remote-updater[667]: [2026-02-07 20:46:09] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1770497166 101 Feb 07 20:46:09 volumioloft volumio[31076]: 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 Feb 07 20:46:09 volumioloft volumio[31076]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 20:46:09 volumioloft volumio[31076]: info: Executing start script for DAC IQaudIO DAC Plus Feb 07 20:46:09 volumioloft volumio[31076]: info: Reloading queue from file Feb 07 20:46:09 volumioloft volumio[31076]: info: CoreStateMachine::setRepeat null single undefined Feb 07 20:46:09 volumioloft volumio[31076]: info: CoreStateMachine::pushState Feb 07 20:46:09 volumioloft volumio[31076]: info: CorePlayQueue::getTrack 0 Feb 07 20:46:09 volumioloft volumio[31076]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 07 20:46:09 volumioloft volumio[31076]: info: CoreCommandRouter::volumioPushState Feb 07 20:46:09 volumioloft volumio[31076]: info: CoreStateMachine::setRandom null Feb 07 20:46:09 volumioloft volumio[31076]: info: CoreStateMachine::pushState Feb 07 20:46:09 volumioloft volumio[31076]: info: CorePlayQueue::getTrack 0 Feb 07 20:46:09 volumioloft volumio[31076]: info: CoreCommandRouter::volumioPushState Feb 07 20:46:09 volumioloft volumio[31076]: info: Setting Device type: Raspberry PI Feb 07 20:46:09 volumioloft volumio[31076]: info: VolumeController:: Volume=22 Mute =false Feb 07 20:46:09 volumioloft volumio[31076]: info: CoreStateMachine::pushState Feb 07 20:46:09 volumioloft volumio[31076]: info: CorePlayQueue::getTrack 0 Feb 07 20:46:09 volumioloft volumio[31076]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 07 20:46:09 volumioloft volumio[31076]: info: CoreCommandRouter::volumioPushState Feb 07 20:46:09 volumioloft volumio[31076]: info: CoreStateMachine::updateTrackBlock Feb 07 20:46:09 volumioloft volumio[31076]: info: CorePlayQueue::getTrackBlock Feb 07 20:46:09 volumioloft volumio[31076]: info: CoreCommandRouter::volumioRetrievevolume Feb 07 20:46:09 volumioloft volumio[31076]: info: DAC script executed Feb 07 20:46:09 volumioloft volumio[31076]: info: Completed loading Core Plugins Feb 07 20:46:09 volumioloft volumio[31076]: info: Preparing to generate the ALSA configuration file Feb 07 20:46:09 volumioloft volumio[31076]: info: Asound.conf file unchanged, so no further update is needed Feb 07 20:46:09 volumioloft volumio[31076]: info: Output device has changed, restarting MPD Feb 07 20:46:09 volumioloft sudo[31203]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 07 20:46:10 volumioloft volumio[31076]: info: Output device has changed, restarting Shairport Sync Feb 07 20:46:10 volumioloft sudo[31203]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:46:10 volumioloft volumio[31076]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:46:10 volumioloft volumio[31076]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 20:46:10 volumioloft sudo[31203]: pam_unix(sudo:session): session closed for user root Feb 07 20:46:10 volumioloft sudo[31205]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 07 20:46:10 volumioloft sudo[31205]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:46:10 volumioloft systemd[1]: Stopping Music Player Daemon... Feb 07 20:46:10 volumioloft volumio[31076]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 07 20:46:10 volumioloft volumio[31076]: info: ___________ START PLUGINS ___________ Feb 07 20:46:10 volumioloft systemd[1]: mpd.service: Succeeded. Feb 07 20:46:10 volumioloft systemd[1]: Stopped Music Player Daemon. Feb 07 20:46:10 volumioloft volumio[31076]: info: ControllerMpd::onStart: Initializing MPD Feb 07 20:46:10 volumioloft volumio[31076]: info: Creating MPD Configuration file Feb 07 20:46:10 volumioloft sudo[31213]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 07 20:46:10 volumioloft sudo[31213]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:46:10 volumioloft systemd[1]: Starting Music Player Daemon... Feb 07 20:46:10 volumioloft volumio[31076]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 07 20:46:10 volumioloft volumio[31076]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 07 20:46:10 volumioloft volumio[31076]: info: [1770497170124] CoreMusicLibrary::Adding element Media Servers Feb 07 20:46:10 volumioloft volumio[31076]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 20:46:10 volumioloft volumio[31076]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:46:10 volumioloft volumio[31076]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 20:46:10 volumioloft sudo[31213]: pam_unix(sudo:session): session closed for user root Feb 07 20:46:10 volumioloft sudo[31215]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 07 20:46:10 volumioloft sudo[31215]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:46:10 volumioloft systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Feb 07 20:46:10 volumioloft systemd[1]: mpd.service: Succeeded. Feb 07 20:46:10 volumioloft systemd[1]: Stopped Music Player Daemon. Feb 07 20:46:10 volumioloft systemd[1]: Starting Music Player Daemon... Feb 07 20:46:10 volumioloft volumio[31076]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 07 20:46:10 volumioloft volumio[31076]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:46:10 volumioloft volumio[31076]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 20:46:10 volumioloft volumio[31076]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 07 20:46:10 volumioloft volumio[31076]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 07 20:46:10 volumioloft volumio[31076]: info: [1770497170258] CoreMusicLibrary::Adding element Last_100 Feb 07 20:46:10 volumioloft volumio[31076]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 20:46:10 volumioloft volumio[31076]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 07 20:46:10 volumioloft volumio[31076]: info: [1770497170261] CoreMusicLibrary::Adding element Webradio Feb 07 20:46:10 volumioloft volumio[31076]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 20:46:10 volumioloft volumio[31076]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 07 20:46:10 volumioloft volumio[31076]: info: Initializing BBC Radios Feb 07 20:46:10 volumioloft sudo[31221]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 07 20:46:10 volumioloft sudo[31221]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:46:10 volumioloft sudo[31221]: pam_unix(sudo:session): session closed for user root Feb 07 20:46:10 volumioloft volumio[31076]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 07 20:46:10 volumioloft volumio[31076]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 20:46:10 volumioloft volumio[31076]: info: [squeezelite_mc] Starting proxy server... Feb 07 20:46:10 volumioloft volumio[31076]: info: Loading i18n strings for locale en Feb 07 20:46:10 volumioloft volumio[31076]: Updating browse sources language Feb 07 20:46:10 volumioloft volumio[31076]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 20:46:10 volumioloft volumio[31076]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 07 20:46:10 volumioloft volumio[31076]: info: [1770497170419] CoreMusicLibrary::Adding element Volusonic Feb 07 20:46:10 volumioloft volumio[31076]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 20:46:10 volumioloft volumio[31076]: Cannot find translation for source Volusonic Feb 07 20:46:10 volumioloft volumio[31076]: info: Volumio Calling Home Feb 07 20:46:10 volumioloft volumio[31076]: info: [squeezelite_mc] Proxy server started on port 34865 Feb 07 20:46:10 volumioloft volumio[31076]: info: CoreCommandRouter::volumioRetrievevolume Feb 07 20:46:10 volumioloft volumio[31076]: Unhandled rejection Error: No sockets available, cannot start. Feb 07 20:46:10 volumioloft volumio[31076]: at SsdpClient.SSDP._createSockets (/volumio/node_modules/node-ssdp/lib/index.js:186:11) Feb 07 20:46:10 volumioloft volumio[31076]: at SsdpClient.SSDP._start (/volumio/node_modules/node-ssdp/lib/index.js:229:10) Feb 07 20:46:10 volumioloft volumio[31076]: at /volumio/node_modules/node-ssdp/lib/client.js:60:10 Feb 07 20:46:10 volumioloft volumio[31076]: at Promise._execute (/volumio/node_modules/bluebird/js/release/debuggability.js:384:9) Feb 07 20:46:10 volumioloft volumio[31076]: at Promise._resolveFromExecutor (/volumio/node_modules/bluebird/js/release/promise.js:518:18) Feb 07 20:46:10 volumioloft volumio[31076]: at new Promise (/volumio/node_modules/bluebird/js/release/promise.js:103:10) Feb 07 20:46:10 volumioloft volumio[31076]: at SsdpClient.start (/volumio/node_modules/node-ssdp/lib/client.js:54:10) Feb 07 20:46:10 volumioloft volumio[31076]: at SsdpClient.search (/volumio/node_modules/node-ssdp/lib/client.js:82:17) Feb 07 20:46:10 volumioloft volumio[31076]: at ControllerUPNPBrowser.onStart (/volumio/app/plugins/music_service/upnp_browser/index.js:126:12) Feb 07 20:46:10 volumioloft volumio[31076]: at PluginManager.startCorePlugin (/volumio/app/pluginmanager.js:398:24) Feb 07 20:46:10 volumioloft volumio[31076]: at HashMap. (/volumio/app/pluginmanager.js:496:31) Feb 07 20:46:10 volumioloft volumio[31076]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Feb 07 20:46:10 volumioloft volumio[31076]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Feb 07 20:46:10 volumioloft volumio[31076]: at PluginManager.startCorePlugins (/volumio/app/pluginmanager.js:495:20) Feb 07 20:46:10 volumioloft volumio[31076]: at Promise._successFn (/volumio/app/pluginmanager.js:142:29) Feb 07 20:46:10 volumioloft volumio[31076]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Feb 07 20:46:10 volumioloft volumio[31076]: info: MPD Permissions set Feb 07 20:46:10 volumioloft volumio[31076]: info: VolumeController:: Volume=22 Mute =false Feb 07 20:46:10 volumioloft volumio[31076]: info: CoreStateMachine::pushState Feb 07 20:46:10 volumioloft volumio[31076]: info: CorePlayQueue::getTrack 0 Feb 07 20:46:10 volumioloft volumio[31076]: info: CoreCommandRouter::volumioPushState Feb 07 20:46:10 volumioloft volumio[31076]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Feb 07 20:46:10 volumioloft volumio[31076]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:46:10 volumioloft volumio[31076]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:46:10 volumioloft volumio[31076]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:46:10 volumioloft volumio[31076]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:46:10 volumioloft volumio[31076]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:46:10 volumioloft volumio[31076]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:46:10 volumioloft volumio[31076]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:46:10 volumioloft volumio[31076]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:46:10 volumioloft volumio[31076]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 20:46:10 volumioloft volumio[31076]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:46:10 volumioloft volumio[31076]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:46:10 volumioloft volumio[31076]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:46:10 volumioloft volumio[31076]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:46:10 volumioloft volumio[31076]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:46:10 volumioloft volumio[31076]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:46:10 volumioloft volumio[31076]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:46:10 volumioloft volumio[31076]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:46:10 volumioloft volumio[31076]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:46:10 volumioloft volumio[31076]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 20:46:10 volumioloft volumio[31076]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:46:10 volumioloft volumio[31076]: info: VolumeController:: Volume=22 Mute =false Feb 07 20:46:10 volumioloft volumio[31076]: info: CoreStateMachine::pushState Feb 07 20:46:10 volumioloft volumio[31076]: info: CorePlayQueue::getTrack 0 Feb 07 20:46:10 volumioloft volumio[31076]: info: CoreCommandRouter::volumioPushState Feb 07 20:46:10 volumioloft volumio[31076]: info: [squeezelite_mc] Server discovery started Feb 07 20:46:10 volumioloft volumio[31076]: info: [squeezelite_mc] Player finder started Feb 07 20:46:10 volumioloft volumio[31076]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:46:10 volumioloft volumio[31076]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:46:10 volumioloft volumio[31076]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:46:10 volumioloft volumio[31076]: info: [squeezelite_mc] Starting Squeezelite service with params: {"type":"manual","startupOptions":"-s 10.0.0.101:3483 -o squeezelite -C 1 -n \"volumioloft\" -V \"Digital\" -f /tmp/squeezelite.log","card":"2","mixerType":"Hardware","mixer":"Digital"} Feb 07 20:46:10 volumioloft wpa_supplicant[892]: wlan0: Failed to initiate sched scan Feb 07 20:46:10 volumioloft volumio[31076]: 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 Feb 07 20:46:10 volumioloft volumio[31076]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 07 20:46:10 volumioloft volumio[31076]: Error: send ENETUNREACH 255.255.255.255:3483 Feb 07 20:46:10 volumioloft volumio[31076]: at doSend (dgram.js:692:16) Feb 07 20:46:10 volumioloft volumio[31076]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:430:12) Feb 07 20:46:10 volumioloft volumio[31076]: at afterDns (dgram.js:638:5) Feb 07 20:46:10 volumioloft volumio[31076]: at processTicksAndRejections (internal/process/task_queues.js:81:21) { Feb 07 20:46:10 volumioloft volumio[31076]: errno: -101, Feb 07 20:46:10 volumioloft volumio[31076]: code: 'ENETUNREACH', Feb 07 20:46:10 volumioloft volumio[31076]: syscall: 'send', Feb 07 20:46:10 volumioloft volumio[31076]: address: '255.255.255.255', Feb 07 20:46:10 volumioloft volumio[31076]: port: 3483 Feb 07 20:46:10 volumioloft volumio[31076]: } Feb 07 20:46:10 volumioloft volumio[31076]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 07 20:46:11 volumioloft sudo[31252]: 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 Feb 07 20:46:11 volumioloft sudo[31252]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:46:11 volumioloft sudo[31252]: pam_unix(sudo:session): session closed for user root Feb 07 20:46:11 volumioloft sudo[31263]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-02-07 20:45 Feb 07 20:46:11 volumioloft sudo[31263]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:46:11 volumioloft sudo[31263]: pam_unix(sudo:session): session closed for user root Feb 07 20:46:11 volumioloft volumio-remote-updater[667]: [2026-02-07 20:46:11] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Feb 07 20:46:11 volumioloft volumio-remote-updater[667]: [2026-02-07 20:46:11] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Feb 07 20:46:11 volumioloft systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Feb 07 20:46:11 volumioloft sudo[31215]: pam_unix(sudo:session): session closed for user root Feb 07 20:46:11 volumioloft sudo[31205]: pam_unix(sudo:session): session closed for user root Feb 07 20:46:11 volumioloft systemd[1]: volumio.service: Failed with result 'exit-code'. Feb 07 20:46:11 volumioloft mpd[31236]: decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 07 20:46:12 volumioloft mpd[31236]: output: No 'audio_output' defined in config file Feb 07 20:46:12 volumioloft mpd[31236]: output: Successfully detected a sndio audio device Feb 07 20:46:12 volumioloft mpd[31236]: zeroconf: No global port, disabling zeroconf Feb 07 20:46:12 volumioloft systemd[1]: Started dynamicswap service. Feb 07 20:46:12 volumioloft systemd[1]: Started Music Player Daemon. Feb 07 20:46:12 volumioloft systemd[1]: dynamicswap.service: Succeeded. Feb 07 20:46:12 volumioloft systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Feb 07 20:46:12 volumioloft systemd[1]: volumio.service: Scheduled restart job, restart counter is at 97. Feb 07 20:46:12 volumioloft systemd[1]: Started dynamicswap service. Feb 07 20:46:12 volumioloft systemd[1]: Stopped Volumio Backend Module. Feb 07 20:46:12 volumioloft systemd[1]: Started Volumio Backend Module. Feb 07 20:46:12 volumioloft systemd[1]: dynamicswap.service: Succeeded. Feb 07 20:46:14 volumioloft volumio[31279]: info: ------------------------------------------- Feb 07 20:46:14 volumioloft volumio[31279]: info: ----- Volumio3 ---- Feb 07 20:46:14 volumioloft volumio[31279]: info: ------------------------------------------- Feb 07 20:46:14 volumioloft volumio[31279]: info: ----- System startup ---- Feb 07 20:46:14 volumioloft volumio[31279]: info: ------------------------------------------- Feb 07 20:46:14 volumioloft volumio[31279]: info: MYVOLUMIO Environment detected Feb 07 20:46:14 volumioloft volumio[31279]: info: Plugin folders cleanup Feb 07 20:46:14 volumioloft volumio[31279]: info: Scanning into folder /volumio/app/plugins/ Feb 07 20:46:14 volumioloft volumio[31279]: info: Scanning category audio_interface Feb 07 20:46:14 volumioloft volumio[31279]: info: Scanning category miscellanea Feb 07 20:46:14 volumioloft volumio[31279]: info: Scanning category music_service Feb 07 20:46:14 volumioloft volumio[31279]: info: Scanning category plugins.json Feb 07 20:46:14 volumioloft volumio[31279]: info: Scanning category system_controller Feb 07 20:46:14 volumioloft volumio[31279]: info: Scanning category user_interface Feb 07 20:46:14 volumioloft volumio[31279]: info: Scanning into folder /data/plugins/ Feb 07 20:46:14 volumioloft volumio[31279]: info: Scanning category music_service Feb 07 20:46:14 volumioloft volumio[31279]: info: Plugin folders cleanup completed Feb 07 20:46:14 volumioloft volumio[31279]: info: ------------------------------------------- Feb 07 20:46:14 volumioloft volumio[31279]: info: ----- Core plugins startup ---- Feb 07 20:46:14 volumioloft volumio[31279]: info: ------------------------------------------- Feb 07 20:46:14 volumioloft volumio[31279]: info: Loading plugins from folder /volumio/app/plugins/ Feb 07 20:46:14 volumioloft volumio[31279]: info: Adding plugin upnp to MyMusic Plugins Feb 07 20:46:14 volumioloft volumio[31279]: info: Adding plugin airplay_emulation to MyMusic Plugins Feb 07 20:46:14 volumioloft volumio[31279]: info: Adding plugin upnp_browser to MyMusic Plugins Feb 07 20:46:14 volumioloft volumio[31279]: info: Loading plugins from folder /data/plugins/ Feb 07 20:46:14 volumioloft volumio[31279]: info: Loading plugin "system"... Feb 07 20:46:14 volumioloft volumio[31279]: info: Loading plugin "appearance"... Feb 07 20:46:15 volumioloft volumio[31279]: info: Loading plugin "network"... Feb 07 20:46:15 volumioloft volumio[31279]: info: Refreshing Cached IP Addresses Feb 07 20:46:15 volumioloft sudo[31305]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 07 20:46:15 volumioloft sudo[31305]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:46:15 volumioloft sudo[31305]: pam_unix(sudo:session): session closed for user root Feb 07 20:46:15 volumioloft sudo[31307]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 07 20:46:15 volumioloft sudo[31307]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:46:15 volumioloft sudo[31307]: pam_unix(sudo:session): session closed for user root Feb 07 20:46:15 volumioloft volumio[31279]: info: Loading plugin "services"... Feb 07 20:46:15 volumioloft volumio[31279]: info: Loading plugin "alsa_controller"... Feb 07 20:46:16 volumioloft sudo[31319]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Feb 07 20:46:16 volumioloft sudo[31319]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:46:16 volumioloft sudo[31319]: pam_unix(sudo:session): session closed for user root Feb 07 20:46:16 volumioloft volumio[31279]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 07 20:46:16 volumioloft volumio[31279]: info: Loading plugin "wizard"... Feb 07 20:46:16 volumioloft volumio[31279]: info: Loading plugin "networkfs"... Feb 07 20:46:16 volumioloft volumio[31279]: info: Starting Udev Watcher for removable devices Feb 07 20:46:16 volumioloft volumio[31279]: info: Ignoring mount for partition: boot Feb 07 20:46:16 volumioloft volumio[31279]: info: Ignoring mount for partition: volumio Feb 07 20:46:16 volumioloft volumio[31279]: info: Ignoring mount for partition: volumio_data Feb 07 20:46:16 volumioloft volumio[31279]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 07 20:46:16 volumioloft volumio[31279]: info: Loading plugin "volumio_command_line_client"... Feb 07 20:46:16 volumioloft volumio[31279]: info: Loading plugin "upnp"... Feb 07 20:46:16 volumioloft volumio[31279]: info: [1770497176188] Starting Upmpd Daemon Feb 07 20:46:16 volumioloft volumio[31279]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 07 20:46:16 volumioloft volumio[31279]: info: Loading plugin "my_music"... Feb 07 20:46:16 volumioloft volumio[31279]: info: Loading plugin "mpd"... Feb 07 20:46:16 volumioloft wpa_supplicant[892]: wlan0: Trying to associate with SSID 'Hole' Feb 07 20:46:16 volumioloft volumio[31279]: info: Loading plugin "upnp_browser"... Feb 07 20:46:16 volumioloft dhcpcd[909]: wlan0: carrier acquired Feb 07 20:46:16 volumioloft wpa_supplicant[892]: wlan0: Associated with fc:ec:da:fd:73:f7 Feb 07 20:46:16 volumioloft wpa_supplicant[892]: wlan0: CTRL-EVENT-CONNECTED - Connection to fc:ec:da:fd:73:f7 completed [id=0 id_str=] Feb 07 20:46:16 volumioloft wpa_supplicant[892]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Feb 07 20:46:16 volumioloft wpa_supplicant[892]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=NO Feb 07 20:46:16 volumioloft dhcpcd[909]: wlan0: IAID eb:9a:05:ad Feb 07 20:46:16 volumioloft dhcpcd[909]: wlan0: carrier lost Feb 07 20:46:16 volumioloft dhcpcd[909]: wlan0: carrier acquired Feb 07 20:46:16 volumioloft dhcpcd[909]: wlan0: IAID eb:9a:05:ad Feb 07 20:46:16 volumioloft volumio[31279]: info: Loading plugin "alarm-clock"... Feb 07 20:46:16 volumioloft volumio-remote-updater[667]: [2026-02-07 20:46:16] [connect] Successful connection Feb 07 20:46:17 volumioloft volumio[31279]: info: Loading plugin "airplay_emulation"... Feb 07 20:46:17 volumioloft volumio[31279]: info: Starting Shairport Sync Feb 07 20:46:17 volumioloft volumio[31279]: info: Loading plugin "last_100"... Feb 07 20:46:17 volumioloft volumio[31279]: info: Loading plugin "webradio"... Feb 07 20:46:17 volumioloft volumio[31279]: info: Loading plugin "i2s_dacs"... Feb 07 20:46:17 volumioloft volumio[31279]: info: Loading plugin "volumiodiscovery"... Feb 07 20:46:17 volumioloft volumio[31279]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 07 20:46:17 volumioloft volumio[31279]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 07 20:46:17 volumioloft volumio[31279]: *** WARNING *** For more information see Feb 07 20:46:17 volumioloft node[31279]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 07 20:46:17 volumioloft volumio[31279]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 07 20:46:17 volumioloft volumio[31279]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 07 20:46:17 volumioloft volumio[31279]: *** WARNING *** For more information see Feb 07 20:46:17 volumioloft node[31279]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 07 20:46:17 volumioloft node[31279]: *** WARNING *** For more information see Feb 07 20:46:17 volumioloft node[31279]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 07 20:46:17 volumioloft node[31279]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 07 20:46:17 volumioloft node[31279]: *** WARNING *** For more information see Feb 07 20:46:17 volumioloft volumio[31279]: info: Applying required configuration parameters for plugin volumiodiscovery Feb 07 20:46:17 volumioloft volumio[31279]: info: Discovery: Started advertising with name: Volumioloft Feb 07 20:46:17 volumioloft volumio[31279]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 07 20:46:17 volumioloft volumio[31279]: info: Loading plugin "squeezelite_mc"... Feb 07 20:46:17 volumioloft dhcpcd[909]: wlan0: soliciting an IPv6 router Feb 07 20:46:17 volumioloft dhcpcd[909]: wlan0: rebinding lease of 10.0.20.130 Feb 07 20:46:17 volumioloft dhcpcd[909]: wlan0: probing address 10.0.20.130/24 Feb 07 20:46:18 volumioloft volumio[31279]: info: Loading plugin "outputs"... Feb 07 20:46:18 volumioloft volumio[31279]: info: Loading plugin "albumart"... Feb 07 20:46:18 volumioloft volumio[31279]: info: Plugin example_plugin is not enabled Feb 07 20:46:18 volumioloft volumio[31279]: info: Loading plugin "inputs"... Feb 07 20:46:18 volumioloft volumio[31279]: info: Loading plugin "updater_comm"... Feb 07 20:46:18 volumioloft volumio[31279]: info: Plugin mpdemulation is not enabled Feb 07 20:46:18 volumioloft volumio[31279]: info: Loading plugin "rest_api"... Feb 07 20:46:18 volumioloft volumio[31279]: info: Loading plugin "websocket"... Feb 07 20:46:18 volumioloft volumio[31279]: info: Starting Socket.io Server version 2.3.0 Feb 07 20:46:18 volumioloft volumio[31279]: info: Loading plugin "volusonic"... Feb 07 20:46:18 volumioloft volumio[31279]: Forking 3 albumart workers Feb 07 20:46:19 volumioloft volumio[31279]: info: Applying required configuration parameters for plugin volusonic Feb 07 20:46:19 volumioloft volumio[31279]: info: Loading i18n strings for locale en Feb 07 20:46:19 volumioloft volumio[31279]: Updating browse sources language Feb 07 20:46:19 volumioloft volumio[31279]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 20:46:19 volumioloft volumio[31279]: Starting albumart workers Feb 07 20:46:19 volumioloft volumio[31279]: Starting albumart workers Feb 07 20:46:19 volumioloft volumio[31279]: Starting albumart workers Feb 07 20:46:19 volumioloft volumio[31279]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 07 20:46:19 volumioloft volumio[31279]: info: CoreCommandRouter::initPlayerControls Feb 07 20:46:19 volumioloft volumio[31279]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:46:19 volumioloft volumio[31279]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:46:19 volumioloft volumio[31279]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:46:19 volumioloft volumio[31279]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:46:19 volumioloft volumio[31279]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:46:19 volumioloft volumio[31279]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:46:19 volumioloft volumio[31279]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:46:19 volumioloft volumio[31279]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:46:19 volumioloft volumio[31279]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 07 20:46:19 volumioloft volumio[31279]: Express server listening on port 3000 Feb 07 20:46:19 volumioloft volumio[31279]: [Metrics] WebUI: 6s 329.39ms Feb 07 20:46:19 volumioloft volumio[31279]: info: CoreStateMachine::resetVolumioState Feb 07 20:46:19 volumioloft volumio[31279]: info: CoreStateMachine::getcurrentVolume Feb 07 20:46:19 volumioloft volumio[31279]: info: CoreCommandRouter::volumioRetrievevolume Feb 07 20:46:20 volumioloft volumio[31279]: info: Volumio Network Manager: Network status updated: 0 Feb 07 20:46:20 volumioloft volumio[31279]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Feb 07 20:46:20 volumioloft volumio[31279]: wlan0 Interface doesn't support scanning : Device or resource busy Feb 07 20:46:20 volumioloft volumio[31279]: info: Cannot use regular scanning, forcing with ap-force Feb 07 20:46:20 volumioloft sudo[31417]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Feb 07 20:46:20 volumioloft sudo[31417]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:46:21 volumioloft sudo[31417]: pam_unix(sudo:session): session closed for user root Feb 07 20:46:21 volumioloft volumio-remote-updater[667]: [2026-02-07 20:46:21] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1770497176 101 Feb 07 20:46:21 volumioloft volumio[31279]: 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 Feb 07 20:46:21 volumioloft volumio[31279]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 20:46:21 volumioloft volumio[31279]: info: Executing start script for DAC IQaudIO DAC Plus Feb 07 20:46:21 volumioloft volumio[31279]: info: Reloading queue from file Feb 07 20:46:21 volumioloft volumio[31279]: info: CoreStateMachine::setRepeat null single undefined Feb 07 20:46:21 volumioloft volumio[31279]: info: CoreStateMachine::pushState Feb 07 20:46:21 volumioloft volumio[31279]: info: CorePlayQueue::getTrack 0 Feb 07 20:46:21 volumioloft volumio[31279]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 07 20:46:21 volumioloft volumio[31279]: info: CoreCommandRouter::volumioPushState Feb 07 20:46:21 volumioloft volumio[31279]: info: CoreStateMachine::setRandom null Feb 07 20:46:21 volumioloft volumio[31279]: info: CoreStateMachine::pushState Feb 07 20:46:21 volumioloft volumio[31279]: info: CorePlayQueue::getTrack 0 Feb 07 20:46:21 volumioloft volumio[31279]: info: CoreCommandRouter::volumioPushState Feb 07 20:46:21 volumioloft volumio[31279]: info: Setting Device type: Raspberry PI Feb 07 20:46:21 volumioloft volumio[31279]: info: VolumeController:: Volume=22 Mute =false Feb 07 20:46:21 volumioloft volumio[31279]: info: CoreStateMachine::pushState Feb 07 20:46:21 volumioloft volumio[31279]: info: CorePlayQueue::getTrack 0 Feb 07 20:46:21 volumioloft volumio[31279]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 07 20:46:21 volumioloft volumio[31279]: info: CoreCommandRouter::volumioPushState Feb 07 20:46:21 volumioloft volumio[31279]: info: CoreStateMachine::updateTrackBlock Feb 07 20:46:21 volumioloft volumio[31279]: info: CorePlayQueue::getTrackBlock Feb 07 20:46:21 volumioloft volumio[31279]: info: CoreCommandRouter::volumioRetrievevolume Feb 07 20:46:21 volumioloft volumio[31279]: info: DAC script executed Feb 07 20:46:21 volumioloft volumio[31279]: info: Completed loading Core Plugins Feb 07 20:46:21 volumioloft volumio[31279]: info: Preparing to generate the ALSA configuration file Feb 07 20:46:21 volumioloft volumio[31279]: info: Asound.conf file unchanged, so no further update is needed Feb 07 20:46:21 volumioloft volumio[31279]: info: Output device has changed, restarting MPD Feb 07 20:46:21 volumioloft sudo[31458]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 07 20:46:21 volumioloft volumio[31279]: info: Output device has changed, restarting Shairport Sync Feb 07 20:46:21 volumioloft volumio[31279]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:46:21 volumioloft sudo[31458]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:46:21 volumioloft volumio[31279]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 20:46:21 volumioloft sudo[31458]: pam_unix(sudo:session): session closed for user root Feb 07 20:46:21 volumioloft sudo[31460]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 07 20:46:21 volumioloft sudo[31460]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:46:21 volumioloft systemd[1]: Stopping Music Player Daemon... Feb 07 20:46:21 volumioloft volumio[31279]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 07 20:46:21 volumioloft volumio[31279]: info: ___________ START PLUGINS ___________ Feb 07 20:46:21 volumioloft systemd[1]: mpd.service: Succeeded. Feb 07 20:46:21 volumioloft volumio[31279]: info: ControllerMpd::onStart: Initializing MPD Feb 07 20:46:21 volumioloft volumio[31279]: info: Creating MPD Configuration file Feb 07 20:46:21 volumioloft systemd[1]: Stopped Music Player Daemon. Feb 07 20:46:21 volumioloft sudo[31468]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 07 20:46:21 volumioloft sudo[31468]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:46:21 volumioloft systemd[1]: Starting Music Player Daemon... Feb 07 20:46:21 volumioloft volumio[31279]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 07 20:46:21 volumioloft volumio[31279]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 07 20:46:21 volumioloft volumio[31279]: info: [1770497181476] CoreMusicLibrary::Adding element Media Servers Feb 07 20:46:21 volumioloft volumio[31279]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 20:46:21 volumioloft volumio[31279]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:46:21 volumioloft volumio[31279]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 20:46:21 volumioloft sudo[31468]: pam_unix(sudo:session): session closed for user root Feb 07 20:46:21 volumioloft sudo[31470]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 07 20:46:21 volumioloft sudo[31470]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:46:21 volumioloft systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Feb 07 20:46:21 volumioloft systemd[1]: mpd.service: Succeeded. Feb 07 20:46:21 volumioloft systemd[1]: Stopped Music Player Daemon. Feb 07 20:46:21 volumioloft systemd[1]: Starting Music Player Daemon... Feb 07 20:46:21 volumioloft volumio[31279]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 07 20:46:21 volumioloft volumio[31279]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:46:21 volumioloft volumio[31279]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 20:46:21 volumioloft volumio[31279]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 07 20:46:21 volumioloft volumio[31279]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 07 20:46:21 volumioloft volumio[31279]: info: [1770497181607] CoreMusicLibrary::Adding element Last_100 Feb 07 20:46:21 volumioloft volumio[31279]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 20:46:21 volumioloft volumio[31279]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 07 20:46:21 volumioloft volumio[31279]: info: [1770497181611] CoreMusicLibrary::Adding element Webradio Feb 07 20:46:21 volumioloft volumio[31279]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 20:46:21 volumioloft volumio[31279]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 07 20:46:21 volumioloft volumio[31279]: info: Initializing BBC Radios Feb 07 20:46:21 volumioloft sudo[31476]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 07 20:46:21 volumioloft sudo[31476]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:46:21 volumioloft sudo[31476]: pam_unix(sudo:session): session closed for user root Feb 07 20:46:21 volumioloft volumio[31279]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 07 20:46:21 volumioloft volumio[31279]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 20:46:21 volumioloft volumio[31279]: info: [squeezelite_mc] Starting proxy server... Feb 07 20:46:21 volumioloft volumio[31279]: info: Loading i18n strings for locale en Feb 07 20:46:21 volumioloft volumio[31279]: Updating browse sources language Feb 07 20:46:21 volumioloft volumio[31279]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 20:46:21 volumioloft volumio[31279]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 07 20:46:21 volumioloft volumio[31279]: info: [1770497181773] CoreMusicLibrary::Adding element Volusonic Feb 07 20:46:21 volumioloft volumio[31279]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 07 20:46:21 volumioloft volumio[31279]: Cannot find translation for source Volusonic Feb 07 20:46:21 volumioloft volumio[31279]: info: Volumio Calling Home Feb 07 20:46:21 volumioloft volumio[31279]: info: [squeezelite_mc] Proxy server started on port 34017 Feb 07 20:46:21 volumioloft volumio[31279]: info: CoreCommandRouter::volumioRetrievevolume Feb 07 20:46:22 volumioloft volumio[31279]: Unhandled rejection Error: No sockets available, cannot start. Feb 07 20:46:22 volumioloft volumio[31279]: at SsdpClient.SSDP._createSockets (/volumio/node_modules/node-ssdp/lib/index.js:186:11) Feb 07 20:46:22 volumioloft volumio[31279]: at SsdpClient.SSDP._start (/volumio/node_modules/node-ssdp/lib/index.js:229:10) Feb 07 20:46:22 volumioloft volumio[31279]: at /volumio/node_modules/node-ssdp/lib/client.js:60:10 Feb 07 20:46:22 volumioloft volumio[31279]: at Promise._execute (/volumio/node_modules/bluebird/js/release/debuggability.js:384:9) Feb 07 20:46:22 volumioloft volumio[31279]: at Promise._resolveFromExecutor (/volumio/node_modules/bluebird/js/release/promise.js:518:18) Feb 07 20:46:22 volumioloft volumio[31279]: at new Promise (/volumio/node_modules/bluebird/js/release/promise.js:103:10) Feb 07 20:46:22 volumioloft volumio[31279]: at SsdpClient.start (/volumio/node_modules/node-ssdp/lib/client.js:54:10) Feb 07 20:46:22 volumioloft volumio[31279]: at SsdpClient.search (/volumio/node_modules/node-ssdp/lib/client.js:82:17) Feb 07 20:46:22 volumioloft volumio[31279]: at ControllerUPNPBrowser.onStart (/volumio/app/plugins/music_service/upnp_browser/index.js:126:12) Feb 07 20:46:22 volumioloft volumio[31279]: at PluginManager.startCorePlugin (/volumio/app/pluginmanager.js:398:24) Feb 07 20:46:22 volumioloft volumio[31279]: at HashMap. (/volumio/app/pluginmanager.js:496:31) Feb 07 20:46:22 volumioloft volumio[31279]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Feb 07 20:46:22 volumioloft volumio[31279]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Feb 07 20:46:22 volumioloft volumio[31279]: at PluginManager.startCorePlugins (/volumio/app/pluginmanager.js:495:20) Feb 07 20:46:22 volumioloft volumio[31279]: at Promise._successFn (/volumio/app/pluginmanager.js:142:29) Feb 07 20:46:22 volumioloft volumio[31279]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Feb 07 20:46:22 volumioloft volumio[31279]: info: MPD Permissions set Feb 07 20:46:22 volumioloft volumio[31279]: info: VolumeController:: Volume=22 Mute =false Feb 07 20:46:22 volumioloft volumio[31279]: info: CoreStateMachine::pushState Feb 07 20:46:22 volumioloft volumio[31279]: info: CorePlayQueue::getTrack 0 Feb 07 20:46:22 volumioloft volumio[31279]: info: CoreCommandRouter::volumioPushState Feb 07 20:46:22 volumioloft volumio[31279]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Feb 07 20:46:22 volumioloft volumio[31279]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:46:22 volumioloft volumio[31279]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:46:22 volumioloft volumio[31279]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:46:22 volumioloft volumio[31279]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:46:22 volumioloft volumio[31279]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:46:22 volumioloft volumio[31279]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:46:22 volumioloft volumio[31279]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:46:22 volumioloft volumio[31279]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:46:22 volumioloft volumio[31279]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 20:46:22 volumioloft volumio[31279]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:46:22 volumioloft volumio[31279]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:46:22 volumioloft volumio[31279]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:46:22 volumioloft volumio[31279]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:46:22 volumioloft volumio[31279]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:46:22 volumioloft volumio[31279]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:46:22 volumioloft volumio[31279]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:46:22 volumioloft volumio[31279]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:46:22 volumioloft volumio[31279]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:46:22 volumioloft volumio[31279]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 07 20:46:22 volumioloft volumio[31279]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:46:22 volumioloft volumio[31279]: info: VolumeController:: Volume=22 Mute =false Feb 07 20:46:22 volumioloft volumio[31279]: info: CoreStateMachine::pushState Feb 07 20:46:22 volumioloft volumio[31279]: info: CorePlayQueue::getTrack 0 Feb 07 20:46:22 volumioloft volumio[31279]: info: CoreCommandRouter::volumioPushState Feb 07 20:46:22 volumioloft volumio[31279]: info: [squeezelite_mc] Server discovery started Feb 07 20:46:22 volumioloft volumio[31279]: info: [squeezelite_mc] Player finder started Feb 07 20:46:22 volumioloft volumio[31279]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:46:22 volumioloft volumio[31279]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:46:22 volumioloft volumio[31279]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 07 20:46:22 volumioloft volumio[31279]: info: [squeezelite_mc] Starting Squeezelite service with params: {"type":"manual","startupOptions":"-s 10.0.0.101:3483 -o squeezelite -C 1 -n \"volumioloft\" -V \"Digital\" -f /tmp/squeezelite.log","card":"2","mixerType":"Hardware","mixer":"Digital"} Feb 07 20:46:22 volumioloft volumio[31279]: 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 Feb 07 20:46:22 volumioloft volumio[31279]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 07 20:46:22 volumioloft volumio[31279]: Error: send ENETUNREACH 255.255.255.255:3483 Feb 07 20:46:22 volumioloft volumio[31279]: at doSend (dgram.js:692:16) Feb 07 20:46:22 volumioloft volumio[31279]: at defaultTriggerAsyncIdScope (internal/async_hooks.js:430:12) Feb 07 20:46:22 volumioloft volumio[31279]: at afterDns (dgram.js:638:5) Feb 07 20:46:22 volumioloft volumio[31279]: at processTicksAndRejections (internal/process/task_queues.js:81:21) { Feb 07 20:46:22 volumioloft volumio[31279]: errno: -101, Feb 07 20:46:22 volumioloft volumio[31279]: code: 'ENETUNREACH', Feb 07 20:46:22 volumioloft volumio[31279]: syscall: 'send', Feb 07 20:46:22 volumioloft volumio[31279]: address: '255.255.255.255', Feb 07 20:46:22 volumioloft volumio[31279]: port: 3483 Feb 07 20:46:22 volumioloft volumio[31279]: } Feb 07 20:46:22 volumioloft volumio[31279]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 07 20:46:22 volumioloft sudo[31507]: 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 Feb 07 20:46:22 volumioloft sudo[31507]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 07 20:46:22 volumioloft sudo[31507]: pam_unix(sudo:session): session closed for user root Feb 07 20:46:22 volumioloft dhcpcd[909]: wlan0: leased 10.0.20.130 for 7200 seconds Feb 07 20:46:22 volumioloft avahi-daemon[670]: Joining mDNS multicast group on interface wlan0.IPv4 with address 10.0.20.130. Feb 07 20:46:22 volumioloft dhcpcd[909]: wlan0: adding route to 10.0.20.0/24 Feb 07 20:46:22 volumioloft dhcpcd[909]: wlan0: adding default route via 10.0.20.1 Feb 07 20:46:22 volumioloft avahi-daemon[670]: New relevant interface wlan0.IPv4 for mDNS. Feb 07 20:46:22 volumioloft avahi-daemon[670]: Registering new address record for 10.0.20.130 on wlan0.IPv4. Feb 07 20:46:22 volumioloft sudo[31540]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-02-07 20:45 Feb 07 20:46:23 volumioloft sudo[31540]: 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="570c5791513f5bac7da274aba6690c1a961705de" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 13 May 2025 05:16:30 PM CEST" VOLUMIO_VERSION="3.812" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="3934ee440d5d3f0186049a23752ad680"