Jun 01 18:29:56 ferrum-broen-241 ntpd[1139]: CLOCK: time stepped by 354490.550108 Jun 01 18:29:56 ferrum-broen-241 ntpd[1139]: CLOCK: time changed from 2026-05-28 to 2026-06-01 Jun 01 18:29:56 ferrum-broen-241 ntpd[1139]: INIT: MRU 13107 entries, 13 hash bits, 32768 bytes Jun 01 18:29:56 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 01 18:29:56 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 01 18:29:56 ferrum-broen-241 volumiobt[2298]: [176B blob data] Jun 01 18:29:56 ferrum-broen-241 volumiobt[2298]: [157B blob data] Jun 01 18:29:56 ferrum-broen-241 volumiobt[2298]: [157B blob data] Jun 01 18:29:56 ferrum-broen-241 volumiobt[2298]: [157B blob data] Jun 01 18:29:56 ferrum-broen-241 volumiobt[2298]: [113B blob data] Jun 01 18:29:56 ferrum-broen-241 volumiobt[2298]: [bluetoothctl]> discoverable on Jun 01 18:29:56 ferrum-broen-241 volumiobt[2298]: Warning: setting discoverable while discoverable-timeout not set(0) is not recommended Jun 01 18:29:56 ferrum-broen-241 volumiobt[2298]: [bluetoothctl]> pairable on Jun 01 18:29:56 ferrum-broen-241 bluetoothd[961]: Adv Monitor app :1.23 disconnected from D-Bus Jun 01 18:29:56 ferrum-broen-241 volumiobt[2298]: [bluetoothctl]> Jun 01 18:29:56 ferrum-broen-241 volumiobt[2301]: INFO [BTSTART] Registering Bluetooth agent... Jun 01 18:29:56 ferrum-broen-241 volumiobt[2303]: [NEW] Media /org/bluez/hci0 Jun 01 18:29:56 ferrum-broen-241 volumiobt[2303]: SupportedUUIDs: 0000110a-0000-1000-8000-00805f9b34fb Jun 01 18:29:56 ferrum-broen-241 volumiobt[2303]: SupportedUUIDs: 0000110b-0000-1000-8000-00805f9b34fb Jun 01 18:29:56 ferrum-broen-241 volumiobt[2303]: SupportedUUIDs: 0000FDF0-0000-1000-8000-00805f9b34fb Jun 01 18:29:56 ferrum-broen-241 bluetoothd[961]: Adv Monitor app :1.24 disconnected from D-Bus Jun 01 18:29:56 ferrum-broen-241 volumiobt[2304]: No agent is registered Jun 01 18:29:56 ferrum-broen-241 volumiobt[2304]: [NEW] Media /org/bluez/hci0 Jun 01 18:29:56 ferrum-broen-241 volumiobt[2304]: SupportedUUIDs: 0000110a-0000-1000-8000-00805f9b34fb Jun 01 18:29:56 ferrum-broen-241 volumiobt[2304]: SupportedUUIDs: 0000110b-0000-1000-8000-00805f9b34fb Jun 01 18:29:56 ferrum-broen-241 volumiobt[2304]: SupportedUUIDs: 0000FDF0-0000-1000-8000-00805f9b34fb Jun 01 18:29:56 ferrum-broen-241 bluetoothd[961]: Adv Monitor app :1.25 disconnected from D-Bus Jun 01 18:29:56 ferrum-broen-241 volumiobt[2305]: INFO [BTSTART] Agent registered successfully. Jun 01 18:29:56 ferrum-broen-241 volumiobt[2306]: INFO [BTSTART] Starting A2DP agent (a2dp-agent)... Jun 01 18:29:56 ferrum-broen-241 volumio[1420]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Jun 01 18:29:56 ferrum-broen-241 volumio[1420]: ------------------------------------ BT MESSAGE: volumiobt.service started successfully Jun 01 18:29:56 ferrum-broen-241 volumio[1420]: ------------------------------------ BT MESSAGE: [FUNC] dbusStart Jun 01 18:29:56 ferrum-broen-241 sudo[2311]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/xset dpms 0 0 0 Jun 01 18:29:56 ferrum-broen-241 sudo[2311]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 01 18:29:56 ferrum-broen-241 sudo[2311]: pam_unix(sudo:session): session closed for user root Jun 01 18:29:56 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: ferrumbroencontrol , handleCustomCommand Jun 01 18:29:56 ferrum-broen-241 volumio[1420]: info: [HEM] TRIGDIR received: undefined Jun 01 18:29:56 ferrum-broen-241 volumio[1420]: info: [fsct] FSCT Started Jun 01 18:29:56 ferrum-broen-241 volumio[1420]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 4 Jun 01 18:29:56 ferrum-broen-241 volumio[1420]: info: Received Get System Info Jun 01 18:29:56 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 01 18:29:56 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 01 18:29:56 ferrum-broen-241 volumio[1420]: info: Discovery: Getting this device information Jun 01 18:29:56 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::volumioGetState Jun 01 18:29:56 ferrum-broen-241 volumio[1420]: info: CorePlayQueue::getTrack 0 Jun 01 18:29:56 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 01 18:29:56 ferrum-broen-241 volumio5-onboarding[2141]: time=2026-06-01T18:29:56.638+02:00 level=INFO msg="system info for a5eb69faae32081bbb29e69e8cc1749a" deviceName="Ferrum Broen 241" deviceVariant=ferrumbroen deviceModel="Ferrum Broen" softwareVersion=4.158 Jun 01 18:29:56 ferrum-broen-241 volumio[1420]: info: [HEM] Checking for updates. Jun 01 18:29:56 ferrum-broen-241 volumio[1420]: info: [HEM:FirmwareManager] Starting check for all targets... (force=false) Jun 01 18:29:56 ferrum-broen-241 volumio5-onboarding[2141]: time=2026-06-01T18:29:56.650+02:00 level=INFO msg="bootstrapping state" hasInternet=true Jun 01 18:29:56 ferrum-broen-241 volumio[1420]: info: MRS: Pushing audio output on request Jun 01 18:29:56 ferrum-broen-241 volumio[1420]: info: MRS: Pushing multiroomSync output Jun 01 18:29:56 ferrum-broen-241 volumio[1420]: info: Discovery: Connected to remote: 192.168.1.105 Jun 01 18:29:56 ferrum-broen-241 volumio[1420]: info: Starting Shairport Sync Jun 01 18:29:56 ferrum-broen-241 volumio[1420]: info: Starting Shairport Sync Jun 01 18:29:56 ferrum-broen-241 volumio[1420]: info: Starting Shairport Sync Jun 01 18:29:56 ferrum-broen-241 sudo[2317]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 01 18:29:56 ferrum-broen-241 sudo[2317]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 01 18:29:56 ferrum-broen-241 sudo[2316]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 01 18:29:56 ferrum-broen-241 sudo[2316]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 01 18:29:56 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: ferrumbroencontrol , handleCustomCommand Jun 01 18:29:56 ferrum-broen-241 volumio[1420]: info: [HEM] ACTLEDDIMM received: 30 Jun 01 18:29:56 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: ferrumbroencontrol , handleCustomCommand Jun 01 18:29:56 ferrum-broen-241 volumio[1420]: info: [HEM] STBYLEDDIMM received: 10 Jun 01 18:29:56 ferrum-broen-241 volumio[1420]: info: Received Get System Info Jun 01 18:29:56 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 01 18:29:56 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 01 18:29:56 ferrum-broen-241 volumio[1420]: info: Discovery: Getting this device information Jun 01 18:29:56 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::volumioGetState Jun 01 18:29:56 ferrum-broen-241 volumio[1420]: info: CorePlayQueue::getTrack 0 Jun 01 18:29:56 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 01 18:29:56 ferrum-broen-241 sudo[2321]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 01 18:29:56 ferrum-broen-241 sudo[2321]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 01 18:29:56 ferrum-broen-241 volumio[1420]: info: [HEM:FirmwareManager] Target SDDC Bootloader - Current: 0.15.1, Available: 0.15.1 Jun 01 18:29:56 ferrum-broen-241 volumio[1420]: info: [HEM:FirmwareManager] Target SDDC Bootloader is up to date. Jun 01 18:29:56 ferrum-broen-241 volumio[1420]: info: Discovery: A device disappeared from network Jun 01 18:29:56 ferrum-broen-241 systemd[1]: Starting dpkg-db-backup.service - Daily dpkg database backup service... Jun 01 18:29:56 ferrum-broen-241 systemd[1]: Started ntpsec-rotate-stats.service - Rotate ntpd stats. Jun 01 18:29:56 ferrum-broen-241 systemd[1]: ntpsec-rotate-stats.service: Deactivated successfully. Jun 01 18:29:56 ferrum-broen-241 systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Jun 01 18:29:56 ferrum-broen-241 systemd[1]: shairport-sync.service: Deactivated successfully. Jun 01 18:29:56 ferrum-broen-241 systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jun 01 18:29:56 ferrum-broen-241 systemd[1]: shairport-sync.service: Consumed 1.568s CPU time. Jun 01 18:29:56 ferrum-broen-241 systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jun 01 18:29:56 ferrum-broen-241 sudo[2316]: pam_unix(sudo:session): session closed for user root Jun 01 18:29:56 ferrum-broen-241 sudo[2321]: pam_unix(sudo:session): session closed for user root Jun 01 18:29:56 ferrum-broen-241 sudo[2317]: pam_unix(sudo:session): session closed for user root Jun 01 18:29:56 ferrum-broen-241 volumio[1420]: info: Discovery: A device disappeared from network Jun 01 18:29:56 ferrum-broen-241 volumio[1420]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Jun 01 18:29:56 ferrum-broen-241 volumio[1420]: info: Shairport-Sync Started Jun 01 18:29:56 ferrum-broen-241 volumio[1420]: Error adding Membership: Error: addMembership EINVAL Jun 01 18:29:56 ferrum-broen-241 volumio[1420]: info: Shairport-Sync Started Jun 01 18:29:56 ferrum-broen-241 volumio[1420]: info: Discovery: A device disappeared from network Jun 01 18:29:56 ferrum-broen-241 volumio[1420]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Jun 01 18:29:56 ferrum-broen-241 volumio[1420]: info: Shairport-Sync Started Jun 01 18:29:56 ferrum-broen-241 volumio[1420]: info: [HEM:FirmwareManager] Target SDDC Application - Current: 0.3.0, Available: 0.3.0 Jun 01 18:29:56 ferrum-broen-241 volumio[1420]: info: [HEM:FirmwareManager] Target SDDC Application is up to date. Jun 01 18:29:56 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 01 18:29:56 ferrum-broen-241 volumiobt[2307]: 2026-06-01 18:29:56 a2dp-agent [INFO] Connecting to system D-Bus Jun 01 18:29:56 ferrum-broen-241 volumiobt[2307]: 2026-06-01 18:29:56 a2dp-agent [INFO] Connected to system D-Bus Jun 01 18:29:56 ferrum-broen-241 volumiobt[2307]: 2026-06-01 18:29:56 bluezutils [INFO] Found adapter at: /org/bluez/hci0 Jun 01 18:29:56 ferrum-broen-241 volumiobt[2307]: 2026-06-01 18:29:56 a2dp-agent [INFO] Found Bluetooth adapter: /org/bluez/hci0 Jun 01 18:29:56 ferrum-broen-241 volumiobt[2307]: 2026-06-01 18:29:56 a2dp-agent [INFO] Set DiscoverableTimeout to infinite Jun 01 18:29:56 ferrum-broen-241 volumio[1420]: info: [HEM:FirmwareManager] Target MCU - Current: 0.17.0-F.D056-79.4-Release, Available: 0.17.0-F.D056-79.4 Jun 01 18:29:56 ferrum-broen-241 volumiobt[2307]: 2026-06-01 18:29:56 a2dp-agent [INFO] Enabled Discoverable mode Jun 01 18:29:56 ferrum-broen-241 volumio[1420]: info: [HEM:FirmwareManager] Updating MCU... (forced: false) Jun 01 18:29:57 ferrum-broen-241 volumiobt[2307]: 2026-06-01 18:29:57 a2dp-agent [INFO] Agent registered at /local/a2dpagent Jun 01 18:29:57 ferrum-broen-241 volumiobt[2307]: 2026-06-01 18:29:57 a2dp-agent [INFO] Agent set as default Jun 01 18:29:57 ferrum-broen-241 volumiobt[2307]: 2026-06-01 18:29:57 a2dp-agent [INFO] A2DP agent running, waiting for connections... Jun 01 18:29:57 ferrum-broen-241 systemd[1]: dpkg-db-backup.service: Deactivated successfully. Jun 01 18:29:57 ferrum-broen-241 systemd[1]: Finished dpkg-db-backup.service - Daily dpkg database backup service. Jun 01 18:29:57 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::volumioGetState Jun 01 18:29:57 ferrum-broen-241 volumio[1420]: info: CorePlayQueue::getTrack 0 Jun 01 18:29:57 ferrum-broen-241 volumio[1420]: info: [HEM:FirmwareManager:MCU] Starting MCU update sequence Jun 01 18:29:57 ferrum-broen-241 volumio[1420]: info: [HEM:FirmwareManager:MCU] Closing serial port Jun 01 18:29:57 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: inputs , closeSerialPort Jun 01 18:29:57 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::volumioGetState Jun 01 18:29:57 ferrum-broen-241 volumio[1420]: info: CorePlayQueue::getTrack 0 Jun 01 18:29:57 ferrum-broen-241 volumio[1420]: info: Serial port closed Jun 01 18:29:57 ferrum-broen-241 volumio[1420]: info: [HEM:FirmwareManager:MCU] Running update via external tool Jun 01 18:29:57 ferrum-broen-241 volumio[1420]: info: [HEM:FirmwareManager:MCU] McuTarget: Executing command: /volumio/app/plugins/system_controller/ferrumbroencontrol/bin/fstr-fpupdater -p /dev/ttyAMA3 -r /dev/gpiochip0/25/active-high -b /dev/gpiochip0/10/active-high -c 4c04 -B 115200 -f /volumio/app/plugins/system_controller/ferrumbroencontrol/mcu/056-fstr-fpapp-0.17.0-F.D056-79.4+b.300-git.f2afae3b3095d43c7f7da3c069f972a8035c164b-Release.bin Jun 01 18:29:57 ferrum-broen-241 volumio[1420]: info: Discovery: adding b4884cb3-3f42-49f1-9d77-9526ba615462 Jun 01 18:29:57 ferrum-broen-241 volumio[1420]: info: Discovery: Found device Ferrum Broen 241 Jun 01 18:29:57 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::volumioGetState Jun 01 18:29:57 ferrum-broen-241 volumio[1420]: info: CorePlayQueue::getTrack 0 Jun 01 18:29:57 ferrum-broen-241 volumio[1420]: info: Discovery: this is already registered, b4884cb3-3f42-49f1-9d77-9526ba615462 Jun 01 18:29:57 ferrum-broen-241 volumio[1420]: info: Discovery: Found device Ferrum Broen 241 Jun 01 18:29:57 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::volumioGetState Jun 01 18:29:57 ferrum-broen-241 volumio[1420]: info: CorePlayQueue::getTrack 0 Jun 01 18:29:57 ferrum-broen-241 volumio[1420]: info: Discovery: adding 2d86b1a6-8d56-44e8-94b0-19be1a03dc85 Jun 01 18:29:57 ferrum-broen-241 volumio[1420]: info: Discovery: Found device Ferrum Broen 236 Jun 01 18:29:57 ferrum-broen-241 mpd[2218]: 2026-06-01T18:29:57 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jun 01 18:29:57 ferrum-broen-241 systemd[1]: Started mpd.service - Music Player Daemon. Jun 01 18:29:57 ferrum-broen-241 sudo[2097]: pam_unix(sudo:session): session closed for user root Jun 01 18:29:57 ferrum-broen-241 sudo[2061]: pam_unix(sudo:session): session closed for user root Jun 01 18:29:57 ferrum-broen-241 volumio[1420]: error: MPD error: The expression evaluated to a falsy value: Jun 01 18:29:57 ferrum-broen-241 volumio[1420]: assert.ok(self.idling) Jun 01 18:29:57 ferrum-broen-241 volumio[1420]: error: The expression evaluated to a falsy value: Jun 01 18:29:57 ferrum-broen-241 volumio[1420]: assert.ok(self.idling) Jun 01 18:29:57 ferrum-broen-241 volumio[1420]: info: MPD running with PID2218 Jun 01 18:29:57 ferrum-broen-241 volumio[1420]: ,establishing connection Jun 01 18:29:57 ferrum-broen-241 volumio[1420]: error: updateQueue error: null Jun 01 18:29:57 ferrum-broen-241 volumio[1420]: error: updateQueue error: null Jun 01 18:29:58 ferrum-broen-241 volumio[1420]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: polling Total Clients: 6 Jun 01 18:29:58 ferrum-broen-241 volumio[1420]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: polling Total Clients: 7 Jun 01 18:29:58 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 01 18:29:58 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::volumioGetVisibleSources Jun 01 18:29:58 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 01 18:29:58 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::volumioGetState Jun 01 18:29:58 ferrum-broen-241 volumio[1420]: info: CorePlayQueue::getTrack 0 Jun 01 18:29:58 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jun 01 18:29:58 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 01 18:29:58 ferrum-broen-241 volumio[1420]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Jun 01 18:29:58 ferrum-broen-241 volumio[1420]: info: Received Get System Info Jun 01 18:29:58 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 01 18:29:58 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 01 18:29:58 ferrum-broen-241 volumio[1420]: info: Discovery: Getting this device information Jun 01 18:29:58 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::volumioGetState Jun 01 18:29:58 ferrum-broen-241 volumio[1420]: info: CorePlayQueue::getTrack 0 Jun 01 18:29:58 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 01 18:29:58 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::volumioGetState Jun 01 18:29:58 ferrum-broen-241 volumio[1420]: info: CorePlayQueue::getTrack 0 Jun 01 18:29:58 ferrum-broen-241 volumio[1420]: info: Listing playlists Jun 01 18:29:58 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jun 01 18:29:58 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 01 18:29:58 ferrum-broen-241 volumio[1420]: info: TidalConnect service stoped! Jun 01 18:29:59 ferrum-broen-241 volumio[1420]: info: Adding tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jun 01 18:29:59 ferrum-broen-241 volumio[1420]: info: Adding tc_connect REST Endpoint for plugin: music_service/tidalconnect Jun 01 18:29:59 ferrum-broen-241 sudo[2436]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jun 01 18:29:59 ferrum-broen-241 sudo[2436]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 01 18:29:59 ferrum-broen-241 systemd[1]: Started vtcs.service - Volumio Tidal Connect Service. Jun 01 18:29:59 ferrum-broen-241 sudo[2436]: pam_unix(sudo:session): session closed for user root Jun 01 18:29:59 ferrum-broen-241 volumio[1420]: info: Executing endpoint tc_getconfig Jun 01 18:29:59 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Jun 01 18:29:59 ferrum-broen-241 vtcs[2439]: STARTING TidalConnect services, version: 1.6.1 Jun 01 18:29:59 ferrum-broen-241 vtcs[2439]: STARTED TidalConnect services. Jun 01 18:29:59 ferrum-broen-241 volumio[1420]: info: Executing endpoint tc_connect Jun 01 18:29:59 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Jun 01 18:29:59 ferrum-broen-241 volumio[1420]: info: Connecting to TidalConnect Jun 01 18:29:59 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::servicePushState Jun 01 18:29:59 ferrum-broen-241 volumio[1420]: info: CoreStateMachine::pushState Jun 01 18:29:59 ferrum-broen-241 volumio[1420]: info: CorePlayQueue::getTrack 0 Jun 01 18:29:59 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::volumioPushState Jun 01 18:29:59 ferrum-broen-241 volumio[1420]: info: MRS: Pushing multiroomSync output update for this device Jun 01 18:29:59 ferrum-broen-241 volumio[1420]: info: MRS: Pushing multiroomSync output Jun 01 18:29:59 ferrum-broen-241 volumio[1420]: info: CorePlayQueue::getTrack 0 Jun 01 18:29:59 ferrum-broen-241 volumio[1420]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Jun 01 18:29:59 ferrum-broen-241 volumio[1420]: verbose: CURRENT POSITION 0 Jun 01 18:29:59 ferrum-broen-241 volumio[1420]: info: CoreStateMachine::syncState stateService stop Jun 01 18:29:59 ferrum-broen-241 volumio[1420]: info: CoreStateMachine::syncState currentStatus stop Jun 01 18:29:59 ferrum-broen-241 volumio[1420]: info: CoreStateMachine::pushState Jun 01 18:29:59 ferrum-broen-241 volumio[1420]: info: CorePlayQueue::getTrack 0 Jun 01 18:29:59 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 01 18:29:59 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::volumioPushState Jun 01 18:29:59 ferrum-broen-241 volumio[1420]: info: MRS: Pushing multiroomSync output update for this device Jun 01 18:29:59 ferrum-broen-241 volumio[1420]: info: MRS: Pushing multiroomSync output Jun 01 18:29:59 ferrum-broen-241 volumio[1420]: info: No code Jun 01 18:29:59 ferrum-broen-241 volumio[1420]: info: CoreStateMachine::pushState Jun 01 18:29:59 ferrum-broen-241 volumio[1420]: info: CorePlayQueue::getTrack 0 Jun 01 18:29:59 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::volumioPushState Jun 01 18:29:59 ferrum-broen-241 volumio[1420]: info: MRS: Pushing multiroomSync output update for this device Jun 01 18:29:59 ferrum-broen-241 volumio[1420]: info: MRS: Pushing multiroomSync output Jun 01 18:29:59 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::servicePushState Jun 01 18:29:59 ferrum-broen-241 volumio[1420]: info: CoreStateMachine::pushState Jun 01 18:29:59 ferrum-broen-241 volumio[1420]: info: CorePlayQueue::getTrack 0 Jun 01 18:29:59 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::volumioPushState Jun 01 18:29:59 ferrum-broen-241 volumio[1420]: info: MRS: Pushing multiroomSync output update for this device Jun 01 18:29:59 ferrum-broen-241 volumio[1420]: info: MRS: Pushing multiroomSync output Jun 01 18:29:59 ferrum-broen-241 volumio[1420]: info: CorePlayQueue::getTrack 0 Jun 01 18:29:59 ferrum-broen-241 volumio[1420]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Jun 01 18:29:59 ferrum-broen-241 volumio[1420]: verbose: CURRENT POSITION 0 Jun 01 18:29:59 ferrum-broen-241 volumio[1420]: info: CoreStateMachine::syncState stateService stop Jun 01 18:29:59 ferrum-broen-241 volumio[1420]: info: CoreStateMachine::syncState currentStatus stop Jun 01 18:29:59 ferrum-broen-241 volumio[1420]: info: CoreStateMachine::pushState Jun 01 18:29:59 ferrum-broen-241 volumio[1420]: info: CorePlayQueue::getTrack 0 Jun 01 18:29:59 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::volumioPushState Jun 01 18:29:59 ferrum-broen-241 volumio[1420]: info: MRS: Pushing multiroomSync output update for this device Jun 01 18:29:59 ferrum-broen-241 volumio[1420]: info: MRS: Pushing multiroomSync output Jun 01 18:29:59 ferrum-broen-241 volumio[1420]: info: No code Jun 01 18:29:59 ferrum-broen-241 volumio[1420]: info: CoreStateMachine::pushState Jun 01 18:29:59 ferrum-broen-241 volumio[1420]: info: CorePlayQueue::getTrack 0 Jun 01 18:29:59 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::volumioPushState Jun 01 18:29:59 ferrum-broen-241 volumio[1420]: info: MRS: Pushing multiroomSync output update for this device Jun 01 18:29:59 ferrum-broen-241 volumio[1420]: info: MRS: Pushing multiroomSync output Jun 01 18:29:59 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::volumioGetState Jun 01 18:29:59 ferrum-broen-241 volumio[1420]: info: CorePlayQueue::getTrack 0 Jun 01 18:29:59 ferrum-broen-241 sudo[2480]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 01 18:29:59 ferrum-broen-241 sudo[2482]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 01 18:29:59 ferrum-broen-241 sudo[2482]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 01 18:29:59 ferrum-broen-241 sudo[2482]: pam_unix(sudo:session): session closed for user root Jun 01 18:29:59 ferrum-broen-241 sudo[2480]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 01 18:29:59 ferrum-broen-241 sudo[2480]: pam_unix(sudo:session): session closed for user root Jun 01 18:29:59 ferrum-broen-241 sudo[2486]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jun 01 18:29:59 ferrum-broen-241 sudo[2486]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 01 18:30:00 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 01 18:30:00 ferrum-broen-241 volumio[1420]: info: Received Get System Info Jun 01 18:30:00 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 01 18:30:00 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 01 18:30:00 ferrum-broen-241 volumio[1420]: info: Discovery: Getting this device information Jun 01 18:30:00 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::volumioGetState Jun 01 18:30:00 ferrum-broen-241 volumio[1420]: info: CorePlayQueue::getTrack 0 Jun 01 18:30:00 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 01 18:30:00 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Jun 01 18:30:01 ferrum-broen-241 volumio[1420]: info: MRS: Getting audio outputs on start Jun 01 18:30:01 ferrum-broen-241 volumio[1420]: info: MRS: Requesting all other devices output Jun 01 18:30:01 ferrum-broen-241 volumio[1420]: info: MRS: Adding multiroomSync output Jun 01 18:30:01 ferrum-broen-241 volumio[1420]: info: Adding audio output: Jun 01 18:30:01 ferrum-broen-241 volumio[1420]: info: MRS: Pushing multiroomSync output Jun 01 18:30:02 ferrum-broen-241 volumio[1420]: info: TidalConnect service started! Jun 01 18:30:02 ferrum-broen-241 volumio[1420]: info: Completed starting Core Plugins Jun 01 18:30:02 ferrum-broen-241 volumio[1420]: info: ------------------------------------------- Jun 01 18:30:02 ferrum-broen-241 volumio[1420]: info: ----- MyVolumio plugins startup ---- Jun 01 18:30:02 ferrum-broen-241 volumio[1420]: info: ------------------------------------------- Jun 01 18:30:02 ferrum-broen-241 volumio[1420]: info: [MyVolumio PluginManager] Fetching plans data.... Jun 01 18:30:03 ferrum-broen-241 volumio-remote-updater[984]: [2026-06-01 18:30:03] [connect] Successful connection Jun 01 18:30:03 ferrum-broen-241 volumio-remote-updater[984]: [2026-06-01 18:30:03] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=3&transport=websocket&t=1780331403 101 Jun 01 18:30:03 ferrum-broen-241 volumio[1420]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 3 Transport: websocket Total Clients: 8 Jun 01 18:30:04 ferrum-broen-241 systemd[1]: systemd-fsckd.service: Deactivated successfully. Jun 01 18:30:04 ferrum-broen-241 sudo[2490]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 01 18:30:04 ferrum-broen-241 sudo[2492]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 01 18:30:04 ferrum-broen-241 sudo[2492]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 01 18:30:04 ferrum-broen-241 sudo[2490]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 01 18:30:04 ferrum-broen-241 sudo[2492]: pam_unix(sudo:session): session closed for user root Jun 01 18:30:04 ferrum-broen-241 sudo[2490]: pam_unix(sudo:session): session closed for user root Jun 01 18:30:04 ferrum-broen-241 volumio[1420]: verbose: New Socket.io Connection to 192.168.1.106 from 192.168.1.108 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/148.0.0.0 Safari/537.36 Edg/148.0.0.0 Engine version: 3 Transport: polling Total Clients: 9 Jun 01 18:30:05 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 01 18:30:05 ferrum-broen-241 nmbd[1268]: [2026/06/01 18:30:05.111034, 0] ../../source3/nmbd/nmbd_nameregister.c:73(register_name_response) Jun 01 18:30:05 ferrum-broen-241 nmbd[1268]: register_name_response: Answer name <00> differs from question name <00>. Jun 01 18:30:05 ferrum-broen-241 nmbd[1268]: [2026/06/01 18:30:05.111189, 0] ../../source3/nmbd/nmbd_nameregister.c:73(register_name_response) Jun 01 18:30:05 ferrum-broen-241 nmbd[1268]: register_name_response: Answer name <03> differs from question name <03>. Jun 01 18:30:05 ferrum-broen-241 nmbd[1268]: [2026/06/01 18:30:05.111254, 0] ../../source3/nmbd/nmbd_nameregister.c:73(register_name_response) Jun 01 18:30:05 ferrum-broen-241 nmbd[1268]: register_name_response: Answer name <20> differs from question name <20>. Jun 01 18:30:05 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::volumioGetVisibleSources Jun 01 18:30:05 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 01 18:30:05 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::volumioGetState Jun 01 18:30:05 ferrum-broen-241 volumio[1420]: info: CorePlayQueue::getTrack 0 Jun 01 18:30:05 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jun 01 18:30:05 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 01 18:30:05 ferrum-broen-241 volumio[1420]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Jun 01 18:30:05 ferrum-broen-241 volumio[1420]: info: Received Get System Info Jun 01 18:30:05 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 01 18:30:05 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 01 18:30:05 ferrum-broen-241 volumio[1420]: info: Discovery: Getting this device information Jun 01 18:30:05 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::volumioGetState Jun 01 18:30:05 ferrum-broen-241 volumio[1420]: info: CorePlayQueue::getTrack 0 Jun 01 18:30:05 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 01 18:30:05 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::volumioGetState Jun 01 18:30:05 ferrum-broen-241 volumio[1420]: info: CorePlayQueue::getTrack 0 Jun 01 18:30:05 ferrum-broen-241 volumio[1420]: info: Listing playlists Jun 01 18:30:05 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jun 01 18:30:05 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 01 18:30:05 ferrum-broen-241 dhcpcd[948]: timed out Jun 01 18:30:05 ferrum-broen-241 sh[930]: timed out Jun 01 18:30:05 ferrum-broen-241 sh[869]: ifup: failed to bring up eth0 Jun 01 18:30:05 ferrum-broen-241 systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE Jun 01 18:30:05 ferrum-broen-241 systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. Jun 01 18:30:05 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::volumioGetState Jun 01 18:30:05 ferrum-broen-241 volumio[1420]: info: CorePlayQueue::getTrack 0 Jun 01 18:30:06 ferrum-broen-241 systemd[1]: systemd-hostnamed.service: Deactivated successfully. Jun 01 18:30:06 ferrum-broen-241 systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 2. Jun 01 18:30:06 ferrum-broen-241 systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Jun 01 18:30:06 ferrum-broen-241 systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Jun 01 18:30:06 ferrum-broen-241 sudo[2486]: pam_unix(sudo:session): session closed for user root Jun 01 18:30:06 ferrum-broen-241 volumio[1420]: info: Upmpdcli Daemon Started Jun 01 18:30:06 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 01 18:30:06 ferrum-broen-241 volumio[1420]: info: Received Get System Info Jun 01 18:30:06 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 01 18:30:06 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 01 18:30:06 ferrum-broen-241 volumio[1420]: info: Discovery: Getting this device information Jun 01 18:30:06 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::volumioGetState Jun 01 18:30:06 ferrum-broen-241 volumio[1420]: info: CorePlayQueue::getTrack 0 Jun 01 18:30:06 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 01 18:30:06 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Jun 01 18:30:08 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jun 01 18:30:10 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::volumioGetQueue Jun 01 18:30:10 ferrum-broen-241 volumio[1420]: info: CoreStateMachine::getQueue Jun 01 18:30:10 ferrum-broen-241 volumio[1420]: info: CorePlayQueue::getQueue Jun 01 18:30:10 ferrum-broen-241 volumio[1420]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Jun 01 18:30:10 ferrum-broen-241 volumio[1420]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Jun 01 18:30:10 ferrum-broen-241 volumio[1420]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Jun 01 18:30:10 ferrum-broen-241 volumio[1420]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Jun 01 18:30:10 ferrum-broen-241 volumio[1420]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Jun 01 18:30:10 ferrum-broen-241 volumio[1420]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Jun 01 18:30:10 ferrum-broen-241 volumio[1420]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Jun 01 18:30:10 ferrum-broen-241 volumio[1420]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Jun 01 18:30:10 ferrum-broen-241 volumio[1420]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Jun 01 18:30:10 ferrum-broen-241 volumio[1420]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Jun 01 18:30:10 ferrum-broen-241 volumio[1420]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Jun 01 18:30:10 ferrum-broen-241 volumio[1420]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Jun 01 18:30:10 ferrum-broen-241 volumio[1420]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Jun 01 18:30:10 ferrum-broen-241 volumio[1420]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Jun 01 18:30:10 ferrum-broen-241 volumio[1420]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Jun 01 18:30:10 ferrum-broen-241 volumio[1420]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Jun 01 18:30:10 ferrum-broen-241 volumio[1420]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Jun 01 18:30:10 ferrum-broen-241 volumio[1420]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Jun 01 18:30:10 ferrum-broen-241 volumio[1420]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Jun 01 18:30:10 ferrum-broen-241 volumio[1420]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Jun 01 18:30:10 ferrum-broen-241 volumio[1420]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Jun 01 18:30:10 ferrum-broen-241 volumio[1420]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Jun 01 18:30:10 ferrum-broen-241 volumio[1420]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Jun 01 18:30:10 ferrum-broen-241 volumio[1420]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Jun 01 18:30:10 ferrum-broen-241 volumio[1420]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Jun 01 18:30:10 ferrum-broen-241 volumio[1420]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Jun 01 18:30:10 ferrum-broen-241 volumio[1420]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Jun 01 18:30:10 ferrum-broen-241 volumio[1420]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Jun 01 18:30:10 ferrum-broen-241 volumio[1420]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Jun 01 18:30:10 ferrum-broen-241 volumio[1420]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Jun 01 18:30:10 ferrum-broen-241 volumio[1420]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Jun 01 18:30:10 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 01 18:30:10 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 01 18:30:10 ferrum-broen-241 volumio[1420]: info: Starting MyVolumio Remote Streaming Endpoints Jun 01 18:30:10 ferrum-broen-241 volumio[1420]: info: MyVolumio not started Jun 01 18:30:10 ferrum-broen-241 volumio[1420]: info: Initializing device activation check Jun 01 18:30:10 ferrum-broen-241 volumio[1420]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Jun 01 18:30:10 ferrum-broen-241 volumio[1420]: error: [MyVolumio PluginManager] Could not read package.json file: Error: /myvolumio/plugins/music_service/streaming_services//package.json: ENOENT: no such file or directory, open '/myvolumio/plugins/music_service/streaming_services//package.json' Jun 01 18:30:13 ferrum-broen-241 volumio[1420]: info: [HEM:FirmwareManager:MCU] McuTarget updater stdout: Trying to connect to STM32 at serial port: /dev/ttyAMA3 Jun 01 18:30:13 ferrum-broen-241 volumio[1420]: Connected to STM32 device with ID: 0x4c04 Jun 01 18:30:13 ferrum-broen-241 volumio[1420]: Loading firmware file: "/volumio/app/plugins/system_controller/ferrumbroencontrol/mcu/056-fstr-fpapp-0.17.0-F.D056-79.4+b.300-git.f2afae3b3095d43c7f7da3c069f972a8035c164b-Release.bin" Jun 01 18:30:13 ferrum-broen-241 volumio[1420]: Loaded firmware: 42708 bytes Jun 01 18:30:13 ferrum-broen-241 volumio[1420]: Starting firmware update... Jun 01 18:30:13 ferrum-broen-241 volumio[1420]: Verifying firmware... Jun 01 18:30:13 ferrum-broen-241 volumio[1420]: Firmware update successful! Jun 01 18:30:13 ferrum-broen-241 volumio[1420]: info: [HEM:FirmwareManager:MCU] Update tool execution finished Jun 01 18:30:13 ferrum-broen-241 volumio[1420]: info: [HEM:FirmwareManager:MCU] Waiting 1 second for MCU to reboot and reinitialize Jun 01 18:30:13 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::volumioGetState Jun 01 18:30:13 ferrum-broen-241 volumio[1420]: info: CorePlayQueue::getTrack 0 Jun 01 18:30:14 ferrum-broen-241 volumio[1420]: info: [HEM:FirmwareManager:MCU] Reinitializing serial connection Jun 01 18:30:14 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: inputs , initializeSerialPort Jun 01 18:30:14 ferrum-broen-241 volumio[1420]: info: Initializing Serial Communication on port /dev/ttyAMA3 Jun 01 18:30:14 ferrum-broen-241 volumio[1420]: info: [HEM] MCU firmware update completed successfully. Jun 01 18:30:14 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: inputs , sendSerialMessage Jun 01 18:30:14 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: inputs , sendSerialMessage Jun 01 18:30:14 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: inputs , sendSerialMessage Jun 01 18:30:14 ferrum-broen-241 volumio[1420]: info: Serial port opened successfully Jun 01 18:30:14 ferrum-broen-241 volumio[1420]: info: Sending serial start messages Jun 01 18:30:14 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 01 18:30:14 ferrum-broen-241 volumio[1420]: info: Reporting MCU Network Status: 2 Jun 01 18:30:14 ferrum-broen-241 volumio[1420]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Jun 01 18:30:14 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: ferrumbroencontrol , handleCustomCommand Jun 01 18:30:14 ferrum-broen-241 volumio[1420]: info: [HEM] TRIGDIR received: undefined Jun 01 18:30:14 ferrum-broen-241 volumio[1420]: info: MCU Signalled Sleep Mode Disabled Jun 01 18:30:14 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: ferrumbroencontrol , handleCustomCommand Jun 01 18:30:14 ferrum-broen-241 volumio[1420]: info: [HEM] ACTLEDDIMM received: 30 Jun 01 18:30:14 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: ferrumbroencontrol , handleCustomCommand Jun 01 18:30:14 ferrum-broen-241 volumio[1420]: info: [HEM] STBYLEDDIMM received: 10 Jun 01 18:30:14 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: system , setAdditionalSVInfo Jun 01 18:30:14 ferrum-broen-241 volumio[1420]: info: Setting Additional System Software info: Hardware Revision: 1.0, SN: NO_INFO, Firmware Version: 0.17.0-F.D056-79.4-Release Jun 01 18:30:14 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: system , setHwFwVersion Jun 01 18:30:14 ferrum-broen-241 volumio[1420]: info: Setting HW Firmware info: 0.17.0-F.D056-79.4-Release Jun 01 18:30:14 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: system , setHwVersion Jun 01 18:30:14 ferrum-broen-241 volumio[1420]: info: Setting HW Version info: 1.0, SN: NO_INFO Jun 01 18:30:14 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: system , setAdditionalSVInfo Jun 01 18:30:14 ferrum-broen-241 volumio[1420]: info: Setting Additional System Software info: Hardware Revision: 1.0, SN: NO_INFO, Firmware Version: 0.17.0-F.D056-79.4-Release Jun 01 18:30:14 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: system , setHwFwVersion Jun 01 18:30:14 ferrum-broen-241 volumio[1420]: info: Setting HW Firmware info: 0.17.0-F.D056-79.4-Release Jun 01 18:30:14 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: system , setHwVersion Jun 01 18:30:14 ferrum-broen-241 volumio[1420]: info: Setting HW Version info: 1.0, SN: NO_INFO Jun 01 18:30:14 ferrum-broen-241 sudo[2535]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/xset dpms force on Jun 01 18:30:14 ferrum-broen-241 sudo[2535]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 01 18:30:14 ferrum-broen-241 volumio[1420]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Jun 01 18:30:14 ferrum-broen-241 volumio[1420]: info: MCU Signalled Sleep Mode Disabled Jun 01 18:30:14 ferrum-broen-241 volumio[1420]: info: MCU Signalled Auto Boot Mode On Power Active Jun 01 18:30:14 ferrum-broen-241 sudo[2538]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/xset dpms force on Jun 01 18:30:14 ferrum-broen-241 sudo[2538]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 01 18:30:14 ferrum-broen-241 sudo[2535]: pam_unix(sudo:session): session closed for user root Jun 01 18:30:14 ferrum-broen-241 sudo[2538]: pam_unix(sudo:session): session closed for user root Jun 01 18:30:14 ferrum-broen-241 sudo[2541]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/xset dpms 0 0 0 Jun 01 18:30:14 ferrum-broen-241 sudo[2541]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 01 18:30:14 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::volumioGetState Jun 01 18:30:14 ferrum-broen-241 volumio[1420]: info: CorePlayQueue::getTrack 0 Jun 01 18:30:14 ferrum-broen-241 sudo[2541]: pam_unix(sudo:session): session closed for user root Jun 01 18:30:14 ferrum-broen-241 sudo[2543]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/xset dpms 0 0 0 Jun 01 18:30:14 ferrum-broen-241 sudo[2543]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 01 18:30:14 ferrum-broen-241 sudo[2543]: pam_unix(sudo:session): session closed for user root Jun 01 18:30:14 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jun 01 18:30:16 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 01 18:30:16 ferrum-broen-241 volumio[1420]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jun 01 18:30:16 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jun 01 18:30:16 ferrum-broen-241 volumio[1420]: info: Received Get System Version Jun 01 18:30:16 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 01 18:30:16 ferrum-broen-241 volumio[1420]: info: Received Get System Info Jun 01 18:30:16 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 01 18:30:16 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 01 18:30:16 ferrum-broen-241 volumio[1420]: info: Discovery: Getting this device information Jun 01 18:30:16 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::volumioGetState Jun 01 18:30:16 ferrum-broen-241 volumio[1420]: info: CorePlayQueue::getTrack 0 Jun 01 18:30:16 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 01 18:30:17 ferrum-broen-241 upmpdcli[2546]: writing RSA key Jun 01 18:30:17 ferrum-broen-241 systemd[1]: Starting e2scrub_all.service - Online ext4 Metadata Check for All Filesystems... Jun 01 18:30:17 ferrum-broen-241 systemd[1]: e2scrub_all.service: Deactivated successfully. Jun 01 18:30:17 ferrum-broen-241 systemd[1]: Finished e2scrub_all.service - Online ext4 Metadata Check for All Filesystems. Jun 01 18:30:19 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 01 18:30:19 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jun 01 18:30:19 ferrum-broen-241 volumio[1420]: Disk list : [ { device: 'nvme0n1', name: 'NVMe', size: '1.9T' } ] Jun 01 18:30:19 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jun 01 18:30:19 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jun 01 18:30:19 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs Jun 01 18:30:19 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: ferrumbroencontrol , getAdditionalUiSection Jun 01 18:30:19 ferrum-broen-241 volumio[1420]: info: [HEM] Getting UI Config for section: system Jun 01 18:30:19 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: inputs , getAdditionalUiSection Jun 01 18:30:19 ferrum-broen-241 volumio[1420]: info: Received Get System Version Jun 01 18:30:19 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 01 18:30:22 ferrum-broen-241 volumio[1420]: error: MyVolumio Plugin failed to start in a timely fashion Jun 01 18:30:22 ferrum-broen-241 volumio[1420]: [Metrics] CommandRouter: 33s 546.51ms Jun 01 18:30:22 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::volumiosetStartupVolume Jun 01 18:30:22 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 01 18:30:22 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 01 18:30:22 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::Close All Modals sent Jun 01 18:30:22 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::Close All Modals sent Jun 01 18:30:23 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 01 18:30:23 ferrum-broen-241 volumio[1420]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jun 01 18:30:23 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jun 01 18:30:23 ferrum-broen-241 volumio[1420]: info: Received Get System Version Jun 01 18:30:23 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 01 18:30:23 ferrum-broen-241 volumio[1420]: info: Received Get System Info Jun 01 18:30:23 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 01 18:30:23 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 01 18:30:23 ferrum-broen-241 volumio[1420]: info: Discovery: Getting this device information Jun 01 18:30:23 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::volumioGetState Jun 01 18:30:23 ferrum-broen-241 volumio[1420]: info: CorePlayQueue::getTrack 0 Jun 01 18:30:23 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 01 18:30:23 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Jun 01 18:30:23 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 01 18:30:23 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Jun 01 18:30:25 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 01 18:30:25 ferrum-broen-241 volumio[1420]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 11 Jun 01 18:30:25 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::volumioGetState Jun 01 18:30:25 ferrum-broen-241 volumio[1420]: info: CorePlayQueue::getTrack 0 Jun 01 18:30:26 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 01 18:30:26 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 01 18:30:26 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 01 18:30:26 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Jun 01 18:30:26 ferrum-broen-241 volumio-remote-updater[984]: Test mode disabled Jun 01 18:30:26 ferrum-broen-241 volumio-remote-updater[984]: Alpha mode disabled Jun 01 18:30:26 ferrum-broen-241 volumio-remote-updater[984]: Alpha legacy test mode disabled Jun 01 18:30:26 ferrum-broen-241 volumio[1420]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Jun 01 18:30:26 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Jun 01 18:30:26 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 01 18:30:26 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 01 18:30:26 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 01 18:30:26 ferrum-broen-241 volumio[1420]: info: Received Get System Info Jun 01 18:30:26 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 01 18:30:26 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 01 18:30:26 ferrum-broen-241 volumio[1420]: info: Discovery: Getting this device information Jun 01 18:30:26 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::volumioGetState Jun 01 18:30:26 ferrum-broen-241 volumio[1420]: info: CorePlayQueue::getTrack 0 Jun 01 18:30:26 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 01 18:30:26 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 01 18:30:26 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 01 18:30:26 ferrum-broen-241 volumio5-onboarding[2141]: time=2026-06-01T18:30:26.338+02:00 level=INFO msg="enabling local network discovery" Jun 01 18:30:26 ferrum-broen-241 volumio5-onboarding[2141]: time=2026-06-01T18:30:26.343+02:00 level=INFO msg="enabling BLE discovery" Jun 01 18:30:27 ferrum-broen-241 volumio5-onboarding[2141]: time=2026-06-01T18:30:27.266+02:00 level=INFO msg="service successfully established" component=discovery/localnet Jun 01 18:30:27 ferrum-broen-241 systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Jun 01 18:30:28 ferrum-broen-241 volumio5-onboarding[2141]: time=2026-06-01T18:30:28.054+02:00 level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.1.102:46652 Jun 01 18:30:28 ferrum-broen-241 systemd[1]: setdatetime-helper.service: Deactivated successfully. Jun 01 18:30:28 ferrum-broen-241 systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Jun 01 18:30:29 ferrum-broen-241 volumio[1420]: info: BOOT COMPLETED Jun 01 18:30:30 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 01 18:30:30 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 01 18:30:30 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Jun 01 18:30:30 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jun 01 18:30:30 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Jun 01 18:30:30 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::volumioGetBrowseSources Jun 01 18:30:30 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 01 18:30:32 ferrum-broen-241 bluealsa[1100]: bluez.c:1290: Signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded(/org/bluez/hci0/dev_50_BC_B0_7C_E1_C0, ...) Jun 01 18:30:33 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::volumioGetState Jun 01 18:30:33 ferrum-broen-241 volumio[1420]: info: CorePlayQueue::getTrack 0 Jun 01 18:30:33 ferrum-broen-241 bluealsa[1100]: bluez.c:1290: Signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded(/org/bluez/hci0/dev_50_BC_B0_7C_E1_C0/service0001, ...) Jun 01 18:30:33 ferrum-broen-241 bluealsa[1100]: bluez.c:1290: Signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded(/org/bluez/hci0/dev_50_BC_B0_7C_E1_C0/service0001/char0002, ...) Jun 01 18:30:33 ferrum-broen-241 bluealsa[1100]: bluez.c:1290: Signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded(/org/bluez/hci0/dev_50_BC_B0_7C_E1_C0/service0001/char0004, ...) Jun 01 18:30:33 ferrum-broen-241 bluealsa[1100]: bluez.c:1290: Signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded(/org/bluez/hci0/dev_50_BC_B0_7C_E1_C0/service0001/char0006, ...) Jun 01 18:30:33 ferrum-broen-241 bluealsa[1100]: bluez.c:1290: Signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded(/org/bluez/hci0/dev_50_BC_B0_7C_E1_C0/service0001/char0008, ...) Jun 01 18:30:33 ferrum-broen-241 bluealsa[1100]: bluez.c:1290: Signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded(/org/bluez/hci0/dev_50_BC_B0_7C_E1_C0/service0014, ...) Jun 01 18:30:33 ferrum-broen-241 bluealsa[1100]: bluez.c:1290: Signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded(/org/bluez/hci0/dev_50_BC_B0_7C_E1_C0/service0014/char0015, ...) Jun 01 18:30:33 ferrum-broen-241 bluealsa[1100]: bluez.c:1290: Signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded(/org/bluez/hci0/dev_50_BC_B0_7C_E1_C0/service0014/char0017, ...) Jun 01 18:30:33 ferrum-broen-241 bluealsa[1100]: bluez.c:1290: Signal: org.freedesktop.DBus.ObjectManager.InterfacesAdded(/org/bluez/hci0/dev_50_BC_B0_7C_E1_C0/service0014/char0019, ...) Jun 01 18:30:35 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 01 18:30:35 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jun 01 18:30:35 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 01 18:30:35 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 01 18:30:35 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 01 18:30:35 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 01 18:30:35 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 01 18:30:35 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 01 18:30:35 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 01 18:30:35 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 01 18:30:35 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 01 18:30:35 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jun 01 18:30:35 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jun 01 18:30:35 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::executeOnPlugin: ferrumbroencontrol , getAdditionalUiSection Jun 01 18:30:35 ferrum-broen-241 volumio[1420]: info: [HEM] Getting UI Config for section: audio Jun 01 18:30:35 ferrum-broen-241 volumio[1420]: info: [HEM] Config value for i2s_predefined_mode: 0 Jun 01 18:30:35 ferrum-broen-241 volumio[1420]: info: [HEM] Config value for i2s_format: standard Jun 01 18:30:35 ferrum-broen-241 volumio[1420]: info: [HEM] Config value for i2s_pcm_slot_size: bits32 Jun 01 18:30:35 ferrum-broen-241 volumio[1420]: info: [HEM] Config value for i2s_dsd_pin: p13 Jun 01 18:30:35 ferrum-broen-241 volumio[1420]: info: [HEM] Config value for i2s_dsd_channel_assignment: leftOnWck Jun 01 18:30:35 ferrum-broen-241 volumio[1420]: info: [HEM] Config value for i2s_wck_polarity: normal Jun 01 18:30:35 ferrum-broen-241 volumio[1420]: info: [HEM] Config value for i2s_bck_polarity: normal Jun 01 18:30:35 ferrum-broen-241 volumio[1420]: info: [HEM] Config value for i2s_sd_polarity: normal Jun 01 18:30:39 ferrum-broen-241 volumio[1420]: info: CoreCommandRouter::volumioGetState Jun 01 18:30:39 ferrum-broen-241 volumio[1420]: info: CorePlayQueue::getTrack 0 Jun 01 18:30:44 ferrum-broen-241 volumio5-onboarding[2141]: time=2026-06-01T18:30:44.576+02:00 level=INFO msg="new address was allocated" component=ble/conn old=1 new=2 Jun 01 18:30:44 ferrum-broen-241 dbus-daemon[962]: [system] Rejected send message, 0 matched rules; type="error", sender=":1.27" (uid=0 pid=2141 comm="/usr/bin/volumio5-onboarding") interface="(unset)" member="(unset)" error name="org.freedesktop.DBus.Error.UnknownMethod" requested_reply="0" destination=":1.2" (uid=0 pid=961 comm="/usr/libexec/bluetooth/bluetoothd --noplugin=sap,b") Jun 01 18:30:49 ferrum-broen-241 sshd[2664]: Accepted password for volumiooem from 192.168.1.108 port 61742 ssh2 Jun 01 18:30:49 ferrum-broen-241 sshd[2664]: pam_unix(sshd:session): session opened for user volumiooem(uid=1001) by (uid=0) Jun 01 18:30:49 ferrum-broen-241 systemd[1]: Created slice user-1001.slice - User Slice of UID 1001. Jun 01 18:30:49 ferrum-broen-241 systemd[1]: Starting user-runtime-dir@1001.service - User Runtime Directory /run/user/1001... Jun 01 18:30:49 ferrum-broen-241 systemd-logind[977]: New session 1 of user volumiooem. Jun 01 18:30:49 ferrum-broen-241 systemd[1]: Finished user-runtime-dir@1001.service - User Runtime Directory /run/user/1001. Jun 01 18:30:49 ferrum-broen-241 systemd[1]: Starting user@1001.service - User Manager for UID 1001... Jun 01 18:30:49 ferrum-broen-241 (systemd)[2668]: pam_unix(systemd-user:session): session opened for user volumiooem(uid=1001) by (uid=0) Jun 01 18:30:49 ferrum-broen-241 systemd[2668]: Queued start job for default target default.target. Jun 01 18:30:49 ferrum-broen-241 systemd[2668]: Created slice app.slice - User Application Slice. Jun 01 18:30:49 ferrum-broen-241 systemd[2668]: Created slice session.slice - User Core Session Slice. Jun 01 18:30:49 ferrum-broen-241 systemd[2668]: Reached target paths.target - Paths. Jun 01 18:30:49 ferrum-broen-241 systemd[2668]: Reached target timers.target - Timers. Jun 01 18:30:49 ferrum-broen-241 systemd[2668]: Starting dbus.socket - D-Bus User Message Bus Socket... Jun 01 18:30:49 ferrum-broen-241 systemd[2668]: Listening on dirmngr.socket - GnuPG network certificate management daemon. Jun 01 18:30:49 ferrum-broen-241 systemd[2668]: Listening on gpg-agent-browser.socket - GnuPG cryptographic agent and passphrase cache (access for web browsers). Jun 01 18:30:49 ferrum-broen-241 systemd[2668]: Listening on gpg-agent-extra.socket - GnuPG cryptographic agent and passphrase cache (restricted). Jun 01 18:30:49 ferrum-broen-241 systemd[2668]: Listening on gpg-agent-ssh.socket - GnuPG cryptographic agent (ssh-agent emulation). Jun 01 18:30:49 ferrum-broen-241 systemd[2668]: Listening on gpg-agent.socket - GnuPG cryptographic agent and passphrase cache. Jun 01 18:30:49 ferrum-broen-241 systemd[2668]: Listening on dbus.socket - D-Bus User Message Bus Socket. Jun 01 18:30:49 ferrum-broen-241 systemd[2668]: Reached target sockets.target - Sockets. Jun 01 18:30:49 ferrum-broen-241 systemd[2668]: Reached target basic.target - Basic System. Jun 01 18:30:49 ferrum-broen-241 systemd[1]: Started user@1001.service - User Manager for UID 1001. Jun 01 18:30:49 ferrum-broen-241 systemd[2668]: Starting dbus.service - D-Bus User Message Bus... Jun 01 18:30:49 ferrum-broen-241 systemd[1]: Started session-1.scope - Session 1 of User volumiooem. Jun 01 18:30:49 ferrum-broen-241 systemd[2668]: Started dbus.service - D-Bus User Message Bus. Jun 01 18:30:49 ferrum-broen-241 systemd[2668]: Started fsct-driver.service - FSCT per-user client (MPRIS integration). Jun 01 18:30:49 ferrum-broen-241 systemd[2668]: Started mpris-proxy.service - Bluetooth mpris proxy. Jun 01 18:30:49 ferrum-broen-241 systemd[2668]: Reached target default.target - Main User Target. Jun 01 18:30:49 ferrum-broen-241 systemd[2668]: Startup finished in 296ms. Jun 01 18:30:49 ferrum-broen-241 fsctd[2688]: [2026-06-01T16:30:49Z INFO fsct_driver::service_main] Connecting to IPC driver at /run/fsct/fsct.sock Jun 01 18:30:49 ferrum-broen-241 fsctd[2258]: [2026-06-01T16:30:49Z INFO fsct_driver::ipc] New IPC client connected, id = 1d5ec825-0171-47e0-9407-3cfe66994c09 Jun 01 18:30:49 ferrum-broen-241 fsctd[2688]: [2026-06-01T16:30:49Z INFO fsct_driver::ports::linux] systemd socket activation not detected, using /run/fsct/fsct.sock Jun 01 18:30:49 ferrum-broen-241 sshd[2664]: pam_env(sshd:session): deprecated reading of user environment enabled Jun 01 18:30:54 ferrum-broen-241 sudo[2715]: volumiooem : TTY=pts/0 ; PWD=/home/volumiooem ; USER=root ; COMMAND=/usr/sbin/reboot Jun 01 18:30:54 ferrum-broen-241 sudo[2715]: pam_unix(sudo:session): session opened for user root(uid=0) by volumiooem(uid=1001) Jun 01 18:30:54 ferrum-broen-241 systemd-logind[977]: The system will reboot now! Jun 01 18:30:54 ferrum-broen-241 systemd-logind[977]: System is rebooting. Jun 01 18:30:54 ferrum-broen-241 sudo[2715]: pam_unix(sudo:session): session closed for user root Jun 01 18:30:54 ferrum-broen-241 systemd[1]: Stopping session-1.scope - Session 1 of User volumiooem... Jun 01 18:30:54 ferrum-broen-241 sshd[2664]: pam_unix(sshd:session): session closed for user volumiooem Jun 01 18:30:54 ferrum-broen-241 systemd[1]: Removed slice system-modprobe.slice - Slice /system/modprobe. Jun 01 18:30:54 ferrum-broen-241 systemd[1]: Stopped target bluetooth.target - Bluetooth Support. Jun 01 18:30:54 ferrum-broen-241 systemd[1]: Stopped target graphical.target - Graphical Interface. Jun 01 18:30:54 ferrum-broen-241 systemd[1]: Stopped target ip-changed@wlan0.target - IP Address changed on wlan0. Jun 01 18:30:54 ferrum-broen-241 systemd[1]: Stopped target rpc_pipefs.target. Jun 01 18:30:54 ferrum-broen-241 systemd[1]: Stopped target rpcbind.target - RPC Port Mapper. Jun 01 18:30:54 ferrum-broen-241 systemd[1]: Stopped target timers.target - Timer Units. Jun 01 18:30:54 ferrum-broen-241 systemd[1]: apt-daily-upgrade.timer: Deactivated successfully. Jun 01 18:30:54 ferrum-broen-241 systemd[1]: Stopped apt-daily-upgrade.timer - Daily apt upgrade and clean activities. Jun 01 18:30:54 ferrum-broen-241 systemd[1]: apt-daily.timer: Deactivated successfully. Jun 01 18:30:54 ferrum-broen-241 systemd[1]: Stopped apt-daily.timer - Daily apt download activities. Jun 01 18:30:54 ferrum-broen-241 systemd[1]: dpkg-db-backup.timer: Deactivated successfully. Jun 01 18:30:54 ferrum-broen-241 systemd[1]: Stopped dpkg-db-backup.timer - Daily dpkg database backup timer. Jun 01 18:30:54 ferrum-broen-241 systemd[1]: e2scrub_all.timer: Deactivated successfully. Jun 01 18:30:54 ferrum-broen-241 systemd[1]: Stopped e2scrub_all.timer - Periodic ext4 Online Metadata Check for All Filesystems. Jun 01 18:30:54 ferrum-broen-241 systemd[1]: fstrim.timer: Deactivated successfully. Jun 01 18:30:54 ferrum-broen-241 systemd[1]: Stopped fstrim.timer - Discard unused blocks once a week. Jun 01 18:30:54 ferrum-broen-241 systemd[1]: ntpsec-rotate-stats.timer: Deactivated successfully. Jun 01 18:30:54 ferrum-broen-241 systemd[1]: Stopped ntpsec-rotate-stats.timer - Rotate ntpd stats daily. Jun 01 18:30:54 ferrum-broen-241 systemd[1]: setdatetime-helper.timer: Deactivated successfully. Jun 01 18:30:54 ferrum-broen-241 systemd[1]: Stopped setdatetime-helper.timer - Volumio Time Sync Watchdog Timer. Jun 01 18:30:54 ferrum-broen-241 systemd[1]: systemd-tmpfiles-clean.timer: Deactivated successfully. Jun 01 18:30:54 ferrum-broen-241 systemd[1]: Stopped systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Jun 01 18:30:54 ferrum-broen-241 systemd[1]: systemd-rfkill.socket: Deactivated successfully. Jun 01 18:30:54 ferrum-broen-241 systemd[1]: Closed systemd-rfkill.socket - Load/Save RF Kill Switch Status /dev/rfkill Watch. Jun 01 18:30:54 ferrum-broen-241 systemd[1]: Unmounting run-rpc_pipefs.mount - RPC Pipe File System... Jun 01 18:30:54 ferrum-broen-241 systemd[1]: Stopping bluealsa.service - BlueALSA service... Jun 01 18:30:54 ferrum-broen-241 systemd[1]: Stopping fsct-driver.service - FSCT driver... Jun 01 18:30:54 ferrum-broen-241 systemd[1]: Stopping mpd.service - Music Player Daemon... Jun 01 18:30:54 ferrum-broen-241 fsctd[2258]: [2026-06-01T16:30:54Z INFO fsct_driver::orchestrator] Orchestrator shutdown requested Jun 01 18:30:54 ferrum-broen-241 fsctd[2258]: [2026-06-01T16:30:54Z INFO fsct_driver::ipc] IPC connection stop requested, id = bddd8985-3e1e-4bbf-93a5-55b2f70e9216 Jun 01 18:30:54 ferrum-broen-241 fsctd[2258]: [2026-06-01T16:30:54Z INFO fsct_driver::player_manager] Player 1 unregistered Jun 01 18:30:54 ferrum-broen-241 fsctd[2258]: [2026-06-01T16:30:54Z INFO fsct_driver::ipc] IPC connection closed, id = bddd8985-3e1e-4bbf-93a5-55b2f70e9216 Jun 01 18:30:54 ferrum-broen-241 fsctd[2258]: [2026-06-01T16:30:54Z INFO fsct_driver::ipc] IPC connection stop requested, id = 1d5ec825-0171-47e0-9407-3cfe66994c09 Jun 01 18:30:54 ferrum-broen-241 fsctd[2258]: [2026-06-01T16:30:54Z INFO fsct_driver::ipc] IPC connection closed, id = 1d5ec825-0171-47e0-9407-3cfe66994c09 Jun 01 18:30:54 ferrum-broen-241 fsctd[2258]: [2026-06-01T16:30:54Z INFO fsct_driver::ipc] IPC server stopped Jun 01 18:30:54 ferrum-broen-241 volumio[1420]: info: [fsct] ipc connection closed Jun 01 18:30:54 ferrum-broen-241 bluealsa[1100]: ../src/ba-adapter.c:144: Freeing adapter: hci0 Jun 01 18:30:54 ferrum-broen-241 systemd[1]: Starting plymouth-reboot.service - Show Plymouth Reboot Screen... Jun 01 18:30:54 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:30:54 ferrum-broen-241 bluetoothd[961]: Endpoint unregistered: sender=:1.6 path=/org/bluez/hci0/A2DP/SBC/source/1 Jun 01 18:30:54 ferrum-broen-241 bluetoothd[961]: Endpoint unregistered: sender=:1.6 path=/org/bluez/hci0/A2DP/SBC/sink/2 Jun 01 18:30:54 ferrum-broen-241 systemd[1]: Stopping systemd-random-seed.service - Load/Save Random Seed... Jun 01 18:30:54 ferrum-broen-241 bluetoothd[961]: Endpoint unregistered: sender=:1.6 path=/org/bluez/hci0/A2DP/SBC/source/2 Jun 01 18:30:54 ferrum-broen-241 systemd[1]: Stopping volumio5-onboarding.service - Volumio5 Onboarding Server... Jun 01 18:30:54 ferrum-broen-241 systemd[1]: Stopping volumiobt.service - Volumio Bluetooth Module... Jun 01 18:30:54 ferrum-broen-241 bluetoothd[961]: Endpoint unregistered: sender=:1.6 path=/org/bluez/hci0/A2DP/SBC/sink/1 Jun 01 18:30:54 ferrum-broen-241 systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service... Jun 01 18:30:54 ferrum-broen-241 systemd[1]: fsct-driver.service: Deactivated successfully. Jun 01 18:30:54 ferrum-broen-241 volumiobt[2724]: INFO [BTSTART] Disconnecting all Bluetooth devices... Jun 01 18:30:54 ferrum-broen-241 systemd[1]: Stopped fsct-driver.service - FSCT driver. Jun 01 18:30:54 ferrum-broen-241 systemd[1]: volumio5-onboarding.service: Deactivated successfully. Jun 01 18:30:54 ferrum-broen-241 systemd[1]: Stopped volumio5-onboarding.service - Volumio5 Onboarding Server. Jun 01 18:30:54 ferrum-broen-241 systemd[1]: vtcs.service: Killing process 2454 (vtcs) with signal SIGKILL. Jun 01 18:30:54 ferrum-broen-241 systemd[1]: run-rpc_pipefs.mount: Deactivated successfully. Jun 01 18:30:54 ferrum-broen-241 systemd[1]: Unmounted run-rpc_pipefs.mount - RPC Pipe File System. Jun 01 18:30:54 ferrum-broen-241 systemd[1]: Received SIGRTMIN+20 from PID 2723 (plymouthd). Jun 01 18:30:54 ferrum-broen-241 systemd[1]: vtcs.service: Deactivated successfully. Jun 01 18:30:54 ferrum-broen-241 systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service. Jun 01 18:30:54 ferrum-broen-241 systemd[1]: bluealsa.service: Deactivated successfully. Jun 01 18:30:54 ferrum-broen-241 systemd[1]: Stopped bluealsa.service - BlueALSA service. Jun 01 18:30:54 ferrum-broen-241 systemd[1]: session-1.scope: Deactivated successfully. Jun 01 18:30:54 ferrum-broen-241 systemd[1]: Stopped session-1.scope - Session 1 of User volumiooem. Jun 01 18:30:54 ferrum-broen-241 systemd-logind[977]: Session 1 logged out. Waiting for processes to exit. Jun 01 18:30:54 ferrum-broen-241 systemd[1]: Stopping user@1001.service - User Manager for UID 1001... Jun 01 18:30:54 ferrum-broen-241 systemd[1]: systemd-random-seed.service: Deactivated successfully. Jun 01 18:30:54 ferrum-broen-241 systemd[1]: Stopped systemd-random-seed.service - Load/Save Random Seed. Jun 01 18:30:54 ferrum-broen-241 systemd[2668]: Activating special unit exit.target... Jun 01 18:30:54 ferrum-broen-241 systemd[2668]: Stopped target default.target - Main User Target. Jun 01 18:30:54 ferrum-broen-241 systemd[2668]: Stopping fsct-driver.service - FSCT per-user client (MPRIS integration)... Jun 01 18:30:54 ferrum-broen-241 systemd[2668]: Stopping mpris-proxy.service - Bluetooth mpris proxy... Jun 01 18:30:54 ferrum-broen-241 systemd[2668]: Stopped fsct-driver.service - FSCT per-user client (MPRIS integration). Jun 01 18:30:54 ferrum-broen-241 systemd[1]: Started plymouth-reboot.service - Show Plymouth Reboot Screen. Jun 01 18:30:54 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:30:54 ferrum-broen-241 systemd-logind[977]: Removed session 1. Jun 01 18:30:54 ferrum-broen-241 mpris-proxy[2689]: org.bluez appeared Jun 01 18:30:54 ferrum-broen-241 mpris-proxy[2689]: Bluetooth Adapter /org/bluez/hci0 found Jun 01 18:30:54 ferrum-broen-241 mpris-proxy[2689]: Bluetooth Adapter /org/bluez/hci0 removed Jun 01 18:30:54 ferrum-broen-241 mpris-proxy[2689]: org.bluez disappeared Jun 01 18:30:54 ferrum-broen-241 systemd[2668]: Stopped mpris-proxy.service - Bluetooth mpris proxy. Jun 01 18:30:54 ferrum-broen-241 systemd[2668]: Stopping dbus.service - D-Bus User Message Bus... Jun 01 18:30:54 ferrum-broen-241 systemd[2668]: Stopped dbus.service - D-Bus User Message Bus. Jun 01 18:30:54 ferrum-broen-241 systemd[2668]: Removed slice session.slice - User Core Session Slice. Jun 01 18:30:54 ferrum-broen-241 systemd[2668]: Stopped target basic.target - Basic System. Jun 01 18:30:54 ferrum-broen-241 systemd[2668]: Stopped target paths.target - Paths. Jun 01 18:30:54 ferrum-broen-241 systemd[2668]: Stopped target sockets.target - Sockets. Jun 01 18:30:54 ferrum-broen-241 systemd[2668]: Stopped target timers.target - Timers. Jun 01 18:30:54 ferrum-broen-241 systemd[2668]: Closed dbus.socket - D-Bus User Message Bus Socket. Jun 01 18:30:54 ferrum-broen-241 systemd[2668]: Closed dirmngr.socket - GnuPG network certificate management daemon. Jun 01 18:30:54 ferrum-broen-241 systemd[2668]: Closed gpg-agent-browser.socket - GnuPG cryptographic agent and passphrase cache (access for web browsers). Jun 01 18:30:54 ferrum-broen-241 systemd[2668]: Closed gpg-agent-extra.socket - GnuPG cryptographic agent and passphrase cache (restricted). Jun 01 18:30:54 ferrum-broen-241 bluetoothd[961]: Path / reserved for Adv Monitor app :1.41 Jun 01 18:30:54 ferrum-broen-241 systemd[2668]: Closed gpg-agent-ssh.socket - GnuPG cryptographic agent (ssh-agent emulation). Jun 01 18:30:54 ferrum-broen-241 systemd[2668]: Closed gpg-agent.socket - GnuPG cryptographic agent and passphrase cache. Jun 01 18:30:54 ferrum-broen-241 systemd[2668]: Removed slice app.slice - User Application Slice. Jun 01 18:30:54 ferrum-broen-241 systemd[2668]: Reached target shutdown.target - Shutdown. Jun 01 18:30:54 ferrum-broen-241 systemd[2668]: Finished systemd-exit.service - Exit the Session. Jun 01 18:30:54 ferrum-broen-241 systemd[2668]: Reached target exit.target - Exit the Session. Jun 01 18:30:54 ferrum-broen-241 bluetoothd[961]: Adv Monitor app :1.41 disconnected from D-Bus Jun 01 18:30:54 ferrum-broen-241 volumiobt[2737]: Attempting to disconnect from 50:BC:B0:7C:E1:C0 Jun 01 18:30:54 ferrum-broen-241 volumiobt[2737]: [NEW] Media /org/bluez/hci0 Jun 01 18:30:54 ferrum-broen-241 volumiobt[2737]: SupportedUUIDs: 0000110a-0000-1000-8000-00805f9b34fb Jun 01 18:30:54 ferrum-broen-241 volumiobt[2737]: SupportedUUIDs: 0000110b-0000-1000-8000-00805f9b34fb Jun 01 18:30:54 ferrum-broen-241 volumiobt[2737]: SupportedUUIDs: 0000FDF0-0000-1000-8000-00805f9b34fb Jun 01 18:30:54 ferrum-broen-241 bluetoothd[961]: Path / reserved for Adv Monitor app :1.42 Jun 01 18:30:54 ferrum-broen-241 volumiobt[2737]: AdvertisementMonitor path registered Jun 01 18:30:54 ferrum-broen-241 systemd[1]: user@1001.service: Deactivated successfully. Jun 01 18:30:54 ferrum-broen-241 systemd[1]: Stopped user@1001.service - User Manager for UID 1001. Jun 01 18:30:54 ferrum-broen-241 systemd[1]: mpd.service: Deactivated successfully. Jun 01 18:30:54 ferrum-broen-241 systemd[1]: Stopped mpd.service - Music Player Daemon. Jun 01 18:30:54 ferrum-broen-241 systemd[1]: mpd.service: Consumed 1.330s CPU time. Jun 01 18:30:55 ferrum-broen-241 systemd[1]: Stopping user-runtime-dir@1001.service - User Runtime Directory /run/user/1001... Jun 01 18:30:55 ferrum-broen-241 systemd[1]: run-user-1001.mount: Deactivated successfully. Jun 01 18:30:55 ferrum-broen-241 systemd[1]: Unmounted run-user-1001.mount - /run/user/1001. Jun 01 18:30:55 ferrum-broen-241 systemd[1]: user-runtime-dir@1001.service: Deactivated successfully. Jun 01 18:30:55 ferrum-broen-241 systemd[1]: Stopped user-runtime-dir@1001.service - User Runtime Directory /run/user/1001. Jun 01 18:30:55 ferrum-broen-241 systemd[1]: Removed slice user-1001.slice - User Slice of UID 1001. Jun 01 18:30:56 ferrum-broen-241 volumio[1420]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 01 18:30:56 ferrum-broen-241 volumio[1420]: Error: read ECONNRESET Jun 01 18:30:56 ferrum-broen-241 volumio[1420]: at Pipe.onStreamRead (node:internal/stream_base_commons:217:20) { Jun 01 18:30:56 ferrum-broen-241 volumio[1420]: errno: -104, Jun 01 18:30:56 ferrum-broen-241 volumio[1420]: code: 'ECONNRESET', Jun 01 18:30:56 ferrum-broen-241 volumio[1420]: syscall: 'read' Jun 01 18:30:56 ferrum-broen-241 volumio[1420]: } Jun 01 18:30:56 ferrum-broen-241 volumio[1420]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 01 18:30:56 ferrum-broen-241 sudo[2753]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-06-01 18:29' Jun 01 18:30:56 ferrum-broen-241 sudo[2753]: 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"