-- Logs begin at Thu 2019-02-14 11:11:58 CET, end at Sat 2026-02-21 19:55:28 CET. --
Feb 21 19:55:17 volumio systemd-timedated[1059]: Changed local time to Sat Feb 21 19:55:17 2026
Feb 21 19:55:17 volumio sudo[1057]: pam_unix(sudo:session): session closed for user root
Feb 21 19:55:17 volumio systemd[1]: Starting Daily apt download activities...
Feb 21 19:55:17 volumio volumio-time-update[598]: volumio-time-update-util: System time updated successfully.
Feb 21 19:55:17 volumio systemd[1]: Starting Daily man-db regeneration...
Feb 21 19:55:17 volumio systemd[1]: Started Volumio Time Update Utility.
Feb 21 19:55:17 volumio systemd[1]: Reached target Multi-User System.
Feb 21 19:55:17 volumio systemd[1]: Reached target Graphical Interface.
Feb 21 19:55:17 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes...
Feb 21 19:55:17 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded.
Feb 21 19:55:17 volumio systemd[1]: Started Update UTMP about System Runlevel Changes.
Feb 21 19:55:17 volumio volumio[987]: info: Starting UPNP Browser
Feb 21 19:55:17 volumio volumio[987]: info: Loading plugin "alarm-clock"...
Feb 21 19:55:17 volumio systemd[1]: apt-daily.service: Succeeded.
Feb 21 19:55:17 volumio systemd[1]: Started Daily apt download activities.
Feb 21 19:55:17 volumio systemd[1]: Starting Daily apt upgrade and clean activities...
Feb 21 19:55:17 volumio systemd[1]: man-db.service: Succeeded.
Feb 21 19:55:17 volumio systemd[1]: Started Daily man-db regeneration.
Feb 21 19:55:17 volumio volumio[987]: info: Loading plugin "airplay_emulation"...
Feb 21 19:55:17 volumio volumio[987]: info: Starting Shairport Sync
Feb 21 19:55:17 volumio volumio[987]: info: Loading plugin "last_100"...
Feb 21 19:55:17 volumio volumio[987]: info: Loading plugin "webradio"...
Feb 21 19:55:17 volumio systemd[1]: apt-daily-upgrade.service: Succeeded.
Feb 21 19:55:17 volumio systemd[1]: Started Daily apt upgrade and clean activities.
Feb 21 19:55:17 volumio systemd[1]: Startup finished in 12.057s (kernel) + 30.012s (userspace) = 42.070s.
Feb 21 19:55:17 volumio volumio[987]: info: Loading plugin "i2s_dacs"...
Feb 21 19:55:17 volumio volumio[987]: info: Loading plugin "volumiodiscovery"...
Feb 21 19:55:17 volumio volumio[987]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Feb 21 19:55:17 volumio node[987]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Feb 21 19:55:17 volumio node[987]: *** WARNING *** Please fix your application to use the native API of Avahi!
Feb 21 19:55:17 volumio volumio[987]: *** WARNING *** Please fix your application to use the native API of Avahi!
Feb 21 19:55:17 volumio volumio[987]: *** WARNING *** For more information see
Feb 21 19:55:17 volumio volumio[987]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Feb 21 19:55:17 volumio volumio[987]: *** WARNING *** Please fix your application to use the native API of Avahi!
Feb 21 19:55:17 volumio volumio[987]: *** WARNING *** For more information see
Feb 21 19:55:17 volumio node[987]: *** WARNING *** For more information see
Feb 21 19:55:17 volumio node[987]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Feb 21 19:55:17 volumio node[987]: *** WARNING *** Please fix your application to use the native API of Avahi!
Feb 21 19:55:17 volumio node[987]: *** WARNING *** For more information see
Feb 21 19:55:17 volumio volumio[987]: info: Applying required configuration parameters for plugin volumiodiscovery
Feb 21 19:55:17 volumio volumio[987]: info: Discovery: Started advertising with name: Volumio
Feb 21 19:55:17 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Feb 21 19:55:17 volumio volumio[987]: info: Loading plugin "spop"...
Feb 21 19:55:18 volumio volumio[987]: info: Loading plugin "now_playing"...
Feb 21 19:55:19 volumio volumio[987]: info: Loading plugin "outputs"...
Feb 21 19:55:19 volumio volumio[987]: info: Loading plugin "albumart"...
Feb 21 19:55:19 volumio volumio[987]: info: Plugin example_plugin is not enabled
Feb 21 19:55:19 volumio volumio[987]: info: Loading plugin "inputs"...
Feb 21 19:55:19 volumio volumio[987]: info: Loading plugin "updater_comm"...
Feb 21 19:55:20 volumio volumio[987]: info: Plugin mpdemulation is not enabled
Feb 21 19:55:20 volumio volumio[987]: info: Loading plugin "rest_api"...
Feb 21 19:55:20 volumio volumio[987]: info: Loading plugin "websocket"...
Feb 21 19:55:20 volumio volumio[987]: info: Starting Socket.io Server version 2.3.0
Feb 21 19:55:20 volumio volumio[987]: info: Loading i18n strings for locale de
Feb 21 19:55:20 volumio sudo[1040]: pam_unix(sudo:session): session closed for user root
Feb 21 19:55:20 volumio volumio[987]: Updating browse sources language
Feb 21 19:55:20 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 21 19:55:20 volumio volumio[987]: Forking 3 albumart workers
Feb 21 19:55:20 volumio systemd[1]: systemd-fsckd.service: Succeeded.
Feb 21 19:55:20 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 21 19:55:20 volumio volumio[987]: info: CoreCommandRouter::initPlayerControls
Feb 21 19:55:20 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 19:55:20 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 19:55:20 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 19:55:20 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 19:55:20 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 19:55:20 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 19:55:20 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 19:55:20 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 19:55:20 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 21 19:55:20 volumio volumio[987]: Express server listening on port 3000
Feb 21 19:55:20 volumio volumio[987]: [Metrics] WebUI: 6s 383.99ms
Feb 21 19:55:20 volumio volumio[987]: info: CoreStateMachine::resetVolumioState
Feb 21 19:55:20 volumio volumio[987]: info: CoreStateMachine::getcurrentVolume
Feb 21 19:55:20 volumio volumio[987]: info: CoreCommandRouter::volumioRetrievevolume
Feb 21 19:55:20 volumio volumio[987]: info: Volumio Network Manager: Network status updated: 2
Feb 21 19:55:20 volumio sh[500]: timed out
Feb 21 19:55:20 volumio dhcpcd[533]: timed out
Feb 21 19:55:20 volumio sh[500]: dhcpcd exited
Feb 21 19:55:20 volumio dhcpcd[533]: dhcpcd exited
Feb 21 19:55:20 volumio sh[500]: ifup: failed to bring up eth0
Feb 21 19:55:20 volumio systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE
Feb 21 19:55:20 volumio systemd[1]: ifup@eth0.service: Failed with result 'exit-code'.
Feb 21 19:55:20 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 21 19:55:20 volumio volumio[987]: info: Reloading queue from file
Feb 21 19:55:20 volumio volumio[987]: info: CoreStateMachine::setRepeat null single undefined
Feb 21 19:55:20 volumio volumio[987]: info: CoreStateMachine::pushState
Feb 21 19:55:20 volumio volumio[987]: info: CorePlayQueue::getTrack 0
Feb 21 19:55:20 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 21 19:55:20 volumio volumio[987]: info: CoreCommandRouter::volumioPushState
Feb 21 19:55:20 volumio volumio[987]: info: CoreStateMachine::setRandom null
Feb 21 19:55:20 volumio volumio[987]: info: CoreStateMachine::pushState
Feb 21 19:55:20 volumio volumio[987]: info: CorePlayQueue::getTrack 0
Feb 21 19:55:20 volumio volumio[987]: info: CoreCommandRouter::volumioPushState
Feb 21 19:55:20 volumio volumio[987]: info: Setting Device type: Raspberry PI
Feb 21 19:55:20 volumio volumio[987]: info: VolumeController:: Volume=52 Mute =false
Feb 21 19:55:20 volumio volumio[987]: info: CoreStateMachine::pushState
Feb 21 19:55:20 volumio volumio[987]: info: CorePlayQueue::getTrack 0
Feb 21 19:55:20 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 21 19:55:20 volumio volumio[987]: info: CoreCommandRouter::volumioPushState
Feb 21 19:55:20 volumio volumio[987]: info: CoreStateMachine::updateTrackBlock
Feb 21 19:55:20 volumio volumio[987]: info: CorePlayQueue::getTrackBlock
Feb 21 19:55:20 volumio volumio[987]: info: CoreCommandRouter::volumioRetrievevolume
Feb 21 19:55:20 volumio volumio[987]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb
Feb 21 19:55:20 volumio volumio[987]: info: USB Boot Capable - System SBC Revision found in cpuinfo: b03115
Feb 21 19:55:20 volumio volumio[987]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI
Feb 21 19:55:20 volumio volumio[987]: info: Completed loading Core Plugins
Feb 21 19:55:20 volumio volumio[987]: info: Preparing to generate the ALSA configuration file
Feb 21 19:55:20 volumio volumio[987]: Starting albumart workers
Feb 21 19:55:20 volumio volumio[987]: Starting albumart workers
Feb 21 19:55:20 volumio volumio[987]: Starting albumart workers
Feb 21 19:55:20 volumio volumio[987]: info: Asound.conf file unchanged, so no further update is needed
Feb 21 19:55:20 volumio volumio[987]: info: Output device has changed, restarting MPD
Feb 21 19:55:20 volumio sudo[1145]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Feb 21 19:55:20 volumio sudo[1145]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 21 19:55:20 volumio sudo[1145]: pam_unix(sudo:session): session closed for user root
Feb 21 19:55:20 volumio volumio[987]: info: Output device has changed, restarting Shairport Sync
Feb 21 19:55:20 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 19:55:20 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 21 19:55:20 volumio sudo[1148]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Feb 21 19:55:20 volumio sudo[1148]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 21 19:55:20 volumio volumio[987]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Feb 21 19:55:20 volumio volumio[987]: info: ___________ START PLUGINS ___________
Feb 21 19:55:20 volumio volumio[987]: info: ControllerMpd::onStart: Initializing MPD
Feb 21 19:55:21 volumio volumio[987]: info: Creating MPD Configuration file
Feb 21 19:55:21 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 21 19:55:21 volumio volumio[987]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Feb 21 19:55:21 volumio volumio[987]: info: [1771700120995] CoreMusicLibrary::Adding element Medienserver
Feb 21 19:55:21 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 21 19:55:21 volumio volumio[987]: info: UPNP Browser: Client initialized successfully
Feb 21 19:55:21 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 19:55:21 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 21 19:55:20 volumio sudo[1155]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio5-onboarding.service
Feb 21 19:55:20 volumio sudo[1155]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 21 19:55:20 volumio sudo[1157]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Feb 21 19:55:20 volumio sudo[1157]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 21 19:55:21 volumio sudo[1157]: pam_unix(sudo:session): session closed for user root
Feb 21 19:55:21 volumio sudo[1160]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Feb 21 19:55:21 volumio sudo[1160]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 21 19:55:21 volumio systemd[1]: Listening on mpd.socket.
Feb 21 19:55:21 volumio systemd[1]: Starting Music Player Daemon...
Feb 21 19:55:21 volumio volumio[987]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Feb 21 19:55:21 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 19:55:21 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 21 19:55:21 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM
Feb 21 19:55:21 volumio systemd[1]: mpd.service: Succeeded.
Feb 21 19:55:21 volumio systemd[1]: Stopped Music Player Daemon.
Feb 21 19:55:21 volumio systemd[1]: Started Volumio5 Onboarding Server.
Feb 21 19:55:21 volumio systemd[1]: Starting Music Player Daemon...
Feb 21 19:55:21 volumio sudo[1155]: pam_unix(sudo:session): session closed for user root
Feb 21 19:55:21 volumio volumio[987]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Feb 21 19:55:21 volumio volumio[987]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Feb 21 19:55:21 volumio volumio[987]: info: [1771700121152] CoreMusicLibrary::Adding element Last_100
Feb 21 19:55:21 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 21 19:55:21 volumio volumio[987]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Feb 21 19:55:21 volumio volumio[987]: info: [1771700121156] CoreMusicLibrary::Adding element Webradio
Feb 21 19:55:21 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 21 19:55:21 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Feb 21 19:55:21 volumio volumio[987]: info: Initializing BBC Radios
Feb 21 19:55:21 volumio sudo[1171]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Feb 21 19:55:21 volumio sudo[1171]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 21 19:55:21 volumio sudo[1171]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory
Feb 21 19:55:21 volumio sudo[1171]: pam_unix(sudo:session): session closed for user root
Feb 21 19:55:21 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Feb 21 19:55:21 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 21 19:55:21 volumio volumio[987]: info: Creating Spotify config file
Feb 21 19:55:21 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 19:55:21 volumio volumio[987]: info: [now-playing] ConfigUpdater: config is up to date.
Feb 21 19:55:21 volumio volumio[987]: info: Volumio Calling Home
Feb 21 19:55:21 volumio volumio[987]: info: [now-playing] App is listening on port 4004.
Feb 21 19:55:21 volumio volumio[987]: warn: [now-playing] MyBackgroundMonitor is now watching /data/INTERNAL/NowPlayingPlugin/My Backgrounds
Feb 21 19:55:21 volumio volumio[987]: info: Discovery: adding 8f9d4509-c3cd-419e-a9f2-049f87b97c2d
Feb 21 19:55:21 volumio volumio[987]: info: Discovery: Found device Volumio
Feb 21 19:55:21 volumio volumio[987]: info: CoreCommandRouter::volumioGetState
Feb 21 19:55:21 volumio volumio[987]: info: CorePlayQueue::getTrack 0
Feb 21 19:55:21 volumio volumio[987]: info: MPD Permissions set
Feb 21 19:55:21 volumio volumio[987]: info: MPD Permissions set
Feb 21 19:55:21 volumio volumio[987]: info: VolumeController:: Volume=52 Mute =false
Feb 21 19:55:21 volumio volumio[987]: info: CoreStateMachine::pushState
Feb 21 19:55:21 volumio volumio[987]: info: CorePlayQueue::getTrack 0
Feb 21 19:55:21 volumio volumio[987]: info: CoreCommandRouter::volumioPushState
Feb 21 19:55:21 volumio volumio[987]: info: Volumio called home
Feb 21 19:55:21 volumio volumio[987]: info: Spotify config file written
Feb 21 19:55:21 volumio sudo[1217]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service
Feb 21 19:55:21 volumio volumio[987]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1
Feb 21 19:55:21 volumio sudo[1217]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 21 19:55:21 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 19:55:21 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 19:55:21 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 19:55:21 volumio volumio5-onboarding[1170]: time=2026-02-21T19:55:21.663+01:00 level=INFO msg="running volumio5-device-gateway" version=30d1950e+CHANGES buildDate=2026-01-29T13:10:08Z
Feb 21 19:55:21 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 21 19:55:21 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 19:55:21 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 19:55:21 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 19:55:21 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 19:55:21 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 19:55:21 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 19:55:21 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 19:55:21 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 19:55:21 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 19:55:21 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 21 19:55:21 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 19:55:21 volumio volumio[987]: info: No need to fix Spotify hosts
Feb 21 19:55:21 volumio systemd[1]: Started go-librespot Daemon.
Feb 21 19:55:21 volumio go-librespot[1225]: go-librespot daemon starting...
Feb 21 19:55:21 volumio sudo[1217]: pam_unix(sudo:session): session closed for user root
Feb 21 19:55:21 volumio volumio[987]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2
Feb 21 19:55:21 volumio volumio[987]: info: Starting Shairport Sync
Feb 21 19:55:21 volumio volumio[987]: info: Starting Shairport Sync
Feb 21 19:55:21 volumio volumio[987]: info: Starting Shairport Sync
Feb 21 19:55:21 volumio sudo[1232]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Feb 21 19:55:21 volumio sudo[1232]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 21 19:55:21 volumio sudo[1234]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Feb 21 19:55:21 volumio sudo[1234]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 21 19:55:21 volumio sudo[1237]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Feb 21 19:55:21 volumio sudo[1237]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 21 19:55:21 volumio volumio[987]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2
Feb 21 19:55:21 volumio volumio[987]: info: Received Get System Info
Feb 21 19:55:21 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 21 19:55:21 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 21 19:55:21 volumio volumio[987]: info: Discovery: Getting this device information
Feb 21 19:55:21 volumio volumio[987]: info: CoreCommandRouter::volumioGetState
Feb 21 19:55:21 volumio volumio[987]: info: CorePlayQueue::getTrack 0
Feb 21 19:55:21 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 21 19:55:21 volumio volumio5-onboarding[1170]: time=2026-02-21T19:55:21.935+01:00 level=INFO msg="system info for 5f586a5595e852268df361e0002440ee" deviceName=Volumio deviceVariant=volumio deviceModel= softwareVersion=3.908
Feb 21 19:55:21 volumio volumio[987]: info: CoreCommandRouter::volumioGetState
Feb 21 19:55:21 volumio volumio[987]: info: CorePlayQueue::getTrack 0
Feb 21 19:55:21 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Feb 21 19:55:21 volumio systemd[1]: shairport-sync.service: Succeeded.
Feb 21 19:55:21 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Feb 21 19:55:21 volumio volumio[987]: info: Received Get System Info
Feb 21 19:55:22 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 21 19:55:22 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 21 19:55:22 volumio volumio[987]: info: Discovery: Getting this device information
Feb 21 19:55:22 volumio volumio[987]: info: CoreCommandRouter::volumioGetState
Feb 21 19:55:22 volumio volumio[987]: info: CorePlayQueue::getTrack 0
Feb 21 19:55:22 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 21 19:55:22 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Feb 21 19:55:22 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Feb 21 19:55:22 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Feb 21 19:55:22 volumio sudo[1237]: pam_unix(sudo:session): session closed for user root
Feb 21 19:55:22 volumio volumio[987]: info: Shairport-Sync Started
Feb 21 19:55:22 volumio sudo[1232]: pam_unix(sudo:session): session closed for user root
Feb 21 19:55:22 volumio sudo[1234]: pam_unix(sudo:session): session closed for user root
Feb 21 19:55:22 volumio volumio5-onboarding[1170]: time=2026-02-21T19:55:22.047+01:00 level=INFO msg="enabling local network discovery"
Feb 21 19:55:22 volumio volumio[987]: Error adding Membership: Error: addMembership EINVAL
Feb 21 19:55:22 volumio volumio[987]: info: Shairport-Sync Started
Feb 21 19:55:22 volumio volumio[987]: info: Shairport-Sync Started
Feb 21 19:55:22 volumio volumio5-onboarding[1170]: time=2026-02-21T19:55:22.084+01:00 level=INFO msg="bootstrapping state" hasInternet=true
Feb 21 19:55:22 volumio volumio[987]: info: Received Get System Info
Feb 21 19:55:22 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 21 19:55:22 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 21 19:55:22 volumio volumio[987]: info: Discovery: Getting this device information
Feb 21 19:55:22 volumio volumio[987]: info: CoreCommandRouter::volumioGetState
Feb 21 19:55:22 volumio volumio[987]: info: CorePlayQueue::getTrack 0
Feb 21 19:55:22 volumio volumio[987]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 21 19:55:22 volumio go-librespot[1225]: time="2026-02-21T19:55:22+01:00" level=info msg="running go-librespot 0.6.2"
Feb 21 19:55:22 volumio go-librespot[1225]: time="2026-02-21T19:55:22+01:00" level=debug msg="app state loaded"
Feb 21 19:55:22 volumio go-librespot[1225]: time="2026-02-21T19:55:22+01:00" level=debug msg="stored credentials not found"
Feb 21 19:55:22 volumio go-librespot[1225]: time="2026-02-21T19:55:22+01:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 21 19:55:22 volumio go-librespot[1225]: time="2026-02-21T19:55:22+01:00" level=debug msg="fetched new accesspoints: [ap-gew4.spotify.com:4070 ap-gew4.spotify.com:443 ap-gew4.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew1.spotify.com:80]"
Feb 21 19:55:22 volumio go-librespot[1225]: time="2026-02-21T19:55:22+01:00" level=debug msg="fetched new dealers: [gew4-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443]"
Feb 21 19:55:22 volumio go-librespot[1225]: time="2026-02-21T19:55:22+01:00" level=debug msg="fetched new spclients: [gew4-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443]"
Feb 21 19:55:22 volumio go-librespot[1225]: time="2026-02-21T19:55:22+01:00" level=info msg="zeroconf server listening on port 37421"
Feb 21 19:55:23 volumio mpd[1175]: Feb 21 19:55 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Feb 21 19:55:23 volumio systemd[1]: Started Music Player Daemon.
Feb 21 19:55:23 volumio sudo[1148]: pam_unix(sudo:session): session closed for user root
Feb 21 19:55:23 volumio sudo[1160]: pam_unix(sudo:session): session closed for user root
Feb 21 19:55:23 volumio volumio[987]: info: Completed starting Core Plugins
Feb 21 19:55:23 volumio volumio[987]: info: -------------------------------------------
Feb 21 19:55:23 volumio volumio[987]: info: ----- MyVolumio plugins startup ----
Feb 21 19:55:23 volumio volumio[987]: info: -------------------------------------------
Feb 21 19:55:23 volumio volumio[987]: info: [MyVolumio PluginManager] Fetching plans data....
Feb 21 19:55:23 volumio volumio[987]: error: MPD error: The expression evaluated to a falsy value:
Feb 21 19:55:23 volumio volumio[987]: assert.ok(self.idling)
Feb 21 19:55:23 volumio volumio[987]: error: The expression evaluated to a falsy value:
Feb 21 19:55:23 volumio volumio[987]: assert.ok(self.idling)
Feb 21 19:55:23 volumio volumio[987]: info: MPD running with PID1175
Feb 21 19:55:23 volumio volumio[987]: ,establishing connection
Feb 21 19:55:23 volumio volumio[987]: error: updateQueue error: null
Feb 21 19:55:23 volumio volumio[987]: error: updateQueue error: null
Feb 21 19:55:24 volumio volumio[987]: info: go-librespot daemon successfully initialized
Feb 21 19:55:26 volumio go-librespot[1225]: time="2026-02-21T19:55:26+01:00" level=debug msg="obtained new client token: AACydWGHLJ76GMgwIBAl43DDNAVLfjXhapBMmc9z1Q4icNe5duB+SxismzTrzd1ZfmXzoyJb0lXe9EWc4kQVWEixIegRcmhEKecIJ+KetqZ0n03aLO7N1pyk5Wh9m+hnjWK/h7VnQvXDNq7daEyatTM7nE1hBy0WPT9k7+UG0ni3+bnpJDtUb6Jlrw9cWH+53cwm38OH5gLuyDkVkG7PUAs1NfXJoSVbDKIs677D7P5eIHr0MMgwXQ=="
Feb 21 19:55:26 volumio go-librespot[1225]: time="2026-02-21T19:55:26+01:00" level=debug msg="connected to ap-gew4.spotify.com:4070"
Feb 21 19:55:26 volumio go-librespot[1225]: time="2026-02-21T19:55:26+01:00" level=debug msg="completed keyexchange"
Feb 21 19:55:26 volumio go-librespot[1225]: time="2026-02-21T19:55:26+01:00" level=debug msg="completed challenge"
Feb 21 19:55:26 volumio go-librespot[1225]: time="2026-02-21T19:55:26+01:00" level=info msg="authenticated AP" username="uk*********************ic"
Feb 21 19:55:26 volumio go-librespot[1225]: time="2026-02-21T19:55:26+01:00" level=info msg="authenticated Login5" username="uk*********************ic"
Feb 21 19:55:26 volumio sudo[1274]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Feb 21 19:55:26 volumio sudo[1274]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 21 19:55:26 volumio go-librespot[1225]: time="2026-02-21T19:55:26+01:00" level=info msg="accepted zeroconf from Rainers MacBook Pro" username="uk*********************ic"
Feb 21 19:55:26 volumio sudo[1274]: pam_unix(sudo:session): session closed for user root
Feb 21 19:55:26 volumio sudo[1276]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Feb 21 19:55:26 volumio sudo[1276]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 21 19:55:26 volumio sudo[1276]: pam_unix(sudo:session): session closed for user root
Feb 21 19:55:26 volumio sudo[1280]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Feb 21 19:55:26 volumio sudo[1280]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 21 19:55:26 volumio systemd[1]: Started UPnP Renderer front-end to MPD.
Feb 21 19:55:26 volumio sudo[1280]: pam_unix(sudo:session): session closed for user root
Feb 21 19:55:26 volumio volumio[987]: info: Upmpdcli Daemon Started
Feb 21 19:55:26 volumio go-librespot[1225]: time="2026-02-21T19:55:26+01:00" level=debug msg="dealer connection opened"
Feb 21 19:55:26 volumio go-librespot[1225]: time="2026-02-21T19:55:26+01:00" level=trace msg="starting accesspoint recv loop"
Feb 21 19:55:26 volumio go-librespot[1225]: time="2026-02-21T19:55:26+01:00" level=trace msg="starting dealer recv loop"
Feb 21 19:55:26 volumio go-librespot[1225]: time="2026-02-21T19:55:26+01:00" level=trace msg="received accesspoint ping"
Feb 21 19:55:26 volumio go-librespot[1225]: time="2026-02-21T19:55:26+01:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336"
Feb 21 19:55:26 volumio go-librespot[1225]: time="2026-02-21T19:55:26+01:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2"
Feb 21 19:55:26 volumio go-librespot[1225]: time="2026-02-21T19:55:26+01:00" level=debug msg="received connection id: ZmU1NTE1OTgtNWRm...RUE3OUQ4OEVBQg=="
Feb 21 19:55:26 volumio volumio[1282]: Generating RSA private key, 4096 bit long modulus (2 primes)
Feb 21 19:55:26 volumio go-librespot[1225]: time="2026-02-21T19:55:26+01:00" level=debug msg="put connect state because NEW_DEVICE"
Feb 21 19:55:26 volumio go-librespot[1225]: time="2026-02-21T19:55:26+01:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17"
Feb 21 19:55:26 volumio go-librespot[1225]: time="2026-02-21T19:55:26+01:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0"
Feb 21 19:55:26 volumio go-librespot[1225]: time="2026-02-21T19:55:26+01:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 481"
Feb 21 19:55:26 volumio go-librespot[1225]: time="2026-02-21T19:55:26+01:00" level=trace msg="received accesspoint pong ack"
Feb 21 19:55:26 volumio go-librespot[1225]: time="2026-02-21T19:55:26+01:00" level=debug msg="handling transfer player command from 0fe3e8863bb0aeb5c1a0229b419254005e57d9ef"
Feb 21 19:55:27 volumio go-librespot[1225]: time="2026-02-21T19:55:27+01:00" level=debug msg="resolved context of track" uri="spotify:album:4sb0eMpDn3upAFfyi4q2rw"
Feb 21 19:55:27 volumio go-librespot[1225]: time="2026-02-21T19:55:27+01:00" level=trace msg="fetched new page 0 with 21 items (list: 21)" uri="spotify:album:4sb0eMpDn3upAFfyi4q2rw"
Feb 21 19:55:27 volumio go-librespot[1225]: time="2026-02-21T19:55:27+01:00" level=debug msg="loading track (paused: true, position: 74154ms)" uri="spotify:track:4vLYewWIvqHfKtJDk8c8tq"
Feb 21 19:55:27 volumio go-librespot[1225]: time="2026-02-21T19:55:27+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED"
Feb 21 19:55:27 volumio go-librespot[1225]: time="2026-02-21T19:55:27+01:00" level=trace msg="emitting websocket event: will_play"
Feb 21 19:55:27 volumio go-librespot[1225]: time="2026-02-21T19:55:27+01:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 411"
Feb 21 19:55:27 volumio go-librespot[1225]: time="2026-02-21T19:55:27+01:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 1360"
Feb 21 19:55:27 volumio go-librespot[1225]: time="2026-02-21T19:55:27+01:00" level=debug msg="selected format OGG_VORBIS_320 (83e608f3419a9707e6ad9f926f7f94c7ad639830)" uri="spotify:track:4vLYewWIvqHfKtJDk8c8tq"
Feb 21 19:55:27 volumio go-librespot[1225]: time="2026-02-21T19:55:27+01:00" level=debug msg="requested aes key for file 83e608f3419a9707e6ad9f926f7f94c7ad639830, gid: 4vLYewWIvqHfKtJDk8c8tq"
Feb 21 19:55:27 volumio go-librespot[1225]: time="2026-02-21T19:55:27+01:00" level=trace msg="found 2 cdn urls" uri="spotify:track:4vLYewWIvqHfKtJDk8c8tq"
Feb 21 19:55:27 volumio go-librespot[1225]: time="2026-02-21T19:55:27+01:00" level=debug msg="fetched first chunk of 43, total size is 22384232 bytes" uri="spotify:track:4vLYewWIvqHfKtJDk8c8tq"
Feb 21 19:55:27 volumio go-librespot[1225]: time="2026-02-21T19:55:27+01:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 1124"
Feb 21 19:55:27 volumio go-librespot[1225]: time="2026-02-21T19:55:27+01:00" level=debug msg="fetched chunk 2/42, size: 524288" uri="spotify:track:4vLYewWIvqHfKtJDk8c8tq"
Feb 21 19:55:27 volumio go-librespot[1225]: time="2026-02-21T19:55:27+01:00" level=debug msg="fetched chunk 1/42, size: 524288" uri="spotify:track:4vLYewWIvqHfKtJDk8c8tq"
Feb 21 19:55:27 volumio go-librespot[1225]: time="2026-02-21T19:55:27+01:00" level=debug msg="fetched chunk 8/42, size: 524288" uri="spotify:track:4vLYewWIvqHfKtJDk8c8tq"
Feb 21 19:55:27 volumio go-librespot[1225]: time="2026-02-21T19:55:27+01:00" level=debug msg="fetched chunk 5/42, size: 524288" uri="spotify:track:4vLYewWIvqHfKtJDk8c8tq"
Feb 21 19:55:27 volumio go-librespot[1225]: time="2026-02-21T19:55:27+01:00" level=trace msg="seek to 74154ms (diff: 157ms, samples: 3270191, bytes: 2669990)" uri="spotify:track:4vLYewWIvqHfKtJDk8c8tq"
Feb 21 19:55:27 volumio go-librespot[1225]: time="2026-02-21T19:55:27+01:00" level=debug msg="created new output device"
Feb 21 19:55:27 volumio go-librespot[1225]: time="2026-02-21T19:55:27+01:00" level=info msg="loaded track \"So What (feat. John Coltrane, Cannonball Adderley & Bill Evans)\" (paused: true, position: 74154ms, duration: 562640ms, prefetched: false)" uri="spotify:track:4vLYewWIvqHfKtJDk8c8tq"
Feb 21 19:55:27 volumio go-librespot[1225]: time="2026-02-21T19:55:27+01:00" level=debug msg="fetched chunk 3/42, size: 524288" uri="spotify:track:4vLYewWIvqHfKtJDk8c8tq"
Feb 21 19:55:27 volumio go-librespot[1225]: time="2026-02-21T19:55:27+01:00" level=debug msg="fetched chunk 6/42, size: 524288" uri="spotify:track:4vLYewWIvqHfKtJDk8c8tq"
Feb 21 19:55:27 volumio go-librespot[1225]: time="2026-02-21T19:55:27+01:00" level=debug msg="fetched chunk 7/42, size: 524288" uri="spotify:track:4vLYewWIvqHfKtJDk8c8tq"
Feb 21 19:55:27 volumio volumio[987]: info: Initializing connection to go-librespot Websocket
Feb 21 19:55:27 volumio go-librespot[1225]: time="2026-02-21T19:55:27+01:00" level=debug msg="new websocket client"
Feb 21 19:55:27 volumio volumio[987]: info: Connection to go-librespot Websocket established
Feb 21 19:55:27 volumio go-librespot[1225]: time="2026-02-21T19:55:27+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED"
Feb 21 19:55:27 volumio go-librespot[1225]: time="2026-02-21T19:55:27+01:00" level=trace msg="emitting websocket event: metadata"
Feb 21 19:55:27 volumio go-librespot[1225]: time="2026-02-21T19:55:27+01:00" level=trace msg="emitting websocket event: active"
Feb 21 19:55:27 volumio go-librespot[1225]: time="2026-02-21T19:55:27+01:00" level=debug msg="sending successful reply for dealer request"
Feb 21 19:55:27 volumio go-librespot[1225]: time="2026-02-21T19:55:27+01:00" level=debug msg="skipping dealer message" uri=social-connect/v2/broadcast_status_update
Feb 21 19:55:27 volumio go-librespot[1225]: time="2026-02-21T19:55:27+01:00" level=debug msg="skipping dealer message" uri=social-connect/v2/session_update
Feb 21 19:55:27 volumio volumio[987]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:4vLYewWIvqHfKtJDk8c8tq","name":"So What (feat. John Coltrane, Cannonball Adderley \u0026 Bill Evans)","artist_names":["Miles Davis","John Coltrane","Cannonball Adderley","Bill Evans"],"album_name":"Kind Of Blue (Legacy Edition)","album_cover_url":"https://i.scdn.co/image/ab67616d00001e020ebc17239b6b18ba88cfb8ca","position":74154,"duration":562640,"release_date":"year:1959 month:8 day:17","track_number":1,"disc_number":1}}
Feb 21 19:55:27 volumio volumio[987]: SPOTIFY: received: {"type":"active","data":null}
Feb 21 19:55:27 volumio volumio[987]: info: Aligning Spotify Volume to Volumio Volume
Feb 21 19:55:27 volumio volumio[987]: info: CoreCommandRouter::volumioGetState
Feb 21 19:55:27 volumio volumio[987]: info: CorePlayQueue::getTrack 0
Feb 21 19:55:27 volumio volumio[987]: info: Setting Spotify Volume from Volumio: 52
Feb 21 19:55:27 volumio go-librespot[1225]: time="2026-02-21T19:55:27+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED"
Feb 21 19:55:27 volumio go-librespot[1225]: time="2026-02-21T19:55:27+01:00" level=trace msg="emitting websocket event: paused"
Feb 21 19:55:27 volumio volumio[987]: SPOTIFY: received: {"type":"paused","data":{"context_uri":"spotify:album:4sb0eMpDn3upAFfyi4q2rw","uri":"spotify:track:4vLYewWIvqHfKtJDk8c8tq","play_origin":"album"}}
Feb 21 19:55:27 volumio volumio[987]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 21 19:55:27 volumio volumio[987]: TypeError: Cannot read property 'service' of undefined
Feb 21 19:55:27 volumio volumio[987]: at ControllerSpotify.identifyPlaybackMode (/data/plugins/music_service/spop/index.js:346:50)
Feb 21 19:55:27 volumio volumio[987]: at ControllerSpotify.parseEventState (/data/plugins/music_service/spop/index.js:280:18)
Feb 21 19:55:27 volumio volumio[987]: at WebSocket.message (/data/plugins/music_service/spop/index.js:199:14)
Feb 21 19:55:27 volumio volumio[987]: at WebSocket.emit (events.js:315:20)
Feb 21 19:55:27 volumio volumio[987]: at Receiver.receiverOnMessage (/data/plugins/music_service/spop/node_modules/ws/lib/websocket.js:1220:20)
Feb 21 19:55:27 volumio volumio[987]: at Receiver.emit (events.js:315:20)
Feb 21 19:55:27 volumio volumio[987]: at Receiver.dataMessage (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:596:14)
Feb 21 19:55:27 volumio volumio[987]: at Receiver.getData (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:496:10)
Feb 21 19:55:27 volumio volumio[987]: at Receiver.startLoop (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:167:16)
Feb 21 19:55:27 volumio volumio[987]: at Receiver._write (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:94:10)
Feb 21 19:55:27 volumio volumio[987]: at writeOrBuffer (internal/streams/writable.js:358:12)
Feb 21 19:55:27 volumio volumio[987]: at Receiver.Writable.write (internal/streams/writable.js:303:10)
Feb 21 19:55:27 volumio volumio[987]: at Socket.socketOnData (/data/plugins/music_service/spop/node_modules/ws/lib/websocket.js:1355:35)
Feb 21 19:55:27 volumio volumio[987]: at Socket.emit (events.js:315:20)
Feb 21 19:55:27 volumio volumio[987]: at addChunk (internal/streams/readable.js:309:12)
Feb 21 19:55:27 volumio volumio[987]: at readableAddChunk (internal/streams/readable.js:284:9)
Feb 21 19:55:27 volumio volumio[987]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 21 19:55:28 volumio sudo[1308]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-02-21 19:54
Feb 21 19:55:28 volumio sudo[1308]: 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="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Thu 05 Feb 2026 01:46:18 PM CET"
VOLUMIO_VERSION="3.908"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="3e9dbaf8f44792d26e97456a18f12823"