-- Logs begin at Sun 2023-03-26 01:25:59 UTC, end at Sat 2025-02-22 10:33:29 UTC. -- Feb 22 10:32:47 minidsp-shd systemd[1]: Time has been changed Feb 22 10:32:49 minidsp-shd volumio-remote-updater[551]: [2025-02-22 10:32:49] [connect] Successful connection Feb 22 10:32:49 minidsp-shd volumio[777]: info: Loading plugin "network"... Feb 22 10:32:49 minidsp-shd volumio[777]: info: Refreshing Cached IP Addresses Feb 22 10:32:49 minidsp-shd volumio[777]: info: Loading plugin "services"... Feb 22 10:32:49 minidsp-shd sudo[871]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 22 10:32:49 minidsp-shd sudo[871]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 10:32:49 minidsp-shd volumio[777]: info: Loading plugin "alsa_controller"... Feb 22 10:32:49 minidsp-shd sudo[871]: pam_unix(sudo:session): session closed for user root Feb 22 10:32:49 minidsp-shd sudo[873]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 22 10:32:49 minidsp-shd sudo[873]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 10:32:49 minidsp-shd sudo[873]: pam_unix(sudo:session): session closed for user root Feb 22 10:32:49 minidsp-shd volumio[777]: info: Loading plugin "wizard"... Feb 22 10:32:50 minidsp-shd volumio[777]: info: Loading plugin "volumio_command_line_client"... Feb 22 10:32:50 minidsp-shd volumio[777]: info: Loading plugin "upnp"... Feb 22 10:32:50 minidsp-shd volumio[777]: info: [1740220370081] Starting Upmpd Daemon Feb 22 10:32:50 minidsp-shd volumio[777]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 22 10:32:50 minidsp-shd volumio[777]: info: Loading plugin "my_music"... Feb 22 10:32:50 minidsp-shd volumio[777]: info: Loading plugin "mpd"... Feb 22 10:32:50 minidsp-shd volumio[777]: info: Loading plugin "upnp_browser"... Feb 22 10:32:51 minidsp-shd volumio[777]: info: Loading plugin "networkfs"... Feb 22 10:32:52 minidsp-shd volumio[777]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 22 10:32:52 minidsp-shd volumio[777]: info: Loading plugin "bluetooth"... Feb 22 10:32:52 minidsp-shd sudo[885]: 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 Feb 22 10:32:52 minidsp-shd sudo[885]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 10:32:52 minidsp-shd kernel: FS-Cache: Netfs 'cifs' registered for caching Feb 22 10:32:52 minidsp-shd kernel: Key type cifs.spnego registered Feb 22 10:32:52 minidsp-shd kernel: Key type cifs.idmap registered Feb 22 10:32:52 minidsp-shd kernel: CIFS: Attempting to mount //192.168.50.68/Music Feb 22 10:32:52 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. Feb 22 10:32:52 minidsp-shd kernel: Status code returned 0xc000006d STATUS_LOGON_FAILURE Feb 22 10:32:52 minidsp-shd kernel: CIFS VFS: \\192.168.50.68 Send error in SessSetup = -13 Feb 22 10:32:52 minidsp-shd kernel: CIFS VFS: cifs_mount failed w/return code = -13 Feb 22 10:32:52 minidsp-shd sudo[885]: pam_unix(sudo:session): session closed for user root Feb 22 10:32:52 minidsp-shd volumio[777]: info: [1740220372683] Starting BluetoothController Feb 22 10:32:52 minidsp-shd volumio[777]: info: Loading plugin "alarm-clock"... Feb 22 10:32:53 minidsp-shd volumio[777]: info: Loading plugin "metavolumio"... Feb 22 10:32:53 minidsp-shd volumio[777]: info: Loading plugin "airplay_emulation"... Feb 22 10:32:53 minidsp-shd volumio[777]: info: Starting Shairport Sync Feb 22 10:32:53 minidsp-shd volumio[777]: info: Loading plugin "cd_controller"... Feb 22 10:32:53 minidsp-shd volumio[777]: info: Loading plugin "last_100"... Feb 22 10:32:53 minidsp-shd volumio[777]: info: Loading plugin "raat"... Feb 22 10:32:53 minidsp-shd volumio[777]: info: RAAT Plugin loaded Feb 22 10:32:53 minidsp-shd volumio[777]: info: Adding restartRAATSocket REST API Endpoint Feb 22 10:32:53 minidsp-shd volumio[777]: info: Adding restartRAATSocket REST Endpoint for plugin: music_service/raat Feb 22 10:32:53 minidsp-shd volumio[777]: info: CoreCommandRouter::executeOnPlugin: inputs , getVolume Feb 22 10:32:53 minidsp-shd volumio[777]: error: Could not retrieve plugin music_service inputs Feb 22 10:32:53 minidsp-shd volumio[777]: info: CoreCommandRouter::executeOnPlugin: inputs , getDSP Feb 22 10:32:53 minidsp-shd volumio[777]: error: Could not retrieve plugin music_service inputs Feb 22 10:32:53 minidsp-shd volumio[777]: info: Loading plugin "streaming_services"... Feb 22 10:32:53 minidsp-shd volumio[777]: info: Loading plugin "tidalconnect"... Feb 22 10:32:54 minidsp-shd volumio[777]: info: Loading plugin "webradio"... Feb 22 10:32:54 minidsp-shd volumio[777]: info: Loading plugin "i2s_dacs"... Feb 22 10:32:54 minidsp-shd volumio[777]: info: I2S DAC not set, start Auto-detection Feb 22 10:32:54 minidsp-shd volumio[777]: info: Loading plugin "volumiodiscovery"... Feb 22 10:32:54 minidsp-shd volumio[777]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 22 10:32:54 minidsp-shd node[777]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 22 10:32:54 minidsp-shd node[777]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 22 10:32:54 minidsp-shd node[777]: *** WARNING *** For more information see Feb 22 10:32:54 minidsp-shd node[777]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 22 10:32:54 minidsp-shd node[777]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 22 10:32:54 minidsp-shd node[777]: *** WARNING *** For more information see Feb 22 10:32:54 minidsp-shd volumio[777]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 22 10:32:54 minidsp-shd volumio[777]: *** WARNING *** For more information see Feb 22 10:32:54 minidsp-shd volumio[777]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 22 10:32:54 minidsp-shd volumio[777]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 22 10:32:54 minidsp-shd volumio[777]: *** WARNING *** For more information see Feb 22 10:32:54 minidsp-shd volumio[777]: info: Applying required configuration parameters for plugin volumiodiscovery Feb 22 10:32:54 minidsp-shd volumio[777]: Discovery: StartAdv! undefined Feb 22 10:32:54 minidsp-shd volumio[777]: Discovery: Started advertising... minidsp-shd - undefined Feb 22 10:32:54 minidsp-shd volumio[777]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 22 10:32:54 minidsp-shd volumio[777]: info: Loading plugin "outputs"... Feb 22 10:32:54 minidsp-shd volumio[777]: info: Loading plugin "albumart"... Feb 22 10:32:54 minidsp-shd volumio[777]: info: Loading plugin "ms_surface_dial"... Feb 22 10:32:55 minidsp-shd volumio[777]: Forking 3 albumart workers Feb 22 10:32:56 minidsp-shd volumio[777]: info: Applying required configuration parameters for plugin ms_surface_dial Feb 22 10:32:56 minidsp-shd volumio[777]: info: Plugin example_plugin is not enabled Feb 22 10:32:56 minidsp-shd volumio[777]: info: Loading plugin "hi_res_audio"... Feb 22 10:32:56 minidsp-shd volumio[777]: info: Applying required configuration parameters for plugin hi_res_audio Feb 22 10:32:56 minidsp-shd volumio[777]: info: Loading plugin "inputs"... Feb 22 10:32:56 minidsp-shd volumio[777]: info: Loading plugin "qobuz"... Feb 22 10:32:57 minidsp-shd nmbd[838]: [2025/02/22 10:32:57.287970, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Feb 22 10:32:57 minidsp-shd nmbd[838]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.50.24 for name WORKGROUP<1d>. Feb 22 10:32:57 minidsp-shd nmbd[838]: This response was from IP 192.168.50.68, reporting an IP address of 192.168.50.68. Feb 22 10:32:57 minidsp-shd volumio[777]: Starting albumart workers Feb 22 10:32:57 minidsp-shd volumio[777]: Starting albumart workers Feb 22 10:32:57 minidsp-shd volumio[777]: Starting albumart workers Feb 22 10:33:00 minidsp-shd volumio[777]: info: Loading plugin "tidal"... Feb 22 10:33:03 minidsp-shd volumio[777]: info: Loading plugin "updater_comm"... Feb 22 10:33:03 minidsp-shd volumio[777]: info: Plugin mpdemulation is not enabled Feb 22 10:33:03 minidsp-shd volumio[777]: info: Loading plugin "rest_api"... Feb 22 10:33:03 minidsp-shd volumio[777]: info: Loading plugin "websocket"... Feb 22 10:33:04 minidsp-shd volumio[777]: info: Loading plugin "RoonBridge"... Feb 22 10:33:04 minidsp-shd volumio-remote-updater[551]: [2025-02-22 10:33:04] [connect] Successful connection Feb 22 10:33:04 minidsp-shd volumio[777]: info: Applying required configuration parameters for plugin RoonBridge Feb 22 10:33:04 minidsp-shd volumio[777]: info: Loading plugin "hotelradio"... Feb 22 10:33:07 minidsp-shd volumio[777]: info: Loading plugin "personal_radio"... Feb 22 10:33:09 minidsp-shd volumio[777]: info: ControllerPersonalRadio::constructor Feb 22 10:33:09 minidsp-shd volumio[777]: info: Loading plugin "podcast"... Feb 22 10:33:13 minidsp-shd volumio[777]: info: ControllerPodcast::constructor Feb 22 10:33:13 minidsp-shd volumio[777]: info: Loading plugin "radio_paradise"... Feb 22 10:33:14 minidsp-shd volumio[777]: info: Applying required configuration parameters for plugin radio_paradise Feb 22 10:33:14 minidsp-shd volumio[777]: info: [1740220394012] [RadioParadise] API delay: 5 Feb 22 10:33:14 minidsp-shd volumio[777]: info: Loading plugin "spop"... Feb 22 10:33:15 minidsp-shd volumio[777]: info: Loading plugin "volspotconnect2"... Feb 22 10:33:16 minidsp-shd volumio[777]: info: ___________ START PLUGINS ___________ Feb 22 10:33:16 minidsp-shd volumio[777]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 22 10:33:16 minidsp-shd volumio[777]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 22 10:33:16 minidsp-shd volumio[777]: info: [1740220396977] CoreMusicLibrary::Adding element Media Servers Feb 22 10:33:16 minidsp-shd volumio[777]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 22 10:33:17 minidsp-shd volumio[777]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 22 10:33:17 minidsp-shd volumio[777]: info: Adding METAVOLUMIO REST API Endpoints Feb 22 10:33:17 minidsp-shd volumio[777]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Feb 22 10:33:17 minidsp-shd sudo[963]: pam_unix(sudo:auth): conversation failed Feb 22 10:33:17 minidsp-shd sudo[963]: pam_unix(sudo:auth): auth could not identify password for [volumio] Feb 22 10:33:17 minidsp-shd volumio[777]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 22 10:33:17 minidsp-shd volumio[777]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 22 10:33:17 minidsp-shd volumio[777]: info: Preparing CD Folders Feb 22 10:33:17 minidsp-shd volumio[777]: info: Adding CD REST API Endpoints Feb 22 10:33:17 minidsp-shd volumio[777]: info: Adding detectCD REST Endpoint for plugin: music_service/cd_controller Feb 22 10:33:17 minidsp-shd volumio[777]: info: Adding cdRemove REST Endpoint for plugin: music_service/cd_controller Feb 22 10:33:17 minidsp-shd volumio[777]: info: Adding cdPostScan REST Endpoint for plugin: music_service/cd_controller Feb 22 10:33:17 minidsp-shd volumio[777]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Feb 22 10:33:17 minidsp-shd volumio[777]: info: Detecting CD presence with Flag file Feb 22 10:33:17 minidsp-shd volumio[777]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 22 10:33:17 minidsp-shd volumio[777]: info: [1740220397266] CoreMusicLibrary::Adding element Last_100 Feb 22 10:33:17 minidsp-shd volumio[777]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 22 10:33:17 minidsp-shd volumio[777]: info: Starting RAAT Plugin Feb 22 10:33:17 minidsp-shd volumio[777]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , addAdditionalUISections Feb 22 10:33:17 minidsp-shd volumio[777]: info: Additional UI Settings Added for plugin music_service/raat Feb 22 10:33:17 minidsp-shd volumio[777]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 10:33:17 minidsp-shd volumio[777]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 10:33:17 minidsp-shd volumio[777]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 10:33:17 minidsp-shd volumio[777]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 22 10:33:17 minidsp-shd volumio[777]: info: Not Reporting Auto name since its the default one Feb 22 10:33:17 minidsp-shd volumio[777]: info: Streaming services startup Feb 22 10:33:17 minidsp-shd volumio[777]: info: Starting Streaming Daemon Feb 22 10:33:17 minidsp-shd sudo[977]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Feb 22 10:33:17 minidsp-shd sudo[977]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 10:33:17 minidsp-shd systemd[1]: Stopping Volumio Streaming Daemon... Feb 22 10:33:17 minidsp-shd systemd[1]: Starting Volumio Streaming Daemon... Feb 22 10:33:17 minidsp-shd systemd[1]: Started Volumio Streaming Daemon. Feb 22 10:33:17 minidsp-shd sudo[977]: pam_unix(sudo:session): session closed for user root Feb 22 10:33:17 minidsp-shd volumio-streaming-daemon[983]: ############################ Feb 22 10:33:17 minidsp-shd volumio-streaming-daemon[983]: # Volumio Streaming Daemon # Feb 22 10:33:17 minidsp-shd volumio-streaming-daemon[983]: # Running on port 7777 # Feb 22 10:33:17 minidsp-shd volumio-streaming-daemon[983]: ############################ Feb 22 10:33:17 minidsp-shd volumio-streaming-daemon[983]: Checking variant in static cache Feb 22 10:33:17 minidsp-shd volumio-streaming-daemon[983]: Enabled services: Feb 22 10:33:17 minidsp-shd volumio-streaming-daemon[983]: 1) tidal Feb 22 10:33:17 minidsp-shd volumio-streaming-daemon[983]: 2) qobuz Feb 22 10:33:17 minidsp-shd volumio[777]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 22 10:33:17 minidsp-shd volumio[777]: info: [1740220397548] CoreMusicLibrary::Adding element Webradio Feb 22 10:33:17 minidsp-shd volumio[777]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 22 10:33:17 minidsp-shd volumio[777]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 22 10:33:17 minidsp-shd sudo[991]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 22 10:33:17 minidsp-shd sudo[991]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 10:33:17 minidsp-shd systemd[1]: Configuration file /lib/systemd/system/vtcs.service is marked executable. Please remove executable permission bits. Proceeding anyway. Feb 22 10:33:17 minidsp-shd systemd[1]: Stopped Volumio Tidal Connect Service. Feb 22 10:33:17 minidsp-shd systemd[1]: Configuration file /lib/systemd/system/vtcs.service is marked executable. Please remove executable permission bits. Proceeding anyway. Feb 22 10:33:17 minidsp-shd systemd[1]: Configuration file /lib/systemd/system/vtcs.service is marked executable. Please remove executable permission bits. Proceeding anyway. Feb 22 10:33:17 minidsp-shd volumio[777]: error: Hi Res Audio Failed Login: Missing Login Data Feb 22 10:33:17 minidsp-shd sudo[991]: pam_unix(sudo:session): session closed for user root Feb 22 10:33:17 minidsp-shd volumio[777]: info: Refreshing TIDAL token Feb 22 10:33:17 minidsp-shd sudo[995]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start roonbridge.service Feb 22 10:33:17 minidsp-shd sudo[995]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 10:33:17 minidsp-shd systemd[1]: Starting RoonBridge... Feb 22 10:33:17 minidsp-shd systemd[1]: Started RoonBridge. Feb 22 10:33:17 minidsp-shd sudo[995]: pam_unix(sudo:session): session closed for user root Feb 22 10:33:17 minidsp-shd volumio[777]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 22 10:33:17 minidsp-shd volumio[777]: info: [1740220397785] CoreMusicLibrary::Adding element Personal Radio Feb 22 10:33:17 minidsp-shd volumio[777]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 22 10:33:17 minidsp-shd volumio[777]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 22 10:33:17 minidsp-shd volumio[777]: info: [1740220397812] CoreMusicLibrary::Adding element Podcast Feb 22 10:33:17 minidsp-shd volumio[777]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 22 10:33:17 minidsp-shd volumio[777]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 22 10:33:17 minidsp-shd volumio[777]: info: [1740220397832] CoreMusicLibrary::Adding element Radio Paradise Feb 22 10:33:17 minidsp-shd volumio[777]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 22 10:33:17 minidsp-shd volumio[777]: [SpotifyConnect] Creating VLS config file Feb 22 10:33:17 minidsp-shd volumio[777]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 10:33:17 minidsp-shd volumio[777]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 10:33:17 minidsp-shd volumio[777]: [SpotifyConnect] <> or Mixer found, using softvol Feb 22 10:33:17 minidsp-shd volumio[777]: [SpotifyConnect] Starting metadata listener Feb 22 10:33:17 minidsp-shd sudo[1006]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start spop.service Feb 22 10:33:17 minidsp-shd sudo[1006]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 10:33:17 minidsp-shd systemd[1]: Configuration file /lib/systemd/system/spop.service is marked executable. Please remove executable permission bits. Proceeding anyway. Feb 22 10:33:17 minidsp-shd systemd[1]: Configuration file /lib/systemd/system/spop.service is marked world-writable. Please remove world writability permission bits. Proceeding anyway. Feb 22 10:33:17 minidsp-shd systemd[1]: Starting Spotify Daemon... Feb 22 10:33:17 minidsp-shd systemd[1]: Started Spotify Daemon. Feb 22 10:33:17 minidsp-shd sudo[1006]: pam_unix(sudo:session): session closed for user root Feb 22 10:33:17 minidsp-shd volumio[777]: info: Loading i18n strings for locale zh_TW Feb 22 10:33:17 minidsp-shd sudo[1010]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect2.service Feb 22 10:33:17 minidsp-shd sudo[1010]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 10:33:18 minidsp-shd volumio[777]: Updating browse sources language Feb 22 10:33:18 minidsp-shd volumio[777]: Cannot find translation for sourceMedia Servers Feb 22 10:33:18 minidsp-shd volumio[777]: Cannot find translation for sourcePersonal Radio Feb 22 10:33:18 minidsp-shd volumio[777]: Cannot find translation for sourcePodcast Feb 22 10:33:18 minidsp-shd volumio[777]: Cannot find translation for sourceRadio Paradise Feb 22 10:33:18 minidsp-shd volumio[777]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 22 10:33:18 minidsp-shd systemd[1]: Starting Volspotconnect2 Daemon... Feb 22 10:33:18 minidsp-shd systemd[1]: Started Volspotconnect2 Daemon. Feb 22 10:33:18 minidsp-shd sudo[1010]: pam_unix(sudo:session): session closed for user root Feb 22 10:33:18 minidsp-shd volumio[777]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 22 10:33:18 minidsp-shd volumio[777]: info: CoreCommandRouter::initPlayerControls Feb 22 10:33:18 minidsp-shd volumio[777]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 10:33:18 minidsp-shd volumio[777]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Feb 22 10:33:18 minidsp-shd volumio[1009]: 2025-02-22 10:33:18 [SPTF] 10:33:18.190 I [offline_authorizer.cpp:297] Unable to login offline: no such user Feb 22 10:33:18 minidsp-shd volumio[777]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 10:33:18 minidsp-shd volumio[777]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 10:33:18 minidsp-shd volumio[777]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 10:33:18 minidsp-shd volumio[1009]: 2025-02-22 10:33:18 [SPTF] 10:33:18.194 I [ap:1752] Connecting to AP ap.spotify.com:4070 Feb 22 10:33:18 minidsp-shd volumio[777]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 10:33:18 minidsp-shd volumio[777]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 10:33:18 minidsp-shd volumio[1013]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07 Feb 22 10:33:18 minidsp-shd volumio[1009]: 2025-02-22 10:33:18 [SPTF] 10:33:18.214 I [ap:1226] Connected to AP: 104.199.241.202:4070 Feb 22 10:33:18 minidsp-shd volumio[1013]: Reading Config from "volspotify.toml" Feb 22 10:33:18 minidsp-shd volumio[777]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 22 10:33:18 minidsp-shd volumio[777]: info: BOOT COMPLETED Feb 22 10:33:18 minidsp-shd volumio[777]: [Metrics] CommandRouter: 32s 922.15ms Feb 22 10:33:18 minidsp-shd volumio[1013]: [Vollibrespot] : Using Alsa backend with device: plughw:0 Feb 22 10:33:18 minidsp-shd volumio[777]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 22 10:33:18 minidsp-shd volumio[1013]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Other, message: "No such device" } Feb 22 10:33:18 minidsp-shd volumio[1009]: 2025-02-22 10:33:18 [SPTF] 10:33:18.407 E [ap:3953] Connection error: 410 Feb 22 10:33:18 minidsp-shd volumio[1009]: 2025-02-22 10:33:18 [WARN] Login failed: Bad username and/or password Feb 22 10:33:18 minidsp-shd volumio[1009]: 2025-02-22 10:33:18 [ERR ] Could not get the playlist container. Feb 22 10:33:18 minidsp-shd systemd[1]: spop.service: main process exited, code=killed, status=5/TRAP Feb 22 10:33:18 minidsp-shd systemd[1]: Unit spop.service entered failed state. Feb 22 10:33:19 minidsp-shd volumio-remote-updater[551]: [2025-02-22 10:33:19] [connect] Successful connection Feb 22 10:33:19 minidsp-shd RoonBridge[997]: 00:00:00.026 Warn: get lock file path: /tmp/.rnbgem0- Feb 22 10:33:20 minidsp-shd RoonBridge[997]: 00:00:00.989 Trace: [childprocess] using unix child process Feb 22 10:33:20 minidsp-shd RoonBridge[997]: 00:00:01.139 Debug: PathForResource, filename: ../.update Feb 22 10:33:20 minidsp-shd RoonBridge[997]: 00:00:01.220 Debug: PathForResource, candidate: /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/../.update Feb 22 10:33:20 minidsp-shd RoonBridge[997]: 00:00:01.239 Debug: PathForResource, filename: RAATServer Feb 22 10:33:20 minidsp-shd RoonBridge[997]: 00:00:01.239 Debug: PathForResource, candidate: /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/RAATServer Feb 22 10:33:20 minidsp-shd RoonBridge[997]: 00:00:01.241 Debug: PathForResource, filename: RoonBridgeHelper Feb 22 10:33:20 minidsp-shd RoonBridge[997]: 00:00:01.242 Debug: PathForResource, candidate: /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/RoonBridgeHelper Feb 22 10:33:20 minidsp-shd RoonBridge[997]: Initializing Feb 22 10:33:20 minidsp-shd RoonBridge[997]: 00:00:01.341 Info: Starting /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/RoonBridgeHelper Feb 22 10:33:21 minidsp-shd RoonBridge[997]: 00:00:01.406 Info: ConnectOrStartAndWaitForExit RAATServer, path: /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/RAATServer Feb 22 10:33:21 minidsp-shd RoonBridge[997]: Not Running (.o) Feb 22 10:33:21 minidsp-shd RoonBridge[997]: Running Feb 22 10:33:22 minidsp-shd RoonBridge[997]: 00:00:00.074 Warn: get lock file path: /tmp/.rnbhgem0- Feb 22 10:33:23 minidsp-shd volumio[777]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Feb 22 10:33:23 minidsp-shd volumio[777]: info: CoreCommandRouter::Close All Modals sent Feb 22 10:33:23 minidsp-shd volumio[777]: info: CoreCommandRouter::Close All Modals sent Feb 22 10:33:23 minidsp-shd volumio[777]: Express server listening on port 3000 Feb 22 10:33:23 minidsp-shd volumio[777]: [Metrics] WebUI: 39s 790.24ms Feb 22 10:33:23 minidsp-shd volumio[777]: Volumio Calling Home Feb 22 10:33:23 minidsp-shd volumio[777]: info: CoreStateMachine::resetVolumioState Feb 22 10:33:23 minidsp-shd volumio[777]: info: CoreStateMachine::getcurrentVolume Feb 22 10:33:23 minidsp-shd volumio[777]: info: CoreCommandRouter::volumioRetrievevolume Feb 22 10:33:23 minidsp-shd volumio[777]: info: Stopping AccessToken refresher cron for QOBUZ Feb 22 10:33:24 minidsp-shd volumio[777]: info: AccessToken refresher cron started for QOBUZ Feb 22 10:33:24 minidsp-shd volumio[777]: info: msSurfaceDial volumioupdatevolume callback: {"vol":100,"mute":false,"disableVolumeControl":true} Feb 22 10:33:24 minidsp-shd volumio[777]: info: CoreStateMachine::pushState Feb 22 10:33:24 minidsp-shd volumio[777]: info: CorePlayQueue::getTrack 0 Feb 22 10:33:24 minidsp-shd volumio[777]: info: CoreCommandRouter::volumioPushState Feb 22 10:33:24 minidsp-shd volumio[777]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 22 10:33:24 minidsp-shd volumio[777]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 22 10:33:24 minidsp-shd sudo[1057]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 22 10:33:24 minidsp-shd sudo[1057]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 10:33:24 minidsp-shd sudo[1059]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 22 10:33:24 minidsp-shd sudo[1057]: pam_unix(sudo:session): session closed for user root Feb 22 10:33:24 minidsp-shd sudo[1059]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 10:33:24 minidsp-shd sudo[1062]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service Feb 22 10:33:24 minidsp-shd sudo[1062]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 10:33:24 minidsp-shd sudo[1059]: pam_unix(sudo:session): session closed for user root Feb 22 10:33:24 minidsp-shd systemd[1]: Configuration file /lib/systemd/system/volumiobt.service is marked executable. Please remove executable permission bits. Proceeding anyway. Feb 22 10:33:24 minidsp-shd systemd[1]: Starting Volumio Bluetooth Module... Feb 22 10:33:24 minidsp-shd systemd[1]: Started Volumio Bluetooth Module. Feb 22 10:33:24 minidsp-shd volumio[777]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Feb 22 10:33:24 minidsp-shd sudo[1062]: pam_unix(sudo:session): session closed for user root Feb 22 10:33:24 minidsp-shd volumio[777]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 10:33:24 minidsp-shd volumio[777]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 22 10:33:24 minidsp-shd volumio[777]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Feb 22 10:33:24 minidsp-shd volumio[777]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 22 10:33:24 minidsp-shd sudo[1068]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth/* Feb 22 10:33:24 minidsp-shd sudo[1068]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 10:33:24 minidsp-shd volumiobt[1067]: /bin/chmod: cannot access '/var/lib/bluetooth/*': No such file or directory Feb 22 10:33:24 minidsp-shd sudo[1068]: pam_unix(sudo:session): session closed for user root Feb 22 10:33:24 minidsp-shd volumio[777]: xcb_connection_has_error() returned true Feb 22 10:33:24 minidsp-shd volumio[777]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Feb 22 10:33:24 minidsp-shd volumio[777]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Feb 22 10:33:24 minidsp-shd volumio[777]: info: Serial port opened successfully Feb 22 10:33:25 minidsp-shd sudo[1075]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall pulseaudio Feb 22 10:33:25 minidsp-shd sudo[1075]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 10:33:26 minidsp-shd volumiobt[1067]: pulseaudio: no process found Feb 22 10:33:26 minidsp-shd sudo[1075]: pam_unix(sudo:session): session closed for user root Feb 22 10:33:26 minidsp-shd volumio[777]: info: Volumio BT Module successfully started Feb 22 10:33:26 minidsp-shd volumio[777]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Hardware Feb 22 10:33:26 minidsp-shd volumio[777]: [SpotifyConnect] Vollibrespot Daemon service started! Feb 22 10:33:26 minidsp-shd volumio[777]: [Metrics] SpotifyConnect: 8s 314.11ms Feb 22 10:33:26 minidsp-shd volumio[777]: info: SpopD Daemon Started Feb 22 10:33:26 minidsp-shd volumio[777]: info: TidalConnect service stoped! Feb 22 10:33:26 minidsp-shd dbus[588]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' Feb 22 10:33:26 minidsp-shd systemd[1]: Starting RealtimeKit Scheduling Policy Service... Feb 22 10:33:26 minidsp-shd volumio[777]: info: RAAT Albumart path created successfully Feb 22 10:33:26 minidsp-shd volumio[777]: error: Cannot set new Bluetooth Name : Error: Command failed: /usr/bin/sudo /bin/hciconfig hci0 name 'minidsp-shd' Feb 22 10:33:26 minidsp-shd volumio[777]: sudo: no tty present and no askpass program specified Feb 22 10:33:26 minidsp-shd volumio[777]: info: Cannot mount NAS Asustor_Nas at system boot, trial number 1 ,retrying in 5 seconds Feb 22 10:33:26 minidsp-shd volumio[777]: info: MPD running with PID585 Feb 22 10:33:26 minidsp-shd volumio[777]: ,establishing connection Feb 22 10:33:26 minidsp-shd dbus[588]: [system] Successfully activated service 'org.freedesktop.RealtimeKit1' Feb 22 10:33:26 minidsp-shd rtkit-daemon[1084]: Successfully called chroot. Feb 22 10:33:26 minidsp-shd rtkit-daemon[1084]: Successfully dropped privileges. Feb 22 10:33:26 minidsp-shd rtkit-daemon[1084]: Successfully limited resources. Feb 22 10:33:26 minidsp-shd rtkit-daemon[1084]: Running. Feb 22 10:33:26 minidsp-shd rtkit-daemon[1084]: Watchdog thread running. Feb 22 10:33:26 minidsp-shd rtkit-daemon[1084]: Canary thread running. Feb 22 10:33:26 minidsp-shd systemd[1]: Started RealtimeKit Scheduling Policy Service. Feb 22 10:33:26 minidsp-shd sudo[1087]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1 Feb 22 10:33:26 minidsp-shd sudo[1087]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 22 10:33:26 minidsp-shd dbus[588]: [system] Connection has not authenticated soon enough, closing it (auth_timeout=30000ms, elapsed: 30002ms) Feb 22 10:33:26 minidsp-shd sudo[1087]: pam_unix(sudo:session): session closed for user root Feb 22 10:33:26 minidsp-shd volumio[777]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 22 10:33:26 minidsp-shd volumio[777]: { Error: write EPIPE Feb 22 10:33:26 minidsp-shd volumio[777]: at WriteWrap.afterWrite [as oncomplete] (net.js:868:14) errno: 'EPIPE', code: 'EPIPE', syscall: 'write' } Feb 22 10:33:26 minidsp-shd volumio[777]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 22 10:33:27 minidsp-shd dbus[588]: [system] Activating via systemd: service name='org.bluez' unit='dbus-org.bluez.service' Feb 22 10:33:27 minidsp-shd systemd[1]: Starting Bluetooth service... Feb 22 10:33:27 minidsp-shd bluetoothd[1101]: Bluetooth daemon 5.23 Feb 22 10:33:27 minidsp-shd dbus[588]: [system] Successfully activated service 'org.bluez' Feb 22 10:33:27 minidsp-shd systemd[1]: Started Bluetooth service. Feb 22 10:33:27 minidsp-shd bluetoothd[1101]: Starting SDP server Feb 22 10:33:27 minidsp-shd bluetoothd[1101]: Excluding (cli) sap Feb 22 10:33:27 minidsp-shd bluetoothd[1101]: kernel lacks bnep-protocol support Feb 22 10:33:27 minidsp-shd bluetoothd[1101]: System does not support network plugin Feb 22 10:33:27 minidsp-shd dbus[588]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' Feb 22 10:33:27 minidsp-shd bluetoothd[1101]: Bluetooth management interface 1.14 initialized Feb 22 10:33:27 minidsp-shd systemd[1]: Starting Hostname Service... Feb 22 10:33:27 minidsp-shd pulseaudio[1081]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Feb 22 10:33:27 minidsp-shd pulseaudio[1081]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Feb 22 10:33:27 minidsp-shd volumiobt[1067]: Applying permissions Feb 22 10:33:27 minidsp-shd volumiobt[1067]: Setting BT discoverable and pairable Feb 22 10:33:27 minidsp-shd pulseaudio[1081]: org.bluez.Manager.GetProperties() failed: org.freedesktop.DBus.Error.UnknownMethod: Method "GetProperties" with signature "" on interface "org.bluez.Manager" doesn't exist Feb 22 10:33:27 minidsp-shd pulseaudio[1081]: org.bluez.Manager.GetProperties() failed: org.freedesktop.DBus.Error.UnknownMethod: Method "GetProperties" with signature "" on interface "org.bluez.Manager" doesn't exist Feb 22 10:33:27 minidsp-shd volumiobt[1067]: [38B blob data] Feb 22 10:33:27 minidsp-shd volumiobt[1067]: Invalid command Feb 22 10:33:27 minidsp-shd volumiobt[1067]: [bluetooth]# agent on Feb 22 10:33:27 minidsp-shd volumiobt[1067]: [bluetooth]# discoverable on Feb 22 10:33:27 minidsp-shd volumiobt[1067]: No default controller available Feb 22 10:33:27 minidsp-shd volumiobt[1067]: [bluetooth]# pairable on Feb 22 10:33:27 minidsp-shd volumiobt[1067]: No default controller available Feb 22 10:33:27 minidsp-shd systemd-hostnamed[1106]: Warning: nss-myhostname is not installed. Changing the local hostname might make it unresolveable. Please install nss-myhostname! Feb 22 10:33:27 minidsp-shd volumiobt[1067]: [bluetooth]# agent NoInputNoOutput Feb 22 10:33:27 minidsp-shd volumiobt[1067]: Failed to register agent object Feb 22 10:33:27 minidsp-shd volumiobt[1067]: [bluetooth]# default-agent Feb 22 10:33:27 minidsp-shd volumiobt[1067]: No agent is registered Feb 22 10:33:27 minidsp-shd volumiobt[1067]: [bluetooth]# quit Feb 22 10:33:27 minidsp-shd volumiobt[1067]: [61B blob data] Feb 22 10:33:27 minidsp-shd dbus[588]: [system] Successfully activated service 'org.freedesktop.hostname1' Feb 22 10:33:27 minidsp-shd volumiobt[1067]: [62B blob data] Feb 22 10:33:28 minidsp-shd systemd[1]: Started Hostname Service. Feb 22 10:33:29 minidsp-shd sudo[1119]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-22 10:32 Feb 22 10:33:29 minidsp-shd sudo[1119]: 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"