-- Logs begin at Wed 2025-12-17 13:17:01 WET, end at Wed 2025-12-17 13:52:06 WET. -- Dec 17 13:52:04 box-de-musica systemd-timedated[1343]: Changed local time to Wed Dec 17 13:52:04 2025 Dec 17 13:52:04 box-de-musica sudo[1336]: pam_unix(sudo:session): session closed for user root Dec 17 13:52:04 box-de-musica volumio-time-update[604]: volumio-time-update-util: System time updated successfully. Dec 17 13:52:04 box-de-musica systemd[1]: Started Volumio Time Update Utility. Dec 17 13:52:04 box-de-musica systemd[1]: Reached target Multi-User System. Dec 17 13:52:04 box-de-musica systemd[1]: Reached target Graphical Interface. Dec 17 13:52:04 box-de-musica volumio[1189]: info: ___________ START PLUGINS ___________ Dec 17 13:52:04 box-de-musica volumio[1189]: info: ControllerMpd::onStart: Initializing MPD Dec 17 13:52:04 box-de-musica volumio[1189]: info: Creating MPD Configuration file Dec 17 13:52:04 box-de-musica systemd[1]: Starting Update UTMP about System Runlevel Changes... Dec 17 13:52:04 box-de-musica volumio[1189]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 17 13:52:04 box-de-musica volumio[1189]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 17 13:52:04 box-de-musica volumio[1189]: info: [1765979524110] CoreMusicLibrary::Adding element Servidores multimédia Dec 17 13:52:04 box-de-musica volumio[1189]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 17 13:52:04 box-de-musica sudo[1361]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 17 13:52:04 box-de-musica sudo[1361]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 17 13:52:04 box-de-musica sudo[1361]: pam_unix(sudo:session): session closed for user root Dec 17 13:52:04 box-de-musica sudo[1363]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 17 13:52:04 box-de-musica sudo[1363]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 17 13:52:04 box-de-musica systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Dec 17 13:52:04 box-de-musica systemd[1]: Started Update UTMP about System Runlevel Changes. Dec 17 13:52:04 box-de-musica volumio[1189]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 13:52:04 box-de-musica volumio[1189]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 17 13:52:04 box-de-musica volumio[1189]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 17 13:52:04 box-de-musica volumio[1189]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 13:52:04 box-de-musica volumio[1189]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 17 13:52:04 box-de-musica volumio[1189]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 17 13:52:04 box-de-musica volumio[1189]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 17 13:52:04 box-de-musica volumio[1189]: info: [1765979524327] CoreMusicLibrary::Adding element Last_100 Dec 17 13:52:04 box-de-musica volumio[1189]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 17 13:52:04 box-de-musica volumio[1189]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 17 13:52:04 box-de-musica volumio[1189]: info: [1765979524332] CoreMusicLibrary::Adding element Webradio Dec 17 13:52:04 box-de-musica volumio[1189]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 17 13:52:04 box-de-musica volumio[1189]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 17 13:52:04 box-de-musica volumio[1189]: info: Initializing BBC Radios Dec 17 13:52:04 box-de-musica volumio[1189]: Starting albumart workers Dec 17 13:52:04 box-de-musica volumio[1189]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 17 13:52:04 box-de-musica volumio[1189]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 17 13:52:04 box-de-musica volumio[1189]: info: Volumio Calling Home Dec 17 13:52:04 box-de-musica volumio[1189]: Starting albumart workers Dec 17 13:52:04 box-de-musica volumio[1189]: Starting albumart workers Dec 17 13:52:04 box-de-musica volumio[1189]: info: MPD Permissions set Dec 17 13:52:04 box-de-musica volumio[1189]: info: Dec 17 13:52:04 box-de-musica volumio[1189]: ---------------------------- Client requests Volumio Play Playlist Tiffosi Dec 17 13:52:04 box-de-musica volumio[1189]: info: Play playlist Tiffosi Dec 17 13:52:04 box-de-musica volumio[1189]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 13:52:04 box-de-musica volumio[1189]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 13:52:04 box-de-musica volumio[1189]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 13:52:04 box-de-musica volumio[1189]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 13:52:04 box-de-musica volumio[1189]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 13:52:04 box-de-musica volumio[1189]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 17 13:52:04 box-de-musica volumio[1189]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 13:52:04 box-de-musica volumio[1189]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 13:52:04 box-de-musica volumio[1189]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 13:52:04 box-de-musica volumio[1189]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 13:52:04 box-de-musica volumio[1189]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 13:52:04 box-de-musica volumio[1189]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 13:52:04 box-de-musica volumio[1189]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 13:52:05 box-de-musica volumio[1189]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 13:52:05 box-de-musica volumio[1189]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 17 13:52:05 box-de-musica volumio[1189]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 13:52:05 box-de-musica systemd[1]: mpd.service: Succeeded. Dec 17 13:52:05 box-de-musica systemd[1]: Stopped Music Player Daemon. Dec 17 13:52:05 box-de-musica volumio[1189]: info: VolumeController:: Volume=93 Mute =false Dec 17 13:52:05 box-de-musica volumio[1189]: info: CoreStateMachine::pushState Dec 17 13:52:05 box-de-musica volumio[1189]: info: CorePlayQueue::getTrack 0 Dec 17 13:52:05 box-de-musica volumio[1189]: info: CoreCommandRouter::volumioPushState Dec 17 13:52:05 box-de-musica volumio[1189]: info: Starting Shairport Sync Dec 17 13:52:05 box-de-musica volumio[1189]: info: Starting Shairport Sync Dec 17 13:52:05 box-de-musica sudo[1397]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 17 13:52:05 box-de-musica volumio[1189]: info: Starting Shairport Sync Dec 17 13:52:05 box-de-musica systemd[1]: Starting Music Player Daemon... Dec 17 13:52:05 box-de-musica sudo[1397]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 17 13:52:05 box-de-musica sudo[1399]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 17 13:52:05 box-de-musica sudo[1399]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 17 13:52:05 box-de-musica sudo[1402]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 17 13:52:05 box-de-musica sudo[1402]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 17 13:52:05 box-de-musica systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Dec 17 13:52:05 box-de-musica volumio[1189]: info: CoreCommandRouter::volumioClearQueue Dec 17 13:52:05 box-de-musica systemd[1]: shairport-sync.service: Succeeded. Dec 17 13:52:05 box-de-musica volumio[1189]: info: CoreStateMachine::ClearQueue Dec 17 13:52:05 box-de-musica volumio[1189]: info: CoreStateMachine::stop Dec 17 13:52:05 box-de-musica volumio[1189]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 17 13:52:05 box-de-musica volumio[1189]: info: CorePlayQueue::clearPlayQueue Dec 17 13:52:05 box-de-musica volumio[1189]: info: CorePlayQueue::saveQueue Dec 17 13:52:05 box-de-musica volumio[1189]: info: CoreCommandRouter::volumioPushState Dec 17 13:52:05 box-de-musica systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Dec 17 13:52:05 box-de-musica volumio[1189]: info: CoreCommandRouter::volumioPushQueue Dec 17 13:52:05 box-de-musica volumio[1189]: info: CoreCommandRouter::volumioAddQueueItems Dec 17 13:52:05 box-de-musica volumio[1189]: info: CoreStateMachine::addQueueItems Dec 17 13:52:05 box-de-musica volumio[1189]: info: CorePlayQueue::addQueueItems Dec 17 13:52:05 box-de-musica volumio[1189]: info: Preload queue cleared Dec 17 13:52:05 box-de-musica volumio[1189]: info: Adding Item to queue: mnt/INTERNAL/01 Givin' Up On Lovin' (DLG. Remix).mp3 Dec 17 13:52:05 box-de-musica volumio[1189]: info: Exploding uri mnt/INTERNAL/01 Givin' Up On Lovin' (DLG. Remix).mp3 in service mpd Dec 17 13:52:05 box-de-musica volumio[1189]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 17 13:52:05 box-de-musica systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 17 13:52:05 box-de-musica volumio[1189]: TypeError: Cannot read property 'then' of undefined Dec 17 13:52:05 box-de-musica volumio[1189]: at ControllerMpd.scanFolder (/volumio/app/plugins/music_service/mpd/index.js:2528:19) Dec 17 13:52:05 box-de-musica volumio[1189]: at ControllerMpd.explodeUri (/volumio/app/plugins/music_service/mpd/index.js:2326:21) Dec 17 13:52:05 box-de-musica volumio[1189]: at CoreCommandRouter.explodeUriFromService (/volumio/app/index.js:1378:16) Dec 17 13:52:05 box-de-musica volumio[1189]: at CorePlayQueue.explodeUriFromCache (/volumio/app/playqueue.js:123:24) Dec 17 13:52:05 box-de-musica volumio[1189]: at CorePlayQueue.explodeUri (/volumio/app/playqueue.js:181:19) Dec 17 13:52:05 box-de-musica volumio[1189]: at CorePlayQueue.addQueueItems (/volumio/app/playqueue.js:223:30) Dec 17 13:52:05 box-de-musica volumio[1189]: at CoreStateMachine.addQueueItems (/volumio/app/statemachine.js:247:25) Dec 17 13:52:05 box-de-musica volumio[1189]: at CoreCommandRouter.addQueueItems (/volumio/app/index.js:448:28) Dec 17 13:52:05 box-de-musica volumio[1189]: at /volumio/app/playlistManager.js:726:30 Dec 17 13:52:05 box-de-musica volumio[1189]: at /volumio/node_modules/jsonfile/index.js:46:5 Dec 17 13:52:05 box-de-musica volumio[1189]: at /volumio/node_modules/graceful-fs/graceful-fs.js:123:16 Dec 17 13:52:05 box-de-musica volumio[1189]: at FSReqCallback.readFileAfterClose [as oncomplete] (internal/fs/read_file_context.js:63:3) Dec 17 13:52:05 box-de-musica volumio[1189]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 17 13:52:05 box-de-musica sudo[1397]: pam_unix(sudo:session): session closed for user root Dec 17 13:52:05 box-de-musica sudo[1399]: pam_unix(sudo:session): session closed for user root Dec 17 13:52:05 box-de-musica sudo[1402]: pam_unix(sudo:session): session closed for user root Dec 17 13:52:05 box-de-musica dhcpcd[653]: wlan0: using IPv4LL address 169.254.216.44 Dec 17 13:52:05 box-de-musica avahi-daemon[601]: Registering new address record for 169.254.216.44 on wlan0.IPv4. Dec 17 13:52:05 box-de-musica dhcpcd[653]: wlan0: adding route to 169.254.0.0/16 Dec 17 13:52:05 box-de-musica sudo[1395]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 17 13:52:05 box-de-musica sudo[1395]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 17 13:52:05 box-de-musica sudo[1395]: pam_unix(sudo:session): session closed for user root Dec 17 13:52:06 box-de-musica sudo[1462]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-17 13:51 Dec 17 13:52:06 box-de-musica sudo[1462]: 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"