-- Logs begin at Fri 2025-02-28 10:46:41 CET, end at Sun 2025-03-02 09:53:00 CET. -- Mar 02 09:52:10 volumio volumio-remote-updater[658]: [2025-03-02 09:52:10] [connect] Successful connection Mar 02 09:52:16 volumio volumio[4991]: info: Cannot mount NAS music at system boot, trial number 2 ,retrying in 5 seconds Mar 02 09:52:16 volumio sudo[5340]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 02 09:52:16 volumio sudo[5340]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 02 09:52:16 volumio volumio[4991]: error: Plugin system_controller system failed to complete 'onVolumioStart' in a timely fashion Mar 02 09:52:16 volumio volumio[4991]: error: Plugin system_controller volumio_command_line_client failed to complete 'onVolumioStart' in a timely fashion Mar 02 09:52:16 volumio volumio[4991]: error: Plugin system_controller i2s_dacs failed to complete 'onVolumioStart' in a timely fashion Mar 02 09:52:16 volumio volumio[4991]: info: Preparing to generate the ALSA configuration file Mar 02 09:52:16 volumio sudo[5340]: pam_unix(sudo:session): session closed for user root Mar 02 09:52:16 volumio sudo[5342]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 02 09:52:16 volumio sudo[5342]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 02 09:52:16 volumio sudo[5342]: pam_unix(sudo:session): session closed for user root Mar 02 09:52:16 volumio volumio[4991]: info: Reloading queue from file Mar 02 09:52:16 volumio volumio[4991]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Niccol%C3%B2%20Paganini/Paganini%3A%2024%20Caprices%2C%20Op.%201/4cc2d9d2-6e70-4da6-a36b-7528d8cbad95.jpg' Mar 02 09:52:16 volumio volumio[4991]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Pink%20Floyd/Dark%20Side%20of%20the%20Moon/7dfaac3c-76a7-4e5c-8d37-61847b9eedb3.png' Mar 02 09:52:16 volumio volumio[4991]: info: VolumeController:: Volume=65 Mute =false Mar 02 09:52:16 volumio volumio[4991]: info: CoreStateMachine::pushState Mar 02 09:52:16 volumio volumio[4991]: info: CorePlayQueue::getTrack 0 Mar 02 09:52:16 volumio volumio[4991]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 02 09:52:16 volumio volumio[4991]: info: CoreCommandRouter::volumioPushState Mar 02 09:52:16 volumio volumio[4991]: info: CoreStateMachine::updateTrackBlock Mar 02 09:52:16 volumio volumio[4991]: info: CorePlayQueue::getTrackBlock Mar 02 09:52:16 volumio volumio[4991]: info: CoreCommandRouter::volumioRetrievevolume Mar 02 09:52:16 volumio volumio[4991]: info: CoreStateMachine::setRepeat false single undefined Mar 02 09:52:16 volumio volumio[4991]: info: CoreStateMachine::pushState Mar 02 09:52:16 volumio volumio[4991]: info: CorePlayQueue::getTrack 0 Mar 02 09:52:16 volumio volumio[4991]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 02 09:52:16 volumio volumio[4991]: info: CoreCommandRouter::volumioPushState Mar 02 09:52:16 volumio volumio[4991]: info: CoreStateMachine::setRandom false Mar 02 09:52:16 volumio volumio[4991]: info: CoreStateMachine::pushState Mar 02 09:52:16 volumio volumio[4991]: info: CorePlayQueue::getTrack 0 Mar 02 09:52:16 volumio volumio[4991]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 02 09:52:16 volumio volumio[4991]: info: CoreCommandRouter::volumioPushState Mar 02 09:52:16 volumio volumio[4991]: info: Setting Device type: Raspberry PI Mar 02 09:52:17 volumio volumio[4991]: info: Asound.conf file unchanged, so no further update is needed Mar 02 09:52:17 volumio volumio[4991]: info: Output device has changed, restarting MPD Mar 02 09:52:17 volumio volumio[4991]: info: Output device has changed, restarting Shairport Sync Mar 02 09:52:17 volumio volumio[4991]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 02 09:52:17 volumio volumio[4991]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 02 09:52:17 volumio sudo[5353]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 02 09:52:17 volumio sudo[5353]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 02 09:52:17 volumio sudo[5353]: pam_unix(sudo:session): session closed for user root Mar 02 09:52:17 volumio sudo[5355]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 02 09:52:17 volumio sudo[5355]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 02 09:52:17 volumio systemd[1]: Stopping Music Player Daemon... Mar 02 09:52:17 volumio volumio[4991]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 02 09:52:17 volumio systemd[1]: mpd.service: Succeeded. Mar 02 09:52:17 volumio systemd[1]: Stopped Music Player Daemon. Mar 02 09:52:17 volumio volumio[4991]: info: ___________ START PLUGINS ___________ Mar 02 09:52:17 volumio volumio[4991]: info: ControllerMpd::onStart: Initializing MPD Mar 02 09:52:17 volumio volumio[4991]: info: Creating MPD Configuration file Mar 02 09:52:17 volumio systemd[1]: Starting Music Player Daemon... Mar 02 09:52:17 volumio sudo[5363]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 02 09:52:17 volumio sudo[5363]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 02 09:52:17 volumio sudo[5363]: pam_unix(sudo:session): session closed for user root Mar 02 09:52:17 volumio volumio[4991]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 02 09:52:17 volumio volumio[4991]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 02 09:52:17 volumio sudo[5367]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 02 09:52:17 volumio sudo[5367]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 02 09:52:17 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Mar 02 09:52:17 volumio systemd[1]: mpd.service: Succeeded. Mar 02 09:52:17 volumio systemd[1]: Stopped Music Player Daemon. Mar 02 09:52:17 volumio systemd[1]: Starting Music Player Daemon... Mar 02 09:52:17 volumio volumio[4991]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 02 09:52:17 volumio volumio[4991]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 02 09:52:17 volumio volumio[4991]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 02 09:52:17 volumio volumio[4991]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 02 09:52:17 volumio volumio[4991]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 02 09:52:17 volumio volumio[4991]: info: [1740905537532] CoreMusicLibrary::Adding element Last_100 Mar 02 09:52:17 volumio volumio[4991]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 02 09:52:17 volumio volumio[4991]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 02 09:52:17 volumio volumio[4991]: info: [1740905537537] CoreMusicLibrary::Adding element Webradio Mar 02 09:52:17 volumio volumio[4991]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 02 09:52:17 volumio volumio[4991]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 02 09:52:17 volumio volumio[4991]: info: Initializing BBC Radios Mar 02 09:52:17 volumio sudo[5372]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 02 09:52:17 volumio sudo[5372]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 02 09:52:17 volumio sudo[5372]: pam_unix(sudo:session): session closed for user root Mar 02 09:52:17 volumio volumio[4991]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 02 09:52:17 volumio volumio[4991]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 02 09:52:17 volumio volumio[4991]: info: Volumio Calling Home Mar 02 09:52:19 volumio mpd[5387]: Mar 02 09:52 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 02 09:52:19 volumio systemd[1]: Started Music Player Daemon. Mar 02 09:52:19 volumio sudo[5355]: pam_unix(sudo:session): session closed for user root Mar 02 09:52:19 volumio sudo[5367]: pam_unix(sudo:session): session closed for user root Mar 02 09:52:25 volumio volumio-remote-updater[658]: [2025-03-02 09:52:25] [connect] Successful connection Mar 02 09:52:40 volumio volumio-remote-updater[658]: [2025-03-02 09:52:40] [connect] Successful connection Mar 02 09:52:55 volumio volumio-remote-updater[658]: [2025-03-02 09:52:55] [connect] Successful connection Mar 02 09:53:00 volumio volumio[4991]: info: MPD Permissions set Mar 02 09:53:00 volumio volumio[4991]: info: VolumeController:: Volume=65 Mute =false Mar 02 09:53:00 volumio volumio[4991]: info: CoreStateMachine::pushState Mar 02 09:53:00 volumio volumio[4991]: info: CorePlayQueue::getTrack 0 Mar 02 09:53:00 volumio volumio[4991]: info: CoreCommandRouter::volumioPushState Mar 02 09:53:00 volumio volumio[4991]: info: Cannot mount NAS music at system boot, trial number 3 ,retrying in 5 seconds Mar 02 09:53:00 volumio volumio[4991]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 02 09:53:00 volumio volumio[4991]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 02 09:53:00 volumio volumio[4991]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 02 09:53:00 volumio volumio[4991]: error: Plugin music_service mpd failed to complete 'onStart' in a timely fashion Mar 02 09:53:00 volumio volumio[4991]: info: ------------------------------------------- Mar 02 09:53:00 volumio volumio[4991]: info: ----- MyVolumio plugins startup ---- Mar 02 09:53:00 volumio volumio[4991]: info: ------------------------------------------- Mar 02 09:53:00 volumio volumio[4991]: info: [MyVolumio PluginManager] Fetching plans data.... Mar 02 09:53:00 volumio volumio[4991]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 02 09:53:00 volumio volumio[4991]: Error: read ECONNRESET Mar 02 09:53:00 volumio volumio[4991]: at TLSWrap.onStreamRead (internal/stream_base_commons.js:209:20) { Mar 02 09:53:00 volumio volumio[4991]: errno: -104, Mar 02 09:53:00 volumio volumio[4991]: code: 'ECONNRESET', Mar 02 09:53:00 volumio volumio[4991]: syscall: 'read' Mar 02 09:53:00 volumio volumio[4991]: } Mar 02 09:53:00 volumio volumio[4991]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 02 09:53:00 volumio sudo[5445]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-02 09:52 Mar 02 09:53:00 volumio sudo[5445]: 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"