-- Logs begin at Thu 2019-02-14 13:11:59 MSK, end at Thu 2026-02-26 20:08:41 MSK. -- Feb 26 20:07:01 usic volumio[960]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 26 20:07:06 usic volumio[960]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 26 20:07:10 usic volumio[960]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 26 20:07:14 usic volumio[960]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 26 20:07:18 usic volumio[960]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 26 20:07:22 usic volumio[960]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 26 20:07:26 usic volumio[960]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 26 20:07:30 usic volumio[960]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 26 20:07:34 usic volumio[960]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 26 20:07:35 usic volumio[960]: info: MPD Database updated - AlbumList cache refreshed Feb 26 20:07:35 usic volumio[960]: info: Feb 26 20:07:35 usic volumio[960]: ---------------------------- MPD announces state update: database Feb 26 20:07:35 usic volumio[960]: verbose: ControllerMpd::sendMpdCommand status Feb 26 20:07:35 usic volumio[960]: info: Feb 26 20:07:35 usic volumio[960]: ---------------------------- MPD announces state update: update Feb 26 20:07:35 usic volumio[960]: info: ControllerMpd::getState Feb 26 20:07:35 usic volumio[960]: verbose: ControllerMpd::sendMpdCommand status Feb 26 20:07:35 usic volumio[960]: info: ControllerMpd::getState Feb 26 20:07:35 usic volumio[960]: verbose: ControllerMpd::sendMpdCommand status Feb 26 20:07:36 usic volumio[960]: info: sendMpdCommand status took 240 milliseconds Feb 26 20:07:36 usic volumio[960]: info: sendMpdCommand status took 238 milliseconds Feb 26 20:07:36 usic volumio[960]: info: sendMpdCommand status took 237 milliseconds Feb 26 20:07:36 usic volumio[960]: verbose: ControllerMpd::parseState Feb 26 20:07:36 usic volumio[960]: info: Command Router : Notfying DB Updatefalse Feb 26 20:07:36 usic volumio[960]: info: CoreCommandRouter::Close All Modals sent Feb 26 20:07:36 usic volumio[960]: verbose: ControllerMpd::parseState Feb 26 20:07:36 usic volumio[960]: verbose: ControllerMpd::parseState Feb 26 20:07:36 usic volumio[960]: info: ControllerMpd::pushState Feb 26 20:07:36 usic volumio[960]: info: CoreCommandRouter::servicePushState Feb 26 20:07:36 usic volumio[960]: info: CoreStateMachine::pushState Feb 26 20:07:36 usic volumio[960]: info: CorePlayQueue::getTrack 0 Feb 26 20:07:36 usic volumio[960]: info: CoreCommandRouter::volumioPushState Feb 26 20:07:36 usic volumio[960]: info: CorePlayQueue::getTrack 0 Feb 26 20:07:36 usic volumio[960]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Feb 26 20:07:36 usic volumio[960]: verbose: CURRENT POSITION 0 Feb 26 20:07:36 usic volumio[960]: info: CoreStateMachine::syncState stateService stop Feb 26 20:07:36 usic volumio[960]: info: CoreStateMachine::syncState currentStatus stop Feb 26 20:07:36 usic volumio[960]: info: CoreStateMachine::pushState Feb 26 20:07:36 usic volumio[960]: info: CorePlayQueue::getTrack 0 Feb 26 20:07:36 usic volumio[960]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 26 20:07:36 usic volumio[960]: info: CoreCommandRouter::volumioPushState Feb 26 20:07:36 usic volumio[960]: info: No code Feb 26 20:07:36 usic volumio[960]: info: CoreStateMachine::pushState Feb 26 20:07:36 usic volumio[960]: info: CorePlayQueue::getTrack 0 Feb 26 20:07:36 usic volumio[960]: info: CoreCommandRouter::volumioPushState Feb 26 20:07:36 usic volumio[960]: info: ControllerMpd::pushState Feb 26 20:07:36 usic volumio[960]: info: CoreCommandRouter::servicePushState Feb 26 20:07:36 usic volumio[960]: info: CoreStateMachine::pushState Feb 26 20:07:36 usic volumio[960]: info: CorePlayQueue::getTrack 0 Feb 26 20:07:36 usic volumio[960]: info: CoreCommandRouter::volumioPushState Feb 26 20:07:36 usic volumio[960]: info: CorePlayQueue::getTrack 0 Feb 26 20:07:36 usic volumio[960]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Feb 26 20:07:36 usic volumio[960]: verbose: CURRENT POSITION 0 Feb 26 20:07:36 usic volumio[960]: info: CoreStateMachine::syncState stateService stop Feb 26 20:07:36 usic volumio[960]: info: CoreStateMachine::syncState currentStatus stop Feb 26 20:07:36 usic volumio[960]: info: CoreStateMachine::pushState Feb 26 20:07:36 usic volumio[960]: info: CorePlayQueue::getTrack 0 Feb 26 20:07:36 usic volumio[960]: info: CoreCommandRouter::volumioPushState Feb 26 20:07:36 usic volumio[960]: info: No code Feb 26 20:07:36 usic volumio[960]: info: CoreStateMachine::pushState Feb 26 20:07:36 usic volumio[960]: info: CorePlayQueue::getTrack 0 Feb 26 20:07:36 usic volumio[960]: info: CoreCommandRouter::volumioPushState Feb 26 20:07:36 usic volumio[960]: info: ------------------------------ 402ms Feb 26 20:07:36 usic volumio[960]: info: ------------------------------ 402ms Feb 26 20:07:38 usic volumio[960]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 26 20:07:41 usic volumio[960]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 26 20:07:45 usic volumio[960]: info: CoreCommandRouter::volumioGetState Feb 26 20:07:45 usic volumio[960]: info: CorePlayQueue::getTrack 0 Feb 26 20:07:49 usic volumio[960]: info: CoreCommandRouter::volumioGetQueue Feb 26 20:07:49 usic volumio[960]: info: CoreStateMachine::getQueue Feb 26 20:07:49 usic volumio[960]: info: CorePlayQueue::getQueue Feb 26 20:07:52 usic volumio[960]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Feb 26 20:07:52 usic volumio[960]: info: CURURI: artists:// Feb 26 20:07:52 usic volumio[960]: info: Preload queue cleared Feb 26 20:07:54 usic volumio[960]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 26 20:07:54 usic volumio[960]: Error: getaddrinfo ENOTFOUND cdn-images.dzcdn.net Feb 26 20:07:54 usic volumio[960]: at GetAddrInfoReqWrap.onlookup [as oncomplete] (dns.js:71:26) { Feb 26 20:07:54 usic volumio[960]: errno: -3007, Feb 26 20:07:54 usic volumio[960]: code: 'ENOTFOUND', Feb 26 20:07:54 usic volumio[960]: syscall: 'getaddrinfo', Feb 26 20:07:54 usic volumio[960]: hostname: 'cdn-images.dzcdn.net' Feb 26 20:07:54 usic volumio[960]: } Feb 26 20:07:54 usic volumio[960]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 26 20:07:56 usic sudo[4759]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-02-26 20:06 Feb 26 20:07:56 usic sudo[4759]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 26 20:07:56 usic sudo[4759]: pam_unix(sudo:session): session closed for user root Feb 26 20:08:02 usic volumio-remote-updater[1880]: [2026-02-26 20:08:02] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Feb 26 20:08:02 usic volumio-remote-updater[1880]: [2026-02-26 20:08:02] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Feb 26 20:08:02 usic systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Feb 26 20:08:02 usic systemd[1]: volumio.service: Failed with result 'exit-code'. Feb 26 20:08:02 usic systemd[1]: Started dynamicswap service. Feb 26 20:08:02 usic systemd[1]: dynamicswap.service: Succeeded. Feb 26 20:08:02 usic systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Feb 26 20:08:02 usic systemd[1]: volumio.service: Scheduled restart job, restart counter is at 1. Feb 26 20:08:02 usic systemd[1]: Stopped Volumio Backend Module. Feb 26 20:08:02 usic systemd[1]: Started Volumio Backend Module. Feb 26 20:08:02 usic systemd[1]: Started dynamicswap service. Feb 26 20:08:02 usic systemd[1]: dynamicswap.service: Succeeded. Feb 26 20:08:05 usic volumio[4772]: info: ------------------------------------------- Feb 26 20:08:05 usic volumio[4772]: info: ----- Volumio3 ---- Feb 26 20:08:05 usic volumio[4772]: info: ------------------------------------------- Feb 26 20:08:05 usic volumio[4772]: info: ----- System startup ---- Feb 26 20:08:05 usic volumio[4772]: info: ------------------------------------------- Feb 26 20:08:07 usic volumio[4772]: info: MYVOLUMIO Environment detected Feb 26 20:08:07 usic volumio-remote-updater[1880]: [2026-02-26 20:08:07] [connect] Successful connection Feb 26 20:08:07 usic volumio[4772]: info: Plugin folders cleanup Feb 26 20:08:07 usic volumio[4772]: info: Scanning into folder /volumio/app/plugins/ Feb 26 20:08:07 usic volumio[4772]: info: Scanning category audio_interface Feb 26 20:08:07 usic volumio[4772]: info: Scanning category miscellanea Feb 26 20:08:07 usic volumio[4772]: info: Scanning category music_service Feb 26 20:08:07 usic volumio[4772]: info: Scanning category plugins.json Feb 26 20:08:07 usic volumio[4772]: info: Scanning category system_controller Feb 26 20:08:07 usic volumio[4772]: info: Scanning category user_interface Feb 26 20:08:07 usic volumio[4772]: info: Scanning into folder /data/plugins/ Feb 26 20:08:07 usic volumio[4772]: info: Plugin folders cleanup completed Feb 26 20:08:07 usic volumio[4772]: info: ------------------------------------------- Feb 26 20:08:07 usic volumio[4772]: info: ----- Core plugins startup ---- Feb 26 20:08:07 usic volumio[4772]: info: ------------------------------------------- Feb 26 20:08:07 usic volumio[4772]: info: Loading plugins from folder /volumio/app/plugins/ Feb 26 20:08:07 usic volumio[4772]: info: Adding plugin upnp to MyMusic Plugins Feb 26 20:08:07 usic volumio[4772]: info: Adding plugin airplay_emulation to MyMusic Plugins Feb 26 20:08:07 usic volumio[4772]: info: Adding plugin upnp_browser to MyMusic Plugins Feb 26 20:08:07 usic volumio[4772]: info: Loading plugins from folder /data/plugins/ Feb 26 20:08:07 usic volumio[4772]: info: Loading plugin "system"... Feb 26 20:08:07 usic volumio[4772]: info: Loading plugin "appearance"... Feb 26 20:08:09 usic volumio[4772]: info: Loading plugin "network"... Feb 26 20:08:09 usic volumio[4772]: info: Refreshing Cached IP Addresses Feb 26 20:08:09 usic sudo[4801]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 26 20:08:09 usic sudo[4801]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 26 20:08:09 usic sudo[4801]: pam_unix(sudo:session): session closed for user root Feb 26 20:08:09 usic sudo[4803]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 26 20:08:09 usic sudo[4803]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 26 20:08:09 usic volumio[4772]: info: Loading plugin "services"... Feb 26 20:08:09 usic volumio[4772]: info: Loading plugin "alsa_controller"... Feb 26 20:08:09 usic sudo[4803]: pam_unix(sudo:session): session closed for user root Feb 26 20:08:09 usic sudo[4813]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Feb 26 20:08:09 usic sudo[4813]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 26 20:08:09 usic sudo[4813]: pam_unix(sudo:session): session closed for user root Feb 26 20:08:09 usic volumio[4772]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 26 20:08:09 usic volumio[4772]: info: Loading plugin "wizard"... Feb 26 20:08:09 usic volumio[4772]: info: Loading plugin "networkfs"... Feb 26 20:08:09 usic volumio[4772]: info: Cannot mount NAS NAS73 at system boot, trial number 1 ,retrying in 5 seconds Feb 26 20:08:09 usic volumio[4772]: info: Starting Udev Watcher for removable devices Feb 26 20:08:09 usic volumio[4772]: info: Ignoring mount for partition: boot Feb 26 20:08:09 usic volumio[4772]: info: Ignoring mount for partition: volumio Feb 26 20:08:09 usic volumio[4772]: info: Ignoring mount for partition: volumio_data Feb 26 20:08:09 usic volumio[4772]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 26 20:08:09 usic volumio[4772]: info: Loading plugin "volumio_command_line_client"... Feb 26 20:08:09 usic volumio[4772]: info: Plugin upnp is not enabled Feb 26 20:08:09 usic volumio[4772]: info: Loading plugin "my_music"... Feb 26 20:08:09 usic volumio[4772]: info: Loading plugin "mpd"... Feb 26 20:08:10 usic volumio[4772]: info: Plugin upnp_browser is not enabled Feb 26 20:08:10 usic volumio[4772]: info: Loading plugin "alarm-clock"... Feb 26 20:08:10 usic volumio[4772]: info: Plugin airplay_emulation is not enabled Feb 26 20:08:10 usic volumio[4772]: info: Loading plugin "last_100"... Feb 26 20:08:10 usic volumio[4772]: info: Loading plugin "webradio"... Feb 26 20:08:10 usic volumio[4772]: info: Loading plugin "i2s_dacs"... Feb 26 20:08:11 usic volumio[4772]: info: I2S DAC not set, start Auto-detection Feb 26 20:08:11 usic volumio[4772]: info: Loading plugin "volumiodiscovery"... Feb 26 20:08:11 usic volumio[4772]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 26 20:08:11 usic volumio[4772]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 26 20:08:11 usic node[4772]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 26 20:08:11 usic volumio[4772]: *** WARNING *** For more information see Feb 26 20:08:11 usic volumio[4772]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 26 20:08:11 usic volumio[4772]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 26 20:08:11 usic volumio[4772]: *** WARNING *** For more information see Feb 26 20:08:11 usic node[4772]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 26 20:08:11 usic node[4772]: *** WARNING *** For more information see Feb 26 20:08:11 usic node[4772]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 26 20:08:11 usic node[4772]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 26 20:08:11 usic node[4772]: *** WARNING *** For more information see Feb 26 20:08:11 usic volumio[4772]: info: Applying required configuration parameters for plugin volumiodiscovery Feb 26 20:08:11 usic volumio[4772]: info: Discovery: Started advertising with name: usic Feb 26 20:08:11 usic volumio[4772]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 26 20:08:11 usic volumio[4772]: info: Loading plugin "outputs"... Feb 26 20:08:11 usic volumio[4772]: info: Loading plugin "albumart"... Feb 26 20:08:11 usic volumio[4772]: info: Plugin example_plugin is not enabled Feb 26 20:08:11 usic volumio[4772]: info: Loading plugin "inputs"... Feb 26 20:08:11 usic volumio[4772]: info: Loading plugin "updater_comm"... Feb 26 20:08:11 usic volumio[4772]: info: Plugin mpdemulation is not enabled Feb 26 20:08:11 usic volumio[4772]: info: Loading plugin "rest_api"... Feb 26 20:08:11 usic volumio[4772]: info: Loading plugin "websocket"... Feb 26 20:08:11 usic volumio[4772]: info: Starting Socket.io Server version 2.3.0 Feb 26 20:08:11 usic volumio[4772]: info: Loading i18n strings for locale ru Feb 26 20:08:11 usic volumio[4772]: Updating browse sources language Feb 26 20:08:11 usic volumio[4772]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 26 20:08:11 usic volumio[4772]: Forking 3 albumart workers Feb 26 20:08:12 usic volumio[4772]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 26 20:08:12 usic volumio[4772]: info: CoreCommandRouter::initPlayerControls Feb 26 20:08:12 usic volumio[4772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:12 usic volumio[4772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:12 usic volumio[4772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:12 usic volumio[4772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:12 usic volumio[4772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:12 usic volumio[4772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:12 usic volumio[4772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:12 usic volumio[4772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:12 usic volumio[4772]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 26 20:08:12 usic volumio[4772]: Express server listening on port 3000 Feb 26 20:08:12 usic volumio[4772]: [Metrics] WebUI: 7s 714.24ms Feb 26 20:08:12 usic volumio[4772]: info: CoreStateMachine::resetVolumioState Feb 26 20:08:12 usic volumio[4772]: info: CoreStateMachine::getcurrentVolume Feb 26 20:08:12 usic volumio[4772]: info: CoreCommandRouter::volumioRetrievevolume Feb 26 20:08:12 usic volumio[4772]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 26 20:08:12 usic volumio[4772]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Feb 26 20:08:12 usic volumio[4772]: info: Completed loading Core Plugins Feb 26 20:08:12 usic volumio[4772]: info: Preparing to generate the ALSA configuration file Feb 26 20:08:12 usic volumio[4772]: info: Cannot read play queue from file Feb 26 20:08:12 usic volumio[4772]: info: Volumio Network Manager: Network status updated: 1 Feb 26 20:08:12 usic volumio[4772]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Feb 26 20:08:12 usic volumio[4772]: wlan0 Interface doesn't support scanning. Feb 26 20:08:12 usic volumio[4772]: info: Cannot use regular scanning, forcing with ap-force Feb 26 20:08:12 usic sudo[4870]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Feb 26 20:08:12 usic sudo[4870]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 26 20:08:12 usic sudo[4870]: pam_unix(sudo:session): session closed for user root Feb 26 20:08:12 usic volumio[4772]: command failed: No such device (-19) Feb 26 20:08:12 usic volumio[4772]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Feb 26 20:08:12 usic volumio[4772]: command failed: No such device (-19) Feb 26 20:08:13 usic volumio[4772]: info: VolumeController:: Volume=100 Mute =false Feb 26 20:08:13 usic volumio[4772]: info: CoreStateMachine::pushState Feb 26 20:08:13 usic volumio[4772]: info: CorePlayQueue::getTrack 0 Feb 26 20:08:13 usic volumio[4772]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 26 20:08:13 usic volumio[4772]: info: CoreCommandRouter::volumioPushState Feb 26 20:08:13 usic volumio[4772]: info: CoreStateMachine::updateTrackBlock Feb 26 20:08:13 usic volumio[4772]: info: CorePlayQueue::getTrackBlock Feb 26 20:08:13 usic volumio[4772]: info: CoreCommandRouter::volumioRetrievevolume Feb 26 20:08:13 usic volumio[4772]: info: Asound.conf file unchanged, so no further update is needed Feb 26 20:08:13 usic volumio[4772]: Starting albumart workers Feb 26 20:08:13 usic volumio[4772]: info: Output device has changed, restarting MPD Feb 26 20:08:13 usic volumio[4772]: Starting albumart workers Feb 26 20:08:13 usic volumio[4772]: info: ___________ START PLUGINS ___________ Feb 26 20:08:13 usic volumio[4772]: Starting albumart workers Feb 26 20:08:13 usic volumio[4772]: info: ControllerMpd::onStart: Initializing MPD Feb 26 20:08:13 usic volumio[4772]: info: Creating MPD Configuration file Feb 26 20:08:13 usic sudo[4882]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 26 20:08:13 usic sudo[4882]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 26 20:08:13 usic sudo[4883]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 26 20:08:13 usic sudo[4882]: pam_unix(sudo:session): session closed for user root Feb 26 20:08:13 usic sudo[4883]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 26 20:08:13 usic volumio[4772]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 26 20:08:13 usic volumio[4772]: info: [1772125693653] CoreMusicLibrary::Adding element Last_100 Feb 26 20:08:13 usic volumio[4772]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 26 20:08:13 usic volumio[4772]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 26 20:08:13 usic volumio[4772]: info: [1772125693667] CoreMusicLibrary::Adding element Webradio Feb 26 20:08:13 usic volumio[4772]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 26 20:08:13 usic systemd[1]: Stopping Music Player Daemon... Feb 26 20:08:13 usic sudo[4886]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 26 20:08:13 usic sudo[4886]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 26 20:08:13 usic volumio[4772]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 26 20:08:13 usic volumio[4772]: info: Initializing BBC Radios Feb 26 20:08:13 usic sudo[4886]: pam_unix(sudo:session): session closed for user root Feb 26 20:08:13 usic sudo[4889]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 26 20:08:13 usic sudo[4889]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 26 20:08:13 usic volumio[4772]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 26 20:08:13 usic volumio[4772]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 26 20:08:13 usic volumio[4772]: info: Volumio Calling Home Feb 26 20:08:14 usic volumio[4772]: info: CoreStateMachine::setRepeat null single undefined Feb 26 20:08:14 usic volumio[4772]: info: CoreStateMachine::pushState Feb 26 20:08:14 usic volumio[4772]: info: CorePlayQueue::getTrack 0 Feb 26 20:08:14 usic volumio[4772]: info: CoreCommandRouter::volumioPushState Feb 26 20:08:14 usic volumio[4772]: info: CoreStateMachine::setRandom null Feb 26 20:08:14 usic volumio[4772]: info: CoreStateMachine::pushState Feb 26 20:08:14 usic volumio[4772]: info: CorePlayQueue::getTrack 0 Feb 26 20:08:14 usic volumio[4772]: info: CoreCommandRouter::volumioPushState Feb 26 20:08:14 usic volumio[4772]: info: MPD Permissions set Feb 26 20:08:14 usic volumio[4772]: info: MPD Permissions set Feb 26 20:08:14 usic volumio[4772]: 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 26 20:08:14 usic volumio[4772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:14 usic volumio[4772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:14 usic volumio[4772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:14 usic volumio[4772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:14 usic volumio[4772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:14 usic volumio[4772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:14 usic volumio[4772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:14 usic volumio[4772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:14 usic volumio[4772]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 26 20:08:14 usic volumio[4772]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 26 20:08:14 usic volumio[4772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:14 usic volumio[4772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:14 usic volumio[4772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:14 usic volumio[4772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:14 usic volumio[4772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:14 usic volumio[4772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:14 usic volumio[4772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:14 usic volumio[4772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:14 usic volumio[4772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:14 usic volumio[4772]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 26 20:08:14 usic volumio[4772]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 26 20:08:14 usic volumio[4772]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:14 usic volumio[4772]: info: Discovery: adding 4f54dfed-c19c-47a1-bae2-83b3668bd707 Feb 26 20:08:14 usic volumio[4772]: info: Discovery: Found device usic Feb 26 20:08:14 usic volumio[4772]: info: CoreCommandRouter::volumioGetState Feb 26 20:08:14 usic volumio[4772]: info: CorePlayQueue::getTrack 0 Feb 26 20:08:15 usic volumio[4772]: info: VolumeController:: Volume=100 Mute =false Feb 26 20:08:15 usic volumio[4772]: info: CoreStateMachine::pushState Feb 26 20:08:15 usic volumio[4772]: info: CorePlayQueue::getTrack 0 Feb 26 20:08:15 usic volumio[4772]: info: CoreCommandRouter::volumioPushState Feb 26 20:08:15 usic volumio[4772]: info: Cannot mount NAS NAS73 at system boot, trial number 2 ,retrying in 5 seconds Feb 26 20:08:15 usic volumio[4772]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 26 20:08:15 usic volumio[4772]: Error: getaddrinfo ENOTFOUND cdn-images.dzcdn.net Feb 26 20:08:15 usic volumio[4772]: at GetAddrInfoReqWrap.onlookup [as oncomplete] (dns.js:71:26) { Feb 26 20:08:15 usic volumio[4772]: errno: -3007, Feb 26 20:08:15 usic volumio[4772]: code: 'ENOTFOUND', Feb 26 20:08:15 usic volumio[4772]: syscall: 'getaddrinfo', Feb 26 20:08:15 usic volumio[4772]: hostname: 'cdn-images.dzcdn.net' Feb 26 20:08:15 usic volumio[4772]: } Feb 26 20:08:15 usic volumio[4772]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 26 20:08:15 usic systemd[1]: mpd.service: Succeeded. Feb 26 20:08:15 usic systemd[1]: Stopped Music Player Daemon. Feb 26 20:08:15 usic systemd[1]: Starting Music Player Daemon... Feb 26 20:08:15 usic sudo[4951]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 26 20:08:15 usic sudo[4951]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 26 20:08:15 usic sudo[4951]: pam_unix(sudo:session): session closed for user root Feb 26 20:08:16 usic sudo[4955]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-02-26 20:07 Feb 26 20:08:16 usic sudo[4955]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 26 20:08:16 usic sudo[4955]: pam_unix(sudo:session): session closed for user root Feb 26 20:08:16 usic systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Feb 26 20:08:16 usic sudo[4889]: pam_unix(sudo:session): session closed for user root Feb 26 20:08:16 usic sudo[4883]: pam_unix(sudo:session): session closed for user root Feb 26 20:08:16 usic systemd[1]: volumio.service: Failed with result 'exit-code'. Feb 26 20:08:16 usic systemd[1]: Started dynamicswap service. Feb 26 20:08:16 usic systemd[1]: dynamicswap.service: Succeeded. Feb 26 20:08:16 usic systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Feb 26 20:08:16 usic systemd[1]: volumio.service: Scheduled restart job, restart counter is at 2. Feb 26 20:08:16 usic systemd[1]: Started dynamicswap service. Feb 26 20:08:16 usic systemd[1]: Stopped Volumio Backend Module. Feb 26 20:08:16 usic systemd[1]: Started Volumio Backend Module. Feb 26 20:08:16 usic systemd[1]: dynamicswap.service: Succeeded. Feb 26 20:08:18 usic mpd[4953]: Feb 26 20:08 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 26 20:08:18 usic systemd[1]: Started Music Player Daemon. Feb 26 20:08:19 usic volumio[4966]: info: ------------------------------------------- Feb 26 20:08:19 usic volumio[4966]: info: ----- Volumio3 ---- Feb 26 20:08:19 usic volumio[4966]: info: ------------------------------------------- Feb 26 20:08:19 usic volumio[4966]: info: ----- System startup ---- Feb 26 20:08:19 usic volumio[4966]: info: ------------------------------------------- Feb 26 20:08:19 usic volumio-remote-updater[1880]: [2026-02-26 20:08:19] [connect] Successful connection Feb 26 20:08:20 usic volumio[4966]: info: MYVOLUMIO Environment detected Feb 26 20:08:20 usic volumio[4966]: info: Plugin folders cleanup Feb 26 20:08:20 usic volumio[4966]: info: Scanning into folder /volumio/app/plugins/ Feb 26 20:08:20 usic volumio[4966]: info: Scanning category audio_interface Feb 26 20:08:20 usic volumio[4966]: info: Scanning category miscellanea Feb 26 20:08:20 usic volumio[4966]: info: Scanning category music_service Feb 26 20:08:20 usic volumio[4966]: info: Scanning category plugins.json Feb 26 20:08:20 usic volumio[4966]: info: Scanning category system_controller Feb 26 20:08:20 usic volumio[4966]: info: Scanning category user_interface Feb 26 20:08:20 usic volumio[4966]: info: Scanning into folder /data/plugins/ Feb 26 20:08:20 usic volumio[4966]: info: Plugin folders cleanup completed Feb 26 20:08:20 usic volumio[4966]: info: ------------------------------------------- Feb 26 20:08:20 usic volumio[4966]: info: ----- Core plugins startup ---- Feb 26 20:08:20 usic volumio[4966]: info: ------------------------------------------- Feb 26 20:08:20 usic volumio[4966]: info: Loading plugins from folder /volumio/app/plugins/ Feb 26 20:08:20 usic volumio[4966]: info: Adding plugin upnp to MyMusic Plugins Feb 26 20:08:20 usic volumio[4966]: info: Adding plugin airplay_emulation to MyMusic Plugins Feb 26 20:08:20 usic volumio[4966]: info: Adding plugin upnp_browser to MyMusic Plugins Feb 26 20:08:20 usic volumio[4966]: info: Loading plugins from folder /data/plugins/ Feb 26 20:08:20 usic volumio[4966]: info: Loading plugin "system"... Feb 26 20:08:20 usic volumio[4966]: info: Loading plugin "appearance"... Feb 26 20:08:22 usic volumio[4966]: info: Loading plugin "network"... Feb 26 20:08:22 usic volumio[4966]: info: Refreshing Cached IP Addresses Feb 26 20:08:22 usic sudo[4994]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 26 20:08:22 usic sudo[4994]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 26 20:08:22 usic sudo[4994]: pam_unix(sudo:session): session closed for user root Feb 26 20:08:22 usic sudo[4996]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 26 20:08:22 usic sudo[4996]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 26 20:08:22 usic volumio[4966]: info: Loading plugin "services"... Feb 26 20:08:22 usic volumio[4966]: info: Loading plugin "alsa_controller"... Feb 26 20:08:22 usic sudo[4996]: pam_unix(sudo:session): session closed for user root Feb 26 20:08:22 usic sudo[5010]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Feb 26 20:08:22 usic sudo[5010]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 26 20:08:22 usic sudo[5010]: pam_unix(sudo:session): session closed for user root Feb 26 20:08:22 usic volumio[4966]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 26 20:08:22 usic volumio[4966]: info: Loading plugin "wizard"... Feb 26 20:08:22 usic volumio[4966]: info: Loading plugin "networkfs"... Feb 26 20:08:22 usic volumio[4966]: info: Cannot mount NAS NAS73 at system boot, trial number 1 ,retrying in 5 seconds Feb 26 20:08:22 usic volumio[4966]: info: Starting Udev Watcher for removable devices Feb 26 20:08:22 usic volumio[4966]: info: Ignoring mount for partition: boot Feb 26 20:08:22 usic volumio[4966]: info: Ignoring mount for partition: volumio Feb 26 20:08:22 usic volumio[4966]: info: Ignoring mount for partition: volumio_data Feb 26 20:08:22 usic volumio[4966]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 26 20:08:22 usic volumio[4966]: info: Loading plugin "volumio_command_line_client"... Feb 26 20:08:22 usic volumio[4966]: info: Plugin upnp is not enabled Feb 26 20:08:22 usic volumio[4966]: info: Loading plugin "my_music"... Feb 26 20:08:22 usic volumio[4966]: info: Loading plugin "mpd"... Feb 26 20:08:22 usic volumio[4966]: info: Plugin upnp_browser is not enabled Feb 26 20:08:22 usic volumio[4966]: info: Loading plugin "alarm-clock"... Feb 26 20:08:23 usic volumio[4966]: info: Plugin airplay_emulation is not enabled Feb 26 20:08:23 usic volumio[4966]: info: Loading plugin "last_100"... Feb 26 20:08:23 usic volumio[4966]: info: Loading plugin "webradio"... Feb 26 20:08:23 usic volumio[4966]: info: Loading plugin "i2s_dacs"... Feb 26 20:08:23 usic volumio[4966]: info: I2S DAC not set, start Auto-detection Feb 26 20:08:23 usic volumio[4966]: info: Loading plugin "volumiodiscovery"... Feb 26 20:08:23 usic volumio[4966]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 26 20:08:23 usic volumio[4966]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 26 20:08:23 usic node[4966]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 26 20:08:23 usic volumio[4966]: *** WARNING *** For more information see Feb 26 20:08:23 usic volumio[4966]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 26 20:08:23 usic volumio[4966]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 26 20:08:23 usic volumio[4966]: *** WARNING *** For more information see Feb 26 20:08:23 usic node[4966]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 26 20:08:23 usic node[4966]: *** WARNING *** For more information see Feb 26 20:08:23 usic node[4966]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 26 20:08:23 usic node[4966]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 26 20:08:23 usic node[4966]: *** WARNING *** For more information see Feb 26 20:08:23 usic volumio[4966]: info: Applying required configuration parameters for plugin volumiodiscovery Feb 26 20:08:23 usic volumio[4966]: info: Discovery: Started advertising with name: usic Feb 26 20:08:23 usic volumio[4966]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 26 20:08:23 usic volumio[4966]: info: Loading plugin "outputs"... Feb 26 20:08:23 usic volumio[4966]: info: Loading plugin "albumart"... Feb 26 20:08:23 usic volumio[4966]: info: Plugin example_plugin is not enabled Feb 26 20:08:23 usic volumio[4966]: info: Loading plugin "inputs"... Feb 26 20:08:23 usic volumio[4966]: info: Loading plugin "updater_comm"... Feb 26 20:08:23 usic volumio[4966]: info: Plugin mpdemulation is not enabled Feb 26 20:08:23 usic volumio[4966]: info: Loading plugin "rest_api"... Feb 26 20:08:23 usic volumio[4966]: info: Loading plugin "websocket"... Feb 26 20:08:23 usic volumio[4966]: info: Starting Socket.io Server version 2.3.0 Feb 26 20:08:23 usic volumio[4966]: info: Loading i18n strings for locale ru Feb 26 20:08:23 usic volumio[4966]: Updating browse sources language Feb 26 20:08:23 usic volumio[4966]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 26 20:08:24 usic volumio[4966]: Forking 3 albumart workers Feb 26 20:08:24 usic volumio[4966]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 26 20:08:24 usic volumio[4966]: info: CoreCommandRouter::initPlayerControls Feb 26 20:08:24 usic volumio[4966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:24 usic volumio[4966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:24 usic volumio[4966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:24 usic volumio[4966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:24 usic volumio[4966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:24 usic volumio[4966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:24 usic volumio[4966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:24 usic volumio[4966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:24 usic volumio[4966]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 26 20:08:24 usic volumio[4966]: Express server listening on port 3000 Feb 26 20:08:24 usic volumio[4966]: [Metrics] WebUI: 5s 764.80ms Feb 26 20:08:24 usic volumio[4966]: info: CoreStateMachine::resetVolumioState Feb 26 20:08:24 usic volumio[4966]: info: CoreStateMachine::getcurrentVolume Feb 26 20:08:24 usic volumio[4966]: info: CoreCommandRouter::volumioRetrievevolume Feb 26 20:08:24 usic volumio[4966]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 26 20:08:24 usic volumio[4966]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Feb 26 20:08:24 usic volumio[4966]: info: Completed loading Core Plugins Feb 26 20:08:24 usic volumio[4966]: info: Preparing to generate the ALSA configuration file Feb 26 20:08:24 usic volumio[4966]: info: Cannot read play queue from file Feb 26 20:08:24 usic volumio[4966]: info: Volumio Network Manager: Network status updated: 1 Feb 26 20:08:24 usic volumio[4966]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Feb 26 20:08:24 usic volumio[4966]: wlan0 Interface doesn't support scanning. Feb 26 20:08:24 usic volumio[4966]: info: Cannot use regular scanning, forcing with ap-force Feb 26 20:08:24 usic sudo[5060]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Feb 26 20:08:24 usic sudo[5060]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 26 20:08:24 usic sudo[5060]: pam_unix(sudo:session): session closed for user root Feb 26 20:08:24 usic volumio[4966]: command failed: No such device (-19) Feb 26 20:08:24 usic volumio[4966]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Feb 26 20:08:24 usic volumio[4966]: command failed: No such device (-19) Feb 26 20:08:25 usic volumio[4966]: info: VolumeController:: Volume=100 Mute =false Feb 26 20:08:25 usic volumio[4966]: info: CoreStateMachine::pushState Feb 26 20:08:25 usic volumio[4966]: info: CorePlayQueue::getTrack 0 Feb 26 20:08:25 usic volumio[4966]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 26 20:08:25 usic volumio[4966]: info: CoreCommandRouter::volumioPushState Feb 26 20:08:25 usic volumio[4966]: info: CoreStateMachine::updateTrackBlock Feb 26 20:08:25 usic volumio[4966]: info: CorePlayQueue::getTrackBlock Feb 26 20:08:25 usic volumio[4966]: info: CoreCommandRouter::volumioRetrievevolume Feb 26 20:08:25 usic volumio[4966]: info: Asound.conf file unchanged, so no further update is needed Feb 26 20:08:25 usic volumio[4966]: info: Output device has changed, restarting MPD Feb 26 20:08:25 usic volumio[4966]: info: ___________ START PLUGINS ___________ Feb 26 20:08:25 usic volumio[4966]: info: ControllerMpd::onStart: Initializing MPD Feb 26 20:08:25 usic volumio[4966]: info: Creating MPD Configuration file Feb 26 20:08:25 usic sudo[5072]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 26 20:08:25 usic sudo[5073]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 26 20:08:25 usic sudo[5073]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 26 20:08:25 usic sudo[5072]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 26 20:08:25 usic sudo[5072]: pam_unix(sudo:session): session closed for user root Feb 26 20:08:25 usic volumio[4966]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 26 20:08:25 usic volumio[4966]: info: [1772125705666] CoreMusicLibrary::Adding element Last_100 Feb 26 20:08:25 usic volumio[4966]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 26 20:08:25 usic volumio[4966]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 26 20:08:25 usic systemd[1]: Stopping Music Player Daemon... Feb 26 20:08:25 usic volumio[4966]: info: [1772125705687] CoreMusicLibrary::Adding element Webradio Feb 26 20:08:25 usic volumio[4966]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 26 20:08:25 usic volumio[4966]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 26 20:08:25 usic sudo[5077]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 26 20:08:25 usic sudo[5077]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 26 20:08:25 usic volumio[4966]: info: Initializing BBC Radios Feb 26 20:08:25 usic systemd[1]: mpd.service: Succeeded. Feb 26 20:08:25 usic systemd[1]: Stopped Music Player Daemon. Feb 26 20:08:25 usic sudo[5079]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 26 20:08:25 usic sudo[5079]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 26 20:08:25 usic sudo[5077]: pam_unix(sudo:session): session closed for user root Feb 26 20:08:25 usic systemd[1]: Starting Music Player Daemon... Feb 26 20:08:25 usic systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Feb 26 20:08:25 usic systemd[1]: mpd.service: Succeeded. Feb 26 20:08:25 usic systemd[1]: Stopped Music Player Daemon. Feb 26 20:08:25 usic systemd[1]: Starting Music Player Daemon... Feb 26 20:08:25 usic volumio[4966]: Starting albumart workers Feb 26 20:08:25 usic volumio[4966]: Starting albumart workers Feb 26 20:08:25 usic volumio[4966]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 26 20:08:25 usic volumio[4966]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 26 20:08:25 usic volumio[4966]: info: Volumio Calling Home Feb 26 20:08:25 usic volumio[4966]: Starting albumart workers Feb 26 20:08:26 usic sudo[5090]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 26 20:08:26 usic sudo[5090]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 26 20:08:26 usic sudo[5090]: pam_unix(sudo:session): session closed for user root Feb 26 20:08:26 usic volumio[4966]: info: CoreStateMachine::setRepeat null single undefined Feb 26 20:08:26 usic volumio[4966]: info: CoreStateMachine::pushState Feb 26 20:08:26 usic volumio[4966]: info: CorePlayQueue::getTrack 0 Feb 26 20:08:26 usic volumio[4966]: info: CoreCommandRouter::volumioPushState Feb 26 20:08:26 usic volumio[4966]: info: CoreStateMachine::setRandom null Feb 26 20:08:26 usic volumio[4966]: info: CoreStateMachine::pushState Feb 26 20:08:26 usic volumio[4966]: info: CorePlayQueue::getTrack 0 Feb 26 20:08:26 usic volumio[4966]: info: CoreCommandRouter::volumioPushState Feb 26 20:08:26 usic volumio[4966]: info: MPD Permissions set Feb 26 20:08:26 usic volumio[4966]: info: MPD Permissions set Feb 26 20:08:26 usic volumio[4966]: 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 26 20:08:26 usic volumio[4966]: info: VolumeController:: Volume=100 Mute =false Feb 26 20:08:26 usic volumio[4966]: info: CoreStateMachine::pushState Feb 26 20:08:26 usic volumio[4966]: info: CorePlayQueue::getTrack 0 Feb 26 20:08:26 usic volumio[4966]: info: CoreCommandRouter::volumioPushState Feb 26 20:08:26 usic volumio[4966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:26 usic volumio[4966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:26 usic volumio[4966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:26 usic volumio[4966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:26 usic volumio[4966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:26 usic volumio[4966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:26 usic volumio[4966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:26 usic volumio[4966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:26 usic volumio[4966]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 26 20:08:26 usic volumio[4966]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 26 20:08:26 usic volumio[4966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:26 usic volumio[4966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:26 usic volumio[4966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:26 usic volumio[4966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:26 usic volumio[4966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:26 usic volumio[4966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:26 usic volumio[4966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:26 usic volumio[4966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:26 usic volumio[4966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:26 usic volumio[4966]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 26 20:08:26 usic volumio[4966]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 26 20:08:27 usic volumio[4966]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:27 usic volumio[4966]: info: Discovery: adding 4f54dfed-c19c-47a1-bae2-83b3668bd707 Feb 26 20:08:27 usic volumio[4966]: info: Discovery: Found device usic Feb 26 20:08:27 usic volumio[4966]: info: CoreCommandRouter::volumioGetState Feb 26 20:08:27 usic volumio[4966]: info: CorePlayQueue::getTrack 0 Feb 26 20:08:27 usic volumio[4966]: info: CoreCommandRouter::volumioGetState Feb 26 20:08:27 usic volumio[4966]: info: CorePlayQueue::getTrack 0 Feb 26 20:08:27 usic volumio[4966]: info: Cannot mount NAS NAS73 at system boot, trial number 2 ,retrying in 5 seconds Feb 26 20:08:27 usic volumio[4966]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 26 20:08:27 usic volumio[4966]: Error: getaddrinfo ENOTFOUND cdn-images.dzcdn.net Feb 26 20:08:27 usic volumio[4966]: at GetAddrInfoReqWrap.onlookup [as oncomplete] (dns.js:71:26) { Feb 26 20:08:27 usic volumio[4966]: errno: -3007, Feb 26 20:08:27 usic volumio[4966]: code: 'ENOTFOUND', Feb 26 20:08:27 usic volumio[4966]: syscall: 'getaddrinfo', Feb 26 20:08:27 usic volumio[4966]: hostname: 'cdn-images.dzcdn.net' Feb 26 20:08:27 usic volumio[4966]: } Feb 26 20:08:27 usic volumio[4966]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 26 20:08:28 usic sudo[5147]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-02-26 20:07 Feb 26 20:08:28 usic sudo[5147]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 26 20:08:28 usic sudo[5147]: pam_unix(sudo:session): session closed for user root Feb 26 20:08:28 usic systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Feb 26 20:08:28 usic sudo[5079]: pam_unix(sudo:session): session closed for user root Feb 26 20:08:28 usic sudo[5073]: pam_unix(sudo:session): session closed for user root Feb 26 20:08:28 usic systemd[1]: volumio.service: Failed with result 'exit-code'. Feb 26 20:08:28 usic systemd[1]: Started dynamicswap service. Feb 26 20:08:28 usic systemd[1]: dynamicswap.service: Succeeded. Feb 26 20:08:28 usic systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Feb 26 20:08:28 usic mpd[5098]: Feb 26 20:08 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 26 20:08:28 usic systemd[1]: volumio.service: Scheduled restart job, restart counter is at 3. Feb 26 20:08:28 usic systemd[1]: Started dynamicswap service. Feb 26 20:08:28 usic systemd[1]: Stopped Volumio Backend Module. Feb 26 20:08:28 usic systemd[1]: Started Volumio Backend Module. Feb 26 20:08:28 usic systemd[1]: Started Music Player Daemon. Feb 26 20:08:28 usic systemd[1]: dynamicswap.service: Succeeded. Feb 26 20:08:31 usic volumio[5158]: info: ------------------------------------------- Feb 26 20:08:31 usic volumio[5158]: info: ----- Volumio3 ---- Feb 26 20:08:31 usic volumio[5158]: info: ------------------------------------------- Feb 26 20:08:31 usic volumio[5158]: info: ----- System startup ---- Feb 26 20:08:31 usic volumio[5158]: info: ------------------------------------------- Feb 26 20:08:32 usic volumio[5158]: info: MYVOLUMIO Environment detected Feb 26 20:08:32 usic volumio[5158]: info: Plugin folders cleanup Feb 26 20:08:32 usic volumio[5158]: info: Scanning into folder /volumio/app/plugins/ Feb 26 20:08:32 usic volumio[5158]: info: Scanning category audio_interface Feb 26 20:08:32 usic volumio[5158]: info: Scanning category miscellanea Feb 26 20:08:32 usic volumio[5158]: info: Scanning category music_service Feb 26 20:08:32 usic volumio[5158]: info: Scanning category plugins.json Feb 26 20:08:32 usic volumio[5158]: info: Scanning category system_controller Feb 26 20:08:32 usic volumio[5158]: info: Scanning category user_interface Feb 26 20:08:32 usic volumio[5158]: info: Scanning into folder /data/plugins/ Feb 26 20:08:32 usic volumio[5158]: info: Plugin folders cleanup completed Feb 26 20:08:32 usic volumio[5158]: info: ------------------------------------------- Feb 26 20:08:32 usic volumio[5158]: info: ----- Core plugins startup ---- Feb 26 20:08:32 usic volumio[5158]: info: ------------------------------------------- Feb 26 20:08:32 usic volumio[5158]: info: Loading plugins from folder /volumio/app/plugins/ Feb 26 20:08:32 usic volumio[5158]: info: Adding plugin upnp to MyMusic Plugins Feb 26 20:08:32 usic volumio[5158]: info: Adding plugin airplay_emulation to MyMusic Plugins Feb 26 20:08:32 usic volumio[5158]: info: Adding plugin upnp_browser to MyMusic Plugins Feb 26 20:08:32 usic volumio[5158]: info: Loading plugins from folder /data/plugins/ Feb 26 20:08:32 usic volumio[5158]: info: Loading plugin "system"... Feb 26 20:08:32 usic volumio[5158]: info: Loading plugin "appearance"... Feb 26 20:08:34 usic volumio[5158]: info: Loading plugin "network"... Feb 26 20:08:34 usic volumio[5158]: info: Refreshing Cached IP Addresses Feb 26 20:08:34 usic sudo[5189]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 26 20:08:34 usic sudo[5189]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 26 20:08:34 usic sudo[5189]: pam_unix(sudo:session): session closed for user root Feb 26 20:08:34 usic sudo[5191]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 26 20:08:34 usic sudo[5191]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 26 20:08:34 usic volumio[5158]: info: Loading plugin "services"... Feb 26 20:08:34 usic volumio[5158]: info: Loading plugin "alsa_controller"... Feb 26 20:08:34 usic sudo[5191]: pam_unix(sudo:session): session closed for user root Feb 26 20:08:34 usic sudo[5201]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Feb 26 20:08:34 usic sudo[5201]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 26 20:08:34 usic sudo[5201]: pam_unix(sudo:session): session closed for user root Feb 26 20:08:34 usic volumio[5158]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 26 20:08:34 usic volumio[5158]: info: Loading plugin "wizard"... Feb 26 20:08:34 usic volumio[5158]: info: Loading plugin "networkfs"... Feb 26 20:08:34 usic volumio[5158]: info: Cannot mount NAS NAS73 at system boot, trial number 1 ,retrying in 5 seconds Feb 26 20:08:34 usic volumio[5158]: info: Starting Udev Watcher for removable devices Feb 26 20:08:34 usic volumio[5158]: info: Ignoring mount for partition: boot Feb 26 20:08:34 usic volumio[5158]: info: Ignoring mount for partition: volumio Feb 26 20:08:34 usic volumio[5158]: info: Ignoring mount for partition: volumio_data Feb 26 20:08:34 usic volumio[5158]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 26 20:08:34 usic volumio[5158]: info: Loading plugin "volumio_command_line_client"... Feb 26 20:08:34 usic volumio[5158]: info: Plugin upnp is not enabled Feb 26 20:08:34 usic volumio[5158]: info: Loading plugin "my_music"... Feb 26 20:08:34 usic volumio[5158]: info: Loading plugin "mpd"... Feb 26 20:08:34 usic volumio-remote-updater[1880]: [2026-02-26 20:08:34] [connect] Successful connection Feb 26 20:08:34 usic volumio[5158]: info: Plugin upnp_browser is not enabled Feb 26 20:08:34 usic volumio[5158]: info: Loading plugin "alarm-clock"... Feb 26 20:08:35 usic volumio[5158]: info: Plugin airplay_emulation is not enabled Feb 26 20:08:35 usic volumio[5158]: info: Loading plugin "last_100"... Feb 26 20:08:35 usic volumio[5158]: info: Loading plugin "webradio"... Feb 26 20:08:35 usic volumio[5158]: info: Loading plugin "i2s_dacs"... Feb 26 20:08:35 usic volumio[5158]: info: I2S DAC not set, start Auto-detection Feb 26 20:08:35 usic volumio[5158]: info: Loading plugin "volumiodiscovery"... Feb 26 20:08:35 usic volumio[5158]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 26 20:08:35 usic volumio[5158]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 26 20:08:35 usic volumio[5158]: *** WARNING *** For more information see Feb 26 20:08:35 usic node[5158]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 26 20:08:35 usic volumio[5158]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 26 20:08:35 usic volumio[5158]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 26 20:08:35 usic volumio[5158]: *** WARNING *** For more information see Feb 26 20:08:35 usic node[5158]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 26 20:08:35 usic node[5158]: *** WARNING *** For more information see Feb 26 20:08:35 usic node[5158]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 26 20:08:35 usic node[5158]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 26 20:08:35 usic node[5158]: *** WARNING *** For more information see Feb 26 20:08:35 usic volumio[5158]: info: Applying required configuration parameters for plugin volumiodiscovery Feb 26 20:08:35 usic volumio[5158]: info: Discovery: Started advertising with name: usic Feb 26 20:08:35 usic volumio[5158]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 26 20:08:35 usic volumio[5158]: info: Loading plugin "outputs"... Feb 26 20:08:35 usic volumio[5158]: info: Loading plugin "albumart"... Feb 26 20:08:35 usic volumio[5158]: info: Plugin example_plugin is not enabled Feb 26 20:08:35 usic volumio[5158]: info: Loading plugin "inputs"... Feb 26 20:08:35 usic volumio[5158]: info: Loading plugin "updater_comm"... Feb 26 20:08:35 usic volumio[5158]: info: Plugin mpdemulation is not enabled Feb 26 20:08:35 usic volumio[5158]: info: Loading plugin "rest_api"... Feb 26 20:08:35 usic volumio[5158]: info: Loading plugin "websocket"... Feb 26 20:08:35 usic volumio[5158]: info: Starting Socket.io Server version 2.3.0 Feb 26 20:08:35 usic volumio[5158]: info: Loading i18n strings for locale ru Feb 26 20:08:35 usic volumio[5158]: Updating browse sources language Feb 26 20:08:35 usic volumio[5158]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 26 20:08:36 usic volumio[5158]: Forking 3 albumart workers Feb 26 20:08:36 usic volumio[5158]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 26 20:08:36 usic volumio[5158]: info: CoreCommandRouter::initPlayerControls Feb 26 20:08:36 usic volumio[5158]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:36 usic volumio[5158]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:36 usic volumio[5158]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:36 usic volumio[5158]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:36 usic volumio[5158]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:36 usic volumio[5158]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:36 usic volumio[5158]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:36 usic volumio[5158]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:36 usic volumio[5158]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 26 20:08:36 usic volumio[5158]: Express server listening on port 3000 Feb 26 20:08:36 usic volumio[5158]: [Metrics] WebUI: 5s 775.00ms Feb 26 20:08:36 usic volumio[5158]: info: CoreStateMachine::resetVolumioState Feb 26 20:08:36 usic volumio[5158]: info: CoreStateMachine::getcurrentVolume Feb 26 20:08:36 usic volumio[5158]: info: CoreCommandRouter::volumioRetrievevolume Feb 26 20:08:36 usic volumio[5158]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 26 20:08:36 usic volumio[5158]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Feb 26 20:08:36 usic volumio[5158]: info: Completed loading Core Plugins Feb 26 20:08:36 usic volumio[5158]: info: Preparing to generate the ALSA configuration file Feb 26 20:08:36 usic volumio[5158]: info: Cannot read play queue from file Feb 26 20:08:36 usic volumio[5158]: info: Volumio Network Manager: Network status updated: 1 Feb 26 20:08:36 usic volumio[5158]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Feb 26 20:08:36 usic volumio[5158]: wlan0 Interface doesn't support scanning. Feb 26 20:08:36 usic volumio[5158]: info: Cannot use regular scanning, forcing with ap-force Feb 26 20:08:36 usic sudo[5255]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Feb 26 20:08:36 usic sudo[5255]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 26 20:08:36 usic sudo[5255]: pam_unix(sudo:session): session closed for user root Feb 26 20:08:36 usic volumio[5158]: command failed: No such device (-19) Feb 26 20:08:36 usic volumio[5158]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Feb 26 20:08:36 usic volumio[5158]: command failed: No such device (-19) Feb 26 20:08:36 usic volumio-remote-updater[1880]: [2026-02-26 20:08:36] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1772125714 101 Feb 26 20:08:37 usic volumio[5158]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 1 Feb 26 20:08:37 usic volumio[5158]: info: VolumeController:: Volume=100 Mute =false Feb 26 20:08:37 usic volumio[5158]: info: CoreStateMachine::pushState Feb 26 20:08:37 usic volumio[5158]: info: CorePlayQueue::getTrack 0 Feb 26 20:08:37 usic volumio[5158]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 26 20:08:37 usic volumio[5158]: info: CoreCommandRouter::volumioPushState Feb 26 20:08:37 usic volumio[5158]: info: CoreStateMachine::updateTrackBlock Feb 26 20:08:37 usic volumio[5158]: info: CorePlayQueue::getTrackBlock Feb 26 20:08:37 usic volumio[5158]: info: CoreCommandRouter::volumioRetrievevolume Feb 26 20:08:37 usic volumio[5158]: info: Asound.conf file unchanged, so no further update is needed Feb 26 20:08:37 usic volumio[5158]: info: Output device has changed, restarting MPD Feb 26 20:08:37 usic volumio[5158]: info: ___________ START PLUGINS ___________ Feb 26 20:08:37 usic volumio[5158]: info: ControllerMpd::onStart: Initializing MPD Feb 26 20:08:37 usic volumio[5158]: info: Creating MPD Configuration file Feb 26 20:08:37 usic sudo[5267]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 26 20:08:37 usic sudo[5267]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 26 20:08:37 usic sudo[5267]: pam_unix(sudo:session): session closed for user root Feb 26 20:08:37 usic sudo[5268]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 26 20:08:37 usic sudo[5271]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 26 20:08:37 usic sudo[5268]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 26 20:08:37 usic volumio[5158]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 26 20:08:37 usic volumio[5158]: info: [1772125717745] CoreMusicLibrary::Adding element Last_100 Feb 26 20:08:37 usic volumio[5158]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 26 20:08:37 usic sudo[5271]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 26 20:08:37 usic volumio[5158]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 26 20:08:37 usic volumio[5158]: info: [1772125717767] CoreMusicLibrary::Adding element Webradio Feb 26 20:08:37 usic volumio[5158]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 26 20:08:37 usic sudo[5271]: pam_unix(sudo:session): session closed for user root Feb 26 20:08:37 usic volumio[5158]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 26 20:08:37 usic volumio[5158]: info: Initializing BBC Radios Feb 26 20:08:37 usic systemd[1]: Stopping Music Player Daemon... Feb 26 20:08:37 usic sudo[5274]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 26 20:08:37 usic sudo[5274]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 26 20:08:37 usic systemd[1]: mpd.service: Succeeded. Feb 26 20:08:37 usic systemd[1]: Stopped Music Player Daemon. Feb 26 20:08:37 usic volumio[5158]: Starting albumart workers Feb 26 20:08:37 usic systemd[1]: Starting Music Player Daemon... Feb 26 20:08:37 usic systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Feb 26 20:08:37 usic systemd[1]: mpd.service: Succeeded. Feb 26 20:08:37 usic systemd[1]: Stopped Music Player Daemon. Feb 26 20:08:37 usic systemd[1]: Starting Music Player Daemon... Feb 26 20:08:37 usic volumio[5158]: Starting albumart workers Feb 26 20:08:38 usic volumio[5158]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 26 20:08:38 usic volumio[5158]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 26 20:08:38 usic volumio[5158]: info: Volumio Calling Home Feb 26 20:08:38 usic volumio[5158]: Starting albumart workers Feb 26 20:08:38 usic sudo[5285]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 26 20:08:38 usic sudo[5285]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 26 20:08:38 usic sudo[5285]: pam_unix(sudo:session): session closed for user root Feb 26 20:08:38 usic volumio[5158]: info: CoreStateMachine::setRepeat null single undefined Feb 26 20:08:38 usic volumio[5158]: info: CoreStateMachine::pushState Feb 26 20:08:38 usic volumio[5158]: info: CorePlayQueue::getTrack 0 Feb 26 20:08:38 usic volumio[5158]: info: CoreCommandRouter::volumioPushState Feb 26 20:08:38 usic volumio[5158]: info: CoreStateMachine::setRandom null Feb 26 20:08:38 usic volumio[5158]: info: CoreStateMachine::pushState Feb 26 20:08:38 usic volumio[5158]: info: CorePlayQueue::getTrack 0 Feb 26 20:08:38 usic volumio[5158]: info: CoreCommandRouter::volumioPushState Feb 26 20:08:38 usic volumio[5158]: info: MPD Permissions set Feb 26 20:08:38 usic volumio[5158]: info: MPD Permissions set Feb 26 20:08:38 usic volumio[5158]: 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 26 20:08:38 usic volumio[5158]: info: VolumeController:: Volume=100 Mute =false Feb 26 20:08:38 usic volumio[5158]: info: CoreStateMachine::pushState Feb 26 20:08:38 usic volumio[5158]: info: CorePlayQueue::getTrack 0 Feb 26 20:08:38 usic volumio[5158]: info: CoreCommandRouter::volumioPushState Feb 26 20:08:38 usic volumio[5158]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:38 usic volumio[5158]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:38 usic volumio[5158]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:38 usic volumio[5158]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:38 usic volumio[5158]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:38 usic volumio[5158]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:38 usic volumio[5158]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:38 usic volumio[5158]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:39 usic volumio[5158]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 26 20:08:39 usic volumio[5158]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 26 20:08:39 usic volumio[5158]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:39 usic volumio[5158]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:39 usic volumio[5158]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:39 usic volumio[5158]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:39 usic volumio[5158]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:39 usic volumio[5158]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:39 usic volumio[5158]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:39 usic volumio[5158]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:39 usic volumio[5158]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:39 usic volumio[5158]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 26 20:08:39 usic volumio[5158]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 26 20:08:39 usic volumio[5158]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 26 20:08:39 usic volumio[5158]: info: Discovery: adding 4f54dfed-c19c-47a1-bae2-83b3668bd707 Feb 26 20:08:39 usic volumio[5158]: info: Discovery: Found device usic Feb 26 20:08:39 usic volumio[5158]: info: CoreCommandRouter::volumioGetState Feb 26 20:08:39 usic volumio[5158]: info: CorePlayQueue::getTrack 0 Feb 26 20:08:39 usic volumio[5158]: info: Cannot mount NAS NAS73 at system boot, trial number 2 ,retrying in 5 seconds Feb 26 20:08:39 usic volumio[5158]: info: CoreCommandRouter::volumioGetState Feb 26 20:08:39 usic volumio[5158]: info: CorePlayQueue::getTrack 0 Feb 26 20:08:40 usic volumio[5158]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 26 20:08:40 usic volumio[5158]: Error: getaddrinfo ENOTFOUND assets.fanart.tv Feb 26 20:08:40 usic volumio[5158]: at GetAddrInfoReqWrap.onlookup [as oncomplete] (dns.js:71:26) { Feb 26 20:08:40 usic volumio[5158]: errno: -3007, Feb 26 20:08:40 usic volumio[5158]: code: 'ENOTFOUND', Feb 26 20:08:40 usic volumio[5158]: syscall: 'getaddrinfo', Feb 26 20:08:40 usic volumio[5158]: hostname: 'assets.fanart.tv' Feb 26 20:08:40 usic volumio[5158]: } Feb 26 20:08:40 usic volumio[5158]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 26 20:08:41 usic mpd[5293]: Feb 26 20:08 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 26 20:08:41 usic systemd[1]: Started Music Player Daemon. Feb 26 20:08:41 usic sudo[5274]: pam_unix(sudo:session): session closed for user root Feb 26 20:08:41 usic sudo[5268]: pam_unix(sudo:session): session closed for user root Feb 26 20:08:41 usic sudo[5344]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-02-26 20:07 Feb 26 20:08:41 usic sudo[5344]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="cc50ad4a2058d01de272214eb33827883bd2b7d8" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="8bcc10c3dbcbcb349e9887dc0527d54876b32688" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 17 Nov 2025 09:38:04 PM CET" VOLUMIO_VERSION="3.875" VOLUMIO_HARDWARE="orangepipc" VOLUMIO_DEVICENAME="Orange Pi PC" VOLUMIO_HASH="f14a1b6604a50dfb96eb025c18ac7629"