-- Logs begin at Sat 2025-11-22 18:06:08 CET, end at Sat 2025-12-20 17:41:43 CET. -- Dec 20 17:40:04 minidsp-shd volumio[1573]: <--- Last few GCs ---> Dec 20 17:40:04 minidsp-shd volumio[1573]: [1573:0x5340008] 2421056261 ms: Scavenge 211.7 (219.3) -> 211.6 (219.3) MB, 1.0 / 0.0 ms (average mu = 0.855, current mu = 0.881) allocation failure Dec 20 17:40:04 minidsp-shd volumio[1573]: [1573:0x5340008] 2421056377 ms: Scavenge (reduce) 224.0 (231.7) -> 224.0 (231.7) MB, 8.0 / 0.0 ms (average mu = 0.855, current mu = 0.881) allocation failure Dec 20 17:40:04 minidsp-shd volumio[1573]: [1573:0x5340008] 2421056482 ms: Scavenge (reduce) 236.5 (242.2) -> 236.5 (242.2) MB, 8.3 / 0.0 ms (average mu = 0.855, current mu = 0.881) allocation failure Dec 20 17:40:04 minidsp-shd volumio[1573]: <--- JS stacktrace ---> Dec 20 17:40:04 minidsp-shd volumio[1573]: FATAL ERROR: MarkCompactCollector: young object promotion failed Allocation failed - JavaScript heap out of memory Dec 20 17:40:04 minidsp-shd systemd[1]: volumio.service: Main process exited, code=killed, status=6/ABRT Dec 20 17:40:04 minidsp-shd volumio-remote-updater[1564]: [2025-12-20 17:40:04] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Dec 20 17:40:04 minidsp-shd volumio-remote-updater[1564]: [2025-12-20 17:40:04] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Dec 20 17:40:04 minidsp-shd systemd[1]: volumio.service: Failed with result 'signal'. Dec 20 17:40:04 minidsp-shd qobuz-connect[1816]: 20251220 17:40:04.812 [1816.1816] INFO SampleApp: Socket closed Dec 20 17:40:04 minidsp-shd systemd[1]: Started dynamicswap service. Dec 20 17:40:04 minidsp-shd vtcs[1917]: [2025-12-20 17:40:04.748] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected Dec 20 17:40:04 minidsp-shd systemd[1]: dynamicswap.service: Succeeded. Dec 20 17:40:04 minidsp-shd systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Dec 20 17:40:04 minidsp-shd systemd[1]: volumio.service: Scheduled restart job, restart counter is at 2. Dec 20 17:40:04 minidsp-shd systemd[1]: Started dynamicswap service. Dec 20 17:40:04 minidsp-shd systemd[1]: Stopped Volumio Backend Module. Dec 20 17:40:04 minidsp-shd systemd[1]: Started Volumio Backend Module. Dec 20 17:40:04 minidsp-shd systemd[1]: dynamicswap.service: Succeeded. Dec 20 17:40:09 minidsp-shd volumio[7657]: info: ------------------------------------------- Dec 20 17:40:09 minidsp-shd volumio[7657]: info: ----- Volumio3 ---- Dec 20 17:40:09 minidsp-shd volumio[7657]: info: ------------------------------------------- Dec 20 17:40:09 minidsp-shd volumio[7657]: info: ----- System startup ---- Dec 20 17:40:09 minidsp-shd volumio[7657]: info: ------------------------------------------- Dec 20 17:40:09 minidsp-shd volumio-remote-updater[1564]: [2025-12-20 17:40:09] [connect] Successful connection Dec 20 17:40:10 minidsp-shd volumio[7657]: info: MYVOLUMIO Environment detected Dec 20 17:40:11 minidsp-shd volumio[7657]: info: Plugin folders cleanup Dec 20 17:40:11 minidsp-shd volumio[7657]: info: Scanning into folder /volumio/app/plugins/ Dec 20 17:40:11 minidsp-shd volumio[7657]: info: Scanning category audio_interface Dec 20 17:40:11 minidsp-shd volumio[7657]: info: Scanning category miscellanea Dec 20 17:40:11 minidsp-shd volumio[7657]: info: Scanning category music_service Dec 20 17:40:11 minidsp-shd volumio[7657]: info: Scanning category plugins.json Dec 20 17:40:11 minidsp-shd volumio[7657]: info: Scanning category system_controller Dec 20 17:40:11 minidsp-shd volumio[7657]: info: Scanning category user_interface Dec 20 17:40:11 minidsp-shd volumio[7657]: info: Scanning into folder /data/plugins/ Dec 20 17:40:11 minidsp-shd volumio[7657]: info: Plugin folders cleanup completed Dec 20 17:40:11 minidsp-shd volumio[7657]: info: ------------------------------------------- Dec 20 17:40:11 minidsp-shd volumio[7657]: info: ----- Core plugins startup ---- Dec 20 17:40:11 minidsp-shd volumio[7657]: info: ------------------------------------------- Dec 20 17:40:11 minidsp-shd volumio[7657]: info: Loading plugins from folder /volumio/app/plugins/ Dec 20 17:40:11 minidsp-shd volumio[7657]: info: Adding plugin bluetooth to MyMusic Plugins Dec 20 17:40:11 minidsp-shd volumio[7657]: info: Adding plugin multiroom to MyMusic Plugins Dec 20 17:40:11 minidsp-shd volumio[7657]: info: Adding plugin upnp to MyMusic Plugins Dec 20 17:40:11 minidsp-shd volumio[7657]: info: Adding plugin metavolumio to MyMusic Plugins Dec 20 17:40:11 minidsp-shd volumio[7657]: info: Adding plugin ms_surface_dial to MyMusic Plugins Dec 20 17:40:11 minidsp-shd volumio[7657]: info: Adding plugin airplay_emulation to MyMusic Plugins Dec 20 17:40:11 minidsp-shd volumio[7657]: info: Adding plugin cd_controller to MyMusic Plugins Dec 20 17:40:11 minidsp-shd volumio[7657]: info: Adding plugin qobuzconnect to MyMusic Plugins Dec 20 17:40:11 minidsp-shd volumio[7657]: info: Adding plugin raat to MyMusic Plugins Dec 20 17:40:11 minidsp-shd volumio[7657]: info: Adding plugin tidalconnect to MyMusic Plugins Dec 20 17:40:11 minidsp-shd volumio[7657]: info: Adding plugin upnp_browser to MyMusic Plugins Dec 20 17:40:11 minidsp-shd volumio[7657]: info: Loading plugins from folder /data/plugins/ Dec 20 17:40:11 minidsp-shd volumio[7657]: info: Loading plugin "system"... Dec 20 17:40:11 minidsp-shd volumio[7657]: info: Loading plugin "appearance"... Dec 20 17:40:13 minidsp-shd volumio[7657]: info: Loading plugin "network"... Dec 20 17:40:13 minidsp-shd volumio[7657]: info: Refreshing Cached IP Addresses Dec 20 17:40:13 minidsp-shd sudo[7684]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 20 17:40:13 minidsp-shd sudo[7684]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 17:40:13 minidsp-shd sudo[7686]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 20 17:40:13 minidsp-shd volumio[7657]: info: Loading plugin "services"... Dec 20 17:40:13 minidsp-shd sudo[7686]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 17:40:13 minidsp-shd sudo[7684]: pam_unix(sudo:session): session closed for user root Dec 20 17:40:13 minidsp-shd volumio[7657]: info: Loading plugin "alsa_controller"... Dec 20 17:40:13 minidsp-shd sudo[7686]: pam_unix(sudo:session): session closed for user root Dec 20 17:40:13 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 20 17:40:13 minidsp-shd volumio[7657]: info: Loading plugin "wizard"... Dec 20 17:40:13 minidsp-shd volumio[7657]: info: Loading plugin "networkfs"... Dec 20 17:40:13 minidsp-shd volumio[7657]: info: Cannot mount NAS QNAP at system boot, trial number 1 ,retrying in 5 seconds Dec 20 17:40:13 minidsp-shd volumio[7657]: info: Starting Udev Watcher for removable devices Dec 20 17:40:13 minidsp-shd volumio[7657]: info: Ignoring mount for partition: BOOT Dec 20 17:40:13 minidsp-shd volumio[7657]: info: Ignoring mount for partition: volumio Dec 20 17:40:13 minidsp-shd volumio[7657]: info: Ignoring mount for partition: volumio_data Dec 20 17:40:13 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 20 17:40:13 minidsp-shd volumio[7657]: info: Loading plugin "volumio_command_line_client"... Dec 20 17:40:13 minidsp-shd volumio[7657]: info: Loading plugin "upnp"... Dec 20 17:40:13 minidsp-shd volumio[7657]: info: [1766248813901] Starting Upmpd Daemon Dec 20 17:40:13 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 20 17:40:13 minidsp-shd volumio[7657]: info: Loading plugin "my_music"... Dec 20 17:40:13 minidsp-shd volumio[7657]: info: Loading plugin "mpd"... Dec 20 17:40:14 minidsp-shd volumio[7657]: info: Loading plugin "upnp_browser"... Dec 20 17:40:15 minidsp-shd volumio[7657]: info: Loading plugin "bluetooth"... Dec 20 17:40:15 minidsp-shd volumio[7657]: info: [1766248815397] Starting BluetoothController Dec 20 17:40:15 minidsp-shd volumio[7657]: info: Loading plugin "alarm-clock"... Dec 20 17:40:15 minidsp-shd volumio[7657]: info: Loading plugin "manifestui"... Dec 20 17:40:16 minidsp-shd volumio[7657]: info: Loading plugin "metavolumio"... Dec 20 17:40:18 minidsp-shd volumio[7657]: info: Loading plugin "airplay_emulation"... Dec 20 17:40:18 minidsp-shd volumio[7657]: info: Starting Shairport Sync Dec 20 17:40:18 minidsp-shd volumio[7657]: info: Loading plugin "cd_controller"... Dec 20 17:40:18 minidsp-shd volumio[7657]: info: Loading plugin "last_100"... Dec 20 17:40:18 minidsp-shd volumio[7657]: info: Loading plugin "qobuzconnect"... Dec 20 17:40:18 minidsp-shd volumio[7657]: info: Loading plugin "raat"... Dec 20 17:40:19 minidsp-shd volumio[7657]: info: RAAT Plugin loaded Dec 20 17:40:19 minidsp-shd volumio[7657]: info: Adding restartRAATSocket REST API Endpoint Dec 20 17:40:19 minidsp-shd volumio[7657]: info: Adding restartRAATSocket REST Endpoint for plugin: music_service/raat Dec 20 17:40:19 minidsp-shd volumio[7657]: info: Loading plugin "streaming_services"... Dec 20 17:40:21 minidsp-shd volumio[7657]: info: Starting Streaming Service Transparent Proxy Dec 20 17:40:21 minidsp-shd volumio[7657]: info: Loading plugin "tidalconnect"... Dec 20 17:40:21 minidsp-shd volumio[7657]: info: Loading plugin "webradio"... Dec 20 17:40:21 minidsp-shd volumio[7657]: info: Loading plugin "i2s_dacs"... Dec 20 17:40:21 minidsp-shd volumio[7657]: info: I2S DAC not set, start Auto-detection Dec 20 17:40:21 minidsp-shd volumio[7657]: info: Loading plugin "volumiodiscovery"... Dec 20 17:40:21 minidsp-shd volumio[7657]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 20 17:40:21 minidsp-shd volumio[7657]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 20 17:40:21 minidsp-shd volumio[7657]: *** WARNING *** For more information see Dec 20 17:40:21 minidsp-shd volumio[7657]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 20 17:40:21 minidsp-shd volumio[7657]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 20 17:40:21 minidsp-shd volumio[7657]: *** WARNING *** For more information see Dec 20 17:40:21 minidsp-shd node[7657]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 20 17:40:21 minidsp-shd node[7657]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 20 17:40:21 minidsp-shd node[7657]: *** WARNING *** For more information see Dec 20 17:40:21 minidsp-shd node[7657]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 20 17:40:21 minidsp-shd node[7657]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 20 17:40:21 minidsp-shd node[7657]: *** WARNING *** For more information see Dec 20 17:40:21 minidsp-shd volumio[7657]: info: Applying required configuration parameters for plugin volumiodiscovery Dec 20 17:40:21 minidsp-shd volumio[7657]: info: Discovery: Started advertising with name: miniDSP SHD Dec 20 17:40:21 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 20 17:40:21 minidsp-shd volumio[7657]: info: Loading plugin "multiroom"... Dec 20 17:40:22 minidsp-shd volumio-remote-updater[1564]: [2025-12-20 17:40:22] [connect] Successful connection Dec 20 17:40:22 minidsp-shd volumio[7657]: STREAMING PROXY: Starting server on port 3245 Dec 20 17:40:22 minidsp-shd volumio[7657]: Node JS runtime: 14 Dec 20 17:40:24 minidsp-shd volumio[7657]: info: Applying required configuration parameters for plugin multiroom Dec 20 17:40:24 minidsp-shd sudo[7737]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Dec 20 17:40:24 minidsp-shd sudo[7737]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 17:40:24 minidsp-shd sudo[7737]: pam_unix(sudo:session): session closed for user root Dec 20 17:40:24 minidsp-shd volumio[7657]: /bin/mkdir: cannot create directory ‘/tmp/hls’: File exists Dec 20 17:40:24 minidsp-shd volumio[7657]: info: MRS: MultiRoom plugin initialized Dec 20 17:40:24 minidsp-shd volumio[7657]: info: MRS: STOPPING SNAPCLIENT Dec 20 17:40:24 minidsp-shd volumio[7657]: info: MRS: Snap server stop Dec 20 17:40:24 minidsp-shd sudo[7753]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Dec 20 17:40:24 minidsp-shd sudo[7753]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 17:40:24 minidsp-shd volumio[7657]: info: MRS: STOPPING volumioStreaming Dec 20 17:40:24 minidsp-shd sudo[7756]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver Dec 20 17:40:24 minidsp-shd sudo[7756]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 17:40:24 minidsp-shd sudo[7759]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Dec 20 17:40:24 minidsp-shd sudo[7759]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 17:40:24 minidsp-shd volumio[7657]: info: Loading plugin "outputs"... Dec 20 17:40:24 minidsp-shd volumio[7657]: info: Loading plugin "albumart"... Dec 20 17:40:24 minidsp-shd sudo[7762]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Dec 20 17:40:24 minidsp-shd sudo[7762]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 17:40:24 minidsp-shd sudo[7762]: pam_unix(sudo:session): session closed for user root Dec 20 17:40:24 minidsp-shd volumio[7657]: info: Loading plugin "ms_surface_dial"... Dec 20 17:40:24 minidsp-shd sudo[7756]: pam_unix(sudo:session): session closed for user root Dec 20 17:40:24 minidsp-shd sudo[7753]: pam_unix(sudo:session): session closed for user root Dec 20 17:40:24 minidsp-shd sudo[7759]: pam_unix(sudo:session): session closed for user root Dec 20 17:40:25 minidsp-shd volumio[7657]: Forking 3 albumart workers Dec 20 17:40:25 minidsp-shd volumio[7657]: info: Applying required configuration parameters for plugin ms_surface_dial Dec 20 17:40:25 minidsp-shd volumio[7657]: info: Plugin example_plugin is not enabled Dec 20 17:40:25 minidsp-shd volumio[7657]: info: Loading plugin "hi_res_audio"... Dec 20 17:40:26 minidsp-shd volumio[7657]: Starting albumart workers Dec 20 17:40:26 minidsp-shd volumio[7657]: Starting albumart workers Dec 20 17:40:26 minidsp-shd volumio[7657]: Starting albumart workers Dec 20 17:40:28 minidsp-shd volumio[7657]: info: Applying required configuration parameters for plugin hi_res_audio Dec 20 17:40:28 minidsp-shd volumio[7657]: info: Loading plugin "inputs"... Dec 20 17:40:29 minidsp-shd volumio[7657]: info: Loading plugin "qobuz"... Dec 20 17:40:31 minidsp-shd volumio[7657]: info: Loading plugin "tidal"... Dec 20 17:40:33 minidsp-shd volumio[7657]: info: Loading plugin "oem_helper"... Dec 20 17:40:34 minidsp-shd volumio[7657]: info: Applying required configuration parameters for plugin oem_helper Dec 20 17:40:34 minidsp-shd volumio[7657]: info: Loading plugin "updater_comm"... Dec 20 17:40:35 minidsp-shd volumio[7657]: info: Plugin mpdemulation is not enabled Dec 20 17:40:35 minidsp-shd volumio[7657]: info: Loading plugin "rest_api"... Dec 20 17:40:35 minidsp-shd volumio[7657]: info: Loading plugin "websocket"... Dec 20 17:40:35 minidsp-shd volumio[7657]: info: Starting Socket.io Server version 2.3.0 Dec 20 17:40:35 minidsp-shd volumio[7657]: info: Loading i18n strings for locale it Dec 20 17:40:35 minidsp-shd volumio[7657]: Updating browse sources language Dec 20 17:40:35 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 20 17:40:35 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 20 17:40:35 minidsp-shd volumio[7657]: info: CoreCommandRouter::initPlayerControls Dec 20 17:40:35 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:40:35 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:40:35 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:40:35 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:40:35 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:40:35 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:40:35 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:40:35 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:40:35 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 20 17:40:35 minidsp-shd volumio[7657]: Express server listening on port 3000 Dec 20 17:40:35 minidsp-shd volumio[7657]: [Metrics] WebUI: 27s 458.96ms Dec 20 17:40:35 minidsp-shd volumio[7657]: info: CoreStateMachine::resetVolumioState Dec 20 17:40:35 minidsp-shd volumio[7657]: info: CoreStateMachine::getcurrentVolume Dec 20 17:40:35 minidsp-shd volumio[7657]: info: CoreCommandRouter::volumioRetrievevolume Dec 20 17:40:35 minidsp-shd volumio[7657]: info: CoreStateMachine::pushState Dec 20 17:40:35 minidsp-shd volumio[7657]: info: CorePlayQueue::getTrack 0 Dec 20 17:40:35 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 17:40:35 minidsp-shd volumio[7657]: info: CoreCommandRouter::volumioPushState Dec 20 17:40:35 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 20 17:40:35 minidsp-shd volumio[7657]: info: Cannot mount NAS QNAP at system boot, trial number 2 ,retrying in 5 seconds Dec 20 17:40:35 minidsp-shd sudo[7872]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 20 17:40:35 minidsp-shd sudo[7872]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 17:40:35 minidsp-shd sudo[7872]: pam_unix(sudo:session): session closed for user root Dec 20 17:40:35 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: inputs , getVolume Dec 20 17:40:35 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: inputs , getDSP Dec 20 17:40:35 minidsp-shd sudo[7875]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 20 17:40:35 minidsp-shd sudo[7875]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 17:40:35 minidsp-shd volumio[7657]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Dec 20 17:40:35 minidsp-shd volumio[7657]: info: Completed loading Core Plugins Dec 20 17:40:35 minidsp-shd sudo[7875]: pam_unix(sudo:session): session closed for user root Dec 20 17:40:35 minidsp-shd volumio[7657]: info: Preparing to generate the ALSA configuration file Dec 20 17:40:36 minidsp-shd volumio[7657]: info: Volumio Network Manager: Network status updated: 1 Dec 20 17:40:36 minidsp-shd volumio[7657]: info: MRS: Removed streaming files Dec 20 17:40:36 minidsp-shd volumio[7657]: info: MRS: volumioStreaming STOPPED Dec 20 17:40:36 minidsp-shd volumio[7657]: info: MRS: SNAPSERVER STOPPED Dec 20 17:40:36 minidsp-shd volumio[7657]: info: MRS: SNAPCLIENT STOPPED Dec 20 17:40:36 minidsp-shd volumio[7657]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Dec 20 17:40:36 minidsp-shd volumio[7657]: info: Reading ALSA contributions from plugins. Dec 20 17:40:36 minidsp-shd volumio[7657]: verbose: New Socket.io Connection to 192.168.1.20 from 192.168.1.18 UA: Mozilla/5.0 (Linux; Android 15; 23073RPBFG Build/AQ3A.240829.003; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/143.0.7499.115 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Dec 20 17:40:36 minidsp-shd volumio[7657]: verbose: New Socket.io Connection to 192.168.1.20 from 192.168.1.18 UA: Mozilla/5.0 (Linux; Android 15; 23073RPBFG Build/AQ3A.240829.003; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/143.0.7499.115 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Dec 20 17:40:36 minidsp-shd volumio[7657]: verbose: New Socket.io Connection to 192.168.1.20 from 192.168.1.18 UA: Mozilla/5.0 (Linux; Android 15; 23073RPBFG Build/AQ3A.240829.003; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/143.0.7499.115 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Dec 20 17:40:36 minidsp-shd volumio[7657]: verbose: New Socket.io Connection to 192.168.1.20:3000 from 192.168.1.18 UA: Dart/3.9 (dart:io) Engine version: 3 Transport: websocket Total Clients: 4 Dec 20 17:40:36 minidsp-shd volumio[7657]: verbose: New Socket.io Connection to 192.168.1.20 from 192.168.1.18 UA: Mozilla/5.0 (Linux; Android 15; 23073RPBFG Build/AQ3A.240829.003; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/143.0.7499.115 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Dec 20 17:40:36 minidsp-shd volumio[7657]: verbose: New Socket.io Connection to 192.168.1.20:3000 from 192.168.1.18 UA: Dart/3.9 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Dec 20 17:40:36 minidsp-shd volumio[7657]: info: Reloading queue from file Dec 20 17:40:36 minidsp-shd volumio[7657]: info: Setting Device type: NanoPi NEO 2 Dec 20 17:40:36 minidsp-shd volumio[7657]: info: CoreStateMachine::setRepeat false single undefined Dec 20 17:40:36 minidsp-shd volumio[7657]: info: CoreStateMachine::pushState Dec 20 17:40:36 minidsp-shd volumio[7657]: info: CorePlayQueue::getTrack 0 Dec 20 17:40:36 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 17:40:36 minidsp-shd volumio[7657]: info: CoreCommandRouter::volumioPushState Dec 20 17:40:36 minidsp-shd volumio[7657]: info: CoreStateMachine::setRandom false Dec 20 17:40:36 minidsp-shd volumio[7657]: info: CoreStateMachine::pushState Dec 20 17:40:36 minidsp-shd volumio[7657]: info: CorePlayQueue::getTrack 0 Dec 20 17:40:36 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 17:40:36 minidsp-shd volumio[7657]: info: CoreCommandRouter::volumioPushState Dec 20 17:40:36 minidsp-shd volumio[7657]: verbose: New Socket.io Connection to 192.168.1.20 from 192.168.1.18 UA: Mozilla/5.0 (Linux; Android 15; 23073RPBFG Build/AQ3A.240829.003; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/143.0.7499.115 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Dec 20 17:40:36 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 20 17:40:36 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 20 17:40:36 minidsp-shd volumio[7657]: info: Discovery: Getting this device information Dec 20 17:40:36 minidsp-shd volumio[7657]: info: CoreCommandRouter::volumioGetState Dec 20 17:40:36 minidsp-shd volumio[7657]: info: CorePlayQueue::getTrack 0 Dec 20 17:40:36 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 20 17:40:36 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 20 17:40:36 minidsp-shd sudo[7883]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Dec 20 17:40:36 minidsp-shd sudo[7883]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 17:40:36 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 20 17:40:36 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 20 17:40:36 minidsp-shd volumio[7657]: info: Discovery: Getting this device information Dec 20 17:40:36 minidsp-shd volumio[7657]: info: CoreCommandRouter::volumioGetState Dec 20 17:40:36 minidsp-shd sudo[7883]: pam_unix(sudo:session): session closed for user root Dec 20 17:40:36 minidsp-shd volumio[7657]: info: CorePlayQueue::getTrack 0 Dec 20 17:40:36 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 20 17:40:36 minidsp-shd volumio[7657]: info: Asound.conf file unchanged, so no further update is needed Dec 20 17:40:36 minidsp-shd volumio[7657]: info: Output device has changed, restarting MPD Dec 20 17:40:36 minidsp-shd sudo[7887]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 20 17:40:36 minidsp-shd sudo[7887]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 17:40:36 minidsp-shd sudo[7887]: pam_unix(sudo:session): session closed for user root Dec 20 17:40:36 minidsp-shd volumio[7657]: info: Output device has changed, restarting Shairport Sync Dec 20 17:40:36 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:40:36 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 20 17:40:36 minidsp-shd sudo[7890]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 20 17:40:36 minidsp-shd sudo[7890]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 17:40:36 minidsp-shd systemd[1]: Stopping Music Player Daemon... Dec 20 17:40:36 minidsp-shd volumio[7657]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 20 17:40:36 minidsp-shd volumio[7657]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 20 17:40:36 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:40:36 minidsp-shd volumio[7657]: info: ___________ START PLUGINS ___________ Dec 20 17:40:36 minidsp-shd volumio[7657]: info: ControllerMpd::onStart: Initializing MPD Dec 20 17:40:36 minidsp-shd volumio[7657]: info: Creating MPD Configuration file Dec 20 17:40:36 minidsp-shd sudo[7898]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 20 17:40:36 minidsp-shd sudo[7898]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 17:40:36 minidsp-shd sudo[7898]: pam_unix(sudo:session): session closed for user root Dec 20 17:40:36 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 20 17:40:36 minidsp-shd volumio[7657]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 20 17:40:36 minidsp-shd volumio[7657]: info: [1766248836940] CoreMusicLibrary::Adding element Server multimediali Dec 20 17:40:36 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 20 17:40:36 minidsp-shd sudo[7901]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 20 17:40:36 minidsp-shd sudo[7901]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 17:40:37 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 20 17:40:37 minidsp-shd volumio[7657]: info: Adding METAVOLUMIO REST API Endpoints Dec 20 17:40:37 minidsp-shd volumio[7657]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Dec 20 17:40:37 minidsp-shd volumio[7657]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Dec 20 17:40:37 minidsp-shd volumio[7657]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Dec 20 17:40:37 minidsp-shd volumio[7657]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Dec 20 17:40:37 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:40:37 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 20 17:40:37 minidsp-shd sudo[7904]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name miniDSP SHD Dec 20 17:40:37 minidsp-shd sudo[7904]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 17:40:37 minidsp-shd sudo[7904]: pam_unix(sudo:session): session closed for user root Dec 20 17:40:37 minidsp-shd volumio[7657]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 20 17:40:37 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:40:37 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 20 17:40:37 minidsp-shd volumio[7657]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 20 17:40:37 minidsp-shd volumio[7657]: info: Preparing CD Folders Dec 20 17:40:37 minidsp-shd volumio[7657]: info: Adding CD REST API Endpoints Dec 20 17:40:37 minidsp-shd volumio[7657]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Dec 20 17:40:37 minidsp-shd volumio[7657]: info: Starting UDEV Watcher for CD Dec 20 17:40:37 minidsp-shd volumio[7657]: info: Detecting CD presence with UDEV Dec 20 17:40:37 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices Dec 20 17:40:37 minidsp-shd volumio[7657]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 20 17:40:37 minidsp-shd volumio[7657]: info: [1766248837242] CoreMusicLibrary::Adding element Last_100 Dec 20 17:40:37 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 20 17:40:37 minidsp-shd volumio[7657]: info: Adding qc_getconfig REST Endpoint for plugin: music_service/qobuzconnect Dec 20 17:40:37 minidsp-shd volumio-remote-updater[1564]: [2025-12-20 17:40:37] [connect] Successful connection Dec 20 17:40:37 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 20 17:40:37 minidsp-shd volumio[7657]: info: QobuzConnect: Starting Qobuz Connect socket and service Dec 20 17:40:37 minidsp-shd volumio[7657]: info: Starting RAAT Plugin Dec 20 17:40:37 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , addAdditionalUISections Dec 20 17:40:37 minidsp-shd volumio[7657]: info: Additional UI Settings Added for plugin music_service/raat Dec 20 17:40:37 minidsp-shd volumio[7657]: info: Streaming services startup Dec 20 17:40:37 minidsp-shd volumio[7657]: info: Starting Streaming Daemon Dec 20 17:40:37 minidsp-shd sudo[7916]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 20 17:40:37 minidsp-shd sudo[7916]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 17:40:37 minidsp-shd sudo[7916]: pam_unix(sudo:session): session closed for user root Dec 20 17:40:37 minidsp-shd sudo[7919]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Dec 20 17:40:37 minidsp-shd sudo[7919]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 17:40:37 minidsp-shd sudo[7920]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 20 17:40:37 minidsp-shd sudo[7920]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 17:40:37 minidsp-shd sudo[7919]: pam_unix(sudo:session): session closed for user root Dec 20 17:40:37 minidsp-shd systemd[1]: Stopping Volumio Qobuz Connect Service... Dec 20 17:40:37 minidsp-shd volumio[7657]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 20 17:40:37 minidsp-shd volumio[7657]: info: [1766248837567] CoreMusicLibrary::Adding element Webradio Dec 20 17:40:37 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 20 17:40:37 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 20 17:40:37 minidsp-shd sudo[7929]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 20 17:40:37 minidsp-shd sudo[7929]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 17:40:37 minidsp-shd volumio[7657]: info: Initializing BBC Radios Dec 20 17:40:37 minidsp-shd systemd[1]: Stopping Volumio Tidal Connect Service... Dec 20 17:40:37 minidsp-shd systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Dec 20 17:40:37 minidsp-shd systemd[1]: vtcs.service: Succeeded. Dec 20 17:40:37 minidsp-shd systemd[1]: Stopped Volumio Tidal Connect Service. Dec 20 17:40:37 minidsp-shd sudo[7929]: pam_unix(sudo:session): session closed for user root Dec 20 17:40:37 minidsp-shd qobuz-connect[1816]: 20251220 17:40:37.707 [1816.1816] INFO SampleApp: Stopping Local configuration server Dec 20 17:40:37 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 20 17:40:37 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 20 17:40:37 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus Dec 20 17:40:37 minidsp-shd volumio[7657]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 20 17:40:37 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:40:37 minidsp-shd volumio[7657]: error: Hi Res Audio Failed Login: Missing Login Data Dec 20 17:40:37 minidsp-shd volumio[7657]: info: Adding HIGHRESAUDIO REST API Endpoints Dec 20 17:40:37 minidsp-shd volumio[7657]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Dec 20 17:40:37 minidsp-shd volumio[7657]: info: Adding saveAccountData_hi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Dec 20 17:40:37 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 20 17:40:37 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 20 17:40:37 minidsp-shd volumio[7657]: info: Volumio Calling Home Dec 20 17:40:38 minidsp-shd volumio[7657]: info: QobuzConnect: Opened /tmp/qbz-connect.socket socket, listening for connections Dec 20 17:40:38 minidsp-shd volumio[7657]: info: Stopping AccessToken refresher cron for QOBUZ Dec 20 17:40:38 minidsp-shd systemd[1]: qobuz-connect.service: Succeeded. Dec 20 17:40:38 minidsp-shd systemd[1]: Stopped Volumio Qobuz Connect Service. Dec 20 17:40:38 minidsp-shd systemd[1]: Started Volumio Qobuz Connect Service. Dec 20 17:40:38 minidsp-shd sudo[7920]: pam_unix(sudo:session): session closed for user root Dec 20 17:40:38 minidsp-shd volumio[7657]: info: AccessToken refresher cron started for QOBUZ Dec 20 17:40:38 minidsp-shd volumio[7657]: info: Adding TIDAL REST API Endpoints Dec 20 17:40:38 minidsp-shd volumio[7657]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal Dec 20 17:40:38 minidsp-shd volumio[7657]: info: Adding QOBUZ REST API Endpoints Dec 20 17:40:38 minidsp-shd volumio[7657]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz Dec 20 17:40:38 minidsp-shd volumio[7657]: info: Discovery: adding be0871ae-e095-4897-9223-ba341f4c9119 Dec 20 17:40:38 minidsp-shd volumio[7657]: info: Discovery: Found device miniDSP SHD Dec 20 17:40:38 minidsp-shd volumio[7657]: info: CoreCommandRouter::volumioGetState Dec 20 17:40:38 minidsp-shd volumio[7657]: info: CorePlayQueue::getTrack 0 Dec 20 17:40:38 minidsp-shd volumio[7657]: info: MRS: Pushing multiroomSync output for this device Dec 20 17:40:38 minidsp-shd volumio[7657]: info: MRS: Pushing multiroomSync output Dec 20 17:40:38 minidsp-shd volumio[7657]: info: Adding audio output: Dec 20 17:40:38 minidsp-shd volumio[7657]: info: Adding audio output: Dec 20 17:40:38 minidsp-shd volumio[7657]: info: CoreCommandRouter::volumioGetVisibleSources Dec 20 17:40:38 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 20 17:40:38 minidsp-shd volumio[7657]: info: CoreCommandRouter::volumioGetState Dec 20 17:40:38 minidsp-shd volumio[7657]: info: CorePlayQueue::getTrack 0 Dec 20 17:40:38 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Dec 20 17:40:38 minidsp-shd volumio[7657]: info: CoreCommandRouter::volumioGetQueue Dec 20 17:40:38 minidsp-shd volumio[7657]: info: CoreStateMachine::getQueue Dec 20 17:40:38 minidsp-shd volumio[7657]: info: CorePlayQueue::getQueue Dec 20 17:40:38 minidsp-shd volumio[7657]: info: Listing playlists Dec 20 17:40:38 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 20 17:40:38 minidsp-shd volumio[7657]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Dec 20 17:40:38 minidsp-shd volumio[7657]: info: Received Get System Info Dec 20 17:40:38 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 20 17:40:38 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 20 17:40:38 minidsp-shd volumio[7657]: info: Discovery: Getting this device information Dec 20 17:40:38 minidsp-shd volumio[7657]: info: CoreCommandRouter::volumioGetState Dec 20 17:40:38 minidsp-shd volumio[7657]: info: CorePlayQueue::getTrack 0 Dec 20 17:40:38 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 20 17:40:38 minidsp-shd volumio[7657]: info: CoreCommandRouter::volumioGetState Dec 20 17:40:38 minidsp-shd volumio[7657]: info: CorePlayQueue::getTrack 0 Dec 20 17:40:38 minidsp-shd volumio[7657]: info: Upmpdcli Daemon Started Dec 20 17:40:38 minidsp-shd volumio[7657]: info: Serial port opened successfully Dec 20 17:40:38 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 20 17:40:38 minidsp-shd volumio[7657]: error: Cannot start Volumio Streaming Daemon Dec 20 17:40:38 minidsp-shd volumio[7657]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Dec 20 17:40:38 minidsp-shd volumio[7657]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Dec 20 17:40:38 minidsp-shd volumio[7657]: error: Cannot set new Bluetooth Name : Error: Command failed: /usr/bin/sudo /bin/hciconfig hci0 name 'miniDSP SHD' Dec 20 17:40:38 minidsp-shd volumio[7657]: Can't get device info: No such device Dec 20 17:40:38 minidsp-shd volumio[7657]: info: MPD Permissions set Dec 20 17:40:38 minidsp-shd volumio[7657]: info: MPD Permissions set Dec 20 17:40:38 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Dec 20 17:40:38 minidsp-shd volumio[7657]: info: msSurfaceDial Managed Objs {"/org/bluez":{"org.freedesktop.DBus.Introspectable":{},"org.bluez.AgentManager1":{},"org.bluez.ProfileManager1":{}}} Dec 20 17:40:38 minidsp-shd volumio[7657]: info: [msSurfaceDial init()] check /org/bluez Dec 20 17:40:38 minidsp-shd volumio[7657]: info: [msSurfaceDial init()] Adapter: null; SurfaceDial: null Dec 20 17:40:38 minidsp-shd volumio[7657]: info: msSurfaceDial BluetoothSurfaceDial init() - ready! Dec 20 17:40:38 minidsp-shd volumio[7657]: info: CoreCommandRouter::Reload Ui Dec 20 17:40:38 minidsp-shd volumio-remote-updater[1564]: [2025-12-20 17:40:38] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1766248837 101 Dec 20 17:40:38 minidsp-shd volumio[7657]: 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: 8 Dec 20 17:40:38 minidsp-shd volumio[7657]: info: Executing endpoint qc_getconfig Dec 20 17:40:38 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Dec 20 17:40:38 minidsp-shd qobuz-connect[7958]: 20251220 17:40:38.974 [7958.7958] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Dec 20 17:40:38 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: system , getCurrentTimezone Dec 20 17:40:39 minidsp-shd qobuz-connect[7958]: 20251220 17:40:39.023 [7958.7958] INFO VolumeManager: [0x14f8908]: Setting new playback volume: 75 Dec 20 17:40:39 minidsp-shd qobuz-connect[7958]: 20251220 17:40:39.023 [7958.7958] INFO VolumeManager: [0x14f8908]: Setting new mute state: 0 Dec 20 17:40:39 minidsp-shd qobuz-connect[7958]: 20251220 17:40:39.024 [7958.7958] INFO QobuzConnect: [0x14f92d8]: Client initialized! Dec 20 17:40:39 minidsp-shd qobuz-connect[7958]: 20251220 17:40:39.024 [7958.7958] INFO SampleApp: Starting Avahi advertising, name: miniDSP SHD, service name: _qobuz-connect._tcp Dec 20 17:40:39 minidsp-shd qobuz-connect[7958]: 20251220 17:40:39.038 [7958.7958] INFO LocalConfigManager: [0x14f81e8]: Starting Local Configuration server Dec 20 17:40:39 minidsp-shd qobuz-connect[7958]: 20251220 17:40:39.039 [7958.7958] INFO SampleApp: Starting Local configuration server Dec 20 17:40:39 minidsp-shd qobuz-connect[7958]: 20251220 17:40:39.040 [7958.7958] INFO SampleApp: Connected to UNIX socket client 0x14eded8 Dec 20 17:40:39 minidsp-shd qobuz-connect[7958]: 20251220 17:40:39.123 [7958.7958] INFO SampleApp: Playback volume changed: 75 Dec 20 17:40:39 minidsp-shd systemd[1]: mpd.service: Succeeded. Dec 20 17:40:39 minidsp-shd systemd[1]: Stopped Music Player Daemon. Dec 20 17:40:39 minidsp-shd systemd[1]: Starting Music Player Daemon... Dec 20 17:40:39 minidsp-shd volumio[7657]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Dec 20 17:40:39 minidsp-shd volumio[7657]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Dec 20 17:40:39 minidsp-shd volumio[7657]: info: QobuzConnect: QOBUZ Connect daemon connected Dec 20 17:40:39 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:40:39 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:40:39 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:40:39 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:40:39 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:40:39 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:40:39 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:40:39 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:40:39 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 20 17:40:39 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Dec 20 17:40:39 minidsp-shd sudo[7964]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 20 17:40:39 minidsp-shd sudo[7964]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 17:40:39 minidsp-shd sudo[7964]: pam_unix(sudo:session): session closed for user root Dec 20 17:40:39 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:40:39 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:40:39 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:40:39 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:40:39 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:40:39 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:40:39 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:40:39 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:40:39 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:40:39 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 20 17:40:39 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Dec 20 17:40:39 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:40:39 minidsp-shd volumio[7657]: info: msSurfaceDial volumioupdatevolume callback: {"vol":62,"dbVolume":-49,"disableVolumeControl":false} Dec 20 17:40:39 minidsp-shd volumio[7657]: info: CoreStateMachine::pushState Dec 20 17:40:39 minidsp-shd volumio[7657]: info: CorePlayQueue::getTrack 0 Dec 20 17:40:39 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 17:40:39 minidsp-shd volumio[7657]: info: CoreCommandRouter::volumioPushState Dec 20 17:40:39 minidsp-shd volumio[7657]: info: CoreCommandRouter::volumioGetState Dec 20 17:40:39 minidsp-shd volumio[7657]: info: CorePlayQueue::getTrack 0 Dec 20 17:40:39 minidsp-shd volumio[7657]: info: MRS: Pushing multiroomSync output update for this device Dec 20 17:40:39 minidsp-shd volumio[7657]: info: MRS: Pushing multiroomSync output Dec 20 17:40:39 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: raat , updateRoonVolume Dec 20 17:40:39 minidsp-shd volumio[7657]: info: Ignoring ROON Volume update because of undefined data Dec 20 17:40:39 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: raat , updateDSP Dec 20 17:40:39 minidsp-shd volumio[7657]: info: updateDSP function in raat called! Dec 20 17:40:39 minidsp-shd volumio[7657]: info: Updating RAAT Signal Path Dec 20 17:40:39 minidsp-shd volumio[7657]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined Dec 20 17:40:39 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: raat , reconfigureAndRestartRaat Dec 20 17:40:39 minidsp-shd volumio[7657]: info: Reconfiguring and Restarting RAAT Plugin Dec 20 17:40:39 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:40:39 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:40:39 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:40:39 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:40:39 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 20 17:40:39 minidsp-shd volumio[7657]: info: Not Reporting Auto name since its the default one Dec 20 17:40:39 minidsp-shd volumio[7657]: info: RAAT Overriding default device vendor model Dec 20 17:40:39 minidsp-shd volumio[7657]: info: Adding MINIDSP Inputs Dec 20 17:40:39 minidsp-shd volumio[7657]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 20 17:40:39 minidsp-shd volumio[7657]: info: [1766248839594] CoreMusicLibrary::Adding element Inputs Dec 20 17:40:39 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 20 17:40:39 minidsp-shd volumio[7657]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 20 17:40:39 minidsp-shd volumio[7657]: info: [1766248839599] CoreMusicLibrary::Adding element Presets Dec 20 17:40:39 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 20 17:40:39 minidsp-shd volumio[7657]: Cannot find translation for source Presets Dec 20 17:40:39 minidsp-shd volumio[7657]: (node:7657) [DEP0005] DeprecationWarning: Buffer() is deprecated due to security and usability issues. Please use the Buffer.alloc(), Buffer.allocUnsafe(), or Buffer.from() methods instead. Dec 20 17:40:39 minidsp-shd volumio[7657]: (Use `node --trace-deprecation ...` to show where the warning was created) Dec 20 17:40:39 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Dec 20 17:40:39 minidsp-shd sudo[7984]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Dec 20 17:40:39 minidsp-shd sudo[7984]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 17:40:39 minidsp-shd sudo[7984]: pam_unix(sudo:session): session closed for user root Dec 20 17:40:39 minidsp-shd sudo[7990]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 20 17:40:39 minidsp-shd sudo[7990]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 17:40:39 minidsp-shd sudo[7990]: pam_unix(sudo:session): session closed for user root Dec 20 17:40:39 minidsp-shd sudo[8001]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 20 17:40:39 minidsp-shd sudo[8001]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 17:40:39 minidsp-shd sudo[8001]: pam_unix(sudo:session): session closed for user root Dec 20 17:40:39 minidsp-shd sudo[8006]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Dec 20 17:40:39 minidsp-shd sudo[8006]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 17:40:39 minidsp-shd sudo[8006]: pam_unix(sudo:session): session closed for user root Dec 20 17:40:39 minidsp-shd sudo[8012]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 20 17:40:39 minidsp-shd sudo[8012]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 17:40:39 minidsp-shd sudo[8012]: pam_unix(sudo:session): session closed for user root Dec 20 17:40:39 minidsp-shd sudo[8015]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 20 17:40:39 minidsp-shd sudo[8015]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 17:40:39 minidsp-shd sudo[8015]: pam_unix(sudo:session): session closed for user root Dec 20 17:40:40 minidsp-shd volumio[7657]: info: CoreCommandRouter::volumioGetState Dec 20 17:40:40 minidsp-shd volumio[7657]: info: CorePlayQueue::getTrack 0 Dec 20 17:40:40 minidsp-shd sudo[8018]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service Dec 20 17:40:40 minidsp-shd sudo[8018]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 17:40:40 minidsp-shd sudo[8018]: pam_unix(sudo:session): session closed for user root Dec 20 17:40:40 minidsp-shd volumio[7657]: info: Volumio BT Module successfully started Dec 20 17:40:40 minidsp-shd volumio[7657]: info: Starting Shairport Sync Dec 20 17:40:40 minidsp-shd volumio[7657]: info: Starting Shairport Sync Dec 20 17:40:40 minidsp-shd sudo[8021]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 20 17:40:40 minidsp-shd sudo[8021]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 17:40:40 minidsp-shd volumio[7657]: info: Starting Shairport Sync Dec 20 17:40:40 minidsp-shd sudo[8024]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 20 17:40:40 minidsp-shd sudo[8024]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 17:40:40 minidsp-shd systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Dec 20 17:40:40 minidsp-shd systemd[1]: shairport-sync.service: Succeeded. Dec 20 17:40:40 minidsp-shd sudo[8027]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 20 17:40:40 minidsp-shd sudo[8027]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 17:40:40 minidsp-shd systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Dec 20 17:40:40 minidsp-shd volumio[7657]: info: CoreCommandRouter::volumiosetSourceActiveno-source Dec 20 17:40:40 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 20 17:40:40 minidsp-shd volumio[7657]: Cannot find translation for source Presets Dec 20 17:40:40 minidsp-shd systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 20 17:40:40 minidsp-shd sudo[8024]: pam_unix(sudo:session): session closed for user root Dec 20 17:40:40 minidsp-shd sudo[8021]: pam_unix(sudo:session): session closed for user root Dec 20 17:40:40 minidsp-shd volumio[7657]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 20 17:40:40 minidsp-shd systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Dec 20 17:40:40 minidsp-shd systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Dec 20 17:40:40 minidsp-shd systemd[1]: shairport-sync.service: Succeeded. Dec 20 17:40:40 minidsp-shd volumio[7657]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 20 17:40:40 minidsp-shd volumio[7657]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 20 17:40:40 minidsp-shd systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Dec 20 17:40:40 minidsp-shd systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 20 17:40:40 minidsp-shd sudo[8027]: pam_unix(sudo:session): session closed for user root Dec 20 17:40:40 minidsp-shd volumio[7657]: info: CoreCommandRouter::volumioGetState Dec 20 17:40:40 minidsp-shd volumio[7657]: info: CorePlayQueue::getTrack 0 Dec 20 17:40:40 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Dec 20 17:40:40 minidsp-shd volumio[7657]: xcb_connection_has_error() returned true Dec 20 17:40:40 minidsp-shd sudo[8036]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Dec 20 17:40:40 minidsp-shd sudo[8036]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 17:40:40 minidsp-shd volumio[7657]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 20 17:40:40 minidsp-shd volumio[7657]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 20 17:40:40 minidsp-shd systemd[1]: Stopping RAAT DAEMON... Dec 20 17:40:40 minidsp-shd systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM Dec 20 17:40:40 minidsp-shd systemd[1]: raat-daemon.service: Succeeded. Dec 20 17:40:40 minidsp-shd systemd[1]: Stopped RAAT DAEMON. Dec 20 17:40:40 minidsp-shd systemd[1]: Started RAAT DAEMON. Dec 20 17:40:40 minidsp-shd sudo[8036]: pam_unix(sudo:session): session closed for user root Dec 20 17:40:40 minidsp-shd volumio[7657]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Dec 20 17:40:41 minidsp-shd volumio[7657]: info: Shairport-Sync Started Dec 20 17:40:41 minidsp-shd volumio[7657]: Error adding Membership: Error: addMembership EINVAL Dec 20 17:40:41 minidsp-shd volumio[7657]: info: Shairport-Sync Started Dec 20 17:40:41 minidsp-shd volumio[7657]: info: Shairport-Sync Started Dec 20 17:40:41 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Dec 20 17:40:41 minidsp-shd volumio[7657]: info: Enabling external Volume Control Dec 20 17:40:41 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:40:41 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:40:41 minidsp-shd volumio[7657]: info: Cannot mount NAS QNAP at system boot, trial number 3 ,retrying in 5 seconds Dec 20 17:40:41 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 20 17:40:41 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 20 17:40:41 minidsp-shd volumio[7657]: info: Discovery: Getting this device information Dec 20 17:40:41 minidsp-shd volumio[7657]: info: CoreCommandRouter::volumioGetState Dec 20 17:40:41 minidsp-shd volumio[7657]: info: CorePlayQueue::getTrack 0 Dec 20 17:40:41 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 20 17:40:41 minidsp-shd volumio[7657]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 20 17:40:41 minidsp-shd volumio[7657]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 20 17:40:41 minidsp-shd volumio[7657]: info: Raat Daemon started successfully Dec 20 17:40:41 minidsp-shd volumio[7657]: info: TidalConnect service stoped! Dec 20 17:40:41 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 20 17:40:41 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 20 17:40:41 minidsp-shd volumio[7657]: info: Discovery: Getting this device information Dec 20 17:40:41 minidsp-shd volumio[7657]: info: CoreCommandRouter::volumioGetState Dec 20 17:40:41 minidsp-shd volumio[7657]: info: CorePlayQueue::getTrack 0 Dec 20 17:40:41 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 20 17:40:41 minidsp-shd volumio[7657]: info: CoreCommandRouter::volumioGetState Dec 20 17:40:41 minidsp-shd volumio[7657]: info: CorePlayQueue::getTrack 0 Dec 20 17:40:41 minidsp-shd volumio[7657]: info: Executing endpoint restartRAATSocket Dec 20 17:40:41 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Dec 20 17:40:41 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 20 17:40:41 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 20 17:40:41 minidsp-shd volumio[7657]: verbose: New Socket.io Connection to 192.168.1.20:3000 from 192.168.1.18 UA: Dart/3.9 (dart:io) Engine version: 3 Transport: websocket Total Clients: 10 Dec 20 17:40:41 minidsp-shd volumio[7657]: info: Adding tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Dec 20 17:40:41 minidsp-shd volumio[7657]: info: Adding tc_connect REST Endpoint for plugin: music_service/tidalconnect Dec 20 17:40:41 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 20 17:40:41 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 20 17:40:41 minidsp-shd volumio[7657]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 11 Dec 20 17:40:41 minidsp-shd sudo[8061]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Dec 20 17:40:41 minidsp-shd sudo[8061]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 17:40:41 minidsp-shd systemd[1]: Started Volumio Tidal Connect Service. Dec 20 17:40:41 minidsp-shd sudo[8061]: pam_unix(sudo:session): session closed for user root Dec 20 17:40:41 minidsp-shd volumio[7657]: info: CoreCommandRouter::volumioGetState Dec 20 17:40:41 minidsp-shd volumio[7657]: info: CorePlayQueue::getTrack 0 Dec 20 17:40:41 minidsp-shd sudo[8069]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 20 17:40:41 minidsp-shd sudo[8069]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 17:40:41 minidsp-shd sudo[8069]: pam_unix(sudo:session): session closed for user root Dec 20 17:40:41 minidsp-shd sudo[8072]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 20 17:40:41 minidsp-shd sudo[8072]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 17:40:41 minidsp-shd sudo[8072]: pam_unix(sudo:session): session closed for user root Dec 20 17:40:42 minidsp-shd volumio[7657]: info: msSurfaceDial volumioupdatevolume callback: {"vol":62,"dbVolume":-49,"mute":false,"disableVolumeControl":false} Dec 20 17:40:42 minidsp-shd volumio[7657]: info: CoreStateMachine::pushState Dec 20 17:40:42 minidsp-shd volumio[7657]: info: CorePlayQueue::getTrack 0 Dec 20 17:40:42 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 17:40:42 minidsp-shd volumio[7657]: info: CoreCommandRouter::volumioPushState Dec 20 17:40:42 minidsp-shd volumio[7657]: info: CoreCommandRouter::volumioGetState Dec 20 17:40:42 minidsp-shd volumio[7657]: info: CorePlayQueue::getTrack 0 Dec 20 17:40:42 minidsp-shd volumio[7657]: info: MRS: Pushing multiroomSync output update for this device Dec 20 17:40:42 minidsp-shd volumio[7657]: info: MRS: Pushing multiroomSync output Dec 20 17:40:42 minidsp-shd volumio[7657]: error: Help! Some callbacks for volumioPushState are crashing! Dec 20 17:40:42 minidsp-shd volumio[7657]: error: Cannot read property 'sendVolumeMute' of undefined Dec 20 17:40:42 minidsp-shd volumio[7657]: verbose: New Socket.io Connection to 192.168.1.20 from 192.168.1.18 UA: Mozilla/5.0 (Linux; Android 15; 23073RPBFG Build/AQ3A.240829.003; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/143.0.7499.115 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 Dec 20 17:40:42 minidsp-shd volumio[7657]: info: Executing endpoint tc_getconfig Dec 20 17:40:42 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Dec 20 17:40:42 minidsp-shd vtcs[8063]: STARTING TidalConnect services, version: 1.5.1-beta1 Dec 20 17:40:42 minidsp-shd vtcs[8063]: STARTED TidalConnect services. Dec 20 17:40:42 minidsp-shd volumio[7657]: info: Executing endpoint tc_connect Dec 20 17:40:42 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Dec 20 17:40:42 minidsp-shd volumio[7657]: info: Connecting to TidalConnect Dec 20 17:40:42 minidsp-shd volumio[7657]: info: CoreCommandRouter::servicePushState Dec 20 17:40:42 minidsp-shd volumio[7657]: info: CoreStateMachine::pushState Dec 20 17:40:42 minidsp-shd volumio[7657]: info: CorePlayQueue::getTrack 0 Dec 20 17:40:42 minidsp-shd volumio[7657]: info: CoreCommandRouter::volumioPushState Dec 20 17:40:42 minidsp-shd volumio[7657]: info: CoreCommandRouter::volumioGetState Dec 20 17:40:42 minidsp-shd volumio[7657]: info: CorePlayQueue::getTrack 0 Dec 20 17:40:42 minidsp-shd volumio[7657]: info: MRS: Pushing multiroomSync output update for this device Dec 20 17:40:42 minidsp-shd volumio[7657]: info: MRS: Pushing multiroomSync output Dec 20 17:40:42 minidsp-shd volumio[7657]: info: CorePlayQueue::getTrack 0 Dec 20 17:40:42 minidsp-shd volumio[7657]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received tidalconnect Dec 20 17:40:42 minidsp-shd volumio[7657]: info: CoreCommandRouter::servicePushState Dec 20 17:40:42 minidsp-shd volumio[7657]: info: CoreStateMachine::pushState Dec 20 17:40:42 minidsp-shd volumio[7657]: info: CorePlayQueue::getTrack 0 Dec 20 17:40:42 minidsp-shd volumio[7657]: info: CoreCommandRouter::volumioPushState Dec 20 17:40:42 minidsp-shd volumio[7657]: info: CoreCommandRouter::volumioGetState Dec 20 17:40:42 minidsp-shd volumio[7657]: info: CorePlayQueue::getTrack 0 Dec 20 17:40:42 minidsp-shd volumio[7657]: info: MRS: Pushing multiroomSync output update for this device Dec 20 17:40:42 minidsp-shd volumio[7657]: info: MRS: Pushing multiroomSync output Dec 20 17:40:42 minidsp-shd volumio[7657]: info: CorePlayQueue::getTrack 0 Dec 20 17:40:42 minidsp-shd volumio[7657]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received tidalconnect Dec 20 17:40:42 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 20 17:40:42 minidsp-shd mpd[7973]: Dec 20 17:40 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 20 17:40:42 minidsp-shd volumio[7657]: info: CoreCommandRouter::volumioGetVisibleSources Dec 20 17:40:42 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 20 17:40:42 minidsp-shd volumio[7657]: info: CoreCommandRouter::volumioGetState Dec 20 17:40:42 minidsp-shd volumio[7657]: info: CorePlayQueue::getTrack 0 Dec 20 17:40:42 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Dec 20 17:40:42 minidsp-shd volumio[7657]: info: CoreCommandRouter::volumioGetQueue Dec 20 17:40:42 minidsp-shd volumio[7657]: info: CoreStateMachine::getQueue Dec 20 17:40:42 minidsp-shd volumio[7657]: info: CorePlayQueue::getQueue Dec 20 17:40:42 minidsp-shd volumio[7657]: info: Listing playlists Dec 20 17:40:42 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 20 17:40:42 minidsp-shd volumio[7657]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Dec 20 17:40:42 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: inputs , handleBrowseUri Dec 20 17:40:42 minidsp-shd volumio[7657]: info: Received Get System Info Dec 20 17:40:42 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 20 17:40:42 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 20 17:40:42 minidsp-shd volumio[7657]: info: Discovery: Getting this device information Dec 20 17:40:42 minidsp-shd volumio[7657]: info: CoreCommandRouter::volumioGetState Dec 20 17:40:42 minidsp-shd volumio[7657]: info: CorePlayQueue::getTrack 0 Dec 20 17:40:42 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 20 17:40:42 minidsp-shd volumio[7657]: info: CoreCommandRouter::volumioGetState Dec 20 17:40:42 minidsp-shd volumio[7657]: info: CorePlayQueue::getTrack 0 Dec 20 17:40:42 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 20 17:40:42 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 20 17:40:42 minidsp-shd volumio[7657]: info: MRS: Getting audio outputs on start Dec 20 17:40:42 minidsp-shd volumio[7657]: info: MRS: Requesting all other devices output Dec 20 17:40:43 minidsp-shd volumio[7657]: info: msSurfaceDial volumioupdatevolume callback: {"vol":62,"dbVolume":-49,"mute":false,"disableVolumeControl":false} Dec 20 17:40:43 minidsp-shd volumio[7657]: info: CoreStateMachine::pushState Dec 20 17:40:43 minidsp-shd volumio[7657]: info: CorePlayQueue::getTrack 0 Dec 20 17:40:43 minidsp-shd volumio[7657]: info: CoreCommandRouter::volumioPushState Dec 20 17:40:43 minidsp-shd volumio[7657]: info: CoreCommandRouter::volumioGetState Dec 20 17:40:43 minidsp-shd volumio[7657]: info: CorePlayQueue::getTrack 0 Dec 20 17:40:43 minidsp-shd volumio[7657]: info: MRS: Pushing multiroomSync output update for this device Dec 20 17:40:43 minidsp-shd volumio[7657]: info: MRS: Pushing multiroomSync output Dec 20 17:40:43 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: raat , updateRoonVolume Dec 20 17:40:43 minidsp-shd sudo[8092]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 20 17:40:43 minidsp-shd sudo[8092]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 17:40:43 minidsp-shd sudo[8092]: pam_unix(sudo:session): session closed for user root Dec 20 17:40:43 minidsp-shd sudo[8095]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 20 17:40:43 minidsp-shd sudo[8095]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 17:40:43 minidsp-shd sudo[8095]: pam_unix(sudo:session): session closed for user root Dec 20 17:40:43 minidsp-shd volumio[7657]: verbose: New Socket.io Connection to 192.168.1.20 from 192.168.1.18 UA: Mozilla/5.0 (Linux; Android 15; 23073RPBFG Build/AQ3A.240829.003; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/143.0.7499.115 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 12 Dec 20 17:40:43 minidsp-shd systemd[1]: Started Music Player Daemon. Dec 20 17:40:43 minidsp-shd sudo[7890]: pam_unix(sudo:session): session closed for user root Dec 20 17:40:43 minidsp-shd sudo[7901]: pam_unix(sudo:session): session closed for user root Dec 20 17:40:43 minidsp-shd volumio[7657]: error: MPD error: The expression evaluated to a falsy value: Dec 20 17:40:43 minidsp-shd volumio[7657]: assert.ok(self.idling) Dec 20 17:40:43 minidsp-shd volumio[7657]: error: The expression evaluated to a falsy value: Dec 20 17:40:43 minidsp-shd volumio[7657]: assert.ok(self.idling) Dec 20 17:40:43 minidsp-shd volumio[7657]: info: MPD running with PID7973 Dec 20 17:40:43 minidsp-shd volumio[7657]: ,establishing connection Dec 20 17:40:43 minidsp-shd volumio[7657]: error: updateQueue error: null Dec 20 17:40:43 minidsp-shd sudo[8117]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 20 17:40:43 minidsp-shd sudo[8117]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 17:40:43 minidsp-shd sudo[8117]: pam_unix(sudo:session): session closed for user root Dec 20 17:40:43 minidsp-shd volumio[7657]: info: Volumio called home Dec 20 17:40:43 minidsp-shd volumio[7657]: error: updateQueue error: null Dec 20 17:40:43 minidsp-shd sudo[8120]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 20 17:40:43 minidsp-shd sudo[8120]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 17:40:43 minidsp-shd sudo[8120]: pam_unix(sudo:session): session closed for user root Dec 20 17:40:43 minidsp-shd volumio[7657]: verbose: New Socket.io Connection to 192.168.1.20 from 192.168.1.18 UA: Mozilla/5.0 (Linux; Android 15; 23073RPBFG Build/AQ3A.240829.003; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/143.0.7499.115 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 13 Dec 20 17:40:44 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 20 17:40:44 minidsp-shd volumio[7657]: info: CoreCommandRouter::volumioGetVisibleSources Dec 20 17:40:44 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 20 17:40:44 minidsp-shd volumio[7657]: info: CoreCommandRouter::volumioGetState Dec 20 17:40:44 minidsp-shd volumio[7657]: info: CorePlayQueue::getTrack 0 Dec 20 17:40:44 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Dec 20 17:40:44 minidsp-shd volumio[7657]: info: CoreCommandRouter::volumioGetQueue Dec 20 17:40:44 minidsp-shd volumio[7657]: info: CoreStateMachine::getQueue Dec 20 17:40:44 minidsp-shd volumio[7657]: info: CorePlayQueue::getQueue Dec 20 17:40:44 minidsp-shd volumio[7657]: info: Listing playlists Dec 20 17:40:44 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 20 17:40:44 minidsp-shd volumio[7657]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Dec 20 17:40:44 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: inputs , handleBrowseUri Dec 20 17:40:44 minidsp-shd volumio[7657]: info: Received Get System Info Dec 20 17:40:44 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 20 17:40:44 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 20 17:40:44 minidsp-shd volumio[7657]: info: Discovery: Getting this device information Dec 20 17:40:44 minidsp-shd volumio[7657]: info: CoreCommandRouter::volumioGetState Dec 20 17:40:44 minidsp-shd volumio[7657]: info: CorePlayQueue::getTrack 0 Dec 20 17:40:44 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 20 17:40:44 minidsp-shd volumio[7657]: info: CoreCommandRouter::volumioGetState Dec 20 17:40:44 minidsp-shd volumio[7657]: info: CorePlayQueue::getTrack 0 Dec 20 17:40:44 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 20 17:40:44 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 20 17:40:44 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 20 17:40:44 minidsp-shd volumio[7657]: info: Received Get System Info Dec 20 17:40:44 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 20 17:40:44 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 20 17:40:44 minidsp-shd volumio[7657]: info: Discovery: Getting this device information Dec 20 17:40:44 minidsp-shd volumio[7657]: info: CoreCommandRouter::volumioGetState Dec 20 17:40:44 minidsp-shd volumio[7657]: info: CorePlayQueue::getTrack 0 Dec 20 17:40:44 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 20 17:40:44 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Dec 20 17:40:44 minidsp-shd volumio[7657]: info: TidalConnect service started! Dec 20 17:40:44 minidsp-shd volumio[7657]: info: Completed starting Core Plugins Dec 20 17:40:44 minidsp-shd volumio[7657]: info: ------------------------------------------- Dec 20 17:40:44 minidsp-shd volumio[7657]: info: ----- MyVolumio plugins startup ---- Dec 20 17:40:44 minidsp-shd volumio[7657]: info: ------------------------------------------- Dec 20 17:40:44 minidsp-shd volumio[7657]: info: [MyVolumio PluginManager] Fetching plans data.... Dec 20 17:40:44 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Dec 20 17:40:45 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 20 17:40:45 minidsp-shd volumio[7657]: info: Received Get System Info Dec 20 17:40:45 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 20 17:40:45 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 20 17:40:45 minidsp-shd volumio[7657]: info: Discovery: Getting this device information Dec 20 17:40:45 minidsp-shd volumio[7657]: info: CoreCommandRouter::volumioGetState Dec 20 17:40:45 minidsp-shd volumio[7657]: info: CorePlayQueue::getTrack 0 Dec 20 17:40:45 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 20 17:40:45 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 20 17:40:45 minidsp-shd volumio[7657]: info: Received Get System Info Dec 20 17:40:45 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 20 17:40:45 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 20 17:40:45 minidsp-shd volumio[7657]: info: Discovery: Getting this device information Dec 20 17:40:45 minidsp-shd volumio[7657]: info: CoreCommandRouter::volumioGetState Dec 20 17:40:45 minidsp-shd volumio[7657]: info: CorePlayQueue::getTrack 0 Dec 20 17:40:45 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 20 17:40:45 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Dec 20 17:40:45 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Dec 20 17:40:45 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Dec 20 17:40:46 minidsp-shd volumio[7657]: info: Cannot mount NAS QNAP at system boot, trial number 4 ,retrying in 5 seconds Dec 20 17:40:46 minidsp-shd sudo[8123]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 20 17:40:46 minidsp-shd sudo[8123]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 17:40:46 minidsp-shd systemd[1]: Stopping MPD Monitor Service... Dec 20 17:40:46 minidsp-shd systemd[1]: mpd_monitor.service: Main process exited, code=killed, status=15/TERM Dec 20 17:40:46 minidsp-shd systemd[1]: mpd_monitor.service: Succeeded. Dec 20 17:40:46 minidsp-shd systemd[1]: Stopped MPD Monitor Service. Dec 20 17:40:46 minidsp-shd sudo[8126]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 20 17:40:46 minidsp-shd sudo[8126]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 17:40:46 minidsp-shd systemd[1]: Started MPD Monitor Service. Dec 20 17:40:46 minidsp-shd volumio[7657]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 20 17:40:46 minidsp-shd sudo[8123]: pam_unix(sudo:session): session closed for user root Dec 20 17:40:46 minidsp-shd volumio[7657]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 20 17:40:46 minidsp-shd mpd_monitor.sh[8128]: MPD Monitor Service: Starting MPD Monitor Service Dec 20 17:40:46 minidsp-shd volumio[7657]: info: Successfully started MPD Monitor Dec 20 17:40:46 minidsp-shd systemd[1]: Stopping MPD Monitor Service... Dec 20 17:40:46 minidsp-shd systemd[1]: mpd_monitor.service: Main process exited, code=killed, status=15/TERM Dec 20 17:40:46 minidsp-shd systemd[1]: mpd_monitor.service: Succeeded. Dec 20 17:40:46 minidsp-shd systemd[1]: Stopped MPD Monitor Service. Dec 20 17:40:46 minidsp-shd systemd[1]: Started MPD Monitor Service. Dec 20 17:40:46 minidsp-shd volumio[7657]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 20 17:40:46 minidsp-shd sudo[8126]: pam_unix(sudo:session): session closed for user root Dec 20 17:40:46 minidsp-shd volumio[7657]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 20 17:40:46 minidsp-shd mpd_monitor.sh[8132]: MPD Monitor Service: Starting MPD Monitor Service Dec 20 17:40:46 minidsp-shd volumio[7657]: info: Successfully started MPD Monitor Dec 20 17:40:46 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 20 17:40:46 minidsp-shd volumio[7657]: info: Received Get System Info Dec 20 17:40:46 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 20 17:40:46 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 20 17:40:46 minidsp-shd volumio[7657]: info: Discovery: Getting this device information Dec 20 17:40:46 minidsp-shd volumio[7657]: info: CoreCommandRouter::volumioGetState Dec 20 17:40:46 minidsp-shd volumio[7657]: info: CorePlayQueue::getTrack 0 Dec 20 17:40:46 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 20 17:40:47 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Dec 20 17:40:47 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:40:47 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:40:47 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:40:47 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:40:47 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 20 17:40:47 minidsp-shd volumio[7657]: info: Not Reporting Auto name since its the default one Dec 20 17:40:47 minidsp-shd volumio[7657]: info: RAAT Overriding default device vendor model Dec 20 17:40:47 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Dec 20 17:40:47 minidsp-shd volumio[7657]: xcb_connection_has_error() returned true Dec 20 17:40:47 minidsp-shd sudo[8144]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Dec 20 17:40:47 minidsp-shd sudo[8144]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 17:40:47 minidsp-shd systemd[1]: Stopping RAAT DAEMON... Dec 20 17:40:47 minidsp-shd systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM Dec 20 17:40:47 minidsp-shd systemd[1]: raat-daemon.service: Succeeded. Dec 20 17:40:47 minidsp-shd systemd[1]: Stopped RAAT DAEMON. Dec 20 17:40:47 minidsp-shd systemd[1]: Started RAAT DAEMON. Dec 20 17:40:47 minidsp-shd volumio[7657]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 20 17:40:47 minidsp-shd sudo[8144]: pam_unix(sudo:session): session closed for user root Dec 20 17:40:47 minidsp-shd volumio[7657]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 20 17:40:47 minidsp-shd volumio[7657]: info: Raat Daemon started successfully Dec 20 17:40:47 minidsp-shd volumio[7657]: info: Executing endpoint restartRAATSocket Dec 20 17:40:47 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Dec 20 17:40:47 minidsp-shd volumio[7657]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 14 Dec 20 17:40:47 minidsp-shd volumio[7657]: info: CoreCommandRouter::volumioGetState Dec 20 17:40:47 minidsp-shd volumio[7657]: info: CorePlayQueue::getTrack 0 Dec 20 17:40:47 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: raat , updateDSP Dec 20 17:40:47 minidsp-shd volumio[7657]: info: updateDSP function in raat called! Dec 20 17:40:47 minidsp-shd volumio[7657]: info: Updating RAAT Signal Path Dec 20 17:40:49 minidsp-shd volumio[7657]: Searching plugin music_service/mpd Dec 20 17:40:49 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: mpd , search Dec 20 17:40:50 minidsp-shd volumio[7657]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Dec 20 17:40:51 minidsp-shd volumio[7657]: info: Cannot mount NAS at system boot, trial number 4 ,stopping Dec 20 17:40:51 minidsp-shd volumio[7657]: Searching plugin music_service/mpd Dec 20 17:40:51 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: mpd , search Dec 20 17:40:52 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Dec 20 17:40:53 minidsp-shd volumio[7657]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Dec 20 17:40:53 minidsp-shd volumio[7657]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Dec 20 17:40:53 minidsp-shd volumio[7657]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Dec 20 17:40:53 minidsp-shd volumio[7657]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Dec 20 17:40:53 minidsp-shd volumio[7657]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Dec 20 17:40:53 minidsp-shd volumio[7657]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Dec 20 17:40:53 minidsp-shd volumio[7657]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Dec 20 17:40:53 minidsp-shd volumio[7657]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Dec 20 17:40:53 minidsp-shd volumio[7657]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Dec 20 17:40:53 minidsp-shd volumio[7657]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Dec 20 17:40:53 minidsp-shd volumio[7657]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Dec 20 17:40:53 minidsp-shd volumio[7657]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Dec 20 17:40:53 minidsp-shd volumio[7657]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Dec 20 17:40:53 minidsp-shd volumio[7657]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Dec 20 17:40:53 minidsp-shd volumio[7657]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Dec 20 17:40:53 minidsp-shd volumio[7657]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Dec 20 17:40:53 minidsp-shd volumio[7657]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Dec 20 17:40:53 minidsp-shd volumio[7657]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Dec 20 17:40:53 minidsp-shd volumio[7657]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Dec 20 17:40:53 minidsp-shd volumio[7657]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Dec 20 17:40:53 minidsp-shd volumio[7657]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Dec 20 17:40:53 minidsp-shd volumio[7657]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Dec 20 17:40:53 minidsp-shd volumio[7657]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Dec 20 17:40:53 minidsp-shd volumio[7657]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Dec 20 17:40:53 minidsp-shd volumio[7657]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Dec 20 17:40:53 minidsp-shd volumio[7657]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Dec 20 17:40:53 minidsp-shd volumio[7657]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Dec 20 17:40:53 minidsp-shd volumio[7657]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Dec 20 17:40:53 minidsp-shd volumio[7657]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Dec 20 17:40:54 minidsp-shd volumio[7657]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Dec 20 17:40:54 minidsp-shd volumio[7657]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Dec 20 17:40:54 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 20 17:40:54 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 20 17:40:55 minidsp-shd volumio[7657]: info: Starting MyVolumio Remote Streaming Endpoints Dec 20 17:40:55 minidsp-shd volumio[7657]: info: MyVolumio login type: Token Dec 20 17:40:55 minidsp-shd volumio[7657]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Dec 20 17:40:55 minidsp-shd volumio[7657]: error: [MyVolumio PluginManager] Could not read package.json file: Error: /myvolumio/plugins/music_service/streaming_services//package.json: ENOENT: no such file or directory, open '/myvolumio/plugins/music_service/streaming_services//package.json' Dec 20 17:40:55 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Dec 20 17:40:56 minidsp-shd volumio[7657]: error: MyVolumio Custom Token format not valid, refreshing it Dec 20 17:41:00 minidsp-shd volumio[7657]: info: MyVolumio login type: Token Dec 20 17:41:02 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 20 17:41:02 minidsp-shd volumio[7657]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Dec 20 17:41:02 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Dec 20 17:41:02 minidsp-shd volumio[7657]: info: Received Get System Version Dec 20 17:41:02 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 20 17:41:02 minidsp-shd volumio[7657]: info: Received Get System Info Dec 20 17:41:02 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 20 17:41:02 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 20 17:41:02 minidsp-shd volumio[7657]: info: Discovery: Getting this device information Dec 20 17:41:02 minidsp-shd volumio[7657]: info: CoreCommandRouter::volumioGetState Dec 20 17:41:02 minidsp-shd volumio[7657]: info: CorePlayQueue::getTrack 0 Dec 20 17:41:02 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 20 17:41:02 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 20 17:41:02 minidsp-shd volumio[7657]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Dec 20 17:41:02 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Dec 20 17:41:02 minidsp-shd volumio[7657]: info: Received Get System Version Dec 20 17:41:02 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 20 17:41:02 minidsp-shd volumio[7657]: info: Received Get System Info Dec 20 17:41:02 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 20 17:41:02 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 20 17:41:02 minidsp-shd volumio[7657]: info: Discovery: Getting this device information Dec 20 17:41:02 minidsp-shd volumio[7657]: info: CoreCommandRouter::volumioGetState Dec 20 17:41:02 minidsp-shd volumio[7657]: info: CorePlayQueue::getTrack 0 Dec 20 17:41:02 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 20 17:41:04 minidsp-shd volumio[7657]: error: MyVolumio Plugin failed to start in a timely fashion Dec 20 17:41:04 minidsp-shd volumio[7657]: [Metrics] CommandRouter: 55s 399.96ms Dec 20 17:41:04 minidsp-shd volumio[7657]: info: CoreCommandRouter::volumiosetStartupVolume Dec 20 17:41:04 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:41:04 minidsp-shd volumio[7657]: info: VolumeController:: Setting startup Volume 30 Dec 20 17:41:04 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: inputs , setVolume Dec 20 17:41:04 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 20 17:41:04 minidsp-shd volumio[7657]: info: CoreCommandRouter::Close All Modals sent Dec 20 17:41:04 minidsp-shd volumio[7657]: info: CoreCommandRouter::Close All Modals sent Dec 20 17:41:04 minidsp-shd volumio[7657]: info: msSurfaceDial volumioupdatevolume callback: {"vol":30,"dbVolume":-89,"mute":false,"disableVolumeControl":false} Dec 20 17:41:04 minidsp-shd volumio[7657]: info: CoreStateMachine::pushState Dec 20 17:41:04 minidsp-shd volumio[7657]: info: CorePlayQueue::getTrack 0 Dec 20 17:41:04 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 17:41:04 minidsp-shd volumio[7657]: info: CoreCommandRouter::volumioPushState Dec 20 17:41:04 minidsp-shd volumio[7657]: info: CoreCommandRouter::volumioGetState Dec 20 17:41:04 minidsp-shd volumio[7657]: info: CorePlayQueue::getTrack 0 Dec 20 17:41:04 minidsp-shd volumio[7657]: info: MRS: Pushing multiroomSync output update for this device Dec 20 17:41:04 minidsp-shd volumio[7657]: info: MRS: Pushing multiroomSync output Dec 20 17:41:06 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Dec 20 17:41:06 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Dec 20 17:41:06 minidsp-shd volumio[7657]: xcb_connection_has_error() returned true Dec 20 17:41:06 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Dec 20 17:41:06 minidsp-shd volumio[7657]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Dec 20 17:41:08 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 20 17:41:08 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 20 17:41:08 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 20 17:41:09 minidsp-shd volumio-remote-updater[1564]: No test mode Dec 20 17:41:09 minidsp-shd volumio-remote-updater[1564]: No alpha test mode Dec 20 17:41:09 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Dec 20 17:41:10 minidsp-shd volumio[7657]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 20 17:41:11 minidsp-shd volumio[7657]: <--- Last few GCs ---> Dec 20 17:41:11 minidsp-shd volumio[7657]: [7657:0x3b46008] 65321 ms: Scavenge 195.7 (208.5) -> 195.6 (208.5) MB, 2.3 / 0.0 ms (average mu = 0.914, current mu = 0.952) allocation failure Dec 20 17:41:11 minidsp-shd volumio[7657]: [7657:0x3b46008] 65465 ms: Scavenge 215.7 (228.5) -> 215.7 (228.5) MB, 1.1 / 0.0 ms (average mu = 0.914, current mu = 0.952) allocation failure Dec 20 17:41:11 minidsp-shd volumio[7657]: <--- JS stacktrace ---> Dec 20 17:41:11 minidsp-shd volumio[7657]: FATAL ERROR: MarkCompactCollector: young object promotion failed Allocation failed - JavaScript heap out of memory Dec 20 17:41:11 minidsp-shd vtcs[8063]: [2025-12-20 17:41:11.557] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected Dec 20 17:41:11 minidsp-shd systemd[1]: volumio.service: Main process exited, code=killed, status=6/ABRT Dec 20 17:41:11 minidsp-shd qobuz-connect[7958]: 20251220 17:41:11.563 [7958.7958] INFO SampleApp: Socket closed Dec 20 17:41:11 minidsp-shd systemd[1]: volumio.service: Failed with result 'signal'. Dec 20 17:41:11 minidsp-shd systemd[1]: Started dynamicswap service. Dec 20 17:41:11 minidsp-shd systemd[1]: dynamicswap.service: Succeeded. Dec 20 17:41:11 minidsp-shd systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Dec 20 17:41:11 minidsp-shd systemd[1]: volumio.service: Scheduled restart job, restart counter is at 3. Dec 20 17:41:11 minidsp-shd systemd[1]: Stopped Volumio Backend Module. Dec 20 17:41:11 minidsp-shd systemd[1]: Started Volumio Backend Module. Dec 20 17:41:11 minidsp-shd systemd[1]: Started dynamicswap service. Dec 20 17:41:11 minidsp-shd systemd[1]: dynamicswap.service: Succeeded. Dec 20 17:41:14 minidsp-shd volumio[8203]: info: ------------------------------------------- Dec 20 17:41:14 minidsp-shd volumio[8203]: info: ----- Volumio3 ---- Dec 20 17:41:14 minidsp-shd volumio[8203]: info: ------------------------------------------- Dec 20 17:41:14 minidsp-shd volumio[8203]: info: ----- System startup ---- Dec 20 17:41:14 minidsp-shd volumio[8203]: info: ------------------------------------------- Dec 20 17:41:14 minidsp-shd volumio-remote-updater[1564]: [2025-12-20 17:41:14] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Dec 20 17:41:14 minidsp-shd volumio-remote-updater[1564]: [2025-12-20 17:41:14] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Dec 20 17:41:16 minidsp-shd volumio[8203]: info: MYVOLUMIO Environment detected Dec 20 17:41:16 minidsp-shd volumio[8203]: info: Plugin folders cleanup Dec 20 17:41:16 minidsp-shd volumio[8203]: info: Scanning into folder /volumio/app/plugins/ Dec 20 17:41:16 minidsp-shd volumio[8203]: info: Scanning category audio_interface Dec 20 17:41:16 minidsp-shd volumio[8203]: info: Scanning category miscellanea Dec 20 17:41:16 minidsp-shd volumio[8203]: info: Scanning category music_service Dec 20 17:41:16 minidsp-shd volumio[8203]: info: Scanning category plugins.json Dec 20 17:41:16 minidsp-shd volumio[8203]: info: Scanning category system_controller Dec 20 17:41:16 minidsp-shd volumio[8203]: info: Scanning category user_interface Dec 20 17:41:16 minidsp-shd volumio[8203]: info: Scanning into folder /data/plugins/ Dec 20 17:41:16 minidsp-shd volumio[8203]: info: Plugin folders cleanup completed Dec 20 17:41:16 minidsp-shd volumio[8203]: info: ------------------------------------------- Dec 20 17:41:16 minidsp-shd volumio[8203]: info: ----- Core plugins startup ---- Dec 20 17:41:16 minidsp-shd volumio[8203]: info: ------------------------------------------- Dec 20 17:41:16 minidsp-shd volumio[8203]: info: Loading plugins from folder /volumio/app/plugins/ Dec 20 17:41:16 minidsp-shd volumio[8203]: info: Adding plugin bluetooth to MyMusic Plugins Dec 20 17:41:16 minidsp-shd volumio[8203]: info: Adding plugin multiroom to MyMusic Plugins Dec 20 17:41:16 minidsp-shd volumio[8203]: info: Adding plugin upnp to MyMusic Plugins Dec 20 17:41:16 minidsp-shd volumio[8203]: info: Adding plugin metavolumio to MyMusic Plugins Dec 20 17:41:16 minidsp-shd volumio[8203]: info: Adding plugin ms_surface_dial to MyMusic Plugins Dec 20 17:41:16 minidsp-shd volumio[8203]: info: Adding plugin airplay_emulation to MyMusic Plugins Dec 20 17:41:16 minidsp-shd volumio[8203]: info: Adding plugin cd_controller to MyMusic Plugins Dec 20 17:41:16 minidsp-shd volumio[8203]: info: Adding plugin qobuzconnect to MyMusic Plugins Dec 20 17:41:16 minidsp-shd volumio[8203]: info: Adding plugin raat to MyMusic Plugins Dec 20 17:41:16 minidsp-shd volumio[8203]: info: Adding plugin tidalconnect to MyMusic Plugins Dec 20 17:41:16 minidsp-shd volumio[8203]: info: Adding plugin upnp_browser to MyMusic Plugins Dec 20 17:41:16 minidsp-shd volumio[8203]: info: Loading plugins from folder /data/plugins/ Dec 20 17:41:16 minidsp-shd volumio[8203]: info: Loading plugin "system"... Dec 20 17:41:16 minidsp-shd volumio[8203]: info: Loading plugin "appearance"... Dec 20 17:41:17 minidsp-shd volumio[8203]: info: Loading plugin "network"... Dec 20 17:41:17 minidsp-shd volumio[8203]: info: Refreshing Cached IP Addresses Dec 20 17:41:17 minidsp-shd volumio[8203]: info: Loading plugin "services"... Dec 20 17:41:18 minidsp-shd volumio[8203]: info: Loading plugin "alsa_controller"... Dec 20 17:41:18 minidsp-shd sudo[8231]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 20 17:41:18 minidsp-shd sudo[8233]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 20 17:41:18 minidsp-shd sudo[8233]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 17:41:18 minidsp-shd sudo[8231]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 17:41:18 minidsp-shd sudo[8233]: pam_unix(sudo:session): session closed for user root Dec 20 17:41:18 minidsp-shd sudo[8231]: pam_unix(sudo:session): session closed for user root Dec 20 17:41:18 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 20 17:41:18 minidsp-shd volumio[8203]: info: Loading plugin "wizard"... Dec 20 17:41:18 minidsp-shd volumio[8203]: info: Loading plugin "networkfs"... Dec 20 17:41:18 minidsp-shd volumio[8203]: info: Cannot mount NAS QNAP at system boot, trial number 1 ,retrying in 5 seconds Dec 20 17:41:18 minidsp-shd volumio[8203]: info: Starting Udev Watcher for removable devices Dec 20 17:41:18 minidsp-shd volumio[8203]: info: Ignoring mount for partition: BOOT Dec 20 17:41:18 minidsp-shd volumio[8203]: info: Ignoring mount for partition: volumio Dec 20 17:41:18 minidsp-shd volumio[8203]: info: Ignoring mount for partition: volumio_data Dec 20 17:41:18 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 20 17:41:18 minidsp-shd volumio[8203]: info: Loading plugin "volumio_command_line_client"... Dec 20 17:41:18 minidsp-shd volumio[8203]: info: Loading plugin "upnp"... Dec 20 17:41:18 minidsp-shd volumio[8203]: info: [1766248878274] Starting Upmpd Daemon Dec 20 17:41:18 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 20 17:41:18 minidsp-shd volumio[8203]: info: Loading plugin "my_music"... Dec 20 17:41:18 minidsp-shd volumio[8203]: info: Loading plugin "mpd"... Dec 20 17:41:18 minidsp-shd volumio[8203]: info: Loading plugin "upnp_browser"... Dec 20 17:41:19 minidsp-shd volumio[8203]: info: Loading plugin "bluetooth"... Dec 20 17:41:19 minidsp-shd volumio[8203]: info: [1766248879749] Starting BluetoothController Dec 20 17:41:19 minidsp-shd volumio-remote-updater[1564]: [2025-12-20 17:41:19] [connect] Successful connection Dec 20 17:41:19 minidsp-shd volumio[8203]: info: Loading plugin "alarm-clock"... Dec 20 17:41:20 minidsp-shd volumio[8203]: info: Loading plugin "manifestui"... Dec 20 17:41:20 minidsp-shd volumio[8203]: info: Loading plugin "metavolumio"... Dec 20 17:41:22 minidsp-shd volumio[8203]: info: Loading plugin "airplay_emulation"... Dec 20 17:41:22 minidsp-shd volumio[8203]: info: Starting Shairport Sync Dec 20 17:41:22 minidsp-shd volumio[8203]: info: Loading plugin "cd_controller"... Dec 20 17:41:23 minidsp-shd volumio[8203]: info: Loading plugin "last_100"... Dec 20 17:41:23 minidsp-shd volumio[8203]: info: Loading plugin "qobuzconnect"... Dec 20 17:41:23 minidsp-shd volumio[8203]: info: Loading plugin "raat"... Dec 20 17:41:23 minidsp-shd volumio[8203]: info: RAAT Plugin loaded Dec 20 17:41:23 minidsp-shd volumio[8203]: info: Adding restartRAATSocket REST API Endpoint Dec 20 17:41:23 minidsp-shd volumio[8203]: info: Adding restartRAATSocket REST Endpoint for plugin: music_service/raat Dec 20 17:41:23 minidsp-shd volumio[8203]: info: Loading plugin "streaming_services"... Dec 20 17:41:25 minidsp-shd volumio[8203]: info: Starting Streaming Service Transparent Proxy Dec 20 17:41:25 minidsp-shd volumio[8203]: info: Loading plugin "tidalconnect"... Dec 20 17:41:25 minidsp-shd volumio[8203]: info: Loading plugin "webradio"... Dec 20 17:41:25 minidsp-shd volumio[8203]: info: Loading plugin "i2s_dacs"... Dec 20 17:41:25 minidsp-shd volumio[8203]: info: I2S DAC not set, start Auto-detection Dec 20 17:41:25 minidsp-shd volumio[8203]: info: Loading plugin "volumiodiscovery"... Dec 20 17:41:26 minidsp-shd volumio[8203]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 20 17:41:26 minidsp-shd volumio[8203]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 20 17:41:26 minidsp-shd volumio[8203]: *** WARNING *** For more information see Dec 20 17:41:26 minidsp-shd volumio[8203]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 20 17:41:26 minidsp-shd volumio[8203]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 20 17:41:26 minidsp-shd volumio[8203]: *** WARNING *** For more information see Dec 20 17:41:26 minidsp-shd node[8203]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 20 17:41:26 minidsp-shd node[8203]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 20 17:41:26 minidsp-shd node[8203]: *** WARNING *** For more information see Dec 20 17:41:26 minidsp-shd node[8203]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 20 17:41:26 minidsp-shd node[8203]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 20 17:41:26 minidsp-shd node[8203]: *** WARNING *** For more information see Dec 20 17:41:26 minidsp-shd volumio[8203]: info: Applying required configuration parameters for plugin volumiodiscovery Dec 20 17:41:26 minidsp-shd volumio[8203]: info: Discovery: Started advertising with name: miniDSP SHD Dec 20 17:41:26 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 20 17:41:26 minidsp-shd volumio[8203]: info: Loading plugin "multiroom"... Dec 20 17:41:27 minidsp-shd volumio[8203]: STREAMING PROXY: Starting server on port 3245 Dec 20 17:41:27 minidsp-shd volumio[8203]: Node JS runtime: 14 Dec 20 17:41:28 minidsp-shd volumio[8203]: info: Applying required configuration parameters for plugin multiroom Dec 20 17:41:28 minidsp-shd sudo[8284]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Dec 20 17:41:28 minidsp-shd sudo[8284]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 17:41:28 minidsp-shd sudo[8284]: pam_unix(sudo:session): session closed for user root Dec 20 17:41:28 minidsp-shd volumio[8203]: /bin/mkdir: cannot create directory ‘/tmp/hls’: File exists Dec 20 17:41:28 minidsp-shd volumio[8203]: info: MRS: MultiRoom plugin initialized Dec 20 17:41:28 minidsp-shd volumio[8203]: info: MRS: STOPPING SNAPCLIENT Dec 20 17:41:28 minidsp-shd volumio[8203]: info: MRS: Snap server stop Dec 20 17:41:28 minidsp-shd sudo[8300]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Dec 20 17:41:28 minidsp-shd sudo[8300]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 17:41:28 minidsp-shd volumio[8203]: info: MRS: STOPPING volumioStreaming Dec 20 17:41:28 minidsp-shd sudo[8303]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver Dec 20 17:41:28 minidsp-shd sudo[8303]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 17:41:28 minidsp-shd sudo[8300]: pam_unix(sudo:session): session closed for user root Dec 20 17:41:28 minidsp-shd sudo[8306]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Dec 20 17:41:28 minidsp-shd sudo[8306]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 17:41:28 minidsp-shd volumio[8203]: info: Loading plugin "outputs"... Dec 20 17:41:28 minidsp-shd volumio[8203]: info: Loading plugin "albumart"... Dec 20 17:41:28 minidsp-shd sudo[8309]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Dec 20 17:41:28 minidsp-shd sudo[8309]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 17:41:28 minidsp-shd sudo[8309]: pam_unix(sudo:session): session closed for user root Dec 20 17:41:28 minidsp-shd sudo[8303]: pam_unix(sudo:session): session closed for user root Dec 20 17:41:28 minidsp-shd volumio[8203]: info: Loading plugin "ms_surface_dial"... Dec 20 17:41:28 minidsp-shd sudo[8306]: pam_unix(sudo:session): session closed for user root Dec 20 17:41:29 minidsp-shd volumio[8203]: Forking 3 albumart workers Dec 20 17:41:29 minidsp-shd volumio[8203]: info: Applying required configuration parameters for plugin ms_surface_dial Dec 20 17:41:29 minidsp-shd volumio[8203]: info: Plugin example_plugin is not enabled Dec 20 17:41:29 minidsp-shd volumio[8203]: info: Loading plugin "hi_res_audio"... Dec 20 17:41:30 minidsp-shd volumio[8203]: Starting albumart workers Dec 20 17:41:30 minidsp-shd volumio[8203]: Starting albumart workers Dec 20 17:41:31 minidsp-shd volumio[8203]: Starting albumart workers Dec 20 17:41:32 minidsp-shd volumio[8203]: info: Applying required configuration parameters for plugin hi_res_audio Dec 20 17:41:32 minidsp-shd volumio[8203]: info: Loading plugin "inputs"... Dec 20 17:41:32 minidsp-shd volumio-remote-updater[1564]: [2025-12-20 17:41:32] [connect] Successful connection Dec 20 17:41:32 minidsp-shd volumio[8203]: info: Loading plugin "qobuz"... Dec 20 17:41:34 minidsp-shd volumio[8203]: info: Loading plugin "tidal"... Dec 20 17:41:36 minidsp-shd volumio[8203]: info: Loading plugin "oem_helper"... Dec 20 17:41:37 minidsp-shd volumio[8203]: info: Applying required configuration parameters for plugin oem_helper Dec 20 17:41:37 minidsp-shd volumio[8203]: info: Loading plugin "updater_comm"... Dec 20 17:41:38 minidsp-shd volumio[8203]: info: Plugin mpdemulation is not enabled Dec 20 17:41:38 minidsp-shd volumio[8203]: info: Loading plugin "rest_api"... Dec 20 17:41:38 minidsp-shd volumio[8203]: info: Loading plugin "websocket"... Dec 20 17:41:38 minidsp-shd volumio[8203]: info: Starting Socket.io Server version 2.3.0 Dec 20 17:41:38 minidsp-shd volumio[8203]: info: Loading i18n strings for locale it Dec 20 17:41:38 minidsp-shd volumio[8203]: Updating browse sources language Dec 20 17:41:38 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 20 17:41:38 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 20 17:41:38 minidsp-shd volumio[8203]: info: CoreCommandRouter::initPlayerControls Dec 20 17:41:38 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:41:38 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:41:38 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:41:38 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:41:38 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:41:38 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:41:38 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:41:38 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:41:38 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 20 17:41:38 minidsp-shd volumio[8203]: Express server listening on port 3000 Dec 20 17:41:38 minidsp-shd volumio[8203]: [Metrics] WebUI: 24s 709.56ms Dec 20 17:41:38 minidsp-shd volumio[8203]: info: CoreStateMachine::resetVolumioState Dec 20 17:41:38 minidsp-shd volumio[8203]: info: CoreStateMachine::getcurrentVolume Dec 20 17:41:38 minidsp-shd volumio[8203]: info: CoreCommandRouter::volumioRetrievevolume Dec 20 17:41:38 minidsp-shd volumio[8203]: info: CoreStateMachine::pushState Dec 20 17:41:38 minidsp-shd volumio[8203]: info: CorePlayQueue::getTrack 0 Dec 20 17:41:38 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 17:41:38 minidsp-shd volumio[8203]: info: CoreCommandRouter::volumioPushState Dec 20 17:41:38 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 20 17:41:38 minidsp-shd volumio[8203]: info: Cannot mount NAS QNAP at system boot, trial number 2 ,retrying in 5 seconds Dec 20 17:41:38 minidsp-shd sudo[8421]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 20 17:41:38 minidsp-shd sudo[8421]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 17:41:38 minidsp-shd sudo[8421]: pam_unix(sudo:session): session closed for user root Dec 20 17:41:38 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: inputs , getVolume Dec 20 17:41:38 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: inputs , getDSP Dec 20 17:41:38 minidsp-shd sudo[8424]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 20 17:41:38 minidsp-shd sudo[8424]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 17:41:38 minidsp-shd volumio[8203]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Dec 20 17:41:38 minidsp-shd sudo[8424]: pam_unix(sudo:session): session closed for user root Dec 20 17:41:38 minidsp-shd volumio[8203]: info: Completed loading Core Plugins Dec 20 17:41:38 minidsp-shd volumio[8203]: info: Preparing to generate the ALSA configuration file Dec 20 17:41:38 minidsp-shd volumio[8203]: info: Volumio Network Manager: Network status updated: 1 Dec 20 17:41:38 minidsp-shd volumio[8203]: info: MRS: Removed streaming files Dec 20 17:41:38 minidsp-shd volumio[8203]: info: MRS: volumioStreaming STOPPED Dec 20 17:41:38 minidsp-shd volumio[8203]: info: MRS: SNAPSERVER STOPPED Dec 20 17:41:38 minidsp-shd volumio[8203]: info: MRS: SNAPCLIENT STOPPED Dec 20 17:41:38 minidsp-shd volumio[8203]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Dec 20 17:41:38 minidsp-shd volumio[8203]: info: Reading ALSA contributions from plugins. Dec 20 17:41:38 minidsp-shd volumio[8203]: verbose: New Socket.io Connection to 192.168.1.20:3000 from 192.168.1.18 UA: Dart/3.9 (dart:io) Engine version: 3 Transport: websocket Total Clients: 1 Dec 20 17:41:38 minidsp-shd volumio[8203]: verbose: New Socket.io Connection to 192.168.1.20 from 192.168.1.18 UA: Mozilla/5.0 (Linux; Android 15; 23073RPBFG Build/AQ3A.240829.003; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/143.0.7499.115 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Dec 20 17:41:38 minidsp-shd volumio[8203]: verbose: New Socket.io Connection to 192.168.1.20 from 192.168.1.18 UA: Mozilla/5.0 (Linux; Android 15; 23073RPBFG Build/AQ3A.240829.003; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/143.0.7499.115 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Dec 20 17:41:38 minidsp-shd volumio[8203]: verbose: New Socket.io Connection to 192.168.1.20 from 192.168.1.18 UA: Mozilla/5.0 (Linux; Android 15; 23073RPBFG Build/AQ3A.240829.003; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/143.0.7499.115 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Dec 20 17:41:38 minidsp-shd volumio[8203]: verbose: New Socket.io Connection to 192.168.1.20 from 192.168.1.18 UA: Mozilla/5.0 (Linux; Android 15; 23073RPBFG Build/AQ3A.240829.003; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/143.0.7499.115 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Dec 20 17:41:39 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 20 17:41:39 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 20 17:41:39 minidsp-shd volumio[8203]: info: Discovery: Getting this device information Dec 20 17:41:39 minidsp-shd volumio[8203]: info: CoreCommandRouter::volumioGetState Dec 20 17:41:39 minidsp-shd volumio[8203]: info: CorePlayQueue::getTrack 0 Dec 20 17:41:39 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 20 17:41:39 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 20 17:41:39 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 20 17:41:39 minidsp-shd volumio[8203]: info: Discovery: Getting this device information Dec 20 17:41:39 minidsp-shd volumio[8203]: info: CoreCommandRouter::volumioGetState Dec 20 17:41:39 minidsp-shd volumio[8203]: info: CorePlayQueue::getTrack 0 Dec 20 17:41:39 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 20 17:41:39 minidsp-shd volumio[8203]: info: Reloading queue from file Dec 20 17:41:39 minidsp-shd volumio[8203]: info: CoreStateMachine::setRepeat false single undefined Dec 20 17:41:39 minidsp-shd volumio[8203]: info: CoreStateMachine::pushState Dec 20 17:41:39 minidsp-shd volumio[8203]: info: CorePlayQueue::getTrack 0 Dec 20 17:41:39 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 17:41:39 minidsp-shd volumio[8203]: info: CoreCommandRouter::volumioPushState Dec 20 17:41:39 minidsp-shd volumio[8203]: info: CoreStateMachine::setRandom false Dec 20 17:41:39 minidsp-shd volumio[8203]: info: CoreStateMachine::pushState Dec 20 17:41:39 minidsp-shd volumio[8203]: info: CorePlayQueue::getTrack 0 Dec 20 17:41:39 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 17:41:39 minidsp-shd volumio[8203]: info: CoreCommandRouter::volumioPushState Dec 20 17:41:39 minidsp-shd volumio[8203]: info: Setting Device type: NanoPi NEO 2 Dec 20 17:41:39 minidsp-shd volumio[8203]: info: Asound.conf file unchanged, so no further update is needed Dec 20 17:41:39 minidsp-shd volumio[8203]: info: Output device has changed, restarting MPD Dec 20 17:41:39 minidsp-shd sudo[8433]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Dec 20 17:41:39 minidsp-shd sudo[8433]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 17:41:39 minidsp-shd sudo[8433]: pam_unix(sudo:session): session closed for user root Dec 20 17:41:39 minidsp-shd sudo[8436]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 20 17:41:39 minidsp-shd sudo[8436]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 17:41:39 minidsp-shd sudo[8436]: pam_unix(sudo:session): session closed for user root Dec 20 17:41:39 minidsp-shd volumio[8203]: info: Output device has changed, restarting Shairport Sync Dec 20 17:41:39 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:41:39 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 20 17:41:39 minidsp-shd sudo[8439]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 20 17:41:39 minidsp-shd sudo[8439]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 17:41:39 minidsp-shd systemd[1]: Stopping Music Player Daemon... Dec 20 17:41:39 minidsp-shd volumio[8203]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 20 17:41:39 minidsp-shd volumio[8203]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 20 17:41:39 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:41:39 minidsp-shd volumio[8203]: info: ___________ START PLUGINS ___________ Dec 20 17:41:39 minidsp-shd volumio[8203]: info: ControllerMpd::onStart: Initializing MPD Dec 20 17:41:39 minidsp-shd volumio[8203]: info: Creating MPD Configuration file Dec 20 17:41:39 minidsp-shd sudo[8447]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 20 17:41:39 minidsp-shd sudo[8447]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 17:41:39 minidsp-shd sudo[8447]: pam_unix(sudo:session): session closed for user root Dec 20 17:41:39 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 20 17:41:39 minidsp-shd volumio[8203]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 20 17:41:39 minidsp-shd volumio[8203]: info: [1766248899647] CoreMusicLibrary::Adding element Server multimediali Dec 20 17:41:39 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 20 17:41:39 minidsp-shd systemd[1]: mpd.service: Succeeded. Dec 20 17:41:39 minidsp-shd systemd[1]: Stopped Music Player Daemon. Dec 20 17:41:39 minidsp-shd systemd[1]: Starting Music Player Daemon... Dec 20 17:41:39 minidsp-shd sudo[8450]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 20 17:41:39 minidsp-shd sudo[8450]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 17:41:39 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 20 17:41:39 minidsp-shd systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Dec 20 17:41:39 minidsp-shd systemd[1]: mpd.service: Succeeded. Dec 20 17:41:39 minidsp-shd systemd[1]: Stopped Music Player Daemon. Dec 20 17:41:39 minidsp-shd systemd[1]: Starting Music Player Daemon... Dec 20 17:41:39 minidsp-shd volumio[8203]: info: Adding METAVOLUMIO REST API Endpoints Dec 20 17:41:39 minidsp-shd volumio[8203]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Dec 20 17:41:39 minidsp-shd volumio[8203]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Dec 20 17:41:39 minidsp-shd volumio[8203]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Dec 20 17:41:39 minidsp-shd volumio[8203]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Dec 20 17:41:39 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:41:39 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 20 17:41:39 minidsp-shd sudo[8454]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name miniDSP SHD Dec 20 17:41:39 minidsp-shd sudo[8454]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 17:41:39 minidsp-shd sudo[8454]: pam_unix(sudo:session): session closed for user root Dec 20 17:41:39 minidsp-shd volumio[8203]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 20 17:41:39 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:41:39 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 20 17:41:39 minidsp-shd sudo[8455]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 20 17:41:39 minidsp-shd sudo[8455]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 17:41:39 minidsp-shd sudo[8455]: pam_unix(sudo:session): session closed for user root Dec 20 17:41:39 minidsp-shd volumio[8203]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 20 17:41:39 minidsp-shd volumio[8203]: info: Preparing CD Folders Dec 20 17:41:39 minidsp-shd volumio[8203]: info: Adding CD REST API Endpoints Dec 20 17:41:39 minidsp-shd volumio[8203]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Dec 20 17:41:39 minidsp-shd volumio[8203]: info: Starting UDEV Watcher for CD Dec 20 17:41:39 minidsp-shd volumio[8203]: info: Detecting CD presence with UDEV Dec 20 17:41:39 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices Dec 20 17:41:39 minidsp-shd volumio[8203]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 20 17:41:39 minidsp-shd volumio[8203]: info: [1766248899956] CoreMusicLibrary::Adding element Last_100 Dec 20 17:41:39 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 20 17:41:39 minidsp-shd volumio[8203]: info: Adding qc_getconfig REST Endpoint for plugin: music_service/qobuzconnect Dec 20 17:41:40 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 20 17:41:40 minidsp-shd volumio[8203]: info: QobuzConnect: Starting Qobuz Connect socket and service Dec 20 17:41:40 minidsp-shd volumio[8203]: info: Starting RAAT Plugin Dec 20 17:41:40 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , addAdditionalUISections Dec 20 17:41:40 minidsp-shd volumio[8203]: info: Additional UI Settings Added for plugin music_service/raat Dec 20 17:41:40 minidsp-shd volumio[8203]: info: Streaming services startup Dec 20 17:41:40 minidsp-shd volumio[8203]: info: Starting Streaming Daemon Dec 20 17:41:40 minidsp-shd sudo[8470]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 20 17:41:40 minidsp-shd sudo[8470]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 17:41:40 minidsp-shd sudo[8470]: pam_unix(sudo:session): session closed for user root Dec 20 17:41:40 minidsp-shd sudo[8473]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 20 17:41:40 minidsp-shd sudo[8473]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 17:41:40 minidsp-shd sudo[8474]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Dec 20 17:41:40 minidsp-shd sudo[8474]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 17:41:40 minidsp-shd sudo[8474]: pam_unix(sudo:session): session closed for user root Dec 20 17:41:40 minidsp-shd systemd[1]: Stopping Volumio Qobuz Connect Service... Dec 20 17:41:40 minidsp-shd qobuz-connect[7958]: 20251220 17:41:40.179 [7958.7958] INFO SampleApp: Stopping Local configuration server Dec 20 17:41:40 minidsp-shd systemd[1]: qobuz-connect.service: Succeeded. Dec 20 17:41:40 minidsp-shd systemd[1]: Stopped Volumio Qobuz Connect Service. Dec 20 17:41:40 minidsp-shd systemd[1]: Started Volumio Qobuz Connect Service. Dec 20 17:41:40 minidsp-shd sudo[8473]: pam_unix(sudo:session): session closed for user root Dec 20 17:41:40 minidsp-shd volumio[8203]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 20 17:41:40 minidsp-shd volumio[8203]: info: [1766248900298] CoreMusicLibrary::Adding element Webradio Dec 20 17:41:40 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 20 17:41:40 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 20 17:41:40 minidsp-shd volumio[8203]: info: Initializing BBC Radios Dec 20 17:41:40 minidsp-shd sudo[8486]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 20 17:41:40 minidsp-shd sudo[8486]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 17:41:40 minidsp-shd systemd[1]: Stopping Volumio Tidal Connect Service... Dec 20 17:41:40 minidsp-shd systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Dec 20 17:41:40 minidsp-shd systemd[1]: vtcs.service: Succeeded. Dec 20 17:41:40 minidsp-shd systemd[1]: Stopped Volumio Tidal Connect Service. Dec 20 17:41:40 minidsp-shd sudo[8486]: pam_unix(sudo:session): session closed for user root Dec 20 17:41:40 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 20 17:41:40 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 20 17:41:40 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus Dec 20 17:41:40 minidsp-shd volumio[8203]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 20 17:41:40 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:41:40 minidsp-shd volumio[8203]: error: Hi Res Audio Failed Login: Missing Login Data Dec 20 17:41:40 minidsp-shd volumio[8203]: info: Adding HIGHRESAUDIO REST API Endpoints Dec 20 17:41:40 minidsp-shd volumio[8203]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Dec 20 17:41:40 minidsp-shd volumio[8203]: info: Adding saveAccountData_hi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Dec 20 17:41:40 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 20 17:41:40 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 20 17:41:40 minidsp-shd volumio[8203]: info: Volumio Calling Home Dec 20 17:41:40 minidsp-shd volumio[8203]: info: QobuzConnect: Opened /tmp/qbz-connect.socket socket, listening for connections Dec 20 17:41:40 minidsp-shd volumio[8203]: info: Stopping AccessToken refresher cron for QOBUZ Dec 20 17:41:40 minidsp-shd volumio[8203]: info: AccessToken refresher cron started for QOBUZ Dec 20 17:41:40 minidsp-shd volumio[8203]: info: Adding TIDAL REST API Endpoints Dec 20 17:41:40 minidsp-shd volumio[8203]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal Dec 20 17:41:40 minidsp-shd volumio[8203]: info: Adding QOBUZ REST API Endpoints Dec 20 17:41:40 minidsp-shd volumio[8203]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz Dec 20 17:41:41 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 20 17:41:41 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 20 17:41:41 minidsp-shd volumio[8203]: info: Discovery: Getting this device information Dec 20 17:41:41 minidsp-shd volumio[8203]: info: CoreCommandRouter::volumioGetState Dec 20 17:41:41 minidsp-shd volumio[8203]: info: CorePlayQueue::getTrack 0 Dec 20 17:41:41 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 20 17:41:41 minidsp-shd volumio[8203]: info: Discovery: adding be0871ae-e095-4897-9223-ba341f4c9119 Dec 20 17:41:41 minidsp-shd volumio[8203]: info: Discovery: Found device miniDSP SHD Dec 20 17:41:41 minidsp-shd volumio[8203]: info: CoreCommandRouter::volumioGetState Dec 20 17:41:41 minidsp-shd volumio[8203]: info: CorePlayQueue::getTrack 0 Dec 20 17:41:41 minidsp-shd volumio[8203]: info: MRS: Pushing multiroomSync output for this device Dec 20 17:41:41 minidsp-shd volumio[8203]: info: MRS: Pushing multiroomSync output Dec 20 17:41:41 minidsp-shd volumio[8203]: info: Adding audio output: Dec 20 17:41:41 minidsp-shd volumio[8203]: info: Adding audio output: Dec 20 17:41:41 minidsp-shd volumio[8203]: info: Serial port opened successfully Dec 20 17:41:41 minidsp-shd volumio[8203]: error: Cannot start Volumio Streaming Daemon Dec 20 17:41:41 minidsp-shd volumio[8203]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Dec 20 17:41:41 minidsp-shd volumio[8203]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Dec 20 17:41:41 minidsp-shd volumio[8203]: error: Cannot set new Bluetooth Name : Error: Command failed: /usr/bin/sudo /bin/hciconfig hci0 name 'miniDSP SHD' Dec 20 17:41:41 minidsp-shd volumio[8203]: Can't get device info: No such device Dec 20 17:41:41 minidsp-shd volumio[8203]: info: MPD Permissions set Dec 20 17:41:41 minidsp-shd volumio[8203]: info: MPD Permissions set Dec 20 17:41:41 minidsp-shd volumio[8203]: info: Upmpdcli Daemon Started Dec 20 17:41:41 minidsp-shd volumio[8203]: info: msSurfaceDial volumioupdatevolume callback: {"vol":30,"dbVolume":-89,"disableVolumeControl":false} Dec 20 17:41:41 minidsp-shd volumio[8203]: info: CoreStateMachine::pushState Dec 20 17:41:41 minidsp-shd volumio[8203]: info: CorePlayQueue::getTrack 0 Dec 20 17:41:41 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 17:41:41 minidsp-shd volumio[8203]: info: CoreCommandRouter::volumioPushState Dec 20 17:41:41 minidsp-shd volumio[8203]: info: CoreCommandRouter::volumioGetState Dec 20 17:41:41 minidsp-shd volumio[8203]: info: CorePlayQueue::getTrack 0 Dec 20 17:41:41 minidsp-shd volumio[8203]: info: MRS: Pushing multiroomSync output update for this device Dec 20 17:41:41 minidsp-shd volumio[8203]: info: MRS: Pushing multiroomSync output Dec 20 17:41:41 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: raat , updateRoonVolume Dec 20 17:41:41 minidsp-shd volumio[8203]: info: Ignoring ROON Volume update because of undefined data Dec 20 17:41:41 minidsp-shd volumio[8203]: info: msSurfaceDial Managed Objs {"/org/bluez":{"org.freedesktop.DBus.Introspectable":{},"org.bluez.AgentManager1":{},"org.bluez.ProfileManager1":{}}} Dec 20 17:41:41 minidsp-shd volumio[8203]: info: [msSurfaceDial init()] check /org/bluez Dec 20 17:41:41 minidsp-shd volumio[8203]: info: [msSurfaceDial init()] Adapter: null; SurfaceDial: null Dec 20 17:41:41 minidsp-shd volumio[8203]: info: msSurfaceDial BluetoothSurfaceDial init() - ready! Dec 20 17:41:41 minidsp-shd volumio[8203]: info: CoreCommandRouter::Reload Ui Dec 20 17:41:41 minidsp-shd volumio[8203]: info: Executing endpoint qc_getconfig Dec 20 17:41:41 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Dec 20 17:41:41 minidsp-shd qobuz-connect[8481]: 20251220 17:41:41.470 [8481.8481] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Dec 20 17:41:41 minidsp-shd qobuz-connect[8481]: 20251220 17:41:41.479 [8481.8481] INFO VolumeManager: [0x1e71908]: Setting new playback volume: 75 Dec 20 17:41:41 minidsp-shd qobuz-connect[8481]: 20251220 17:41:41.479 [8481.8481] INFO VolumeManager: [0x1e71908]: Setting new mute state: 0 Dec 20 17:41:41 minidsp-shd qobuz-connect[8481]: 20251220 17:41:41.479 [8481.8481] INFO QobuzConnect: [0x1e722d8]: Client initialized! Dec 20 17:41:41 minidsp-shd qobuz-connect[8481]: 20251220 17:41:41.479 [8481.8481] INFO SampleApp: Starting Avahi advertising, name: miniDSP SHD, service name: _qobuz-connect._tcp Dec 20 17:41:41 minidsp-shd volumio[8203]: verbose: New Socket.io Connection to 192.168.1.20:3000 from 192.168.1.18 UA: Dart/3.9 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Dec 20 17:41:41 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: raat , updateDSP Dec 20 17:41:41 minidsp-shd volumio[8203]: info: updateDSP function in raat called! Dec 20 17:41:41 minidsp-shd volumio[8203]: info: Updating RAAT Signal Path Dec 20 17:41:41 minidsp-shd qobuz-connect[8481]: 20251220 17:41:41.500 [8481.8481] INFO LocalConfigManager: [0x1e711e8]: Starting Local Configuration server Dec 20 17:41:41 minidsp-shd qobuz-connect[8481]: 20251220 17:41:41.501 [8481.8481] INFO SampleApp: Starting Local configuration server Dec 20 17:41:41 minidsp-shd qobuz-connect[8481]: 20251220 17:41:41.502 [8481.8481] INFO SampleApp: Connected to UNIX socket client 0x1e66ed8 Dec 20 17:41:41 minidsp-shd volumio[8203]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined Dec 20 17:41:41 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: raat , reconfigureAndRestartRaat Dec 20 17:41:41 minidsp-shd volumio[8203]: info: Reconfiguring and Restarting RAAT Plugin Dec 20 17:41:41 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:41:41 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:41:41 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:41:41 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:41:41 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 20 17:41:41 minidsp-shd volumio[8203]: info: Not Reporting Auto name since its the default one Dec 20 17:41:41 minidsp-shd volumio[8203]: info: RAAT Overriding default device vendor model Dec 20 17:41:41 minidsp-shd volumio[8203]: info: Adding MINIDSP Inputs Dec 20 17:41:41 minidsp-shd volumio[8203]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 20 17:41:41 minidsp-shd volumio[8203]: info: [1766248901570] CoreMusicLibrary::Adding element Inputs Dec 20 17:41:41 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 20 17:41:41 minidsp-shd volumio[8203]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 20 17:41:41 minidsp-shd volumio[8203]: info: [1766248901576] CoreMusicLibrary::Adding element Presets Dec 20 17:41:41 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 20 17:41:41 minidsp-shd volumio[8203]: Cannot find translation for source Presets Dec 20 17:41:41 minidsp-shd volumio[8203]: (node:8203) [DEP0005] DeprecationWarning: Buffer() is deprecated due to security and usability issues. Please use the Buffer.alloc(), Buffer.allocUnsafe(), or Buffer.from() methods instead. Dec 20 17:41:41 minidsp-shd volumio[8203]: (Use `node --trace-deprecation ...` to show where the warning was created) Dec 20 17:41:41 minidsp-shd qobuz-connect[8481]: 20251220 17:41:41.620 [8481.8481] INFO SampleApp: Playback volume changed: 75 Dec 20 17:41:41 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 20 17:41:41 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 20 17:41:41 minidsp-shd volumio[8203]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Dec 20 17:41:41 minidsp-shd volumio[8203]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Dec 20 17:41:41 minidsp-shd volumio[8203]: info: QobuzConnect: QOBUZ Connect daemon connected Dec 20 17:41:41 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:41:41 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:41:41 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:41:41 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:41:41 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:41:41 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:41:41 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:41:41 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:41:41 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 20 17:41:41 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Dec 20 17:41:41 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:41:41 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:41:41 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:41:41 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:41:41 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:41:41 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:41:41 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:41:41 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:41:41 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:41:41 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 20 17:41:41 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Dec 20 17:41:41 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 20 17:41:42 minidsp-shd volumio[8203]: info: CoreCommandRouter::volumioGetState Dec 20 17:41:42 minidsp-shd volumio[8203]: info: CorePlayQueue::getTrack 0 Dec 20 17:41:42 minidsp-shd volumio[8203]: verbose: New Socket.io Connection to 192.168.1.20:3000 from 192.168.1.18 UA: Dart/3.9 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7 Dec 20 17:41:42 minidsp-shd volumio[8203]: info: Starting Shairport Sync Dec 20 17:41:42 minidsp-shd volumio[8203]: info: Starting Shairport Sync Dec 20 17:41:42 minidsp-shd sudo[8536]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 20 17:41:42 minidsp-shd sudo[8536]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 17:41:42 minidsp-shd volumio[8203]: info: Starting Shairport Sync Dec 20 17:41:42 minidsp-shd sudo[8539]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 20 17:41:42 minidsp-shd sudo[8539]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 17:41:42 minidsp-shd systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Dec 20 17:41:42 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Dec 20 17:41:42 minidsp-shd systemd[1]: shairport-sync.service: Succeeded. Dec 20 17:41:42 minidsp-shd systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Dec 20 17:41:42 minidsp-shd sudo[8542]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 20 17:41:42 minidsp-shd sudo[8542]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 17:41:42 minidsp-shd mpd[8465]: Dec 20 17:41 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 20 17:41:42 minidsp-shd systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 20 17:41:42 minidsp-shd sudo[8539]: pam_unix(sudo:session): session closed for user root Dec 20 17:41:42 minidsp-shd sudo[8536]: pam_unix(sudo:session): session closed for user root Dec 20 17:41:42 minidsp-shd systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Dec 20 17:41:42 minidsp-shd systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Dec 20 17:41:42 minidsp-shd systemd[1]: shairport-sync.service: Succeeded. Dec 20 17:41:42 minidsp-shd systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Dec 20 17:41:42 minidsp-shd systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 20 17:41:42 minidsp-shd sudo[8542]: pam_unix(sudo:session): session closed for user root Dec 20 17:41:42 minidsp-shd volumio[8203]: info: CoreCommandRouter::volumioGetState Dec 20 17:41:42 minidsp-shd volumio[8203]: info: CorePlayQueue::getTrack 0 Dec 20 17:41:42 minidsp-shd sudo[8549]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Dec 20 17:41:42 minidsp-shd sudo[8549]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 17:41:42 minidsp-shd systemd[1]: Stopping RAAT DAEMON... Dec 20 17:41:42 minidsp-shd systemd[1]: raat-daemon.service: Main process exited, code=killed, status=15/TERM Dec 20 17:41:42 minidsp-shd systemd[1]: raat-daemon.service: Succeeded. Dec 20 17:41:42 minidsp-shd systemd[1]: Stopped RAAT DAEMON. Dec 20 17:41:42 minidsp-shd systemd[1]: Started RAAT DAEMON. Dec 20 17:41:42 minidsp-shd sudo[8549]: pam_unix(sudo:session): session closed for user root Dec 20 17:41:42 minidsp-shd volumio[8203]: verbose: New Socket.io Connection to 192.168.1.20 from 192.168.1.18 UA: Mozilla/5.0 (Linux; Android 15; 23073RPBFG Build/AQ3A.240829.003; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/143.0.7499.115 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Dec 20 17:41:42 minidsp-shd volumio[8203]: info: Shairport-Sync Started Dec 20 17:41:42 minidsp-shd volumio[8203]: Error adding Membership: Error: addMembership EINVAL Dec 20 17:41:42 minidsp-shd volumio[8203]: info: Shairport-Sync Started Dec 20 17:41:42 minidsp-shd volumio[8203]: info: Shairport-Sync Started Dec 20 17:41:42 minidsp-shd sudo[8564]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 20 17:41:42 minidsp-shd sudo[8564]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 17:41:42 minidsp-shd sudo[8564]: pam_unix(sudo:session): session closed for user root Dec 20 17:41:42 minidsp-shd volumio[8203]: Searching plugin music_service/mpd Dec 20 17:41:42 minidsp-shd volumio[8203]: info: CoreCommandRouter::executeOnPlugin: mpd , search Dec 20 17:41:42 minidsp-shd sudo[8567]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 20 17:41:42 minidsp-shd sudo[8567]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 20 17:41:42 minidsp-shd volumio[8203]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 20 17:41:42 minidsp-shd sudo[8567]: pam_unix(sudo:session): session closed for user root Dec 20 17:41:42 minidsp-shd volumio[8203]: TypeError: Cannot read property 'then' of undefined Dec 20 17:41:42 minidsp-shd volumio[8203]: at ControllerMpd.search (/volumio/app/plugins/music_service/mpd/index.js:1601:17) Dec 20 17:41:42 minidsp-shd volumio[8203]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1096:32) Dec 20 17:41:42 minidsp-shd volumio[8203]: at CoreMusicLibrary.search (/volumio/app/musiclibrary.js:477:37) Dec 20 17:41:42 minidsp-shd volumio[8203]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:485:44) Dec 20 17:41:42 minidsp-shd volumio[8203]: at Socket.emit (events.js:400:28) Dec 20 17:41:42 minidsp-shd volumio[8203]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Dec 20 17:41:42 minidsp-shd volumio[8203]: at processTicksAndRejections (internal/process/task_queues.js:77:11) Dec 20 17:41:42 minidsp-shd volumio[8203]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 20 17:41:43 minidsp-shd systemd[1]: Started Music Player Daemon. Dec 20 17:41:43 minidsp-shd sudo[8450]: pam_unix(sudo:session): session closed for user root Dec 20 17:41:43 minidsp-shd sudo[8439]: pam_unix(sudo:session): session closed for user root Dec 20 17:41:43 minidsp-shd sudo[8580]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-20 17:40 Dec 20 17:41:43 minidsp-shd sudo[8580]: 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="cc50ad4a2058d01de272214eb33827883bd2b7d8" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="8bcc10c3dbcbcb349e9887dc0527d54876b32688" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="minidspshd" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 18 Nov 2025 04:14:14 PM CET" VOLUMIO_VERSION="3.877" VOLUMIO_HARDWARE="nanopineo2" VOLUMIO_DEVICENAME="NanoPi Neo2" VOLUMIO_VENDOR="miniDSP" VOLUMIO_MODEL="SHD" VOLUMIO_VENDOR_MODEL="miniDSP SHD" VOLUMIO_HASH="57978c68a391dbf6badbe915e5672a72"