-- Logs begin at Thu 2019-02-14 18:11:59 CST, end at Thu 2025-07-10 13:30:33 CST. --
Jul 10 13:29:25 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:25 smsl-n100 systemd-timedated[1069]: Changed local time to Thu Jul 10 13:29:25 2025
Jul 10 13:29:25 smsl-n100 sudo[1067]: pam_unix(sudo:session): session closed for user root
Jul 10 13:29:25 smsl-n100 volumio-time-update[488]: volumio-time-update-util: System time updated successfully.
Jul 10 13:29:25 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:25 smsl-n100 systemd[1]: Started Volumio Time Update Utility.
Jul 10 13:29:25 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:25 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:25 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:25 smsl-n100 ntpd[1049]: Soliciting pool server 162.159.200.123
Jul 10 13:29:25 smsl-n100 ntpd[1049]: Soliciting pool server 119.28.183.184
Jul 10 13:29:25 smsl-n100 wireless.js[487]: trying...
Jul 10 13:29:25 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:25 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:25 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:25 smsl-n100 sudo[1075]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Jul 10 13:29:25 smsl-n100 sudo[1075]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 10 13:29:25 smsl-n100 sudo[1075]: pam_unix(sudo:session): session closed for user root
Jul 10 13:29:25 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:25 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:26 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:26 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:26 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:26 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:26 smsl-n100 ntpd[1049]: Soliciting pool server 95.111.202.5
Jul 10 13:29:26 smsl-n100 ntpd[1049]: Soliciting pool server 185.209.85.222
Jul 10 13:29:26 smsl-n100 volumio-remote-updater[508]: [2025-07-10 13:29:26] [info] asio async_connect error: system:111 (Connection refused)
Jul 10 13:29:26 smsl-n100 volumio-remote-updater[508]: [2025-07-10 13:29:26] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Jul 10 13:29:26 smsl-n100 volumio-remote-updater[508]: [2025-07-10 13:29:26] [error] handle_connect error: Underlying Transport Error
Jul 10 13:29:26 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:26 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:26 smsl-n100 wireless.js[487]: trying...
Jul 10 13:29:26 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:26 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:26 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:26 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:26 smsl-n100 sudo[1079]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Jul 10 13:29:26 smsl-n100 sudo[1079]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 10 13:29:26 smsl-n100 sudo[1079]: pam_unix(sudo:session): session closed for user root
Jul 10 13:29:26 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:26 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:27 smsl-n100 ntpd[1049]: Soliciting pool server 84.16.67.12
Jul 10 13:29:27 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:27 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:27 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:27 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:27 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:27 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:27 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:27 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:27 smsl-n100 wireless.js[487]: trying...
Jul 10 13:29:27 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:27 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:27 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:27 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:27 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:28 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:28 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:28 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:28 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:28 smsl-n100 ntpd[1049]: Soliciting pool server 193.182.111.141
Jul 10 13:29:28 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:28 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:28 smsl-n100 sudo[1082]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Jul 10 13:29:28 smsl-n100 sudo[1082]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 10 13:29:28 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:28 smsl-n100 sudo[1082]: pam_unix(sudo:session): session closed for user root
Jul 10 13:29:28 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:28 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:28 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:28 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:28 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:28 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:28 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:28 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:28 smsl-n100 wireless.js[487]: trying...
Jul 10 13:29:28 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:28 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:28 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:28 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:28 smsl-n100 sudo[1086]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Jul 10 13:29:28 smsl-n100 sudo[1086]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 10 13:29:28 smsl-n100 sudo[1086]: pam_unix(sudo:session): session closed for user root
Jul 10 13:29:28 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:28 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:29 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:29 smsl-n100 ntpd[1049]: Soliciting pool server 108.59.2.24
Jul 10 13:29:29 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:29 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:29 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:29 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:29 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:29 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:29 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:29 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:29 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:29 smsl-n100 wireless.js[487]: trying...
Jul 10 13:29:29 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:29 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:29 smsl-n100 sudo[1089]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Jul 10 13:29:29 smsl-n100 sudo[1089]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 10 13:29:29 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:29 smsl-n100 sudo[1089]: pam_unix(sudo:session): session closed for user root
Jul 10 13:29:29 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:29 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:29 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:29 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:30 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:30 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:30 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:30 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:30 smsl-n100 ntpd[1049]: Soliciting pool server 116.203.151.74
Jul 10 13:29:30 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:30 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:30 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:30 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:30 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:30 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:30 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:30 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:30 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:30 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:30 smsl-n100 wireless.js[487]: trying...
Jul 10 13:29:30 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:30 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:30 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:30 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:30 smsl-n100 sudo[1092]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Jul 10 13:29:30 smsl-n100 sudo[1092]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 10 13:29:30 smsl-n100 sudo[1092]: pam_unix(sudo:session): session closed for user root
Jul 10 13:29:30 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:30 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:30 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:30 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:31 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:31 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:31 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:31 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:32 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:32 smsl-n100 ntpd[1049]: receive: Unexpected origin timestamp 0xec19ce3b.2e4e5ffd does not match aorg 0000000000.00000000 from server@119.28.206.193 xmt 0xec19ce3c.6b5109eb
Jul 10 13:29:32 smsl-n100 systemd[1]: systemd-fsckd.service: Succeeded.
Jul 10 13:29:32 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:32 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:32 smsl-n100 ntpd[1049]: receive: Unexpected origin timestamp 0xec19ce3b.2e5aa99b does not match aorg 0000000000.00000000 from server@210.28.130.4 xmt 0xec19ce3c.70ca258e
Jul 10 13:29:32 smsl-n100 ntpd[1049]: receive: Unexpected origin timestamp 0xec19ce3b.2e4846c4 does not match aorg 0000000000.00000000 from server@202.118.1.81 xmt 0xec19ce3c.6f7a191e
Jul 10 13:29:32 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:32 smsl-n100 ntpd[1049]: receive: Unexpected origin timestamp 0xec19ce3b.2e3a2bd3 does not match aorg 0000000000.00000000 from server@95.111.202.5 xmt 0xec19ce3c.7b55b426
Jul 10 13:29:32 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:32 smsl-n100 ntpd[1049]: receive: Unexpected origin timestamp 0xec19ce3b.2e41a3f8 does not match aorg 0000000000.00000000 from server@162.159.200.123 xmt 0xec19ce3c.7c44ee88
Jul 10 13:29:32 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:32 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:32 smsl-n100 ntpd[1049]: receive: Unexpected origin timestamp 0xec19ce3b.2e21c6af does not match aorg 0000000000.00000000 from server@116.203.151.74 xmt 0xec19ce3c.88c856a4
Jul 10 13:29:32 smsl-n100 ntpd[1049]: receive: Unexpected origin timestamp 0xec19ce3b.2e6117a8 does not match aorg 0000000000.00000000 from server@193.182.111.14 xmt 0xec19ce3c.88f2ec28
Jul 10 13:29:32 smsl-n100 ntpd[1049]: receive: Unexpected origin timestamp 0xec19ce3b.2e67051b does not match aorg 0000000000.00000000 from server@193.182.111.143 xmt 0xec19ce3c.8a38f401
Jul 10 13:29:32 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:32 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:32 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:32 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:32 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:32 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:33 smsl-n100 wireless.js[487]: trying...
Jul 10 13:29:33 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:33 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:33 smsl-n100 sudo[1095]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Jul 10 13:29:33 smsl-n100 sudo[1095]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 10 13:29:33 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:33 smsl-n100 sudo[1095]: pam_unix(sudo:session): session closed for user root
Jul 10 13:29:33 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:33 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:33 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:33 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:33 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:33 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:33 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:33 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:33 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:33 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:33 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:33 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:33 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:33 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:33 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:33 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:33 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:33 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:34 smsl-n100 wireless.js[487]: trying...
Jul 10 13:29:34 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:34 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:34 smsl-n100 sudo[1098]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Jul 10 13:29:34 smsl-n100 sudo[1098]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 10 13:29:34 smsl-n100 sudo[1098]: pam_unix(sudo:session): session closed for user root
Jul 10 13:29:34 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:34 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:35 smsl-n100 wireless.js[487]: trying...
Jul 10 13:29:35 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:35 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:35 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:35 smsl-n100 sudo[1101]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Jul 10 13:29:35 smsl-n100 sudo[1101]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 10 13:29:35 smsl-n100 sudo[1101]: pam_unix(sudo:session): session closed for user root
Jul 10 13:29:35 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:35 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:35 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:35 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:35 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:35 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:35 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:36 smsl-n100 wireless.js[487]: trying...
Jul 10 13:29:36 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:36 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:36 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:36 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:36 smsl-n100 sudo[1107]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Jul 10 13:29:36 smsl-n100 sudo[1107]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 10 13:29:36 smsl-n100 sudo[1107]: pam_unix(sudo:session): session closed for user root
Jul 10 13:29:36 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:36 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:37 smsl-n100 wireless.js[487]: trying...
Jul 10 13:29:37 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:37 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:37 smsl-n100 sudo[1110]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Jul 10 13:29:37 smsl-n100 sudo[1110]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 10 13:29:37 smsl-n100 sudo[1110]: pam_unix(sudo:session): session closed for user root
Jul 10 13:29:37 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:37 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:37 smsl-n100 volumio-remote-updater[508]: [2025-07-10 13:29:37] [info] asio async_connect error: system:111 (Connection refused)
Jul 10 13:29:37 smsl-n100 volumio-remote-updater[508]: [2025-07-10 13:29:37] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected)
Jul 10 13:29:37 smsl-n100 volumio-remote-updater[508]: [2025-07-10 13:29:37] [error] handle_connect error: Underlying Transport Error
Jul 10 13:29:37 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:37 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:38 smsl-n100 wireless.js[487]: trying...
Jul 10 13:29:38 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:38 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:38 smsl-n100 sudo[1113]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r
Jul 10 13:29:38 smsl-n100 sudo[1113]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 10 13:29:38 smsl-n100 sudo[1113]: pam_unix(sudo:session): session closed for user root
Jul 10 13:29:38 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:38 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:39 smsl-n100 wireless.js[487]: Overtime, starting plan B
Jul 10 13:29:39 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:39 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:39 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:39 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:39 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:39 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:39 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:39 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:39 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:39 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:40 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:40 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:40 smsl-n100 iwconfig[1117]: Error for wireless request "Set Power Management" (8B2C) :
Jul 10 13:29:40 smsl-n100 iwconfig[1117]: SET failed on device wlan0 ; Operation not permitted.
Jul 10 13:29:40 smsl-n100 systemd[1]: Started Wireless Services.
Jul 10 13:29:40 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:40 smsl-n100 systemd[1]: Started Volumio Backend Module.
Jul 10 13:29:40 smsl-n100 kernel: vdd_arm: ramp_delay not set
Jul 10 13:29:40 smsl-n100 systemd[1]: Started Volumio Cpu Tweaker.
Jul 10 13:29:40 smsl-n100 systemd[1]: Reached target Multi-User System.
Jul 10 13:29:40 smsl-n100 systemd[1]: Reached target Graphical Interface.
Jul 10 13:29:40 smsl-n100 systemd[1]: Starting Update UTMP about System Runlevel Changes...
Jul 10 13:29:40 smsl-n100 systemd[1]: systemd-update-utmp-runlevel.service: Succeeded.
Jul 10 13:29:40 smsl-n100 systemd[1]: Started Update UTMP about System Runlevel Changes.
Jul 10 13:29:40 smsl-n100 systemd[1]: Startup finished in 6.578s (kernel) + 41.601s (userspace) = 48.180s.
Jul 10 13:29:40 smsl-n100 volumio-cpu-tweak[1119]: Setting RT Priority for mpd
Jul 10 13:29:40 smsl-n100 volumio-cpu-tweak[1119]: Setting MPD Affinity
Jul 10 13:29:40 smsl-n100 volumio-cpu-tweak[1119]: pid 776's current affinity mask: f
Jul 10 13:29:40 smsl-n100 volumio-cpu-tweak[1119]: pid 776's new affinity mask: 3
Jul 10 13:29:40 smsl-n100 volumio-cpu-tweak[1119]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input
Jul 10 13:29:40 smsl-n100 volumio-cpu-tweak[1119]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance
Jul 10 13:29:40 smsl-n100 systemd[1]: volumio_cpu_tweak.service: Succeeded.
Jul 10 13:29:45 smsl-n100 volumio[1118]: info: -------------------------------------------
Jul 10 13:29:45 smsl-n100 volumio[1118]: info: ----- Volumio3 ----
Jul 10 13:29:45 smsl-n100 volumio[1118]: info: -------------------------------------------
Jul 10 13:29:45 smsl-n100 volumio[1118]: info: ----- System startup ----
Jul 10 13:29:45 smsl-n100 volumio[1118]: info: -------------------------------------------
Jul 10 13:29:47 smsl-n100 volumio[1118]: info: MYVOLUMIO Environment detected
Jul 10 13:29:47 smsl-n100 volumio-remote-updater[508]: [2025-07-10 13:29:47] [connect] Successful connection
Jul 10 13:29:48 smsl-n100 volumio[1118]: info: Plugin folders cleanup
Jul 10 13:29:48 smsl-n100 volumio[1118]: info: Scanning into folder /volumio/app/plugins/
Jul 10 13:29:48 smsl-n100 volumio[1118]: info: Scanning category audio_interface
Jul 10 13:29:48 smsl-n100 volumio[1118]: info: Scanning category miscellanea
Jul 10 13:29:48 smsl-n100 volumio[1118]: info: Scanning category music_service
Jul 10 13:29:48 smsl-n100 volumio[1118]: info: Scanning category plugins.json
Jul 10 13:29:48 smsl-n100 volumio[1118]: info: Scanning category system_controller
Jul 10 13:29:48 smsl-n100 volumio[1118]: info: Scanning category user_interface
Jul 10 13:29:48 smsl-n100 volumio[1118]: info: Scanning into folder /data/plugins/
Jul 10 13:29:48 smsl-n100 volumio[1118]: info: Plugin folders cleanup completed
Jul 10 13:29:48 smsl-n100 volumio[1118]: info: -------------------------------------------
Jul 10 13:29:48 smsl-n100 volumio[1118]: info: ----- Core plugins startup ----
Jul 10 13:29:48 smsl-n100 volumio[1118]: info: -------------------------------------------
Jul 10 13:29:48 smsl-n100 volumio[1118]: info: Loading plugins from folder /volumio/app/plugins/
Jul 10 13:29:48 smsl-n100 volumio[1118]: info: Adding plugin bluetooth to MyMusic Plugins
Jul 10 13:29:48 smsl-n100 volumio[1118]: info: Adding plugin multiroom to MyMusic Plugins
Jul 10 13:29:48 smsl-n100 volumio[1118]: info: Adding plugin upnp to MyMusic Plugins
Jul 10 13:29:48 smsl-n100 volumio[1118]: info: Adding plugin metavolumio to MyMusic Plugins
Jul 10 13:29:48 smsl-n100 volumio[1118]: info: Adding plugin airplay_emulation to MyMusic Plugins
Jul 10 13:29:48 smsl-n100 volumio[1118]: info: Adding plugin cd_controller to MyMusic Plugins
Jul 10 13:29:48 smsl-n100 volumio[1118]: info: Adding plugin raat to MyMusic Plugins
Jul 10 13:29:48 smsl-n100 volumio[1118]: info: Adding plugin smart_inputs to MyMusic Plugins
Jul 10 13:29:48 smsl-n100 volumio[1118]: info: Adding plugin tidalconnect to MyMusic Plugins
Jul 10 13:29:48 smsl-n100 volumio[1118]: info: Adding plugin upnp_browser to MyMusic Plugins
Jul 10 13:29:48 smsl-n100 volumio[1118]: info: Loading plugins from folder /data/plugins/
Jul 10 13:29:48 smsl-n100 volumio[1118]: info: Loading plugin "system"...
Jul 10 13:29:48 smsl-n100 volumio[1118]: info: Loading plugin "appearance"...
Jul 10 13:29:51 smsl-n100 volumio[1118]: info: Loading plugin "network"...
Jul 10 13:29:51 smsl-n100 volumio[1118]: info: Refreshing Cached IP Addresses
Jul 10 13:29:51 smsl-n100 sudo[1153]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jul 10 13:29:51 smsl-n100 sudo[1153]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 10 13:29:51 smsl-n100 sudo[1153]: pam_unix(sudo:session): session closed for user root
Jul 10 13:29:51 smsl-n100 sudo[1155]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jul 10 13:29:51 smsl-n100 sudo[1155]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 10 13:29:51 smsl-n100 volumio[1118]: info: Loading plugin "services"...
Jul 10 13:29:51 smsl-n100 sudo[1155]: pam_unix(sudo:session): session closed for user root
Jul 10 13:29:51 smsl-n100 volumio[1118]: info: Loading plugin "alsa_controller"...
Jul 10 13:29:51 smsl-n100 sudo[1164]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Jul 10 13:29:51 smsl-n100 sudo[1164]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 10 13:29:51 smsl-n100 volumio[1118]: warn: Unable to locate the audio output device LOXJIE AUDIO. Please configure a valid output device.
Jul 10 13:29:51 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jul 10 13:29:51 smsl-n100 volumio[1118]: info: Loading plugin "wizard"...
Jul 10 13:29:51 smsl-n100 volumio[1118]: info: Loading plugin "networkfs"...
Jul 10 13:29:52 smsl-n100 volumio[1118]: info: Starting Udev Watcher for removable devices
Jul 10 13:29:52 smsl-n100 volumio[1118]: info: Ignoring mount for partition: boot
Jul 10 13:29:52 smsl-n100 volumio[1118]: info: Ignoring mount for partition: volumio
Jul 10 13:29:52 smsl-n100 volumio[1118]: info: Ignoring mount for partition: volumio_data
Jul 10 13:29:52 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jul 10 13:29:52 smsl-n100 volumio[1118]: info: Loading plugin "volumio_command_line_client"...
Jul 10 13:29:52 smsl-n100 volumio[1118]: info: Loading plugin "upnp"...
Jul 10 13:29:52 smsl-n100 volumio[1118]: info: [1752125392066] Starting Upmpd Daemon
Jul 10 13:29:52 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jul 10 13:29:52 smsl-n100 volumio[1118]: info: Loading plugin "my_music"...
Jul 10 13:29:52 smsl-n100 volumio[1118]: info: Loading plugin "mpd"...
Jul 10 13:29:52 smsl-n100 volumio[1118]: info: Loading plugin "upnp_browser"...
Jul 10 13:29:53 smsl-n100 volumio[1118]: info: Loading plugin "bluetooth"...
Jul 10 13:29:54 smsl-n100 volumio[1118]: info: [1752125394282] Starting BluetoothController
Jul 10 13:29:54 smsl-n100 volumio[1118]: info: Loading plugin "alarm-clock"...
Jul 10 13:29:55 smsl-n100 sudo[1164]: pam_unix(sudo:session): session closed for user root
Jul 10 13:29:55 smsl-n100 volumio[1118]: info: Loading plugin "manifestui"...
Jul 10 13:29:55 smsl-n100 volumio[1118]: info: Loading plugin "metavolumio"...
Jul 10 13:29:56 smsl-n100 systemd[1]: systemd-timedated.service: Succeeded.
Jul 10 13:29:58 smsl-n100 volumio[1118]: info: Loading plugin "airplay_emulation"...
Jul 10 13:29:58 smsl-n100 volumio[1118]: info: Starting Shairport Sync
Jul 10 13:29:58 smsl-n100 volumio[1118]: info: Loading plugin "cd_controller"...
Jul 10 13:29:59 smsl-n100 volumio[1118]: info: Loading plugin "last_100"...
Jul 10 13:29:59 smsl-n100 volumio[1118]: info: Loading plugin "raat"...
Jul 10 13:29:59 smsl-n100 volumio[1118]: info: RAAT Plugin loaded
Jul 10 13:29:59 smsl-n100 volumio[1118]: info: Adding restartRAATSocket REST API Endpoint
Jul 10 13:29:59 smsl-n100 volumio[1118]: info: Adding restartRAATSocket REST Endpoint for plugin: music_service/raat
Jul 10 13:29:59 smsl-n100 volumio[1118]: info: Loading plugin "streaming_services"...
Jul 10 13:30:01 smsl-n100 volumio[1118]: info: Starting Streaming Service Transparent Proxy
Jul 10 13:30:02 smsl-n100 volumio[1118]: info: Loading plugin "tidalconnect"...
Jul 10 13:30:02 smsl-n100 volumio[1118]: info: Loading plugin "webradio"...
Jul 10 13:30:02 smsl-n100 volumio[1118]: info: Loading plugin "i2s_dacs"...
Jul 10 13:30:02 smsl-n100 volumio-remote-updater[508]: [2025-07-10 13:30:02] [connect] Successful connection
Jul 10 13:30:02 smsl-n100 volumio[1118]: info: I2S DAC not set, start Auto-detection
Jul 10 13:30:02 smsl-n100 volumio[1118]: info: Loading plugin "volumiodiscovery"...
Jul 10 13:30:02 smsl-n100 volumio[1118]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Jul 10 13:30:02 smsl-n100 volumio[1118]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jul 10 13:30:02 smsl-n100 node[1118]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Jul 10 13:30:02 smsl-n100 volumio[1118]: *** WARNING *** For more information see
Jul 10 13:30:02 smsl-n100 volumio[1118]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Jul 10 13:30:02 smsl-n100 volumio[1118]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jul 10 13:30:02 smsl-n100 volumio[1118]: *** WARNING *** For more information see
Jul 10 13:30:02 smsl-n100 node[1118]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jul 10 13:30:02 smsl-n100 node[1118]: *** WARNING *** For more information see
Jul 10 13:30:02 smsl-n100 node[1118]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Jul 10 13:30:02 smsl-n100 node[1118]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jul 10 13:30:02 smsl-n100 node[1118]: *** WARNING *** For more information see
Jul 10 13:30:02 smsl-n100 volumio[1118]: info: Applying required configuration parameters for plugin volumiodiscovery
Jul 10 13:30:02 smsl-n100 volumio[1118]: info: Discovery: Started advertising with name: SMSL N100
Jul 10 13:30:02 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jul 10 13:30:02 smsl-n100 volumio[1118]: info: Loading plugin "multiroom"...
Jul 10 13:30:04 smsl-n100 volumio[1118]: STREAMING PROXY: Starting server on port 3245
Jul 10 13:30:04 smsl-n100 volumio[1118]: Node JS runtime: 14
Jul 10 13:30:06 smsl-n100 volumio[1118]: info: Applying required configuration parameters for plugin multiroom
Jul 10 13:30:06 smsl-n100 sudo[1245]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom
Jul 10 13:30:06 smsl-n100 sudo[1245]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 10 13:30:06 smsl-n100 sudo[1245]: pam_unix(sudo:session): session closed for user root
Jul 10 13:30:06 smsl-n100 volumio[1118]: info: MRS: MultiRoom plugin initialized
Jul 10 13:30:06 smsl-n100 volumio[1118]: info: MRS: STOPPING SNAPCLIENT
Jul 10 13:30:06 smsl-n100 volumio[1118]: info: MRS: Snap server stop
Jul 10 13:30:06 smsl-n100 volumio[1118]: info: MRS: STOPPING volumioStreaming
Jul 10 13:30:06 smsl-n100 sudo[1261]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient
Jul 10 13:30:06 smsl-n100 sudo[1261]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 10 13:30:06 smsl-n100 sudo[1263]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver
Jul 10 13:30:06 smsl-n100 sudo[1263]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 10 13:30:06 smsl-n100 sudo[1261]: pam_unix(sudo:session): session closed for user root
Jul 10 13:30:06 smsl-n100 volumio[1118]: info: Loading plugin "outputs"...
Jul 10 13:30:06 smsl-n100 sudo[1266]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming
Jul 10 13:30:06 smsl-n100 sudo[1266]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 10 13:30:06 smsl-n100 volumio[1118]: info: Loading plugin "albumart"...
Jul 10 13:30:06 smsl-n100 sudo[1269]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/*
Jul 10 13:30:06 smsl-n100 sudo[1269]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 10 13:30:06 smsl-n100 sudo[1263]: pam_unix(sudo:session): session closed for user root
Jul 10 13:30:06 smsl-n100 sudo[1269]: pam_unix(sudo:session): session closed for user root
Jul 10 13:30:06 smsl-n100 volumio[1118]: info: Plugin example_plugin is not enabled
Jul 10 13:30:06 smsl-n100 volumio[1118]: info: Loading plugin "hi_res_audio"...
Jul 10 13:30:06 smsl-n100 sudo[1266]: pam_unix(sudo:session): session closed for user root
Jul 10 13:30:07 smsl-n100 volumio[1118]: Forking 3 albumart workers
Jul 10 13:30:09 smsl-n100 volumio[1118]: Starting albumart workers
Jul 10 13:30:09 smsl-n100 volumio[1118]: Starting albumart workers
Jul 10 13:30:09 smsl-n100 volumio[1118]: Starting albumart workers
Jul 10 13:30:10 smsl-n100 volumio[1118]: info: Applying required configuration parameters for plugin hi_res_audio
Jul 10 13:30:10 smsl-n100 volumio[1118]: info: Loading plugin "inputs"...
Jul 10 13:30:12 smsl-n100 volumio[1118]: info: Loading plugin "qobuz"...
Jul 10 13:30:14 smsl-n100 volumio[1118]: info: Loading plugin "smart_inputs"...
Jul 10 13:30:15 smsl-n100 volumio[1118]: info: Loading plugin "tidal"...
Jul 10 13:30:17 smsl-n100 volumio-remote-updater[508]: [2025-07-10 13:30:17] [connect] Successful connection
Jul 10 13:30:17 smsl-n100 volumio[1118]: info: Loading plugin "oem_helper"...
Jul 10 13:30:20 smsl-n100 volumio[1118]: info: Applying required configuration parameters for plugin oem_helper
Jul 10 13:30:20 smsl-n100 volumio[1118]: info: Loading plugin "smslcontrol"...
Jul 10 13:30:20 smsl-n100 kernel: gpio gpiochip0: Persistence not supported for GPIO 5
Jul 10 13:30:20 smsl-n100 volumio[1118]: info: Adding this device properties
Jul 10 13:30:20 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: system , setThisDeviceVolumioProperties
Jul 10 13:30:20 smsl-n100 volumio[1118]: info: Setting Additional Device Volumio Properties: [object Object]
Jul 10 13:30:20 smsl-n100 volumio[1118]: info: Loading plugin "updater_comm"...
Jul 10 13:30:20 smsl-n100 volumio[1118]: info: Plugin mpdemulation is not enabled
Jul 10 13:30:20 smsl-n100 volumio[1118]: info: Loading plugin "rest_api"...
Jul 10 13:30:20 smsl-n100 volumio[1118]: info: Loading plugin "websocket"...
Jul 10 13:30:20 smsl-n100 volumio[1118]: info: Starting Socket.io Server version 2.3.0
Jul 10 13:30:20 smsl-n100 volumio[1118]: info: Loading i18n strings for locale zh
Jul 10 13:30:20 smsl-n100 volumio[1118]: Updating browse sources language
Jul 10 13:30:20 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 10 13:30:21 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 10 13:30:21 smsl-n100 volumio[1118]: info: CoreCommandRouter::initPlayerControls
Jul 10 13:30:21 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 10 13:30:21 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 10 13:30:21 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 10 13:30:21 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 10 13:30:21 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 10 13:30:21 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 10 13:30:21 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 10 13:30:21 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 10 13:30:21 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 10 13:30:21 smsl-n100 volumio[1118]: Express server listening on port 3000
Jul 10 13:30:21 smsl-n100 volumio[1118]: [Metrics] WebUI: 37s 665.18ms
Jul 10 13:30:21 smsl-n100 volumio[1118]: info: CoreStateMachine::resetVolumioState
Jul 10 13:30:21 smsl-n100 volumio[1118]: info: CoreStateMachine::getcurrentVolume
Jul 10 13:30:21 smsl-n100 volumio[1118]: info: CoreCommandRouter::volumioRetrievevolume
Jul 10 13:30:21 smsl-n100 volumio[1118]: info: CoreStateMachine::pushState
Jul 10 13:30:21 smsl-n100 volumio[1118]: info: CorePlayQueue::getTrack 0
Jul 10 13:30:21 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 10 13:30:21 smsl-n100 volumio[1118]: info: CoreCommandRouter::volumioPushState
Jul 10 13:30:21 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 10 13:30:21 smsl-n100 volumio[1118]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt'
Jul 10 13:30:21 smsl-n100 volumio[1118]: info: Completed loading Core Plugins
Jul 10 13:30:21 smsl-n100 volumio[1118]: info: Preparing to generate the ALSA configuration file
Jul 10 13:30:21 smsl-n100 volumio[1118]: info: Volumio Network Manager: Network status updated: 1
Jul 10 13:30:21 smsl-n100 volumio[1118]: info: MRS: Removed streaming files
Jul 10 13:30:21 smsl-n100 volumio[1118]: info: MRS: volumioStreaming STOPPED
Jul 10 13:30:21 smsl-n100 volumio[1118]: info: MRS: SNAPSERVER STOPPED
Jul 10 13:30:21 smsl-n100 volumio[1118]: info: MRS: SNAPCLIENT STOPPED
Jul 10 13:30:21 smsl-n100 volumio[1118]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision
Jul 10 13:30:21 smsl-n100 volumio[1118]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf
Jul 10 13:30:21 smsl-n100 volumio[1118]: info: Reading ALSA contributions from plugins.
Jul 10 13:30:21 smsl-n100 volumio-remote-updater[508]: [2025-07-10 13:30:21] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1752125417 101
Jul 10 13:30:22 smsl-n100 volumio[1118]: 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: 1
Jul 10 13:30:22 smsl-n100 volumio[1118]: info: Reloading queue from file
Jul 10 13:30:22 smsl-n100 volumio[1118]: info: CoreStateMachine::setRepeat null single undefined
Jul 10 13:30:22 smsl-n100 volumio[1118]: info: CoreStateMachine::pushState
Jul 10 13:30:22 smsl-n100 volumio[1118]: info: CorePlayQueue::getTrack 0
Jul 10 13:30:22 smsl-n100 volumio[1118]: info: CoreCommandRouter::volumioPushState
Jul 10 13:30:22 smsl-n100 volumio[1118]: info: CoreStateMachine::setRandom null
Jul 10 13:30:22 smsl-n100 volumio[1118]: info: CoreStateMachine::pushState
Jul 10 13:30:22 smsl-n100 volumio[1118]: info: CorePlayQueue::getTrack 0
Jul 10 13:30:22 smsl-n100 volumio[1118]: info: CoreCommandRouter::volumioPushState
Jul 10 13:30:22 smsl-n100 volumio[1118]: info: Setting Device type: NanoPi NEO 3
Jul 10 13:30:22 smsl-n100 volumio[1118]: info: Asound.conf file unchanged, so no further update is needed
Jul 10 13:30:22 smsl-n100 volumio[1118]: info: Output device has changed, restarting MPD
Jul 10 13:30:22 smsl-n100 sudo[1357]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jul 10 13:30:22 smsl-n100 sudo[1357]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 10 13:30:22 smsl-n100 sudo[1359]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jul 10 13:30:22 smsl-n100 sudo[1370]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Jul 10 13:30:22 smsl-n100 sudo[1359]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 10 13:30:22 smsl-n100 sudo[1372]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jul 10 13:30:22 smsl-n100 sudo[1370]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 10 13:30:22 smsl-n100 sudo[1372]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 10 13:30:22 smsl-n100 volumio[1118]: info: Output device has changed, restarting Shairport Sync
Jul 10 13:30:22 smsl-n100 sudo[1359]: pam_unix(sudo:session): session closed for user root
Jul 10 13:30:22 smsl-n100 sudo[1357]: pam_unix(sudo:session): session closed for user root
Jul 10 13:30:22 smsl-n100 sudo[1372]: pam_unix(sudo:session): session closed for user root
Jul 10 13:30:22 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 10 13:30:22 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 10 13:30:22 smsl-n100 systemd[1]: Started UPnP Renderer front-end to MPD.
Jul 10 13:30:22 smsl-n100 sudo[1387]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jul 10 13:30:22 smsl-n100 sudo[1370]: pam_unix(sudo:session): session closed for user root
Jul 10 13:30:22 smsl-n100 sudo[1387]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 10 13:30:22 smsl-n100 systemd[1]: Stopping Music Player Daemon...
Jul 10 13:30:22 smsl-n100 volumio[1118]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jul 10 13:30:22 smsl-n100 volumio[1118]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Jul 10 13:30:22 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 10 13:30:22 smsl-n100 volumio[1118]: info: ___________ START PLUGINS ___________
Jul 10 13:30:22 smsl-n100 volumio[1118]: info: ControllerMpd::onStart: Initializing MPD
Jul 10 13:30:22 smsl-n100 volumio[1118]: info: Creating MPD Configuration file
Jul 10 13:30:22 smsl-n100 sudo[1397]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jul 10 13:30:22 smsl-n100 sudo[1397]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 10 13:30:22 smsl-n100 sudo[1397]: pam_unix(sudo:session): session closed for user root
Jul 10 13:30:22 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jul 10 13:30:22 smsl-n100 volumio[1118]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jul 10 13:30:22 smsl-n100 volumio[1118]: info: [1752125422812] CoreMusicLibrary::Adding element 媒体服务器
Jul 10 13:30:22 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 10 13:30:22 smsl-n100 sudo[1400]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jul 10 13:30:22 smsl-n100 sudo[1400]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 10 13:30:22 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jul 10 13:30:22 smsl-n100 volumio[1118]: info: Adding METAVOLUMIO REST API Endpoints
Jul 10 13:30:22 smsl-n100 volumio[1118]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio
Jul 10 13:30:22 smsl-n100 volumio[1118]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio
Jul 10 13:30:22 smsl-n100 volumio[1118]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio
Jul 10 13:30:22 smsl-n100 volumio[1118]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio
Jul 10 13:30:22 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 10 13:30:22 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 10 13:30:22 smsl-n100 sudo[1403]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name SMSL N100
Jul 10 13:30:22 smsl-n100 sudo[1403]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 10 13:30:23 smsl-n100 sudo[1403]: pam_unix(sudo:session): session closed for user root
Jul 10 13:30:23 smsl-n100 volumio[1118]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jul 10 13:30:23 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 10 13:30:23 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 10 13:30:23 smsl-n100 systemd[1]: mpd.service: Succeeded.
Jul 10 13:30:23 smsl-n100 systemd[1]: Stopped Music Player Daemon.
Jul 10 13:30:23 smsl-n100 systemd[1]: Starting Music Player Daemon...
Jul 10 13:30:23 smsl-n100 volumio[1118]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jul 10 13:30:23 smsl-n100 volumio[1118]: info: Preparing CD Folders
Jul 10 13:30:23 smsl-n100 volumio[1118]: info: Adding CD REST API Endpoints
Jul 10 13:30:23 smsl-n100 volumio[1118]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller
Jul 10 13:30:23 smsl-n100 volumio[1118]: info: Starting UDEV Watcher for CD
Jul 10 13:30:23 smsl-n100 volumio[1118]: info: Detecting CD presence with UDEV
Jul 10 13:30:23 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices
Jul 10 13:30:23 smsl-n100 volumio[1118]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jul 10 13:30:23 smsl-n100 volumio[1118]: info: [1752125423201] CoreMusicLibrary::Adding element Last_100
Jul 10 13:30:23 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 10 13:30:23 smsl-n100 volumio[1118]: info: Starting RAAT Plugin
Jul 10 13:30:23 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , addAdditionalUISections
Jul 10 13:30:23 smsl-n100 volumio[1118]: info: Additional UI Settings Added for plugin music_service/raat
Jul 10 13:30:23 smsl-n100 volumio[1118]: info: Registering DSP Elements listener and retrieving current ones
Jul 10 13:30:23 smsl-n100 volumio[1118]: info: Additional DSP elements updated
Jul 10 13:30:23 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 10 13:30:23 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 10 13:30:23 smsl-n100 sudo[1409]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Jul 10 13:30:23 smsl-n100 sudo[1409]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 10 13:30:23 smsl-n100 volumio[1118]: info: Updating RAAT Signal Path
Jul 10 13:30:23 smsl-n100 volumio[1118]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined
Jul 10 13:30:23 smsl-n100 volumio[1118]: info: Streaming services startup
Jul 10 13:30:23 smsl-n100 volumio[1118]: info: Starting Streaming Daemon
Jul 10 13:30:23 smsl-n100 sudo[1409]: pam_unix(sudo:session): session closed for user root
Jul 10 13:30:23 smsl-n100 sudo[1417]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Jul 10 13:30:23 smsl-n100 sudo[1417]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 10 13:30:23 smsl-n100 sudo[1417]: pam_unix(sudo:session): session closed for user root
Jul 10 13:30:23 smsl-n100 volumio[1118]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jul 10 13:30:23 smsl-n100 volumio[1118]: info: [1752125423478] CoreMusicLibrary::Adding element Webradio
Jul 10 13:30:23 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jul 10 13:30:23 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jul 10 13:30:23 smsl-n100 volumio[1118]: info: Initializing BBC Radios
Jul 10 13:30:23 smsl-n100 sudo[1424]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Jul 10 13:30:23 smsl-n100 sudo[1424]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 10 13:30:23 smsl-n100 sudo[1424]: pam_unix(sudo:session): session closed for user root
Jul 10 13:30:23 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jul 10 13:30:23 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 10 13:30:23 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus
Jul 10 13:30:23 smsl-n100 volumio[1118]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Jul 10 13:30:23 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 10 13:30:23 smsl-n100 volumio[1118]: error: Hi Res Audio Failed Login: Missing Login Data
Jul 10 13:30:23 smsl-n100 volumio[1118]: info: Adding HIGHRESAUDIO REST API Endpoints
Jul 10 13:30:23 smsl-n100 volumio[1118]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio
Jul 10 13:30:23 smsl-n100 volumio[1118]: info: Initializing Serial Communication on port /dev/ttyS1
Jul 10 13:30:23 smsl-n100 volumio[1118]: info: Touch Event Listener Process Starting
Jul 10 13:30:23 smsl-n100 volumio[1118]: info: Adding inputs REST Endpoints
Jul 10 13:30:23 smsl-n100 volumio[1118]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs
Jul 10 13:30:23 smsl-n100 volumio[1118]: info: Scanning Audio Inputs
Jul 10 13:30:23 smsl-n100 sudo[1441]: pam_unix(sudo:auth): conversation failed
Jul 10 13:30:23 smsl-n100 sudo[1441]: pam_unix(sudo:auth): auth could not identify password for [volumio]
Jul 10 13:30:23 smsl-n100 volumio[1118]: info: Checking against Known Cards name
Jul 10 13:30:23 smsl-n100 volumio[1118]: info: Adding Server instance for streaming
Jul 10 13:30:24 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jul 10 13:30:24 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 10 13:30:24 smsl-n100 volumio[1118]: info: Initializing GPIOs
Jul 10 13:30:24 smsl-n100 kernel: gpio gpiochip3: Persistence not supported for GPIO 1
Jul 10 13:30:24 smsl-n100 kernel: gpio gpiochip2: Persistence not supported for GPIO 15
Jul 10 13:30:24 smsl-n100 kernel: gpio gpiochip3: Persistence not supported for GPIO 0
Jul 10 13:30:24 smsl-n100 kernel: gpio gpiochip2: Persistence not supported for GPIO 2
Jul 10 13:30:24 smsl-n100 volumio[1118]: info: Starting Button Listener
Jul 10 13:30:24 smsl-n100 volumio[1118]: info: Turning off Green LED
Jul 10 13:30:24 smsl-n100 volumio[1118]: info: Tuning on Blue LED
Jul 10 13:30:24 smsl-n100 volumio[1118]: info: Signaling System Ready
Jul 10 13:30:24 smsl-n100 volumio[1118]: info: Volumio Calling Home
Jul 10 13:30:24 smsl-n100 volumio[1118]: (node:1118) [DEP0005] DeprecationWarning: Buffer() is deprecated due to security and usability issues. Please use the Buffer.alloc(), Buffer.allocUnsafe(), or Buffer.from() methods instead.
Jul 10 13:30:24 smsl-n100 volumio[1118]: (Use `node --trace-deprecation ...` to show where the warning was created)
Jul 10 13:30:24 smsl-n100 volumio[1118]: info: Stopping AccessToken refresher cron for QOBUZ
Jul 10 13:30:24 smsl-n100 volumio[1118]: info: AccessToken refresher cron started for QOBUZ
Jul 10 13:30:24 smsl-n100 volumio[1118]: info: Stopping AccessToken refresher cron
Jul 10 13:30:24 smsl-n100 volumio[1118]: info: AccessToken refresher cron started
Jul 10 13:30:24 smsl-n100 volumio[1118]: info: Adding TIDAL REST API Endpoints
Jul 10 13:30:24 smsl-n100 volumio[1118]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal
Jul 10 13:30:24 smsl-n100 volumio[1118]: info: Adding QOBUZ REST API Endpoints
Jul 10 13:30:24 smsl-n100 volumio[1118]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz
Jul 10 13:30:24 smsl-n100 volumio[1118]: info: Serial port opened successfully
Jul 10 13:30:24 smsl-n100 volumio[1118]: info: Sending serial start messages
Jul 10 13:30:25 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 10 13:30:25 smsl-n100 volumio[1118]: info: Reporting MCU Network Status: 1
Jul 10 13:30:25 smsl-n100 volumio[1118]: info: Touch Event Listener Process Closed
Jul 10 13:30:25 smsl-n100 volumio[1118]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined
Jul 10 13:30:25 smsl-n100 volumio[1118]: error: Cannot start Volumio Streaming Daemon
Jul 10 13:30:25 smsl-n100 volumio[1118]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Jul 10 13:30:25 smsl-n100 volumio[1118]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Jul 10 13:30:25 smsl-n100 volumio[1118]: info: RAAT Albumart path created successfully
Jul 10 13:30:25 smsl-n100 volumio[1118]: error: Cannot set new Bluetooth Name : Error: Command failed: /usr/bin/sudo /bin/hciconfig hci0 name 'SMSL N100'
Jul 10 13:30:25 smsl-n100 volumio[1118]: Can't get device info: No such device
Jul 10 13:30:25 smsl-n100 volumio[1118]: info: MPD Permissions set
Jul 10 13:30:25 smsl-n100 volumio[1118]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined
Jul 10 13:30:25 smsl-n100 volumio[1118]: info: MPD Permissions set
Jul 10 13:30:25 smsl-n100 volumio[1118]: info: Upmpdcli Daemon Started
Jul 10 13:30:25 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setDeviceVolumeOverride
Jul 10 13:30:25 smsl-n100 volumio[1118]: info: Setting Device Volume Override
Jul 10 13:30:25 smsl-n100 volumio[1118]: info: CoreCommandRouter::volumioUpdateVolumeSettings
Jul 10 13:30:25 smsl-n100 volumio[1118]: info: Updating Volume Controller Parameters: Device: 5 Name: LOXJIE AUDIO Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1
Jul 10 13:30:25 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume
Jul 10 13:30:25 smsl-n100 volumio[1118]: info: Disabling external Volume Control
Jul 10 13:30:25 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 10 13:30:25 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 10 13:30:25 smsl-n100 volumio[1118]: info: CoreStateMachine::pushState
Jul 10 13:30:25 smsl-n100 volumio[1118]: info: CorePlayQueue::getTrack 0
Jul 10 13:30:25 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 10 13:30:25 smsl-n100 volumio[1118]: info: CoreCommandRouter::volumioPushState
Jul 10 13:30:25 smsl-n100 volumio[1118]: error: Serial API: Failed to decode command: 100, message: undefined
Jul 10 13:30:25 smsl-n100 volumio[1118]: error: Serial API: Failed to decode command: MAXVOL, message:
Jul 10 13:30:25 smsl-n100 volumio[1118]: error: Serial API: Failed to decode command: 100, message: undefined
Jul 10 13:30:25 smsl-n100 volumio[1118]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff
Jul 10 13:30:25 smsl-n100 volumio[1118]: info: CoreStateMachine::pushState
Jul 10 13:30:25 smsl-n100 volumio[1118]: info: CorePlayQueue::getTrack 0
Jul 10 13:30:25 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 10 13:30:25 smsl-n100 volumio[1118]: info: CoreCommandRouter::volumioPushState
Jul 10 13:30:25 smsl-n100 volumio[1118]: info: Volumio called home
Jul 10 13:30:25 smsl-n100 volumio[1118]: info: CoreStateMachine::pushState
Jul 10 13:30:25 smsl-n100 volumio[1118]: info: CorePlayQueue::getTrack 0
Jul 10 13:30:25 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 10 13:30:25 smsl-n100 volumio[1118]: info: CoreCommandRouter::volumioPushState
Jul 10 13:30:25 smsl-n100 volumio[1118]: error: Serial API: Failed to decode command: 100, message: undefined
Jul 10 13:30:25 smsl-n100 volumio[1118]: error: Serial API: Failed to decode command: MAXVOL, message:
Jul 10 13:30:25 smsl-n100 volumio[1118]: error: Serial API: Failed to decode command: 100, message: undefined
Jul 10 13:30:25 smsl-n100 volumio[1118]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff
Jul 10 13:30:25 smsl-n100 volumio[1118]: info: CoreStateMachine::pushState
Jul 10 13:30:25 smsl-n100 volumio[1118]: info: CorePlayQueue::getTrack 0
Jul 10 13:30:25 smsl-n100 volumio[1118]: info: CoreCommandRouter::volumioPushState
Jul 10 13:30:25 smsl-n100 volumio[1118]: error: Serial API: Failed to decode command: 100, message: undefined
Jul 10 13:30:25 smsl-n100 volumio[1118]: error: Serial API: Failed to decode command: MAXVOL, message:
Jul 10 13:30:25 smsl-n100 volumio[1118]: error: Serial API: Failed to decode command: 100, message: undefined
Jul 10 13:30:25 smsl-n100 volumio[1118]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff
Jul 10 13:30:25 smsl-n100 volumio[1118]: error: Serial API: Failed to decode command: 1, message: undefined
Jul 10 13:30:25 smsl-n100 volumio[1118]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2
Jul 10 13:30:25 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 10 13:30:25 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 10 13:30:25 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 10 13:30:25 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 10 13:30:25 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 10 13:30:25 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 10 13:30:25 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 10 13:30:25 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 10 13:30:25 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 10 13:30:25 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Jul 10 13:30:25 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 10 13:30:25 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 10 13:30:25 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 10 13:30:25 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 10 13:30:25 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 10 13:30:25 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 10 13:30:25 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 10 13:30:25 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 10 13:30:25 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 10 13:30:25 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 10 13:30:25 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Jul 10 13:30:25 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 10 13:30:25 smsl-n100 volumio[1118]: info: CoreStateMachine::pushState
Jul 10 13:30:25 smsl-n100 volumio[1118]: info: CorePlayQueue::getTrack 0
Jul 10 13:30:25 smsl-n100 volumio[1118]: info: CoreCommandRouter::volumioPushState
Jul 10 13:30:25 smsl-n100 volumio[1118]: error: Serial API: Failed to decode command: 100, message: undefined
Jul 10 13:30:25 smsl-n100 volumio[1118]: error: Serial API: Failed to decode command: MAXVOL, message:
Jul 10 13:30:25 smsl-n100 volumio[1118]: error: Serial API: Failed to decode command: 100, message: undefined
Jul 10 13:30:25 smsl-n100 volumio[1118]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff
Jul 10 13:30:26 smsl-n100 volumio[1118]: info: Starting Shairport Sync
Jul 10 13:30:26 smsl-n100 sudo[1488]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service
Jul 10 13:30:26 smsl-n100 sudo[1488]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 10 13:30:26 smsl-n100 volumio[1118]: info: Starting Shairport Sync
Jul 10 13:30:26 smsl-n100 systemd[1]: Started Volumio Bluetooth Module.
Jul 10 13:30:26 smsl-n100 sudo[1491]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jul 10 13:30:26 smsl-n100 volumio[1118]: info: Starting Shairport Sync
Jul 10 13:30:26 smsl-n100 sudo[1491]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 10 13:30:26 smsl-n100 sudo[1488]: pam_unix(sudo:session): session closed for user root
Jul 10 13:30:26 smsl-n100 sudo[1494]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jul 10 13:30:26 smsl-n100 sudo[1494]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 10 13:30:26 smsl-n100 volumio[1118]: info: CoreStateMachine::pushState
Jul 10 13:30:26 smsl-n100 volumio[1118]: info: CorePlayQueue::getTrack 0
Jul 10 13:30:26 smsl-n100 volumio[1118]: info: CoreCommandRouter::volumioPushState
Jul 10 13:30:26 smsl-n100 volumio[1118]: error: Serial API: Failed to decode command: 100, message: undefined
Jul 10 13:30:26 smsl-n100 sudo[1497]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth/*
Jul 10 13:30:26 smsl-n100 systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jul 10 13:30:26 smsl-n100 sudo[1497]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 10 13:30:26 smsl-n100 systemd[1]: shairport-sync.service: Succeeded.
Jul 10 13:30:26 smsl-n100 volumio[1118]: error: Serial API: Failed to decode command: MAXVOL, message:
Jul 10 13:30:26 smsl-n100 volumio[1118]: error: Serial API: Failed to decode command: 100, message: undefined
Jul 10 13:30:26 smsl-n100 volumio[1118]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff
Jul 10 13:30:26 smsl-n100 systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Jul 10 13:30:26 smsl-n100 volumio[1118]: info: CoreStateMachine::pushState
Jul 10 13:30:26 smsl-n100 volumio[1118]: info: CorePlayQueue::getTrack 0
Jul 10 13:30:26 smsl-n100 volumiobt[1493]: /bin/chmod: cannot access '/var/lib/bluetooth/*': No such file or directory
Jul 10 13:30:26 smsl-n100 volumio[1118]: info: CoreCommandRouter::volumioPushState
Jul 10 13:30:26 smsl-n100 sudo[1497]: pam_unix(sudo:session): session closed for user root
Jul 10 13:30:26 smsl-n100 sudo[1499]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jul 10 13:30:26 smsl-n100 sudo[1499]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 10 13:30:26 smsl-n100 volumio[1118]: error: Serial API: Failed to decode command: 100, message: undefined
Jul 10 13:30:26 smsl-n100 volumio[1118]: error: Serial API: Failed to decode command: MAXVOL, message:
Jul 10 13:30:26 smsl-n100 volumio[1118]: error: Serial API: Failed to decode command: 100, message: undefined
Jul 10 13:30:26 smsl-n100 volumio[1118]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff
Jul 10 13:30:26 smsl-n100 systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jul 10 13:30:26 smsl-n100 sudo[1494]: pam_unix(sudo:session): session closed for user root
Jul 10 13:30:26 smsl-n100 sudo[1499]: pam_unix(sudo:session): session closed for user root
Jul 10 13:30:26 smsl-n100 sudo[1491]: pam_unix(sudo:session): session closed for user root
Jul 10 13:30:26 smsl-n100 volumio[1118]: info: Shairport-Sync Started
Jul 10 13:30:26 smsl-n100 volumio[1118]: Error adding Membership: Error: addMembership EINVAL
Jul 10 13:30:26 smsl-n100 volumio[1118]: info: Shairport-Sync Started
Jul 10 13:30:26 smsl-n100 volumio[1118]: info: Shairport-Sync Started
Jul 10 13:30:26 smsl-n100 volumio[1118]: info: Volumio BT Module successfully started
Jul 10 13:30:26 smsl-n100 volumio[1118]: info: TidalConnect service stoped!
Jul 10 13:30:26 smsl-n100 volumio[1118]: info: Adding tc_getconfig REST Endpoint for plugin: music_service/tidalconnect
Jul 10 13:30:26 smsl-n100 volumio[1118]: info: Adding tc_connect REST Endpoint for plugin: music_service/tidalconnect
Jul 10 13:30:26 smsl-n100 sudo[1515]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service
Jul 10 13:30:26 smsl-n100 sudo[1515]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 10 13:30:26 smsl-n100 systemd[1]: Started Volumio Tidal Connect Service.
Jul 10 13:30:26 smsl-n100 sudo[1515]: pam_unix(sudo:session): session closed for user root
Jul 10 13:30:27 smsl-n100 sudo[1520]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall pulseaudio
Jul 10 13:30:27 smsl-n100 sudo[1520]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 10 13:30:27 smsl-n100 volumiobt[1493]: pulseaudio: no process found
Jul 10 13:30:27 smsl-n100 sudo[1520]: pam_unix(sudo:session): session closed for user root
Jul 10 13:30:27 smsl-n100 systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Jul 10 13:30:27 smsl-n100 systemd[1]: mpd.service: Failed with result 'protocol'.
Jul 10 13:30:27 smsl-n100 systemd[1]: Failed to start Music Player Daemon.
Jul 10 13:30:27 smsl-n100 sudo[1400]: pam_unix(sudo:session): session closed for user root
Jul 10 13:30:27 smsl-n100 sudo[1387]: pam_unix(sudo:session): session closed for user root
Jul 10 13:30:27 smsl-n100 volumio[1118]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Jul 10 13:30:27 smsl-n100 systemd[1]: Starting Music Player Daemon...
Jul 10 13:30:27 smsl-n100 volumio[1118]: info: Cannot restart MPD: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.service
Jul 10 13:30:27 smsl-n100 volumio[1118]: Job for mpd.service failed because the service did not take the steps required by its unit configuration.
Jul 10 13:30:27 smsl-n100 volumio[1118]: See "systemctl status mpd.service" and "journalctl -xe" for details.
Jul 10 13:30:27 smsl-n100 volumio[1118]: error: Cannot start MPD on system Start: Error: Command failed: /usr/bin/sudo /bin/systemctl restart mpd.service
Jul 10 13:30:27 smsl-n100 volumio[1118]: Job for mpd.service failed because the service did not take the steps required by its unit configuration.
Jul 10 13:30:27 smsl-n100 volumio[1118]: See "systemctl status mpd.service" and "journalctl -xe" for details.
Jul 10 13:30:27 smsl-n100 volumio[1118]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jul 10 13:30:27 smsl-n100 dbus-daemon[513]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' requested by ':1.15' (uid=1000 pid=1528 comm="/usr/bin/pulseaudio --high-priority=true ")
Jul 10 13:30:27 smsl-n100 systemd[1]: Starting RealtimeKit Scheduling Policy Service...
Jul 10 13:30:27 smsl-n100 dbus-daemon[513]: [system] Successfully activated service 'org.freedesktop.RealtimeKit1'
Jul 10 13:30:27 smsl-n100 systemd[1]: Started RealtimeKit Scheduling Policy Service.
Jul 10 13:30:27 smsl-n100 rtkit-daemon[1529]: Successfully called chroot.
Jul 10 13:30:27 smsl-n100 rtkit-daemon[1529]: Successfully dropped privileges.
Jul 10 13:30:27 smsl-n100 rtkit-daemon[1529]: Successfully limited resources.
Jul 10 13:30:27 smsl-n100 rtkit-daemon[1529]: Running.
Jul 10 13:30:27 smsl-n100 rtkit-daemon[1529]: Watchdog thread running.
Jul 10 13:30:27 smsl-n100 sudo[1525]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Jul 10 13:30:27 smsl-n100 rtkit-daemon[1529]: Canary thread running.
Jul 10 13:30:27 smsl-n100 sudo[1525]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 10 13:30:27 smsl-n100 dbus-daemon[513]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.16' (uid=0 pid=1529 comm="/usr/lib/rtkit/rtkit-daemon ")
Jul 10 13:30:27 smsl-n100 volumio[1118]: info: Executing endpoint tc_getconfig
Jul 10 13:30:27 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig
Jul 10 13:30:27 smsl-n100 sudo[1525]: pam_unix(sudo:session): session closed for user root
Jul 10 13:30:27 smsl-n100 systemd[1]: Starting Authorization Manager...
Jul 10 13:30:27 smsl-n100 vtcs[1517]: STARTING TidalConnect services, version: 1.4.0.34
Jul 10 13:30:27 smsl-n100 volumio[1118]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jul 10 13:30:27 smsl-n100 volumio[1118]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jul 10 13:30:28 smsl-n100 vtcs[1517]: STARTED TidalConnect services.
Jul 10 13:30:28 smsl-n100 polkitd[1533]: started daemon version 0.105 using authority implementation `local' version `0.105'
Jul 10 13:30:28 smsl-n100 dbus-daemon[513]: [system] Successfully activated service 'org.freedesktop.PolicyKit1'
Jul 10 13:30:28 smsl-n100 systemd[1]: Started Authorization Manager.
Jul 10 13:30:28 smsl-n100 volumio[1118]: info: Executing endpoint tc_connect
Jul 10 13:30:28 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect
Jul 10 13:30:28 smsl-n100 volumio[1118]: info: Connecting to TidalConnect
Jul 10 13:30:28 smsl-n100 volumio[1118]: info: CoreCommandRouter::servicePushState
Jul 10 13:30:28 smsl-n100 volumio[1118]: info: CoreStateMachine::pushState
Jul 10 13:30:28 smsl-n100 volumio[1118]: info: CorePlayQueue::getTrack 0
Jul 10 13:30:28 smsl-n100 volumio[1118]: info: CoreCommandRouter::volumioPushState
Jul 10 13:30:28 smsl-n100 volumio[1118]: info: CorePlayQueue::getTrack 0
Jul 10 13:30:28 smsl-n100 volumio[1118]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false}
Jul 10 13:30:28 smsl-n100 volumio[1118]: verbose: CURRENT POSITION 0
Jul 10 13:30:28 smsl-n100 volumio[1118]: info: CoreStateMachine::syncState stateService stop
Jul 10 13:30:28 smsl-n100 volumio[1118]: info: CoreStateMachine::syncState currentStatus stop
Jul 10 13:30:28 smsl-n100 volumio[1118]: info: CoreStateMachine::pushState
Jul 10 13:30:28 smsl-n100 volumio[1118]: info: CorePlayQueue::getTrack 0
Jul 10 13:30:28 smsl-n100 volumio[1118]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 10 13:30:28 smsl-n100 volumio[1118]: info: CoreCommandRouter::volumioPushState
Jul 10 13:30:28 smsl-n100 volumio[1118]: info: No code
Jul 10 13:30:28 smsl-n100 volumio[1118]: info: CoreStateMachine::pushState
Jul 10 13:30:28 smsl-n100 volumio[1118]: info: CorePlayQueue::getTrack 0
Jul 10 13:30:28 smsl-n100 volumio[1118]: info: CoreCommandRouter::volumioPushState
Jul 10 13:30:28 smsl-n100 volumio[1118]: info: CoreCommandRouter::servicePushState
Jul 10 13:30:28 smsl-n100 volumio[1118]: info: CoreStateMachine::pushState
Jul 10 13:30:28 smsl-n100 volumio[1118]: info: CorePlayQueue::getTrack 0
Jul 10 13:30:28 smsl-n100 volumio[1118]: info: CoreCommandRouter::volumioPushState
Jul 10 13:30:28 smsl-n100 volumio[1118]: info: CorePlayQueue::getTrack 0
Jul 10 13:30:28 smsl-n100 volumio[1118]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false}
Jul 10 13:30:28 smsl-n100 volumio[1118]: verbose: CURRENT POSITION 0
Jul 10 13:30:28 smsl-n100 volumio[1118]: info: CoreStateMachine::syncState stateService stop
Jul 10 13:30:28 smsl-n100 volumio[1118]: info: CoreStateMachine::syncState currentStatus stop
Jul 10 13:30:28 smsl-n100 volumio[1118]: info: CoreStateMachine::pushState
Jul 10 13:30:28 smsl-n100 volumio[1118]: info: CorePlayQueue::getTrack 0
Jul 10 13:30:28 smsl-n100 volumio[1118]: info: CoreCommandRouter::volumioPushState
Jul 10 13:30:28 smsl-n100 volumio[1118]: info: No code
Jul 10 13:30:28 smsl-n100 volumio[1118]: info: CoreStateMachine::pushState
Jul 10 13:30:28 smsl-n100 volumio[1118]: info: CorePlayQueue::getTrack 0
Jul 10 13:30:28 smsl-n100 volumio[1118]: info: CoreCommandRouter::volumioPushState
Jul 10 13:30:28 smsl-n100 volumio[1118]: info: MRS: Getting audio outputs on start
Jul 10 13:30:28 smsl-n100 volumio[1118]: info: MRS: Requesting all other devices output
Jul 10 13:30:28 smsl-n100 dbus-daemon[513]: [system] Activating via systemd: service name='org.bluez' unit='dbus-org.bluez.service' requested by ':1.37' (uid=1000 pid=1528 comm="/usr/bin/pulseaudio --high-priority=true ")
Jul 10 13:30:28 smsl-n100 systemd[1]: Starting Bluetooth service...
Jul 10 13:30:28 smsl-n100 volumio[1118]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jul 10 13:30:28 smsl-n100 pulseaudio[1528]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11
Jul 10 13:30:28 smsl-n100 pulseaudio[1528]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11
Jul 10 13:30:28 smsl-n100 volumiobt[1493]: Applying permissions
Jul 10 13:30:28 smsl-n100 volumiobt[1493]: Setting BT discoverable and pairable
Jul 10 13:30:28 smsl-n100 bluetoothd[1554]: Bluetooth daemon 5.50
Jul 10 13:30:28 smsl-n100 bluetoothd[1554]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf
Jul 10 13:30:29 smsl-n100 dbus-daemon[513]: [system] Successfully activated service 'org.bluez'
Jul 10 13:30:29 smsl-n100 systemd[1]: Started Bluetooth service.
Jul 10 13:30:29 smsl-n100 bluetoothd[1554]: Starting SDP server
Jul 10 13:30:29 smsl-n100 bluetoothd[1554]: Excluding (cli) sap
Jul 10 13:30:29 smsl-n100 bluetoothd[1554]: kernel lacks bnep-protocol support
Jul 10 13:30:29 smsl-n100 bluetoothd[1554]: System does not support network plugin
Jul 10 13:30:29 smsl-n100 dbus-daemon[513]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.39' (uid=0 pid=1554 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap ")
Jul 10 13:30:29 smsl-n100 bluetoothd[1554]: Bluetooth management interface 1.14 initialized
Jul 10 13:30:29 smsl-n100 volumiobt[1493]: [bluetooth]# -e power on
Jul 10 13:30:29 smsl-n100 volumiobt[1493]: Invalid command in menu main: -e
Jul 10 13:30:29 smsl-n100 volumiobt[1493]:
Jul 10 13:30:29 smsl-n100 volumiobt[1493]: Use "help" for a list of available commands in a menu.
Jul 10 13:30:29 smsl-n100 volumiobt[1493]: Use "menu " if you want to enter any submenu.
Jul 10 13:30:29 smsl-n100 volumiobt[1493]: Use "back" if you want to return to menu main.
Jul 10 13:30:29 smsl-n100 volumiobt[1493]: [bluetooth]# agent on
Jul 10 13:30:29 smsl-n100 volumiobt[1493]: Failed to register agent object
Jul 10 13:30:29 smsl-n100 volumiobt[1493]: [bluetooth]# discoverable on
Jul 10 13:30:29 smsl-n100 volumiobt[1493]: No default controller available
Jul 10 13:30:29 smsl-n100 volumiobt[1493]: [bluetooth]# pairable on
Jul 10 13:30:29 smsl-n100 volumiobt[1493]: No default controller available
Jul 10 13:30:29 smsl-n100 volumiobt[1493]: [bluetooth]# agent NoInputNoOutput
Jul 10 13:30:29 smsl-n100 volumiobt[1493]: Failed to register agent object
Jul 10 13:30:29 smsl-n100 volumiobt[1493]: [bluetooth]# default-agent
Jul 10 13:30:29 smsl-n100 volumiobt[1493]: No agent is registered
Jul 10 13:30:29 smsl-n100 volumiobt[1493]: [bluetooth]# quit
Jul 10 13:30:29 smsl-n100 pulseaudio[1528]: 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
Jul 10 13:30:29 smsl-n100 volumiobt[1493]: [59B blob data]
Jul 10 13:30:29 smsl-n100 systemd[1]: Starting Hostname Service...
Jul 10 13:30:29 smsl-n100 volumio[1118]: ------------------------------------ BT MESSAGE: BT STATUS: running
Jul 10 13:30:29 smsl-n100 dbus-daemon[513]: [system] Successfully activated service 'org.freedesktop.hostname1'
Jul 10 13:30:29 smsl-n100 systemd[1]: Started Hostname Service.
Jul 10 13:30:29 smsl-n100 volumio[1118]: info: TidalConnect service started!
Jul 10 13:30:29 smsl-n100 volumio[1118]: info: Completed starting Core Plugins
Jul 10 13:30:29 smsl-n100 volumio[1118]: info: -------------------------------------------
Jul 10 13:30:29 smsl-n100 volumio[1118]: info: ----- MyVolumio plugins startup ----
Jul 10 13:30:29 smsl-n100 volumio[1118]: info: -------------------------------------------
Jul 10 13:30:29 smsl-n100 volumio[1118]: info: [MyVolumio PluginManager] Fetching plans data....
Jul 10 13:30:30 smsl-n100 volumio[1118]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3
Jul 10 13:30:30 smsl-n100 volumio[1118]: info: CoreCommandRouter::volumioGetState
Jul 10 13:30:30 smsl-n100 volumio[1118]: info: CorePlayQueue::getTrack 0
Jul 10 13:30:30 smsl-n100 volumio[1118]: info: CoreCommandRouter::volumioGetState
Jul 10 13:30:30 smsl-n100 volumio[1118]: info: CorePlayQueue::getTrack 0
Jul 10 13:30:30 smsl-n100 volumio[1118]: info: CoreStateMachine::pushState
Jul 10 13:30:30 smsl-n100 volumio[1118]: info: CorePlayQueue::getTrack 0
Jul 10 13:30:30 smsl-n100 volumio[1118]: info: CoreCommandRouter::volumioPushState
Jul 10 13:30:30 smsl-n100 volumio[1118]: error: Serial API: Failed to decode command: 100, message: undefined
Jul 10 13:30:30 smsl-n100 volumio[1118]: error: Serial API: Failed to decode command: MAXVOL, message:
Jul 10 13:30:30 smsl-n100 volumio[1118]: error: Serial API: Failed to decode command: 100, message: undefined
Jul 10 13:30:30 smsl-n100 volumio[1118]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff
Jul 10 13:30:31 smsl-n100 mpd[1534]: Jul 10 13:30 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Jul 10 13:30:31 smsl-n100 systemd[1]: Started Music Player Daemon.
Jul 10 13:30:31 smsl-n100 volumio[1118]: Upnp client error: Error: This socket has been ended by the other party
Jul 10 13:30:31 smsl-n100 mpd_monitor.sh[486]: MPD restarted due to no mpc output.
Jul 10 13:30:31 smsl-n100 volumio[1118]: error: MPD error: The expression evaluated to a falsy value:
Jul 10 13:30:31 smsl-n100 volumio[1118]: assert.ok(self.idling)
Jul 10 13:30:31 smsl-n100 volumio[1118]: error: The expression evaluated to a falsy value:
Jul 10 13:30:31 smsl-n100 volumio[1118]: assert.ok(self.idling)
Jul 10 13:30:31 smsl-n100 volumio[1118]: Upnp client error: Error: This socket has been ended by the other party
Jul 10 13:30:31 smsl-n100 volumio[1118]: error: updateQueue error: null
Jul 10 13:30:32 smsl-n100 volumio[1118]: info: Discovery: adding 1739e99d-30af-4a32-8b9d-6b08b6604bc0
Jul 10 13:30:32 smsl-n100 volumio[1118]: info: Discovery: Found device SMSL N100
Jul 10 13:30:32 smsl-n100 volumio[1118]: info: CoreCommandRouter::volumioGetState
Jul 10 13:30:32 smsl-n100 volumio[1118]: info: CorePlayQueue::getTrack 0
Jul 10 13:30:32 smsl-n100 volumio[1118]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 10 13:30:32 smsl-n100 volumio[1118]: Error: The value NaN is not a number
Jul 10 13:30:32 smsl-n100 volumio[1118]: at Config.forceToType (/volumio/node_modules/v-conf/index.js:322:20)
Jul 10 13:30:32 smsl-n100 volumio[1118]: at Config.set (/volumio/node_modules/v-conf/index.js:153:25)
Jul 10 13:30:32 smsl-n100 volumio[1118]: at ControllerVolumioDiscovery.updateMultiroomDevice (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:323:25)
Jul 10 13:30:32 smsl-n100 volumio[1118]: at ControllerVolumioDiscovery.connectToRemoteVolumio (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:273:10)
Jul 10 13:30:32 smsl-n100 volumio[1118]: at Browser. (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:192:12)
Jul 10 13:30:32 smsl-n100 volumio[1118]: at Browser.emit (events.js:400:28)
Jul 10 13:30:32 smsl-n100 volumio[1118]: at on_resolver_done (/volumio/node_modules/mdns/lib/browser.js:31:14)
Jul 10 13:30:32 smsl-n100 volumio[1118]: at next (/volumio/node_modules/mdns/lib/browser.js:106:7)
Jul 10 13:30:32 smsl-n100 volumio[1118]: at Array.makeAddressesUnique (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:177:5)
Jul 10 13:30:32 smsl-n100 volumio[1118]: at next (/volumio/node_modules/mdns/lib/browser.js:109:21)
Jul 10 13:30:32 smsl-n100 volumio[1118]: at /volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:160:11
Jul 10 13:30:32 smsl-n100 volumio[1118]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:108:7)
Jul 10 13:30:32 smsl-n100 volumio[1118]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9)
Jul 10 13:30:32 smsl-n100 volumio[1118]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 10 13:30:33 smsl-n100 sudo[1586]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-10 13:29
Jul 10 13:30:33 smsl-n100 sudo[1586]: pam_unix(sudo:session): session opened for user root by (uid=0)
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="cc0042a1eab1cb7982711a1347e242f8947b54b6"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="723ba1d50268911818ebdca474fb7656df6050cb"
VOLUMIO_ARCH="armv7"
VOLUMIO_VARIANT="smsl"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri 14 Feb 2025 02:46:15 PM CET"
VOLUMIO_VERSION="3.789"
VOLUMIO_HARDWARE="nanopineo3"
VOLUMIO_DEVICENAME="Nanopi Neo3"
VOLUMIO_VENDOR_MODEL="SMSL S100"
VOLUMIO_VENDOR="SMSL"
VOLUMIO_MODEL="S100"
VOLUMIO_HASH="215d731aee688e00fb3cc923952be9a7"