-- Logs begin at Sun 2026-05-31 04:22:43 UTC, end at Sun 2026-05-31 04:25:05 UTC. -- May 31 04:24:00 volumio systemd[1]: xbindkeysrc.service holdoff time over, scheduling restart. May 31 04:24:01 volumio systemd[1]: Stopping Xbindrc... May 31 04:24:01 volumio systemd[1]: Starting Xbindrc... May 31 04:24:01 volumio systemd[1]: Started Xbindrc. May 31 04:24:01 volumio volumio-remote-updater[520]: [2026-05-31 04:24:01] [info] asio async_connect error: system:111 (Connection refused) May 31 04:24:01 volumio volumio-remote-updater[520]: [2026-05-31 04:24:01] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) May 31 04:24:01 volumio volumio-remote-updater[520]: [2026-05-31 04:24:01] [error] handle_connect error: Underlying Transport Error May 31 04:24:03 volumio systemd[1]: xbindkeysrc.service holdoff time over, scheduling restart. May 31 04:24:03 volumio systemd[1]: Stopping Xbindrc... May 31 04:24:03 volumio systemd[1]: Starting Xbindrc... May 31 04:24:03 volumio systemd[1]: Started Xbindrc. May 31 04:24:03 volumio wireless.js[636]: WIRELESS: No wireless interface, exiting May 31 04:24:04 volumio systemd[1]: wireless.service: control process exited, code=exited status=1 May 31 04:24:04 volumio systemd[1]: Failed to start Wireless Services. May 31 04:24:04 volumio systemd[1]: Unit wireless.service entered failed state. May 31 04:24:04 volumio systemd[1]: Starting Volumio Backend Module... May 31 04:24:04 volumio systemd[1]: Started Volumio Backend Module. May 31 04:24:04 volumio systemd[1]: Starting Volumio Streaming Daemon... May 31 04:24:04 volumio systemd[1]: Started Volumio Streaming Daemon. May 31 04:24:05 volumio systemd[1]: xbindkeysrc.service holdoff time over, scheduling restart. May 31 04:24:05 volumio systemd[1]: Stopping Xbindrc... May 31 04:24:05 volumio systemd[1]: Starting Xbindrc... May 31 04:24:05 volumio systemd[1]: Started Xbindrc. May 31 04:24:05 volumio systemd[1]: Started LSB: start Samba daemons for the AD DC. May 31 04:24:06 volumio volumio-streaming-daemon[733]: ############################ May 31 04:24:06 volumio volumio-streaming-daemon[733]: # Volumio Streaming Daemon # May 31 04:24:06 volumio volumio-streaming-daemon[733]: # Running on port 7777 # May 31 04:24:06 volumio volumio-streaming-daemon[733]: ############################ May 31 04:24:07 volumio systemd[1]: xbindkeysrc.service holdoff time over, scheduling restart. May 31 04:24:07 volumio systemd[1]: Stopping Xbindrc... May 31 04:24:07 volumio systemd[1]: Starting Xbindrc... May 31 04:24:07 volumio systemd[1]: Started Xbindrc. May 31 04:24:09 volumio systemd[1]: xbindkeysrc.service holdoff time over, scheduling restart. May 31 04:24:09 volumio systemd[1]: Stopping Xbindrc... May 31 04:24:09 volumio winbind[532]: Starting the Winbind daemon: winbindmkdir failed on directory /var/log/samba/cores: No such file or directory May 31 04:24:09 volumio winbind[532]: Failed to create /var/log/samba/cores for user 0 with mode 0700 May 31 04:24:09 volumio winbind[532]: Unable to setup corepath for winbindd: No such file or directory May 31 04:24:09 volumio winbind[532]: mkdir failed on directory /var/log/samba/cores: No such file or directory May 31 04:24:09 volumio winbind[532]: Failed to create /var/log/samba/cores for user 0 with mode 0700 May 31 04:24:09 volumio winbind[532]: Unable to setup corepath for winbindd: No such file or directory May 31 04:24:09 volumio winbind[532]: [2026/05/31 04:24:09, 0] ../lib/util/debug.c:603(reopen_logs_internal) May 31 04:24:09 volumio winbind[532]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory May 31 04:24:09 volumio winbind[532]: [2026/05/31 04:24:09, 0] ../lib/util/debug.c:603(reopen_logs_internal) May 31 04:24:09 volumio winbind[532]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory May 31 04:24:09 volumio winbind[532]: [2026/05/31 04:24:09, 0] ../source3/winbindd/winbindd.c:1549(main) May 31 04:24:09 volumio winbind[532]: winbindd version 4.2.14-Debian started. May 31 04:24:09 volumio winbind[532]: Copyright Andrew Tridgell and the Samba Team 1992-2014 May 31 04:24:09 volumio winbind[532]: [2026/05/31 04:24:09, 0] ../lib/util/util.c:220(directory_create_or_exist) May 31 04:24:09 volumio winbind[532]: mkdir failed on directory /var/log/samba/cores: No such file or directory May 31 04:24:10 volumio winbind[532]: [2026/05/31 04:24:09, 0] ../source3/lib/dumpcore.c:59(get_default_corepath) May 31 04:24:10 volumio winbind[532]: Failed to create /var/log/samba/cores for user 0 with mode 0700 May 31 04:24:10 volumio winbind[532]: [2026/05/31 04:24:09, 0] ../source3/lib/dumpcore.c:250(dump_core_setup) May 31 04:24:10 volumio winbind[532]: Unable to setup corepath for winbindd: No such file or directory May 31 04:24:09 volumio winbindd[753]: [2026/05/31 04:24:09.815382, 0] ../lib/util/debug.c:603(reopen_logs_internal) May 31 04:24:09 volumio winbindd[753]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory May 31 04:24:09 volumio winbindd[753]: [2026/05/31 04:24:09.879892, 0] ../lib/util/debug.c:603(reopen_logs_internal) May 31 04:24:09 volumio winbindd[753]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory May 31 04:24:10 volumio winbindd[766]: [2026/05/31 04:24:10.022542, 0] ../source3/winbindd/winbindd_cache.c:3235(initialize_winbindd_cache) May 31 04:24:10 volumio winbindd[766]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 May 31 04:24:09 volumio systemd[1]: Starting Xbindrc... May 31 04:24:09 volumio systemd[1]: Started Xbindrc. May 31 04:24:10 volumio systemd[1]: Started LSB: start Winbind daemon. May 31 04:24:10 volumio winbind[532]: [2026/05/31 04:24:09.815382, 0] ../lib/util/debug.c:603(reopen_logs_internal) May 31 04:24:10 volumio winbind[532]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory May 31 04:24:10 volumio winbind[532]: [2026/05/31 04:24:09.879892, 0] ../lib/util/debug.c:603(reopen_logs_internal) May 31 04:24:10 volumio winbind[532]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory May 31 04:24:10 volumio nmbd[762]: [2026/05/31 04:24:10.188390, 0] ../lib/util/debug.c:603(reopen_logs_internal) May 31 04:24:10 volumio nmbd[762]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory May 31 04:24:10 volumio nmbd[762]: [2026/05/31 04:24:10.192407, 0] ../lib/util/debug.c:603(reopen_logs_internal) May 31 04:24:10 volumio nmbd[762]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory May 31 04:24:10 volumio nmbd[539]: Starting NetBIOS name server: nmbdmkdir failed on directory /var/log/samba/cores: No such file or directory May 31 04:24:10 volumio nmbd[539]: Failed to create /var/log/samba/cores for user 0 with mode 0700 May 31 04:24:10 volumio nmbd[539]: Unable to setup corepath for nmbd: No such file or directory May 31 04:24:10 volumio nmbd[539]: [2026/05/31 04:24:10, 0] ../lib/util/debug.c:603(reopen_logs_internal) May 31 04:24:10 volumio nmbd[539]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory May 31 04:24:10 volumio nmbd[539]: [2026/05/31 04:24:10, 0] ../lib/util/debug.c:603(reopen_logs_internal) May 31 04:24:10 volumio nmbd[539]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory May 31 04:24:10 volumio nmbd[539]: [2026/05/31 04:24:10, 0] ../source3/nmbd/nmbd.c:908(main) May 31 04:24:10 volumio nmbd[539]: nmbd version 4.2.14-Debian started. May 31 04:24:10 volumio nmbd[539]: Copyright Andrew Tridgell and the Samba Team 1992-2014 May 31 04:24:10 volumio nmbd[539]: [2026/05/31 04:24:10.188390, 0] ../lib/util/debug.c:603(reopen_logs_internal) May 31 04:24:10 volumio nmbd[539]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory May 31 04:24:10 volumio nmbd[539]: [2026/05/31 04:24:10.192407, 0] ../lib/util/debug.c:603(reopen_logs_internal) May 31 04:24:10 volumio nmbd[539]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory May 31 04:24:10 volumio winbindd[766]: [2026/05/31 04:24:10.231295, 0] ../lib/util/become_daemon.c:124(daemon_ready) May 31 04:24:10 volumio winbindd[766]: STATUS=daemon 'winbindd' finished starting up and ready to serve connections May 31 04:24:10 volumio nmbd[767]: [2026/05/31 04:24:10.254355, 0] ../source3/nmbd/asyncdns.c:157(start_async_dns) May 31 04:24:10 volumio nmbd[767]: started asyncdns process 769 May 31 04:24:10 volumio winbindd[768]: [2026/05/31 04:24:10.265133, 0] ../lib/util/debug.c:603(reopen_logs_internal) May 31 04:24:10 volumio winbindd[768]: Unable to open new log file '/var/log/samba/log.wb-VOLUMIO': No such file or directory May 31 04:24:10 volumio nmbd[767]: [2026/05/31 04:24:10.491221, 0] ../lib/util/become_daemon.c:124(daemon_ready) May 31 04:24:10 volumio nmbd[767]: STATUS=daemon 'nmbd' finished starting up and ready to serve connections May 31 04:24:10 volumio systemd[1]: Started LSB: start Samba NetBIOS nameserver (nmbd). May 31 04:24:10 volumio systemd[1]: Starting LSB: start Samba SMB/CIFS daemon (smbd)... May 31 04:24:10 volumio winbind[532]: . May 31 04:24:10 volumio nmbd[539]: . May 31 04:24:11 volumio volumio-remote-updater[520]: [2026-05-31 04:24:11] [info] asio async_connect error: system:111 (Connection refused) May 31 04:24:11 volumio volumio-remote-updater[520]: [2026-05-31 04:24:11] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) May 31 04:24:11 volumio volumio-remote-updater[520]: [2026-05-31 04:24:11] [error] handle_connect error: Underlying Transport Error May 31 04:24:12 volumio systemd[1]: xbindkeysrc.service holdoff time over, scheduling restart. May 31 04:24:12 volumio systemd[1]: Stopping Xbindrc... May 31 04:24:12 volumio systemd[1]: Starting Xbindrc... May 31 04:24:12 volumio systemd[1]: Started Xbindrc. May 31 04:24:13 volumio systemd[1]: Started Music Player Daemon. May 31 04:24:13 volumio systemd[1]: xbindkeysrc.service holdoff time over, scheduling restart. May 31 04:24:13 volumio systemd[1]: Stopping Xbindrc... May 31 04:24:13 volumio systemd[1]: Starting Xbindrc... May 31 04:24:13 volumio systemd[1]: Started Xbindrc. May 31 04:24:14 volumio udisks-glue[517]: Updating DB (#1) ... May 31 04:24:14 volumio udisks-glue[517]: volume:100% repeat: off random: off single: off consume: off May 31 04:24:15 volumio systemd[1]: xbindkeysrc.service holdoff time over, scheduling restart. May 31 04:24:15 volumio systemd[1]: Stopping Xbindrc... May 31 04:24:15 volumio systemd[1]: Starting Xbindrc... May 31 04:24:15 volumio systemd[1]: xbindkeysrc.service start request repeated too quickly, refusing to start. May 31 04:24:15 volumio systemd[1]: Failed to start Xbindrc. May 31 04:24:15 volumio systemd[1]: Unit xbindkeysrc.service entered failed state. May 31 04:24:20 volumio smbd[770]: Starting SMB/CIFS daemon: smbd[2026/05/31 04:24:20, 0] ../lib/util/debug.c:603(reopen_logs_internal) May 31 04:24:20 volumio smbd[770]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory May 31 04:24:20 volumio smbd[770]: [2026/05/31 04:24:20, 0] ../lib/util/util.c:220(directory_create_or_exist) May 31 04:24:20 volumio smbd[770]: mkdir failed on directory /var/log/samba/cores: No such file or directory May 31 04:24:20 volumio smbd[770]: [2026/05/31 04:24:20, 0] ../source3/lib/dumpcore.c:59(get_default_corepath) May 31 04:24:20 volumio smbd[770]: Failed to create /var/log/samba/cores for user 0 with mode 0700 May 31 04:24:20 volumio smbd[770]: [2026/05/31 04:24:20, 0] ../source3/lib/dumpcore.c:250(dump_core_setup) May 31 04:24:20 volumio smbd[770]: Unable to setup corepath for smbd: No such file or directory May 31 04:24:20 volumio smbd[770]: [2026/05/31 04:24:20, 0] ../lib/util/debug.c:603(reopen_logs_internal) May 31 04:24:20 volumio smbd[770]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory May 31 04:24:20 volumio smbd[770]: [2026/05/31 04:24:20, 0] ../source3/smbd/server.c:1241(main) May 31 04:24:20 volumio smbd[770]: smbd version 4.2.14-Debian started. May 31 04:24:20 volumio smbd[770]: Copyright Andrew Tridgell and the Samba Team 1992-2014 May 31 04:24:20 volumio smbd[792]: [2026/05/31 04:24:20.464423, 0] ../lib/util/debug.c:603(reopen_logs_internal) May 31 04:24:20 volumio smbd[770]: [2026/05/31 04:24:20.464423, 0] ../lib/util/debug.c:603(reopen_logs_internal) May 31 04:24:20 volumio smbd[792]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory May 31 04:24:20 volumio smbd[792]: [2026/05/31 04:24:20.481835, 0] ../lib/util/debug.c:603(reopen_logs_internal) May 31 04:24:20 volumio smbd[792]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory May 31 04:24:20 volumio smbd[792]: [2026/05/31 04:24:20.482492, 0] ../lib/util/debug.c:603(reopen_logs_internal) May 31 04:24:20 volumio smbd[792]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory May 31 04:24:20 volumio smbd[770]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory May 31 04:24:20 volumio smbd[770]: [2026/05/31 04:24:20.481835, 0] ../lib/util/debug.c:603(reopen_logs_internal) May 31 04:24:20 volumio smbd[770]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory May 31 04:24:20 volumio smbd[770]: [2026/05/31 04:24:20.482492, 0] ../lib/util/debug.c:603(reopen_logs_internal) May 31 04:24:20 volumio smbd[770]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory May 31 04:24:20 volumio systemd[1]: Started LSB: start Samba SMB/CIFS daemon (smbd). May 31 04:24:20 volumio smbd[770]: . May 31 04:24:20 volumio systemd[1]: Starting Multi-User System. May 31 04:24:20 volumio systemd[1]: Reached target Multi-User System. May 31 04:24:20 volumio systemd[1]: Starting Graphical Interface. May 31 04:24:20 volumio systemd[1]: Reached target Graphical Interface. May 31 04:24:20 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... May 31 04:24:20 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. May 31 04:24:20 volumio systemd[1]: Startup finished in 15.586s (kernel) + 1min 9.939s (userspace) = 1min 25.526s. May 31 04:24:20 volumio winbindd[799]: [2026/05/31 04:24:20.862929, 0] ../lib/util/debug.c:603(reopen_logs_internal) May 31 04:24:20 volumio winbindd[799]: Unable to open new log file '/var/log/samba/log.winbindd-idmap': No such file or directory May 31 04:24:20 volumio winbindd[800]: [2026/05/31 04:24:20.992956, 0] ../lib/util/debug.c:603(reopen_logs_internal) May 31 04:24:20 volumio winbindd[800]: Unable to open new log file '/var/log/samba/log.wb-BUILTIN': No such file or directory May 31 04:24:21 volumio smbd[793]: [2026/05/31 04:24:21.203739, 0] ../lib/util/become_daemon.c:124(daemon_ready) May 31 04:24:21 volumio smbd[793]: STATUS=daemon 'smbd' finished starting up and ready to serve connections May 31 04:24:21 volumio smbd[801]: [2026/05/31 04:24:21.231685, 0] ../lib/util/debug.c:603(reopen_logs_internal) May 31 04:24:21 volumio smbd[801]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory May 31 04:24:21 volumio volumio-remote-updater[520]: [2026-05-31 04:24:21] [info] asio async_connect error: system:111 (Connection refused) May 31 04:24:21 volumio volumio-remote-updater[520]: [2026-05-31 04:24:21] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) May 31 04:24:21 volumio volumio-remote-updater[520]: [2026-05-31 04:24:21] [error] handle_connect error: Underlying Transport Error May 31 04:24:25 volumio volumio[732]: info: ------------------------------------------- May 31 04:24:25 volumio volumio[732]: info: ----- Volumio2 ---- May 31 04:24:25 volumio volumio[732]: info: ------------------------------------------- May 31 04:24:25 volumio volumio[732]: info: ----- System startup ---- May 31 04:24:25 volumio volumio[732]: info: ------------------------------------------- May 31 04:24:25 volumio volumio[732]: info: MYVOLUMIO Environment detected May 31 04:24:30 volumio volumio[732]: info: Plugin folders cleanup May 31 04:24:30 volumio volumio[732]: info: Scanning into folder /volumio/app/plugins/ May 31 04:24:30 volumio volumio[732]: info: Scanning category audio_interface May 31 04:24:30 volumio volumio[732]: info: Scanning category miscellanea May 31 04:24:30 volumio volumio[732]: info: Scanning category music_service May 31 04:24:30 volumio volumio[732]: info: Scanning category plugins.json May 31 04:24:30 volumio volumio[732]: info: Scanning category system_controller May 31 04:24:30 volumio volumio[732]: info: Scanning category user_interface May 31 04:24:30 volumio volumio[732]: info: Scanning into folder /data/plugins/ May 31 04:24:30 volumio volumio[732]: info: Scanning category audio_interface May 31 04:24:30 volumio volumio[732]: info: Plugin folders cleanup completed May 31 04:24:30 volumio volumio[732]: info: ------------------------------------------- May 31 04:24:30 volumio volumio[732]: info: ----- Core plugins startup ---- May 31 04:24:30 volumio volumio[732]: info: ------------------------------------------- May 31 04:24:30 volumio volumio[732]: info: Loading plugins from folder /volumio/app/plugins/ May 31 04:24:30 volumio volumio[732]: info: Adding plugin upnp to MyMusic Plugins May 31 04:24:30 volumio volumio[732]: info: Adding plugin airplay_emulation to MyMusic Plugins May 31 04:24:30 volumio volumio[732]: info: Adding plugin upnp_browser to MyMusic Plugins May 31 04:24:30 volumio volumio[732]: info: Loading plugins from folder /data/plugins/ May 31 04:24:30 volumio volumio[732]: info: Loading plugin "system"... May 31 04:24:30 volumio volumio[732]: info: Loading plugin "appearance"... May 31 04:24:31 volumio volumio-remote-updater[520]: [2026-05-31 04:24:31] [connect] Successful connection May 31 04:24:33 volumio volumio[732]: info: Loading plugin "network"... May 31 04:24:34 volumio volumio[732]: info: Loading plugin "services"... May 31 04:24:34 volumio volumio[732]: info: Loading plugin "alsa_controller"... May 31 04:24:35 volumio volumio[732]: info: Loading plugin "wizard"... May 31 04:24:35 volumio volumio[732]: info: Loading plugin "volumio_command_line_client"... May 31 04:24:35 volumio volumio[732]: info: Loading plugin "upnp"... May 31 04:24:35 volumio volumio[732]: info: [1780201475459] Starting Upmpd Daemon May 31 04:24:35 volumio volumio[732]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 31 04:24:35 volumio volumio[732]: info: Loading plugin "my_music"... May 31 04:24:35 volumio volumio[732]: info: Loading plugin "mpd"... May 31 04:24:37 volumio volumio[732]: info: Loading plugin "upnp_browser"... May 31 04:24:39 volumio volumio[732]: info: Loading plugin "networkfs"... May 31 04:24:39 volumio volumio[732]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 31 04:24:39 volumio volumio[732]: info: Loading plugin "alarm-clock"... May 31 04:24:40 volumio volumio[732]: info: Loading plugin "airplay_emulation"... May 31 04:24:40 volumio volumio[732]: info: Starting Shairport Sync May 31 04:24:40 volumio volumio[732]: info: Loading plugin "last_100"... May 31 04:24:40 volumio volumio[732]: info: Loading plugin "webradio"... May 31 04:24:41 volumio volumio[732]: info: Loading plugin "i2s_dacs"... May 31 04:24:41 volumio volumio[732]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 31 04:24:41 volumio volumio[732]: info: Loading plugin "volumiodiscovery"... May 31 04:24:41 volumio volumio[732]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 31 04:24:41 volumio node[732]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 31 04:24:41 volumio node[732]: *** WARNING *** Please fix your application to use the native API of Avahi! May 31 04:24:41 volumio node[732]: *** WARNING *** For more information see May 31 04:24:41 volumio node[732]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 31 04:24:41 volumio node[732]: *** WARNING *** Please fix your application to use the native API of Avahi! May 31 04:24:41 volumio node[732]: *** WARNING *** For more information see May 31 04:24:41 volumio volumio[732]: *** WARNING *** Please fix your application to use the native API of Avahi! May 31 04:24:41 volumio volumio[732]: *** WARNING *** For more information see May 31 04:24:41 volumio volumio[732]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 31 04:24:41 volumio volumio[732]: *** WARNING *** Please fix your application to use the native API of Avahi! May 31 04:24:41 volumio volumio[732]: *** WARNING *** For more information see May 31 04:24:42 volumio volumio[732]: info: Applying required configuration parameters for plugin volumiodiscovery May 31 04:24:42 volumio volumio[732]: Discovery: StartAdv! undefined May 31 04:24:42 volumio volumio[732]: Discovery: Started advertising... Volumio - undefined May 31 04:24:43 volumio volumio[732]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 31 04:24:43 volumio volumio[732]: info: Loading plugin "volparametriceq"... May 31 04:24:44 volumio volumio[732]: info: Applying required configuration parameters for plugin volparametriceq May 31 04:24:44 volumio volumio[732]: info: Loading plugin "outputs"... May 31 04:24:44 volumio volumio[732]: info: Loading plugin "albumart"... May 31 04:24:44 volumio volumio[732]: info: Plugin example_plugin is not enabled May 31 04:24:44 volumio volumio[732]: info: Loading plugin "inputs"... May 31 04:24:44 volumio volumio[732]: info: Loading plugin "updater_comm"... May 31 04:24:45 volumio volumio[732]: info: Plugin mpdemulation is not enabled May 31 04:24:45 volumio volumio[732]: info: Loading plugin "rest_api"... May 31 04:24:46 volumio volumio[732]: info: Loading plugin "websocket"... May 31 04:24:46 volumio volumio[732]: info: ___________ START PLUGINS ___________ May 31 04:24:46 volumio volumio[732]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 31 04:24:46 volumio volumio[732]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 31 04:24:46 volumio volumio[732]: info: [1780201486564] CoreMusicLibrary::Adding element Media Servers May 31 04:24:46 volumio volumio[732]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 31 04:24:46 volumio volumio-remote-updater[520]: [2026-05-31 04:24:46] [connect] Successful connection May 31 04:24:47 volumio volumio[732]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 31 04:24:47 volumio volumio[732]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 31 04:24:47 volumio volumio[732]: Forking 1 albumart workers May 31 04:24:47 volumio volumio[732]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 31 04:24:47 volumio volumio[732]: info: [1780201487386] CoreMusicLibrary::Adding element Last_100 May 31 04:24:47 volumio volumio[732]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 31 04:24:47 volumio volumio[732]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 31 04:24:47 volumio volumio[732]: info: [1780201487419] CoreMusicLibrary::Adding element Webradio May 31 04:24:47 volumio volumio[732]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 31 04:24:47 volumio volumio[732]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 31 04:24:47 volumio volumio[732]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 04:24:47 volumio volumio[732]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 04:24:47 volumio volumio[732]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 04:24:47 volumio volumio[732]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 04:24:47 volumio volumio[732]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 04:24:47 volumio volumio[732]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 04:24:47 volumio volumio[732]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 04:24:47 volumio volumio[732]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 04:24:48 volumio volumio[732]: info: ------------------------------------------- May 31 04:24:48 volumio sudo[848]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd_aloop index=7 pcm_substreams=2 May 31 04:24:48 volumio volumio[732]: info: ----- MyVolumio plugins startup ---- May 31 04:24:48 volumio volumio[732]: info: ------------------------------------------- May 31 04:24:48 volumio volumio[732]: info: [MyVolumio PluginManager] Fetching plans data.... May 31 04:24:48 volumio sudo[848]: pam_unix(sudo:session): session opened for user root by (uid=0) May 31 04:24:48 volumio sudo[848]: pam_unix(sudo:session): session closed for user root May 31 04:24:48 volumio volumio[732]: info: Loading i18n strings for locale ja May 31 04:24:48 volumio volumio[732]: Updating browse sources language May 31 04:24:48 volumio volumio[732]: Cannot find translation for sourceMedia Servers May 31 04:24:48 volumio volumio[732]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 31 04:24:48 volumio volumio[732]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 31 04:24:48 volumio volumio[732]: info: CoreCommandRouter::initPlayerControls May 31 04:24:48 volumio volumio[732]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 04:24:48 volumio volumio[732]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards May 31 04:24:49 volumio volumio[732]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 04:24:49 volumio volumio[732]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 04:24:49 volumio volumio[732]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 04:24:49 volumio volumio[732]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 04:24:49 volumio volumio[732]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 31 04:24:49 volumio volumio[732]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 31 04:24:49 volumio volumio[732]: info: BOOT COMPLETED May 31 04:24:49 volumio volumio[732]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 31 04:24:51 volumio volumio[732]: Starting albumart workers May 31 04:24:54 volumio volumio[732]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo May 31 04:24:54 volumio volumio[732]: info: CoreCommandRouter::Close All Modals sent May 31 04:24:54 volumio volumio[732]: info: CoreCommandRouter::Close All Modals sent May 31 04:24:54 volumio volumio[732]: Express server listening on port 3000 May 31 04:24:54 volumio volumio[732]: Volumio Calling Home May 31 04:24:55 volumio volumio[732]: info: volparametriceq Started May 31 04:24:55 volumio volumio[732]: info: CoreStateMachine::resetVolumioState May 31 04:24:55 volumio volumio[732]: info: CoreStateMachine::getcurrentVolume May 31 04:24:55 volumio volumio[732]: info: CoreCommandRouter::volumioRetrievevolume May 31 04:24:55 volumio volumio[732]: info: CoreStateMachine::pushState May 31 04:24:55 volumio volumio[732]: info: CoreStateMachine::getState May 31 04:24:55 volumio volumio[732]: info: CorePlayQueue::getTrack 0 May 31 04:24:55 volumio volumio[732]: info: CoreCommandRouter::volumioPushState May 31 04:24:55 volumio volumio[732]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 04:24:55 volumio sudo[876]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 31 04:24:55 volumio sudo[876]: pam_unix(sudo:session): session opened for user root by (uid=0) May 31 04:24:55 volumio volumio[732]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , disableI2SDAC May 31 04:24:55 volumio sudo[876]: pam_unix(sudo:session): session closed for user root May 31 04:24:55 volumio volumio[732]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 31 04:24:55 volumio volumio[732]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions May 31 04:24:55 volumio volumio[732]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 31 04:24:55 volumio volumio[732]: info: Output device has changed, restarting MPD May 31 04:24:55 volumio volumio[732]: info: Output device has changed, restarting Shairport Sync May 31 04:24:56 volumio sudo[887]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 31 04:24:56 volumio sudo[887]: pam_unix(sudo:session): session opened for user root by (uid=0) May 31 04:24:56 volumio sudo[887]: pam_unix(sudo:session): session closed for user root May 31 04:24:56 volumio sudo[889]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 31 04:24:56 volumio sudo[889]: pam_unix(sudo:session): session opened for user root by (uid=0) May 31 04:24:56 volumio systemd[1]: Stopping Music Player Daemon... May 31 04:24:56 volumio volumio[732]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 31 04:24:56 volumio systemd[1]: Starting Music Player Daemon... May 31 04:24:56 volumio volumio[732]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 31 04:24:56 volumio volumio[732]: info: Device Loopback does not have any Mixer Control Available, setting a softvol device May 31 04:24:57 volumio volumio[732]: info: CoreCommandRouter::volumioUpdateVolumeSettings May 31 04:24:57 volumio volumio[732]: info: Updating Volume Controller Parameters: Device: Loopback Name: Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 10 May 31 04:24:57 volumio volumio[732]: info: CoreCommandRouter::getUIConfigOnPlugin May 31 04:24:57 volumio volumio[732]: info: CoreStateMachine::pushState May 31 04:24:57 volumio volumio[732]: info: CoreStateMachine::getState May 31 04:24:57 volumio volumio[732]: info: CorePlayQueue::getTrack 0 May 31 04:24:57 volumio volumio[732]: info: CoreCommandRouter::volumioPushState May 31 04:24:57 volumio volumio[732]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 04:24:57 volumio volumio[732]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable May 31 04:24:57 volumio volumio[732]: info: CoreCommandRouter::executeOnPlugin: raat , onStop May 31 04:24:57 volumio volumio[732]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect May 31 04:25:00 volumio systemd[1]: Started Music Player Daemon. May 31 04:25:00 volumio sudo[889]: pam_unix(sudo:session): session closed for user root May 31 04:25:00 volumio volumio[732]: info: MPD Permissions set May 31 04:25:00 volumio volumio[732]: info: Setting Device type: Raspberry PI May 31 04:25:00 volumio volumio[732]: info: snd_aloop loaded May 31 04:25:00 volumio volumio[732]: info: MPD running with PID565 ,establishing connection May 31 04:25:00 volumio volumio[732]: info: CoreCommandRouter::volumioRetrieveVolumeLevels May 31 04:25:00 volumio volumio[732]: info: CoreStateMachine::getcurrentVolume May 31 04:25:01 volumio volumio[732]: info: CoreCommandRouter::volumioRetrievevolume May 31 04:25:01 volumio volumio[732]: info: CoreStateMachine::pushState May 31 04:25:01 volumio volumio[732]: info: CoreStateMachine::getState May 31 04:25:01 volumio volumio[732]: info: CorePlayQueue::getTrack 0 May 31 04:25:01 volumio volumio[732]: info: CoreCommandRouter::volumioPushState May 31 04:25:01 volumio volumio[732]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 04:25:01 volumio volumio[732]: { device: '1', May 31 04:25:01 volumio volumio[732]: name: 'HiFiBerry DAC', May 31 04:25:01 volumio volumio[732]: mixer: '', May 31 04:25:01 volumio volumio[732]: mixertype: 'None', May 31 04:25:01 volumio volumio[732]: maxvolume: '100', May 31 04:25:01 volumio volumio[732]: volumecurve: 'logarithmic', May 31 04:25:01 volumio volumio[732]: volumestart: 'disabled', May 31 04:25:01 volumio volumio[732]: volumesteps: '10' } May 31 04:25:01 volumio volumio-remote-updater[520]: [2026-05-31 04:25:01] [connect] Successful connection May 31 04:25:01 volumio volumio[732]: info: CoreCommandRouter::volumioUpdateVolumeSettings May 31 04:25:01 volumio volumio[732]: info: Updating Volume Controller Parameters: Device: 1 Name: HiFiBerry DAC Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 10 May 31 04:25:01 volumio volumio[732]: info: CoreStateMachine::pushState May 31 04:25:01 volumio volumio[732]: info: CoreStateMachine::getState May 31 04:25:01 volumio volumio[732]: info: CorePlayQueue::getTrack 0 May 31 04:25:01 volumio volumio[732]: info: CoreCommandRouter::volumioPushState May 31 04:25:01 volumio volumio[732]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 31 04:25:02 volumio volumio[732]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 31 04:25:02 volumio volumio[732]: { AssertionError [ERR_ASSERTION]: false == true May 31 04:25:02 volumio volumio[732]: at MpdClient.sendCommand (/volumio/app/plugins/music_service/mpd/lib/mpd.js:92:9) May 31 04:25:02 volumio volumio[732]: at /volumio/app/plugins/music_service/mpd/index.js:3103:19 May 31 04:25:02 volumio volumio[732]: at _combinedTickCallback (internal/process/next_tick.js:131:7) May 31 04:25:02 volumio volumio[732]: at process._tickCallback (internal/process/next_tick.js:180:9) May 31 04:25:02 volumio volumio[732]: generatedMessage: true, May 31 04:25:02 volumio volumio[732]: name: 'AssertionError [ERR_ASSERTION]', May 31 04:25:02 volumio volumio[732]: code: 'ERR_ASSERTION', May 31 04:25:02 volumio volumio[732]: actual: false, May 31 04:25:02 volumio volumio[732]: expected: true, May 31 04:25:02 volumio volumio[732]: operator: '==' } May 31 04:25:02 volumio volumio[732]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 31 04:25:05 volumio sudo[931]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-05-31 04:24 May 31 04:25:05 volumio sudo[931]: 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="76976c3150e60fa37f55c84c5ca4b7a47b667b83" VOLUMIO_FE_VERSION="" VOLUMIO_BE_VERSION="2b418696ba9df7da37e66ecee4256e963897e4a2" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sun Dec 1 01:32:00 CET 2019" VOLUMIO_VERSION="2.673" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="195d359258dcdb7969a22e2c84f33e21"