-- Logs begin at Tue 2022-07-19 18:58:21 UTC, end at Mon 2025-09-01 16:20:57 UTC. -- Sep 01 16:20:36 shd systemd[1]: Time has been changed Sep 01 16:20:36 shd volumio[944]: info: Applying required configuration parameters for plugin ms_surface_dial Sep 01 16:20:36 shd volumio[944]: info: Plugin example_plugin is not enabled Sep 01 16:20:36 shd volumio[944]: info: Loading plugin "hi_res_audio"... Sep 01 16:20:36 shd volumio[944]: info: Applying required configuration parameters for plugin hi_res_audio Sep 01 16:20:36 shd volumio[944]: info: Loading plugin "inputs"... Sep 01 16:20:36 shd volumio[944]: info: Loading plugin "qobuz"... Sep 01 16:20:36 shd sudo[980]: pam_unix(sudo:session): session closed for user root Sep 01 16:20:36 shd volumio[944]: Starting albumart workers Sep 01 16:20:36 shd volumio[944]: Starting albumart workers Sep 01 16:20:37 shd volumio-remote-updater[643]: [2025-09-01 16:20:37] [connect] Successful connection Sep 01 16:20:37 shd volumio[944]: Starting albumart workers Sep 01 16:20:39 shd volumio[944]: info: Loading plugin "tidal"... Sep 01 16:20:41 shd volumio[944]: info: Loading plugin "updater_comm"... Sep 01 16:20:41 shd volumio[944]: info: Plugin mpdemulation is not enabled Sep 01 16:20:41 shd volumio[944]: info: Loading plugin "rest_api"... Sep 01 16:20:41 shd volumio[944]: info: Loading plugin "websocket"... Sep 01 16:20:41 shd volumio[944]: info: Loading plugin "RoonBridge"... Sep 01 16:20:42 shd ifup[516]: dhcpcd[550]: timed out Sep 01 16:20:42 shd dhcpcd[550]: timed out Sep 01 16:20:42 shd dhcpcd[550]: exited Sep 01 16:20:42 shd ifup[516]: dhcpcd[550]: exited Sep 01 16:20:42 shd ifup[516]: Failed to bring up eth0. Sep 01 16:20:42 shd volumio[944]: info: Applying required configuration parameters for plugin RoonBridge Sep 01 16:20:42 shd volumio[944]: info: Loading plugin "spop"... Sep 01 16:20:44 shd volumio[944]: info: Loading plugin "volspotconnect2"... Sep 01 16:20:45 shd volumio[944]: info: ___________ START PLUGINS ___________ Sep 01 16:20:45 shd volumio[944]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 01 16:20:45 shd volumio[944]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 01 16:20:45 shd volumio[944]: info: [1756743645041] CoreMusicLibrary::Adding element Media Servers Sep 01 16:20:45 shd volumio[944]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 01 16:20:45 shd volumio[944]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 01 16:20:45 shd volumio[944]: info: Adding METAVOLUMIO REST API Endpoints Sep 01 16:20:45 shd volumio[944]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Sep 01 16:20:45 shd sudo[1041]: pam_unix(sudo:auth): conversation failed Sep 01 16:20:45 shd sudo[1041]: pam_unix(sudo:auth): auth could not identify password for [volumio] Sep 01 16:20:45 shd volumio[944]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 01 16:20:45 shd volumio[944]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Sep 01 16:20:45 shd volumio[944]: info: Preparing CD Folders Sep 01 16:20:45 shd volumio[944]: info: Adding CD REST API Endpoints Sep 01 16:20:45 shd volumio[944]: info: Adding detectCD REST Endpoint for plugin: music_service/cd_controller Sep 01 16:20:45 shd volumio[944]: info: Adding cdRemove REST Endpoint for plugin: music_service/cd_controller Sep 01 16:20:45 shd volumio[944]: info: Adding cdPostScan REST Endpoint for plugin: music_service/cd_controller Sep 01 16:20:45 shd volumio[944]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Sep 01 16:20:45 shd volumio[944]: info: Detecting CD presence with Flag file Sep 01 16:20:45 shd volumio[944]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 01 16:20:45 shd volumio[944]: info: [1756743645228] CoreMusicLibrary::Adding element Last_100 Sep 01 16:20:45 shd volumio[944]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 01 16:20:45 shd volumio[944]: info: Starting RAAT Plugin Sep 01 16:20:45 shd volumio[944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , addAdditionalUISections Sep 01 16:20:45 shd volumio[944]: info: Additional UI Settings Added for plugin music_service/raat Sep 01 16:20:45 shd volumio[944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 01 16:20:45 shd volumio[944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 01 16:20:45 shd volumio[944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 01 16:20:45 shd volumio[944]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 01 16:20:45 shd volumio[944]: info: Not Reporting Auto name since its the default one Sep 01 16:20:45 shd volumio[944]: info: Streaming services startup Sep 01 16:20:45 shd volumio[944]: info: Starting Streaming Daemon Sep 01 16:20:45 shd sudo[1055]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Sep 01 16:20:45 shd sudo[1055]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 01 16:20:45 shd systemd[1]: Stopping Volumio Streaming Daemon... Sep 01 16:20:45 shd systemd[1]: Starting Volumio Streaming Daemon... Sep 01 16:20:45 shd systemd[1]: Started Volumio Streaming Daemon. Sep 01 16:20:45 shd sudo[1055]: pam_unix(sudo:session): session closed for user root Sep 01 16:20:45 shd volumio-streaming-daemon[1060]: ############################ Sep 01 16:20:45 shd volumio-streaming-daemon[1060]: # Volumio Streaming Daemon # Sep 01 16:20:45 shd volumio-streaming-daemon[1060]: # Running on port 7777 # Sep 01 16:20:45 shd volumio-streaming-daemon[1060]: ############################ Sep 01 16:20:45 shd volumio-streaming-daemon[1060]: Checking variant in static cache Sep 01 16:20:45 shd volumio-streaming-daemon[1060]: Enabled services: Sep 01 16:20:45 shd volumio-streaming-daemon[1060]: 1) tidal Sep 01 16:20:45 shd volumio-streaming-daemon[1060]: 2) qobuz Sep 01 16:20:45 shd volumio[944]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 01 16:20:45 shd volumio[944]: info: [1756743645408] CoreMusicLibrary::Adding element Webradio Sep 01 16:20:45 shd volumio[944]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 01 16:20:45 shd volumio[944]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 01 16:20:45 shd volumio[944]: error: Hi Res Audio Failed Login: Missing Login Data Sep 01 16:20:45 shd volumio[944]: info: Refreshing QOBUZ token Sep 01 16:20:45 shd sudo[1069]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start roonbridge.service Sep 01 16:20:45 shd sudo[1069]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 01 16:20:45 shd systemd[1]: Starting RoonBridge... Sep 01 16:20:45 shd systemd[1]: Started RoonBridge. Sep 01 16:20:45 shd sudo[1069]: pam_unix(sudo:session): session closed for user root Sep 01 16:20:45 shd volumio[944]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 01 16:20:45 shd sudo[1077]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/hosts Sep 01 16:20:45 shd sudo[1077]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 01 16:20:45 shd sudo[1077]: pam_unix(sudo:session): session closed for user root Sep 01 16:20:45 shd volumio[944]: [SpotifyConnect] Creating VLS config file Sep 01 16:20:45 shd volumio[944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 01 16:20:45 shd volumio[944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 01 16:20:45 shd volumio[944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 01 16:20:45 shd volumio[944]: [SpotifyConnect] Starting metadata listener Sep 01 16:20:45 shd volumio[944]: [SpotifyConnect] Creating VLS config file Sep 01 16:20:45 shd volumio[944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 01 16:20:45 shd volumio[944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 01 16:20:45 shd volumio[944]: [SpotifyConnect] <> or Mixer found, using softvol Sep 01 16:20:45 shd sudo[1083]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect.service Sep 01 16:20:45 shd volumio[944]: [SpotifyConnect] Starting metadata listener Sep 01 16:20:45 shd sudo[1083]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 01 16:20:45 shd systemd[1]: Starting Volspotconnect2 Daemon... Sep 01 16:20:45 shd systemd[1]: Started Volspotconnect2 Daemon. Sep 01 16:20:45 shd sudo[1083]: pam_unix(sudo:session): session closed for user root Sep 01 16:20:45 shd sudo[1087]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect2.service Sep 01 16:20:45 shd volumio[944]: info: Loading i18n strings for locale en Sep 01 16:20:45 shd sudo[1087]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 01 16:20:45 shd volumio[944]: Updating browse sources language Sep 01 16:20:45 shd volumio[944]: Cannot find translation for sourceMedia Servers Sep 01 16:20:45 shd volumio[944]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 01 16:20:45 shd systemd[1]: Starting Volspotconnect2 Daemon... Sep 01 16:20:45 shd systemd[1]: Started Volspotconnect2 Daemon. Sep 01 16:20:45 shd sudo[1087]: pam_unix(sudo:session): session closed for user root Sep 01 16:20:45 shd volumio[944]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 01 16:20:45 shd volumio[944]: info: CoreCommandRouter::initPlayerControls Sep 01 16:20:45 shd volumio[944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 01 16:20:45 shd volumio[944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Sep 01 16:20:45 shd volumio[944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 01 16:20:45 shd volumio[944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 01 16:20:45 shd volumio[944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 01 16:20:45 shd volumio[944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 01 16:20:45 shd volumio[944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 01 16:20:45 shd volumio[944]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 01 16:20:45 shd volumio[944]: info: BOOT COMPLETED Sep 01 16:20:45 shd volumio[944]: [Metrics] CommandRouter: 17s 615.11ms Sep 01 16:20:45 shd volumio[944]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 01 16:20:46 shd volumio[1086]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-07-11 Sep 01 16:20:46 shd volumio[1086]: Reading Config from "/tmp/volspotify.toml" Sep 01 16:20:46 shd volumio[1086]: Malformed config key: missing field `Authentication` Sep 01 16:20:46 shd volumio[1090]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07 Sep 01 16:20:46 shd volumio[1090]: Reading Config from "volspotify.toml" Sep 01 16:20:46 shd volumio[1090]: [Vollibrespot] : Using Alsa backend with device: plughw:0 Sep 01 16:20:46 shd volumio[1090]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Other, message: "No such device" } Sep 01 16:20:46 shd volumio[1090]: [Vollibrespot] : couldn't parse packet from V4(10.1.100.1:5353): type 47 is invalid Sep 01 16:20:47 shd volumio[1090]: [Vollibrespot] : couldn't parse packet from V4(10.1.100.1:5353): type 47 is invalid Sep 01 16:20:47 shd volumio[1090]: [Vollibrespot] : couldn't parse packet from V4(10.1.100.1:5353): type 47 is invalid Sep 01 16:20:47 shd RoonBridge[1071]: 00:00:00.019 Warn: get lock file path: /tmp/.rnbgem0- Sep 01 16:20:48 shd systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Sep 01 16:20:48 shd systemd[1]: Stopping Volspotconnect2 Daemon... Sep 01 16:20:48 shd systemd[1]: Starting Volspotconnect2 Daemon... Sep 01 16:20:48 shd systemd[1]: Started Volspotconnect2 Daemon. Sep 01 16:20:48 shd volumio[1099]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-07-11 Sep 01 16:20:48 shd volumio[1099]: Reading Config from "/tmp/volspotify.toml" Sep 01 16:20:48 shd volumio[1099]: Malformed config key: missing field `Authentication` Sep 01 16:20:48 shd RoonBridge[1071]: 00:00:00.799 Trace: [childprocess] using unix child process Sep 01 16:20:48 shd RoonBridge[1071]: 00:00:00.908 Debug: PathForResource, filename: ../.update Sep 01 16:20:48 shd RoonBridge[1071]: 00:00:01.016 Debug: PathForResource, candidate: /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/../.update Sep 01 16:20:48 shd volumio[1090]: [Vollibrespot] : couldn't parse packet from V4(10.1.100.1:5353): type 47 is invalid Sep 01 16:20:48 shd RoonBridge[1071]: 00:00:01.030 Debug: PathForResource, filename: RAATServer Sep 01 16:20:48 shd RoonBridge[1071]: 00:00:01.030 Debug: PathForResource, candidate: /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/RAATServer Sep 01 16:20:48 shd RoonBridge[1071]: 00:00:01.031 Debug: PathForResource, filename: RoonBridgeHelper Sep 01 16:20:48 shd RoonBridge[1071]: 00:00:01.031 Debug: PathForResource, candidate: /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/RoonBridgeHelper Sep 01 16:20:48 shd RoonBridge[1071]: Initializing Sep 01 16:20:48 shd RoonBridge[1071]: 00:00:01.099 Info: Starting /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/RoonBridgeHelper Sep 01 16:20:48 shd RoonBridge[1071]: 00:00:01.164 Info: ConnectOrStartAndWaitForExit RAATServer, path: /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/RAATServer Sep 01 16:20:48 shd RoonBridge[1071]: Not Running (.o) Sep 01 16:20:49 shd RoonBridge[1071]: Running Sep 01 16:20:49 shd volumio[1090]: [Vollibrespot] : couldn't parse packet from V4(10.1.100.1:5353): type 47 is invalid Sep 01 16:20:50 shd RoonBridge[1071]: 00:00:00.054 Warn: get lock file path: /tmp/.rnbhgem0- Sep 01 16:20:50 shd systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Sep 01 16:20:50 shd systemd[1]: Stopping Volspotconnect2 Daemon... Sep 01 16:20:50 shd systemd[1]: Starting Volspotconnect2 Daemon... Sep 01 16:20:50 shd systemd[1]: Started Volspotconnect2 Daemon. Sep 01 16:20:50 shd volumio[1129]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-07-11 Sep 01 16:20:50 shd volumio[1129]: Reading Config from "/tmp/volspotify.toml" Sep 01 16:20:50 shd volumio[1129]: Malformed config key: missing field `Authentication` Sep 01 16:20:51 shd volumio[944]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Sep 01 16:20:51 shd volumio[944]: info: CoreCommandRouter::Close All Modals sent Sep 01 16:20:51 shd volumio[944]: info: CoreCommandRouter::Close All Modals sent Sep 01 16:20:51 shd volumio[944]: Express server listening on port 3000 Sep 01 16:20:51 shd volumio[944]: [Metrics] WebUI: 24s 371.98ms Sep 01 16:20:51 shd volumio[944]: Volumio Calling Home Sep 01 16:20:51 shd volumio[944]: [SpotifyConnect] Error: bind EADDRINUSE 0.0.0.0:5030 Sep 01 16:20:51 shd volumio[944]: at _handle.lookup (dgram.js:266:18) Sep 01 16:20:51 shd volumio[944]: at _combinedTickCallback (internal/process/next_tick.js:142:11) Sep 01 16:20:51 shd volumio[944]: at process._tickCallback (internal/process/next_tick.js:181:9) Sep 01 16:20:51 shd volumio[944]: at Function.Module.runMain (module.js:696:11) Sep 01 16:20:51 shd volumio[944]: at startup (bootstrap_node.js:204:16) Sep 01 16:20:51 shd volumio[944]: at bootstrap_node.js:625:3 Sep 01 16:20:51 shd volumio[944]: [SpotifyConnect] Error [ERR_SOCKET_CANNOT_SEND]: Unable to send data Sep 01 16:20:51 shd volumio[944]: at Socket.onListenError (dgram.js:362:22) Sep 01 16:20:51 shd volumio[944]: at Object.onceWrapper (events.js:315:30) Sep 01 16:20:51 shd volumio[944]: at emitOne (events.js:121:20) Sep 01 16:20:51 shd volumio[944]: at Socket.emit (events.js:211:7) Sep 01 16:20:51 shd volumio[944]: at _handle.lookup (dgram.js:267:14) Sep 01 16:20:51 shd volumio[944]: at _combinedTickCallback (internal/process/next_tick.js:142:11) Sep 01 16:20:51 shd volumio[944]: at process._tickCallback (internal/process/next_tick.js:181:9) Sep 01 16:20:51 shd volumio[944]: at Function.Module.runMain (module.js:696:11) Sep 01 16:20:51 shd volumio[944]: at startup (bootstrap_node.js:204:16) Sep 01 16:20:51 shd volumio[944]: at bootstrap_node.js:625:3 Sep 01 16:20:51 shd volumio[944]: info: CoreStateMachine::resetVolumioState Sep 01 16:20:51 shd volumio[944]: info: CoreStateMachine::getcurrentVolume Sep 01 16:20:51 shd volumio[944]: info: CoreCommandRouter::volumioRetrievevolume Sep 01 16:20:51 shd volumio[944]: info: Stopping AccessToken refresher cron Sep 01 16:20:51 shd volumio[944]: info: AccessToken refresher cron started Sep 01 16:20:51 shd volumio[944]: info: msSurfaceDial volumioupdatevolume callback: {"vol":100,"mute":false,"disableVolumeControl":true} Sep 01 16:20:51 shd volumio[944]: info: CoreStateMachine::pushState Sep 01 16:20:51 shd volumio[944]: info: CorePlayQueue::getTrack 0 Sep 01 16:20:51 shd volumio[944]: info: CoreCommandRouter::volumioPushState Sep 01 16:20:51 shd volumio[944]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 16:20:51 shd volumio[944]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 01 16:20:51 shd sudo[1141]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 01 16:20:51 shd sudo[1141]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 01 16:20:51 shd sudo[1141]: pam_unix(sudo:session): session closed for user root Sep 01 16:20:51 shd sudo[1144]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 01 16:20:51 shd sudo[1144]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 01 16:20:51 shd sudo[1144]: pam_unix(sudo:session): session closed for user root Sep 01 16:20:51 shd sudo[1148]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service Sep 01 16:20:51 shd sudo[1148]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 01 16:20:52 shd systemd[1]: Configuration file /lib/systemd/system/volumiobt.service is marked executable. Please remove executable permission bits. Proceeding anyway. Sep 01 16:20:52 shd systemd[1]: Starting Volumio Bluetooth Module... Sep 01 16:20:52 shd volumio-remote-updater[643]: [2025-09-01 16:20:52] [connect] Successful connection Sep 01 16:20:52 shd systemd[1]: Started Volumio Bluetooth Module. Sep 01 16:20:52 shd sudo[1148]: pam_unix(sudo:session): session closed for user root Sep 01 16:20:52 shd volumio[944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Sep 01 16:20:52 shd volumio[944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 01 16:20:52 shd volumio[944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 01 16:20:52 shd volumio[944]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Sep 01 16:20:52 shd sudo[1152]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth/* Sep 01 16:20:52 shd sudo[1152]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 01 16:20:52 shd volumiobt[1151]: /bin/chmod: cannot access '/var/lib/bluetooth/*': No such file or directory Sep 01 16:20:52 shd sudo[1152]: pam_unix(sudo:session): session closed for user root Sep 01 16:20:52 shd volumio[944]: info: Serial port opened successfully Sep 01 16:20:52 shd volumio[944]: info: Volumio BT Module successfully started Sep 01 16:20:52 shd volumio[944]: info: Setting Device type: NanoPi NEO2 Sep 01 16:20:52 shd volumio[944]: [SpotifyConnect] Vollibrespot Daemon service started! Sep 01 16:20:52 shd volumio[944]: [Metrics] SpotifyConnect: 6s 604.11ms Sep 01 16:20:52 shd volumio[944]: [SpotifyConnect] Vollibrespot Daemon service started! Sep 01 16:20:52 shd volumio[944]: [Metrics] SpotifyConnect: 6s 607.20ms Sep 01 16:20:52 shd volumio[944]: info: RAAT Albumart path created successfully Sep 01 16:20:52 shd volumio[944]: error: Cannot set new Bluetooth Name : Error: Command failed: /usr/bin/sudo /bin/hciconfig hci0 name 'shd' Sep 01 16:20:52 shd volumio[944]: sudo: no tty present and no askpass program specified Sep 01 16:20:52 shd volumio[944]: info: Cannot mount NAS Music at system boot, trial number 1 ,retrying in 5 seconds Sep 01 16:20:52 shd volumio[944]: info: MPD running with PID673 Sep 01 16:20:52 shd volumio[944]: ,establishing connection Sep 01 16:20:52 shd sudo[1156]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1 Sep 01 16:20:52 shd sudo[1156]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 01 16:20:52 shd sudo[1156]: pam_unix(sudo:session): session closed for user root Sep 01 16:20:52 shd dbus[674]: [system] Activating via systemd: service name='org.bluez' unit='dbus-org.bluez.service' Sep 01 16:20:52 shd systemd[1]: Starting Bluetooth service... Sep 01 16:20:52 shd bluetoothd[1158]: Bluetooth daemon 5.23 Sep 01 16:20:52 shd dbus[674]: [system] Successfully activated service 'org.bluez' Sep 01 16:20:52 shd systemd[1]: Started Bluetooth service. Sep 01 16:20:52 shd kernel: Bluetooth: Core ver 2.22 Sep 01 16:20:52 shd kernel: NET: Registered protocol family 31 Sep 01 16:20:52 shd kernel: Bluetooth: HCI device and connection manager initialized Sep 01 16:20:52 shd kernel: Bluetooth: HCI socket layer initialized Sep 01 16:20:52 shd kernel: Bluetooth: L2CAP socket layer initialized Sep 01 16:20:52 shd kernel: Bluetooth: SCO socket layer initialized Sep 01 16:20:52 shd bluetoothd[1158]: Starting SDP server Sep 01 16:20:52 shd bluetoothd[1158]: Excluding (cli) sap Sep 01 16:20:52 shd volumio-remote-updater[643]: [2025-09-01 16:20:52] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1756743652 101 Sep 01 16:20:52 shd volumio[944]: info: Volumio called home Sep 01 16:20:52 shd kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3 Sep 01 16:20:52 shd kernel: Bluetooth: BNEP filters: protocol multicast Sep 01 16:20:52 shd kernel: Bluetooth: BNEP socket layer initialized Sep 01 16:20:52 shd volumio[944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Sep 01 16:20:52 shd bluetoothd[1158]: Bluetooth management interface 1.14 initialized Sep 01 16:20:52 shd dbus[674]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' Sep 01 16:20:52 shd volumio[944]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Sep 01 16:20:52 shd systemd[1]: Starting Hostname Service... Sep 01 16:20:52 shd volumio[944]: xcb_connection_has_error() returned true Sep 01 16:20:52 shd volumio[944]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Sep 01 16:20:52 shd systemd-hostnamed[1164]: Warning: nss-myhostname is not installed. Changing the local hostname might make it unresolveable. Please install nss-myhostname! Sep 01 16:20:52 shd dbus[674]: [system] Successfully activated service 'org.freedesktop.hostname1' Sep 01 16:20:52 shd systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Sep 01 16:20:52 shd systemd[1]: Started Hostname Service. Sep 01 16:20:52 shd systemd[1]: Stopping Volspotconnect2 Daemon... Sep 01 16:20:52 shd systemd[1]: Starting Volspotconnect2 Daemon... Sep 01 16:20:52 shd systemd[1]: Started Volspotconnect2 Daemon. Sep 01 16:20:52 shd volumio[1169]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-07-11 Sep 01 16:20:52 shd volumio[1169]: Reading Config from "/tmp/volspotify.toml" Sep 01 16:20:52 shd volumio[1169]: [Vollibrespot] : Using Alsa backend with device: plughw:0 Sep 01 16:20:53 shd volumio[944]: info: Cannot read I2C interface or I2C interface not presentError: Command failed: /usr/bin/sudo /usr/sbin/i2cdetect -y 1 Sep 01 16:20:53 shd volumio[944]: Error: Could not open file `/dev/i2c-1' or `/dev/i2c/1': No such file or directory Sep 01 16:20:53 shd volumio[944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Sep 01 16:20:53 shd volumio[1169]: [Vollibrespot] : Connecting to AP "ap-gew4.spotify.com:443" Sep 01 16:20:53 shd volumio[944]: xcb_connection_has_error() returned true Sep 01 16:20:53 shd sudo[1179]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall pulseaudio Sep 01 16:20:53 shd volumio[944]: info: Reloading queue from file Sep 01 16:20:53 shd sudo[1179]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 01 16:20:53 shd volumio[944]: info: Serial Data: Sep 01 16:20:53 shd volumio[944]: info: CoreCommandRouter::executeOnPlugin: raat , reconfigureAndRestartRaat Sep 01 16:20:53 shd volumio[944]: info: Reconfiguring and Restarting RAAT Plugin Sep 01 16:20:53 shd sudo[1182]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Sep 01 16:20:53 shd sudo[1179]: pam_unix(sudo:session): session closed for user root Sep 01 16:20:53 shd sudo[1182]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 01 16:20:53 shd volumiobt[1151]: pulseaudio: no process found Sep 01 16:20:53 shd systemd[1]: Starting RAAT DAEMON... Sep 01 16:20:53 shd systemd[1]: Started RAAT DAEMON. Sep 01 16:20:53 shd sudo[1182]: pam_unix(sudo:session): session closed for user root Sep 01 16:20:53 shd volumio[944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 01 16:20:53 shd volumio[944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 01 16:20:53 shd volumio[944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 01 16:20:53 shd volumio[944]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 01 16:20:53 shd volumio[944]: info: Not Reporting Auto name since its the default one Sep 01 16:20:53 shd volumio[944]: info: RAAT Overriding default device vendor model Sep 01 16:20:53 shd volumio[944]: info: Adding MINIDSP Inputs Sep 01 16:20:53 shd volumio[944]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 01 16:20:53 shd volumio[944]: info: [1756743653265] CoreMusicLibrary::Adding element Inputs Sep 01 16:20:53 shd volumio[944]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 01 16:20:53 shd volumio[944]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 01 16:20:53 shd volumio[944]: info: [1756743653320] CoreMusicLibrary::Adding element Presets Sep 01 16:20:53 shd volumio[944]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 01 16:20:53 shd volumio[1090]: [Vollibrespot] : couldn't parse packet from V4(10.1.100.1:5353): type 47 is invalid Sep 01 16:20:53 shd volumio[944]: info: msSurfaceDial Managed Objs {"/org/bluez":{"org.freedesktop.DBus.Introspectable":{},"org.bluez.AgentManager1":{},"org.bluez.ProfileManager1":{},"org.bluez.Alert1":{},"org.bluez.HealthManager1":{}}} Sep 01 16:20:53 shd volumio[944]: info: [msSurfaceDial init()] check /org/bluez Sep 01 16:20:53 shd volumio[944]: info: [msSurfaceDial init()] Adapter: null; SurfaceDial: null Sep 01 16:20:53 shd dbus[674]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' Sep 01 16:20:53 shd systemd[1]: Starting RealtimeKit Scheduling Policy Service... Sep 01 16:20:53 shd volumio[944]: info: msSurfaceDial BluetoothSurfaceDial init() - ready! Sep 01 16:20:53 shd volumio[944]: info: CoreCommandRouter::Reload Ui Sep 01 16:20:53 shd volumio[944]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 01 16:20:53 shd volumio[944]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 01 16:20:53 shd dbus[674]: [system] Successfully activated service 'org.freedesktop.RealtimeKit1' Sep 01 16:20:53 shd systemd[1]: Started RealtimeKit Scheduling Policy Service. Sep 01 16:20:53 shd rtkit-daemon[1204]: Successfully called chroot. Sep 01 16:20:53 shd rtkit-daemon[1204]: Successfully dropped privileges. Sep 01 16:20:53 shd rtkit-daemon[1204]: Successfully limited resources. Sep 01 16:20:53 shd rtkit-daemon[1204]: Running. Sep 01 16:20:53 shd rtkit-daemon[1204]: Watchdog thread running. Sep 01 16:20:53 shd rtkit-daemon[1204]: Canary thread running. Sep 01 16:20:53 shd volumio[944]: error: updateQueue error: null Sep 01 16:20:53 shd volumio[944]: error: Failed LSINFO: Error: [50@0] {} No such directory Sep 01 16:20:54 shd pulseaudio[1203]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Sep 01 16:20:54 shd pulseaudio[1203]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Sep 01 16:20:54 shd pulseaudio[1203]: org.bluez.Manager.GetProperties() failed: org.freedesktop.DBus.Error.UnknownMethod: Method "GetProperties" with signature "" on interface "org.bluez.Manager" doesn't exist Sep 01 16:20:54 shd volumiobt[1151]: Applying permissions Sep 01 16:20:54 shd volumiobt[1151]: Setting BT discoverable and pairable Sep 01 16:20:54 shd volumio[944]: info: CoreStateMachine::setRepeat undefined single undefined Sep 01 16:20:54 shd volumio[944]: info: CoreStateMachine::pushState Sep 01 16:20:54 shd volumio[944]: info: CorePlayQueue::getTrack 0 Sep 01 16:20:54 shd volumio[944]: info: CoreCommandRouter::volumioPushState Sep 01 16:20:54 shd volumio[944]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 16:20:54 shd volumio[944]: info: CoreStateMachine::setRandom true Sep 01 16:20:54 shd volumio[944]: info: CoreStateMachine::pushState Sep 01 16:20:54 shd volumio[944]: info: CorePlayQueue::getTrack 0 Sep 01 16:20:54 shd volumio[944]: info: CoreCommandRouter::volumioPushState Sep 01 16:20:54 shd volumio[944]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 16:20:54 shd volumiobt[1151]: [38B blob data] Sep 01 16:20:54 shd volumiobt[1151]: Invalid command Sep 01 16:20:54 shd volumiobt[1151]: [bluetooth]# agent on Sep 01 16:20:54 shd volumiobt[1151]: [bluetooth]# discoverable on Sep 01 16:20:54 shd volumiobt[1151]: No default controller available Sep 01 16:20:54 shd volumiobt[1151]: [bluetooth]# pairable on Sep 01 16:20:54 shd volumiobt[1151]: No default controller available Sep 01 16:20:54 shd volumiobt[1151]: [bluetooth]# agent NoInputNoOutput Sep 01 16:20:54 shd volumiobt[1151]: Failed to register agent object Sep 01 16:20:54 shd volumiobt[1151]: [bluetooth]# default-agent Sep 01 16:20:54 shd volumiobt[1151]: No agent is registered Sep 01 16:20:54 shd volumiobt[1151]: [bluetooth]# quit Sep 01 16:20:54 shd volumiobt[1151]: [61B blob data] Sep 01 16:20:54 shd volumiobt[1151]: [62B blob data] Sep 01 16:20:54 shd volumio[1090]: [Vollibrespot] : couldn't parse packet from V4(10.1.100.1:5353): type 47 is invalid Sep 01 16:20:54 shd volumio[944]: info: Raat Daemon started successfully Sep 01 16:20:54 shd volumio[944]: info: mDNS: A device disapperared from network Sep 01 16:20:54 shd volumio[944]: info: mDNS Browse raised the following error TypeError: Cannot read property 'toLowerCase' of undefined Sep 01 16:20:54 shd volumio[944]: info: Executing endpoint restartRAATSocket Sep 01 16:20:54 shd volumio[944]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Sep 01 16:20:54 shd volumio[944]: info: Starting Shairport Sync Sep 01 16:20:54 shd volumio[944]: info: Starting Shairport Sync Sep 01 16:20:55 shd sudo[1228]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 01 16:20:55 shd sudo[1228]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 01 16:20:55 shd systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Sep 01 16:20:55 shd sudo[1230]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 01 16:20:55 shd sudo[1230]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 01 16:20:55 shd systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Sep 01 16:20:55 shd volumio[944]: Discovery: adding c96094bd-a322-465c-98e6-a51c19ab2527 Sep 01 16:20:55 shd volumio[944]: info: mDNS: Found device shd Sep 01 16:20:55 shd volumio[944]: info: CoreCommandRouter::volumioGetState Sep 01 16:20:55 shd volumio[944]: info: CorePlayQueue::getTrack 0 Sep 01 16:20:55 shd volumio[944]: error: Could not retrieve plugin audio_interface multiroom Sep 01 16:20:55 shd sudo[1228]: pam_unix(sudo:session): session closed for user root Sep 01 16:20:55 shd sudo[1235]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Sep 01 16:20:55 shd sudo[1235]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 01 16:20:55 shd volumio[944]: error: Could not retrieve plugin audio_interface multiroom Sep 01 16:20:55 shd systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Sep 01 16:20:55 shd volumio[944]: info: Serial Data: Sep 01 16:20:55 shd volumio[944]: info: msSurfaceDial volumioupdatevolume callback: {"mute":false,"disableVolumeControl":false} Sep 01 16:20:55 shd volumio[944]: info: CoreStateMachine::pushState Sep 01 16:20:55 shd volumio[944]: info: CorePlayQueue::getTrack 0 Sep 01 16:20:55 shd volumio[944]: info: CoreCommandRouter::volumioPushState Sep 01 16:20:55 shd volumio[944]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 16:20:55 shd systemd[1]: Starting UPnP Renderer front-end to MPD... Sep 01 16:20:55 shd volumio[944]: info: CoreCommandRouter::executeOnPlugin: raat , updateRoonVolume Sep 01 16:20:55 shd systemd[1]: Started UPnP Renderer front-end to MPD. Sep 01 16:20:55 shd sudo[1235]: pam_unix(sudo:session): session closed for user root Sep 01 16:20:55 shd systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Sep 01 16:20:55 shd systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Sep 01 16:20:55 shd sudo[1230]: pam_unix(sudo:session): session closed for user root Sep 01 16:20:55 shd volumio[944]: info: Updating RAAT Signal Path Sep 01 16:20:55 shd volumio[944]: info: CorePlayQueue::getTrack 0 Sep 01 16:20:55 shd volumio[944]: info: CoreCommandRouter::volumiosetSourceActiveno-source Sep 01 16:20:55 shd volumio[944]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 01 16:20:55 shd volumio[944]: info: CoreCommandRouter::volumioStop Sep 01 16:20:55 shd volumio[944]: info: CoreStateMachine::stop Sep 01 16:20:55 shd volumio[944]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 01 16:20:55 shd volumio[944]: verbose: UNSET VOLATILE Sep 01 16:20:55 shd volumio[944]: info: Notifying Active Input {"trackType":"input","service":"inputs","title":"TOSLINK","disableUiControls":true,"albumart":"/albumart"} Sep 01 16:20:55 shd volumio[944]: info: msSurfaceDial volumioupdatevolume callback: {"vol":null,"dbVolume":null,"mute":false,"disableVolumeControl":false} Sep 01 16:20:55 shd volumio[944]: info: CoreStateMachine::pushState Sep 01 16:20:55 shd volumio[944]: info: CorePlayQueue::getTrack 0 Sep 01 16:20:55 shd volumio[944]: info: CoreCommandRouter::volumioPushState Sep 01 16:20:55 shd volumio[944]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 16:20:55 shd volumio[944]: info: CoreCommandRouter::executeOnPlugin: raat , updateRoonVolume Sep 01 16:20:55 shd volumio[944]: info: Updating RAAT Signal Path Sep 01 16:20:55 shd volumio[944]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 01 16:20:55 shd volumio[944]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 01 16:20:55 shd volumio[944]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Sep 01 16:20:55 shd volumio[1090]: [Vollibrespot] : couldn't parse packet from V4(10.1.100.1:5353): type 47 is invalid Sep 01 16:20:55 shd volumio[944]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Sep 01 16:20:55 shd volumio[944]: xcb_connection_has_error() returned true Sep 01 16:20:55 shd sudo[1253]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Sep 01 16:20:55 shd sudo[1253]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 01 16:20:55 shd systemd[1]: Stopping RAAT DAEMON... Sep 01 16:20:55 shd systemd[1]: Starting RAAT DAEMON... Sep 01 16:20:55 shd systemd[1]: Started RAAT DAEMON. Sep 01 16:20:55 shd sudo[1253]: pam_unix(sudo:session): session closed for user root Sep 01 16:20:55 shd volumio[944]: info: Access Token successfully retrieved Sep 01 16:20:55 shd volumio[944]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 01 16:20:55 shd volumio[944]: info: [1756743655583] CoreMusicLibrary::Adding element QOBUZ Sep 01 16:20:55 shd volumio[944]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 01 16:20:55 shd volumio[944]: info: Stopping AccessToken refresher cron for QOBUZ Sep 01 16:20:55 shd volumio[944]: info: AccessToken refresher cron started for QOBUZ Sep 01 16:20:55 shd volumio[944]: info: Upmpdcli Daemon Started Sep 01 16:20:55 shd volumio[944]: info: Shairport-Sync Started Sep 01 16:20:55 shd volumio[944]: Error adding Membership: Error: addMembership EINVAL Sep 01 16:20:55 shd volumio[944]: info: Shairport-Sync Started Sep 01 16:20:55 shd volumio[944]: info: CoreCommandRouter::servicePushState Sep 01 16:20:55 shd volumio[944]: info: CoreStateMachine::pushState Sep 01 16:20:55 shd volumio[944]: info: CoreCommandRouter::volumioPushState Sep 01 16:20:55 shd volumio[944]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 01 16:20:55 shd volumio[944]: ------------------------------------ BT MESSAGE: BT STATUS: running Sep 01 16:20:55 shd volumio[944]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Sep 01 16:20:56 shd volumio[944]: info: Raat Daemon started successfully Sep 01 16:20:56 shd volumio-streaming-daemon[1060]: Checking variant in static cache Sep 01 16:20:56 shd volumio[944]: info: Serial Data: Sep 01 16:20:56 shd volumio[944]: info: CoreCommandRouter::executeOnPlugin: raat , updateDSP Sep 01 16:20:56 shd volumio[944]: info: updateDSP function in raat called! Sep 01 16:20:56 shd volumio[944]: info: Updating RAAT Signal Path Sep 01 16:20:56 shd volumio[944]: info: Executing endpoint restartRAATSocket Sep 01 16:20:56 shd volumio[944]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Sep 01 16:20:56 shd volumio[944]: Discovery: this is already registered, c96094bd-a322-465c-98e6-a51c19ab2527 Sep 01 16:20:56 shd volumio[944]: info: mDNS: Found device shd Sep 01 16:20:56 shd volumio[944]: info: CoreCommandRouter::volumioGetState Sep 01 16:20:56 shd volumio[944]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 01 16:20:56 shd volumio[944]: Error: The value NaN is not a number Sep 01 16:20:56 shd volumio[944]: at Config.forceToType (/volumio/node_modules/v-conf/index.js:322:20) Sep 01 16:20:56 shd volumio[944]: at Config.set (/volumio/node_modules/v-conf/index.js:153:25) Sep 01 16:20:56 shd volumio[944]: at ControllerVolumioDiscovery.pushMultiRoomStatusUpdate (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:287:25) Sep 01 16:20:56 shd volumio[944]: at ControllerVolumioDiscovery.connectToRemoteVolumio (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:276:10) Sep 01 16:20:56 shd volumio[944]: at Browser. (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:202:12) Sep 01 16:20:56 shd volumio[944]: at emitTwo (events.js:126:13) Sep 01 16:20:56 shd volumio[944]: at Browser.emit (events.js:214:7) Sep 01 16:20:56 shd volumio[944]: at on_resolver_done (/volumio/node_modules/mdns/lib/browser.js:31:14) Sep 01 16:20:56 shd volumio[944]: at next (/volumio/node_modules/mdns/lib/browser.js:104:7) Sep 01 16:20:56 shd volumio[944]: at /volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:160:11 Sep 01 16:20:56 shd volumio[944]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:108:7) Sep 01 16:20:56 shd volumio[944]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) Sep 01 16:20:56 shd volumio[944]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 01 16:20:56 shd volumio[1090]: [Vollibrespot] : couldn't parse packet from V4(10.1.100.1:5353): type 47 is invalid Sep 01 16:20:57 shd sudo[1275]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-09-01 16:19 Sep 01 16:20:57 shd sudo[1275]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 8 (jessie)" NAME="Debian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=debian HOME_URL="http://www.debian.org/" SUPPORT_URL="http://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="e5ce74e254a237ac98580c4437c4ed223c7d5cd9" VOLUMIO_BE_VERSION="0cf482c24e7a7ab87af1081ea7d6d953621249a4" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="minidspshd" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Mar 23 10:08:04 CET 2022" VOLUMIO_VERSION="1.121" VOLUMIO_HARDWARE="nanopineo2" VOLUMIO_VENDOR="miniDSP" VOLUMIO_MODEL="SHD" VOLUMIO_VENDOR_MODEL="miniDSP SHD" VOLUMIO_HASH="c49a059c2bcfb892c670d4f5a84421ae"