-- Logs begin at Mon 2024-07-22 19:22:30 CEST, end at Sat 2024-09-07 16:34:51 CEST. -- Sep 07 16:33:05 volumio-sleep volumio[12131]: error: MPD error: The expression evaluated to a falsy value: Sep 07 16:33:05 volumio-sleep volumio[12131]: assert.ok(self.idling) Sep 07 16:33:05 volumio-sleep volumio[12131]: error: The expression evaluated to a falsy value: Sep 07 16:33:05 volumio-sleep volumio[12131]: assert.ok(self.idling) Sep 07 16:33:05 volumio-sleep volumio[12131]: error: MPD error: The expression evaluated to a falsy value: Sep 07 16:33:05 volumio-sleep volumio[12131]: assert.ok(self.idling) Sep 07 16:33:05 volumio-sleep volumio[12131]: error: The expression evaluated to a falsy value: Sep 07 16:33:05 volumio-sleep volumio[12131]: assert.ok(self.idling) Sep 07 16:33:05 volumio-sleep volumio[12131]: error: MPD error: The expression evaluated to a falsy value: Sep 07 16:33:05 volumio-sleep volumio[12131]: assert.ok(self.idling) Sep 07 16:33:05 volumio-sleep volumio[12131]: error: The expression evaluated to a falsy value: Sep 07 16:33:05 volumio-sleep volumio[12131]: assert.ok(self.idling) Sep 07 16:33:05 volumio-sleep volumio[12131]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Sep 07 16:33:06 volumio-sleep volumio[12131]: verbose: New Socket.io Connection to 192.168.178.47:3000 from 192.168.178.45 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Sep 07 16:33:06 volumio-sleep volumio[12131]: info: Discovery: Remote connection error: 192.168.178.45 Sep 07 16:33:06 volumio-sleep volumio[12131]: info: Discovery: Remote connection timeout: 192.168.178.45 Sep 07 16:33:12 volumio-sleep volumio-remote-updater[453]: [2024-09-07 14:33:12] [connect] Successful connection Sep 07 16:33:12 volumio-sleep volumio[12131]: error: MyVolumio Plugin failed to authenticate in a timely fashion Sep 07 16:33:12 volumio-sleep volumio[12131]: info: Completed starting MyVolumio Plugin Sep 07 16:33:12 volumio-sleep volumio[12131]: info: BOOT COMPLETED Sep 07 16:33:12 volumio-sleep volumio[12131]: [Metrics] CommandRouter: 194s 46.04ms Sep 07 16:33:12 volumio-sleep volumio[12131]: info: CoreCommandRouter::volumiosetStartupVolume Sep 07 16:33:12 volumio-sleep volumio[12131]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 07 16:33:12 volumio-sleep volumio[12131]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 07 16:33:13 volumio-sleep volumio[12131]: info: CoreCommandRouter::Close All Modals sent Sep 07 16:33:13 volumio-sleep volumio[12131]: info: CoreCommandRouter::Close All Modals sent Sep 07 16:33:15 volumio-sleep volumio[12131]: error: updateQueue error: null Sep 07 16:33:15 volumio-sleep volumio[12131]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Sep 07 16:33:16 volumio-sleep volumio[12131]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Sep 07 16:33:16 volumio-sleep volumio[12131]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Sep 07 16:33:16 volumio-sleep volumio[12131]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Sep 07 16:33:18 volumio-sleep volumio[12131]: info: Discovery: Connected to remote: 192.168.178.45 Sep 07 16:33:18 volumio-sleep volumio[12131]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Sep 07 16:33:18 volumio-sleep volumio[12131]: info: FusionDsp - ---- read samplerate from file: 44100 Sep 07 16:33:18 volumio-sleep volumio[12131]: info: camilladsp stopping service pid 12418... Sep 07 16:33:18 volumio-sleep volumio[12131]: info: camilladsp service terminated, instance 1 Sep 07 16:33:18 volumio-sleep volumio[12131]: info: FusionDsp - If filter freq >samplerate/2 then disable it Sep 07 16:33:18 volumio-sleep volumio[12131]: info: camilladsp service started and running in background, instance 1 Sep 07 16:33:19 volumio-sleep volumio[12131]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Sep 07 16:33:19 volumio-sleep volumio[12131]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Sep 07 16:33:19 volumio-sleep volumio[12131]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Sep 07 16:33:19 volumio-sleep volumio[12131]: verbose: New Socket.io Connection to 192.168.178.47:3000 from 192.168.178.45 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 11 Sep 07 16:33:21 volumio-sleep volumio[12131]: info: CoreCommandRouter::volumioGetState Sep 07 16:33:21 volumio-sleep volumio[12131]: info: CorePlayQueue::getTrack 0 Sep 07 16:33:23 volumio-sleep volumio[12131]: info: camilladsp spawned new process with pid 12591, instance 1, run: true Sep 07 16:33:24 volumio-sleep volumio[12131]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Sep 07 16:33:26 volumio-sleep volumio[12131]: verbose: New Socket.io Connection to 192.168.178.47:3000 from 192.168.178.45 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 12 Sep 07 16:33:27 volumio-sleep volumio-remote-updater[453]: [2024-09-07 14:33:27] [connect] Successful connection Sep 07 16:33:27 volumio-sleep volumio[12131]: info: camilladsp spawned new process with pid 12599, instance 1, run: true Sep 07 16:33:31 volumio-sleep volumio[12131]: verbose: New Socket.io Connection to 192.168.178.47:3000 from 192.168.178.45 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Sep 07 16:33:32 volumio-sleep volumio-remote-updater[453]: [2024-09-07 14:33:32] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1725719607 101 Sep 07 16:33:32 volumio-sleep volumio[12131]: 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: 9 Sep 07 16:33:34 volumio-sleep volumio[12131]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Sep 07 16:33:34 volumio-sleep volumio[12131]: info: MyVolumio token set successfully Sep 07 16:33:34 volumio-sleep volumio[12131]: info: MYVOLUMIO: Adding device Sep 07 16:33:34 volumio-sleep volumio[12131]: info: MYVOLUMIO: Evaluating Server Sep 07 16:33:38 volumio-sleep volumio[12131]: STREAMING PROXY: Starting server on port 3245 Sep 07 16:33:38 volumio-sleep volumio[12131]: Node JS runtime: 14 Sep 07 16:33:40 volumio-sleep volumio[12131]: info: MyVolumio status changed Sep 07 16:33:40 volumio-sleep volumio[12131]: info: Streaming services startup Sep 07 16:33:40 volumio-sleep volumio[12131]: info: Starting Streaming Daemon Sep 07 16:33:40 volumio-sleep volumio[12131]: info: Removing browser output: myVolumio user plan is not superstar Sep 07 16:33:40 volumio-sleep volumio[12131]: info: Removing audio output: Sep 07 16:33:40 volumio-sleep volumio[12131]: info: Stoppping Tunnel 1 Sep 07 16:33:41 volumio-sleep sudo[12681]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Sep 07 16:33:41 volumio-sleep sudo[12681]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 07 16:33:41 volumio-sleep sudo[12683]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Sep 07 16:33:41 volumio-sleep sudo[12683]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 07 16:33:41 volumio-sleep sudo[12681]: pam_unix(sudo:session): session closed for user root Sep 07 16:33:41 volumio-sleep volumio[12131]: info: CoreCommandRouter::volumioGetState Sep 07 16:33:41 volumio-sleep volumio[12131]: info: CorePlayQueue::getTrack 0 Sep 07 16:33:42 volumio-sleep sudo[12683]: pam_unix(sudo:session): session closed for user root Sep 07 16:33:42 volumio-sleep volumio[12131]: info: Setting Geolocation for MyVolumio to eu10 Sep 07 16:33:42 volumio-sleep volumio[12131]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 07 16:33:42 volumio-sleep volumio[12131]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 07 16:33:42 volumio-sleep volumio[12131]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 07 16:33:42 volumio-sleep volumio[12131]: info: Remote SSH Stopped Sep 07 16:33:42 volumio-sleep volumio[12131]: error: Cannot start Volumio Streaming Daemon Sep 07 16:33:42 volumio-sleep volumio[12131]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Sep 07 16:33:42 volumio-sleep volumio[12131]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Sep 07 16:33:43 volumio-sleep volumio[12131]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Sep 07 16:33:43 volumio-sleep volumio[12131]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Sep 07 16:33:43 volumio-sleep volumio[12131]: info: Updating MyVolumio device info Sep 07 16:33:43 volumio-sleep volumio[12131]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 07 16:33:43 volumio-sleep volumio[12131]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 07 16:33:43 volumio-sleep volumio[12131]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 07 16:33:43 volumio-sleep volumio[12131]: info: CoreCommandRouter::volumioGetState Sep 07 16:33:43 volumio-sleep volumio[12131]: info: CorePlayQueue::getTrack 0 Sep 07 16:33:44 volumio-sleep volumio[12131]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Sep 07 16:33:44 volumio-sleep volumio[12131]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 11 Sep 07 16:33:44 volumio-sleep volumio[12131]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 12 Sep 07 16:33:45 volumio-sleep volumio[12131]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Sep 07 16:33:47 volumio-sleep volumio[12131]: info: MYVOLUMIO: Adding device Sep 07 16:33:47 volumio-sleep volumio[12131]: info: MYVOLUMIO: Evaluating Server Sep 07 16:33:51 volumio-sleep volumio[12131]: info: Setting Geolocation for MyVolumio to eu4 Sep 07 16:33:51 volumio-sleep volumio[12131]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 07 16:33:52 volumio-sleep volumio[12131]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 07 16:33:52 volumio-sleep volumio[12131]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 07 16:33:52 volumio-sleep volumio[12131]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Sep 07 16:33:53 volumio-sleep volumio[12131]: info: Updating MyVolumio device info Sep 07 16:33:53 volumio-sleep volumio[12131]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 07 16:33:53 volumio-sleep volumio[12131]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 07 16:33:53 volumio-sleep volumio[12131]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Sep 07 16:34:40 volumio-sleep volumio[12131]: 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 Sep 07 16:34:41 volumio-sleep volumio[12131]: 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: 8 Sep 07 16:34:41 volumio-sleep volumio[12131]: info: Downloading plugin at http://127.0.0.1:3000/plugin-serve/tft24-display.zip Sep 07 16:34:42 volumio-sleep volumio[12131]: info: END DOWNLOAD: http://127.0.0.1:3000/plugin-serve/tft24-display.zip Sep 07 16:34:42 volumio-sleep volumio[12131]: info: Folder /tmp/plugins removed Sep 07 16:34:46 volumio-sleep volumio[12131]: info: Check plugin dependencies Sep 07 16:34:46 volumio-sleep volumio[12131]: info: Checking if plugin already exists Sep 07 16:34:46 volumio-sleep volumio[12131]: info: Rename folder Sep 07 16:34:47 volumio-sleep volumio[12131]: info: Move to category Sep 07 16:34:47 volumio-sleep volumio[12131]: info: Folder /tmp/downloaded_plugin.zip removed Sep 07 16:34:47 volumio-sleep volumio[12131]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 07 16:34:47 volumio-sleep volumio[12131]: Error: Unable to resolve or reject the same promise twice Sep 07 16:34:47 volumio-sleep volumio[12131]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Sep 07 16:34:47 volumio-sleep volumio[12131]: at /volumio/app/pluginmanager.js:1087:11 Sep 07 16:34:47 volumio-sleep volumio[12131]: at CB (/volumio/node_modules/fs-extra/lib/remove/rimraf.js:57:5) Sep 07 16:34:47 volumio-sleep volumio[12131]: at /volumio/node_modules/fs-extra/lib/remove/rimraf.js:201:20 Sep 07 16:34:47 volumio-sleep volumio[12131]: at go$readdir$cb (/volumio/node_modules/graceful-fs/graceful-fs.js:195:14) Sep 07 16:34:47 volumio-sleep volumio[12131]: at FSReqCallback.oncomplete (fs.js:171:23) Sep 07 16:34:47 volumio-sleep volumio[12131]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 07 16:34:51 volumio-sleep sudo[12784]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-09-07 16:33 Sep 07 16:34:51 volumio-sleep sudo[12784]: 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="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:17:01 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="2782e52360f70dfab079c82951ebbbb1"