May 28 20:52:46 volumio systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service...
May 28 20:52:46 volumio dbus-daemon[814]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.66' (uid=0 pid=5123 comm="timedatectl show --property=NTPSynchronized --valu")
May 28 20:52:46 volumio systemd[1]: Starting systemd-timedated.service - Time & Date Service...
May 28 20:52:46 volumio dbus-daemon[814]: [system] Successfully activated service 'org.freedesktop.timedate1'
May 28 20:52:46 volumio systemd[1]: Started systemd-timedated.service - Time & Date Service.
May 28 20:52:46 volumio setdatetime-helper.sh[5122]: Time is not synchronized. Attempting to sync...
May 28 20:52:46 volumio sudo[5131]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/date -s 'Thu, 29 May 2025 02:52:47 GMT#015'
May 28 20:52:46 volumio sudo[5131]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
May 28 20:52:47 volumio setdatetime-helper.sh[5132]: Wed May 28 20:52:47 MDT 2025
May 28 20:52:47 volumio sudo[5131]: pam_unix(sudo:session): session closed for user root
May 28 20:52:47 volumio setdatetime-helper.sh[5122]: Time synchronized successfully.
May 28 20:52:47 volumio systemd[1]: setdatetime-helper.timer.service: Deactivated successfully.
May 28 20:52:47 volumio systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service.
May 28 20:52:52 volumio ntpd[1013]: CLOCK: time stepped by 0.608268
May 28 20:52:52 volumio ntpd[1013]: INIT: MRU 10922 entries, 13 hash bits, 65536 bytes
May 28 20:52:52 volumio systemd[1]: Starting man-db.service - Daily man-db regeneration...
May 28 20:52:53 volumio systemd[1]: man-db.service: Deactivated successfully.
May 28 20:52:53 volumio systemd[1]: Finished man-db.service - Daily man-db regeneration.
May 28 20:53:17 volumio systemd[1]: systemd-timedated.service: Deactivated successfully.
May 28 20:53:24 volumio sshd[3301]: pam_unix(sshd:session): session closed for user volumio
May 28 20:53:24 volumio systemd[1]: session-1.scope: Deactivated successfully.
May 28 20:53:24 volumio systemd[1]: session-1.scope: Consumed 1.271s CPU time.
May 28 20:53:24 volumio systemd-logind[818]: Session 1 logged out. Waiting for processes to exit.
May 28 20:53:24 volumio systemd-logind[818]: Removed session 1.
May 28 20:53:34 volumio systemd[1]: Stopping user@1000.service - User Manager for UID 1000...
May 28 20:53:34 volumio systemd[3323]: Activating special unit exit.target...
May 28 20:53:34 volumio systemd[3323]: Stopped target default.target - Main User Target.
May 28 20:53:34 volumio systemd[3323]: Stopped target basic.target - Basic System.
May 28 20:53:34 volumio systemd[3323]: Stopped target paths.target - Paths.
May 28 20:53:34 volumio systemd[3323]: Stopped target sockets.target - Sockets.
May 28 20:53:34 volumio systemd[3323]: Stopped target timers.target - Timers.
May 28 20:53:34 volumio systemd[3323]: Closed dbus.socket - D-Bus User Message Bus Socket.
May 28 20:53:34 volumio systemd[3323]: Closed dirmngr.socket - GnuPG network certificate management daemon.
May 28 20:53:34 volumio systemd[3323]: Closed gpg-agent-browser.socket - GnuPG cryptographic agent and passphrase cache (access for web browsers).
May 28 20:53:34 volumio systemd[3323]: Closed gpg-agent-extra.socket - GnuPG cryptographic agent and passphrase cache (restricted).
May 28 20:53:34 volumio systemd[3323]: Closed gpg-agent-ssh.socket - GnuPG cryptographic agent (ssh-agent emulation).
May 28 20:53:34 volumio systemd[3323]: Closed gpg-agent.socket - GnuPG cryptographic agent and passphrase cache.
May 28 20:53:34 volumio systemd[3323]: Removed slice app.slice - User Application Slice.
May 28 20:53:34 volumio systemd[3323]: Reached target shutdown.target - Shutdown.
May 28 20:53:34 volumio systemd[3323]: Finished systemd-exit.service - Exit the Session.
May 28 20:53:34 volumio systemd[3323]: Reached target exit.target - Exit the Session.
May 28 20:53:34 volumio systemd[1]: user@1000.service: Deactivated successfully.
May 28 20:53:34 volumio systemd[1]: Stopped user@1000.service - User Manager for UID 1000.
May 28 20:53:34 volumio systemd[1]: Stopping user-runtime-dir@1000.service - User Runtime Directory /run/user/1000...
May 28 20:53:34 volumio systemd[1]: run-user-1000.mount: Deactivated successfully.
May 28 20:53:34 volumio systemd[1]: user-runtime-dir@1000.service: Deactivated successfully.
May 28 20:53:34 volumio systemd[1]: Stopped user-runtime-dir@1000.service - User Runtime Directory /run/user/1000.
May 28 20:53:34 volumio systemd[1]: Removed slice user-1000.slice - User Slice of UID 1000.
May 28 20:53:34 volumio systemd[1]: user-1000.slice: Consumed 2.289s CPU time.
May 28 20:53:34 volumio volumio[1285]: info: CoreCommandRouter::volumioGetState
May 28 20:53:34 volumio volumio[1285]: info: CorePlayQueue::getTrack 0
May 28 20:53:38 volumio volumio[1285]: info: CoreCommandRouter::getUIConfigOnPlugin
May 28 20:53:38 volumio volumio[1285]: info: CoreCommandRouter::getUIConfigOnPlugin
May 28 20:53:38 volumio volumio[1285]: info: Retrieving Cloud Streaming UI
May 28 20:53:38 volumio volumio[1285]: info: Getting Tidal Cloud Configuration
May 28 20:53:38 volumio volumio[1285]: info: CoreCommandRouter::getUIConfigOnPlugin
May 28 20:53:38 volumio volumio[1285]: info: Getting Qobuz Cloud Configuration
May 28 20:53:38 volumio volumio[1285]: info: Asking plugin for UI Config
May 28 20:53:38 volumio volumio[1285]: info: CoreCommandRouter::getUIConfigOnPlugin
May 28 20:53:38 volumio volumio[1285]: info: Getting Spotify Cloud Configuration
May 28 20:53:38 volumio volumio[1285]: info: Asking plugin for UI Config
May 28 20:53:38 volumio volumio[1285]: info: CoreCommandRouter::getUIConfigOnPlugin
May 28 20:53:38 volumio volumio[1285]: info: Saving Spotify Acccount
May 28 20:53:38 volumio volumio[1285]: info: Got Tidal Cloud Configuration
May 28 20:53:38 volumio volumio[1285]: info: Got it
May 28 20:53:38 volumio volumio[1285]: info: Got it
May 28 20:53:38 volumio volumio[1285]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
May 28 20:53:38 volumio volumio[1285]: info: CoreCommandRouter::getUIConfigOnPlugin
May 28 20:53:38 volumio volumio[1285]: error: Error retrieving Highresaudio conf: TypeError: Cannot read properties of undefined (reading 'onSave')
May 28 20:53:38 volumio volumio[1285]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
May 28 20:53:38 volumio volumio[1285]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
May 28 20:53:38 volumio volumio[1285]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
May 28 20:53:38 volumio volumio[1285]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
May 28 20:53:38 volumio volumio[1285]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 28 20:53:38 volumio volumio[1285]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 28 20:53:38 volumio volumio[1285]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 28 20:53:38 volumio volumio[1285]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
May 28 20:53:38 volumio volumio[1285]: info: CoreCommandRouter::volumioGetBrowseSources
May 28 20:53:38 volumio volumio[1285]: info: CoreCommandRouter::volumioGetBrowseSources
May 28 20:53:38 volumio volumio[1285]: info: CoreCommandRouter::volumioGetBrowseSources
May 28 20:53:38 volumio volumio[1285]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 28 20:53:38 volumio volumio[1285]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
May 28 20:53:40 volumio volumio[1285]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares
May 28 20:53:40 volumio volumio[1285]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService
May 28 20:53:42 volumio volumio[1285]: info: Executing SMB command: smbclient --no-pass --debuglevel=0 -L truenas.local.
May 28 20:53:42 volumio volumio[1285]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
May 28 20:53:42 volumio volumio[1285]: info: Error browsing device truenas for shares: Command failed: smbclient --no-pass --debuglevel=0 -L truenas.local.
May 28 20:53:46 volumio volumio[1285]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 28 20:53:46 volumio volumio[1285]: Error: dns service error: unknown
May 28 20:53:46 volumio volumio[1285]: at MDNSService.on_resolver_done (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:19:30)
May 28 20:53:46 volumio volumio[1285]: at MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) {
May 28 20:53:46 volumio volumio[1285]: errorCode: -65537
May 28 20:53:46 volumio volumio[1285]: }
May 28 20:53:46 volumio volumio[1285]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 28 20:53:46 volumio sudo[5254]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-05-28 20:52'
May 28 20:53:46 volumio sudo[5254]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
PRETTY_NAME="Debian GNU/Linux 12 (bookworm)"
NAME="Debian GNU/Linux"
VERSION_ID="12"
VERSION="12 (bookworm)"
VERSION_CODENAME=bookworm
ID=debian
HOME_URL="https://www.debian.org/"
SUPPORT_URL="https://www.debian.org/support"
BUG_REPORT_URL="https://bugs.debian.org/"
VOLUMIO_BUILD_VERSION="fd567ba9bc0dc34c0403e2d5b72a0f46467d1983"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri May 23 07:33:33 UTC 2025"
VOLUMIO_VERSION="0.069"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="d67a2da4ffe3f001e986b1f31eaa3a76"