-- Logs begin at Sun 2025-05-18 21:32:43 JST, end at Sun 2025-05-18 21:41:56 JST. -- May 18 21:41:31 smsl-n100 systemd-timedated[1794]: Changed local time to Sun May 18 21:41:31 2025 May 18 21:41:31 smsl-n100 sudo[1790]: pam_unix(sudo:session): session closed for user root May 18 21:41:31 smsl-n100 volumio-time-update[549]: volumio-time-update-util: System time updated successfully. May 18 21:41:31 smsl-n100 systemd[1]: Started Volumio Time Update Utility. May 18 21:41:31 smsl-n100 systemd[1]: Reached target Multi-User System. May 18 21:41:31 smsl-n100 systemd[1]: Reached target Graphical Interface. May 18 21:41:31 smsl-n100 systemd[1]: Starting Update UTMP about System Runlevel Changes... May 18 21:41:31 smsl-n100 ntpd[1756]: Soliciting pool server 129.250.35.251 May 18 21:41:31 smsl-n100 ntpd[1756]: Soliciting pool server 122.215.240.51 May 18 21:41:31 smsl-n100 volumio[1764]: info: Loading plugin "appearance"... May 18 21:41:31 smsl-n100 systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. May 18 21:41:31 smsl-n100 systemd[1]: Started Update UTMP about System Runlevel Changes. May 18 21:41:31 smsl-n100 systemd[1]: Startup finished in 5.957s (kernel) + 3min 2.271s (userspace) = 3min 8.229s. May 18 21:41:32 smsl-n100 ntpd[1756]: Soliciting pool server 103.131.151.30 May 18 21:41:32 smsl-n100 ntpd[1756]: Soliciting pool server 2600:3c18::f03c:95ff:fed8:d9d May 18 21:41:32 smsl-n100 volumio[1764]: info: Loading plugin "network"... May 18 21:41:32 smsl-n100 volumio[1764]: info: Refreshing Cached IP Addresses May 18 21:41:32 smsl-n100 sudo[1800]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 18 21:41:32 smsl-n100 sudo[1800]: pam_unix(sudo:session): session opened for user root by (uid=0) May 18 21:41:32 smsl-n100 sudo[1800]: pam_unix(sudo:session): session closed for user root May 18 21:41:33 smsl-n100 sudo[1802]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 18 21:41:33 smsl-n100 sudo[1802]: pam_unix(sudo:session): session opened for user root by (uid=0) May 18 21:41:33 smsl-n100 sudo[1802]: pam_unix(sudo:session): session closed for user root May 18 21:41:33 smsl-n100 volumio[1764]: info: Loading plugin "services"... May 18 21:41:33 smsl-n100 volumio[1764]: info: Loading plugin "alsa_controller"... May 18 21:41:33 smsl-n100 sudo[1811]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan May 18 21:41:33 smsl-n100 sudo[1811]: pam_unix(sudo:session): session opened for user root by (uid=0) May 18 21:41:33 smsl-n100 volumio[1764]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 18 21:41:33 smsl-n100 volumio[1764]: info: Loading plugin "wizard"... May 18 21:41:33 smsl-n100 volumio[1764]: info: Loading plugin "networkfs"... May 18 21:41:33 smsl-n100 volumio[1764]: info: Starting Udev Watcher for removable devices May 18 21:41:33 smsl-n100 volumio[1764]: info: Ignoring mount for partition: boot May 18 21:41:33 smsl-n100 volumio[1764]: info: Ignoring mount for partition: volumio May 18 21:41:33 smsl-n100 volumio[1764]: info: Ignoring mount for partition: volumio_data May 18 21:41:33 smsl-n100 volumio[1764]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 18 21:41:33 smsl-n100 volumio[1764]: info: Loading plugin "volumio_command_line_client"... May 18 21:41:33 smsl-n100 volumio[1764]: info: Loading plugin "upnp"... May 18 21:41:33 smsl-n100 volumio[1764]: info: [1747572093372] Starting Upmpd Daemon May 18 21:41:33 smsl-n100 volumio[1764]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 18 21:41:33 smsl-n100 volumio[1764]: info: Loading plugin "my_music"... May 18 21:41:33 smsl-n100 volumio[1764]: info: Loading plugin "mpd"... May 18 21:41:34 smsl-n100 volumio[1764]: info: Loading plugin "upnp_browser"... May 18 21:41:34 smsl-n100 sudo[1828]: 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 18 21:41:34 smsl-n100 sudo[1828]: pam_unix(sudo:session): session opened for user root by (uid=0) May 18 21:41:34 smsl-n100 sudo[1826]: 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 18 21:41:34 smsl-n100 sudo[1826]: pam_unix(sudo:session): session opened for user root by (uid=0) May 18 21:41:34 smsl-n100 kernel: CIFS: Attempting to mount //192.168.0.12/USB May 18 21:41:34 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 18 21:41:34 smsl-n100 kernel: CIFS: Attempting to mount //192.168.0.12/NAS May 18 21:41:34 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 18 21:41:34 smsl-n100 volumio[1764]: info: Plugin bluetooth is not enabled May 18 21:41:34 smsl-n100 volumio[1764]: info: Loading plugin "alarm-clock"... May 18 21:41:34 smsl-n100 volumio[1764]: info: Loading plugin "manifestui"... May 18 21:41:35 smsl-n100 volumio[1764]: info: Loading plugin "metavolumio"... May 18 21:41:36 smsl-n100 volumio-remote-updater[560]: [2025-05-18 21:41:36] [connect] Successful connection May 18 21:41:38 smsl-n100 ntpd[1756]: receive: Unexpected origin timestamp 0xebd45401.0b8971f8 does not match aorg 0000000000.00000000 from server@47.79.37.210 xmt 0xebd45402.48379608 May 18 21:41:38 smsl-n100 ntpd[1756]: receive: Unexpected origin timestamp 0xebd45401.0babc297 does not match aorg 0000000000.00000000 from server@45.77.20.103 xmt 0xebd45402.48c480fc May 18 21:41:38 smsl-n100 ntpd[1756]: receive: Unexpected origin timestamp 0xebd45401.0bb149fa does not match aorg 0000000000.00000000 from server@103.131.151.20 xmt 0xebd45402.4895af29 May 18 21:41:38 smsl-n100 ntpd[1756]: receive: Unexpected origin timestamp 0xebd45401.0bb4f619 does not match aorg 0000000000.00000000 from server@133.130.121.141 xmt 0xebd45402.77c92f0c May 18 21:41:38 smsl-n100 volumio[1764]: info: Loading plugin "airplay_emulation"... May 18 21:41:38 smsl-n100 volumio[1764]: info: Starting Shairport Sync May 18 21:41:38 smsl-n100 volumio[1764]: info: Plugin cd_controller is not enabled May 18 21:41:38 smsl-n100 volumio[1764]: info: Loading plugin "last_100"... May 18 21:41:38 smsl-n100 volumio[1764]: info: Plugin raat is not enabled May 18 21:41:38 smsl-n100 volumio[1764]: info: Loading plugin "streaming_services"... May 18 21:41:39 smsl-n100 sudo[1811]: pam_unix(sudo:session): session closed for user root May 18 21:41:40 smsl-n100 volumio[1764]: info: Starting Streaming Service Transparent Proxy May 18 21:41:40 smsl-n100 volumio[1764]: info: Plugin tidalconnect is not enabled May 18 21:41:40 smsl-n100 volumio[1764]: info: Loading plugin "webradio"... May 18 21:41:40 smsl-n100 volumio[1764]: info: Loading plugin "i2s_dacs"... May 18 21:41:40 smsl-n100 volumio[1764]: info: I2S DAC not set, start Auto-detection May 18 21:41:40 smsl-n100 volumio[1764]: info: Loading plugin "volumiodiscovery"... May 18 21:41:40 smsl-n100 volumio[1764]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 18 21:41:40 smsl-n100 volumio[1764]: *** WARNING *** Please fix your application to use the native API of Avahi! May 18 21:41:40 smsl-n100 node[1764]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 18 21:41:40 smsl-n100 volumio[1764]: *** WARNING *** For more information see May 18 21:41:40 smsl-n100 volumio[1764]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 18 21:41:40 smsl-n100 volumio[1764]: *** WARNING *** Please fix your application to use the native API of Avahi! May 18 21:41:40 smsl-n100 volumio[1764]: *** WARNING *** For more information see May 18 21:41:40 smsl-n100 node[1764]: *** WARNING *** Please fix your application to use the native API of Avahi! May 18 21:41:40 smsl-n100 node[1764]: *** WARNING *** For more information see May 18 21:41:40 smsl-n100 node[1764]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 18 21:41:40 smsl-n100 node[1764]: *** WARNING *** Please fix your application to use the native API of Avahi! May 18 21:41:40 smsl-n100 node[1764]: *** WARNING *** For more information see May 18 21:41:40 smsl-n100 volumio[1764]: info: Applying required configuration parameters for plugin volumiodiscovery May 18 21:41:40 smsl-n100 volumio[1764]: info: Discovery: Started advertising with name: SMSL N100 May 18 21:41:40 smsl-n100 volumio[1764]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 18 21:41:40 smsl-n100 volumio[1764]: info: Plugin multiroom is not enabled May 18 21:41:40 smsl-n100 volumio[1764]: info: Loading plugin "outputs"... May 18 21:41:40 smsl-n100 volumio[1764]: info: Loading plugin "albumart"... May 18 21:41:40 smsl-n100 volumio[1764]: info: Plugin example_plugin is not enabled May 18 21:41:40 smsl-n100 volumio[1764]: info: Loading plugin "hi_res_audio"... May 18 21:41:41 smsl-n100 volumio[1764]: Forking 3 albumart workers May 18 21:41:43 smsl-n100 volumio[1764]: STREAMING PROXY: Starting server on port 3245 May 18 21:41:43 smsl-n100 volumio[1764]: Node JS runtime: 14 May 18 21:41:43 smsl-n100 volumio[1764]: Starting albumart workers May 18 21:41:44 smsl-n100 volumio[1764]: info: Applying required configuration parameters for plugin hi_res_audio May 18 21:41:44 smsl-n100 volumio[1764]: Starting albumart workers May 18 21:41:44 smsl-n100 volumio[1764]: info: Loading plugin "inputs"... May 18 21:41:44 smsl-n100 volumio[1764]: Starting albumart workers May 18 21:41:45 smsl-n100 volumio[1764]: info: Loading plugin "qobuz"... May 18 21:41:45 smsl-n100 kernel: CIFS VFS: Error connecting to socket. Aborting operation. May 18 21:41:45 smsl-n100 kernel: CIFS VFS: cifs_mount failed w/return code = -115 May 18 21:41:45 smsl-n100 kernel: CIFS VFS: cifs_mount failed w/return code = -115 May 18 21:41:45 smsl-n100 sudo[1826]: pam_unix(sudo:session): session closed for user root May 18 21:41:45 smsl-n100 sudo[1828]: pam_unix(sudo:session): session closed for user root May 18 21:41:47 smsl-n100 volumio[1764]: info: Loading plugin "smart_inputs"... May 18 21:41:48 smsl-n100 volumio[1764]: info: Loading plugin "tidal"... May 18 21:41:49 smsl-n100 volumio[1764]: info: Loading plugin "oem_helper"... May 18 21:41:51 smsl-n100 volumio[1764]: info: Applying required configuration parameters for plugin oem_helper May 18 21:41:51 smsl-n100 volumio[1764]: info: Loading plugin "smslcontrol"... May 18 21:41:51 smsl-n100 volumio[1764]: info: Adding this device properties May 18 21:41:51 smsl-n100 volumio[1764]: info: CoreCommandRouter::executeOnPlugin: system , setThisDeviceVolumioProperties May 18 21:41:51 smsl-n100 volumio[1764]: info: Setting Additional Device Volumio Properties: [object Object] May 18 21:41:51 smsl-n100 volumio[1764]: info: Loading plugin "updater_comm"... May 18 21:41:51 smsl-n100 volumio[1764]: info: Plugin mpdemulation is not enabled May 18 21:41:51 smsl-n100 volumio[1764]: info: Loading plugin "rest_api"... May 18 21:41:51 smsl-n100 volumio[1764]: info: Loading plugin "websocket"... May 18 21:41:51 smsl-n100 volumio[1764]: info: Starting Socket.io Server version 2.3.0 May 18 21:41:51 smsl-n100 volumio[1764]: info: Loading i18n strings for locale ja May 18 21:41:51 smsl-n100 volumio[1764]: Updating browse sources language May 18 21:41:51 smsl-n100 volumio[1764]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 18 21:41:52 smsl-n100 volumio[1764]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 18 21:41:52 smsl-n100 volumio[1764]: info: CoreCommandRouter::initPlayerControls May 18 21:41:52 smsl-n100 volumio[1764]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 21:41:52 smsl-n100 volumio[1764]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 21:41:52 smsl-n100 volumio[1764]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 21:41:52 smsl-n100 volumio[1764]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 21:41:52 smsl-n100 volumio[1764]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 21:41:52 smsl-n100 volumio[1764]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 21:41:52 smsl-n100 volumio[1764]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 21:41:52 smsl-n100 volumio[1764]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 21:41:52 smsl-n100 volumio[1764]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 18 21:41:52 smsl-n100 volumio[1764]: Express server listening on port 3000 May 18 21:41:52 smsl-n100 volumio[1764]: [Metrics] WebUI: 22s 636.15ms May 18 21:41:52 smsl-n100 volumio-remote-updater[560]: [2025-05-18 21:41:52] [connect] Successful connection May 18 21:41:52 smsl-n100 volumio[1764]: info: CoreStateMachine::resetVolumioState May 18 21:41:52 smsl-n100 volumio[1764]: info: CoreStateMachine::getcurrentVolume May 18 21:41:52 smsl-n100 volumio[1764]: info: CoreCommandRouter::volumioRetrievevolume May 18 21:41:52 smsl-n100 volumio[1764]: info: CoreStateMachine::pushState May 18 21:41:52 smsl-n100 volumio[1764]: info: CorePlayQueue::getTrack 0 May 18 21:41:52 smsl-n100 volumio[1764]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 18 21:41:52 smsl-n100 volumio[1764]: info: CoreCommandRouter::volumioPushState May 18 21:41:52 smsl-n100 volumio[1764]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 18 21:41:52 smsl-n100 sudo[1966]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 18 21:41:52 smsl-n100 sudo[1966]: pam_unix(sudo:session): session opened for user root by (uid=0) May 18 21:41:52 smsl-n100 sudo[1966]: pam_unix(sudo:session): session closed for user root May 18 21:41:52 smsl-n100 sudo[1968]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 18 21:41:52 smsl-n100 volumio[1764]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' May 18 21:41:52 smsl-n100 volumio[1764]: info: Completed loading Core Plugins May 18 21:41:52 smsl-n100 sudo[1968]: pam_unix(sudo:session): session opened for user root by (uid=0) May 18 21:41:52 smsl-n100 volumio[1764]: info: Preparing to generate the ALSA configuration file May 18 21:41:52 smsl-n100 sudo[1968]: pam_unix(sudo:session): session closed for user root May 18 21:41:52 smsl-n100 volumio[1764]: info: Volumio Network Manager: Network status updated: 3 May 18 21:41:52 smsl-n100 volumio[1764]: info: Cannot mount NAS USB at system boot, trial number 1 ,retrying in 5 seconds May 18 21:41:52 smsl-n100 volumio[1764]: info: Cannot mount NAS NAS at system boot, trial number 1 ,retrying in 5 seconds May 18 21:41:52 smsl-n100 volumio[1764]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision May 18 21:41:52 smsl-n100 volumio-remote-updater[560]: [2025-05-18 21:41:52] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1747572112 101 May 18 21:41:52 smsl-n100 volumio[1764]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 1 May 18 21:41:52 smsl-n100 volumio[1764]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 18 21:41:52 smsl-n100 volumio[1764]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 18 21:41:52 smsl-n100 volumio[1764]: info: Discovery: Getting this device information May 18 21:41:52 smsl-n100 volumio[1764]: info: CoreCommandRouter::volumioGetState May 18 21:41:52 smsl-n100 volumio[1764]: info: CorePlayQueue::getTrack 0 May 18 21:41:52 smsl-n100 volumio[1764]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 18 21:41:52 smsl-n100 volumio[1764]: info: Reloading queue from file May 18 21:41:53 smsl-n100 volumio[1764]: info: Asound.conf file unchanged, so no further update is needed May 18 21:41:53 smsl-n100 volumio[1764]: info: Output device has changed, restarting MPD May 18 21:41:53 smsl-n100 sudo[1977]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 18 21:41:53 smsl-n100 sudo[1977]: pam_unix(sudo:session): session opened for user root by (uid=0) May 18 21:41:53 smsl-n100 volumio[1764]: info: Output device has changed, restarting Shairport Sync May 18 21:41:53 smsl-n100 volumio[1764]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 21:41:53 smsl-n100 volumio[1764]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 18 21:41:53 smsl-n100 sudo[1977]: pam_unix(sudo:session): session closed for user root May 18 21:41:53 smsl-n100 sudo[1979]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 18 21:41:53 smsl-n100 sudo[1979]: pam_unix(sudo:session): session opened for user root by (uid=0) May 18 21:41:53 smsl-n100 systemd[1]: Stopping Music Player Daemon... May 18 21:41:53 smsl-n100 volumio[1764]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 18 21:41:53 smsl-n100 volumio[1764]: info: ___________ START PLUGINS ___________ May 18 21:41:53 smsl-n100 systemd[1]: mpd.service: Succeeded. May 18 21:41:53 smsl-n100 systemd[1]: Stopped Music Player Daemon. May 18 21:41:53 smsl-n100 volumio[1764]: info: ControllerMpd::onStart: Initializing MPD May 18 21:41:53 smsl-n100 volumio[1764]: info: Creating MPD Configuration file May 18 21:41:53 smsl-n100 systemd[1]: Starting Music Player Daemon... May 18 21:41:53 smsl-n100 sudo[1987]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 18 21:41:53 smsl-n100 sudo[1987]: pam_unix(sudo:session): session opened for user root by (uid=0) May 18 21:41:53 smsl-n100 volumio[1764]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 18 21:41:53 smsl-n100 volumio[1764]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 18 21:41:53 smsl-n100 volumio[1764]: info: [1747572113311] CoreMusicLibrary::Adding element DLNAサーバー May 18 21:41:53 smsl-n100 sudo[1987]: pam_unix(sudo:session): session closed for user root May 18 21:41:53 smsl-n100 volumio[1764]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 18 21:41:53 smsl-n100 sudo[1989]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 18 21:41:53 smsl-n100 sudo[1989]: pam_unix(sudo:session): session opened for user root by (uid=0) May 18 21:41:53 smsl-n100 volumio[1764]: info: Adding METAVOLUMIO REST API Endpoints May 18 21:41:53 smsl-n100 systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM May 18 21:41:53 smsl-n100 systemd[1]: mpd.service: Succeeded. May 18 21:41:53 smsl-n100 volumio[1764]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio May 18 21:41:53 smsl-n100 volumio[1764]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio May 18 21:41:53 smsl-n100 volumio[1764]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio May 18 21:41:53 smsl-n100 volumio[1764]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio May 18 21:41:53 smsl-n100 systemd[1]: Stopped Music Player Daemon. May 18 21:41:53 smsl-n100 volumio[1764]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 21:41:53 smsl-n100 volumio[1764]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 18 21:41:53 smsl-n100 systemd[1]: Starting Music Player Daemon... May 18 21:41:53 smsl-n100 volumio[1764]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 18 21:41:53 smsl-n100 volumio[1764]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 21:41:53 smsl-n100 volumio[1764]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 18 21:41:53 smsl-n100 sudo[1992]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 18 21:41:53 smsl-n100 sudo[1992]: pam_unix(sudo:session): session opened for user root by (uid=0) May 18 21:41:53 smsl-n100 volumio[1764]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 18 21:41:53 smsl-n100 volumio[1764]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 18 21:41:53 smsl-n100 volumio[1764]: info: [1747572113601] CoreMusicLibrary::Adding element Last_100 May 18 21:41:53 smsl-n100 volumio[1764]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 18 21:41:53 smsl-n100 sudo[1992]: pam_unix(sudo:session): session closed for user root May 18 21:41:53 smsl-n100 volumio[1764]: info: Streaming services startup May 18 21:41:53 smsl-n100 volumio[1764]: info: Starting Streaming Daemon May 18 21:41:53 smsl-n100 sudo[2002]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service May 18 21:41:53 smsl-n100 sudo[2002]: pam_unix(sudo:session): session opened for user root by (uid=0) May 18 21:41:53 smsl-n100 sudo[2002]: pam_unix(sudo:session): session closed for user root May 18 21:41:53 smsl-n100 volumio[1764]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 18 21:41:53 smsl-n100 volumio[1764]: info: [1747572113753] CoreMusicLibrary::Adding element Webradio May 18 21:41:53 smsl-n100 volumio[1764]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 18 21:41:53 smsl-n100 volumio[1764]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 18 21:41:53 smsl-n100 volumio[1764]: info: Initializing BBC Radios May 18 21:41:53 smsl-n100 volumio[1764]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 18 21:41:53 smsl-n100 volumio[1764]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 18 21:41:53 smsl-n100 volumio[1764]: error: Hi Res Audio Failed Login: Missing Login Data May 18 21:41:53 smsl-n100 volumio[1764]: info: Adding HIGHRESAUDIO REST API Endpoints May 18 21:41:53 smsl-n100 volumio[1764]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio May 18 21:41:53 smsl-n100 volumio[1764]: info: Initializing Serial Communication on port /dev/ttyS1 May 18 21:41:53 smsl-n100 volumio[1764]: info: Touch Event Listener Process Starting May 18 21:41:54 smsl-n100 volumio[1764]: info: Adding inputs REST Endpoints May 18 21:41:54 smsl-n100 volumio[1764]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs May 18 21:41:54 smsl-n100 volumio[1764]: info: Scanning Audio Inputs May 18 21:41:54 smsl-n100 sudo[2019]: pam_unix(sudo:auth): conversation failed May 18 21:41:54 smsl-n100 sudo[2019]: pam_unix(sudo:auth): auth could not identify password for [volumio] May 18 21:41:54 smsl-n100 volumio[1764]: info: Checking against Known Cards name May 18 21:41:54 smsl-n100 volumio[1764]: info: Adding Server instance for streaming May 18 21:41:54 smsl-n100 volumio[1764]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 18 21:41:54 smsl-n100 volumio[1764]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 18 21:41:54 smsl-n100 volumio[1764]: info: Initializing GPIOs May 18 21:41:54 smsl-n100 volumio[1764]: info: Starting Button Listener May 18 21:41:54 smsl-n100 volumio[1764]: info: Turning off Green LED May 18 21:41:54 smsl-n100 volumio[1764]: info: Tuning on Blue LED May 18 21:41:54 smsl-n100 volumio[1764]: info: Signaling System Ready May 18 21:41:54 smsl-n100 volumio[1764]: info: Volumio Calling Home May 18 21:41:54 smsl-n100 volumio[1764]: info: Stopping AccessToken refresher cron for QOBUZ May 18 21:41:54 smsl-n100 volumio[1764]: info: AccessToken refresher cron started for QOBUZ May 18 21:41:54 smsl-n100 volumio[1764]: info: Stopping AccessToken refresher cron May 18 21:41:54 smsl-n100 volumio[1764]: info: AccessToken refresher cron started May 18 21:41:54 smsl-n100 volumio[1764]: info: Adding TIDAL REST API Endpoints May 18 21:41:54 smsl-n100 volumio[1764]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal May 18 21:41:54 smsl-n100 volumio[1764]: info: Adding QOBUZ REST API Endpoints May 18 21:41:54 smsl-n100 volumio[1764]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz May 18 21:41:54 smsl-n100 volumio[1764]: info: CoreStateMachine::setRepeat false single undefined May 18 21:41:54 smsl-n100 volumio[1764]: info: CoreStateMachine::pushState May 18 21:41:54 smsl-n100 volumio[1764]: info: CorePlayQueue::getTrack 0 May 18 21:41:54 smsl-n100 volumio[1764]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 18 21:41:54 smsl-n100 volumio[1764]: info: CoreCommandRouter::volumioPushState May 18 21:41:54 smsl-n100 volumio[1764]: info: CoreStateMachine::setRandom null May 18 21:41:54 smsl-n100 volumio[1764]: info: CoreStateMachine::pushState May 18 21:41:54 smsl-n100 volumio[1764]: info: CorePlayQueue::getTrack 0 May 18 21:41:54 smsl-n100 volumio[1764]: info: CoreCommandRouter::volumioPushState May 18 21:41:54 smsl-n100 volumio[1764]: info: Setting Device type: NanoPi NEO 3 May 18 21:41:55 smsl-n100 volumio[1764]: info: Serial port opened successfully May 18 21:41:55 smsl-n100 volumio[1764]: info: Sending serial start messages May 18 21:41:55 smsl-n100 volumio[1764]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 21:41:55 smsl-n100 volumio[1764]: info: Reporting MCU Network Status: 3 May 18 21:41:55 smsl-n100 volumio[1764]: info: Touch Event Listener Process Closed May 18 21:41:55 smsl-n100 volumio[1764]: error: Cannot start Volumio Streaming Daemon May 18 21:41:55 smsl-n100 volumio[1764]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service May 18 21:41:55 smsl-n100 volumio[1764]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. May 18 21:41:55 smsl-n100 volumio[1764]: info: MPD Permissions set May 18 21:41:55 smsl-n100 volumio[1764]: info: MPD Permissions set May 18 21:41:55 smsl-n100 volumio[1764]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setDeviceVolumeOverride May 18 21:41:55 smsl-n100 volumio[1764]: info: Setting Device Volume Override May 18 21:41:55 smsl-n100 volumio[1764]: info: CoreCommandRouter::volumioUpdateVolumeSettings May 18 21:41:55 smsl-n100 volumio[1764]: info: Updating Volume Controller Parameters: Device: 1 Name: SPDIF Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 May 18 21:41:55 smsl-n100 volumio[1764]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume May 18 21:41:55 smsl-n100 volumio[1764]: info: Disabling external Volume Control May 18 21:41:55 smsl-n100 volumio[1764]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 21:41:55 smsl-n100 volumio[1764]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 21:41:55 smsl-n100 volumio[1764]: info: CoreStateMachine::pushState May 18 21:41:55 smsl-n100 volumio[1764]: info: CorePlayQueue::getTrack 0 May 18 21:41:55 smsl-n100 volumio[1764]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 18 21:41:55 smsl-n100 volumio[1764]: info: CoreCommandRouter::volumioPushState May 18 21:41:55 smsl-n100 volumio[1764]: error: Serial API: Failed to decode command: 100, message: undefined May 18 21:41:55 smsl-n100 volumio[1764]: error: Serial API: Failed to decode command: MAXVOL, message: May 18 21:41:55 smsl-n100 volumio[1764]: error: Serial API: Failed to decode command: 100, message: undefined May 18 21:41:55 smsl-n100 volumio[1764]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff May 18 21:41:55 smsl-n100 volumio[1764]: info: CoreStateMachine::pushState May 18 21:41:55 smsl-n100 volumio[1764]: info: CorePlayQueue::getTrack 0 May 18 21:41:55 smsl-n100 volumio[1764]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 18 21:41:55 smsl-n100 volumio[1764]: info: CoreCommandRouter::volumioPushState May 18 21:41:55 smsl-n100 volumio[1764]: info: CoreStateMachine::pushState May 18 21:41:55 smsl-n100 volumio[1764]: info: CorePlayQueue::getTrack 0 May 18 21:41:55 smsl-n100 volumio[1764]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 18 21:41:55 smsl-n100 volumio[1764]: info: CoreCommandRouter::volumioPushState May 18 21:41:55 smsl-n100 sudo[2055]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service May 18 21:41:55 smsl-n100 sudo[2055]: pam_unix(sudo:session): session opened for user root by (uid=0) May 18 21:41:55 smsl-n100 volumio[1764]: error: Serial API: Failed to decode command: 100, message: undefined May 18 21:41:55 smsl-n100 volumio[1764]: error: Serial API: Failed to decode command: MAXVOL, message: May 18 21:41:55 smsl-n100 volumio[1764]: error: Serial API: Failed to decode command: 100, message: undefined May 18 21:41:55 smsl-n100 volumio[1764]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff May 18 21:41:55 smsl-n100 volumio[1764]: info: CoreStateMachine::pushState May 18 21:41:55 smsl-n100 volumio[1764]: info: CorePlayQueue::getTrack 0 May 18 21:41:55 smsl-n100 volumio[1764]: info: CoreCommandRouter::volumioPushState May 18 21:41:55 smsl-n100 volumio[1764]: error: Serial API: Failed to decode command: 100, message: undefined May 18 21:41:55 smsl-n100 volumio[1764]: error: Serial API: Failed to decode command: MAXVOL, message: May 18 21:41:55 smsl-n100 volumio[1764]: error: Serial API: Failed to decode command: 100, message: undefined May 18 21:41:55 smsl-n100 volumio[1764]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff May 18 21:41:55 smsl-n100 volumio[1764]: error: Serial API: Failed to decode command: 3, message: undefined May 18 21:41:55 smsl-n100 sudo[2055]: pam_unix(sudo:session): session closed for user root May 18 21:41:55 smsl-n100 volumio[1764]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 May 18 21:41:55 smsl-n100 volumio[1764]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 21:41:55 smsl-n100 volumio[1764]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 21:41:55 smsl-n100 volumio[1764]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 21:41:55 smsl-n100 volumio[1764]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 21:41:55 smsl-n100 volumio[1764]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 21:41:55 smsl-n100 volumio[1764]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 18 21:41:55 smsl-n100 volumio[1764]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber May 18 21:41:55 smsl-n100 volumio[1764]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 21:41:55 smsl-n100 volumio[1764]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 21:41:55 smsl-n100 volumio[1764]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 21:41:55 smsl-n100 volumio[1764]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 21:41:55 smsl-n100 volumio[1764]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 21:41:55 smsl-n100 volumio[1764]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 21:41:55 smsl-n100 volumio[1764]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 21:41:55 smsl-n100 volumio[1764]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 21:41:55 smsl-n100 volumio[1764]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 21:41:55 smsl-n100 volumio[1764]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 18 21:41:55 smsl-n100 volumio[1764]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber May 18 21:41:55 smsl-n100 volumio[1764]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 18 21:41:55 smsl-n100 volumio[1764]: info: CoreStateMachine::pushState May 18 21:41:55 smsl-n100 volumio[1764]: info: CorePlayQueue::getTrack 0 May 18 21:41:55 smsl-n100 volumio[1764]: info: CoreCommandRouter::volumioPushState May 18 21:41:55 smsl-n100 volumio[1764]: error: Serial API: Failed to decode command: 100, message: undefined May 18 21:41:55 smsl-n100 volumio[1764]: error: Serial API: Failed to decode command: MAXVOL, message: May 18 21:41:55 smsl-n100 volumio[1764]: error: Serial API: Failed to decode command: 100, message: undefined May 18 21:41:55 smsl-n100 volumio[1764]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff May 18 21:41:55 smsl-n100 volumio[1764]: info: Discovery: adding 2a96ea59-075c-4c4c-8bcd-0a4edfd023cf May 18 21:41:55 smsl-n100 volumio[1764]: info: Discovery: Found device SMSL N100 May 18 21:41:55 smsl-n100 volumio[1764]: info: CoreCommandRouter::volumioGetState May 18 21:41:55 smsl-n100 volumio[1764]: info: CorePlayQueue::getTrack 0 May 18 21:41:55 smsl-n100 volumio[1764]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 18 21:41:55 smsl-n100 volumio[1764]: Error: The value NaN is not a number May 18 21:41:55 smsl-n100 volumio[1764]: at Config.forceToType (/volumio/node_modules/v-conf/index.js:322:20) May 18 21:41:55 smsl-n100 volumio[1764]: at Config.set (/volumio/node_modules/v-conf/index.js:153:25) May 18 21:41:55 smsl-n100 volumio[1764]: at ControllerVolumioDiscovery.updateMultiroomDevice (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:323:25) May 18 21:41:55 smsl-n100 volumio[1764]: at ControllerVolumioDiscovery.connectToRemoteVolumio (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:273:10) May 18 21:41:55 smsl-n100 volumio[1764]: at Browser. (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:192:12) May 18 21:41:55 smsl-n100 volumio[1764]: at Browser.emit (events.js:400:28) May 18 21:41:55 smsl-n100 volumio[1764]: at on_resolver_done (/volumio/node_modules/mdns/lib/browser.js:31:14) May 18 21:41:55 smsl-n100 volumio[1764]: at next (/volumio/node_modules/mdns/lib/browser.js:106:7) May 18 21:41:55 smsl-n100 volumio[1764]: at Array.makeAddressesUnique (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:177:5) May 18 21:41:55 smsl-n100 volumio[1764]: at next (/volumio/node_modules/mdns/lib/browser.js:109:21) May 18 21:41:55 smsl-n100 volumio[1764]: at /volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:160:11 May 18 21:41:55 smsl-n100 volumio[1764]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:108:7) May 18 21:41:55 smsl-n100 volumio[1764]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) May 18 21:41:55 smsl-n100 volumio[1764]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 18 21:41:56 smsl-n100 systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM May 18 21:41:56 smsl-n100 systemd[1]: mpd.service: Failed with result 'protocol'. May 18 21:41:56 smsl-n100 systemd[1]: Failed to start Music Player Daemon. May 18 21:41:56 smsl-n100 sudo[1989]: pam_unix(sudo:session): session closed for user root May 18 21:41:56 smsl-n100 sudo[1979]: pam_unix(sudo:session): session closed for user root May 18 21:41:56 smsl-n100 systemd[1]: Starting Music Player Daemon... May 18 21:41:56 smsl-n100 sudo[2081]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-18 21:40 May 18 21:41:56 smsl-n100 sudo[2081]: 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"