-- Logs begin at Mon 2026-10-12 07:01:57 UTC, end at Tue 2026-10-13 05:56:43 UTC. -- Oct 13 05:55:00 volumio1 udisks-glue[530]: Device file /dev/mmcblk0 inserted Oct 13 05:55:06 volumio1 volumio-remote-updater[532]: [2026-10-13 05:55:06] [info] asio async_connect error: system:111 (Connection refused) Oct 13 05:55:06 volumio1 volumio-remote-updater[532]: [2026-10-13 05:55:06] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Oct 13 05:55:06 volumio1 volumio-remote-updater[532]: [2026-10-13 05:55:06] [error] handle_connect error: Underlying Transport Error Oct 13 05:55:12 volumio1 haveged[528]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 4.8.2 CTV); collect: 128K Oct 13 05:55:12 volumio1 haveged[528]: haveged: cpu: (VC); data: 16K (D); inst: 16K (D); idx: 8/40; sz: 15248/74244 Oct 13 05:55:12 volumio1 haveged[528]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 7.99617 Oct 13 05:55:12 volumio1 haveged[528]: haveged: fills: 0, generated: 0 Oct 13 05:55:16 volumio1 volumio-remote-updater[532]: [2026-10-13 05:55:16] [info] asio async_connect error: system:111 (Connection refused) Oct 13 05:55:16 volumio1 volumio-remote-updater[532]: [2026-10-13 05:55:16] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Oct 13 05:55:16 volumio1 volumio-remote-updater[532]: [2026-10-13 05:55:16] [error] handle_connect error: Underlying Transport Error Oct 13 05:55:22 volumio1 wireless.js[667]: WIRELESS: No wireless interface, exiting Oct 13 05:55:22 volumio1 systemd[1]: wireless.service: control process exited, code=exited status=1 Oct 13 05:55:22 volumio1 systemd[1]: Failed to start Wireless Services. Oct 13 05:55:22 volumio1 systemd[1]: Unit wireless.service entered failed state. Oct 13 05:55:22 volumio1 systemd[1]: Starting Volumio Backend Module... Oct 13 05:55:22 volumio1 systemd[1]: Started Volumio Backend Module. Oct 13 05:55:22 volumio1 systemd[1]: Starting Volumio Streaming Daemon... Oct 13 05:55:22 volumio1 systemd[1]: Started Volumio Streaming Daemon. Oct 13 05:55:22 volumio1 systemd[1]: Started LSB: start Samba daemons for the AD DC. Oct 13 05:55:23 volumio1 mpd[588]: output: No 'AudioOutput' defined in config file Oct 13 05:55:23 volumio1 mpd[588]: output: Attempt to detect audio output device Oct 13 05:55:23 volumio1 mpd[588]: output: Attempting to detect a alsa audio device Oct 13 05:55:24 volumio1 mpd[588]: output: Successfully detected a alsa audio device Oct 13 05:55:24 volumio1 systemd[1]: Started Music Player Daemon. Oct 13 05:55:24 volumio1 volumio-streaming-daemon[718]: ############################ Oct 13 05:55:24 volumio1 volumio-streaming-daemon[718]: # Volumio Streaming Daemon # Oct 13 05:55:24 volumio1 volumio-streaming-daemon[718]: # Running on port 7777 # Oct 13 05:55:24 volumio1 volumio-streaming-daemon[718]: ############################ Oct 13 05:55:24 volumio1 volumio-streaming-daemon[718]: Environment: production Oct 13 05:55:26 volumio1 volumio-remote-updater[532]: [2026-10-13 05:55:26] [info] asio async_connect error: system:111 (Connection refused) Oct 13 05:55:26 volumio1 volumio-remote-updater[532]: [2026-10-13 05:55:26] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Oct 13 05:55:26 volumio1 volumio-remote-updater[532]: [2026-10-13 05:55:26] [error] handle_connect error: Underlying Transport Error Oct 13 05:55:26 volumio1 winbind[542]: Starting the Winbind daemon: winbindmkdir failed on directory /var/log/samba/cores: No such file or directory Oct 13 05:55:26 volumio1 winbind[542]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Oct 13 05:55:26 volumio1 winbind[542]: Unable to setup corepath for winbindd: No such file or directory Oct 13 05:55:26 volumio1 winbind[542]: mkdir failed on directory /var/log/samba/cores: No such file or directory Oct 13 05:55:26 volumio1 winbind[542]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Oct 13 05:55:26 volumio1 winbind[542]: Unable to setup corepath for winbindd: No such file or directory Oct 13 05:55:26 volumio1 winbind[542]: [2026/10/13 05:55:26, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 13 05:55:26 volumio1 winbind[542]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Oct 13 05:55:26 volumio1 winbind[542]: [2026/10/13 05:55:26, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 13 05:55:26 volumio1 winbind[542]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Oct 13 05:55:26 volumio1 winbind[542]: [2026/10/13 05:55:26, 0] ../source3/winbindd/winbindd.c:1549(main) Oct 13 05:55:26 volumio1 winbind[542]: winbindd version 4.2.14-Debian started. Oct 13 05:55:26 volumio1 winbind[542]: Copyright Andrew Tridgell and the Samba Team 1992-2014 Oct 13 05:55:26 volumio1 winbindd[732]: [2026/10/13 05:55:26.790492, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 13 05:55:26 volumio1 winbindd[732]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Oct 13 05:55:26 volumio1 winbindd[732]: [2026/10/13 05:55:26.814524, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 13 05:55:26 volumio1 winbindd[732]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Oct 13 05:55:26 volumio1 winbind[542]: [2026/10/13 05:55:26, 0] ../lib/util/util.c:220(directory_create_or_exist) Oct 13 05:55:26 volumio1 winbind[542]: mkdir failed on directory /var/log/samba/cores: No such file or directory Oct 13 05:55:26 volumio1 winbind[542]: [2026/10/13 05:55:26, 0] ../source3/lib/dumpcore.c:59(get_default_corepath) Oct 13 05:55:26 volumio1 winbind[542]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Oct 13 05:55:26 volumio1 winbind[542]: [2026/10/13 05:55:26, 0] ../source3/lib/dumpcore.c:250(dump_core_setup) Oct 13 05:55:26 volumio1 winbind[542]: Unable to setup corepath for winbindd: No such file or directory Oct 13 05:55:26 volumio1 winbind[542]: [2026/10/13 05:55:26.790492, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 13 05:55:26 volumio1 winbind[542]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Oct 13 05:55:26 volumio1 winbind[542]: [2026/10/13 05:55:26.814524, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 13 05:55:26 volumio1 winbind[542]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Oct 13 05:55:26 volumio1 winbindd[743]: [2026/10/13 05:55:26.937910, 0] ../source3/winbindd/winbindd_cache.c:3235(initialize_winbindd_cache) Oct 13 05:55:26 volumio1 winbindd[743]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Oct 13 05:55:26 volumio1 systemd[1]: Started LSB: start Winbind daemon. Oct 13 05:55:26 volumio1 winbind[542]: . Oct 13 05:55:27 volumio1 winbindd[743]: [2026/10/13 05:55:27.080665, 0] ../lib/util/become_daemon.c:124(daemon_ready) Oct 13 05:55:27 volumio1 winbindd[743]: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Oct 13 05:55:27 volumio1 winbindd[744]: [2026/10/13 05:55:27.144348, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 13 05:55:27 volumio1 winbindd[744]: Unable to open new log file '/var/log/samba/log.wb-VOLUMIO1': No such file or directory Oct 13 05:55:27 volumio1 nmbd[555]: Starting NetBIOS name server: nmbdmkdir failed on directory /var/log/samba/cores: No such file or directory Oct 13 05:55:27 volumio1 nmbd[555]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Oct 13 05:55:27 volumio1 nmbd[555]: Unable to setup corepath for nmbd: No such file or directory Oct 13 05:55:27 volumio1 nmbd[555]: [2026/10/13 05:55:27, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 13 05:55:27 volumio1 nmbd[555]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Oct 13 05:55:27 volumio1 nmbd[555]: [2026/10/13 05:55:27, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 13 05:55:27 volumio1 nmbd[555]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Oct 13 05:55:27 volumio1 nmbd[555]: [2026/10/13 05:55:27, 0] ../source3/nmbd/nmbd.c:908(main) Oct 13 05:55:27 volumio1 nmbd[555]: nmbd version 4.2.14-Debian started. Oct 13 05:55:27 volumio1 nmbd[555]: Copyright Andrew Tridgell and the Samba Team 1992-2014 Oct 13 05:55:27 volumio1 nmbd[742]: [2026/10/13 05:55:27.193081, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 13 05:55:27 volumio1 nmbd[742]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Oct 13 05:55:27 volumio1 nmbd[742]: [2026/10/13 05:55:27.228881, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 13 05:55:27 volumio1 nmbd[742]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Oct 13 05:55:27 volumio1 nmbd[745]: [2026/10/13 05:55:27.262819, 0] ../source3/nmbd/asyncdns.c:157(start_async_dns) Oct 13 05:55:27 volumio1 nmbd[745]: started asyncdns process 746 Oct 13 05:55:27 volumio1 systemd[1]: Started LSB: start Samba NetBIOS nameserver (nmbd). Oct 13 05:55:27 volumio1 systemd[1]: Starting LSB: start Samba SMB/CIFS daemon (smbd)... Oct 13 05:55:27 volumio1 nmbd[555]: [2026/10/13 05:55:27.193081, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 13 05:55:27 volumio1 nmbd[555]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Oct 13 05:55:27 volumio1 nmbd[555]: [2026/10/13 05:55:27.228881, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 13 05:55:27 volumio1 nmbd[555]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Oct 13 05:55:27 volumio1 nmbd[555]: . Oct 13 05:55:27 volumio1 nmbd[745]: [2026/10/13 05:55:27.463256, 0] ../lib/util/become_daemon.c:124(daemon_ready) Oct 13 05:55:27 volumio1 nmbd[745]: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Oct 13 05:55:36 volumio1 volumio-remote-updater[532]: [2026-10-13 05:55:36] [info] asio async_connect error: system:111 (Connection refused) Oct 13 05:55:36 volumio1 volumio-remote-updater[532]: [2026-10-13 05:55:36] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Oct 13 05:55:36 volumio1 volumio-remote-updater[532]: [2026-10-13 05:55:36] [error] handle_connect error: Underlying Transport Error Oct 13 05:55:37 volumio1 smbd[747]: Starting SMB/CIFS daemon: smbd[2026/10/13 05:55:37, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 13 05:55:37 volumio1 smbd[747]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Oct 13 05:55:37 volumio1 smbd[747]: [2026/10/13 05:55:37, 0] ../lib/util/util.c:220(directory_create_or_exist) Oct 13 05:55:37 volumio1 smbd[747]: mkdir failed on directory /var/log/samba/cores: No such file or directory Oct 13 05:55:37 volumio1 smbd[747]: [2026/10/13 05:55:37, 0] ../source3/lib/dumpcore.c:59(get_default_corepath) Oct 13 05:55:37 volumio1 smbd[747]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Oct 13 05:55:37 volumio1 smbd[747]: [2026/10/13 05:55:37, 0] ../source3/lib/dumpcore.c:250(dump_core_setup) Oct 13 05:55:37 volumio1 smbd[747]: Unable to setup corepath for smbd: No such file or directory Oct 13 05:55:37 volumio1 smbd[747]: [2026/10/13 05:55:37, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 13 05:55:37 volumio1 smbd[747]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Oct 13 05:55:37 volumio1 smbd[747]: [2026/10/13 05:55:37, 0] ../source3/smbd/server.c:1241(main) Oct 13 05:55:37 volumio1 smbd[747]: smbd version 4.2.14-Debian started. Oct 13 05:55:37 volumio1 smbd[747]: Copyright Andrew Tridgell and the Samba Team 1992-2014 Oct 13 05:55:37 volumio1 smbd[757]: [2026/10/13 05:55:37.314645, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 13 05:55:37 volumio1 smbd[757]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Oct 13 05:55:37 volumio1 smbd[747]: [2026/10/13 05:55:37.314645, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 13 05:55:37 volumio1 smbd[747]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Oct 13 05:55:37 volumio1 smbd[757]: [2026/10/13 05:55:37.332618, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 13 05:55:37 volumio1 smbd[757]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Oct 13 05:55:37 volumio1 smbd[757]: [2026/10/13 05:55:37.333754, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 13 05:55:37 volumio1 smbd[757]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Oct 13 05:55:37 volumio1 smbd[747]: [2026/10/13 05:55:37.332618, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 13 05:55:37 volumio1 smbd[747]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Oct 13 05:55:37 volumio1 smbd[747]: [2026/10/13 05:55:37.333754, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 13 05:55:37 volumio1 smbd[747]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Oct 13 05:55:37 volumio1 smbd[747]: . Oct 13 05:55:37 volumio1 systemd[1]: Started LSB: start Samba SMB/CIFS daemon (smbd). Oct 13 05:55:37 volumio1 systemd[1]: Starting Multi-User System. Oct 13 05:55:37 volumio1 systemd[1]: Reached target Multi-User System. Oct 13 05:55:37 volumio1 systemd[1]: Starting Graphical Interface. Oct 13 05:55:37 volumio1 systemd[1]: Reached target Graphical Interface. Oct 13 05:55:37 volumio1 systemd[1]: Starting Update UTMP about System Runlevel Changes... Oct 13 05:55:37 volumio1 systemd[1]: Started Update UTMP about System Runlevel Changes. Oct 13 05:55:37 volumio1 systemd[1]: Startup finished in 11.575s (kernel) + 1min 12.844s (userspace) = 1min 24.420s. Oct 13 05:55:37 volumio1 winbindd[764]: [2026/10/13 05:55:37.840436, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 13 05:55:37 volumio1 winbindd[764]: Unable to open new log file '/var/log/samba/log.winbindd-idmap': No such file or directory Oct 13 05:55:38 volumio1 winbindd[765]: [2026/10/13 05:55:38.014063, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 13 05:55:38 volumio1 winbindd[765]: Unable to open new log file '/var/log/samba/log.wb-BUILTIN': No such file or directory Oct 13 05:55:38 volumio1 smbd[758]: [2026/10/13 05:55:38.310995, 0] ../lib/util/become_daemon.c:124(daemon_ready) Oct 13 05:55:38 volumio1 smbd[758]: STATUS=daemon 'smbd' finished starting up and ready to serve connections Oct 13 05:55:38 volumio1 smbd[766]: [2026/10/13 05:55:38.351196, 0] ../lib/util/debug.c:603(reopen_logs_internal) Oct 13 05:55:38 volumio1 smbd[766]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Oct 13 05:55:44 volumio1 volumio[717]: info: ------------------------------------------- Oct 13 05:55:44 volumio1 volumio[717]: info: ----- Volumio2 ---- Oct 13 05:55:44 volumio1 volumio[717]: info: ------------------------------------------- Oct 13 05:55:44 volumio1 volumio[717]: info: ----- System startup ---- Oct 13 05:55:44 volumio1 volumio[717]: info: ------------------------------------------- Oct 13 05:55:46 volumio1 volumio-remote-updater[532]: [2026-10-13 05:55:46] [connect] Successful connection Oct 13 05:55:50 volumio1 volumio[717]: info: MYVOLUMIO Environment detected Oct 13 05:55:51 volumio1 volumio[717]: info: Plugin folders cleanup Oct 13 05:55:51 volumio1 volumio[717]: info: Scanning into folder /volumio/app/plugins/ Oct 13 05:55:51 volumio1 volumio[717]: info: Scanning category audio_interface Oct 13 05:55:51 volumio1 volumio[717]: info: Scanning category miscellanea Oct 13 05:55:51 volumio1 volumio[717]: info: Scanning category music_service Oct 13 05:55:51 volumio1 volumio[717]: info: Scanning category plugins.json Oct 13 05:55:51 volumio1 volumio[717]: info: Scanning category system_controller Oct 13 05:55:51 volumio1 volumio[717]: info: Scanning category user_interface Oct 13 05:55:51 volumio1 volumio[717]: info: Scanning into folder /data/plugins/ Oct 13 05:55:51 volumio1 volumio[717]: info: Scanning category miscellanea Oct 13 05:55:51 volumio1 volumio[717]: info: Plugin folders cleanup completed Oct 13 05:55:51 volumio1 volumio[717]: info: ------------------------------------------- Oct 13 05:55:51 volumio1 volumio[717]: info: ----- Core plugins startup ---- Oct 13 05:55:51 volumio1 volumio[717]: info: ------------------------------------------- Oct 13 05:55:51 volumio1 volumio[717]: info: Loading plugins from folder /volumio/app/plugins/ Oct 13 05:55:51 volumio1 volumio[717]: info: Adding plugin upnp to MyMusic Plugins Oct 13 05:55:51 volumio1 volumio[717]: info: Adding plugin airplay_emulation to MyMusic Plugins Oct 13 05:55:51 volumio1 volumio[717]: info: Adding plugin upnp_browser to MyMusic Plugins Oct 13 05:55:51 volumio1 volumio[717]: info: Loading plugins from folder /data/plugins/ Oct 13 05:55:51 volumio1 volumio[717]: info: Loading plugin "system"... Oct 13 05:55:51 volumio1 volumio[717]: info: Loading plugin "appearance"... Oct 13 05:56:01 volumio1 volumio-remote-updater[532]: [2026-10-13 05:56:01] [connect] Successful connection Oct 13 05:56:04 volumio1 volumio[717]: info: Loading plugin "network"... Oct 13 05:56:04 volumio1 volumio[717]: info: Refreshing Cached IP Addresses Oct 13 05:56:05 volumio1 volumio[717]: info: Loading plugin "services"... Oct 13 05:56:05 volumio1 sudo[790]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 13 05:56:05 volumio1 volumio[717]: info: Loading plugin "alsa_controller"... Oct 13 05:56:05 volumio1 sudo[790]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 13 05:56:05 volumio1 sudo[792]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 13 05:56:05 volumio1 sudo[790]: pam_unix(sudo:session): session closed for user root Oct 13 05:56:05 volumio1 sudo[792]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 13 05:56:05 volumio1 sudo[792]: pam_unix(sudo:session): session closed for user root Oct 13 05:56:05 volumio1 volumio[717]: info: Loading plugin "wizard"... Oct 13 05:56:05 volumio1 volumio[717]: info: Loading plugin "volumio_command_line_client"... Oct 13 05:56:06 volumio1 volumio[717]: info: Loading plugin "upnp"... Oct 13 05:56:06 volumio1 volumio[717]: info: [1791870966196] Starting Upmpd Daemon Oct 13 05:56:06 volumio1 volumio[717]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 13 05:56:06 volumio1 volumio[717]: info: Loading plugin "my_music"... Oct 13 05:56:06 volumio1 volumio[717]: info: Loading plugin "mpd"... Oct 13 05:56:08 volumio1 volumio[717]: info: Loading plugin "upnp_browser"... Oct 13 05:56:11 volumio1 volumio[717]: info: Loading plugin "networkfs"... Oct 13 05:56:12 volumio1 volumio[717]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 13 05:56:12 volumio1 volumio[717]: info: Loading plugin "alarm-clock"... Oct 13 05:56:14 volumio1 volumio[717]: info: Loading plugin "airplay_emulation"... Oct 13 05:56:14 volumio1 volumio[717]: info: Starting Shairport Sync Oct 13 05:56:14 volumio1 volumio[717]: info: Loading plugin "last_100"... Oct 13 05:56:14 volumio1 volumio[717]: info: Loading plugin "webradio"... Oct 13 05:56:14 volumio1 volumio[717]: info: Loading plugin "i2s_dacs"... Oct 13 05:56:14 volumio1 volumio[717]: info: I2S DAC not set, start Auto-detection Oct 13 05:56:14 volumio1 volumio[717]: info: Loading plugin "volumiodiscovery"... Oct 13 05:56:15 volumio1 volumio[717]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 13 05:56:15 volumio1 node[717]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 13 05:56:15 volumio1 node[717]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 13 05:56:15 volumio1 node[717]: *** WARNING *** For more information see Oct 13 05:56:15 volumio1 node[717]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 13 05:56:15 volumio1 node[717]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 13 05:56:15 volumio1 node[717]: *** WARNING *** For more information see Oct 13 05:56:15 volumio1 volumio[717]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 13 05:56:15 volumio1 volumio[717]: *** WARNING *** For more information see Oct 13 05:56:15 volumio1 volumio[717]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 13 05:56:15 volumio1 volumio[717]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 13 05:56:15 volumio1 volumio[717]: *** WARNING *** For more information see Oct 13 05:56:15 volumio1 volumio[717]: info: Applying required configuration parameters for plugin volumiodiscovery Oct 13 05:56:15 volumio1 volumio[717]: Discovery: StartAdv! undefined Oct 13 05:56:15 volumio1 volumio[717]: Discovery: Started advertising... Volumio1 - undefined Oct 13 05:56:15 volumio1 volumio[717]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 13 05:56:15 volumio1 volumio[717]: info: Loading plugin "auto_play"... Oct 13 05:56:15 volumio1 volumio[717]: info: ControllerAutoPlay - connecting mpd on host: localhost; port: 6600 Oct 13 05:56:15 volumio1 volumio[717]: info: Loading plugin "autostart"... Oct 13 05:56:16 volumio1 volumio-remote-updater[532]: [2026-10-13 05:56:16] [connect] Successful connection Oct 13 05:56:16 volumio1 volumio[717]: info: Applying required configuration parameters for plugin autostart Oct 13 05:56:16 volumio1 volumio[717]: info: Loading plugin "outputs"... Oct 13 05:56:16 volumio1 volumio[717]: info: Loading plugin "albumart"... Oct 13 05:56:16 volumio1 volumio[717]: info: Plugin example_plugin is not enabled Oct 13 05:56:16 volumio1 volumio[717]: info: Loading plugin "inputs"... Oct 13 05:56:16 volumio1 volumio[717]: info: Loading plugin "updater_comm"... Oct 13 05:56:18 volumio1 volumio[717]: info: Plugin mpdemulation is not enabled Oct 13 05:56:18 volumio1 volumio[717]: info: Loading plugin "rest_api"... Oct 13 05:56:19 volumio1 volumio[717]: info: Loading plugin "websocket"... Oct 13 05:56:19 volumio1 volumio[717]: info: ___________ START PLUGINS ___________ Oct 13 05:56:19 volumio1 volumio[717]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 13 05:56:19 volumio1 volumio[717]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 13 05:56:19 volumio1 volumio[717]: info: [1791870979674] CoreMusicLibrary::Adding element Media Servers Oct 13 05:56:19 volumio1 volumio[717]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 13 05:56:20 volumio1 volumio[717]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 13 05:56:20 volumio1 volumio[717]: Forking 1 albumart workers Oct 13 05:56:20 volumio1 volumio[717]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 13 05:56:20 volumio1 volumio[717]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 13 05:56:20 volumio1 volumio[717]: info: [1791870980829] CoreMusicLibrary::Adding element Last_100 Oct 13 05:56:20 volumio1 volumio[717]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 13 05:56:20 volumio1 volumio[717]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 13 05:56:20 volumio1 volumio[717]: info: [1791870980878] CoreMusicLibrary::Adding element Webradio Oct 13 05:56:20 volumio1 volumio[717]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 13 05:56:20 volumio1 volumio[717]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 13 05:56:21 volumio1 volumio[717]: info: ------------------------------------------- Oct 13 05:56:21 volumio1 volumio[717]: info: ----- MyVolumio plugins startup ---- Oct 13 05:56:21 volumio1 volumio[717]: info: ------------------------------------------- Oct 13 05:56:21 volumio1 volumio[717]: info: [MyVolumio PluginManager] Fetching plans data.... Oct 13 05:56:21 volumio1 volumio[717]: info: Loading i18n strings for locale ja Oct 13 05:56:21 volumio1 volumio[717]: Updating browse sources language Oct 13 05:56:21 volumio1 volumio[717]: Cannot find translation for sourceMedia Servers Oct 13 05:56:21 volumio1 volumio[717]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 13 05:56:21 volumio1 volumio[717]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 13 05:56:21 volumio1 volumio[717]: info: CoreCommandRouter::initPlayerControls Oct 13 05:56:21 volumio1 volumio[717]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 05:56:21 volumio1 volumio[717]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Oct 13 05:56:22 volumio1 volumio[717]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 05:56:22 volumio1 volumio[717]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 05:56:22 volumio1 volumio[717]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 05:56:22 volumio1 volumio[717]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 05:56:22 volumio1 volumio[717]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 05:56:22 volumio1 volumio[717]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 13 05:56:22 volumio1 volumio[717]: info: BOOT COMPLETED Oct 13 05:56:22 volumio1 volumio[717]: [Metrics] CommandRouter: 37s 868.50ms Oct 13 05:56:22 volumio1 volumio[717]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 13 05:56:22 volumio1 volumio[717]: ALSA lib pcm_hw.c:1713:(_snd_pcm_hw_open) Invalid value for card Oct 13 05:56:22 volumio1 volumio[717]: aplay: main:722: audio open error: No such file or directory Oct 13 05:56:22 volumio1 volumio[717]: Cannot play startup sound Oct 13 05:56:22 volumio1 volumio[717]: info: CoreCommandRouter::Close All Modals sent Oct 13 05:56:22 volumio1 volumio[717]: info: CoreCommandRouter::Close All Modals sent Oct 13 05:56:22 volumio1 volumio[717]: Express server listening on port 3000 Oct 13 05:56:22 volumio1 volumio[717]: [Metrics] WebUI: 42s 60.88ms Oct 13 05:56:22 volumio1 volumio[717]: Volumio Calling Home Oct 13 05:56:23 volumio1 volumio[717]: info: CoreStateMachine::resetVolumioState Oct 13 05:56:23 volumio1 volumio[717]: info: CoreStateMachine::getcurrentVolume Oct 13 05:56:23 volumio1 volumio[717]: info: CoreCommandRouter::volumioRetrievevolume Oct 13 05:56:25 volumio1 volumio[717]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 13 05:56:25 volumio1 volumio[717]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 13 05:56:25 volumio1 volumio[717]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Oct 13 05:56:25 volumio1 volumio[717]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 13 05:56:25 volumio1 sudo[852]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 13 05:56:25 volumio1 sudo[852]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 13 05:56:25 volumio1 sudo[852]: pam_unix(sudo:session): session closed for user root Oct 13 05:56:25 volumio1 sudo[854]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 13 05:56:25 volumio1 sudo[854]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 13 05:56:25 volumio1 sudo[854]: pam_unix(sudo:session): session closed for user root Oct 13 05:56:26 volumio1 volumio[717]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Oct 13 05:56:26 volumio1 volumio[717]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Oct 13 05:56:29 volumio1 volumio[717]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Oct 13 05:56:29 volumio1 volumio[717]: info: Volumio called home Oct 13 05:56:29 volumio1 volumio[717]: info: Setting Device type: Raspberry PI Oct 13 05:56:29 volumio1 volumio[717]: info: MPD running with PID588 Oct 13 05:56:29 volumio1 volumio[717]: ,establishing connection Oct 13 05:56:29 volumio1 sudo[875]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1 Oct 13 05:56:30 volumio1 sudo[875]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 13 05:56:30 volumio1 sudo[875]: pam_unix(sudo:session): session closed for user root Oct 13 05:56:31 volumio1 volumio[717]: Starting albumart workers Oct 13 05:56:31 volumio1 volumio-remote-updater[532]: [2026-10-13 05:56:31] [connect] Successful connection Oct 13 05:56:31 volumio1 volumio[717]: info: VolumeController:: Volume=undefined Mute =false Oct 13 05:56:31 volumio1 volumio[717]: info: CoreStateMachine::pushState Oct 13 05:56:31 volumio1 volumio[717]: info: CorePlayQueue::getTrack 0 Oct 13 05:56:31 volumio1 volumio[717]: info: CoreCommandRouter::volumioPushState Oct 13 05:56:31 volumio1 volumio[717]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 13 05:56:31 volumio1 volumio[717]: info: CoreStateMachine::updateTrackBlock Oct 13 05:56:31 volumio1 volumio[717]: info: CorePlayQueue::getTrackBlock Oct 13 05:56:31 volumio1 volumio[717]: info: CoreCommandRouter::volumioRetrievevolume Oct 13 05:56:32 volumio1 volumio[717]: info: Oct 13 05:56:32 volumio1 volumio[717]: ---------------------------- Client requests Volume 5 Oct 13 05:56:32 volumio1 volumio[717]: info: VolumeController::SetAlsaVolume5 Oct 13 05:56:32 volumio1 volumio[717]: info: CoreStateMachine::pushState Oct 13 05:56:32 volumio1 volumio[717]: info: CorePlayQueue::getTrack 0 Oct 13 05:56:32 volumio1 volumio[717]: info: CoreCommandRouter::volumioPushState Oct 13 05:56:32 volumio1 volumio[717]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 13 05:56:33 volumio1 volumio[717]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Oct 13 05:56:33 volumio1 volumio[717]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 13 05:56:33 volumio1 volumio[717]: info: Reloading queue from file Oct 13 05:56:34 volumio1 volumio[717]: error: updateQueue error: null Oct 13 05:56:34 volumio1 volumio[717]: error: Failed LSINFO: Error: [50@0] {} No database Oct 13 05:56:34 volumio1 volumio-remote-updater[532]: [2026-10-13 05:56:34] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1791870991 101 Oct 13 05:56:34 volumio1 volumio[717]: info: VolumeController:: Volume=undefined Mute =false Oct 13 05:56:34 volumio1 volumio[717]: info: CoreStateMachine::pushState Oct 13 05:56:34 volumio1 volumio[717]: info: CorePlayQueue::getTrack 0 Oct 13 05:56:34 volumio1 volumio[717]: info: CoreCommandRouter::volumioPushState Oct 13 05:56:34 volumio1 volumio[717]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 13 05:56:34 volumio1 volumio[717]: error: Cannot set ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Oct 13 05:56:34 volumio1 volumio[717]: info: Setting volume on startup at 5 Oct 13 05:56:34 volumio1 volumio[717]: info: CoreStateMachine::setRepeat true single undefined Oct 13 05:56:34 volumio1 volumio[717]: info: CoreStateMachine::pushState Oct 13 05:56:34 volumio1 volumio[717]: info: CorePlayQueue::getTrack 0 Oct 13 05:56:34 volumio1 volumio[717]: info: CoreCommandRouter::volumioPushState Oct 13 05:56:34 volumio1 volumio[717]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 13 05:56:35 volumio1 volumio[717]: info: CoreStateMachine::setRandom null Oct 13 05:56:35 volumio1 volumio[717]: info: CoreStateMachine::pushState Oct 13 05:56:35 volumio1 volumio[717]: info: CorePlayQueue::getTrack 0 Oct 13 05:56:35 volumio1 volumio[717]: info: CoreCommandRouter::volumioPushState Oct 13 05:56:35 volumio1 volumio[717]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 13 05:56:36 volumio1 volumio[717]: info: Starting Shairport Sync Oct 13 05:56:36 volumio1 volumio[717]: info: Starting Shairport Sync Oct 13 05:56:36 volumio1 volumio[717]: Discovery: adding bbad7d26-6b9b-45d5-88e0-8a605797e05c Oct 13 05:56:36 volumio1 volumio[717]: info: mDNS: Found device Volumio1 Oct 13 05:56:36 volumio1 sudo[892]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 13 05:56:36 volumio1 volumio[717]: info: CoreCommandRouter::volumioGetState Oct 13 05:56:36 volumio1 volumio[717]: info: CorePlayQueue::getTrack 0 Oct 13 05:56:36 volumio1 sudo[892]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 13 05:56:36 volumio1 sudo[894]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 13 05:56:37 volumio1 sudo[894]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 13 05:56:37 volumio1 systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Oct 13 05:56:37 volumio1 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 13 05:56:37 volumio1 sudo[892]: pam_unix(sudo:session): session closed for user root Oct 13 05:56:37 volumio1 sudo[897]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Oct 13 05:56:37 volumio1 sudo[897]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 13 05:56:37 volumio1 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 13 05:56:37 volumio1 volumio[717]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 13 05:56:37 volumio1 systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Oct 13 05:56:37 volumio1 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 13 05:56:37 volumio1 sudo[894]: pam_unix(sudo:session): session closed for user root Oct 13 05:56:37 volumio1 volumio[717]: Error: Non okay return status: "ACK [50@0] {} No database" Oct 13 05:56:37 volumio1 volumio[717]: at MPD._checkReturn (/data/plugins/miscellanea/auto_play/node_modules/node-mpd/src/mpd.js:353:10) Oct 13 05:56:37 volumio1 volumio[717]: at MPD. (/data/plugins/miscellanea/auto_play/node_modules/node-mpd/src/mpd.js:188:18) Oct 13 05:56:37 volumio1 volumio[717]: at MPD._handleResponse (/data/plugins/miscellanea/auto_play/node_modules/node-mpd/src/mpd.js:450:3) Oct 13 05:56:37 volumio1 volumio[717]: at MPD._onData (/data/plugins/miscellanea/auto_play/node_modules/node-mpd/src/mpd.js:344:10) Oct 13 05:56:37 volumio1 volumio[717]: at emitOne (events.js:116:13) Oct 13 05:56:37 volumio1 volumio[717]: at Socket.emit (events.js:211:7) Oct 13 05:56:37 volumio1 volumio[717]: at addChunk (_stream_readable.js:263:12) Oct 13 05:56:37 volumio1 volumio[717]: at readableAddChunk (_stream_readable.js:246:13) Oct 13 05:56:37 volumio1 volumio[717]: at Socket.Readable.push (_stream_readable.js:208:10) Oct 13 05:56:37 volumio1 volumio[717]: at TCP.onread (net.js:607:20) Oct 13 05:56:37 volumio1 systemd[1]: Starting UPnP Renderer front-end to MPD... Oct 13 05:56:37 volumio1 volumio[717]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 13 05:56:37 volumio1 sudo[897]: pam_unix(sudo:session): session closed for user root Oct 13 05:56:37 volumio1 systemd[1]: Started UPnP Renderer front-end to MPD. Oct 13 05:56:43 volumio1 sudo[944]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-10-13 05:55 Oct 13 05:56:43 volumio1 sudo[944]: 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"