-- Logs begin at Thu 2019-02-14 11:11:58 CET, end at Thu 2025-03-20 00:25:21 CET. --
Mar 20 00:24:25 volumio volumio-remote-updater[587]: zsync done
Mar 20 00:24:33 volumio volumio-remote-updater[587]: PROGRESS: 80, STATUS: "Downloading new update", ETA: "2m"
Mar 20 00:24:33 volumio volumio[888]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage
Mar 20 00:24:33 volumio volumio[888]: updateProgress
Mar 20 00:24:33 volumio volumio[888]: {
Mar 20 00:24:33 volumio volumio[888]: downloadSpeed: '',
Mar 20 00:24:33 volumio volumio[888]: eta: '2m',
Mar 20 00:24:33 volumio volumio[888]: progress: 80,
Mar 20 00:24:33 volumio volumio[888]: status: 'Téléchargement de la mise à jour'
Mar 20 00:24:33 volumio volumio[888]: }
Mar 20 00:24:34 volumio ntpd[769]: 5.39.80.51 local addr 192.168.1.63 ->
Mar 20 00:24:34 volumio ntpd[769]: 95.81.173.74 local addr 192.168.1.63 ->
Mar 20 00:24:36 volumio nmbd[732]: [2025/03/20 00:24:36.078419, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response)
Mar 20 00:24:36 volumio nmbd[732]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.1.63 for name WORKGROUP<1d>.
Mar 20 00:24:36 volumio nmbd[732]: This response was from IP 192.168.1.200, reporting an IP address of 192.168.1.200.
Mar 20 00:24:36 volumio nmbd[732]: [2025/03/20 00:24:36.079048, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response)
Mar 20 00:24:36 volumio nmbd[732]: query_name_response: Multiple (3) responses received for a query on subnet 192.168.1.63 for name WORKGROUP<1d>.
Mar 20 00:24:36 volumio nmbd[732]: This response was from IP 192.168.1.61, reporting an IP address of 192.168.1.200.
Mar 20 00:24:36 volumio nmbd[732]: [2025/03/20 00:24:36.079253, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response)
Mar 20 00:24:36 volumio nmbd[732]: query_name_response: Multiple (4) responses received for a query on subnet 192.168.1.63 for name WORKGROUP<1d>.
Mar 20 00:24:36 volumio nmbd[732]: This response was from IP 192.168.1.61, reporting an IP address of 192.168.1.200.
Mar 20 00:24:36 volumio nmbd[732]: [2025/03/20 00:24:36.079436, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response)
Mar 20 00:24:36 volumio nmbd[732]: query_name_response: Multiple (5) responses received for a query on subnet 192.168.1.63 for name WORKGROUP<1d>.
Mar 20 00:24:36 volumio nmbd[732]: This response was from IP 192.168.1.200, reporting an IP address of 192.168.1.200.
Mar 20 00:24:36 volumio nmbd[732]: [2025/03/20 00:24:36.079631, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response)
Mar 20 00:24:36 volumio nmbd[732]: query_name_response: Multiple (6) responses received for a query on subnet 192.168.1.63 for name WORKGROUP<1d>.
Mar 20 00:24:36 volumio nmbd[732]: This response was from IP 192.168.1.200, reporting an IP address of 192.168.1.200.
Mar 20 00:24:52 volumio volumio-remote-updater[587]: zsync done
Mar 20 00:24:58 volumio volumio[888]: info:
Mar 20 00:24:58 volumio volumio[888]: ---------------------------- MPD announces system playlist update
Mar 20 00:24:58 volumio volumio[888]: info: Ignoring MPD Status Update
Mar 20 00:24:58 volumio volumio[888]: info:
Mar 20 00:24:58 volumio volumio[888]: ---------------------------- MPD announces state update: player
Mar 20 00:24:58 volumio volumio[888]: info: ControllerMpd::getState
Mar 20 00:24:58 volumio volumio[888]: verbose: ControllerMpd::sendMpdCommand status
Mar 20 00:24:58 volumio volumio[888]: info:
Mar 20 00:24:58 volumio volumio[888]: ---------------------------- MPD announces system playlist update
Mar 20 00:24:58 volumio volumio[888]: info: Ignoring MPD Status Update
Mar 20 00:24:58 volumio volumio[888]: info:
Mar 20 00:24:58 volumio volumio[888]: ---------------------------- MPD announces state update: player
Mar 20 00:24:58 volumio volumio[888]: info: ControllerMpd::getState
Mar 20 00:24:58 volumio volumio[888]: verbose: ControllerMpd::sendMpdCommand status
Mar 20 00:24:58 volumio volumio[888]: info:
Mar 20 00:24:58 volumio volumio[888]: ---------------------------- MPD announces system playlist update
Mar 20 00:24:58 volumio volumio[888]: info: Ignoring MPD Status Update
Mar 20 00:24:58 volumio volumio[888]: info:
Mar 20 00:24:58 volumio volumio[888]: ---------------------------- MPD announces state update: player
Mar 20 00:24:58 volumio volumio[888]: info: ControllerMpd::getState
Mar 20 00:24:58 volumio volumio[888]: verbose: ControllerMpd::sendMpdCommand status
Mar 20 00:24:58 volumio volumio[888]: info: ------------------------------ 3ms
Mar 20 00:24:58 volumio volumio[888]: info: sendMpdCommand status took 4 milliseconds
Mar 20 00:24:58 volumio volumio[888]: info: ------------------------------ 3ms
Mar 20 00:24:58 volumio volumio[888]: info: sendMpdCommand status took 3 milliseconds
Mar 20 00:24:58 volumio volumio[888]: info: ------------------------------ 2ms
Mar 20 00:24:58 volumio volumio[888]: info: sendMpdCommand status took 2 milliseconds
Mar 20 00:24:58 volumio volumio[888]: verbose: ControllerMpd::parseState
Mar 20 00:24:58 volumio volumio[888]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 20 00:24:58 volumio volumio[888]: verbose: ControllerMpd::parseState
Mar 20 00:24:58 volumio volumio[888]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 20 00:24:58 volumio volumio[888]: verbose: ControllerMpd::parseState
Mar 20 00:24:58 volumio volumio[888]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Mar 20 00:24:58 volumio volumio[888]: info: sendMpdCommand playlistinfo took 2 milliseconds
Mar 20 00:24:58 volumio volumio[888]: info: sendMpdCommand playlistinfo took 3 milliseconds
Mar 20 00:24:58 volumio volumio[888]: info: sendMpdCommand playlistinfo took 2 milliseconds
Mar 20 00:24:58 volumio volumio[888]: verbose: ControllerMpd::parseTrackInfo
Mar 20 00:24:58 volumio volumio[888]: info: ControllerMpd::pushState
Mar 20 00:24:58 volumio volumio[888]: info: CoreCommandRouter::servicePushState
Mar 20 00:24:58 volumio volumio[888]: info: CorePlayQueue::getTrack 0
Mar 20 00:24:58 volumio volumio[888]: verbose: STATE SERVICE {"status":"play","position":0,"seek":399187,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"59 Kbps","isStreaming":false,"title":"Beck - Scarecrow","artist":"Radio Paradise (64k aac)","album":null,"uri":"http://stream-uk1.radioparadise.com/aac-64","trackType":"com/aac-64"}
Mar 20 00:24:58 volumio volumio[888]: verbose: CURRENT POSITION 0
Mar 20 00:24:58 volumio volumio[888]: info: CoreStateMachine::syncState stateService play
Mar 20 00:24:58 volumio volumio[888]: info: CoreStateMachine::syncState currentStatus play
Mar 20 00:24:58 volumio volumio[888]: info: Received an update from plugin. extracting info from payload
Mar 20 00:24:58 volumio volumio[888]: info: CoreStateMachine::pushState
Mar 20 00:24:58 volumio volumio[888]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Mar 20 00:24:58 volumio volumio[888]: info: CoreCommandRouter::volumioPushState
Mar 20 00:24:58 volumio volumio[888]: info: CoreStateMachine::pushState
Mar 20 00:24:58 volumio volumio[888]: info: CoreCommandRouter::volumioPushState
Mar 20 00:24:58 volumio volumio[888]: info: ControllerMpd::pushState
Mar 20 00:24:58 volumio volumio[888]: info: CoreCommandRouter::servicePushState
Mar 20 00:24:58 volumio volumio[888]: info: CorePlayQueue::getTrack 0
Mar 20 00:24:58 volumio volumio[888]: verbose: STATE SERVICE {"status":"play","position":0,"seek":399187,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"59 Kbps","isStreaming":false,"title":"Beck - Scarecrow","artist":"Radio Paradise (64k aac)","album":null,"uri":"http://stream-uk1.radioparadise.com/aac-64","trackType":"com/aac-64"}
Mar 20 00:24:58 volumio volumio[888]: verbose: CURRENT POSITION 0
Mar 20 00:24:58 volumio volumio[888]: info: CoreStateMachine::syncState stateService play
Mar 20 00:24:58 volumio volumio[888]: info: CoreStateMachine::syncState currentStatus play
Mar 20 00:24:58 volumio volumio[888]: info: Received an update from plugin. extracting info from payload
Mar 20 00:24:58 volumio volumio[888]: info: CoreStateMachine::pushState
Mar 20 00:24:58 volumio volumio[888]: info: CoreCommandRouter::volumioPushState
Mar 20 00:24:58 volumio volumio[888]: info: CoreStateMachine::pushState
Mar 20 00:24:58 volumio volumio[888]: info: CoreCommandRouter::volumioPushState
Mar 20 00:24:58 volumio volumio[888]: info: ControllerMpd::pushState
Mar 20 00:24:58 volumio volumio[888]: info: CoreCommandRouter::servicePushState
Mar 20 00:24:58 volumio volumio[888]: info: CorePlayQueue::getTrack 0
Mar 20 00:24:58 volumio volumio[888]: verbose: STATE SERVICE {"status":"play","position":0,"seek":399187,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"59 Kbps","isStreaming":false,"title":"Beck - Scarecrow","artist":"Radio Paradise (64k aac)","album":null,"uri":"http://stream-uk1.radioparadise.com/aac-64","trackType":"com/aac-64"}
Mar 20 00:24:58 volumio volumio[888]: verbose: CURRENT POSITION 0
Mar 20 00:24:58 volumio volumio[888]: info: CoreStateMachine::syncState stateService play
Mar 20 00:24:58 volumio volumio[888]: info: CoreStateMachine::syncState currentStatus play
Mar 20 00:24:58 volumio volumio[888]: info: Received an update from plugin. extracting info from payload
Mar 20 00:24:58 volumio volumio[888]: info: CoreStateMachine::pushState
Mar 20 00:24:58 volumio volumio[888]: info: CoreCommandRouter::volumioPushState
Mar 20 00:24:58 volumio volumio[888]: info: CoreStateMachine::pushState
Mar 20 00:24:58 volumio volumio[888]: info: CoreCommandRouter::volumioPushState
Mar 20 00:24:58 volumio volumio[888]: info: ------------------------------ 37ms
Mar 20 00:24:58 volumio volumio[888]: info: ------------------------------ 36ms
Mar 20 00:24:58 volumio volumio[888]: info: ------------------------------ 36ms
Mar 20 00:25:03 volumio volumio-remote-updater[587]: PROGRESS: 90, STATUS: "Cleaning old files", ETA: "1m"
Mar 20 00:25:03 volumio volumio[888]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage
Mar 20 00:25:03 volumio volumio[888]: updateProgress
Mar 20 00:25:03 volumio volumio[888]: {
Mar 20 00:25:03 volumio volumio[888]: downloadSpeed: '',
Mar 20 00:25:03 volumio volumio[888]: eta: '1m',
Mar 20 00:25:03 volumio volumio[888]: progress: 90,
Mar 20 00:25:03 volumio volumio[888]: status: 'Suppression des fichiers précédents'
Mar 20 00:25:03 volumio volumio[888]: }
Mar 20 00:25:03 volumio volumio-remote-updater[587]: /bin/cp: cannot stat '/data/volumio_factory.sqsh': No such file or directory
Mar 20 00:25:05 volumio volumio-remote-updater[587]: /bin/rm: cannot remove '/data/volumio_factory.sqsh': No such file or directory
Mar 20 00:25:05 volumio volumio-remote-updater[587]: PROGRESS: 95, STATUS: "Finalizing update", ETA: "30s"
Mar 20 00:25:05 volumio volumio[888]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage
Mar 20 00:25:05 volumio volumio[888]: updateProgress
Mar 20 00:25:05 volumio volumio[888]: {
Mar 20 00:25:05 volumio volumio[888]: downloadSpeed: '',
Mar 20 00:25:05 volumio volumio[888]: eta: '30s',
Mar 20 00:25:05 volumio volumio[888]: progress: 95,
Mar 20 00:25:05 volumio volumio[888]: status: 'Finalisation de la mise à jour'
Mar 20 00:25:05 volumio volumio[888]: }
Mar 20 00:25:05 volumio volumio-remote-updater[587]: PROGRESS: 100, STATUS: "success", MESSAGE: "Successfully updated to \"3.795\" version. System restart required."
Mar 20 00:25:05 volumio volumio-remote-updater[587]: No test mode
Mar 20 00:25:05 volumio volumio-remote-updater[587]: No alpha test mode
Mar 20 00:25:05 volumio volumio-remote-updater[587]: [2025-03-20 00:25:05] [disconnect] Disconnect close local:[1000] remote:[1000]
Mar 20 00:25:05 volumio volumio-remote-updater[587]: [2025-03-20 00:25:05] [info] asio async_write error: system:32 (Broken pipe)
Mar 20 00:25:05 volumio volumio-remote-updater[587]: [2025-03-20 00:25:05] [fatal] handle_write_frame error: websocketpp.transport:2 (Underlying Transport Error)
Mar 20 00:25:05 volumio volumio[888]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage
Mar 20 00:25:05 volumio volumio[888]: updateReady
Mar 20 00:25:05 volumio volumio[888]: {
Mar 20 00:25:05 volumio volumio[888]: changeLogLink: 'http://volumio.org',
Mar 20 00:25:05 volumio volumio[888]: description: 'FIXES
- Improved translations
NEW ADDITIONS
- Add DSD-quirk for several USB DACs
- Enable install-to-NVME on CM5 and newer RPi5 revisions
- Fix potential issues with QOBUZ and TIDAL Streaming on slow connections
',
Mar 20 00:25:05 volumio volumio[888]: title: 'Update v3.795',
Mar 20 00:25:05 volumio volumio[888]: updateavailable: true
Mar 20 00:25:05 volumio volumio[888]: }
Mar 20 00:25:05 volumio systemd[1]: volumio-remote-updater.service: Succeeded.
Mar 20 00:25:05 volumio systemd[1]: volumio-remote-updater.service: Service RestartSec=100ms expired, scheduling restart.
Mar 20 00:25:05 volumio systemd[1]: volumio-remote-updater.service: Scheduled restart job, restart counter is at 1.
Mar 20 00:25:05 volumio systemd[1]: Stopped volumio-remote-updater.service.
Mar 20 00:25:06 volumio systemd[1]: Started volumio-remote-updater.service.
Mar 20 00:25:06 volumio volumio-remote-updater[4692]: Error: No active session
Mar 20 00:25:06 volumio volumio-remote-updater[4692]: [2025-03-20 00:25:06] [connect] Successful connection
Mar 20 00:25:06 volumio volumio-remote-updater[4692]: [2025-03-20 00:25:06] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1742426706 101
Mar 20 00:25:06 volumio volumio[888]: 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 20 00:25:06 volumio volumio[888]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage
Mar 20 00:25:07 volumio volumio[888]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage
Mar 20 00:25:08 volumio volumio[888]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage
Mar 20 00:25:09 volumio ntpd[769]: 129.151.225.244 local addr 192.168.1.63 ->
Mar 20 00:25:09 volumio volumio[888]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage
Mar 20 00:25:10 volumio volumio[888]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage
Mar 20 00:25:11 volumio volumio[888]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage
Mar 20 00:25:12 volumio volumio[888]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage
Mar 20 00:25:13 volumio volumio[888]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage
Mar 20 00:25:14 volumio volumio[888]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage
Mar 20 00:25:15 volumio volumio[888]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage
Mar 20 00:25:16 volumio volumio[888]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage
Mar 20 00:25:17 volumio volumio[888]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage
Mar 20 00:25:18 volumio volumio[888]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage
Mar 20 00:25:19 volumio volumio[888]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage
Mar 20 00:25:20 volumio volumio[888]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage
Mar 20 00:25:21 volumio volumio[888]: info: CoreCommandRouter::Close All Modals sent
Mar 20 00:25:21 volumio volumio[888]: info: ___________ PLUGINS: Run onVolumioReboot Tasks ___________
Mar 20 00:25:21 volumio volumio[888]: info: PLUGIN onReboot : networkfs
Mar 20 00:25:21 volumio volumio[888]: info: PLUGIN onReboot : audiophonicsonoff
Mar 20 00:25:21 volumio volumio[888]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Mar 20 00:25:21 volumio volumio[888]: TypeError: Cannot read property 'writeSync' of undefined
Mar 20 00:25:21 volumio volumio[888]: at ControllerAudiophonicsOnOff.onVolumioReboot (/data/plugins/system_controller/audiophonicsonoff/index.js:35:25)
Mar 20 00:25:21 volumio volumio[888]: at PluginManager.onVolumioRebootPlugin (/volumio/app/pluginmanager.js:684:30)
Mar 20 00:25:21 volumio volumio[888]: at HashMap. (/volumio/app/pluginmanager.js:668:31)
Mar 20 00:25:21 volumio volumio[888]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10)
Mar 20 00:25:21 volumio volumio[888]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7)
Mar 20 00:25:21 volumio volumio[888]: at PluginManager.onVolumioReboot (/volumio/app/pluginmanager.js:666:20)
Mar 20 00:25:21 volumio volumio[888]: at CoreCommandRouter.reboot (/volumio/app/index.js:1344:22)
Mar 20 00:25:21 volumio volumio[888]: at Timeout._onTimeout (/volumio/app/plugins/system_controller/updater_comm/index.js:156:35)
Mar 20 00:25:21 volumio volumio[888]: at listOnTimeout (internal/timers.js:554:17)
Mar 20 00:25:21 volumio volumio[888]: at processTimers (internal/timers.js:497:7)
Mar 20 00:25:21 volumio volumio[888]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Mar 20 00:25:21 volumio sudo[4795]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-20 00:24
Mar 20 00:25:21 volumio sudo[4795]: 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="f6610a1100d2380eef33bd3004af43153c786f96"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="1c0e5daee99fe3a72cc38b0d1fe6cd78d7f001fe"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Mon 16 Dec 2024 09:30:04 AM CET"
VOLUMIO_VERSION="3.785"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="fe0ac4b79aed19ccde4b5bd83d468193"