-- Logs begin at Thu 2019-02-14 10:11:59 UTC, end at Sat 2024-10-12 00:27:22 UTC. -- Oct 12 00:26:20 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 12 00:26:20 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 12 00:26:20 volumio volumio[1109]: info: Discovery: Getting this device information Oct 12 00:26:20 volumio volumio[1109]: info: CoreCommandRouter::volumioGetState Oct 12 00:26:20 volumio volumio[1109]: info: CorePlayQueue::getTrack 0 Oct 12 00:26:20 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 12 00:26:45 volumio volumio-remote-updater[513]: zsync done Oct 12 00:26:47 volumio volumio-remote-updater[513]: PROGRESS: 80, STATUS: "Downloading new update", ETA: "2m" Oct 12 00:26:47 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Oct 12 00:26:47 volumio volumio[1109]: updateProgress Oct 12 00:26:47 volumio volumio[1109]: { Oct 12 00:26:47 volumio volumio[1109]: downloadSpeed: '', Oct 12 00:26:47 volumio volumio[1109]: eta: '2m', Oct 12 00:26:47 volumio volumio[1109]: progress: 80, Oct 12 00:26:47 volumio volumio[1109]: status: 'Downloading new update' Oct 12 00:26:47 volumio volumio[1109]: } Oct 12 00:26:50 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 12 00:26:50 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 12 00:26:50 volumio volumio[1109]: info: Discovery: Getting this device information Oct 12 00:26:50 volumio volumio[1109]: info: CoreCommandRouter::volumioGetState Oct 12 00:26:50 volumio volumio[1109]: info: CorePlayQueue::getTrack 0 Oct 12 00:26:50 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 12 00:27:04 volumio volumio-remote-updater[513]: zsync done Oct 12 00:27:05 volumio volumio-remote-updater[513]: PROGRESS: 90, STATUS: "Cleaning old files", ETA: "1m" Oct 12 00:27:05 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Oct 12 00:27:05 volumio volumio[1109]: updateProgress Oct 12 00:27:05 volumio volumio[1109]: { Oct 12 00:27:05 volumio volumio[1109]: downloadSpeed: '', Oct 12 00:27:05 volumio volumio[1109]: eta: '1m', Oct 12 00:27:05 volumio volumio[1109]: progress: 90, Oct 12 00:27:05 volumio volumio[1109]: status: 'Cleaning old files' Oct 12 00:27:05 volumio volumio[1109]: } Oct 12 00:27:05 volumio volumio-remote-updater[513]: /bin/cp: cannot stat '/data/volumio_factory.sqsh': No such file or directory Oct 12 00:27:05 volumio volumio-remote-updater[513]: /bin/rm: cannot remove '/data/volumio_factory.sqsh': No such file or directory Oct 12 00:27:05 volumio volumio-remote-updater[513]: PROGRESS: 95, STATUS: "Finalizing update", ETA: "30s" Oct 12 00:27:05 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Oct 12 00:27:05 volumio volumio[1109]: updateProgress Oct 12 00:27:05 volumio volumio[1109]: { Oct 12 00:27:05 volumio volumio[1109]: downloadSpeed: '', Oct 12 00:27:05 volumio volumio[1109]: eta: '30s', Oct 12 00:27:05 volumio volumio[1109]: progress: 95, Oct 12 00:27:05 volumio volumio[1109]: status: 'Finalizing update' Oct 12 00:27:05 volumio volumio[1109]: } Oct 12 00:27:05 volumio volumio-remote-updater[513]: PROGRESS: 100, STATUS: "success", MESSAGE: "Successfully updated to \"3.757\" version. System restart required." Oct 12 00:27:05 volumio volumio-remote-updater[513]: [2024-10-12 00:27:05] [disconnect] Disconnect close local:[1000] remote:[1000] Oct 12 00:27:05 volumio volumio-remote-updater[513]: [2024-10-12 00:27:05] [info] asio async_write error: system:32 (Broken pipe) Oct 12 00:27:05 volumio volumio-remote-updater[513]: [2024-10-12 00:27:05] [fatal] handle_write_frame error: websocketpp.transport:2 (Underlying Transport Error) Oct 12 00:27:05 volumio systemd[1]: volumio-remote-updater.service: Succeeded. Oct 12 00:27:05 volumio systemd[1]: volumio-remote-updater.service: Service RestartSec=100ms expired, scheduling restart. Oct 12 00:27:05 volumio systemd[1]: volumio-remote-updater.service: Scheduled restart job, restart counter is at 1. Oct 12 00:27:05 volumio systemd[1]: Stopped volumio-remote-updater.service. Oct 12 00:27:05 volumio systemd[1]: Started volumio-remote-updater.service. Oct 12 00:27:05 volumio volumio-remote-updater[26152]: Error: No active session Oct 12 00:27:05 volumio volumio-remote-updater[26152]: [2024-10-12 00:27:05] [connect] Successful connection Oct 12 00:27:05 volumio volumio[1109]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 11 Oct 12 00:27:05 volumio volumio-remote-updater[26152]: [2024-10-12 00:27:05] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1728692825 101 Oct 12 00:27:06 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Oct 12 00:27:07 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Oct 12 00:27:08 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Oct 12 00:27:09 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Oct 12 00:27:10 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Oct 12 00:27:11 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Oct 12 00:27:12 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Oct 12 00:27:13 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Oct 12 00:27:14 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Oct 12 00:27:15 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Oct 12 00:27:16 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Oct 12 00:27:17 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Oct 12 00:27:18 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Oct 12 00:27:19 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Oct 12 00:27:20 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 12 00:27:20 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 12 00:27:20 volumio volumio[1109]: info: Discovery: Getting this device information Oct 12 00:27:20 volumio volumio[1109]: info: CoreCommandRouter::volumioGetState Oct 12 00:27:20 volumio volumio[1109]: info: CorePlayQueue::getTrack 0 Oct 12 00:27:20 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 12 00:27:20 volumio volumio[1109]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage Oct 12 00:27:21 volumio volumio[1109]: info: CoreCommandRouter::Close All Modals sent Oct 12 00:27:21 volumio volumio[1109]: info: ___________ PLUGINS: Run onVolumioReboot Tasks ___________ Oct 12 00:27:21 volumio volumio[1109]: info: PLUGIN onReboot : networkfs Oct 12 00:27:21 volumio volumio[1109]: info: PLUGIN onReboot : audiophonicsonoff Oct 12 00:27:21 volumio volumio[1109]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 12 00:27:21 volumio volumio[1109]: TypeError: Cannot read property 'writeSync' of undefined Oct 12 00:27:21 volumio volumio[1109]: at ControllerAudiophonicsOnOff.onVolumioReboot (/data/plugins/system_controller/audiophonicsonoff/index.js:35:25) Oct 12 00:27:21 volumio volumio[1109]: at PluginManager.onVolumioRebootPlugin (/volumio/app/pluginmanager.js:684:30) Oct 12 00:27:21 volumio volumio[1109]: at HashMap. (/volumio/app/pluginmanager.js:668:31) Oct 12 00:27:21 volumio volumio[1109]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Oct 12 00:27:21 volumio volumio[1109]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Oct 12 00:27:21 volumio volumio[1109]: at PluginManager.onVolumioReboot (/volumio/app/pluginmanager.js:666:20) Oct 12 00:27:21 volumio volumio[1109]: at CoreCommandRouter.reboot (/volumio/app/index.js:1292:22) Oct 12 00:27:21 volumio volumio[1109]: at Timeout._onTimeout (/volumio/app/plugins/system_controller/updater_comm/index.js:151:35) Oct 12 00:27:21 volumio volumio[1109]: at listOnTimeout (internal/timers.js:554:17) Oct 12 00:27:21 volumio volumio[1109]: at processTimers (internal/timers.js:497:7) Oct 12 00:27:21 volumio volumio[1109]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 12 00:27:22 volumio sudo[26389]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-12 00:26 Oct 12 00:27:22 volumio sudo[26389]: 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="91e88ea6c5c4ec4f00aff63f7c3a2944b14ec939" VOLUMIO_FE_VERSION="c433755e569617abac52264d17ad61be303ef463" VOLUMIO_FE3_VERSION="2419ddd8e895c5bdc456962163c9dc7c0f187aa7" VOLUMIO_BE_VERSION="85acf7bbbceb3e3dec447156a39a88033f921210" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 30 Sep 2022 10:43:40 AM CEST" VOLUMIO_VERSION="3.378" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="4bc817297375b72097a1fade15c6518b"