-- Logs begin at Thu 2019-02-14 11:11:58 CET, end at Fri 2026-03-27 04:26:08 CET. -- Mar 27 04:25:00 volumio-black volumio-remote-updater[632]: PROGRESS: 80, STATUS: "Downloading new update", ETA: "2m" Mar 27 04:25:00 volumio-black volumio[970]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Mar 27 04:25:00 volumio-black volumio[970]: updateProgress Mar 27 04:25:00 volumio-black volumio[970]: { Mar 27 04:25:00 volumio-black volumio[970]: downloadSpeed: '', Mar 27 04:25:00 volumio-black volumio[970]: eta: '2m', Mar 27 04:25:00 volumio-black volumio[970]: progress: 80, Mar 27 04:25:00 volumio-black volumio[970]: status: 'Téléchargement de la mise à jour' Mar 27 04:25:00 volumio-black volumio[970]: } Mar 27 04:25:02 volumio-black wpa_supplicant[859]: RRM: Ignoring radio measurement request: Not RRM network Mar 27 04:25:12 volumio-black wpa_supplicant[859]: RRM: Ignoring radio measurement request: Not RRM network Mar 27 04:25:18 volumio-black wpa_supplicant[859]: RRM: Ignoring radio measurement request: Not RRM network Mar 27 04:25:26 volumio-black wpa_supplicant[859]: RRM: Ignoring radio measurement request: Not RRM network Mar 27 04:25:32 volumio-black wpa_supplicant[859]: RRM: Ignoring radio measurement request: Not RRM network Mar 27 04:25:38 volumio-black wpa_supplicant[859]: RRM: Ignoring radio measurement request: Not RRM network Mar 27 04:25:44 volumio-black wpa_supplicant[859]: RRM: Ignoring radio measurement request: Not RRM network Mar 27 04:25:47 volumio-black volumiologrotate[631]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory Mar 27 04:25:47 volumio-black volumiologrotate[631]: ls: cannot access 'BLACK': No such file or directory Mar 27 04:25:48 volumio-black volumio[970]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Mar 27 04:25:50 volumio-black volumio-remote-updater[632]: zsync done Mar 27 04:25:50 volumio-black volumio-remote-updater[632]: PROGRESS: 90, STATUS: "Cleaning old files", ETA: "1m" Mar 27 04:25:50 volumio-black volumio[970]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Mar 27 04:25:50 volumio-black volumio[970]: updateProgress Mar 27 04:25:50 volumio-black volumio[970]: { Mar 27 04:25:50 volumio-black volumio[970]: downloadSpeed: '', Mar 27 04:25:50 volumio-black volumio[970]: eta: '1m', Mar 27 04:25:50 volumio-black volumio[970]: progress: 90, Mar 27 04:25:50 volumio-black volumio[970]: status: 'Suppression des fichiers précédents' Mar 27 04:25:50 volumio-black volumio[970]: } Mar 27 04:25:50 volumio-black volumio-remote-updater[632]: /bin/cp: cannot stat '/data/volumio_factory.sqsh': No such file or directory Mar 27 04:25:50 volumio-black volumio[970]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Mar 27 04:25:50 volumio-black volumio-remote-updater[632]: /bin/rm: cannot remove '/data/volumio_factory.sqsh': No such file or directory Mar 27 04:25:50 volumio-black volumio-remote-updater[632]: PROGRESS: 95, STATUS: "Finalizing update", ETA: "30s" Mar 27 04:25:50 volumio-black volumio[970]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Mar 27 04:25:50 volumio-black volumio[970]: updateProgress Mar 27 04:25:50 volumio-black volumio[970]: { Mar 27 04:25:50 volumio-black volumio[970]: downloadSpeed: '', Mar 27 04:25:50 volumio-black volumio[970]: eta: '30s', Mar 27 04:25:50 volumio-black volumio[970]: progress: 95, Mar 27 04:25:50 volumio-black volumio[970]: status: 'Finalisation de la mise à jour' Mar 27 04:25:50 volumio-black volumio[970]: } Mar 27 04:25:50 volumio-black wpa_supplicant[859]: RRM: Ignoring radio measurement request: Not RRM network Mar 27 04:25:50 volumio-black volumio[970]: info: CoreCommandRouter::volumioGetState Mar 27 04:25:50 volumio-black volumio[970]: info: CorePlayQueue::getTrack 0 Mar 27 04:25:50 volumio-black volumio[970]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 27 04:25:50 volumio-black volumio[970]: info: Listing playlists Mar 27 04:25:51 volumio-black volumio-remote-updater[632]: PROGRESS: 100, STATUS: "success", MESSAGE: "Successfully updated to \"3.912\" version. System restart required." Mar 27 04:25:51 volumio-black volumio-remote-updater[632]: No test mode Mar 27 04:25:51 volumio-black volumio-remote-updater[632]: No alpha test mode Mar 27 04:25:51 volumio-black volumio-remote-updater[632]: [2026-03-27 04:25:51] [disconnect] Disconnect close local:[1000] remote:[1000] Mar 27 04:25:51 volumio-black volumio-remote-updater[632]: [2026-03-27 04:25:51] [info] asio async_write error: system:32 (Broken pipe) Mar 27 04:25:51 volumio-black volumio-remote-updater[632]: [2026-03-27 04:25:51] [fatal] handle_write_frame error: websocketpp.transport:2 (Underlying Transport Error) Mar 27 04:25:51 volumio-black volumio[970]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Mar 27 04:25:51 volumio-black volumio[970]: updateReady Mar 27 04:25:51 volumio-black volumio[970]: { Mar 27 04:25:51 volumio-black volumio[970]: changeLogLink: 'http://volumio.org', Mar 27 04:25:51 volumio-black volumio[970]: description: '

FIXES

\n' + Mar 27 04:25:51 volumio-black volumio[970]: '\n' + Mar 27 04:25:51 volumio-black volumio[970]: '

NEW ADDITIONS

\n' + Mar 27 04:25:51 volumio-black volumio[970]: '\n', Mar 27 04:25:51 volumio-black volumio[970]: title: 'Update v3.912', Mar 27 04:25:51 volumio-black volumio[970]: updateavailable: true Mar 27 04:25:51 volumio-black volumio[970]: } Mar 27 04:25:51 volumio-black systemd[1]: volumio-remote-updater.service: Succeeded. Mar 27 04:25:51 volumio-black systemd[1]: volumio-remote-updater.service: Service RestartSec=100ms expired, scheduling restart. Mar 27 04:25:51 volumio-black systemd[1]: volumio-remote-updater.service: Scheduled restart job, restart counter is at 1. Mar 27 04:25:51 volumio-black systemd[1]: Stopped volumio-remote-updater.service. Mar 27 04:25:51 volumio-black systemd[1]: Started volumio-remote-updater.service. Mar 27 04:25:52 volumio-black volumio-remote-updater[3668]: Error: No active session Mar 27 04:25:52 volumio-black volumio-remote-updater[3668]: [2026-03-27 04:25:52] [connect] Successful connection Mar 27 04:25:52 volumio-black volumio-remote-updater[3668]: [2026-03-27 04:25:52] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1774581952 101 Mar 27 04:25:52 volumio-black volumio[970]: 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: 6 Mar 27 04:25:52 volumio-black volumio[970]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Mar 27 04:25:53 volumio-black volumio[970]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Mar 27 04:25:54 volumio-black volumio[970]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Mar 27 04:25:55 volumio-black volumio[970]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Mar 27 04:25:56 volumio-black volumio[970]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Mar 27 04:25:57 volumio-black volumio[970]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Mar 27 04:25:57 volumio-black wpa_supplicant[859]: RRM: Ignoring radio measurement request: Not RRM network Mar 27 04:25:58 volumio-black volumio[970]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Mar 27 04:25:59 volumio-black volumio[970]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Mar 27 04:26:00 volumio-black volumio[970]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Mar 27 04:26:01 volumio-black volumio[970]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Mar 27 04:26:02 volumio-black volumio[970]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Mar 27 04:26:03 volumio-black volumio[970]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Mar 27 04:26:03 volumio-black wpa_supplicant[859]: RRM: Ignoring radio measurement request: Not RRM network Mar 27 04:26:04 volumio-black volumio[970]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Mar 27 04:26:05 volumio-black volumio[970]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Mar 27 04:26:06 volumio-black volumio[970]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Mar 27 04:26:07 volumio-black volumio[970]: info: CoreCommandRouter::Close All Modals sent Mar 27 04:26:07 volumio-black volumio[970]: info: ___________ PLUGINS: Run onVolumioReboot Tasks ___________ Mar 27 04:26:07 volumio-black volumio[970]: info: PLUGIN onReboot : networkfs Mar 27 04:26:07 volumio-black volumio[970]: info: PLUGIN onReboot : audiophonicsonoff Mar 27 04:26:07 volumio-black volumio[970]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 27 04:26:07 volumio-black volumio[970]: TypeError: Cannot read property 'writeSync' of undefined Mar 27 04:26:07 volumio-black volumio[970]: at ControllerAudiophonicsOnOff.onVolumioReboot (/data/plugins/system_controller/audiophonicsonoff/index.js:35:25) Mar 27 04:26:07 volumio-black volumio[970]: at PluginManager.onVolumioRebootPlugin (/volumio/app/pluginmanager.js:684:30) Mar 27 04:26:07 volumio-black volumio[970]: at HashMap. (/volumio/app/pluginmanager.js:668:31) Mar 27 04:26:07 volumio-black volumio[970]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Mar 27 04:26:07 volumio-black volumio[970]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Mar 27 04:26:07 volumio-black volumio[970]: at PluginManager.onVolumioReboot (/volumio/app/pluginmanager.js:666:20) Mar 27 04:26:07 volumio-black volumio[970]: at CoreCommandRouter.reboot (/volumio/app/index.js:1350:22) Mar 27 04:26:07 volumio-black volumio[970]: at Timeout._onTimeout (/volumio/app/plugins/system_controller/updater_comm/index.js:156:35) Mar 27 04:26:07 volumio-black volumio[970]: at listOnTimeout (internal/timers.js:554:17) Mar 27 04:26:07 volumio-black volumio[970]: at processTimers (internal/timers.js:497:7) Mar 27 04:26:07 volumio-black volumio[970]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 27 04:26:08 volumio-black sudo[3712]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-03-27 04:25 Mar 27 04:26:08 volumio-black sudo[3712]: 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"