-- Logs begin at Sat 2025-05-17 13:09:23 PDT, end at Sun 2025-05-25 14:50:26 PDT. -- May 25 14:49:31 minidsp-shd ntpd[851]: receive: Unexpected origin timestamp 0xebd36b8a.6c912114 does not match aorg 0000000000.00000000 from server@216.232.132.102 xmt 0xebde0eeb.3e732b46 May 25 14:49:31 minidsp-shd ntpd[851]: receive: Unexpected origin timestamp 0xebd36b8a.6cbed7c9 does not match aorg 0000000000.00000000 from server@173.183.146.26 xmt 0xebde0eeb.401638de May 25 14:49:31 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:31 minidsp-shd systemd[1]: Starting Daily apt download activities... May 25 14:49:31 minidsp-shd ntpd[851]: receive: Unexpected origin timestamp 0xebd36b8a.6cc5ea87 does not match aorg 0000000000.00000000 from server@216.197.228.230 xmt 0xebde0eeb.426815eb May 25 14:49:31 minidsp-shd ntpd[851]: receive: Unexpected origin timestamp 0xebd36b8a.6ca9dd14 does not match aorg 0000000000.00000000 from server@23.133.168.244 xmt 0xebde0eeb.413bf954 May 25 14:49:31 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:31 minidsp-shd ntpd[851]: receive: Unexpected origin timestamp 0xebd36b8a.6cb76428 does not match aorg 0000000000.00000000 from server@67.215.197.149 xmt 0xebde0eeb.44be3dba May 25 14:49:31 minidsp-shd ntpd[851]: receive: Unexpected origin timestamp 0xebd36b8a.6c7ca9cd does not match aorg 0000000000.00000000 from server@142.4.192.253 xmt 0xebde0eeb.47221dc7 May 25 14:49:31 minidsp-shd ntpd[851]: receive: Unexpected origin timestamp 0xebd36b8a.6c9a5ea1 does not match aorg 0000000000.00000000 from server@54.39.23.64 xmt 0xebde0eeb.477b324e May 25 14:49:31 minidsp-shd ntpd[851]: receive: Unexpected origin timestamp 0xebd36b8a.6cb0b104 does not match aorg 0000000000.00000000 from server@148.113.209.151 xmt 0xebde0eeb.47f9281d May 25 14:49:31 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:31 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:31 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:31 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:31 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:31 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:31 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:31 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:31 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:31 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:31 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:31 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:31 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:31 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:31 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:31 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:31 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:31 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:31 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:31 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:31 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:31 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:31 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:31 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:31 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:31 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:31 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:31 minidsp-shd wireless.js[464]: trying... May 25 14:49:31 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:31 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:31 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:31 minidsp-shd sudo[905]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 25 14:49:31 minidsp-shd sudo[905]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 14:49:31 minidsp-shd sudo[905]: pam_unix(sudo:session): session closed for user root May 25 14:49:31 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:31 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:31 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:31 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:31 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:31 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:31 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:31 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:31 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:31 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:31 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:31 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:31 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:31 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:31 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:32 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:32 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:32 minidsp-shd nmbd[646]: [2025/05/25 14:49:32.048508, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) May 25 14:49:32 minidsp-shd nmbd[646]: query_name_response: Multiple (2) responses received for a query on subnet 10.0.1.16 for name WORKGROUP<1d>. May 25 14:49:32 minidsp-shd nmbd[646]: This response was from IP 10.0.1.6, reporting an IP address of 10.0.1.6. May 25 14:49:32 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:32 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:32 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:32 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:32 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:32 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:32 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:32 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:32 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:32 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:32 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:32 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:32 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:32 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:32 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:32 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:32 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:32 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:32 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:32 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:32 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:32 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:32 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:32 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:32 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:32 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:32 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:32 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:32 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:32 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:32 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:32 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:32 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:32 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:32 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:32 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:32 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:32 minidsp-shd systemd[1]: apt-daily.service: Succeeded. May 25 14:49:32 minidsp-shd systemd[1]: Started Daily apt download activities. May 25 14:49:32 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:32 minidsp-shd systemd[1]: Starting Daily apt upgrade and clean activities... May 25 14:49:32 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:32 minidsp-shd wireless.js[464]: trying... May 25 14:49:32 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:32 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:32 minidsp-shd sudo[950]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 25 14:49:32 minidsp-shd sudo[950]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 14:49:32 minidsp-shd sudo[950]: pam_unix(sudo:session): session closed for user root May 25 14:49:32 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:32 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:32 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:32 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:32 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:32 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:32 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:32 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:32 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:32 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:32 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:32 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:32 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:32 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:32 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:32 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:32 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:33 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:33 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:33 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:33 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:33 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:33 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:33 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:33 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:33 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:33 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:33 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:33 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:33 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:33 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:33 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:33 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:33 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:33 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:33 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:33 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:33 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:33 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:33 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:33 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:33 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:33 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:33 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:33 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:33 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:33 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:33 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:33 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:33 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:33 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:33 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:33 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:33 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:33 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:33 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:33 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:33 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:33 minidsp-shd wireless.js[464]: trying... May 25 14:49:33 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:33 minidsp-shd systemd[1]: apt-daily-upgrade.service: Succeeded. May 25 14:49:33 minidsp-shd systemd[1]: Started Daily apt upgrade and clean activities. May 25 14:49:33 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:33 minidsp-shd sudo[999]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 25 14:49:33 minidsp-shd sudo[999]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 14:49:33 minidsp-shd sudo[999]: pam_unix(sudo:session): session closed for user root May 25 14:49:33 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:33 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:34 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:34 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:34 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:34 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:34 minidsp-shd volumio-remote-updater[488]: [2025-05-25 14:49:34] [info] asio async_connect error: system:111 (Connection refused) May 25 14:49:34 minidsp-shd volumio-remote-updater[488]: [2025-05-25 14:49:34] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) May 25 14:49:34 minidsp-shd volumio-remote-updater[488]: [2025-05-25 14:49:34] [error] handle_connect error: Underlying Transport Error May 25 14:49:34 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:34 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:34 minidsp-shd wireless.js[464]: trying... May 25 14:49:34 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:34 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:34 minidsp-shd sudo[1003]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 25 14:49:34 minidsp-shd sudo[1003]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 14:49:34 minidsp-shd sudo[1003]: pam_unix(sudo:session): session closed for user root May 25 14:49:34 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:34 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:34 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:35 minidsp-shd wireless.js[464]: trying... May 25 14:49:35 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:35 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:35 minidsp-shd sudo[1006]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 25 14:49:35 minidsp-shd sudo[1006]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 14:49:35 minidsp-shd sudo[1006]: pam_unix(sudo:session): session closed for user root May 25 14:49:35 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:35 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:35 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:36 minidsp-shd wireless.js[464]: trying... May 25 14:49:36 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:36 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:36 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:36 minidsp-shd sudo[1009]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 25 14:49:36 minidsp-shd sudo[1009]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 14:49:36 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:36 minidsp-shd sudo[1009]: pam_unix(sudo:session): session closed for user root May 25 14:49:36 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:36 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:37 minidsp-shd wireless.js[464]: trying... May 25 14:49:37 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:37 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:37 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:37 minidsp-shd sudo[1012]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 25 14:49:37 minidsp-shd sudo[1012]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 14:49:37 minidsp-shd sudo[1012]: pam_unix(sudo:session): session closed for user root May 25 14:49:37 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:37 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:38 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:38 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:38 minidsp-shd wireless.js[464]: Overtime, starting plan B May 25 14:49:38 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:38 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:38 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:38 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:38 minidsp-shd systemd[1]: Started Wireless Services. May 25 14:49:38 minidsp-shd kernel: vdd_arm: ramp_delay not set May 25 14:49:38 minidsp-shd systemd[1]: Started Volumio Backend Module. May 25 14:49:38 minidsp-shd systemd[1]: Started Volumio Cpu Tweaker. May 25 14:49:38 minidsp-shd systemd[1]: Reached target Multi-User System. May 25 14:49:38 minidsp-shd systemd[1]: Reached target Graphical Interface. May 25 14:49:38 minidsp-shd systemd[1]: Starting Update UTMP about System Runlevel Changes... May 25 14:49:38 minidsp-shd volumio-cpu-tweak[1018]: Setting RT Priority for mpd May 25 14:49:38 minidsp-shd systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. May 25 14:49:38 minidsp-shd systemd[1]: Started Update UTMP about System Runlevel Changes. May 25 14:49:38 minidsp-shd systemd[1]: Startup finished in 8.453s (kernel) + 32.282s (userspace) = 40.735s. May 25 14:49:38 minidsp-shd volumio-cpu-tweak[1018]: pid 35's current scheduling policy: SCHED_OTHER May 25 14:49:38 minidsp-shd volumio-cpu-tweak[1018]: pid 35's current scheduling priority: 0 May 25 14:49:38 minidsp-shd volumio-cpu-tweak[1018]: Setting MPD Affinity May 25 14:49:38 minidsp-shd volumio-cpu-tweak[1018]: pid 3's current affinity mask: f May 25 14:49:38 minidsp-shd volumio-cpu-tweak[1018]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input May 25 14:49:38 minidsp-shd volumio-cpu-tweak[1018]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance May 25 14:49:38 minidsp-shd systemd[1]: volumio_cpu_tweak.service: Succeeded. May 25 14:49:40 minidsp-shd systemd[1]: systemd-fsckd.service: Succeeded. May 25 14:49:43 minidsp-shd volumio[1017]: info: ------------------------------------------- May 25 14:49:43 minidsp-shd volumio[1017]: info: ----- Volumio3 ---- May 25 14:49:43 minidsp-shd volumio[1017]: info: ------------------------------------------- May 25 14:49:43 minidsp-shd volumio[1017]: info: ----- System startup ---- May 25 14:49:43 minidsp-shd volumio[1017]: info: ------------------------------------------- May 25 14:49:44 minidsp-shd volumio-remote-updater[488]: [2025-05-25 14:49:44] [connect] Successful connection May 25 14:49:45 minidsp-shd volumio[1017]: info: MYVOLUMIO Environment detected May 25 14:49:45 minidsp-shd volumio[1017]: info: Plugin folders cleanup May 25 14:49:45 minidsp-shd volumio[1017]: info: Scanning into folder /volumio/app/plugins/ May 25 14:49:45 minidsp-shd volumio[1017]: info: Scanning category audio_interface May 25 14:49:45 minidsp-shd volumio[1017]: info: Scanning category miscellanea May 25 14:49:45 minidsp-shd volumio[1017]: info: Scanning category music_service May 25 14:49:45 minidsp-shd volumio[1017]: info: Scanning category plugins.json May 25 14:49:45 minidsp-shd volumio[1017]: info: Scanning category system_controller May 25 14:49:45 minidsp-shd volumio[1017]: info: Scanning category user_interface May 25 14:49:45 minidsp-shd volumio[1017]: info: Scanning into folder /data/plugins/ May 25 14:49:45 minidsp-shd volumio[1017]: info: Scanning category music_service May 25 14:49:45 minidsp-shd volumio[1017]: info: Plugin folders cleanup completed May 25 14:49:45 minidsp-shd volumio[1017]: info: ------------------------------------------- May 25 14:49:45 minidsp-shd volumio[1017]: info: ----- Core plugins startup ---- May 25 14:49:45 minidsp-shd volumio[1017]: info: ------------------------------------------- May 25 14:49:45 minidsp-shd volumio[1017]: info: Loading plugins from folder /volumio/app/plugins/ May 25 14:49:45 minidsp-shd volumio[1017]: info: Adding plugin bluetooth to MyMusic Plugins May 25 14:49:45 minidsp-shd volumio[1017]: info: Adding plugin multiroom to MyMusic Plugins May 25 14:49:45 minidsp-shd volumio[1017]: info: Adding plugin upnp to MyMusic Plugins May 25 14:49:45 minidsp-shd volumio[1017]: info: Adding plugin metavolumio to MyMusic Plugins May 25 14:49:45 minidsp-shd volumio[1017]: info: Adding plugin ms_surface_dial to MyMusic Plugins May 25 14:49:45 minidsp-shd volumio[1017]: info: Adding plugin airplay_emulation to MyMusic Plugins May 25 14:49:45 minidsp-shd volumio[1017]: info: Adding plugin cd_controller to MyMusic Plugins May 25 14:49:45 minidsp-shd volumio[1017]: info: Adding plugin raat to MyMusic Plugins May 25 14:49:45 minidsp-shd volumio[1017]: info: Adding plugin tidalconnect to MyMusic Plugins May 25 14:49:45 minidsp-shd volumio[1017]: info: Adding plugin upnp_browser to MyMusic Plugins May 25 14:49:45 minidsp-shd volumio[1017]: info: Loading plugins from folder /data/plugins/ May 25 14:49:45 minidsp-shd volumio[1017]: info: Loading plugin "system"... May 25 14:49:45 minidsp-shd volumio[1017]: info: Loading plugin "appearance"... May 25 14:49:48 minidsp-shd volumio[1017]: info: Loading plugin "network"... May 25 14:49:48 minidsp-shd volumio[1017]: info: Refreshing Cached IP Addresses May 25 14:49:48 minidsp-shd sudo[1049]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 25 14:49:48 minidsp-shd sudo[1049]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 14:49:48 minidsp-shd sudo[1049]: pam_unix(sudo:session): session closed for user root May 25 14:49:48 minidsp-shd sudo[1051]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 25 14:49:48 minidsp-shd sudo[1051]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 14:49:48 minidsp-shd volumio[1017]: info: Loading plugin "services"... May 25 14:49:48 minidsp-shd volumio[1017]: info: Loading plugin "alsa_controller"... May 25 14:49:48 minidsp-shd sudo[1051]: pam_unix(sudo:session): session closed for user root May 25 14:49:48 minidsp-shd sudo[1054]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan May 25 14:49:48 minidsp-shd sudo[1054]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 14:49:48 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 25 14:49:48 minidsp-shd volumio[1017]: info: Loading plugin "wizard"... May 25 14:49:48 minidsp-shd volumio[1017]: info: Loading plugin "networkfs"... May 25 14:49:48 minidsp-shd volumio[1017]: info: Starting Udev Watcher for removable devices May 25 14:49:48 minidsp-shd sudo[1060]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=gcw6202-1,password=\HLc>n!$FzF6,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //10.0.1.6/Music /mnt/NAS/NAS_Music May 25 14:49:48 minidsp-shd sudo[1060]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 14:49:48 minidsp-shd kernel: FS-Cache: Loaded May 25 14:49:48 minidsp-shd volumio[1017]: info: Ignoring mount for partition: BOOT May 25 14:49:48 minidsp-shd volumio[1017]: info: Ignoring mount for partition: volumio May 25 14:49:48 minidsp-shd volumio[1017]: info: Ignoring mount for partition: volumio_data May 25 14:49:48 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 25 14:49:48 minidsp-shd volumio[1017]: info: Loading plugin "volumio_command_line_client"... May 25 14:49:48 minidsp-shd volumio[1017]: info: Loading plugin "upnp"... May 25 14:49:48 minidsp-shd volumio[1017]: info: [1748209788615] Starting Upmpd Daemon May 25 14:49:48 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 25 14:49:48 minidsp-shd volumio[1017]: info: Loading plugin "my_music"... May 25 14:49:48 minidsp-shd volumio[1017]: info: Loading plugin "mpd"... May 25 14:49:48 minidsp-shd kernel: FS-Cache: Netfs 'cifs' registered for caching May 25 14:49:48 minidsp-shd kernel: Key type cifs.spnego registered May 25 14:49:48 minidsp-shd kernel: Key type cifs.idmap registered May 25 14:49:48 minidsp-shd kernel: CIFS: Attempting to mount //10.0.1.6/Music May 25 14:49:48 minidsp-shd kernel: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3 (or SMB2.1) specify vers=1.0 on mount. May 25 14:49:48 minidsp-shd sudo[1060]: pam_unix(sudo:session): session closed for user root May 25 14:49:49 minidsp-shd sudo[1054]: pam_unix(sudo:session): session closed for user root May 25 14:49:49 minidsp-shd volumio[1017]: info: Loading plugin "upnp_browser"... May 25 14:49:50 minidsp-shd volumio[1017]: info: Loading plugin "bluetooth"... May 25 14:49:50 minidsp-shd volumio[1017]: info: [1748209790601] Starting BluetoothController May 25 14:49:50 minidsp-shd volumio[1017]: info: Loading plugin "alarm-clock"... May 25 14:49:51 minidsp-shd volumio[1017]: info: Loading plugin "manifestui"... May 25 14:49:51 minidsp-shd volumio[1017]: info: Loading plugin "metavolumio"... May 25 14:49:52 minidsp-shd wpa_supplicant[731]: wlan0: CTRL-EVENT-SSID-REENABLED id=0 ssid="BlueRun 2GHz" May 25 14:49:52 minidsp-shd kernel: wlan0: authenticate with 64:a5:c3:6f:e8:84 May 25 14:49:52 minidsp-shd wpa_supplicant[731]: wlan0: SME: Trying to authenticate with 64:a5:c3:6f:e8:84 (SSID='BlueRun 2GHz' freq=2437 MHz) May 25 14:49:52 minidsp-shd kernel: wlan0: send auth to 64:a5:c3:6f:e8:84 (try 1/3) May 25 14:49:52 minidsp-shd kernel: wlan0: authenticated May 25 14:49:52 minidsp-shd wpa_supplicant[731]: wlan0: Trying to associate with 64:a5:c3:6f:e8:84 (SSID='BlueRun 2GHz' freq=2437 MHz) May 25 14:49:52 minidsp-shd kernel: wlan0: associate with 64:a5:c3:6f:e8:84 (try 1/3) May 25 14:49:52 minidsp-shd kernel: wlan0: RX AssocResp from 64:a5:c3:6f:e8:84 (capab=0x1411 status=0 aid=6) May 25 14:49:52 minidsp-shd kernel: wlan0: associated May 25 14:49:52 minidsp-shd wpa_supplicant[731]: wlan0: Associated with 64:a5:c3:6f:e8:84 May 25 14:49:52 minidsp-shd wpa_supplicant[731]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 May 25 14:49:52 minidsp-shd kernel: wlan0: deauthenticated from 64:a5:c3:6f:e8:84 (Reason: 2=PREV_AUTH_NOT_VALID) May 25 14:49:52 minidsp-shd wpa_supplicant[731]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=CA May 25 14:49:52 minidsp-shd wpa_supplicant[731]: wlan0: CTRL-EVENT-DISCONNECTED bssid=64:a5:c3:6f:e8:84 reason=2 May 25 14:49:52 minidsp-shd wpa_supplicant[731]: wlan0: WPA: 4-Way Handshake failed - pre-shared key may be incorrect May 25 14:49:52 minidsp-shd wpa_supplicant[731]: wlan0: CTRL-EVENT-SSID-TEMP-DISABLED id=0 ssid="BlueRun 2GHz" auth_failures=3 duration=46 reason=WRONG_KEY May 25 14:49:52 minidsp-shd wpa_supplicant[731]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD May 25 14:49:52 minidsp-shd wpa_supplicant[731]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=USER type=COUNTRY alpha2=CA May 25 14:49:54 minidsp-shd volumio[1017]: info: Loading plugin "airplay_emulation"... May 25 14:49:54 minidsp-shd volumio[1017]: info: Starting Shairport Sync May 25 14:49:54 minidsp-shd volumio[1017]: info: Loading plugin "cd_controller"... May 25 14:49:54 minidsp-shd volumio[1017]: info: Loading plugin "last_100"... May 25 14:49:54 minidsp-shd volumio[1017]: info: Plugin raat is not enabled May 25 14:49:54 minidsp-shd volumio[1017]: info: Loading plugin "streaming_services"... May 25 14:49:57 minidsp-shd volumio[1017]: info: Starting Streaming Service Transparent Proxy May 25 14:49:57 minidsp-shd volumio[1017]: info: Plugin tidalconnect is not enabled May 25 14:49:57 minidsp-shd volumio[1017]: info: Loading plugin "webradio"... May 25 14:49:57 minidsp-shd volumio[1017]: info: Loading plugin "i2s_dacs"... May 25 14:49:57 minidsp-shd volumio[1017]: info: I2S DAC not set, start Auto-detection May 25 14:49:57 minidsp-shd volumio[1017]: info: Loading plugin "volumiodiscovery"... May 25 14:49:57 minidsp-shd volumio[1017]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 25 14:49:57 minidsp-shd volumio[1017]: *** WARNING *** Please fix your application to use the native API of Avahi! May 25 14:49:57 minidsp-shd node[1017]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 25 14:49:57 minidsp-shd volumio[1017]: *** WARNING *** For more information see May 25 14:49:57 minidsp-shd volumio[1017]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 25 14:49:57 minidsp-shd volumio[1017]: *** WARNING *** Please fix your application to use the native API of Avahi! May 25 14:49:57 minidsp-shd volumio[1017]: *** WARNING *** For more information see May 25 14:49:57 minidsp-shd node[1017]: *** WARNING *** Please fix your application to use the native API of Avahi! May 25 14:49:57 minidsp-shd node[1017]: *** WARNING *** For more information see May 25 14:49:57 minidsp-shd node[1017]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 25 14:49:57 minidsp-shd node[1017]: *** WARNING *** Please fix your application to use the native API of Avahi! May 25 14:49:57 minidsp-shd node[1017]: *** WARNING *** For more information see May 25 14:49:57 minidsp-shd volumio[1017]: info: Applying required configuration parameters for plugin volumiodiscovery May 25 14:49:57 minidsp-shd volumio[1017]: info: Discovery: Started advertising with name: miniDSP SHD May 25 14:49:57 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 25 14:49:57 minidsp-shd volumio[1017]: info: Loading plugin "spop"... May 25 14:49:59 minidsp-shd volumio[1017]: STREAMING PROXY: Starting server on port 3245 May 25 14:49:59 minidsp-shd volumio[1017]: Node JS runtime: 14 May 25 14:49:59 minidsp-shd volumio-remote-updater[488]: [2025-05-25 14:49:59] [connect] Successful connection May 25 14:50:00 minidsp-shd volumio[1017]: info: Plugin multiroom is not enabled May 25 14:50:00 minidsp-shd volumio[1017]: info: Loading plugin "outputs"... May 25 14:50:00 minidsp-shd volumio[1017]: info: Loading plugin "albumart"... May 25 14:50:00 minidsp-shd volumio[1017]: info: Plugin ms_surface_dial is not enabled May 25 14:50:00 minidsp-shd volumio[1017]: info: Plugin example_plugin is not enabled May 25 14:50:00 minidsp-shd volumio[1017]: info: Loading plugin "hi_res_audio"... May 25 14:50:01 minidsp-shd volumio[1017]: Forking 3 albumart workers May 25 14:50:03 minidsp-shd volumio[1017]: Starting albumart workers May 25 14:50:03 minidsp-shd volumio[1017]: Starting albumart workers May 25 14:50:03 minidsp-shd volumio[1017]: Starting albumart workers May 25 14:50:03 minidsp-shd volumio[1017]: info: Applying required configuration parameters for plugin hi_res_audio May 25 14:50:04 minidsp-shd volumio[1017]: info: Loading plugin "inputs"... May 25 14:50:05 minidsp-shd volumio[1017]: info: Loading plugin "qobuz"... May 25 14:50:08 minidsp-shd volumio[1017]: info: Loading plugin "tidal"... May 25 14:50:11 minidsp-shd volumio[1017]: info: Loading plugin "oem_helper"... May 25 14:50:12 minidsp-shd volumio[1017]: info: Applying required configuration parameters for plugin oem_helper May 25 14:50:12 minidsp-shd volumio[1017]: info: Loading plugin "updater_comm"... May 25 14:50:13 minidsp-shd volumio[1017]: info: Plugin mpdemulation is not enabled May 25 14:50:13 minidsp-shd volumio[1017]: info: Loading plugin "rest_api"... May 25 14:50:13 minidsp-shd volumio[1017]: info: Loading plugin "websocket"... May 25 14:50:13 minidsp-shd volumio[1017]: info: Loading i18n strings for locale en May 25 14:50:13 minidsp-shd volumio[1017]: Updating browse sources language May 25 14:50:13 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 25 14:50:13 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 25 14:50:13 minidsp-shd volumio[1017]: info: CoreCommandRouter::initPlayerControls May 25 14:50:13 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 14:50:13 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 14:50:13 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 14:50:13 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 14:50:13 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 14:50:13 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 14:50:13 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 14:50:13 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 14:50:13 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 25 14:50:13 minidsp-shd volumio[1017]: Express server listening on port 3000 May 25 14:50:13 minidsp-shd volumio[1017]: [Metrics] WebUI: 32s 72.88ms May 25 14:50:13 minidsp-shd volumio[1017]: info: CoreStateMachine::resetVolumioState May 25 14:50:13 minidsp-shd volumio[1017]: info: CoreStateMachine::getcurrentVolume May 25 14:50:13 minidsp-shd volumio[1017]: info: CoreCommandRouter::volumioRetrievevolume May 25 14:50:13 minidsp-shd volumio[1017]: info: CoreStateMachine::pushState May 25 14:50:13 minidsp-shd volumio[1017]: info: CorePlayQueue::getTrack 0 May 25 14:50:13 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 25 14:50:13 minidsp-shd volumio[1017]: info: CoreCommandRouter::volumioPushState May 25 14:50:14 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 25 14:50:14 minidsp-shd sudo[1196]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 25 14:50:14 minidsp-shd sudo[1196]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 14:50:14 minidsp-shd sudo[1196]: pam_unix(sudo:session): session closed for user root May 25 14:50:14 minidsp-shd sudo[1198]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 25 14:50:14 minidsp-shd sudo[1198]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 14:50:14 minidsp-shd volumio[1017]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' May 25 14:50:14 minidsp-shd volumio[1017]: info: Completed loading Core Plugins May 25 14:50:14 minidsp-shd sudo[1198]: pam_unix(sudo:session): session closed for user root May 25 14:50:14 minidsp-shd volumio[1017]: info: Preparing to generate the ALSA configuration file May 25 14:50:14 minidsp-shd volumio[1017]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision May 25 14:50:14 minidsp-shd volumio[1017]: info: Asound.conf file unchanged, so no further update is needed May 25 14:50:14 minidsp-shd volumio[1017]: info: Output device has changed, restarting MPD May 25 14:50:14 minidsp-shd volumio-remote-updater[488]: [2025-05-25 14:50:14] [connect] Successful connection May 25 14:50:14 minidsp-shd sudo[1207]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 25 14:50:14 minidsp-shd volumio[1017]: info: Output device has changed, restarting Shairport Sync May 25 14:50:14 minidsp-shd sudo[1207]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 14:50:14 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 14:50:14 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 25 14:50:14 minidsp-shd sudo[1207]: pam_unix(sudo:session): session closed for user root May 25 14:50:14 minidsp-shd sudo[1209]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 25 14:50:14 minidsp-shd sudo[1209]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 14:50:14 minidsp-shd systemd[1]: Listening on mpd.socket. May 25 14:50:14 minidsp-shd volumio[1017]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 25 14:50:14 minidsp-shd systemd[1]: Starting Music Player Daemon... May 25 14:50:14 minidsp-shd volumio[1017]: info: ___________ START PLUGINS ___________ May 25 14:50:14 minidsp-shd volumio[1017]: info: ControllerMpd::onStart: Initializing MPD May 25 14:50:14 minidsp-shd volumio[1017]: info: Creating MPD Configuration file May 25 14:50:14 minidsp-shd sudo[1217]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 25 14:50:14 minidsp-shd sudo[1217]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 14:50:14 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 25 14:50:14 minidsp-shd volumio[1017]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 25 14:50:14 minidsp-shd volumio[1017]: info: [1748209814876] CoreMusicLibrary::Adding element Media Servers May 25 14:50:14 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 25 14:50:14 minidsp-shd sudo[1217]: pam_unix(sudo:session): session closed for user root May 25 14:50:14 minidsp-shd sudo[1219]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 25 14:50:14 minidsp-shd sudo[1219]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 14:50:14 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 25 14:50:14 minidsp-shd systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM May 25 14:50:14 minidsp-shd systemd[1]: mpd.service: Succeeded. May 25 14:50:14 minidsp-shd systemd[1]: Stopped Music Player Daemon. May 25 14:50:14 minidsp-shd systemd[1]: Starting Music Player Daemon... May 25 14:50:14 minidsp-shd volumio[1017]: info: Adding Manifest REST API Endpoints May 25 14:50:14 minidsp-shd volumio[1017]: info: Adding manifestui REST Endpoint for plugin: miscellanea/manifestui May 25 14:50:15 minidsp-shd volumio[1017]: info: Adding METAVOLUMIO REST API Endpoints May 25 14:50:15 minidsp-shd volumio[1017]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio May 25 14:50:15 minidsp-shd volumio[1017]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio May 25 14:50:15 minidsp-shd volumio[1017]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio May 25 14:50:15 minidsp-shd volumio[1017]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio May 25 14:50:15 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 14:50:15 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 25 14:50:15 minidsp-shd sudo[1224]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name miniDSP SHD May 25 14:50:15 minidsp-shd sudo[1224]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 14:50:15 minidsp-shd sudo[1224]: pam_unix(sudo:session): session closed for user root May 25 14:50:15 minidsp-shd volumio[1017]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 25 14:50:15 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 14:50:15 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 25 14:50:15 minidsp-shd volumio[1017]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 25 14:50:15 minidsp-shd volumio[1017]: info: Preparing CD Folders May 25 14:50:15 minidsp-shd volumio[1017]: info: Adding CD REST API Endpoints May 25 14:50:15 minidsp-shd volumio[1017]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller May 25 14:50:15 minidsp-shd volumio[1017]: info: Starting UDEV Watcher for CD May 25 14:50:15 minidsp-shd volumio[1017]: info: Detecting CD presence with UDEV May 25 14:50:15 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices May 25 14:50:15 minidsp-shd volumio[1017]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 25 14:50:15 minidsp-shd volumio[1017]: info: [1748209815279] CoreMusicLibrary::Adding element Last_100 May 25 14:50:15 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 25 14:50:15 minidsp-shd volumio[1017]: info: Streaming services startup May 25 14:50:15 minidsp-shd volumio[1017]: info: Starting Streaming Daemon May 25 14:50:15 minidsp-shd sudo[1233]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service May 25 14:50:15 minidsp-shd sudo[1233]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 14:50:15 minidsp-shd sudo[1233]: pam_unix(sudo:session): session closed for user root May 25 14:50:15 minidsp-shd volumio[1017]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 25 14:50:15 minidsp-shd volumio[1017]: info: [1748209815432] CoreMusicLibrary::Adding element Webradio May 25 14:50:15 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 25 14:50:15 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 25 14:50:15 minidsp-shd volumio[1017]: info: Creating Spotify config file May 25 14:50:15 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 14:50:15 minidsp-shd volumio[1017]: error: Hi Res Audio Failed Login: Missing Login Data May 25 14:50:15 minidsp-shd volumio[1017]: info: Adding HIGHRESAUDIO REST API Endpoints May 25 14:50:15 minidsp-shd volumio[1017]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio May 25 14:50:15 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 25 14:50:15 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 25 14:50:15 minidsp-shd volumio[1017]: info: Volumio Calling Home May 25 14:50:16 minidsp-shd volumio[1017]: info: Stopping AccessToken refresher cron for QOBUZ May 25 14:50:16 minidsp-shd volumio[1017]: info: AccessToken refresher cron started for QOBUZ May 25 14:50:16 minidsp-shd volumio[1017]: info: Stopping AccessToken refresher cron May 25 14:50:16 minidsp-shd volumio[1017]: info: AccessToken refresher cron started May 25 14:50:16 minidsp-shd volumio[1017]: info: Adding TIDAL REST API Endpoints May 25 14:50:16 minidsp-shd volumio[1017]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal May 25 14:50:16 minidsp-shd volumio[1017]: info: Adding QOBUZ REST API Endpoints May 25 14:50:16 minidsp-shd volumio[1017]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz May 25 14:50:16 minidsp-shd volumio[1017]: info: Setting Device type: NanoPi NEO 3 May 25 14:50:16 minidsp-shd volumio[1017]: info: CoreStateMachine::setRepeat true single undefined May 25 14:50:16 minidsp-shd volumio[1017]: info: CoreStateMachine::pushState May 25 14:50:16 minidsp-shd volumio[1017]: info: CorePlayQueue::getTrack 0 May 25 14:50:16 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 25 14:50:16 minidsp-shd volumio[1017]: info: CoreCommandRouter::volumioPushState May 25 14:50:16 minidsp-shd volumio[1017]: info: CoreStateMachine::setRandom undefined May 25 14:50:16 minidsp-shd volumio[1017]: info: CoreStateMachine::pushState May 25 14:50:16 minidsp-shd volumio[1017]: info: CorePlayQueue::getTrack 0 May 25 14:50:16 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 25 14:50:16 minidsp-shd volumio[1017]: info: CoreCommandRouter::volumioPushState May 25 14:50:16 minidsp-shd volumio[1017]: info: Serial port opened successfully May 25 14:50:16 minidsp-shd volumio[1017]: error: Cannot start Volumio Streaming Daemon May 25 14:50:16 minidsp-shd volumio[1017]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service May 25 14:50:16 minidsp-shd volumio[1017]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. May 25 14:50:16 minidsp-shd volumio[1017]: error: Cannot set new Bluetooth Name : Error: Command failed: /usr/bin/sudo /bin/hciconfig hci0 name 'miniDSP SHD' May 25 14:50:16 minidsp-shd volumio[1017]: Can't get device info: No such device May 25 14:50:16 minidsp-shd volumio[1017]: info: MPD Permissions set May 25 14:50:16 minidsp-shd volumio[1017]: info: MPD Permissions set May 25 14:50:16 minidsp-shd volumio-remote-updater[488]: [2025-05-25 14:50:16] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1748209814 101 May 25 14:50:16 minidsp-shd sudo[1260]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service May 25 14:50:16 minidsp-shd sudo[1260]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 14:50:16 minidsp-shd volumio[1017]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 1 May 25 14:50:16 minidsp-shd volumio[1017]: info: Spotify config file written May 25 14:50:16 minidsp-shd systemd[1]: Started UPnP Renderer front-end to MPD. May 25 14:50:16 minidsp-shd sudo[1260]: pam_unix(sudo:session): session closed for user root May 25 14:50:16 minidsp-shd sudo[1264]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service May 25 14:50:16 minidsp-shd sudo[1264]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 14:50:16 minidsp-shd volumio[1017]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 2 May 25 14:50:16 minidsp-shd systemd[1]: Started go-librespot Daemon. May 25 14:50:16 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 14:50:16 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 14:50:16 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 14:50:16 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 14:50:16 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 14:50:16 minidsp-shd sudo[1264]: pam_unix(sudo:session): session closed for user root May 25 14:50:16 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 14:50:16 minidsp-shd go-librespot[1266]: Librespot-go daemon starting... May 25 14:50:16 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 14:50:17 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 25 14:50:17 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber May 25 14:50:17 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 14:50:17 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 14:50:17 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 14:50:17 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 14:50:17 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 14:50:17 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 14:50:17 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 14:50:17 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 14:50:17 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 14:50:17 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 25 14:50:17 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber May 25 14:50:17 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 14:50:17 minidsp-shd go-librespot[1266]: time="2025-05-25T14:50:17-07:00" level=info msg="generated new device id: 9e439be76551cb3ad930e4a0225739796ed034ed" May 25 14:50:17 minidsp-shd go-librespot[1266]: time="2025-05-25T14:50:17-07:00" level=debug msg="stored credentials found for tywvg3rccay7bze81pvlor5nk" May 25 14:50:17 minidsp-shd volumio[1017]: info: Reloading queue from file May 25 14:50:17 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: raat , reconfigureAndRestartRaat May 25 14:50:17 minidsp-shd volumio[1017]: info: Adding MINIDSP Inputs May 25 14:50:17 minidsp-shd volumio[1017]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 25 14:50:17 minidsp-shd volumio[1017]: info: [1748209817435] CoreMusicLibrary::Adding element Inputs May 25 14:50:17 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 25 14:50:17 minidsp-shd volumio[1017]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 25 14:50:17 minidsp-shd volumio[1017]: info: [1748209817449] CoreMusicLibrary::Adding element Presets May 25 14:50:17 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 25 14:50:17 minidsp-shd volumio[1017]: Cannot find translation for source Presets May 25 14:50:17 minidsp-shd volumio[1017]: info: Upmpdcli Daemon Started May 25 14:50:17 minidsp-shd volumio[1017]: info: Volumio called home May 25 14:50:17 minidsp-shd volumio[1017]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ May 25 14:50:17 minidsp-shd volumio[1017]: SPOTIFY: BQAYmkCr2NqX0B2nMDYNDTmJD8KVCxksBYdZTQixOztW5jfyZCCOJVz3oNuMV8q4y-6T8hK4GOt2UhytFflhdvTXEUfxHj521uEx-b6h5uhkGjvKiFSBLqYtK6yJvb1W2Gbn6JyB4Qz6kJM6_4uCklVBB-hiCkbev1hyiOHO0E7Dd60ky3jQHnklV6pz5g0eabxOjOunZ08wwcNbWyeG27UchL8ibwVdYnrf3afad39MW_uIOhVBUowFhQxO5oofcRTlaNDFIuY9evHjsn_mB20H13NEI1uqRqtwOA18LnJbX88 May 25 14:50:17 minidsp-shd volumio[1017]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ May 25 14:50:17 minidsp-shd volumio[1017]: info: New Spotify access token = BQAYmkCr2NqX0B2nMDYNDTmJD8KVCxksBYdZTQixOztW5jfyZCCOJVz3oNuMV8q4y-6T8hK4GOt2UhytFflhdvTXEUfxHj521uEx-b6h5uhkGjvKiFSBLqYtK6yJvb1W2Gbn6JyB4Qz6kJM6_4uCklVBB-hiCkbev1hyiOHO0E7Dd60ky3jQHnklV6pz5g0eabxOjOunZ08wwcNbWyeG27UchL8ibwVdYnrf3afad39MW_uIOhVBUowFhQxO5oofcRTlaNDFIuY9evHjsn_mB20H13NEI1uqRqtwOA18LnJbX88 May 25 14:50:17 minidsp-shd volumio[1017]: info: Spotify credentials grant success - running version from March 24, 2019 May 25 14:50:17 minidsp-shd go-librespot[1266]: time="2025-05-25T14:50:17-07:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" May 25 14:50:17 minidsp-shd go-librespot[1266]: time="2025-05-25T14:50:17-07:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" May 25 14:50:17 minidsp-shd go-librespot[1266]: time="2025-05-25T14:50:17-07:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" May 25 14:50:17 minidsp-shd go-librespot[1266]: time="2025-05-25T14:50:17-07:00" level=debug msg="zeroconf server listening on port 41447" May 25 14:50:17 minidsp-shd volumio[1017]: info: Starting Shairport Sync May 25 14:50:18 minidsp-shd volumio[1017]: info: Starting Shairport Sync May 25 14:50:18 minidsp-shd volumio[1017]: info: Starting Shairport Sync May 25 14:50:18 minidsp-shd sudo[1288]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 25 14:50:18 minidsp-shd sudo[1288]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 14:50:18 minidsp-shd go-librespot[1266]: time="2025-05-25T14:50:18-07:00" level=debug msg="obtained new client token: AABeyGUSqP8H8/sYKVjNfAZDTRdxvYcTjXTDnJVCKYcwI3C/ZK9W040C+fccDsQRYSgEyJV4ucG3Y2ZxqmeFN0QYayfiZKnORSo2b/hZUFxAFFODyUVh2UGur3QOUzK2pQZWgn+mfeDjesgAa6ioZ9FBv19NJ8y36G8m2oKMYQDqQyTU/lUfe8DSEstZdL7VErGW6L7pAWuoA+Af6qQy4TgiUtPcoCNcQERWZp4HZKjkGE14KIRvXuc=" May 25 14:50:18 minidsp-shd volumio[1017]: info: CoreCommandRouter::volumiosetSourceActiveno-source May 25 14:50:18 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 25 14:50:18 minidsp-shd volumio[1017]: Cannot find translation for source Presets May 25 14:50:18 minidsp-shd sudo[1290]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 25 14:50:18 minidsp-shd sudo[1290]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 14:50:18 minidsp-shd systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 25 14:50:18 minidsp-shd sudo[1293]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 25 14:50:18 minidsp-shd sudo[1293]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 14:50:18 minidsp-shd systemd[1]: shairport-sync.service: Succeeded. May 25 14:50:18 minidsp-shd systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. May 25 14:50:18 minidsp-shd systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 25 14:50:18 minidsp-shd go-librespot[1266]: time="2025-05-25T14:50:18-07:00" level=debug msg="completed keyexchange" May 25 14:50:18 minidsp-shd sudo[1288]: pam_unix(sudo:session): session closed for user root May 25 14:50:18 minidsp-shd sudo[1290]: pam_unix(sudo:session): session closed for user root May 25 14:50:18 minidsp-shd sudo[1293]: pam_unix(sudo:session): session closed for user root May 25 14:50:18 minidsp-shd sudo[1298]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service May 25 14:50:18 minidsp-shd sudo[1298]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 14:50:18 minidsp-shd systemd[1]: Started Volumio Bluetooth Module. May 25 14:50:18 minidsp-shd sudo[1298]: pam_unix(sudo:session): session closed for user root May 25 14:50:18 minidsp-shd sudo[1303]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth/* May 25 14:50:18 minidsp-shd sudo[1303]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 14:50:18 minidsp-shd volumiobt[1301]: /bin/chmod: cannot access '/var/lib/bluetooth/*': No such file or directory May 25 14:50:18 minidsp-shd sudo[1303]: pam_unix(sudo:session): session closed for user root May 25 14:50:18 minidsp-shd volumio[1017]: info: Shairport-Sync Started May 25 14:50:18 minidsp-shd volumio[1017]: Error adding Membership: Error: addMembership EINVAL May 25 14:50:18 minidsp-shd volumio[1017]: info: Shairport-Sync Started May 25 14:50:18 minidsp-shd volumio[1017]: info: Shairport-Sync Started May 25 14:50:18 minidsp-shd volumio[1017]: info: Volumio BT Module successfully started May 25 14:50:18 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume May 25 14:50:18 minidsp-shd volumio[1017]: info: Enabling external Volume Control May 25 14:50:18 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 14:50:18 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 25 14:50:18 minidsp-shd go-librespot[1266]: time="2025-05-25T14:50:18-07:00" level=debug msg="completed challenge" May 25 14:50:18 minidsp-shd volumio[1017]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 3 May 25 14:50:18 minidsp-shd volumio[1017]: info: CoreCommandRouter::volumioGetState May 25 14:50:18 minidsp-shd volumio[1017]: info: CorePlayQueue::getTrack 0 May 25 14:50:18 minidsp-shd go-librespot[1266]: time="2025-05-25T14:50:18-07:00" level=debug msg="authenticated as tywvg3rccay7bze81pvlor5nk" May 25 14:50:19 minidsp-shd go-librespot[1266]: time="2025-05-25T14:50:19-07:00" level=debug msg="authenticated as tywvg3rccay7bze81pvlor5nk" May 25 14:50:19 minidsp-shd volumio[1017]: SPOTIFY: User informations: {"country":"CA","display_name":"George","email":"gcweeks@icloud.com","explicit_content":{"filter_enabled":false,"filter_locked":false},"external_urls":{"spotify":"https://open.spotify.com/user/tywvg3rccay7bze81pvlor5nk"},"followers":{"href":null,"total":0},"href":"https://api.spotify.com/v1/users/tywvg3rccay7bze81pvlor5nk","id":"tywvg3rccay7bze81pvlor5nk","images":[],"product":"premium","type":"user","uri":"spotify:user:tywvg3rccay7bze81pvlor5nk"} May 25 14:50:19 minidsp-shd volumio[1017]: info: Spotify Successfully logged in May 25 14:50:19 minidsp-shd volumio[1017]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 25 14:50:19 minidsp-shd volumio[1017]: info: [1748209819186] CoreMusicLibrary::Adding element Spotify May 25 14:50:19 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 25 14:50:19 minidsp-shd volumio[1017]: Cannot find translation for source Presets May 25 14:50:19 minidsp-shd volumio[1017]: Cannot find translation for source Spotify May 25 14:50:19 minidsp-shd go-librespot[1266]: time="2025-05-25T14:50:19-07:00" level=debug msg="dealer connection opened" May 25 14:50:19 minidsp-shd go-librespot[1266]: time="2025-05-25T14:50:19-07:00" level=debug msg="initializing zeroconf session, username: tywvg3rccay7bze81pvlor5nk" May 25 14:50:19 minidsp-shd go-librespot[1266]: time="2025-05-25T14:50:19-07:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" May 25 14:50:19 minidsp-shd go-librespot[1266]: time="2025-05-25T14:50:19-07:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" May 25 14:50:19 minidsp-shd go-librespot[1266]: time="2025-05-25T14:50:19-07:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" May 25 14:50:19 minidsp-shd go-librespot[1266]: time="2025-05-25T14:50:19-07:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" May 25 14:50:19 minidsp-shd go-librespot[1266]: time="2025-05-25T14:50:19-07:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 481" May 25 14:50:19 minidsp-shd go-librespot[1266]: time="2025-05-25T14:50:19-07:00" level=debug msg="autoplay enabled: false" May 25 14:50:19 minidsp-shd go-librespot[1266]: time="2025-05-25T14:50:19-07:00" level=debug msg="received connection id: ODg1ZjI4NTEtNmE1Yy00OWE3LTliZmItMDA1ZGJkNDQ4YThlK2RlYWxlcit0Y3A6Ly8wYWNiZDgzNy5pcC5ndWMzLnNwb3RpZnkubmV0OjU3MDArMTI2M0JERkI3M0FDQkMwNTRBMDJEOTU0ODE1MkUxOUUwMDQ2RDYyQzZBMjM2QjE3QTkwMjFDMDNBMTQwNDFGNA==" May 25 14:50:19 minidsp-shd go-librespot[1266]: time="2025-05-25T14:50:19-07:00" level=debug msg="put connect state because NEW_DEVICE" May 25 14:50:19 minidsp-shd sudo[1306]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall pulseaudio May 25 14:50:19 minidsp-shd sudo[1306]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 14:50:19 minidsp-shd volumiobt[1301]: pulseaudio: no process found May 25 14:50:19 minidsp-shd sudo[1306]: pam_unix(sudo:session): session closed for user root May 25 14:50:19 minidsp-shd volumio[1017]: info: CoreStateMachine::pushState May 25 14:50:19 minidsp-shd volumio[1017]: info: CorePlayQueue::getTrack 0 May 25 14:50:19 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 25 14:50:19 minidsp-shd volumio[1017]: info: CoreCommandRouter::volumioPushState May 25 14:50:19 minidsp-shd dbus-daemon[469]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' requested by ':1.13' (uid=1000 pid=1310 comm="/usr/bin/pulseaudio --high-priority=true ") May 25 14:50:19 minidsp-shd systemd[1]: Starting RealtimeKit Scheduling Policy Service... May 25 14:50:19 minidsp-shd volumio[1017]: ------------------------------------ BT MESSAGE: BT STATUS: running May 25 14:50:19 minidsp-shd dbus-daemon[469]: [system] Successfully activated service 'org.freedesktop.RealtimeKit1' May 25 14:50:19 minidsp-shd systemd[1]: Started RealtimeKit Scheduling Policy Service. May 25 14:50:19 minidsp-shd rtkit-daemon[1311]: Successfully called chroot. May 25 14:50:19 minidsp-shd rtkit-daemon[1311]: Successfully dropped privileges. May 25 14:50:19 minidsp-shd rtkit-daemon[1311]: Successfully limited resources. May 25 14:50:19 minidsp-shd rtkit-daemon[1311]: Running. May 25 14:50:19 minidsp-shd rtkit-daemon[1311]: Watchdog thread running. May 25 14:50:19 minidsp-shd dbus-daemon[469]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.14' (uid=0 pid=1311 comm="/usr/lib/rtkit/rtkit-daemon ") May 25 14:50:19 minidsp-shd rtkit-daemon[1311]: Canary thread running. May 25 14:50:19 minidsp-shd systemd[1]: Starting Authorization Manager... May 25 14:50:20 minidsp-shd volumio[1017]: ------------------------------------ BT MESSAGE: BT STATUS: running May 25 14:50:20 minidsp-shd polkitd[1314]: started daemon version 0.105 using authority implementation `local' version `0.105' May 25 14:50:20 minidsp-shd dbus-daemon[469]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' May 25 14:50:20 minidsp-shd systemd[1]: Started Authorization Manager. May 25 14:50:20 minidsp-shd dbus-daemon[469]: [system] Activating via systemd: service name='org.bluez' unit='dbus-org.bluez.service' requested by ':1.34' (uid=1000 pid=1310 comm="/usr/bin/pulseaudio --high-priority=true ") May 25 14:50:20 minidsp-shd systemd[1]: Starting Bluetooth service... May 25 14:50:20 minidsp-shd volumio[1017]: ------------------------------------ BT MESSAGE: BT STATUS: running May 25 14:50:20 minidsp-shd volumio[1017]: info: CoreStateMachine::pushState May 25 14:50:20 minidsp-shd volumio[1017]: info: CorePlayQueue::getTrack 0 May 25 14:50:20 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 25 14:50:20 minidsp-shd volumio[1017]: info: CoreCommandRouter::volumioPushState May 25 14:50:20 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: raat , updateRoonVolume May 25 14:50:20 minidsp-shd bluetoothd[1319]: Bluetooth daemon 5.23 May 25 14:50:20 minidsp-shd pulseaudio[1310]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 May 25 14:50:20 minidsp-shd pulseaudio[1310]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 May 25 14:50:20 minidsp-shd volumio[1017]: info: go-librespot daemon successfully initialized May 25 14:50:20 minidsp-shd volumiobt[1301]: Applying permissions May 25 14:50:20 minidsp-shd volumiobt[1301]: Setting BT discoverable and pairable May 25 14:50:20 minidsp-shd dbus-daemon[469]: [system] Successfully activated service 'org.bluez' May 25 14:50:20 minidsp-shd systemd[1]: Started Bluetooth service. May 25 14:50:20 minidsp-shd bluetoothd[1319]: Starting SDP server May 25 14:50:20 minidsp-shd bluetoothd[1319]: kernel lacks bnep-protocol support May 25 14:50:20 minidsp-shd bluetoothd[1319]: System does not support network plugin May 25 14:50:20 minidsp-shd bluetoothd[1319]: Bluetooth management interface 1.14 initialized May 25 14:50:20 minidsp-shd dbus-daemon[469]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.35' (uid=0 pid=1319 comm="/usr/local/libexec/bluetooth/bluetoothd ") May 25 14:50:20 minidsp-shd pulseaudio[1310]: Failed to register as a handsfree audio agent with ofono: org.freedesktop.DBus.Error.ServiceUnknown: The name org.ofono was not provided by any .service files May 25 14:50:20 minidsp-shd volumiobt[1301]: [38B blob data] May 25 14:50:20 minidsp-shd volumiobt[1301]: Invalid command May 25 14:50:20 minidsp-shd volumiobt[1301]: [bluetooth]# agent on May 25 14:50:20 minidsp-shd volumiobt[1301]: [bluetooth]# discoverable on May 25 14:50:20 minidsp-shd volumiobt[1301]: No default controller available May 25 14:50:20 minidsp-shd volumiobt[1301]: [bluetooth]# pairable on May 25 14:50:20 minidsp-shd volumiobt[1301]: No default controller available May 25 14:50:20 minidsp-shd volumiobt[1301]: [bluetooth]# agent NoInputNoOutput May 25 14:50:20 minidsp-shd volumiobt[1301]: Failed to register agent object May 25 14:50:20 minidsp-shd volumiobt[1301]: [bluetooth]# default-agent May 25 14:50:20 minidsp-shd volumiobt[1301]: No agent is registered May 25 14:50:20 minidsp-shd volumiobt[1301]: [bluetooth]# quit May 25 14:50:20 minidsp-shd volumiobt[1301]: [61B blob data] May 25 14:50:20 minidsp-shd systemd[1]: Starting Hostname Service... May 25 14:50:20 minidsp-shd volumiobt[1301]: [62B blob data] May 25 14:50:20 minidsp-shd volumio[1017]: ------------------------------------ BT MESSAGE: BT STATUS: running May 25 14:50:21 minidsp-shd dbus-daemon[469]: [system] Successfully activated service 'org.freedesktop.hostname1' May 25 14:50:21 minidsp-shd systemd[1]: Started Hostname Service. May 25 14:50:21 minidsp-shd volumio[1017]: info: Discovery: adding 287b961b-517f-45a0-87d5-7d86fe9f1569 May 25 14:50:21 minidsp-shd volumio[1017]: info: Discovery: Found device miniDSP SHD May 25 14:50:21 minidsp-shd volumio[1017]: info: CoreCommandRouter::volumioGetState May 25 14:50:21 minidsp-shd volumio[1017]: info: CorePlayQueue::getTrack 0 May 25 14:50:22 minidsp-shd mpd[1223]: May 25 14:50 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg May 25 14:50:22 minidsp-shd systemd[1]: Started Music Player Daemon. May 25 14:50:22 minidsp-shd volumio[1017]: Upnp client error: Error: This socket has been ended by the other party May 25 14:50:22 minidsp-shd sudo[1219]: pam_unix(sudo:session): session closed for user root May 25 14:50:22 minidsp-shd sudo[1209]: pam_unix(sudo:session): session closed for user root May 25 14:50:22 minidsp-shd volumio[1017]: info: Completed starting Core Plugins May 25 14:50:22 minidsp-shd volumio[1017]: info: ------------------------------------------- May 25 14:50:22 minidsp-shd volumio[1017]: info: ----- MyVolumio plugins startup ---- May 25 14:50:22 minidsp-shd volumio[1017]: info: ------------------------------------------- May 25 14:50:22 minidsp-shd volumio[1017]: info: [MyVolumio PluginManager] Fetching plans data.... May 25 14:50:22 minidsp-shd volumio[1017]: error: MPD error: The expression evaluated to a falsy value: May 25 14:50:22 minidsp-shd volumio[1017]: assert.ok(self.idling) May 25 14:50:22 minidsp-shd volumio[1017]: error: The expression evaluated to a falsy value: May 25 14:50:22 minidsp-shd volumio[1017]: assert.ok(self.idling) May 25 14:50:22 minidsp-shd volumio[1017]: info: MPD running with PID1223 May 25 14:50:22 minidsp-shd volumio[1017]: ,establishing connection May 25 14:50:22 minidsp-shd volumio[1017]: error: updateQueue error: null May 25 14:50:22 minidsp-shd volumio[1017]: error: updateQueue error: null May 25 14:50:23 minidsp-shd volumio[1262]: Generating RSA private key, 4096 bit long modulus (2 primes) May 25 14:50:23 minidsp-shd volumio[1017]: info: Initializing connection to go-librespot Websocket May 25 14:50:23 minidsp-shd go-librespot[1266]: time="2025-05-25T14:50:23-07:00" level=debug msg="new websocket client" May 25 14:50:23 minidsp-shd volumio[1017]: info: Connection to go-librespot Websocket established May 25 14:50:24 minidsp-shd go-librespot[1266]: time="2025-05-25T14:50:24-07:00" level=debug msg="handling transfer player command from 953b3c791b00df347055fa7b738a28ac4b568006" May 25 14:50:24 minidsp-shd go-librespot[1266]: time="2025-05-25T14:50:24-07:00" level=debug msg="resolved context of track" uri="spotify:playlist:76cPTyWVCTtj0HhqVUZAT0" May 25 14:50:24 minidsp-shd go-librespot[1266]: time="2025-05-25T14:50:24-07:00" level=trace msg="fetched new page 0 with 27 items (list: 27)" uri="spotify:playlist:76cPTyWVCTtj0HhqVUZAT0" May 25 14:50:24 minidsp-shd go-librespot[1266]: time="2025-05-25T14:50:24-07:00" level=debug msg="loading track (paused: false, position: 17605ms)" uri="spotify:track:0GhAc4Q5FIRaq3qLV0NsWY" May 25 14:50:24 minidsp-shd go-librespot[1266]: time="2025-05-25T14:50:24-07:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" May 25 14:50:24 minidsp-shd go-librespot[1266]: time="2025-05-25T14:50:24-07:00" level=trace msg="emitting websocket event: will_play" May 25 14:50:24 minidsp-shd volumio[1017]: SPOTIFY: received: {"type":"will_play","data":{"uri":"spotify:track:0GhAc4Q5FIRaq3qLV0NsWY","play_origin":"playlist"}} May 25 14:50:24 minidsp-shd go-librespot[1266]: time="2025-05-25T14:50:24-07:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 345" May 25 14:50:24 minidsp-shd go-librespot[1266]: time="2025-05-25T14:50:24-07:00" level=debug msg="selected format OGG_VORBIS_320 (e51baeae740b34aeea34eabfc778f0c8e275cceb)" uri="spotify:track:0GhAc4Q5FIRaq3qLV0NsWY" May 25 14:50:24 minidsp-shd go-librespot[1266]: time="2025-05-25T14:50:24-07:00" level=debug msg="requested aes key for file e51baeae740b34aeea34eabfc778f0c8e275cceb, gid: 0GhAc4Q5FIRaq3qLV0NsWY" May 25 14:50:25 minidsp-shd go-librespot[1266]: time="2025-05-25T14:50:25-07:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 1366" May 25 14:50:25 minidsp-shd go-librespot[1266]: time="2025-05-25T14:50:25-07:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 1129" May 25 14:50:25 minidsp-shd go-librespot[1266]: time="2025-05-25T14:50:25-07:00" level=debug msg="fetched first chunk of 28, total size is 14356156 bytes" uri="spotify:track:0GhAc4Q5FIRaq3qLV0NsWY" May 25 14:50:25 minidsp-shd go-librespot[1266]: time="2025-05-25T14:50:25-07:00" level=debug msg="fetched chunk 1/27, size: 524288" uri="spotify:track:0GhAc4Q5FIRaq3qLV0NsWY" May 25 14:50:25 minidsp-shd go-librespot[1266]: time="2025-05-25T14:50:25-07:00" level=trace msg="seek to 17605ms (diff: 134ms, samples: 776380, bytes: 752419)" uri="spotify:track:0GhAc4Q5FIRaq3qLV0NsWY" May 25 14:50:25 minidsp-shd go-librespot[1266]: time="2025-05-25T14:50:25-07:00" level=debug msg="fetched chunk 2/27, size: 524288" uri="spotify:track:0GhAc4Q5FIRaq3qLV0NsWY" May 25 14:50:25 minidsp-shd go-librespot[1266]: time="2025-05-25T14:50:25-07:00" level=debug msg="alsa driver configured, rate = 44100 bps, period time = 5804 us, period size = 256 frames, buffer time = 92879 us, buffer size = 4096 frames, periods per buffer = 16 frames" May 25 14:50:25 minidsp-shd go-librespot[1266]: time="2025-05-25T14:50:25-07:00" level=debug msg="created new output device" May 25 14:50:25 minidsp-shd go-librespot[1266]: time="2025-05-25T14:50:25-07:00" level=info msg="loaded track \"Blue World\" (paused: false, position: 17605ms, duration: 319146ms, prefetched: false)" uri="spotify:track:0GhAc4Q5FIRaq3qLV0NsWY" May 25 14:50:25 minidsp-shd volumio[1017]: info: CoreCommandRouter::executeOnPlugin: raat , updateDSP May 25 14:50:25 minidsp-shd go-librespot[1266]: time="2025-05-25T14:50:25-07:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" May 25 14:50:25 minidsp-shd go-librespot[1266]: time="2025-05-25T14:50:25-07:00" level=trace msg="scheduling prefetch in 271s" May 25 14:50:25 minidsp-shd go-librespot[1266]: time="2025-05-25T14:50:25-07:00" level=trace msg="emitting websocket event: metadata" May 25 14:50:25 minidsp-shd go-librespot[1266]: time="2025-05-25T14:50:25-07:00" level=trace msg="emitting websocket event: active" May 25 14:50:25 minidsp-shd go-librespot[1266]: time="2025-05-25T14:50:25-07:00" level=debug msg="sending successful reply for dealer request" May 25 14:50:25 minidsp-shd go-librespot[1266]: time="2025-05-25T14:50:25-07:00" level=debug msg="skipping dealer message" uri=social-connect/v2/broadcast_status_update May 25 14:50:25 minidsp-shd go-librespot[1266]: time="2025-05-25T14:50:25-07:00" level=debug msg="skipping dealer message" uri=social-connect/v2/session_update May 25 14:50:25 minidsp-shd volumio[1017]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:0GhAc4Q5FIRaq3qLV0NsWY","name":"Blue World","artist_names":["The Moody Blues"],"album_name":"The Present","album_cover_url":"https://i.scdn.co/image/ab67616d00001e021e92bd14eba00855cbfeee63","position":17605,"duration":319146,"release_date":"year:1983","track_number":1,"disc_number":1}} May 25 14:50:25 minidsp-shd volumio[1017]: SPOTIFY: received: {"type":"active","data":null} May 25 14:50:25 minidsp-shd volumio[1017]: info: Aligning Spotify Volume to Volumio Volume May 25 14:50:25 minidsp-shd volumio[1017]: info: CoreCommandRouter::volumioGetState May 25 14:50:25 minidsp-shd go-librespot[1266]: time="2025-05-25T14:50:25-07:00" level=debug msg="skipping dealer message" uri=social-connect/v2/session_update May 25 14:50:25 minidsp-shd volumio[1017]: info: CorePlayQueue::getTrack 0 May 25 14:50:25 minidsp-shd volumio[1017]: info: Setting Spotify Volume from Volumio: 64 May 25 14:50:25 minidsp-shd go-librespot[1266]: time="2025-05-25T14:50:25-07:00" level=debug msg="fetched chunk 3/27, size: 524288" uri="spotify:track:0GhAc4Q5FIRaq3qLV0NsWY" May 25 14:50:25 minidsp-shd go-librespot[1266]: time="2025-05-25T14:50:25-07:00" level=debug msg="fetched chunk 4/27, size: 524288" uri="spotify:track:0GhAc4Q5FIRaq3qLV0NsWY" May 25 14:50:25 minidsp-shd go-librespot[1266]: time="2025-05-25T14:50:25-07:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" May 25 14:50:25 minidsp-shd go-librespot[1266]: time="2025-05-25T14:50:25-07:00" level=trace msg="emitting websocket event: playing" May 25 14:50:25 minidsp-shd volumio[1017]: SPOTIFY: received: {"type":"playing","data":{"uri":"spotify:track:0GhAc4Q5FIRaq3qLV0NsWY","play_origin":"playlist"}} May 25 14:50:25 minidsp-shd volumio[1017]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 25 14:50:25 minidsp-shd volumio[1017]: TypeError: Cannot read property 'service' of undefined May 25 14:50:25 minidsp-shd volumio[1017]: at ControllerSpotify.identifyPlaybackMode (/data/plugins/music_service/spop/index.js:336:50) May 25 14:50:25 minidsp-shd volumio[1017]: at ControllerSpotify.parseEventState (/data/plugins/music_service/spop/index.js:262:18) May 25 14:50:25 minidsp-shd volumio[1017]: at WebSocket.message (/data/plugins/music_service/spop/index.js:189:14) May 25 14:50:25 minidsp-shd volumio[1017]: at WebSocket.emit (events.js:400:28) May 25 14:50:25 minidsp-shd volumio[1017]: at Receiver.receiverOnMessage (/data/plugins/music_service/spop/node_modules/ws/lib/websocket.js:1220:20) May 25 14:50:25 minidsp-shd volumio[1017]: at Receiver.emit (events.js:400:28) May 25 14:50:25 minidsp-shd volumio[1017]: at Receiver.dataMessage (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:596:14) May 25 14:50:25 minidsp-shd volumio[1017]: at Receiver.getData (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:496:10) May 25 14:50:25 minidsp-shd volumio[1017]: at Receiver.startLoop (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:167:16) May 25 14:50:25 minidsp-shd volumio[1017]: at Receiver._write (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:94:10) May 25 14:50:25 minidsp-shd volumio[1017]: at writeOrBuffer (internal/streams/writable.js:358:12) May 25 14:50:25 minidsp-shd volumio[1017]: at Receiver.Writable.write (internal/streams/writable.js:303:10) May 25 14:50:25 minidsp-shd volumio[1017]: at Socket.socketOnData (/data/plugins/music_service/spop/node_modules/ws/lib/websocket.js:1355:35) May 25 14:50:25 minidsp-shd volumio[1017]: at Socket.emit (events.js:400:28) May 25 14:50:25 minidsp-shd volumio[1017]: at addChunk (internal/streams/readable.js:293:12) May 25 14:50:25 minidsp-shd volumio[1017]: at readableAddChunk (internal/streams/readable.js:267:9) May 25 14:50:25 minidsp-shd volumio[1017]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 25 14:50:26 minidsp-shd sudo[1355]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-25 14:49 May 25 14:50:26 minidsp-shd sudo[1355]: pam_unix(sudo:session): session opened for user root by (uid=0) May 25 14:50:27 minidsp-shd volumio[1262]: .....................................................++++ PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="17fcb754ddd6bd152b01008c46cc4ba1ca48bf35" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="281cefcd7a302aa7cfba569185cf7aae19b8c376" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="minidspshd" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 22 Mar 2024 03:13:25 PM CET" VOLUMIO_VERSION="3.608" VOLUMIO_HARDWARE="nanopineo3" VOLUMIO_DEVICENAME="Nanopi Neo3" VOLUMIO_VENDOR="miniDSP" VOLUMIO_MODEL="SHD" VOLUMIO_VENDOR_MODEL="miniDSP SHD" VOLUMIO_HASH="18533ba33f8f92d7e7e459bb30f70beb"