Jun 01 19:05:00 ferrum-broen-240 volumio[3668]: error: MyVolumio Plugin failed to start in a timely fashion Jun 01 19:05:00 ferrum-broen-240 volumio[3668]: [Metrics] CommandRouter: 29s 372.78ms Jun 01 19:05:00 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::volumiosetStartupVolume Jun 01 19:05:00 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 01 19:05:00 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 01 19:05:00 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::Close All Modals sent Jun 01 19:05:00 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::Close All Modals sent Jun 01 19:05:00 ferrum-broen-240 volumio[3668]: info: Cannot play startup sound: Error: Command failed: /usr/bin/aplay -D volumio /volumio/app/startup.wav Jun 01 19:05:00 ferrum-broen-240 volumio[3668]: ALSA lib confmisc.c:165:(snd_config_get_card) Cannot get card index for F2 Jun 01 19:05:00 ferrum-broen-240 volumio[3668]: ALSA lib ./src/pcm_volumioswitch.c:143:(_snd_pcm_volumioswitch_open_target_pcm) PCM Volumio ALSA Switch Plugin failed to open the switcher target pcm volumioLocalPlayback Jun 01 19:05:00 ferrum-broen-240 volumio[3668]: aplay: main:831: audio open error: No such device Jun 01 19:05:00 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:05:00Z INFO fsct_driver::ipc] New IPC client connected, id = c209f343-4a6a-4b19-9c1e-54c4a248da60 Jun 01 19:05:00 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:05:00Z INFO fsct_driver::ipc] IPC connection closed, id = c209f343-4a6a-4b19-9c1e-54c4a248da60 Jun 01 19:05:00 ferrum-broen-240 volumio[3668]: error: [fsct] reconnect failed: unknown method: get_timesync Jun 01 19:05:01 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Jun 01 19:05:01 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 01 19:05:01 ferrum-broen-240 volumio[3668]: aplay: device_list:274: no soundcards found... Jun 01 19:05:01 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Jun 01 19:05:01 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Jun 01 19:05:02 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:05:02Z INFO fsct_driver::ipc] New IPC client connected, id = 58cda9f2-0887-40b5-aad0-50d40f8ff331 Jun 01 19:05:02 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:05:02Z INFO fsct_driver::ipc] IPC connection closed, id = 58cda9f2-0887-40b5-aad0-50d40f8ff331 Jun 01 19:05:02 ferrum-broen-240 volumio[3668]: error: [fsct] reconnect failed: unknown method: get_timesync Jun 01 19:05:04 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 01 19:05:04 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 01 19:05:04 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 01 19:05:04 ferrum-broen-240 volumio[3668]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=cm5&variante=ferrumbroen&version=4.158&uuid=98c58c417e74d6661e77a106d3b12dd3" http://updates.volumio.org/downloader-v1/track-device Jun 01 19:05:04 ferrum-broen-240 volumio[3668]: % Total % Received % Xferd Average Speed Time Time Time Current Jun 01 19:05:04 ferrum-broen-240 volumio[3668]: Dload Upload Total Spent Left Speed Jun 01 19:05:04 ferrum-broen-240 volumio[3668]: [132B blob data] Jun 01 19:05:04 ferrum-broen-240 volumio[3668]: retrying in 5 seconds, trial 2 Jun 01 19:05:04 ferrum-broen-240 volumio[3668]: info: Volumio Calling Home Jun 01 19:05:04 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:05:04Z INFO fsct_driver::ipc] New IPC client connected, id = a1457e94-3555-4b70-a9c2-0bf95388f566 Jun 01 19:05:04 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:05:04Z INFO fsct_driver::ipc] IPC connection closed, id = a1457e94-3555-4b70-a9c2-0bf95388f566 Jun 01 19:05:04 ferrum-broen-240 volumio[3668]: error: [fsct] reconnect failed: unknown method: get_timesync Jun 01 19:05:06 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:05:06Z INFO fsct_driver::ipc] New IPC client connected, id = 94ec66fc-92d3-4bdf-b068-f269f8fe604e Jun 01 19:05:06 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:05:06Z INFO fsct_driver::ipc] IPC connection closed, id = 94ec66fc-92d3-4bdf-b068-f269f8fe604e Jun 01 19:05:06 ferrum-broen-240 volumio[3668]: error: [fsct] reconnect failed: unknown method: get_timesync Jun 01 19:05:07 ferrum-broen-240 volumio[3668]: info: BOOT COMPLETED Jun 01 19:05:08 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:05:08Z INFO fsct_driver::ipc] New IPC client connected, id = 5f6e7a90-1166-4b29-9d0a-d3910245a3e0 Jun 01 19:05:08 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:05:08Z INFO fsct_driver::ipc] IPC connection closed, id = 5f6e7a90-1166-4b29-9d0a-d3910245a3e0 Jun 01 19:05:08 ferrum-broen-240 volumio[3668]: error: [fsct] reconnect failed: unknown method: get_timesync Jun 01 19:05:10 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:05:10Z INFO fsct_driver::ipc] New IPC client connected, id = 221d8a8f-a0a4-4490-b83d-774938fe7afd Jun 01 19:05:10 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:05:10Z INFO fsct_driver::ipc] IPC connection closed, id = 221d8a8f-a0a4-4490-b83d-774938fe7afd Jun 01 19:05:10 ferrum-broen-240 volumio[3668]: error: [fsct] reconnect failed: unknown method: get_timesync Jun 01 19:05:12 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:05:12Z INFO fsct_driver::ipc] New IPC client connected, id = de95337d-6340-4dce-bb95-26ea87aafcab Jun 01 19:05:12 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:05:12Z INFO fsct_driver::ipc] IPC connection closed, id = de95337d-6340-4dce-bb95-26ea87aafcab Jun 01 19:05:12 ferrum-broen-240 volumio[3668]: error: [fsct] reconnect failed: unknown method: get_timesync Jun 01 19:05:14 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:05:14Z INFO fsct_driver::ipc] New IPC client connected, id = 86703cb7-6c6d-4f3b-a873-2db0a5ef3ba5 Jun 01 19:05:14 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:05:14Z INFO fsct_driver::ipc] IPC connection closed, id = 86703cb7-6c6d-4f3b-a873-2db0a5ef3ba5 Jun 01 19:05:14 ferrum-broen-240 volumio[3668]: error: [fsct] reconnect failed: unknown method: get_timesync Jun 01 19:05:16 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:05:16Z INFO fsct_driver::ipc] New IPC client connected, id = dcf6d8a5-e77c-4d56-a001-71a94bd8aafe Jun 01 19:05:16 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:05:16Z INFO fsct_driver::ipc] IPC connection closed, id = dcf6d8a5-e77c-4d56-a001-71a94bd8aafe Jun 01 19:05:16 ferrum-broen-240 volumio[3668]: error: [fsct] reconnect failed: unknown method: get_timesync Jun 01 19:05:18 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:05:18Z INFO fsct_driver::ipc] New IPC client connected, id = 7f509bef-ede4-4ada-9d2c-a28c0c755c93 Jun 01 19:05:18 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:05:18Z INFO fsct_driver::ipc] IPC connection closed, id = 7f509bef-ede4-4ada-9d2c-a28c0c755c93 Jun 01 19:05:18 ferrum-broen-240 volumio[3668]: error: [fsct] reconnect failed: unknown method: get_timesync Jun 01 19:05:20 ferrum-broen-240 p056-sfpmgr[3490]: Transition: NoLink --[LinkDetected]--> Link Jun 01 19:05:20 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:05:20Z INFO fsct_driver::ipc] New IPC client connected, id = 00886e05-9c25-4d2d-9c7e-90b8b419c2f9 Jun 01 19:05:20 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:05:20Z INFO fsct_driver::ipc] IPC connection closed, id = 00886e05-9c25-4d2d-9c7e-90b8b419c2f9 Jun 01 19:05:20 ferrum-broen-240 volumio[3668]: error: [fsct] reconnect failed: unknown method: get_timesync Jun 01 19:05:21 ferrum-broen-240 kernel: macb 1f00100000.ethernet eth0: PHY [1f00100000.ethernet-ffffffff:00] driver [Broadcom BCM54213PE] (irq=170) Jun 01 19:05:21 ferrum-broen-240 kernel: macb 1f00100000.ethernet eth0: configuring for phy/rgmii-id link mode Jun 01 19:05:21 ferrum-broen-240 kernel: macb 1f00100000.ethernet: gem-ptp-timer ptp clock registered. Jun 01 19:05:21 ferrum-broen-240 volumio[3668]: info: Received Get System Info Jun 01 19:05:21 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 01 19:05:21 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 01 19:05:21 ferrum-broen-240 volumio[3668]: info: Discovery: Getting this device information Jun 01 19:05:21 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::volumioGetState Jun 01 19:05:21 ferrum-broen-240 volumio[3668]: info: CorePlayQueue::getTrack 0 Jun 01 19:05:21 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 01 19:05:21 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 01 19:05:21 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 01 19:05:22 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:05:22Z INFO fsct_driver::ipc] New IPC client connected, id = e6252f55-a11a-4673-9baf-d062d633efa2 Jun 01 19:05:22 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:05:22Z INFO fsct_driver::ipc] IPC connection closed, id = e6252f55-a11a-4673-9baf-d062d633efa2 Jun 01 19:05:22 ferrum-broen-240 volumio[3668]: error: [fsct] reconnect failed: unknown method: get_timesync Jun 01 19:05:22 ferrum-broen-240 volumio5-onboarding[2227]: time=2026-06-01T19:05:22.725+02:00 level=INFO msg="service successfully established" component=discovery/localnet Jun 01 19:05:23 ferrum-broen-240 dhcpcd[1021]: eth0: carrier acquired Jun 01 19:05:23 ferrum-broen-240 kernel: macb 1f00100000.ethernet eth0: Link is Up - 1Gbps/Full - flow control off Jun 01 19:05:23 ferrum-broen-240 dhcpcd[1021]: eth0: IAID 67:bf:81:be Jun 01 19:05:24 ferrum-broen-240 volumio[3668]: info: Received Get System Info Jun 01 19:05:24 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 01 19:05:24 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 01 19:05:24 ferrum-broen-240 volumio[3668]: info: Discovery: Getting this device information Jun 01 19:05:24 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::volumioGetState Jun 01 19:05:24 ferrum-broen-240 volumio[3668]: info: CorePlayQueue::getTrack 0 Jun 01 19:05:24 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 01 19:05:24 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 01 19:05:24 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 01 19:05:24 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:05:24Z INFO fsct_driver::ipc] New IPC client connected, id = 19971bbd-e371-434b-b3ee-cc0fe225fa94 Jun 01 19:05:24 ferrum-broen-240 volumio[3668]: error: [fsct] reconnect failed: unknown method: get_timesync Jun 01 19:05:24 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:05:24Z INFO fsct_driver::ipc] IPC connection closed, id = 19971bbd-e371-434b-b3ee-cc0fe225fa94 Jun 01 19:05:24 ferrum-broen-240 dhcpcd[1021]: eth0: soliciting an IPv6 router Jun 01 19:05:25 ferrum-broen-240 volumio5-onboarding[2227]: time=2026-06-01T19:05:25.149+02:00 level=INFO msg="service successfully established" component=discovery/localnet Jun 01 19:05:25 ferrum-broen-240 dhcpcd[1021]: eth0: rebinding lease of 192.168.0.60 Jun 01 19:05:25 ferrum-broen-240 dhcpcd[1021]: eth0: probing address 192.168.0.60/24 Jun 01 19:05:26 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:05:26Z INFO fsct_driver::ipc] New IPC client connected, id = e2bba8e5-3625-444a-b714-fe4f637b68d5 Jun 01 19:05:26 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:05:26Z INFO fsct_driver::ipc] IPC connection closed, id = e2bba8e5-3625-444a-b714-fe4f637b68d5 Jun 01 19:05:26 ferrum-broen-240 volumio[3668]: error: [fsct] reconnect failed: unknown method: get_timesync Jun 01 19:05:28 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:05:28Z INFO fsct_driver::ipc] New IPC client connected, id = ca7b0d7a-f25c-4841-9acc-872b88ab7319 Jun 01 19:05:28 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:05:28Z INFO fsct_driver::ipc] IPC connection closed, id = ca7b0d7a-f25c-4841-9acc-872b88ab7319 Jun 01 19:05:28 ferrum-broen-240 volumio[3668]: error: [fsct] reconnect failed: unknown method: get_timesync Jun 01 19:05:30 ferrum-broen-240 dhcpcd[1021]: eth0: leased 192.168.0.60 for 6196 seconds Jun 01 19:05:30 ferrum-broen-240 avahi-daemon[978]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.0.60. Jun 01 19:05:30 ferrum-broen-240 avahi-daemon[978]: New relevant interface eth0.IPv4 for mDNS. Jun 01 19:05:30 ferrum-broen-240 avahi-daemon[978]: Registering new address record for 192.168.0.60 on eth0.IPv4. Jun 01 19:05:30 ferrum-broen-240 dhcpcd[1021]: eth0: adding route to 192.168.0.0/24 Jun 01 19:05:30 ferrum-broen-240 dhcpcd[1021]: eth0: adding default route via 192.168.0.1 Jun 01 19:05:30 ferrum-broen-240 systemd[1]: Stopped target ip-changed@eth0.target - IP Address changed on eth0. Jun 01 19:05:30 ferrum-broen-240 systemd[1]: Stopping ip-changed@eth0.target - IP Address changed on eth0... Jun 01 19:05:30 ferrum-broen-240 systemd[1]: welcome.service: Deactivated successfully. Jun 01 19:05:30 ferrum-broen-240 systemd[1]: Stopped welcome.service - Show a welcome message on console. Jun 01 19:05:30 ferrum-broen-240 systemd[1]: Stopping welcome.service - Show a welcome message on console... Jun 01 19:05:30 ferrum-broen-240 dnsmasq[2031]: reading /etc/resolv.conf Jun 01 19:05:30 ferrum-broen-240 dnsmasq[2031]: using nameserver 192.168.0.101#53 Jun 01 19:05:30 ferrum-broen-240 dnsmasq[2031]: using nameserver 1.1.1.1#53 Jun 01 19:05:30 ferrum-broen-240 dnsmasq[2031]: using nameserver 208.67.222.222#53 Jun 01 19:05:30 ferrum-broen-240 dnsmasq[2031]: using nameserver 208.67.220.220#53 Jun 01 19:05:30 ferrum-broen-240 systemd[1]: Starting welcome.service - Show a welcome message on console... Jun 01 19:05:30 ferrum-broen-240 welcome[4165]: Resolved ip:[2] 192.168.0.60 192.168.211.1 Jun 01 19:05:30 ferrum-broen-240 systemd[1]: Finished welcome.service - Show a welcome message on console. Jun 01 19:05:30 ferrum-broen-240 systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0. Jun 01 19:05:30 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:05:30Z INFO fsct_driver::ipc] New IPC client connected, id = a24fdd35-e923-47cc-85c9-ede00d9cb544 Jun 01 19:05:30 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:05:30Z INFO fsct_driver::ipc] IPC connection closed, id = a24fdd35-e923-47cc-85c9-ede00d9cb544 Jun 01 19:05:30 ferrum-broen-240 volumio[3668]: error: [fsct] reconnect failed: unknown method: get_timesync Jun 01 19:05:30 ferrum-broen-240 volumio[3668]: info: Discovery: adding b6a10235-fc0a-4d6f-ac6e-44f5378c5f3f Jun 01 19:05:30 ferrum-broen-240 volumio[3668]: info: Discovery: Found device Ferrum Broen 238 Jun 01 19:05:30 ferrum-broen-240 volumio[3668]: info: Discovery: Connecting to remote: 192.168.0.83 Jun 01 19:05:30 ferrum-broen-240 volumio[3668]: info: MRS: Pushing audio output on request Jun 01 19:05:30 ferrum-broen-240 volumio[3668]: info: MRS: Pushing multiroomSync output Jun 01 19:05:30 ferrum-broen-240 volumio[3668]: info: Discovery: Connected to remote: 192.168.0.83 Jun 01 19:05:30 ferrum-broen-240 volumio[3668]: info: Received Get System Info Jun 01 19:05:30 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 01 19:05:30 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 01 19:05:30 ferrum-broen-240 volumio[3668]: info: Discovery: Getting this device information Jun 01 19:05:30 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::volumioGetState Jun 01 19:05:30 ferrum-broen-240 volumio[3668]: info: CorePlayQueue::getTrack 0 Jun 01 19:05:30 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 01 19:05:30 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 01 19:05:30 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 01 19:05:31 ferrum-broen-240 volumio[3668]: info: Discovery: this is already registered, be1edeb6-c1e5-4c48-84ef-b96711f7fed3 Jun 01 19:05:31 ferrum-broen-240 volumio[3668]: info: Discovery: Found device Ferrum Broen 240 Jun 01 19:05:31 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::volumioGetState Jun 01 19:05:31 ferrum-broen-240 volumio[3668]: info: CorePlayQueue::getTrack 0 Jun 01 19:05:31 ferrum-broen-240 volumio[3668]: verbose: New Socket.io Connection to 192.168.0.60:3000 from 192.168.0.83 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Jun 01 19:05:31 ferrum-broen-240 volumio[3668]: info: MRS: Adding multiroomSync output Jun 01 19:05:31 ferrum-broen-240 volumio[3668]: info: Adding audio output: Jun 01 19:05:31 ferrum-broen-240 volumio[3668]: info: MRS: Pushing multiroomSync output Jun 01 19:05:31 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 01 19:05:31 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 01 19:05:31 ferrum-broen-240 volumio[3668]: info: Discovery: Getting this device information Jun 01 19:05:31 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::volumioGetState Jun 01 19:05:31 ferrum-broen-240 volumio[3668]: info: CorePlayQueue::getTrack 0 Jun 01 19:05:31 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 01 19:05:31 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Jun 01 19:05:31 ferrum-broen-240 volumio[3668]: verbose: New Socket.io Connection to 192.168.0.60:3000 from 192.168.0.73 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 9 Jun 01 19:05:31 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::volumioGetState Jun 01 19:05:31 ferrum-broen-240 volumio[3668]: info: CorePlayQueue::getTrack 0 Jun 01 19:05:31 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 01 19:05:31 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 01 19:05:31 ferrum-broen-240 volumio[3668]: info: Reporting MCU Network Status: 1 Jun 01 19:05:31 ferrum-broen-240 volumio[3668]: info: Volumio Network Manager: Network status updated: 1 Jun 01 19:05:31 ferrum-broen-240 volumio5-onboarding[2227]: time=2026-06-01T19:05:31.758+02:00 level=INFO msg="service successfully established" component=discovery/localnet Jun 01 19:05:31 ferrum-broen-240 volumio[3668]: verbose: New Socket.io Connection to ferrum-broen-240.local from 192.168.0.2 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/142.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Jun 01 19:05:31 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::volumioGetState Jun 01 19:05:31 ferrum-broen-240 volumio[3668]: info: CorePlayQueue::getTrack 0 Jun 01 19:05:31 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::volumioGetQueue Jun 01 19:05:31 ferrum-broen-240 volumio[3668]: info: CoreStateMachine::getQueue Jun 01 19:05:31 ferrum-broen-240 volumio[3668]: info: CorePlayQueue::getQueue Jun 01 19:05:31 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::executeOnPlugin: system , getHwuuid Jun 01 19:05:31 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::executeOnPlugin: system , getUpdaterChannel Jun 01 19:05:31 ferrum-broen-240 volumio[3668]: info: CALLMETHOD: music_service inputs serialMonitorAction [object Object] Jun 01 19:05:31 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::executeOnPlugin: inputs , serialMonitorAction Jun 01 19:05:31 ferrum-broen-240 volumio[3668]: info: CALLMETHOD: system_controller motivocontrol displaySelection [object Object] Jun 01 19:05:31 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::executeOnPlugin: motivocontrol , displaySelection Jun 01 19:05:32 ferrum-broen-240 ntpd[1155]: IO: Listen normally on 5 eth0 192.168.0.60:123 Jun 01 19:05:32 ferrum-broen-240 ntpd[1155]: IO: new interface(s) found: waking up resolver Jun 01 19:05:32 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:05:32Z INFO fsct_driver::ipc] New IPC client connected, id = 9c0c1433-60ff-4be2-9b46-83613b25096c Jun 01 19:05:32 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:05:32Z INFO fsct_driver::ipc] IPC connection closed, id = 9c0c1433-60ff-4be2-9b46-83613b25096c Jun 01 19:05:32 ferrum-broen-240 volumio[3668]: error: [fsct] reconnect failed: unknown method: get_timesync Jun 01 19:05:34 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:05:34Z INFO fsct_driver::ipc] New IPC client connected, id = 0944657c-7a48-40b6-a93b-5bf510e2d9e5 Jun 01 19:05:34 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:05:34Z INFO fsct_driver::ipc] IPC connection closed, id = 0944657c-7a48-40b6-a93b-5bf510e2d9e5 Jun 01 19:05:34 ferrum-broen-240 volumio[3668]: error: [fsct] reconnect failed: unknown method: get_timesync Jun 01 19:05:36 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:05:36Z INFO fsct_driver::ipc] New IPC client connected, id = 9aa2baa1-f950-46fa-af21-61827cc3e89d Jun 01 19:05:36 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:05:36Z INFO fsct_driver::ipc] IPC connection closed, id = 9aa2baa1-f950-46fa-af21-61827cc3e89d Jun 01 19:05:36 ferrum-broen-240 volumio[3668]: error: [fsct] reconnect failed: unknown method: get_timesync Jun 01 19:05:36 ferrum-broen-240 volumio[3668]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Jun 01 19:05:36 ferrum-broen-240 volumio[3668]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Jun 01 19:05:36 ferrum-broen-240 volumio[3668]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Jun 01 19:05:36 ferrum-broen-240 volumio[3668]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Jun 01 19:05:36 ferrum-broen-240 volumio[3668]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Jun 01 19:05:36 ferrum-broen-240 volumio[3668]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Jun 01 19:05:36 ferrum-broen-240 volumio[3668]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Jun 01 19:05:36 ferrum-broen-240 volumio[3668]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Jun 01 19:05:36 ferrum-broen-240 volumio[3668]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Jun 01 19:05:36 ferrum-broen-240 volumio[3668]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Jun 01 19:05:36 ferrum-broen-240 volumio[3668]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Jun 01 19:05:36 ferrum-broen-240 volumio[3668]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Jun 01 19:05:36 ferrum-broen-240 volumio[3668]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Jun 01 19:05:36 ferrum-broen-240 volumio[3668]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Jun 01 19:05:36 ferrum-broen-240 volumio[3668]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Jun 01 19:05:36 ferrum-broen-240 volumio[3668]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Jun 01 19:05:36 ferrum-broen-240 volumio[3668]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Jun 01 19:05:36 ferrum-broen-240 volumio[3668]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Jun 01 19:05:36 ferrum-broen-240 volumio[3668]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Jun 01 19:05:36 ferrum-broen-240 volumio[3668]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Jun 01 19:05:36 ferrum-broen-240 volumio[3668]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Jun 01 19:05:36 ferrum-broen-240 volumio[3668]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Jun 01 19:05:36 ferrum-broen-240 volumio[3668]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Jun 01 19:05:36 ferrum-broen-240 volumio[3668]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Jun 01 19:05:36 ferrum-broen-240 volumio[3668]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Jun 01 19:05:36 ferrum-broen-240 volumio[3668]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Jun 01 19:05:36 ferrum-broen-240 volumio[3668]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Jun 01 19:05:36 ferrum-broen-240 volumio[3668]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Jun 01 19:05:36 ferrum-broen-240 volumio[3668]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Jun 01 19:05:36 ferrum-broen-240 volumio[3668]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Jun 01 19:05:36 ferrum-broen-240 volumio[3668]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Jun 01 19:05:36 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 01 19:05:36 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 01 19:05:36 ferrum-broen-240 volumio[3668]: info: Starting MyVolumio Remote Streaming Endpoints Jun 01 19:05:36 ferrum-broen-240 volumio[3668]: info: MyVolumio not started Jun 01 19:05:36 ferrum-broen-240 volumio[3668]: info: Initializing device activation check Jun 01 19:05:36 ferrum-broen-240 volumio[3668]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Jun 01 19:05:36 ferrum-broen-240 volumio[3668]: 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 19:05:38 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:05:38Z INFO fsct_driver::ipc] New IPC client connected, id = 25b0a202-7a29-4c9a-ba39-2f73166767be Jun 01 19:05:38 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:05:38Z INFO fsct_driver::ipc] IPC connection closed, id = 25b0a202-7a29-4c9a-ba39-2f73166767be Jun 01 19:05:38 ferrum-broen-240 volumio[3668]: error: [fsct] reconnect failed: unknown method: get_timesync Jun 01 19:05:40 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:05:40Z INFO fsct_driver::ipc] New IPC client connected, id = bf1bc61a-e127-4788-a658-6b3c10cd0311 Jun 01 19:05:40 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:05:40Z INFO fsct_driver::ipc] IPC connection closed, id = bf1bc61a-e127-4788-a658-6b3c10cd0311 Jun 01 19:05:40 ferrum-broen-240 volumio[3668]: error: [fsct] reconnect failed: unknown method: get_timesync Jun 01 19:05:42 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:05:42Z INFO fsct_driver::ipc] New IPC client connected, id = 74573bc3-75c1-4380-a899-e50347d219fa Jun 01 19:05:42 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:05:42Z INFO fsct_driver::ipc] IPC connection closed, id = 74573bc3-75c1-4380-a899-e50347d219fa Jun 01 19:05:42 ferrum-broen-240 volumio[3668]: error: [fsct] reconnect failed: unknown method: get_timesync Jun 01 19:05:44 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:05:44Z INFO fsct_driver::ipc] New IPC client connected, id = 386953a4-9a27-4611-9444-0b6124183d6b Jun 01 19:05:44 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:05:44Z INFO fsct_driver::ipc] IPC connection closed, id = 386953a4-9a27-4611-9444-0b6124183d6b Jun 01 19:05:44 ferrum-broen-240 volumio[3668]: error: [fsct] reconnect failed: unknown method: get_timesync Jun 01 19:05:46 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:05:46Z INFO fsct_driver::ipc] New IPC client connected, id = beee1366-b2f0-4037-9d50-42eb8723ae34 Jun 01 19:05:46 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:05:46Z INFO fsct_driver::ipc] IPC connection closed, id = beee1366-b2f0-4037-9d50-42eb8723ae34 Jun 01 19:05:46 ferrum-broen-240 volumio[3668]: error: [fsct] reconnect failed: unknown method: get_timesync Jun 01 19:05:48 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:05:48Z INFO fsct_driver::ipc] New IPC client connected, id = 6a63775d-71db-4151-afd3-211e2c17ef35 Jun 01 19:05:48 ferrum-broen-240 volumio[3668]: error: [fsct] reconnect failed: unknown method: get_timesync Jun 01 19:05:48 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:05:48Z INFO fsct_driver::ipc] IPC connection closed, id = 6a63775d-71db-4151-afd3-211e2c17ef35 Jun 01 19:05:50 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:05:50Z INFO fsct_driver::ipc] New IPC client connected, id = 8b593417-7830-40bc-8110-ce47851da47e Jun 01 19:05:50 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:05:50Z INFO fsct_driver::ipc] IPC connection closed, id = 8b593417-7830-40bc-8110-ce47851da47e Jun 01 19:05:50 ferrum-broen-240 volumio[3668]: error: [fsct] reconnect failed: unknown method: get_timesync Jun 01 19:05:51 ferrum-broen-240 volumio[3668]: info: Discovery: A device disappeared from network Jun 01 19:05:51 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 01 19:05:51 ferrum-broen-240 volumio[3668]: 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 19:05:51 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::volumioGetState Jun 01 19:05:51 ferrum-broen-240 volumio[3668]: info: CorePlayQueue::getTrack 0 Jun 01 19:05:52 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:05:52Z INFO fsct_driver::ipc] New IPC client connected, id = 13b89d63-bb58-4de7-9aac-ff9930281253 Jun 01 19:05:52 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:05:52Z INFO fsct_driver::ipc] IPC connection closed, id = 13b89d63-bb58-4de7-9aac-ff9930281253 Jun 01 19:05:52 ferrum-broen-240 volumio[3668]: error: [fsct] reconnect failed: unknown method: get_timesync Jun 01 19:05:54 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:05:54Z INFO fsct_driver::ipc] New IPC client connected, id = 2be53fde-c440-4983-94c5-a5dd076456ea Jun 01 19:05:54 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:05:54Z INFO fsct_driver::ipc] IPC connection closed, id = 2be53fde-c440-4983-94c5-a5dd076456ea Jun 01 19:05:54 ferrum-broen-240 volumio[3668]: error: [fsct] reconnect failed: unknown method: get_timesync Jun 01 19:05:56 ferrum-broen-240 volumio[3668]: info: Discovery: adding b6a10235-fc0a-4d6f-ac6e-44f5378c5f3f Jun 01 19:05:56 ferrum-broen-240 volumio[3668]: info: Discovery: Found device Ferrum Broen 238 Jun 01 19:05:56 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:05:56Z INFO fsct_driver::ipc] New IPC client connected, id = faebb658-273a-4b3b-83b1-ee668287ae31 Jun 01 19:05:56 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:05:56Z INFO fsct_driver::ipc] IPC connection closed, id = faebb658-273a-4b3b-83b1-ee668287ae31 Jun 01 19:05:56 ferrum-broen-240 volumio[3668]: error: [fsct] reconnect failed: unknown method: get_timesync Jun 01 19:05:56 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 01 19:05:56 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 01 19:05:56 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Jun 01 19:05:56 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jun 01 19:05:56 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Jun 01 19:05:56 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::volumioGetBrowseSources Jun 01 19:05:56 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 01 19:05:58 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:05:58Z INFO fsct_driver::ipc] New IPC client connected, id = 87a27885-7d49-4107-bf62-f5a4b92ca42c Jun 01 19:05:58 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:05:58Z INFO fsct_driver::ipc] IPC connection closed, id = 87a27885-7d49-4107-bf62-f5a4b92ca42c Jun 01 19:05:58 ferrum-broen-240 volumio[3668]: error: [fsct] reconnect failed: unknown method: get_timesync Jun 01 19:06:00 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:06:00Z INFO fsct_driver::ipc] New IPC client connected, id = 96bb2605-843a-4b83-885f-8f60b66dd424 Jun 01 19:06:00 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:06:00Z INFO fsct_driver::ipc] IPC connection closed, id = 96bb2605-843a-4b83-885f-8f60b66dd424 Jun 01 19:06:00 ferrum-broen-240 volumio[3668]: error: [fsct] reconnect failed: unknown method: get_timesync Jun 01 19:06:02 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:06:02Z INFO fsct_driver::ipc] New IPC client connected, id = 535f4c22-cc2c-48c2-ae1c-4e8471ad041e Jun 01 19:06:02 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:06:02Z INFO fsct_driver::ipc] IPC connection closed, id = 535f4c22-cc2c-48c2-ae1c-4e8471ad041e Jun 01 19:06:02 ferrum-broen-240 volumio[3668]: error: [fsct] reconnect failed: unknown method: get_timesync Jun 01 19:06:04 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:06:04Z INFO fsct_driver::ipc] New IPC client connected, id = 6b1033f9-51b6-4e2d-be1c-7a011b844a17 Jun 01 19:06:04 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:06:04Z INFO fsct_driver::ipc] IPC connection closed, id = 6b1033f9-51b6-4e2d-be1c-7a011b844a17 Jun 01 19:06:04 ferrum-broen-240 volumio[3668]: error: [fsct] reconnect failed: unknown method: get_timesync Jun 01 19:06:06 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:06:06Z INFO fsct_driver::ipc] New IPC client connected, id = 486d1ab4-510c-4ca7-a85a-7ec95198d726 Jun 01 19:06:06 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:06:06Z INFO fsct_driver::ipc] IPC connection closed, id = 486d1ab4-510c-4ca7-a85a-7ec95198d726 Jun 01 19:06:06 ferrum-broen-240 volumio[3668]: error: [fsct] reconnect failed: unknown method: get_timesync Jun 01 19:06:08 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:06:08Z INFO fsct_driver::ipc] New IPC client connected, id = 2ec1d358-6961-464a-a0b3-42cd83ec2603 Jun 01 19:06:08 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:06:08Z INFO fsct_driver::ipc] IPC connection closed, id = 2ec1d358-6961-464a-a0b3-42cd83ec2603 Jun 01 19:06:08 ferrum-broen-240 volumio[3668]: error: [fsct] reconnect failed: unknown method: get_timesync Jun 01 19:06:10 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:06:10Z INFO fsct_driver::ipc] New IPC client connected, id = 9f43b377-bc41-4ade-8765-861f56af3454 Jun 01 19:06:10 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:06:10Z INFO fsct_driver::ipc] IPC connection closed, id = 9f43b377-bc41-4ade-8765-861f56af3454 Jun 01 19:06:10 ferrum-broen-240 volumio[3668]: error: [fsct] reconnect failed: unknown method: get_timesync Jun 01 19:06:12 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:06:12Z INFO fsct_driver::ipc] New IPC client connected, id = 826cc7e8-c262-414a-995d-581673478923 Jun 01 19:06:12 ferrum-broen-240 volumio[3668]: error: [fsct] reconnect failed: unknown method: get_timesync Jun 01 19:06:12 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:06:12Z INFO fsct_driver::ipc] IPC connection closed, id = 826cc7e8-c262-414a-995d-581673478923 Jun 01 19:06:14 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:06:14Z INFO fsct_driver::ipc] New IPC client connected, id = 16859f84-682c-4a06-a5a2-6d1664fed33b Jun 01 19:06:14 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:06:14Z INFO fsct_driver::ipc] IPC connection closed, id = 16859f84-682c-4a06-a5a2-6d1664fed33b Jun 01 19:06:14 ferrum-broen-240 volumio[3668]: error: [fsct] reconnect failed: unknown method: get_timesync Jun 01 19:06:16 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:06:16Z INFO fsct_driver::ipc] New IPC client connected, id = 43dd446b-b4b3-4d04-b0ce-ff2078d8100f Jun 01 19:06:16 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:06:16Z INFO fsct_driver::ipc] IPC connection closed, id = 43dd446b-b4b3-4d04-b0ce-ff2078d8100f Jun 01 19:06:16 ferrum-broen-240 volumio[3668]: error: [fsct] reconnect failed: unknown method: get_timesync Jun 01 19:06:18 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:06:18Z INFO fsct_driver::ipc] New IPC client connected, id = 204161ea-19ad-4270-9082-d0a743f30ea4 Jun 01 19:06:18 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:06:18Z INFO fsct_driver::ipc] IPC connection closed, id = 204161ea-19ad-4270-9082-d0a743f30ea4 Jun 01 19:06:18 ferrum-broen-240 volumio[3668]: error: [fsct] reconnect failed: unknown method: get_timesync Jun 01 19:06:20 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:06:20Z INFO fsct_driver::ipc] New IPC client connected, id = df09d279-d660-445d-8e9c-13230e8981f4 Jun 01 19:06:20 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:06:20Z INFO fsct_driver::ipc] IPC connection closed, id = df09d279-d660-445d-8e9c-13230e8981f4 Jun 01 19:06:20 ferrum-broen-240 volumio[3668]: error: [fsct] reconnect failed: unknown method: get_timesync Jun 01 19:06:22 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:06:22Z INFO fsct_driver::ipc] New IPC client connected, id = 7bc8c848-3e0b-41b2-9b97-8adab3279dc8 Jun 01 19:06:22 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:06:22Z INFO fsct_driver::ipc] IPC connection closed, id = 7bc8c848-3e0b-41b2-9b97-8adab3279dc8 Jun 01 19:06:22 ferrum-broen-240 volumio[3668]: error: [fsct] reconnect failed: unknown method: get_timesync Jun 01 19:06:24 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:06:24Z INFO fsct_driver::ipc] New IPC client connected, id = e0192faa-759f-4f99-9bfe-1f40c81ba34e Jun 01 19:06:24 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:06:24Z INFO fsct_driver::ipc] IPC connection closed, id = e0192faa-759f-4f99-9bfe-1f40c81ba34e Jun 01 19:06:24 ferrum-broen-240 volumio[3668]: error: [fsct] reconnect failed: unknown method: get_timesync Jun 01 19:06:25 ferrum-broen-240 kernel: usb 5-1: USB disconnect, device number 2 Jun 01 19:06:25 ferrum-broen-240 kernel: sd 0:0:0:0: [sda] Synchronizing SCSI cache Jun 01 19:06:25 ferrum-broen-240 kernel: sd 0:0:0:0: [sda] Synchronize Cache(10) failed: Result: hostbyte=0x01 driverbyte=DRIVER_OK Jun 01 19:06:25 ferrum-broen-240 volumio[3668]: info: Partition removed: {"syspath":"/sys/devices/platform/axi/1000120000.pcie/1f00300000.usb/xhci-hcd.1/usb5/5-1/5-1:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","ACTION":"remove","CURRENT_TAGS":":systemd:","DEVLINKS":"/dev/disk/by-partuuid/6dc493e6-c1ed-4900-aedb-581f59562db2 /dev/disk/by-id/usb-ADATA_USB_Flash_Drive_2961208090230013-0:0-part1 /dev/disk/by-uuid/92A2-76A5 /dev/disk/by-partlabel/Basic\\x20data\\x20partition /dev/disk/by-path/platform-xhci-hcd.1-usb-0:1:1.0-scsi-0:0:0:0-part1 /dev/disk/by-label/PENDRIVE","DEVNAME":"/dev/sda1","DEVPATH":"/devices/platform/axi/1000120000.pcie/1f00300000.usb/xhci-hcd.1/usb5/5-1/5-1:1.0/host0/target0:0:0/0:0:0:0/block/sda/sda1","DEVTYPE":"partition","DISKSEQ":"30","ID_BUS":"usb","ID_FS_LABEL":"PENDRIVE","ID_FS_LABEL_ENC":"PENDRIVE","ID_FS_TYPE":"vfat","ID_FS_USAGE":"filesystem","ID_FS_UUID":"92A2-76A5","ID_FS_UUID_ENC":"92A2-76A5","ID_FS_VERSION":"FAT32","ID_INSTANCE":"0:0","ID_MODEL":"USB_Flash_Drive","ID_MODEL_ENC":"USB\\x20Flash\\x20Drive\\x20","ID_MODEL_ID":"312b","ID_PART_ENTRY_DISK":"8:0","ID_PART_ENTRY_NAME":"Basic\\x20data\\x20partition","ID_PART_ENTRY_NUMBER":"1","ID_PART_ENTRY_OFFSET":"2048","ID_PART_ENTRY_SCHEME":"gpt","ID_PART_ENTRY_SIZE":"30306304","ID_PART_ENTRY_TYPE":"ebd0a0a2-b9e5-4433-87c0-68b6b72699c7","ID_PART_ENTRY_UUID":"6dc493e6-c1ed-4900-aedb-581f59562db2","ID_PART_TABLE_TYPE":"gpt","ID_PART_TABLE_UUID":"ea1e6ff5-2143-48fe-b303-2a83a70100a7","ID_PATH":"platform-xhci-hcd.1-usb-0:1:1.0-scsi-0:0:0:0","ID_PATH_TAG":"platform-xhci-hcd_1-usb-0_1_1_0-scsi-0_0_0_0","ID_REVISION":"1100","ID_SERIAL":"ADATA_USB_Flash_Drive_2961208090230013-0:0","ID_SERIAL_SHORT":"2961208090230013","ID_TYPE":"disk","ID_USB_DRIVER":"usb-storage","ID_USB_INSTANCE":"0:0","ID_USB_INTERFACES":":080650:","ID_USB_INTERFACE_NUM":"00","ID_USB_MODEL":"USB_Flash_Drive","ID_USB_MODEL_ENC":"USB\\x20Flash\\x20Drive\\x20","ID_USB_MODEL_ID":"312b","ID_USB_REVISION":"1100","ID_USB_SERIAL":"ADATA_USB_Flash_Drive_2961208090230013-0:0","ID_USB_SERIAL_SHORT":"2961208090230013","ID_USB_TYPE":"disk","ID_USB_VENDOR":"ADATA","ID_USB_VENDOR_ENC":"ADATA\\x20\\x20\\x20","ID_USB_VENDOR_ID":"125f","ID_VENDOR":"ADATA","ID_VENDOR_ENC":"ADATA\\x20\\x20\\x20","ID_VENDOR_ID":"125f","MAJOR":"8","MINOR":"1","PARTN":"1","PARTNAME":"Basic data partition","SEQNUM":"3355","SUBSYSTEM":"block","TAGS":":systemd:","USEC_INITIALIZED":"119526797"} Jun 01 19:06:25 ferrum-broen-240 sudo[4278]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/umount -f /dev/sda1 Jun 01 19:06:25 ferrum-broen-240 sudo[4278]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 01 19:06:25 ferrum-broen-240 systemd[1]: media-PENDRIVE.mount: Deactivated successfully. Jun 01 19:06:25 ferrum-broen-240 sudo[4278]: pam_unix(sudo:session): session closed for user root Jun 01 19:06:26 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:06:26Z INFO fsct_driver::ipc] New IPC client connected, id = 5a8babb6-2e4f-40c4-ad18-fa1c4f7c3ebc Jun 01 19:06:26 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:06:26Z INFO fsct_driver::ipc] IPC connection closed, id = 5a8babb6-2e4f-40c4-ad18-fa1c4f7c3ebc Jun 01 19:06:26 ferrum-broen-240 volumio[3668]: error: [fsct] reconnect failed: unknown method: get_timesync Jun 01 19:06:28 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:06:28Z INFO fsct_driver::ipc] New IPC client connected, id = 689e1ff8-0349-4d3e-a15d-fd6f6ae94fa3 Jun 01 19:06:28 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:06:28Z INFO fsct_driver::ipc] IPC connection closed, id = 689e1ff8-0349-4d3e-a15d-fd6f6ae94fa3 Jun 01 19:06:28 ferrum-broen-240 volumio[3668]: error: [fsct] reconnect failed: unknown method: get_timesync Jun 01 19:06:29 ferrum-broen-240 volumio[3668]: info: TEST: Here we shall have deleted mounted folder: /mnt/USB/PENDRIVE Jun 01 19:06:30 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:06:30Z INFO fsct_driver::ipc] New IPC client connected, id = 509d8b98-c107-4afb-b4f7-ee4221f143cc Jun 01 19:06:30 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:06:30Z INFO fsct_driver::ipc] IPC connection closed, id = 509d8b98-c107-4afb-b4f7-ee4221f143cc Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: error: [fsct] reconnect failed: unknown method: get_timesync Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: Scanning removed location : "USB/PENDRIVE" Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: verbose: ControllerMpd::sendMpdCommand status Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: ---------------------------- MPD announces state update: update Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: ControllerMpd::getState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: verbose: ControllerMpd::sendMpdCommand status Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: verbose: ControllerMpd::sendMpdCommand status Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: ---------------------------- MPD announces state update: update Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: ControllerMpd::getState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: verbose: ControllerMpd::sendMpdCommand status Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: verbose: ControllerMpd::sendMpdCommand status Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: ---------------------------- MPD announces state update: update Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: MPD Database updated - AlbumList cache refreshed Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: ---------------------------- MPD announces state update: database Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: verbose: ControllerMpd::sendMpdCommand status Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: ---------------------------- MPD announces state update: update Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: ControllerMpd::getState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: verbose: ControllerMpd::sendMpdCommand status Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: sendMpdCommand status took 4 milliseconds Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: ControllerMpd::getState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: verbose: ControllerMpd::sendMpdCommand status Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: ControllerMpd::getState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: verbose: ControllerMpd::sendMpdCommand status Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: sendMpdCommand status took 4 milliseconds Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: sendMpdCommand status took 3 milliseconds Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: sendMpdCommand status took 3 milliseconds Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: verbose: ControllerMpd::parseState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: Command Router : Notfying DB Updatefalse Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::Close All Modals sent Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: verbose: ControllerMpd::parseState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: verbose: ControllerMpd::parseState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: Command Router : Notfying DB Updatefalse Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::Close All Modals sent Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: verbose: ControllerMpd::parseState Jun 01 19:06:30 ferrum-broen-240 systemd-logind[1009]: Power key pressed short. Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: ControllerMpd::pushState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::servicePushState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreStateMachine::pushState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CorePlayQueue::getTrack 0 Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::volumioPushState Jun 01 19:06:30 ferrum-broen-240 systemd-logind[1009]: Powering off... Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: MRS: Pushing multiroomSync output update for this device Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: MRS: Pushing multiroomSync output Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CorePlayQueue::getTrack 0 Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: verbose: CURRENT POSITION 0 Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreStateMachine::syncState stateService stop Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreStateMachine::syncState currentStatus stop Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreStateMachine::pushState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CorePlayQueue::getTrack 0 Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::volumioPushState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: MRS: Pushing multiroomSync output update for this device Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: MRS: Pushing multiroomSync output Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: No code Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreStateMachine::pushState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CorePlayQueue::getTrack 0 Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::volumioPushState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: MRS: Pushing multiroomSync output update for this device Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: MRS: Pushing multiroomSync output Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: ControllerMpd::pushState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::servicePushState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreStateMachine::pushState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CorePlayQueue::getTrack 0 Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::volumioPushState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: MRS: Pushing multiroomSync output update for this device Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: MRS: Pushing multiroomSync output Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CorePlayQueue::getTrack 0 Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: verbose: CURRENT POSITION 0 Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreStateMachine::syncState stateService stop Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreStateMachine::syncState currentStatus stop Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreStateMachine::pushState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CorePlayQueue::getTrack 0 Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::volumioPushState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: MRS: Pushing multiroomSync output update for this device Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: MRS: Pushing multiroomSync output Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: No code Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreStateMachine::pushState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CorePlayQueue::getTrack 0 Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::volumioPushState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: MRS: Pushing multiroomSync output update for this device Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: MRS: Pushing multiroomSync output Jun 01 19:06:30 ferrum-broen-240 systemd-logind[1009]: System is powering down. Jun 01 19:06:30 ferrum-broen-240 sshd[3126]: pam_unix(sshd:session): session closed for user volumiooem Jun 01 19:06:30 ferrum-broen-240 systemd[1]: Stopping session-1.scope - Session 1 of User volumiooem... Jun 01 19:06:30 ferrum-broen-240 systemd[1]: Removed slice system-modprobe.slice - Slice /system/modprobe. Jun 01 19:06:30 ferrum-broen-240 systemd[1]: Stopped target bluetooth.target - Bluetooth Support. Jun 01 19:06:30 ferrum-broen-240 systemd[1]: Stopped target graphical.target - Graphical Interface. Jun 01 19:06:30 ferrum-broen-240 systemd[1]: Stopped target ip-changed@eth0.target - IP Address changed on eth0. Jun 01 19:06:30 ferrum-broen-240 systemd[1]: Stopped target ip-changed@wlan0.target - IP Address changed on wlan0. Jun 01 19:06:30 ferrum-broen-240 systemd[1]: Stopped target rpc_pipefs.target. Jun 01 19:06:30 ferrum-broen-240 systemd[1]: Stopped target rpcbind.target - RPC Port Mapper. Jun 01 19:06:30 ferrum-broen-240 systemd[1]: Stopped target timers.target - Timer Units. Jun 01 19:06:30 ferrum-broen-240 systemd[1]: apt-daily-upgrade.timer: Deactivated successfully. Jun 01 19:06:30 ferrum-broen-240 systemd[1]: Stopped apt-daily-upgrade.timer - Daily apt upgrade and clean activities. Jun 01 19:06:30 ferrum-broen-240 systemd[1]: apt-daily.timer: Deactivated successfully. Jun 01 19:06:30 ferrum-broen-240 systemd[1]: Stopped apt-daily.timer - Daily apt download activities. Jun 01 19:06:30 ferrum-broen-240 systemd[1]: dpkg-db-backup.timer: Deactivated successfully. Jun 01 19:06:30 ferrum-broen-240 systemd[1]: Stopped dpkg-db-backup.timer - Daily dpkg database backup timer. Jun 01 19:06:30 ferrum-broen-240 systemd[1]: e2scrub_all.timer: Deactivated successfully. Jun 01 19:06:30 ferrum-broen-240 systemd[1]: Stopped e2scrub_all.timer - Periodic ext4 Online Metadata Check for All Filesystems. Jun 01 19:06:30 ferrum-broen-240 systemd[1]: fstrim.timer: Deactivated successfully. Jun 01 19:06:30 ferrum-broen-240 systemd[1]: Stopped fstrim.timer - Discard unused blocks once a week. Jun 01 19:06:30 ferrum-broen-240 systemd[1]: ntpsec-rotate-stats.timer: Deactivated successfully. Jun 01 19:06:30 ferrum-broen-240 systemd[1]: Stopped ntpsec-rotate-stats.timer - Rotate ntpd stats daily. Jun 01 19:06:30 ferrum-broen-240 systemd[1]: setdatetime-helper.timer: Deactivated successfully. Jun 01 19:06:30 ferrum-broen-240 systemd[1]: Stopped setdatetime-helper.timer - Volumio Time Sync Watchdog Timer. Jun 01 19:06:30 ferrum-broen-240 systemd[1]: systemd-tmpfiles-clean.timer: Deactivated successfully. Jun 01 19:06:30 ferrum-broen-240 systemd[1]: Stopped systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Jun 01 19:06:30 ferrum-broen-240 systemd[1]: systemd-rfkill.socket: Deactivated successfully. Jun 01 19:06:30 ferrum-broen-240 systemd[1]: Closed systemd-rfkill.socket - Load/Save RF Kill Switch Status /dev/rfkill Watch. Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: ------------------------------ 116ms Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: ------------------------------ 115ms Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: MPD Database updated - AlbumList cache refreshed Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: ---------------------------- MPD announces state update: database Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: verbose: ControllerMpd::sendMpdCommand status Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: ---------------------------- MPD announces state update: update Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: ControllerMpd::getState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: verbose: ControllerMpd::sendMpdCommand status Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: ControllerMpd::getState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: verbose: ControllerMpd::sendMpdCommand status Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: MPD Database updated - AlbumList cache refreshed Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: ---------------------------- MPD announces state update: database Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: verbose: ControllerMpd::sendMpdCommand status Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: ---------------------------- MPD announces state update: update Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: ControllerMpd::getState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: verbose: ControllerMpd::sendMpdCommand status Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: ControllerMpd::getState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: verbose: ControllerMpd::sendMpdCommand status Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: sendMpdCommand status took 121 milliseconds Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: sendMpdCommand status took 120 milliseconds Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: sendMpdCommand status took 120 milliseconds Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: sendMpdCommand status took 120 milliseconds Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: sendMpdCommand status took 119 milliseconds Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: sendMpdCommand status took 3 milliseconds Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: sendMpdCommand status took 9 milliseconds Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: sendMpdCommand status took 9 milliseconds Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: sendMpdCommand status took 8 milliseconds Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: sendMpdCommand status took 8 milliseconds Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: sendMpdCommand status took 8 milliseconds Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: verbose: ControllerMpd::parseState Jun 01 19:06:30 ferrum-broen-240 systemd[1]: Unmounting run-rpc_pipefs.mount - RPC Pipe File System... Jun 01 19:06:30 ferrum-broen-240 systemd[1]: Stopping bluealsa.service - BlueALSA service... Jun 01 19:06:30 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:06:30Z INFO fsct_driver::orchestrator] Orchestrator shutdown requested Jun 01 19:06:30 ferrum-broen-240 systemd[1]: Stopping fsct-driver.service - FSCT driver... Jun 01 19:06:30 ferrum-broen-240 fsctd[2287]: [2026-06-01T17:06:30Z INFO fsct_driver::ipc] IPC server stopped Jun 01 19:06:30 ferrum-broen-240 bluealsa[1085]: ../src/ba-adapter.c:144: Freeing adapter: hci0 Jun 01 19:06:30 ferrum-broen-240 systemd[1]: Stopping ifplugd.service - LSB: Brings up/down network automatically... Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: Command Router : Notfying DB Updatefalse Jun 01 19:06:30 ferrum-broen-240 systemd[1]: Stopping mpd.service - Music Player Daemon... Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::Close All Modals sent Jun 01 19:06:30 ferrum-broen-240 bluetoothd[979]: Endpoint unregistered: sender=:1.6 path=/org/bluez/hci0/A2DP/SBC/source/1 Jun 01 19:06:30 ferrum-broen-240 systemd[1]: Starting plymouth-poweroff.service - Show Plymouth Power Off Screen... Jun 01 19:06:30 ferrum-broen-240 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 19:06:30 ferrum-broen-240 bluetoothd[979]: Endpoint unregistered: sender=:1.6 path=/org/bluez/hci0/A2DP/SBC/sink/2 Jun 01 19:06:30 ferrum-broen-240 systemd[1]: Stopping systemd-random-seed.service - Load/Save Random Seed... Jun 01 19:06:30 ferrum-broen-240 systemd[1]: Stopping volumio5-onboarding.service - Volumio5 Onboarding Server... Jun 01 19:06:30 ferrum-broen-240 bluetoothd[979]: Endpoint unregistered: sender=:1.6 path=/org/bluez/hci0/A2DP/SBC/source/2 Jun 01 19:06:30 ferrum-broen-240 systemd[1]: Stopping volumiobt.service - Volumio Bluetooth Module... Jun 01 19:06:30 ferrum-broen-240 systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service... Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: verbose: ControllerMpd::parseState Jun 01 19:06:30 ferrum-broen-240 systemd[1]: bluealsa.service: Deactivated successfully. Jun 01 19:06:30 ferrum-broen-240 bluetoothd[979]: Endpoint unregistered: sender=:1.6 path=/org/bluez/hci0/A2DP/SBC/sink/1 Jun 01 19:06:30 ferrum-broen-240 systemd[1]: Stopped bluealsa.service - BlueALSA service. Jun 01 19:06:30 ferrum-broen-240 systemd[1]: volumio5-onboarding.service: Deactivated successfully. Jun 01 19:06:30 ferrum-broen-240 systemd[1]: Stopped volumio5-onboarding.service - Volumio5 Onboarding Server. Jun 01 19:06:30 ferrum-broen-240 systemd[1]: fsct-driver.service: Deactivated successfully. Jun 01 19:06:30 ferrum-broen-240 systemd[1]: Stopped fsct-driver.service - FSCT driver. Jun 01 19:06:30 ferrum-broen-240 systemd[1]: vtcs.service: Deactivated successfully. Jun 01 19:06:30 ferrum-broen-240 volumiobt[4312]: INFO [BTSTART] Disconnecting all Bluetooth devices... Jun 01 19:06:30 ferrum-broen-240 systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service. Jun 01 19:06:30 ferrum-broen-240 systemd[1]: run-rpc_pipefs.mount: Deactivated successfully. Jun 01 19:06:30 ferrum-broen-240 systemd[1]: Unmounted run-rpc_pipefs.mount - RPC Pipe File System. Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: Command Router : Notfying DB Updatefalse Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::Close All Modals sent Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: verbose: ControllerMpd::parseState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: verbose: ControllerMpd::parseState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: verbose: ControllerMpd::parseState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: verbose: ControllerMpd::parseState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: Command Router : Notfying DB Updatefalse Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::Close All Modals sent Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: verbose: ControllerMpd::parseState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: verbose: ControllerMpd::parseState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: verbose: ControllerMpd::parseState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: Command Router : Notfying DB Updatefalse Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::Close All Modals sent Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: verbose: ControllerMpd::parseState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: verbose: ControllerMpd::parseState Jun 01 19:06:30 ferrum-broen-240 systemd[1]: mpd.service: Deactivated successfully. Jun 01 19:06:30 ferrum-broen-240 systemd[1]: Stopped mpd.service - Music Player Daemon. Jun 01 19:06:30 ferrum-broen-240 systemd[1]: systemd-random-seed.service: Deactivated successfully. Jun 01 19:06:30 ferrum-broen-240 systemd[1]: Stopped systemd-random-seed.service - Load/Save Random Seed. Jun 01 19:06:30 ferrum-broen-240 systemd[1]: Received SIGRTMIN+20 from PID 4306 (plymouthd). Jun 01 19:06:30 ferrum-broen-240 systemd[1]: session-1.scope: Deactivated successfully. Jun 01 19:06:30 ferrum-broen-240 systemd[1]: Stopped session-1.scope - Session 1 of User volumiooem. Jun 01 19:06:30 ferrum-broen-240 systemd[1]: session-1.scope: Consumed 4.150s CPU time. Jun 01 19:06:30 ferrum-broen-240 bluetoothd[979]: Path / reserved for Adv Monitor app :1.58 Jun 01 19:06:30 ferrum-broen-240 systemd-logind[1009]: Session 1 logged out. Waiting for processes to exit. Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: ControllerMpd::pushState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::servicePushState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreStateMachine::pushState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CorePlayQueue::getTrack 0 Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::volumioPushState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: MRS: Pushing multiroomSync output update for this device Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: MRS: Pushing multiroomSync output Jun 01 19:06:30 ferrum-broen-240 systemd[1]: Started plymouth-poweroff.service - Show Plymouth Power Off Screen. Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CorePlayQueue::getTrack 0 Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: verbose: CURRENT POSITION 0 Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreStateMachine::syncState stateService stop Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreStateMachine::syncState currentStatus stop Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreStateMachine::pushState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CorePlayQueue::getTrack 0 Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::volumioPushState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: MRS: Pushing multiroomSync output update for this device Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: MRS: Pushing multiroomSync output Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: No code Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreStateMachine::pushState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CorePlayQueue::getTrack 0 Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::volumioPushState Jun 01 19:06:30 ferrum-broen-240 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 19:06:30 ferrum-broen-240 volumio[3668]: info: MRS: Pushing multiroomSync output update for this device Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: MRS: Pushing multiroomSync output Jun 01 19:06:30 ferrum-broen-240 systemd[1]: Stopping user@1001.service - User Manager for UID 1001... Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: ControllerMpd::pushState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::servicePushState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreStateMachine::pushState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CorePlayQueue::getTrack 0 Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::volumioPushState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: MRS: Pushing multiroomSync output update for this device Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: MRS: Pushing multiroomSync output Jun 01 19:06:30 ferrum-broen-240 systemd[3161]: Activating special unit exit.target... Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CorePlayQueue::getTrack 0 Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: verbose: CURRENT POSITION 0 Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreStateMachine::syncState stateService stop Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreStateMachine::syncState currentStatus stop Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreStateMachine::pushState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CorePlayQueue::getTrack 0 Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::volumioPushState Jun 01 19:06:30 ferrum-broen-240 systemd[3161]: Stopped target default.target - Main User Target. Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: MRS: Pushing multiroomSync output update for this device Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: MRS: Pushing multiroomSync output Jun 01 19:06:30 ferrum-broen-240 systemd[3161]: Stopping mpris-proxy.service - Bluetooth mpris proxy... Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: No code Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreStateMachine::pushState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CorePlayQueue::getTrack 0 Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::volumioPushState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: MRS: Pushing multiroomSync output update for this device Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: MRS: Pushing multiroomSync output Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: ControllerMpd::pushState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::servicePushState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreStateMachine::pushState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CorePlayQueue::getTrack 0 Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::volumioPushState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: MRS: Pushing multiroomSync output update for this device Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: MRS: Pushing multiroomSync output Jun 01 19:06:30 ferrum-broen-240 systemd[1]: ifplugd.service: Deactivated successfully. Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CorePlayQueue::getTrack 0 Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: verbose: CURRENT POSITION 0 Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreStateMachine::syncState stateService stop Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreStateMachine::syncState currentStatus stop Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreStateMachine::pushState Jun 01 19:06:30 ferrum-broen-240 systemd[1]: Stopped ifplugd.service - LSB: Brings up/down network automatically. Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CorePlayQueue::getTrack 0 Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::volumioPushState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: MRS: Pushing multiroomSync output update for this device Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: MRS: Pushing multiroomSync output Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: No code Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreStateMachine::pushState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CorePlayQueue::getTrack 0 Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::volumioPushState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: MRS: Pushing multiroomSync output update for this device Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: MRS: Pushing multiroomSync output Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: ControllerMpd::pushState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::servicePushState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreStateMachine::pushState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CorePlayQueue::getTrack 0 Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::volumioPushState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: MRS: Pushing multiroomSync output update for this device Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: MRS: Pushing multiroomSync output Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CorePlayQueue::getTrack 0 Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: verbose: CURRENT POSITION 0 Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreStateMachine::syncState stateService stop Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreStateMachine::syncState currentStatus stop Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreStateMachine::pushState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CorePlayQueue::getTrack 0 Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::volumioPushState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: MRS: Pushing multiroomSync output update for this device Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: MRS: Pushing multiroomSync output Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: No code Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreStateMachine::pushState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CorePlayQueue::getTrack 0 Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::volumioPushState Jun 01 19:06:30 ferrum-broen-240 systemd-logind[1009]: Removed session 1. Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: MRS: Pushing multiroomSync output update for this device Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: MRS: Pushing multiroomSync output Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: ControllerMpd::pushState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::servicePushState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreStateMachine::pushState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CorePlayQueue::getTrack 0 Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::volumioPushState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: MRS: Pushing multiroomSync output update for this device Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: MRS: Pushing multiroomSync output Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CorePlayQueue::getTrack 0 Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: verbose: CURRENT POSITION 0 Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreStateMachine::syncState stateService stop Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreStateMachine::syncState currentStatus stop Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreStateMachine::pushState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CorePlayQueue::getTrack 0 Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::volumioPushState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: MRS: Pushing multiroomSync output update for this device Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: MRS: Pushing multiroomSync output Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: No code Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreStateMachine::pushState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CorePlayQueue::getTrack 0 Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::volumioPushState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: MRS: Pushing multiroomSync output update for this device Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: MRS: Pushing multiroomSync output Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: ControllerMpd::pushState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::servicePushState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreStateMachine::pushState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CorePlayQueue::getTrack 0 Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::volumioPushState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: MRS: Pushing multiroomSync output update for this device Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: MRS: Pushing multiroomSync output Jun 01 19:06:30 ferrum-broen-240 bluetoothd[979]: Adv Monitor app :1.58 disconnected from D-Bus Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CorePlayQueue::getTrack 0 Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: verbose: CURRENT POSITION 0 Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreStateMachine::syncState stateService stop Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreStateMachine::syncState currentStatus stop Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreStateMachine::pushState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CorePlayQueue::getTrack 0 Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::volumioPushState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: MRS: Pushing multiroomSync output update for this device Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: MRS: Pushing multiroomSync output Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: No code Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreStateMachine::pushState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CorePlayQueue::getTrack 0 Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::volumioPushState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: MRS: Pushing multiroomSync output update for this device Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: MRS: Pushing multiroomSync output Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: ControllerMpd::pushState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::servicePushState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreStateMachine::pushState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CorePlayQueue::getTrack 0 Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::volumioPushState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: MRS: Pushing multiroomSync output update for this device Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: MRS: Pushing multiroomSync output Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CorePlayQueue::getTrack 0 Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: verbose: CURRENT POSITION 0 Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreStateMachine::syncState stateService stop Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreStateMachine::syncState currentStatus stop Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreStateMachine::pushState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CorePlayQueue::getTrack 0 Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::volumioPushState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: MRS: Pushing multiroomSync output update for this device Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: MRS: Pushing multiroomSync output Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: No code Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreStateMachine::pushState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CorePlayQueue::getTrack 0 Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: CoreCommandRouter::volumioPushState Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: MRS: Pushing multiroomSync output update for this device Jun 01 19:06:30 ferrum-broen-240 volumio[3668]: info: MRS: Pushing multiroomSync output Jun 01 19:06:30 ferrum-broen-240 mpris-proxy[3177]: org.bluez appeared Jun 01 19:06:30 ferrum-broen-240 mpris-proxy[3177]: Bluetooth Adapter /org/bluez/hci0 found Jun 01 19:06:30 ferrum-broen-240 mpris-proxy[3177]: Bluetooth Adapter /org/bluez/hci0 removed Jun 01 19:06:30 ferrum-broen-240 mpris-proxy[3177]: org.bluez disappeared Jun 01 19:06:30 ferrum-broen-240 systemd[3161]: Stopped mpris-proxy.service - Bluetooth mpris proxy. Jun 01 19:06:30 ferrum-broen-240 systemd[3161]: Stopping dbus.service - D-Bus User Message Bus... Jun 01 19:06:30 ferrum-broen-240 systemd[3161]: Stopped dbus.service - D-Bus User Message Bus. Jun 01 19:06:30 ferrum-broen-240 systemd[3161]: Removed slice session.slice - User Core Session Slice. Jun 01 19:06:30 ferrum-broen-240 systemd[3161]: Stopped target basic.target - Basic System. Jun 01 19:06:30 ferrum-broen-240 systemd[3161]: Stopped target paths.target - Paths. Jun 01 19:06:30 ferrum-broen-240 systemd[3161]: Stopped target sockets.target - Sockets. Jun 01 19:06:30 ferrum-broen-240 systemd[3161]: Stopped target timers.target - Timers. Jun 01 19:06:30 ferrum-broen-240 systemd[3161]: Closed dbus.socket - D-Bus User Message Bus Socket. Jun 01 19:06:30 ferrum-broen-240 systemd[3161]: Closed dirmngr.socket - GnuPG network certificate management daemon. Jun 01 19:06:30 ferrum-broen-240 systemd[3161]: Closed gpg-agent-browser.socket - GnuPG cryptographic agent and passphrase cache (access for web browsers). Jun 01 19:06:30 ferrum-broen-240 systemd[3161]: Closed gpg-agent-extra.socket - GnuPG cryptographic agent and passphrase cache (restricted). Jun 01 19:06:30 ferrum-broen-240 systemd[3161]: Closed gpg-agent-ssh.socket - GnuPG cryptographic agent (ssh-agent emulation). Jun 01 19:06:30 ferrum-broen-240 systemd[3161]: Closed gpg-agent.socket - GnuPG cryptographic agent and passphrase cache. Jun 01 19:06:30 ferrum-broen-240 systemd[3161]: Removed slice app.slice - User Application Slice. Jun 01 19:06:30 ferrum-broen-240 systemd[3161]: Reached target shutdown.target - Shutdown. Jun 01 19:06:30 ferrum-broen-240 systemd[3161]: Finished systemd-exit.service - Exit the Session. Jun 01 19:06:30 ferrum-broen-240 systemd[3161]: Reached target exit.target - Exit the Session. Jun 01 19:06:30 ferrum-broen-240 volumiobt[4331]: Attempting to disconnect from 38:8A:06:5E:0F:B1 Jun 01 19:06:30 ferrum-broen-240 volumiobt[4331]: [NEW] Media /org/bluez/hci0 Jun 01 19:06:30 ferrum-broen-240 volumiobt[4331]: SupportedUUIDs: 0000110a-0000-1000-8000-00805f9b34fb Jun 01 19:06:30 ferrum-broen-240 volumiobt[4331]: SupportedUUIDs: 0000110b-0000-1000-8000-00805f9b34fb Jun 01 19:06:30 ferrum-broen-240 volumiobt[4331]: SupportedUUIDs: 0000FDF0-0000-1000-8000-00805f9b34fb Jun 01 19:06:30 ferrum-broen-240 volumiobt[4331]: Disconnection successful Jun 01 19:06:30 ferrum-broen-240 bluetoothd[979]: Path / reserved for Adv Monitor app :1.59 Jun 01 19:06:30 ferrum-broen-240 bluetoothd[979]: Adv Monitor app :1.59 disconnected from D-Bus Jun 01 19:06:30 ferrum-broen-240 (sd-pam)[3162]: pam_unix(systemd-user:session): session closed for user volumiooem Jun 01 19:06:30 ferrum-broen-240 systemd[1]: user@1001.service: Deactivated successfully. Jun 01 19:06:30 ferrum-broen-240 systemd[1]: Stopped user@1001.service - User Manager for UID 1001. Jun 01 19:06:30 ferrum-broen-240 volumiobt[4332]: INFO [BTSTART] Disconnected device: 38:8A:06:5E:0F:B1 Jun 01 19:06:30 ferrum-broen-240 volumiobt[4333]: Attempting to disconnect from 20:3B:34:A8:4C:53 Jun 01 19:06:30 ferrum-broen-240 volumiobt[4333]: [NEW] Media /org/bluez/hci0 Jun 01 19:06:30 ferrum-broen-240 volumiobt[4333]: SupportedUUIDs: 0000110a-0000-1000-8000-00805f9b34fb Jun 01 19:06:30 ferrum-broen-240 volumiobt[4333]: SupportedUUIDs: 0000110b-0000-1000-8000-00805f9b34fb Jun 01 19:06:30 ferrum-broen-240 volumiobt[4333]: SupportedUUIDs: 0000FDF0-0000-1000-8000-00805f9b34fb Jun 01 19:06:30 ferrum-broen-240 bluetoothd[979]: Path / reserved for Adv Monitor app :1.60 Jun 01 19:06:30 ferrum-broen-240 volumiobt[4333]: AdvertisementMonitor path registered Jun 01 19:06:31 ferrum-broen-240 volumio[3668]: info: ------------------------------ 351ms Jun 01 19:06:31 ferrum-broen-240 volumio[3668]: info: ------------------------------ 350ms Jun 01 19:06:31 ferrum-broen-240 volumio[3668]: info: ------------------------------ 351ms Jun 01 19:06:31 ferrum-broen-240 volumio[3668]: info: ------------------------------ 233ms Jun 01 19:06:31 ferrum-broen-240 volumio[3668]: info: ------------------------------ 233ms Jun 01 19:06:31 ferrum-broen-240 volumio[3668]: info: ------------------------------ 232ms Jun 01 19:06:31 ferrum-broen-240 volumio[3668]: info: ------------------------------ 232ms Jun 01 19:06:31 ferrum-broen-240 systemd[1]: Stopping user-runtime-dir@1001.service - User Runtime Directory /run/user/1001... Jun 01 19:06:31 ferrum-broen-240 systemd[1]: run-user-1001.mount: Deactivated successfully. Jun 01 19:06:31 ferrum-broen-240 systemd[1]: Unmounted run-user-1001.mount - /run/user/1001. Jun 01 19:06:31 ferrum-broen-240 systemd[1]: user-runtime-dir@1001.service: Deactivated successfully. Jun 01 19:06:31 ferrum-broen-240 systemd[1]: Stopped user-runtime-dir@1001.service - User Runtime Directory /run/user/1001. Jun 01 19:06:31 ferrum-broen-240 systemd[1]: Removed slice user-1001.slice - User Slice of UID 1001. Jun 01 19:06:31 ferrum-broen-240 systemd[1]: user-1001.slice: Consumed 4.972s CPU time. Jun 01 19:06:32 ferrum-broen-240 volumio[3668]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 01 19:06:32 ferrum-broen-240 volumio[3668]: Error: write EPIPE Jun 01 19:06:32 ferrum-broen-240 volumio[3668]: at afterWriteDispatched (node:internal/stream_base_commons:160:15) Jun 01 19:06:32 ferrum-broen-240 volumio[3668]: at writeGeneric (node:internal/stream_base_commons:151:3) Jun 01 19:06:32 ferrum-broen-240 volumio[3668]: at Socket._writeGeneric (node:net:952:11) Jun 01 19:06:32 ferrum-broen-240 volumio[3668]: at Socket._write (node:net:964:8) Jun 01 19:06:32 ferrum-broen-240 volumio[3668]: at writeOrBuffer (node:internal/streams/writable:399:12) Jun 01 19:06:32 ferrum-broen-240 volumio[3668]: at _write (node:internal/streams/writable:340:10) Jun 01 19:06:32 ferrum-broen-240 volumio[3668]: at Writable.write (node:internal/streams/writable:344:10) Jun 01 19:06:32 ferrum-broen-240 volumio[3668]: at /volumio/app/plugins/user_interface/ferrum_streaming_control_technology/node_modules/@hemspzoo/fsct-client/dist/index.js:102:19 Jun 01 19:06:32 ferrum-broen-240 volumio[3668]: at new Promise () Jun 01 19:06:32 ferrum-broen-240 volumio[3668]: at Mux.call (/volumio/app/plugins/user_interface/ferrum_streaming_control_technology/node_modules/@hemspzoo/fsct-client/dist/index.js:87:12) Jun 01 19:06:32 ferrum-broen-240 volumio[3668]: at _FsctIpcClient.performHandshake (/volumio/app/plugins/user_interface/ferrum_streaming_control_technology/node_modules/@hemspzoo/fsct-client/dist/index.js:325:28) Jun 01 19:06:32 ferrum-broen-240 volumio[3668]: at _FsctIpcClient.connectToEndpoint (/volumio/app/plugins/user_interface/ferrum_streaming_control_technology/node_modules/@hemspzoo/fsct-client/dist/index.js:316:48) Jun 01 19:06:32 ferrum-broen-240 volumio[3668]: at async connectAndRegister (/volumio/app/plugins/user_interface/ferrum_streaming_control_technology/index.js:120:20) { Jun 01 19:06:32 ferrum-broen-240 volumio[3668]: errno: -32, Jun 01 19:06:32 ferrum-broen-240 volumio[3668]: code: 'EPIPE', Jun 01 19:06:32 ferrum-broen-240 volumio[3668]: syscall: 'write' Jun 01 19:06:32 ferrum-broen-240 volumio[3668]: } Jun 01 19:06:32 ferrum-broen-240 volumio[3668]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 01 19:06:32 ferrum-broen-240 sudo[4365]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-06-01 19:05' Jun 01 19:06:32 ferrum-broen-240 sudo[4365]: 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"