-- Logs begin at Thu 2019-02-14 18:11:59 CST, end at Thu 2025-11-06 00:07:00 CST. -- Nov 06 00:06:00 smsl-n100 kernel: vdd_arm: ramp_delay not set Nov 06 00:06:00 smsl-n100 kernel: vdd_arm: ramp_delay not set Nov 06 00:06:00 smsl-n100 wireless.js[539]: trying... Nov 06 00:06:00 smsl-n100 kernel: vdd_arm: ramp_delay not set Nov 06 00:06:00 smsl-n100 kernel: vdd_arm: ramp_delay not set Nov 06 00:06:00 smsl-n100 sudo[1071]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Nov 06 00:06:00 smsl-n100 sudo[1071]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 06 00:06:00 smsl-n100 kernel: vdd_arm: ramp_delay not set Nov 06 00:06:00 smsl-n100 sudo[1071]: pam_unix(sudo:session): session closed for user root Nov 06 00:06:00 smsl-n100 kernel: vdd_arm: ramp_delay not set Nov 06 00:06:00 smsl-n100 kernel: vdd_arm: ramp_delay not set Nov 06 00:06:00 smsl-n100 kernel: vdd_arm: ramp_delay not set Nov 06 00:06:00 smsl-n100 kernel: vdd_arm: ramp_delay not set Nov 06 00:06:01 smsl-n100 kernel: vdd_arm: ramp_delay not set Nov 06 00:06:01 smsl-n100 systemd[1]: systemd-fsckd.service: Succeeded. Nov 06 00:06:01 smsl-n100 kernel: vdd_arm: ramp_delay not set Nov 06 00:06:01 smsl-n100 kernel: vdd_arm: ramp_delay not set Nov 06 00:06:01 smsl-n100 kernel: vdd_arm: ramp_delay not set Nov 06 00:06:01 smsl-n100 wireless.js[539]: trying... Nov 06 00:06:01 smsl-n100 kernel: vdd_arm: ramp_delay not set Nov 06 00:06:01 smsl-n100 kernel: vdd_arm: ramp_delay not set Nov 06 00:06:01 smsl-n100 kernel: vdd_arm: ramp_delay not set Nov 06 00:06:01 smsl-n100 kernel: vdd_arm: ramp_delay not set Nov 06 00:06:01 smsl-n100 sudo[1074]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Nov 06 00:06:01 smsl-n100 sudo[1074]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 06 00:06:01 smsl-n100 sudo[1074]: pam_unix(sudo:session): session closed for user root Nov 06 00:06:01 smsl-n100 kernel: vdd_arm: ramp_delay not set Nov 06 00:06:01 smsl-n100 kernel: vdd_arm: ramp_delay not set Nov 06 00:06:01 smsl-n100 kernel: vdd_arm: ramp_delay not set Nov 06 00:06:02 smsl-n100 wireless.js[539]: trying... Nov 06 00:06:02 smsl-n100 kernel: vdd_arm: ramp_delay not set Nov 06 00:06:02 smsl-n100 kernel: vdd_arm: ramp_delay not set Nov 06 00:06:02 smsl-n100 kernel: vdd_arm: ramp_delay not set Nov 06 00:06:02 smsl-n100 kernel: vdd_arm: ramp_delay not set Nov 06 00:06:02 smsl-n100 sudo[1077]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Nov 06 00:06:02 smsl-n100 sudo[1077]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 06 00:06:02 smsl-n100 sudo[1077]: pam_unix(sudo:session): session closed for user root Nov 06 00:06:02 smsl-n100 kernel: vdd_arm: ramp_delay not set Nov 06 00:06:02 smsl-n100 kernel: vdd_arm: ramp_delay not set Nov 06 00:06:03 smsl-n100 wireless.js[539]: trying... Nov 06 00:06:03 smsl-n100 kernel: vdd_arm: ramp_delay not set Nov 06 00:06:03 smsl-n100 kernel: vdd_arm: ramp_delay not set Nov 06 00:06:03 smsl-n100 kernel: vdd_arm: ramp_delay not set Nov 06 00:06:03 smsl-n100 sudo[1080]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Nov 06 00:06:03 smsl-n100 sudo[1080]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 06 00:06:03 smsl-n100 kernel: vdd_arm: ramp_delay not set Nov 06 00:06:03 smsl-n100 sudo[1080]: pam_unix(sudo:session): session closed for user root Nov 06 00:06:03 smsl-n100 kernel: vdd_arm: ramp_delay not set Nov 06 00:06:04 smsl-n100 wireless.js[539]: trying... Nov 06 00:06:04 smsl-n100 kernel: vdd_arm: ramp_delay not set Nov 06 00:06:04 smsl-n100 kernel: vdd_arm: ramp_delay not set Nov 06 00:06:04 smsl-n100 kernel: vdd_arm: ramp_delay not set Nov 06 00:06:04 smsl-n100 kernel: vdd_arm: ramp_delay not set Nov 06 00:06:04 smsl-n100 sudo[1083]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Nov 06 00:06:04 smsl-n100 sudo[1083]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 06 00:06:04 smsl-n100 sudo[1083]: pam_unix(sudo:session): session closed for user root Nov 06 00:06:04 smsl-n100 kernel: vdd_arm: ramp_delay not set Nov 06 00:06:04 smsl-n100 kernel: vdd_arm: ramp_delay not set Nov 06 00:06:05 smsl-n100 wireless.js[539]: Overtime, starting plan B Nov 06 00:06:05 smsl-n100 kernel: vdd_arm: ramp_delay not set Nov 06 00:06:05 smsl-n100 kernel: vdd_arm: ramp_delay not set Nov 06 00:06:05 smsl-n100 kernel: vdd_arm: ramp_delay not set Nov 06 00:06:05 smsl-n100 kernel: vdd_arm: ramp_delay not set Nov 06 00:06:05 smsl-n100 kernel: vdd_arm: ramp_delay not set Nov 06 00:06:05 smsl-n100 kernel: vdd_arm: ramp_delay not set Nov 06 00:06:05 smsl-n100 iwconfig[1087]: Error for wireless request "Set Power Management" (8B2C) : Nov 06 00:06:05 smsl-n100 iwconfig[1087]: SET failed on device wlan0 ; Operation not permitted. Nov 06 00:06:05 smsl-n100 kernel: vdd_arm: ramp_delay not set Nov 06 00:06:05 smsl-n100 systemd[1]: Started Wireless Services. Nov 06 00:06:05 smsl-n100 systemd[1]: Started Volumio Backend Module. Nov 06 00:06:05 smsl-n100 systemd[1]: Started Volumio Cpu Tweaker. Nov 06 00:06:05 smsl-n100 systemd[1]: Reached target Multi-User System. Nov 06 00:06:05 smsl-n100 systemd[1]: Reached target Graphical Interface. Nov 06 00:06:05 smsl-n100 systemd[1]: Starting Update UTMP about System Runlevel Changes... Nov 06 00:06:05 smsl-n100 volumio-cpu-tweak[1089]: Setting RT Priority for mpd Nov 06 00:06:05 smsl-n100 systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Nov 06 00:06:05 smsl-n100 systemd[1]: Started Update UTMP about System Runlevel Changes. Nov 06 00:06:05 smsl-n100 volumio-cpu-tweak[1089]: Setting MPD Affinity Nov 06 00:06:05 smsl-n100 systemd[1]: Startup finished in 6.606s (kernel) + 38.459s (userspace) = 45.066s. Nov 06 00:06:05 smsl-n100 volumio-cpu-tweak[1089]: pid 785's current affinity mask: f Nov 06 00:06:05 smsl-n100 volumio-cpu-tweak[1089]: pid 785's new affinity mask: 3 Nov 06 00:06:05 smsl-n100 volumio-cpu-tweak[1089]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Nov 06 00:06:05 smsl-n100 volumio-cpu-tweak[1089]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Nov 06 00:06:05 smsl-n100 systemd[1]: volumio_cpu_tweak.service: Succeeded. Nov 06 00:06:06 smsl-n100 volumio-remote-updater[540]: [2025-11-06 00:06:06] [info] asio async_connect error: system:111 (Connection refused) Nov 06 00:06:06 smsl-n100 volumio-remote-updater[540]: [2025-11-06 00:06:06] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Nov 06 00:06:06 smsl-n100 volumio-remote-updater[540]: [2025-11-06 00:06:06] [error] handle_connect error: Underlying Transport Error Nov 06 00:06:10 smsl-n100 volumio[1088]: info: ------------------------------------------- Nov 06 00:06:10 smsl-n100 volumio[1088]: info: ----- Volumio3 ---- Nov 06 00:06:10 smsl-n100 volumio[1088]: info: ------------------------------------------- Nov 06 00:06:10 smsl-n100 volumio[1088]: info: ----- System startup ---- Nov 06 00:06:10 smsl-n100 volumio[1088]: info: ------------------------------------------- Nov 06 00:06:12 smsl-n100 volumio[1088]: info: MYVOLUMIO Environment detected Nov 06 00:06:12 smsl-n100 volumio[1088]: info: Plugin folders cleanup Nov 06 00:06:12 smsl-n100 volumio[1088]: info: Scanning into folder /volumio/app/plugins/ Nov 06 00:06:12 smsl-n100 volumio[1088]: info: Scanning category audio_interface Nov 06 00:06:12 smsl-n100 volumio[1088]: info: Scanning category miscellanea Nov 06 00:06:12 smsl-n100 volumio[1088]: info: Scanning category music_service Nov 06 00:06:12 smsl-n100 volumio[1088]: info: Scanning category plugins.json Nov 06 00:06:12 smsl-n100 volumio[1088]: info: Scanning category system_controller Nov 06 00:06:12 smsl-n100 volumio[1088]: info: Scanning category user_interface Nov 06 00:06:12 smsl-n100 volumio[1088]: info: Scanning into folder /data/plugins/ Nov 06 00:06:12 smsl-n100 volumio[1088]: info: Scanning category music_service Nov 06 00:06:12 smsl-n100 volumio[1088]: info: Plugin folders cleanup completed Nov 06 00:06:13 smsl-n100 volumio[1088]: info: ------------------------------------------- Nov 06 00:06:13 smsl-n100 volumio[1088]: info: ----- Core plugins startup ---- Nov 06 00:06:13 smsl-n100 volumio[1088]: info: ------------------------------------------- Nov 06 00:06:13 smsl-n100 volumio[1088]: info: Loading plugins from folder /volumio/app/plugins/ Nov 06 00:06:13 smsl-n100 volumio[1088]: info: Adding plugin bluetooth to MyMusic Plugins Nov 06 00:06:13 smsl-n100 volumio[1088]: info: Adding plugin multiroom to MyMusic Plugins Nov 06 00:06:13 smsl-n100 volumio[1088]: info: Adding plugin upnp to MyMusic Plugins Nov 06 00:06:13 smsl-n100 volumio[1088]: info: Adding plugin metavolumio to MyMusic Plugins Nov 06 00:06:13 smsl-n100 volumio[1088]: info: Adding plugin airplay_emulation to MyMusic Plugins Nov 06 00:06:13 smsl-n100 volumio[1088]: info: Adding plugin cd_controller to MyMusic Plugins Nov 06 00:06:13 smsl-n100 volumio[1088]: info: Adding plugin raat to MyMusic Plugins Nov 06 00:06:13 smsl-n100 volumio[1088]: info: Adding plugin smart_inputs to MyMusic Plugins Nov 06 00:06:13 smsl-n100 volumio[1088]: info: Adding plugin tidalconnect to MyMusic Plugins Nov 06 00:06:13 smsl-n100 volumio[1088]: info: Adding plugin upnp_browser to MyMusic Plugins Nov 06 00:06:13 smsl-n100 volumio[1088]: info: Loading plugins from folder /data/plugins/ Nov 06 00:06:13 smsl-n100 volumio[1088]: info: Loading plugin "system"... Nov 06 00:06:13 smsl-n100 volumio[1088]: info: Loading plugin "appearance"... Nov 06 00:06:16 smsl-n100 volumio[1088]: info: Loading plugin "network"... Nov 06 00:06:16 smsl-n100 volumio[1088]: info: Refreshing Cached IP Addresses Nov 06 00:06:16 smsl-n100 volumio[1088]: info: Loading plugin "services"... Nov 06 00:06:16 smsl-n100 volumio[1088]: info: Loading plugin "alsa_controller"... Nov 06 00:06:16 smsl-n100 volumio[1088]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 06 00:06:16 smsl-n100 volumio[1088]: info: Loading plugin "wizard"... Nov 06 00:06:16 smsl-n100 volumio[1088]: info: Loading plugin "networkfs"... Nov 06 00:06:16 smsl-n100 volumio[1088]: info: Starting Udev Watcher for removable devices Nov 06 00:06:16 smsl-n100 volumio[1088]: info: Ignoring mount for partition: boot Nov 06 00:06:16 smsl-n100 volumio[1088]: info: Ignoring mount for partition: volumio Nov 06 00:06:16 smsl-n100 volumio[1088]: info: Ignoring mount for partition: volumio_data Nov 06 00:06:16 smsl-n100 volumio[1088]: info: Mounting Device HIFI_Audio_HD-1 Nov 06 00:06:16 smsl-n100 volumio-remote-updater[540]: [2025-11-06 00:06:16] [connect] Successful connection Nov 06 00:06:16 smsl-n100 sudo[1132]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Nov 06 00:06:16 smsl-n100 sudo[1123]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 06 00:06:16 smsl-n100 sudo[1123]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 06 00:06:16 smsl-n100 sudo[1132]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 06 00:06:16 smsl-n100 sudo[1143]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/HIFI_Audio_HD-1 -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Nov 06 00:06:16 smsl-n100 sudo[1123]: pam_unix(sudo:session): session closed for user root Nov 06 00:06:16 smsl-n100 sudo[1143]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 06 00:06:16 smsl-n100 sudo[1138]: 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.1.54/USB /mnt/NAS/USB Nov 06 00:06:16 smsl-n100 sudo[1138]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 06 00:06:16 smsl-n100 sudo[1136]: 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.1.43/USB /mnt/NAS/USB Nov 06 00:06:16 smsl-n100 sudo[1136]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 06 00:06:16 smsl-n100 sudo[1125]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 06 00:06:16 smsl-n100 sudo[1125]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 06 00:06:16 smsl-n100 sudo[1125]: pam_unix(sudo:session): session closed for user root Nov 06 00:06:17 smsl-n100 kernel: FS-Cache: Loaded Nov 06 00:06:17 smsl-n100 kernel: FS-Cache: Netfs 'cifs' registered for caching Nov 06 00:06:17 smsl-n100 kernel: Key type cifs.spnego registered Nov 06 00:06:17 smsl-n100 kernel: Key type cifs.idmap registered Nov 06 00:06:17 smsl-n100 kernel: CIFS: Attempting to mount //192.168.1.43/USB Nov 06 00:06:17 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. Nov 06 00:06:17 smsl-n100 kernel: CIFS: Attempting to mount //192.168.1.54/USB Nov 06 00:06:17 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. Nov 06 00:06:17 smsl-n100 sudo[1138]: pam_unix(sudo:session): session closed for user root Nov 06 00:06:19 smsl-n100 systemd[1]: systemd-timedated.service: Succeeded. Nov 06 00:06:21 smsl-n100 sudo[1132]: pam_unix(sudo:session): session closed for user root Nov 06 00:06:22 smsl-n100 ntfs-3g[1194]: Version 2017.3.23AR.3 integrated FUSE 28 Nov 06 00:06:22 smsl-n100 ntfs-3g[1194]: Mounted /dev/sda1 (Read-Write, label "HIFI Audio HD-1", NTFS 3.1) Nov 06 00:06:22 smsl-n100 ntfs-3g[1194]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8 Nov 06 00:06:22 smsl-n100 ntfs-3g[1194]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sda1,blkdev,blksize=4096 Nov 06 00:06:22 smsl-n100 ntfs-3g[1194]: Global ownership and permissions enforced, configuration type 7 Nov 06 00:06:22 smsl-n100 sudo[1143]: pam_unix(sudo:session): session closed for user root Nov 06 00:06:22 smsl-n100 volumio[1088]: info: Mounting Device HIFI_Audio_HD-2 Nov 06 00:06:22 smsl-n100 sudo[1200]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sdb1 /mnt/USB/HIFI_Audio_HD-2 -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Nov 06 00:06:22 smsl-n100 sudo[1200]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 06 00:06:23 smsl-n100 kernel: CIFS VFS: Error connecting to socket. Aborting operation. Nov 06 00:06:23 smsl-n100 kernel: CIFS VFS: cifs_mount failed w/return code = -113 Nov 06 00:06:23 smsl-n100 sudo[1136]: pam_unix(sudo:session): session closed for user root Nov 06 00:06:29 smsl-n100 ntfs-3g[1220]: Version 2017.3.23AR.3 integrated FUSE 28 Nov 06 00:06:29 smsl-n100 sudo[1200]: pam_unix(sudo:session): session closed for user root Nov 06 00:06:29 smsl-n100 ntfs-3g[1220]: Mounted /dev/sdb1 (Read-Write, label "HIFI Audio HD-2", NTFS 3.1) Nov 06 00:06:29 smsl-n100 ntfs-3g[1220]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8 Nov 06 00:06:29 smsl-n100 ntfs-3g[1220]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sdb1,blkdev,blksize=4096 Nov 06 00:06:29 smsl-n100 ntfs-3g[1220]: Global ownership and permissions enforced, configuration type 7 Nov 06 00:06:29 smsl-n100 volumio[1088]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 06 00:06:29 smsl-n100 volumio[1088]: info: Loading plugin "volumio_command_line_client"... Nov 06 00:06:29 smsl-n100 volumio[1088]: info: Loading plugin "upnp"... Nov 06 00:06:29 smsl-n100 volumio[1088]: info: [1762358789092] Starting Upmpd Daemon Nov 06 00:06:29 smsl-n100 volumio[1088]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 06 00:06:29 smsl-n100 volumio[1088]: info: Loading plugin "my_music"... Nov 06 00:06:29 smsl-n100 volumio[1088]: info: Loading plugin "mpd"... Nov 06 00:06:29 smsl-n100 volumio[1088]: info: Loading plugin "upnp_browser"... Nov 06 00:06:30 smsl-n100 volumio[1088]: info: Plugin bluetooth is not enabled Nov 06 00:06:30 smsl-n100 volumio[1088]: info: Loading plugin "alarm-clock"... Nov 06 00:06:31 smsl-n100 volumio[1088]: info: Loading plugin "manifestui"... Nov 06 00:06:31 smsl-n100 volumio[1088]: info: Loading plugin "metavolumio"... Nov 06 00:06:31 smsl-n100 volumio-remote-updater[540]: [2025-11-06 00:06:31] [connect] Successful connection Nov 06 00:06:34 smsl-n100 volumio[1088]: info: Loading plugin "airplay_emulation"... Nov 06 00:06:34 smsl-n100 volumio[1088]: info: Starting Shairport Sync Nov 06 00:06:34 smsl-n100 volumio[1088]: info: Plugin cd_controller is not enabled Nov 06 00:06:34 smsl-n100 volumio[1088]: info: Loading plugin "last_100"... Nov 06 00:06:34 smsl-n100 volumio[1088]: info: Plugin raat is not enabled Nov 06 00:06:34 smsl-n100 volumio[1088]: info: Loading plugin "streaming_services"... Nov 06 00:06:36 smsl-n100 volumio[1088]: info: Starting Streaming Service Transparent Proxy Nov 06 00:06:36 smsl-n100 volumio[1088]: info: Loading plugin "tidalconnect"... Nov 06 00:06:37 smsl-n100 volumio[1088]: info: Loading plugin "webradio"... Nov 06 00:06:37 smsl-n100 volumio[1088]: info: Loading plugin "i2s_dacs"... Nov 06 00:06:37 smsl-n100 volumio[1088]: info: I2S DAC not set, start Auto-detection Nov 06 00:06:37 smsl-n100 volumio[1088]: info: Loading plugin "volumiodiscovery"... Nov 06 00:06:37 smsl-n100 volumio[1088]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 06 00:06:37 smsl-n100 volumio[1088]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 06 00:06:37 smsl-n100 node[1088]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Nov 06 00:06:37 smsl-n100 volumio[1088]: *** WARNING *** For more information see Nov 06 00:06:37 smsl-n100 volumio[1088]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 06 00:06:37 smsl-n100 volumio[1088]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 06 00:06:37 smsl-n100 volumio[1088]: *** WARNING *** For more information see Nov 06 00:06:37 smsl-n100 node[1088]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 06 00:06:37 smsl-n100 node[1088]: *** WARNING *** For more information see Nov 06 00:06:37 smsl-n100 node[1088]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Nov 06 00:06:37 smsl-n100 node[1088]: *** WARNING *** Please fix your application to use the native API of Avahi! Nov 06 00:06:37 smsl-n100 node[1088]: *** WARNING *** For more information see Nov 06 00:06:37 smsl-n100 volumio[1088]: info: Applying required configuration parameters for plugin volumiodiscovery Nov 06 00:06:37 smsl-n100 volumio[1088]: info: Discovery: Started advertising with name: SMSL N100 Nov 06 00:06:37 smsl-n100 volumio[1088]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Nov 06 00:06:37 smsl-n100 volumio[1088]: info: Loading plugin "spop"... Nov 06 00:06:39 smsl-n100 volumio[1088]: STREAMING PROXY: Starting server on port 3245 Nov 06 00:06:39 smsl-n100 volumio[1088]: Node JS runtime: 14 Nov 06 00:06:40 smsl-n100 volumio[1088]: info: Plugin multiroom is not enabled Nov 06 00:06:40 smsl-n100 volumio[1088]: info: Loading plugin "outputs"... Nov 06 00:06:40 smsl-n100 volumio[1088]: info: Loading plugin "albumart"... Nov 06 00:06:40 smsl-n100 volumio[1088]: info: Plugin example_plugin is not enabled Nov 06 00:06:40 smsl-n100 volumio[1088]: info: Loading plugin "hi_res_audio"... Nov 06 00:06:41 smsl-n100 volumio[1088]: Forking 3 albumart workers Nov 06 00:06:43 smsl-n100 volumio[1088]: Starting albumart workers Nov 06 00:06:43 smsl-n100 volumio[1088]: Starting albumart workers Nov 06 00:06:43 smsl-n100 volumio[1088]: Starting albumart workers Nov 06 00:06:44 smsl-n100 volumio[1088]: info: Applying required configuration parameters for plugin hi_res_audio Nov 06 00:06:44 smsl-n100 volumio[1088]: info: Loading plugin "inputs"... Nov 06 00:06:46 smsl-n100 volumio[1088]: info: Loading plugin "qobuz"... Nov 06 00:06:46 smsl-n100 volumio-remote-updater[540]: [2025-11-06 00:06:46] [connect] Successful connection Nov 06 00:06:49 smsl-n100 volumio[1088]: info: Loading plugin "smart_inputs"... Nov 06 00:06:49 smsl-n100 volumio[1088]: info: Loading plugin "tidal"... Nov 06 00:06:52 smsl-n100 volumio[1088]: info: Loading plugin "oem_helper"... Nov 06 00:06:53 smsl-n100 ntpd[973]: Soliciting pool server 111.90.158.134 Nov 06 00:06:54 smsl-n100 volumio[1088]: info: Applying required configuration parameters for plugin oem_helper Nov 06 00:06:54 smsl-n100 volumio[1088]: info: Loading plugin "smslcontrol"... Nov 06 00:06:54 smsl-n100 kernel: gpio gpiochip0: Persistence not supported for GPIO 5 Nov 06 00:06:54 smsl-n100 volumio[1088]: info: Adding this device properties Nov 06 00:06:54 smsl-n100 volumio[1088]: info: CoreCommandRouter::executeOnPlugin: system , setThisDeviceVolumioProperties Nov 06 00:06:54 smsl-n100 volumio[1088]: info: Setting Additional Device Volumio Properties: [object Object] Nov 06 00:06:54 smsl-n100 volumio[1088]: info: Loading plugin "updater_comm"... Nov 06 00:06:54 smsl-n100 volumio[1088]: info: Plugin mpdemulation is not enabled Nov 06 00:06:54 smsl-n100 volumio[1088]: info: Loading plugin "rest_api"... Nov 06 00:06:54 smsl-n100 volumio[1088]: info: Loading plugin "websocket"... Nov 06 00:06:54 smsl-n100 volumio[1088]: info: Starting Socket.io Server version 2.3.0 Nov 06 00:06:54 smsl-n100 ntpd[973]: Soliciting pool server 47.254.196.78 Nov 06 00:06:54 smsl-n100 ntpd[973]: Soliciting pool server 111.90.158.134 Nov 06 00:06:54 smsl-n100 volumio[1088]: info: Loading i18n strings for locale en Nov 06 00:06:54 smsl-n100 volumio[1088]: Updating browse sources language Nov 06 00:06:54 smsl-n100 volumio[1088]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 06 00:06:55 smsl-n100 volumio[1088]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 06 00:06:55 smsl-n100 volumio[1088]: info: CoreCommandRouter::initPlayerControls Nov 06 00:06:55 smsl-n100 volumio[1088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 06 00:06:55 smsl-n100 volumio[1088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 06 00:06:55 smsl-n100 volumio[1088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 06 00:06:55 smsl-n100 volumio[1088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 06 00:06:55 smsl-n100 volumio[1088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 06 00:06:55 smsl-n100 volumio[1088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 06 00:06:55 smsl-n100 volumio[1088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 06 00:06:55 smsl-n100 volumio[1088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 06 00:06:55 smsl-n100 volumio[1088]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 06 00:06:55 smsl-n100 volumio[1088]: Express server listening on port 3000 Nov 06 00:06:55 smsl-n100 volumio[1088]: [Metrics] WebUI: 46s 782.60ms Nov 06 00:06:55 smsl-n100 volumio[1088]: info: CoreStateMachine::resetVolumioState Nov 06 00:06:55 smsl-n100 volumio[1088]: info: CoreStateMachine::getcurrentVolume Nov 06 00:06:55 smsl-n100 volumio[1088]: info: CoreCommandRouter::volumioRetrievevolume Nov 06 00:06:55 smsl-n100 volumio[1088]: info: CoreStateMachine::pushState Nov 06 00:06:55 smsl-n100 volumio[1088]: info: CorePlayQueue::getTrack 0 Nov 06 00:06:55 smsl-n100 volumio[1088]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 06 00:06:55 smsl-n100 volumio[1088]: info: CoreCommandRouter::volumioPushState Nov 06 00:06:55 smsl-n100 volumio[1088]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 06 00:06:55 smsl-n100 sudo[1367]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 06 00:06:55 smsl-n100 sudo[1367]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 06 00:06:55 smsl-n100 sudo[1367]: pam_unix(sudo:session): session closed for user root Nov 06 00:06:55 smsl-n100 sudo[1369]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 06 00:06:55 smsl-n100 sudo[1369]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 06 00:06:55 smsl-n100 volumio[1088]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Nov 06 00:06:55 smsl-n100 volumio[1088]: info: Completed loading Core Plugins Nov 06 00:06:55 smsl-n100 sudo[1369]: pam_unix(sudo:session): session closed for user root Nov 06 00:06:55 smsl-n100 volumio[1088]: info: Preparing to generate the ALSA configuration file Nov 06 00:06:55 smsl-n100 ntpd[973]: Soliciting pool server 111.90.158.16 Nov 06 00:06:55 smsl-n100 ntpd[973]: Soliciting pool server 111.90.158.16 Nov 06 00:06:55 smsl-n100 volumio[1088]: info: Volumio Network Manager: Network status updated: 1 Nov 06 00:06:55 smsl-n100 volumio[1088]: info: Cannot mount NAS USB at system boot, trial number 1 ,retrying in 5 seconds Nov 06 00:06:55 smsl-n100 volumio[1088]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Nov 06 00:06:56 smsl-n100 volumio[1088]: info: Reloading queue from file Nov 06 00:06:56 smsl-n100 volumio[1088]: info: CoreStateMachine::setRepeat false single undefined Nov 06 00:06:56 smsl-n100 volumio[1088]: info: CoreStateMachine::pushState Nov 06 00:06:56 smsl-n100 volumio[1088]: info: CorePlayQueue::getTrack 0 Nov 06 00:06:56 smsl-n100 volumio[1088]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 06 00:06:56 smsl-n100 volumio[1088]: info: CoreCommandRouter::volumioPushState Nov 06 00:06:56 smsl-n100 volumio[1088]: info: CoreStateMachine::setRandom null Nov 06 00:06:56 smsl-n100 volumio[1088]: info: CoreStateMachine::pushState Nov 06 00:06:56 smsl-n100 volumio[1088]: info: CorePlayQueue::getTrack 0 Nov 06 00:06:56 smsl-n100 volumio[1088]: info: CoreCommandRouter::volumioPushState Nov 06 00:06:56 smsl-n100 volumio[1088]: info: Setting Device type: NanoPi NEO 3 Nov 06 00:06:56 smsl-n100 volumio[1088]: info: Asound.conf file unchanged, so no further update is needed Nov 06 00:06:56 smsl-n100 volumio[1088]: info: Output device has changed, restarting MPD Nov 06 00:06:56 smsl-n100 sudo[1378]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 06 00:06:56 smsl-n100 sudo[1378]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 06 00:06:56 smsl-n100 volumio[1088]: info: Output device has changed, restarting Shairport Sync Nov 06 00:06:56 smsl-n100 volumio[1088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 06 00:06:56 smsl-n100 volumio[1088]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 06 00:06:56 smsl-n100 sudo[1378]: pam_unix(sudo:session): session closed for user root Nov 06 00:06:56 smsl-n100 sudo[1380]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 06 00:06:56 smsl-n100 sudo[1380]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 06 00:06:56 smsl-n100 systemd[1]: Stopping Music Player Daemon... Nov 06 00:06:56 smsl-n100 volumio[1088]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 06 00:06:56 smsl-n100 volumio[1088]: info: ___________ START PLUGINS ___________ Nov 06 00:06:56 smsl-n100 volumio[1088]: info: ControllerMpd::onStart: Initializing MPD Nov 06 00:06:56 smsl-n100 volumio[1088]: info: Creating MPD Configuration file Nov 06 00:06:56 smsl-n100 sudo[1387]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Nov 06 00:06:56 smsl-n100 volumio[1088]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 06 00:06:56 smsl-n100 sudo[1387]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 06 00:06:56 smsl-n100 volumio[1088]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 06 00:06:56 smsl-n100 volumio[1088]: info: [1762358816601] CoreMusicLibrary::Adding element Media Servers Nov 06 00:06:56 smsl-n100 volumio[1088]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 06 00:06:56 smsl-n100 sudo[1389]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Nov 06 00:06:56 smsl-n100 sudo[1389]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 06 00:06:56 smsl-n100 sudo[1387]: pam_unix(sudo:session): session closed for user root Nov 06 00:06:56 smsl-n100 volumio[1088]: info: Adding METAVOLUMIO REST API Endpoints Nov 06 00:06:56 smsl-n100 volumio[1088]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Nov 06 00:06:56 smsl-n100 volumio[1088]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Nov 06 00:06:56 smsl-n100 volumio[1088]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Nov 06 00:06:56 smsl-n100 volumio[1088]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Nov 06 00:06:56 smsl-n100 volumio[1088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 06 00:06:56 smsl-n100 volumio[1088]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 06 00:06:56 smsl-n100 volumio[1088]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 06 00:06:56 smsl-n100 volumio[1088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 06 00:06:56 smsl-n100 volumio[1088]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 06 00:06:56 smsl-n100 volumio[1088]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Nov 06 00:06:56 smsl-n100 volumio[1088]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 06 00:06:56 smsl-n100 volumio[1088]: info: [1762358816888] CoreMusicLibrary::Adding element Last_100 Nov 06 00:06:56 smsl-n100 volumio[1088]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 06 00:06:56 smsl-n100 volumio[1088]: info: Streaming services startup Nov 06 00:06:56 smsl-n100 volumio[1088]: info: Starting Streaming Daemon Nov 06 00:06:56 smsl-n100 sudo[1399]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Nov 06 00:06:56 smsl-n100 sudo[1399]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 06 00:06:57 smsl-n100 sudo[1399]: pam_unix(sudo:session): session closed for user root Nov 06 00:06:57 smsl-n100 volumio[1088]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Nov 06 00:06:57 smsl-n100 volumio[1088]: info: [1762358817074] CoreMusicLibrary::Adding element Webradio Nov 06 00:06:57 smsl-n100 volumio[1088]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 06 00:06:57 smsl-n100 volumio[1088]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 06 00:06:57 smsl-n100 sudo[1406]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Nov 06 00:06:57 smsl-n100 sudo[1406]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 06 00:06:57 smsl-n100 volumio[1088]: info: Initializing BBC Radios Nov 06 00:06:57 smsl-n100 sudo[1406]: pam_unix(sudo:session): session closed for user root Nov 06 00:06:57 smsl-n100 systemd[1]: mpd.service: Succeeded. Nov 06 00:06:57 smsl-n100 systemd[1]: Stopped Music Player Daemon. Nov 06 00:06:57 smsl-n100 systemd[1]: Starting Music Player Daemon... Nov 06 00:06:57 smsl-n100 volumio[1088]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 06 00:06:57 smsl-n100 volumio[1088]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 06 00:06:57 smsl-n100 volumio[1088]: info: Creating Spotify config file Nov 06 00:06:57 smsl-n100 volumio[1088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 06 00:06:57 smsl-n100 volumio[1088]: error: Hi Res Audio Failed Login: Missing Login Data Nov 06 00:06:57 smsl-n100 volumio[1088]: info: Adding HIGHRESAUDIO REST API Endpoints Nov 06 00:06:57 smsl-n100 volumio[1088]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Nov 06 00:06:57 smsl-n100 volumio[1088]: info: Initializing Serial Communication on port /dev/ttyS1 Nov 06 00:06:57 smsl-n100 volumio[1088]: info: Touch Event Listener Process Starting Nov 06 00:06:57 smsl-n100 volumio[1088]: info: Adding inputs REST Endpoints Nov 06 00:06:57 smsl-n100 volumio[1088]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs Nov 06 00:06:57 smsl-n100 volumio[1088]: info: Scanning Audio Inputs Nov 06 00:06:57 smsl-n100 sudo[1412]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 06 00:06:57 smsl-n100 sudo[1412]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 06 00:06:57 smsl-n100 sudo[1412]: pam_unix(sudo:session): session closed for user root Nov 06 00:06:57 smsl-n100 sudo[1421]: pam_unix(sudo:auth): conversation failed Nov 06 00:06:57 smsl-n100 sudo[1421]: pam_unix(sudo:auth): auth could not identify password for [volumio] Nov 06 00:06:57 smsl-n100 volumio[1088]: info: Checking against Known Cards name Nov 06 00:06:57 smsl-n100 volumio[1088]: info: Adding Server instance for streaming Nov 06 00:06:57 smsl-n100 volumio[1088]: info: Refreshing TIDAL token Nov 06 00:06:57 smsl-n100 volumio[1088]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 06 00:06:57 smsl-n100 volumio[1088]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 06 00:06:57 smsl-n100 volumio[1088]: info: Initializing GPIOs Nov 06 00:06:57 smsl-n100 kernel: gpio gpiochip3: Persistence not supported for GPIO 1 Nov 06 00:06:57 smsl-n100 kernel: gpio gpiochip2: Persistence not supported for GPIO 15 Nov 06 00:06:57 smsl-n100 kernel: gpio gpiochip3: Persistence not supported for GPIO 0 Nov 06 00:06:57 smsl-n100 kernel: gpio gpiochip2: Persistence not supported for GPIO 2 Nov 06 00:06:57 smsl-n100 volumio[1088]: info: Starting Button Listener Nov 06 00:06:57 smsl-n100 volumio[1088]: info: Turning off Green LED Nov 06 00:06:57 smsl-n100 volumio[1088]: info: Tuning on Blue LED Nov 06 00:06:57 smsl-n100 volumio[1088]: info: Signaling System Ready Nov 06 00:06:57 smsl-n100 volumio[1088]: info: Volumio Calling Home Nov 06 00:06:58 smsl-n100 volumio[1088]: info: Stopping AccessToken refresher cron for QOBUZ Nov 06 00:06:58 smsl-n100 volumio[1088]: info: AccessToken refresher cron started for QOBUZ Nov 06 00:06:58 smsl-n100 volumio[1088]: info: Adding QOBUZ REST API Endpoints Nov 06 00:06:58 smsl-n100 volumio[1088]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz Nov 06 00:06:58 smsl-n100 volumio[1088]: info: Serial port opened successfully Nov 06 00:06:58 smsl-n100 volumio[1088]: info: Sending serial start messages Nov 06 00:06:58 smsl-n100 volumio[1088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 06 00:06:58 smsl-n100 volumio[1088]: info: Reporting MCU Network Status: 1 Nov 06 00:06:58 smsl-n100 volumio[1088]: info: Touch Event Listener Process Closed Nov 06 00:06:58 smsl-n100 volumio[1088]: error: Cannot start Volumio Streaming Daemon Nov 06 00:06:58 smsl-n100 volumio[1088]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Nov 06 00:06:58 smsl-n100 volumio[1088]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Nov 06 00:06:58 smsl-n100 volumio[1088]: info: MPD Permissions set Nov 06 00:06:58 smsl-n100 volumio[1088]: info: MPD Permissions set Nov 06 00:06:58 smsl-n100 volumio[1088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setDeviceVolumeOverride Nov 06 00:06:58 smsl-n100 volumio[1088]: info: Setting Device Volume Override Nov 06 00:06:58 smsl-n100 volumio[1088]: info: CoreCommandRouter::volumioUpdateVolumeSettings Nov 06 00:06:58 smsl-n100 volumio[1088]: info: Updating Volume Controller Parameters: Device: 5 Name: VMV D1 USB2.0 Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Nov 06 00:06:58 smsl-n100 volumio[1088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Nov 06 00:06:58 smsl-n100 volumio[1088]: info: Disabling external Volume Control Nov 06 00:06:58 smsl-n100 volumio[1088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 06 00:06:58 smsl-n100 volumio[1088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 06 00:06:58 smsl-n100 volumio[1088]: info: CoreStateMachine::pushState Nov 06 00:06:58 smsl-n100 volumio[1088]: info: CorePlayQueue::getTrack 0 Nov 06 00:06:58 smsl-n100 volumio[1088]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 06 00:06:58 smsl-n100 volumio[1088]: info: CoreCommandRouter::volumioPushState Nov 06 00:06:58 smsl-n100 volumio[1088]: error: Serial API: Failed to decode command: 100, message: undefined Nov 06 00:06:58 smsl-n100 volumio[1088]: error: Serial API: Failed to decode command: MAXVOL, message: Nov 06 00:06:58 smsl-n100 volumio[1088]: error: Serial API: Failed to decode command: 100, message: undefined Nov 06 00:06:58 smsl-n100 volumio[1088]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Nov 06 00:06:58 smsl-n100 volumio[1088]: info: CoreStateMachine::pushState Nov 06 00:06:58 smsl-n100 volumio[1088]: info: CorePlayQueue::getTrack 0 Nov 06 00:06:58 smsl-n100 volumio[1088]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 06 00:06:58 smsl-n100 volumio[1088]: info: CoreCommandRouter::volumioPushState Nov 06 00:06:58 smsl-n100 volumio[1088]: info: Volumio called home Nov 06 00:06:58 smsl-n100 volumio[1088]: info: Spotify config file written Nov 06 00:06:58 smsl-n100 volumio[1088]: info: CoreStateMachine::pushState Nov 06 00:06:58 smsl-n100 volumio[1088]: info: CorePlayQueue::getTrack 0 Nov 06 00:06:58 smsl-n100 volumio[1088]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 06 00:06:58 smsl-n100 volumio[1088]: info: CoreCommandRouter::volumioPushState Nov 06 00:06:58 smsl-n100 volumio[1088]: error: Serial API: Failed to decode command: 100, message: undefined Nov 06 00:06:58 smsl-n100 volumio[1088]: error: Serial API: Failed to decode command: MAXVOL, message: Nov 06 00:06:58 smsl-n100 volumio[1088]: error: Serial API: Failed to decode command: 100, message: undefined Nov 06 00:06:58 smsl-n100 volumio[1088]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Nov 06 00:06:58 smsl-n100 volumio[1088]: info: CoreStateMachine::pushState Nov 06 00:06:58 smsl-n100 volumio[1088]: info: CorePlayQueue::getTrack 0 Nov 06 00:06:58 smsl-n100 volumio[1088]: info: CoreCommandRouter::volumioPushState Nov 06 00:06:58 smsl-n100 volumio[1088]: error: Serial API: Failed to decode command: 100, message: undefined Nov 06 00:06:58 smsl-n100 volumio[1088]: error: Serial API: Failed to decode command: MAXVOL, message: Nov 06 00:06:58 smsl-n100 volumio[1088]: error: Serial API: Failed to decode command: 100, message: undefined Nov 06 00:06:58 smsl-n100 volumio[1088]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Nov 06 00:06:58 smsl-n100 volumio[1088]: error: Serial API: Failed to decode command: 1, message: undefined Nov 06 00:06:58 smsl-n100 volumio[1088]: info: CoreStateMachine::pushState Nov 06 00:06:58 smsl-n100 volumio[1088]: info: CorePlayQueue::getTrack 0 Nov 06 00:06:58 smsl-n100 volumio[1088]: info: CoreCommandRouter::volumioPushState Nov 06 00:06:58 smsl-n100 volumio[1088]: error: Serial API: Failed to decode command: 100, message: undefined Nov 06 00:06:58 smsl-n100 volumio[1088]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Nov 06 00:06:58 smsl-n100 volumio[1088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 06 00:06:58 smsl-n100 volumio[1088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 06 00:06:58 smsl-n100 volumio[1088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 06 00:06:58 smsl-n100 volumio[1088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 06 00:06:58 smsl-n100 volumio[1088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 06 00:06:58 smsl-n100 volumio[1088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 06 00:06:58 smsl-n100 volumio[1088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 06 00:06:58 smsl-n100 volumio[1088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 06 00:06:59 smsl-n100 volumio[1088]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 06 00:06:59 smsl-n100 volumio[1088]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Nov 06 00:06:59 smsl-n100 volumio[1088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 06 00:06:59 smsl-n100 volumio[1088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 06 00:06:59 smsl-n100 volumio[1088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 06 00:06:59 smsl-n100 volumio[1088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 06 00:06:59 smsl-n100 volumio[1088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 06 00:06:59 smsl-n100 volumio[1088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 06 00:06:59 smsl-n100 volumio[1088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 06 00:06:59 smsl-n100 volumio[1088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 06 00:06:59 smsl-n100 volumio[1088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 06 00:06:59 smsl-n100 volumio[1088]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 06 00:06:59 smsl-n100 volumio[1088]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Nov 06 00:06:59 smsl-n100 sudo[1456]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Nov 06 00:06:59 smsl-n100 sudo[1456]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 06 00:06:59 smsl-n100 sudo[1464]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Nov 06 00:06:59 smsl-n100 sudo[1464]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 06 00:06:59 smsl-n100 volumio[1088]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 06 00:06:59 smsl-n100 volumio[1088]: info: No need to fix Spotify hosts Nov 06 00:06:59 smsl-n100 volumio[1088]: info: CoreStateMachine::pushState Nov 06 00:06:59 smsl-n100 volumio[1088]: info: CorePlayQueue::getTrack 0 Nov 06 00:06:59 smsl-n100 volumio[1088]: info: CoreCommandRouter::volumioPushState Nov 06 00:06:59 smsl-n100 volumio[1088]: error: Serial API: Failed to decode command: 100, message: undefined Nov 06 00:06:59 smsl-n100 volumio[1088]: error: Serial API: Failed to decode command: MAXVOL, message: Nov 06 00:06:59 smsl-n100 volumio[1088]: error: Serial API: Failed to decode command: 100, message: undefined Nov 06 00:06:59 smsl-n100 volumio[1088]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Nov 06 00:06:59 smsl-n100 systemd[1]: Started UPnP Renderer front-end to MPD. Nov 06 00:06:59 smsl-n100 systemd[1]: Started go-librespot Daemon. Nov 06 00:06:59 smsl-n100 sudo[1464]: pam_unix(sudo:session): session closed for user root Nov 06 00:06:59 smsl-n100 sudo[1456]: pam_unix(sudo:session): session closed for user root Nov 06 00:06:59 smsl-n100 go-librespot[1490]: go-librespot daemon starting... Nov 06 00:06:59 smsl-n100 volumio[1088]: info: Discovery: adding c32a3912-3ad2-4e38-b09f-ae11ecd87622 Nov 06 00:06:59 smsl-n100 volumio[1088]: info: Discovery: Found device SMSL N100 Nov 06 00:06:59 smsl-n100 volumio[1088]: info: CoreCommandRouter::volumioGetState Nov 06 00:06:59 smsl-n100 volumio[1088]: info: CorePlayQueue::getTrack 0 Nov 06 00:06:59 smsl-n100 volumio[1088]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 06 00:06:59 smsl-n100 volumio[1088]: Error: The value NaN is not a number Nov 06 00:06:59 smsl-n100 volumio[1088]: at Config.forceToType (/volumio/node_modules/v-conf/index.js:322:20) Nov 06 00:06:59 smsl-n100 volumio[1088]: at Config.set (/volumio/node_modules/v-conf/index.js:153:25) Nov 06 00:06:59 smsl-n100 volumio[1088]: at ControllerVolumioDiscovery.updateMultiroomDevice (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:323:25) Nov 06 00:06:59 smsl-n100 volumio[1088]: at ControllerVolumioDiscovery.connectToRemoteVolumio (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:273:10) Nov 06 00:06:59 smsl-n100 volumio[1088]: at Browser. (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:192:12) Nov 06 00:06:59 smsl-n100 volumio[1088]: at Browser.emit (events.js:400:28) Nov 06 00:06:59 smsl-n100 volumio[1088]: at on_resolver_done (/volumio/node_modules/mdns/lib/browser.js:31:14) Nov 06 00:06:59 smsl-n100 volumio[1088]: at next (/volumio/node_modules/mdns/lib/browser.js:106:7) Nov 06 00:06:59 smsl-n100 volumio[1088]: at Array.makeAddressesUnique (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:177:5) Nov 06 00:06:59 smsl-n100 volumio[1088]: at next (/volumio/node_modules/mdns/lib/browser.js:109:21) Nov 06 00:06:59 smsl-n100 volumio[1088]: at /volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:160:11 Nov 06 00:06:59 smsl-n100 volumio[1088]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:108:7) Nov 06 00:06:59 smsl-n100 volumio[1088]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) Nov 06 00:06:59 smsl-n100 volumio[1088]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 06 00:06:59 smsl-n100 go-librespot[1490]: time="2025-11-06T00:06:59+08:00" level=info msg="running go-librespot 0.4.0" Nov 06 00:06:59 smsl-n100 go-librespot[1490]: time="2025-11-06T00:06:59+08:00" level=debug msg="app state loaded" Nov 06 00:06:59 smsl-n100 go-librespot[1490]: time="2025-11-06T00:06:59+08:00" level=debug msg="stored credentials not found" Nov 06 00:06:59 smsl-n100 systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Nov 06 00:06:59 smsl-n100 systemd[1]: mpd.service: Failed with result 'protocol'. Nov 06 00:06:59 smsl-n100 systemd[1]: Failed to start Music Player Daemon. Nov 06 00:06:59 smsl-n100 go-librespot[1490]: time="2025-11-06T00:06:59+08:00" level=info msg="api server listening on 127.0.0.1:9879" Nov 06 00:07:00 smsl-n100 sudo[1389]: pam_unix(sudo:session): session closed for user root Nov 06 00:07:00 smsl-n100 sudo[1380]: pam_unix(sudo:session): session closed for user root Nov 06 00:07:00 smsl-n100 systemd[1]: Starting Music Player Daemon... Nov 06 00:07:00 smsl-n100 sudo[1507]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Nov 06 00:07:00 smsl-n100 sudo[1507]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 06 00:07:00 smsl-n100 sudo[1507]: pam_unix(sudo:session): session closed for user root Nov 06 00:07:00 smsl-n100 go-librespot[1490]: time="2025-11-06T00:07:00+08:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Nov 06 00:07:00 smsl-n100 go-librespot[1490]: time="2025-11-06T00:07:00+08:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Nov 06 00:07:00 smsl-n100 go-librespot[1490]: time="2025-11-06T00:07:00+08:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Nov 06 00:07:00 smsl-n100 go-librespot[1490]: time="2025-11-06T00:07:00+08:00" level=info msg="zeroconf server listening on port 42831" Nov 06 00:07:00 smsl-n100 sudo[1513]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-11-06 00:06 Nov 06 00:07:00 smsl-n100 sudo[1513]: 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"