Jun 01 18:54:02 ferrum-broen-241 volumio[1398]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 01 18:54:02 ferrum-broen-241 volumio[1398]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 01 18:54:02 ferrum-broen-241 volumio[1398]: info: Discovery: Getting this device information Jun 01 18:54:02 ferrum-broen-241 volumio[1398]: info: CoreCommandRouter::volumioGetState Jun 01 18:54:02 ferrum-broen-241 volumio[1398]: info: CorePlayQueue::getTrack 0 Jun 01 18:54:02 ferrum-broen-241 volumio[1398]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 01 18:54:02 ferrum-broen-241 volumio[1398]: verbose: New Socket.io Connection to 192.168.1.106:3000 from 192.168.1.109 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 9 Jun 01 18:54:02 ferrum-broen-241 volumio[1398]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 01 18:54:02 ferrum-broen-241 volumio[1398]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 01 18:54:04 ferrum-broen-241 volumio[1398]: info: CoreCommandRouter::volumioGetState Jun 01 18:54:04 ferrum-broen-241 volumio[1398]: info: CorePlayQueue::getTrack 0 Jun 01 18:54:06 ferrum-broen-241 volumio[1398]: info: Executing endpoint metavolumio Jun 01 18:54:06 ferrum-broen-241 volumio[1398]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jun 01 18:54:06 ferrum-broen-241 volumio[1398]: info: Executing endpoint metavolumio Jun 01 18:54:06 ferrum-broen-241 volumio[1398]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jun 01 18:54:06 ferrum-broen-241 volumio[1398]: info: Executing endpoint metavolumio Jun 01 18:54:06 ferrum-broen-241 volumio[1398]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jun 01 18:54:09 ferrum-broen-241 volumio5-onboarding[2157]: time=2026-06-01T18:54:09.517+02:00 level=INFO msg="app ready event" component=server event=CLIENT_EVENT_TYPE_APP_READY peer="192.168.1.109:49807 @ 0x28c3320" latency=-2m9.661439725s platform=PLATFORM_IOS version=5.260413.0 Jun 01 18:54:09 ferrum-broen-241 volumio5-onboarding[2157]: time=2026-06-01T18:54:09.518+02:00 level=INFO msg="device data request" component=server type=REQUEST_TYPE_DEVICE_DATA peer="192.168.1.109:49807 @ 0x28c3320" latency=-2m9.665180115s timeout=10s Jun 01 18:54:09 ferrum-broen-241 volumio5-onboarding[2157]: time=2026-06-01T18:54:09.518+02:00 level=INFO msg="emitting device capabilities changed event" component=server peer="192.168.1.109:49807 @ 0x28c3320" Jun 01 18:54:09 ferrum-broen-241 volumio[1398]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 01 18:54:09 ferrum-broen-241 volumio[1398]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 01 18:54:09 ferrum-broen-241 volumio[1398]: info: Received Get System Info Jun 01 18:54:09 ferrum-broen-241 volumio[1398]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 01 18:54:09 ferrum-broen-241 volumio[1398]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 01 18:54:09 ferrum-broen-241 volumio[1398]: info: Discovery: Getting this device information Jun 01 18:54:09 ferrum-broen-241 volumio[1398]: info: CoreCommandRouter::volumioGetState Jun 01 18:54:09 ferrum-broen-241 volumio[1398]: info: CorePlayQueue::getTrack 0 Jun 01 18:54:09 ferrum-broen-241 volumio[1398]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 01 18:54:09 ferrum-broen-241 volumio5-onboarding[2157]: time=2026-06-01T18:54:09.520+02:00 level=INFO msg="emitting device name changed event" component=server peer="192.168.1.109:49807 @ 0x28c3320" name="Ferrum Broen 241" Jun 01 18:54:09 ferrum-broen-241 volumio5-onboarding[2157]: time=2026-06-01T18:54:09.521+02:00 level=INFO msg="emitting device language changed event" component=server peer="192.168.1.109:49807 @ 0x28c3320" language=en Jun 01 18:54:09 ferrum-broen-241 volumio[1398]: info: CoreCommandRouter::executeOnPlugin: system , getCurrentTimezone Jun 01 18:54:09 ferrum-broen-241 volumio5-onboarding[2157]: time=2026-06-01T18:54:09.522+02:00 level=INFO msg="emitting device timezone changed event" component=server peer="192.168.1.109:49807 @ 0x28c3320" timezone=Europe/Warsaw Jun 01 18:54:09 ferrum-broen-241 volumio5-onboarding[2157]: time=2026-06-01T18:54:09.523+02:00 level=INFO msg="emitting ethernet info changed event" component=server peer="192.168.1.109:49807 @ 0x28c3320" available=true connected=false macAddress= ip4Address= ip6Address= Jun 01 18:54:09 ferrum-broen-241 volumio5-onboarding[2157]: time=2026-06-01T18:54:09.525+02:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.1.109:49807 @ 0x28c3320" available=true connected=true macAddress=2c:cf:67:bf:cf:b8 ip4Address=192.168.1.106/24 ip6Address= ssid=Ferrum Jun 01 18:54:09 ferrum-broen-241 volumio5-onboarding[2157]: time=2026-06-01T18:54:09.525+02:00 level=INFO msg="emitting device setup status changed event" component=server peer="192.168.1.109:49807 @ 0x28c3320" setupComplete=true Jun 01 18:54:09 ferrum-broen-241 volumio[1398]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getExtendedOutputDevices Jun 01 18:54:09 ferrum-broen-241 volumio[1398]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 01 18:54:09 ferrum-broen-241 volumio[1398]: error: Cannot read Audio Device Capabilities Command failed: /usr/local/bin/alsacap -C 5 Jun 01 18:54:09 ferrum-broen-241 volumio[1398]: /bin/sh: 1: /usr/local/bin/alsacap: not found Jun 01 18:54:09 ferrum-broen-241 volumio[1398]: {"cmd":"/usr/local/bin/alsacap -C 5","code":127,"killed":false,"signal":null,"stack":"Error: Command failed: /usr/local/bin/alsacap -C 5\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)"} Jun 01 18:54:09 ferrum-broen-241 volumio[1398]: amixer -c 5 info | grep "BROEN synchronous outputs" Jun 01 18:54:09 ferrum-broen-241 volumio[1398]: Card sysdefault:5 'outputs'/'HEM BROEN synchronous outputs at usb-1000480000.usb-1.1, high speed' Jun 01 18:54:09 ferrum-broen-241 volumio[1398]: error: Cannot read Audio Device Capabilities Command failed: /usr/local/bin/alsacap -C 5 Jun 01 18:54:09 ferrum-broen-241 volumio[1398]: /bin/sh: 1: /usr/local/bin/alsacap: not found Jun 01 18:54:09 ferrum-broen-241 volumio[1398]: {"cmd":"/usr/local/bin/alsacap -C 5","code":127,"killed":false,"signal":null,"stack":"Error: Command failed: /usr/local/bin/alsacap -C 5\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)"} Jun 01 18:54:09 ferrum-broen-241 volumio[1398]: amixer -c 5 info | grep "BROEN synchronous outputs" Jun 01 18:54:09 ferrum-broen-241 volumio[1398]: Card sysdefault:5 'outputs'/'HEM BROEN synchronous outputs at usb-1000480000.usb-1.1, high speed' Jun 01 18:54:09 ferrum-broen-241 volumio5-onboarding[2157]: time=2026-06-01T18:54:09.569+02:00 level=INFO msg="emitting audio outputs changed event" component=server peer="192.168.1.109:49807 @ 0x28c3320" selectedOutputId=5 Jun 01 18:54:09 ferrum-broen-241 volumio[1398]: info: Received Get System Info Jun 01 18:54:09 ferrum-broen-241 volumio[1398]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 01 18:54:09 ferrum-broen-241 volumio[1398]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 01 18:54:09 ferrum-broen-241 volumio[1398]: info: Discovery: Getting this device information Jun 01 18:54:09 ferrum-broen-241 volumio[1398]: info: CoreCommandRouter::volumioGetState Jun 01 18:54:09 ferrum-broen-241 volumio[1398]: info: CorePlayQueue::getTrack 0 Jun 01 18:54:09 ferrum-broen-241 volumio[1398]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 01 18:54:09 ferrum-broen-241 volumio5-onboarding[2157]: time=2026-06-01T18:54:09.576+02:00 level=INFO msg="emitting software info changed event" component=server peer="192.168.1.109:49807 @ 0x28c3320" currentVersion=4.158 latestVersion=4.158 Jun 01 18:54:09 ferrum-broen-241 volumio5-onboarding[2157]: time=2026-06-01T18:54:09.576+02:00 level=INFO msg="emitting software update progress event" component=server peer="192.168.1.109:49807 @ 0x28c3320" status=UPDATE_STATUS_NONE progress=0 Jun 01 18:54:09 ferrum-broen-241 volumio5-onboarding[2157]: time=2026-06-01T18:54:09.576+02:00 level=INFO msg="emitting user changed event" component=server peer="192.168.1.109:49807 @ 0x28c3320" userId= Jun 01 18:54:09 ferrum-broen-241 volumio5-onboarding[2157]: time=2026-06-01T18:54:09.576+02:00 level=INFO msg="emitting music providers changed event" component=server peer="192.168.1.109:49807 @ 0x28c3320" providers=3 Jun 01 18:54:09 ferrum-broen-241 volumio[1398]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 01 18:54:09 ferrum-broen-241 volumio5-onboarding[2157]: time=2026-06-01T18:54:09.577+02:00 level=INFO msg="emitting plugins changed event" component=server peer="192.168.1.109:49807 @ 0x28c3320" plugins=0 Jun 01 18:54:09 ferrum-broen-241 volumio[1398]: info: CoreCommandRouter::volumioGetState Jun 01 18:54:09 ferrum-broen-241 volumio[1398]: info: CorePlayQueue::getTrack 0 Jun 01 18:54:09 ferrum-broen-241 volumio5-onboarding[2157]: time=2026-06-01T18:54:09.579+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.109:49807 @ 0x28c3320" state=STATUS_PAUSED positionMs=165625 volume=100 Jun 01 18:54:09 ferrum-broen-241 volumio5-onboarding[2157]: time=2026-06-01T18:54:09.579+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.109:49807 @ 0x28c3320" id="mnt/INTERNAL/music/Adele/Adele - 19 [24_88.2]/01 Daydreamer.aif" title=Daydreamer Jun 01 18:54:09 ferrum-broen-241 volumio5-onboarding[2157]: time=2026-06-01T18:54:09.587+02:00 level=INFO msg="navigate to next page" component=server type=REQUEST_TYPE_CONTINUE_NAVIGATION peer="192.168.1.109:49807,00:00:00:00:00:00%03 @ 0x28c3320" latency=-2m9.66752049s timeout=10s from=APP_PAGE_ROOT to=APP_PAGE_LEGACY_DEVICE Jun 01 18:54:10 ferrum-broen-241 ntpd[1134]: PROTO: 89.161.47.132 unlink local addr 192.168.1.106 -> Jun 01 18:54:18 ferrum-broen-241 sudo[3988]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 01 18:54:18 ferrum-broen-241 sudo[3988]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 01 18:54:18 ferrum-broen-241 sudo[3990]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 01 18:54:18 ferrum-broen-241 sudo[3990]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 01 18:54:18 ferrum-broen-241 sudo[3988]: pam_unix(sudo:session): session closed for user root Jun 01 18:54:18 ferrum-broen-241 sudo[3990]: pam_unix(sudo:session): session closed for user root Jun 01 18:54:18 ferrum-broen-241 volumio[1398]: verbose: New Socket.io Connection to 192.168.1.106 from 192.168.1.109 UA: Mozilla/5.0 (iPad; CPU OS 18_5 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 9 Jun 01 18:54:18 ferrum-broen-241 volumio[1398]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 01 18:54:18 ferrum-broen-241 volumio[1398]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jun 01 18:54:18 ferrum-broen-241 sudo[3994]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 01 18:54:18 ferrum-broen-241 sudo[3994]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 01 18:54:18 ferrum-broen-241 sudo[3994]: pam_unix(sudo:session): session closed for user root Jun 01 18:54:18 ferrum-broen-241 sudo[3997]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 01 18:54:18 ferrum-broen-241 sudo[3997]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 01 18:54:18 ferrum-broen-241 sudo[3997]: pam_unix(sudo:session): session closed for user root Jun 01 18:54:18 ferrum-broen-241 volumio[1398]: verbose: New Socket.io Connection to 192.168.1.106 from 192.168.1.109 UA: Mozilla/5.0 (iPad; CPU OS 18_5 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 10 Jun 01 18:54:19 ferrum-broen-241 volumio[1398]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 01 18:54:19 ferrum-broen-241 volumio[1398]: info: CoreCommandRouter::volumioGetVisibleSources Jun 01 18:54:19 ferrum-broen-241 volumio[1398]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 01 18:54:19 ferrum-broen-241 volumio[1398]: info: CoreCommandRouter::volumioGetState Jun 01 18:54:19 ferrum-broen-241 volumio[1398]: info: CorePlayQueue::getTrack 0 Jun 01 18:54:19 ferrum-broen-241 volumio[1398]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jun 01 18:54:19 ferrum-broen-241 volumio[1398]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 01 18:54:19 ferrum-broen-241 volumio[1398]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Jun 01 18:54:19 ferrum-broen-241 volumio[1398]: info: Received Get System Info Jun 01 18:54:19 ferrum-broen-241 volumio[1398]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 01 18:54:19 ferrum-broen-241 volumio[1398]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 01 18:54:19 ferrum-broen-241 volumio[1398]: info: Discovery: Getting this device information Jun 01 18:54:19 ferrum-broen-241 volumio[1398]: info: CoreCommandRouter::volumioGetState Jun 01 18:54:19 ferrum-broen-241 volumio[1398]: info: CorePlayQueue::getTrack 0 Jun 01 18:54:19 ferrum-broen-241 volumio[1398]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 01 18:54:19 ferrum-broen-241 volumio[1398]: info: CoreCommandRouter::volumioGetState Jun 01 18:54:19 ferrum-broen-241 volumio[1398]: info: CorePlayQueue::getTrack 0 Jun 01 18:54:19 ferrum-broen-241 volumio[1398]: info: Listing playlists Jun 01 18:54:19 ferrum-broen-241 volumio[1398]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jun 01 18:54:19 ferrum-broen-241 volumio[1398]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 01 18:54:19 ferrum-broen-241 volumio[1398]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jun 01 18:54:20 ferrum-broen-241 volumio[1398]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Jun 01 18:54:20 ferrum-broen-241 volumio[1398]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 01 18:54:20 ferrum-broen-241 volumio[1398]: info: Received Get System Info Jun 01 18:54:20 ferrum-broen-241 volumio[1398]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 01 18:54:20 ferrum-broen-241 volumio[1398]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 01 18:54:20 ferrum-broen-241 volumio[1398]: info: Discovery: Getting this device information Jun 01 18:54:20 ferrum-broen-241 volumio[1398]: info: CoreCommandRouter::volumioGetState Jun 01 18:54:20 ferrum-broen-241 volumio[1398]: info: CorePlayQueue::getTrack 0 Jun 01 18:54:20 ferrum-broen-241 volumio[1398]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 01 18:54:39 ferrum-broen-241 volumio[1398]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 01 18:54:39 ferrum-broen-241 volumio[1398]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jun 01 18:54:39 ferrum-broen-241 volumio[1398]: Disk list : [ { device: 'nvme0n1', name: 'NVMe', size: '1.9T' } ] Jun 01 18:54:39 ferrum-broen-241 volumio[1398]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jun 01 18:54:39 ferrum-broen-241 volumio[1398]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jun 01 18:54:39 ferrum-broen-241 volumio[1398]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs Jun 01 18:54:39 ferrum-broen-241 volumio[1398]: info: CoreCommandRouter::executeOnPlugin: ferrumbroencontrol , getAdditionalUiSection Jun 01 18:54:39 ferrum-broen-241 volumio[1398]: info: [HEM] Getting UI Config for section: system Jun 01 18:54:39 ferrum-broen-241 volumio[1398]: info: CoreCommandRouter::executeOnPlugin: inputs , getAdditionalUiSection Jun 01 18:54:39 ferrum-broen-241 volumio[1398]: info: Received Get System Version Jun 01 18:54:39 ferrum-broen-241 volumio[1398]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 01 18:54:42 ferrum-broen-241 volumio[1398]: info: CALLMETHOD: system_controller ferrumbroencontrol saveSystemSettings [object Object] Jun 01 18:54:42 ferrum-broen-241 volumio[1398]: info: CoreCommandRouter::executeOnPlugin: ferrumbroencontrol , saveSystemSettings Jun 01 18:54:42 ferrum-broen-241 volumio[1398]: info: CoreCommandRouter::executeOnPlugin: inputs , sendSerialMessage Jun 01 18:54:42 ferrum-broen-241 volumio[1398]: info: CoreCommandRouter::executeOnPlugin: inputs , sendSerialMessage Jun 01 18:54:42 ferrum-broen-241 volumio[1398]: info: CoreCommandRouter::executeOnPlugin: inputs , sendSerialMessage Jun 01 18:54:42 ferrum-broen-241 volumio[1398]: info: CoreCommandRouter::executeOnPlugin: ferrumbroencontrol , handleCustomCommand Jun 01 18:54:42 ferrum-broen-241 volumio[1398]: info: [HEM] TRIGDIR received: OUTPUT Jun 01 18:54:42 ferrum-broen-241 volumio[1398]: info: CoreCommandRouter::executeOnPlugin: ferrumbroencontrol , handleCustomCommand Jun 01 18:54:42 ferrum-broen-241 volumio[1398]: info: [HEM] ACTLEDDIMM received: 100 Jun 01 18:54:42 ferrum-broen-241 volumio[1398]: info: CoreCommandRouter::executeOnPlugin: ferrumbroencontrol , handleCustomCommand Jun 01 18:54:42 ferrum-broen-241 volumio[1398]: info: [HEM] STBYLEDDIMM received: 10 Jun 01 18:54:45 ferrum-broen-241 volumio[1398]: info: CoreCommandRouter::volumioGetState Jun 01 18:54:45 ferrum-broen-241 volumio[1398]: info: CorePlayQueue::getTrack 0 Jun 01 18:54:47 ferrum-broen-241 volumio[1398]: info: Executing endpoint metavolumio Jun 01 18:54:47 ferrum-broen-241 volumio[1398]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jun 01 18:54:47 ferrum-broen-241 volumio[1398]: info: Executing endpoint metavolumio Jun 01 18:54:47 ferrum-broen-241 volumio[1398]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jun 01 18:54:47 ferrum-broen-241 volumio[1398]: info: Executing endpoint metavolumio Jun 01 18:54:47 ferrum-broen-241 volumio[1398]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jun 01 18:55:02 ferrum-broen-241 volumio[1398]: info: ___________ PLUGINS: Run onVolumioReboot Tasks ___________ Jun 01 18:55:02 ferrum-broen-241 volumio[1398]: info: PLUGIN onReboot : networkfs Jun 01 18:55:02 ferrum-broen-241 sudo[4102]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reboot Jun 01 18:55:02 ferrum-broen-241 sudo[4102]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 01 18:55:02 ferrum-broen-241 systemd-logind[989]: The system will reboot now! Jun 01 18:55:02 ferrum-broen-241 systemd-logind[989]: System is rebooting. Jun 01 18:55:02 ferrum-broen-241 sudo[4102]: pam_unix(sudo:session): session closed for user root Jun 01 18:55:02 ferrum-broen-241 systemd[1]: Removed slice system-modprobe.slice - Slice /system/modprobe. Jun 01 18:55:02 ferrum-broen-241 systemd[1]: Stopped target bluetooth.target - Bluetooth Support. Jun 01 18:55:02 ferrum-broen-241 systemd[1]: Stopped target graphical.target - Graphical Interface. Jun 01 18:55:02 ferrum-broen-241 systemd[1]: Stopped target ip-changed@wlan0.target - IP Address changed on wlan0. Jun 01 18:55:02 ferrum-broen-241 systemd[1]: Stopped target rpc_pipefs.target. Jun 01 18:55:02 ferrum-broen-241 systemd[1]: Stopped target rpcbind.target - RPC Port Mapper. Jun 01 18:55:02 ferrum-broen-241 systemd[1]: Stopped target timers.target - Timer Units. Jun 01 18:55:02 ferrum-broen-241 systemd[1]: apt-daily-upgrade.timer: Deactivated successfully. Jun 01 18:55:02 ferrum-broen-241 systemd[1]: Stopped apt-daily-upgrade.timer - Daily apt upgrade and clean activities. Jun 01 18:55:02 ferrum-broen-241 systemd[1]: apt-daily.timer: Deactivated successfully. Jun 01 18:55:02 ferrum-broen-241 systemd[1]: Stopped apt-daily.timer - Daily apt download activities. Jun 01 18:55:02 ferrum-broen-241 systemd[1]: dpkg-db-backup.timer: Deactivated successfully. Jun 01 18:55:02 ferrum-broen-241 systemd[1]: Stopped dpkg-db-backup.timer - Daily dpkg database backup timer. Jun 01 18:55:02 ferrum-broen-241 systemd[1]: e2scrub_all.timer: Deactivated successfully. Jun 01 18:55:02 ferrum-broen-241 systemd[1]: Stopped e2scrub_all.timer - Periodic ext4 Online Metadata Check for All Filesystems. Jun 01 18:55:02 ferrum-broen-241 systemd[1]: fstrim.timer: Deactivated successfully. Jun 01 18:55:02 ferrum-broen-241 systemd[1]: Stopped fstrim.timer - Discard unused blocks once a week. Jun 01 18:55:02 ferrum-broen-241 systemd[1]: ntpsec-rotate-stats.timer: Deactivated successfully. Jun 01 18:55:02 ferrum-broen-241 systemd[1]: Stopped ntpsec-rotate-stats.timer - Rotate ntpd stats daily. Jun 01 18:55:02 ferrum-broen-241 systemd[1]: setdatetime-helper.timer: Deactivated successfully. Jun 01 18:55:02 ferrum-broen-241 systemd[1]: Stopped setdatetime-helper.timer - Volumio Time Sync Watchdog Timer. Jun 01 18:55:02 ferrum-broen-241 systemd[1]: systemd-tmpfiles-clean.timer: Deactivated successfully. Jun 01 18:55:02 ferrum-broen-241 systemd[1]: Stopped systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Jun 01 18:55:02 ferrum-broen-241 systemd[1]: systemd-rfkill.socket: Deactivated successfully. Jun 01 18:55:02 ferrum-broen-241 systemd[1]: Closed systemd-rfkill.socket - Load/Save RF Kill Switch Status /dev/rfkill Watch. Jun 01 18:55:02 ferrum-broen-241 volumio[1398]: info: Rebooting Jun 01 18:55:02 ferrum-broen-241 systemd[1]: Unmounting run-rpc_pipefs.mount - RPC Pipe File System... Jun 01 18:55:02 ferrum-broen-241 bluealsa[1085]: ../src/ba-adapter.c:144: Freeing adapter: hci0 Jun 01 18:55:02 ferrum-broen-241 systemd[1]: Stopping bluealsa.service - BlueALSA service... Jun 01 18:55:02 ferrum-broen-241 fsctd[2249]: [2026-06-01T16:55:02Z INFO fsct_driver::orchestrator] Orchestrator shutdown requested Jun 01 18:55:02 ferrum-broen-241 fsctd[2249]: [2026-06-01T16:55:02Z INFO fsct_driver::ipc] IPC connection stop requested, id = f2c6699c-29d5-4dec-bf74-96721daf5b2d Jun 01 18:55:02 ferrum-broen-241 fsctd[2249]: [2026-06-01T16:55:02Z INFO fsct_driver::player_manager] Player 1 unregistered Jun 01 18:55:02 ferrum-broen-241 fsctd[2249]: [2026-06-01T16:55:02Z INFO fsct_driver::ipc] IPC connection closed, id = f2c6699c-29d5-4dec-bf74-96721daf5b2d Jun 01 18:55:02 ferrum-broen-241 fsctd[2249]: [2026-06-01T16:55:02Z INFO fsct_driver::ipc] IPC server stopped Jun 01 18:55:02 ferrum-broen-241 systemd[1]: Stopping fsct-driver.service - FSCT driver... Jun 01 18:55:02 ferrum-broen-241 systemd[1]: Stopping mpd.service - Music Player Daemon... Jun 01 18:55:02 ferrum-broen-241 bluetoothd[969]: Endpoint unregistered: sender=:1.6 path=/org/bluez/hci0/A2DP/SBC/source/1 Jun 01 18:55:02 ferrum-broen-241 volumio[1398]: info: [fsct] ipc connection closed Jun 01 18:55:02 ferrum-broen-241 systemd[1]: Starting plymouth-reboot.service - Show Plymouth Reboot Screen... Jun 01 18:55:02 ferrum-broen-241 systemd[1]: rpi-display-backlight.service - Turns off Raspberry Pi display backlight on shutdown/reboot was skipped because of an unmet condition check (ConditionPathIsDirectory=/proc/device-tree/rpi_backlight). Jun 01 18:55:02 ferrum-broen-241 bluetoothd[969]: Endpoint unregistered: sender=:1.6 path=/org/bluez/hci0/A2DP/SBC/sink/2 Jun 01 18:55:02 ferrum-broen-241 systemd[1]: Stopping systemd-random-seed.service - Load/Save Random Seed... Jun 01 18:55:02 ferrum-broen-241 systemd[1]: Stopping volumio5-onboarding.service - Volumio5 Onboarding Server... Jun 01 18:55:02 ferrum-broen-241 bluetoothd[969]: Endpoint unregistered: sender=:1.6 path=/org/bluez/hci0/A2DP/SBC/source/2 Jun 01 18:55:02 ferrum-broen-241 bluetoothd[969]: Endpoint unregistered: sender=:1.6 path=/org/bluez/hci0/A2DP/SBC/sink/1 Jun 01 18:55:02 ferrum-broen-241 bluetoothd[969]: Endpoint unregistered: sender=:1.6 path=/org/bluez/hci0/A2DP/SBC/sink/3 Jun 01 18:55:02 ferrum-broen-241 systemd[1]: Stopping volumiobt.service - Volumio Bluetooth Module... Jun 01 18:55:02 ferrum-broen-241 systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service... Jun 01 18:55:02 ferrum-broen-241 systemd[1]: fsct-driver.service: Deactivated successfully. Jun 01 18:55:02 ferrum-broen-241 systemd[1]: Stopped fsct-driver.service - FSCT driver. Jun 01 18:55:02 ferrum-broen-241 systemd[1]: vtcs.service: Deactivated successfully. Jun 01 18:55:02 ferrum-broen-241 systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service. Jun 01 18:55:02 ferrum-broen-241 systemd[1]: volumio5-onboarding.service: Deactivated successfully. Jun 01 18:55:02 ferrum-broen-241 systemd[1]: Stopped volumio5-onboarding.service - Volumio5 Onboarding Server. Jun 01 18:55:02 ferrum-broen-241 systemd[1]: run-rpc_pipefs.mount: Deactivated successfully. Jun 01 18:55:02 ferrum-broen-241 volumiobt[4112]: INFO [BTSTART] Disconnecting all Bluetooth devices... Jun 01 18:55:02 ferrum-broen-241 systemd[1]: Unmounted run-rpc_pipefs.mount - RPC Pipe File System. Jun 01 18:55:02 ferrum-broen-241 systemd[1]: Received SIGRTMIN+20 from PID 4109 (plymouthd). Jun 01 18:55:02 ferrum-broen-241 systemd[1]: bluealsa.service: Deactivated successfully. Jun 01 18:55:02 ferrum-broen-241 systemd[1]: Stopped bluealsa.service - BlueALSA service. Jun 01 18:55:02 ferrum-broen-241 systemd[1]: systemd-random-seed.service: Deactivated successfully. Jun 01 18:55:02 ferrum-broen-241 systemd[1]: Stopped systemd-random-seed.service - Load/Save Random Seed. Jun 01 18:55:02 ferrum-broen-241 systemd[1]: Started plymouth-reboot.service - Show Plymouth Reboot Screen. Jun 01 18:55:02 ferrum-broen-241 systemd[1]: plymouth-switch-root-initramfs.service - Tell Plymouth To Jump To initramfs was skipped because of an unmet condition check (ConditionPathExists=/run/initramfs/bin/sh). Jun 01 18:55:02 ferrum-broen-241 systemd[1]: mpd.service: Deactivated successfully. Jun 01 18:55:02 ferrum-broen-241 systemd[1]: Stopped mpd.service - Music Player Daemon. Jun 01 18:55:02 ferrum-broen-241 systemd[1]: mpd.service: Consumed 2.381s CPU time. Jun 01 18:55:02 ferrum-broen-241 bluetoothd[969]: Path / reserved for Adv Monitor app :1.34 Jun 01 18:55:02 ferrum-broen-241 bluetoothd[969]: Adv Monitor app :1.34 disconnected from D-Bus Jun 01 18:55:02 ferrum-broen-241 volumiobt[4123]: Attempting to disconnect from 54:61:26:C9:B7:8E Jun 01 18:55:02 ferrum-broen-241 volumiobt[4123]: [NEW] Media /org/bluez/hci0 Jun 01 18:55:02 ferrum-broen-241 volumiobt[4123]: SupportedUUIDs: 0000110a-0000-1000-8000-00805f9b34fb Jun 01 18:55:02 ferrum-broen-241 volumiobt[4123]: SupportedUUIDs: 0000110b-0000-1000-8000-00805f9b34fb Jun 01 18:55:02 ferrum-broen-241 volumiobt[4123]: SupportedUUIDs: 0000FDF0-0000-1000-8000-00805f9b34fb Jun 01 18:55:02 ferrum-broen-241 volumiobt[4123]: [NEW] Player /org/bluez/hci0/dev_38_8A_06_5E_0F_B1/mcp/player0 [default] Jun 01 18:55:02 ferrum-broen-241 bluetoothd[969]: Path / reserved for Adv Monitor app :1.35 Jun 01 18:55:02 ferrum-broen-241 volumiobt[4123]: AdvertisementMonitor path registered Jun 01 18:55:03 ferrum-broen-241 volumiobt[4123]: [CHG] Device 38:8A:06:5E:0F:B1 ServicesResolved: no Jun 01 18:55:03 ferrum-broen-241 volumiobt[4123]: [SIGNAL] org.bluez.Device1.Disconnected org.bluez.Reason.Unknown Unspecified Jun 01 18:55:03 ferrum-broen-241 volumiobt[4123]: [CHG] Device 38:8A:06:5E:0F:B1 Connected: no Jun 01 18:55:03 ferrum-broen-241 volumiobt[4123]: [DEL] Player /org/bluez/hci0/dev_38_8A_06_5E_0F_B1/mcp/player0 [default] Jun 01 18:55:04 ferrum-broen-241 volumio[1398]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 01 18:55:04 ferrum-broen-241 volumio[1398]: Error: write EPIPE Jun 01 18:55:04 ferrum-broen-241 volumio[1398]: at afterWriteDispatched (node:internal/stream_base_commons:160:15) Jun 01 18:55:04 ferrum-broen-241 volumio[1398]: at writeGeneric (node:internal/stream_base_commons:151:3) Jun 01 18:55:04 ferrum-broen-241 volumio[1398]: at Socket._writeGeneric (node:net:952:11) Jun 01 18:55:04 ferrum-broen-241 volumio[1398]: at Socket._write (node:net:964:8) Jun 01 18:55:04 ferrum-broen-241 volumio[1398]: at writeOrBuffer (node:internal/streams/writable:399:12) Jun 01 18:55:04 ferrum-broen-241 volumio[1398]: at _write (node:internal/streams/writable:340:10) Jun 01 18:55:04 ferrum-broen-241 volumio[1398]: at Writable.write (node:internal/streams/writable:344:10) Jun 01 18:55:04 ferrum-broen-241 volumio[1398]: at /volumio/app/plugins/user_interface/ferrum_streaming_control_technology/node_modules/@hemspzoo/fsct-client/dist/index.js:102:19 Jun 01 18:55:04 ferrum-broen-241 volumio[1398]: at new Promise () Jun 01 18:55:04 ferrum-broen-241 volumio[1398]: at Mux.call (/volumio/app/plugins/user_interface/ferrum_streaming_control_technology/node_modules/@hemspzoo/fsct-client/dist/index.js:87:12) Jun 01 18:55:04 ferrum-broen-241 volumio[1398]: at _FsctIpcClient.performHandshake (/volumio/app/plugins/user_interface/ferrum_streaming_control_technology/node_modules/@hemspzoo/fsct-client/dist/index.js:325:28) Jun 01 18:55:04 ferrum-broen-241 volumio[1398]: at _FsctIpcClient.connectToEndpoint (/volumio/app/plugins/user_interface/ferrum_streaming_control_technology/node_modules/@hemspzoo/fsct-client/dist/index.js:316:48) Jun 01 18:55:04 ferrum-broen-241 volumio[1398]: at async connectAndRegister (/volumio/app/plugins/user_interface/ferrum_streaming_control_technology/index.js:120:20) { Jun 01 18:55:04 ferrum-broen-241 volumio[1398]: errno: -32, Jun 01 18:55:04 ferrum-broen-241 volumio[1398]: code: 'EPIPE', Jun 01 18:55:04 ferrum-broen-241 volumio[1398]: syscall: 'write' Jun 01 18:55:04 ferrum-broen-241 volumio[1398]: } Jun 01 18:55:04 ferrum-broen-241 volumio[1398]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 01 18:55:04 ferrum-broen-241 sudo[4139]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-06-01 18:54' Jun 01 18:55:04 ferrum-broen-241 sudo[4139]: 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="ceea798be624bcca033d94ae449c2a749a9724f0" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="9938d7179e3b7c4e41f3e2d60c255985cff08fee" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="ferrumbroen" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri May 22 16:38:09 UTC 2026" VOLUMIO_VERSION="4.158" VOLUMIO_HARDWARE="cm5" VOLUMIO_DEVICENAME="CM5" VOLUMIO_HASH="77cfb2328929483feb27383f4fdb634f"