-- Logs begin at Sat 2025-03-15 23:10:31 MSK, end at Sat 2025-03-15 23:12:21 MSK. --
Mar 15 23:11:00 volumio volumio[975]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Mar 15 23:11:00 volumio volumio[975]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10
Mar 15 23:11:00 volumio volumio[975]: info: CoreCommandRouter::volumioGetState
Mar 15 23:11:00 volumio volumio[975]: info: CorePlayQueue::getTrack 0
Mar 15 23:11:01 volumio systemd[1]: systemd-fsckd.service: Succeeded.
Mar 15 23:11:02 volumio systemd[1]: systemd-hostnamed.service: Succeeded.
Mar 15 23:11:05 volumio volumio[975]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 15 23:11:05 volumio volumio[975]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
Mar 15 23:11:05 volumio volumio[975]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Mar 15 23:11:05 volumio volumio[975]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
Mar 15 23:11:05 volumio volumio[975]: info: CoreCommandRouter::volumioGetBrowseSources
Mar 15 23:11:05 volumio volumio[975]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Mar 15 23:11:05 volumio volumio[975]: error: MyVolumio Plugin failed to authenticate in a timely fashion
Mar 15 23:11:05 volumio volumio[975]: info: Completed starting MyVolumio Plugin
Mar 15 23:11:05 volumio volumio[975]: [Metrics] CommandRouter: 31s 640.21ms
Mar 15 23:11:05 volumio volumio[975]: info: CoreCommandRouter::volumiosetStartupVolume
Mar 15 23:11:05 volumio volumio[975]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 15 23:11:05 volumio volumio[975]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 15 23:11:05 volumio volumio[975]: info: CoreCommandRouter::Close All Modals sent
Mar 15 23:11:05 volumio volumio[975]: info: CoreCommandRouter::Close All Modals sent
Mar 15 23:11:05 volumio volumio[975]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Mar 15 23:11:05 volumio volumio[975]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 15 23:11:05 volumio volumio[975]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Mar 15 23:11:05 volumio volumio-remote-updater[693]: No test mode
Mar 15 23:11:05 volumio volumio-remote-updater[693]: No alpha test mode
Mar 15 23:11:05 volumio volumio[975]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
Mar 15 23:11:06 volumio volumio[975]: info: Update Ready: {"changeLogLink":"http://volumio.org","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
","title":"Update v3.795","updateavailable":true}
Mar 15 23:11:06 volumio volumio[975]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Mar 15 23:11:06 volumio volumio[975]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Mar 15 23:11:06 volumio volumio[975]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Mar 15 23:11:06 volumio volumio[975]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Mar 15 23:11:11 volumio volumio[1813]: .................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................++++
Mar 15 23:11:11 volumio volumio[1813]: e is 65537 (0x010001)
Mar 15 23:11:11 volumio volumio[1813]: writing RSA key
Mar 15 23:11:12 volumio systemd[1]: systemd-timedated.service: Succeeded.
Mar 15 23:11:12 volumio volumio[975]: info: BOOT COMPLETED
Mar 15 23:11:27 volumio sudo[2006]: volumio : TTY=pts/0 ; PWD=/home/volumio/peppy_screensaver ; USER=root ; COMMAND=/usr/local/bin/volumio plugin install
Mar 15 23:11:27 volumio sudo[2006]: pam_unix(sudo:session): session opened for user root by volumio(uid=0)
Mar 15 23:11:32 volumio volumio[975]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7
Mar 15 23:11:32 volumio volumio[975]: info: Downloading plugin at http://127.0.0.1:3000/plugin-serve/peppy_screensaver.zip
Mar 15 23:11:32 volumio volumio[975]: info: Cannot download file http://127.0.0.1:3000/plugin-serve/peppy_screensaver.zip - Error: Command failed: /bin/mv /tmp/plugins/peppy_screensaver.zip /tmp/downloaded_plugin.zip
Mar 15 23:11:32 volumio volumio[975]: /bin/mv: cannot move '/tmp/plugins/peppy_screensaver.zip' to '/tmp/downloaded_plugin.zip': Permission denied
Mar 15 23:11:32 volumio volumio[975]: info: Error: Error: Error: Command failed: /bin/mv /tmp/plugins/peppy_screensaver.zip /tmp/downloaded_plugin.zip
Mar 15 23:11:32 volumio volumio[975]: /bin/mv: cannot move '/tmp/plugins/peppy_screensaver.zip' to '/tmp/downloaded_plugin.zip': Permission denied
Mar 15 23:11:33 volumio kernel: hwmon hwmon3: Undervoltage detected!
Mar 15 23:11:35 volumio kernel: hwmon hwmon3: Voltage normalised
Mar 15 23:11:40 volumio ntpd[1059]: Soliciting pool server 195.54.177.84
Mar 15 23:11:41 volumio ntpd[1059]: Soliciting pool server 212.41.8.158
Mar 15 23:11:41 volumio ntpd[1059]: Soliciting pool server 188.246.226.170
Mar 15 23:11:41 volumio ntpd[1059]: Soliciting pool server 192.36.143.130
Mar 15 23:11:41 volumio ntpd[1059]: Soliciting pool server 5.178.87.94
Mar 15 23:11:42 volumio ntpd[1059]: Soliciting pool server 162.159.200.123
Mar 15 23:11:42 volumio ntpd[1059]: Soliciting pool server 212.113.99.6
Mar 15 23:11:42 volumio ntpd[1059]: Soliciting pool server 5.178.87.93
Mar 15 23:11:42 volumio ntpd[1059]: Soliciting pool server 185.209.85.222
Mar 15 23:11:43 volumio ntpd[1059]: Soliciting pool server 45.92.177.52
Mar 15 23:11:43 volumio ntpd[1059]: Soliciting pool server 80.93.187.13
Mar 15 23:11:43 volumio ntpd[1059]: Soliciting pool server 91.206.16.3
Mar 15 23:11:43 volumio ntpd[1059]: Soliciting pool server 51.250.53.172
Mar 15 23:11:44 volumio ntpd[1059]: Soliciting pool server 51.250.35.68
Mar 15 23:11:44 volumio ntpd[1059]: Soliciting pool server 92.255.126.3
Mar 15 23:11:44 volumio ntpd[1059]: Soliciting pool server 89.179.240.219
Mar 15 23:11:45 volumio ntpd[1059]: Soliciting pool server 2a03:aa00::136:50
Mar 15 23:11:50 volumio ntpd[1059]: receive: Unexpected origin timestamp 0xeb805d85.e517e565 does not match aorg 0000000000.00000000 from server@5.178.87.93 xmt 0xeb805d86.a427bce4
Mar 15 23:11:50 volumio ntpd[1059]: receive: Unexpected origin timestamp 0xeb805d85.e519562c does not match aorg 0000000000.00000000 from server@212.41.8.158 xmt 0xeb805d86.a4284ac6
Mar 15 23:11:50 volumio ntpd[1059]: receive: Unexpected origin timestamp 0xeb805d85.e5155811 does not match aorg 0000000000.00000000 from server@92.255.126.3 xmt 0xeb805d86.a519748e
Mar 15 23:12:19 volumio volumio[975]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/gpio-buttons/volumio/buster/armhf
Mar 15 23:12:21 volumio volumio[975]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/gpio-buttons/volumio/buster/armhf
Mar 15 23:12:21 volumio volumio[975]: info: Folder /tmp/plugins removed
Mar 15 23:12:21 volumio volumio[975]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Mar 15 23:12:21 volumio volumio[975]: Error: Unable to resolve or reject the same promise twice
Mar 15 23:12:21 volumio volumio[975]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43)
Mar 15 23:12:21 volumio volumio[975]: at /volumio/app/pluginmanager.js:1087:11
Mar 15 23:12:21 volumio volumio[975]: at CB (/volumio/node_modules/fs-extra/lib/remove/rimraf.js:57:5)
Mar 15 23:12:21 volumio volumio[975]: at /volumio/node_modules/fs-extra/lib/remove/rimraf.js:213:24
Mar 15 23:12:21 volumio volumio[975]: at CB (/volumio/node_modules/fs-extra/lib/remove/rimraf.js:57:5)
Mar 15 23:12:21 volumio volumio[975]: at /volumio/node_modules/fs-extra/lib/remove/rimraf.js:107:14
Mar 15 23:12:21 volumio volumio[975]: at FSReqCallback.oncomplete (fs.js:171:23)
Mar 15 23:12:21 volumio volumio[975]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Mar 15 23:12:21 volumio sudo[2188]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-15 23:11
Mar 15 23:12:21 volumio sudo[2188]: 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"