-- Logs begin at Thu 2019-02-14 11:12:00 CET, end at Fri 2024-08-23 20:08:12 CEST. --
Aug 23 20:07:17 myvolumio volumio[940]: info: Tunnel connection is inactive, restarting it
Aug 23 20:07:17 myvolumio volumio[940]: info: Starting Tunnel 1
Aug 23 20:07:17 myvolumio volumio[940]: info: Starting Tunnel Connection Checker
Aug 23 20:07:18 myvolumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Aug 23 20:07:18 myvolumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Aug 23 20:07:18 myvolumio volumio[940]: info: Discovery: Getting this device information
Aug 23 20:07:18 myvolumio volumio[940]: info: CoreCommandRouter::volumioGetState
Aug 23 20:07:18 myvolumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Aug 23 20:07:20 myvolumio sudo[13067]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service
Aug 23 20:07:20 myvolumio sudo[13067]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 23 20:07:20 myvolumio autossh[12594]: received signal to exit (15)
Aug 23 20:07:20 myvolumio systemd[1]: Stopping MyVolumio SSH Tunnel...
Aug 23 20:07:20 myvolumio systemd[1]: sshtunnel.service: Main process exited, code=killed, status=15/TERM
Aug 23 20:07:20 myvolumio systemd[1]: sshtunnel.service: Succeeded.
Aug 23 20:07:20 myvolumio systemd[1]: Stopped MyVolumio SSH Tunnel.
Aug 23 20:07:20 myvolumio volumio[940]: ------------------------------------ BT MESSAGE: BT STATUS: running
Aug 23 20:07:20 myvolumio volumio[940]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Aug 23 20:07:20 myvolumio systemd[1]: Started MyVolumio SSH Tunnel.
Aug 23 20:07:20 myvolumio sudo[13067]: pam_unix(sudo:session): session closed for user root
Aug 23 20:07:20 myvolumio autossh[13070]: port set to 0, monitoring disabled
Aug 23 20:07:20 myvolumio autossh[13070]: starting ssh (count 1)
Aug 23 20:07:20 myvolumio autossh[13070]: ssh child pid is 13073
Aug 23 20:07:20 myvolumio volumio[940]: info: Remote SSH Started
Aug 23 20:07:20 myvolumio volumio[940]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 10
Aug 23 20:07:21 myvolumio volumio[940]: info: CoreCommandRouter::volumioGetState
Aug 23 20:07:21 myvolumio volumiossh-tunnel[13069]: Warning: Permanently added '[eu4.myvolumio.org]:2222,[167.172.103.77]:2222' (RSA) to the list of known hosts.
Aug 23 20:07:21 myvolumio volumiossh-tunnel[13069]: Warning: remote port forwarding failed for listen port 8091
Aug 23 20:07:23 myvolumio volumio-remote-updater[537]: zsync done
Aug 23 20:07:23 myvolumio volumio-remote-updater[537]: PROGRESS: 80, STATUS: "Downloading new update", ETA: "2m"
Aug 23 20:07:23 myvolumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage
Aug 23 20:07:23 myvolumio volumio[940]: updateProgress
Aug 23 20:07:23 myvolumio volumio[940]: {
Aug 23 20:07:23 myvolumio volumio[940]: downloadSpeed: '',
Aug 23 20:07:23 myvolumio volumio[940]: eta: '2m',
Aug 23 20:07:23 myvolumio volumio[940]: progress: 80,
Aug 23 20:07:23 myvolumio volumio[940]: status: 'Neue Aktualisierung wird heruntergeladen'
Aug 23 20:07:23 myvolumio volumio[940]: }
Aug 23 20:07:48 myvolumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Aug 23 20:07:48 myvolumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Aug 23 20:07:48 myvolumio volumio[940]: info: Discovery: Getting this device information
Aug 23 20:07:48 myvolumio volumio[940]: info: CoreCommandRouter::volumioGetState
Aug 23 20:07:48 myvolumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Aug 23 20:07:55 myvolumio volumio-remote-updater[537]: zsync done
Aug 23 20:07:55 myvolumio volumio-remote-updater[537]: PROGRESS: 90, STATUS: "Cleaning old files", ETA: "1m"
Aug 23 20:07:55 myvolumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage
Aug 23 20:07:55 myvolumio volumio[940]: updateProgress
Aug 23 20:07:55 myvolumio volumio[940]: {
Aug 23 20:07:55 myvolumio volumio[940]: downloadSpeed: '',
Aug 23 20:07:55 myvolumio volumio[940]: eta: '1m',
Aug 23 20:07:55 myvolumio volumio[940]: progress: 90,
Aug 23 20:07:55 myvolumio volumio[940]: status: 'Alte Dateien werden bereinigt'
Aug 23 20:07:55 myvolumio volumio[940]: }
Aug 23 20:07:55 myvolumio volumio-remote-updater[537]: /bin/cp: cannot stat '/data/volumio_factory.sqsh': No such file or directory
Aug 23 20:07:55 myvolumio volumio-remote-updater[537]: /bin/rm: cannot remove '/data/volumio_factory.sqsh': No such file or directory
Aug 23 20:07:55 myvolumio volumio-remote-updater[537]: PROGRESS: 95, STATUS: "Finalizing update", ETA: "30s"
Aug 23 20:07:55 myvolumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage
Aug 23 20:07:55 myvolumio volumio[940]: updateProgress
Aug 23 20:07:55 myvolumio volumio[940]: {
Aug 23 20:07:55 myvolumio volumio[940]: downloadSpeed: '',
Aug 23 20:07:55 myvolumio volumio[940]: eta: '30s',
Aug 23 20:07:55 myvolumio volumio[940]: progress: 95,
Aug 23 20:07:55 myvolumio volumio[940]: status: 'Aktualisierung wird abgeschlossen'
Aug 23 20:07:55 myvolumio volumio[940]: }
Aug 23 20:07:55 myvolumio volumio-remote-updater[537]: PROGRESS: 100, STATUS: "success", MESSAGE: "Successfully updated to \"3.742\" version. System restart required."
Aug 23 20:07:55 myvolumio volumio-remote-updater[537]: No test mode
Aug 23 20:07:55 myvolumio volumio-remote-updater[537]: No alpha test mode
Aug 23 20:07:56 myvolumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage
Aug 23 20:07:56 myvolumio volumio[940]: updateReady
Aug 23 20:07:56 myvolumio volumio-remote-updater[537]: [2024-08-23 20:07:56] [disconnect] Disconnect close local:[1000] remote:[1000]
Aug 23 20:07:56 myvolumio volumio-remote-updater[537]: [2024-08-23 20:07:56] [info] asio async_write error: system:32 (Broken pipe)
Aug 23 20:07:56 myvolumio volumio-remote-updater[537]: [2024-08-23 20:07:56] [fatal] handle_write_frame error: websocketpp.transport:2 (Underlying Transport Error)
Aug 23 20:07:56 myvolumio volumio[940]: {
Aug 23 20:07:56 myvolumio volumio[940]: changeLogLink: 'http://volumio.org',
Aug 23 20:07:56 myvolumio volumio[940]: description: 'FIXES
- Improved translations
- Fix for controlling Volumio device from another one
- Fix for slow playback on RPi5 with HifiBerry DAC
- Improved speed for default albumart
- Fix for HifiBerry DAC detection
- Fix for Supersearch bar on Iphone
- Fix for Network connection on Wizard
NEW ADDITIONS
- Facility for third party UIs
',
Aug 23 20:07:56 myvolumio volumio[940]: title: 'Update v3.742',
Aug 23 20:07:56 myvolumio volumio[940]: updateavailable: true
Aug 23 20:07:56 myvolumio volumio[940]: }
Aug 23 20:07:56 myvolumio systemd[1]: volumio-remote-updater.service: Succeeded.
Aug 23 20:07:56 myvolumio systemd[1]: volumio-remote-updater.service: Service RestartSec=100ms expired, scheduling restart.
Aug 23 20:07:56 myvolumio systemd[1]: volumio-remote-updater.service: Scheduled restart job, restart counter is at 1.
Aug 23 20:07:56 myvolumio systemd[1]: Stopped volumio-remote-updater.service.
Aug 23 20:07:56 myvolumio systemd[1]: Started volumio-remote-updater.service.
Aug 23 20:07:56 myvolumio volumio-remote-updater[13167]: Error: No active session
Aug 23 20:07:56 myvolumio volumio-remote-updater[13167]: [2024-08-23 20:07:56] [connect] Successful connection
Aug 23 20:07:56 myvolumio volumio-remote-updater[13167]: [2024-08-23 20:07:56] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1724436476 101
Aug 23 20:07:56 myvolumio volumio[940]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 10
Aug 23 20:07:56 myvolumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage
Aug 23 20:07:57 myvolumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage
Aug 23 20:07:58 myvolumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage
Aug 23 20:07:59 myvolumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage
Aug 23 20:08:00 myvolumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage
Aug 23 20:08:01 myvolumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage
Aug 23 20:08:02 myvolumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage
Aug 23 20:08:03 myvolumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage
Aug 23 20:08:04 myvolumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage
Aug 23 20:08:05 myvolumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage
Aug 23 20:08:06 myvolumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage
Aug 23 20:08:07 myvolumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage
Aug 23 20:08:08 myvolumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage
Aug 23 20:08:09 myvolumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage
Aug 23 20:08:10 myvolumio volumio[940]: info: CoreCommandRouter::executeOnPlugin: websocket , broadcastMessage
Aug 23 20:08:11 myvolumio volumio[940]: info: CoreCommandRouter::Close All Modals sent
Aug 23 20:08:11 myvolumio volumio[940]: info: ___________ PLUGINS: Run onVolumioReboot Tasks ___________
Aug 23 20:08:11 myvolumio volumio[940]: info: PLUGIN onReboot : networkfs
Aug 23 20:08:11 myvolumio sudo[13205]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount -f /mnt/NAS/Roger
Aug 23 20:08:12 myvolumio sudo[13205]: pam_unix(sudo:session): session opened for user root by (uid=0)
Aug 23 20:08:12 myvolumio sudo[13205]: pam_unix(sudo:session): session closed for user root
Aug 23 20:08:12 myvolumio volumio[940]: umount: /mnt/NAS/Roger: not mounted.
Aug 23 20:08:12 myvolumio volumio[940]: error: Cannot umount share Roger : Error: Command failed: /usr/bin/sudo /bin/umount -f /mnt/NAS/Roger
Aug 23 20:08:12 myvolumio volumio[940]: umount: /mnt/NAS/Roger: not mounted.
Aug 23 20:08:12 myvolumio volumio[940]: info: PLUGIN onReboot : audiophonicsonoff
Aug 23 20:08:12 myvolumio volumio[940]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Aug 23 20:08:12 myvolumio volumio[940]: TypeError: Cannot read property 'writeSync' of undefined
Aug 23 20:08:12 myvolumio volumio[940]: at ControllerAudiophonicsOnOff.onVolumioReboot (/data/plugins/system_controller/audiophonicsonoff/index.js:35:25)
Aug 23 20:08:12 myvolumio volumio[940]: at PluginManager.onVolumioRebootPlugin (/volumio/app/pluginmanager.js:684:30)
Aug 23 20:08:12 myvolumio volumio[940]: at HashMap. (/volumio/app/pluginmanager.js:668:31)
Aug 23 20:08:12 myvolumio volumio[940]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10)
Aug 23 20:08:12 myvolumio volumio[940]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7)
Aug 23 20:08:12 myvolumio volumio[940]: at PluginManager.onVolumioReboot (/volumio/app/pluginmanager.js:666:20)
Aug 23 20:08:12 myvolumio volumio[940]: at CoreCommandRouter.reboot (/volumio/app/index.js:1324:22)
Aug 23 20:08:12 myvolumio volumio[940]: at Timeout._onTimeout (/volumio/app/plugins/system_controller/updater_comm/index.js:156:35)
Aug 23 20:08:12 myvolumio volumio[940]: at listOnTimeout (internal/timers.js:554:17)
Aug 23 20:08:12 myvolumio volumio[940]: at processTimers (internal/timers.js:497:7)
Aug 23 20:08:12 myvolumio volumio[940]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Aug 23 20:08:12 myvolumio sudo[13216]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-23 20:07
Aug 23 20:08:12 myvolumio sudo[13216]: 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="893d2e91c55a7857b58762e70c2f65b9d163562b"
VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71"
VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1"
VOLUMIO_BE_VERSION="30b77d58bf3c2745acc494ddafed946392a79905"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri 20 Oct 2023 03:38:28 PM CEST"
VOLUMIO_VERSION="3.569"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="4163d3756b55b3bf7c480d7285f68954"