-- Logs begin at Mon 2026-03-16 20:59:31 EET, end at Tue 2026-03-24 23:26:20 EET. -- Mar 24 23:25:06 my-volumio wpa_supplicant[866]: RRM: Ignoring radio measurement request: Not RRM network Mar 24 23:25:27 my-volumio volumiologrotate[646]: ls: cannot access '/var/log/samba/log.wb-MY': No such file or directory Mar 24 23:25:27 my-volumio volumiologrotate[646]: ls: cannot access 'VOLUMIO': No such file or directory Mar 24 23:25:46 my-volumio wpa_supplicant[866]: RRM: Ignoring radio measurement request: Not RRM network Mar 24 23:25:57 my-volumio volumio-remote-updater[647]: zsync done Mar 24 23:25:57 my-volumio volumio-remote-updater[647]: PROGRESS: 80, STATUS: "Downloading new update", ETA: "2m" Mar 24 23:25:57 my-volumio volumio[963]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Mar 24 23:25:57 my-volumio volumio[963]: updateProgress Mar 24 23:25:57 my-volumio volumio[963]: { Mar 24 23:25:57 my-volumio volumio[963]: downloadSpeed: '', Mar 24 23:25:57 my-volumio volumio[963]: eta: '2m', Mar 24 23:25:57 my-volumio volumio[963]: progress: 80, Mar 24 23:25:57 my-volumio volumio[963]: status: 'Downloading new update' Mar 24 23:25:57 my-volumio volumio[963]: } Mar 24 23:26:04 my-volumio volumio-remote-updater[647]: zsync done Mar 24 23:26:04 my-volumio volumio-remote-updater[647]: PROGRESS: 90, STATUS: "Cleaning old files", ETA: "1m" Mar 24 23:26:04 my-volumio volumio[963]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Mar 24 23:26:04 my-volumio volumio[963]: updateProgress Mar 24 23:26:04 my-volumio volumio[963]: { Mar 24 23:26:04 my-volumio volumio[963]: downloadSpeed: '', Mar 24 23:26:04 my-volumio volumio[963]: eta: '1m', Mar 24 23:26:04 my-volumio volumio[963]: progress: 90, Mar 24 23:26:04 my-volumio volumio[963]: status: 'Cleaning old files' Mar 24 23:26:04 my-volumio volumio[963]: } Mar 24 23:26:04 my-volumio volumio-remote-updater[647]: /bin/cp: cannot stat '/data/volumio_factory.sqsh': No such file or directory Mar 24 23:26:04 my-volumio volumio-remote-updater[647]: /bin/rm: cannot remove '/data/volumio_factory.sqsh': No such file or directory Mar 24 23:26:04 my-volumio volumio-remote-updater[647]: PROGRESS: 95, STATUS: "Finalizing update", ETA: "30s" Mar 24 23:26:04 my-volumio volumio[963]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Mar 24 23:26:04 my-volumio volumio[963]: updateProgress Mar 24 23:26:04 my-volumio volumio[963]: { Mar 24 23:26:04 my-volumio volumio[963]: downloadSpeed: '', Mar 24 23:26:04 my-volumio volumio[963]: eta: '30s', Mar 24 23:26:04 my-volumio volumio[963]: progress: 95, Mar 24 23:26:04 my-volumio volumio[963]: status: 'Finalizing update' Mar 24 23:26:04 my-volumio volumio[963]: } Mar 24 23:26:04 my-volumio volumio-remote-updater[647]: PROGRESS: 100, STATUS: "success", MESSAGE: "Successfully updated to \"3.912\" version. System restart required." Mar 24 23:26:04 my-volumio volumio-remote-updater[647]: No test mode Mar 24 23:26:04 my-volumio volumio-remote-updater[647]: No alpha test mode Mar 24 23:26:04 my-volumio volumio-remote-updater[647]: [2026-03-24 23:26:04] [disconnect] Disconnect close local:[1000] remote:[1000] Mar 24 23:26:04 my-volumio volumio-remote-updater[647]: [2026-03-24 23:26:04] [info] asio async_write error: system:32 (Broken pipe) Mar 24 23:26:04 my-volumio volumio-remote-updater[647]: [2026-03-24 23:26:04] [fatal] handle_write_frame error: websocketpp.transport:2 (Underlying Transport Error) Mar 24 23:26:04 my-volumio volumio[963]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Mar 24 23:26:04 my-volumio volumio[963]: updateReady Mar 24 23:26:04 my-volumio volumio[963]: { Mar 24 23:26:04 my-volumio volumio[963]: changeLogLink: 'http://volumio.org', Mar 24 23:26:04 my-volumio volumio[963]: description: '

FIXES

\n' + Mar 24 23:26:04 my-volumio volumio[963]: '\n' + Mar 24 23:26:04 my-volumio volumio[963]: '

NEW ADDITIONS

\n' + Mar 24 23:26:04 my-volumio volumio[963]: '\n', Mar 24 23:26:04 my-volumio volumio[963]: title: 'Update v3.912', Mar 24 23:26:04 my-volumio volumio[963]: updateavailable: true Mar 24 23:26:04 my-volumio volumio[963]: } Mar 24 23:26:04 my-volumio systemd[1]: volumio-remote-updater.service: Succeeded. Mar 24 23:26:04 my-volumio systemd[1]: volumio-remote-updater.service: Service RestartSec=100ms expired, scheduling restart. Mar 24 23:26:04 my-volumio systemd[1]: volumio-remote-updater.service: Scheduled restart job, restart counter is at 1. Mar 24 23:26:04 my-volumio systemd[1]: Stopped volumio-remote-updater.service. Mar 24 23:26:05 my-volumio systemd[1]: Started volumio-remote-updater.service. Mar 24 23:26:05 my-volumio volumio-remote-updater[2047]: Error: No active session Mar 24 23:26:05 my-volumio volumio-remote-updater[2047]: [2026-03-24 23:26:05] [connect] Successful connection Mar 24 23:26:05 my-volumio volumio-remote-updater[2047]: [2026-03-24 23:26:05] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1774387565 101 Mar 24 23:26:05 my-volumio volumio[963]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 7 Mar 24 23:26:05 my-volumio volumio[963]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Mar 24 23:26:06 my-volumio volumio[963]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Mar 24 23:26:07 my-volumio volumio[963]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Mar 24 23:26:07 my-volumio wpa_supplicant[866]: RRM: Ignoring radio measurement request: Not RRM network Mar 24 23:26:08 my-volumio volumio[963]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Mar 24 23:26:09 my-volumio volumio[963]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Mar 24 23:26:10 my-volumio volumio[963]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Mar 24 23:26:11 my-volumio volumio[963]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Mar 24 23:26:12 my-volumio volumio[963]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Mar 24 23:26:13 my-volumio volumio[963]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Mar 24 23:26:14 my-volumio volumio[963]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Mar 24 23:26:15 my-volumio volumio[963]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Mar 24 23:26:16 my-volumio volumio[963]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Mar 24 23:26:17 my-volumio volumio[963]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Mar 24 23:26:18 my-volumio volumio[963]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Mar 24 23:26:19 my-volumio volumio[963]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Mar 24 23:26:20 my-volumio volumio[963]: info: CoreCommandRouter::Close All Modals sent Mar 24 23:26:20 my-volumio volumio[963]: info: ___________ PLUGINS: Run onVolumioReboot Tasks ___________ Mar 24 23:26:20 my-volumio volumio[963]: info: PLUGIN onReboot : networkfs Mar 24 23:26:20 my-volumio volumio[963]: info: PLUGIN onReboot : audiophonicsonoff Mar 24 23:26:20 my-volumio volumio[963]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 24 23:26:20 my-volumio volumio[963]: TypeError: Cannot read property 'writeSync' of undefined Mar 24 23:26:20 my-volumio volumio[963]: at ControllerAudiophonicsOnOff.onVolumioReboot (/data/plugins/system_controller/audiophonicsonoff/index.js:35:25) Mar 24 23:26:20 my-volumio volumio[963]: at PluginManager.onVolumioRebootPlugin (/volumio/app/pluginmanager.js:684:30) Mar 24 23:26:20 my-volumio volumio[963]: at HashMap. (/volumio/app/pluginmanager.js:668:31) Mar 24 23:26:20 my-volumio volumio[963]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Mar 24 23:26:20 my-volumio volumio[963]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Mar 24 23:26:20 my-volumio volumio[963]: at PluginManager.onVolumioReboot (/volumio/app/pluginmanager.js:666:20) Mar 24 23:26:20 my-volumio volumio[963]: at CoreCommandRouter.reboot (/volumio/app/index.js:1350:22) Mar 24 23:26:20 my-volumio volumio[963]: at Timeout._onTimeout (/volumio/app/plugins/system_controller/updater_comm/index.js:156:35) Mar 24 23:26:20 my-volumio volumio[963]: at listOnTimeout (internal/timers.js:554:17) Mar 24 23:26:20 my-volumio volumio[963]: at processTimers (internal/timers.js:497:7) Mar 24 23:26:20 my-volumio volumio[963]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 24 23:26:20 my-volumio sudo[2073]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-03-24 23:25 Mar 24 23:26:20 my-volumio sudo[2073]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster 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="b43c85cc0006d3f1efecba101311ec96e334d1fd" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 11 Dec 2025 05:43:24 PM CET" VOLUMIO_VERSION="3.886" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="15d0241b0cd805792809f3ddf4a0fc4e"