-- Logs begin at Tue 2024-07-16 18:22:14 CST, end at Tue 2024-07-16 18:24:32 CST. --
Jul 16 18:23:01 volumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jul 16 18:23:01 volumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 16 18:23:01 volumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jul 16 18:23:01 volumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Jul 16 18:23:01 volumio volumio[1160]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 36
Jul 16 18:23:02 volumio volumio[1160]: info: CoreCommandRouter::volumioGetState
Jul 16 18:23:02 volumio volumio[1160]: info: CorePlayQueue::getTrack 0
Jul 16 18:23:02 volumio volumio-remote-updater[862]: Test mode enabled
Jul 16 18:23:02 volumio volumio-remote-updater[862]: No alpha test mode
Jul 16 18:23:02 volumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
Jul 16 18:23:04 volumio volumio[1160]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"FIXES
\n\n- Improved translations
\n- Fix for controlling Volumio device from another one
\n- Fix for slow playback on RPi5 with HifiBerry DAC
\n
\nNEW ADDITIONS
\n\n- Enable THD compensation on Motivo
\n- Bump CM4 kernel to 6.6.30
\n- New custom display driver on Motivo
\n- Improved Plymouth boot animation on Motivo
\n- Enable Albumart on Motivo
\n- Add zoom setting on Vivaldi kiosk
\n- Set default zoom to 120% on Motivo
\n- Add DAC filter selection on Primo v2
\n- UNSTABLE ALPHA BUILD, DO NOT INSTALL
\n
\n","title":"Update v3.733","updateavailable":true}
Jul 16 18:23:04 volumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Jul 16 18:23:06 volumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 16 18:23:06 volumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 16 18:23:06 volumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
Jul 16 18:23:06 volumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Jul 16 18:23:06 volumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
Jul 16 18:23:06 volumio volumio[1160]: info: CoreCommandRouter::volumioGetBrowseSources
Jul 16 18:23:06 volumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jul 16 18:23:08 volumio volumio[1160]: error: MyVolumio Plugin failed to authenticate in a timely fashion
Jul 16 18:23:08 volumio volumio[1160]: info: Completed starting MyVolumio Plugin
Jul 16 18:23:08 volumio volumio[1160]: info: BOOT COMPLETED
Jul 16 18:23:08 volumio volumio[1160]: [Metrics] CommandRouter: 42s 312.33ms
Jul 16 18:23:08 volumio volumio[1160]: info: CoreCommandRouter::volumiosetStartupVolume
Jul 16 18:23:08 volumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jul 16 18:23:08 volumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 16 18:23:08 volumio volumio[1160]: info: CoreCommandRouter::Close All Modals sent
Jul 16 18:23:08 volumio volumio[1160]: info: CoreCommandRouter::Close All Modals sent
Jul 16 18:23:08 volumio volumio[1160]: info: Cannot play startup sound: Error: Command failed: /usr/bin/aplay -D volumio /volumio/app/startup.wav
Jul 16 18:23:08 volumio volumio[1160]: ALSA lib pcm_meter.c:677:(snd_pcm_meter_add_scope_conf) Cannot open shared library /data/plugins/user_interface/peppyspectrum/alsa-lib/libpeppyalsa.so ((null): /data/plugins/user_interface/peppyspectrum/alsa-lib/libpeppyalsa.so: cannot open shared object file: No such file or directory)
Jul 16 18:23:08 volumio volumio[1160]: aplay: main:828: audio open error: No such file or directory
Jul 16 18:23:09 volumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Jul 16 18:23:09 volumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Jul 16 18:23:09 volumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Jul 16 18:23:11 volumio sshd[2720]: Accepted password for root from 192.168.1.15 port 43356 ssh2
Jul 16 18:23:11 volumio sshd[2720]: pam_unix(sshd:session): session opened for user root by (uid=0)
Jul 16 18:23:11 volumio systemd-logind[868]: New session 5 of user root.
Jul 16 18:23:11 volumio systemd[1]: Started Session 5 of user root.
Jul 16 18:23:19 volumio volumio[1160]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred.
Jul 16 18:23:19 volumio volumio[1160]: info: Retrying Login Due to Network Error
Jul 16 18:23:28 volumio ntpd[1033]: Soliciting pool server 45.76.218.37
Jul 16 18:23:29 volumio ntpd[1033]: Soliciting pool server 133.243.238.243
Jul 16 18:23:29 volumio volumio[1160]: info: MyVolumio login type: Token
Jul 16 18:23:30 volumio ntpd[1033]: Soliciting pool server 133.243.238.163
Jul 16 18:23:31 volumio ntpd[1033]: Soliciting pool server 150.249.188.191
Jul 16 18:23:31 volumio ntpd[1033]: Soliciting pool server 202.182.111.234
Jul 16 18:23:31 volumio ntpd[1033]: Soliciting pool server 45.77.20.103
Jul 16 18:23:32 volumio ntpd[1033]: Soliciting pool server 162.159.200.1
Jul 16 18:23:32 volumio volumio[1160]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN
Jul 16 18:23:33 volumio ntpd[1033]: Soliciting pool server 202.181.103.212
Jul 16 18:23:33 volumio ntpd[1033]: Soliciting pool server 129.250.35.251
Jul 16 18:23:33 volumio ntpd[1033]: Soliciting pool server 172.105.204.105
Jul 16 18:23:34 volumio ntpd[1033]: Soliciting pool server 162.159.200.123
Jul 16 18:23:35 volumio ntpd[1033]: Soliciting pool server 160.16.113.133
Jul 16 18:23:35 volumio ntpd[1033]: Soliciting pool server 172.105.240.243
Jul 16 18:23:35 volumio ntpd[1033]: Soliciting pool server 129.250.35.250
Jul 16 18:23:35 volumio ntpd[1033]: receive: Unexpected origin timestamp 0xea40c8a7.8a2aecf8 does not match aorg 0000000000.00000000 from server@133.243.238.163 xmt 0xea40c8a7.ff6c8fff
Jul 16 18:23:36 volumio ntpd[1033]: Soliciting pool server 167.179.119.205
Jul 16 18:23:36 volumio ntpd[1033]: Soliciting pool server 2400:8902::f03c:91ff:fe50:f5f0
Jul 16 18:23:37 volumio ntpd[1033]: Soliciting pool server 108.160.132.224
Jul 16 18:23:44 volumio volumio[1160]: 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
Jul 16 18:23:46 volumio volumio[1160]: info: MyVolumio token set successfully
Jul 16 18:23:46 volumio volumio[1160]: info: MYVOLUMIO: Adding device
Jul 16 18:23:46 volumio volumio[1160]: info: MYVOLUMIO: Evaluating Server
Jul 16 18:23:46 volumio volumio[1160]: info: MyVolumio status changed
Jul 16 18:23:46 volumio volumio[1160]: info: Streaming services startup
Jul 16 18:23:46 volumio volumio[1160]: info: Starting Streaming Daemon
Jul 16 18:23:46 volumio volumio[1160]: info: Removing browser output: myVolumio user plan is not superstar
Jul 16 18:23:46 volumio volumio[1160]: info: Removing audio output:
Jul 16 18:23:46 volumio volumio[1160]: info: Stoppping Tunnel 1
Jul 16 18:23:46 volumio sudo[3583]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Jul 16 18:23:46 volumio sudo[3583]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 16 18:23:46 volumio sudo[3583]: pam_unix(sudo:session): session closed for user root
Jul 16 18:23:46 volumio volumio[1160]: error: Cannot start Volumio Streaming Daemon
Jul 16 18:23:46 volumio volumio[1160]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Jul 16 18:23:46 volumio volumio[1160]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Jul 16 18:23:46 volumio sudo[3586]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service
Jul 16 18:23:46 volumio sudo[3586]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jul 16 18:23:46 volumio sudo[3586]: pam_unix(sudo:session): session closed for user root
Jul 16 18:23:46 volumio volumio[1160]: info: Remote SSH Stopped
Jul 16 18:23:47 volumio volumio[1160]: info: Setting Geolocation for MyVolumio to us2
Jul 16 18:23:47 volumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 16 18:23:47 volumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 16 18:23:47 volumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 16 18:23:48 volumio volumio[1160]: info: Updating MyVolumio device info
Jul 16 18:23:48 volumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jul 16 18:23:50 volumio volumio[1160]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"}
Jul 16 18:23:54 volumio volumio[1160]: info: MYVOLUMIO: Adding device
Jul 16 18:23:54 volumio volumio[1160]: info: MYVOLUMIO: Evaluating Server
Jul 16 18:23:58 volumio volumio[1160]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"}
Jul 16 18:24:01 volumio sudo[3773]: volumio : TTY=pts/0 ; PWD=/home/volumio/peppy_screensaver ; USER=root ; COMMAND=/usr/local/bin/volumio plugin install
Jul 16 18:24:01 volumio sudo[3773]: pam_unix(sudo:session): session opened for user root by volumio(uid=0)
Jul 16 18:24:17 volumio volumio[1160]: 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
Jul 16 18:24:17 volumio volumio[1160]: info: Downloading plugin at http://127.0.0.1:3000/plugin-serve/peppy_screensaver.zip
Jul 16 18:24:18 volumio volumio[1160]: info: END DOWNLOAD: http://127.0.0.1:3000/plugin-serve/peppy_screensaver.zip
Jul 16 18:24:18 volumio volumio[1160]: info: Folder /tmp/plugins removed
Jul 16 18:24:32 volumio volumio[1160]: info: Check plugin dependencies
Jul 16 18:24:32 volumio volumio[1160]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jul 16 18:24:32 volumio volumio[1160]: info: Checking if plugin already exists
Jul 16 18:24:32 volumio volumio[1160]: info: Rename folder
Jul 16 18:24:32 volumio volumio[1160]: info: Move to category
Jul 16 18:24:32 volumio volumio[1160]: info: Folder /tmp/downloaded_plugin.zip removed
Jul 16 18:24:32 volumio volumio[1160]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 16 18:24:32 volumio volumio[1160]: Error: Unable to resolve or reject the same promise twice
Jul 16 18:24:32 volumio volumio[1160]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43)
Jul 16 18:24:32 volumio volumio[1160]: at /volumio/app/pluginmanager.js:1087:11
Jul 16 18:24:32 volumio volumio[1160]: at CB (/volumio/node_modules/fs-extra/lib/remove/rimraf.js:57:5)
Jul 16 18:24:32 volumio volumio[1160]: at /volumio/node_modules/fs-extra/lib/remove/rimraf.js:201:20
Jul 16 18:24:32 volumio volumio[1160]: at go$readdir$cb (/volumio/node_modules/graceful-fs/graceful-fs.js:195:14)
Jul 16 18:24:32 volumio volumio[1160]: at FSReqCallback.oncomplete (fs.js:180:23)
Jul 16 18:24:32 volumio volumio[1160]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 16 18:24:32 volumio sudo[4670]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-16 18:23
Jul 16 18:24:32 volumio sudo[4670]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Debian GNU/Linux 10 (buster)"
NAME="Debian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
ID=debian
HOME_URL="https://www.debian.org/"
SUPPORT_URL="https://www.debian.org/support"
BUG_REPORT_URL="https://bugs.debian.org/"
VOLUMIO_BUILD_VERSION="4b122b2365bb8c09786cd63b50d1ea6db780eb4e"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 09:13:11 PM CEST"
VOLUMIO_VERSION="3.703"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="ac782621640fcc70c07e91a81b6d958b"