May 23 22:16:26 digionesign02 setdatetime-helper.sh[999]: Fri May 23 22:16:26 CEST 2025 May 23 22:16:26 digionesign02 bash[998]: Fri May 23 22:16:26 CEST 2025 May 23 22:16:26 digionesign02 systemd-journald[338]: Time jumped backwards, rotating. May 23 22:16:26 digionesign02 bash[910]: Time synchronized successfully. May 23 22:16:26 digionesign02 sudo[966]: pam_unix(sudo:session): session closed for user root May 23 22:16:26 digionesign02 sudo[965]: pam_unix(sudo:session): session closed for user root May 23 22:16:26 digionesign02 setdatetime-helper.sh[814]: Time synchronized successfully. May 23 22:16:26 digionesign02 systemd[1]: setdatetime-helper.timer.service: Deactivated successfully. May 23 22:16:26 digionesign02 systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service. May 23 22:16:26 digionesign02 systemd[1]: setdatetime-helper.service: Deactivated successfully. May 23 22:16:26 digionesign02 systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. May 23 22:16:26 digionesign02 systemd[1]: systemd-rfkill.service: Deactivated successfully. May 23 22:16:26 digionesign02 systemd[1]: welcome.service: Deactivated successfully. May 23 22:16:26 digionesign02 systemd[1]: Stopped welcome.service - Show a welcome message on console. May 23 22:16:26 digionesign02 systemd[1]: Stopping welcome.service - Show a welcome message on console... May 23 22:16:26 digionesign02 systemd[1]: Starting welcome.service - Show a welcome message on console... May 23 22:16:26 digionesign02 welcome[1009]: Resolved ip:[1] 192.168.178.125 May 23 22:16:26 digionesign02 systemd[1]: Finished welcome.service - Show a welcome message on console. May 23 22:16:26 digionesign02 systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0. May 23 22:16:26 digionesign02 ntpd[928]: DNS: dns_probe: 0.debian.pool.ntp.org, cast_flags:8, flags:101 May 23 22:16:26 digionesign02 systemd[1]: samba-ad-dc.service: Skipped due to 'exec-condition'. May 23 22:16:26 digionesign02 ntpd[928]: DNS: dns_check: processing 0.debian.pool.ntp.org, 8, 101 May 23 22:16:26 digionesign02 ntpd[928]: DNS: Pool taking: 193.134.29.12 May 23 22:16:26 digionesign02 ntpd[928]: DNS: Pool taking: 195.186.1.100 May 23 22:16:26 digionesign02 systemd[1]: Condition check resulted in samba-ad-dc.service - Samba AD Daemon being skipped. May 23 22:16:26 digionesign02 ntpd[928]: DNS: Pool taking: 85.195.227.70 May 23 22:16:26 digionesign02 ntpd[928]: DNS: Pool taking: 77.109.132.50 May 23 22:16:26 digionesign02 ntpd[928]: DNS: dns_take_status: 0.debian.pool.ntp.org=>good, 8 May 23 22:16:27 digionesign02 sudo[1026]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ip addr flush dev wlan0 May 23 22:16:27 digionesign02 sudo[1026]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 23 22:16:27 digionesign02 sudo[1026]: pam_unix(sudo:session): session closed for user root May 23 22:16:27 digionesign02 sudo[1028]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/ifconfig wlan0 down May 23 22:16:27 digionesign02 sudo[1028]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 23 22:16:27 digionesign02 ntpd[928]: DNS: dns_probe: 1.debian.pool.ntp.org, cast_flags:8, flags:101 May 23 22:16:28 digionesign02 ntpd[928]: DNS: dns_check: processing 1.debian.pool.ntp.org, 8, 101 May 23 22:16:28 digionesign02 ntpd[928]: DNS: Pool taking: 193.33.30.39 May 23 22:16:28 digionesign02 ntpd[928]: DNS: Pool taking: 212.51.144.47 May 23 22:16:28 digionesign02 ntpd[928]: DNS: Pool taking: 212.51.144.44 May 23 22:16:28 digionesign02 ntpd[928]: DNS: Pool taking: 109.233.182.115 May 23 22:16:28 digionesign02 ntpd[928]: DNS: dns_take_status: 1.debian.pool.ntp.org=>good, 8 May 23 22:16:28 digionesign02 sudo[1028]: pam_unix(sudo:session): session closed for user root May 23 22:16:28 digionesign02 nmbd[1024]: [2025/05/23 22:16:28.242409, 0] ../../source3/nmbd/nmbd.c:901(main) May 23 22:16:28 digionesign02 nmbd[1024]: nmbd version 4.17.8-Raspbian started. May 23 22:16:28 digionesign02 nmbd[1024]: Copyright Andrew Tridgell and the Samba Team 1992-2022 May 23 22:16:28 digionesign02 nmbd[1024]: [2025/05/23 22:16:28.250465, 0] ../../source3/nmbd/asyncdns.c:158(start_async_dns) May 23 22:16:28 digionesign02 nmbd[1024]: started asyncdns process 1032 May 23 22:16:28 digionesign02 systemd[1]: Started nmbd.service - Samba NMB Daemon. May 23 22:16:28 digionesign02 systemd[1]: Starting winbind.service - Samba Winbind Daemon... May 23 22:16:28 digionesign02 ntpd[928]: DNS: dns_probe: 2.debian.pool.ntp.org, cast_flags:8, flags:101 May 23 22:16:28 digionesign02 ntpd[928]: DNS: dns_check: processing 2.debian.pool.ntp.org, 8, 101 May 23 22:16:28 digionesign02 ntpd[928]: DNS: Pool taking: 193.5.60.9 May 23 22:16:28 digionesign02 ntpd[928]: DNS: Pool taking: 195.186.4.101 May 23 22:16:28 digionesign02 ntpd[928]: DNS: Pool taking: 82.197.188.130 May 23 22:16:28 digionesign02 ntpd[928]: DNS: Pool taking: 156.106.214.48 May 23 22:16:28 digionesign02 ntpd[928]: DNS: Pool taking: 2a02:168:6200:8::123 May 23 22:16:28 digionesign02 ntpd[928]: DNS: Pool taking: 2a02:168:420b:4::7b:12 May 23 22:16:28 digionesign02 ntpd[928]: DNS: Pool taking: 2a00:7580:60:211::52 May 23 22:16:28 digionesign02 ntpd[928]: DNS: Pool taking: 2001:620:0:fffc::123:47 May 23 22:16:28 digionesign02 ntpd[928]: DNS: dns_take_status: 2.debian.pool.ntp.org=>good, 8 May 23 22:16:28 digionesign02 systemd[1]: wireless.service: Deactivated successfully. May 23 22:16:28 digionesign02 systemd[1]: Started wireless.service - Wireless Services. May 23 22:16:28 digionesign02 systemd[1]: wireless.service: Consumed 14.237s CPU time. May 23 22:16:28 digionesign02 systemd[1]: Started volumio.service - Volumio Backend Module. May 23 22:16:28 digionesign02 systemd[1]: Starting plymouth-quit.service - Terminate Plymouth Boot Screen... May 23 22:16:28 digionesign02 systemd[1]: Started volumio_cpu_tweak.service - Volumio Cpu Tweaker. May 23 22:16:28 digionesign02 systemd[1]: Received SIGRTMIN+21 from PID 206 (plymouthd). May 23 22:16:28 digionesign02 systemd[1]: Received SIGRTMIN+21 from PID 206 (plymouthd). May 23 22:16:28 digionesign02 systemd[1]: Finished plymouth-quit-wait.service - Hold until boot process finishes up. May 23 22:16:28 digionesign02 systemd[1]: Finished plymouth-quit.service - Terminate Plymouth Boot Screen. May 23 22:16:29 digionesign02 systemd[1]: Started getty@tty1.service - Getty on tty1. May 23 22:16:29 digionesign02 systemd[1]: Reached target getty.target - Login Prompts. May 23 22:16:29 digionesign02 volumio-cpu-tweak[1045]: Setting RT Priority for mpd May 23 22:16:29 digionesign02 volumio-cpu-tweak[1060]: pid 35's current scheduling policy: SCHED_OTHER May 23 22:16:29 digionesign02 volumio-cpu-tweak[1060]: pid 35's current scheduling priority: 0 May 23 22:16:29 digionesign02 volumio-cpu-tweak[1045]: Setting MPD Affinity May 23 22:16:29 digionesign02 volumio-cpu-tweak[1061]: pid 3's current affinity mask: f May 23 22:16:29 digionesign02 volumio-cpu-tweak[1045]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input May 23 22:16:29 digionesign02 volumio-cpu-tweak[1045]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance May 23 22:16:29 digionesign02 systemd[1]: volumio_cpu_tweak.service: Deactivated successfully. May 23 22:16:29 digionesign02 winbindd[1039]: [2025/05/23 22:16:29.584269, 0] ../../source3/winbindd/winbindd.c:1440(main) May 23 22:16:29 digionesign02 winbindd[1039]: winbindd version 4.17.8-Raspbian started. May 23 22:16:29 digionesign02 winbindd[1039]: Copyright Andrew Tridgell and the Samba Team 1992-2022 May 23 22:16:29 digionesign02 winbindd[1039]: [2025/05/23 22:16:29.619131, 0] ../../source3/winbindd/winbindd_cache.c:3116(initialize_winbindd_cache) May 23 22:16:29 digionesign02 winbindd[1039]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 May 23 22:16:29 digionesign02 systemd[1]: Started winbind.service - Samba Winbind Daemon. May 23 22:16:29 digionesign02 ntpd[928]: DNS: dns_probe: 3.debian.pool.ntp.org, cast_flags:8, flags:101 May 23 22:16:29 digionesign02 ntpd[928]: DNS: dns_check: processing 3.debian.pool.ntp.org, 8, 101 May 23 22:16:29 digionesign02 ntpd[928]: DNS: Pool skipping: 193.33.30.39 May 23 22:16:29 digionesign02 ntpd[928]: DNS: Pool taking: 81.94.123.17 May 23 22:16:29 digionesign02 ntpd[928]: DNS: Pool taking: 62.220.129.71 May 23 22:16:29 digionesign02 ntpd[928]: DNS: Pool taking: 84.16.73.33 May 23 22:16:29 digionesign02 ntpd[928]: DNS: dns_take_status: 3.debian.pool.ntp.org=>good, 8 May 23 22:16:29 digionesign02 systemd[1]: Starting smbd.service - Samba SMB Daemon... May 23 22:16:30 digionesign02 smbd[1079]: [2025/05/23 22:16:30.972386, 0] ../../source3/smbd/server.c:1741(main) May 23 22:16:30 digionesign02 smbd[1079]: smbd version 4.17.8-Raspbian started. May 23 22:16:30 digionesign02 smbd[1079]: Copyright Andrew Tridgell and the Samba Team 1992-2022 May 23 22:16:31 digionesign02 volumio-remote-updater[572]: [2025-05-23 22:16:31] [info] asio async_connect error: system:111 (Connection refused) May 23 22:16:31 digionesign02 volumio-remote-updater[572]: [2025-05-23 22:16:31] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) May 23 22:16:31 digionesign02 volumio-remote-updater[572]: [2025-05-23 22:16:31] [error] handle_connect error: Underlying Transport Error May 23 22:16:34 digionesign02 ntpd[928]: CLOCK: time stepped by 1.379354 May 23 22:16:34 digionesign02 ntpd[928]: INIT: MRU 13107 entries, 13 hash bits, 32768 bytes May 23 22:16:34 digionesign02 systemd[1]: Started smbd.service - Samba SMB Daemon. May 23 22:16:34 digionesign02 systemd[1]: Reached target multi-user.target - Multi-User System. May 23 22:16:34 digionesign02 systemd[1]: Reached target graphical.target - Graphical Interface. May 23 22:16:35 digionesign02 systemd[1]: Starting systemd-update-utmp-runlevel.service - Record Runlevel Change in UTMP... May 23 22:16:35 digionesign02 systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. May 23 22:16:35 digionesign02 systemd[1]: Finished systemd-update-utmp-runlevel.service - Record Runlevel Change in UTMP. May 23 22:16:35 digionesign02 systemd[1]: Startup finished in 16.009s (kernel) + 24.996s (userspace) = 41.006s. May 23 22:16:37 digionesign02 volumio[1043]: info: ------------------------------------------- May 23 22:16:37 digionesign02 volumio[1043]: info: ----- Volumio3 ---- May 23 22:16:37 digionesign02 volumio[1043]: info: ------------------------------------------- May 23 22:16:37 digionesign02 volumio[1043]: info: ----- System startup ---- May 23 22:16:37 digionesign02 volumio[1043]: info: ------------------------------------------- May 23 22:16:39 digionesign02 volumio[1043]: info: MYVOLUMIO Environment detected May 23 22:16:39 digionesign02 volumio[1043]: info: Plugin folders cleanup May 23 22:16:39 digionesign02 volumio[1043]: info: Scanning into folder /volumio/app/plugins/ May 23 22:16:39 digionesign02 volumio[1043]: info: Scanning category audio_interface May 23 22:16:39 digionesign02 volumio[1043]: info: Scanning category miscellanea May 23 22:16:39 digionesign02 volumio[1043]: info: Scanning category music_service May 23 22:16:39 digionesign02 volumio[1043]: info: Scanning category plugins.json May 23 22:16:39 digionesign02 volumio[1043]: info: Scanning category system_controller May 23 22:16:39 digionesign02 volumio[1043]: info: Scanning category user_interface May 23 22:16:39 digionesign02 volumio[1043]: info: Scanning into folder /data/plugins/ May 23 22:16:39 digionesign02 volumio[1043]: info: Scanning category user_interface May 23 22:16:39 digionesign02 volumio[1043]: info: Plugin folders cleanup completed May 23 22:16:39 digionesign02 volumio[1043]: info: ------------------------------------------- May 23 22:16:39 digionesign02 volumio[1043]: info: ----- Core plugins startup ---- May 23 22:16:39 digionesign02 volumio[1043]: info: ------------------------------------------- May 23 22:16:39 digionesign02 volumio[1043]: info: Loading plugins from folder /volumio/app/plugins/ May 23 22:16:39 digionesign02 volumio[1043]: info: Adding plugin upnp to MyMusic Plugins May 23 22:16:39 digionesign02 volumio[1043]: info: Adding plugin airplay_emulation to MyMusic Plugins May 23 22:16:39 digionesign02 volumio[1043]: info: Adding plugin upnp_browser to MyMusic Plugins May 23 22:16:39 digionesign02 volumio[1043]: info: Loading plugins from folder /data/plugins/ May 23 22:16:39 digionesign02 volumio[1043]: info: Loading plugin "system"... May 23 22:16:39 digionesign02 volumio[1043]: info: Loading plugin "appearance"... May 23 22:16:42 digionesign02 volumio[1043]: info: Loading plugin "network"... May 23 22:16:42 digionesign02 volumio[1043]: info: Refreshing Cached IP Addresses May 23 22:16:43 digionesign02 sudo[1105]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 23 22:16:43 digionesign02 sudo[1105]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 23 22:16:43 digionesign02 volumio[1043]: info: Loading plugin "services"... May 23 22:16:43 digionesign02 sudo[1105]: pam_unix(sudo:session): session closed for user root May 23 22:16:43 digionesign02 volumio[1043]: info: Loading plugin "alsa_controller"... May 23 22:16:43 digionesign02 sudo[1107]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 23 22:16:43 digionesign02 sudo[1107]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 23 22:16:43 digionesign02 sudo[1107]: pam_unix(sudo:session): session closed for user root May 23 22:16:43 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 23 22:16:43 digionesign02 volumio[1043]: info: Loading plugin "wizard"... May 23 22:16:43 digionesign02 volumio[1043]: info: Loading plugin "networkfs"... May 23 22:16:43 digionesign02 volumio-remote-updater[572]: [2025-05-23 22:16:43] [connect] Successful connection May 23 22:16:43 digionesign02 volumio[1043]: info: Starting Udev Watcher for removable devices May 23 22:16:43 digionesign02 sudo[1133]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=Musik,password=MyStreamer(JM,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.178.11/music /mnt/NAS/Musik May 23 22:16:43 digionesign02 sudo[1133]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 23 22:16:43 digionesign02 volumio[1043]: info: Ignoring mount for partition: boot May 23 22:16:43 digionesign02 volumio[1043]: info: Ignoring mount for partition: volumio May 23 22:16:43 digionesign02 volumio[1043]: info: Ignoring mount for partition: volumio_data May 23 22:16:43 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 23 22:16:43 digionesign02 volumio[1043]: info: Loading plugin "volumio_command_line_client"... May 23 22:16:43 digionesign02 volumio[1043]: info: Loading plugin "upnp"... May 23 22:16:43 digionesign02 volumio[1043]: info: [1748031403463] Starting Upmpd Daemon May 23 22:16:43 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 23 22:16:43 digionesign02 volumio[1043]: info: Loading plugin "my_music"... May 23 22:16:43 digionesign02 volumio[1043]: info: Loading plugin "mpd"... May 23 22:16:43 digionesign02 kernel: netfs: FS-Cache loaded May 23 22:16:43 digionesign02 kernel: Key type cifs.spnego registered May 23 22:16:43 digionesign02 kernel: Key type cifs.idmap registered May 23 22:16:43 digionesign02 kernel: CIFS: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3.1.1), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3.1.1 (or even SMB3 or SMB2.1) specify vers=1.0 on mount. May 23 22:16:43 digionesign02 kernel: CIFS: Attempting to mount //192.168.178.11/music May 23 22:16:44 digionesign02 sudo[1133]: pam_unix(sudo:session): session closed for user root May 23 22:16:44 digionesign02 volumio[1043]: info: Loading plugin "upnp_browser"... May 23 22:16:46 digionesign02 systemd[1]: systemd-fsckd.service: Deactivated successfully. May 23 22:16:47 digionesign02 volumio[1043]: info: Loading plugin "alarm-clock"... May 23 22:16:48 digionesign02 volumio[1043]: info: Loading plugin "airplay_emulation"... May 23 22:16:48 digionesign02 volumio[1043]: info: Starting Shairport Sync May 23 22:16:48 digionesign02 volumio[1043]: info: Loading plugin "last_100"... May 23 22:16:48 digionesign02 volumio[1043]: info: Loading plugin "webradio"... May 23 22:16:48 digionesign02 volumio[1043]: info: Loading plugin "i2s_dacs"... May 23 22:16:48 digionesign02 volumio[1043]: info: Loading plugin "volumiodiscovery"... May 23 22:16:48 digionesign02 volumio[1043]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 23 22:16:48 digionesign02 volumio[1043]: *** WARNING *** Please fix your application to use the native API of Avahi! May 23 22:16:48 digionesign02 volumio[1043]: *** WARNING *** For more information see May 23 22:16:48 digionesign02 volumio[1043]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 23 22:16:48 digionesign02 volumio[1043]: *** WARNING *** Please fix your application to use the native API of Avahi! May 23 22:16:48 digionesign02 volumio[1043]: *** WARNING *** For more information see May 23 22:16:48 digionesign02 node[1043]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 23 22:16:48 digionesign02 node[1043]: *** WARNING *** Please fix your application to use the native API of Avahi! May 23 22:16:48 digionesign02 node[1043]: *** WARNING *** For more information see May 23 22:16:48 digionesign02 node[1043]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 23 22:16:48 digionesign02 node[1043]: *** WARNING *** Please fix your application to use the native API of Avahi! May 23 22:16:48 digionesign02 node[1043]: *** WARNING *** For more information see May 23 22:16:48 digionesign02 volumio[1043]: info: Applying required configuration parameters for plugin volumiodiscovery May 23 22:16:48 digionesign02 volumio[1043]: info: Discovery: Started advertising with name: digionesign02 May 23 22:16:48 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 23 22:16:48 digionesign02 volumio[1043]: info: Loading plugin "outputs"... May 23 22:16:48 digionesign02 volumio[1043]: info: Loading plugin "albumart"... May 23 22:16:48 digionesign02 volumio[1043]: info: Plugin example_plugin is not enabled May 23 22:16:48 digionesign02 volumio[1043]: info: Loading plugin "inputs"... May 23 22:16:48 digionesign02 volumio[1043]: info: Loading plugin "updater_comm"... May 23 22:16:49 digionesign02 volumio[1043]: info: Plugin mpdemulation is not enabled May 23 22:16:49 digionesign02 volumio[1043]: info: Loading plugin "rest_api"... May 23 22:16:49 digionesign02 volumio[1043]: info: Loading plugin "websocket"... May 23 22:16:49 digionesign02 volumio[1043]: info: Starting Socket.io Server version 1.7.4 May 23 22:16:49 digionesign02 volumio[1043]: info: Loading plugin "Systeminfo"... May 23 22:16:50 digionesign02 volumio[1171]: Forking 3 albumart workers May 23 22:16:50 digionesign02 volumio[1043]: info: Loading i18n strings for locale de May 23 22:16:51 digionesign02 volumio[1043]: Updating browse sources language May 23 22:16:51 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 23 22:16:52 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 23 22:16:52 digionesign02 volumio[1043]: info: CoreCommandRouter::initPlayerControls May 23 22:16:52 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 23 22:16:52 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 23 22:16:52 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 23 22:16:52 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 23 22:16:52 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 23 22:16:52 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 23 22:16:52 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 23 22:16:52 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 23 22:16:52 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 23 22:16:52 digionesign02 volumio[1043]: Express server listening on port 3000 May 23 22:16:52 digionesign02 volumio[1043]: [Metrics] WebUI: 16s 587.28ms May 23 22:16:52 digionesign02 volumio[1043]: info: CoreStateMachine::resetVolumioState May 23 22:16:52 digionesign02 volumio[1043]: info: CoreStateMachine::getcurrentVolume May 23 22:16:52 digionesign02 volumio[1043]: info: CoreCommandRouter::volumioRetrievevolume May 23 22:16:53 digionesign02 volumio[1043]: info: Volumio Network Manager: Network status updated: 1 May 23 22:16:53 digionesign02 volumio[1043]: verbose: New Socket.io Connection to digionesign02.local from 192.168.178.132 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 May 23 22:16:54 digionesign02 volumio[1043]: info: CoreStateMachine::pushState May 23 22:16:54 digionesign02 volumio[1043]: info: CorePlayQueue::getTrack 0 May 23 22:16:54 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 23 22:16:54 digionesign02 volumio[1043]: info: CoreCommandRouter::volumioPushState May 23 22:16:54 digionesign02 volumio[1043]: info: CoreStateMachine::updateTrackBlock May 23 22:16:54 digionesign02 volumio[1043]: info: CorePlayQueue::getTrackBlock May 23 22:16:54 digionesign02 volumio[1043]: info: CoreCommandRouter::volumioRetrievevolume May 23 22:16:54 digionesign02 sudo[1245]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 23 22:16:54 digionesign02 sudo[1245]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 23 22:16:54 digionesign02 sudo[1243]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 23 22:16:54 digionesign02 sudo[1243]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 23 22:16:54 digionesign02 sudo[1245]: pam_unix(sudo:session): session closed for user root May 23 22:16:54 digionesign02 sudo[1243]: pam_unix(sudo:session): session closed for user root May 23 22:16:54 digionesign02 volumio[1043]: verbose: New Socket.io Connection to 192.168.178.125 from 192.168.178.132 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 May 23 22:16:54 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 23 22:16:55 digionesign02 volumio[1043]: info: Reloading queue from file May 23 22:16:55 digionesign02 systemd[1]: systemd-hostnamed.service: Deactivated successfully. May 23 22:16:55 digionesign02 volumio[1043]: info: CoreCommandRouter::volumioGetState May 23 22:16:55 digionesign02 volumio[1043]: info: CorePlayQueue::getTrack 0 May 23 22:16:55 digionesign02 volumio[1043]: info: CoreStateMachine::pushState May 23 22:16:55 digionesign02 volumio[1043]: info: CorePlayQueue::getTrack 0 May 23 22:16:55 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 23 22:16:55 digionesign02 volumio[1043]: info: CoreCommandRouter::volumioPushState May 23 22:16:55 digionesign02 volumio[1043]: info: CoreStateMachine::setRepeat true single undefined May 23 22:16:55 digionesign02 volumio[1043]: info: CoreStateMachine::pushState May 23 22:16:55 digionesign02 volumio[1043]: info: CorePlayQueue::getTrack 0 May 23 22:16:55 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 23 22:16:55 digionesign02 volumio[1043]: info: CoreCommandRouter::volumioPushState May 23 22:16:55 digionesign02 volumio[1043]: info: CoreStateMachine::setRandom null May 23 22:16:55 digionesign02 volumio[1043]: info: CoreStateMachine::pushState May 23 22:16:55 digionesign02 volumio[1043]: info: CorePlayQueue::getTrack 0 May 23 22:16:55 digionesign02 volumio[1043]: info: CoreCommandRouter::volumioPushState May 23 22:16:55 digionesign02 volumio[1043]: info: Setting Device type: Raspberry PI May 23 22:16:56 digionesign02 volumio[1043]: info: CoreCommandRouter::volumioGetQueue May 23 22:16:56 digionesign02 volumio[1043]: info: CoreStateMachine::getQueue May 23 22:16:56 digionesign02 volumio[1043]: info: CorePlayQueue::getQueue May 23 22:16:56 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: system , getHwuuid May 23 22:16:56 digionesign02 volumio[1043]: info: CALLMETHOD: music_service inputs serialMonitorAction [object Object] May 23 22:16:56 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: inputs , serialMonitorAction May 23 22:16:56 digionesign02 volumio[1043]: info: Error : CoreCommandRouter::executeOnPlugin: No method [serialMonitorAction] in plugin inputs May 23 22:16:56 digionesign02 volumio[1043]: info: CALLMETHOD: system_controller motivocontrol displaySelection [object Object] May 23 22:16:56 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: motivocontrol , displaySelection May 23 22:16:56 digionesign02 volumio[1043]: verbose: New Socket.io Connection to 192.168.178.125 from 192.168.178.132 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 May 23 22:16:56 digionesign02 volumio[1043]: info: Completed loading Core Plugins May 23 22:16:56 digionesign02 systemd[1]: systemd-timedated.service: Deactivated successfully. May 23 22:16:56 digionesign02 volumio[1043]: info: Preparing to generate the ALSA configuration file May 23 22:16:56 digionesign02 volumio[1043]: info: Discovery: adding fadf173a-e027-49d7-ab38-9c4f63f5c6a4 May 23 22:16:56 digionesign02 volumio[1043]: info: Discovery: Found device BOSS2-02 May 23 22:16:56 digionesign02 volumio[1043]: info: Discovery: Connecting to remote: 192.168.178.182 May 23 22:16:56 digionesign02 volumio[1043]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf May 23 22:16:56 digionesign02 volumio[1043]: info: Reading ALSA contributions from plugins. May 23 22:16:56 digionesign02 volumio[1043]: verbose: New Socket.io Connection to 192.168.178.125:3000 from 192.168.178.157 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 May 23 22:16:56 digionesign02 volumio[1043]: verbose: New Socket.io Connection to 192.168.178.125:3000 from 192.168.178.182 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 May 23 22:16:57 digionesign02 volumio[1043]: info: Discovery: adding bc66f56f-feaa-474f-9bce-adbe0d33ce3d May 23 22:16:57 digionesign02 volumio[1043]: info: Discovery: Found device DigiOneSignEG May 23 22:16:57 digionesign02 volumio[1043]: info: Discovery: Connecting to remote: 192.168.178.157 May 23 22:16:57 digionesign02 volumio[1043]: verbose: New Socket.io Connection to 192.168.178.125 from 192.168.178.132 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/136.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 May 23 22:16:57 digionesign02 volumio[1043]: info: Discovery: Connected to remote: 192.168.178.182 May 23 22:16:57 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 23 22:16:57 digionesign02 sudo[1265]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service May 23 22:16:57 digionesign02 sudo[1265]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 23 22:16:57 digionesign02 volumio[1043]: info: Discovery: adding 4e453294-728a-4540-9270-79d8b7f52067 May 23 22:16:57 digionesign02 volumio[1043]: info: Discovery: Found device BOSS-02 May 23 22:16:58 digionesign02 volumio[1043]: info: Discovery: Connecting to remote: 192.168.178.178 May 23 22:16:58 digionesign02 volumio[1043]: info: Discovery: adding 762c0799-fc34-489a-9be6-91ff2aec9e22 May 23 22:16:58 digionesign02 volumio[1043]: info: Discovery: Found device digionesign02 May 23 22:16:58 digionesign02 volumio[1043]: info: CoreCommandRouter::volumioGetState May 23 22:16:58 digionesign02 volumio[1043]: info: CorePlayQueue::getTrack 0 May 23 22:16:58 digionesign02 volumio[1043]: info: Discovery: this is already registered, 762c0799-fc34-489a-9be6-91ff2aec9e22 May 23 22:16:58 digionesign02 volumio[1043]: info: Discovery: Found device digionesign02 May 23 22:16:58 digionesign02 volumio[1043]: info: CoreCommandRouter::volumioGetState May 23 22:16:58 digionesign02 volumio[1043]: info: CorePlayQueue::getTrack 0 May 23 22:16:58 digionesign02 systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. May 23 22:16:58 digionesign02 sudo[1265]: pam_unix(sudo:session): session closed for user root May 23 22:16:58 digionesign02 volumio-remote-updater[572]: [2025-05-23 22:16:58] [connect] Successful connection May 23 22:16:58 digionesign02 volumio[1183]: Starting albumart workers May 23 22:16:58 digionesign02 volumio[1043]: info: Discovery: Connected to remote: 192.168.178.157 May 23 22:16:59 digionesign02 volumio[1043]: info: CoreCommandRouter::volumioGetVisibleSources May 23 22:16:59 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 23 22:16:59 digionesign02 volumio[1043]: info: CoreCommandRouter::volumioGetState May 23 22:16:59 digionesign02 volumio[1043]: info: CorePlayQueue::getTrack 0 May 23 22:16:59 digionesign02 volumio[1043]: info: CoreCommandRouter::volumioGetState May 23 22:16:59 digionesign02 volumio[1043]: info: CorePlayQueue::getTrack 0 May 23 22:16:59 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 23 22:16:59 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 23 22:16:59 digionesign02 volumio[1043]: info: Received Get System Info May 23 22:16:59 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 23 22:16:59 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 23 22:16:59 digionesign02 volumio[1043]: info: Discovery: Getting this device information May 23 22:16:59 digionesign02 volumio[1043]: info: CoreCommandRouter::volumioGetState May 23 22:16:59 digionesign02 volumio[1043]: info: CorePlayQueue::getTrack 0 May 23 22:16:59 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 23 22:16:59 digionesign02 volumio[1043]: info: CoreCommandRouter::volumioGetState May 23 22:16:59 digionesign02 volumio[1043]: info: CorePlayQueue::getTrack 0 May 23 22:16:59 digionesign02 volumio[1043]: info: Listing playlists May 23 22:16:59 digionesign02 volumio[1043]: verbose: New Socket.io Connection to 192.168.178.125:3000 from 192.168.178.182 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 May 23 22:16:59 digionesign02 volumio[1043]: info: Upmpdcli Daemon Started May 23 22:16:59 digionesign02 volumio[1043]: verbose: New Socket.io Connection to 192.168.178.125:3000 from 192.168.178.178 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 May 23 22:16:59 digionesign02 volumio[1043]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 May 23 22:17:00 digionesign02 volumio[1043]: verbose: New Socket.io Connection to 192.168.178.125:3000 from 192.168.178.157 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 May 23 22:17:00 digionesign02 volumio[1182]: Starting albumart workers May 23 22:17:00 digionesign02 volumio[1043]: info: Discovery: Connected to remote: 192.168.178.178 May 23 22:17:00 digionesign02 volumio[1181]: Starting albumart workers May 23 22:17:01 digionesign02 volumio-remote-updater[572]: [2025-05-23 22:17:01] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1748031418 101 May 23 22:17:01 digionesign02 volumio[1043]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 10 May 23 22:17:01 digionesign02 volumio[1043]: info: Asound.conf file written May 23 22:17:01 digionesign02 sudo[1281]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf May 23 22:17:01 digionesign02 sudo[1281]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 23 22:17:01 digionesign02 sudo[1281]: pam_unix(sudo:session): session closed for user root May 23 22:17:01 digionesign02 volumio[1043]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 May 23 22:17:01 digionesign02 volumio[1043]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 May 23 22:17:01 digionesign02 volumio[1043]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:2 use case configuration -2 May 23 22:17:01 digionesign02 volumio[1043]: info: Output device has changed, restarting MPD May 23 22:17:02 digionesign02 volumio[1043]: info: Output device has changed, restarting Shairport Sync May 23 22:17:02 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 23 22:17:02 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 23 22:17:02 digionesign02 sudo[1287]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 23 22:17:02 digionesign02 sudo[1287]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 23 22:17:02 digionesign02 sudo[1287]: pam_unix(sudo:session): session closed for user root May 23 22:17:02 digionesign02 sudo[1289]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 23 22:17:02 digionesign02 sudo[1289]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 23 22:17:02 digionesign02 volumio[1043]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 23 22:17:02 digionesign02 volumio[1043]: info: ___________ START PLUGINS ___________ May 23 22:17:02 digionesign02 volumio[1043]: info: ControllerMpd::onStart: Initializing MPD May 23 22:17:02 digionesign02 volumio[1043]: info: Creating MPD Configuration file May 23 22:17:02 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 23 22:17:02 digionesign02 volumio[1043]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 23 22:17:02 digionesign02 volumio[1043]: info: [1748031422577] CoreMusicLibrary::Adding element Medienserver May 23 22:17:02 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 23 22:17:02 digionesign02 sudo[1297]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 23 22:17:02 digionesign02 systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. May 23 22:17:02 digionesign02 sudo[1297]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 23 22:17:02 digionesign02 sudo[1297]: pam_unix(sudo:session): session closed for user root May 23 22:17:02 digionesign02 systemd[1]: Starting mpd.service - Music Player Daemon... May 23 22:17:02 digionesign02 sudo[1300]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 23 22:17:02 digionesign02 sudo[1300]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 23 22:17:02 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 23 22:17:02 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 23 22:17:02 digionesign02 volumio[1043]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 23 22:17:02 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 23 22:17:02 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 23 22:17:03 digionesign02 systemd[1]: mpd.service: Deactivated successfully. May 23 22:17:03 digionesign02 systemd[1]: Stopped mpd.service - Music Player Daemon. May 23 22:17:03 digionesign02 systemd[1]: mpd.socket: Deactivated successfully. May 23 22:17:03 digionesign02 systemd[1]: Closed mpd.socket - Music Player Daemon Socket. May 23 22:17:03 digionesign02 systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... May 23 22:17:03 digionesign02 volumio[1043]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 23 22:17:03 digionesign02 volumio[1043]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 23 22:17:03 digionesign02 volumio[1043]: info: [1748031423099] CoreMusicLibrary::Adding element Last_100 May 23 22:17:03 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 23 22:17:03 digionesign02 systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. May 23 22:17:03 digionesign02 systemd[1]: Starting mpd.service - Music Player Daemon... May 23 22:17:03 digionesign02 volumio[1043]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 23 22:17:03 digionesign02 volumio[1043]: info: [1748031423184] CoreMusicLibrary::Adding element Webradio May 23 22:17:03 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 23 22:17:03 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 23 22:17:03 digionesign02 volumio[1043]: info: Initializing BBC Radios May 23 22:17:03 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 23 22:17:03 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 23 22:17:03 digionesign02 volumio[1043]: info: Volumio Calling Home May 23 22:17:03 digionesign02 sudo[1320]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 23 22:17:03 digionesign02 sudo[1320]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 23 22:17:03 digionesign02 sudo[1344]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory May 23 22:17:03 digionesign02 sudo[1320]: pam_unix(sudo:session): session closed for user root May 23 22:17:08 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket May 23 22:17:08 digionesign02 volumio[1043]: info: CoreCommandRouter::volumioGetState May 23 22:17:08 digionesign02 volumio[1043]: info: CorePlayQueue::getTrack 0 May 23 22:17:08 digionesign02 volumio[1043]: info: MPD Permissions set May 23 22:17:08 digionesign02 volumio[1043]: info: MPD Permissions set May 23 22:17:09 digionesign02 volumio[1043]: info: Volumio called home May 23 22:17:10 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 23 22:17:10 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 23 22:17:10 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 23 22:17:10 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 23 22:17:10 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 23 22:17:10 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 23 22:17:10 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 23 22:17:10 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 23 22:17:10 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 23 22:17:10 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 23 22:17:10 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 23 22:17:10 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 23 22:17:10 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 23 22:17:10 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 23 22:17:10 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 23 22:17:10 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 23 22:17:10 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 23 22:17:10 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 23 22:17:10 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 23 22:17:10 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 23 22:17:10 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket May 23 22:17:11 digionesign02 volumio[1043]: info: CoreCommandRouter::volumioGetState May 23 22:17:11 digionesign02 volumio[1043]: info: CorePlayQueue::getTrack 0 May 23 22:17:11 digionesign02 volumio[1043]: info: Starting Shairport Sync May 23 22:17:12 digionesign02 volumio[1043]: info: Starting Shairport Sync May 23 22:17:12 digionesign02 volumio[1043]: info: Starting Shairport Sync May 23 22:17:12 digionesign02 sudo[1380]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 23 22:17:12 digionesign02 sudo[1380]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 23 22:17:12 digionesign02 sudo[1384]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 23 22:17:12 digionesign02 sudo[1384]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 23 22:17:12 digionesign02 sudo[1382]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 23 22:17:12 digionesign02 sudo[1382]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 23 22:17:12 digionesign02 volumio[1043]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 11 May 23 22:17:12 digionesign02 systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... May 23 22:17:12 digionesign02 systemd[1]: shairport-sync.service: Deactivated successfully. May 23 22:17:12 digionesign02 systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. May 23 22:17:12 digionesign02 systemd[1]: shairport-sync.service: Consumed 2.105s CPU time. May 23 22:17:12 digionesign02 systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. May 23 22:17:12 digionesign02 sudo[1380]: pam_unix(sudo:session): session closed for user root May 23 22:17:12 digionesign02 volumio[1043]: info: Shairport-Sync Started May 23 22:17:12 digionesign02 systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... May 23 22:17:12 digionesign02 systemd[1]: shairport-sync.service: Deactivated successfully. May 23 22:17:12 digionesign02 systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. May 23 22:17:12 digionesign02 volumio[1043]: Error adding Membership: Error: addMembership EINVAL May 23 22:17:12 digionesign02 systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. May 23 22:17:12 digionesign02 sudo[1384]: pam_unix(sudo:session): session closed for user root May 23 22:17:12 digionesign02 sudo[1382]: pam_unix(sudo:session): session closed for user root May 23 22:17:13 digionesign02 volumio[1043]: info: Shairport-Sync Started May 23 22:17:13 digionesign02 volumio[1043]: info: Shairport-Sync Started May 23 22:17:13 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket May 23 22:17:13 digionesign02 volumio[1043]: info: CoreCommandRouter::volumioGetState May 23 22:17:13 digionesign02 volumio[1043]: info: CorePlayQueue::getTrack 0 May 23 22:17:13 digionesign02 volumio[1043]: info: CoreCommandRouter::volumioGetState May 23 22:17:13 digionesign02 volumio[1043]: info: CorePlayQueue::getTrack 0 May 23 22:17:15 digionesign02 mpd[1345]: 2025-05-23T22:17:15 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg May 23 22:17:16 digionesign02 systemd[1]: Started mpd.service - Music Player Daemon. May 23 22:17:16 digionesign02 sudo[1289]: pam_unix(sudo:session): session closed for user root May 23 22:17:16 digionesign02 sudo[1300]: pam_unix(sudo:session): session closed for user root May 23 22:17:16 digionesign02 volumio[1043]: info: Completed starting Core Plugins May 23 22:17:16 digionesign02 volumio[1043]: info: ------------------------------------------- May 23 22:17:16 digionesign02 volumio[1043]: info: ----- MyVolumio plugins startup ---- May 23 22:17:16 digionesign02 volumio[1043]: info: ------------------------------------------- May 23 22:17:16 digionesign02 volumio[1043]: info: [MyVolumio PluginManager] Fetching plans data.... May 23 22:17:17 digionesign02 volumio[1043]: error: MPD error: The expression evaluated to a falsy value: May 23 22:17:17 digionesign02 volumio[1043]: assert.ok(self.idling) May 23 22:17:17 digionesign02 volumio[1043]: error: The expression evaluated to a falsy value: May 23 22:17:17 digionesign02 volumio[1043]: assert.ok(self.idling) May 23 22:17:17 digionesign02 volumio[1043]: info: MPD running with PID1345 May 23 22:17:17 digionesign02 volumio[1043]: ,establishing connection May 23 22:17:17 digionesign02 volumio[1043]: error: updateQueue error: null May 23 22:17:17 digionesign02 volumio[1043]: error: updateQueue error: null May 23 22:17:22 digionesign02 volumio[1043]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory May 23 22:17:35 digionesign02 systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service... May 23 22:17:35 digionesign02 dbus-daemon[558]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.22' (uid=0 pid=1457 comm="timedatectl show --property=NTPSynchronized --valu") May 23 22:17:35 digionesign02 systemd[1]: Starting systemd-timedated.service - Time & Date Service... May 23 22:17:36 digionesign02 dbus-daemon[558]: [system] Successfully activated service 'org.freedesktop.timedate1' May 23 22:17:36 digionesign02 systemd[1]: Started systemd-timedated.service - Time & Date Service. May 23 22:17:36 digionesign02 setdatetime-helper.sh[1456]: Time is already synchronized. May 23 22:17:36 digionesign02 systemd[1]: setdatetime-helper.timer.service: Deactivated successfully. May 23 22:17:36 digionesign02 systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service. May 23 22:17:39 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 23 22:17:39 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 23 22:17:39 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 23 22:17:39 digionesign02 volumio[1043]: error: MyVolumio Plugin failed to start in a timely fashion May 23 22:17:39 digionesign02 volumio[1043]: [Metrics] CommandRouter: 61s 854.07ms May 23 22:17:39 digionesign02 volumio[1043]: info: CoreCommandRouter::volumiosetStartupVolume May 23 22:17:39 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 23 22:17:39 digionesign02 volumio[1043]: info: VolumeController:: Setting startup Volume 5 May 23 22:17:39 digionesign02 volumio[1043]: info: VolumeController::SetAlsaVolume5 May 23 22:17:39 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 23 22:17:39 digionesign02 volumio[1043]: info: CoreCommandRouter::Close All Modals sent May 23 22:17:39 digionesign02 volumio[1043]: info: CoreCommandRouter::Close All Modals sent May 23 22:17:39 digionesign02 volumio[1043]: info: CoreStateMachine::pushState May 23 22:17:39 digionesign02 volumio[1043]: info: CorePlayQueue::getTrack 0 May 23 22:17:39 digionesign02 volumio[1043]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 23 22:17:39 digionesign02 volumio[1043]: info: CoreCommandRouter::volumioPushState May 23 22:17:39 digionesign02 volumio[1043]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 23 22:17:39 digionesign02 volumio[1043]: Error [ERR_INTERNAL_ASSERTION]: This is caused by either a bug in Node.js or incorrect usage of Node.js internals. May 23 22:17:39 digionesign02 volumio[1043]: Please open an issue with this stack trace at https://github.com/nodejs/node/issues May 23 22:17:39 digionesign02 volumio[1043]: at new NodeError (node:internal/errors:405:5) May 23 22:17:39 digionesign02 volumio[1043]: at assert (node:internal/assert:14:11) May 23 22:17:39 digionesign02 volumio[1043]: at internalConnectMultiple (node:net:1118:3) May 23 22:17:39 digionesign02 volumio[1043]: at Timeout.internalConnectMultipleTimeout (node:net:1687:3) May 23 22:17:39 digionesign02 volumio[1043]: at listOnTimeout (node:internal/timers:575:11) May 23 22:17:39 digionesign02 volumio[1043]: at process.processTimers (node:internal/timers:514:7) { May 23 22:17:39 digionesign02 volumio[1043]: code: 'ERR_INTERNAL_ASSERTION' May 23 22:17:39 digionesign02 volumio[1043]: } May 23 22:17:39 digionesign02 volumio[1043]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 23 22:17:47 digionesign02 sudo[1494]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-05-23 22:16' May 23 22:17:47 digionesign02 sudo[1494]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="fd567ba9bc0dc34c0403e2d5b72a0f46467d1983" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri May 23 08:02:06 UTC 2025" VOLUMIO_VERSION="0.069" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="76fa67e30b28261e1dc7c3a89e610b9e"