Oct 11 20:56:00 roffe-mp3 kernel: usb 3-2: new high-speed USB device number 2 using xhci-hcd Oct 11 20:56:00 roffe-mp3 kernel: usb 3-2: New USB device found, idVendor=345e, idProduct=07d1, bcdDevice= 6.f2 Oct 11 20:56:00 roffe-mp3 kernel: usb 3-2: New USB device strings: Mfr=1, Product=3, SerialNumber=0 Oct 11 20:56:00 roffe-mp3 kernel: usb 3-2: Product: DIY PreAmplifier USB Audio 2.0 Oct 11 20:56:00 roffe-mp3 kernel: usb 3-2: Manufacturer: HYPEX Oct 11 20:56:00 roffe-mp3 fsct-plugin[1334]: Failed to initialize device 345e:07d1: BOS descriptor not available, unsupported usb version 2.00 Oct 11 20:56:00 roffe-mp3 systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Oct 11 20:56:00 roffe-mp3 kernel: usbcore: registered new interface driver snd-usb-audio Oct 11 20:56:00 roffe-mp3 (udev-worker)[2095]: controlC5: Process '/usr/sbin/alsactl -E HOME=/run/alsa -E XDG_RUNTIME_DIR=/run/alsa/runtime restore 5' failed with exit code 99. Oct 11 20:56:00 roffe-mp3 volumio[1334]: info: Oct 11 20:56:00 roffe-mp3 volumio[1334]: ---------------------------- USB Audio Device Attached Oct 11 20:56:00 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Oct 11 20:56:00 roffe-mp3 volumio[1334]: info: CoreCommandRouter::Close All Modals sent Oct 11 20:56:00 roffe-mp3 volumio[1334]: info: Preparing to save Alsa Options, stopping services first Oct 11 20:56:00 roffe-mp3 volumio[1334]: info: CoreCommandRouter::volumioGetState Oct 11 20:56:00 roffe-mp3 volumio[1334]: info: CorePlayQueue::getTrack 0 Oct 11 20:56:00 roffe-mp3 volumio[1334]: info: CoreCommandRouter::volumioPause Oct 11 20:56:00 roffe-mp3 volumio[1334]: info: CoreStateMachine::pause Oct 11 20:56:00 roffe-mp3 volumio[1334]: info: Saving Audio Output to: {"disallowPush":true,"output_device":{"value":"5","label":"DIY PreAmplifier USB Audio 2.0","alsacard":"D20"},"i2s":false} Oct 11 20:56:00 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 11 20:56:00 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 11 20:56:00 roffe-mp3 volumio[1334]: info: Device 5 does not have any Mixer Control Available Oct 11 20:56:00 roffe-mp3 volumio[1334]: info: CoreCommandRouter::volumioUpdateVolumeSettings Oct 11 20:56:00 roffe-mp3 volumio[1334]: info: Updating Volume Controller Parameters: Device: 5 Name: DIY PreAmplifier USB Audio 2.0 Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Oct 11 20:56:00 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Oct 11 20:56:00 roffe-mp3 volumio[1334]: info: Disabling external Volume Control Oct 11 20:56:00 roffe-mp3 volumio[1334]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 11 20:56:00 roffe-mp3 volumio[1334]: info: CoreStateMachine::pushState Oct 11 20:56:00 roffe-mp3 volumio[1334]: info: CorePlayQueue::getTrack 0 Oct 11 20:56:00 roffe-mp3 volumio[1334]: info: CoreCommandRouter::volumioPushState Oct 11 20:56:00 roffe-mp3 volumio5-onboarding[1595]: time=2026-10-11T20:56:00.509+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.86.20:49321 @ 0x2000ed0" state=STATUS_STOPPED positionMs=0 volume=100 Oct 11 20:56:00 roffe-mp3 volumio5-onboarding[1595]: time=2026-10-11T20:56:00.510+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.86.20:49321 @ 0x2000ed0" id=http://streams.80s80s.de/love/mp3-192/volumio title="80s80s Love" Oct 11 20:56:00 roffe-mp3 volumio[1334]: info: Preparing to generate the ALSA configuration file Oct 11 20:56:00 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Oct 11 20:56:00 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 11 20:56:00 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 11 20:56:00 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 11 20:56:00 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 11 20:56:00 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 11 20:56:00 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 11 20:56:00 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 11 20:56:00 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 11 20:56:00 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 11 20:56:00 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Oct 11 20:56:00 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 11 20:56:00 roffe-mp3 volumio[1334]: info: Asound.conf file unchanged, so no further update is needed Oct 11 20:56:00 roffe-mp3 volumio[1334]: info: Output device has changed, restarting MPD Oct 11 20:56:00 roffe-mp3 volumio[1334]: info: Output device has changed, restarting Shairport Sync Oct 11 20:56:00 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 20:56:00 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 11 20:56:00 roffe-mp3 sudo[2142]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 11 20:56:00 roffe-mp3 sudo[2142]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 11 20:56:00 roffe-mp3 sudo[2141]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 11 20:56:00 roffe-mp3 sudo[2141]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 11 20:56:00 roffe-mp3 sudo[2141]: pam_unix(sudo:session): session closed for user root Oct 11 20:56:00 roffe-mp3 volumio[1334]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 11 20:56:00 roffe-mp3 volumio[1334]: info: MPD Permissions set Oct 11 20:56:00 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 20:56:00 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 20:56:00 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 20:56:00 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 20:56:00 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 20:56:00 roffe-mp3 systemd[1]: Stopping mpd.service - Music Player Daemon... Oct 11 20:56:00 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 20:56:00 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 20:56:00 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 20:56:00 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 11 20:56:00 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 11 20:56:00 roffe-mp3 volumio[1334]: info: Starting Shairport Sync Oct 11 20:56:00 roffe-mp3 sudo[2155]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 11 20:56:00 roffe-mp3 sudo[2155]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 11 20:56:00 roffe-mp3 systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Oct 11 20:56:00 roffe-mp3 systemd[1]: shairport-sync.service: Deactivated successfully. Oct 11 20:56:00 roffe-mp3 systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 11 20:56:00 roffe-mp3 systemd[1]: shairport-sync.service: Consumed 1.536s CPU time. Oct 11 20:56:00 roffe-mp3 systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 11 20:56:00 roffe-mp3 sudo[2155]: pam_unix(sudo:session): session closed for user root Oct 11 20:56:00 roffe-mp3 volumio[1334]: info: Shairport-Sync Started Oct 11 20:56:00 roffe-mp3 systemd[1]: mpd.service: Deactivated successfully. Oct 11 20:56:00 roffe-mp3 systemd[1]: Stopped mpd.service - Music Player Daemon. Oct 11 20:56:00 roffe-mp3 systemd[1]: mpd.service: Consumed 1.209s CPU time. Oct 11 20:56:00 roffe-mp3 systemd[1]: mpd.socket: Deactivated successfully. Oct 11 20:56:00 roffe-mp3 systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Oct 11 20:56:00 roffe-mp3 systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Oct 11 20:56:00 roffe-mp3 systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Oct 11 20:56:00 roffe-mp3 systemd[1]: Starting mpd.service - Music Player Daemon... Oct 11 20:56:00 roffe-mp3 sudo[2173]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 11 20:56:00 roffe-mp3 sudo[2173]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Oct 11 20:56:00 roffe-mp3 sudo[2173]: pam_unix(sudo:session): session closed for user root Oct 11 20:56:01 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Oct 11 20:56:01 roffe-mp3 mpd[2175]: 2026-10-11T20:56:01 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 11 20:56:01 roffe-mp3 systemd[1]: Started mpd.service - Music Player Daemon. Oct 11 20:56:01 roffe-mp3 sudo[2142]: pam_unix(sudo:session): session closed for user root Oct 11 20:56:01 roffe-mp3 volumio[1334]: error: updateQueue error: null Oct 11 20:56:01 roffe-mp3 systemd[1]: setdatetime-helper.service: Deactivated successfully. Oct 11 20:56:01 roffe-mp3 systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Oct 11 20:56:02 roffe-mp3 kernel: usb 3-2: USB disconnect, device number 2 Oct 11 20:56:02 roffe-mp3 volumio[1334]: info: Oct 11 20:56:02 roffe-mp3 volumio[1334]: ---------------------------- USB Audio Device Detached Oct 11 20:56:02 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach Oct 11 20:56:02 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 11 20:56:02 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: raat , onStop Oct 11 20:56:04 roffe-mp3 volumio[1334]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Oct 11 20:56:04 roffe-mp3 volumio[1334]: info: CoreStateMachine::getcurrentVolume Oct 11 20:56:04 roffe-mp3 volumio[1334]: info: CoreCommandRouter::volumioRetrievevolume Oct 11 20:56:04 roffe-mp3 volumio[1334]: info: CoreStateMachine::pushState Oct 11 20:56:04 roffe-mp3 volumio[1334]: info: CorePlayQueue::getTrack 0 Oct 11 20:56:04 roffe-mp3 volumio[1334]: info: CoreCommandRouter::volumioPushState Oct 11 20:56:04 roffe-mp3 volumio5-onboarding[1595]: time=2026-10-11T20:56:04.508+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.86.20:49321 @ 0x2000ed0" state=STATUS_STOPPED positionMs=0 volume=100 Oct 11 20:56:04 roffe-mp3 volumio5-onboarding[1595]: time=2026-10-11T20:56:04.508+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.86.20:49321 @ 0x2000ed0" id=http://streams.80s80s.de/love/mp3-192/volumio title="80s80s Love" Oct 11 20:56:05 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 11 20:56:05 roffe-mp3 volumio[1334]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Oct 11 20:56:05 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Oct 11 20:56:05 roffe-mp3 volumio[1334]: info: Received Get System Version Oct 11 20:56:05 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 11 20:56:05 roffe-mp3 volumio[1334]: info: Received Get System Info Oct 11 20:56:05 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 11 20:56:05 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 11 20:56:05 roffe-mp3 volumio[1334]: info: Discovery: Getting this device information Oct 11 20:56:05 roffe-mp3 volumio[1334]: info: CoreCommandRouter::volumioGetState Oct 11 20:56:05 roffe-mp3 volumio[1334]: info: CorePlayQueue::getTrack 0 Oct 11 20:56:05 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 11 20:56:15 roffe-mp3 volumio5-onboarding[1595]: time=2026-10-11T20:56:15.752+02:00 level=INFO msg="navigate to next page" component=server type=REQUEST_TYPE_CONTINUE_NAVIGATION peer="192.168.86.20:49321 @ 0x2000ed0" latency=20.182547ms timeout=10s from=APP_PAGE_ROOT to=APP_PAGE_LEGACY_DEVICE Oct 11 20:56:15 roffe-mp3 volumio5-onboarding[1595]: time=2026-10-11T20:56:15.782+02:00 level=INFO msg="check connectivity" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.20:49321 @ 0x2000ed0" latency=17.483831ms timeout=10s Oct 11 20:56:15 roffe-mp3 volumio5-onboarding[1595]: time=2026-10-11T20:56:15.806+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.20:49321 @ 0x2000ed0" latency=17.483831ms timeout=10s endpoint=https://radio-directory.firebaseapp.com duration=23.811355ms Oct 11 20:56:15 roffe-mp3 volumio5-onboarding[1595]: time=2026-10-11T20:56:15.819+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.20:49321 @ 0x2000ed0" latency=17.483831ms timeout=10s endpoint=http://pushupdates.volumio.org duration=35.531523ms Oct 11 20:56:15 roffe-mp3 volumio5-onboarding[1595]: time=2026-10-11T20:56:15.836+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.20:49321 @ 0x2000ed0" latency=17.483831ms timeout=10s endpoint=https://oauth-performer.dfs.volumio.org duration=53.67899ms Oct 11 20:56:15 roffe-mp3 volumio5-onboarding[1595]: time=2026-10-11T20:56:15.842+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.20:49321 @ 0x2000ed0" latency=17.483831ms timeout=10s endpoint=https://browsing-performer.dfs.volumio.org duration=59.506861ms Oct 11 20:56:15 roffe-mp3 volumio5-onboarding[1595]: time=2026-10-11T20:56:15.905+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.20:49321 @ 0x2000ed0" latency=17.483831ms timeout=10s endpoint=https://www.googleapis.com duration=122.678966ms Oct 11 20:56:15 roffe-mp3 volumio5-onboarding[1595]: time=2026-10-11T20:56:15.940+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.20:49321 @ 0x2000ed0" latency=17.483831ms timeout=10s endpoint=https://myvolumio.firebaseio.com duration=157.461799ms Oct 11 20:56:15 roffe-mp3 volumio5-onboarding[1595]: time=2026-10-11T20:56:15.945+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.20:49321 @ 0x2000ed0" latency=17.483831ms timeout=10s endpoint=https://securetoken.googleapis.com duration=162.398775ms Oct 11 20:56:15 roffe-mp3 volumio5-onboarding[1595]: time=2026-10-11T20:56:15.952+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.20:49321 @ 0x2000ed0" latency=17.483831ms timeout=10s endpoint=https://functions.volumio.cloud duration=169.659987ms Oct 11 20:56:15 roffe-mp3 volumio5-onboarding[1595]: time=2026-10-11T20:56:15.952+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.20:49321 @ 0x2000ed0" latency=17.483831ms timeout=10s endpoint=https://functions.volumio.cloud duration=169.11591ms Oct 11 20:56:15 roffe-mp3 volumio5-onboarding[1595]: time=2026-10-11T20:56:15.963+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.20:49321 @ 0x2000ed0" latency=17.483831ms timeout=10s endpoint=https://database.volumio.cloud duration=180.361352ms Oct 11 20:56:16 roffe-mp3 sudo[2209]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 11 20:56:16 roffe-mp3 sudo[2209]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 11 20:56:16 roffe-mp3 sudo[2209]: pam_unix(sudo:session): session closed for user root Oct 11 20:56:16 roffe-mp3 sudo[2211]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 11 20:56:16 roffe-mp3 sudo[2211]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 11 20:56:16 roffe-mp3 sudo[2211]: pam_unix(sudo:session): session closed for user root Oct 11 20:56:16 roffe-mp3 volumio[1334]: verbose: New Socket.io Connection to 192.168.86.30 from 192.168.86.20 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 VolumioApp/6.260929.0 Engine version: 3 Transport: polling Total Clients: 8 Oct 11 20:56:16 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 11 20:56:16 roffe-mp3 volumio[1334]: info: CoreCommandRouter::volumioGetVisibleSources Oct 11 20:56:16 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 11 20:56:16 roffe-mp3 volumio[1334]: info: CoreCommandRouter::volumioGetState Oct 11 20:56:16 roffe-mp3 volumio[1334]: info: CorePlayQueue::getTrack 0 Oct 11 20:56:16 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 11 20:56:16 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 11 20:56:16 roffe-mp3 volumio[1334]: info: Received Get System Info Oct 11 20:56:16 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 11 20:56:16 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 11 20:56:16 roffe-mp3 volumio[1334]: info: Discovery: Getting this device information Oct 11 20:56:16 roffe-mp3 volumio[1334]: info: CoreCommandRouter::volumioGetState Oct 11 20:56:16 roffe-mp3 volumio[1334]: info: CorePlayQueue::getTrack 0 Oct 11 20:56:16 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 11 20:56:16 roffe-mp3 volumio[1334]: info: CoreCommandRouter::volumioGetState Oct 11 20:56:16 roffe-mp3 volumio[1334]: info: CorePlayQueue::getTrack 0 Oct 11 20:56:16 roffe-mp3 volumio[1334]: info: Listing playlists Oct 11 20:56:16 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 11 20:56:16 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 11 20:56:16 roffe-mp3 sudo[2215]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 11 20:56:16 roffe-mp3 sudo[2215]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 11 20:56:16 roffe-mp3 sudo[2217]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 11 20:56:16 roffe-mp3 sudo[2217]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 11 20:56:16 roffe-mp3 sudo[2215]: pam_unix(sudo:session): session closed for user root Oct 11 20:56:16 roffe-mp3 sudo[2217]: pam_unix(sudo:session): session closed for user root Oct 11 20:56:16 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 11 20:56:16 roffe-mp3 volumio5-onboarding[1595]: time=2026-10-11T20:56:16.354+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.20:49321 @ 0x2000ed0" latency=17.483831ms timeout=10s endpoint=http://plugins.volumio.org duration=570.966321ms Oct 11 20:56:16 roffe-mp3 volumio5-onboarding[1595]: time=2026-10-11T20:56:16.375+02:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.20:49321 @ 0x2000ed0" latency=17.483831ms timeout=10s endpoint=http://cddb.volumio.org duration=592.342882ms error="Head \"http://gnudb.gnudb.org/~cddb/cddb.cgi/\": EOF" Oct 11 20:56:16 roffe-mp3 volumio[1334]: verbose: New Socket.io Connection to 192.168.86.30 from 192.168.86.20 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 VolumioApp/6.260929.0 Engine version: 3 Transport: polling Total Clients: 8 Oct 11 20:56:16 roffe-mp3 volumio5-onboarding[1595]: time=2026-10-11T20:56:16.432+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.20:49321 @ 0x2000ed0" latency=17.483831ms timeout=10s endpoint=https://google.com duration=649.893378ms Oct 11 20:56:16 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 11 20:56:16 roffe-mp3 volumio[1334]: info: CoreCommandRouter::volumioGetVisibleSources Oct 11 20:56:16 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 11 20:56:16 roffe-mp3 volumio[1334]: info: CoreCommandRouter::volumioGetState Oct 11 20:56:16 roffe-mp3 volumio[1334]: info: CorePlayQueue::getTrack 0 Oct 11 20:56:16 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 11 20:56:16 roffe-mp3 volumio[1334]: info: CoreCommandRouter::volumioGetQueue Oct 11 20:56:16 roffe-mp3 volumio[1334]: info: CoreStateMachine::getQueue Oct 11 20:56:16 roffe-mp3 volumio[1334]: info: CorePlayQueue::getQueue Oct 11 20:56:16 roffe-mp3 volumio[1334]: info: Listing playlists Oct 11 20:56:16 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 11 20:56:16 roffe-mp3 volumio[1334]: info: Received Get System Info Oct 11 20:56:16 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 11 20:56:16 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 11 20:56:16 roffe-mp3 volumio[1334]: info: Discovery: Getting this device information Oct 11 20:56:16 roffe-mp3 volumio[1334]: info: CoreCommandRouter::volumioGetState Oct 11 20:56:16 roffe-mp3 volumio[1334]: info: CorePlayQueue::getTrack 0 Oct 11 20:56:16 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 11 20:56:16 roffe-mp3 volumio[1334]: info: CoreCommandRouter::volumioGetState Oct 11 20:56:16 roffe-mp3 volumio[1334]: info: CorePlayQueue::getTrack 0 Oct 11 20:56:16 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 11 20:56:16 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 11 20:56:16 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 11 20:56:18 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Oct 11 20:56:18 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 11 20:56:18 roffe-mp3 volumio[1334]: info: Received Get System Info Oct 11 20:56:18 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 11 20:56:18 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 11 20:56:18 roffe-mp3 volumio[1334]: info: Discovery: Getting this device information Oct 11 20:56:18 roffe-mp3 volumio[1334]: info: CoreCommandRouter::volumioGetState Oct 11 20:56:18 roffe-mp3 volumio[1334]: info: CorePlayQueue::getTrack 0 Oct 11 20:56:18 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 11 20:56:19 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 11 20:56:19 roffe-mp3 volumio[1334]: info: Received Get System Info Oct 11 20:56:19 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 11 20:56:19 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 11 20:56:19 roffe-mp3 volumio[1334]: info: Discovery: Getting this device information Oct 11 20:56:19 roffe-mp3 volumio[1334]: info: CoreCommandRouter::volumioGetState Oct 11 20:56:19 roffe-mp3 volumio[1334]: info: CorePlayQueue::getTrack 0 Oct 11 20:56:19 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 11 20:56:26 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 11 20:56:34 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 11 20:56:34 roffe-mp3 volumio[1334]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Oct 11 20:56:34 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Oct 11 20:56:34 roffe-mp3 volumio[1334]: info: Received Get System Version Oct 11 20:56:34 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 11 20:56:34 roffe-mp3 volumio[1334]: info: Received Get System Info Oct 11 20:56:34 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 11 20:56:34 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 11 20:56:34 roffe-mp3 volumio[1334]: info: Discovery: Getting this device information Oct 11 20:56:34 roffe-mp3 volumio[1334]: info: CoreCommandRouter::volumioGetState Oct 11 20:56:34 roffe-mp3 volumio[1334]: info: CorePlayQueue::getTrack 0 Oct 11 20:56:34 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 11 20:56:40 roffe-mp3 volumio[1334]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 11 20:56:40 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Oct 11 20:56:40 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 11 20:56:40 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 11 20:56:40 roffe-mp3 volumio[1334]: Invalid card number '5'. Oct 11 20:56:40 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 11 20:56:40 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 11 20:56:40 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 11 20:56:40 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 11 20:56:40 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 11 20:56:40 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 11 20:56:40 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 11 20:56:40 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Oct 11 20:56:40 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 11 20:56:44 roffe-mp3 volumio5-onboarding[1595]: time=2026-10-11T20:56:44.750+02:00 level=INFO msg="navigate to next page" component=server type=REQUEST_TYPE_CONTINUE_NAVIGATION peer="192.168.86.20:49321 @ 0x2000ed0" latency=20.347362ms timeout=10s from=APP_PAGE_ROOT to=APP_PAGE_LEGACY_DEVICE Oct 11 20:56:44 roffe-mp3 volumio5-onboarding[1595]: time=2026-10-11T20:56:44.764+02:00 level=INFO msg="check connectivity" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.20:49321 @ 0x2000ed0" latency=18.022975ms timeout=10s Oct 11 20:56:44 roffe-mp3 volumio5-onboarding[1595]: time=2026-10-11T20:56:44.782+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.20:49321 @ 0x2000ed0" latency=18.022975ms timeout=10s endpoint=https://radio-directory.firebaseapp.com duration=18.324527ms Oct 11 20:56:44 roffe-mp3 volumio5-onboarding[1595]: time=2026-10-11T20:56:44.799+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.20:49321 @ 0x2000ed0" latency=18.022975ms timeout=10s endpoint=http://pushupdates.volumio.org duration=34.851938ms Oct 11 20:56:44 roffe-mp3 volumio5-onboarding[1595]: time=2026-10-11T20:56:44.816+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.20:49321 @ 0x2000ed0" latency=18.022975ms timeout=10s endpoint=https://oauth-performer.dfs.volumio.org duration=52.325323ms Oct 11 20:56:44 roffe-mp3 volumio5-onboarding[1595]: time=2026-10-11T20:56:44.820+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.20:49321 @ 0x2000ed0" latency=18.022975ms timeout=10s endpoint=https://browsing-performer.dfs.volumio.org duration=56.26983ms Oct 11 20:56:44 roffe-mp3 volumio5-onboarding[1595]: time=2026-10-11T20:56:44.887+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.20:49321 @ 0x2000ed0" latency=18.022975ms timeout=10s endpoint=https://www.googleapis.com duration=122.615749ms Oct 11 20:56:44 roffe-mp3 volumio5-onboarding[1595]: time=2026-10-11T20:56:44.918+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.20:49321 @ 0x2000ed0" latency=18.022975ms timeout=10s endpoint=https://myvolumio.firebaseio.com duration=154.367618ms Oct 11 20:56:44 roffe-mp3 volumio5-onboarding[1595]: time=2026-10-11T20:56:44.918+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.20:49321 @ 0x2000ed0" latency=18.022975ms timeout=10s endpoint=https://securetoken.googleapis.com duration=154.619764ms Oct 11 20:56:44 roffe-mp3 volumio5-onboarding[1595]: time=2026-10-11T20:56:44.933+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.20:49321 @ 0x2000ed0" latency=18.022975ms timeout=10s endpoint=https://functions.volumio.cloud duration=169.410077ms Oct 11 20:56:44 roffe-mp3 volumio5-onboarding[1595]: time=2026-10-11T20:56:44.936+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.20:49321 @ 0x2000ed0" latency=18.022975ms timeout=10s endpoint=https://functions.volumio.cloud duration=171.734504ms Oct 11 20:56:44 roffe-mp3 volumio5-onboarding[1595]: time=2026-10-11T20:56:44.940+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.20:49321 @ 0x2000ed0" latency=18.022975ms timeout=10s endpoint=https://database.volumio.cloud duration=175.574179ms Oct 11 20:56:45 roffe-mp3 sudo[2280]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 11 20:56:45 roffe-mp3 sudo[2280]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 11 20:56:45 roffe-mp3 sudo[2282]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 11 20:56:45 roffe-mp3 sudo[2282]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 11 20:56:45 roffe-mp3 sudo[2280]: pam_unix(sudo:session): session closed for user root Oct 11 20:56:45 roffe-mp3 sudo[2282]: pam_unix(sudo:session): session closed for user root Oct 11 20:56:45 roffe-mp3 volumio[1334]: verbose: New Socket.io Connection to 192.168.86.30 from 192.168.86.20 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 VolumioApp/6.260929.0 Engine version: 3 Transport: polling Total Clients: 8 Oct 11 20:56:45 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 11 20:56:45 roffe-mp3 volumio[1334]: info: CoreCommandRouter::volumioGetVisibleSources Oct 11 20:56:45 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 11 20:56:45 roffe-mp3 volumio[1334]: info: CoreCommandRouter::volumioGetState Oct 11 20:56:45 roffe-mp3 volumio[1334]: info: CorePlayQueue::getTrack 0 Oct 11 20:56:45 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 11 20:56:45 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 11 20:56:45 roffe-mp3 volumio[1334]: info: Received Get System Info Oct 11 20:56:45 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 11 20:56:45 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 11 20:56:45 roffe-mp3 volumio[1334]: info: Discovery: Getting this device information Oct 11 20:56:45 roffe-mp3 volumio[1334]: info: CoreCommandRouter::volumioGetState Oct 11 20:56:45 roffe-mp3 volumio[1334]: info: CorePlayQueue::getTrack 0 Oct 11 20:56:45 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 11 20:56:45 roffe-mp3 volumio[1334]: info: CoreCommandRouter::volumioGetState Oct 11 20:56:45 roffe-mp3 volumio[1334]: info: CorePlayQueue::getTrack 0 Oct 11 20:56:45 roffe-mp3 volumio[1334]: info: Listing playlists Oct 11 20:56:45 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 11 20:56:45 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 11 20:56:45 roffe-mp3 volumio5-onboarding[1595]: time=2026-10-11T20:56:45.283+02:00 level=ERROR msg="endpoint is not reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.20:49321 @ 0x2000ed0" latency=18.022975ms timeout=10s endpoint=http://cddb.volumio.org duration=519.498739ms error="Head \"http://gnudb.gnudb.org/~cddb/cddb.cgi/\": EOF" Oct 11 20:56:45 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 11 20:56:45 roffe-mp3 sudo[2286]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 11 20:56:45 roffe-mp3 sudo[2286]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 11 20:56:45 roffe-mp3 sudo[2288]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 11 20:56:45 roffe-mp3 sudo[2288]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 11 20:56:45 roffe-mp3 sudo[2286]: pam_unix(sudo:session): session closed for user root Oct 11 20:56:45 roffe-mp3 sudo[2288]: pam_unix(sudo:session): session closed for user root Oct 11 20:56:45 roffe-mp3 volumio5-onboarding[1595]: time=2026-10-11T20:56:45.338+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.20:49321 @ 0x2000ed0" latency=18.022975ms timeout=10s endpoint=http://plugins.volumio.org duration=573.726011ms Oct 11 20:56:45 roffe-mp3 volumio[1334]: verbose: New Socket.io Connection to 192.168.86.30 from 192.168.86.20 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 VolumioApp/6.260929.0 Engine version: 3 Transport: polling Total Clients: 9 Oct 11 20:56:45 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 11 20:56:45 roffe-mp3 volumio5-onboarding[1595]: time=2026-10-11T20:56:45.439+02:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.86.20:49321 @ 0x2000ed0" latency=18.022975ms timeout=10s endpoint=https://google.com duration=675.144292ms Oct 11 20:56:45 roffe-mp3 volumio[1334]: info: CoreCommandRouter::volumioGetVisibleSources Oct 11 20:56:45 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 11 20:56:45 roffe-mp3 volumio[1334]: info: CoreCommandRouter::volumioGetState Oct 11 20:56:45 roffe-mp3 volumio[1334]: info: CorePlayQueue::getTrack 0 Oct 11 20:56:45 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 11 20:56:45 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 11 20:56:45 roffe-mp3 volumio[1334]: info: Received Get System Info Oct 11 20:56:45 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 11 20:56:45 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 11 20:56:45 roffe-mp3 volumio[1334]: info: Discovery: Getting this device information Oct 11 20:56:45 roffe-mp3 volumio[1334]: info: CoreCommandRouter::volumioGetState Oct 11 20:56:45 roffe-mp3 volumio[1334]: info: CorePlayQueue::getTrack 0 Oct 11 20:56:45 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 11 20:56:45 roffe-mp3 volumio[1334]: info: CoreCommandRouter::volumioGetState Oct 11 20:56:45 roffe-mp3 volumio[1334]: info: CorePlayQueue::getTrack 0 Oct 11 20:56:45 roffe-mp3 volumio[1334]: info: Listing playlists Oct 11 20:56:45 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 11 20:56:45 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 11 20:56:45 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 11 20:56:46 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Oct 11 20:56:47 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 11 20:56:47 roffe-mp3 volumio[1334]: info: Received Get System Info Oct 11 20:56:47 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 11 20:56:47 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 11 20:56:47 roffe-mp3 volumio[1334]: info: Discovery: Getting this device information Oct 11 20:56:47 roffe-mp3 volumio[1334]: info: CoreCommandRouter::volumioGetState Oct 11 20:56:47 roffe-mp3 volumio[1334]: info: CorePlayQueue::getTrack 0 Oct 11 20:56:47 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 11 20:56:48 roffe-mp3 volumio[1334]: info: CoreCommandRouter::volumioGetQueue Oct 11 20:56:48 roffe-mp3 volumio[1334]: info: CoreStateMachine::getQueue Oct 11 20:56:48 roffe-mp3 volumio[1334]: info: CorePlayQueue::getQueue Oct 11 20:56:48 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 11 20:56:48 roffe-mp3 volumio[1334]: info: Received Get System Info Oct 11 20:56:48 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 11 20:56:48 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 11 20:56:48 roffe-mp3 volumio[1334]: info: Discovery: Getting this device information Oct 11 20:56:48 roffe-mp3 volumio[1334]: info: CoreCommandRouter::volumioGetState Oct 11 20:56:48 roffe-mp3 volumio[1334]: info: CorePlayQueue::getTrack 0 Oct 11 20:56:48 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 11 20:56:52 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: 80s80s , handleBrowseUri Oct 11 20:56:52 roffe-mp3 volumio[1334]: info: [1791745012289] [80s80s] handleBrowseUri curUri: 80s80s Oct 11 20:56:52 roffe-mp3 volumio[1334]: info: Preload queue cleared Oct 11 20:56:53 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: 80s80s , handleBrowseUri Oct 11 20:56:53 roffe-mp3 volumio[1334]: info: [1791745013518] [80s80s] handleBrowseUri curUri: 80s80s/eighties Oct 11 20:56:53 roffe-mp3 volumio[1334]: info: [1791745013519] [80s80s] getRadioContent url: eighties Oct 11 20:56:53 roffe-mp3 volumio[1334]: info: Preload queue cleared Oct 11 20:56:54 roffe-mp3 volumio[1334]: info: Preload queue cleared Oct 11 20:56:54 roffe-mp3 volumio[1334]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 11 20:56:54 roffe-mp3 volumio[1334]: info: CoreStateMachine::ClearQueue Oct 11 20:56:54 roffe-mp3 volumio[1334]: info: CoreStateMachine::stop Oct 11 20:56:54 roffe-mp3 volumio[1334]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 11 20:56:54 roffe-mp3 volumio[1334]: info: CorePlayQueue::clearPlayQueue Oct 11 20:56:54 roffe-mp3 volumio[1334]: info: CorePlayQueue::saveQueue Oct 11 20:56:54 roffe-mp3 volumio[1334]: info: CoreCommandRouter::volumioPushQueue Oct 11 20:56:54 roffe-mp3 volumio[1334]: info: CoreStateMachine::addQueueItems Oct 11 20:56:54 roffe-mp3 volumio[1334]: info: CorePlayQueue::addQueueItems Oct 11 20:56:54 roffe-mp3 volumio[1334]: info: Preload queue cleared Oct 11 20:56:54 roffe-mp3 volumio[1334]: info: Adding Item to queue: webeighties/2 Oct 11 20:56:54 roffe-mp3 volumio[1334]: info: Exploding uri webeighties/2 in service 80s80s Oct 11 20:56:54 roffe-mp3 volumio[1334]: info: [1791745014570] [80s80s] explodeUri: webeighties/2 Oct 11 20:56:54 roffe-mp3 volumio[1334]: info: CoreCommandRouter::volumioPushQueue Oct 11 20:56:54 roffe-mp3 volumio[1334]: info: CorePlayQueue::saveQueue Oct 11 20:56:54 roffe-mp3 volumio[1334]: info: CoreStateMachine::updateTrackBlock Oct 11 20:56:54 roffe-mp3 volumio[1334]: info: CorePlayQueue::getTrackBlock Oct 11 20:56:54 roffe-mp3 volumio[1334]: info: CoreCommandRouter::volumioPlay Oct 11 20:56:54 roffe-mp3 volumio[1334]: info: CoreStateMachine::play index 0 Oct 11 20:56:54 roffe-mp3 volumio[1334]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 11 20:56:54 roffe-mp3 volumio[1334]: info: CoreStateMachine::stop Oct 11 20:56:54 roffe-mp3 volumio[1334]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 11 20:56:54 roffe-mp3 volumio[1334]: info: CoreStateMachine::play index undefined Oct 11 20:56:54 roffe-mp3 volumio[1334]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 11 20:56:54 roffe-mp3 volumio[1334]: info: CorePlayQueue::getTrack 0 Oct 11 20:56:54 roffe-mp3 volumio[1334]: info: CoreStateMachine::startPlaybackTimer Oct 11 20:56:54 roffe-mp3 volumio[1334]: info: CorePlayQueue::getTrack 0 Oct 11 20:56:54 roffe-mp3 volumio[1334]: info: [1791745014576] [80s80s] clearAddPlayTrack url: http://streams.80s80s.de/love/mp3-192/volumio Oct 11 20:56:54 roffe-mp3 volumio[1334]: info: [1791745014576] [80s80s] getContentOfUrl started with url http://iris-80s80s.loverad.io/flow.json?station=85&count=2 Oct 11 20:56:54 roffe-mp3 volumio[1334]: info: [1791745014788] [80s80s] received new event containing 2 songs. Oct 11 20:56:54 roffe-mp3 volumio[1334]: verbose: ControllerMpd::sendMpdCommand stop Oct 11 20:56:54 roffe-mp3 volumio[1334]: info: sendMpdCommand stop took 0 milliseconds Oct 11 20:56:54 roffe-mp3 volumio[1334]: verbose: ControllerMpd::sendMpdCommand clear Oct 11 20:56:54 roffe-mp3 volumio[1334]: info: sendMpdCommand clear took 1 milliseconds Oct 11 20:56:54 roffe-mp3 volumio[1334]: verbose: ControllerMpd::sendMpdCommand consume 1 Oct 11 20:56:54 roffe-mp3 volumio[1334]: info: Oct 11 20:56:54 roffe-mp3 volumio[1334]: ---------------------------- MPD announces system playlist update Oct 11 20:56:54 roffe-mp3 volumio[1334]: info: Ignoring MPD Status Update Oct 11 20:56:54 roffe-mp3 volumio[1334]: info: Oct 11 20:56:54 roffe-mp3 volumio[1334]: ---------------------------- MPD announces state update: options Oct 11 20:56:54 roffe-mp3 volumio[1334]: info: sendMpdCommand consume 1 took 1 milliseconds Oct 11 20:56:54 roffe-mp3 volumio[1334]: info: ControllerMpd::getState Oct 11 20:56:54 roffe-mp3 volumio[1334]: verbose: ControllerMpd::sendMpdCommand status Oct 11 20:56:54 roffe-mp3 volumio[1334]: info: [1791745014792] [80s80s] adding url: http://streams.80s80s.de/love/mp3-192/volumio Oct 11 20:56:54 roffe-mp3 volumio[1334]: verbose: ControllerMpd::sendMpdCommand add "http://streams.80s80s.de/love/mp3-192/volumio" Oct 11 20:56:54 roffe-mp3 volumio[1334]: error: updateQueue error: null Oct 11 20:56:54 roffe-mp3 volumio[1334]: info: ------------------------------ 3ms Oct 11 20:56:54 roffe-mp3 volumio[1334]: info: sendMpdCommand status took 5 milliseconds Oct 11 20:56:54 roffe-mp3 volumio[1334]: verbose: ControllerMpd::parseState Oct 11 20:56:54 roffe-mp3 volumio[1334]: info: ControllerMpd::pushState Oct 11 20:56:54 roffe-mp3 volumio[1334]: info: CoreCommandRouter::servicePushState Oct 11 20:56:54 roffe-mp3 volumio[1334]: info: CoreStateMachine::pushState Oct 11 20:56:54 roffe-mp3 volumio[1334]: info: CorePlayQueue::getTrack 0 Oct 11 20:56:54 roffe-mp3 volumio[1334]: info: CoreCommandRouter::volumioPushState Oct 11 20:56:54 roffe-mp3 volumio[1334]: info: CorePlayQueue::getTrack 0 Oct 11 20:56:54 roffe-mp3 volumio[1334]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Oct 11 20:56:54 roffe-mp3 volumio5-onboarding[1595]: time=2026-10-11T20:56:54.802+02:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.86.20:49321 @ 0x2000ed0" state=STATUS_STOPPED positionMs=0 volume=100 Oct 11 20:56:54 roffe-mp3 volumio5-onboarding[1595]: time=2026-10-11T20:56:54.802+02:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.86.20:49321 @ 0x2000ed0" id=http://streams.80s80s.de/love/mp3-192/volumio title="80s80s Love" Oct 11 20:56:54 roffe-mp3 volumio[1334]: info: ------------------------------ 12ms Oct 11 20:56:54 roffe-mp3 volumio[1334]: info: Oct 11 20:56:54 roffe-mp3 volumio[1334]: ---------------------------- MPD announces system playlist update Oct 11 20:56:54 roffe-mp3 volumio[1334]: info: Ignoring MPD Status Update Oct 11 20:56:54 roffe-mp3 volumio[1334]: info: sendMpdCommand add "http://streams.80s80s.de/love/mp3-192/volumio" took 11 milliseconds Oct 11 20:56:54 roffe-mp3 volumio[1334]: verbose: ControllerMpd::sendMpdCommand play Oct 11 20:56:54 roffe-mp3 volumio[1334]: info: ------------------------------ 6ms Oct 11 20:56:54 roffe-mp3 volumio[1334]: info: sendMpdCommand play took 3 milliseconds Oct 11 20:56:54 roffe-mp3 volumio[1334]: info: [1791745014809] [80s80s] Pushing the next song state: Womack & Womack - Teardrops Oct 11 20:56:54 roffe-mp3 volumio[1334]: info: CorePlayQueue::getTrack 0 Oct 11 20:56:54 roffe-mp3 volumio[1334]: info: CoreCommandRouter::servicePushState Oct 11 20:56:54 roffe-mp3 volumio[1334]: info: CorePlayQueue::getTrack 0 Oct 11 20:56:54 roffe-mp3 volumio[1334]: verbose: STATE SERVICE {"status":"play","service":"80s80s","type":"track","trackType":"80s80s Radio","radioType":"80s80s","albumart":"https://is5-ssl.mzstatic.com/image/thumb/Music124/v4/9c/0b/19/9c0b1940-0130-12d3-0b36-17c415608164/source/600x600bb.jpg","name":"Womack & Womack - Teardrops","title":"Teardrops","artist":"80s80s Love","album":"","streaming":true,"disableUiControls":true,"duration":"288","seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Oct 11 20:56:54 roffe-mp3 volumio[1334]: verbose: CURRENT POSITION 0 Oct 11 20:56:54 roffe-mp3 volumio[1334]: info: CoreStateMachine::syncState stateService play Oct 11 20:56:54 roffe-mp3 volumio[1334]: info: CoreStateMachine::syncState currentStatus stop Oct 11 20:56:54 roffe-mp3 volumio[1334]: info: [1791745014810] [80s80s] PlayNextTrack API delay: 30 Oct 11 20:56:54 roffe-mp3 volumio[1334]: info: [1791745014816] [80s80s] Setting timer to: 288000 milliseconds. Oct 11 20:56:54 roffe-mp3 volumio[1334]: info: CorePlayQueue::getTrack 0 Oct 11 20:56:54 roffe-mp3 volumio[1334]: info: CorePlayQueue::getTrack 1 Oct 11 20:56:55 roffe-mp3 volumio[1334]: info: Oct 11 20:56:55 roffe-mp3 volumio[1334]: ---------------------------- MPD announces state update: player Oct 11 20:56:55 roffe-mp3 volumio[1334]: info: ControllerMpd::getState Oct 11 20:56:55 roffe-mp3 volumio[1334]: verbose: ControllerMpd::sendMpdCommand status Oct 11 20:56:55 roffe-mp3 volumio[1334]: info: Oct 11 20:56:55 roffe-mp3 volumio[1334]: ---------------------------- MPD announces state update: player Oct 11 20:56:55 roffe-mp3 volumio[1334]: error: MPD returned error for command status: Failed to open "alsa" (alsa); Failed to open ALSA device "volumio": No such device Oct 11 20:56:55 roffe-mp3 volumio[1334]: verbose: ControllerMpd::sendMpdCommand clearerror Oct 11 20:56:55 roffe-mp3 volumio[1334]: info: sendMpdCommand status took 3 milliseconds Oct 11 20:56:55 roffe-mp3 volumio[1334]: info: ControllerMpd::getState Oct 11 20:56:55 roffe-mp3 volumio[1334]: verbose: ControllerMpd::sendMpdCommand status Oct 11 20:56:55 roffe-mp3 volumio[1334]: verbose: ControllerMpd::parseState Oct 11 20:56:55 roffe-mp3 volumio[1334]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 20:56:55 roffe-mp3 volumio[1334]: info: sendMpdCommand clearerror took 1 milliseconds Oct 11 20:56:55 roffe-mp3 volumio[1334]: info: sendMpdCommand status took 0 milliseconds Oct 11 20:56:55 roffe-mp3 volumio[1334]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 11 20:56:55 roffe-mp3 volumio[1334]: verbose: ControllerMpd::parseState Oct 11 20:56:55 roffe-mp3 volumio[1334]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 11 20:56:55 roffe-mp3 volumio[1334]: verbose: ControllerMpd::parseTrackInfo Oct 11 20:56:55 roffe-mp3 volumio[1334]: info: ControllerMpd::pushState Oct 11 20:56:55 roffe-mp3 volumio[1334]: info: CoreCommandRouter::servicePushState Oct 11 20:56:55 roffe-mp3 volumio[1334]: info: CorePlayQueue::getTrack 0 Oct 11 20:56:55 roffe-mp3 volumio[1334]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Oct 11 20:56:55 roffe-mp3 volumio[1334]: info: ------------------------------ 7ms Oct 11 20:56:55 roffe-mp3 volumio[1334]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 11 20:56:55 roffe-mp3 volumio[1334]: verbose: ControllerMpd::parseTrackInfo Oct 11 20:56:55 roffe-mp3 volumio[1334]: info: ControllerMpd::pushState Oct 11 20:56:55 roffe-mp3 volumio[1334]: info: CoreCommandRouter::servicePushState Oct 11 20:56:55 roffe-mp3 volumio[1334]: info: CorePlayQueue::getTrack 0 Oct 11 20:56:55 roffe-mp3 volumio[1334]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current 80s80s Received mpd Oct 11 20:56:55 roffe-mp3 volumio[1334]: info: ------------------------------ 8ms Oct 11 20:56:55 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 11 20:57:03 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 11 20:57:03 roffe-mp3 volumio[1334]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Oct 11 20:57:03 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Oct 11 20:57:03 roffe-mp3 volumio[1334]: info: Received Get System Version Oct 11 20:57:03 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 11 20:57:03 roffe-mp3 volumio[1334]: info: Received Get System Info Oct 11 20:57:03 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 11 20:57:03 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 11 20:57:03 roffe-mp3 volumio[1334]: info: Discovery: Getting this device information Oct 11 20:57:03 roffe-mp3 volumio[1334]: info: CoreCommandRouter::volumioGetState Oct 11 20:57:03 roffe-mp3 volumio[1334]: info: CorePlayQueue::getTrack 0 Oct 11 20:57:03 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 11 20:57:03 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: 80s80s , handleBrowseUri Oct 11 20:57:03 roffe-mp3 volumio[1334]: info: [1791745023695] [80s80s] handleBrowseUri curUri: 80s80s/nineties Oct 11 20:57:03 roffe-mp3 volumio[1334]: info: [1791745023696] [80s80s] getRadioContent url: nineties Oct 11 20:57:03 roffe-mp3 volumio[1334]: info: Preload queue cleared Oct 11 20:57:04 roffe-mp3 volumio[1334]: info: Preload queue cleared Oct 11 20:57:04 roffe-mp3 volumio[1334]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 11 20:57:04 roffe-mp3 volumio[1334]: info: CoreStateMachine::ClearQueue Oct 11 20:57:04 roffe-mp3 volumio[1334]: info: CoreStateMachine::stop Oct 11 20:57:04 roffe-mp3 volumio[1334]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 11 20:57:04 roffe-mp3 volumio[1334]: info: CoreStateMachine::stPlaybackTimer Oct 11 20:57:04 roffe-mp3 volumio[1334]: info: CoreStateMachine::updateTrackBlock Oct 11 20:57:04 roffe-mp3 volumio[1334]: info: CorePlayQueue::getTrackBlock Oct 11 20:57:04 roffe-mp3 volumio[1334]: info: CoreStateMachine::pushState Oct 11 20:57:04 roffe-mp3 volumio[1334]: info: CorePlayQueue::getTrack 0 Oct 11 20:57:04 roffe-mp3 volumio[1334]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 11 20:57:04 roffe-mp3 volumio[1334]: info: CoreCommandRouter::volumioPushState Oct 11 20:57:04 roffe-mp3 volumio[1334]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 11 20:57:04 roffe-mp3 volumio[1334]: Error: Failed to convert napi value String into rust type `f64` on TimelineInfo.duration Oct 11 20:57:04 roffe-mp3 volumio[1334]: at FerrumStreamingControlTechnology.updateStateOnPlayer (/data/plugins/user_interface/ferrum_streaming_control_technology/index.js:72:12) Oct 11 20:57:04 roffe-mp3 volumio[1334]: at FerrumStreamingControlTechnology.pushState (/data/plugins/user_interface/ferrum_streaming_control_technology/index.js:182:10) Oct 11 20:57:04 roffe-mp3 volumio[1334]: at /volumio/app/index.js:326:81 Oct 11 20:57:04 roffe-mp3 volumio[1334]: at fastMap (/volumio/node_modules/fast.js/array/map.js:21:17) Oct 11 20:57:04 roffe-mp3 volumio[1334]: at Function.fastMap [as map] (/volumio/node_modules/fast.js/map.js:18:12) Oct 11 20:57:04 roffe-mp3 volumio[1334]: at CoreCommandRouter.volumioPushState (/volumio/app/index.js:324:13) Oct 11 20:57:04 roffe-mp3 volumio[1334]: at CoreStateMachine.pushState (/volumio/app/statemachine.js:534:22) Oct 11 20:57:04 roffe-mp3 volumio[1334]: at CoreStateMachine.stop (/volumio/app/statemachine.js:1247:12) Oct 11 20:57:04 roffe-mp3 volumio[1334]: at CoreStateMachine.clearQueue (/volumio/app/statemachine.js:277:8) Oct 11 20:57:04 roffe-mp3 volumio[1334]: at CoreCommandRouter.replaceAndPlay (/volumio/app/index.js:494:21) Oct 11 20:57:04 roffe-mp3 volumio[1334]: at CoreCommandRouter.playItemsList (/volumio/app/index.js:484:17) Oct 11 20:57:04 roffe-mp3 volumio[1334]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:142:33) Oct 11 20:57:04 roffe-mp3 volumio[1334]: at Socket.emit (node:events:514:28) Oct 11 20:57:04 roffe-mp3 volumio[1334]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Oct 11 20:57:04 roffe-mp3 volumio[1334]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) { Oct 11 20:57:04 roffe-mp3 volumio[1334]: code: 'NumberExpected' Oct 11 20:57:04 roffe-mp3 volumio[1334]: } Oct 11 20:57:04 roffe-mp3 volumio[1334]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 11 20:57:05 roffe-mp3 sudo[2342]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-11 20:56' Oct 11 20:57:05 roffe-mp3 sudo[2342]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:20:52 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="d0c2fd9dbc5e70e58c32413c12353563"