-- Logs begin at Fri 2026-04-10 11:50:01 CEST, end at Fri 2026-04-10 16:27:27 CEST. --
Apr 10 16:26:00 volumio sshd[22980]: Accepted password for volumio from 192.168.2.29 port 53664 ssh2
Apr 10 16:26:00 volumio sshd[22980]: pam_unix(sshd:session): session opened for user volumio by (uid=0)
Apr 10 16:26:00 volumio systemd[1]: Created slice User Slice of UID 1000.
Apr 10 16:26:00 volumio systemd[1]: Starting User Runtime Directory /run/user/1000...
Apr 10 16:26:00 volumio systemd-logind[513]: New session 91427 of user volumio.
Apr 10 16:26:00 volumio systemd[1]: Started User Runtime Directory /run/user/1000.
Apr 10 16:26:00 volumio systemd[1]: Starting User Manager for UID 1000...
Apr 10 16:26:00 volumio systemd[22983]: pam_unix(systemd-user:session): session opened for user volumio by (uid=0)
Apr 10 16:26:01 volumio systemd[22983]: Listening on GnuPG cryptographic agent and passphrase cache (access for web browsers).
Apr 10 16:26:01 volumio systemd[22983]: Listening on GnuPG cryptographic agent and passphrase cache.
Apr 10 16:26:01 volumio systemd[22983]: Listening on GnuPG cryptographic agent (ssh-agent emulation).
Apr 10 16:26:01 volumio systemd[22983]: Reached target Paths.
Apr 10 16:26:01 volumio systemd[22983]: Listening on GnuPG network certificate management daemon.
Apr 10 16:26:01 volumio systemd[22983]: Reached target Timers.
Apr 10 16:26:01 volumio systemd[22983]: Listening on GnuPG cryptographic agent and passphrase cache (restricted).
Apr 10 16:26:01 volumio systemd[22983]: Starting D-Bus User Message Bus Socket.
Apr 10 16:26:01 volumio systemd[22983]: Listening on Sound System.
Apr 10 16:26:01 volumio systemd[22983]: Listening on D-Bus User Message Bus Socket.
Apr 10 16:26:01 volumio systemd[22983]: Reached target Sockets.
Apr 10 16:26:01 volumio systemd[22983]: Reached target Basic System.
Apr 10 16:26:01 volumio systemd[22983]: Reached target Default.
Apr 10 16:26:01 volumio systemd[22983]: Startup finished in 241ms.
Apr 10 16:26:01 volumio systemd[1]: Started User Manager for UID 1000.
Apr 10 16:26:01 volumio systemd[1]: Started Session 91427 of user volumio.
Apr 10 16:26:02 volumio sshd[23002]: Received disconnect from 192.168.2.29 port 53664:11: PECL/ssh2 (http://pecl.php.net/packages/ssh2)
Apr 10 16:26:02 volumio sshd[23002]: Disconnected from user volumio 192.168.2.29 port 53664
Apr 10 16:26:02 volumio sshd[22980]: pam_unix(sshd:session): session closed for user volumio
Apr 10 16:26:02 volumio systemd[1]: session-91427.scope: Succeeded.
Apr 10 16:26:02 volumio systemd-logind[513]: Session 91427 logged out. Waiting for processes to exit.
Apr 10 16:26:02 volumio systemd-logind[513]: Removed session 91427.
Apr 10 16:26:05 volumio volumio[7381]: info: CoreCommandRouter::volumioGetState
Apr 10 16:26:05 volumio volumio[7381]: info: CorePlayQueue::getTrack 1282
Apr 10 16:26:05 volumio volumio[7381]: info: Listing playlists
Apr 10 16:26:05 volumio volumio[7381]: info: Listing playlists
Apr 10 16:26:12 volumio systemd[1]: Stopping User Manager for UID 1000...
Apr 10 16:26:12 volumio systemd[22983]: Stopped target Default.
Apr 10 16:26:12 volumio systemd[22983]: Stopped target Basic System.
Apr 10 16:26:12 volumio systemd[22983]: Stopped target Timers.
Apr 10 16:26:12 volumio systemd[22983]: Stopped target Sockets.
Apr 10 16:26:12 volumio systemd[22983]: gpg-agent-browser.socket: Succeeded.
Apr 10 16:26:12 volumio systemd[22983]: Closed GnuPG cryptographic agent and passphrase cache (access for web browsers).
Apr 10 16:26:12 volumio systemd[22983]: gpg-agent.socket: Succeeded.
Apr 10 16:26:12 volumio systemd[22983]: Closed GnuPG cryptographic agent and passphrase cache.
Apr 10 16:26:12 volumio systemd[22983]: pulseaudio.socket: Succeeded.
Apr 10 16:26:12 volumio systemd[22983]: Closed Sound System.
Apr 10 16:26:12 volumio systemd[22983]: gpg-agent-extra.socket: Succeeded.
Apr 10 16:26:12 volumio systemd[22983]: Closed GnuPG cryptographic agent and passphrase cache (restricted).
Apr 10 16:26:12 volumio systemd[22983]: dirmngr.socket: Succeeded.
Apr 10 16:26:12 volumio systemd[22983]: Closed GnuPG network certificate management daemon.
Apr 10 16:26:12 volumio systemd[22983]: gpg-agent-ssh.socket: Succeeded.
Apr 10 16:26:12 volumio systemd[22983]: Closed GnuPG cryptographic agent (ssh-agent emulation).
Apr 10 16:26:12 volumio systemd[22983]: Stopped target Paths.
Apr 10 16:26:12 volumio systemd[22983]: dbus.socket: Succeeded.
Apr 10 16:26:12 volumio systemd[22983]: Closed D-Bus User Message Bus Socket.
Apr 10 16:26:12 volumio systemd[22983]: Reached target Shutdown.
Apr 10 16:26:12 volumio systemd[22983]: systemd-exit.service: Succeeded.
Apr 10 16:26:12 volumio systemd[22983]: Started Exit the Session.
Apr 10 16:26:12 volumio systemd[22983]: Reached target Exit the Session.
Apr 10 16:26:12 volumio systemd[22984]: pam_unix(systemd-user:session): session closed for user volumio
Apr 10 16:26:12 volumio systemd[1]: user@1000.service: Succeeded.
Apr 10 16:26:12 volumio systemd[1]: Stopped User Manager for UID 1000.
Apr 10 16:26:12 volumio systemd[1]: Stopping User Runtime Directory /run/user/1000...
Apr 10 16:26:12 volumio systemd[1]: run-user-1000.mount: Succeeded.
Apr 10 16:26:12 volumio systemd[1]: user-runtime-dir@1000.service: Succeeded.
Apr 10 16:26:12 volumio systemd[1]: Stopped User Runtime Directory /run/user/1000.
Apr 10 16:26:12 volumio systemd[1]: Removed slice User Slice of UID 1000.
Apr 10 16:26:15 volumio volumio[7381]: info: CoreCommandRouter::volumioGetState
Apr 10 16:26:15 volumio volumio[7381]: info: CorePlayQueue::getTrack 1282
Apr 10 16:26:25 volumio volumio[7381]: info: CoreCommandRouter::volumioGetState
Apr 10 16:26:25 volumio volumio[7381]: info: CorePlayQueue::getTrack 1282
Apr 10 16:26:25 volumio volumio[7381]: info: Listing playlists
Apr 10 16:26:25 volumio volumio[7381]: info: Listing playlists
Apr 10 16:26:35 volumio volumio[7381]: info: CoreCommandRouter::volumioGetState
Apr 10 16:26:35 volumio volumio[7381]: info: CorePlayQueue::getTrack 1282
Apr 10 16:26:45 volumio volumio[7381]: info: CoreCommandRouter::volumioGetState
Apr 10 16:26:45 volumio volumio[7381]: info: CorePlayQueue::getTrack 1282
Apr 10 16:26:45 volumio volumio[7381]: info: Listing playlists
Apr 10 16:26:45 volumio volumio[7381]: info: Listing playlists
Apr 10 16:26:55 volumio volumio[7381]: info: CoreCommandRouter::volumioGetState
Apr 10 16:26:55 volumio volumio[7381]: info: CorePlayQueue::getTrack 1282
Apr 10 16:27:00 volumio sshd[23133]: Accepted password for volumio from 192.168.2.29 port 58606 ssh2
Apr 10 16:27:00 volumio sshd[23133]: pam_unix(sshd:session): session opened for user volumio by (uid=0)
Apr 10 16:27:00 volumio systemd[1]: Created slice User Slice of UID 1000.
Apr 10 16:27:00 volumio systemd[1]: Starting User Runtime Directory /run/user/1000...
Apr 10 16:27:00 volumio systemd-logind[513]: New session 91429 of user volumio.
Apr 10 16:27:00 volumio systemd[1]: Started User Runtime Directory /run/user/1000.
Apr 10 16:27:00 volumio systemd[1]: Starting User Manager for UID 1000...
Apr 10 16:27:00 volumio systemd[23136]: pam_unix(systemd-user:session): session opened for user volumio by (uid=0)
Apr 10 16:27:01 volumio systemd[23136]: Starting D-Bus User Message Bus Socket.
Apr 10 16:27:01 volumio systemd[23136]: Listening on GnuPG cryptographic agent and passphrase cache.
Apr 10 16:27:01 volumio systemd[23136]: Listening on GnuPG network certificate management daemon.
Apr 10 16:27:01 volumio systemd[23136]: Listening on GnuPG cryptographic agent and passphrase cache (access for web browsers).
Apr 10 16:27:01 volumio systemd[23136]: Reached target Paths.
Apr 10 16:27:01 volumio systemd[23136]: Listening on GnuPG cryptographic agent and passphrase cache (restricted).
Apr 10 16:27:01 volumio systemd[23136]: Listening on GnuPG cryptographic agent (ssh-agent emulation).
Apr 10 16:27:01 volumio systemd[23136]: Reached target Timers.
Apr 10 16:27:01 volumio systemd[23136]: Listening on Sound System.
Apr 10 16:27:01 volumio systemd[23136]: Listening on D-Bus User Message Bus Socket.
Apr 10 16:27:01 volumio systemd[23136]: Reached target Sockets.
Apr 10 16:27:01 volumio systemd[23136]: Reached target Basic System.
Apr 10 16:27:01 volumio systemd[23136]: Reached target Default.
Apr 10 16:27:01 volumio systemd[23136]: Startup finished in 179ms.
Apr 10 16:27:01 volumio systemd[1]: Started User Manager for UID 1000.
Apr 10 16:27:01 volumio systemd[1]: Started Session 91429 of user volumio.
Apr 10 16:27:02 volumio sshd[23154]: Received disconnect from 192.168.2.29 port 58606:11: PECL/ssh2 (http://pecl.php.net/packages/ssh2)
Apr 10 16:27:02 volumio sshd[23154]: Disconnected from user volumio 192.168.2.29 port 58606
Apr 10 16:27:02 volumio sshd[23133]: pam_unix(sshd:session): session closed for user volumio
Apr 10 16:27:02 volumio systemd[1]: session-91429.scope: Succeeded.
Apr 10 16:27:02 volumio systemd-logind[513]: Session 91429 logged out. Waiting for processes to exit.
Apr 10 16:27:02 volumio systemd-logind[513]: Removed session 91429.
Apr 10 16:27:05 volumio volumio[7381]: info: CoreCommandRouter::volumioGetState
Apr 10 16:27:05 volumio volumio[7381]: info: CorePlayQueue::getTrack 1282
Apr 10 16:27:05 volumio volumio[7381]: info: Listing playlists
Apr 10 16:27:05 volumio volumio[7381]: info: Listing playlists
Apr 10 16:27:12 volumio systemd[1]: Stopping User Manager for UID 1000...
Apr 10 16:27:12 volumio systemd[23136]: Stopped target Default.
Apr 10 16:27:12 volumio systemd[23136]: Stopped target Basic System.
Apr 10 16:27:12 volumio systemd[23136]: Stopped target Paths.
Apr 10 16:27:12 volumio systemd[23136]: Stopped target Sockets.
Apr 10 16:27:12 volumio systemd[23136]: gpg-agent-ssh.socket: Succeeded.
Apr 10 16:27:12 volumio systemd[23136]: Closed GnuPG cryptographic agent (ssh-agent emulation).
Apr 10 16:27:12 volumio systemd[23136]: gpg-agent-extra.socket: Succeeded.
Apr 10 16:27:12 volumio systemd[23136]: Closed GnuPG cryptographic agent and passphrase cache (restricted).
Apr 10 16:27:12 volumio systemd[23136]: gpg-agent.socket: Succeeded.
Apr 10 16:27:12 volumio systemd[23136]: Closed GnuPG cryptographic agent and passphrase cache.
Apr 10 16:27:12 volumio systemd[23136]: dbus.socket: Succeeded.
Apr 10 16:27:12 volumio systemd[23136]: Closed D-Bus User Message Bus Socket.
Apr 10 16:27:12 volumio systemd[23136]: gpg-agent-browser.socket: Succeeded.
Apr 10 16:27:12 volumio systemd[23136]: Closed GnuPG cryptographic agent and passphrase cache (access for web browsers).
Apr 10 16:27:12 volumio systemd[23136]: pulseaudio.socket: Succeeded.
Apr 10 16:27:12 volumio systemd[23136]: Closed Sound System.
Apr 10 16:27:12 volumio systemd[23136]: Stopped target Timers.
Apr 10 16:27:12 volumio systemd[23136]: dirmngr.socket: Succeeded.
Apr 10 16:27:12 volumio systemd[23136]: Closed GnuPG network certificate management daemon.
Apr 10 16:27:12 volumio systemd[23136]: Reached target Shutdown.
Apr 10 16:27:12 volumio systemd[23136]: systemd-exit.service: Succeeded.
Apr 10 16:27:12 volumio systemd[23136]: Started Exit the Session.
Apr 10 16:27:12 volumio systemd[23136]: Reached target Exit the Session.
Apr 10 16:27:12 volumio systemd[23137]: pam_unix(systemd-user:session): session closed for user volumio
Apr 10 16:27:12 volumio systemd[1]: user@1000.service: Succeeded.
Apr 10 16:27:12 volumio systemd[1]: Stopped User Manager for UID 1000.
Apr 10 16:27:12 volumio systemd[1]: Stopping User Runtime Directory /run/user/1000...
Apr 10 16:27:12 volumio systemd[1]: run-user-1000.mount: Succeeded.
Apr 10 16:27:12 volumio systemd[1]: user-runtime-dir@1000.service: Succeeded.
Apr 10 16:27:12 volumio systemd[1]: Stopped User Runtime Directory /run/user/1000.
Apr 10 16:27:12 volumio systemd[1]: Removed slice User Slice of UID 1000.
Apr 10 16:27:15 volumio volumio[7381]: info: CoreCommandRouter::volumioGetState
Apr 10 16:27:15 volumio volumio[7381]: info: CorePlayQueue::getTrack 1282
Apr 10 16:27:22 volumio volumio[7381]: info: CorePlayQueue::getTrack 1282
Apr 10 16:27:22 volumio volumio[7381]: info: CorePlayQueue::getTrack 8891
Apr 10 16:27:22 volumio volumio[7381]: info: Prefetching next song
Apr 10 16:27:22 volumio volumio[7381]: info: DOING PREFETCH IN MPD
Apr 10 16:27:22 volumio volumio[7381]: verbose: ControllerMpd::sendMpdCommand add "NAS/truenas/Rock/Primal Scream/Screamadelica/Inner Flight.mp3"
Apr 10 16:27:22 volumio volumio[7381]: info:
Apr 10 16:27:22 volumio volumio[7381]: ---------------------------- MPD announces system playlist update
Apr 10 16:27:22 volumio volumio[7381]: info: Ignoring MPD Status Update
Apr 10 16:27:22 volumio volumio[7381]: info: sendMpdCommand add "NAS/truenas/Rock/Primal Scream/Screamadelica/Inner Flight.mp3" took 3 milliseconds
Apr 10 16:27:22 volumio volumio[7381]: verbose: ControllerMpd::sendMpdCommand consume 1
Apr 10 16:27:22 volumio volumio[7381]: info:
Apr 10 16:27:22 volumio volumio[7381]: ---------------------------- MPD announces system playlist update
Apr 10 16:27:22 volumio volumio[7381]: info: Ignoring MPD Status Update
Apr 10 16:27:22 volumio volumio[7381]: info:
Apr 10 16:27:22 volumio volumio[7381]: ---------------------------- MPD announces system playlist update
Apr 10 16:27:22 volumio volumio[7381]: info: Ignoring MPD Status Update
Apr 10 16:27:22 volumio volumio[7381]: info: ------------------------------ 6ms
Apr 10 16:27:22 volumio volumio[7381]: info: sendMpdCommand consume 1 took 4 milliseconds
Apr 10 16:27:22 volumio volumio[7381]: info: ------------------------------ 3ms
Apr 10 16:27:22 volumio volumio[7381]: info: ------------------------------ 2ms
Apr 10 16:27:25 volumio volumio[7381]: info: CoreCommandRouter::volumioGetState
Apr 10 16:27:25 volumio volumio[7381]: info: CorePlayQueue::getTrack 1282
Apr 10 16:27:25 volumio volumio[7381]: info: Listing playlists
Apr 10 16:27:25 volumio volumio[7381]: info: Listing playlists
Apr 10 16:27:26 volumio volumio[7381]: info: CoreStateMachine::startPlaybackTimer
Apr 10 16:27:26 volumio volumio[7381]: info: CorePlayQueue::getTrack 8891
Apr 10 16:27:27 volumio volumio[7381]: info: CoreStateMachine::pushState
Apr 10 16:27:27 volumio volumio[7381]: info: CorePlayQueue::getTrack 8891
Apr 10 16:27:27 volumio volumio[7381]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 10 16:27:27 volumio volumio[7381]: info: CoreCommandRouter::volumioPushState
Apr 10 16:27:27 volumio volumio[7381]: info: [LastFM] Current track has sufficient metadata: title (Inner Flight) and artist (Primal Scream) passed on explicitly
Apr 10 16:27:27 volumio volumio[7381]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 10 16:27:27 volumio volumio[7381]: Error: getaddrinfo ENOTFOUND ws.audioscrobbler.com
Apr 10 16:27:27 volumio volumio[7381]: at GetAddrInfoReqWrap.onlookup [as oncomplete] (dns.js:67:26) {
Apr 10 16:27:27 volumio volumio[7381]: errno: -3007,
Apr 10 16:27:27 volumio volumio[7381]: code: 'ENOTFOUND',
Apr 10 16:27:27 volumio volumio[7381]: syscall: 'getaddrinfo',
Apr 10 16:27:27 volumio volumio[7381]: hostname: 'ws.audioscrobbler.com'
Apr 10 16:27:27 volumio volumio[7381]: }
Apr 10 16:27:27 volumio volumio[7381]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 10 16:27:27 volumio sudo[23234]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-04-10 16:26
Apr 10 16:27:27 volumio sudo[23234]: 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="e9612ec5034fb2e958508aaefbca2962fd6f6654"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="464fc672d77d3df6ee72b331d36cdf1fa936e1ec"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri 27 Feb 2026 10:59:40 AM CET"
VOLUMIO_VERSION="3.912"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="37c6ab864cb114e1344d540995c69f86"