-- Logs begin at Thu 2019-02-14 18:11:59 +08, end at Fri 2025-08-29 20:20:42 +08. -- Aug 29 20:20:06 smsl-n100 systemd-timedated[1046]: Changed local time to Fri Aug 29 20:20:06 2025 Aug 29 20:20:06 smsl-n100 sudo[1044]: pam_unix(sudo:session): session closed for user root Aug 29 20:20:06 smsl-n100 volumio-time-update[557]: volumio-time-update-util: System time updated successfully. Aug 29 20:20:06 smsl-n100 ntpd[990]: Soliciting pool server 95.111.192.87 Aug 29 20:20:06 smsl-n100 systemd[1]: Started Volumio Time Update Utility. Aug 29 20:20:06 smsl-n100 ntpd[990]: Soliciting pool server 173.234.15.82 Aug 29 20:20:06 smsl-n100 systemd[1]: Reached target Multi-User System. Aug 29 20:20:06 smsl-n100 systemd[1]: Reached target Graphical Interface. Aug 29 20:20:06 smsl-n100 systemd[1]: Starting Update UTMP about System Runlevel Changes... Aug 29 20:20:06 smsl-n100 systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Aug 29 20:20:06 smsl-n100 systemd[1]: Started Update UTMP about System Runlevel Changes. Aug 29 20:20:06 smsl-n100 systemd[1]: Startup finished in 5.855s (kernel) + 21.224s (userspace) = 27.080s. Aug 29 20:20:06 smsl-n100 volumio[918]: info: ------------------------------------------- Aug 29 20:20:06 smsl-n100 volumio[918]: info: ----- Volumio3 ---- Aug 29 20:20:06 smsl-n100 volumio[918]: info: ------------------------------------------- Aug 29 20:20:06 smsl-n100 volumio[918]: info: ----- System startup ---- Aug 29 20:20:06 smsl-n100 volumio[918]: info: ------------------------------------------- Aug 29 20:20:07 smsl-n100 ntpd[990]: Soliciting pool server 162.159.200.1 Aug 29 20:20:08 smsl-n100 ntpd[990]: Soliciting pool server 23.106.249.200 Aug 29 20:20:08 smsl-n100 volumio[918]: info: MYVOLUMIO Environment detected Aug 29 20:20:08 smsl-n100 volumio[918]: info: Plugin folders cleanup Aug 29 20:20:08 smsl-n100 volumio[918]: info: Scanning into folder /volumio/app/plugins/ Aug 29 20:20:08 smsl-n100 volumio[918]: info: Scanning category audio_interface Aug 29 20:20:08 smsl-n100 volumio[918]: info: Scanning category miscellanea Aug 29 20:20:08 smsl-n100 volumio[918]: info: Scanning category music_service Aug 29 20:20:08 smsl-n100 volumio[918]: info: Scanning category plugins.json Aug 29 20:20:08 smsl-n100 volumio[918]: info: Scanning category system_controller Aug 29 20:20:08 smsl-n100 volumio[918]: info: Scanning category user_interface Aug 29 20:20:08 smsl-n100 volumio[918]: info: Scanning into folder /data/plugins/ Aug 29 20:20:08 smsl-n100 volumio[918]: info: Plugin folders cleanup completed Aug 29 20:20:08 smsl-n100 volumio[918]: info: ------------------------------------------- Aug 29 20:20:08 smsl-n100 volumio[918]: info: ----- Core plugins startup ---- Aug 29 20:20:08 smsl-n100 volumio[918]: info: ------------------------------------------- Aug 29 20:20:08 smsl-n100 volumio[918]: info: Loading plugins from folder /volumio/app/plugins/ Aug 29 20:20:08 smsl-n100 volumio[918]: info: Adding plugin bluetooth to MyMusic Plugins Aug 29 20:20:08 smsl-n100 volumio[918]: info: Adding plugin multiroom to MyMusic Plugins Aug 29 20:20:08 smsl-n100 volumio[918]: info: Adding plugin upnp to MyMusic Plugins Aug 29 20:20:08 smsl-n100 volumio[918]: info: Adding plugin metavolumio to MyMusic Plugins Aug 29 20:20:08 smsl-n100 volumio[918]: info: Adding plugin airplay_emulation to MyMusic Plugins Aug 29 20:20:08 smsl-n100 volumio[918]: info: Adding plugin cd_controller to MyMusic Plugins Aug 29 20:20:08 smsl-n100 volumio[918]: info: Adding plugin raat to MyMusic Plugins Aug 29 20:20:08 smsl-n100 volumio[918]: info: Adding plugin smart_inputs to MyMusic Plugins Aug 29 20:20:08 smsl-n100 volumio[918]: info: Adding plugin tidalconnect to MyMusic Plugins Aug 29 20:20:08 smsl-n100 volumio[918]: info: Adding plugin upnp_browser to MyMusic Plugins Aug 29 20:20:08 smsl-n100 volumio[918]: info: Loading plugins from folder /data/plugins/ Aug 29 20:20:08 smsl-n100 volumio[918]: info: Loading plugin "system"... Aug 29 20:20:08 smsl-n100 volumio[918]: info: Loading plugin "appearance"... Aug 29 20:20:09 smsl-n100 ntpd[990]: Soliciting pool server 47.241.41.246 Aug 29 20:20:10 smsl-n100 dhcpcd[980]: wlan0: using IPv4LL address 169.254.6.107 Aug 29 20:20:10 smsl-n100 dhcpcd[980]: wlan0: adding route to 169.254.0.0/16 Aug 29 20:20:10 smsl-n100 avahi-daemon[585]: Registering new address record for 169.254.6.107 on wlan0.IPv4. Aug 29 20:20:10 smsl-n100 volumio[918]: info: Loading plugin "network"... Aug 29 20:20:10 smsl-n100 volumio[918]: info: Refreshing Cached IP Addresses Aug 29 20:20:11 smsl-n100 sudo[1076]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 29 20:20:11 smsl-n100 sudo[1076]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 29 20:20:11 smsl-n100 sudo[1076]: pam_unix(sudo:session): session closed for user root Aug 29 20:20:11 smsl-n100 sudo[1078]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 29 20:20:11 smsl-n100 sudo[1078]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 29 20:20:11 smsl-n100 sudo[1078]: pam_unix(sudo:session): session closed for user root Aug 29 20:20:11 smsl-n100 volumio[918]: info: Loading plugin "services"... Aug 29 20:20:11 smsl-n100 volumio[918]: info: Loading plugin "alsa_controller"... Aug 29 20:20:11 smsl-n100 sudo[1088]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Aug 29 20:20:11 smsl-n100 sudo[1088]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 29 20:20:11 smsl-n100 volumio[918]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 29 20:20:11 smsl-n100 volumio[918]: info: Loading plugin "wizard"... Aug 29 20:20:11 smsl-n100 volumio[918]: info: Loading plugin "networkfs"... Aug 29 20:20:11 smsl-n100 volumio[918]: info: Starting Udev Watcher for removable devices Aug 29 20:20:11 smsl-n100 sudo[1104]: 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.50.112/USB /mnt/NAS/USB Aug 29 20:20:11 smsl-n100 sudo[1104]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 29 20:20:11 smsl-n100 volumio[918]: info: Ignoring mount for partition: boot Aug 29 20:20:11 smsl-n100 volumio[918]: info: Ignoring mount for partition: volumio Aug 29 20:20:11 smsl-n100 volumio[918]: info: Ignoring mount for partition: volumio_data Aug 29 20:20:11 smsl-n100 volumio[918]: error: Cannot associate FS Label, not mounting Aug 29 20:20:11 smsl-n100 kernel: FS-Cache: Loaded Aug 29 20:20:11 smsl-n100 volumio[918]: info: Mounting Device 新加卷 Aug 29 20:20:11 smsl-n100 sudo[1114]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda2 /mnt/USB/新加卷 -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Aug 29 20:20:11 smsl-n100 sudo[1114]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 29 20:20:11 smsl-n100 kernel: FS-Cache: Netfs 'cifs' registered for caching Aug 29 20:20:11 smsl-n100 kernel: Key type cifs.spnego registered Aug 29 20:20:11 smsl-n100 kernel: Key type cifs.idmap registered Aug 29 20:20:11 smsl-n100 kernel: CIFS: Attempting to mount //192.168.50.112/USB Aug 29 20:20:11 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. Aug 29 20:20:11 smsl-n100 sudo[1104]: pam_unix(sudo:session): session closed for user root Aug 29 20:20:12 smsl-n100 ntpd[990]: Listen normally on 5 wlan0 169.254.6.107:123 Aug 29 20:20:12 smsl-n100 ntpd[990]: new interface(s) found: waking up resolver Aug 29 20:20:12 smsl-n100 ntpd[990]: receive: Unexpected origin timestamp 0xec5c197c.05d4f820 does not match aorg 0000000000.00000000 from server@23.106.249.200 xmt 0xec5c197c.9981efca Aug 29 20:20:13 smsl-n100 volumio-remote-updater[553]: [2025-08-29 20:20:13] [connect] Successful connection Aug 29 20:20:14 smsl-n100 ntfs-3g[1136]: Version 2017.3.23AR.3 integrated FUSE 28 Aug 29 20:20:14 smsl-n100 ntfs-3g[1136]: Mounted /dev/sda2 (Read-Write, label "新加卷", NTFS 3.1) Aug 29 20:20:14 smsl-n100 ntfs-3g[1136]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8 Aug 29 20:20:14 smsl-n100 ntfs-3g[1136]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sda2,blkdev,blksize=4096 Aug 29 20:20:14 smsl-n100 ntfs-3g[1136]: Global ownership and permissions enforced, configuration type 7 Aug 29 20:20:14 smsl-n100 sudo[1114]: pam_unix(sudo:session): session closed for user root Aug 29 20:20:14 smsl-n100 volumio[918]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 29 20:20:14 smsl-n100 volumio[918]: info: Loading plugin "volumio_command_line_client"... Aug 29 20:20:14 smsl-n100 volumio[918]: info: Loading plugin "upnp"... Aug 29 20:20:14 smsl-n100 volumio[918]: info: [1756470014886] Starting Upmpd Daemon Aug 29 20:20:14 smsl-n100 volumio[918]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 29 20:20:14 smsl-n100 volumio[918]: info: Loading plugin "my_music"... Aug 29 20:20:14 smsl-n100 volumio[918]: info: Loading plugin "mpd"... Aug 29 20:20:15 smsl-n100 volumio[918]: info: Loading plugin "upnp_browser"... Aug 29 20:20:16 smsl-n100 sudo[1088]: pam_unix(sudo:session): session closed for user root Aug 29 20:20:16 smsl-n100 volumio[918]: info: Plugin bluetooth is not enabled Aug 29 20:20:16 smsl-n100 volumio[918]: info: Loading plugin "alarm-clock"... Aug 29 20:20:16 smsl-n100 volumio[918]: info: Loading plugin "manifestui"... Aug 29 20:20:17 smsl-n100 volumio[918]: info: Loading plugin "metavolumio"... Aug 29 20:20:19 smsl-n100 systemd[1]: systemd-fsckd.service: Succeeded. Aug 29 20:20:19 smsl-n100 volumio[918]: info: Loading plugin "airplay_emulation"... Aug 29 20:20:19 smsl-n100 volumio[918]: info: Starting Shairport Sync Aug 29 20:20:19 smsl-n100 volumio[918]: info: Plugin cd_controller is not enabled Aug 29 20:20:19 smsl-n100 volumio[918]: info: Loading plugin "last_100"... Aug 29 20:20:19 smsl-n100 volumio[918]: info: Plugin raat is not enabled Aug 29 20:20:19 smsl-n100 volumio[918]: info: Loading plugin "streaming_services"... Aug 29 20:20:22 smsl-n100 volumio[918]: info: Starting Streaming Service Transparent Proxy Aug 29 20:20:22 smsl-n100 volumio[918]: info: Loading plugin "tidalconnect"... Aug 29 20:20:22 smsl-n100 volumio[918]: info: Loading plugin "webradio"... Aug 29 20:20:22 smsl-n100 volumio[918]: info: Loading plugin "i2s_dacs"... Aug 29 20:20:22 smsl-n100 volumio[918]: info: I2S DAC not set, start Auto-detection Aug 29 20:20:22 smsl-n100 volumio[918]: info: Loading plugin "volumiodiscovery"... Aug 29 20:20:23 smsl-n100 volumio[918]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 29 20:20:23 smsl-n100 node[918]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 29 20:20:23 smsl-n100 node[918]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 29 20:20:23 smsl-n100 volumio[918]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 29 20:20:23 smsl-n100 volumio[918]: *** WARNING *** For more information see Aug 29 20:20:23 smsl-n100 volumio[918]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 29 20:20:23 smsl-n100 volumio[918]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 29 20:20:23 smsl-n100 volumio[918]: *** WARNING *** For more information see Aug 29 20:20:23 smsl-n100 node[918]: *** WARNING *** For more information see Aug 29 20:20:23 smsl-n100 node[918]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 29 20:20:23 smsl-n100 node[918]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 29 20:20:23 smsl-n100 node[918]: *** WARNING *** For more information see Aug 29 20:20:23 smsl-n100 volumio[918]: info: Applying required configuration parameters for plugin volumiodiscovery Aug 29 20:20:23 smsl-n100 volumio[918]: info: Discovery: Started advertising with name: SMSL N100 Aug 29 20:20:23 smsl-n100 volumio[918]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 29 20:20:23 smsl-n100 volumio[918]: info: Plugin multiroom is not enabled Aug 29 20:20:23 smsl-n100 volumio[918]: info: Loading plugin "outputs"... Aug 29 20:20:23 smsl-n100 volumio[918]: info: Loading plugin "albumart"... Aug 29 20:20:23 smsl-n100 volumio[918]: info: Plugin example_plugin is not enabled Aug 29 20:20:23 smsl-n100 volumio[918]: info: Loading plugin "hi_res_audio"... Aug 29 20:20:24 smsl-n100 volumio[918]: Forking 3 albumart workers Aug 29 20:20:24 smsl-n100 volumio[918]: STREAMING PROXY: Starting server on port 3245 Aug 29 20:20:24 smsl-n100 volumio[918]: Node JS runtime: 14 Aug 29 20:20:26 smsl-n100 volumio[918]: Starting albumart workers Aug 29 20:20:26 smsl-n100 volumio[918]: Starting albumart workers Aug 29 20:20:26 smsl-n100 volumio[918]: Starting albumart workers Aug 29 20:20:27 smsl-n100 volumio[918]: info: Applying required configuration parameters for plugin hi_res_audio Aug 29 20:20:27 smsl-n100 volumio[918]: info: Loading plugin "inputs"... Aug 29 20:20:28 smsl-n100 volumio-remote-updater[553]: [2025-08-29 20:20:28] [connect] Successful connection Aug 29 20:20:28 smsl-n100 volumio[918]: info: Loading plugin "qobuz"... Aug 29 20:20:31 smsl-n100 volumio[918]: info: Loading plugin "smart_inputs"... Aug 29 20:20:32 smsl-n100 volumio[918]: info: Loading plugin "tidal"... Aug 29 20:20:34 smsl-n100 volumio[918]: info: Loading plugin "oem_helper"... Aug 29 20:20:36 smsl-n100 systemd[1]: systemd-timedated.service: Succeeded. Aug 29 20:20:36 smsl-n100 volumio[918]: info: Applying required configuration parameters for plugin oem_helper Aug 29 20:20:36 smsl-n100 volumio[918]: info: Loading plugin "smslcontrol"... Aug 29 20:20:36 smsl-n100 kernel: gpio gpiochip0: Persistence not supported for GPIO 5 Aug 29 20:20:36 smsl-n100 volumio[918]: info: Adding this device properties Aug 29 20:20:36 smsl-n100 volumio[918]: info: CoreCommandRouter::executeOnPlugin: system , setThisDeviceVolumioProperties Aug 29 20:20:36 smsl-n100 volumio[918]: info: Setting Additional Device Volumio Properties: [object Object] Aug 29 20:20:36 smsl-n100 volumio[918]: info: Loading plugin "updater_comm"... Aug 29 20:20:37 smsl-n100 volumio[918]: info: Plugin mpdemulation is not enabled Aug 29 20:20:37 smsl-n100 volumio[918]: info: Loading plugin "rest_api"... Aug 29 20:20:37 smsl-n100 volumio[918]: info: Loading plugin "websocket"... Aug 29 20:20:37 smsl-n100 volumio[918]: info: Starting Socket.io Server version 2.3.0 Aug 29 20:20:37 smsl-n100 volumio[918]: info: Loading i18n strings for locale en Aug 29 20:20:37 smsl-n100 volumio[918]: Updating browse sources language Aug 29 20:20:37 smsl-n100 volumio[918]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 29 20:20:37 smsl-n100 volumio[918]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 29 20:20:37 smsl-n100 volumio[918]: info: CoreCommandRouter::initPlayerControls Aug 29 20:20:37 smsl-n100 volumio[918]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 20:20:37 smsl-n100 volumio[918]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 20:20:37 smsl-n100 volumio[918]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 20:20:37 smsl-n100 volumio[918]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 20:20:37 smsl-n100 volumio[918]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 20:20:37 smsl-n100 volumio[918]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 20:20:37 smsl-n100 volumio[918]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 20:20:37 smsl-n100 volumio[918]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 20:20:37 smsl-n100 volumio[918]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 29 20:20:37 smsl-n100 volumio[918]: Express server listening on port 3000 Aug 29 20:20:37 smsl-n100 volumio[918]: [Metrics] WebUI: 32s 694.33ms Aug 29 20:20:38 smsl-n100 volumio[918]: info: CoreStateMachine::resetVolumioState Aug 29 20:20:38 smsl-n100 volumio[918]: info: CoreStateMachine::getcurrentVolume Aug 29 20:20:38 smsl-n100 volumio[918]: info: CoreCommandRouter::volumioRetrievevolume Aug 29 20:20:38 smsl-n100 volumio[918]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 29 20:20:38 smsl-n100 sudo[1254]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 29 20:20:38 smsl-n100 sudo[1254]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 29 20:20:38 smsl-n100 sudo[1254]: pam_unix(sudo:session): session closed for user root Aug 29 20:20:38 smsl-n100 sudo[1256]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 29 20:20:38 smsl-n100 sudo[1256]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 29 20:20:38 smsl-n100 volumio[918]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Aug 29 20:20:38 smsl-n100 volumio[918]: info: Completed loading Core Plugins Aug 29 20:20:38 smsl-n100 sudo[1256]: pam_unix(sudo:session): session closed for user root Aug 29 20:20:38 smsl-n100 volumio[918]: info: Preparing to generate the ALSA configuration file Aug 29 20:20:38 smsl-n100 volumio[918]: info: Volumio Network Manager: Network status updated: 1 Aug 29 20:20:38 smsl-n100 volumio[918]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Aug 29 20:20:38 smsl-n100 volumio[918]: info: VolumeController:: Volume=100 Mute =false Aug 29 20:20:38 smsl-n100 volumio[918]: info: CoreStateMachine::pushState Aug 29 20:20:38 smsl-n100 volumio[918]: info: CorePlayQueue::getTrack 0 Aug 29 20:20:38 smsl-n100 volumio[918]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 29 20:20:38 smsl-n100 volumio[918]: info: CoreCommandRouter::volumioPushState Aug 29 20:20:38 smsl-n100 volumio[918]: info: CoreStateMachine::updateTrackBlock Aug 29 20:20:38 smsl-n100 volumio[918]: info: CorePlayQueue::getTrackBlock Aug 29 20:20:38 smsl-n100 volumio[918]: info: CoreCommandRouter::volumioRetrievevolume Aug 29 20:20:38 smsl-n100 volumio[918]: info: Asound.conf file unchanged, so no further update is needed Aug 29 20:20:38 smsl-n100 volumio[918]: info: Output device has changed, restarting MPD Aug 29 20:20:38 smsl-n100 sudo[1267]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 29 20:20:38 smsl-n100 volumio[918]: info: Output device has changed, restarting Shairport Sync Aug 29 20:20:38 smsl-n100 sudo[1267]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 29 20:20:38 smsl-n100 volumio[918]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 20:20:38 smsl-n100 volumio[918]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 29 20:20:38 smsl-n100 sudo[1267]: pam_unix(sudo:session): session closed for user root Aug 29 20:20:38 smsl-n100 sudo[1269]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 29 20:20:38 smsl-n100 sudo[1269]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 29 20:20:38 smsl-n100 systemd[1]: Stopping Music Player Daemon... Aug 29 20:20:38 smsl-n100 volumio[918]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 29 20:20:38 smsl-n100 volumio[918]: info: ___________ START PLUGINS ___________ Aug 29 20:20:38 smsl-n100 volumio[918]: info: ControllerMpd::onStart: Initializing MPD Aug 29 20:20:38 smsl-n100 volumio[918]: info: Creating MPD Configuration file Aug 29 20:20:39 smsl-n100 sudo[1276]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 29 20:20:39 smsl-n100 sudo[1276]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 29 20:20:39 smsl-n100 volumio[918]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 29 20:20:39 smsl-n100 volumio[918]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 29 20:20:39 smsl-n100 volumio[918]: info: [1756470039091] CoreMusicLibrary::Adding element Media Servers Aug 29 20:20:39 smsl-n100 volumio[918]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 29 20:20:39 smsl-n100 sudo[1276]: pam_unix(sudo:session): session closed for user root Aug 29 20:20:39 smsl-n100 sudo[1278]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 29 20:20:39 smsl-n100 sudo[1278]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 29 20:20:39 smsl-n100 volumio[918]: info: Adding METAVOLUMIO REST API Endpoints Aug 29 20:20:39 smsl-n100 volumio[918]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Aug 29 20:20:39 smsl-n100 volumio[918]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Aug 29 20:20:39 smsl-n100 volumio[918]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Aug 29 20:20:39 smsl-n100 volumio[918]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Aug 29 20:20:39 smsl-n100 volumio[918]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 20:20:39 smsl-n100 volumio[918]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 29 20:20:39 smsl-n100 systemd[1]: mpd.service: Succeeded. Aug 29 20:20:39 smsl-n100 systemd[1]: Stopped Music Player Daemon. Aug 29 20:20:39 smsl-n100 systemd[1]: Starting Music Player Daemon... Aug 29 20:20:39 smsl-n100 volumio[918]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 29 20:20:39 smsl-n100 volumio[918]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 20:20:39 smsl-n100 volumio[918]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 29 20:20:39 smsl-n100 volumio[918]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 29 20:20:39 smsl-n100 volumio[918]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 29 20:20:39 smsl-n100 volumio[918]: info: [1756470039394] CoreMusicLibrary::Adding element Last_100 Aug 29 20:20:39 smsl-n100 volumio[918]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 29 20:20:39 smsl-n100 volumio[918]: info: Streaming services startup Aug 29 20:20:39 smsl-n100 volumio[918]: info: Starting Streaming Daemon Aug 29 20:20:39 smsl-n100 sudo[1282]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 29 20:20:39 smsl-n100 sudo[1282]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 29 20:20:39 smsl-n100 sudo[1282]: pam_unix(sudo:session): session closed for user root Aug 29 20:20:39 smsl-n100 sudo[1290]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Aug 29 20:20:39 smsl-n100 sudo[1290]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 29 20:20:39 smsl-n100 sudo[1290]: pam_unix(sudo:session): session closed for user root Aug 29 20:20:39 smsl-n100 volumio[918]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 29 20:20:39 smsl-n100 volumio[918]: info: [1756470039588] CoreMusicLibrary::Adding element Webradio Aug 29 20:20:39 smsl-n100 volumio[918]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 29 20:20:39 smsl-n100 volumio[918]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 29 20:20:39 smsl-n100 volumio[918]: info: Initializing BBC Radios Aug 29 20:20:39 smsl-n100 sudo[1298]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 29 20:20:39 smsl-n100 sudo[1298]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 29 20:20:39 smsl-n100 sudo[1298]: pam_unix(sudo:session): session closed for user root Aug 29 20:20:39 smsl-n100 volumio[918]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 29 20:20:39 smsl-n100 volumio[918]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 29 20:20:39 smsl-n100 volumio[918]: error: Hi Res Audio Failed Login: Missing Login Data Aug 29 20:20:39 smsl-n100 volumio[918]: info: Adding HIGHRESAUDIO REST API Endpoints Aug 29 20:20:39 smsl-n100 volumio[918]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Aug 29 20:20:39 smsl-n100 volumio[918]: info: Initializing Serial Communication on port /dev/ttyS1 Aug 29 20:20:39 smsl-n100 volumio[918]: info: Touch Event Listener Process Starting Aug 29 20:20:39 smsl-n100 volumio[918]: info: Adding inputs REST Endpoints Aug 29 20:20:39 smsl-n100 volumio[918]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs Aug 29 20:20:39 smsl-n100 volumio[918]: info: Scanning Audio Inputs Aug 29 20:20:39 smsl-n100 sudo[1312]: pam_unix(sudo:auth): conversation failed Aug 29 20:20:39 smsl-n100 sudo[1312]: pam_unix(sudo:auth): auth could not identify password for [volumio] Aug 29 20:20:39 smsl-n100 volumio[918]: info: Checking against Known Cards name Aug 29 20:20:39 smsl-n100 volumio[918]: info: Adding Server instance for streaming Aug 29 20:20:40 smsl-n100 volumio[918]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 29 20:20:40 smsl-n100 volumio[918]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 29 20:20:40 smsl-n100 volumio[918]: info: Initializing GPIOs Aug 29 20:20:40 smsl-n100 kernel: gpio gpiochip3: Persistence not supported for GPIO 1 Aug 29 20:20:40 smsl-n100 kernel: gpio gpiochip2: Persistence not supported for GPIO 15 Aug 29 20:20:40 smsl-n100 kernel: gpio gpiochip3: Persistence not supported for GPIO 0 Aug 29 20:20:40 smsl-n100 kernel: gpio gpiochip2: Persistence not supported for GPIO 2 Aug 29 20:20:40 smsl-n100 volumio[918]: info: Starting Button Listener Aug 29 20:20:40 smsl-n100 volumio[918]: info: Turning off Green LED Aug 29 20:20:40 smsl-n100 volumio[918]: info: Tuning on Blue LED Aug 29 20:20:40 smsl-n100 volumio[918]: info: Signaling System Ready Aug 29 20:20:40 smsl-n100 volumio[918]: info: Volumio Calling Home Aug 29 20:20:40 smsl-n100 volumio[918]: info: Stopping AccessToken refresher cron for QOBUZ Aug 29 20:20:40 smsl-n100 volumio[918]: info: AccessToken refresher cron started for QOBUZ Aug 29 20:20:40 smsl-n100 volumio[918]: info: Stopping AccessToken refresher cron Aug 29 20:20:40 smsl-n100 volumio[918]: info: AccessToken refresher cron started Aug 29 20:20:40 smsl-n100 volumio[918]: info: Adding TIDAL REST API Endpoints Aug 29 20:20:40 smsl-n100 volumio[918]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal Aug 29 20:20:40 smsl-n100 volumio[918]: info: Adding QOBUZ REST API Endpoints Aug 29 20:20:40 smsl-n100 volumio[918]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz Aug 29 20:20:40 smsl-n100 volumio[918]: info: Setting Device type: NanoPi NEO 3 Aug 29 20:20:40 smsl-n100 volumio[918]: info: CoreStateMachine::setRepeat true single undefined Aug 29 20:20:40 smsl-n100 volumio[918]: info: CoreStateMachine::pushState Aug 29 20:20:40 smsl-n100 volumio[918]: info: CorePlayQueue::getTrack 0 Aug 29 20:20:40 smsl-n100 volumio[918]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 29 20:20:40 smsl-n100 volumio[918]: info: CoreCommandRouter::volumioPushState Aug 29 20:20:40 smsl-n100 volumio[918]: info: CoreStateMachine::setRandom null Aug 29 20:20:40 smsl-n100 volumio[918]: info: CoreStateMachine::pushState Aug 29 20:20:40 smsl-n100 volumio[918]: info: CorePlayQueue::getTrack 0 Aug 29 20:20:40 smsl-n100 volumio[918]: info: CoreCommandRouter::volumioPushState Aug 29 20:20:41 smsl-n100 volumio[918]: info: Serial port opened successfully Aug 29 20:20:41 smsl-n100 volumio[918]: info: Sending serial start messages Aug 29 20:20:41 smsl-n100 volumio[918]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 20:20:41 smsl-n100 volumio[918]: info: Reporting MCU Network Status: 1 Aug 29 20:20:41 smsl-n100 volumio[918]: info: Touch Event Listener Process Closed Aug 29 20:20:41 smsl-n100 volumio[918]: error: Cannot start Volumio Streaming Daemon Aug 29 20:20:41 smsl-n100 volumio[918]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Aug 29 20:20:41 smsl-n100 volumio[918]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Aug 29 20:20:41 smsl-n100 volumio[918]: info: MPD Permissions set Aug 29 20:20:41 smsl-n100 volumio[918]: info: MPD Permissions set Aug 29 20:20:41 smsl-n100 volumio[918]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setDeviceVolumeOverride Aug 29 20:20:41 smsl-n100 volumio[918]: info: Setting Device Volume Override Aug 29 20:20:41 smsl-n100 volumio[918]: info: CoreCommandRouter::volumioUpdateVolumeSettings Aug 29 20:20:41 smsl-n100 volumio[918]: info: Updating Volume Controller Parameters: Device: 5 Name: D90 III Discrete Mixer: D90 III Discrete Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Aug 29 20:20:41 smsl-n100 volumio[918]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Aug 29 20:20:41 smsl-n100 volumio[918]: info: Disabling external Volume Control Aug 29 20:20:41 smsl-n100 volumio[918]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 20:20:41 smsl-n100 volumio[918]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 29 20:20:41 smsl-n100 volumio[918]: info: CoreStateMachine::pushState Aug 29 20:20:41 smsl-n100 volumio[918]: info: CorePlayQueue::getTrack 0 Aug 29 20:20:41 smsl-n100 volumio[918]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 29 20:20:41 smsl-n100 volumio[918]: info: CoreCommandRouter::volumioPushState Aug 29 20:20:41 smsl-n100 volumio[918]: error: Serial API: Failed to decode command: 100, message: undefined Aug 29 20:20:41 smsl-n100 volumio[918]: error: Serial API: Failed to decode command: MAXVOL, message: Aug 29 20:20:41 smsl-n100 volumio[918]: error: Serial API: Failed to decode command: 100, message: undefined Aug 29 20:20:41 smsl-n100 volumio[918]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Aug 29 20:20:41 smsl-n100 sudo[1347]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Aug 29 20:20:41 smsl-n100 sudo[1347]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 29 20:20:41 smsl-n100 volumio[918]: info: VolumeController:: Volume=100 Mute =false Aug 29 20:20:41 smsl-n100 volumio[918]: info: CoreStateMachine::pushState Aug 29 20:20:41 smsl-n100 volumio[918]: info: CorePlayQueue::getTrack 0 Aug 29 20:20:41 smsl-n100 volumio[918]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 29 20:20:41 smsl-n100 volumio[918]: info: CoreCommandRouter::volumioPushState Aug 29 20:20:41 smsl-n100 volumio[918]: info: Volumio called home Aug 29 20:20:41 smsl-n100 volumio[918]: info: CoreStateMachine::pushState Aug 29 20:20:41 smsl-n100 volumio[918]: info: CorePlayQueue::getTrack 0 Aug 29 20:20:41 smsl-n100 volumio[918]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 29 20:20:41 smsl-n100 volumio[918]: info: CoreCommandRouter::volumioPushState Aug 29 20:20:41 smsl-n100 volumio[918]: error: Serial API: Failed to decode command: 100, message: undefined Aug 29 20:20:41 smsl-n100 volumio[918]: error: Serial API: Failed to decode command: MAXVOL, message: Aug 29 20:20:41 smsl-n100 volumio[918]: error: Serial API: Failed to decode command: 100, message: undefined Aug 29 20:20:41 smsl-n100 volumio[918]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Aug 29 20:20:41 smsl-n100 volumio[918]: info: CoreStateMachine::pushState Aug 29 20:20:41 smsl-n100 volumio[918]: info: CorePlayQueue::getTrack 0 Aug 29 20:20:41 smsl-n100 volumio[918]: info: CoreCommandRouter::volumioPushState Aug 29 20:20:41 smsl-n100 volumio[918]: error: Serial API: Failed to decode command: 100, message: undefined Aug 29 20:20:41 smsl-n100 systemd[1]: Started UPnP Renderer front-end to MPD. Aug 29 20:20:41 smsl-n100 volumio[918]: error: Serial API: Failed to decode command: MAXVOL, message: Aug 29 20:20:41 smsl-n100 volumio[918]: error: Serial API: Failed to decode command: 100, message: undefined Aug 29 20:20:41 smsl-n100 volumio[918]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Aug 29 20:20:41 smsl-n100 volumio[918]: error: Serial API: Failed to decode command: 1, message: undefined Aug 29 20:20:41 smsl-n100 volumio[918]: info: Discovery: adding 591cb836-2a0f-4cf1-a23d-4e5f04138128 Aug 29 20:20:41 smsl-n100 volumio[918]: info: Discovery: Found device SMSL N100 Aug 29 20:20:41 smsl-n100 volumio[918]: info: CoreCommandRouter::volumioGetState Aug 29 20:20:41 smsl-n100 volumio[918]: info: CorePlayQueue::getTrack 0 Aug 29 20:20:41 smsl-n100 sudo[1347]: pam_unix(sudo:session): session closed for user root Aug 29 20:20:41 smsl-n100 volumio[918]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 29 20:20:41 smsl-n100 volumio[918]: Error: The value NaN is not a number Aug 29 20:20:41 smsl-n100 volumio[918]: at Config.forceToType (/volumio/node_modules/v-conf/index.js:322:20) Aug 29 20:20:41 smsl-n100 volumio[918]: at Config.set (/volumio/node_modules/v-conf/index.js:153:25) Aug 29 20:20:41 smsl-n100 volumio[918]: at ControllerVolumioDiscovery.updateMultiroomDevice (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:323:25) Aug 29 20:20:41 smsl-n100 volumio[918]: at ControllerVolumioDiscovery.connectToRemoteVolumio (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:273:10) Aug 29 20:20:41 smsl-n100 volumio[918]: at Browser. (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:192:12) Aug 29 20:20:41 smsl-n100 volumio[918]: at Browser.emit (events.js:400:28) Aug 29 20:20:41 smsl-n100 volumio[918]: at on_resolver_done (/volumio/node_modules/mdns/lib/browser.js:31:14) Aug 29 20:20:41 smsl-n100 volumio[918]: at next (/volumio/node_modules/mdns/lib/browser.js:106:7) Aug 29 20:20:41 smsl-n100 volumio[918]: at Array.makeAddressesUnique (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:177:5) Aug 29 20:20:41 smsl-n100 volumio[918]: at next (/volumio/node_modules/mdns/lib/browser.js:109:21) Aug 29 20:20:41 smsl-n100 volumio[918]: at /volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:160:11 Aug 29 20:20:41 smsl-n100 volumio[918]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:108:7) Aug 29 20:20:41 smsl-n100 volumio[918]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) Aug 29 20:20:41 smsl-n100 volumio[918]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 29 20:20:42 smsl-n100 sudo[1373]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-08-29 20:19 Aug 29 20:20:42 smsl-n100 sudo[1373]: 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"