-- Logs begin at Sun 2026-10-11 04:29:37 UTC, end at Sun 2026-10-11 04:34:37 UTC. -- Oct 11 04:33:00 volumio volumio[4256]: info: Loading plugin "network"... Oct 11 04:33:00 volumio volumio[4256]: info: Refreshing Cached IP Addresses Oct 11 04:33:00 volumio sudo[4279]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 11 04:33:00 volumio volumio[4256]: info: Loading plugin "services"... Oct 11 04:33:00 volumio volumio[4256]: info: Loading plugin "alsa_controller"... Oct 11 04:33:00 volumio sudo[4279]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 11 04:33:00 volumio sudo[4279]: pam_unix(sudo:session): session closed for user root Oct 11 04:33:00 volumio sudo[4282]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 11 04:33:00 volumio sudo[4282]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 11 04:33:00 volumio sudo[4282]: pam_unix(sudo:session): session closed for user root Oct 11 04:33:00 volumio volumio[4256]: info: Loading plugin "wizard"... Oct 11 04:33:00 volumio volumio[4256]: info: Loading plugin "volumio_command_line_client"... Oct 11 04:33:00 volumio volumio[4256]: info: Loading plugin "upnp"... Oct 11 04:33:00 volumio volumio[4256]: info: [1791693180847] Starting Upmpd Daemon Oct 11 04:33:00 volumio volumio[4256]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 11 04:33:00 volumio volumio[4256]: info: Loading plugin "my_music"... Oct 11 04:33:00 volumio volumio[4256]: info: Loading plugin "mpd"... Oct 11 04:33:01 volumio volumio[4256]: info: Loading plugin "upnp_browser"... Oct 11 04:33:01 volumio volumio[4256]: info: Loading plugin "networkfs"... Oct 11 04:33:01 volumio volumio[4256]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 11 04:33:01 volumio volumio[4256]: info: Loading plugin "alarm-clock"... Oct 11 04:33:01 volumio volumio[4256]: info: Loading plugin "airplay_emulation"... Oct 11 04:33:01 volumio volumio[4256]: info: Starting Shairport Sync Oct 11 04:33:01 volumio volumio[4256]: info: Loading plugin "last_100"... Oct 11 04:33:01 volumio volumio[4256]: info: Loading plugin "webradio"... Oct 11 04:33:01 volumio volumio[4256]: info: Loading plugin "i2s_dacs"... Oct 11 04:33:01 volumio volumio[4256]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 11 04:33:01 volumio volumio[4256]: info: Loading plugin "volumiodiscovery"... Oct 11 04:33:01 volumio volumio[4256]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 11 04:33:01 volumio node[4256]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 11 04:33:01 volumio node[4256]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 11 04:33:01 volumio node[4256]: *** WARNING *** For more information see Oct 11 04:33:01 volumio node[4256]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 11 04:33:01 volumio node[4256]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 11 04:33:01 volumio node[4256]: *** WARNING *** For more information see Oct 11 04:33:01 volumio volumio[4256]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 11 04:33:01 volumio volumio[4256]: *** WARNING *** For more information see Oct 11 04:33:01 volumio volumio[4256]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 11 04:33:01 volumio volumio[4256]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 11 04:33:01 volumio volumio[4256]: *** WARNING *** For more information see Oct 11 04:33:01 volumio volumio[4256]: info: Applying required configuration parameters for plugin volumiodiscovery Oct 11 04:33:01 volumio volumio[4256]: Discovery: StartAdv! undefined Oct 11 04:33:01 volumio volumio[4256]: Discovery: Started advertising... Volumio - undefined Oct 11 04:33:01 volumio volumio[4256]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 11 04:33:01 volumio volumio[4256]: info: Plugin volsimpleequal is not enabled Oct 11 04:33:01 volumio volumio[4256]: info: Loading plugin "auto_play"... Oct 11 04:33:01 volumio volumio[4256]: info: ControllerAutoPlay - connecting mpd on host: localhost; port: 6600 Oct 11 04:33:01 volumio volumio[4256]: info: Loading plugin "outputs"... Oct 11 04:33:01 volumio volumio[4256]: info: Loading plugin "albumart"... Oct 11 04:33:01 volumio volumio[4256]: info: Plugin example_plugin is not enabled Oct 11 04:33:01 volumio volumio[4256]: info: Loading plugin "inputs"... Oct 11 04:33:01 volumio volumio[4256]: info: Loading plugin "updater_comm"... Oct 11 04:33:01 volumio volumio[4256]: info: Plugin mpdemulation is not enabled Oct 11 04:33:01 volumio volumio[4256]: info: Loading plugin "rest_api"... Oct 11 04:33:01 volumio volumio[4256]: info: Loading plugin "websocket"... Oct 11 04:33:01 volumio volumio[4256]: info: Loading plugin "RoonBridge"... Oct 11 04:33:01 volumio volumio[4256]: Forking 3 albumart workers Oct 11 04:33:01 volumio volumio[4256]: info: Applying required configuration parameters for plugin RoonBridge Oct 11 04:33:01 volumio volumio[4256]: info: Loading plugin "lms"... Oct 11 04:33:02 volumio volumio[4256]: info: Loading plugin "squeezelite"... Oct 11 04:33:02 volumio volumio[4256]: info: Squeezelite initiated Oct 11 04:33:02 volumio volumio[4256]: info: ___________ START PLUGINS ___________ Oct 11 04:33:02 volumio volumio[4256]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 11 04:33:02 volumio volumio[4256]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 11 04:33:02 volumio volumio[4256]: info: [1791693182258] CoreMusicLibrary::Adding element Media Servers Oct 11 04:33:02 volumio volumio[4256]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 11 04:33:02 volumio volumio[4256]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 11 04:33:02 volumio volumio[4256]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 11 04:33:02 volumio volumio[4256]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 11 04:33:02 volumio volumio[4256]: info: [1791693182372] CoreMusicLibrary::Adding element Last_100 Oct 11 04:33:02 volumio volumio[4256]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 11 04:33:02 volumio volumio[4256]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 11 04:33:02 volumio volumio[4256]: info: [1791693182374] CoreMusicLibrary::Adding element Webradio Oct 11 04:33:02 volumio volumio[4256]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 11 04:33:02 volumio volumio[4256]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 11 04:33:02 volumio volumio[4256]: Starting albumart workers Oct 11 04:33:02 volumio volumio[4256]: Starting albumart workers Oct 11 04:33:02 volumio volumio[4256]: Starting albumart workers Oct 11 04:33:02 volumio volumio[4256]: info: ------------------------------------------- Oct 11 04:33:02 volumio volumio[4256]: info: ----- MyVolumio plugins startup ---- Oct 11 04:33:02 volumio volumio[4256]: info: ------------------------------------------- Oct 11 04:33:02 volumio volumio[4256]: info: [MyVolumio PluginManager] Fetching plans data.... Oct 11 04:33:02 volumio volumio[4256]: info: Loading i18n strings for locale ja Oct 11 04:33:02 volumio sudo[4336]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start roonbridge.service Oct 11 04:33:02 volumio volumio[4256]: Updating browse sources language Oct 11 04:33:02 volumio volumio[4256]: Cannot find translation for sourceMedia Servers Oct 11 04:33:02 volumio sudo[4338]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart logitechmediaserver Oct 11 04:33:02 volumio volumio[4256]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 11 04:33:02 volumio sudo[4336]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 11 04:33:02 volumio sudo[4339]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Oct 11 04:33:02 volumio sudo[4338]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 11 04:33:02 volumio sudo[4339]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 11 04:33:02 volumio volumio[4256]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 11 04:33:02 volumio volumio[4256]: info: CoreCommandRouter::initPlayerControls Oct 11 04:33:02 volumio volumio[4256]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 04:33:02 volumio volumio[4256]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Oct 11 04:33:02 volumio systemd[1]: Starting Logitech Media Server Daemon... Oct 11 04:33:02 volumio sudo[4336]: pam_unix(sudo:session): session closed for user root Oct 11 04:33:02 volumio systemd[1]: Started Logitech Media Server Daemon. Oct 11 04:33:02 volumio systemd[4359]: Failed at step EXEC spawning /usr/sbin/squeezeboxserver: No such file or directory Oct 11 04:33:02 volumio sudo[4338]: pam_unix(sudo:session): session closed for user root Oct 11 04:33:02 volumio systemd[1]: logitechmediaserver.service: main process exited, code=exited, status=203/EXEC Oct 11 04:33:02 volumio systemd[1]: Unit logitechmediaserver.service entered failed state. Oct 11 04:33:02 volumio systemd[1]: Reloading. Oct 11 04:33:02 volumio volumio[4256]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 04:33:02 volumio volumio[4256]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 04:33:02 volumio volumio[4256]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 04:33:02 volumio volumio[4256]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 04:33:02 volumio volumio[4256]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 04:33:02 volumio volumio[4256]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 11 04:33:02 volumio volumio[4256]: info: BOOT COMPLETED Oct 11 04:33:02 volumio volumio[4256]: [Metrics] CommandRouter: 3s 571.22ms Oct 11 04:33:02 volumio volumio[4256]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 11 04:33:02 volumio systemd[1]: [/lib/systemd/system/mpd.service:18] Unknown lvalue 'ProtectKernelTunables' in section 'Service' Oct 11 04:33:02 volumio systemd[1]: [/lib/systemd/system/mpd.service:19] Unknown lvalue 'ProtectControlGroups' in section 'Service' Oct 11 04:33:02 volumio systemd[1]: [/lib/systemd/system/mpd.service:20] Unknown lvalue 'ProtectKernelModules' in section 'Service' Oct 11 04:33:02 volumio systemd[1]: [/lib/systemd/system/mpd.service:23] Unknown lvalue 'RestrictNamespaces' in section 'Service' Oct 11 04:33:02 volumio sudo[4339]: pam_unix(sudo:session): session closed for user root Oct 11 04:33:07 volumio volumio-remote-updater[582]: [2026-10-11 04:33:07] [connect] Successful connection Oct 11 04:33:07 volumio volumio[4256]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Oct 11 04:33:07 volumio volumio[4256]: info: CoreCommandRouter::Close All Modals sent Oct 11 04:33:07 volumio volumio[4256]: info: CoreCommandRouter::Close All Modals sent Oct 11 04:33:07 volumio volumio[4256]: Express server listening on port 3000 Oct 11 04:33:07 volumio volumio[4256]: [Metrics] WebUI: 9s 167.42ms Oct 11 04:33:07 volumio volumio[4256]: Volumio Calling Home Oct 11 04:33:08 volumio volumio[4256]: info: CoreStateMachine::resetVolumioState Oct 11 04:33:08 volumio volumio[4256]: info: CoreStateMachine::getcurrentVolume Oct 11 04:33:08 volumio volumio[4256]: info: CoreCommandRouter::volumioRetrievevolume Oct 11 04:33:08 volumio volumio[4256]: info: CoreStateMachine::pushState Oct 11 04:33:08 volumio volumio[4256]: info: CorePlayQueue::getTrack 0 Oct 11 04:33:08 volumio volumio[4256]: info: CoreCommandRouter::volumioPushState Oct 11 04:33:08 volumio volumio[4256]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 11 04:33:08 volumio volumio[4256]: Unhandled rejection Error: No sockets available, cannot start. Oct 11 04:33:08 volumio volumio[4256]: at SsdpClient.SSDP._createSockets (/volumio/node_modules/node-ssdp/lib/index.js:186:11) Oct 11 04:33:08 volumio volumio[4256]: at SsdpClient.SSDP._start (/volumio/node_modules/node-ssdp/lib/index.js:229:10) Oct 11 04:33:08 volumio volumio[4256]: at /volumio/node_modules/node-ssdp/lib/client.js:60:10 Oct 11 04:33:08 volumio volumio[4256]: at Promise._execute (/volumio/node_modules/bluebird/js/release/debuggability.js:384:9) Oct 11 04:33:08 volumio volumio[4256]: at Promise._resolveFromExecutor (/volumio/node_modules/bluebird/js/release/promise.js:518:18) Oct 11 04:33:08 volumio volumio[4256]: at new Promise (/volumio/node_modules/bluebird/js/release/promise.js:103:10) Oct 11 04:33:08 volumio volumio[4256]: at SsdpClient.start (/volumio/node_modules/node-ssdp/lib/client.js:54:10) Oct 11 04:33:08 volumio volumio[4256]: at SsdpClient.search (/volumio/node_modules/node-ssdp/lib/client.js:82:17) Oct 11 04:33:08 volumio volumio[4256]: at ControllerUPNPBrowser.onStart (/volumio/app/plugins/music_service/upnp_browser/index.js:126:12) Oct 11 04:33:08 volumio volumio[4256]: at PluginManager.startCorePlugin (/volumio/app/pluginmanager.js:282:30) Oct 11 04:33:08 volumio volumio[4256]: at HashMap. (/volumio/app/pluginmanager.js:377:31) Oct 11 04:33:08 volumio volumio[4256]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Oct 11 04:33:08 volumio volumio[4256]: at HashMap.proto.(anonymous function) [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Oct 11 04:33:08 volumio volumio[4256]: at PluginManager.startCorePlugins (/volumio/app/pluginmanager.js:376:20) Oct 11 04:33:08 volumio volumio[4256]: at PluginManager.startPlugins (/volumio/app/pluginmanager.js:95:8) Oct 11 04:33:08 volumio volumio[4256]: at new CoreCommandRouter (/volumio/app/index.js:45:22) Oct 11 04:33:08 volumio volumio[4256]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 11 04:33:08 volumio volumio[4256]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 04:33:08 volumio volumio[4256]: info: Setting Device type: Raspberry PI Oct 11 04:33:08 volumio volumio[4256]: info: squeezelite reloaded Oct 11 04:33:08 volumio volumio[4256]: info: logitechmediaserver started Oct 11 04:33:08 volumio volumio[4256]: error: Cannot start Roon Bridge Error: Command failed: /usr/bin/sudo /bin/systemctl start roonbridge.service Oct 11 04:33:08 volumio volumio[4256]: Failed to start roonbridge.service: Unit roonbridge.service failed to load: No such file or directory. Oct 11 04:33:08 volumio volumio[4256]: error: Cannot initialize MPD Connection: MPD is not running Oct 11 04:33:08 volumio sudo[4415]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart squeezelite Oct 11 04:33:08 volumio sudo[4415]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 11 04:33:08 volumio systemd[1]: Stopping Squeezelite lightweight headless Squeezebox emulator... Oct 11 04:33:08 volumio volumio[4256]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 11 04:33:08 volumio volumio[4256]: { Error: connect ECONNREFUSED 127.0.0.1:6600 Oct 11 04:33:08 volumio volumio[4256]: at Object._errnoException (util.js:1022:11) Oct 11 04:33:08 volumio volumio[4256]: at _exceptionWithHostPort (util.js:1044:20) Oct 11 04:33:08 volumio volumio[4256]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Oct 11 04:33:08 volumio volumio[4256]: code: 'ECONNREFUSED', Oct 11 04:33:08 volumio volumio[4256]: errno: 'ECONNREFUSED', Oct 11 04:33:08 volumio volumio[4256]: syscall: 'connect', Oct 11 04:33:08 volumio volumio[4256]: address: '127.0.0.1', Oct 11 04:33:08 volumio volumio[4256]: port: 6600 } Oct 11 04:33:08 volumio volumio[4256]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 11 04:33:08 volumio systemd[1]: Starting Squeezelite lightweight headless Squeezebox emulator... Oct 11 04:33:08 volumio systemd[1]: Started Squeezelite lightweight headless Squeezebox emulator. Oct 11 04:33:08 volumio sudo[4415]: pam_unix(sudo:session): session closed for user root Oct 11 04:33:08 volumio sudo[4436]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-10-11 04:32 Oct 11 04:33:08 volumio sudo[4436]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 11 04:33:08 volumio sudo[4436]: pam_unix(sudo:session): session closed for user root Oct 11 04:33:08 volumio volumio-remote-updater[582]: [2026-10-11 04:33:08] [info] asio async_read_at_least error: system:104 (Connection reset by peer) Oct 11 04:33:08 volumio volumio-remote-updater[582]: [2026-10-11 04:33:08] [error] handle_read_http_response error: websocketpp.transport:2 (Underlying Transport Error) Oct 11 04:33:08 volumio volumio-remote-updater[582]: [2026-10-11 04:33:08] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Oct 11 04:33:08 volumio systemd[1]: volumio.service: main process exited, code=exited, status=1/FAILURE Oct 11 04:33:08 volumio systemd[1]: Unit volumio.service entered failed state. Oct 11 04:33:08 volumio systemd[1]: Starting dynamicswap service... Oct 11 04:33:08 volumio systemd[1]: Started dynamicswap service. Oct 11 04:33:09 volumio systemd[1]: volumio.service holdoff time over, scheduling restart. Oct 11 04:33:09 volumio systemd[1]: Starting dynamicswap service... Oct 11 04:33:09 volumio systemd[1]: Started dynamicswap service. Oct 11 04:33:09 volumio systemd[1]: Stopping Volumio Backend Module... Oct 11 04:33:09 volumio systemd[1]: Starting Volumio Backend Module... Oct 11 04:33:09 volumio systemd[1]: Started Volumio Backend Module. Oct 11 04:33:10 volumio volumio[4460]: info: ------------------------------------------- Oct 11 04:33:10 volumio volumio[4460]: info: ----- Volumio2 ---- Oct 11 04:33:10 volumio volumio[4460]: info: ------------------------------------------- Oct 11 04:33:10 volumio volumio[4460]: info: ----- System startup ---- Oct 11 04:33:10 volumio volumio[4460]: info: ------------------------------------------- Oct 11 04:33:10 volumio volumio[4460]: info: MYVOLUMIO Environment detected Oct 11 04:33:10 volumio volumio[4460]: info: Plugin folders cleanup Oct 11 04:33:10 volumio volumio[4460]: info: Scanning into folder /volumio/app/plugins/ Oct 11 04:33:10 volumio volumio[4460]: info: Scanning category audio_interface Oct 11 04:33:10 volumio volumio[4460]: info: Scanning category miscellanea Oct 11 04:33:10 volumio volumio[4460]: info: Scanning category music_service Oct 11 04:33:10 volumio volumio[4460]: info: Scanning category plugins.json Oct 11 04:33:10 volumio volumio[4460]: info: Scanning category system_controller Oct 11 04:33:10 volumio volumio[4460]: info: Scanning category user_interface Oct 11 04:33:10 volumio volumio[4460]: info: Scanning into folder /data/plugins/ Oct 11 04:33:10 volumio volumio[4460]: info: Scanning category audio_interface Oct 11 04:33:10 volumio volumio[4460]: info: Scanning category miscellanea Oct 11 04:33:10 volumio volumio[4460]: info: Scanning category music_service Oct 11 04:33:10 volumio volumio[4460]: info: Plugin folders cleanup completed Oct 11 04:33:10 volumio volumio[4460]: info: ------------------------------------------- Oct 11 04:33:10 volumio volumio[4460]: info: ----- Core plugins startup ---- Oct 11 04:33:10 volumio volumio[4460]: info: ------------------------------------------- Oct 11 04:33:10 volumio volumio[4460]: info: Loading plugins from folder /volumio/app/plugins/ Oct 11 04:33:10 volumio volumio[4460]: info: Adding plugin upnp to MyMusic Plugins Oct 11 04:33:10 volumio volumio[4460]: info: Adding plugin airplay_emulation to MyMusic Plugins Oct 11 04:33:10 volumio volumio[4460]: info: Adding plugin upnp_browser to MyMusic Plugins Oct 11 04:33:10 volumio volumio[4460]: info: Loading plugins from folder /data/plugins/ Oct 11 04:33:10 volumio volumio[4460]: info: Loading plugin "system"... Oct 11 04:33:10 volumio volumio[4460]: info: Loading plugin "appearance"... Oct 11 04:33:11 volumio volumio[4460]: info: Loading plugin "network"... Oct 11 04:33:11 volumio volumio[4460]: info: Refreshing Cached IP Addresses Oct 11 04:33:11 volumio sudo[4485]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 11 04:33:11 volumio volumio[4460]: info: Loading plugin "services"... Oct 11 04:33:11 volumio volumio[4460]: info: Loading plugin "alsa_controller"... Oct 11 04:33:11 volumio sudo[4485]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 11 04:33:11 volumio sudo[4485]: pam_unix(sudo:session): session closed for user root Oct 11 04:33:11 volumio sudo[4488]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 11 04:33:11 volumio sudo[4488]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 11 04:33:11 volumio sudo[4488]: pam_unix(sudo:session): session closed for user root Oct 11 04:33:11 volumio volumio[4460]: info: Loading plugin "wizard"... Oct 11 04:33:11 volumio volumio[4460]: info: Loading plugin "volumio_command_line_client"... Oct 11 04:33:11 volumio volumio[4460]: info: Loading plugin "upnp"... Oct 11 04:33:11 volumio volumio[4460]: info: [1791693191830] Starting Upmpd Daemon Oct 11 04:33:11 volumio volumio[4460]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 11 04:33:11 volumio volumio[4460]: info: Loading plugin "my_music"... Oct 11 04:33:11 volumio volumio[4460]: info: Loading plugin "mpd"... Oct 11 04:33:12 volumio volumio[4460]: info: Loading plugin "upnp_browser"... Oct 11 04:33:12 volumio volumio[4460]: info: Loading plugin "networkfs"... Oct 11 04:33:12 volumio volumio[4460]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 11 04:33:12 volumio volumio[4460]: info: Loading plugin "alarm-clock"... Oct 11 04:33:12 volumio volumio[4460]: info: Loading plugin "airplay_emulation"... Oct 11 04:33:12 volumio volumio[4460]: info: Starting Shairport Sync Oct 11 04:33:12 volumio volumio[4460]: info: Loading plugin "last_100"... Oct 11 04:33:12 volumio volumio[4460]: info: Loading plugin "webradio"... Oct 11 04:33:12 volumio volumio[4460]: info: Loading plugin "i2s_dacs"... Oct 11 04:33:12 volumio volumio[4460]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 11 04:33:12 volumio volumio[4460]: info: Loading plugin "volumiodiscovery"... Oct 11 04:33:12 volumio volumio[4460]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 11 04:33:12 volumio node[4460]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 11 04:33:12 volumio node[4460]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 11 04:33:12 volumio node[4460]: *** WARNING *** For more information see Oct 11 04:33:12 volumio node[4460]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 11 04:33:12 volumio node[4460]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 11 04:33:12 volumio node[4460]: *** WARNING *** For more information see Oct 11 04:33:12 volumio volumio[4460]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 11 04:33:12 volumio volumio[4460]: *** WARNING *** For more information see Oct 11 04:33:12 volumio volumio[4460]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 11 04:33:12 volumio volumio[4460]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 11 04:33:12 volumio volumio[4460]: *** WARNING *** For more information see Oct 11 04:33:12 volumio volumio[4460]: info: Applying required configuration parameters for plugin volumiodiscovery Oct 11 04:33:12 volumio volumio[4460]: Discovery: StartAdv! undefined Oct 11 04:33:12 volumio volumio[4460]: Discovery: Started advertising... Volumio - undefined Oct 11 04:33:12 volumio volumio[4460]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 11 04:33:12 volumio volumio[4460]: info: Plugin volsimpleequal is not enabled Oct 11 04:33:12 volumio volumio[4460]: info: Loading plugin "auto_play"... Oct 11 04:33:12 volumio volumio[4460]: info: ControllerAutoPlay - connecting mpd on host: localhost; port: 6600 Oct 11 04:33:12 volumio volumio[4460]: info: Loading plugin "outputs"... Oct 11 04:33:12 volumio volumio[4460]: info: Loading plugin "albumart"... Oct 11 04:33:12 volumio volumio[4460]: info: Plugin example_plugin is not enabled Oct 11 04:33:12 volumio volumio[4460]: info: Loading plugin "inputs"... Oct 11 04:33:12 volumio volumio[4460]: info: Loading plugin "updater_comm"... Oct 11 04:33:12 volumio volumio[4460]: info: Plugin mpdemulation is not enabled Oct 11 04:33:12 volumio volumio[4460]: info: Loading plugin "rest_api"... Oct 11 04:33:12 volumio volumio[4460]: info: Loading plugin "websocket"... Oct 11 04:33:12 volumio volumio[4460]: info: Loading plugin "RoonBridge"... Oct 11 04:33:12 volumio volumio[4460]: Forking 3 albumart workers Oct 11 04:33:12 volumio volumio[4460]: info: Applying required configuration parameters for plugin RoonBridge Oct 11 04:33:12 volumio volumio[4460]: info: Loading plugin "lms"... Oct 11 04:33:13 volumio volumio[4460]: info: Loading plugin "squeezelite"... Oct 11 04:33:13 volumio volumio[4460]: info: Squeezelite initiated Oct 11 04:33:13 volumio volumio[4460]: info: ___________ START PLUGINS ___________ Oct 11 04:33:13 volumio volumio[4460]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 11 04:33:13 volumio volumio[4460]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 11 04:33:13 volumio volumio[4460]: info: [1791693193221] CoreMusicLibrary::Adding element Media Servers Oct 11 04:33:13 volumio volumio[4460]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 11 04:33:13 volumio volumio[4460]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 11 04:33:13 volumio volumio[4460]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 11 04:33:13 volumio volumio[4460]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 11 04:33:13 volumio volumio[4460]: info: [1791693193334] CoreMusicLibrary::Adding element Last_100 Oct 11 04:33:13 volumio volumio[4460]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 11 04:33:13 volumio volumio[4460]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 11 04:33:13 volumio volumio[4460]: info: [1791693193337] CoreMusicLibrary::Adding element Webradio Oct 11 04:33:13 volumio volumio[4460]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 11 04:33:13 volumio volumio[4460]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 11 04:33:13 volumio volumio[4460]: Starting albumart workers Oct 11 04:33:13 volumio volumio[4460]: Starting albumart workers Oct 11 04:33:13 volumio volumio[4460]: Starting albumart workers Oct 11 04:33:13 volumio sudo[4543]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart logitechmediaserver Oct 11 04:33:13 volumio volumio[4460]: info: ------------------------------------------- Oct 11 04:33:13 volumio volumio[4460]: info: ----- MyVolumio plugins startup ---- Oct 11 04:33:13 volumio volumio[4460]: info: ------------------------------------------- Oct 11 04:33:13 volumio sudo[4542]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start roonbridge.service Oct 11 04:33:13 volumio volumio[4460]: info: [MyVolumio PluginManager] Fetching plans data.... Oct 11 04:33:13 volumio volumio[4460]: info: Loading i18n strings for locale ja Oct 11 04:33:13 volumio sudo[4543]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 11 04:33:13 volumio sudo[4542]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 11 04:33:13 volumio volumio[4460]: Updating browse sources language Oct 11 04:33:13 volumio volumio[4460]: Cannot find translation for sourceMedia Servers Oct 11 04:33:13 volumio volumio[4460]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 11 04:33:13 volumio volumio[4460]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 11 04:33:13 volumio volumio[4460]: info: CoreCommandRouter::initPlayerControls Oct 11 04:33:13 volumio systemd[1]: Starting Logitech Media Server Daemon... Oct 11 04:33:13 volumio sudo[4551]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Oct 11 04:33:13 volumio sudo[4542]: pam_unix(sudo:session): session closed for user root Oct 11 04:33:13 volumio volumio[4460]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 04:33:13 volumio volumio[4460]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Oct 11 04:33:13 volumio systemd[1]: Started Logitech Media Server Daemon. Oct 11 04:33:13 volumio sudo[4543]: pam_unix(sudo:session): session closed for user root Oct 11 04:33:13 volumio sudo[4551]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 11 04:33:13 volumio systemd[4562]: Failed at step EXEC spawning /usr/sbin/squeezeboxserver: No such file or directory Oct 11 04:33:13 volumio systemd[1]: logitechmediaserver.service: main process exited, code=exited, status=203/EXEC Oct 11 04:33:13 volumio systemd[1]: Unit logitechmediaserver.service entered failed state. Oct 11 04:33:13 volumio systemd[1]: Reloading. Oct 11 04:33:13 volumio volumio[4460]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 04:33:13 volumio volumio[4460]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 04:33:13 volumio volumio[4460]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 04:33:13 volumio volumio[4460]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 04:33:13 volumio volumio[4460]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 04:33:13 volumio volumio[4460]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 11 04:33:13 volumio volumio[4460]: info: BOOT COMPLETED Oct 11 04:33:13 volumio volumio[4460]: [Metrics] CommandRouter: 3s 591.53ms Oct 11 04:33:13 volumio volumio[4460]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 11 04:33:13 volumio systemd[1]: [/lib/systemd/system/mpd.service:18] Unknown lvalue 'ProtectKernelTunables' in section 'Service' Oct 11 04:33:13 volumio systemd[1]: [/lib/systemd/system/mpd.service:19] Unknown lvalue 'ProtectControlGroups' in section 'Service' Oct 11 04:33:13 volumio systemd[1]: [/lib/systemd/system/mpd.service:20] Unknown lvalue 'ProtectKernelModules' in section 'Service' Oct 11 04:33:13 volumio systemd[1]: [/lib/systemd/system/mpd.service:23] Unknown lvalue 'RestrictNamespaces' in section 'Service' Oct 11 04:33:13 volumio sudo[4551]: pam_unix(sudo:session): session closed for user root Oct 11 04:33:18 volumio dhcpcd[881]: eth0: carrier acquired Oct 11 04:33:18 volumio kernel: bcmgenet fd580000.genet eth0: Link is Up - 100Mbps/Full - flow control rx/tx Oct 11 04:33:18 volumio volumio-remote-updater[582]: [2026-10-11 04:33:18] [connect] Successful connection Oct 11 04:33:18 volumio volumio[4460]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Oct 11 04:33:18 volumio volumio[4460]: info: CoreCommandRouter::Close All Modals sent Oct 11 04:33:18 volumio volumio[4460]: info: CoreCommandRouter::Close All Modals sent Oct 11 04:33:18 volumio volumio[4460]: Express server listening on port 3000 Oct 11 04:33:18 volumio volumio[4460]: [Metrics] WebUI: 9s 198.27ms Oct 11 04:33:19 volumio volumio[4460]: Volumio Calling Home Oct 11 04:33:19 volumio volumio[4460]: info: CoreStateMachine::resetVolumioState Oct 11 04:33:19 volumio volumio[4460]: info: CoreStateMachine::getcurrentVolume Oct 11 04:33:19 volumio volumio[4460]: info: CoreCommandRouter::volumioRetrievevolume Oct 11 04:33:19 volumio volumio[4460]: info: CoreStateMachine::pushState Oct 11 04:33:19 volumio volumio[4460]: info: CorePlayQueue::getTrack 0 Oct 11 04:33:19 volumio volumio[4460]: info: CoreCommandRouter::volumioPushState Oct 11 04:33:19 volumio volumio[4460]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 11 04:33:19 volumio volumio[4460]: Unhandled rejection Error: No sockets available, cannot start. Oct 11 04:33:19 volumio volumio[4460]: at SsdpClient.SSDP._createSockets (/volumio/node_modules/node-ssdp/lib/index.js:186:11) Oct 11 04:33:19 volumio volumio[4460]: at SsdpClient.SSDP._start (/volumio/node_modules/node-ssdp/lib/index.js:229:10) Oct 11 04:33:19 volumio volumio[4460]: at /volumio/node_modules/node-ssdp/lib/client.js:60:10 Oct 11 04:33:19 volumio volumio[4460]: at Promise._execute (/volumio/node_modules/bluebird/js/release/debuggability.js:384:9) Oct 11 04:33:19 volumio volumio[4460]: at Promise._resolveFromExecutor (/volumio/node_modules/bluebird/js/release/promise.js:518:18) Oct 11 04:33:19 volumio volumio[4460]: at new Promise (/volumio/node_modules/bluebird/js/release/promise.js:103:10) Oct 11 04:33:19 volumio volumio[4460]: at SsdpClient.start (/volumio/node_modules/node-ssdp/lib/client.js:54:10) Oct 11 04:33:19 volumio volumio[4460]: at SsdpClient.search (/volumio/node_modules/node-ssdp/lib/client.js:82:17) Oct 11 04:33:19 volumio volumio[4460]: at ControllerUPNPBrowser.onStart (/volumio/app/plugins/music_service/upnp_browser/index.js:126:12) Oct 11 04:33:19 volumio volumio[4460]: at PluginManager.startCorePlugin (/volumio/app/pluginmanager.js:282:30) Oct 11 04:33:19 volumio volumio[4460]: at HashMap. (/volumio/app/pluginmanager.js:377:31) Oct 11 04:33:19 volumio volumio[4460]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Oct 11 04:33:19 volumio volumio[4460]: at HashMap.proto.(anonymous function) [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Oct 11 04:33:19 volumio volumio[4460]: at PluginManager.startCorePlugins (/volumio/app/pluginmanager.js:376:20) Oct 11 04:33:19 volumio volumio[4460]: at PluginManager.startPlugins (/volumio/app/pluginmanager.js:95:8) Oct 11 04:33:19 volumio volumio[4460]: at new CoreCommandRouter (/volumio/app/index.js:45:22) Oct 11 04:33:19 volumio volumio[4460]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 11 04:33:19 volumio volumio[4460]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 04:33:19 volumio volumio[4460]: info: Setting Device type: Raspberry PI Oct 11 04:33:19 volumio volumio[4460]: info: squeezelite reloaded Oct 11 04:33:19 volumio volumio[4460]: info: logitechmediaserver started Oct 11 04:33:19 volumio volumio[4460]: error: Cannot start Roon Bridge Error: Command failed: /usr/bin/sudo /bin/systemctl start roonbridge.service Oct 11 04:33:19 volumio volumio[4460]: Failed to start roonbridge.service: Unit roonbridge.service failed to load: No such file or directory. Oct 11 04:33:19 volumio volumio[4460]: error: Cannot initialize MPD Connection: MPD is not running Oct 11 04:33:19 volumio sudo[4622]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart squeezelite Oct 11 04:33:19 volumio sudo[4622]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 11 04:33:19 volumio volumio[4460]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 11 04:33:19 volumio volumio[4460]: { Error: connect ECONNREFUSED 127.0.0.1:6600 Oct 11 04:33:19 volumio volumio[4460]: at Object._errnoException (util.js:1022:11) Oct 11 04:33:19 volumio volumio[4460]: at _exceptionWithHostPort (util.js:1044:20) Oct 11 04:33:19 volumio volumio[4460]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Oct 11 04:33:19 volumio volumio[4460]: code: 'ECONNREFUSED', Oct 11 04:33:19 volumio volumio[4460]: errno: 'ECONNREFUSED', Oct 11 04:33:19 volumio volumio[4460]: syscall: 'connect', Oct 11 04:33:19 volumio volumio[4460]: address: '127.0.0.1', Oct 11 04:33:19 volumio volumio[4460]: port: 6600 } Oct 11 04:33:19 volumio systemd[1]: Stopping Squeezelite lightweight headless Squeezebox emulator... Oct 11 04:33:19 volumio volumio[4460]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 11 04:33:19 volumio ifplugd(eth0)[684]: Link beat detected. Oct 11 04:33:19 volumio dhcpcd[881]: eth0: soliciting a DHCP lease Oct 11 04:33:19 volumio systemd[1]: Starting Squeezelite lightweight headless Squeezebox emulator... Oct 11 04:33:19 volumio systemd[1]: Started Squeezelite lightweight headless Squeezebox emulator. Oct 11 04:33:19 volumio sudo[4622]: pam_unix(sudo:session): session closed for user root Oct 11 04:33:19 volumio ifplugd(eth0)[684]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Oct 11 04:33:19 volumio dhcpcd[4658]: sending commands to master dhcpcd process Oct 11 04:33:19 volumio dhcpcd[881]: control command: dhcpcd eth0 Oct 11 04:33:19 volumio ifplugd(eth0)[684]: client: dhcpcd[4658]: sending commands to master dhcpcd process Oct 11 04:33:19 volumio systemd[1]: Reloading OpenBSD Secure Shell server. Oct 11 04:33:19 volumio sshd[741]: Received SIGHUP; restarting. Oct 11 04:33:19 volumio systemd[1]: Reloaded OpenBSD Secure Shell server. Oct 11 04:33:19 volumio sshd[741]: Server listening on 0.0.0.0 port 22. Oct 11 04:33:19 volumio sshd[741]: Server listening on :: port 22. Oct 11 04:33:19 volumio sudo[4730]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-10-11 04:32 Oct 11 04:33:19 volumio sudo[4730]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 11 04:33:19 volumio ifplugd(eth0)[684]: Program executed successfully. Oct 11 04:33:19 volumio sudo[4730]: pam_unix(sudo:session): session closed for user root Oct 11 04:33:20 volumio dhcpcd[881]: eth0: offered 192.168.1.8 from 192.168.1.1 Oct 11 04:33:20 volumio dhcpcd[881]: eth0: leased 192.168.1.8 for 14400 seconds Oct 11 04:33:20 volumio dhcpcd[881]: eth0: adding route to 192.168.1.0/24 Oct 11 04:33:20 volumio dhcpcd[881]: eth0: adding default route via 192.168.1.1 Oct 11 04:33:20 volumio avahi-daemon[644]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.1.8. Oct 11 04:33:20 volumio avahi-daemon[644]: New relevant interface eth0.IPv4 for mDNS. Oct 11 04:33:20 volumio avahi-daemon[644]: Registering new address record for 192.168.1.8 on eth0.IPv4. Oct 11 04:33:20 volumio nmbd[811]: [2026/10/11 04:33:20.187019, 0] ../lib/util/become_daemon.c:124(daemon_ready) Oct 11 04:33:20 volumio nmbd[811]: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Oct 11 04:33:20 volumio volumio-remote-updater[582]: [2026-10-11 04:33:20] [info] asio async_read_at_least error: system:104 (Connection reset by peer) Oct 11 04:33:20 volumio volumio-remote-updater[582]: [2026-10-11 04:33:20] [error] handle_read_http_response error: websocketpp.transport:2 (Underlying Transport Error) Oct 11 04:33:20 volumio volumio-remote-updater[582]: [2026-10-11 04:33:20] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Oct 11 04:33:20 volumio systemd[1]: volumio.service: main process exited, code=exited, status=1/FAILURE Oct 11 04:33:20 volumio systemd[1]: Unit volumio.service entered failed state. Oct 11 04:33:20 volumio systemd[1]: Starting dynamicswap service... Oct 11 04:33:20 volumio systemd[1]: Started dynamicswap service. Oct 11 04:33:20 volumio systemd[1]: volumio.service holdoff time over, scheduling restart. Oct 11 04:33:20 volumio systemd[1]: Starting dynamicswap service... Oct 11 04:33:20 volumio systemd[1]: Started dynamicswap service. Oct 11 04:33:20 volumio systemd[1]: Stopping Volumio Backend Module... Oct 11 04:33:20 volumio systemd[1]: Starting Volumio Backend Module... Oct 11 04:33:20 volumio systemd[1]: Started Volumio Backend Module. Oct 11 04:33:21 volumio ntpd[713]: Listen normally on 3 eth0 192.168.1.8 UDP 123 Oct 11 04:33:21 volumio ntpd[713]: peers refreshed Oct 11 04:33:21 volumio volumio[4776]: info: ------------------------------------------- Oct 11 04:33:21 volumio volumio[4776]: info: ----- Volumio2 ---- Oct 11 04:33:21 volumio volumio[4776]: info: ------------------------------------------- Oct 11 04:33:21 volumio volumio[4776]: info: ----- System startup ---- Oct 11 04:33:21 volumio volumio[4776]: info: ------------------------------------------- Oct 11 04:33:22 volumio volumio[4776]: info: MYVOLUMIO Environment detected Oct 11 04:33:22 volumio volumio[4776]: info: Plugin folders cleanup Oct 11 04:33:22 volumio volumio[4776]: info: Scanning into folder /volumio/app/plugins/ Oct 11 04:33:22 volumio volumio[4776]: info: Scanning category audio_interface Oct 11 04:33:22 volumio volumio[4776]: info: Scanning category miscellanea Oct 11 04:33:22 volumio volumio[4776]: info: Scanning category music_service Oct 11 04:33:22 volumio volumio[4776]: info: Scanning category plugins.json Oct 11 04:33:22 volumio volumio[4776]: info: Scanning category system_controller Oct 11 04:33:22 volumio volumio[4776]: info: Scanning category user_interface Oct 11 04:33:22 volumio volumio[4776]: info: Scanning into folder /data/plugins/ Oct 11 04:33:22 volumio volumio[4776]: info: Scanning category audio_interface Oct 11 04:33:22 volumio volumio[4776]: info: Scanning category miscellanea Oct 11 04:33:22 volumio volumio[4776]: info: Scanning category music_service Oct 11 04:33:22 volumio volumio[4776]: info: Plugin folders cleanup completed Oct 11 04:33:22 volumio volumio[4776]: info: ------------------------------------------- Oct 11 04:33:22 volumio volumio[4776]: info: ----- Core plugins startup ---- Oct 11 04:33:22 volumio volumio[4776]: info: ------------------------------------------- Oct 11 04:33:22 volumio volumio[4776]: info: Loading plugins from folder /volumio/app/plugins/ Oct 11 04:33:22 volumio volumio[4776]: info: Adding plugin upnp to MyMusic Plugins Oct 11 04:33:22 volumio volumio[4776]: info: Adding plugin airplay_emulation to MyMusic Plugins Oct 11 04:33:22 volumio volumio[4776]: info: Adding plugin upnp_browser to MyMusic Plugins Oct 11 04:33:22 volumio volumio[4776]: info: Loading plugins from folder /data/plugins/ Oct 11 04:33:22 volumio volumio[4776]: info: Loading plugin "system"... Oct 11 04:33:22 volumio volumio[4776]: info: Loading plugin "appearance"... Oct 11 04:33:23 volumio ntpd_intres[770]: DNS 0.debian.pool.ntp.org -> 140.245.90.15 Oct 11 04:33:23 volumio ntpd_intres[770]: DNS 1.debian.pool.ntp.org -> 167.179.119.205 Oct 11 04:33:23 volumio volumio[4776]: info: Loading plugin "network"... Oct 11 04:33:23 volumio volumio[4776]: info: Refreshing Cached IP Addresses Oct 11 04:33:23 volumio sudo[4801]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 11 04:33:23 volumio volumio[4776]: info: Loading plugin "services"... Oct 11 04:33:23 volumio volumio[4776]: info: Loading plugin "alsa_controller"... Oct 11 04:33:23 volumio sudo[4801]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 11 04:33:23 volumio sudo[4801]: pam_unix(sudo:session): session closed for user root Oct 11 04:33:23 volumio sudo[4804]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 11 04:33:23 volumio sudo[4804]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 11 04:33:23 volumio sudo[4804]: pam_unix(sudo:session): session closed for user root Oct 11 04:33:23 volumio volumio[4776]: info: Loading plugin "wizard"... Oct 11 04:33:23 volumio volumio[4776]: info: Loading plugin "volumio_command_line_client"... Oct 11 04:33:23 volumio ntpd_intres[770]: DNS 2.debian.pool.ntp.org -> 142.91.108.61 Oct 11 04:33:23 volumio volumio[4776]: info: Loading plugin "upnp"... Oct 11 04:33:23 volumio volumio[4776]: info: [1791693203593] Starting Upmpd Daemon Oct 11 04:33:23 volumio volumio[4776]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 11 04:33:23 volumio volumio[4776]: info: Loading plugin "my_music"... Oct 11 04:33:23 volumio volumio[4776]: info: Loading plugin "mpd"... Oct 11 04:33:23 volumio volumio[4776]: info: Loading plugin "upnp_browser"... Oct 11 04:33:23 volumio ntpd_intres[770]: DNS 3.debian.pool.ntp.org -> 208.88.66.8 Oct 11 04:33:24 volumio volumio[4776]: info: Loading plugin "networkfs"... Oct 11 04:33:24 volumio volumio[4776]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 11 04:33:24 volumio volumio[4776]: info: Loading plugin "alarm-clock"... Oct 11 04:33:24 volumio volumio[4776]: info: Loading plugin "airplay_emulation"... Oct 11 04:33:24 volumio volumio[4776]: info: Starting Shairport Sync Oct 11 04:33:24 volumio volumio[4776]: info: Loading plugin "last_100"... Oct 11 04:33:24 volumio volumio[4776]: info: Loading plugin "webradio"... Oct 11 04:33:24 volumio volumio[4776]: info: Loading plugin "i2s_dacs"... Oct 11 04:33:24 volumio volumio[4776]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 11 04:33:24 volumio volumio[4776]: info: Loading plugin "volumiodiscovery"... Oct 11 04:33:24 volumio volumio[4776]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 11 04:33:24 volumio node[4776]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 11 04:33:24 volumio node[4776]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 11 04:33:24 volumio node[4776]: *** WARNING *** For more information see Oct 11 04:33:24 volumio node[4776]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 11 04:33:24 volumio node[4776]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 11 04:33:24 volumio node[4776]: *** WARNING *** For more information see Oct 11 04:33:24 volumio volumio[4776]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 11 04:33:24 volumio volumio[4776]: *** WARNING *** For more information see Oct 11 04:33:24 volumio volumio[4776]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 11 04:33:24 volumio volumio[4776]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 11 04:33:24 volumio volumio[4776]: *** WARNING *** For more information see Oct 11 04:33:24 volumio volumio[4776]: info: Applying required configuration parameters for plugin volumiodiscovery Oct 11 04:33:24 volumio volumio[4776]: Discovery: StartAdv! undefined Oct 11 04:33:24 volumio volumio[4776]: Discovery: Started advertising... Volumio - undefined Oct 11 04:33:24 volumio volumio[4776]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 11 04:33:24 volumio volumio[4776]: info: Plugin volsimpleequal is not enabled Oct 11 04:33:24 volumio volumio[4776]: info: Loading plugin "auto_play"... Oct 11 04:33:24 volumio volumio[4776]: info: ControllerAutoPlay - connecting mpd on host: localhost; port: 6600 Oct 11 04:33:24 volumio volumio[4776]: info: Loading plugin "outputs"... Oct 11 04:33:24 volumio volumio[4776]: info: Loading plugin "albumart"... Oct 11 04:33:24 volumio volumio[4776]: info: Plugin example_plugin is not enabled Oct 11 04:33:24 volumio volumio[4776]: info: Loading plugin "inputs"... Oct 11 04:33:24 volumio volumio[4776]: info: Loading plugin "updater_comm"... Oct 11 04:33:24 volumio volumio[4776]: info: Plugin mpdemulation is not enabled Oct 11 04:33:24 volumio volumio[4776]: info: Loading plugin "rest_api"... Oct 11 04:33:24 volumio volumio[4776]: info: Loading plugin "websocket"... Oct 11 04:33:24 volumio volumio[4776]: info: Loading plugin "RoonBridge"... Oct 11 04:33:24 volumio volumio[4776]: Forking 3 albumart workers Oct 11 04:33:24 volumio volumio[4776]: info: Applying required configuration parameters for plugin RoonBridge Oct 11 04:33:24 volumio volumio[4776]: info: Loading plugin "lms"... Oct 11 04:33:24 volumio volumio[4776]: info: Loading plugin "squeezelite"... Oct 11 04:33:24 volumio volumio[4776]: info: Squeezelite initiated Oct 11 04:33:24 volumio volumio[4776]: info: ___________ START PLUGINS ___________ Oct 11 04:33:24 volumio volumio[4776]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 11 04:33:24 volumio volumio[4776]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 11 04:33:24 volumio volumio[4776]: info: [1791693204995] CoreMusicLibrary::Adding element Media Servers Oct 11 04:33:24 volumio volumio[4776]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 11 04:33:25 volumio volumio[4776]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 11 04:33:25 volumio volumio[4776]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 11 04:33:25 volumio volumio[4776]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 11 04:33:25 volumio volumio[4776]: info: [1791693205113] CoreMusicLibrary::Adding element Last_100 Oct 11 04:33:25 volumio volumio[4776]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 11 04:33:25 volumio volumio[4776]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 11 04:33:25 volumio volumio[4776]: info: [1791693205117] CoreMusicLibrary::Adding element Webradio Oct 11 04:33:25 volumio volumio[4776]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 11 04:33:25 volumio volumio[4776]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 11 04:33:25 volumio volumio[4776]: Starting albumart workers Oct 11 04:33:25 volumio volumio[4776]: Starting albumart workers Oct 11 04:33:25 volumio volumio[4776]: info: ------------------------------------------- Oct 11 04:33:25 volumio volumio[4776]: info: ----- MyVolumio plugins startup ---- Oct 11 04:33:25 volumio volumio[4776]: info: ------------------------------------------- Oct 11 04:33:25 volumio volumio[4776]: info: [MyVolumio PluginManager] Fetching plans data.... Oct 11 04:33:25 volumio volumio[4776]: info: Loading i18n strings for locale ja Oct 11 04:33:25 volumio volumio[4776]: Updating browse sources language Oct 11 04:33:25 volumio sudo[4858]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start roonbridge.service Oct 11 04:33:25 volumio volumio[4776]: Cannot find translation for sourceMedia Servers Oct 11 04:33:25 volumio volumio[4776]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 11 04:33:25 volumio sudo[4858]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 11 04:33:25 volumio volumio[4776]: Starting albumart workers Oct 11 04:33:25 volumio volumio[4776]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 11 04:33:25 volumio sudo[4859]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart logitechmediaserver Oct 11 04:33:25 volumio sudo[4862]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Oct 11 04:33:25 volumio volumio[4776]: info: CoreCommandRouter::initPlayerControls Oct 11 04:33:25 volumio volumio[4776]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 04:33:25 volumio volumio[4776]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Oct 11 04:33:25 volumio sudo[4859]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 11 04:33:25 volumio sudo[4862]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 11 04:33:25 volumio sudo[4858]: pam_unix(sudo:session): session closed for user root Oct 11 04:33:25 volumio systemd[1]: Reloading. Oct 11 04:33:25 volumio volumio[4776]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 04:33:25 volumio volumio[4776]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 04:33:25 volumio volumio[4776]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 04:33:25 volumio volumio[4776]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 04:33:25 volumio volumio[4776]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 04:33:25 volumio volumio[4776]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 11 04:33:25 volumio volumio[4776]: info: BOOT COMPLETED Oct 11 04:33:25 volumio volumio[4776]: [Metrics] CommandRouter: 3s 562.50ms Oct 11 04:33:25 volumio volumio[4776]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 11 04:33:25 volumio systemd[1]: [/lib/systemd/system/mpd.service:18] Unknown lvalue 'ProtectKernelTunables' in section 'Service' Oct 11 04:33:25 volumio systemd[1]: [/lib/systemd/system/mpd.service:19] Unknown lvalue 'ProtectControlGroups' in section 'Service' Oct 11 04:33:25 volumio systemd[1]: [/lib/systemd/system/mpd.service:20] Unknown lvalue 'ProtectKernelModules' in section 'Service' Oct 11 04:33:25 volumio systemd[1]: [/lib/systemd/system/mpd.service:23] Unknown lvalue 'RestrictNamespaces' in section 'Service' Oct 11 04:33:25 volumio sudo[4862]: pam_unix(sudo:session): session closed for user root Oct 11 04:33:25 volumio systemd[1]: Starting Logitech Media Server Daemon... Oct 11 04:33:25 volumio systemd[1]: Started Logitech Media Server Daemon. Oct 11 04:33:25 volumio sudo[4859]: pam_unix(sudo:session): session closed for user root Oct 11 04:33:25 volumio systemd[4917]: Failed at step EXEC spawning /usr/sbin/squeezeboxserver: No such file or directory Oct 11 04:33:25 volumio systemd[1]: logitechmediaserver.service: main process exited, code=exited, status=203/EXEC Oct 11 04:33:25 volumio systemd[1]: Unit logitechmediaserver.service entered failed state. Oct 11 04:34:36 volumio systemd[1]: Time has been changed Oct 11 04:34:36 volumio volumio-remote-updater[582]: [2026-10-11 04:34:36] [connect] Successful connection Oct 11 04:34:37 volumio volumio[4776]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Oct 11 04:34:37 volumio volumio[4776]: info: CoreCommandRouter::Close All Modals sent Oct 11 04:34:37 volumio volumio[4776]: info: CoreCommandRouter::Close All Modals sent Oct 11 04:34:37 volumio volumio[4776]: Express server listening on port 3000 Oct 11 04:34:37 volumio volumio[4776]: [Metrics] WebUI: 9s 170.17ms Oct 11 04:34:37 volumio volumio[4776]: Volumio Calling Home Oct 11 04:34:37 volumio volumio[4776]: info: CoreStateMachine::resetVolumioState Oct 11 04:34:37 volumio volumio[4776]: info: CoreStateMachine::getcurrentVolume Oct 11 04:34:37 volumio volumio[4776]: info: CoreCommandRouter::volumioRetrievevolume Oct 11 04:34:37 volumio volumio[4776]: info: CoreStateMachine::pushState Oct 11 04:34:37 volumio volumio[4776]: info: CorePlayQueue::getTrack 0 Oct 11 04:34:37 volumio volumio[4776]: info: CoreCommandRouter::volumioPushState Oct 11 04:34:37 volumio volumio[4776]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 11 04:34:37 volumio volumio[4776]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 11 04:34:37 volumio volumio[4776]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 04:34:37 volumio volumio[4776]: info: Setting Device type: Raspberry PI Oct 11 04:34:37 volumio volumio[4776]: info: squeezelite reloaded Oct 11 04:34:37 volumio volumio[4776]: info: logitechmediaserver started Oct 11 04:34:37 volumio volumio[4776]: error: Cannot start Roon Bridge Error: Command failed: /usr/bin/sudo /bin/systemctl start roonbridge.service Oct 11 04:34:37 volumio volumio[4776]: Failed to start roonbridge.service: Unit roonbridge.service failed to load: No such file or directory. Oct 11 04:34:37 volumio volumio[4776]: error: Cannot initialize MPD Connection: MPD is not running Oct 11 04:34:37 volumio sudo[4937]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart squeezelite Oct 11 04:34:37 volumio sudo[4937]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 11 04:34:37 volumio volumio[4776]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 11 04:34:37 volumio volumio[4776]: { Error: connect ECONNREFUSED 127.0.0.1:6600 Oct 11 04:34:37 volumio volumio[4776]: at Object._errnoException (util.js:1022:11) Oct 11 04:34:37 volumio volumio[4776]: at _exceptionWithHostPort (util.js:1044:20) Oct 11 04:34:37 volumio volumio[4776]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Oct 11 04:34:37 volumio volumio[4776]: code: 'ECONNREFUSED', Oct 11 04:34:37 volumio volumio[4776]: errno: 'ECONNREFUSED', Oct 11 04:34:37 volumio volumio[4776]: syscall: 'connect', Oct 11 04:34:37 volumio volumio[4776]: address: '127.0.0.1', Oct 11 04:34:37 volumio volumio[4776]: port: 6600 } Oct 11 04:34:37 volumio systemd[1]: Stopping Squeezelite lightweight headless Squeezebox emulator... Oct 11 04:34:37 volumio volumio[4776]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 11 04:34:37 volumio systemd[1]: Starting Squeezelite lightweight headless Squeezebox emulator... Oct 11 04:34:37 volumio systemd[1]: Started Squeezelite lightweight headless Squeezebox emulator. Oct 11 04:34:37 volumio sudo[4937]: pam_unix(sudo:session): session closed for user root Oct 11 04:34:37 volumio sudo[4958]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-10-11 04:33 Oct 11 04:34:37 volumio sudo[4958]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" 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="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="958dedc0edff114f244fa9acc70cf53089d9e5ae" VOLUMIO_BE_VERSION="fd3e37ffec12db034ec93f94dbc26e5495d5b91a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Oct 6 12:34:49 CEST 2021" VOLUMIO_VERSION="2.917" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="98c8f08c531a6f0456f17ab17795e35f"