-- Logs begin at Tue 2022-07-19 18:58:21 UTC, end at Sat 2026-01-10 16:10:42 UTC. -- Jan 10 16:10:19 shd systemd[1]: Time has been changed Jan 10 16:10:19 shd volumio[945]: info: Loading plugin "alarm-clock"... Jan 10 16:10:20 shd volumio[945]: info: Loading plugin "metavolumio"... Jan 10 16:10:20 shd volumio[945]: info: Loading plugin "airplay_emulation"... Jan 10 16:10:20 shd volumio[945]: info: Starting Shairport Sync Jan 10 16:10:20 shd volumio[945]: info: Loading plugin "cd_controller"... Jan 10 16:10:20 shd volumio[945]: info: Loading plugin "last_100"... Jan 10 16:10:20 shd volumio[945]: info: Loading plugin "raat"... Jan 10 16:10:20 shd volumio[945]: info: RAAT Plugin loaded Jan 10 16:10:20 shd volumio[945]: info: Adding restartRAATSocket REST API Endpoint Jan 10 16:10:20 shd volumio[945]: info: Adding restartRAATSocket REST Endpoint for plugin: music_service/raat Jan 10 16:10:20 shd volumio[945]: info: CoreCommandRouter::executeOnPlugin: inputs , getVolume Jan 10 16:10:20 shd volumio[945]: error: Could not retrieve plugin music_service inputs Jan 10 16:10:20 shd volumio[945]: info: CoreCommandRouter::executeOnPlugin: inputs , getDSP Jan 10 16:10:20 shd volumio[945]: error: Could not retrieve plugin music_service inputs Jan 10 16:10:20 shd volumio[945]: info: Loading plugin "streaming_services"... Jan 10 16:10:20 shd volumio[945]: info: Loading plugin "webradio"... Jan 10 16:10:20 shd volumio[945]: info: Loading plugin "i2s_dacs"... Jan 10 16:10:20 shd volumio[945]: info: I2S DAC not set, start Auto-detection Jan 10 16:10:20 shd volumio[945]: info: Loading plugin "volumiodiscovery"... Jan 10 16:10:20 shd volumio[945]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 10 16:10:20 shd node[945]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 10 16:10:20 shd node[945]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 10 16:10:20 shd node[945]: *** WARNING *** For more information see Jan 10 16:10:20 shd node[945]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 10 16:10:20 shd node[945]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 10 16:10:20 shd node[945]: *** WARNING *** For more information see Jan 10 16:10:20 shd volumio[945]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 10 16:10:20 shd volumio[945]: *** WARNING *** For more information see Jan 10 16:10:20 shd volumio[945]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 10 16:10:20 shd volumio[945]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 10 16:10:20 shd volumio[945]: *** WARNING *** For more information see Jan 10 16:10:20 shd volumio[945]: info: Applying required configuration parameters for plugin volumiodiscovery Jan 10 16:10:20 shd volumio[945]: Discovery: StartAdv! undefined Jan 10 16:10:20 shd volumio[945]: Discovery: Started advertising... shd - undefined Jan 10 16:10:20 shd volumio[945]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 10 16:10:20 shd volumio[945]: info: Loading plugin "outputs"... Jan 10 16:10:20 shd volumio[945]: info: Loading plugin "albumart"... Jan 10 16:10:20 shd volumio[945]: info: Loading plugin "ms_surface_dial"... Jan 10 16:10:21 shd volumio[945]: Forking 3 albumart workers Jan 10 16:10:21 shd volumio[945]: info: Applying required configuration parameters for plugin ms_surface_dial Jan 10 16:10:21 shd volumio[945]: info: Plugin example_plugin is not enabled Jan 10 16:10:21 shd volumio[945]: info: Loading plugin "hi_res_audio"... Jan 10 16:10:22 shd volumio[945]: info: Applying required configuration parameters for plugin hi_res_audio Jan 10 16:10:22 shd volumio[945]: info: Loading plugin "inputs"... Jan 10 16:10:22 shd volumio[945]: info: Loading plugin "qobuz"... Jan 10 16:10:22 shd sudo[981]: pam_unix(sudo:session): session closed for user root Jan 10 16:10:22 shd volumio[945]: Starting albumart workers Jan 10 16:10:22 shd volumio-remote-updater[643]: [2026-01-10 16:10:22] [connect] Successful connection Jan 10 16:10:22 shd volumio[945]: Starting albumart workers Jan 10 16:10:22 shd volumio[945]: Starting albumart workers Jan 10 16:10:24 shd volumio[945]: info: Loading plugin "tidal"... Jan 10 16:10:27 shd volumio[945]: info: Loading plugin "updater_comm"... Jan 10 16:10:27 shd volumio[945]: info: Plugin mpdemulation is not enabled Jan 10 16:10:27 shd volumio[945]: info: Loading plugin "rest_api"... Jan 10 16:10:27 shd volumio[945]: info: Loading plugin "websocket"... Jan 10 16:10:27 shd volumio[945]: info: Loading plugin "RoonBridge"... Jan 10 16:10:27 shd ifup[516]: dhcpcd[550]: timed out Jan 10 16:10:27 shd dhcpcd[550]: timed out Jan 10 16:10:27 shd dhcpcd[550]: exited Jan 10 16:10:27 shd ifup[516]: dhcpcd[550]: exited Jan 10 16:10:27 shd ifup[516]: Failed to bring up eth0. Jan 10 16:10:27 shd volumio[945]: info: Applying required configuration parameters for plugin RoonBridge Jan 10 16:10:27 shd volumio[945]: info: Loading plugin "spop"... Jan 10 16:10:29 shd volumio[945]: info: Loading plugin "volspotconnect2"... Jan 10 16:10:30 shd volumio[945]: info: ___________ START PLUGINS ___________ Jan 10 16:10:30 shd volumio[945]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 10 16:10:30 shd volumio[945]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 10 16:10:30 shd volumio[945]: info: [1768061430610] CoreMusicLibrary::Adding element Media Servers Jan 10 16:10:30 shd volumio[945]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 10 16:10:30 shd volumio[945]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 10 16:10:30 shd volumio[945]: info: Adding METAVOLUMIO REST API Endpoints Jan 10 16:10:30 shd volumio[945]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Jan 10 16:10:30 shd sudo[1042]: pam_unix(sudo:auth): conversation failed Jan 10 16:10:30 shd sudo[1042]: pam_unix(sudo:auth): auth could not identify password for [volumio] Jan 10 16:10:30 shd volumio[945]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 10 16:10:30 shd volumio[945]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 10 16:10:30 shd volumio[945]: info: Preparing CD Folders Jan 10 16:10:30 shd volumio[945]: info: Adding CD REST API Endpoints Jan 10 16:10:30 shd volumio[945]: info: Adding detectCD REST Endpoint for plugin: music_service/cd_controller Jan 10 16:10:30 shd volumio[945]: info: Adding cdRemove REST Endpoint for plugin: music_service/cd_controller Jan 10 16:10:30 shd volumio[945]: info: Adding cdPostScan REST Endpoint for plugin: music_service/cd_controller Jan 10 16:10:30 shd volumio[945]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Jan 10 16:10:30 shd volumio[945]: info: Detecting CD presence with Flag file Jan 10 16:10:30 shd volumio[945]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 10 16:10:30 shd volumio[945]: info: [1768061430797] CoreMusicLibrary::Adding element Last_100 Jan 10 16:10:30 shd volumio[945]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 10 16:10:30 shd volumio[945]: info: Starting RAAT Plugin Jan 10 16:10:30 shd volumio[945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , addAdditionalUISections Jan 10 16:10:30 shd volumio[945]: info: Additional UI Settings Added for plugin music_service/raat Jan 10 16:10:30 shd volumio[945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 16:10:30 shd volumio[945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 16:10:30 shd volumio[945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 16:10:30 shd volumio[945]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 10 16:10:30 shd volumio[945]: info: Not Reporting Auto name since its the default one Jan 10 16:10:30 shd volumio[945]: info: Streaming services startup Jan 10 16:10:30 shd volumio[945]: info: Starting Streaming Daemon Jan 10 16:10:30 shd sudo[1056]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jan 10 16:10:30 shd sudo[1056]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 10 16:10:30 shd systemd[1]: Stopping Volumio Streaming Daemon... Jan 10 16:10:30 shd systemd[1]: Starting Volumio Streaming Daemon... Jan 10 16:10:30 shd systemd[1]: Started Volumio Streaming Daemon. Jan 10 16:10:30 shd sudo[1056]: pam_unix(sudo:session): session closed for user root Jan 10 16:10:30 shd volumio-streaming-daemon[1061]: ############################ Jan 10 16:10:30 shd volumio-streaming-daemon[1061]: # Volumio Streaming Daemon # Jan 10 16:10:30 shd volumio-streaming-daemon[1061]: # Running on port 7777 # Jan 10 16:10:30 shd volumio-streaming-daemon[1061]: ############################ Jan 10 16:10:30 shd volumio-streaming-daemon[1061]: Checking variant in static cache Jan 10 16:10:30 shd volumio-streaming-daemon[1061]: Enabled services: Jan 10 16:10:30 shd volumio-streaming-daemon[1061]: 1) tidal Jan 10 16:10:30 shd volumio-streaming-daemon[1061]: 2) qobuz Jan 10 16:10:30 shd volumio[945]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 10 16:10:30 shd volumio[945]: info: [1768061430976] CoreMusicLibrary::Adding element Webradio Jan 10 16:10:30 shd volumio[945]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 10 16:10:30 shd volumio[945]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 10 16:10:31 shd volumio[945]: error: Hi Res Audio Failed Login: Missing Login Data Jan 10 16:10:31 shd volumio[945]: info: Refreshing QOBUZ token Jan 10 16:10:31 shd sudo[1070]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start roonbridge.service Jan 10 16:10:31 shd sudo[1070]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 10 16:10:31 shd systemd[1]: Starting RoonBridge... Jan 10 16:10:31 shd systemd[1]: Started RoonBridge. Jan 10 16:10:31 shd sudo[1070]: pam_unix(sudo:session): session closed for user root Jan 10 16:10:31 shd volumio[945]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 10 16:10:31 shd volumio[945]: [SpotifyConnect] Creating VLS config file Jan 10 16:10:31 shd volumio[945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 16:10:31 shd volumio[945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 16:10:31 shd volumio[945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 16:10:31 shd sudo[1078]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/hosts Jan 10 16:10:31 shd volumio[945]: [SpotifyConnect] Starting metadata listener Jan 10 16:10:31 shd sudo[1078]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 10 16:10:31 shd sudo[1078]: pam_unix(sudo:session): session closed for user root Jan 10 16:10:31 shd volumio[945]: [SpotifyConnect] Creating VLS config file Jan 10 16:10:31 shd volumio[945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 16:10:31 shd volumio[945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 16:10:31 shd volumio[945]: [SpotifyConnect] <> or Mixer found, using softvol Jan 10 16:10:31 shd sudo[1085]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect.service Jan 10 16:10:31 shd volumio[945]: [SpotifyConnect] Starting metadata listener Jan 10 16:10:31 shd sudo[1085]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 10 16:10:31 shd systemd[1]: Starting Volspotconnect2 Daemon... Jan 10 16:10:31 shd systemd[1]: Started Volspotconnect2 Daemon. Jan 10 16:10:31 shd sudo[1085]: pam_unix(sudo:session): session closed for user root Jan 10 16:10:31 shd sudo[1089]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volspotconnect2.service Jan 10 16:10:31 shd sudo[1089]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 10 16:10:31 shd volumio[945]: info: Loading i18n strings for locale en Jan 10 16:10:31 shd volumio[945]: Updating browse sources language Jan 10 16:10:31 shd volumio[945]: Cannot find translation for sourceMedia Servers Jan 10 16:10:31 shd volumio[945]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 10 16:10:31 shd systemd[1]: Starting Volspotconnect2 Daemon... Jan 10 16:10:31 shd systemd[1]: Started Volspotconnect2 Daemon. Jan 10 16:10:31 shd sudo[1089]: pam_unix(sudo:session): session closed for user root Jan 10 16:10:31 shd volumio[945]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 10 16:10:31 shd volumio[945]: info: CoreCommandRouter::initPlayerControls Jan 10 16:10:31 shd volumio[945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 16:10:31 shd volumio[945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Jan 10 16:10:31 shd volumio[945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 16:10:31 shd volumio[945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 16:10:31 shd volumio[945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 16:10:31 shd volumio[945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 16:10:31 shd volumio[945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 16:10:31 shd volumio[945]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 10 16:10:31 shd volumio[945]: info: BOOT COMPLETED Jan 10 16:10:31 shd volumio[945]: [Metrics] CommandRouter: 17s 581.88ms Jan 10 16:10:31 shd volumio[945]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 10 16:10:31 shd volumio[1088]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-07-11 Jan 10 16:10:31 shd volumio[1088]: Reading Config from "/tmp/volspotify.toml" Jan 10 16:10:31 shd volumio[1088]: Malformed config key: missing field `Authentication` Jan 10 16:10:31 shd volumio[1092]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07 Jan 10 16:10:31 shd volumio[1092]: Reading Config from "volspotify.toml" Jan 10 16:10:31 shd volumio[1092]: [Vollibrespot] : Using Alsa backend with device: plughw:0 Jan 10 16:10:31 shd volumio[1092]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Other, message: "No such device" } Jan 10 16:10:33 shd RoonBridge[1072]: 00:00:00.018 Warn: get lock file path: /tmp/.rnbgem0- Jan 10 16:10:33 shd systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Jan 10 16:10:33 shd systemd[1]: Stopping Volspotconnect2 Daemon... Jan 10 16:10:33 shd systemd[1]: Starting Volspotconnect2 Daemon... Jan 10 16:10:33 shd systemd[1]: Started Volspotconnect2 Daemon. Jan 10 16:10:33 shd volumio[1101]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-07-11 Jan 10 16:10:33 shd volumio[1101]: Reading Config from "/tmp/volspotify.toml" Jan 10 16:10:33 shd volumio[1101]: Malformed config key: missing field `Authentication` Jan 10 16:10:33 shd RoonBridge[1072]: 00:00:00.796 Trace: [childprocess] using unix child process Jan 10 16:10:34 shd RoonBridge[1072]: 00:00:00.904 Debug: PathForResource, filename: ../.update Jan 10 16:10:34 shd RoonBridge[1072]: 00:00:01.013 Debug: PathForResource, candidate: /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/../.update Jan 10 16:10:34 shd RoonBridge[1072]: 00:00:01.025 Debug: PathForResource, filename: RAATServer Jan 10 16:10:34 shd RoonBridge[1072]: 00:00:01.025 Debug: PathForResource, candidate: /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/RAATServer Jan 10 16:10:34 shd RoonBridge[1072]: 00:00:01.027 Debug: PathForResource, filename: RoonBridgeHelper Jan 10 16:10:34 shd RoonBridge[1072]: 00:00:01.027 Debug: PathForResource, candidate: /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/RoonBridgeHelper Jan 10 16:10:34 shd RoonBridge[1072]: Initializing Jan 10 16:10:34 shd RoonBridge[1072]: 00:00:01.095 Info: Starting /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/RoonBridgeHelper Jan 10 16:10:34 shd RoonBridge[1072]: 00:00:01.160 Info: ConnectOrStartAndWaitForExit RAATServer, path: /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/RAATServer Jan 10 16:10:34 shd RoonBridge[1072]: Not Running (.o) Jan 10 16:10:34 shd RoonBridge[1072]: Running Jan 10 16:10:35 shd RoonBridge[1072]: 00:00:00.054 Warn: get lock file path: /tmp/.rnbhgem0- Jan 10 16:10:35 shd systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Jan 10 16:10:35 shd systemd[1]: Stopping Volspotconnect2 Daemon... Jan 10 16:10:35 shd systemd[1]: Starting Volspotconnect2 Daemon... Jan 10 16:10:35 shd systemd[1]: Started Volspotconnect2 Daemon. Jan 10 16:10:35 shd volumio[1128]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-07-11 Jan 10 16:10:35 shd volumio[1128]: Reading Config from "/tmp/volspotify.toml" Jan 10 16:10:35 shd volumio[1128]: Malformed config key: missing field `Authentication` Jan 10 16:10:36 shd volumio[945]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Jan 10 16:10:36 shd volumio[945]: info: CoreCommandRouter::Close All Modals sent Jan 10 16:10:36 shd volumio[945]: info: CoreCommandRouter::Close All Modals sent Jan 10 16:10:36 shd volumio[945]: Express server listening on port 3000 Jan 10 16:10:36 shd volumio[945]: [Metrics] WebUI: 24s 236.47ms Jan 10 16:10:36 shd volumio[945]: Volumio Calling Home Jan 10 16:10:37 shd volumio[945]: [SpotifyConnect] Error: bind EADDRINUSE 0.0.0.0:5030 Jan 10 16:10:37 shd volumio[945]: at _handle.lookup (dgram.js:266:18) Jan 10 16:10:37 shd volumio[945]: at _combinedTickCallback (internal/process/next_tick.js:142:11) Jan 10 16:10:37 shd volumio[945]: at process._tickCallback (internal/process/next_tick.js:181:9) Jan 10 16:10:37 shd volumio[945]: at Function.Module.runMain (module.js:696:11) Jan 10 16:10:37 shd volumio[945]: at startup (bootstrap_node.js:204:16) Jan 10 16:10:37 shd volumio[945]: at bootstrap_node.js:625:3 Jan 10 16:10:37 shd volumio[945]: [SpotifyConnect] Error [ERR_SOCKET_CANNOT_SEND]: Unable to send data Jan 10 16:10:37 shd volumio[945]: at Socket.onListenError (dgram.js:362:22) Jan 10 16:10:37 shd volumio[945]: at Object.onceWrapper (events.js:315:30) Jan 10 16:10:37 shd volumio[945]: at emitOne (events.js:121:20) Jan 10 16:10:37 shd volumio[945]: at Socket.emit (events.js:211:7) Jan 10 16:10:37 shd volumio[945]: at _handle.lookup (dgram.js:267:14) Jan 10 16:10:37 shd volumio[945]: at _combinedTickCallback (internal/process/next_tick.js:142:11) Jan 10 16:10:37 shd volumio[945]: at process._tickCallback (internal/process/next_tick.js:181:9) Jan 10 16:10:37 shd volumio[945]: at Function.Module.runMain (module.js:696:11) Jan 10 16:10:37 shd volumio[945]: at startup (bootstrap_node.js:204:16) Jan 10 16:10:37 shd volumio[945]: at bootstrap_node.js:625:3 Jan 10 16:10:37 shd volumio[945]: info: CoreStateMachine::resetVolumioState Jan 10 16:10:37 shd volumio[945]: info: CoreStateMachine::getcurrentVolume Jan 10 16:10:37 shd volumio[945]: info: CoreCommandRouter::volumioRetrievevolume Jan 10 16:10:37 shd volumio[945]: info: Stopping AccessToken refresher cron Jan 10 16:10:37 shd volumio[945]: info: AccessToken refresher cron started Jan 10 16:10:37 shd volumio[945]: info: msSurfaceDial volumioupdatevolume callback: {"vol":100,"mute":false,"disableVolumeControl":true} Jan 10 16:10:37 shd volumio[945]: info: CoreStateMachine::pushState Jan 10 16:10:37 shd volumio[945]: info: CorePlayQueue::getTrack 0 Jan 10 16:10:37 shd volumio[945]: info: CoreCommandRouter::volumioPushState Jan 10 16:10:37 shd volumio[945]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 10 16:10:37 shd volumio[945]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 10 16:10:37 shd sudo[1144]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 10 16:10:37 shd sudo[1144]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 10 16:10:37 shd sudo[1147]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 10 16:10:37 shd sudo[1147]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 10 16:10:37 shd sudo[1147]: pam_unix(sudo:session): session closed for user root Jan 10 16:10:37 shd sudo[1144]: pam_unix(sudo:session): session closed for user root Jan 10 16:10:37 shd sudo[1150]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service Jan 10 16:10:37 shd volumio[945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jan 10 16:10:37 shd volumio[945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 16:10:37 shd volumio[945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 16:10:37 shd sudo[1150]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 10 16:10:37 shd systemd[1]: Configuration file /lib/systemd/system/volumiobt.service is marked executable. Please remove executable permission bits. Proceeding anyway. Jan 10 16:10:37 shd volumio[945]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Jan 10 16:10:37 shd systemd[1]: Starting Volumio Bluetooth Module... Jan 10 16:10:37 shd systemd[1]: Started Volumio Bluetooth Module. Jan 10 16:10:37 shd sudo[1150]: pam_unix(sudo:session): session closed for user root Jan 10 16:10:37 shd volumio[945]: info: Serial port opened successfully Jan 10 16:10:37 shd sudo[1153]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth/* Jan 10 16:10:37 shd sudo[1153]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 10 16:10:37 shd volumiobt[1152]: /bin/chmod: cannot access '/var/lib/bluetooth/*': No such file or directory Jan 10 16:10:37 shd sudo[1153]: pam_unix(sudo:session): session closed for user root Jan 10 16:10:37 shd volumio-remote-updater[643]: [2026-01-10 16:10:37] [connect] Successful connection Jan 10 16:10:37 shd volumio[945]: info: Setting Device type: NanoPi NEO2 Jan 10 16:10:37 shd volumio[945]: [SpotifyConnect] Vollibrespot Daemon service started! Jan 10 16:10:37 shd volumio[945]: [Metrics] SpotifyConnect: 6s 420.29ms Jan 10 16:10:37 shd volumio[945]: [SpotifyConnect] Vollibrespot Daemon service started! Jan 10 16:10:37 shd volumio[945]: [Metrics] SpotifyConnect: 6s 423.51ms Jan 10 16:10:37 shd volumio[945]: info: RAAT Albumart path created successfully Jan 10 16:10:37 shd volumio[945]: error: Cannot set new Bluetooth Name : Error: Command failed: /usr/bin/sudo /bin/hciconfig hci0 name 'shd' Jan 10 16:10:37 shd volumio[945]: sudo: no tty present and no askpass program specified Jan 10 16:10:37 shd volumio[945]: info: Cannot mount NAS Music at system boot, trial number 1 ,retrying in 5 seconds Jan 10 16:10:37 shd volumio[945]: info: MPD running with PID679 Jan 10 16:10:37 shd volumio[945]: ,establishing connection Jan 10 16:10:37 shd sudo[1158]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1 Jan 10 16:10:37 shd sudo[1158]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 10 16:10:37 shd sudo[1158]: pam_unix(sudo:session): session closed for user root Jan 10 16:10:37 shd dbus[683]: [system] Activating via systemd: service name='org.bluez' unit='dbus-org.bluez.service' Jan 10 16:10:37 shd systemd[1]: Starting Bluetooth service... Jan 10 16:10:37 shd bluetoothd[1160]: Bluetooth daemon 5.23 Jan 10 16:10:37 shd dbus[683]: [system] Successfully activated service 'org.bluez' Jan 10 16:10:37 shd systemd[1]: Started Bluetooth service. Jan 10 16:10:37 shd kernel: Bluetooth: Core ver 2.22 Jan 10 16:10:37 shd kernel: NET: Registered protocol family 31 Jan 10 16:10:37 shd kernel: Bluetooth: HCI device and connection manager initialized Jan 10 16:10:37 shd kernel: Bluetooth: HCI socket layer initialized Jan 10 16:10:37 shd kernel: Bluetooth: L2CAP socket layer initialized Jan 10 16:10:37 shd kernel: Bluetooth: SCO socket layer initialized Jan 10 16:10:37 shd bluetoothd[1160]: Starting SDP server Jan 10 16:10:37 shd bluetoothd[1160]: Excluding (cli) sap Jan 10 16:10:37 shd volumio[945]: info: Volumio BT Module successfully started Jan 10 16:10:37 shd volumio[945]: info: Volumio called home Jan 10 16:10:37 shd volumio[945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Jan 10 16:10:37 shd volumio[945]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jan 10 16:10:37 shd kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3 Jan 10 16:10:37 shd kernel: Bluetooth: BNEP filters: protocol multicast Jan 10 16:10:37 shd kernel: Bluetooth: BNEP socket layer initialized Jan 10 16:10:37 shd bluetoothd[1160]: Bluetooth management interface 1.14 initialized Jan 10 16:10:37 shd dbus[683]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' Jan 10 16:10:37 shd systemd[1]: volspotconnect.service holdoff time over, scheduling restart. Jan 10 16:10:37 shd systemd[1]: Stopping Volspotconnect2 Daemon... Jan 10 16:10:37 shd systemd[1]: Starting Volspotconnect2 Daemon... Jan 10 16:10:37 shd systemd[1]: Started Volspotconnect2 Daemon. Jan 10 16:10:38 shd systemd[1]: Starting Hostname Service... Jan 10 16:10:38 shd volumio[945]: xcb_connection_has_error() returned true Jan 10 16:10:38 shd volumio[945]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Jan 10 16:10:38 shd volumio[1167]: vollibrespot v0.2.5 8922128 2022-05-31 (librespot 08d8bcc 2020-10-07) -- Built On 2022-07-11 Jan 10 16:10:38 shd volumio[1167]: Reading Config from "/tmp/volspotify.toml" Jan 10 16:10:38 shd systemd-hostnamed[1168]: Warning: nss-myhostname is not installed. Changing the local hostname might make it unresolveable. Please install nss-myhostname! Jan 10 16:10:38 shd volumio[1167]: [Vollibrespot] : Using Alsa backend with device: plughw:0 Jan 10 16:10:38 shd dbus[683]: [system] Successfully activated service 'org.freedesktop.hostname1' Jan 10 16:10:38 shd systemd[1]: Started Hostname Service. Jan 10 16:10:38 shd volumio[1167]: [Vollibrespot] : Connecting to AP "ap-gew4.spotify.com:443" Jan 10 16:10:38 shd volumio-remote-updater[643]: [2026-01-10 16:10:38] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1768061437 101 Jan 10 16:10:38 shd volumio[945]: info: Cannot read I2C interface or I2C interface not presentError: Command failed: /usr/bin/sudo /usr/sbin/i2cdetect -y 1 Jan 10 16:10:38 shd volumio[945]: Error: Could not open file `/dev/i2c-1' or `/dev/i2c/1': No such file or directory Jan 10 16:10:38 shd volumio[945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Jan 10 16:10:38 shd volumio[945]: xcb_connection_has_error() returned true Jan 10 16:10:38 shd volumio[945]: info: Reloading queue from file Jan 10 16:10:38 shd volumio[945]: info: Serial Data: Jan 10 16:10:38 shd volumio[945]: info: CoreCommandRouter::executeOnPlugin: raat , reconfigureAndRestartRaat Jan 10 16:10:38 shd volumio[945]: info: Reconfiguring and Restarting RAAT Plugin Jan 10 16:10:38 shd sudo[1181]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall pulseaudio Jan 10 16:10:38 shd sudo[1180]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Jan 10 16:10:38 shd sudo[1181]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 10 16:10:38 shd sudo[1180]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 10 16:10:38 shd systemd[1]: Starting RAAT DAEMON... Jan 10 16:10:38 shd systemd[1]: Started RAAT DAEMON. Jan 10 16:10:38 shd volumiobt[1152]: pulseaudio: no process found Jan 10 16:10:38 shd sudo[1181]: pam_unix(sudo:session): session closed for user root Jan 10 16:10:38 shd sudo[1180]: pam_unix(sudo:session): session closed for user root Jan 10 16:10:38 shd volumio[945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 16:10:38 shd volumio[945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 16:10:38 shd volumio[945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 10 16:10:38 shd volumio[945]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 10 16:10:38 shd volumio[945]: info: Not Reporting Auto name since its the default one Jan 10 16:10:38 shd volumio[945]: info: RAAT Overriding default device vendor model Jan 10 16:10:38 shd volumio[945]: info: Adding MINIDSP Inputs Jan 10 16:10:38 shd volumio[945]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 10 16:10:38 shd volumio[945]: info: [1768061438716] CoreMusicLibrary::Adding element Inputs Jan 10 16:10:38 shd volumio[945]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 10 16:10:38 shd volumio[945]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 10 16:10:38 shd volumio[945]: info: [1768061438764] CoreMusicLibrary::Adding element Presets Jan 10 16:10:38 shd volumio[945]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 10 16:10:38 shd dbus[683]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' Jan 10 16:10:38 shd systemd[1]: Starting RealtimeKit Scheduling Policy Service... Jan 10 16:10:38 shd volumio[945]: info: msSurfaceDial Managed Objs {"/org/bluez":{"org.freedesktop.DBus.Introspectable":{},"org.bluez.AgentManager1":{},"org.bluez.ProfileManager1":{},"org.bluez.Alert1":{},"org.bluez.HealthManager1":{}}} Jan 10 16:10:38 shd volumio[945]: info: [msSurfaceDial init()] check /org/bluez Jan 10 16:10:38 shd volumio[945]: info: [msSurfaceDial init()] Adapter: null; SurfaceDial: null Jan 10 16:10:38 shd volumio[945]: info: msSurfaceDial BluetoothSurfaceDial init() - ready! Jan 10 16:10:38 shd volumio[945]: info: CoreCommandRouter::Reload Ui Jan 10 16:10:38 shd dbus[683]: [system] Successfully activated service 'org.freedesktop.RealtimeKit1' Jan 10 16:10:38 shd rtkit-daemon[1206]: Successfully called chroot. Jan 10 16:10:38 shd rtkit-daemon[1206]: Successfully dropped privileges. Jan 10 16:10:38 shd rtkit-daemon[1206]: Successfully limited resources. Jan 10 16:10:38 shd rtkit-daemon[1206]: Running. Jan 10 16:10:38 shd rtkit-daemon[1206]: Canary thread running. Jan 10 16:10:38 shd rtkit-daemon[1206]: Watchdog thread running. Jan 10 16:10:38 shd systemd[1]: Started RealtimeKit Scheduling Policy Service. Jan 10 16:10:38 shd volumio[945]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 10 16:10:38 shd volumio[945]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 10 16:10:38 shd volumio[945]: error: updateQueue error: null Jan 10 16:10:38 shd volumio[945]: error: Failed LSINFO: Error: [50@0] {} No such directory Jan 10 16:10:39 shd pulseaudio[1203]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Jan 10 16:10:39 shd pulseaudio[1203]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 Jan 10 16:10:39 shd volumiobt[1152]: Applying permissions Jan 10 16:10:39 shd volumiobt[1152]: Setting BT discoverable and pairable Jan 10 16:10:39 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 Jan 10 16:10:39 shd volumio[945]: info: CoreStateMachine::setRepeat undefined single undefined Jan 10 16:10:39 shd volumio[945]: info: CoreStateMachine::pushState Jan 10 16:10:39 shd volumio[945]: info: CorePlayQueue::getTrack 0 Jan 10 16:10:39 shd volumio[945]: info: CoreCommandRouter::volumioPushState Jan 10 16:10:39 shd volumio[945]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 10 16:10:39 shd volumiobt[1152]: [38B blob data] Jan 10 16:10:39 shd volumiobt[1152]: Invalid command Jan 10 16:10:39 shd volumiobt[1152]: [bluetooth]# agent on Jan 10 16:10:39 shd volumiobt[1152]: [bluetooth]# discoverable on Jan 10 16:10:39 shd volumiobt[1152]: No default controller available Jan 10 16:10:39 shd volumiobt[1152]: [bluetooth]# pairable on Jan 10 16:10:39 shd volumiobt[1152]: No default controller available Jan 10 16:10:39 shd volumio[945]: info: CoreStateMachine::setRandom true Jan 10 16:10:39 shd volumio[945]: info: CoreStateMachine::pushState Jan 10 16:10:39 shd volumio[945]: info: CorePlayQueue::getTrack 0 Jan 10 16:10:39 shd volumio[945]: info: CoreCommandRouter::volumioPushState Jan 10 16:10:39 shd volumio[945]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 10 16:10:39 shd volumiobt[1152]: [bluetooth]# agent NoInputNoOutput Jan 10 16:10:39 shd volumiobt[1152]: Failed to register agent object Jan 10 16:10:39 shd volumiobt[1152]: [bluetooth]# default-agent Jan 10 16:10:39 shd volumiobt[1152]: No agent is registered Jan 10 16:10:39 shd volumiobt[1152]: [bluetooth]# quit Jan 10 16:10:39 shd volumiobt[1152]: [61B blob data] Jan 10 16:10:39 shd volumiobt[1152]: [62B blob data] Jan 10 16:10:39 shd volumio[1092]: [Vollibrespot] : couldn't parse packet from V4(10.1.100.1:5353): type 47 is invalid Jan 10 16:10:39 shd volumio[945]: info: Raat Daemon started successfully Jan 10 16:10:39 shd volumio[945]: info: Access Token successfully retrieved Jan 10 16:10:39 shd volumio[945]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 10 16:10:39 shd volumio[945]: info: [1768061439973] CoreMusicLibrary::Adding element QOBUZ Jan 10 16:10:39 shd volumio[945]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 10 16:10:39 shd volumio[945]: info: Stopping AccessToken refresher cron for QOBUZ Jan 10 16:10:40 shd volumio[945]: info: AccessToken refresher cron started for QOBUZ Jan 10 16:10:40 shd volumio[945]: info: Executing endpoint restartRAATSocket Jan 10 16:10:40 shd volumio[945]: info: CoreCommandRouter::executeOnPlugin: raat , establishDaemonConnection Jan 10 16:10:40 shd volumio[945]: info: Starting Shairport Sync Jan 10 16:10:40 shd volumio[945]: info: Starting Shairport Sync Jan 10 16:10:40 shd sudo[1231]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 10 16:10:40 shd sudo[1231]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 10 16:10:40 shd volumio[945]: info: Serial Data: Jan 10 16:10:40 shd systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Jan 10 16:10:40 shd systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jan 10 16:10:40 shd volumio[945]: info: msSurfaceDial volumioupdatevolume callback: {"mute":false,"disableVolumeControl":false} Jan 10 16:10:40 shd volumio[945]: info: CoreStateMachine::pushState Jan 10 16:10:40 shd volumio[945]: info: CorePlayQueue::getTrack 0 Jan 10 16:10:40 shd sudo[1233]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 10 16:10:40 shd volumio[945]: info: CoreCommandRouter::volumioPushState Jan 10 16:10:40 shd volumio[945]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 10 16:10:40 shd volumio[945]: info: CoreCommandRouter::executeOnPlugin: raat , updateRoonVolume Jan 10 16:10:40 shd sudo[1231]: pam_unix(sudo:session): session closed for user root Jan 10 16:10:40 shd sudo[1233]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 10 16:10:40 shd volumio[945]: info: Updating RAAT Signal Path Jan 10 16:10:40 shd volumio[945]: info: CorePlayQueue::getTrack 0 Jan 10 16:10:40 shd sudo[1237]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jan 10 16:10:40 shd volumio[945]: info: CoreCommandRouter::volumiosetSourceActiveno-source Jan 10 16:10:40 shd volumio[945]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 10 16:10:40 shd systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jan 10 16:10:40 shd sudo[1237]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 10 16:10:40 shd systemd[1]: Starting Shairport Sync - AirPlay Audio Receiver... Jan 10 16:10:40 shd systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jan 10 16:10:40 shd sudo[1233]: pam_unix(sudo:session): session closed for user root Jan 10 16:10:40 shd volumio[945]: info: CoreCommandRouter::volumioStop Jan 10 16:10:40 shd volumio[945]: info: CoreStateMachine::stop Jan 10 16:10:40 shd volumio[945]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 10 16:10:40 shd volumio[945]: verbose: UNSET VOLATILE Jan 10 16:10:40 shd volumio[945]: info: Notifying Active Input {"trackType":"input","service":"inputs","title":"TOSLINK","disableUiControls":true,"albumart":"/albumart"} Jan 10 16:10:40 shd volumio[945]: info: msSurfaceDial volumioupdatevolume callback: {"vol":null,"dbVolume":null,"mute":false,"disableVolumeControl":false} Jan 10 16:10:40 shd volumio[945]: info: CoreStateMachine::pushState Jan 10 16:10:40 shd volumio[945]: info: CorePlayQueue::getTrack 0 Jan 10 16:10:40 shd volumio[945]: info: CoreCommandRouter::volumioPushState Jan 10 16:10:40 shd volumio[945]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 10 16:10:40 shd volumio[945]: info: CoreCommandRouter::executeOnPlugin: raat , updateRoonVolume Jan 10 16:10:40 shd volumio[945]: info: Updating RAAT Signal Path Jan 10 16:10:40 shd volumio[945]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 10 16:10:40 shd systemd[1]: Starting UPnP Renderer front-end to MPD... Jan 10 16:10:40 shd systemd[1]: Started UPnP Renderer front-end to MPD. Jan 10 16:10:40 shd sudo[1237]: pam_unix(sudo:session): session closed for user root Jan 10 16:10:40 shd volumio[945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable Jan 10 16:10:40 shd volumio[945]: xcb_connection_has_error() returned true Jan 10 16:10:40 shd sudo[1256]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart raat-daemon.service Jan 10 16:10:40 shd sudo[1256]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 10 16:10:40 shd volumio[945]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 10 16:10:40 shd systemd[1]: Stopping RAAT DAEMON... Jan 10 16:10:40 shd volumio[945]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 10 16:10:40 shd systemd[1]: Starting RAAT DAEMON... Jan 10 16:10:40 shd systemd[1]: Started RAAT DAEMON. Jan 10 16:10:40 shd sudo[1256]: pam_unix(sudo:session): session closed for user root Jan 10 16:10:41 shd volumio[945]: info: Upmpdcli Daemon Started Jan 10 16:10:41 shd volumio-streaming-daemon[1061]: Checking variant in static cache Jan 10 16:10:41 shd volumio[945]: info: Shairport-Sync Started Jan 10 16:10:41 shd volumio[945]: Error adding Membership: Error: addMembership EINVAL Jan 10 16:10:41 shd volumio[945]: info: Shairport-Sync Started Jan 10 16:10:41 shd volumio[945]: info: CoreCommandRouter::servicePushState Jan 10 16:10:41 shd volumio[945]: info: CoreStateMachine::pushState Jan 10 16:10:41 shd volumio[945]: info: CoreCommandRouter::volumioPushState Jan 10 16:10:41 shd volumio[945]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 10 16:10:41 shd volumio[945]: Discovery: adding c96094bd-a322-465c-98e6-a51c19ab2527 Jan 10 16:10:41 shd volumio[945]: info: mDNS: Found device shd Jan 10 16:10:41 shd volumio[945]: info: CoreCommandRouter::volumioGetState Jan 10 16:10:41 shd volumio[945]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 10 16:10:41 shd volumio[945]: Error: The value NaN is not a number Jan 10 16:10:41 shd volumio[945]: at Config.forceToType (/volumio/node_modules/v-conf/index.js:322:20) Jan 10 16:10:41 shd volumio[945]: at Config.set (/volumio/node_modules/v-conf/index.js:153:25) Jan 10 16:10:41 shd volumio[945]: at ControllerVolumioDiscovery.pushMultiRoomStatusUpdate (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:287:25) Jan 10 16:10:41 shd volumio[945]: at ControllerVolumioDiscovery.connectToRemoteVolumio (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:276:10) Jan 10 16:10:41 shd volumio[945]: at Browser. (/volumio/app/plugins/system_controller/volumiodiscovery/index.js:202:12) Jan 10 16:10:41 shd volumio[945]: at emitTwo (events.js:126:13) Jan 10 16:10:41 shd volumio[945]: at Browser.emit (events.js:214:7) Jan 10 16:10:41 shd volumio[945]: at on_resolver_done (/volumio/node_modules/mdns/lib/browser.js:31:14) Jan 10 16:10:41 shd volumio[945]: at next (/volumio/node_modules/mdns/lib/browser.js:104:7) Jan 10 16:10:41 shd volumio[945]: at /volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:160:11 Jan 10 16:10:41 shd volumio[945]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:108:7) Jan 10 16:10:41 shd volumio[945]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) Jan 10 16:10:41 shd volumio[945]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 10 16:10:42 shd sudo[1277]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-01-10 16:09 Jan 10 16:10:42 shd sudo[1277]: 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"