Feb 08 05:38:03 volumio wpa_supplicant[2840]: wlan0: Failed to initiate sched scan Feb 08 05:38:10 volumio volumio-remote-updater[2374]: [2026-02-08 04:38:10] [connect] Successful connection Feb 08 05:38:10 volumio wpa_supplicant[2840]: wlan0: Failed to initiate sched scan Feb 08 05:38:18 volumio wpa_supplicant[2840]: wlan0: Failed to initiate sched scan Feb 08 05:38:23 volumio sudo[1970]: pam_unix(sudo:session): session closed for user root Feb 08 05:38:23 volumio volumio[1889]: sudo: unable to resolve host volumio: System error Feb 08 05:38:23 volumio volumio[1889]: command failed: No buffer space available (-105) Feb 08 05:38:23 volumio volumio[1889]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Feb 08 05:38:23 volumio volumio[1889]: sudo: unable to resolve host volumio: System error Feb 08 05:38:23 volumio volumio[1889]: command failed: No buffer space available (-105) Feb 08 05:38:23 volumio sudo[2049]: volumio : unable to resolve host volumio: System error Feb 08 05:38:23 volumio sudo[2051]: volumio : unable to resolve host volumio: System error Feb 08 05:38:23 volumio sudo[2051]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 08 05:38:23 volumio sudo[2051]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 05:38:23 volumio sudo[2049]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 08 05:38:23 volumio sudo[2049]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 05:38:23 volumio sudo[2051]: pam_unix(sudo:session): session closed for user root Feb 08 05:38:23 volumio sudo[2049]: pam_unix(sudo:session): session closed for user root Feb 08 05:38:23 volumio volumio[1889]: info: Reloading queue from file Feb 08 05:38:23 volumio volumio[1889]: info: VolumeController:: Volume=100 Mute =false Feb 08 05:38:23 volumio volumio[1889]: info: CoreStateMachine::pushState Feb 08 05:38:23 volumio volumio[1889]: info: CorePlayQueue::getTrack 0 Feb 08 05:38:23 volumio volumio[1889]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 08 05:38:23 volumio volumio[1889]: info: CoreCommandRouter::volumioPushState Feb 08 05:38:23 volumio volumio[1889]: info: CoreStateMachine::updateTrackBlock Feb 08 05:38:23 volumio volumio[1889]: info: CorePlayQueue::getTrackBlock Feb 08 05:38:23 volumio volumio[1889]: info: CoreCommandRouter::volumioRetrievevolume Feb 08 05:38:23 volumio volumio[1889]: info: CoreStateMachine::setRepeat null single undefined Feb 08 05:38:23 volumio volumio[1889]: info: CoreStateMachine::pushState Feb 08 05:38:23 volumio volumio[1889]: info: CorePlayQueue::getTrack 0 Feb 08 05:38:23 volumio volumio[1889]: info: CoreCommandRouter::volumioPushState Feb 08 05:38:23 volumio volumio[1889]: info: CoreStateMachine::setRandom null Feb 08 05:38:23 volumio volumio[1889]: info: CoreStateMachine::pushState Feb 08 05:38:23 volumio volumio[1889]: info: CorePlayQueue::getTrack 0 Feb 08 05:38:23 volumio volumio[1889]: info: CoreCommandRouter::volumioPushState Feb 08 05:38:23 volumio volumio[1889]: info: Setting Device type: Raspberry PI Feb 08 05:38:23 volumio volumio[1889]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Feb 08 05:38:23 volumio volumio[1889]: info: USB Boot Capable - System SBC Revision found in cpuinfo: c03111 Feb 08 05:38:23 volumio volumio[1889]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Feb 08 05:38:23 volumio volumio[1889]: info: Discovery: adding 6a8902c9-5eee-4430-84ba-2ef95c5a1f77 Feb 08 05:38:23 volumio volumio[1889]: info: Discovery: Found device Anlægget Feb 08 05:38:23 volumio volumio[1889]: info: CoreCommandRouter::volumioGetState Feb 08 05:38:23 volumio volumio[1889]: info: CorePlayQueue::getTrack 0 Feb 08 05:38:23 volumio sudo[2063]: volumio : unable to resolve host volumio: System error Feb 08 05:38:23 volumio volumio[1889]: info: VolumeController:: Volume=100 Mute =false Feb 08 05:38:23 volumio volumio[1889]: info: CoreStateMachine::pushState Feb 08 05:38:23 volumio volumio[1889]: info: CorePlayQueue::getTrack 0 Feb 08 05:38:23 volumio volumio[1889]: info: CoreCommandRouter::volumioPushState Feb 08 05:38:23 volumio sudo[2063]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Feb 08 05:38:23 volumio sudo[2063]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 05:38:23 volumio volumio[1889]: info: Completed loading Core Plugins Feb 08 05:38:23 volumio volumio[1889]: info: Preparing to generate the ALSA configuration file Feb 08 05:38:23 volumio volumio[1889]: info: Asound.conf file unchanged, so no further update is needed Feb 08 05:38:23 volumio volumio[1889]: info: Output device has changed, restarting MPD Feb 08 05:38:23 volumio sudo[2063]: pam_unix(sudo:session): session closed for user root Feb 08 05:38:23 volumio volumio[1889]: info: Output device has changed, restarting Shairport Sync Feb 08 05:38:23 volumio volumio[1889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:38:23 volumio volumio[1889]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 05:38:23 volumio sudo[2068]: volumio : unable to resolve host volumio: System error Feb 08 05:38:23 volumio sudo[2068]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 08 05:38:23 volumio sudo[2068]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 05:38:23 volumio sudo[2070]: volumio : unable to resolve host volumio: System error Feb 08 05:38:23 volumio sudo[2068]: pam_unix(sudo:session): session closed for user root Feb 08 05:38:23 volumio sudo[2070]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 08 05:38:23 volumio sudo[2070]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 05:38:23 volumio volumio[1889]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 08 05:38:23 volumio volumio[1889]: info: ___________ START PLUGINS ___________ Feb 08 05:38:23 volumio volumio[1889]: info: ControllerMpd::onStart: Initializing MPD Feb 08 05:38:23 volumio volumio[1889]: info: Creating MPD Configuration file Feb 08 05:38:23 volumio sudo[2078]: volumio : unable to resolve host volumio: System error Feb 08 05:38:23 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Feb 08 05:38:23 volumio volumio[1889]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 08 05:38:23 volumio volumio[1889]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 08 05:38:23 volumio volumio[1889]: info: [1770525503965] CoreMusicLibrary::Adding element Medieservere Feb 08 05:38:23 volumio volumio[1889]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 08 05:38:23 volumio sudo[2078]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 08 05:38:23 volumio sudo[2078]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 05:38:23 volumio sudo[2078]: pam_unix(sudo:session): session closed for user root Feb 08 05:38:23 volumio volumio[1889]: info: UPNP Browser: Client initialized successfully Feb 08 05:38:23 volumio sudo[2080]: volumio : unable to resolve host volumio: System error Feb 08 05:38:23 volumio volumio[1889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:38:23 volumio volumio[1889]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 05:38:23 volumio sudo[2080]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 08 05:38:23 volumio sudo[2080]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 05:38:23 volumio systemd[1]: mpd.service: Deactivated successfully. Feb 08 05:38:23 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Feb 08 05:38:23 volumio systemd[1]: mpd.service: Consumed 1.506s CPU time. Feb 08 05:38:23 volumio systemd[1]: mpd.socket: Deactivated successfully. Feb 08 05:38:23 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Feb 08 05:38:23 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Feb 08 05:38:24 volumio volumio[1889]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 08 05:38:24 volumio volumio[1889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:38:24 volumio volumio[1889]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 05:38:24 volumio volumio[1889]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 08 05:38:24 volumio volumio[1889]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 08 05:38:24 volumio volumio[1889]: info: [1770525504023] CoreMusicLibrary::Adding element Last_100 Feb 08 05:38:24 volumio volumio[1889]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 08 05:38:24 volumio volumio[1889]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 08 05:38:24 volumio volumio[1889]: info: [1770525504026] CoreMusicLibrary::Adding element Webradio Feb 08 05:38:24 volumio volumio[1889]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 08 05:38:24 volumio volumio[1889]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 08 05:38:24 volumio volumio[1889]: info: Initializing BBC Radios Feb 08 05:38:24 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Feb 08 05:38:24 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Feb 08 05:38:24 volumio systemd[1]: mpd.service: Deactivated successfully. Feb 08 05:38:24 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Feb 08 05:38:24 volumio systemd[1]: mpd.socket: Deactivated successfully. Feb 08 05:38:24 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Feb 08 05:38:24 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Feb 08 05:38:24 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Feb 08 05:38:24 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Feb 08 05:38:24 volumio volumio[1889]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 08 05:38:24 volumio volumio[1889]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 05:38:24 volumio volumio[1889]: info: [squeezelite_mc] Starting proxy server... Feb 08 05:38:24 volumio volumio[1889]: info: Volumio Calling Home Feb 08 05:38:24 volumio volumio[1889]: info: [squeezelite_mc] Proxy server started on port 39281 Feb 08 05:38:24 volumio sudo[2103]: root : unable to resolve host volumio: System error Feb 08 05:38:24 volumio sudo[2103]: sudo: unable to resolve host volumio: System error Feb 08 05:38:24 volumio sudo[2103]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 08 05:38:24 volumio sudo[2103]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 08 05:38:24 volumio sudo[2103]: pam_unix(sudo:session): session closed for user root Feb 08 05:38:24 volumio volumio[1889]: info: CoreCommandRouter::volumioRetrievevolume Feb 08 05:38:24 volumio volumio[1889]: Unhandled rejection Error: No sockets available, cannot start. Feb 08 05:38:24 volumio volumio[1889]: at SSDP._createSockets (/volumio/node_modules/node-ssdp/lib/index.js:186:11) Feb 08 05:38:24 volumio volumio[1889]: at SSDP._start (/volumio/node_modules/node-ssdp/lib/index.js:229:10) Feb 08 05:38:24 volumio volumio[1889]: at /volumio/node_modules/node-ssdp/lib/client.js:60:10 Feb 08 05:38:24 volumio volumio[1889]: at Promise._execute (/volumio/node_modules/bluebird/js/release/debuggability.js:384:9) Feb 08 05:38:24 volumio volumio[1889]: at Promise._resolveFromExecutor (/volumio/node_modules/bluebird/js/release/promise.js:518:18) Feb 08 05:38:24 volumio volumio[1889]: at new Promise (/volumio/node_modules/bluebird/js/release/promise.js:103:10) Feb 08 05:38:24 volumio volumio[1889]: at SsdpClient.start (/volumio/node_modules/node-ssdp/lib/client.js:54:10) Feb 08 05:38:24 volumio volumio[1889]: at SsdpClient.search (/volumio/node_modules/node-ssdp/lib/client.js:82:17) Feb 08 05:38:24 volumio volumio[1889]: at ControllerUPNPBrowser.onStart (/volumio/app/plugins/music_service/upnp_browser/index.js:156:14) Feb 08 05:38:24 volumio volumio[1889]: at PluginManager.startCorePlugin (/volumio/app/pluginmanager.js:398:24) Feb 08 05:38:24 volumio volumio[1889]: at HashMap. (/volumio/app/pluginmanager.js:496:31) Feb 08 05:38:24 volumio volumio[1889]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Feb 08 05:38:24 volumio volumio[1889]: at proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Feb 08 05:38:24 volumio volumio[1889]: at PluginManager.startCorePlugins (/volumio/app/pluginmanager.js:495:20) Feb 08 05:38:24 volumio volumio[1889]: at Promise._successFn (/volumio/app/pluginmanager.js:142:29) Feb 08 05:38:24 volumio volumio[1889]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Feb 08 05:38:24 volumio volumio[1889]: info: MPD Permissions set Feb 08 05:38:24 volumio volumio[1889]: info: MPD Permissions set Feb 08 05:38:24 volumio volumio[1889]: info: Upmpdcli Daemon Started Feb 08 05:38:24 volumio volumio[1889]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Feb 08 05:38:24 volumio volumio[1889]: info: VolumeController:: Volume=100 Mute =false Feb 08 05:38:24 volumio volumio[1889]: info: CoreStateMachine::pushState Feb 08 05:38:24 volumio volumio[1889]: info: CorePlayQueue::getTrack 0 Feb 08 05:38:24 volumio volumio[1889]: info: CoreCommandRouter::volumioPushState Feb 08 05:38:24 volumio volumio[1889]: info: [squeezelite_mc] Server discovery started Feb 08 05:38:24 volumio volumio[1889]: info: [squeezelite_mc] Player finder started Feb 08 05:38:24 volumio volumio[1889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:38:24 volumio volumio[1889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:38:24 volumio volumio[1889]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:38:24 volumio volumio[1889]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 08 05:38:24 volumio volumio[1889]: info: [squeezelite_mc] Executing aplay -D hw:5 --nonblock -f MPEG /dev/zero 2>&1 || true Feb 08 05:38:24 volumio volumio[1889]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 08 05:38:24 volumio volumio[1889]: Error: send ENETUNREACH 255.255.255.255:3483 Feb 08 05:38:24 volumio volumio[1889]: at doSend (node:dgram:717:16) Feb 08 05:38:24 volumio volumio[1889]: at defaultTriggerAsyncIdScope (node:internal/async_hooks:464:18) Feb 08 05:38:24 volumio volumio[1889]: at afterDns (node:dgram:663:5) Feb 08 05:38:24 volumio volumio[1889]: at process.processTicksAndRejections (node:internal/process/task_queues:83:21) { Feb 08 05:38:24 volumio volumio[1889]: errno: -101, Feb 08 05:38:24 volumio volumio[1889]: code: 'ENETUNREACH', Feb 08 05:38:24 volumio volumio[1889]: syscall: 'send', Feb 08 05:38:24 volumio volumio[1889]: address: '255.255.255.255', Feb 08 05:38:24 volumio volumio[1889]: port: 3483 Feb 08 05:38:24 volumio volumio[1889]: } Feb 08 05:38:24 volumio volumio[1889]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 08 05:38:24 volumio sudo[2131]: volumio : unable to resolve host volumio: System error Feb 08 05:38:24 volumio sudo[2131]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-08 05:37' Feb 08 05:38:24 volumio sudo[2131]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 05:38:25 volumio sudo[2131]: pam_unix(sudo:session): session closed for user root Feb 08 05:38:25 volumio volumio[1889]: sudo: unable to resolve host volumio: System error Feb 08 05:38:25 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Feb 08 05:38:25 volumio sudo[2080]: pam_unix(sudo:session): session closed for user root Feb 08 05:38:25 volumio sudo[2070]: pam_unix(sudo:session): session closed for user root Feb 08 05:38:25 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Feb 08 05:38:25 volumio systemd[1]: volumio.service: Consumed 35.604s CPU time. Feb 08 05:38:25 volumio systemd[1]: Started dynamicswap.service - dynamicswap service. Feb 08 05:38:25 volumio systemd[1]: dynamicswap.service: Deactivated successfully. Feb 08 05:38:25 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 95. Feb 08 05:38:25 volumio systemd[1]: Started dynamicswap.service - dynamicswap service. Feb 08 05:38:25 volumio systemd[1]: Stopped volumio.service - Volumio Backend Module. Feb 08 05:38:25 volumio systemd[1]: volumio.service: Consumed 35.604s CPU time. Feb 08 05:38:25 volumio systemd[1]: Started volumio.service - Volumio Backend Module. Feb 08 05:38:25 volumio systemd[1]: dynamicswap.service: Deactivated successfully. Feb 08 05:38:25 volumio mpd[2112]: decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 08 05:38:25 volumio mpd[2112]: output: No 'audio_output' defined in config file Feb 08 05:38:25 volumio mpd[2112]: output: Successfully detected a sndio audio device Feb 08 05:38:25 volumio mpd[2112]: zeroconf: No global port, disabling zeroconf Feb 08 05:38:25 volumio systemd[1]: Started mpd.service - Music Player Daemon. Feb 08 05:38:25 volumio volumio-remote-updater[2374]: [2026-02-08 04:38:25] [info] asio async_connect error: asio.system:111 (Connection refused) Feb 08 05:38:25 volumio volumio-remote-updater[2374]: [2026-02-08 04:38:25] [info] Error getting remote endpoint: asio.system:107 (Transport endpoint is not connected) Feb 08 05:38:25 volumio volumio-remote-updater[2374]: [2026-02-08 04:38:25] [error] handle_connect error: Connection refused Feb 08 05:38:26 volumio wpa_supplicant[2840]: wlan0: Failed to initiate sched scan Feb 08 05:38:26 volumio volumio[2146]: info: ------------------------------------------- Feb 08 05:38:26 volumio volumio[2146]: info: ----- Volumio3 ---- Feb 08 05:38:26 volumio volumio[2146]: info: ------------------------------------------- Feb 08 05:38:26 volumio volumio[2146]: info: ----- System startup ---- Feb 08 05:38:26 volumio volumio[2146]: info: ------------------------------------------- Feb 08 05:38:26 volumio volumio[2146]: info: MYVOLUMIO Environment detected Feb 08 05:38:26 volumio volumio[2146]: info: Plugin folders cleanup Feb 08 05:38:26 volumio volumio[2146]: info: Scanning into folder /volumio/app/plugins/ Feb 08 05:38:26 volumio volumio[2146]: info: Scanning category audio_interface Feb 08 05:38:26 volumio volumio[2146]: info: Scanning category miscellanea Feb 08 05:38:26 volumio volumio[2146]: info: Scanning category music_service Feb 08 05:38:26 volumio volumio[2146]: info: Scanning category plugins.json Feb 08 05:38:26 volumio volumio[2146]: info: Scanning category system_controller Feb 08 05:38:26 volumio volumio[2146]: info: Scanning category user_interface Feb 08 05:38:26 volumio volumio[2146]: info: Scanning into folder /data/plugins/ Feb 08 05:38:26 volumio volumio[2146]: info: Scanning category music_service Feb 08 05:38:26 volumio volumio[2146]: info: Plugin folders cleanup completed Feb 08 05:38:26 volumio volumio[2146]: info: ------------------------------------------- Feb 08 05:38:26 volumio volumio[2146]: info: ----- Core plugins startup ---- Feb 08 05:38:26 volumio volumio[2146]: info: ------------------------------------------- Feb 08 05:38:26 volumio volumio[2146]: info: Loading plugins from folder /volumio/app/plugins/ Feb 08 05:38:26 volumio volumio[2146]: info: Adding plugin upnp to MyMusic Plugins Feb 08 05:38:26 volumio volumio[2146]: info: Adding plugin airplay_emulation to MyMusic Plugins Feb 08 05:38:26 volumio volumio[2146]: info: Adding plugin upnp_browser to MyMusic Plugins Feb 08 05:38:26 volumio volumio[2146]: info: Loading plugins from folder /data/plugins/ Feb 08 05:38:26 volumio volumio[2146]: info: Loading plugin "system"... Feb 08 05:38:26 volumio volumio[2146]: info: Loading plugin "appearance"... Feb 08 05:38:27 volumio volumio[2146]: info: Loading plugin "network"... Feb 08 05:38:27 volumio volumio[2146]: info: Refreshing Cached IP Addresses Feb 08 05:38:27 volumio sudo[2176]: volumio : unable to resolve host volumio: System error Feb 08 05:38:27 volumio sudo[2176]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 08 05:38:27 volumio sudo[2176]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 05:38:27 volumio sudo[2178]: volumio : unable to resolve host volumio: System error Feb 08 05:38:27 volumio volumio[2146]: info: Loading plugin "services"... Feb 08 05:38:27 volumio sudo[2176]: pam_unix(sudo:session): session closed for user root Feb 08 05:38:27 volumio sudo[2178]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 08 05:38:27 volumio sudo[2178]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 05:38:27 volumio volumio[2146]: info: Loading plugin "alsa_controller"... Feb 08 05:38:27 volumio sudo[2178]: pam_unix(sudo:session): session closed for user root Feb 08 05:38:27 volumio sudo[2185]: volumio : unable to resolve host volumio: System error Feb 08 05:38:27 volumio sudo[2185]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Feb 08 05:38:27 volumio sudo[2185]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 05:38:27 volumio volumio[2146]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 08 05:38:27 volumio volumio[2146]: info: Loading plugin "wizard"... Feb 08 05:38:27 volumio volumio[2146]: info: Loading plugin "networkfs"... Feb 08 05:38:27 volumio volumio[2146]: info: Starting Udev Watcher for removable devices Feb 08 05:38:27 volumio volumio[2146]: info: Ignoring mount for partition: boot Feb 08 05:38:27 volumio volumio[2146]: info: Ignoring mount for partition: volumio Feb 08 05:38:27 volumio volumio[2146]: info: Ignoring mount for partition: volumio_data Feb 08 05:38:27 volumio volumio[2146]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 08 05:38:27 volumio volumio[2146]: info: Loading plugin "volumio_command_line_client"... Feb 08 05:38:27 volumio volumio[2146]: info: Loading plugin "upnp"... Feb 08 05:38:27 volumio volumio[2146]: info: [1770525507625] Starting Upmpd Daemon Feb 08 05:38:27 volumio volumio[2146]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 08 05:38:27 volumio volumio[2146]: info: Loading plugin "my_music"... Feb 08 05:38:27 volumio volumio[2146]: info: Loading plugin "mpd"... Feb 08 05:38:27 volumio volumio[2146]: info: Loading plugin "upnp_browser"... Feb 08 05:38:28 volumio volumio[2146]: info: Starting UPNP Browser Feb 08 05:38:28 volumio volumio[2146]: info: Loading plugin "alarm-clock"... Feb 08 05:38:28 volumio volumio[2146]: info: Loading plugin "airplay_emulation"... Feb 08 05:38:28 volumio volumio[2146]: info: Starting Shairport Sync Feb 08 05:38:28 volumio volumio[2146]: info: Loading plugin "last_100"... Feb 08 05:38:28 volumio volumio[2146]: info: Loading plugin "webradio"... Feb 08 05:38:28 volumio volumio[2146]: info: Loading plugin "i2s_dacs"... Feb 08 05:38:28 volumio volumio[2146]: info: I2S DAC not set, start Auto-detection Feb 08 05:38:28 volumio volumio[2146]: info: Loading plugin "volumiodiscovery"... Feb 08 05:38:28 volumio volumio[2146]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 08 05:38:28 volumio volumio[2146]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 08 05:38:28 volumio volumio[2146]: *** WARNING *** For more information see Feb 08 05:38:28 volumio volumio[2146]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 08 05:38:28 volumio volumio[2146]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 08 05:38:28 volumio volumio[2146]: *** WARNING *** For more information see Feb 08 05:38:28 volumio node[2146]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 08 05:38:28 volumio node[2146]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 08 05:38:28 volumio node[2146]: *** WARNING *** For more information see Feb 08 05:38:28 volumio node[2146]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 08 05:38:28 volumio node[2146]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 08 05:38:28 volumio node[2146]: *** WARNING *** For more information see Feb 08 05:38:28 volumio volumio[2146]: info: Applying required configuration parameters for plugin volumiodiscovery Feb 08 05:38:28 volumio volumio[2146]: info: Discovery: Started advertising with name: Anlægget Feb 08 05:38:28 volumio volumio[2146]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 08 05:38:28 volumio volumio[2146]: info: Loading plugin "squeezelite_mc"... Feb 08 05:38:29 volumio volumio[2146]: info: Loading plugin "outputs"... Feb 08 05:38:29 volumio volumio[2146]: info: Loading plugin "albumart"... Feb 08 05:38:29 volumio volumio[2146]: info: Plugin example_plugin is not enabled Feb 08 05:38:29 volumio volumio[2146]: info: Loading plugin "inputs"... Feb 08 05:38:29 volumio volumio[2146]: info: Loading plugin "updater_comm"... Feb 08 05:38:29 volumio volumio[2146]: info: Plugin mpdemulation is not enabled Feb 08 05:38:29 volumio volumio[2146]: info: Loading plugin "rest_api"... Feb 08 05:38:29 volumio volumio[2146]: info: Loading plugin "websocket"... Feb 08 05:38:29 volumio volumio[2146]: info: Starting Socket.io Server version 1.7.4 Feb 08 05:38:29 volumio volumio[2146]: info: Loading i18n strings for locale da Feb 08 05:38:29 volumio volumio[2146]: Updating browse sources language Feb 08 05:38:29 volumio volumio[2146]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 08 05:38:29 volumio volumio[2146]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 08 05:38:29 volumio volumio[2146]: info: CoreCommandRouter::initPlayerControls Feb 08 05:38:29 volumio volumio[2146]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:38:29 volumio volumio[2146]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:38:29 volumio volumio[2146]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:38:29 volumio volumio[2146]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:38:29 volumio volumio[2146]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:38:29 volumio volumio[2146]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:38:29 volumio volumio[2146]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:38:29 volumio volumio[2146]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:38:29 volumio volumio[2146]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 08 05:38:29 volumio volumio[2146]: Express server listening on port 3000 Feb 08 05:38:29 volumio volumio[2146]: [Metrics] WebUI: 3s 194.63ms Feb 08 05:38:29 volumio volumio[2146]: info: CoreStateMachine::resetVolumioState Feb 08 05:38:29 volumio volumio[2146]: info: CoreStateMachine::getcurrentVolume Feb 08 05:38:29 volumio volumio[2146]: info: CoreCommandRouter::volumioRetrievevolume Feb 08 05:38:29 volumio volumio[2146]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 05:38:29 volumio volumio[2146]: info: Volumio Network Manager: Network status updated: 0 Feb 08 05:38:29 volumio volumio[2146]: info: VolumeController:: Volume=100 Mute =false Feb 08 05:38:29 volumio volumio[2146]: info: CoreStateMachine::pushState Feb 08 05:38:29 volumio volumio[2146]: info: CorePlayQueue::getTrack 0 Feb 08 05:38:29 volumio volumio[2146]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 08 05:38:29 volumio volumio[2146]: info: CoreCommandRouter::volumioPushState Feb 08 05:38:29 volumio volumio[2146]: info: CoreStateMachine::updateTrackBlock Feb 08 05:38:29 volumio volumio[2146]: info: CorePlayQueue::getTrackBlock Feb 08 05:38:29 volumio volumio[2146]: info: CoreCommandRouter::volumioRetrievevolume Feb 08 05:38:29 volumio volumio[2211]: Forking 3 albumart workers Feb 08 05:38:29 volumio volumio[2146]: info: Reloading queue from file Feb 08 05:38:29 volumio volumio[2146]: info: CoreStateMachine::setRepeat null single undefined Feb 08 05:38:29 volumio volumio[2146]: info: CoreStateMachine::pushState Feb 08 05:38:29 volumio volumio[2146]: info: CorePlayQueue::getTrack 0 Feb 08 05:38:29 volumio volumio[2146]: info: CoreCommandRouter::volumioPushState Feb 08 05:38:29 volumio volumio[2146]: info: CoreStateMachine::setRandom null Feb 08 05:38:29 volumio volumio[2146]: info: CoreStateMachine::pushState Feb 08 05:38:29 volumio volumio[2146]: info: CorePlayQueue::getTrack 0 Feb 08 05:38:29 volumio volumio[2146]: info: CoreCommandRouter::volumioPushState Feb 08 05:38:29 volumio volumio[2146]: info: Setting Device type: Raspberry PI Feb 08 05:38:29 volumio volumio[2146]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Feb 08 05:38:29 volumio volumio[2146]: info: USB Boot Capable - System SBC Revision found in cpuinfo: c03111 Feb 08 05:38:29 volumio volumio[2146]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Feb 08 05:38:29 volumio volumio[2146]: info: VolumeController:: Volume=100 Mute =false Feb 08 05:38:29 volumio volumio[2146]: info: CoreStateMachine::pushState Feb 08 05:38:29 volumio volumio[2146]: info: CorePlayQueue::getTrack 0 Feb 08 05:38:29 volumio volumio[2146]: info: CoreCommandRouter::volumioPushState Feb 08 05:38:29 volumio volumio[2146]: info: Completed loading Core Plugins Feb 08 05:38:29 volumio volumio[2146]: info: Preparing to generate the ALSA configuration file Feb 08 05:38:29 volumio volumio[2146]: info: Asound.conf file unchanged, so no further update is needed Feb 08 05:38:29 volumio volumio[2146]: info: Output device has changed, restarting MPD Feb 08 05:38:29 volumio volumio[2146]: info: Output device has changed, restarting Shairport Sync Feb 08 05:38:29 volumio volumio[2146]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:38:29 volumio sudo[2266]: volumio : unable to resolve host volumio: System error Feb 08 05:38:29 volumio volumio[2146]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 05:38:29 volumio sudo[2269]: volumio : unable to resolve host volumio: System error Feb 08 05:38:29 volumio sudo[2266]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 08 05:38:29 volumio sudo[2266]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 05:38:29 volumio sudo[2266]: pam_unix(sudo:session): session closed for user root Feb 08 05:38:29 volumio sudo[2269]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 08 05:38:29 volumio sudo[2269]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 05:38:29 volumio volumio[2146]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 08 05:38:29 volumio volumio[2146]: info: ___________ START PLUGINS ___________ Feb 08 05:38:29 volumio volumio[2146]: info: ControllerMpd::onStart: Initializing MPD Feb 08 05:38:29 volumio volumio[2146]: info: Creating MPD Configuration file Feb 08 05:38:29 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Feb 08 05:38:29 volumio sudo[2277]: volumio : unable to resolve host volumio: System error Feb 08 05:38:29 volumio sudo[2277]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 08 05:38:29 volumio sudo[2277]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 05:38:29 volumio sudo[2277]: pam_unix(sudo:session): session closed for user root Feb 08 05:38:29 volumio volumio[2146]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 08 05:38:29 volumio volumio[2146]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 08 05:38:29 volumio sudo[2279]: volumio : unable to resolve host volumio: System error Feb 08 05:38:29 volumio volumio[2146]: info: [1770525509736] CoreMusicLibrary::Adding element Medieservere Feb 08 05:38:29 volumio volumio[2146]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 08 05:38:29 volumio systemd[1]: mpd.service: Deactivated successfully. Feb 08 05:38:29 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Feb 08 05:38:29 volumio systemd[1]: mpd.service: Consumed 1.501s CPU time. Feb 08 05:38:29 volumio sudo[2279]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 08 05:38:29 volumio systemd[1]: mpd.socket: Deactivated successfully. Feb 08 05:38:29 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Feb 08 05:38:29 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Feb 08 05:38:29 volumio sudo[2279]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 05:38:29 volumio volumio[2146]: info: UPNP Browser: Client initialized successfully Feb 08 05:38:29 volumio volumio[2146]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:38:29 volumio volumio[2146]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 05:38:29 volumio volumio[2146]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 08 05:38:29 volumio volumio[2146]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:38:29 volumio volumio[2146]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 05:38:29 volumio volumio[2146]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 08 05:38:29 volumio volumio[2146]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 08 05:38:29 volumio volumio[2146]: info: [1770525509814] CoreMusicLibrary::Adding element Last_100 Feb 08 05:38:29 volumio volumio[2146]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 08 05:38:29 volumio volumio[2146]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 08 05:38:29 volumio volumio[2146]: info: [1770525509816] CoreMusicLibrary::Adding element Webradio Feb 08 05:38:29 volumio volumio[2146]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 08 05:38:29 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Feb 08 05:38:29 volumio volumio[2146]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 08 05:38:29 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Feb 08 05:38:29 volumio volumio[2146]: info: Initializing BBC Radios Feb 08 05:38:29 volumio systemd[1]: mpd.service: Deactivated successfully. Feb 08 05:38:29 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Feb 08 05:38:29 volumio systemd[1]: mpd.socket: Deactivated successfully. Feb 08 05:38:29 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Feb 08 05:38:29 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Feb 08 05:38:29 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Feb 08 05:38:29 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Feb 08 05:38:29 volumio volumio[2146]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 08 05:38:29 volumio volumio[2146]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 05:38:29 volumio volumio[2146]: info: [squeezelite_mc] Starting proxy server... Feb 08 05:38:29 volumio volumio[2146]: info: Volumio Calling Home Feb 08 05:38:30 volumio sudo[2298]: root : unable to resolve host volumio: System error Feb 08 05:38:30 volumio sudo[2298]: sudo: unable to resolve host volumio: System error Feb 08 05:38:30 volumio sudo[2298]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 08 05:38:30 volumio sudo[2298]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 08 05:38:30 volumio sudo[2298]: pam_unix(sudo:session): session closed for user root Feb 08 05:38:30 volumio volumio[2146]: info: [squeezelite_mc] Proxy server started on port 43819 Feb 08 05:38:30 volumio sudo[2185]: pam_unix(sudo:session): session closed for user root Feb 08 05:38:30 volumio volumio[2235]: Starting albumart workers Feb 08 05:38:30 volumio volumio[2233]: Starting albumart workers Feb 08 05:38:30 volumio volumio[2146]: info: CoreCommandRouter::volumioRetrievevolume Feb 08 05:38:30 volumio volumio[2146]: Unhandled rejection Error: No sockets available, cannot start. Feb 08 05:38:30 volumio volumio[2146]: at SSDP._createSockets (/volumio/node_modules/node-ssdp/lib/index.js:186:11) Feb 08 05:38:30 volumio volumio[2146]: at SSDP._start (/volumio/node_modules/node-ssdp/lib/index.js:229:10) Feb 08 05:38:30 volumio volumio[2146]: at /volumio/node_modules/node-ssdp/lib/client.js:60:10 Feb 08 05:38:30 volumio volumio[2146]: at Promise._execute (/volumio/node_modules/bluebird/js/release/debuggability.js:384:9) Feb 08 05:38:30 volumio volumio[2146]: at Promise._resolveFromExecutor (/volumio/node_modules/bluebird/js/release/promise.js:518:18) Feb 08 05:38:30 volumio volumio[2146]: at new Promise (/volumio/node_modules/bluebird/js/release/promise.js:103:10) Feb 08 05:38:30 volumio volumio[2146]: at SsdpClient.start (/volumio/node_modules/node-ssdp/lib/client.js:54:10) Feb 08 05:38:30 volumio volumio[2146]: at SsdpClient.search (/volumio/node_modules/node-ssdp/lib/client.js:82:17) Feb 08 05:38:30 volumio volumio[2146]: at ControllerUPNPBrowser.onStart (/volumio/app/plugins/music_service/upnp_browser/index.js:156:14) Feb 08 05:38:30 volumio volumio[2146]: at PluginManager.startCorePlugin (/volumio/app/pluginmanager.js:398:24) Feb 08 05:38:30 volumio volumio[2146]: at HashMap. (/volumio/app/pluginmanager.js:496:31) Feb 08 05:38:30 volumio volumio[2146]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Feb 08 05:38:30 volumio volumio[2146]: at proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Feb 08 05:38:30 volumio volumio[2146]: at PluginManager.startCorePlugins (/volumio/app/pluginmanager.js:495:20) Feb 08 05:38:30 volumio volumio[2146]: at Promise._successFn (/volumio/app/pluginmanager.js:142:29) Feb 08 05:38:30 volumio volumio[2146]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Feb 08 05:38:30 volumio volumio[2146]: info: MPD Permissions set Feb 08 05:38:30 volumio volumio[2146]: info: MPD Permissions set Feb 08 05:38:30 volumio volumio[2146]: info: Discovery: adding 6a8902c9-5eee-4430-84ba-2ef95c5a1f77 Feb 08 05:38:30 volumio volumio[2146]: info: Discovery: Found device Anlægget Feb 08 05:38:30 volumio volumio[2146]: info: CoreCommandRouter::volumioGetState Feb 08 05:38:30 volumio volumio[2146]: info: CorePlayQueue::getTrack 0 Feb 08 05:38:30 volumio volumio[2146]: info: VolumeController:: Volume=100 Mute =false Feb 08 05:38:30 volumio volumio[2146]: info: CoreStateMachine::pushState Feb 08 05:38:30 volumio volumio[2146]: info: CorePlayQueue::getTrack 0 Feb 08 05:38:30 volumio volumio[2146]: info: CoreCommandRouter::volumioPushState Feb 08 05:38:30 volumio volumio[2146]: info: [squeezelite_mc] Server discovery started Feb 08 05:38:30 volumio volumio[2146]: info: [squeezelite_mc] Player finder started Feb 08 05:38:30 volumio volumio[2234]: Starting albumart workers Feb 08 05:38:30 volumio volumio[2146]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:38:30 volumio volumio[2146]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:38:30 volumio volumio[2146]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:38:30 volumio volumio[2146]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 08 05:38:30 volumio volumio[2146]: info: [squeezelite_mc] Executing aplay -D hw:5 --nonblock -f MPEG /dev/zero 2>&1 || true Feb 08 05:38:30 volumio volumio[2146]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 08 05:38:30 volumio volumio[2146]: Error: send ENETUNREACH 255.255.255.255:3483 Feb 08 05:38:30 volumio volumio[2146]: at doSend (node:dgram:717:16) Feb 08 05:38:30 volumio volumio[2146]: at defaultTriggerAsyncIdScope (node:internal/async_hooks:464:18) Feb 08 05:38:30 volumio volumio[2146]: at afterDns (node:dgram:663:5) Feb 08 05:38:30 volumio volumio[2146]: at process.processTicksAndRejections (node:internal/process/task_queues:83:21) { Feb 08 05:38:30 volumio volumio[2146]: errno: -101, Feb 08 05:38:30 volumio volumio[2146]: code: 'ENETUNREACH', Feb 08 05:38:30 volumio volumio[2146]: syscall: 'send', Feb 08 05:38:30 volumio volumio[2146]: address: '255.255.255.255', Feb 08 05:38:30 volumio volumio[2146]: port: 3483 Feb 08 05:38:30 volumio volumio[2146]: } Feb 08 05:38:30 volumio volumio[2146]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 08 05:38:31 volumio sudo[2348]: volumio : unable to resolve host volumio: System error Feb 08 05:38:31 volumio sudo[2348]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-08 05:37' Feb 08 05:38:31 volumio sudo[2348]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 05:38:31 volumio sudo[2348]: pam_unix(sudo:session): session closed for user root Feb 08 05:38:31 volumio volumio[2146]: sudo: unable to resolve host volumio: System error Feb 08 05:38:31 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Feb 08 05:38:31 volumio sudo[2279]: pam_unix(sudo:session): session closed for user root Feb 08 05:38:31 volumio sudo[2269]: pam_unix(sudo:session): session closed for user root Feb 08 05:38:31 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Feb 08 05:38:31 volumio systemd[1]: volumio.service: Consumed 11.900s CPU time. Feb 08 05:38:31 volumio systemd[1]: Started dynamicswap.service - dynamicswap service. Feb 08 05:38:31 volumio systemd[1]: dynamicswap.service: Deactivated successfully. Feb 08 05:38:31 volumio mpd[2310]: decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 08 05:38:31 volumio mpd[2310]: output: No 'audio_output' defined in config file Feb 08 05:38:31 volumio mpd[2310]: output: Successfully detected a sndio audio device Feb 08 05:38:31 volumio mpd[2310]: zeroconf: No global port, disabling zeroconf Feb 08 05:38:31 volumio systemd[1]: Started mpd.service - Music Player Daemon. Feb 08 05:38:31 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 96. Feb 08 05:38:31 volumio systemd[1]: Started dynamicswap.service - dynamicswap service. Feb 08 05:38:31 volumio systemd[1]: Stopped volumio.service - Volumio Backend Module. Feb 08 05:38:31 volumio systemd[1]: volumio.service: Consumed 11.900s CPU time. Feb 08 05:38:31 volumio systemd[1]: Started volumio.service - Volumio Backend Module. Feb 08 05:38:31 volumio systemd[1]: dynamicswap.service: Deactivated successfully. Feb 08 05:38:32 volumio volumio[2365]: info: ------------------------------------------- Feb 08 05:38:32 volumio volumio[2365]: info: ----- Volumio3 ---- Feb 08 05:38:32 volumio volumio[2365]: info: ------------------------------------------- Feb 08 05:38:32 volumio volumio[2365]: info: ----- System startup ---- Feb 08 05:38:32 volumio volumio[2365]: info: ------------------------------------------- Feb 08 05:38:33 volumio volumio[2365]: info: MYVOLUMIO Environment detected Feb 08 05:38:33 volumio volumio[2365]: info: Plugin folders cleanup Feb 08 05:38:33 volumio volumio[2365]: info: Scanning into folder /volumio/app/plugins/ Feb 08 05:38:33 volumio volumio[2365]: info: Scanning category audio_interface Feb 08 05:38:33 volumio volumio[2365]: info: Scanning category miscellanea Feb 08 05:38:33 volumio volumio[2365]: info: Scanning category music_service Feb 08 05:38:33 volumio volumio[2365]: info: Scanning category plugins.json Feb 08 05:38:33 volumio volumio[2365]: info: Scanning category system_controller Feb 08 05:38:33 volumio volumio[2365]: info: Scanning category user_interface Feb 08 05:38:33 volumio volumio[2365]: info: Scanning into folder /data/plugins/ Feb 08 05:38:33 volumio volumio[2365]: info: Scanning category music_service Feb 08 05:38:33 volumio volumio[2365]: info: Plugin folders cleanup completed Feb 08 05:38:33 volumio volumio[2365]: info: ------------------------------------------- Feb 08 05:38:33 volumio volumio[2365]: info: ----- Core plugins startup ---- Feb 08 05:38:33 volumio volumio[2365]: info: ------------------------------------------- Feb 08 05:38:33 volumio volumio[2365]: info: Loading plugins from folder /volumio/app/plugins/ Feb 08 05:38:33 volumio volumio[2365]: info: Adding plugin upnp to MyMusic Plugins Feb 08 05:38:33 volumio volumio[2365]: info: Adding plugin airplay_emulation to MyMusic Plugins Feb 08 05:38:33 volumio volumio[2365]: info: Adding plugin upnp_browser to MyMusic Plugins Feb 08 05:38:33 volumio volumio[2365]: info: Loading plugins from folder /data/plugins/ Feb 08 05:38:33 volumio volumio[2365]: info: Loading plugin "system"... Feb 08 05:38:33 volumio volumio[2365]: info: Loading plugin "appearance"... Feb 08 05:38:33 volumio wpa_supplicant[2840]: wlan0: Failed to initiate sched scan Feb 08 05:38:33 volumio volumio[2365]: info: Loading plugin "network"... Feb 08 05:38:33 volumio volumio[2365]: info: Refreshing Cached IP Addresses Feb 08 05:38:33 volumio sudo[2396]: volumio : unable to resolve host volumio: System error Feb 08 05:38:33 volumio sudo[2396]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 08 05:38:33 volumio sudo[2398]: volumio : unable to resolve host volumio: System error Feb 08 05:38:33 volumio sudo[2396]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 05:38:33 volumio volumio[2365]: info: Loading plugin "services"... Feb 08 05:38:33 volumio sudo[2396]: pam_unix(sudo:session): session closed for user root Feb 08 05:38:33 volumio sudo[2398]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 08 05:38:33 volumio volumio[2365]: info: Loading plugin "alsa_controller"... Feb 08 05:38:33 volumio sudo[2398]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 05:38:33 volumio sudo[2406]: volumio : unable to resolve host volumio: System error Feb 08 05:38:33 volumio sudo[2398]: pam_unix(sudo:session): session closed for user root Feb 08 05:38:33 volumio sudo[2406]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Feb 08 05:38:33 volumio sudo[2406]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 05:38:34 volumio volumio[2365]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 08 05:38:34 volumio volumio[2365]: info: Loading plugin "wizard"... Feb 08 05:38:34 volumio volumio[2365]: info: Loading plugin "networkfs"... Feb 08 05:38:34 volumio volumio[2365]: info: Starting Udev Watcher for removable devices Feb 08 05:38:34 volumio volumio[2365]: info: Ignoring mount for partition: boot Feb 08 05:38:34 volumio volumio[2365]: info: Ignoring mount for partition: volumio Feb 08 05:38:34 volumio volumio[2365]: info: Ignoring mount for partition: volumio_data Feb 08 05:38:34 volumio volumio[2365]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 08 05:38:34 volumio volumio[2365]: info: Loading plugin "volumio_command_line_client"... Feb 08 05:38:34 volumio volumio[2365]: info: Loading plugin "upnp"... Feb 08 05:38:34 volumio volumio[2365]: info: [1770525514080] Starting Upmpd Daemon Feb 08 05:38:34 volumio volumio[2365]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 08 05:38:34 volumio volumio[2365]: info: Loading plugin "my_music"... Feb 08 05:38:34 volumio volumio[2365]: info: Loading plugin "mpd"... Feb 08 05:38:34 volumio volumio[2365]: info: Loading plugin "upnp_browser"... Feb 08 05:38:35 volumio volumio[2365]: info: Starting UPNP Browser Feb 08 05:38:35 volumio volumio[2365]: info: Loading plugin "alarm-clock"... Feb 08 05:38:35 volumio volumio[2365]: info: Loading plugin "airplay_emulation"... Feb 08 05:38:35 volumio volumio[2365]: info: Starting Shairport Sync Feb 08 05:38:35 volumio volumio[2365]: info: Loading plugin "last_100"... Feb 08 05:38:35 volumio volumio[2365]: info: Loading plugin "webradio"... Feb 08 05:38:35 volumio volumio[2365]: info: Loading plugin "i2s_dacs"... Feb 08 05:38:35 volumio volumio[2365]: info: I2S DAC not set, start Auto-detection Feb 08 05:38:35 volumio volumio[2365]: info: Loading plugin "volumiodiscovery"... Feb 08 05:38:35 volumio volumio[2365]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 08 05:38:35 volumio volumio[2365]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 08 05:38:35 volumio volumio[2365]: *** WARNING *** For more information see Feb 08 05:38:35 volumio volumio[2365]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 08 05:38:35 volumio volumio[2365]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 08 05:38:35 volumio node[2365]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 08 05:38:35 volumio volumio[2365]: *** WARNING *** For more information see Feb 08 05:38:35 volumio node[2365]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 08 05:38:35 volumio node[2365]: *** WARNING *** For more information see Feb 08 05:38:35 volumio node[2365]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 08 05:38:35 volumio node[2365]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 08 05:38:35 volumio node[2365]: *** WARNING *** For more information see Feb 08 05:38:35 volumio volumio[2365]: info: Applying required configuration parameters for plugin volumiodiscovery Feb 08 05:38:35 volumio volumio[2365]: info: Discovery: Started advertising with name: Anlægget Feb 08 05:38:35 volumio volumio[2365]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 08 05:38:35 volumio volumio[2365]: info: Loading plugin "squeezelite_mc"... Feb 08 05:38:35 volumio volumio[2365]: info: Loading plugin "outputs"... Feb 08 05:38:35 volumio volumio[2365]: info: Loading plugin "albumart"... Feb 08 05:38:35 volumio volumio[2365]: info: Plugin example_plugin is not enabled Feb 08 05:38:35 volumio volumio[2365]: info: Loading plugin "inputs"... Feb 08 05:38:35 volumio volumio[2365]: info: Loading plugin "updater_comm"... Feb 08 05:38:35 volumio volumio[2365]: info: Plugin mpdemulation is not enabled Feb 08 05:38:35 volumio volumio[2365]: info: Loading plugin "rest_api"... Feb 08 05:38:35 volumio volumio[2365]: info: Loading plugin "websocket"... Feb 08 05:38:35 volumio volumio[2365]: info: Starting Socket.io Server version 1.7.4 Feb 08 05:38:35 volumio volumio[2365]: info: Loading i18n strings for locale da Feb 08 05:38:35 volumio volumio[2365]: Updating browse sources language Feb 08 05:38:35 volumio volumio[2365]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 08 05:38:35 volumio volumio[2365]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 08 05:38:35 volumio volumio[2365]: info: CoreCommandRouter::initPlayerControls Feb 08 05:38:35 volumio volumio[2365]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:38:35 volumio volumio[2365]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:38:35 volumio volumio[2365]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:38:35 volumio volumio[2365]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:38:35 volumio volumio[2365]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:38:35 volumio volumio[2365]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:38:35 volumio volumio[2365]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:38:35 volumio volumio[2365]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:38:35 volumio volumio[2365]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 08 05:38:35 volumio volumio[2365]: Express server listening on port 3000 Feb 08 05:38:35 volumio volumio[2365]: [Metrics] WebUI: 3s 186.15ms Feb 08 05:38:35 volumio volumio[2365]: info: CoreStateMachine::resetVolumioState Feb 08 05:38:35 volumio volumio[2365]: info: CoreStateMachine::getcurrentVolume Feb 08 05:38:35 volumio volumio[2365]: info: CoreCommandRouter::volumioRetrievevolume Feb 08 05:38:35 volumio volumio-remote-updater[2374]: [2026-02-08 04:38:35] [connect] Successful connection Feb 08 05:38:35 volumio volumio[2365]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 05:38:35 volumio volumio[2365]: info: Volumio Network Manager: Network status updated: 0 Feb 08 05:38:35 volumio volumio[2431]: Forking 3 albumart workers Feb 08 05:38:35 volumio volumio-remote-updater[2374]: [2026-02-08 04:38:35] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=3&transport=websocket&t=1770525515 101 Feb 08 05:38:35 volumio volumio[2365]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 3 Transport: websocket Total Clients: 1 Feb 08 05:38:36 volumio volumio[2365]: info: VolumeController:: Volume=100 Mute =false Feb 08 05:38:36 volumio volumio[2365]: info: CoreStateMachine::pushState Feb 08 05:38:36 volumio volumio[2365]: info: CorePlayQueue::getTrack 0 Feb 08 05:38:36 volumio volumio[2365]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 08 05:38:36 volumio volumio[2365]: info: CoreCommandRouter::volumioPushState Feb 08 05:38:36 volumio volumio[2365]: info: CoreStateMachine::updateTrackBlock Feb 08 05:38:36 volumio volumio[2365]: info: CorePlayQueue::getTrackBlock Feb 08 05:38:36 volumio volumio[2365]: info: CoreCommandRouter::volumioRetrievevolume Feb 08 05:38:36 volumio volumio[2365]: info: Reloading queue from file Feb 08 05:38:36 volumio volumio[2365]: info: CoreStateMachine::setRepeat null single undefined Feb 08 05:38:36 volumio volumio[2365]: info: CoreStateMachine::pushState Feb 08 05:38:36 volumio volumio[2365]: info: CorePlayQueue::getTrack 0 Feb 08 05:38:36 volumio volumio[2365]: info: CoreCommandRouter::volumioPushState Feb 08 05:38:36 volumio volumio[2365]: info: CoreStateMachine::setRandom null Feb 08 05:38:36 volumio volumio[2365]: info: CoreStateMachine::pushState Feb 08 05:38:36 volumio volumio[2365]: info: CorePlayQueue::getTrack 0 Feb 08 05:38:36 volumio volumio[2365]: info: CoreCommandRouter::volumioPushState Feb 08 05:38:36 volumio volumio[2365]: info: Setting Device type: Raspberry PI Feb 08 05:38:36 volumio volumio[2365]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Feb 08 05:38:36 volumio volumio[2365]: info: USB Boot Capable - System SBC Revision found in cpuinfo: c03111 Feb 08 05:38:36 volumio volumio[2365]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Feb 08 05:38:36 volumio volumio[2365]: info: Discovery: adding 6a8902c9-5eee-4430-84ba-2ef95c5a1f77 Feb 08 05:38:36 volumio volumio[2365]: info: Discovery: Found device Anlægget Feb 08 05:38:36 volumio volumio[2365]: info: CoreCommandRouter::volumioGetState Feb 08 05:38:36 volumio volumio[2365]: info: CorePlayQueue::getTrack 0 Feb 08 05:38:36 volumio volumio[2365]: info: VolumeController:: Volume=100 Mute =false Feb 08 05:38:36 volumio volumio[2365]: info: CoreStateMachine::pushState Feb 08 05:38:36 volumio volumio[2365]: info: CorePlayQueue::getTrack 0 Feb 08 05:38:36 volumio volumio[2365]: info: CoreCommandRouter::volumioPushState Feb 08 05:38:36 volumio volumio[2365]: info: Completed loading Core Plugins Feb 08 05:38:36 volumio volumio[2365]: info: Preparing to generate the ALSA configuration file Feb 08 05:38:36 volumio volumio[2365]: info: Asound.conf file unchanged, so no further update is needed Feb 08 05:38:36 volumio volumio[2365]: info: Output device has changed, restarting MPD Feb 08 05:38:36 volumio volumio[2365]: info: Output device has changed, restarting Shairport Sync Feb 08 05:38:36 volumio volumio[2365]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:38:36 volumio volumio[2365]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 05:38:36 volumio sudo[2487]: volumio : unable to resolve host volumio: System error Feb 08 05:38:36 volumio sudo[2489]: volumio : unable to resolve host volumio: System error Feb 08 05:38:36 volumio volumio[2365]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 08 05:38:36 volumio volumio[2365]: info: ___________ START PLUGINS ___________ Feb 08 05:38:36 volumio sudo[2487]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 08 05:38:36 volumio sudo[2489]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 08 05:38:36 volumio sudo[2489]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 05:38:36 volumio volumio[2365]: info: ControllerMpd::onStart: Initializing MPD Feb 08 05:38:36 volumio sudo[2487]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 05:38:36 volumio volumio[2365]: info: Creating MPD Configuration file Feb 08 05:38:36 volumio sudo[2487]: pam_unix(sudo:session): session closed for user root Feb 08 05:38:36 volumio volumio[2365]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 08 05:38:36 volumio volumio[2365]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 08 05:38:36 volumio volumio[2365]: info: [1770525516225] CoreMusicLibrary::Adding element Medieservere Feb 08 05:38:36 volumio volumio[2365]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 08 05:38:36 volumio volumio[2365]: info: UPNP Browser: Client initialized successfully Feb 08 05:38:36 volumio sudo[2498]: volumio : unable to resolve host volumio: System error Feb 08 05:38:36 volumio volumio[2365]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:38:36 volumio volumio[2365]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 05:38:36 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Feb 08 05:38:36 volumio sudo[2498]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 08 05:38:36 volumio sudo[2498]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 05:38:36 volumio sudo[2499]: volumio : unable to resolve host volumio: System error Feb 08 05:38:36 volumio sudo[2498]: pam_unix(sudo:session): session closed for user root Feb 08 05:38:36 volumio volumio[2365]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 08 05:38:36 volumio volumio[2365]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:38:36 volumio volumio[2365]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 05:38:36 volumio sudo[2499]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 08 05:38:36 volumio sudo[2499]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 05:38:36 volumio systemd[1]: mpd.service: Deactivated successfully. Feb 08 05:38:36 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Feb 08 05:38:36 volumio systemd[1]: mpd.service: Consumed 1.890s CPU time. Feb 08 05:38:36 volumio systemd[1]: mpd.socket: Deactivated successfully. Feb 08 05:38:36 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Feb 08 05:38:36 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Feb 08 05:38:36 volumio volumio[2365]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 08 05:38:36 volumio volumio[2365]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 08 05:38:36 volumio volumio[2365]: info: [1770525516325] CoreMusicLibrary::Adding element Last_100 Feb 08 05:38:36 volumio volumio[2365]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 08 05:38:36 volumio volumio[2365]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 08 05:38:36 volumio volumio[2365]: info: [1770525516328] CoreMusicLibrary::Adding element Webradio Feb 08 05:38:36 volumio volumio[2365]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 08 05:38:36 volumio volumio[2365]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 08 05:38:36 volumio volumio[2365]: info: Initializing BBC Radios Feb 08 05:38:36 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Feb 08 05:38:36 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Feb 08 05:38:36 volumio volumio[2365]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 08 05:38:36 volumio volumio[2365]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 05:38:36 volumio systemd[1]: mpd.service: Deactivated successfully. Feb 08 05:38:36 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Feb 08 05:38:36 volumio systemd[1]: mpd.socket: Deactivated successfully. Feb 08 05:38:36 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Feb 08 05:38:36 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Feb 08 05:38:36 volumio volumio[2365]: info: [squeezelite_mc] Starting proxy server... Feb 08 05:38:36 volumio volumio[2365]: info: Volumio Calling Home Feb 08 05:38:36 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Feb 08 05:38:36 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Feb 08 05:38:36 volumio volumio[2365]: info: [squeezelite_mc] Proxy server started on port 43737 Feb 08 05:38:36 volumio sudo[2528]: root : unable to resolve host volumio: System error Feb 08 05:38:36 volumio sudo[2528]: sudo: unable to resolve host volumio: System error Feb 08 05:38:36 volumio sudo[2528]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 08 05:38:36 volumio sudo[2528]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 08 05:38:36 volumio sudo[2406]: pam_unix(sudo:session): session closed for user root Feb 08 05:38:36 volumio sudo[2528]: pam_unix(sudo:session): session closed for user root Feb 08 05:38:36 volumio volumio[2447]: Starting albumart workers Feb 08 05:38:36 volumio volumio[2365]: info: CoreCommandRouter::volumioRetrievevolume Feb 08 05:38:36 volumio volumio[2365]: Unhandled rejection Error: No sockets available, cannot start. Feb 08 05:38:36 volumio volumio[2365]: at SSDP._createSockets (/volumio/node_modules/node-ssdp/lib/index.js:186:11) Feb 08 05:38:36 volumio volumio[2365]: at SSDP._start (/volumio/node_modules/node-ssdp/lib/index.js:229:10) Feb 08 05:38:36 volumio volumio[2365]: at /volumio/node_modules/node-ssdp/lib/client.js:60:10 Feb 08 05:38:36 volumio volumio[2365]: at Promise._execute (/volumio/node_modules/bluebird/js/release/debuggability.js:384:9) Feb 08 05:38:36 volumio volumio[2365]: at Promise._resolveFromExecutor (/volumio/node_modules/bluebird/js/release/promise.js:518:18) Feb 08 05:38:36 volumio volumio[2365]: at new Promise (/volumio/node_modules/bluebird/js/release/promise.js:103:10) Feb 08 05:38:36 volumio volumio[2365]: at SsdpClient.start (/volumio/node_modules/node-ssdp/lib/client.js:54:10) Feb 08 05:38:36 volumio volumio[2365]: at SsdpClient.search (/volumio/node_modules/node-ssdp/lib/client.js:82:17) Feb 08 05:38:36 volumio volumio[2365]: at ControllerUPNPBrowser.onStart (/volumio/app/plugins/music_service/upnp_browser/index.js:156:14) Feb 08 05:38:36 volumio volumio[2365]: at PluginManager.startCorePlugin (/volumio/app/pluginmanager.js:398:24) Feb 08 05:38:36 volumio volumio[2365]: at HashMap. (/volumio/app/pluginmanager.js:496:31) Feb 08 05:38:36 volumio volumio[2365]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Feb 08 05:38:36 volumio volumio[2365]: at proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Feb 08 05:38:36 volumio volumio[2365]: at PluginManager.startCorePlugins (/volumio/app/pluginmanager.js:495:20) Feb 08 05:38:36 volumio volumio[2365]: at Promise._successFn (/volumio/app/pluginmanager.js:142:29) Feb 08 05:38:36 volumio volumio[2365]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Feb 08 05:38:37 volumio volumio[2365]: info: MPD Permissions set Feb 08 05:38:37 volumio volumio[2365]: info: MPD Permissions set Feb 08 05:38:37 volumio volumio[2365]: info: VolumeController:: Volume=100 Mute =false Feb 08 05:38:37 volumio volumio[2365]: info: CoreStateMachine::pushState Feb 08 05:38:37 volumio volumio[2365]: info: CorePlayQueue::getTrack 0 Feb 08 05:38:37 volumio volumio[2365]: info: CoreCommandRouter::volumioPushState Feb 08 05:38:37 volumio volumio[2365]: info: [squeezelite_mc] Server discovery started Feb 08 05:38:37 volumio volumio[2365]: info: [squeezelite_mc] Player finder started Feb 08 05:38:37 volumio volumio[2365]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:38:37 volumio volumio[2365]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:38:37 volumio volumio[2365]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:38:37 volumio volumio[2365]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 08 05:38:37 volumio volumio[2365]: info: [squeezelite_mc] Executing aplay -D hw:5 --nonblock -f MPEG /dev/zero 2>&1 || true Feb 08 05:38:37 volumio volumio[2448]: Starting albumart workers Feb 08 05:38:37 volumio volumio[2365]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 08 05:38:37 volumio volumio[2449]: Starting albumart workers Feb 08 05:38:37 volumio volumio[2365]: Error: send ENETUNREACH 255.255.255.255:3483 Feb 08 05:38:37 volumio volumio[2365]: at doSend (node:dgram:717:16) Feb 08 05:38:37 volumio volumio[2365]: at defaultTriggerAsyncIdScope (node:internal/async_hooks:464:18) Feb 08 05:38:37 volumio volumio[2365]: at afterDns (node:dgram:663:5) Feb 08 05:38:37 volumio volumio[2365]: at process.processTicksAndRejections (node:internal/process/task_queues:83:21) { Feb 08 05:38:37 volumio volumio[2365]: errno: -101, Feb 08 05:38:37 volumio volumio[2365]: code: 'ENETUNREACH', Feb 08 05:38:37 volumio volumio[2365]: syscall: 'send', Feb 08 05:38:37 volumio volumio[2365]: address: '255.255.255.255', Feb 08 05:38:37 volumio volumio[2365]: port: 3483 Feb 08 05:38:37 volumio volumio[2365]: } Feb 08 05:38:37 volumio volumio[2365]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 08 05:38:37 volumio sudo[2568]: volumio : unable to resolve host volumio: System error Feb 08 05:38:37 volumio sudo[2568]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-08 05:37' Feb 08 05:38:37 volumio sudo[2568]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 05:38:38 volumio sudo[2568]: pam_unix(sudo:session): session closed for user root Feb 08 05:38:38 volumio volumio[2365]: sudo: unable to resolve host volumio: System error Feb 08 05:38:38 volumio volumio-remote-updater[2374]: [2026-02-08 04:38:38] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Feb 08 05:38:38 volumio volumio-remote-updater[2374]: [2026-02-08 04:38:38] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Feb 08 05:38:38 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Feb 08 05:38:38 volumio sudo[2489]: pam_unix(sudo:session): session closed for user root Feb 08 05:38:38 volumio sudo[2499]: pam_unix(sudo:session): session closed for user root Feb 08 05:38:38 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Feb 08 05:38:38 volumio systemd[1]: volumio.service: Consumed 11.966s CPU time. Feb 08 05:38:38 volumio systemd[1]: Started dynamicswap.service - dynamicswap service. Feb 08 05:38:38 volumio systemd[1]: dynamicswap.service: Deactivated successfully. Feb 08 05:38:38 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 97. Feb 08 05:38:38 volumio systemd[1]: Started dynamicswap.service - dynamicswap service. Feb 08 05:38:38 volumio systemd[1]: Stopped volumio.service - Volumio Backend Module. Feb 08 05:38:38 volumio systemd[1]: volumio.service: Consumed 11.966s CPU time. Feb 08 05:38:38 volumio systemd[1]: Started volumio.service - Volumio Backend Module. Feb 08 05:38:38 volumio systemd[1]: dynamicswap.service: Deactivated successfully. Feb 08 05:38:38 volumio mpd[2531]: decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 08 05:38:38 volumio mpd[2531]: output: No 'audio_output' defined in config file Feb 08 05:38:38 volumio mpd[2531]: output: Successfully detected a sndio audio device Feb 08 05:38:38 volumio mpd[2531]: zeroconf: No global port, disabling zeroconf Feb 08 05:38:38 volumio systemd[1]: Started mpd.service - Music Player Daemon. Feb 08 05:38:39 volumio volumio[2583]: info: ------------------------------------------- Feb 08 05:38:39 volumio volumio[2583]: info: ----- Volumio3 ---- Feb 08 05:38:39 volumio volumio[2583]: info: ------------------------------------------- Feb 08 05:38:39 volumio volumio[2583]: info: ----- System startup ---- Feb 08 05:38:39 volumio volumio[2583]: info: ------------------------------------------- Feb 08 05:38:39 volumio volumio[2583]: info: MYVOLUMIO Environment detected Feb 08 05:38:39 volumio volumio[2583]: info: Plugin folders cleanup Feb 08 05:38:39 volumio volumio[2583]: info: Scanning into folder /volumio/app/plugins/ Feb 08 05:38:39 volumio volumio[2583]: info: Scanning category audio_interface Feb 08 05:38:39 volumio volumio[2583]: info: Scanning category miscellanea Feb 08 05:38:39 volumio volumio[2583]: info: Scanning category music_service Feb 08 05:38:39 volumio volumio[2583]: info: Scanning category plugins.json Feb 08 05:38:39 volumio volumio[2583]: info: Scanning category system_controller Feb 08 05:38:39 volumio volumio[2583]: info: Scanning category user_interface Feb 08 05:38:39 volumio volumio[2583]: info: Scanning into folder /data/plugins/ Feb 08 05:38:39 volumio volumio[2583]: info: Scanning category music_service Feb 08 05:38:39 volumio volumio[2583]: info: Plugin folders cleanup completed Feb 08 05:38:39 volumio volumio[2583]: info: ------------------------------------------- Feb 08 05:38:39 volumio volumio[2583]: info: ----- Core plugins startup ---- Feb 08 05:38:39 volumio volumio[2583]: info: ------------------------------------------- Feb 08 05:38:39 volumio volumio[2583]: info: Loading plugins from folder /volumio/app/plugins/ Feb 08 05:38:39 volumio volumio[2583]: info: Adding plugin upnp to MyMusic Plugins Feb 08 05:38:39 volumio volumio[2583]: info: Adding plugin airplay_emulation to MyMusic Plugins Feb 08 05:38:39 volumio volumio[2583]: info: Adding plugin upnp_browser to MyMusic Plugins Feb 08 05:38:39 volumio volumio[2583]: info: Loading plugins from folder /data/plugins/ Feb 08 05:38:39 volumio volumio[2583]: info: Loading plugin "system"... Feb 08 05:38:39 volumio volumio[2583]: info: Loading plugin "appearance"... Feb 08 05:38:40 volumio volumio[2583]: info: Loading plugin "network"... Feb 08 05:38:40 volumio volumio[2583]: info: Refreshing Cached IP Addresses Feb 08 05:38:40 volumio sudo[2613]: volumio : unable to resolve host volumio: System error Feb 08 05:38:40 volumio sudo[2615]: volumio : unable to resolve host volumio: System error Feb 08 05:38:40 volumio sudo[2613]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 08 05:38:40 volumio sudo[2613]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 05:38:40 volumio volumio[2583]: info: Loading plugin "services"... Feb 08 05:38:40 volumio volumio[2583]: info: Loading plugin "alsa_controller"... Feb 08 05:38:40 volumio sudo[2615]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 08 05:38:40 volumio sudo[2615]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 05:38:40 volumio sudo[2622]: volumio : unable to resolve host volumio: System error Feb 08 05:38:40 volumio sudo[2613]: pam_unix(sudo:session): session closed for user root Feb 08 05:38:40 volumio sudo[2615]: pam_unix(sudo:session): session closed for user root Feb 08 05:38:40 volumio sudo[2622]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Feb 08 05:38:40 volumio sudo[2622]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 05:38:40 volumio sudo[2622]: pam_unix(sudo:session): session closed for user root Feb 08 05:38:40 volumio volumio[2583]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 08 05:38:40 volumio volumio[2583]: info: Loading plugin "wizard"... Feb 08 05:38:40 volumio volumio[2583]: info: Loading plugin "networkfs"... Feb 08 05:38:40 volumio volumio[2583]: info: Starting Udev Watcher for removable devices Feb 08 05:38:40 volumio volumio[2583]: info: Ignoring mount for partition: boot Feb 08 05:38:40 volumio volumio[2583]: info: Ignoring mount for partition: volumio Feb 08 05:38:40 volumio volumio[2583]: info: Ignoring mount for partition: volumio_data Feb 08 05:38:40 volumio volumio[2583]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 08 05:38:40 volumio volumio[2583]: info: Loading plugin "volumio_command_line_client"... Feb 08 05:38:40 volumio volumio[2583]: info: Loading plugin "upnp"... Feb 08 05:38:40 volumio volumio[2583]: info: [1770525520597] Starting Upmpd Daemon Feb 08 05:38:40 volumio volumio[2583]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 08 05:38:40 volumio volumio[2583]: info: Loading plugin "my_music"... Feb 08 05:38:40 volumio volumio[2583]: info: Loading plugin "mpd"... Feb 08 05:38:40 volumio volumio[2583]: info: Loading plugin "upnp_browser"... Feb 08 05:38:41 volumio wpa_supplicant[2840]: wlan0: Failed to initiate sched scan Feb 08 05:38:41 volumio volumio[2583]: info: Starting UPNP Browser Feb 08 05:38:41 volumio volumio[2583]: info: Loading plugin "alarm-clock"... Feb 08 05:38:41 volumio volumio[2583]: info: Loading plugin "airplay_emulation"... Feb 08 05:38:41 volumio volumio[2583]: info: Starting Shairport Sync Feb 08 05:38:41 volumio volumio[2583]: info: Loading plugin "last_100"... Feb 08 05:38:41 volumio volumio[2583]: info: Loading plugin "webradio"... Feb 08 05:38:41 volumio volumio[2583]: info: Loading plugin "i2s_dacs"... Feb 08 05:38:41 volumio volumio[2583]: info: I2S DAC not set, start Auto-detection Feb 08 05:38:41 volumio volumio[2583]: info: Loading plugin "volumiodiscovery"... Feb 08 05:38:41 volumio volumio[2583]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 08 05:38:41 volumio volumio[2583]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 08 05:38:41 volumio volumio[2583]: *** WARNING *** For more information see Feb 08 05:38:41 volumio volumio[2583]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 08 05:38:41 volumio volumio[2583]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 08 05:38:41 volumio volumio[2583]: *** WARNING *** For more information see Feb 08 05:38:41 volumio node[2583]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 08 05:38:41 volumio node[2583]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 08 05:38:41 volumio node[2583]: *** WARNING *** For more information see Feb 08 05:38:41 volumio node[2583]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 08 05:38:41 volumio node[2583]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 08 05:38:41 volumio node[2583]: *** WARNING *** For more information see Feb 08 05:38:41 volumio volumio[2583]: info: Applying required configuration parameters for plugin volumiodiscovery Feb 08 05:38:41 volumio volumio[2583]: info: Discovery: Started advertising with name: Anlægget Feb 08 05:38:41 volumio volumio[2583]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 08 05:38:41 volumio volumio[2583]: info: Loading plugin "squeezelite_mc"... Feb 08 05:38:42 volumio volumio[2583]: info: Loading plugin "outputs"... Feb 08 05:38:42 volumio volumio[2583]: info: Loading plugin "albumart"... Feb 08 05:38:42 volumio volumio[2583]: info: Plugin example_plugin is not enabled Feb 08 05:38:42 volumio volumio[2583]: info: Loading plugin "inputs"... Feb 08 05:38:42 volumio volumio[2583]: info: Loading plugin "updater_comm"... Feb 08 05:38:42 volumio volumio[2583]: info: Plugin mpdemulation is not enabled Feb 08 05:38:42 volumio volumio[2583]: info: Loading plugin "rest_api"... Feb 08 05:38:42 volumio volumio[2583]: info: Loading plugin "websocket"... Feb 08 05:38:42 volumio volumio[2583]: info: Starting Socket.io Server version 1.7.4 Feb 08 05:38:42 volumio volumio[2583]: info: Loading i18n strings for locale da Feb 08 05:38:42 volumio volumio[2583]: Updating browse sources language Feb 08 05:38:42 volumio volumio[2583]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 08 05:38:42 volumio volumio[2583]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 08 05:38:42 volumio volumio[2583]: info: CoreCommandRouter::initPlayerControls Feb 08 05:38:42 volumio volumio[2583]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:38:42 volumio volumio[2583]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:38:42 volumio volumio[2583]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:38:42 volumio volumio[2583]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:38:42 volumio volumio[2583]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:38:42 volumio volumio[2583]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:38:42 volumio volumio[2583]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:38:42 volumio volumio[2583]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:38:42 volumio volumio[2583]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 08 05:38:42 volumio volumio[2583]: Express server listening on port 3000 Feb 08 05:38:42 volumio volumio[2583]: [Metrics] WebUI: 3s 221.40ms Feb 08 05:38:42 volumio volumio[2583]: info: CoreStateMachine::resetVolumioState Feb 08 05:38:42 volumio volumio[2583]: info: CoreStateMachine::getcurrentVolume Feb 08 05:38:42 volumio volumio[2583]: info: CoreCommandRouter::volumioRetrievevolume Feb 08 05:38:42 volumio volumio[2583]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 05:38:42 volumio volumio[2583]: info: Volumio Network Manager: Network status updated: 0 Feb 08 05:38:42 volumio volumio[2583]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Feb 08 05:38:42 volumio volumio[2583]: sudo: unable to resolve host volumio: System error Feb 08 05:38:42 volumio volumio[2583]: wlan0 Interface doesn't support scanning : Device or resource busy Feb 08 05:38:42 volumio volumio[2583]: info: Cannot use regular scanning, forcing with ap-force Feb 08 05:38:42 volumio sudo[2668]: volumio : unable to resolve host volumio: System error Feb 08 05:38:42 volumio sudo[2668]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Feb 08 05:38:42 volumio sudo[2668]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 05:38:42 volumio volumio[2648]: Forking 3 albumart workers Feb 08 05:38:43 volumio volumio[2670]: Starting albumart workers Feb 08 05:38:43 volumio volumio[2673]: Starting albumart workers Feb 08 05:38:43 volumio volumio[2671]: Starting albumart workers Feb 08 05:38:43 volumio volumio-remote-updater[2374]: [2026-02-08 04:38:43] [connect] Successful connection Feb 08 05:38:48 volumio wpa_supplicant[2840]: wlan0: Failed to initiate sched scan Feb 08 05:38:55 volumio volumio-remote-updater[2374]: [2026-02-08 04:38:55] [connect] Successful connection Feb 08 05:38:56 volumio wpa_supplicant[2840]: wlan0: Failed to initiate sched scan Feb 08 05:39:04 volumio wpa_supplicant[2840]: wlan0: Failed to initiate sched scan Feb 08 05:39:09 volumio sudo[2668]: pam_unix(sudo:session): session closed for user root Feb 08 05:39:09 volumio volumio[2583]: sudo: unable to resolve host volumio: System error Feb 08 05:39:09 volumio volumio[2583]: command failed: No buffer space available (-105) Feb 08 05:39:09 volumio volumio[2583]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Feb 08 05:39:09 volumio volumio[2583]: sudo: unable to resolve host volumio: System error Feb 08 05:39:09 volumio volumio[2583]: command failed: No buffer space available (-105) Feb 08 05:39:09 volumio sudo[2761]: volumio : unable to resolve host volumio: System error Feb 08 05:39:09 volumio sudo[2761]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 08 05:39:09 volumio sudo[2761]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 05:39:09 volumio sudo[2763]: volumio : unable to resolve host volumio: System error Feb 08 05:39:09 volumio sudo[2763]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 08 05:39:09 volumio sudo[2763]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 05:39:09 volumio sudo[2761]: pam_unix(sudo:session): session closed for user root Feb 08 05:39:09 volumio volumio[2583]: info: VolumeController:: Volume=100 Mute =false Feb 08 05:39:09 volumio volumio[2583]: info: CoreStateMachine::pushState Feb 08 05:39:09 volumio volumio[2583]: info: CorePlayQueue::getTrack 0 Feb 08 05:39:09 volumio volumio[2583]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 08 05:39:09 volumio volumio[2583]: info: CoreCommandRouter::volumioPushState Feb 08 05:39:09 volumio sudo[2763]: pam_unix(sudo:session): session closed for user root Feb 08 05:39:09 volumio volumio[2583]: info: CoreStateMachine::updateTrackBlock Feb 08 05:39:09 volumio volumio[2583]: info: CorePlayQueue::getTrackBlock Feb 08 05:39:09 volumio volumio[2583]: info: CoreCommandRouter::volumioRetrievevolume Feb 08 05:39:09 volumio volumio[2583]: info: Reloading queue from file Feb 08 05:39:09 volumio volumio[2583]: info: CoreStateMachine::setRepeat null single undefined Feb 08 05:39:09 volumio volumio[2583]: info: CoreStateMachine::pushState Feb 08 05:39:09 volumio volumio[2583]: info: CorePlayQueue::getTrack 0 Feb 08 05:39:09 volumio volumio[2583]: info: CoreCommandRouter::volumioPushState Feb 08 05:39:09 volumio volumio[2583]: info: CoreStateMachine::setRandom null Feb 08 05:39:09 volumio volumio[2583]: info: CoreStateMachine::pushState Feb 08 05:39:09 volumio volumio[2583]: info: CorePlayQueue::getTrack 0 Feb 08 05:39:09 volumio volumio[2583]: info: CoreCommandRouter::volumioPushState Feb 08 05:39:09 volumio volumio[2583]: info: Setting Device type: Raspberry PI Feb 08 05:39:09 volumio volumio[2583]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Feb 08 05:39:09 volumio volumio[2583]: info: USB Boot Capable - System SBC Revision found in cpuinfo: c03111 Feb 08 05:39:09 volumio volumio[2583]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Feb 08 05:39:09 volumio volumio[2583]: info: VolumeController:: Volume=100 Mute =false Feb 08 05:39:09 volumio volumio[2583]: info: CoreStateMachine::pushState Feb 08 05:39:09 volumio volumio[2583]: info: CorePlayQueue::getTrack 0 Feb 08 05:39:09 volumio volumio[2583]: info: CoreCommandRouter::volumioPushState Feb 08 05:39:09 volumio volumio[2583]: info: Discovery: adding 6a8902c9-5eee-4430-84ba-2ef95c5a1f77 Feb 08 05:39:09 volumio volumio[2583]: info: Discovery: Found device Anlægget Feb 08 05:39:09 volumio volumio[2583]: info: CoreCommandRouter::volumioGetState Feb 08 05:39:09 volumio volumio[2583]: info: CorePlayQueue::getTrack 0 Feb 08 05:39:09 volumio sudo[2775]: volumio : unable to resolve host volumio: System error Feb 08 05:39:09 volumio volumio[2583]: info: Completed loading Core Plugins Feb 08 05:39:09 volumio volumio[2583]: info: Preparing to generate the ALSA configuration file Feb 08 05:39:09 volumio sudo[2775]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Feb 08 05:39:09 volumio sudo[2775]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 05:39:09 volumio volumio[2583]: info: Asound.conf file unchanged, so no further update is needed Feb 08 05:39:09 volumio volumio[2583]: info: Output device has changed, restarting MPD Feb 08 05:39:09 volumio volumio[2583]: info: Output device has changed, restarting Shairport Sync Feb 08 05:39:09 volumio volumio[2583]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:39:09 volumio volumio[2583]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 05:39:09 volumio sudo[2778]: volumio : unable to resolve host volumio: System error Feb 08 05:39:09 volumio sudo[2775]: pam_unix(sudo:session): session closed for user root Feb 08 05:39:09 volumio sudo[2778]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 08 05:39:09 volumio sudo[2778]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 05:39:09 volumio sudo[2780]: volumio : unable to resolve host volumio: System error Feb 08 05:39:09 volumio sudo[2778]: pam_unix(sudo:session): session closed for user root Feb 08 05:39:09 volumio sudo[2780]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 08 05:39:09 volumio volumio[2583]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 08 05:39:09 volumio sudo[2780]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 05:39:09 volumio volumio[2583]: info: ___________ START PLUGINS ___________ Feb 08 05:39:09 volumio volumio[2583]: info: ControllerMpd::onStart: Initializing MPD Feb 08 05:39:09 volumio volumio[2583]: info: Creating MPD Configuration file Feb 08 05:39:09 volumio sudo[2788]: volumio : unable to resolve host volumio: System error Feb 08 05:39:09 volumio sudo[2788]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 08 05:39:09 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Feb 08 05:39:09 volumio sudo[2790]: volumio : unable to resolve host volumio: System error Feb 08 05:39:09 volumio sudo[2788]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 05:39:09 volumio volumio[2583]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 08 05:39:09 volumio volumio[2583]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 08 05:39:09 volumio volumio[2583]: info: [1770525549444] CoreMusicLibrary::Adding element Medieservere Feb 08 05:39:09 volumio volumio[2583]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 08 05:39:09 volumio sudo[2790]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 08 05:39:09 volumio sudo[2790]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 05:39:09 volumio sudo[2788]: pam_unix(sudo:session): session closed for user root Feb 08 05:39:09 volumio volumio[2583]: info: UPNP Browser: Client initialized successfully Feb 08 05:39:09 volumio systemd[1]: mpd.service: Deactivated successfully. Feb 08 05:39:09 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Feb 08 05:39:09 volumio volumio[2583]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:39:09 volumio volumio[2583]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 05:39:09 volumio systemd[1]: mpd.service: Consumed 1.866s CPU time. Feb 08 05:39:09 volumio systemd[1]: mpd.socket: Deactivated successfully. Feb 08 05:39:09 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Feb 08 05:39:09 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Feb 08 05:39:09 volumio volumio[2583]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 08 05:39:09 volumio volumio[2583]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:39:09 volumio volumio[2583]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 05:39:09 volumio volumio[2583]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 08 05:39:09 volumio volumio[2583]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 08 05:39:09 volumio volumio[2583]: info: [1770525549506] CoreMusicLibrary::Adding element Last_100 Feb 08 05:39:09 volumio volumio[2583]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 08 05:39:09 volumio volumio[2583]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 08 05:39:09 volumio volumio[2583]: info: [1770525549509] CoreMusicLibrary::Adding element Webradio Feb 08 05:39:09 volumio volumio[2583]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 08 05:39:09 volumio volumio[2583]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 08 05:39:09 volumio volumio[2583]: info: Initializing BBC Radios Feb 08 05:39:09 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Feb 08 05:39:09 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Feb 08 05:39:09 volumio volumio[2583]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 08 05:39:09 volumio volumio[2583]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 05:39:09 volumio volumio[2583]: info: [squeezelite_mc] Starting proxy server... Feb 08 05:39:09 volumio volumio[2583]: info: Volumio Calling Home Feb 08 05:39:09 volumio volumio[2583]: info: [squeezelite_mc] Proxy server started on port 36897 Feb 08 05:39:09 volumio sudo[2806]: root : unable to resolve host volumio: System error Feb 08 05:39:09 volumio sudo[2806]: sudo: unable to resolve host volumio: System error Feb 08 05:39:09 volumio sudo[2806]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 08 05:39:09 volumio sudo[2806]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 08 05:39:09 volumio sudo[2806]: pam_unix(sudo:session): session closed for user root Feb 08 05:39:09 volumio volumio[2583]: info: CoreCommandRouter::volumioRetrievevolume Feb 08 05:39:09 volumio volumio[2583]: Unhandled rejection Error: No sockets available, cannot start. Feb 08 05:39:09 volumio volumio[2583]: at SSDP._createSockets (/volumio/node_modules/node-ssdp/lib/index.js:186:11) Feb 08 05:39:09 volumio volumio[2583]: at SSDP._start (/volumio/node_modules/node-ssdp/lib/index.js:229:10) Feb 08 05:39:09 volumio volumio[2583]: at /volumio/node_modules/node-ssdp/lib/client.js:60:10 Feb 08 05:39:09 volumio volumio[2583]: at Promise._execute (/volumio/node_modules/bluebird/js/release/debuggability.js:384:9) Feb 08 05:39:09 volumio volumio[2583]: at Promise._resolveFromExecutor (/volumio/node_modules/bluebird/js/release/promise.js:518:18) Feb 08 05:39:09 volumio volumio[2583]: at new Promise (/volumio/node_modules/bluebird/js/release/promise.js:103:10) Feb 08 05:39:09 volumio volumio[2583]: at SsdpClient.start (/volumio/node_modules/node-ssdp/lib/client.js:54:10) Feb 08 05:39:09 volumio volumio[2583]: at SsdpClient.search (/volumio/node_modules/node-ssdp/lib/client.js:82:17) Feb 08 05:39:09 volumio volumio[2583]: at ControllerUPNPBrowser.onStart (/volumio/app/plugins/music_service/upnp_browser/index.js:156:14) Feb 08 05:39:09 volumio volumio[2583]: at PluginManager.startCorePlugin (/volumio/app/pluginmanager.js:398:24) Feb 08 05:39:09 volumio volumio[2583]: at HashMap. (/volumio/app/pluginmanager.js:496:31) Feb 08 05:39:09 volumio volumio[2583]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Feb 08 05:39:09 volumio volumio[2583]: at proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Feb 08 05:39:09 volumio volumio[2583]: at PluginManager.startCorePlugins (/volumio/app/pluginmanager.js:495:20) Feb 08 05:39:09 volumio volumio[2583]: at Promise._successFn (/volumio/app/pluginmanager.js:142:29) Feb 08 05:39:09 volumio volumio[2583]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Feb 08 05:39:09 volumio volumio[2583]: info: MPD Permissions set Feb 08 05:39:09 volumio volumio[2583]: info: MPD Permissions set Feb 08 05:39:09 volumio volumio[2583]: info: Upmpdcli Daemon Started Feb 08 05:39:09 volumio volumio[2583]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Feb 08 05:39:09 volumio volumio[2583]: info: VolumeController:: Volume=100 Mute =false Feb 08 05:39:09 volumio volumio[2583]: info: CoreStateMachine::pushState Feb 08 05:39:09 volumio volumio[2583]: info: CorePlayQueue::getTrack 0 Feb 08 05:39:09 volumio volumio[2583]: info: CoreCommandRouter::volumioPushState Feb 08 05:39:09 volumio volumio[2583]: info: [squeezelite_mc] Server discovery started Feb 08 05:39:09 volumio volumio[2583]: info: [squeezelite_mc] Player finder started Feb 08 05:39:09 volumio volumio[2583]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:39:09 volumio volumio[2583]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:39:09 volumio volumio[2583]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:39:09 volumio volumio[2583]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 08 05:39:09 volumio volumio[2583]: info: [squeezelite_mc] Executing aplay -D hw:5 --nonblock -f MPEG /dev/zero 2>&1 || true Feb 08 05:39:09 volumio volumio[2583]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 08 05:39:09 volumio volumio[2583]: Error: send ENETUNREACH 255.255.255.255:3483 Feb 08 05:39:09 volumio volumio[2583]: at doSend (node:dgram:717:16) Feb 08 05:39:09 volumio volumio[2583]: at defaultTriggerAsyncIdScope (node:internal/async_hooks:464:18) Feb 08 05:39:09 volumio volumio[2583]: at afterDns (node:dgram:663:5) Feb 08 05:39:09 volumio volumio[2583]: at process.processTicksAndRejections (node:internal/process/task_queues:83:21) { Feb 08 05:39:09 volumio volumio[2583]: errno: -101, Feb 08 05:39:09 volumio volumio[2583]: code: 'ENETUNREACH', Feb 08 05:39:09 volumio volumio[2583]: syscall: 'send', Feb 08 05:39:09 volumio volumio[2583]: address: '255.255.255.255', Feb 08 05:39:09 volumio volumio[2583]: port: 3483 Feb 08 05:39:09 volumio volumio[2583]: } Feb 08 05:39:09 volumio volumio[2583]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 08 05:39:10 volumio sudo[2842]: volumio : unable to resolve host volumio: System error Feb 08 05:39:10 volumio sudo[2842]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-08 05:38' Feb 08 05:39:10 volumio sudo[2842]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 05:39:10 volumio sudo[2842]: pam_unix(sudo:session): session closed for user root Feb 08 05:39:10 volumio volumio[2583]: sudo: unable to resolve host volumio: System error Feb 08 05:39:10 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Feb 08 05:39:10 volumio sudo[2780]: pam_unix(sudo:session): session closed for user root Feb 08 05:39:10 volumio sudo[2790]: pam_unix(sudo:session): session closed for user root Feb 08 05:39:10 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Feb 08 05:39:10 volumio systemd[1]: volumio.service: Consumed 36.502s CPU time. Feb 08 05:39:10 volumio volumio-remote-updater[2374]: [2026-02-08 04:39:10] [info] asio async_connect error: asio.system:111 (Connection refused) Feb 08 05:39:10 volumio volumio-remote-updater[2374]: [2026-02-08 04:39:10] [info] Error getting remote endpoint: asio.system:107 (Transport endpoint is not connected) Feb 08 05:39:10 volumio volumio-remote-updater[2374]: [2026-02-08 04:39:10] [error] handle_connect error: Connection refused Feb 08 05:39:10 volumio systemd[1]: Started dynamicswap.service - dynamicswap service. Feb 08 05:39:10 volumio systemd[1]: dynamicswap.service: Deactivated successfully. Feb 08 05:39:10 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 98. Feb 08 05:39:10 volumio systemd[1]: Started dynamicswap.service - dynamicswap service. Feb 08 05:39:10 volumio systemd[1]: Stopped volumio.service - Volumio Backend Module. Feb 08 05:39:10 volumio systemd[1]: volumio.service: Consumed 36.502s CPU time. Feb 08 05:39:10 volumio systemd[1]: Started volumio.service - Volumio Backend Module. Feb 08 05:39:10 volumio systemd[1]: dynamicswap.service: Deactivated successfully. Feb 08 05:39:11 volumio mpd[2820]: decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 08 05:39:11 volumio mpd[2820]: output: No 'audio_output' defined in config file Feb 08 05:39:11 volumio mpd[2820]: output: Successfully detected a sndio audio device Feb 08 05:39:11 volumio mpd[2820]: zeroconf: No global port, disabling zeroconf Feb 08 05:39:11 volumio systemd[1]: Started mpd.service - Music Player Daemon. Feb 08 05:39:11 volumio wpa_supplicant[2840]: wlan0: Failed to initiate sched scan Feb 08 05:39:11 volumio volumio[2871]: info: ------------------------------------------- Feb 08 05:39:11 volumio volumio[2871]: info: ----- Volumio3 ---- Feb 08 05:39:11 volumio volumio[2871]: info: ------------------------------------------- Feb 08 05:39:11 volumio volumio[2871]: info: ----- System startup ---- Feb 08 05:39:11 volumio volumio[2871]: info: ------------------------------------------- Feb 08 05:39:12 volumio volumio[2871]: info: MYVOLUMIO Environment detected Feb 08 05:39:12 volumio volumio[2871]: info: Plugin folders cleanup Feb 08 05:39:12 volumio volumio[2871]: info: Scanning into folder /volumio/app/plugins/ Feb 08 05:39:12 volumio volumio[2871]: info: Scanning category audio_interface Feb 08 05:39:12 volumio volumio[2871]: info: Scanning category miscellanea Feb 08 05:39:12 volumio volumio[2871]: info: Scanning category music_service Feb 08 05:39:12 volumio volumio[2871]: info: Scanning category plugins.json Feb 08 05:39:12 volumio volumio[2871]: info: Scanning category system_controller Feb 08 05:39:12 volumio volumio[2871]: info: Scanning category user_interface Feb 08 05:39:12 volumio volumio[2871]: info: Scanning into folder /data/plugins/ Feb 08 05:39:12 volumio volumio[2871]: info: Scanning category music_service Feb 08 05:39:12 volumio volumio[2871]: info: Plugin folders cleanup completed Feb 08 05:39:12 volumio volumio[2871]: info: ------------------------------------------- Feb 08 05:39:12 volumio volumio[2871]: info: ----- Core plugins startup ---- Feb 08 05:39:12 volumio volumio[2871]: info: ------------------------------------------- Feb 08 05:39:12 volumio volumio[2871]: info: Loading plugins from folder /volumio/app/plugins/ Feb 08 05:39:12 volumio volumio[2871]: info: Adding plugin upnp to MyMusic Plugins Feb 08 05:39:12 volumio volumio[2871]: info: Adding plugin airplay_emulation to MyMusic Plugins Feb 08 05:39:12 volumio volumio[2871]: info: Adding plugin upnp_browser to MyMusic Plugins Feb 08 05:39:12 volumio volumio[2871]: info: Loading plugins from folder /data/plugins/ Feb 08 05:39:12 volumio volumio[2871]: info: Loading plugin "system"... Feb 08 05:39:12 volumio volumio[2871]: info: Loading plugin "appearance"... Feb 08 05:39:13 volumio volumio[2871]: info: Loading plugin "network"... Feb 08 05:39:13 volumio volumio[2871]: info: Refreshing Cached IP Addresses Feb 08 05:39:13 volumio sudo[2901]: volumio : unable to resolve host volumio: System error Feb 08 05:39:13 volumio sudo[2901]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 08 05:39:13 volumio sudo[2903]: volumio : unable to resolve host volumio: System error Feb 08 05:39:13 volumio sudo[2901]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 05:39:13 volumio sudo[2903]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 08 05:39:13 volumio sudo[2901]: pam_unix(sudo:session): session closed for user root Feb 08 05:39:13 volumio volumio[2871]: info: Loading plugin "services"... Feb 08 05:39:13 volumio sudo[2903]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 05:39:13 volumio sudo[2910]: volumio : unable to resolve host volumio: System error Feb 08 05:39:13 volumio volumio[2871]: info: Loading plugin "alsa_controller"... Feb 08 05:39:13 volumio sudo[2903]: pam_unix(sudo:session): session closed for user root Feb 08 05:39:13 volumio sudo[2910]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Feb 08 05:39:13 volumio sudo[2910]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 05:39:13 volumio volumio[2871]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 08 05:39:13 volumio volumio[2871]: info: Loading plugin "wizard"... Feb 08 05:39:13 volumio volumio[2871]: info: Loading plugin "networkfs"... Feb 08 05:39:13 volumio volumio[2871]: info: Starting Udev Watcher for removable devices Feb 08 05:39:13 volumio volumio[2871]: info: Ignoring mount for partition: boot Feb 08 05:39:13 volumio volumio[2871]: info: Ignoring mount for partition: volumio Feb 08 05:39:13 volumio volumio[2871]: info: Ignoring mount for partition: volumio_data Feb 08 05:39:13 volumio volumio[2871]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 08 05:39:13 volumio volumio[2871]: info: Loading plugin "volumio_command_line_client"... Feb 08 05:39:13 volumio volumio[2871]: info: Loading plugin "upnp"... Feb 08 05:39:13 volumio volumio[2871]: info: [1770525553172] Starting Upmpd Daemon Feb 08 05:39:13 volumio volumio[2871]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 08 05:39:13 volumio volumio[2871]: info: Loading plugin "my_music"... Feb 08 05:39:13 volumio volumio[2871]: info: Loading plugin "mpd"... Feb 08 05:39:13 volumio volumio[2871]: info: Loading plugin "upnp_browser"... Feb 08 05:39:14 volumio volumio[2871]: info: Starting UPNP Browser Feb 08 05:39:14 volumio volumio[2871]: info: Loading plugin "alarm-clock"... Feb 08 05:39:14 volumio volumio[2871]: info: Loading plugin "airplay_emulation"... Feb 08 05:39:14 volumio volumio[2871]: info: Starting Shairport Sync Feb 08 05:39:14 volumio volumio[2871]: info: Loading plugin "last_100"... Feb 08 05:39:14 volumio volumio[2871]: info: Loading plugin "webradio"... Feb 08 05:39:14 volumio volumio[2871]: info: Loading plugin "i2s_dacs"... Feb 08 05:39:14 volumio volumio[2871]: info: I2S DAC not set, start Auto-detection Feb 08 05:39:14 volumio volumio[2871]: info: Loading plugin "volumiodiscovery"... Feb 08 05:39:14 volumio volumio[2871]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 08 05:39:14 volumio volumio[2871]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 08 05:39:14 volumio volumio[2871]: *** WARNING *** For more information see Feb 08 05:39:14 volumio volumio[2871]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 08 05:39:14 volumio volumio[2871]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 08 05:39:14 volumio volumio[2871]: *** WARNING *** For more information see Feb 08 05:39:14 volumio node[2871]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 08 05:39:14 volumio node[2871]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 08 05:39:14 volumio node[2871]: *** WARNING *** For more information see Feb 08 05:39:14 volumio node[2871]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 08 05:39:14 volumio node[2871]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 08 05:39:14 volumio node[2871]: *** WARNING *** For more information see Feb 08 05:39:14 volumio volumio[2871]: info: Applying required configuration parameters for plugin volumiodiscovery Feb 08 05:39:14 volumio volumio[2871]: info: Discovery: Started advertising with name: Anlægget Feb 08 05:39:14 volumio volumio[2871]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 08 05:39:14 volumio volumio[2871]: info: Loading plugin "squeezelite_mc"... Feb 08 05:39:14 volumio volumio[2871]: info: Loading plugin "outputs"... Feb 08 05:39:14 volumio volumio[2871]: info: Loading plugin "albumart"... Feb 08 05:39:14 volumio volumio[2871]: info: Plugin example_plugin is not enabled Feb 08 05:39:14 volumio volumio[2871]: info: Loading plugin "inputs"... Feb 08 05:39:14 volumio volumio[2871]: info: Loading plugin "updater_comm"... Feb 08 05:39:14 volumio volumio[2871]: info: Plugin mpdemulation is not enabled Feb 08 05:39:14 volumio volumio[2871]: info: Loading plugin "rest_api"... Feb 08 05:39:14 volumio volumio[2871]: info: Loading plugin "websocket"... Feb 08 05:39:14 volumio volumio[2871]: info: Starting Socket.io Server version 1.7.4 Feb 08 05:39:14 volumio volumio[2871]: info: Loading i18n strings for locale da Feb 08 05:39:14 volumio volumio[2871]: Updating browse sources language Feb 08 05:39:14 volumio volumio[2871]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 08 05:39:14 volumio volumio[2871]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 08 05:39:14 volumio volumio[2871]: info: CoreCommandRouter::initPlayerControls Feb 08 05:39:14 volumio volumio[2871]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:39:14 volumio volumio[2871]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:39:14 volumio volumio[2871]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:39:14 volumio volumio[2871]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:39:14 volumio volumio[2871]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:39:14 volumio volumio[2871]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:39:14 volumio volumio[2871]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:39:14 volumio volumio[2871]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:39:14 volumio volumio[2871]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 08 05:39:14 volumio volumio[2871]: Express server listening on port 3000 Feb 08 05:39:14 volumio volumio[2871]: [Metrics] WebUI: 3s 218.51ms Feb 08 05:39:14 volumio volumio[2871]: info: CoreStateMachine::resetVolumioState Feb 08 05:39:14 volumio volumio[2871]: info: CoreStateMachine::getcurrentVolume Feb 08 05:39:14 volumio volumio[2871]: info: CoreCommandRouter::volumioRetrievevolume Feb 08 05:39:14 volumio volumio[2871]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 05:39:14 volumio volumio[2871]: info: Volumio Network Manager: Network status updated: 0 Feb 08 05:39:15 volumio volumio[2871]: info: Reloading queue from file Feb 08 05:39:15 volumio volumio[2871]: info: CoreStateMachine::setRepeat null single undefined Feb 08 05:39:15 volumio volumio[2871]: info: CoreStateMachine::pushState Feb 08 05:39:15 volumio volumio[2871]: info: CorePlayQueue::getTrack 0 Feb 08 05:39:15 volumio volumio[2871]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 08 05:39:15 volumio volumio[2871]: info: CoreCommandRouter::volumioPushState Feb 08 05:39:15 volumio volumio[2871]: info: CoreStateMachine::setRandom null Feb 08 05:39:15 volumio volumio[2871]: info: CoreStateMachine::pushState Feb 08 05:39:15 volumio volumio[2871]: info: CorePlayQueue::getTrack 0 Feb 08 05:39:15 volumio volumio[2871]: info: CoreCommandRouter::volumioPushState Feb 08 05:39:15 volumio volumio[2936]: Forking 3 albumart workers Feb 08 05:39:15 volumio volumio[2871]: info: Setting Device type: Raspberry PI Feb 08 05:39:15 volumio volumio[2871]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Feb 08 05:39:15 volumio volumio[2871]: info: USB Boot Capable - System SBC Revision found in cpuinfo: c03111 Feb 08 05:39:15 volumio volumio[2871]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Feb 08 05:39:15 volumio volumio[2871]: info: VolumeController:: Volume=100 Mute =false Feb 08 05:39:15 volumio volumio[2871]: info: CoreStateMachine::pushState Feb 08 05:39:15 volumio volumio[2871]: info: CorePlayQueue::getTrack 0 Feb 08 05:39:15 volumio volumio[2871]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 08 05:39:15 volumio volumio[2871]: info: CoreCommandRouter::volumioPushState Feb 08 05:39:15 volumio volumio[2871]: info: CoreStateMachine::updateTrackBlock Feb 08 05:39:15 volumio volumio[2871]: info: CorePlayQueue::getTrackBlock Feb 08 05:39:15 volumio volumio[2871]: info: CoreCommandRouter::volumioRetrievevolume Feb 08 05:39:15 volumio volumio[2871]: info: Completed loading Core Plugins Feb 08 05:39:15 volumio volumio[2871]: info: Preparing to generate the ALSA configuration file Feb 08 05:39:15 volumio volumio[2871]: info: VolumeController:: Volume=100 Mute =false Feb 08 05:39:15 volumio volumio[2871]: info: CoreStateMachine::pushState Feb 08 05:39:15 volumio volumio[2871]: info: CorePlayQueue::getTrack 0 Feb 08 05:39:15 volumio volumio[2871]: info: CoreCommandRouter::volumioPushState Feb 08 05:39:15 volumio volumio[2871]: info: Asound.conf file unchanged, so no further update is needed Feb 08 05:39:15 volumio volumio[2871]: info: Output device has changed, restarting MPD Feb 08 05:39:15 volumio volumio[2871]: info: Output device has changed, restarting Shairport Sync Feb 08 05:39:15 volumio volumio[2871]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:39:15 volumio volumio[2871]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 05:39:15 volumio sudo[2992]: volumio : unable to resolve host volumio: System error Feb 08 05:39:15 volumio sudo[2994]: volumio : unable to resolve host volumio: System error Feb 08 05:39:15 volumio sudo[2994]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 08 05:39:15 volumio sudo[2994]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 05:39:15 volumio sudo[2992]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 08 05:39:15 volumio sudo[2992]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 05:39:15 volumio sudo[2992]: pam_unix(sudo:session): session closed for user root Feb 08 05:39:15 volumio volumio[2871]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 08 05:39:15 volumio volumio[2871]: info: ___________ START PLUGINS ___________ Feb 08 05:39:15 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Feb 08 05:39:15 volumio volumio[2871]: info: ControllerMpd::onStart: Initializing MPD Feb 08 05:39:15 volumio volumio[2871]: info: Creating MPD Configuration file Feb 08 05:39:15 volumio systemd[1]: mpd.service: Deactivated successfully. Feb 08 05:39:15 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Feb 08 05:39:15 volumio systemd[1]: mpd.service: Consumed 1.506s CPU time. Feb 08 05:39:15 volumio systemd[1]: mpd.socket: Deactivated successfully. Feb 08 05:39:15 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Feb 08 05:39:15 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Feb 08 05:39:15 volumio volumio[2871]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 08 05:39:15 volumio volumio[2871]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 08 05:39:15 volumio volumio[2871]: info: [1770525555294] CoreMusicLibrary::Adding element Medieservere Feb 08 05:39:15 volumio volumio[2871]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 08 05:39:15 volumio sudo[3002]: volumio : unable to resolve host volumio: System error Feb 08 05:39:15 volumio sudo[3002]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 08 05:39:15 volumio sudo[3002]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 05:39:15 volumio sudo[3002]: pam_unix(sudo:session): session closed for user root Feb 08 05:39:15 volumio volumio[2871]: info: UPNP Browser: Client initialized successfully Feb 08 05:39:15 volumio sudo[3004]: volumio : unable to resolve host volumio: System error Feb 08 05:39:15 volumio volumio[2871]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:39:15 volumio volumio[2871]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 05:39:15 volumio sudo[3004]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 08 05:39:15 volumio sudo[3004]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 05:39:15 volumio volumio[2871]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 08 05:39:15 volumio volumio[2871]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:39:15 volumio volumio[2871]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 05:39:15 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Feb 08 05:39:15 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Feb 08 05:39:15 volumio volumio[2871]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 08 05:39:15 volumio volumio[2871]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 08 05:39:15 volumio volumio[2871]: info: [1770525555385] CoreMusicLibrary::Adding element Last_100 Feb 08 05:39:15 volumio volumio[2871]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 08 05:39:15 volumio volumio[2871]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 08 05:39:15 volumio volumio[2871]: info: [1770525555388] CoreMusicLibrary::Adding element Webradio Feb 08 05:39:15 volumio volumio[2871]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 08 05:39:15 volumio volumio[2871]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 08 05:39:15 volumio volumio[2871]: info: Initializing BBC Radios Feb 08 05:39:15 volumio systemd[1]: mpd.service: Deactivated successfully. Feb 08 05:39:15 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Feb 08 05:39:15 volumio systemd[1]: mpd.socket: Deactivated successfully. Feb 08 05:39:15 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Feb 08 05:39:15 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Feb 08 05:39:15 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Feb 08 05:39:15 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Feb 08 05:39:15 volumio volumio[2871]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 08 05:39:15 volumio volumio[2871]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 05:39:15 volumio volumio[2871]: info: [squeezelite_mc] Starting proxy server... Feb 08 05:39:15 volumio volumio[2871]: info: Volumio Calling Home Feb 08 05:39:15 volumio sudo[3022]: root : unable to resolve host volumio: System error Feb 08 05:39:15 volumio sudo[3022]: sudo: unable to resolve host volumio: System error Feb 08 05:39:15 volumio sudo[3022]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 08 05:39:15 volumio sudo[3022]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 08 05:39:15 volumio sudo[3022]: pam_unix(sudo:session): session closed for user root Feb 08 05:39:15 volumio volumio[2871]: info: [squeezelite_mc] Proxy server started on port 42499 Feb 08 05:39:15 volumio sudo[2910]: pam_unix(sudo:session): session closed for user root Feb 08 05:39:15 volumio volumio[2871]: info: CoreCommandRouter::volumioRetrievevolume Feb 08 05:39:15 volumio volumio[2871]: Unhandled rejection Error: No sockets available, cannot start. Feb 08 05:39:15 volumio volumio[2871]: at SSDP._createSockets (/volumio/node_modules/node-ssdp/lib/index.js:186:11) Feb 08 05:39:15 volumio volumio[2871]: at SSDP._start (/volumio/node_modules/node-ssdp/lib/index.js:229:10) Feb 08 05:39:15 volumio volumio[2871]: at /volumio/node_modules/node-ssdp/lib/client.js:60:10 Feb 08 05:39:15 volumio volumio[2871]: at Promise._execute (/volumio/node_modules/bluebird/js/release/debuggability.js:384:9) Feb 08 05:39:15 volumio volumio[2871]: at Promise._resolveFromExecutor (/volumio/node_modules/bluebird/js/release/promise.js:518:18) Feb 08 05:39:15 volumio volumio[2871]: at new Promise (/volumio/node_modules/bluebird/js/release/promise.js:103:10) Feb 08 05:39:15 volumio volumio[2871]: at SsdpClient.start (/volumio/node_modules/node-ssdp/lib/client.js:54:10) Feb 08 05:39:15 volumio volumio[2871]: at SsdpClient.search (/volumio/node_modules/node-ssdp/lib/client.js:82:17) Feb 08 05:39:15 volumio volumio[2871]: at ControllerUPNPBrowser.onStart (/volumio/app/plugins/music_service/upnp_browser/index.js:156:14) Feb 08 05:39:15 volumio volumio[2871]: at PluginManager.startCorePlugin (/volumio/app/pluginmanager.js:398:24) Feb 08 05:39:15 volumio volumio[2871]: at HashMap. (/volumio/app/pluginmanager.js:496:31) Feb 08 05:39:15 volumio volumio[2871]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Feb 08 05:39:15 volumio volumio[2871]: at proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Feb 08 05:39:15 volumio volumio[2871]: at PluginManager.startCorePlugins (/volumio/app/pluginmanager.js:495:20) Feb 08 05:39:15 volumio volumio[2871]: at Promise._successFn (/volumio/app/pluginmanager.js:142:29) Feb 08 05:39:15 volumio volumio[2871]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Feb 08 05:39:16 volumio volumio[2871]: info: MPD Permissions set Feb 08 05:39:16 volumio volumio[2871]: info: MPD Permissions set Feb 08 05:39:16 volumio volumio[2871]: info: Discovery: adding 6a8902c9-5eee-4430-84ba-2ef95c5a1f77 Feb 08 05:39:16 volumio volumio[2871]: info: Discovery: Found device Anlægget Feb 08 05:39:16 volumio volumio[2871]: info: CoreCommandRouter::volumioGetState Feb 08 05:39:16 volumio volumio[2871]: info: CorePlayQueue::getTrack 0 Feb 08 05:39:16 volumio volumio[2871]: info: VolumeController:: Volume=100 Mute =false Feb 08 05:39:16 volumio volumio[2871]: info: CoreStateMachine::pushState Feb 08 05:39:16 volumio volumio[2871]: info: CorePlayQueue::getTrack 0 Feb 08 05:39:16 volumio volumio[2871]: info: CoreCommandRouter::volumioPushState Feb 08 05:39:16 volumio volumio[2871]: info: [squeezelite_mc] Server discovery started Feb 08 05:39:16 volumio volumio[2871]: info: [squeezelite_mc] Player finder started Feb 08 05:39:16 volumio volumio[2871]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:39:16 volumio volumio[2871]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:39:16 volumio volumio[2871]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:39:16 volumio volumio[2871]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 08 05:39:16 volumio volumio[2871]: info: [squeezelite_mc] Executing aplay -D hw:5 --nonblock -f MPEG /dev/zero 2>&1 || true Feb 08 05:39:16 volumio volumio[2871]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 08 05:39:16 volumio volumio[2871]: Error: send ENETUNREACH 255.255.255.255:3483 Feb 08 05:39:16 volumio volumio[2871]: at doSend (node:dgram:717:16) Feb 08 05:39:16 volumio volumio[2871]: at defaultTriggerAsyncIdScope (node:internal/async_hooks:464:18) Feb 08 05:39:16 volumio volumio[2871]: at afterDns (node:dgram:663:5) Feb 08 05:39:16 volumio volumio[2871]: at process.processTicksAndRejections (node:internal/process/task_queues:83:21) { Feb 08 05:39:16 volumio volumio[2871]: errno: -101, Feb 08 05:39:16 volumio volumio[2871]: code: 'ENETUNREACH', Feb 08 05:39:16 volumio volumio[2871]: syscall: 'send', Feb 08 05:39:16 volumio volumio[2871]: address: '255.255.255.255', Feb 08 05:39:16 volumio volumio[2871]: port: 3483 Feb 08 05:39:16 volumio volumio[2871]: } Feb 08 05:39:16 volumio volumio[2871]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 08 05:39:16 volumio volumio[2957]: Starting albumart workers Feb 08 05:39:16 volumio volumio[2960]: Starting albumart workers Feb 08 05:39:16 volumio volumio[2959]: Starting albumart workers Feb 08 05:39:17 volumio sudo[3076]: volumio : unable to resolve host volumio: System error Feb 08 05:39:17 volumio sudo[3076]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-08 05:38' Feb 08 05:39:17 volumio sudo[3076]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 05:39:17 volumio sudo[3076]: pam_unix(sudo:session): session closed for user root Feb 08 05:39:17 volumio volumio[2871]: sudo: unable to resolve host volumio: System error Feb 08 05:39:17 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Feb 08 05:39:17 volumio sudo[2994]: pam_unix(sudo:session): session closed for user root Feb 08 05:39:17 volumio sudo[3004]: pam_unix(sudo:session): session closed for user root Feb 08 05:39:17 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Feb 08 05:39:17 volumio systemd[1]: volumio.service: Consumed 11.969s CPU time. Feb 08 05:39:17 volumio systemd[1]: Started dynamicswap.service - dynamicswap service. Feb 08 05:39:17 volumio systemd[1]: dynamicswap.service: Deactivated successfully. Feb 08 05:39:17 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 99. Feb 08 05:39:17 volumio systemd[1]: Started dynamicswap.service - dynamicswap service. Feb 08 05:39:17 volumio systemd[1]: Stopped volumio.service - Volumio Backend Module. Feb 08 05:39:17 volumio systemd[1]: volumio.service: Consumed 11.969s CPU time. Feb 08 05:39:17 volumio systemd[1]: Started volumio.service - Volumio Backend Module. Feb 08 05:39:17 volumio systemd[1]: dynamicswap.service: Deactivated successfully. Feb 08 05:39:17 volumio mpd[3038]: decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 08 05:39:17 volumio mpd[3038]: output: No 'audio_output' defined in config file Feb 08 05:39:17 volumio mpd[3038]: output: Successfully detected a sndio audio device Feb 08 05:39:17 volumio mpd[3038]: zeroconf: No global port, disabling zeroconf Feb 08 05:39:17 volumio systemd[1]: Started mpd.service - Music Player Daemon. Feb 08 05:39:18 volumio volumio[3091]: info: ------------------------------------------- Feb 08 05:39:18 volumio volumio[3091]: info: ----- Volumio3 ---- Feb 08 05:39:18 volumio volumio[3091]: info: ------------------------------------------- Feb 08 05:39:18 volumio volumio[3091]: info: ----- System startup ---- Feb 08 05:39:18 volumio volumio[3091]: info: ------------------------------------------- Feb 08 05:39:18 volumio volumio[3091]: info: MYVOLUMIO Environment detected Feb 08 05:39:18 volumio volumio[3091]: info: Plugin folders cleanup Feb 08 05:39:18 volumio volumio[3091]: info: Scanning into folder /volumio/app/plugins/ Feb 08 05:39:18 volumio volumio[3091]: info: Scanning category audio_interface Feb 08 05:39:18 volumio volumio[3091]: info: Scanning category miscellanea Feb 08 05:39:18 volumio volumio[3091]: info: Scanning category music_service Feb 08 05:39:18 volumio volumio[3091]: info: Scanning category plugins.json Feb 08 05:39:18 volumio volumio[3091]: info: Scanning category system_controller Feb 08 05:39:18 volumio volumio[3091]: info: Scanning category user_interface Feb 08 05:39:18 volumio volumio[3091]: info: Scanning into folder /data/plugins/ Feb 08 05:39:18 volumio volumio[3091]: info: Scanning category music_service Feb 08 05:39:18 volumio volumio[3091]: info: Plugin folders cleanup completed Feb 08 05:39:18 volumio volumio[3091]: info: ------------------------------------------- Feb 08 05:39:18 volumio volumio[3091]: info: ----- Core plugins startup ---- Feb 08 05:39:18 volumio volumio[3091]: info: ------------------------------------------- Feb 08 05:39:18 volumio volumio[3091]: info: Loading plugins from folder /volumio/app/plugins/ Feb 08 05:39:18 volumio volumio[3091]: info: Adding plugin upnp to MyMusic Plugins Feb 08 05:39:18 volumio volumio[3091]: info: Adding plugin airplay_emulation to MyMusic Plugins Feb 08 05:39:18 volumio volumio[3091]: info: Adding plugin upnp_browser to MyMusic Plugins Feb 08 05:39:18 volumio volumio[3091]: info: Loading plugins from folder /data/plugins/ Feb 08 05:39:18 volumio volumio[3091]: info: Loading plugin "system"... Feb 08 05:39:18 volumio volumio[3091]: info: Loading plugin "appearance"... Feb 08 05:39:19 volumio wpa_supplicant[2840]: wlan0: Failed to initiate sched scan Feb 08 05:39:19 volumio volumio[3091]: info: Loading plugin "network"... Feb 08 05:39:19 volumio volumio[3091]: info: Refreshing Cached IP Addresses Feb 08 05:39:19 volumio sudo[3121]: volumio : unable to resolve host volumio: System error Feb 08 05:39:19 volumio sudo[3123]: volumio : unable to resolve host volumio: System error Feb 08 05:39:19 volumio sudo[3121]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 08 05:39:19 volumio sudo[3123]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 08 05:39:19 volumio sudo[3123]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 05:39:19 volumio sudo[3121]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 05:39:19 volumio volumio[3091]: info: Loading plugin "services"... Feb 08 05:39:19 volumio sudo[3123]: pam_unix(sudo:session): session closed for user root Feb 08 05:39:19 volumio sudo[3121]: pam_unix(sudo:session): session closed for user root Feb 08 05:39:19 volumio volumio[3091]: info: Loading plugin "alsa_controller"... Feb 08 05:39:19 volumio sudo[3130]: volumio : unable to resolve host volumio: System error Feb 08 05:39:19 volumio sudo[3130]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Feb 08 05:39:19 volumio sudo[3130]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 05:39:19 volumio volumio[3091]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 08 05:39:19 volumio volumio[3091]: info: Loading plugin "wizard"... Feb 08 05:39:19 volumio volumio[3091]: info: Loading plugin "networkfs"... Feb 08 05:39:19 volumio volumio[3091]: info: Starting Udev Watcher for removable devices Feb 08 05:39:19 volumio volumio[3091]: info: Ignoring mount for partition: boot Feb 08 05:39:19 volumio volumio[3091]: info: Ignoring mount for partition: volumio Feb 08 05:39:19 volumio volumio[3091]: info: Ignoring mount for partition: volumio_data Feb 08 05:39:19 volumio volumio[3091]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 08 05:39:19 volumio volumio[3091]: info: Loading plugin "volumio_command_line_client"... Feb 08 05:39:19 volumio volumio[3091]: info: Loading plugin "upnp"... Feb 08 05:39:19 volumio volumio[3091]: info: [1770525559597] Starting Upmpd Daemon Feb 08 05:39:19 volumio volumio[3091]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 08 05:39:19 volumio volumio[3091]: info: Loading plugin "my_music"... Feb 08 05:39:19 volumio volumio[3091]: info: Loading plugin "mpd"... Feb 08 05:39:19 volumio volumio[3091]: info: Loading plugin "upnp_browser"... Feb 08 05:39:20 volumio volumio[3091]: info: Starting UPNP Browser Feb 08 05:39:20 volumio volumio[3091]: info: Loading plugin "alarm-clock"... Feb 08 05:39:20 volumio volumio[3091]: info: Loading plugin "airplay_emulation"... Feb 08 05:39:20 volumio volumio[3091]: info: Starting Shairport Sync Feb 08 05:39:20 volumio volumio[3091]: info: Loading plugin "last_100"... Feb 08 05:39:20 volumio volumio[3091]: info: Loading plugin "webradio"... Feb 08 05:39:20 volumio volumio[3091]: info: Loading plugin "i2s_dacs"... Feb 08 05:39:20 volumio volumio[3091]: info: I2S DAC not set, start Auto-detection Feb 08 05:39:20 volumio volumio[3091]: info: Loading plugin "volumiodiscovery"... Feb 08 05:39:20 volumio volumio-remote-updater[2374]: [2026-02-08 04:39:20] [connect] Successful connection Feb 08 05:39:20 volumio volumio[3091]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 08 05:39:20 volumio volumio[3091]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 08 05:39:20 volumio volumio[3091]: *** WARNING *** For more information see Feb 08 05:39:20 volumio volumio[3091]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 08 05:39:20 volumio volumio[3091]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 08 05:39:20 volumio node[3091]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 08 05:39:20 volumio volumio[3091]: *** WARNING *** For more information see Feb 08 05:39:20 volumio node[3091]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 08 05:39:20 volumio node[3091]: *** WARNING *** For more information see Feb 08 05:39:20 volumio node[3091]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 08 05:39:20 volumio node[3091]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 08 05:39:20 volumio node[3091]: *** WARNING *** For more information see Feb 08 05:39:20 volumio volumio[3091]: info: Applying required configuration parameters for plugin volumiodiscovery Feb 08 05:39:20 volumio volumio[3091]: info: Discovery: Started advertising with name: Anlægget Feb 08 05:39:20 volumio volumio[3091]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 08 05:39:20 volumio volumio[3091]: info: Loading plugin "squeezelite_mc"... Feb 08 05:39:21 volumio volumio[3091]: info: Loading plugin "outputs"... Feb 08 05:39:21 volumio volumio[3091]: info: Loading plugin "albumart"... Feb 08 05:39:21 volumio volumio[3091]: info: Plugin example_plugin is not enabled Feb 08 05:39:21 volumio volumio[3091]: info: Loading plugin "inputs"... Feb 08 05:39:21 volumio volumio[3091]: info: Loading plugin "updater_comm"... Feb 08 05:39:21 volumio volumio[3091]: info: Plugin mpdemulation is not enabled Feb 08 05:39:21 volumio volumio[3091]: info: Loading plugin "rest_api"... Feb 08 05:39:21 volumio volumio[3091]: info: Loading plugin "websocket"... Feb 08 05:39:21 volumio volumio[3091]: info: Starting Socket.io Server version 1.7.4 Feb 08 05:39:21 volumio volumio[3091]: info: Loading i18n strings for locale da Feb 08 05:39:21 volumio volumio[3091]: Updating browse sources language Feb 08 05:39:21 volumio volumio[3091]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 08 05:39:21 volumio volumio[3091]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 08 05:39:21 volumio volumio[3091]: info: CoreCommandRouter::initPlayerControls Feb 08 05:39:21 volumio volumio[3091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:39:21 volumio volumio[3091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:39:21 volumio volumio[3091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:39:21 volumio volumio[3091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:39:21 volumio volumio[3091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:39:21 volumio volumio[3091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:39:21 volumio volumio[3091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:39:21 volumio volumio[3091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:39:21 volumio volumio[3091]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 08 05:39:21 volumio volumio[3091]: Express server listening on port 3000 Feb 08 05:39:21 volumio volumio[3091]: [Metrics] WebUI: 3s 203.82ms Feb 08 05:39:21 volumio volumio[3091]: info: CoreStateMachine::resetVolumioState Feb 08 05:39:21 volumio volumio[3091]: info: CoreStateMachine::getcurrentVolume Feb 08 05:39:21 volumio volumio[3091]: info: CoreCommandRouter::volumioRetrievevolume Feb 08 05:39:21 volumio volumio[3091]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 05:39:21 volumio volumio[3091]: info: Volumio Network Manager: Network status updated: 0 Feb 08 05:39:21 volumio volumio-remote-updater[2374]: [2026-02-08 04:39:21] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=3&transport=websocket&t=1770525560 101 Feb 08 05:39:21 volumio volumio[3156]: Forking 3 albumart workers Feb 08 05:39:21 volumio volumio[3091]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 3 Transport: websocket Total Clients: 1 Feb 08 05:39:21 volumio volumio[3091]: info: VolumeController:: Volume=100 Mute =false Feb 08 05:39:21 volumio volumio[3091]: info: CoreStateMachine::pushState Feb 08 05:39:21 volumio volumio[3091]: info: CorePlayQueue::getTrack 0 Feb 08 05:39:21 volumio volumio[3091]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 08 05:39:21 volumio volumio[3091]: info: CoreCommandRouter::volumioPushState Feb 08 05:39:21 volumio volumio[3091]: info: CoreStateMachine::updateTrackBlock Feb 08 05:39:21 volumio volumio[3091]: info: CorePlayQueue::getTrackBlock Feb 08 05:39:21 volumio volumio[3091]: info: CoreCommandRouter::volumioRetrievevolume Feb 08 05:39:21 volumio volumio[3091]: info: Reloading queue from file Feb 08 05:39:21 volumio volumio[3091]: info: CoreStateMachine::setRepeat null single undefined Feb 08 05:39:21 volumio volumio[3091]: info: CoreStateMachine::pushState Feb 08 05:39:21 volumio volumio[3091]: info: CorePlayQueue::getTrack 0 Feb 08 05:39:21 volumio volumio[3091]: info: CoreCommandRouter::volumioPushState Feb 08 05:39:21 volumio volumio[3091]: info: CoreStateMachine::setRandom null Feb 08 05:39:21 volumio volumio[3091]: info: CoreStateMachine::pushState Feb 08 05:39:21 volumio volumio[3091]: info: CorePlayQueue::getTrack 0 Feb 08 05:39:21 volumio volumio[3091]: info: CoreCommandRouter::volumioPushState Feb 08 05:39:21 volumio volumio[3091]: info: Setting Device type: Raspberry PI Feb 08 05:39:21 volumio volumio[3091]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Feb 08 05:39:21 volumio volumio[3091]: info: USB Boot Capable - System SBC Revision found in cpuinfo: c03111 Feb 08 05:39:21 volumio volumio[3091]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Feb 08 05:39:21 volumio volumio[3091]: info: Discovery: adding 6a8902c9-5eee-4430-84ba-2ef95c5a1f77 Feb 08 05:39:21 volumio volumio[3091]: info: Discovery: Found device Anlægget Feb 08 05:39:21 volumio volumio[3091]: info: CoreCommandRouter::volumioGetState Feb 08 05:39:21 volumio volumio[3091]: info: CorePlayQueue::getTrack 0 Feb 08 05:39:21 volumio volumio[3091]: info: VolumeController:: Volume=100 Mute =false Feb 08 05:39:21 volumio volumio[3091]: info: CoreStateMachine::pushState Feb 08 05:39:21 volumio volumio[3091]: info: CorePlayQueue::getTrack 0 Feb 08 05:39:21 volumio volumio[3091]: info: CoreCommandRouter::volumioPushState Feb 08 05:39:21 volumio volumio[3091]: info: Completed loading Core Plugins Feb 08 05:39:21 volumio volumio[3091]: info: Preparing to generate the ALSA configuration file Feb 08 05:39:21 volumio volumio[3091]: info: Asound.conf file unchanged, so no further update is needed Feb 08 05:39:21 volumio volumio[3091]: info: Output device has changed, restarting MPD Feb 08 05:39:21 volumio volumio[3091]: info: Output device has changed, restarting Shairport Sync Feb 08 05:39:21 volumio volumio[3091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:39:21 volumio volumio[3091]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 05:39:21 volumio sudo[3211]: volumio : unable to resolve host volumio: System error Feb 08 05:39:21 volumio sudo[3211]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 08 05:39:21 volumio sudo[3211]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 05:39:21 volumio volumio[3091]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 08 05:39:21 volumio volumio[3091]: info: ___________ START PLUGINS ___________ Feb 08 05:39:21 volumio sudo[3214]: volumio : unable to resolve host volumio: System error Feb 08 05:39:21 volumio volumio[3091]: info: ControllerMpd::onStart: Initializing MPD Feb 08 05:39:21 volumio volumio[3091]: info: Creating MPD Configuration file Feb 08 05:39:21 volumio sudo[3211]: pam_unix(sudo:session): session closed for user root Feb 08 05:39:21 volumio sudo[3214]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 08 05:39:21 volumio sudo[3214]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 05:39:21 volumio volumio[3091]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 08 05:39:21 volumio volumio[3091]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 08 05:39:21 volumio volumio[3091]: info: [1770525561743] CoreMusicLibrary::Adding element Medieservere Feb 08 05:39:21 volumio volumio[3091]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 08 05:39:21 volumio sudo[3221]: volumio : unable to resolve host volumio: System error Feb 08 05:39:21 volumio sudo[3222]: volumio : unable to resolve host volumio: System error Feb 08 05:39:21 volumio volumio[3091]: info: UPNP Browser: Client initialized successfully Feb 08 05:39:21 volumio volumio[3091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:39:21 volumio volumio[3091]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 05:39:21 volumio sudo[3221]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 08 05:39:21 volumio sudo[3221]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 05:39:21 volumio sudo[3222]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 08 05:39:21 volumio sudo[3222]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 05:39:21 volumio sudo[3221]: pam_unix(sudo:session): session closed for user root Feb 08 05:39:21 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Feb 08 05:39:21 volumio volumio[3091]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 08 05:39:21 volumio volumio[3091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:39:21 volumio volumio[3091]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 05:39:21 volumio volumio[3091]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 08 05:39:21 volumio volumio[3091]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 08 05:39:21 volumio volumio[3091]: info: [1770525561830] CoreMusicLibrary::Adding element Last_100 Feb 08 05:39:21 volumio volumio[3091]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 08 05:39:21 volumio systemd[1]: mpd.service: Deactivated successfully. Feb 08 05:39:21 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Feb 08 05:39:21 volumio systemd[1]: mpd.service: Consumed 1.912s CPU time. Feb 08 05:39:21 volumio systemd[1]: mpd.socket: Deactivated successfully. Feb 08 05:39:21 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Feb 08 05:39:21 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Feb 08 05:39:21 volumio volumio[3091]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 08 05:39:21 volumio volumio[3091]: info: [1770525561841] CoreMusicLibrary::Adding element Webradio Feb 08 05:39:21 volumio volumio[3091]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 08 05:39:21 volumio volumio[3091]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 08 05:39:21 volumio volumio[3091]: info: Initializing BBC Radios Feb 08 05:39:21 volumio volumio[3091]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 08 05:39:21 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Feb 08 05:39:21 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Feb 08 05:39:21 volumio volumio[3091]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 05:39:21 volumio volumio[3091]: info: [squeezelite_mc] Starting proxy server... Feb 08 05:39:21 volumio volumio[3091]: info: Volumio Calling Home Feb 08 05:39:22 volumio sudo[3255]: root : unable to resolve host volumio: System error Feb 08 05:39:22 volumio sudo[3255]: sudo: unable to resolve host volumio: System error Feb 08 05:39:22 volumio sudo[3255]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 08 05:39:22 volumio sudo[3255]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 08 05:39:22 volumio sudo[3255]: pam_unix(sudo:session): session closed for user root Feb 08 05:39:22 volumio volumio[3091]: info: [squeezelite_mc] Proxy server started on port 33583 Feb 08 05:39:22 volumio sudo[3130]: pam_unix(sudo:session): session closed for user root Feb 08 05:39:22 volumio volumio[3171]: Starting albumart workers Feb 08 05:39:22 volumio volumio[3173]: Starting albumart workers Feb 08 05:39:22 volumio volumio[3172]: Starting albumart workers Feb 08 05:39:22 volumio volumio[3091]: info: CoreCommandRouter::volumioRetrievevolume Feb 08 05:39:22 volumio volumio[3091]: Unhandled rejection Error: No sockets available, cannot start. Feb 08 05:39:22 volumio volumio[3091]: at SSDP._createSockets (/volumio/node_modules/node-ssdp/lib/index.js:186:11) Feb 08 05:39:22 volumio volumio[3091]: at SSDP._start (/volumio/node_modules/node-ssdp/lib/index.js:229:10) Feb 08 05:39:22 volumio volumio[3091]: at /volumio/node_modules/node-ssdp/lib/client.js:60:10 Feb 08 05:39:22 volumio volumio[3091]: at Promise._execute (/volumio/node_modules/bluebird/js/release/debuggability.js:384:9) Feb 08 05:39:22 volumio volumio[3091]: at Promise._resolveFromExecutor (/volumio/node_modules/bluebird/js/release/promise.js:518:18) Feb 08 05:39:22 volumio volumio[3091]: at new Promise (/volumio/node_modules/bluebird/js/release/promise.js:103:10) Feb 08 05:39:22 volumio volumio[3091]: at SsdpClient.start (/volumio/node_modules/node-ssdp/lib/client.js:54:10) Feb 08 05:39:22 volumio volumio[3091]: at SsdpClient.search (/volumio/node_modules/node-ssdp/lib/client.js:82:17) Feb 08 05:39:22 volumio volumio[3091]: at ControllerUPNPBrowser.onStart (/volumio/app/plugins/music_service/upnp_browser/index.js:156:14) Feb 08 05:39:22 volumio volumio[3091]: at PluginManager.startCorePlugin (/volumio/app/pluginmanager.js:398:24) Feb 08 05:39:22 volumio volumio[3091]: at HashMap. (/volumio/app/pluginmanager.js:496:31) Feb 08 05:39:22 volumio volumio[3091]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Feb 08 05:39:22 volumio volumio[3091]: at proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Feb 08 05:39:22 volumio volumio[3091]: at PluginManager.startCorePlugins (/volumio/app/pluginmanager.js:495:20) Feb 08 05:39:22 volumio volumio[3091]: at Promise._successFn (/volumio/app/pluginmanager.js:142:29) Feb 08 05:39:22 volumio volumio[3091]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Feb 08 05:39:22 volumio volumio[3091]: info: MPD Permissions set Feb 08 05:39:22 volumio volumio[3091]: info: MPD Permissions set Feb 08 05:39:22 volumio volumio[3091]: info: VolumeController:: Volume=100 Mute =false Feb 08 05:39:22 volumio volumio[3091]: info: CoreStateMachine::pushState Feb 08 05:39:22 volumio volumio[3091]: info: CorePlayQueue::getTrack 0 Feb 08 05:39:22 volumio volumio[3091]: info: CoreCommandRouter::volumioPushState Feb 08 05:39:22 volumio volumio[3091]: info: [squeezelite_mc] Server discovery started Feb 08 05:39:22 volumio volumio[3091]: info: [squeezelite_mc] Player finder started Feb 08 05:39:22 volumio volumio[3091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:39:22 volumio volumio[3091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:39:22 volumio volumio[3091]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:39:22 volumio volumio[3091]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 08 05:39:22 volumio volumio[3091]: info: [squeezelite_mc] Executing aplay -D hw:5 --nonblock -f MPEG /dev/zero 2>&1 || true Feb 08 05:39:22 volumio volumio[3091]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 08 05:39:22 volumio volumio[3091]: Error: send ENETUNREACH 255.255.255.255:3483 Feb 08 05:39:22 volumio volumio[3091]: at doSend (node:dgram:717:16) Feb 08 05:39:22 volumio volumio[3091]: at defaultTriggerAsyncIdScope (node:internal/async_hooks:464:18) Feb 08 05:39:22 volumio volumio[3091]: at afterDns (node:dgram:663:5) Feb 08 05:39:22 volumio volumio[3091]: at process.processTicksAndRejections (node:internal/process/task_queues:83:21) { Feb 08 05:39:22 volumio volumio[3091]: errno: -101, Feb 08 05:39:22 volumio volumio[3091]: code: 'ENETUNREACH', Feb 08 05:39:22 volumio volumio[3091]: syscall: 'send', Feb 08 05:39:22 volumio volumio[3091]: address: '255.255.255.255', Feb 08 05:39:22 volumio volumio[3091]: port: 3483 Feb 08 05:39:22 volumio volumio[3091]: } Feb 08 05:39:22 volumio volumio[3091]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 08 05:39:23 volumio sudo[3298]: volumio : unable to resolve host volumio: System error Feb 08 05:39:23 volumio sudo[3298]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-08 05:38' Feb 08 05:39:23 volumio sudo[3298]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 05:39:23 volumio sudo[3298]: pam_unix(sudo:session): session closed for user root Feb 08 05:39:23 volumio volumio[3091]: sudo: unable to resolve host volumio: System error Feb 08 05:39:23 volumio volumio-remote-updater[2374]: [2026-02-08 04:39:23] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Feb 08 05:39:23 volumio volumio-remote-updater[2374]: [2026-02-08 04:39:23] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Feb 08 05:39:23 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Feb 08 05:39:23 volumio sudo[3222]: pam_unix(sudo:session): session closed for user root Feb 08 05:39:23 volumio sudo[3214]: pam_unix(sudo:session): session closed for user root Feb 08 05:39:23 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Feb 08 05:39:23 volumio systemd[1]: volumio.service: Consumed 11.831s CPU time. Feb 08 05:39:23 volumio systemd[1]: Started dynamicswap.service - dynamicswap service. Feb 08 05:39:23 volumio systemd[1]: dynamicswap.service: Deactivated successfully. Feb 08 05:39:23 volumio mpd[3261]: decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 08 05:39:23 volumio mpd[3261]: output: No 'audio_output' defined in config file Feb 08 05:39:23 volumio mpd[3261]: output: Successfully detected a sndio audio device Feb 08 05:39:23 volumio mpd[3261]: zeroconf: No global port, disabling zeroconf Feb 08 05:39:23 volumio systemd[1]: Started mpd.service - Music Player Daemon. Feb 08 05:39:23 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 100. Feb 08 05:39:23 volumio systemd[1]: Started dynamicswap.service - dynamicswap service. Feb 08 05:39:23 volumio systemd[1]: Stopped volumio.service - Volumio Backend Module. Feb 08 05:39:23 volumio systemd[1]: volumio.service: Consumed 11.831s CPU time. Feb 08 05:39:23 volumio systemd[1]: Started volumio.service - Volumio Backend Module. Feb 08 05:39:23 volumio systemd[1]: dynamicswap.service: Deactivated successfully. Feb 08 05:39:24 volumio volumio[3315]: info: ------------------------------------------- Feb 08 05:39:24 volumio volumio[3315]: info: ----- Volumio3 ---- Feb 08 05:39:24 volumio volumio[3315]: info: ------------------------------------------- Feb 08 05:39:24 volumio volumio[3315]: info: ----- System startup ---- Feb 08 05:39:24 volumio volumio[3315]: info: ------------------------------------------- Feb 08 05:39:25 volumio volumio[3315]: info: MYVOLUMIO Environment detected Feb 08 05:39:25 volumio volumio[3315]: info: Plugin folders cleanup Feb 08 05:39:25 volumio volumio[3315]: info: Scanning into folder /volumio/app/plugins/ Feb 08 05:39:25 volumio volumio[3315]: info: Scanning category audio_interface Feb 08 05:39:25 volumio volumio[3315]: info: Scanning category miscellanea Feb 08 05:39:25 volumio volumio[3315]: info: Scanning category music_service Feb 08 05:39:25 volumio volumio[3315]: info: Scanning category plugins.json Feb 08 05:39:25 volumio volumio[3315]: info: Scanning category system_controller Feb 08 05:39:25 volumio volumio[3315]: info: Scanning category user_interface Feb 08 05:39:25 volumio volumio[3315]: info: Scanning into folder /data/plugins/ Feb 08 05:39:25 volumio volumio[3315]: info: Scanning category music_service Feb 08 05:39:25 volumio volumio[3315]: info: Plugin folders cleanup completed Feb 08 05:39:25 volumio volumio[3315]: info: ------------------------------------------- Feb 08 05:39:25 volumio volumio[3315]: info: ----- Core plugins startup ---- Feb 08 05:39:25 volumio volumio[3315]: info: ------------------------------------------- Feb 08 05:39:25 volumio volumio[3315]: info: Loading plugins from folder /volumio/app/plugins/ Feb 08 05:39:25 volumio volumio[3315]: info: Adding plugin upnp to MyMusic Plugins Feb 08 05:39:25 volumio volumio[3315]: info: Adding plugin airplay_emulation to MyMusic Plugins Feb 08 05:39:25 volumio volumio[3315]: info: Adding plugin upnp_browser to MyMusic Plugins Feb 08 05:39:25 volumio volumio[3315]: info: Loading plugins from folder /data/plugins/ Feb 08 05:39:25 volumio volumio[3315]: info: Loading plugin "system"... Feb 08 05:39:25 volumio volumio[3315]: info: Loading plugin "appearance"... Feb 08 05:39:25 volumio volumio[3315]: info: Loading plugin "network"... Feb 08 05:39:25 volumio volumio[3315]: info: Refreshing Cached IP Addresses Feb 08 05:39:26 volumio sudo[3343]: volumio : unable to resolve host volumio: System error Feb 08 05:39:26 volumio sudo[3345]: volumio : unable to resolve host volumio: System error Feb 08 05:39:26 volumio sudo[3343]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 08 05:39:26 volumio sudo[3343]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 05:39:26 volumio sudo[3345]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 08 05:39:26 volumio sudo[3345]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 05:39:26 volumio volumio[3315]: info: Loading plugin "services"... Feb 08 05:39:26 volumio volumio[3315]: info: Loading plugin "alsa_controller"... Feb 08 05:39:26 volumio sudo[3352]: volumio : unable to resolve host volumio: System error Feb 08 05:39:26 volumio sudo[3345]: pam_unix(sudo:session): session closed for user root Feb 08 05:39:26 volumio sudo[3352]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Feb 08 05:39:26 volumio sudo[3352]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 05:39:26 volumio sudo[3343]: pam_unix(sudo:session): session closed for user root Feb 08 05:39:26 volumio sudo[3352]: pam_unix(sudo:session): session closed for user root Feb 08 05:39:26 volumio volumio[3315]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 08 05:39:26 volumio volumio[3315]: info: Loading plugin "wizard"... Feb 08 05:39:26 volumio volumio[3315]: info: Loading plugin "networkfs"... Feb 08 05:39:26 volumio volumio[3315]: info: Starting Udev Watcher for removable devices Feb 08 05:39:26 volumio volumio[3315]: info: Ignoring mount for partition: boot Feb 08 05:39:26 volumio volumio[3315]: info: Ignoring mount for partition: volumio Feb 08 05:39:26 volumio volumio[3315]: info: Ignoring mount for partition: volumio_data Feb 08 05:39:26 volumio volumio[3315]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 08 05:39:26 volumio volumio[3315]: info: Loading plugin "volumio_command_line_client"... Feb 08 05:39:26 volumio volumio[3315]: info: Loading plugin "upnp"... Feb 08 05:39:26 volumio volumio[3315]: info: [1770525566128] Starting Upmpd Daemon Feb 08 05:39:26 volumio volumio[3315]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 08 05:39:26 volumio volumio[3315]: info: Loading plugin "my_music"... Feb 08 05:39:26 volumio volumio[3315]: info: Loading plugin "mpd"... Feb 08 05:39:26 volumio volumio[3315]: info: Loading plugin "upnp_browser"... Feb 08 05:39:26 volumio wpa_supplicant[2840]: wlan0: Trying to associate with 44:d9:e7:91:5b:88 (SSID='willemoesgade' freq=2437 MHz) Feb 08 05:39:26 volumio wpa_supplicant[2840]: wlan0: Associated with 44:d9:e7:91:5b:88 Feb 08 05:39:26 volumio wpa_supplicant[2840]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Feb 08 05:39:26 volumio wpa_supplicant[2840]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=DK Feb 08 05:39:27 volumio wpa_supplicant[2840]: wlan0: WPA: Key negotiation completed with 44:d9:e7:91:5b:88 [PTK=CCMP GTK=CCMP] Feb 08 05:39:27 volumio wpa_supplicant[2840]: wlan0: CTRL-EVENT-CONNECTED - Connection to 44:d9:e7:91:5b:88 completed [id=0 id_str=] Feb 08 05:39:27 volumio dhcpcd[909]: wlan0: carrier acquired Feb 08 05:39:27 volumio dhcpcd[909]: wlan0: IAID 32:62:a9:14 Feb 08 05:39:27 volumio wpa_supplicant[2840]: wlan0: RRM: Unexpected neighbor report Feb 08 05:39:27 volumio volumio[3315]: info: Starting UPNP Browser Feb 08 05:39:27 volumio volumio[3315]: info: Loading plugin "alarm-clock"... Feb 08 05:39:27 volumio volumio[3315]: info: Loading plugin "airplay_emulation"... Feb 08 05:39:27 volumio volumio[3315]: info: Starting Shairport Sync Feb 08 05:39:27 volumio volumio[3315]: info: Loading plugin "last_100"... Feb 08 05:39:27 volumio volumio[3315]: info: Loading plugin "webradio"... Feb 08 05:39:27 volumio dhcpcd[909]: wlan0: soliciting a DHCP lease Feb 08 05:39:27 volumio dhcpcd[909]: wlan0: soliciting an IPv6 router Feb 08 05:39:27 volumio volumio[3315]: info: Loading plugin "i2s_dacs"... Feb 08 05:39:27 volumio volumio[3315]: info: I2S DAC not set, start Auto-detection Feb 08 05:39:27 volumio volumio[3315]: info: Loading plugin "volumiodiscovery"... Feb 08 05:39:27 volumio volumio[3315]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 08 05:39:27 volumio volumio[3315]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 08 05:39:27 volumio volumio[3315]: *** WARNING *** For more information see Feb 08 05:39:27 volumio volumio[3315]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 08 05:39:27 volumio volumio[3315]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 08 05:39:27 volumio volumio[3315]: *** WARNING *** For more information see Feb 08 05:39:27 volumio node[3315]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 08 05:39:27 volumio node[3315]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 08 05:39:27 volumio node[3315]: *** WARNING *** For more information see Feb 08 05:39:27 volumio node[3315]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 08 05:39:27 volumio node[3315]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 08 05:39:27 volumio node[3315]: *** WARNING *** For more information see Feb 08 05:39:27 volumio volumio[3315]: info: Applying required configuration parameters for plugin volumiodiscovery Feb 08 05:39:27 volumio volumio[3315]: info: Discovery: Started advertising with name: Anlægget Feb 08 05:39:27 volumio volumio[3315]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 08 05:39:27 volumio volumio[3315]: info: Loading plugin "squeezelite_mc"... Feb 08 05:39:27 volumio dhcpcd[909]: wlan0: offered 192.168.1.103 from 192.168.1.1 Feb 08 05:39:27 volumio dhcpcd[909]: wlan0: probing address 192.168.1.103/24 Feb 08 05:39:27 volumio volumio[3315]: info: Loading plugin "outputs"... Feb 08 05:39:27 volumio volumio[3315]: info: Loading plugin "albumart"... Feb 08 05:39:27 volumio volumio[3315]: info: Plugin example_plugin is not enabled Feb 08 05:39:27 volumio volumio[3315]: info: Loading plugin "inputs"... Feb 08 05:39:27 volumio volumio[3315]: info: Loading plugin "updater_comm"... Feb 08 05:39:27 volumio volumio[3315]: info: Plugin mpdemulation is not enabled Feb 08 05:39:27 volumio volumio[3315]: info: Loading plugin "rest_api"... Feb 08 05:39:27 volumio volumio[3315]: info: Loading plugin "websocket"... Feb 08 05:39:27 volumio volumio[3315]: info: Starting Socket.io Server version 1.7.4 Feb 08 05:39:27 volumio volumio[3315]: info: Loading i18n strings for locale da Feb 08 05:39:27 volumio volumio[3315]: Updating browse sources language Feb 08 05:39:27 volumio volumio[3315]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 08 05:39:27 volumio volumio[3315]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 08 05:39:27 volumio volumio[3315]: info: CoreCommandRouter::initPlayerControls Feb 08 05:39:27 volumio volumio[3315]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:39:27 volumio volumio[3315]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:39:27 volumio volumio[3315]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:39:27 volumio volumio[3315]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:39:27 volumio volumio[3315]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:39:27 volumio volumio[3315]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:39:27 volumio volumio[3315]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:39:27 volumio volumio[3315]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:39:27 volumio volumio[3315]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 08 05:39:27 volumio volumio[3315]: Express server listening on port 3000 Feb 08 05:39:27 volumio volumio[3315]: [Metrics] WebUI: 3s 202.66ms Feb 08 05:39:27 volumio volumio[3315]: info: CoreStateMachine::resetVolumioState Feb 08 05:39:27 volumio volumio[3315]: info: CoreStateMachine::getcurrentVolume Feb 08 05:39:27 volumio volumio[3315]: info: CoreCommandRouter::volumioRetrievevolume Feb 08 05:39:27 volumio volumio[3315]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 05:39:27 volumio volumio[3315]: info: Volumio Network Manager: Network status updated: 0 Feb 08 05:39:27 volumio volumio[3315]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Feb 08 05:39:27 volumio volumio[3315]: sudo: unable to resolve host volumio: System error Feb 08 05:39:27 volumio volumio[3315]: wlan0 Interface doesn't support scanning : Device or resource busy Feb 08 05:39:27 volumio volumio[3315]: info: Cannot use regular scanning, forcing with ap-force Feb 08 05:39:27 volumio sudo[3399]: volumio : unable to resolve host volumio: System error Feb 08 05:39:27 volumio sudo[3399]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Feb 08 05:39:27 volumio sudo[3399]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 05:39:27 volumio volumio[3381]: Forking 3 albumart workers Feb 08 05:39:28 volumio volumio[3403]: Starting albumart workers Feb 08 05:39:28 volumio volumio[3401]: Starting albumart workers Feb 08 05:39:28 volumio volumio[3402]: Starting albumart workers Feb 08 05:39:28 volumio volumio-remote-updater[2374]: [2026-02-08 04:39:28] [connect] Successful connection Feb 08 05:39:31 volumio sudo[3399]: pam_unix(sudo:session): session closed for user root Feb 08 05:39:31 volumio volumio[3315]: sudo: unable to resolve host volumio: System error Feb 08 05:39:31 volumio volumio[3315]: info: VolumeController:: Volume=100 Mute =false Feb 08 05:39:31 volumio volumio[3315]: info: CoreStateMachine::pushState Feb 08 05:39:31 volumio volumio[3315]: info: CorePlayQueue::getTrack 0 Feb 08 05:39:31 volumio volumio[3315]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 08 05:39:31 volumio volumio[3315]: info: CoreCommandRouter::volumioPushState Feb 08 05:39:31 volumio volumio[3315]: info: CoreStateMachine::updateTrackBlock Feb 08 05:39:31 volumio volumio[3315]: info: CorePlayQueue::getTrackBlock Feb 08 05:39:31 volumio volumio[3315]: info: CoreCommandRouter::volumioRetrievevolume Feb 08 05:39:31 volumio volumio-remote-updater[2374]: [2026-02-08 04:39:31] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=3&transport=websocket&t=1770525568 101 Feb 08 05:39:31 volumio volumio[3315]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 3 Transport: websocket Total Clients: 1 Feb 08 05:39:31 volumio volumio[3315]: info: Reloading queue from file Feb 08 05:39:31 volumio volumio[3315]: info: CoreStateMachine::setRepeat null single undefined Feb 08 05:39:31 volumio volumio[3315]: info: CoreStateMachine::pushState Feb 08 05:39:31 volumio volumio[3315]: info: CorePlayQueue::getTrack 0 Feb 08 05:39:31 volumio volumio[3315]: info: CoreCommandRouter::volumioPushState Feb 08 05:39:31 volumio volumio[3315]: info: CoreStateMachine::setRandom null Feb 08 05:39:31 volumio volumio[3315]: info: CoreStateMachine::pushState Feb 08 05:39:31 volumio volumio[3315]: info: CorePlayQueue::getTrack 0 Feb 08 05:39:31 volumio volumio[3315]: info: CoreCommandRouter::volumioPushState Feb 08 05:39:31 volumio volumio[3315]: info: Setting Device type: Raspberry PI Feb 08 05:39:31 volumio volumio[3315]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Feb 08 05:39:31 volumio volumio[3315]: info: USB Boot Capable - System SBC Revision found in cpuinfo: c03111 Feb 08 05:39:31 volumio volumio[3315]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Feb 08 05:39:31 volumio volumio[3315]: info: VolumeController:: Volume=100 Mute =false Feb 08 05:39:31 volumio volumio[3315]: info: CoreStateMachine::pushState Feb 08 05:39:31 volumio volumio[3315]: info: CorePlayQueue::getTrack 0 Feb 08 05:39:31 volumio volumio[3315]: info: CoreCommandRouter::volumioPushState Feb 08 05:39:31 volumio volumio[3315]: info: Completed loading Core Plugins Feb 08 05:39:31 volumio volumio[3315]: info: Preparing to generate the ALSA configuration file Feb 08 05:39:31 volumio volumio[3315]: info: Discovery: adding 6a8902c9-5eee-4430-84ba-2ef95c5a1f77 Feb 08 05:39:31 volumio volumio[3315]: info: Discovery: Found device Anlægget Feb 08 05:39:31 volumio volumio[3315]: info: CoreCommandRouter::volumioGetState Feb 08 05:39:31 volumio volumio[3315]: info: CorePlayQueue::getTrack 0 Feb 08 05:39:31 volumio volumio[3315]: info: Asound.conf file unchanged, so no further update is needed Feb 08 05:39:31 volumio volumio[3315]: info: Output device has changed, restarting MPD Feb 08 05:39:31 volumio volumio[3315]: info: Output device has changed, restarting Shairport Sync Feb 08 05:39:31 volumio volumio[3315]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:39:31 volumio volumio[3315]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 05:39:31 volumio sudo[3457]: volumio : unable to resolve host volumio: System error Feb 08 05:39:31 volumio sudo[3459]: volumio : unable to resolve host volumio: System error Feb 08 05:39:31 volumio sudo[3457]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 08 05:39:31 volumio sudo[3457]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 05:39:31 volumio sudo[3459]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 08 05:39:31 volumio sudo[3459]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 05:39:31 volumio volumio[3315]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 08 05:39:31 volumio volumio[3315]: info: ___________ START PLUGINS ___________ Feb 08 05:39:31 volumio sudo[3457]: pam_unix(sudo:session): session closed for user root Feb 08 05:39:31 volumio volumio[3315]: info: ControllerMpd::onStart: Initializing MPD Feb 08 05:39:31 volumio volumio[3315]: info: Creating MPD Configuration file Feb 08 05:39:31 volumio sudo[3467]: volumio : unable to resolve host volumio: System error Feb 08 05:39:31 volumio volumio[3315]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 08 05:39:31 volumio volumio[3315]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 08 05:39:31 volumio sudo[3467]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 08 05:39:31 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Feb 08 05:39:31 volumio sudo[3467]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 05:39:31 volumio volumio[3315]: info: [1770525571898] CoreMusicLibrary::Adding element Medieservere Feb 08 05:39:31 volumio volumio[3315]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 08 05:39:31 volumio sudo[3467]: pam_unix(sudo:session): session closed for user root Feb 08 05:39:31 volumio sudo[3469]: volumio : unable to resolve host volumio: System error Feb 08 05:39:31 volumio volumio[3315]: info: UPNP Browser: Client initialized successfully Feb 08 05:39:31 volumio sudo[3469]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 08 05:39:31 volumio sudo[3469]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 08 05:39:31 volumio volumio[3315]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:39:31 volumio volumio[3315]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 05:39:31 volumio volumio[3315]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 08 05:39:31 volumio systemd[1]: mpd.service: Deactivated successfully. Feb 08 05:39:31 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Feb 08 05:39:31 volumio systemd[1]: mpd.service: Consumed 1.865s CPU time. Feb 08 05:39:31 volumio systemd[1]: mpd.socket: Deactivated successfully. Feb 08 05:39:31 volumio volumio[3315]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:39:31 volumio volumio[3315]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 05:39:31 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Feb 08 05:39:31 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Feb 08 05:39:31 volumio volumio[3315]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 08 05:39:31 volumio volumio[3315]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 08 05:39:31 volumio volumio[3315]: info: [1770525571960] CoreMusicLibrary::Adding element Last_100 Feb 08 05:39:31 volumio volumio[3315]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 08 05:39:31 volumio volumio[3315]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 08 05:39:31 volumio volumio[3315]: info: [1770525571962] CoreMusicLibrary::Adding element Webradio Feb 08 05:39:31 volumio volumio[3315]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 08 05:39:31 volumio volumio[3315]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 08 05:39:31 volumio volumio[3315]: info: Initializing BBC Radios Feb 08 05:39:32 volumio volumio[3315]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 08 05:39:32 volumio volumio[3315]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 08 05:39:32 volumio volumio[3315]: info: [squeezelite_mc] Starting proxy server... Feb 08 05:39:32 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Feb 08 05:39:32 volumio volumio[3315]: info: Volumio Calling Home Feb 08 05:39:32 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Feb 08 05:39:32 volumio systemd[1]: mpd.service: Deactivated successfully. Feb 08 05:39:32 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Feb 08 05:39:32 volumio systemd[1]: mpd.socket: Deactivated successfully. Feb 08 05:39:32 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Feb 08 05:39:32 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Feb 08 05:39:32 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Feb 08 05:39:32 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Feb 08 05:39:32 volumio volumio[3315]: info: [squeezelite_mc] Proxy server started on port 43537 Feb 08 05:39:32 volumio sudo[3498]: root : unable to resolve host volumio: System error Feb 08 05:39:32 volumio sudo[3498]: sudo: unable to resolve host volumio: System error Feb 08 05:39:32 volumio sudo[3498]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 08 05:39:32 volumio sudo[3498]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 08 05:39:32 volumio sudo[3498]: pam_unix(sudo:session): session closed for user root Feb 08 05:39:32 volumio volumio[3315]: info: CoreCommandRouter::volumioRetrievevolume Feb 08 05:39:32 volumio volumio[3315]: Unhandled rejection Error: No sockets available, cannot start. Feb 08 05:39:32 volumio volumio[3315]: at SSDP._createSockets (/volumio/node_modules/node-ssdp/lib/index.js:186:11) Feb 08 05:39:32 volumio volumio[3315]: at SSDP._start (/volumio/node_modules/node-ssdp/lib/index.js:229:10) Feb 08 05:39:32 volumio volumio[3315]: at /volumio/node_modules/node-ssdp/lib/client.js:60:10 Feb 08 05:39:32 volumio volumio[3315]: at Promise._execute (/volumio/node_modules/bluebird/js/release/debuggability.js:384:9) Feb 08 05:39:32 volumio volumio[3315]: at Promise._resolveFromExecutor (/volumio/node_modules/bluebird/js/release/promise.js:518:18) Feb 08 05:39:32 volumio volumio[3315]: at new Promise (/volumio/node_modules/bluebird/js/release/promise.js:103:10) Feb 08 05:39:32 volumio volumio[3315]: at SsdpClient.start (/volumio/node_modules/node-ssdp/lib/client.js:54:10) Feb 08 05:39:32 volumio volumio[3315]: at SsdpClient.search (/volumio/node_modules/node-ssdp/lib/client.js:82:17) Feb 08 05:39:32 volumio volumio[3315]: at ControllerUPNPBrowser.onStart (/volumio/app/plugins/music_service/upnp_browser/index.js:156:14) Feb 08 05:39:32 volumio volumio[3315]: at PluginManager.startCorePlugin (/volumio/app/pluginmanager.js:398:24) Feb 08 05:39:32 volumio volumio[3315]: at HashMap. (/volumio/app/pluginmanager.js:496:31) Feb 08 05:39:32 volumio volumio[3315]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Feb 08 05:39:32 volumio volumio[3315]: at proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Feb 08 05:39:32 volumio volumio[3315]: at PluginManager.startCorePlugins (/volumio/app/pluginmanager.js:495:20) Feb 08 05:39:32 volumio volumio[3315]: at Promise._successFn (/volumio/app/pluginmanager.js:142:29) Feb 08 05:39:32 volumio volumio[3315]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Feb 08 05:39:32 volumio volumio[3315]: info: MPD Permissions set Feb 08 05:39:32 volumio volumio[3315]: info: MPD Permissions set Feb 08 05:39:32 volumio volumio[3315]: 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 08 05:39:32 volumio volumio[3315]: info: VolumeController:: Volume=100 Mute =false Feb 08 05:39:32 volumio volumio[3315]: info: CoreStateMachine::pushState Feb 08 05:39:32 volumio volumio[3315]: info: CorePlayQueue::getTrack 0 Feb 08 05:39:32 volumio volumio[3315]: info: CoreCommandRouter::volumioPushState Feb 08 05:39:32 volumio volumio[3315]: info: [squeezelite_mc] Server discovery started Feb 08 05:39:32 volumio volumio[3315]: info: [squeezelite_mc] Player finder started Feb 08 05:39:32 volumio volumio[3315]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:39:32 volumio volumio[3315]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:39:32 volumio volumio[3315]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 08 05:39:32 volumio volumio[3315]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 08 05:39:32 volumio volumio[3315]: info: [squeezelite_mc] Executing aplay -D hw:5 --nonblock -f MPEG /dev/zero 2>&1 || true Feb 08 05:39:32 volumio volumio[3315]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 08 05:39:32 volumio volumio[3315]: Error: send ENETUNREACH 255.255.255.255:3483 Feb 08 05:39:32 volumio volumio[3315]: at doSend (node:dgram:717:16) Feb 08 05:39:32 volumio volumio[3315]: at defaultTriggerAsyncIdScope (node:internal/async_hooks:464:18) Feb 08 05:39:32 volumio volumio[3315]: at afterDns (node:dgram:663:5) Feb 08 05:39:32 volumio volumio[3315]: at process.processTicksAndRejections (node:internal/process/task_queues:83:21) { Feb 08 05:39:32 volumio volumio[3315]: errno: -101, Feb 08 05:39:32 volumio volumio[3315]: code: 'ENETUNREACH', Feb 08 05:39:32 volumio volumio[3315]: syscall: 'send', Feb 08 05:39:32 volumio volumio[3315]: address: '255.255.255.255', Feb 08 05:39:32 volumio volumio[3315]: port: 3483 Feb 08 05:39:32 volumio volumio[3315]: } Feb 08 05:39:32 volumio volumio[3315]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 08 05:39:32 volumio dhcpcd[909]: wlan0: leased 192.168.1.103 for 86400 seconds Feb 08 05:39:32 volumio avahi-daemon[3026]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.103. Feb 08 05:39:32 volumio avahi-daemon[3026]: New relevant interface wlan0.IPv4 for mDNS. Feb 08 05:39:32 volumio avahi-daemon[3026]: Registering new address record for 192.168.1.103 on wlan0.IPv4. Feb 08 05:39:32 volumio dhcpcd[909]: wlan0: adding route to 192.168.1.0/24 Feb 08 05:39:32 volumio dhcpcd[909]: wlan0: adding default route via 192.168.1.1 Feb 08 05:39:32 volumio systemd[1]: Stopped target ip-changed@wlan0.target - IP Address changed on wlan0. Feb 08 05:39:32 volumio systemd[1]: Stopping ip-changed@wlan0.target - IP Address changed on wlan0... Feb 08 05:39:32 volumio systemd[1]: welcome.service: Deactivated successfully. Feb 08 05:39:32 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console. Feb 08 05:39:32 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console... Feb 08 05:39:32 volumio nmbd[2650]: [2026/02/08 05:39:32.523332, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response) Feb 08 05:39:32 volumio nmbd[2650]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.1.103 for name WORKGROUP<1d>. Feb 08 05:39:32 volumio nmbd[2650]: This response was from IP 192.168.1.100, reporting an IP address of 192.168.1.100. Feb 08 05:39:32 volumio systemd[1]: Starting welcome.service - Show a welcome message on console... Feb 08 05:39:32 volumio welcome[3531]: Resolved ip:[1] 192.168.1.103 Feb 08 05:39:32 volumio systemd[1]: Finished welcome.service - Show a welcome message on console. Feb 08 05:39:32 volumio systemd[1]: Reached target ip-changed@wlan0.target - IP Address changed on wlan0. Feb 08 05:39:32 volumio sudo[3547]: volumio : unable to resolve host volumio: System error Feb 08 05:39:32 volumio sudo[3547]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-08 05:38' Feb 08 05:39:32 volumio sudo[3547]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="b05a530ca81d05eb9a84d0acf82089f0a60b8ee6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="4ad85e2147d972f0b838d33c21382d2d813b2ae8" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Dec 25 09:13:19 UTC 2025" VOLUMIO_VERSION="4.084" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="792f09af7488531aecd1aadcaa9b175e"