-- Logs begin at Fri 2025-02-28 10:46:41 CET, end at Sun 2025-03-02 10:35:23 CET. -- Mar 02 10:34:04 volumio volumio-remote-updater[658]: [2025-03-02 10:34:04] [connect] Successful connection Mar 02 10:34:14 volumio volumio[7601]: info: MPD Permissions set Mar 02 10:34:14 volumio volumio[7601]: info: MPD Permissions set Mar 02 10:34:14 volumio volumio[7601]: info: VolumeController:: Volume=65 Mute =false Mar 02 10:34:14 volumio volumio[7601]: info: CoreStateMachine::pushState Mar 02 10:34:14 volumio volumio[7601]: info: CorePlayQueue::getTrack 0 Mar 02 10:34:14 volumio volumio[7601]: info: CoreCommandRouter::volumioPushState Mar 02 10:34:14 volumio volumio[7601]: info: Cannot mount NAS music at system boot, trial number 3 ,retrying in 5 seconds Mar 02 10:34:14 volumio volumio[7601]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 02 10:34:14 volumio volumio[7601]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 02 10:34:14 volumio volumio[7601]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 02 10:34:14 volumio volumio[7601]: error: Plugin music_service mpd failed to complete 'onStart' in a timely fashion Mar 02 10:34:14 volumio volumio[7601]: info: ------------------------------------------- Mar 02 10:34:14 volumio volumio[7601]: info: ----- MyVolumio plugins startup ---- Mar 02 10:34:14 volumio volumio[7601]: info: ------------------------------------------- Mar 02 10:34:14 volumio volumio[7601]: info: [MyVolumio PluginManager] Fetching plans data.... Mar 02 10:34:14 volumio volumio[7601]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Paul%20Hardcastle/Paul%20Hardcastle%208/9bdba205-36db-4139-aec6-a45b17f0f5bb.jpg' Mar 02 10:34:14 volumio volumio[7601]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Paul%20Hardcastle/Hardcastle%207/74f77745-d02a-409c-8855-60e4916674b8.jpg' Mar 02 10:34:14 volumio volumio[7601]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Kate%20Ryan/Stronger/dead43cb-d407-4453-9e79-58f1a8fdc537.png' Mar 02 10:34:14 volumio volumio[7601]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Yes/Big%20Generator/8787551a-df73-4cd0-abea-1fc6c4eb6e01.jpg' Mar 02 10:34:14 volumio volumio[7601]: info: Discovery: adding 3b7d3e81-c4fa-470e-aeb9-8a884bfcfd3d Mar 02 10:34:14 volumio volumio[7601]: info: Discovery: Found device Volumio Mar 02 10:34:14 volumio volumio[7601]: info: CoreCommandRouter::volumioGetState Mar 02 10:34:14 volumio volumio[7601]: info: CorePlayQueue::getTrack 0 Mar 02 10:34:15 volumio volumio[7601]: info: Volumio called home Mar 02 10:34:15 volumio sudo[8102]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Mar 02 10:34:15 volumio sudo[8102]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 02 10:34:15 volumio volumio[7601]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Mar 02 10:34:15 volumio sudo[8102]: pam_unix(sudo:session): session closed for user root Mar 02 10:34:15 volumio volumio[7601]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 02 10:34:15 volumio volumio[7601]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 02 10:34:15 volumio volumio[7601]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 02 10:34:15 volumio volumio[7601]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 02 10:34:15 volumio volumio[7601]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 02 10:34:15 volumio volumio[7601]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 02 10:34:15 volumio volumio[7601]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 02 10:34:15 volumio volumio[7601]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 02 10:34:15 volumio volumio[7601]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 02 10:34:15 volumio volumio[7601]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 02 10:34:15 volumio volumio[7601]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 02 10:34:15 volumio volumio[7601]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 02 10:34:15 volumio volumio[7601]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 02 10:34:15 volumio volumio[7601]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 02 10:34:15 volumio volumio[7601]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 02 10:34:15 volumio volumio[7601]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 02 10:34:15 volumio volumio[7601]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 02 10:34:15 volumio volumio[7601]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 02 10:34:15 volumio volumio[7601]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 02 10:34:15 volumio volumio[7601]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 02 10:34:19 volumio volumio-remote-updater[658]: [2025-03-02 10:34:19] [connect] Successful connection Mar 02 10:34:34 volumio volumio-remote-updater[658]: [2025-03-02 10:34:34] [connect] Successful connection Mar 02 10:34:49 volumio volumio-remote-updater[658]: [2025-03-02 10:34:49] [connect] Successful connection Mar 02 10:34:56 volumio volumio[7601]: error: MPD error: The expression evaluated to a falsy value: Mar 02 10:34:56 volumio volumio[7601]: assert.ok(self.idling) Mar 02 10:34:56 volumio volumio[7601]: error: The expression evaluated to a falsy value: Mar 02 10:34:56 volumio volumio[7601]: assert.ok(self.idling) Mar 02 10:34:56 volumio volumio[7601]: info: Upmpdcli Daemon Started Mar 02 10:34:56 volumio volumio[7601]: info: MPD running with PID8006 Mar 02 10:34:56 volumio volumio[7601]: ,establishing connection Mar 02 10:34:56 volumio volumio[7601]: info: Cannot mount NAS music at system boot, trial number 4 ,retrying in 5 seconds Mar 02 10:34:56 volumio volumio[7601]: error: MyVolumio Plugin failed to start in a timely fashion Mar 02 10:34:56 volumio volumio[7601]: info: BOOT COMPLETED Mar 02 10:34:56 volumio volumio[7601]: [Metrics] CommandRouter: 540s 273.94ms Mar 02 10:34:56 volumio volumio[7601]: info: CoreCommandRouter::volumiosetStartupVolume Mar 02 10:34:56 volumio volumio[7601]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 02 10:34:56 volumio volumio[7601]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 02 10:34:56 volumio volumio[7601]: info: CoreCommandRouter::Close All Modals sent Mar 02 10:34:56 volumio volumio[7601]: info: CoreCommandRouter::Close All Modals sent Mar 02 10:34:56 volumio volumio[7601]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Kate%20Ryan/Alive/329a2d24-92cb-417d-a8c0-0155fa04fc3a.png' Mar 02 10:34:56 volumio volumio[7601]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Johann%20Sebastian%20Bach/Bach%20for%20Meditation/6e26a641-2c84-4994-b633-b67357418cc8.jpg' Mar 02 10:35:04 volumio volumio-remote-updater[658]: [2025-03-02 10:35:04] [connect] Successful connection Mar 02 10:35:19 volumio volumio-remote-updater[658]: [2025-03-02 10:35:19] [connect] Successful connection Mar 02 10:35:22 volumio volumio[7601]: error: updateQueue error: null Mar 02 10:35:22 volumio volumio[7601]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 02 10:35:22 volumio volumio[7601]: Error: read ECONNRESET Mar 02 10:35:22 volumio volumio[7601]: at TLSWrap.onStreamRead (internal/stream_base_commons.js:209:20) { Mar 02 10:35:22 volumio volumio[7601]: errno: -104, Mar 02 10:35:22 volumio volumio[7601]: code: 'ECONNRESET', Mar 02 10:35:22 volumio volumio[7601]: syscall: 'read' Mar 02 10:35:22 volumio volumio[7601]: } Mar 02 10:35:22 volumio volumio[7601]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 02 10:35:23 volumio sudo[8165]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-02 10:34 Mar 02 10:35:23 volumio sudo[8165]: 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="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:01:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="e0a6dc7e914e3fb93cbf2123f2f73eac"