May 30 11:50:13 office go-librespot[20379]: time="2026-05-30T11:50:13-04:00" level=trace msg="sent dealer ping" May 30 11:50:13 office go-librespot[20379]: time="2026-05-30T11:50:13-04:00" level=trace msg="received dealer pong" May 30 11:50:27 office volumio5-onboarding[1708]: time=2026-05-30T11:50:27.069-04:00 level=INFO msg="app ready event" component=server event=CLIENT_EVENT_TYPE_APP_READY peer="192.168.5.150:41648 @ 0x2f68120" latency=114.023678ms platform=PLATFORM_ANDROID version=5.260413.0 May 30 11:50:27 office volumio5-onboarding[1708]: time=2026-05-30T11:50:27.070-04:00 level=INFO msg="device data request" component=server type=REQUEST_TYPE_DEVICE_DATA peer="192.168.5.150:41648 @ 0x2f68120" latency=113.836071ms timeout=10s May 30 11:50:27 office volumio5-onboarding[1708]: time=2026-05-30T11:50:27.070-04:00 level=INFO msg="emitting device capabilities changed event" component=server peer="192.168.5.150:41648 @ 0x2f68120" May 30 11:50:27 office volumio[20146]: info: Received Get System Info May 30 11:50:27 office volumio[20146]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 30 11:50:27 office volumio[20146]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 30 11:50:27 office volumio[20146]: info: Discovery: Getting this device information May 30 11:50:27 office volumio[20146]: info: CoreCommandRouter::volumioGetState May 30 11:50:27 office volumio[20146]: info: CorePlayQueue::getTrack 0 May 30 11:50:27 office volumio[20146]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 30 11:50:27 office volumio5-onboarding[1708]: time=2026-05-30T11:50:27.075-04:00 level=INFO msg="emitting device name changed event" component=server peer="192.168.5.150:41648 @ 0x2f68120" name=office May 30 11:50:27 office volumio5-onboarding[1708]: time=2026-05-30T11:50:27.077-04:00 level=INFO msg="emitting device language changed event" component=server peer="192.168.5.150:41648 @ 0x2f68120" language=en May 30 11:50:27 office volumio[20146]: info: CoreCommandRouter::executeOnPlugin: system , getCurrentTimezone May 30 11:50:27 office volumio5-onboarding[1708]: time=2026-05-30T11:50:27.080-04:00 level=INFO msg="emitting device timezone changed event" component=server peer="192.168.5.150:41648 @ 0x2f68120" timezone=America/New_York May 30 11:50:27 office volumio5-onboarding[1708]: time=2026-05-30T11:50:27.080-04:00 level=INFO msg="emitting ethernet info changed event" component=server peer="192.168.5.150:41648 @ 0x2f68120" available=false connected=false macAddress= ip4Address= ip6Address= May 30 11:50:27 office volumio5-onboarding[1708]: time=2026-05-30T11:50:27.091-04:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.5.150:41648 @ 0x2f68120" available=true connected=true macAddress=d8:3a:dd:63:bb:72 ip4Address=192.168.5.198/22 ip6Address= ssid="This LAN is my LAN" May 30 11:50:27 office volumio5-onboarding[1708]: time=2026-05-30T11:50:27.092-04:00 level=INFO msg="emitting device setup status changed event" component=server peer="192.168.5.150:41648 @ 0x2f68120" setupComplete=true May 30 11:50:27 office volumio[20146]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getExtendedOutputDevices May 30 11:50:27 office volumio[20146]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions May 30 11:50:27 office volumio[20146]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 30 11:50:27 office volumio[20146]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 30 11:50:27 office volumio[20146]: amixer -c 0 info | grep "bcm2835 ALSA" May 30 11:50:27 office volumio[20146]: amixer -c 1 info | grep "bcm2835 Headphones" May 30 11:50:27 office volumio[20146]: Card sysdefault:1 'Headphones'/'bcm2835 Headphones' May 30 11:50:27 office volumio[20146]: amixer -c 2 info | grep "snd_rpi_hifiberry_dac" May 30 11:50:27 office volumio[20146]: Card sysdefault:2 'sndrpihifiberry'/'snd_rpi_hifiberry_dac' May 30 11:50:27 office volumio[20146]: error: Cannot read Audio Device Capabilities Command failed: /usr/local/bin/alsacap -C 2 May 30 11:50:27 office volumio[20146]: /bin/sh: 1: /usr/local/bin/alsacap: not found May 30 11:50:27 office volumio[20146]: {"cmd":"/usr/local/bin/alsacap -C 2","code":127,"killed":false,"signal":null,"stack":"Error: Command failed: /usr/local/bin/alsacap -C 2\n/bin/sh: 1: /usr/local/bin/alsacap: not found\n\n at ChildProcess.exithandler (node:child_process:421:12)\n at ChildProcess.emit (node:events:514:28)\n at maybeClose (node:internal/child_process:1105:16)\n at Socket. (node:internal/child_process:457:11)\n at Socket.emit (node:events:514:28)\n at Pipe. (node:net:337:12)"} May 30 11:50:27 office volumio[20146]: amixer -c 2 info | grep "HiFiBerry DAC" May 30 11:50:27 office volumio5-onboarding[1708]: time=2026-05-30T11:50:27.309-04:00 level=INFO msg="emitting audio outputs changed event" component=server peer="192.168.5.150:41648 @ 0x2f68120" selectedOutputId=2 May 30 11:50:27 office volumio[20146]: info: Received Get System Info May 30 11:50:27 office volumio[20146]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 30 11:50:27 office volumio[20146]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 30 11:50:27 office volumio[20146]: info: Discovery: Getting this device information May 30 11:50:27 office volumio[20146]: info: CoreCommandRouter::volumioGetState May 30 11:50:27 office volumio[20146]: info: CorePlayQueue::getTrack 0 May 30 11:50:27 office volumio[20146]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 30 11:50:27 office volumio5-onboarding[1708]: time=2026-05-30T11:50:27.335-04:00 level=INFO msg="emitting software info changed event" component=server peer="192.168.5.150:41648 @ 0x2f68120" currentVersion=4.119 latestVersion=4.119 May 30 11:50:27 office volumio5-onboarding[1708]: time=2026-05-30T11:50:27.335-04:00 level=INFO msg="emitting software update progress event" component=server peer="192.168.5.150:41648 @ 0x2f68120" status=UPDATE_STATUS_NONE progress=0 May 30 11:50:27 office volumio5-onboarding[1708]: time=2026-05-30T11:50:27.336-04:00 level=INFO msg="emitting user changed event" component=server peer="192.168.5.150:41648 @ 0x2f68120" userId=kNrz0csLRFelNwGcoyWol2kyTmv1 May 30 11:50:27 office volumio5-onboarding[1708]: time=2026-05-30T11:50:27.336-04:00 level=INFO msg="emitting music providers changed event" component=server peer="192.168.5.150:41648 @ 0x2f68120" providers=9 May 30 11:50:27 office volumio5-onboarding[1708]: time=2026-05-30T11:50:27.337-04:00 level=INFO msg="emitting plugins changed event" component=server peer="192.168.5.150:41648 @ 0x2f68120" plugins=67 May 30 11:50:27 office volumio[20146]: info: CoreCommandRouter::volumioGetState May 30 11:50:27 office volumio[20146]: info: CorePlayQueue::getTrack 0 May 30 11:50:27 office volumio5-onboarding[1708]: time=2026-05-30T11:50:27.343-04:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.5.150:41648 @ 0x2f68120" state=STATUS_STOPPED positionMs=0 volume=0 May 30 11:50:27 office volumio5-onboarding[1708]: time=2026-05-30T11:50:27.343-04:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.5.150:41648 @ 0x2f68120" id="https://navidrome.tomruffner.com/rest/stream.view?id=QqS3BrIZ8MeQkUFyYNKRwc&format=raw&u=tomruffner&t=444f46cf8ac35122d98d72719341a750&s=54JKJ&v=1.10.2&f=json&c=volusonic" title="Hyperpower (TweakerRay ReMix 2026)" May 30 11:50:27 office sudo[29010]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 30 11:50:27 office sudo[29010]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 30 11:50:28 office sudo[29012]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 30 11:50:28 office sudo[29012]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 30 11:50:28 office sudo[29012]: pam_unix(sudo:session): session closed for user root May 30 11:50:28 office sudo[29010]: pam_unix(sudo:session): session closed for user root May 30 11:50:28 office volumio[20146]: verbose: New Socket.io Connection to 192.168.5.198 from 192.168.5.150 UA: Mozilla/5.0 (Linux; Android 16; SM-S916U Build/BP4A.251205.006; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/148.0.7778.178 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 May 30 11:50:28 office sudo[29019]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 30 11:50:28 office sudo[29019]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 30 11:50:28 office sudo[29021]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 30 11:50:28 office sudo[29021]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 30 11:50:28 office sudo[29021]: pam_unix(sudo:session): session closed for user root May 30 11:50:28 office sudo[29019]: pam_unix(sudo:session): session closed for user root May 30 11:50:28 office volumio[20146]: verbose: New Socket.io Connection to 192.168.5.198 from 192.168.5.150 UA: Mozilla/5.0 (Linux; Android 16; SM-S916U Build/BP4A.251205.006; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/148.0.7778.178 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 May 30 11:50:28 office volumio[20146]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 30 11:50:28 office volumio[20146]: info: CoreCommandRouter::volumioGetVisibleSources May 30 11:50:28 office volumio[20146]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 30 11:50:28 office volumio[20146]: info: CoreCommandRouter::volumioGetState May 30 11:50:28 office volumio[20146]: info: CorePlayQueue::getTrack 0 May 30 11:50:28 office volumio[20146]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 30 11:50:28 office volumio[20146]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 30 11:50:28 office volumio[20146]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom May 30 11:50:28 office volumio[20146]: info: Received Get System Info May 30 11:50:28 office volumio[20146]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 30 11:50:28 office volumio[20146]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 30 11:50:28 office volumio[20146]: info: Discovery: Getting this device information May 30 11:50:28 office volumio[20146]: info: CoreCommandRouter::volumioGetState May 30 11:50:28 office volumio[20146]: info: CorePlayQueue::getTrack 0 May 30 11:50:28 office volumio[20146]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 30 11:50:28 office volumio[20146]: info: CoreCommandRouter::volumioGetState May 30 11:50:28 office volumio[20146]: info: CorePlayQueue::getTrack 0 May 30 11:50:28 office volumio[20146]: info: Listing playlists May 30 11:50:28 office volumio[20146]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 30 11:50:28 office volumio[20146]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 30 11:50:28 office volumio[20146]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 30 11:50:28 office bluealsa[840]: bluez.c:1290: Signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded(/org/bluez/hci0/dev_78_39_B2_AA_1A_06, ...) May 30 11:50:30 office volumio[20146]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard May 30 11:50:30 office volumio[20146]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 30 11:50:30 office volumio[20146]: info: Received Get System Info May 30 11:50:30 office volumio[20146]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 30 11:50:30 office volumio[20146]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 30 11:50:30 office volumio[20146]: info: Discovery: Getting this device information May 30 11:50:30 office volumio[20146]: info: CoreCommandRouter::volumioGetState May 30 11:50:30 office volumio[20146]: info: CorePlayQueue::getTrack 0 May 30 11:50:30 office volumio[20146]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 30 11:50:30 office volumio[20146]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 30 11:50:30 office volumio[20146]: info: Received Get System Info May 30 11:50:30 office volumio[20146]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 30 11:50:30 office volumio[20146]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 30 11:50:30 office volumio[20146]: info: Discovery: Getting this device information May 30 11:50:30 office volumio[20146]: info: CoreCommandRouter::volumioGetState May 30 11:50:30 office volumio[20146]: info: CorePlayQueue::getTrack 0 May 30 11:50:30 office volumio[20146]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 30 11:50:36 office volumio[20146]: info: CoreCommandRouter::getUIConfigOnPlugin May 30 11:50:36 office volumio[20146]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam May 30 11:50:37 office volumio[20146]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam May 30 11:50:37 office volumio[20146]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam May 30 11:50:37 office volumio[20146]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs May 30 11:50:37 office volumio[20146]: info: Received Get System Version May 30 11:50:37 office volumio[20146]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 30 11:50:38 office volumio[20146]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 30 11:50:43 office go-librespot[20379]: time="2026-05-30T11:50:43-04:00" level=trace msg="sent dealer ping" May 30 11:50:43 office go-librespot[20379]: time="2026-05-30T11:50:43-04:00" level=trace msg="received dealer pong" May 30 11:50:46 office bluealsa[840]: bluez.c:1290: Signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded(/org/bluez/hci0/dev_6A_5D_6C_A2_6C_9E, ...) May 30 11:50:46 office volumio[20146]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 30 11:50:46 office volumio[20146]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined May 30 11:50:46 office volumio[20146]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates May 30 11:50:46 office volumio[20146]: info: Received Get System Version May 30 11:50:46 office volumio[20146]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 30 11:50:46 office volumio[20146]: info: Received Get System Info May 30 11:50:46 office volumio[20146]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 30 11:50:46 office volumio[20146]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 30 11:50:46 office volumio[20146]: info: Discovery: Getting this device information May 30 11:50:46 office volumio[20146]: info: CoreCommandRouter::volumioGetState May 30 11:50:46 office volumio[20146]: info: CorePlayQueue::getTrack 0 May 30 11:50:46 office volumio[20146]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 30 11:50:53 office volumio[20146]: info: CALLMETHOD: system_controller system saveGeneralSettings [object Object] May 30 11:50:53 office volumio[20146]: info: CoreCommandRouter::executeOnPlugin: system , saveGeneralSettings May 30 11:50:53 office volumio[20146]: info: System name has changed, restarting Shairport Sync May 30 11:50:53 office volumio[20146]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 30 11:50:53 office volumio[20146]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 30 11:50:53 office volumio[20146]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 30 11:50:53 office volumio[20146]: info: Updating MyVolumio device info May 30 11:50:53 office volumio[20146]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 30 11:50:53 office volumio[20146]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 30 11:50:53 office volumio[20146]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 30 11:50:53 office volumio[20146]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 30 11:50:53 office volumio[20146]: info: QobuzConnect: setDeactiveState invoked May 30 11:50:53 office volumio[20146]: info: CoreCommandRouter::volumioGetState May 30 11:50:53 office volumio[20146]: info: CorePlayQueue::getTrack 0 May 30 11:50:53 office vtcs[28511]: [2026-05-30 11:50:53.132] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE May 30 11:50:53 office vtcs[28511]: [2026-05-30 11:50:53.132] [tisoc] [error] [SpkconServer.cpp:378] recv error. socket disconnected May 30 11:50:53 office volumio[20146]: info: Discovery: Restarting Advertising May 30 11:50:53 office volumio[20146]: info: Discovery: Stopping existing advertisement May 30 11:50:53 office sudo[29087]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service May 30 11:50:53 office sudo[29087]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 30 11:50:53 office sudo[29089]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/killall upmpdcli May 30 11:50:53 office sudo[29089]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 30 11:50:53 office sudo[29093]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service May 30 11:50:53 office sudo[29093]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 30 11:50:53 office sudo[29089]: pam_unix(sudo:session): session closed for user root May 30 11:50:53 office volumio[20146]: info: Received Get System Info May 30 11:50:53 office volumio[20146]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 30 11:50:53 office volumio[20146]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 30 11:50:53 office volumio[20146]: info: Discovery: Getting this device information May 30 11:50:53 office volumio[20146]: info: CoreCommandRouter::volumioGetState May 30 11:50:53 office volumio[20146]: info: CorePlayQueue::getTrack 0 May 30 11:50:53 office volumio[20146]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 30 11:50:53 office volumio[20146]: info: Received Get System Info May 30 11:50:53 office volumio[20146]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 30 11:50:53 office volumio[20146]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 30 11:50:53 office volumio[20146]: info: Discovery: Getting this device information May 30 11:50:53 office volumio[20146]: info: CoreCommandRouter::volumioGetState May 30 11:50:53 office volumio[20146]: info: CorePlayQueue::getTrack 0 May 30 11:50:53 office volumio[20146]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 30 11:50:53 office sudo[29100]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service May 30 11:50:53 office sudo[29100]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 30 11:50:53 office volumio5-onboarding[1708]: time=2026-05-30T11:50:53.284-04:00 level=INFO msg="emitting device name changed event" component=server peer="192.168.5.150:41648 @ 0x2f68120" name=vol-office May 30 11:50:53 office volumio[20146]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 30 11:50:53 office volumio[20146]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 30 11:50:53 office volumio[20146]: info: Starting Shairport Sync May 30 11:50:53 office volumio5-onboarding[1708]: time=2026-05-30T11:50:53.351-04:00 level=INFO msg="device name changed, resetting service group" component=discovery/localnet May 30 11:50:53 office sudo[29103]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/hosts May 30 11:50:53 office sudo[29103]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 30 11:50:53 office sudo[29105]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 30 11:50:53 office sudo[29105]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 30 11:50:53 office sudo[29103]: pam_unix(sudo:session): session closed for user root May 30 11:50:53 office volumio[20146]: info: Permissions for /etc/hosts set May 30 11:50:53 office volumio[20146]: info: Hostname now is vol-office May 30 11:50:53 office sudo[29100]: pam_unix(sudo:session): session closed for user root May 30 11:50:53 office systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... May 30 11:50:53 office systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service... May 30 11:50:53 office systemd[1]: shairport-sync.service: Deactivated successfully. May 30 11:50:53 office systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. May 30 11:50:53 office systemd[1]: shairport-sync.service: Consumed 2.902s CPU time. May 30 11:50:53 office systemd[1]: vtcs.service: Deactivated successfully. May 30 11:50:53 office systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service. May 30 11:50:53 office sudo[29109]: volumio : unable to resolve host office: System error May 30 11:50:53 office sudo[29111]: volumio : unable to resolve host office: System error May 30 11:50:53 office sudo[29109]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/hostname vol-office May 30 11:50:53 office sudo[29111]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /etc/avahi/services/ May 30 11:50:53 office sudo[29109]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 30 11:50:53 office sudo[29112]: volumio : unable to resolve host office: System error May 30 11:50:53 office sudo[29111]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 30 11:50:53 office sudo[29111]: pam_unix(sudo:session): session closed for user root May 30 11:50:53 vol-office volumio[20146]: info: Permissions for /etc/avahi/services/volumio.service May 30 11:50:53 vol-office sudo[29109]: pam_unix(sudo:session): session closed for user root May 30 11:50:53 vol-office volumio[20146]: info: Avahi name changed to vol-office May 30 11:50:53 vol-office avahi-daemon[1124]: Files changed, reloading. May 30 11:50:53 vol-office avahi-daemon[1124]: Service group file /services/volumio.service changed, reloading. May 30 11:50:53 vol-office volumio[20146]: info: New hostname set May 30 11:50:53 vol-office sudo[29112]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service May 30 11:50:53 vol-office sudo[29112]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 30 11:50:53 vol-office sudo[29093]: pam_unix(sudo:session): session closed for user root May 30 11:50:53 vol-office sudo[29087]: pam_unix(sudo:session): session closed for user root May 30 11:50:53 vol-office systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. May 30 11:50:53 vol-office sudo[29105]: pam_unix(sudo:session): session closed for user root May 30 11:50:53 vol-office volumio[20146]: info: Shairport-Sync Started May 30 11:50:53 vol-office systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... May 30 11:50:53 vol-office qobuz-connect[28492]: 20260530 11:50:53.779 [28492.28492] INFO SampleApp: Stopping Local configuration server May 30 11:50:53 vol-office bluealsa[840]: bluez.c:1290: Signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded(/org/bluez/hci0/dev_4C_77_DE_02_F8_80, ...) May 30 11:50:54 vol-office volumio[20146]: info: Discovery: A device disappeared from network May 30 11:50:54 vol-office volumio[20146]: info: Discovery: Device office disappeared from network May 30 11:50:54 vol-office volumio[20146]: info: Discovery: A device disappeared from network May 30 11:50:54 vol-office avahi-daemon[1124]: Service "vol-office" (/services/volumio.service) successfully established. May 30 11:50:54 vol-office qobuz-connect[28492]: 20260530 11:50:54.577 [28492.28492] INFO SampleApp: shat down connection on UNIX socket May 30 11:50:54 vol-office volumio[20146]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected May 30 11:50:54 vol-office volumio[20146]: info: QobuzConnect: setDeactiveState invoked May 30 11:50:54 vol-office volumio[20146]: info: CoreCommandRouter::volumioGetState May 30 11:50:54 vol-office volumio[20146]: info: CorePlayQueue::getTrack 0 May 30 11:50:54 vol-office systemd[1]: qobuz-connect.service: Deactivated successfully. May 30 11:50:54 vol-office systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. May 30 11:50:54 vol-office systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. May 30 11:50:54 vol-office sudo[29112]: pam_unix(sudo:session): session closed for user root May 30 11:50:54 vol-office volumio[20146]: info: Executing endpoint qc_getconfig May 30 11:50:54 vol-office volumio[20146]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig May 30 11:50:54 vol-office qobuz-connect[29133]: 20260530 11:50:54.840 [29133.29133] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket May 30 11:50:54 vol-office qobuz-connect[29133]: 20260530 11:50:54.848 [29133.29133] INFO VolumeManager: [0x1446288]: Setting new playback volume: 75 May 30 11:50:54 vol-office qobuz-connect[29133]: 20260530 11:50:54.848 [29133.29133] INFO VolumeManager: [0x1446288]: Setting new mute state: 0 May 30 11:50:54 vol-office qobuz-connect[29133]: 20260530 11:50:54.848 [29133.29133] INFO AudioStreamManager: [0x1445fe0]: Setting new audio download buffer size: 1048576 May 30 11:50:54 vol-office qobuz-connect[29133]: 20260530 11:50:54.848 [29133.29133] INFO QobuzConnect: [0x1446b50]: Client initialized! May 30 11:50:54 vol-office qobuz-connect[29133]: 20260530 11:50:54.848 [29133.29133] INFO SampleApp: Starting Avahi advertising, name: vol-office, service name: _qobuz-connect._tcp May 30 11:50:54 vol-office volumio[20146]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] May 30 11:50:54 vol-office volumio[20146]: info: QobuzConnect: QOBUZ Connect daemon connected May 30 11:50:54 vol-office qobuz-connect[29133]: 20260530 11:50:54.872 [29133.29133] INFO LocalConfigManager: [0x1445d08]: Starting Local Configuration server May 30 11:50:54 vol-office qobuz-connect[29133]: 20260530 11:50:54.872 [29133.29133] INFO SampleApp: Starting Local configuration server May 30 11:50:54 vol-office qobuz-connect[29133]: 20260530 11:50:54.873 [29133.29133] INFO SampleApp: Connected to UNIX socket client 0x1430818 May 30 11:50:54 vol-office qobuz-connect[29133]: 20260530 11:50:54.991 [29133.29133] INFO SampleApp: Playback volume changed: 75 May 30 11:50:54 vol-office volumio[20146]: info: CoreCommandRouter::volumioGetState May 30 11:50:54 vol-office volumio[20146]: info: CorePlayQueue::getTrack 0 May 30 11:50:55 vol-office volumio5-onboarding[1708]: time=2026-05-30T11:50:55.209-04:00 level=INFO msg="service successfully established" component=discovery/localnet May 30 11:50:56 vol-office volumio[20146]: info: TidalConnect service stoped! May 30 11:50:56 vol-office volumio[20146]: info: TidalConnect service stoped! May 30 11:50:56 vol-office volumio[20146]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect May 30 11:50:56 vol-office volumio[20146]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect May 30 11:50:56 vol-office sudo[29163]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service May 30 11:50:56 vol-office sudo[29163]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 30 11:50:56 vol-office systemd[1]: Started vtcs.service - Volumio Tidal Connect Service. May 30 11:50:56 vol-office sudo[29163]: pam_unix(sudo:session): session closed for user root May 30 11:50:57 vol-office volumio[20146]: info: Executing endpoint tc_getconfig May 30 11:50:57 vol-office volumio[20146]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig May 30 11:50:57 vol-office vtcs[29166]: STARTING TidalConnect services, version: 1.6.1 May 30 11:50:57 vol-office vtcs[29166]: [2026-05-30 11:50:57.154] [tisoc] [critical] [DeviceInfo.cpp:52] ioctl error. ret=-1, errno="No such device" May 30 11:50:57 vol-office vtcs[29166]: [2026-05-30 11:50:57.155] [tisoc] [critical] [DeviceInfo.cpp:53] [ASSERT] generateDeviceId(0) May 30 11:50:57 vol-office vtcs[29166]: STARTED TidalConnect services. May 30 11:50:57 vol-office volumio[20146]: info: Executing endpoint tc_connect May 30 11:50:57 vol-office volumio[20146]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect May 30 11:50:57 vol-office volumio[20146]: info: Connecting to TidalConnect May 30 11:50:57 vol-office volumio[20146]: info: CoreCommandRouter::servicePushState May 30 11:50:57 vol-office volumio[20146]: info: CoreStateMachine::pushState May 30 11:50:57 vol-office volumio[20146]: info: CorePlayQueue::getTrack 0 May 30 11:50:57 vol-office volumio[20146]: info: CoreCommandRouter::volumioPushState May 30 11:50:57 vol-office volumio[20146]: info: MRS: Pushing multiroomSync output update for this device May 30 11:50:57 vol-office volumio[20146]: info: MRS: Pushing multiroomSync output May 30 11:50:57 vol-office volumio[20146]: info: CoreCommandRouter::volumioGetState May 30 11:50:57 vol-office volumio[20146]: info: CorePlayQueue::getTrack 0 May 30 11:50:57 vol-office volumio[20146]: info: CorePlayQueue::getTrack 0 May 30 11:50:57 vol-office volumio[20146]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current volusonic Received tidalconnect May 30 11:50:57 vol-office volumio[20146]: info: CoreCommandRouter::servicePushState May 30 11:50:57 vol-office volumio[20146]: info: CoreStateMachine::pushState May 30 11:50:57 vol-office volumio[20146]: info: CorePlayQueue::getTrack 0 May 30 11:50:57 vol-office volumio[20146]: info: CoreCommandRouter::volumioPushState May 30 11:50:57 vol-office volumio[20146]: info: MRS: Pushing multiroomSync output update for this device May 30 11:50:57 vol-office volumio[20146]: info: MRS: Pushing multiroomSync output May 30 11:50:57 vol-office volumio[20146]: info: CoreCommandRouter::volumioGetState May 30 11:50:57 vol-office volumio[20146]: info: CorePlayQueue::getTrack 0 May 30 11:50:57 vol-office volumio[20146]: info: CorePlayQueue::getTrack 0 May 30 11:50:57 vol-office volumio[20146]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current volusonic Received tidalconnect May 30 11:50:57 vol-office volumio5-onboarding[1708]: time=2026-05-30T11:50:57.192-04:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.5.150:41648 @ 0x2f68120" state=STATUS_STOPPED positionMs=0 volume=0 May 30 11:50:57 vol-office volumio5-onboarding[1708]: time=2026-05-30T11:50:57.192-04:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.5.150:41648 @ 0x2f68120" id="https://navidrome.tomruffner.com/rest/stream.view?id=QqS3BrIZ8MeQkUFyYNKRwc&format=raw&u=tomruffner&t=444f46cf8ac35122d98d72719341a750&s=54JKJ&v=1.10.2&f=json&c=volusonic" title="Hyperpower (TweakerRay ReMix 2026)" May 30 11:50:57 vol-office volumio5-onboarding[1708]: time=2026-05-30T11:50:57.193-04:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.5.150:41648 @ 0x2f68120" state=STATUS_STOPPED positionMs=0 volume=0 May 30 11:50:57 vol-office volumio5-onboarding[1708]: time=2026-05-30T11:50:57.194-04:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.5.150:41648 @ 0x2f68120" id="https://navidrome.tomruffner.com/rest/stream.view?id=QqS3BrIZ8MeQkUFyYNKRwc&format=raw&u=tomruffner&t=444f46cf8ac35122d98d72719341a750&s=54JKJ&v=1.10.2&f=json&c=volusonic" title="Hyperpower (TweakerRay ReMix 2026)" May 30 11:50:58 vol-office volumio[20146]: info: Discovery: Started advertising with name: vol-office May 30 11:50:59 vol-office volumio[20146]: info: Discovery: adding 6dfb85d2-b8fd-4e04-98f0-95f8830468d8 May 30 11:50:59 vol-office volumio[20146]: info: Discovery: Found device vol-office May 30 11:50:59 vol-office volumio[20146]: info: CoreCommandRouter::volumioGetState May 30 11:50:59 vol-office volumio[20146]: info: CorePlayQueue::getTrack 0 May 30 11:50:59 vol-office volumio[20146]: info: Discovery: this is already registered, 6dfb85d2-b8fd-4e04-98f0-95f8830468d8 May 30 11:50:59 vol-office volumio[20146]: info: Discovery: Found device vol-office May 30 11:50:59 vol-office volumio[20146]: info: CoreCommandRouter::volumioGetState May 30 11:50:59 vol-office volumio[20146]: info: CorePlayQueue::getTrack 0 May 30 11:50:59 vol-office volumio[20146]: verbose: New Socket.io Connection to 192.168.5.198:3000 from 192.168.5.197 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 11 May 30 11:50:59 vol-office volumio[20146]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket May 30 11:50:59 vol-office volumio[20146]: error: Failed to update MyVolumio device: {"message":"Unauthenticated"} May 30 11:50:59 vol-office volumio[20146]: info: CoreCommandRouter::volumioGetState May 30 11:50:59 vol-office volumio[20146]: info: CorePlayQueue::getTrack 0 May 30 11:50:59 vol-office volumio[20146]: info: TidalConnect service started! May 30 11:51:00 vol-office volumio[20146]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 30 11:51:00 vol-office volumio[20146]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 30 11:51:00 vol-office volumio[20146]: info: Discovery: Getting this device information May 30 11:51:00 vol-office volumio[20146]: info: CoreCommandRouter::volumioGetState May 30 11:51:00 vol-office volumio[20146]: info: CorePlayQueue::getTrack 0 May 30 11:51:00 vol-office volumio[20146]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 30 11:51:00 vol-office volumio[20146]: verbose: New Socket.io Connection to 192.168.5.198:3000 from 192.168.5.150 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 12 May 30 11:51:00 vol-office volumio[20146]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 30 11:51:00 vol-office volumio[20146]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 30 11:51:03 vol-office sudo[29187]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/samba/smb.conf May 30 11:51:03 vol-office sudo[29189]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /data/INTERNAL May 30 11:51:03 vol-office sudo[29187]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 30 11:51:03 vol-office sudo[29189]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 30 11:51:03 vol-office sudo[29189]: pam_unix(sudo:session): session closed for user root May 30 11:51:03 vol-office volumio[20146]: info: Internal perms successfully set May 30 11:51:03 vol-office sudo[29187]: pam_unix(sudo:session): session closed for user root May 30 11:51:03 vol-office volumio[20146]: info: smb.conf Permissions set May 30 11:51:03 vol-office sudo[29193]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart nmbd.service May 30 11:51:03 vol-office sudo[29193]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 30 11:51:03 vol-office sudo[29196]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 30 11:51:03 vol-office sudo[29196]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 30 11:51:03 vol-office systemd[1]: Stopping nmbd.service - Samba NMB Daemon... May 30 11:51:03 vol-office nmbd[28570]: [2026/05/30 11:51:03.346138, 0] ../../source3/nmbd/asyncdns.c:158(start_async_dns) May 30 11:51:03 vol-office nmbd[28570]: started asyncdns process 29202 May 30 11:51:03 vol-office sudo[29198]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 30 11:51:03 vol-office sudo[29198]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 30 11:51:03 vol-office sudo[29198]: pam_unix(sudo:session): session closed for user root May 30 11:51:03 vol-office sudo[29203]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service May 30 11:51:03 vol-office sudo[29203]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 30 11:51:03 vol-office sudo[29196]: pam_unix(sudo:session): session closed for user root May 30 11:51:03 vol-office sudo[29203]: pam_unix(sudo:session): session closed for user root May 30 11:51:03 vol-office volumio[20146]: info: Upmpdcli Daemon Started May 30 11:51:04 vol-office bluealsa[840]: bluez.c:1393: Signal: org.freedesktop.DBus.ObjectManager.InterfacesRemoved(/org/bluez/hci0/dev_78_39_B2_AA_1A_06, ...) May 30 11:51:07 vol-office bluealsa[840]: bluez.c:1290: Signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded(/org/bluez/hci0/dev_68_F7_F3_A0_50_13, ...) May 30 11:51:13 vol-office go-librespot[20379]: time="2026-05-30T11:51:13-04:00" level=trace msg="sent dealer ping" May 30 11:51:13 vol-office go-librespot[20379]: time="2026-05-30T11:51:13-04:00" level=trace msg="received dealer pong" May 30 11:51:18 vol-office bluealsa[840]: bluez.c:1290: Signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded(/org/bluez/hci0/dev_51_24_06_EA_D2_01, ...) May 30 11:51:22 vol-office bluealsa[840]: bluez.c:1393: Signal: org.freedesktop.DBus.ObjectManager.InterfacesRemoved(/org/bluez/hci0/dev_6A_5D_6C_A2_6C_9E, ...) May 30 11:51:29 vol-office bluealsa[840]: bluez.c:1290: Signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded(/org/bluez/hci0/dev_63_A5_66_16_FB_C0, ...) May 30 11:51:29 vol-office bluealsa[840]: bluez.c:1393: Signal: org.freedesktop.DBus.ObjectManager.InterfacesRemoved(/org/bluez/hci0/dev_4C_77_DE_02_F8_80, ...) May 30 11:51:40 vol-office bluealsa[840]: bluez.c:1290: Signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded(/org/bluez/hci0/dev_67_97_2D_C3_B4_83, ...) May 30 11:51:42 vol-office go-librespot[20379]: time="2026-05-30T11:51:42-04:00" level=trace msg="received accesspoint ping" May 30 11:51:43 vol-office go-librespot[20379]: time="2026-05-30T11:51:43-04:00" level=trace msg="sent dealer ping" May 30 11:51:43 vol-office go-librespot[20379]: time="2026-05-30T11:51:43-04:00" level=error msg="did not receive last pong ack from accesspoint, 120s passed" May 30 11:51:43 vol-office go-librespot[20379]: time="2026-05-30T11:51:43-04:00" level=error msg="failed receiving packet" error="failed reading packet header: read tcp 192.168.5.198:58448->34.158.255.62:443: use of closed network connection" May 30 11:51:43 vol-office volumio[20146]: info: Discovery: Disconnected from remote: 192.168.5.197 May 30 11:51:43 vol-office go-librespot[20379]: time="2026-05-30T11:51:43-04:00" level=trace msg="received dealer pong" May 30 11:51:43 vol-office go-librespot[20379]: time="2026-05-30T11:51:43-04:00" level=debug msg="connected to ap-gue1.spotify.com:80" May 30 11:51:43 vol-office go-librespot[20379]: time="2026-05-30T11:51:43-04:00" level=debug msg="completed keyexchange" May 30 11:51:43 vol-office go-librespot[20379]: time="2026-05-30T11:51:43-04:00" level=debug msg="completed challenge" May 30 11:51:43 vol-office go-librespot[20379]: time="2026-05-30T11:51:43-04:00" level=info msg="authenticated AP" username="to******er" May 30 11:51:43 vol-office go-librespot[20379]: time="2026-05-30T11:51:43-04:00" level=debug msg="re-established accesspoint connection" May 30 11:51:43 vol-office go-librespot[20379]: time="2026-05-30T11:51:43-04:00" level=trace msg="received accesspoint ping" May 30 11:51:43 vol-office go-librespot[20379]: time="2026-05-30T11:51:43-04:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" May 30 11:51:43 vol-office go-librespot[20379]: time="2026-05-30T11:51:43-04:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" May 30 11:51:43 vol-office go-librespot[20379]: time="2026-05-30T11:51:43-04:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" May 30 11:51:43 vol-office go-librespot[20379]: time="2026-05-30T11:51:43-04:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" May 30 11:51:43 vol-office go-librespot[20379]: time="2026-05-30T11:51:43-04:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 481" May 30 11:51:43 vol-office bluealsa[840]: bluez.c:1393: Signal: org.freedesktop.DBus.ObjectManager.InterfacesRemoved(/org/bluez/hci0/dev_68_F7_F3_A0_50_13, ...) May 30 11:51:43 vol-office go-librespot[20379]: time="2026-05-30T11:51:43-04:00" level=trace msg="received accesspoint pong ack" May 30 11:51:44 vol-office volumio[20146]: info: Discovery: Remote connection error: 192.168.5.197 May 30 11:51:44 vol-office volumio[20146]: info: Discovery: A device disappeared from network May 30 11:51:44 vol-office volumio[20146]: info: Discovery: Device deck disappeared from network May 30 11:51:53 vol-office bluealsa[840]: bluez.c:1290: Signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded(/org/bluez/hci0/dev_57_CB_41_D1_44_58, ...) May 30 11:51:53 vol-office bluealsa[840]: bluez.c:1393: Signal: org.freedesktop.DBus.ObjectManager.InterfacesRemoved(/org/bluez/hci0/dev_51_24_06_EA_D2_01, ...) May 30 11:51:55 vol-office volumio[20146]: info: CALLMETHOD: system_controller system saveGeneralSettings [object Object] May 30 11:51:55 vol-office volumio[20146]: info: CoreCommandRouter::executeOnPlugin: system , saveGeneralSettings May 30 11:51:56 vol-office volumio[20146]: compat.c: read() failed: Resource temporarily unavailable May 30 11:51:56 vol-office volumio[20146]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 30 11:51:56 vol-office volumio[20146]: Error: dns service error: unknown May 30 11:51:56 vol-office volumio[20146]: at MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { May 30 11:51:56 vol-office volumio[20146]: errorCode: -65537 May 30 11:51:56 vol-office volumio[20146]: } May 30 11:51:56 vol-office volumio[20146]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 30 11:51:59 vol-office bluealsa[840]: bluez.c:1290: Signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded(/org/bluez/hci0/dev_56_A7_F4_BD_30_D1, ...) May 30 11:51:59 vol-office sudo[29318]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-05-30 11:50' May 30 11:51:59 vol-office sudo[29318]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:20:52 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="d0c2fd9dbc5e70e58c32413c12353563"