Dec 07 22:19:15 volumio ntpd[944]: CLOCK: time stepped by 226836.197296 Dec 07 22:19:15 volumio ntpd[944]: CLOCK: time changed from 2025-12-05 to 2025-12-07 Dec 07 22:19:15 volumio volumio[2239]: info: CoreCommandRouter::volumioGetState Dec 07 22:19:15 volumio volumio[2239]: info: CorePlayQueue::getTrack 0 Dec 07 22:19:15 volumio ntpd[944]: INIT: MRU 13107 entries, 13 hash bits, 32768 bytes Dec 07 22:19:15 volumio volumio[2239]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Dec 07 22:19:15 volumio volumio[2239]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 07 22:19:15 volumio volumio[2239]: info: Received Get System Info Dec 07 22:19:15 volumio volumio[2239]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 07 22:19:15 volumio volumio[2239]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 07 22:19:15 volumio volumio[2239]: info: Discovery: Getting this device information Dec 07 22:19:15 volumio volumio[2239]: info: CoreCommandRouter::volumioGetState Dec 07 22:19:15 volumio volumio[2239]: info: CorePlayQueue::getTrack 0 Dec 07 22:19:15 volumio volumio[2239]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 07 22:19:15 volumio volumio[2239]: info: CoreCommandRouter::volumioGetState Dec 07 22:19:15 volumio volumio[2239]: info: CorePlayQueue::getTrack 0 Dec 07 22:19:15 volumio volumio[2239]: info: Listing playlists Dec 07 22:19:15 volumio volumio[2239]: info: CoreCommandRouter::volumioGetQueue Dec 07 22:19:15 volumio volumio[2239]: info: CoreStateMachine::getQueue Dec 07 22:19:15 volumio volumio[2239]: info: CorePlayQueue::getQueue Dec 07 22:19:15 volumio systemd[1]: Starting dpkg-db-backup.service - Daily dpkg database backup service... Dec 07 22:19:15 volumio volumio[2239]: info: Discovery: A device disappeared from network Dec 07 22:19:15 volumio volumio[2239]: info: Discovery: Device volumio disappeared from network Dec 07 22:19:15 volumio volumio[2239]: info: Discovery: A device disappeared from network Dec 07 22:19:15 volumio systemd[1]: Starting e2scrub_all.service - Online ext4 Metadata Check for All Filesystems... Dec 07 22:19:15 volumio systemd[1]: Started ntpsec-rotate-stats.service - Rotate ntpd stats. Dec 07 22:19:15 volumio systemd[1]: e2scrub_all.service: Deactivated successfully. Dec 07 22:19:15 volumio systemd[1]: Finished e2scrub_all.service - Online ext4 Metadata Check for All Filesystems. Dec 07 22:19:15 volumio volumio[2239]: info: Discovery: adding 2d081a8c-b0f6-4dee-8583-5a37aea7284c Dec 07 22:19:15 volumio volumio[2239]: info: Discovery: Found device Volumio Dec 07 22:19:15 volumio volumio[2239]: info: CoreCommandRouter::volumioGetState Dec 07 22:19:15 volumio volumio[2239]: info: CorePlayQueue::getTrack 0 Dec 07 22:19:15 volumio volumio[2239]: info: Discovery: this is already registered, 2d081a8c-b0f6-4dee-8583-5a37aea7284c Dec 07 22:19:15 volumio systemd[1]: ntpsec-rotate-stats.service: Deactivated successfully. Dec 07 22:19:15 volumio volumio[2239]: info: Discovery: Found device Volumio Dec 07 22:19:15 volumio volumio[2239]: info: CoreCommandRouter::volumioGetState Dec 07 22:19:15 volumio volumio[2239]: info: CorePlayQueue::getTrack 0 Dec 07 22:19:16 volumio systemd[1]: dpkg-db-backup.service: Deactivated successfully. Dec 07 22:19:16 volumio systemd[1]: Finished dpkg-db-backup.service - Daily dpkg database backup service. Dec 07 22:19:16 volumio nmbd[1013]: [2025/12/07 22:19:16.529864, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response) Dec 07 22:19:16 volumio nmbd[1013]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.100.7 for name WORKGROUP<1d>. Dec 07 22:19:16 volumio nmbd[1013]: This response was from IP 192.168.100.4, reporting an IP address of 192.168.100.4. Dec 07 22:19:17 volumio systemd[1]: mpd.service: Deactivated successfully. Dec 07 22:19:17 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 07 22:19:17 volumio systemd[1]: mpd.service: Consumed 12.833s CPU time. Dec 07 22:19:17 volumio systemd[1]: mpd.socket: Deactivated successfully. Dec 07 22:19:17 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 07 22:19:17 volumio volumio[2239]: error: Upnp client error: Error: read ECONNRESET Dec 07 22:19:17 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 07 22:19:17 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 07 22:19:17 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Dec 07 22:19:17 volumio sudo[2669]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 07 22:19:17 volumio sudo[2669]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 07 22:19:17 volumio sudo[2670]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Dec 07 22:19:17 volumio sudo[2669]: pam_unix(sudo:session): session closed for user root Dec 07 22:19:18 volumio volumio[2239]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 07 22:19:18 volumio volumio[2239]: info: Cannot mount NAS smbadmin at system boot, trial number 4 ,retrying in 5 seconds Dec 07 22:19:21 volumio volumio[2239]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Dec 07 22:19:21 volumio volumio[2239]: verbose: ControllerMpd::sendMpdCommand rescan Dec 07 22:19:21 volumio volumio[2239]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 07 22:19:21 volumio volumio[2239]: TypeError: Cannot read properties of undefined (reading 'then') Dec 07 22:19:21 volumio volumio[2239]: at ControllerMpd.sendMpdCommand (/volumio/app/plugins/music_service/mpd/index.js:332:6) Dec 07 22:19:21 volumio volumio[2239]: at ControllerMpd.rescanDb (/volumio/app/plugins/music_service/mpd/index.js:1904:15) Dec 07 22:19:21 volumio volumio[2239]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1096:32) Dec 07 22:19:21 volumio volumio[2239]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1098:26) Dec 07 22:19:21 volumio volumio[2239]: at Socket.emit (node:events:514:28) Dec 07 22:19:21 volumio volumio[2239]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Dec 07 22:19:21 volumio volumio[2239]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) Dec 07 22:19:21 volumio volumio[2239]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 07 22:19:23 volumio sudo[2701]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-07 22:18' Dec 07 22:19:23 volumio sudo[2701]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="ec1ce6b3390e13e82b9cc0453f957c4f5298419e" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="8bcc10c3dbcbcb349e9887dc0527d54876b32688" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon Nov 17 16:31:40 UTC 2025" VOLUMIO_VERSION="4.071" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="5fbe1bcf6936184712979c0bfaf061f2"