-- Logs begin at Thu 2019-02-14 17:11:58 +07, end at Tue 2026-08-25 22:48:47 +07. -- Aug 25 22:48:32 blueplayer systemd-timedated[1043]: Changed local time to Tue Aug 25 22:48:32 2026 Aug 25 22:48:32 blueplayer sudo[1041]: pam_unix(sudo:session): session closed for user root Aug 25 22:48:32 blueplayer volumio-time-update[575]: volumio-time-update-util: System time updated successfully. Aug 25 22:48:32 blueplayer systemd[1]: Starting Daily apt download activities... Aug 25 22:48:32 blueplayer systemd[1]: Starting Daily man-db regeneration... Aug 25 22:48:32 blueplayer systemd[1]: Started Volumio Time Update Utility. Aug 25 22:48:32 blueplayer systemd[1]: Reached target Multi-User System. Aug 25 22:48:32 blueplayer systemd[1]: Reached target Graphical Interface. Aug 25 22:48:32 blueplayer systemd[1]: Starting Update UTMP about System Runlevel Changes... Aug 25 22:48:32 blueplayer systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Aug 25 22:48:32 blueplayer systemd[1]: Started Update UTMP about System Runlevel Changes. Aug 25 22:48:34 blueplayer volumio[880]: info: Loading plugin "ytmusic"... Aug 25 22:48:34 blueplayer systemd[1]: man-db.service: Succeeded. Aug 25 22:48:34 blueplayer systemd[1]: Started Daily man-db regeneration. Aug 25 22:48:34 blueplayer systemd[1]: apt-daily.service: Succeeded. Aug 25 22:48:34 blueplayer systemd[1]: Started Daily apt download activities. Aug 25 22:48:34 blueplayer systemd[1]: Starting Daily apt upgrade and clean activities... Aug 25 22:48:36 blueplayer systemd[1]: apt-daily-upgrade.service: Succeeded. Aug 25 22:48:36 blueplayer systemd[1]: Started Daily apt upgrade and clean activities. Aug 25 22:48:36 blueplayer systemd[1]: Startup finished in 12.184s (kernel) + 24.207s (userspace) = 36.392s. Aug 25 22:48:36 blueplayer volumio[880]: info: Loading plugin "outputs"... Aug 25 22:48:36 blueplayer volumio[880]: info: Loading plugin "albumart"... Aug 25 22:48:36 blueplayer volumio[880]: info: Plugin example_plugin is not enabled Aug 25 22:48:36 blueplayer volumio[880]: info: Loading plugin "inputs"... Aug 25 22:48:36 blueplayer volumio[880]: info: Loading plugin "updater_comm"... Aug 25 22:48:37 blueplayer volumio[880]: info: Plugin mpdemulation is not enabled Aug 25 22:48:37 blueplayer volumio[880]: info: Loading plugin "rest_api"... Aug 25 22:48:37 blueplayer volumio[880]: info: Loading plugin "websocket"... Aug 25 22:48:37 blueplayer volumio[880]: info: Loading plugin "RoonBridge"... Aug 25 22:48:37 blueplayer volumio[880]: Forking 3 albumart workers Aug 25 22:48:37 blueplayer volumio[880]: info: Applying required configuration parameters for plugin RoonBridge Aug 25 22:48:37 blueplayer volumio[880]: info: Loading plugin "touch_display"... Aug 25 22:48:37 blueplayer volumio[880]: Starting albumart workers Aug 25 22:48:37 blueplayer volumio[880]: Starting albumart workers Aug 25 22:48:37 blueplayer volumio[880]: info: Applying required configuration parameters for plugin touch_display Aug 25 22:48:37 blueplayer volumio[880]: Starting albumart workers Aug 25 22:48:37 blueplayer volumio[880]: info: Loading i18n strings for locale en Aug 25 22:48:37 blueplayer volumio[880]: Updating browse sources language Aug 25 22:48:37 blueplayer volumio[880]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 25 22:48:38 blueplayer volumio[880]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 25 22:48:38 blueplayer volumio[880]: info: CoreCommandRouter::initPlayerControls Aug 25 22:48:38 blueplayer volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 22:48:38 blueplayer volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 22:48:38 blueplayer volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 22:48:38 blueplayer volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 22:48:38 blueplayer volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 22:48:38 blueplayer volumio[880]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 25 22:48:38 blueplayer volumio[880]: Express server listening on port 3000 Aug 25 22:48:38 blueplayer volumio[880]: [Metrics] WebUI: 17s 135.59ms Aug 25 22:48:38 blueplayer volumio[880]: info: CoreStateMachine::resetVolumioState Aug 25 22:48:38 blueplayer volumio[880]: info: CoreStateMachine::getcurrentVolume Aug 25 22:48:38 blueplayer volumio[880]: info: CoreCommandRouter::volumioRetrievevolume Aug 25 22:48:38 blueplayer volumio[880]: info: CoreStateMachine::pushState Aug 25 22:48:38 blueplayer volumio[880]: info: CorePlayQueue::getTrack 0 Aug 25 22:48:38 blueplayer volumio[880]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 25 22:48:38 blueplayer volumio[880]: info: CoreCommandRouter::volumioPushState Aug 25 22:48:38 blueplayer sudo[1215]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 25 22:48:38 blueplayer sudo[1215]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 25 22:48:38 blueplayer sudo[1215]: pam_unix(sudo:session): session closed for user root Aug 25 22:48:38 blueplayer sudo[1217]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 25 22:48:38 blueplayer sudo[1217]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 25 22:48:38 blueplayer sudo[1217]: pam_unix(sudo:session): session closed for user root Aug 25 22:48:38 blueplayer volumio[880]: info: MPD Permissions set Aug 25 22:48:38 blueplayer volumio[880]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 1 Aug 25 22:48:38 blueplayer volumio[880]: info: MPD running with PID951 Aug 25 22:48:38 blueplayer volumio[880]: ,establishing connection Aug 25 22:48:38 blueplayer volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 22:48:38 blueplayer volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 22:48:38 blueplayer volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 22:48:38 blueplayer volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 22:48:38 blueplayer volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 22:48:38 blueplayer volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 22:48:38 blueplayer volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 22:48:38 blueplayer volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 22:48:38 blueplayer volumio[880]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 25 22:48:38 blueplayer volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 22:48:38 blueplayer volumio[880]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 25 22:48:38 blueplayer volumio[880]: info: Reloading queue from file Aug 25 22:48:38 blueplayer volumio[880]: error: updateQueue error: null Aug 25 22:48:38 blueplayer volumio[880]: info: CoreStateMachine::setRepeat true single undefined Aug 25 22:48:38 blueplayer volumio[880]: info: CoreStateMachine::pushState Aug 25 22:48:38 blueplayer volumio[880]: info: CorePlayQueue::getTrack 0 Aug 25 22:48:38 blueplayer volumio[880]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 25 22:48:38 blueplayer volumio[880]: info: CoreCommandRouter::volumioPushState Aug 25 22:48:38 blueplayer volumio[880]: info: CoreStateMachine::setRandom false Aug 25 22:48:38 blueplayer volumio[880]: info: CoreStateMachine::pushState Aug 25 22:48:38 blueplayer volumio[880]: info: CorePlayQueue::getTrack 0 Aug 25 22:48:38 blueplayer volumio[880]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 25 22:48:38 blueplayer volumio[880]: info: CoreCommandRouter::volumioPushState Aug 25 22:48:38 blueplayer volumio[880]: info: Setting Device type: Raspberry PI Aug 25 22:48:38 blueplayer volumio[880]: info: Completed loading Core Plugins Aug 25 22:48:38 blueplayer volumio[880]: info: Preparing to generate the ALSA configuration file Aug 25 22:48:38 blueplayer sudo[1232]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Aug 25 22:48:38 blueplayer sudo[1232]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 25 22:48:38 blueplayer volumio[880]: info: Asound.conf file unchanged, so no further update is needed Aug 25 22:48:38 blueplayer volumio[880]: info: Output device has changed, restarting MPD Aug 25 22:48:38 blueplayer sudo[1236]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 25 22:48:38 blueplayer sudo[1236]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 25 22:48:38 blueplayer volumio[880]: info: Output device has changed, restarting Shairport Sync Aug 25 22:48:38 blueplayer volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 22:48:38 blueplayer volumio[880]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 25 22:48:38 blueplayer systemd[1]: Started UPnP Renderer front-end to MPD. Aug 25 22:48:38 blueplayer sudo[1236]: pam_unix(sudo:session): session closed for user root Aug 25 22:48:38 blueplayer sudo[1238]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 25 22:48:38 blueplayer sudo[1238]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 25 22:48:38 blueplayer sudo[1232]: pam_unix(sudo:session): session closed for user root Aug 25 22:48:38 blueplayer systemd[1]: Stopping Music Player Daemon... Aug 25 22:48:38 blueplayer volumio[880]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 25 22:48:38 blueplayer volumio[880]: info: ___________ START PLUGINS ___________ Aug 25 22:48:38 blueplayer volumio[880]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 25 22:48:38 blueplayer volumio[880]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 25 22:48:38 blueplayer volumio[880]: info: [1787672918653] CoreMusicLibrary::Adding element Media Servers Aug 25 22:48:38 blueplayer volumio[880]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 25 22:48:38 blueplayer volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 22:48:38 blueplayer volumio[880]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 25 22:48:38 blueplayer volumio[880]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 25 22:48:38 blueplayer volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 22:48:38 blueplayer volumio[880]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 25 22:48:38 blueplayer volumio[880]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 25 22:48:38 blueplayer volumio[880]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 25 22:48:38 blueplayer volumio[880]: info: [1787672918737] CoreMusicLibrary::Adding element Last_100 Aug 25 22:48:38 blueplayer volumio[880]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 25 22:48:38 blueplayer volumio[880]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 25 22:48:38 blueplayer volumio[880]: info: [1787672918739] CoreMusicLibrary::Adding element Webradio Aug 25 22:48:38 blueplayer volumio[880]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 25 22:48:38 blueplayer volumio[880]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 25 22:48:38 blueplayer volumio[880]: info: Creating Spotify config file Aug 25 22:48:38 blueplayer volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 22:48:38 blueplayer volumio[880]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 25 22:48:38 blueplayer volumio[880]: info: [1787672918767] CoreMusicLibrary::Adding element YouTube2 Aug 25 22:48:38 blueplayer volumio[880]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 25 22:48:38 blueplayer volumio[880]: Cannot find translation for source YouTube2 Aug 25 22:48:38 blueplayer volumio[880]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 25 22:48:38 blueplayer volumio[880]: info: [1787672918775] CoreMusicLibrary::Adding element YouTube Music Aug 25 22:48:38 blueplayer volumio[880]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 25 22:48:38 blueplayer volumio[880]: Cannot find translation for source YouTube2 Aug 25 22:48:38 blueplayer volumio[880]: Cannot find translation for source YouTube Music Aug 25 22:48:38 blueplayer volumio[880]: info: Loading i18n strings for locale en Aug 25 22:48:38 blueplayer volumio[880]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 25 22:48:38 blueplayer volumio[880]: info: Volumio Calling Home Aug 25 22:48:38 blueplayer sudo[1251]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start roonbridge.service Aug 25 22:48:38 blueplayer sudo[1251]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 25 22:48:38 blueplayer systemd[1]: Started RoonBridge. Aug 25 22:48:38 blueplayer sudo[1251]: pam_unix(sudo:session): session closed for user root Aug 25 22:48:38 blueplayer sudo[1262]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service Aug 25 22:48:38 blueplayer sudo[1262]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 25 22:48:38 blueplayer sudo[1268]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service Aug 25 22:48:38 blueplayer sudo[1268]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 25 22:48:38 blueplayer sudo[1271]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Aug 25 22:48:38 blueplayer sudo[1262]: pam_unix(sudo:session): session closed for user root Aug 25 22:48:38 blueplayer sudo[1271]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 25 22:48:38 blueplayer systemd[1]: Reloading. Aug 25 22:48:39 blueplayer volumio[880]: info: Discovery: adding 7c2c9f34-9964-4404-b17c-dba74faf7c83 Aug 25 22:48:39 blueplayer volumio[880]: info: Discovery: Found device Blueplayer Aug 25 22:48:39 blueplayer volumio[880]: info: CoreCommandRouter::volumioGetState Aug 25 22:48:39 blueplayer volumio[880]: info: CorePlayQueue::getTrack 0 Aug 25 22:48:39 blueplayer volumio[880]: error: touch_display: Error detecting backlight interface: Error: ENOENT: no such file or directory, scandir '/sys/class/backlight/' Aug 25 22:48:39 blueplayer volumio[880]: info: Discovery: A device disappeared from network Aug 25 22:48:39 blueplayer volumio[880]: info: Discovery: Device blueplayer disappeared from network Aug 25 22:48:39 blueplayer volumio[880]: info: touch_display: systemctl stop getty@tty1.service succeeded. Aug 25 22:48:39 blueplayer volumio[880]: info: MPD Permissions set Aug 25 22:48:39 blueplayer volumio[880]: info: Upmpdcli Daemon Started Aug 25 22:48:39 blueplayer volumio[880]: info: Spotify config file written Aug 25 22:48:39 blueplayer volumio[880]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 2 Aug 25 22:48:39 blueplayer volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 22:48:39 blueplayer sudo[1289]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Aug 25 22:48:39 blueplayer sudo[1289]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 25 22:48:39 blueplayer systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Aug 25 22:48:39 blueplayer volumio[880]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 25 22:48:39 blueplayer volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 25 22:48:39 blueplayer volumio[880]: info: No need to fix Spotify hosts Aug 25 22:48:39 blueplayer volumio[880]: info: touch_display: No Raspberry Pi Foundation touch screen detected. Aug 25 22:48:39 blueplayer volumio[880]: info: Discovery: adding 7c2c9f34-9964-4404-b17c-dba74faf7c83 Aug 25 22:48:39 blueplayer volumio[880]: info: Discovery: Found device Blueplayer Aug 25 22:48:39 blueplayer volumio[880]: info: CoreCommandRouter::volumioGetState Aug 25 22:48:39 blueplayer volumio[880]: info: CorePlayQueue::getTrack 0 Aug 25 22:48:39 blueplayer volumio[880]: info: Starting Shairport Sync Aug 25 22:48:39 blueplayer sudo[1297]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/99-vc4.conf Aug 25 22:48:39 blueplayer sudo[1297]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 25 22:48:39 blueplayer volumio[880]: info: Starting Shairport Sync Aug 25 22:48:39 blueplayer sudo[1297]: pam_unix(sudo:session): session closed for user root Aug 25 22:48:39 blueplayer sudo[1300]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 25 22:48:39 blueplayer volumio[880]: info: Starting Shairport Sync Aug 25 22:48:39 blueplayer sudo[1300]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 25 22:48:39 blueplayer sudo[1302]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 25 22:48:39 blueplayer sudo[1302]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 25 22:48:39 blueplayer volumio[880]: info: CoreCommandRouter::volumioGetState Aug 25 22:48:39 blueplayer volumio[880]: info: CorePlayQueue::getTrack 0 Aug 25 22:48:39 blueplayer sudo[1306]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 25 22:48:39 blueplayer sudo[1306]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 25 22:48:39 blueplayer volumio[880]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/99-vc4.conf set. Aug 25 22:48:39 blueplayer sudo[1271]: pam_unix(sudo:session): session closed for user root Aug 25 22:48:39 blueplayer volumio[880]: info: touch_display: systemctl daemon-reload succeeded. Aug 25 22:48:39 blueplayer systemd[1]: Reloading. Aug 25 22:48:39 blueplayer sudo[1309]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service Aug 25 22:48:39 blueplayer sudo[1309]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 25 22:48:39 blueplayer volumio[880]: info: Volumio called home Aug 25 22:48:39 blueplayer systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Aug 25 22:48:40 blueplayer RoonBridge[1255]: 00:00:00.009 Warn: get lock file path: /tmp/.rnbgem0- Aug 25 22:48:40 blueplayer sudo[1268]: pam_unix(sudo:session): session closed for user root Aug 25 22:48:40 blueplayer volumio[880]: info: touch_display: systemctl disable getty@tty1.service succeeded. Aug 25 22:48:40 blueplayer RoonBridge[1255]: 00:00:00.367 Trace: [childprocess] using unix child process Aug 25 22:48:40 blueplayer systemd[1]: Started Volumio Kiosk. Aug 25 22:48:40 blueplayer sudo[1309]: pam_unix(sudo:session): session closed for user root Aug 25 22:48:40 blueplayer systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 25 22:48:40 blueplayer systemd[1]: Started go-librespot Daemon. Aug 25 22:48:40 blueplayer volumio[880]: info: touch_display: systemctl start volumio-kiosk.service succeeded. Aug 25 22:48:40 blueplayer systemd[1]: shairport-sync.service: Succeeded. Aug 25 22:48:40 blueplayer sudo[1289]: pam_unix(sudo:session): session closed for user root Aug 25 22:48:40 blueplayer systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 25 22:48:40 blueplayer volumio[880]: info: touch_display: Volumio Kiosk started. Aug 25 22:48:40 blueplayer go-librespot[1327]: go-librespot daemon starting... Aug 25 22:48:40 blueplayer systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 25 22:48:40 blueplayer RoonBridge[1255]: 00:00:00.454 Debug: PathForResource, filename: ../.update Aug 25 22:48:40 blueplayer sudo[1302]: pam_unix(sudo:session): session closed for user root Aug 25 22:48:40 blueplayer sudo[1306]: pam_unix(sudo:session): session closed for user root Aug 25 22:48:40 blueplayer volumio[880]: info: CoreCommandRouter::volumioGetState Aug 25 22:48:40 blueplayer volumio[880]: info: CorePlayQueue::getTrack 0 Aug 25 22:48:40 blueplayer volumio[880]: info: Completed starting Core Plugins Aug 25 22:48:40 blueplayer volumio[880]: info: ------------------------------------------- Aug 25 22:48:40 blueplayer volumio[880]: info: ----- MyVolumio plugins startup ---- Aug 25 22:48:40 blueplayer volumio[880]: info: ------------------------------------------- Aug 25 22:48:40 blueplayer sudo[1300]: pam_unix(sudo:session): session closed for user root Aug 25 22:48:40 blueplayer volumio[880]: info: [MyVolumio PluginManager] Fetching plans data.... Aug 25 22:48:40 blueplayer volumio[880]: info: CoreCommandRouter::volumioGetState Aug 25 22:48:40 blueplayer volumio[880]: info: CorePlayQueue::getTrack 0 Aug 25 22:48:40 blueplayer volumio[880]: info: Shairport-Sync Started Aug 25 22:48:40 blueplayer volumio[880]: Error adding Membership: Error: addMembership EINVAL Aug 25 22:48:40 blueplayer volumio[880]: info: Shairport-Sync Started Aug 25 22:48:40 blueplayer volumio[880]: info: touch_display: X display number found: Aug 25 22:48:40 blueplayer RoonBridge[1255]: 00:00:00.570 Debug: PathForResource, candidate: /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/../.update Aug 25 22:48:40 blueplayer RoonBridge[1255]: 00:00:00.578 Debug: PathForResource, filename: RAATServer Aug 25 22:48:40 blueplayer RoonBridge[1255]: 00:00:00.578 Debug: PathForResource, candidate: /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/RAATServer Aug 25 22:48:40 blueplayer RoonBridge[1255]: 00:00:00.578 Debug: PathForResource, filename: RoonBridgeHelper Aug 25 22:48:40 blueplayer RoonBridge[1255]: 00:00:00.579 Debug: PathForResource, candidate: /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/RoonBridgeHelper Aug 25 22:48:40 blueplayer RoonBridge[1255]: Initializing Aug 25 22:48:40 blueplayer RoonBridge[1255]: 00:00:00.618 Info: Starting /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/RoonBridgeHelper Aug 25 22:48:40 blueplayer volumio[880]: info: touch_display: X display number found: 0 Aug 25 22:48:40 blueplayer RoonBridge[1255]: 00:00:00.672 Info: ConnectOrStartAndWaitForExit RAATServer, path: /data/plugins/music_service/RoonBridge/RoonBridge/Bridge/RAATServer Aug 25 22:48:40 blueplayer volumio[880]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Aug 25 22:48:40 blueplayer startx[1326]: X.Org X Server 1.20.4 Aug 25 22:48:40 blueplayer startx[1326]: X Protocol Version 11, Revision 0 Aug 25 22:48:40 blueplayer startx[1326]: Build Operating System: Linux 5.4.0-109-generic armv8l Raspbian Aug 25 22:48:40 blueplayer startx[1326]: Current Operating System: Linux blueplayer 6.6.62-v7l+ #1816 SMP Mon Nov 18 15:33:33 GMT 2024 armv7l Aug 25 22:48:40 blueplayer startx[1326]: Kernel command line: coherent_pool=1M 8250.nr_uarts=0 snd_bcm2835.enable_headphones=0 cgroup_disable=memory numa_policy=interleave snd_bcm2835.enable_headphones=1 snd_bcm2835.enable_hdmi=1 bcm2708_fb.fbwidth=640 bcm2708_fb.fbheight=480 bcm2708_fb.fbswap=1 smsc95xx.macaddr=E4:5F:01:41:4F:80 vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000 splash plymouth.ignore-serial-consoles dwc_otg.fiq_enable=1 dwc_otg.fiq_fsm_enable=1 dwc_otg.fiq_fsm_mask=0xF dwc_otg.nak_holdoff=1 quiet console=ttyS0,115200 console=tty1 imgpart=UUID=db7775c5-9234-4b9a-955e-7341a245d498 imgfile=/volumio_current.sqsh bootpart=UUID=F102-DE29 datapart=UUID=4112086d-38d3-4206-a7af-ef93bf4e4008 uuidconfig=cmdline.txt pcie_aspm=off pci=pcie_bus_safe rootwait bootdelay=7 logo.nologo vt.global_cursor_default=0 net.ifnames=0 snd-bcm2835.enable_compat_alsa= snd_bcm2835.enable_hdmi=1 snd_bcm2835.enable_headphones=1 loglevel=0 nodebug use_kmsg=no Aug 25 22:48:40 blueplayer startx[1326]: Build Date: 04 April 2023 07:50:56AM Aug 25 22:48:40 blueplayer startx[1326]: xorg-server 2:1.20.4-1+rpt4+deb10u9 (https://www.debian.org/support) Aug 25 22:48:40 blueplayer startx[1326]: Current version of pixman: 0.36.0 Aug 25 22:48:40 blueplayer startx[1326]: Before reporting problems, check http://wiki.x.org Aug 25 22:48:40 blueplayer startx[1326]: to make sure that you have the latest version. Aug 25 22:48:40 blueplayer startx[1326]: Markers: (--) probed, (**) from config file, (==) default setting, Aug 25 22:48:40 blueplayer startx[1326]: (++) from command line, (!!) notice, (II) informational, Aug 25 22:48:40 blueplayer startx[1326]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. Aug 25 22:48:40 blueplayer startx[1326]: (==) Log file: "/var/log/Xorg.0.log", Time: Tue Aug 25 22:48:40 2026 Aug 25 22:48:40 blueplayer startx[1326]: (==) Using config directory: "/etc/X11/xorg.conf.d" Aug 25 22:48:40 blueplayer startx[1326]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" Aug 25 22:48:40 blueplayer RoonBridge[1255]: Not Running (.o) Aug 25 22:48:40 blueplayer volumio[880]: info: touch_display: X display number found: 0 Aug 25 22:48:41 blueplayer RoonBridge[1255]: Running Aug 25 22:48:41 blueplayer go-librespot[1327]: time="2026-08-25T22:48:41+07:00" level=info msg="running go-librespot 0.7.1" Aug 25 22:48:41 blueplayer go-librespot[1327]: time="2026-08-25T22:48:41+07:00" level=debug msg="app state loaded" Aug 25 22:48:41 blueplayer go-librespot[1327]: time="2026-08-25T22:48:41+07:00" level=debug msg="stored credentials not found" Aug 25 22:48:41 blueplayer go-librespot[1327]: time="2026-08-25T22:48:41+07:00" level=info msg="api server listening on 127.0.0.1:9879" Aug 25 22:48:41 blueplayer RoonBridge[1255]: 00:00:00.035 Warn: get lock file path: /tmp/.rnbhgem0- Aug 25 22:48:41 blueplayer go-librespot[1327]: time="2026-08-25T22:48:41+07:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-gue1.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Aug 25 22:48:41 blueplayer go-librespot[1327]: time="2026-08-25T22:48:41+07:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Aug 25 22:48:41 blueplayer go-librespot[1327]: time="2026-08-25T22:48:41+07:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Aug 25 22:48:41 blueplayer go-librespot[1327]: time="2026-08-25T22:48:41+07:00" level=info msg="zeroconf server listening on port 44225" Aug 25 22:48:41 blueplayer go-librespot[1327]: time="2026-08-25T22:48:41+07:00" level=info msg="using avahi-daemon avahi 0.7 for mDNS service registration" Aug 25 22:48:42 blueplayer volumio[880]: info: touch_display: Setting screensaver timeout to 120 seconds. Aug 25 22:48:42 blueplayer volumio[880]: error: MPD error: Error: read ECONNRESET Aug 25 22:48:42 blueplayer systemd[1]: mpd.service: Succeeded. Aug 25 22:48:42 blueplayer systemd[1]: Stopped Music Player Daemon. Aug 25 22:48:42 blueplayer systemd[1]: Starting Music Player Daemon... Aug 25 22:48:42 blueplayer sudo[1434]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 25 22:48:42 blueplayer sudo[1434]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 25 22:48:42 blueplayer sudo[1434]: pam_unix(sudo:session): session closed for user root Aug 25 22:48:43 blueplayer volumio[880]: info: go-librespot daemon successfully initialized Aug 25 22:48:43 blueplayer volumio-remote-updater[601]: [2026-08-25 22:48:43] [connect] Successful connection Aug 25 22:48:43 blueplayer volumio-remote-updater[601]: [2026-08-25 22:48:43] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1787672923 101 Aug 25 22:48:43 blueplayer volumio[880]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 3 Aug 25 22:48:43 blueplayer mpd[1455]: Aug 25 22:48 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Aug 25 22:48:44 blueplayer systemd[1]: systemd-fsckd.service: Succeeded. Aug 25 22:48:44 blueplayer go-librespot[1327]: time="2026-08-25T22:48:44+07:00" level=debug msg="obtained new client token: AAHMc8XQKpe6GXKEjhNjENHg4So1ML2OZLspcU8+bfGgOSl3gLDLB2DnFTXG/DTj+C49v9L22hJa08/h2jCh9tWfBe0awu3IWVsPsKKVuRC0NZO2QgEk+gFgtYawG9gpGOWlAvhYi/LqX7vOmhpLb0FIRpKjU1NNSVUWEhErRFdAW66+yuEiztVGjWAvG8NNpL9/mzMmSADzu+nA1yFsowkMXbU23vxEVNjfV1Gexbu1mVY6VolrXnzrJg==" Aug 25 22:48:44 blueplayer go-librespot[1327]: time="2026-08-25T22:48:44+07:00" level=warning msg="failed to connect to AP ap-gae2.spotify.com:4070, retrying with a different AP" error="dial tcp 104.199.241.202:4070: connect: connection refused" Aug 25 22:48:45 blueplayer go-librespot[1327]: time="2026-08-25T22:48:45+07:00" level=debug msg="connected to ap-gae2.spotify.com:443" Aug 25 22:48:45 blueplayer go-librespot[1327]: time="2026-08-25T22:48:45+07:00" level=debug msg="completed keyexchange" Aug 25 22:48:45 blueplayer go-librespot[1327]: time="2026-08-25T22:48:45+07:00" level=debug msg="completed challenge" Aug 25 22:48:45 blueplayer go-librespot[1327]: time="2026-08-25T22:48:45+07:00" level=info msg="authenticated AP" username="hv*********************fn" Aug 25 22:48:45 blueplayer go-librespot[1327]: time="2026-08-25T22:48:45+07:00" level=info msg="authenticated Login5" username="hv*********************fn" Aug 25 22:48:45 blueplayer go-librespot[1327]: time="2026-08-25T22:48:45+07:00" level=info msg="accepted zeroconf from RMX3741" username="hv*********************fn" Aug 25 22:48:45 blueplayer go-librespot[1327]: time="2026-08-25T22:48:45+07:00" level=debug msg="dealer connection opened" Aug 25 22:48:45 blueplayer go-librespot[1327]: time="2026-08-25T22:48:45+07:00" level=trace msg="starting accesspoint recv loop" Aug 25 22:48:45 blueplayer go-librespot[1327]: time="2026-08-25T22:48:45+07:00" level=trace msg="starting dealer recv loop" Aug 25 22:48:45 blueplayer go-librespot[1327]: time="2026-08-25T22:48:45+07:00" level=trace msg="received accesspoint ping" Aug 25 22:48:45 blueplayer go-librespot[1327]: time="2026-08-25T22:48:45+07:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Aug 25 22:48:45 blueplayer go-librespot[1327]: time="2026-08-25T22:48:45+07:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Aug 25 22:48:45 blueplayer go-librespot[1327]: time="2026-08-25T22:48:45+07:00" level=debug msg="received connection id: Yzc4MjlkNGMtYTI1...RDY2MzA2RDAxRQ==" Aug 25 22:48:45 blueplayer go-librespot[1327]: time="2026-08-25T22:48:45+07:00" level=debug msg="put connect state because NEW_DEVICE" Aug 25 22:48:45 blueplayer go-librespot[1327]: time="2026-08-25T22:48:45+07:00" level=debug msg="update volume requested to 62914/65535" Aug 25 22:48:45 blueplayer go-librespot[1327]: time="2026-08-25T22:48:45+07:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Aug 25 22:48:45 blueplayer go-librespot[1327]: time="2026-08-25T22:48:45+07:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Aug 25 22:48:45 blueplayer go-librespot[1327]: time="2026-08-25T22:48:45+07:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 481" Aug 25 22:48:45 blueplayer go-librespot[1327]: time="2026-08-25T22:48:45+07:00" level=trace msg="received accesspoint pong ack" Aug 25 22:48:46 blueplayer go-librespot[1327]: time="2026-08-25T22:48:46+07:00" level=debug msg="put connect state because VOLUME_CHANGED" Aug 25 22:48:46 blueplayer go-librespot[1327]: time="2026-08-25T22:48:46+07:00" level=trace msg="emitting websocket event: volume" Aug 25 22:48:46 blueplayer go-librespot[1327]: time="2026-08-25T22:48:46+07:00" level=debug msg="handling transfer player command from eaafe788deac52b1aa2ff456bde440fc4aee816a" Aug 25 22:48:46 blueplayer go-librespot[1327]: time="2026-08-25T22:48:46+07:00" level=debug msg="resolved context of track" uri="spotify:playlist:37i9dQZF1DX949uWWpmTjT" Aug 25 22:48:46 blueplayer go-librespot[1327]: time="2026-08-25T22:48:46+07:00" level=trace msg="fetched new page 0 with 400 items (list: 400)" uri="spotify:playlist:37i9dQZF1DX949uWWpmTjT" Aug 25 22:48:46 blueplayer go-librespot[1327]: time="2026-08-25T22:48:46+07:00" level=debug msg="loading track (paused: false, position: 6208ms)" uri="spotify:track:32pQP3XD7rIYraHKMVq9pu" Aug 25 22:48:46 blueplayer go-librespot[1327]: time="2026-08-25T22:48:46+07:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Aug 25 22:48:46 blueplayer go-librespot[1327]: time="2026-08-25T22:48:46+07:00" level=trace msg="emitting websocket event: will_play" Aug 25 22:48:46 blueplayer go-librespot[1327]: time="2026-08-25T22:48:46+07:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 337" Aug 25 22:48:46 blueplayer go-librespot[1327]: time="2026-08-25T22:48:46+07:00" level=debug msg="selected format OGG_VORBIS_320 (88fce064e5c1655682fe4d7aa0824a5aacc3e404)" uri="spotify:track:32pQP3XD7rIYraHKMVq9pu" Aug 25 22:48:46 blueplayer go-librespot[1327]: time="2026-08-25T22:48:46+07:00" level=debug msg="requested aes key for file 88fce064e5c1655682fe4d7aa0824a5aacc3e404, gid: 32pQP3XD7rIYraHKMVq9pu" Aug 25 22:48:46 blueplayer volumio[880]: info: Initializing connection to go-librespot Websocket Aug 25 22:48:46 blueplayer go-librespot[1327]: time="2026-08-25T22:48:46+07:00" level=debug msg="new websocket client" Aug 25 22:48:46 blueplayer volumio[880]: info: Connection to go-librespot Websocket established Aug 25 22:48:46 blueplayer go-librespot[1327]: time="2026-08-25T22:48:46+07:00" level=trace msg="found 2 cdn urls" uri="spotify:track:32pQP3XD7rIYraHKMVq9pu" Aug 25 22:48:46 blueplayer go-librespot[1327]: time="2026-08-25T22:48:46+07:00" level=debug msg="fetched first chunk of 36, total size is 18620536 bytes" uri="spotify:track:32pQP3XD7rIYraHKMVq9pu" Aug 25 22:48:46 blueplayer go-librespot[1327]: time="2026-08-25T22:48:46+07:00" level=trace msg="seek to 6208ms (diff: 158ms, samples: 273772, bytes: 171397)" uri="spotify:track:32pQP3XD7rIYraHKMVq9pu" Aug 25 22:48:46 blueplayer go-librespot[1327]: time="2026-08-25T22:48:46+07:00" level=debug msg="created new output device" Aug 25 22:48:46 blueplayer go-librespot[1327]: time="2026-08-25T22:48:46+07:00" level=debug msg="alsa driver configured, rate = 44100 bps, period time = 100000 us, period size = 4410 frames, buffer time = 500000 us, buffer size = 22050 frames, periods per buffer = 5 frames, PCM format = FLOAT_LE" Aug 25 22:48:46 blueplayer go-librespot[1327]: time="2026-08-25T22:48:46+07:00" level=info msg="loaded track \"Stormy Weather\" (paused: false, position: 6208ms, duration: 635266ms, prefetched: false)" uri="spotify:track:32pQP3XD7rIYraHKMVq9pu" Aug 25 22:48:46 blueplayer go-librespot[1327]: time="2026-08-25T22:48:46+07:00" level=debug msg="fetched chunk 1/35, size: 524288" uri="spotify:track:32pQP3XD7rIYraHKMVq9pu" Aug 25 22:48:47 blueplayer go-librespot[1327]: time="2026-08-25T22:48:47+07:00" level=debug msg="fetched chunk 3/35, size: 524288" uri="spotify:track:32pQP3XD7rIYraHKMVq9pu" Aug 25 22:48:47 blueplayer go-librespot[1327]: time="2026-08-25T22:48:47+07:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Aug 25 22:48:47 blueplayer go-librespot[1327]: time="2026-08-25T22:48:47+07:00" level=trace msg="scheduling prefetch in 599s" Aug 25 22:48:47 blueplayer go-librespot[1327]: time="2026-08-25T22:48:47+07:00" level=trace msg="emitting websocket event: metadata" Aug 25 22:48:47 blueplayer go-librespot[1327]: time="2026-08-25T22:48:47+07:00" level=trace msg="emitting websocket event: active" Aug 25 22:48:47 blueplayer go-librespot[1327]: time="2026-08-25T22:48:47+07:00" level=debug msg="sending successful reply for dealer request" Aug 25 22:48:47 blueplayer go-librespot[1327]: time="2026-08-25T22:48:47+07:00" level=debug msg="skipping dealer message" uri=social-connect/v2/broadcast_status_update Aug 25 22:48:47 blueplayer go-librespot[1327]: time="2026-08-25T22:48:47+07:00" level=debug msg="fetched chunk 2/35, size: 524288" uri="spotify:track:32pQP3XD7rIYraHKMVq9pu" Aug 25 22:48:47 blueplayer volumio[880]: info: Aligning Spotify Volume to Volumio Volume Aug 25 22:48:47 blueplayer volumio[880]: info: CoreCommandRouter::volumioGetState Aug 25 22:48:47 blueplayer volumio[880]: info: CorePlayQueue::getTrack 0 Aug 25 22:48:47 blueplayer go-librespot[1327]: time="2026-08-25T22:48:47+07:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED" Aug 25 22:48:47 blueplayer go-librespot[1327]: time="2026-08-25T22:48:47+07:00" level=trace msg="emitting websocket event: playing" Aug 25 22:48:47 blueplayer volumio[880]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 25 22:48:47 blueplayer volumio[880]: TypeError: Cannot read property 'service' of undefined Aug 25 22:48:47 blueplayer volumio[880]: at ControllerSpotify.identifyPlaybackMode (/data/plugins/music_service/spop/index.js:345:50) Aug 25 22:48:47 blueplayer volumio[880]: at ControllerSpotify.parseEventState (/data/plugins/music_service/spop/index.js:271:18) Aug 25 22:48:47 blueplayer volumio[880]: at WebSocket.message (/data/plugins/music_service/spop/index.js:198:14) Aug 25 22:48:47 blueplayer volumio[880]: at WebSocket.emit (events.js:315:20) Aug 25 22:48:47 blueplayer volumio[880]: at Receiver.receiverOnMessage (/data/plugins/music_service/spop/node_modules/ws/lib/websocket.js:1225:20) Aug 25 22:48:47 blueplayer volumio[880]: at Receiver.emit (events.js:315:20) Aug 25 22:48:47 blueplayer volumio[880]: at Receiver.dataMessage (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:596:14) Aug 25 22:48:47 blueplayer volumio[880]: at Receiver.getData (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:496:10) Aug 25 22:48:47 blueplayer volumio[880]: at Receiver.startLoop (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:167:16) Aug 25 22:48:47 blueplayer volumio[880]: at Receiver._write (/data/plugins/music_service/spop/node_modules/ws/lib/receiver.js:94:10) Aug 25 22:48:47 blueplayer volumio[880]: at writeOrBuffer (internal/streams/writable.js:358:12) Aug 25 22:48:47 blueplayer volumio[880]: at Receiver.Writable.write (internal/streams/writable.js:303:10) Aug 25 22:48:47 blueplayer volumio[880]: at Socket.socketOnData (/data/plugins/music_service/spop/node_modules/ws/lib/websocket.js:1360:35) Aug 25 22:48:47 blueplayer volumio[880]: at Socket.emit (events.js:315:20) Aug 25 22:48:47 blueplayer volumio[880]: at addChunk (internal/streams/readable.js:309:12) Aug 25 22:48:47 blueplayer volumio[880]: at readableAddChunk (internal/streams/readable.js:284:9) Aug 25 22:48:47 blueplayer volumio[880]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 25 22:48:47 blueplayer systemd[1]: systemd-hostnamed.service: Succeeded. Aug 25 22:48:47 blueplayer sudo[1554]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-08-25 22:47 Aug 25 22:48:47 blueplayer sudo[1554]: 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="Thu 09 Jan 2025 10:53:32 AM CET" VOLUMIO_VERSION="3.787" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="a8dde41a0a74a6944b1f5d9c8dec1590"