-- Logs begin at Thu 2019-02-14 19:11:59 JST, end at Sun 2025-05-11 08:37:36 JST. -- May 11 08:36:53 smsl-n100 systemd-timedated[1005]: Changed local time to Sun May 11 08:36:53 2025 May 11 08:36:53 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:53 smsl-n100 sudo[1003]: pam_unix(sudo:session): session closed for user root May 11 08:36:53 smsl-n100 volumio-time-update[549]: volumio-time-update-util: System time updated successfully. May 11 08:36:53 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:53 smsl-n100 systemd[1]: Started Volumio Time Update Utility. May 11 08:36:53 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:53 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:53 smsl-n100 dhcpcd[976]: wlan0: rebinding lease of 192.168.0.22 May 11 08:36:53 smsl-n100 dhcpcd[976]: wlan0: probing address 192.168.0.22/24 May 11 08:36:53 smsl-n100 wireless.js[545]: trying... May 11 08:36:53 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:53 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:53 smsl-n100 sudo[1010]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 11 08:36:53 smsl-n100 sudo[1010]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 08:36:53 smsl-n100 sudo[1010]: pam_unix(sudo:session): session closed for user root May 11 08:36:53 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:53 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:53 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:53 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:53 smsl-n100 ntpd[975]: Soliciting pool server 162.159.200.1 May 11 08:36:53 smsl-n100 ntpd[975]: Soliciting pool server 139.162.81.45 May 11 08:36:53 smsl-n100 ntpd[975]: Soliciting pool server 103.131.151.20 May 11 08:36:53 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:53 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:53 smsl-n100 ntpd[975]: Soliciting pool server 162.159.200.123 May 11 08:36:53 smsl-n100 dhcpcd[976]: wlan0: soliciting an IPv6 router May 11 08:36:54 smsl-n100 wireless.js[545]: trying... May 11 08:36:54 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:54 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:54 smsl-n100 sudo[1013]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 11 08:36:54 smsl-n100 sudo[1013]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 08:36:54 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:54 smsl-n100 sudo[1013]: pam_unix(sudo:session): session closed for user root May 11 08:36:54 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:54 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:54 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:54 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:54 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:54 smsl-n100 ntpd[975]: Soliciting pool server 167.179.119.205 May 11 08:36:54 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:54 smsl-n100 ntpd[975]: Soliciting pool server 129.250.35.250 May 11 08:36:54 smsl-n100 ntpd[975]: Soliciting pool server 47.79.37.210 May 11 08:36:54 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:54 smsl-n100 ntpd[975]: Soliciting pool server 122.215.240.52 May 11 08:36:54 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:54 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:55 smsl-n100 wireless.js[545]: trying... May 11 08:36:55 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:55 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:55 smsl-n100 sudo[1019]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 11 08:36:55 smsl-n100 sudo[1019]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 08:36:55 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:55 smsl-n100 sudo[1019]: pam_unix(sudo:session): session closed for user root May 11 08:36:55 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:55 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:55 smsl-n100 ntpd[975]: Soliciting pool server 103.131.151.30 May 11 08:36:55 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:55 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:56 smsl-n100 wireless.js[545]: trying... May 11 08:36:56 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:56 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:56 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:56 smsl-n100 sudo[1022]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 11 08:36:56 smsl-n100 sudo[1022]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 08:36:56 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:56 smsl-n100 sudo[1022]: pam_unix(sudo:session): session closed for user root May 11 08:36:56 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:56 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:56 smsl-n100 ntpd[975]: Soliciting pool server 2406:da14:10c4:9aa0:123:: May 11 08:36:56 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:56 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:56 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:56 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:57 smsl-n100 wireless.js[545]: trying... May 11 08:36:57 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:57 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:57 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:57 smsl-n100 sudo[1025]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 11 08:36:57 smsl-n100 sudo[1025]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 08:36:57 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:57 smsl-n100 sudo[1025]: pam_unix(sudo:session): session closed for user root May 11 08:36:57 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:57 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:57 smsl-n100 dhcpcd[976]: wlan0: leased 192.168.0.22 for 86400 seconds May 11 08:36:57 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:57 smsl-n100 avahi-daemon[565]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.0.22. May 11 08:36:57 smsl-n100 dhcpcd[976]: wlan0: adding route to 192.168.0.0/24 May 11 08:36:57 smsl-n100 avahi-daemon[565]: New relevant interface wlan0.IPv4 for mDNS. May 11 08:36:57 smsl-n100 avahi-daemon[565]: Registering new address record for 192.168.0.22 on wlan0.IPv4. May 11 08:36:57 smsl-n100 dhcpcd[976]: wlan0: adding default route via 192.168.0.1 May 11 08:36:57 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:57 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:57 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:57 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:57 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:57 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:58 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:58 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:58 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:58 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:58 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:58 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:58 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:58 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:58 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:58 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:58 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:58 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:58 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:58 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:58 smsl-n100 wireless.js[545]: trying... May 11 08:36:58 smsl-n100 ntpd[975]: ntpd exiting on signal 15 (Terminated) May 11 08:36:58 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:58 smsl-n100 systemd[1]: Stopping Network Time Service... May 11 08:36:58 smsl-n100 ntpd[975]: 202.181.103.212 local addr 192.168.0.21 -> May 11 08:36:58 smsl-n100 systemd[1]: ntp.service: Succeeded. May 11 08:36:58 smsl-n100 ntpd[975]: 172.237.12.44 local addr 192.168.0.21 -> May 11 08:36:58 smsl-n100 systemd[1]: Stopped Network Time Service. May 11 08:36:58 smsl-n100 ntpd[975]: 129.250.35.251 local addr 192.168.0.21 -> May 11 08:36:58 smsl-n100 ntpd[975]: 133.130.121.141 local addr 192.168.0.21 -> May 11 08:36:58 smsl-n100 ntpd[975]: 45.76.211.39 local addr 192.168.0.21 -> May 11 08:36:58 smsl-n100 ntpd[975]: 160.16.113.133 local addr 192.168.0.21 -> May 11 08:36:58 smsl-n100 ntpd[975]: 162.159.200.1 local addr 192.168.0.21 -> May 11 08:36:58 smsl-n100 ntpd[975]: 139.162.81.45 local addr 192.168.0.21 -> May 11 08:36:58 smsl-n100 ntpd[975]: 103.131.151.20 local addr 192.168.0.21 -> May 11 08:36:58 smsl-n100 ntpd[975]: 162.159.200.123 local addr 192.168.0.21 -> May 11 08:36:58 smsl-n100 ntpd[975]: 129.250.35.250 local addr 192.168.0.21 -> May 11 08:36:58 smsl-n100 ntpd[975]: 47.79.37.210 local addr 192.168.0.21 -> May 11 08:36:58 smsl-n100 ntpd[975]: 122.215.240.52 local addr 192.168.0.21 -> May 11 08:36:58 smsl-n100 ntpd[975]: 103.131.151.30 local addr 192.168.0.21 -> May 11 08:36:58 smsl-n100 systemd[1]: Starting Network Time Service... May 11 08:36:58 smsl-n100 sudo[1058]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r May 11 08:36:58 smsl-n100 sudo[1058]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 08:36:58 smsl-n100 sudo[1058]: pam_unix(sudo:session): session closed for user root May 11 08:36:58 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:58 smsl-n100 wireless.js[545]: Connected to: ----yuremo8 May 11 08:36:58 smsl-n100 wireless.js[545]: ---- May 11 08:36:58 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:58 smsl-n100 ntpd[1061]: ntpd 4.2.8p12@1.3728-o (1): Starting May 11 08:36:58 smsl-n100 ntpd[1061]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 May 11 08:36:58 smsl-n100 systemd[1]: Started Network Time Service. May 11 08:36:58 smsl-n100 ntpd[1070]: proto: precision = 1.166 usec (-20) May 11 08:36:58 smsl-n100 ntpd[1070]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature May 11 08:36:58 smsl-n100 ntpd[1070]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 May 11 08:36:58 smsl-n100 ntpd[1070]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 865 days ago May 11 08:36:58 smsl-n100 ntpd[1070]: Listen and drop on 0 v6wildcard [::]:123 May 11 08:36:58 smsl-n100 ntpd[1070]: Listen and drop on 1 v4wildcard 0.0.0.0:123 May 11 08:36:58 smsl-n100 ntpd[1070]: Listen normally on 2 lo 127.0.0.1:123 May 11 08:36:58 smsl-n100 ntpd[1070]: Listen normally on 3 eth0 192.168.0.21:123 May 11 08:36:58 smsl-n100 ntpd[1070]: Listen normally on 4 wlan0 192.168.0.22:123 May 11 08:36:58 smsl-n100 ntpd[1070]: Listening on routing socket on fd #21 for interface updates May 11 08:36:58 smsl-n100 ntpd[1070]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized May 11 08:36:58 smsl-n100 ntpd[1070]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized May 11 08:36:58 smsl-n100 sudo[1068]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 11 08:36:58 smsl-n100 sudo[1068]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 08:36:58 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:58 smsl-n100 sudo[1068]: pam_unix(sudo:session): session closed for user root May 11 08:36:58 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:58 smsl-n100 wireless.js[545]: ... joined AP, wlan0 IPv4 is 192.168.0.22, ipV6 is undefined May 11 08:36:58 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:58 smsl-n100 wireless.js[545]: It's done! AP May 11 08:36:58 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:58 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:58 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:58 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:58 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:58 smsl-n100 iwconfig[1075]: Error for wireless request "Set Power Management" (8B2C) : May 11 08:36:58 smsl-n100 iwconfig[1075]: SET failed on device wlan0 ; Operation not permitted. May 11 08:36:58 smsl-n100 systemd[1]: Started Wireless Services. May 11 08:36:58 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:58 smsl-n100 systemd[1]: Started Volumio Backend Module. May 11 08:36:58 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:58 smsl-n100 systemd[1]: Started Volumio Cpu Tweaker. May 11 08:36:58 smsl-n100 systemd[1]: Reached target Multi-User System. May 11 08:36:58 smsl-n100 systemd[1]: Reached target Graphical Interface. May 11 08:36:58 smsl-n100 systemd[1]: Starting Update UTMP about System Runlevel Changes... May 11 08:36:58 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:58 smsl-n100 systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. May 11 08:36:58 smsl-n100 systemd[1]: Started Update UTMP about System Runlevel Changes. May 11 08:36:58 smsl-n100 kernel: vdd_arm: ramp_delay not set May 11 08:36:58 smsl-n100 systemd[1]: Startup finished in 5.607s (kernel) + 27.408s (userspace) = 33.015s. May 11 08:36:58 smsl-n100 volumio-cpu-tweak[1077]: Setting RT Priority for mpd May 11 08:36:58 smsl-n100 volumio-cpu-tweak[1077]: Setting MPD Affinity May 11 08:36:58 smsl-n100 volumio-cpu-tweak[1077]: pid 764's current affinity mask: f May 11 08:36:58 smsl-n100 volumio-cpu-tweak[1077]: pid 764's new affinity mask: 3 May 11 08:36:58 smsl-n100 volumio-cpu-tweak[1077]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input May 11 08:36:58 smsl-n100 volumio-cpu-tweak[1077]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance May 11 08:36:58 smsl-n100 systemd[1]: volumio_cpu_tweak.service: Succeeded. May 11 08:36:59 smsl-n100 ntpd[1070]: Soliciting pool server 202.181.103.212 May 11 08:37:00 smsl-n100 volumio-remote-updater[547]: [2025-05-11 08:37:00] [info] asio async_connect error: system:111 (Connection refused) May 11 08:37:00 smsl-n100 volumio-remote-updater[547]: [2025-05-11 08:37:00] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) May 11 08:37:00 smsl-n100 volumio-remote-updater[547]: [2025-05-11 08:37:00] [error] handle_connect error: Underlying Transport Error May 11 08:37:00 smsl-n100 ntpd[1070]: Soliciting pool server 172.237.12.44 May 11 08:37:00 smsl-n100 ntpd[1070]: Soliciting pool server 139.162.81.45 May 11 08:37:01 smsl-n100 ntpd[1070]: Soliciting pool server 129.250.35.251 May 11 08:37:01 smsl-n100 ntpd[1070]: Soliciting pool server 45.76.211.39 May 11 08:37:01 smsl-n100 ntpd[1070]: Soliciting pool server 129.250.35.250 May 11 08:37:02 smsl-n100 ntpd[1070]: Soliciting pool server 160.16.113.133 May 11 08:37:02 smsl-n100 ntpd[1070]: Soliciting pool server 133.130.121.141 May 11 08:37:02 smsl-n100 ntpd[1070]: Soliciting pool server 103.131.151.20 May 11 08:37:02 smsl-n100 ntpd[1070]: Soliciting pool server 162.159.200.123 May 11 08:37:02 smsl-n100 volumio[1076]: info: ------------------------------------------- May 11 08:37:02 smsl-n100 volumio[1076]: info: ----- Volumio3 ---- May 11 08:37:02 smsl-n100 volumio[1076]: info: ------------------------------------------- May 11 08:37:02 smsl-n100 volumio[1076]: info: ----- System startup ---- May 11 08:37:02 smsl-n100 volumio[1076]: info: ------------------------------------------- May 11 08:37:03 smsl-n100 ntpd[1070]: Soliciting pool server 167.179.119.205 May 11 08:37:03 smsl-n100 ntpd[1070]: Soliciting pool server 162.159.200.1 May 11 08:37:03 smsl-n100 ntpd[1070]: Soliciting pool server 138.3.216.120 May 11 08:37:04 smsl-n100 ntpd[1070]: Soliciting pool server 23.81.40.154 May 11 08:37:04 smsl-n100 ntpd[1070]: Soliciting pool server 122.215.240.51 May 11 08:37:04 smsl-n100 volumio[1076]: info: MYVOLUMIO Environment detected May 11 08:37:04 smsl-n100 systemd[1]: systemd-fsckd.service: Succeeded. May 11 08:37:04 smsl-n100 volumio[1076]: info: Plugin folders cleanup May 11 08:37:04 smsl-n100 volumio[1076]: info: Scanning into folder /volumio/app/plugins/ May 11 08:37:04 smsl-n100 volumio[1076]: info: Scanning category audio_interface May 11 08:37:04 smsl-n100 volumio[1076]: info: Scanning category miscellanea May 11 08:37:04 smsl-n100 volumio[1076]: info: Scanning category music_service May 11 08:37:04 smsl-n100 volumio[1076]: info: Scanning category plugins.json May 11 08:37:04 smsl-n100 volumio[1076]: info: Scanning category system_controller May 11 08:37:04 smsl-n100 volumio[1076]: info: Scanning category user_interface May 11 08:37:04 smsl-n100 volumio[1076]: info: Scanning into folder /data/plugins/ May 11 08:37:04 smsl-n100 volumio[1076]: info: Plugin folders cleanup completed May 11 08:37:04 smsl-n100 volumio[1076]: info: ------------------------------------------- May 11 08:37:04 smsl-n100 volumio[1076]: info: ----- Core plugins startup ---- May 11 08:37:04 smsl-n100 volumio[1076]: info: ------------------------------------------- May 11 08:37:04 smsl-n100 volumio[1076]: info: Loading plugins from folder /volumio/app/plugins/ May 11 08:37:04 smsl-n100 volumio[1076]: info: Adding plugin bluetooth to MyMusic Plugins May 11 08:37:04 smsl-n100 volumio[1076]: info: Adding plugin multiroom to MyMusic Plugins May 11 08:37:04 smsl-n100 volumio[1076]: info: Adding plugin upnp to MyMusic Plugins May 11 08:37:05 smsl-n100 volumio[1076]: info: Adding plugin metavolumio to MyMusic Plugins May 11 08:37:05 smsl-n100 volumio[1076]: info: Adding plugin airplay_emulation to MyMusic Plugins May 11 08:37:05 smsl-n100 volumio[1076]: info: Adding plugin cd_controller to MyMusic Plugins May 11 08:37:05 smsl-n100 volumio[1076]: info: Adding plugin raat to MyMusic Plugins May 11 08:37:05 smsl-n100 volumio[1076]: info: Adding plugin smart_inputs to MyMusic Plugins May 11 08:37:05 smsl-n100 volumio[1076]: info: Adding plugin tidalconnect to MyMusic Plugins May 11 08:37:05 smsl-n100 volumio[1076]: info: Adding plugin upnp_browser to MyMusic Plugins May 11 08:37:05 smsl-n100 volumio[1076]: info: Loading plugins from folder /data/plugins/ May 11 08:37:05 smsl-n100 volumio[1076]: info: Loading plugin "system"... May 11 08:37:05 smsl-n100 volumio[1076]: info: Loading plugin "appearance"... May 11 08:37:05 smsl-n100 ntpd[1070]: Soliciting pool server 2400:8902::f03c:91ff:fe50:f5f0 May 11 08:37:05 smsl-n100 ntpd[1070]: Soliciting pool server 47.79.37.210 May 11 08:37:07 smsl-n100 volumio[1076]: info: Loading plugin "network"... May 11 08:37:07 smsl-n100 volumio[1076]: info: Refreshing Cached IP Addresses May 11 08:37:07 smsl-n100 sudo[1111]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 11 08:37:07 smsl-n100 sudo[1111]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 08:37:07 smsl-n100 sudo[1111]: pam_unix(sudo:session): session closed for user root May 11 08:37:07 smsl-n100 sudo[1113]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 11 08:37:07 smsl-n100 sudo[1113]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 08:37:07 smsl-n100 volumio[1076]: info: Loading plugin "services"... May 11 08:37:07 smsl-n100 sudo[1113]: pam_unix(sudo:session): session closed for user root May 11 08:37:07 smsl-n100 volumio[1076]: info: Loading plugin "alsa_controller"... May 11 08:37:07 smsl-n100 sudo[1122]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan May 11 08:37:07 smsl-n100 sudo[1122]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 08:37:07 smsl-n100 volumio[1076]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 11 08:37:07 smsl-n100 volumio[1076]: info: Loading plugin "wizard"... May 11 08:37:07 smsl-n100 volumio[1076]: info: Loading plugin "networkfs"... May 11 08:37:08 smsl-n100 volumio[1076]: info: Starting Udev Watcher for removable devices May 11 08:37:08 smsl-n100 sudo[1137]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.0.12/NAS /mnt/NAS/NAS May 11 08:37:08 smsl-n100 sudo[1137]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 08:37:08 smsl-n100 sudo[1139]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.0.12/USB /mnt/NAS/USB May 11 08:37:08 smsl-n100 sudo[1139]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 08:37:08 smsl-n100 volumio[1076]: info: Ignoring mount for partition: boot May 11 08:37:08 smsl-n100 volumio[1076]: info: Ignoring mount for partition: volumio May 11 08:37:08 smsl-n100 volumio[1076]: info: Ignoring mount for partition: volumio_data May 11 08:37:08 smsl-n100 volumio[1076]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 11 08:37:08 smsl-n100 volumio[1076]: info: Loading plugin "volumio_command_line_client"... May 11 08:37:08 smsl-n100 kernel: FS-Cache: Loaded May 11 08:37:08 smsl-n100 volumio[1076]: info: Loading plugin "upnp"... May 11 08:37:08 smsl-n100 volumio[1076]: info: [1746920228234] Starting Upmpd Daemon May 11 08:37:08 smsl-n100 volumio[1076]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 11 08:37:08 smsl-n100 volumio[1076]: info: Loading plugin "my_music"... May 11 08:37:08 smsl-n100 volumio[1076]: info: Loading plugin "mpd"... May 11 08:37:08 smsl-n100 kernel: FS-Cache: Netfs 'cifs' registered for caching May 11 08:37:08 smsl-n100 kernel: Key type cifs.spnego registered May 11 08:37:08 smsl-n100 kernel: Key type cifs.idmap registered May 11 08:37:08 smsl-n100 kernel: CIFS: Attempting to mount //192.168.0.12/USB May 11 08:37:08 smsl-n100 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 11 08:37:08 smsl-n100 kernel: CIFS: Attempting to mount //192.168.0.12/NAS May 11 08:37:08 smsl-n100 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 11 08:37:09 smsl-n100 volumio[1076]: info: Loading plugin "upnp_browser"... May 11 08:37:10 smsl-n100 ntpd[1070]: receive: Unexpected origin timestamp 0xebca61a5.47a62f3a does not match aorg 0000000000.00000000 from server@129.250.35.251 xmt 0xebca61a6.10301941 May 11 08:37:10 smsl-n100 ntpd[1070]: receive: Unexpected origin timestamp 0xebca61a5.47a392ee does not match aorg 0000000000.00000000 from server@129.250.35.250 xmt 0xebca61a6.110cf828 May 11 08:37:10 smsl-n100 ntpd[1070]: receive: Unexpected origin timestamp 0xebca61a5.47ab2cf5 does not match aorg 0000000000.00000000 from server@172.237.12.44 xmt 0xebca61a6.11f188b4 May 11 08:37:10 smsl-n100 ntpd[1070]: receive: Unexpected origin timestamp 0xebca61a5.47a89941 does not match aorg 0000000000.00000000 from server@139.162.81.45 xmt 0xebca61a6.11f3d0bf May 11 08:37:10 smsl-n100 ntpd[1070]: receive: Unexpected origin timestamp 0xebca61a5.47890f02 does not match aorg 0000000000.00000000 from server@138.3.216.120 xmt 0xebca61a6.12191522 May 11 08:37:10 smsl-n100 ntpd[1070]: receive: Unexpected origin timestamp 0xebca61a5.47adabaf does not match aorg 0000000000.00000000 from server@202.181.103.212 xmt 0xebca61a6.1207e66b May 11 08:37:10 smsl-n100 ntpd[1070]: receive: Unexpected origin timestamp 0xebca61a5.479feb58 does not match aorg 0000000000.00000000 from server@133.130.121.141 xmt 0xebca61a6.12354c9c May 11 08:37:10 smsl-n100 ntpd[1070]: receive: Unexpected origin timestamp 0xebca61a5.479109c3 does not match aorg 0000000000.00000000 from server@103.131.151.20 xmt 0xebca61a6.11524bfd May 11 08:37:10 smsl-n100 ntpd[1070]: receive: Unexpected origin timestamp 0xebca61a5.47937352 does not match aorg 0000000000.00000000 from server@160.16.113.133 xmt 0xebca61a6.1214a69c May 11 08:37:10 smsl-n100 ntpd[1070]: receive: Unexpected origin timestamp 0xebca61a5.4777a08c does not match aorg 0000000000.00000000 from server@23.81.40.154 xmt 0xebca61a6.11f43c8c May 11 08:37:10 smsl-n100 volumio[1076]: info: Plugin bluetooth is not enabled May 11 08:37:10 smsl-n100 volumio[1076]: info: Loading plugin "alarm-clock"... May 11 08:37:10 smsl-n100 volumio-remote-updater[547]: [2025-05-11 08:37:10] [connect] Successful connection May 11 08:37:11 smsl-n100 volumio[1076]: info: Loading plugin "manifestui"... May 11 08:37:11 smsl-n100 volumio[1076]: info: Loading plugin "metavolumio"... May 11 08:37:13 smsl-n100 sudo[1122]: pam_unix(sudo:session): session closed for user root May 11 08:37:14 smsl-n100 volumio[1076]: info: Loading plugin "airplay_emulation"... May 11 08:37:14 smsl-n100 volumio[1076]: info: Starting Shairport Sync May 11 08:37:14 smsl-n100 volumio[1076]: info: Plugin cd_controller is not enabled May 11 08:37:14 smsl-n100 volumio[1076]: info: Loading plugin "last_100"... May 11 08:37:14 smsl-n100 volumio[1076]: info: Plugin raat is not enabled May 11 08:37:14 smsl-n100 volumio[1076]: info: Loading plugin "streaming_services"... May 11 08:37:15 smsl-n100 kernel: CIFS VFS: Error connecting to socket. Aborting operation. May 11 08:37:15 smsl-n100 kernel: CIFS VFS: Error connecting to socket. Aborting operation. May 11 08:37:15 smsl-n100 kernel: CIFS VFS: cifs_mount failed w/return code = -113 May 11 08:37:15 smsl-n100 kernel: CIFS VFS: cifs_mount failed w/return code = -113 May 11 08:37:15 smsl-n100 sudo[1139]: pam_unix(sudo:session): session closed for user root May 11 08:37:15 smsl-n100 sudo[1137]: pam_unix(sudo:session): session closed for user root May 11 08:37:16 smsl-n100 volumio[1076]: info: Starting Streaming Service Transparent Proxy May 11 08:37:16 smsl-n100 volumio[1076]: info: Plugin tidalconnect is not enabled May 11 08:37:16 smsl-n100 volumio[1076]: info: Loading plugin "webradio"... May 11 08:37:16 smsl-n100 volumio[1076]: info: Loading plugin "i2s_dacs"... May 11 08:37:16 smsl-n100 volumio[1076]: info: I2S DAC not set, start Auto-detection May 11 08:37:16 smsl-n100 volumio[1076]: info: Loading plugin "volumiodiscovery"... May 11 08:37:16 smsl-n100 volumio[1076]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 11 08:37:16 smsl-n100 node[1076]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 11 08:37:16 smsl-n100 node[1076]: *** WARNING *** Please fix your application to use the native API of Avahi! May 11 08:37:16 smsl-n100 volumio[1076]: *** WARNING *** Please fix your application to use the native API of Avahi! May 11 08:37:16 smsl-n100 volumio[1076]: *** WARNING *** For more information see May 11 08:37:16 smsl-n100 volumio[1076]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 11 08:37:16 smsl-n100 volumio[1076]: *** WARNING *** Please fix your application to use the native API of Avahi! May 11 08:37:16 smsl-n100 volumio[1076]: *** WARNING *** For more information see May 11 08:37:16 smsl-n100 node[1076]: *** WARNING *** For more information see May 11 08:37:16 smsl-n100 node[1076]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 11 08:37:16 smsl-n100 node[1076]: *** WARNING *** Please fix your application to use the native API of Avahi! May 11 08:37:16 smsl-n100 node[1076]: *** WARNING *** For more information see May 11 08:37:16 smsl-n100 volumio[1076]: info: Applying required configuration parameters for plugin volumiodiscovery May 11 08:37:16 smsl-n100 volumio[1076]: info: Discovery: Started advertising with name: SMSL N100 May 11 08:37:17 smsl-n100 volumio[1076]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 11 08:37:17 smsl-n100 volumio[1076]: info: Plugin multiroom is not enabled May 11 08:37:17 smsl-n100 volumio[1076]: info: Loading plugin "outputs"... May 11 08:37:17 smsl-n100 volumio[1076]: info: Loading plugin "albumart"... May 11 08:37:17 smsl-n100 volumio[1076]: info: Plugin example_plugin is not enabled May 11 08:37:17 smsl-n100 volumio[1076]: info: Loading plugin "hi_res_audio"... May 11 08:37:17 smsl-n100 volumio[1076]: Forking 3 albumart workers May 11 08:37:19 smsl-n100 volumio[1076]: STREAMING PROXY: Starting server on port 3245 May 11 08:37:19 smsl-n100 volumio[1076]: Node JS runtime: 14 May 11 08:37:20 smsl-n100 volumio[1076]: Starting albumart workers May 11 08:37:20 smsl-n100 volumio[1076]: Starting albumart workers May 11 08:37:20 smsl-n100 volumio[1076]: Starting albumart workers May 11 08:37:21 smsl-n100 volumio[1076]: info: Applying required configuration parameters for plugin hi_res_audio May 11 08:37:21 smsl-n100 volumio[1076]: info: Loading plugin "inputs"... May 11 08:37:23 smsl-n100 volumio[1076]: info: Loading plugin "qobuz"... May 11 08:37:23 smsl-n100 systemd[1]: systemd-timedated.service: Succeeded. May 11 08:37:25 smsl-n100 volumio[1076]: info: Loading plugin "smart_inputs"... May 11 08:37:25 smsl-n100 volumio-remote-updater[547]: [2025-05-11 08:37:25] [connect] Successful connection May 11 08:37:26 smsl-n100 volumio[1076]: info: Loading plugin "tidal"... May 11 08:37:28 smsl-n100 volumio[1076]: info: Loading plugin "oem_helper"... May 11 08:37:30 smsl-n100 volumio[1076]: info: Applying required configuration parameters for plugin oem_helper May 11 08:37:30 smsl-n100 volumio[1076]: info: Loading plugin "smslcontrol"... May 11 08:37:31 smsl-n100 kernel: gpio gpiochip0: Persistence not supported for GPIO 5 May 11 08:37:31 smsl-n100 volumio[1076]: info: Adding this device properties May 11 08:37:31 smsl-n100 volumio[1076]: info: CoreCommandRouter::executeOnPlugin: system , setThisDeviceVolumioProperties May 11 08:37:31 smsl-n100 volumio[1076]: info: Setting Additional Device Volumio Properties: [object Object] May 11 08:37:31 smsl-n100 volumio[1076]: info: Loading plugin "updater_comm"... May 11 08:37:31 smsl-n100 volumio[1076]: info: Plugin mpdemulation is not enabled May 11 08:37:31 smsl-n100 volumio[1076]: info: Loading plugin "rest_api"... May 11 08:37:31 smsl-n100 volumio[1076]: info: Loading plugin "websocket"... May 11 08:37:31 smsl-n100 volumio[1076]: info: Starting Socket.io Server version 2.3.0 May 11 08:37:31 smsl-n100 volumio[1076]: info: Loading i18n strings for locale ja May 11 08:37:31 smsl-n100 volumio[1076]: Updating browse sources language May 11 08:37:31 smsl-n100 volumio[1076]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 11 08:37:32 smsl-n100 volumio[1076]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 11 08:37:32 smsl-n100 volumio[1076]: info: CoreCommandRouter::initPlayerControls May 11 08:37:32 smsl-n100 volumio[1076]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 08:37:32 smsl-n100 volumio[1076]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 08:37:32 smsl-n100 volumio[1076]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 08:37:32 smsl-n100 volumio[1076]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 08:37:32 smsl-n100 volumio[1076]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 08:37:32 smsl-n100 volumio[1076]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 08:37:32 smsl-n100 volumio[1076]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 08:37:32 smsl-n100 volumio[1076]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 08:37:32 smsl-n100 volumio[1076]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 11 08:37:32 smsl-n100 volumio[1076]: Express server listening on port 3000 May 11 08:37:32 smsl-n100 volumio[1076]: [Metrics] WebUI: 29s 943.77ms May 11 08:37:32 smsl-n100 volumio[1076]: info: CoreStateMachine::resetVolumioState May 11 08:37:32 smsl-n100 volumio[1076]: info: CoreStateMachine::getcurrentVolume May 11 08:37:32 smsl-n100 volumio[1076]: info: CoreCommandRouter::volumioRetrievevolume May 11 08:37:32 smsl-n100 volumio[1076]: info: CoreStateMachine::pushState May 11 08:37:32 smsl-n100 volumio[1076]: info: CorePlayQueue::getTrack 0 May 11 08:37:32 smsl-n100 volumio[1076]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 11 08:37:32 smsl-n100 volumio[1076]: info: CoreCommandRouter::volumioPushState May 11 08:37:32 smsl-n100 volumio[1076]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 11 08:37:32 smsl-n100 sudo[1268]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 11 08:37:32 smsl-n100 sudo[1268]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 08:37:32 smsl-n100 sudo[1268]: pam_unix(sudo:session): session closed for user root May 11 08:37:32 smsl-n100 sudo[1270]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 11 08:37:32 smsl-n100 sudo[1270]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 08:37:32 smsl-n100 volumio[1076]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' May 11 08:37:32 smsl-n100 volumio[1076]: info: Completed loading Core Plugins May 11 08:37:32 smsl-n100 volumio[1076]: info: Preparing to generate the ALSA configuration file May 11 08:37:32 smsl-n100 sudo[1270]: pam_unix(sudo:session): session closed for user root May 11 08:37:32 smsl-n100 volumio[1076]: info: Volumio Network Manager: Network status updated: 3 May 11 08:37:32 smsl-n100 volumio[1076]: info: Cannot mount NAS USB at system boot, trial number 1 ,retrying in 5 seconds May 11 08:37:32 smsl-n100 volumio[1076]: info: Cannot mount NAS NAS at system boot, trial number 1 ,retrying in 5 seconds May 11 08:37:32 smsl-n100 volumio[1076]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision May 11 08:37:32 smsl-n100 volumio[1076]: info: Reloading queue from file May 11 08:37:32 smsl-n100 volumio[1076]: info: Asound.conf file unchanged, so no further update is needed May 11 08:37:32 smsl-n100 volumio[1076]: info: Output device has changed, restarting MPD May 11 08:37:32 smsl-n100 sudo[1279]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 11 08:37:32 smsl-n100 sudo[1279]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 08:37:32 smsl-n100 volumio[1076]: info: Output device has changed, restarting Shairport Sync May 11 08:37:32 smsl-n100 volumio[1076]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 08:37:32 smsl-n100 volumio[1076]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 11 08:37:32 smsl-n100 sudo[1279]: pam_unix(sudo:session): session closed for user root May 11 08:37:32 smsl-n100 sudo[1281]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 11 08:37:32 smsl-n100 sudo[1281]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 08:37:32 smsl-n100 systemd[1]: Stopping Music Player Daemon... May 11 08:37:32 smsl-n100 volumio[1076]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 11 08:37:32 smsl-n100 volumio[1076]: info: ___________ START PLUGINS ___________ May 11 08:37:32 smsl-n100 volumio[1076]: info: ControllerMpd::onStart: Initializing MPD May 11 08:37:32 smsl-n100 volumio[1076]: info: Creating MPD Configuration file May 11 08:37:33 smsl-n100 sudo[1288]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 11 08:37:33 smsl-n100 volumio[1076]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 11 08:37:33 smsl-n100 volumio[1076]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 11 08:37:33 smsl-n100 volumio[1076]: info: [1746920253054] CoreMusicLibrary::Adding element DLNAサーバー May 11 08:37:33 smsl-n100 volumio[1076]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 11 08:37:33 smsl-n100 sudo[1288]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 08:37:33 smsl-n100 sudo[1288]: pam_unix(sudo:session): session closed for user root May 11 08:37:33 smsl-n100 sudo[1290]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 11 08:37:33 smsl-n100 sudo[1290]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 08:37:33 smsl-n100 volumio[1076]: info: Adding METAVOLUMIO REST API Endpoints May 11 08:37:33 smsl-n100 volumio[1076]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio May 11 08:37:33 smsl-n100 volumio[1076]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio May 11 08:37:33 smsl-n100 volumio[1076]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio May 11 08:37:33 smsl-n100 volumio[1076]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio May 11 08:37:33 smsl-n100 volumio[1076]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 08:37:33 smsl-n100 volumio[1076]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 11 08:37:33 smsl-n100 volumio[1076]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 11 08:37:33 smsl-n100 volumio[1076]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 08:37:33 smsl-n100 volumio[1076]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 11 08:37:33 smsl-n100 systemd[1]: mpd.service: Succeeded. May 11 08:37:33 smsl-n100 systemd[1]: Stopped Music Player Daemon. May 11 08:37:33 smsl-n100 systemd[1]: Starting Music Player Daemon... May 11 08:37:33 smsl-n100 volumio[1076]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 11 08:37:33 smsl-n100 volumio[1076]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 11 08:37:33 smsl-n100 volumio[1076]: info: [1746920253347] CoreMusicLibrary::Adding element Last_100 May 11 08:37:33 smsl-n100 volumio[1076]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 11 08:37:33 smsl-n100 volumio[1076]: info: Streaming services startup May 11 08:37:33 smsl-n100 volumio[1076]: info: Starting Streaming Daemon May 11 08:37:33 smsl-n100 sudo[1301]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service May 11 08:37:33 smsl-n100 sudo[1301]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 08:37:33 smsl-n100 sudo[1297]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 11 08:37:33 smsl-n100 sudo[1297]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 08:37:33 smsl-n100 sudo[1297]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory May 11 08:37:33 smsl-n100 sudo[1301]: pam_unix(sudo:session): session closed for user root May 11 08:37:33 smsl-n100 volumio[1076]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 11 08:37:33 smsl-n100 volumio[1076]: info: [1746920253491] CoreMusicLibrary::Adding element Webradio May 11 08:37:33 smsl-n100 sudo[1297]: pam_unix(sudo:session): session closed for user root May 11 08:37:33 smsl-n100 volumio[1076]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 11 08:37:33 smsl-n100 volumio[1076]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 11 08:37:33 smsl-n100 volumio[1076]: info: Initializing BBC Radios May 11 08:37:33 smsl-n100 volumio[1076]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 11 08:37:33 smsl-n100 volumio[1076]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 11 08:37:33 smsl-n100 volumio[1076]: error: Hi Res Audio Failed Login: Missing Login Data May 11 08:37:33 smsl-n100 volumio[1076]: info: Adding HIGHRESAUDIO REST API Endpoints May 11 08:37:33 smsl-n100 volumio[1076]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio May 11 08:37:33 smsl-n100 volumio[1076]: info: Initializing Serial Communication on port /dev/ttyS1 May 11 08:37:33 smsl-n100 volumio[1076]: info: Touch Event Listener Process Starting May 11 08:37:33 smsl-n100 volumio[1076]: info: Adding inputs REST Endpoints May 11 08:37:33 smsl-n100 volumio[1076]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs May 11 08:37:33 smsl-n100 volumio[1076]: info: Scanning Audio Inputs May 11 08:37:33 smsl-n100 sudo[1320]: pam_unix(sudo:auth): conversation failed May 11 08:37:33 smsl-n100 sudo[1320]: pam_unix(sudo:auth): auth could not identify password for [volumio] May 11 08:37:33 smsl-n100 volumio[1076]: info: Checking against Known Cards name May 11 08:37:33 smsl-n100 volumio[1076]: info: Adding Server instance for streaming May 11 08:37:34 smsl-n100 volumio[1076]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 11 08:37:34 smsl-n100 volumio[1076]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 11 08:37:34 smsl-n100 volumio[1076]: info: Initializing GPIOs May 11 08:37:34 smsl-n100 kernel: gpio gpiochip3: Persistence not supported for GPIO 1 May 11 08:37:34 smsl-n100 kernel: gpio gpiochip2: Persistence not supported for GPIO 15 May 11 08:37:34 smsl-n100 kernel: gpio gpiochip3: Persistence not supported for GPIO 0 May 11 08:37:34 smsl-n100 kernel: gpio gpiochip2: Persistence not supported for GPIO 2 May 11 08:37:34 smsl-n100 volumio[1076]: info: Starting Button Listener May 11 08:37:34 smsl-n100 volumio[1076]: info: Turning off Green LED May 11 08:37:34 smsl-n100 volumio[1076]: info: Tuning on Blue LED May 11 08:37:34 smsl-n100 volumio[1076]: info: Signaling System Ready May 11 08:37:34 smsl-n100 volumio[1076]: info: Volumio Calling Home May 11 08:37:34 smsl-n100 volumio[1076]: info: Stopping AccessToken refresher cron for QOBUZ May 11 08:37:34 smsl-n100 volumio[1076]: info: AccessToken refresher cron started for QOBUZ May 11 08:37:34 smsl-n100 volumio[1076]: info: Stopping AccessToken refresher cron May 11 08:37:34 smsl-n100 volumio[1076]: info: AccessToken refresher cron started May 11 08:37:34 smsl-n100 volumio[1076]: info: Adding TIDAL REST API Endpoints May 11 08:37:34 smsl-n100 volumio[1076]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal May 11 08:37:34 smsl-n100 volumio[1076]: info: Adding QOBUZ REST API Endpoints May 11 08:37:34 smsl-n100 volumio[1076]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz May 11 08:37:34 smsl-n100 volumio[1076]: info: CoreStateMachine::setRepeat false single undefined May 11 08:37:34 smsl-n100 volumio[1076]: info: CoreStateMachine::pushState May 11 08:37:34 smsl-n100 volumio[1076]: info: CorePlayQueue::getTrack 0 May 11 08:37:34 smsl-n100 volumio[1076]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 11 08:37:34 smsl-n100 volumio[1076]: info: CoreCommandRouter::volumioPushState May 11 08:37:34 smsl-n100 volumio[1076]: info: CoreStateMachine::setRandom null May 11 08:37:34 smsl-n100 volumio[1076]: info: CoreStateMachine::pushState May 11 08:37:34 smsl-n100 volumio[1076]: info: CorePlayQueue::getTrack 0 May 11 08:37:34 smsl-n100 volumio[1076]: info: CoreCommandRouter::volumioPushState May 11 08:37:34 smsl-n100 volumio[1076]: info: Setting Device type: NanoPi NEO 3 May 11 08:37:34 smsl-n100 volumio[1076]: info: Serial port opened successfully May 11 08:37:34 smsl-n100 volumio[1076]: info: Sending serial start messages May 11 08:37:34 smsl-n100 volumio[1076]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 08:37:34 smsl-n100 volumio[1076]: info: Reporting MCU Network Status: 3 May 11 08:37:34 smsl-n100 volumio[1076]: info: Touch Event Listener Process Closed May 11 08:37:34 smsl-n100 volumio[1076]: error: Cannot start Volumio Streaming Daemon May 11 08:37:34 smsl-n100 volumio[1076]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service May 11 08:37:34 smsl-n100 volumio[1076]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. May 11 08:37:34 smsl-n100 volumio[1076]: info: MPD Permissions set May 11 08:37:34 smsl-n100 volumio[1076]: info: MPD Permissions set May 11 08:37:35 smsl-n100 volumio[1076]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setDeviceVolumeOverride May 11 08:37:35 smsl-n100 volumio[1076]: info: Setting Device Volume Override May 11 08:37:35 smsl-n100 volumio[1076]: info: CoreCommandRouter::volumioUpdateVolumeSettings May 11 08:37:35 smsl-n100 volumio[1076]: info: Updating Volume Controller Parameters: Device: 1 Name: SPDIF Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 May 11 08:37:35 smsl-n100 volumio[1076]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume May 11 08:37:35 smsl-n100 volumio[1076]: info: Disabling external Volume Control May 11 08:37:35 smsl-n100 volumio[1076]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 08:37:35 smsl-n100 volumio[1076]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 11 08:37:35 smsl-n100 volumio[1076]: info: CoreStateMachine::pushState May 11 08:37:35 smsl-n100 volumio[1076]: info: CorePlayQueue::getTrack 0 May 11 08:37:35 smsl-n100 volumio[1076]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 11 08:37:35 smsl-n100 volumio[1076]: info: CoreCommandRouter::volumioPushState May 11 08:37:35 smsl-n100 volumio[1076]: error: Serial API: Failed to decode command: 100, message: undefined May 11 08:37:35 smsl-n100 volumio[1076]: error: Serial API: Failed to decode command: MAXVOL, message: May 11 08:37:35 smsl-n100 volumio[1076]: error: Serial API: Failed to decode command: 100, message: undefined May 11 08:37:35 smsl-n100 volumio[1076]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff May 11 08:37:35 smsl-n100 volumio[1076]: info: CoreStateMachine::pushState May 11 08:37:35 smsl-n100 volumio[1076]: info: CorePlayQueue::getTrack 0 May 11 08:37:35 smsl-n100 volumio[1076]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 11 08:37:35 smsl-n100 volumio[1076]: info: CoreCommandRouter::volumioPushState May 11 08:37:35 smsl-n100 volumio[1076]: info: CoreStateMachine::pushState May 11 08:37:35 smsl-n100 sudo[1353]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service May 11 08:37:35 smsl-n100 volumio[1076]: info: CorePlayQueue::getTrack 0 May 11 08:37:35 smsl-n100 volumio[1076]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 11 08:37:35 smsl-n100 sudo[1353]: pam_unix(sudo:session): session opened for user root by (uid=0) May 11 08:37:35 smsl-n100 volumio[1076]: info: CoreCommandRouter::volumioPushState May 11 08:37:35 smsl-n100 volumio[1076]: error: Serial API: Failed to decode command: 100, message: undefined May 11 08:37:35 smsl-n100 volumio[1076]: error: Serial API: Failed to decode command: MAXVOL, message: May 11 08:37:35 smsl-n100 volumio[1076]: error: Serial API: Failed to decode command: 100, message: undefined May 11 08:37:35 smsl-n100 volumio[1076]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff May 11 08:37:35 smsl-n100 volumio[1076]: info: CoreStateMachine::pushState May 11 08:37:35 smsl-n100 volumio[1076]: info: CorePlayQueue::getTrack 0 May 11 08:37:35 smsl-n100 volumio[1076]: info: CoreCommandRouter::volumioPushState May 11 08:37:35 smsl-n100 volumio[1076]: error: Serial API: Failed to decode command: 100, message: undefined May 11 08:37:35 smsl-n100 volumio[1076]: error: Serial API: Failed to decode command: MAXVOL, message: May 11 08:37:35 smsl-n100 volumio[1076]: error: Serial API: Failed to decode command: 100, message: undefined May 11 08:37:35 smsl-n100 volumio[1076]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff May 11 08:37:35 smsl-n100 volumio[1076]: info: CoreStateMachine::pushState May 11 08:37:35 smsl-n100 volumio[1076]: info: CorePlayQueue::getTrack 0 May 11 08:37:35 smsl-n100 volumio[1076]: info: CoreCommandRouter::volumioPushState May 11 08:37:35 smsl-n100 volumio[1076]: error: Serial API: Failed to decode command: 100, message: undefined May 11 08:37:35 smsl-n100 volumio[1076]: error: Serial API: Failed to decode command: 3, message: undefined May 11 08:37:35 smsl-n100 volumio[1076]: info: Discovery: adding 2a96ea59-075c-4c4c-8bcd-0a4edfd023cf May 11 08:37:35 smsl-n100 volumio[1076]: info: Discovery: Found device SMSL N100 May 11 08:37:35 smsl-n100 systemd[1]: Started UPnP Renderer front-end to MPD. May 11 08:37:35 smsl-n100 volumio[1076]: info: CoreCommandRouter::volumioGetState May 11 08:37:35 smsl-n100 volumio[1076]: info: CorePlayQueue::getTrack 0 May 11 08:37:35 smsl-n100 volumio[1076]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 11 08:37:35 smsl-n100 sudo[1353]: pam_unix(sudo:session): session closed for user root May 11 08:37:35 smsl-n100 volumio[1076]: Error: The value NaN is not a number May 11 08:37:35 smsl-n100 volumio[1076]: at Config.forceToType (/volumio/node_modules/v-conf/index.js:322:20) May 11 08:37:35 smsl-n100 volumio[1076]: at Config.set (/volumio/node_modules/v-conf/index.js:153:25) May 11 08:37:35 smsl-n100 volumio[1076]: at ControllerVolumioDiscovery.updateMultiroomDevice (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:323:25) May 11 08:37:35 smsl-n100 volumio[1076]: at ControllerVolumioDiscovery.connectToRemoteVolumio (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:273:10) May 11 08:37:35 smsl-n100 volumio[1076]: at Browser. (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:192:12) May 11 08:37:35 smsl-n100 volumio[1076]: at Browser.emit (events.js:400:28) May 11 08:37:35 smsl-n100 volumio[1076]: at on_resolver_done (/volumio/node_modules/mdns/lib/browser.js:31:14) May 11 08:37:35 smsl-n100 volumio[1076]: at next (/volumio/node_modules/mdns/lib/browser.js:106:7) May 11 08:37:35 smsl-n100 volumio[1076]: at Array.makeAddressesUnique (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:177:5) May 11 08:37:35 smsl-n100 volumio[1076]: at next (/volumio/node_modules/mdns/lib/browser.js:109:21) May 11 08:37:35 smsl-n100 volumio[1076]: at /volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:160:11 May 11 08:37:35 smsl-n100 volumio[1076]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:108:7) May 11 08:37:35 smsl-n100 volumio[1076]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) May 11 08:37:35 smsl-n100 volumio[1076]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 11 08:37:36 smsl-n100 sudo[1367]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-11 08:36 May 11 08:37:36 smsl-n100 sudo[1367]: 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"