-- Logs begin at Sun 2023-03-26 01:25:59 UTC, end at Mon 2025-12-08 13:23:10 UTC. -- Dec 08 13:22:30 minidsp-shd systemd[1]: Time has been changed Dec 08 13:22:30 minidsp-shd volumio[807]: info: Loading plugin "network"... Dec 08 13:22:30 minidsp-shd volumio[807]: info: Refreshing Cached IP Addresses Dec 08 13:22:30 minidsp-shd volumio[807]: info: Loading plugin "services"... Dec 08 13:22:30 minidsp-shd sudo[914]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 08 13:22:30 minidsp-shd sudo[914]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 08 13:22:30 minidsp-shd volumio[807]: info: Loading plugin "alsa_controller"... Dec 08 13:22:30 minidsp-shd sudo[914]: pam_unix(sudo:session): session closed for user root Dec 08 13:22:30 minidsp-shd sudo[916]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 08 13:22:30 minidsp-shd sudo[916]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 08 13:22:30 minidsp-shd sudo[916]: pam_unix(sudo:session): session closed for user root Dec 08 13:22:30 minidsp-shd volumio[807]: info: Loading plugin "wizard"... Dec 08 13:22:30 minidsp-shd volumio[807]: info: Loading plugin "volumio_command_line_client"... Dec 08 13:22:30 minidsp-shd volumio[807]: info: Loading plugin "upnp"... Dec 08 13:22:30 minidsp-shd volumio[807]: info: [1765200150861] Starting Upmpd Daemon Dec 08 13:22:30 minidsp-shd volumio[807]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 08 13:22:30 minidsp-shd volumio[807]: info: Loading plugin "my_music"... Dec 08 13:22:30 minidsp-shd volumio[807]: info: Loading plugin "mpd"... Dec 08 13:22:31 minidsp-shd volumio[807]: info: Loading plugin "upnp_browser"... Dec 08 13:22:32 minidsp-shd volumio[807]: info: Loading plugin "networkfs"... Dec 08 13:22:32 minidsp-shd volumio[807]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 08 13:22:32 minidsp-shd volumio[807]: info: Loading plugin "bluetooth"... Dec 08 13:22:32 minidsp-shd sudo[928]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=admin,password=dtao72025,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.50.68/Music /mnt/NAS/Asustor_Nas Dec 08 13:22:32 minidsp-shd sudo[928]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 08 13:22:33 minidsp-shd kernel: FS-Cache: Netfs 'cifs' registered for caching Dec 08 13:22:33 minidsp-shd kernel: Key type cifs.spnego registered Dec 08 13:22:33 minidsp-shd kernel: Key type cifs.idmap registered Dec 08 13:22:33 minidsp-shd kernel: CIFS: Attempting to mount //192.168.50.68/Music Dec 08 13:22:33 minidsp-shd 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. Dec 08 13:22:33 minidsp-shd volumio[807]: info: [1765200153437] Starting BluetoothController Dec 08 13:22:33 minidsp-shd volumio[807]: info: Loading plugin "alarm-clock"... Dec 08 13:22:34 minidsp-shd volumio[807]: info: Loading plugin "metavolumio"... Dec 08 13:22:34 minidsp-shd volumio[807]: info: Loading plugin "airplay_emulation"... Dec 08 13:22:34 minidsp-shd volumio[807]: info: Starting Shairport Sync Dec 08 13:22:34 minidsp-shd volumio[807]: info: Loading plugin "cd_controller"... Dec 08 13:22:34 minidsp-shd volumio[807]: info: Loading plugin "last_100"... Dec 08 13:22:34 minidsp-shd volumio[807]: info: Loading plugin "raat"... Dec 08 13:22:34 minidsp-shd volumio[807]: info: RAAT Plugin loaded Dec 08 13:22:34 minidsp-shd volumio[807]: info: Adding restartRAATSocket REST API Endpoint Dec 08 13:22:34 minidsp-shd volumio[807]: info: Adding restartRAATSocket REST Endpoint for plugin: music_service/raat Dec 08 13:22:34 minidsp-shd volumio[807]: info: CoreCommandRouter::executeOnPlugin: inputs , getVolume Dec 08 13:22:34 minidsp-shd volumio[807]: error: Could not retrieve plugin music_service inputs Dec 08 13:22:34 minidsp-shd volumio[807]: info: CoreCommandRouter::executeOnPlugin: inputs , getDSP Dec 08 13:22:34 minidsp-shd volumio[807]: error: Could not retrieve plugin music_service inputs Dec 08 13:22:34 minidsp-shd volumio[807]: info: Loading plugin "streaming_services"... Dec 08 13:22:34 minidsp-shd volumio[807]: info: Loading plugin "tidalconnect"... Dec 08 13:22:35 minidsp-shd volumio[807]: info: Loading plugin "webradio"... Dec 08 13:22:35 minidsp-shd volumio[807]: info: Loading plugin "i2s_dacs"... Dec 08 13:22:35 minidsp-shd volumio[807]: info: I2S DAC not set, start Auto-detection Dec 08 13:22:35 minidsp-shd volumio[807]: info: Loading plugin "volumiodiscovery"... Dec 08 13:22:35 minidsp-shd volumio[807]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 08 13:22:35 minidsp-shd node[807]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 08 13:22:35 minidsp-shd node[807]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 08 13:22:35 minidsp-shd node[807]: *** WARNING *** For more information see Dec 08 13:22:35 minidsp-shd node[807]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 08 13:22:35 minidsp-shd node[807]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 08 13:22:35 minidsp-shd node[807]: *** WARNING *** For more information see Dec 08 13:22:35 minidsp-shd volumio[807]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 08 13:22:35 minidsp-shd volumio[807]: *** WARNING *** For more information see Dec 08 13:22:35 minidsp-shd volumio[807]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 08 13:22:35 minidsp-shd volumio[807]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 08 13:22:35 minidsp-shd volumio[807]: *** WARNING *** For more information see Dec 08 13:22:35 minidsp-shd volumio[807]: info: Applying required configuration parameters for plugin volumiodiscovery Dec 08 13:22:35 minidsp-shd volumio[807]: Discovery: StartAdv! undefined Dec 08 13:22:35 minidsp-shd volumio[807]: Discovery: Started advertising... minidsp-shd - undefined Dec 08 13:22:35 minidsp-shd volumio[807]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 08 13:22:35 minidsp-shd volumio[807]: info: Loading plugin "outputs"... Dec 08 13:22:35 minidsp-shd volumio[807]: info: Loading plugin "albumart"... Dec 08 13:22:35 minidsp-shd volumio[807]: info: Loading plugin "ms_surface_dial"... Dec 08 13:22:36 minidsp-shd volumio[807]: Forking 3 albumart workers Dec 08 13:22:37 minidsp-shd volumio[807]: info: Applying required configuration parameters for plugin ms_surface_dial Dec 08 13:22:37 minidsp-shd volumio[807]: info: Plugin example_plugin is not enabled Dec 08 13:22:37 minidsp-shd volumio[807]: info: Loading plugin "hi_res_audio"... Dec 08 13:22:37 minidsp-shd volumio[807]: info: Applying required configuration parameters for plugin hi_res_audio Dec 08 13:22:37 minidsp-shd volumio[807]: info: Loading plugin "inputs"... Dec 08 13:22:37 minidsp-shd volumio[807]: info: Loading plugin "qobuz"... Dec 08 13:22:38 minidsp-shd volumio[807]: Starting albumart workers Dec 08 13:22:38 minidsp-shd volumio[807]: Starting albumart workers Dec 08 13:22:38 minidsp-shd volumio[807]: Starting albumart workers Dec 08 13:22:38 minidsp-shd nmbd[877]: [2025/12/08 13:22:38.372215, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Dec 08 13:22:38 minidsp-shd nmbd[877]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.0.86 for name WORKGROUP<1d>. Dec 08 13:22:38 minidsp-shd nmbd[877]: This response was from IP 192.168.0.88, reporting an IP address of 192.168.0.88. Dec 08 13:22:41 minidsp-shd volumio[807]: info: Loading plugin "tidal"... Dec 08 13:22:43 minidsp-shd kernel: CIFS VFS: Error connecting to socket. Aborting operation. Dec 08 13:22:43 minidsp-shd kernel: CIFS VFS: cifs_mount failed w/return code = -115 Dec 08 13:22:43 minidsp-shd sudo[928]: pam_unix(sudo:session): session closed for user root Dec 08 13:22:44 minidsp-shd volumio[807]: info: Loading plugin "updater_comm"... Dec 08 13:22:44 minidsp-shd volumio[807]: info: Plugin mpdemulation is not enabled Dec 08 13:22:44 minidsp-shd volumio[807]: info: Loading plugin "rest_api"... Dec 08 13:22:44 minidsp-shd volumio[807]: info: Loading plugin "websocket"... Dec 08 13:22:44 minidsp-shd volumio[807]: info: Loading plugin "RoonBridge"... Dec 08 13:22:44 minidsp-shd volumio-remote-updater[573]: [2025-12-08 13:22:44] [connect] Successful connection Dec 08 13:22:45 minidsp-shd volumio[807]: info: Applying required configuration parameters for plugin RoonBridge Dec 08 13:22:45 minidsp-shd volumio[807]: info: Loading plugin "hotelradio"... Dec 08 13:22:47 minidsp-shd volumio[807]: info: Loading plugin "personal_radio"... Dec 08 13:22:49 minidsp-shd volumio[807]: info: ControllerPersonalRadio::constructor Dec 08 13:22:49 minidsp-shd volumio[807]: info: Loading plugin "podcast"... Dec 08 13:22:53 minidsp-shd volumio[807]: info: ControllerPodcast::constructor Dec 08 13:22:54 minidsp-shd volumio[807]: info: Loading plugin "radio_paradise"... Dec 08 13:22:54 minidsp-shd volumio[807]: info: Applying required configuration parameters for plugin radio_paradise Dec 08 13:22:54 minidsp-shd volumio[807]: info: [1765200174713] [RadioParadise] API delay: 5 Dec 08 13:22:54 minidsp-shd volumio[807]: info: Loading plugin "spop"... Dec 08 13:22:56 minidsp-shd volumio[807]: info: Loading plugin "volspotconnect2"... Dec 08 13:22:57 minidsp-shd volumio[807]: info: ___________ START PLUGINS ___________ Dec 08 13:22:57 minidsp-shd volumio[807]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 08 13:22:57 minidsp-shd volumio[807]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 08 13:22:57 minidsp-shd volumio[807]: info: [1765200177652] CoreMusicLibrary::Adding element Media Servers Dec 08 13:22:57 minidsp-shd volumio[807]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 08 13:22:57 minidsp-shd volumio[807]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 08 13:22:57 minidsp-shd volumio[807]: info: Adding METAVOLUMIO REST API Endpoints Dec 08 13:22:57 minidsp-shd volumio[807]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Dec 08 13:22:57 minidsp-shd sudo[996]: pam_unix(sudo:auth): conversation failed Dec 08 13:22:57 minidsp-shd sudo[996]: pam_unix(sudo:auth): auth could not identify password for [volumio] Dec 08 13:22:57 minidsp-shd volumio[807]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 08 13:22:57 minidsp-shd volumio[807]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 08 13:22:57 minidsp-shd volumio[807]: info: Preparing CD Folders Dec 08 13:22:57 minidsp-shd volumio[807]: info: Adding CD REST API Endpoints Dec 08 13:22:57 minidsp-shd volumio[807]: info: Adding detectCD REST Endpoint for plugin: music_service/cd_controller Dec 08 13:22:57 minidsp-shd volumio[807]: info: Adding cdRemove REST Endpoint for plugin: music_service/cd_controller Dec 08 13:22:57 minidsp-shd volumio[807]: info: Adding cdPostScan REST Endpoint for plugin: music_service/cd_controller Dec 08 13:22:57 minidsp-shd volumio[807]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Dec 08 13:22:57 minidsp-shd volumio[807]: info: Detecting CD presence with Flag file Dec 08 13:22:57 minidsp-shd volumio[807]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 08 13:22:57 minidsp-shd volumio[807]: info: [1765200177939] CoreMusicLibrary::Adding element Last_100 Dec 08 13:22:57 minidsp-shd volumio[807]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 08 13:22:57 minidsp-shd volumio[807]: info: Starting RAAT Plugin Dec 08 13:22:57 minidsp-shd volumio[807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , addAdditionalUISections Dec 08 13:22:57 minidsp-shd volumio[807]: info: Additional UI Settings Added for plugin music_service/raat Dec 08 13:22:58 minidsp-shd volumio[807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 08 13:22:58 minidsp-shd volumio[807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 08 13:22:58 minidsp-shd volumio[807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 08 13:22:58 minidsp-shd volumio[807]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 08 13:22:58 minidsp-shd volumio[807]: info: Not Reporting Auto name since its the default one Dec 08 13:22:58 minidsp-shd volumio[807]: info: Streaming services startup Dec 08 13:22:58 minidsp-shd volumio[807]: info: Starting Streaming Daemon Dec 08 13:22:58 minidsp-shd sudo[1010]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Dec 08 13:22:58 minidsp-shd sudo[1010]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 08 13:22:58 minidsp-shd systemd[1]: Stopping Volumio Streaming Daemon... Dec 08 13:22:58 minidsp-shd systemd[1]: Starting Volumio Streaming Daemon... Dec 08 13:22:58 minidsp-shd systemd[1]: Started Volumio Streaming Daemon. Dec 08 13:22:58 minidsp-shd sudo[1010]: pam_unix(sudo:session): session closed for user root Dec 08 13:22:58 minidsp-shd volumio-streaming-daemon[1017]: ############################ Dec 08 13:22:58 minidsp-shd volumio-streaming-daemon[1017]: # Volumio Streaming Daemon # Dec 08 13:22:58 minidsp-shd volumio-streaming-daemon[1017]: # Running on port 7777 # Dec 08 13:22:58 minidsp-shd volumio-streaming-daemon[1017]: ############################ Dec 08 13:22:58 minidsp-shd volumio-streaming-daemon[1017]: Checking variant in static cache Dec 08 13:22:58 minidsp-shd volumio-streaming-daemon[1017]: Enabled services: Dec 08 13:22:58 minidsp-shd volumio-streaming-daemon[1017]: 1) tidal Dec 08 13:22:58 minidsp-shd volumio-streaming-daemon[1017]: 2) qobuz Dec 08 13:22:58 minidsp-shd volumio[807]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 08 13:22:58 minidsp-shd volumio[807]: info: [1765200178218] CoreMusicLibrary::Adding element Webradio Dec 08 13:22:58 minidsp-shd volumio[807]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 08 13:22:58 minidsp-shd volumio[807]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 08 13:22:58 minidsp-shd sudo[1025]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 08 13:22:58 minidsp-shd sudo[1025]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 08 13:22:58 minidsp-shd systemd[1]: Configuration file /lib/systemd/system/vtcs.service is marked executable. Please remove executable permission bits. Proceeding anyway. Dec 08 13:22:58 minidsp-shd systemd[1]: Stopped Volumio Tidal Connect Service. Dec 08 13:22:58 minidsp-shd systemd[1]: Configuration file /lib/systemd/system/vtcs.service is marked executable. Please remove executable permission bits. Proceeding anyway. Dec 08 13:22:58 minidsp-shd systemd[1]: Configuration file /lib/systemd/system/vtcs.service is marked executable. Please remove executable permission bits. Proceeding anyway. Dec 08 13:22:58 minidsp-shd volumio[807]: error: Hi Res Audio Failed Login: Missing Login Data Dec 08 13:22:58 minidsp-shd sudo[1025]: pam_unix(sudo:session): session closed for user root Dec 08 13:22:58 minidsp-shd volumio[807]: info: Refreshing TIDAL token Dec 08 13:22:58 minidsp-shd sudo[1029]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start roonbridge.service Dec 08 13:22:58 minidsp-shd sudo[1029]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 08 13:22:58 minidsp-shd systemd[1]: Starting RoonBridge... Dec 08 13:22:58 minidsp-shd systemd[1]: Started RoonBridge. Dec 08 13:22:58 minidsp-shd sudo[1029]: pam_unix(sudo:session): session closed for user root Dec 08 13:22:58 minidsp-shd volumio[807]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 08 13:22:58 minidsp-shd volumio[807]: info: [1765200178450] CoreMusicLibrary::Adding element Personal Radio Dec 08 13:22:58 minidsp-shd volumio[807]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 08 13:22:58 minidsp-shd volumio[807]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 08 13:22:58 minidsp-shd volumio[807]: info: [1765200178480] CoreMusicLibrary::Adding element Podcast Dec 08 13:22:58 minidsp-shd volumio[807]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 08 13:22:58 minidsp-shd volumio[807]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 08 13:22:58 minidsp-shd volumio[807]: info: [1765200178500] CoreMusicLibrary::Adding element Radio Paradise Dec 08 13:22:58 minidsp-shd volumio[807]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 08 13:22:58 minidsp-shd volumio[807]: [SpotifyConnect] Creating VLS config file Dec 08 13:22:58 minidsp-shd volumio[807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 08 13:22:58 minidsp-shd volumio[807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 08 13:22:58 minidsp-shd volumio[807]: [SpotifyConnect] <> or Mixer found, using softvol Dec 08 13:22:58 minidsp-shd volumio[807]: [SpotifyConnect] Starting metadata listener Dec 08 13:22:58 minidsp-shd sudo[1040]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start spop.service Dec 08 13:22:58 minidsp-shd sudo[1040]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 08 13:22:58 minidsp-shd systemd[1]: Configuration file /lib/systemd/system/spop.service is marked executable. Please remove executable permission bits. Proceeding anyway. Dec 08 13:22:58 minidsp-shd systemd[1]: Configuration file /lib/systemd/system/spop.service is marked world-writable. Please remove world writability permission bits. Proceeding anyway. Dec 08 13:22:58 minidsp-shd systemd[1]: Starting Spotify Daemon... Dec 08 13:22:58 minidsp-shd systemd[1]: Started Spotify Daemon. Dec 08 13:22:58 minidsp-shd sudo[1040]: pam_unix(sudo:session): session closed for user root Dec 08 13:22:58 minidsp-shd sudo[1044]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect2.service Dec 08 13:22:58 minidsp-shd sudo[1044]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 08 13:22:58 minidsp-shd systemd[1]: Starting Volspotconnect2 Daemon... Dec 08 13:22:58 minidsp-shd volumio[807]: info: Loading i18n strings for locale zh_TW Dec 08 13:22:58 minidsp-shd systemd[1]: Started Volspotconnect2 Daemon. Dec 08 13:22:58 minidsp-shd sudo[1044]: pam_unix(sudo:session): session closed for user root Dec 08 13:22:58 minidsp-shd volumio[807]: Updating browse sources language Dec 08 13:22:58 minidsp-shd volumio[807]: Cannot find translation for sourceMedia Servers Dec 08 13:22:58 minidsp-shd volumio[807]: Cannot find translation for sourcePersonal Radio Dec 08 13:22:58 minidsp-shd volumio[807]: Cannot find translation for sourcePodcast Dec 08 13:22:58 minidsp-shd volumio[807]: Cannot find translation for sourceRadio Paradise Dec 08 13:22:58 minidsp-shd volumio[807]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 08 13:22:58 minidsp-shd volumio[807]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 08 13:22:58 minidsp-shd volumio[807]: info: CoreCommandRouter::initPlayerControls Dec 08 13:22:58 minidsp-shd volumio[807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 08 13:22:58 minidsp-shd volumio[807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Dec 08 13:22:58 minidsp-shd volumio[1043]: 2025-12-08 13:22:58 [SPTF] 13:22:58.880 I [offline_authorizer.cpp:297] Unable to login offline: no such user Dec 08 13:22:58 minidsp-shd volumio[1043]: 2025-12-08 13:22:58 [SPTF] 13:22:58.882 I [ap:1752] Connecting to AP ap.spotify.com:4070 Dec 08 13:22:58 minidsp-shd volumio[1043]: 2025-12-08 13:22:58 [SPTF] 13:22:58.900 I [ap:1226] Connected to AP: 104.199.241.202:4070 Dec 08 13:22:58 minidsp-shd volumio[1047]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07 Dec 08 13:22:58 minidsp-shd volumio[1047]: Reading Config from "volspotify.toml" Dec 08 13:22:58 minidsp-shd volumio[807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 08 13:22:58 minidsp-shd volumio[807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 08 13:22:58 minidsp-shd volumio[807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 08 13:22:58 minidsp-shd volumio[807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 08 13:22:58 minidsp-shd volumio[807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 08 13:22:58 minidsp-shd volumio[1047]: [Vollibrespot] : Using Alsa backend with device: plughw:0 Dec 08 13:22:58 minidsp-shd volumio[807]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 08 13:22:58 minidsp-shd volumio[807]: info: BOOT COMPLETED Dec 08 13:22:58 minidsp-shd volumio[807]: [Metrics] CommandRouter: 32s 852.34ms Dec 08 13:22:58 minidsp-shd volumio[807]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 08 13:22:59 minidsp-shd volumio[1043]: 2025-12-08 13:22:59 [SPTF] 13:22:59.017 E [ap:3953] Connection error: 410 Dec 08 13:22:59 minidsp-shd volumio[1043]: 2025-12-08 13:22:59 [WARN] Login failed: Bad username and/or password Dec 08 13:22:59 minidsp-shd volumio[1043]: 2025-12-08 13:22:59 [ERR ] Could not get the playlist container. Dec 08 13:22:59 minidsp-shd systemd[1]: spop.service: main process exited, code=killed, status=5/TRAP Dec 08 13:22:59 minidsp-shd systemd[1]: Unit spop.service entered failed state. Dec 08 13:22:59 minidsp-shd volumio[1047]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Other, message: "No such device" } Dec 08 13:22:59 minidsp-shd volumio-remote-updater[573]: [2025-12-08 13:22:59] [connect] Successful connection Dec 08 13:23:00 minidsp-shd RoonBridge[1031]: 00:00:00.026 Warn: get lock file path: /tmp/.rnbgem0- Dec 08 13:23:01 minidsp-shd RoonBridge[1031]: 00:00:00.991 Trace: [childprocess] using unix child process Dec 08 13:23:01 minidsp-shd RoonBridge[1031]: 00:00:01.140 Debug: PathForResource, filename: ../.update Dec 08 13:23:01 minidsp-shd RoonBridge[1031]: 00:00:01.222 Debug: PathForResource, candidate: /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/../.update Dec 08 13:23:01 minidsp-shd RoonBridge[1031]: 00:00:01.241 Debug: PathForResource, filename: RAATServer Dec 08 13:23:01 minidsp-shd RoonBridge[1031]: 00:00:01.241 Debug: PathForResource, candidate: /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/RAATServer Dec 08 13:23:01 minidsp-shd RoonBridge[1031]: 00:00:01.243 Debug: PathForResource, filename: RoonBridgeHelper Dec 08 13:23:01 minidsp-shd RoonBridge[1031]: 00:00:01.244 Debug: PathForResource, candidate: /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/RoonBridgeHelper Dec 08 13:23:01 minidsp-shd RoonBridge[1031]: Initializing Dec 08 13:23:01 minidsp-shd RoonBridge[1031]: 00:00:01.343 Info: Starting /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/RoonBridgeHelper Dec 08 13:23:01 minidsp-shd RoonBridge[1031]: 00:00:01.407 Info: ConnectOrStartAndWaitForExit RAATServer, path: /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/RAATServer Dec 08 13:23:01 minidsp-shd RoonBridge[1031]: Not Running (.o) Dec 08 13:23:02 minidsp-shd RoonBridge[1031]: Running Dec 08 13:23:03 minidsp-shd RoonBridge[1031]: 00:00:00.073 Warn: get lock file path: /tmp/.rnbhgem0- Dec 08 13:23:04 minidsp-shd volumio[807]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Dec 08 13:23:04 minidsp-shd volumio[807]: info: CoreCommandRouter::Close All Modals sent Dec 08 13:23:04 minidsp-shd volumio[807]: info: CoreCommandRouter::Close All Modals sent Dec 08 13:23:04 minidsp-shd volumio[807]: Express server listening on port 3000 Dec 08 13:23:04 minidsp-shd volumio[807]: [Metrics] WebUI: 39s 744.90ms Dec 08 13:23:04 minidsp-shd volumio[807]: Volumio Calling Home Dec 08 13:23:04 minidsp-shd volumio[807]: info: CoreStateMachine::resetVolumioState Dec 08 13:23:04 minidsp-shd volumio[807]: info: CoreStateMachine::getcurrentVolume Dec 08 13:23:04 minidsp-shd volumio[807]: info: CoreCommandRouter::volumioRetrievevolume Dec 08 13:23:04 minidsp-shd volumio[807]: info: Stopping AccessToken refresher cron for QOBUZ Dec 08 13:23:04 minidsp-shd volumio[807]: info: AccessToken refresher cron started for QOBUZ Dec 08 13:23:04 minidsp-shd volumio[807]: info: msSurfaceDial volumioupdatevolume callback: {"vol":100,"mute":false,"disableVolumeControl":true} Dec 08 13:23:04 minidsp-shd volumio[807]: info: CoreStateMachine::pushState Dec 08 13:23:04 minidsp-shd volumio[807]: info: CorePlayQueue::getTrack 0 Dec 08 13:23:04 minidsp-shd volumio[807]: info: CoreCommandRouter::volumioPushState Dec 08 13:23:04 minidsp-shd volumio[807]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 08 13:23:05 minidsp-shd volumio[807]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 08 13:23:05 minidsp-shd sudo[1091]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 08 13:23:05 minidsp-shd sudo[1091]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 08 13:23:05 minidsp-shd sudo[1093]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 08 13:23:05 minidsp-shd sudo[1093]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 08 13:23:05 minidsp-shd sudo[1091]: pam_unix(sudo:session): session closed for user root Dec 08 13:23:05 minidsp-shd sudo[1093]: pam_unix(sudo:session): session closed for user root Dec 08 13:23:05 minidsp-shd sudo[1096]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service Dec 08 13:23:05 minidsp-shd sudo[1096]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 08 13:23:05 minidsp-shd volumio[807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Dec 08 13:23:05 minidsp-shd volumio[807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 08 13:23:05 minidsp-shd volumio[807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 08 13:23:05 minidsp-shd volumio[807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Dec 08 13:23:05 minidsp-shd volumio[807]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 08 13:23:05 minidsp-shd systemd[1]: Configuration file /lib/systemd/system/volumiobt.service is marked executable. Please remove executable permission bits. Proceeding anyway. Dec 08 13:23:05 minidsp-shd systemd[1]: Starting Volumio Bluetooth Module... Dec 08 13:23:05 minidsp-shd systemd[1]: Started Volumio Bluetooth Module. Dec 08 13:23:05 minidsp-shd sudo[1096]: pam_unix(sudo:session): session closed for user root Dec 08 13:23:05 minidsp-shd volumio[807]: xcb_connection_has_error() returned true Dec 08 13:23:05 minidsp-shd volumio[807]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Dec 08 13:23:05 minidsp-shd sudo[1104]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth/* Dec 08 13:23:05 minidsp-shd sudo[1104]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 08 13:23:05 minidsp-shd volumiobt[1102]: /bin/chmod: cannot access '/var/lib/bluetooth/*': No such file or directory Dec 08 13:23:05 minidsp-shd sudo[1104]: pam_unix(sudo:session): session closed for user root Dec 08 13:23:05 minidsp-shd volumio[807]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Dec 08 13:23:05 minidsp-shd volumio[807]: info: Serial port opened successfully Dec 08 13:23:06 minidsp-shd sudo[1110]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall pulseaudio Dec 08 13:23:06 minidsp-shd sudo[1110]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 08 13:23:06 minidsp-shd volumiobt[1102]: pulseaudio: no process found Dec 08 13:23:06 minidsp-shd sudo[1110]: pam_unix(sudo:session): session closed for user root Dec 08 13:23:06 minidsp-shd volumio[807]: info: Volumio BT Module successfully started Dec 08 13:23:06 minidsp-shd volumio[807]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Hardware Dec 08 13:23:06 minidsp-shd volumio[807]: [SpotifyConnect] Vollibrespot Daemon service started! Dec 08 13:23:06 minidsp-shd volumio[807]: [Metrics] SpotifyConnect: 8s 312.46ms Dec 08 13:23:06 minidsp-shd volumio[807]: info: SpopD Daemon Started Dec 08 13:23:06 minidsp-shd volumio[807]: info: TidalConnect service stoped! Dec 08 13:23:06 minidsp-shd volumio[807]: info: RAAT Albumart path created successfully Dec 08 13:23:06 minidsp-shd volumio[807]: error: Cannot set new Bluetooth Name : Error: Command failed: /usr/bin/sudo /bin/hciconfig hci0 name 'minidsp-shd' Dec 08 13:23:06 minidsp-shd volumio[807]: sudo: no tty present and no askpass program specified Dec 08 13:23:06 minidsp-shd dbus[608]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' Dec 08 13:23:06 minidsp-shd systemd[1]: Starting RealtimeKit Scheduling Policy Service... Dec 08 13:23:06 minidsp-shd volumio[807]: info: Cannot mount NAS Asustor_Nas at system boot, trial number 1 ,retrying in 5 seconds Dec 08 13:23:07 minidsp-shd volumio[807]: info: MPD running with PID603 Dec 08 13:23:07 minidsp-shd volumio[807]: ,establishing connection Dec 08 13:23:07 minidsp-shd dbus[608]: [system] Successfully activated service 'org.freedesktop.RealtimeKit1' Dec 08 13:23:07 minidsp-shd systemd[1]: Started RealtimeKit Scheduling Policy Service. Dec 08 13:23:07 minidsp-shd rtkit-daemon[1120]: Successfully called chroot. Dec 08 13:23:07 minidsp-shd rtkit-daemon[1120]: Successfully dropped privileges. Dec 08 13:23:07 minidsp-shd rtkit-daemon[1120]: Successfully limited resources. Dec 08 13:23:07 minidsp-shd rtkit-daemon[1120]: Running. Dec 08 13:23:07 minidsp-shd rtkit-daemon[1120]: Watchdog thread running. Dec 08 13:23:07 minidsp-shd rtkit-daemon[1120]: Canary thread running. Dec 08 13:23:07 minidsp-shd dbus[608]: [system] Connection has not authenticated soon enough, closing it (auth_timeout=30000ms, elapsed: 30000ms) Dec 08 13:23:07 minidsp-shd sudo[1121]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1 Dec 08 13:23:07 minidsp-shd sudo[1121]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 08 13:23:07 minidsp-shd sudo[1121]: pam_unix(sudo:session): session closed for user root Dec 08 13:23:07 minidsp-shd volumio[807]: info: Volumio called home Dec 08 13:23:07 minidsp-shd volumio[807]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 08 13:23:07 minidsp-shd volumio[807]: { Error: write EPIPE Dec 08 13:23:07 minidsp-shd volumio[807]: at WriteWrap.afterWrite [as oncomplete] (net.js:868:14) errno: 'EPIPE', code: 'EPIPE', syscall: 'write' } Dec 08 13:23:07 minidsp-shd volumio[807]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 08 13:23:07 minidsp-shd dbus[608]: [system] Activating via systemd: service name='org.bluez' unit='dbus-org.bluez.service' Dec 08 13:23:07 minidsp-shd systemd[1]: Starting Bluetooth service... Dec 08 13:23:08 minidsp-shd bluetoothd[1140]: Bluetooth daemon 5.23 Dec 08 13:23:08 minidsp-shd dbus[608]: [system] Successfully activated service 'org.bluez' Dec 08 13:23:08 minidsp-shd systemd[1]: Started Bluetooth service. Dec 08 13:23:08 minidsp-shd bluetoothd[1140]: Starting SDP server Dec 08 13:23:08 minidsp-shd bluetoothd[1140]: Excluding (cli) sap Dec 08 13:23:08 minidsp-shd bluetoothd[1140]: kernel lacks bnep-protocol support Dec 08 13:23:08 minidsp-shd bluetoothd[1140]: System does not support network plugin Dec 08 13:23:08 minidsp-shd dbus[608]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' Dec 08 13:23:08 minidsp-shd bluetoothd[1140]: Bluetooth management interface 1.14 initialized Dec 08 13:23:08 minidsp-shd systemd[1]: Starting Hostname Service... Dec 08 13:23:08 minidsp-shd pulseaudio[1118]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Dec 08 13:23:08 minidsp-shd pulseaudio[1118]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Dec 08 13:23:08 minidsp-shd volumiobt[1102]: Applying permissions Dec 08 13:23:08 minidsp-shd volumiobt[1102]: Setting BT discoverable and pairable Dec 08 13:23:08 minidsp-shd pulseaudio[1118]: org.bluez.Manager.GetProperties() failed: org.freedesktop.DBus.Error.UnknownMethod: Method "GetProperties" with signature "" on interface "org.bluez.Manager" doesn't exist Dec 08 13:23:08 minidsp-shd pulseaudio[1118]: org.bluez.Manager.GetProperties() failed: org.freedesktop.DBus.Error.UnknownMethod: Method "GetProperties" with signature "" on interface "org.bluez.Manager" doesn't exist Dec 08 13:23:08 minidsp-shd volumiobt[1102]: [38B blob data] Dec 08 13:23:08 minidsp-shd volumiobt[1102]: Invalid command Dec 08 13:23:08 minidsp-shd volumiobt[1102]: [bluetooth]# agent on Dec 08 13:23:08 minidsp-shd volumiobt[1102]: [bluetooth]# discoverable on Dec 08 13:23:08 minidsp-shd volumiobt[1102]: No default controller available Dec 08 13:23:08 minidsp-shd volumiobt[1102]: [bluetooth]# pairable on Dec 08 13:23:08 minidsp-shd volumiobt[1102]: No default controller available Dec 08 13:23:08 minidsp-shd volumiobt[1102]: [bluetooth]# agent NoInputNoOutput Dec 08 13:23:08 minidsp-shd volumiobt[1102]: Failed to register agent object Dec 08 13:23:08 minidsp-shd volumiobt[1102]: [bluetooth]# default-agent Dec 08 13:23:08 minidsp-shd volumiobt[1102]: No agent is registered Dec 08 13:23:08 minidsp-shd volumiobt[1102]: [bluetooth]# quit Dec 08 13:23:08 minidsp-shd volumiobt[1102]: [61B blob data] Dec 08 13:23:08 minidsp-shd volumiobt[1102]: [62B blob data] Dec 08 13:23:08 minidsp-shd systemd-hostnamed[1144]: Warning: nss-myhostname is not installed. Changing the local hostname might make it unresolveable. Please install nss-myhostname! Dec 08 13:23:08 minidsp-shd dbus[608]: [system] Successfully activated service 'org.freedesktop.hostname1' Dec 08 13:23:09 minidsp-shd systemd[1]: Started Hostname Service. Dec 08 13:23:10 minidsp-shd sudo[1159]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-08 13:22 Dec 08 13:23:10 minidsp-shd sudo[1159]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 8 (jessie)" NAME="Debian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=debian HOME_URL="http://www.debian.org/" SUPPORT_URL="http://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="6d9442f761618503268d0366db805a252514dec1" VOLUMIO_BE_VERSION="3e944f35d34b575025d16b976b4cb4d9aed53b66" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="minidspshd" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Jul 26 13:05:05 CEST 2022" VOLUMIO_VERSION="1.125" VOLUMIO_HARDWARE="nanopineo3" VOLUMIO_VENDOR="miniDSP" VOLUMIO_MODEL="SHD" VOLUMIO_VENDOR_MODEL="miniDSP SHD" VOLUMIO_HASH="b36618da2d3cf6839ff2c23420b9861f"