Apr 12 12:04:03 volumio volumio[1383]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Apr 12 12:04:03 volumio volumio[1383]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 12 12:04:03 volumio systemd[1]: systemd-timedated.service: Deactivated successfully. Apr 12 12:04:03 volumio volumio-remote-updater[846]: Test mode disabled Apr 12 12:04:03 volumio volumio-remote-updater[846]: Alpha mode disabled Apr 12 12:04:03 volumio volumio-remote-updater[846]: Alpha legacy test mode disabled Apr 12 12:04:03 volumio volumio[1383]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Apr 12 12:04:04 volumio volumio[1383]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Apr 12 12:04:04 volumio volumio[1383]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Apr 12 12:04:18 volumio sudo[4905]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 12 12:04:18 volumio sudo[4905]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 12:04:18 volumio sudo[4905]: pam_unix(sudo:session): session closed for user root Apr 12 12:04:18 volumio sudo[4907]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 12 12:04:18 volumio sudo[4907]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 12:04:18 volumio sudo[4907]: pam_unix(sudo:session): session closed for user root Apr 12 12:04:18 volumio volumio[1383]: verbose: New Socket.io Connection to 192.168.1.10 from 192.168.1.13 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:149.0) Gecko/20100101 Firefox/149.0 Engine version: 3 Transport: polling Total Clients: 5 Apr 12 12:04:19 volumio volumio[1383]: info: CoreCommandRouter::volumioGetVisibleSources Apr 12 12:04:19 volumio volumio[1383]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 12 12:04:19 volumio volumio[1383]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps Apr 12 12:04:19 volumio volumio[1383]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode Apr 12 12:04:19 volumio volumio[1383]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages Apr 12 12:04:19 volumio volumio[1383]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones Apr 12 12:04:19 volumio volumio[1383]: info: Received Get System Info Apr 12 12:04:19 volumio volumio[1383]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 12 12:04:19 volumio volumio[1383]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 12 12:04:19 volumio volumio[1383]: info: Discovery: Getting this device information Apr 12 12:04:19 volumio volumio[1383]: info: CoreCommandRouter::volumioGetState Apr 12 12:04:19 volumio volumio[1383]: info: CorePlayQueue::getTrack 0 Apr 12 12:04:19 volumio volumio[1383]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 12 12:04:19 volumio volumio-remote-updater[846]: Test mode disabled Apr 12 12:04:19 volumio volumio-remote-updater[846]: Alpha mode disabled Apr 12 12:04:19 volumio volumio-remote-updater[846]: Alpha legacy test mode disabled Apr 12 12:04:19 volumio volumio[1383]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 12 12:04:19 volumio volumio[1383]: info: Retrieving Cloud Streaming UI Apr 12 12:04:19 volumio volumio[1383]: info: Getting Tidal Cloud Configuration Apr 12 12:04:19 volumio volumio[1383]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 12 12:04:19 volumio volumio[1383]: info: Getting Qobuz Cloud Configuration Apr 12 12:04:19 volumio volumio[1383]: info: Asking plugin for UI Config Apr 12 12:04:19 volumio volumio[1383]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 12 12:04:19 volumio volumio[1383]: info: Getting Spotify Cloud Configuration Apr 12 12:04:19 volumio volumio[1383]: info: Asking plugin for UI Config Apr 12 12:04:19 volumio volumio[1383]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 12 12:04:19 volumio volumio[1383]: info: Saving Spotify Acccount Apr 12 12:04:19 volumio volumio[1383]: info: Got Tidal Cloud Configuration Apr 12 12:04:19 volumio volumio[1383]: info: Got it Apr 12 12:04:19 volumio volumio[1383]: info: Got it Apr 12 12:04:19 volumio volumio[1383]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Apr 12 12:04:19 volumio volumio[1383]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 12 12:04:19 volumio volumio[1383]: error: Error retrieving Highresaudio conf: TypeError: Cannot read properties of undefined (reading 'onSave') Apr 12 12:04:19 volumio volumio[1383]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Apr 12 12:04:19 volumio volumio[1383]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Apr 12 12:04:20 volumio volumio[1383]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage Apr 12 12:04:20 volumio volumio[1383]: info: Loading i18n strings for locale tr Apr 12 12:04:20 volumio volumio[1383]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone Apr 12 12:04:20 volumio volumio[1383]: info: Setting timezone to Europe/Istanbul Apr 12 12:04:20 volumio sudo[4919]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime Apr 12 12:04:20 volumio sudo[4919]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 12:04:20 volumio sudo[4919]: pam_unix(sudo:session): session closed for user root Apr 12 12:04:20 volumio sudo[4923]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/Istanbul /etc/localtime Apr 12 12:04:20 volumio sudo[4923]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 12:04:20 volumio sudo[4923]: pam_unix(sudo:session): session closed for user root Apr 12 12:04:20 volumio sudo[4929]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime Apr 12 12:04:20 volumio sudo[4929]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 12:04:20 volumio sudo[4929]: pam_unix(sudo:session): session closed for user root Apr 12 12:04:20 volumio sudo[4935]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Istanbul Apr 12 12:04:20 volumio sudo[4935]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 12:04:20 volumio dbus-daemon[833]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.31' (uid=0 pid=4936 comm="/usr/bin/timedatectl set-timezone Europe/Istanbul") Apr 12 12:04:20 volumio systemd[1]: Starting systemd-timedated.service - Time & Date Service... Apr 12 12:04:20 volumio dbus-daemon[833]: [system] Successfully activated service 'org.freedesktop.timedate1' Apr 12 12:04:20 volumio systemd[1]: Started systemd-timedated.service - Time & Date Service. Apr 12 12:04:20 volumio sudo[4935]: pam_unix(sudo:session): session closed for user root Apr 12 12:04:20 volumio volumio[1383]: Updating browse sources language Apr 12 12:04:20 volumio volumio[1383]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 12 12:04:20 volumio volumio[1383]: info: Fetching Streaming Services browse cache Apr 12 12:04:21 volumio volumio[1383]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Apr 12 12:04:21 volumio volumio[1383]: info: MyVolumio login type: Token Apr 12 12:04:21 volumio volumio[1383]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 12 12:04:22 volumio volumio[1383]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Apr 12 12:04:22 volumio ntpd[1159]: PROTO: 185.226.92.106 unlink local addr 192.168.1.10 -> Apr 12 12:04:23 volumio volumio[1383]: info: MyVolumio token set successfully Apr 12 12:04:23 volumio volumio[1383]: info: MYVOLUMIO: Adding device Apr 12 12:04:23 volumio volumio[1383]: info: MYVOLUMIO: Evaluating Server Apr 12 12:04:23 volumio volumio[1383]: info: MyVolumio status changed Apr 12 12:04:23 volumio volumio[1383]: info: Streaming services startup Apr 12 12:04:23 volumio volumio[1383]: info: Starting Streaming Daemon Apr 12 12:04:23 volumio volumio[1383]: info: Removing browser output: myVolumio user plan is not superstar Apr 12 12:04:23 volumio volumio[1383]: info: Removing audio output: Apr 12 12:04:23 volumio volumio[1383]: info: Stoppping Tunnel 1 Apr 12 12:04:23 volumio sudo[4961]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Apr 12 12:04:23 volumio sudo[4961]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 12:04:23 volumio sudo[4963]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Apr 12 12:04:23 volumio sudo[4963]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 12:04:23 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Apr 12 12:04:23 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Apr 12 12:04:23 volumio sudo[4961]: pam_unix(sudo:session): session closed for user root Apr 12 12:04:23 volumio volumio[1383]: error: Cannot start Volumio Streaming Daemon Apr 12 12:04:23 volumio volumio[1383]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Apr 12 12:04:23 volumio volumio[1383]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Apr 12 12:04:23 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Apr 12 12:04:23 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Apr 12 12:04:23 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Apr 12 12:04:23 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Apr 12 12:04:23 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Apr 12 12:04:23 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Apr 12 12:04:23 volumio sudo[4963]: pam_unix(sudo:session): session closed for user root Apr 12 12:04:23 volumio volumio[1383]: info: Remote SSH Stopped Apr 12 12:04:23 volumio volumio[1383]: info: Setting Geolocation for MyVolumio to eu11 Apr 12 12:04:23 volumio volumio[1383]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 12 12:04:23 volumio volumio[1383]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 12 12:04:23 volumio volumio[1383]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 12 12:04:24 volumio volumio[1383]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Apr 12 12:04:24 volumio volumio[1383]: info: Updating MyVolumio device info Apr 12 12:04:24 volumio volumio[1383]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 12 12:04:24 volumio volumio[1383]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 12 12:04:24 volumio volumio[1383]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 12 12:04:25 volumio volumio[1383]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Apr 12 12:04:28 volumio volumio[1383]: info: MYVOLUMIO: Adding device Apr 12 12:04:28 volumio volumio[1383]: info: MYVOLUMIO: Evaluating Server Apr 12 12:04:28 volumio volumio[1383]: info: Setting Geolocation for MyVolumio to eu11 Apr 12 12:04:28 volumio volumio[1383]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 12 12:04:28 volumio volumio[1383]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 12 12:04:28 volumio volumio[1383]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 12 12:04:29 volumio volumio[1383]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Apr 12 12:04:29 volumio volumio[1383]: info: Updating MyVolumio device info Apr 12 12:04:29 volumio volumio[1383]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 12 12:04:29 volumio volumio[1383]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 12 12:04:29 volumio volumio[1383]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 12 12:04:30 volumio volumio[1383]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Apr 12 12:04:32 volumio systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Apr 12 12:04:33 volumio systemd[1]: setdatetime-helper.service: Deactivated successfully. Apr 12 12:04:33 volumio systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Apr 12 12:04:35 volumio volumio[1383]: info: CoreCommandRouter::executeOnPlugin: system , saveGeneralSettings Apr 12 12:04:35 volumio volumio[1383]: info: System name has changed, restarting Shairport Sync Apr 12 12:04:35 volumio volumio[1383]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 12:04:35 volumio volumio[1383]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 12 12:04:35 volumio volumio[1383]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 12 12:04:35 volumio volumio[1383]: info: Updating MyVolumio device info Apr 12 12:04:35 volumio volumio[1383]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 12 12:04:35 volumio volumio[1383]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 12 12:04:35 volumio volumio[1383]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 12 12:04:35 volumio volumio[1383]: info: Discovery: Restarting Advertising Apr 12 12:04:35 volumio volumio[1383]: info: Discovery: Stopping existing advertisement Apr 12 12:04:35 volumio volumio[1383]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAudioDevices Apr 12 12:04:35 volumio sudo[5043]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/killall upmpdcli Apr 12 12:04:35 volumio sudo[5043]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 12:04:35 volumio volumio[1383]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Apr 12 12:04:36 volumio volumio[1383]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 12 12:04:36 volumio volumio[1383]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 12 12:04:36 volumio sudo[5043]: pam_unix(sudo:session): session closed for user root Apr 12 12:04:36 volumio volumio[1383]: info: Received Get System Info Apr 12 12:04:36 volumio volumio[1383]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 12 12:04:36 volumio volumio[1383]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 12 12:04:36 volumio volumio[1383]: info: Discovery: Getting this device information Apr 12 12:04:36 volumio volumio[1383]: info: CoreCommandRouter::volumioGetState Apr 12 12:04:36 volumio volumio[1383]: info: CorePlayQueue::getTrack 0 Apr 12 12:04:36 volumio volumio[1383]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 12 12:04:36 volumio volumio[1383]: info: Received Get System Info Apr 12 12:04:36 volumio volumio[1383]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 12 12:04:36 volumio volumio[1383]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 12 12:04:36 volumio volumio[1383]: info: Discovery: Getting this device information Apr 12 12:04:36 volumio volumio[1383]: info: CoreCommandRouter::volumioGetState Apr 12 12:04:36 volumio volumio[1383]: info: CorePlayQueue::getTrack 0 Apr 12 12:04:36 volumio volumio[1383]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 12 12:04:36 volumio volumio[1383]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 12 12:04:36 volumio volumio[1383]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 12 12:04:36 volumio volumio[1383]: info: Starting Shairport Sync Apr 12 12:04:36 volumio volumio5-onboarding[1804]: time=2026-04-12T09:04:36.026Z level=INFO msg="device name changed, resetting service group" component=discovery/localnet Apr 12 12:04:36 volumio sudo[5051]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/hosts Apr 12 12:04:36 volumio sudo[5051]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 12:04:36 volumio sudo[5053]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 12 12:04:36 volumio sudo[5053]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 12:04:36 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Apr 12 12:04:36 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Apr 12 12:04:36 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Apr 12 12:04:36 volumio systemd[1]: shairport-sync.service: Consumed 4.878s CPU time. Apr 12 12:04:36 volumio sudo[5051]: pam_unix(sudo:session): session closed for user root Apr 12 12:04:36 volumio volumio[1383]: info: Permissions for /etc/hosts set Apr 12 12:04:36 volumio volumio[1383]: info: Hostname now is volumiopi Apr 12 12:04:36 volumio sudo[5060]: volumio : unable to resolve host volumio: System error Apr 12 12:04:36 volumio sudo[5058]: volumio : unable to resolve host volumio: System error Apr 12 12:04:36 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Apr 12 12:04:36 volumio sudo[5060]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /etc/avahi/services/ Apr 12 12:04:36 volumio sudo[5058]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/hostname volumiopi Apr 12 12:04:36 volumio sudo[5058]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 12:04:36 volumio sudo[5060]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 12:04:36 volumiopi sudo[5058]: pam_unix(sudo:session): session closed for user root Apr 12 12:04:36 volumiopi sudo[5053]: pam_unix(sudo:session): session closed for user root Apr 12 12:04:36 volumiopi volumio[1383]: info: New hostname set Apr 12 12:04:36 volumiopi volumio[1383]: info: Shairport-Sync Started Apr 12 12:04:36 volumiopi sudo[5060]: pam_unix(sudo:session): session closed for user root Apr 12 12:04:36 volumiopi volumio[1383]: info: Permissions for /etc/avahi/services/volumio.service Apr 12 12:04:36 volumiopi avahi-daemon[831]: Files changed, reloading. Apr 12 12:04:36 volumiopi volumio[1383]: info: Avahi name changed to volumiopi Apr 12 12:04:36 volumiopi avahi-daemon[831]: Loading service file /services/volumio.service. Apr 12 12:04:36 volumiopi systemd[1]: upmpdcli.service: Deactivated successfully. Apr 12 12:04:36 volumiopi systemd[1]: upmpdcli.service: Consumed 12.080s CPU time. Apr 12 12:04:36 volumiopi volumio[1383]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Apr 12 12:04:36 volumiopi volumio[1383]: info: Discovery: A device disappeared from network Apr 12 12:04:36 volumiopi volumio[1383]: info: Discovery: A device disappeared from network Apr 12 12:04:36 volumiopi volumio[1383]: info: Discovery: A device disappeared from network Apr 12 12:04:36 volumiopi volumio[1383]: info: Discovery: A device disappeared from network Apr 12 12:04:37 volumiopi avahi-daemon[831]: Service "Volumiopi" (/services/volumio.service) successfully established. Apr 12 12:04:37 volumiopi volumio5-onboarding[1804]: time=2026-04-12T09:04:37.897Z level=INFO msg="service successfully established" component=discovery/localnet Apr 12 12:04:40 volumiopi volumio[1383]: info: Discovery: Started advertising with name: Volumiopi Apr 12 12:04:41 volumiopi volumio[1383]: info: Discovery: adding bd8ca449-3a08-4e57-b1c6-d82f8b5d380a Apr 12 12:04:41 volumiopi volumio[1383]: info: Discovery: Found device Volumiopi Apr 12 12:04:41 volumiopi volumio[1383]: info: CoreCommandRouter::volumioGetState Apr 12 12:04:41 volumiopi volumio[1383]: info: CorePlayQueue::getTrack 0 Apr 12 12:04:41 volumiopi volumio[1383]: info: Discovery: this is already registered, bd8ca449-3a08-4e57-b1c6-d82f8b5d380a Apr 12 12:04:41 volumiopi volumio[1383]: info: Discovery: Found device Volumiopi Apr 12 12:04:41 volumiopi volumio[1383]: info: CoreCommandRouter::volumioGetState Apr 12 12:04:41 volumiopi volumio[1383]: info: CorePlayQueue::getTrack 0 Apr 12 12:04:41 volumiopi volumio[1383]: info: Discovery: this is already registered, bd8ca449-3a08-4e57-b1c6-d82f8b5d380a Apr 12 12:04:41 volumiopi volumio[1383]: info: Discovery: Found device Volumiopi Apr 12 12:04:41 volumiopi volumio[1383]: info: CoreCommandRouter::volumioGetState Apr 12 12:04:41 volumiopi volumio[1383]: info: CorePlayQueue::getTrack 0 Apr 12 12:04:41 volumiopi volumio[1383]: info: Discovery: this is already registered, bd8ca449-3a08-4e57-b1c6-d82f8b5d380a Apr 12 12:04:41 volumiopi volumio[1383]: info: Discovery: Found device Volumiopi Apr 12 12:04:41 volumiopi volumio[1383]: info: CoreCommandRouter::volumioGetState Apr 12 12:04:41 volumiopi volumio[1383]: info: CorePlayQueue::getTrack 0 Apr 12 12:04:43 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Apr 12 12:04:43 volumiopi volumio[1383]: info: Preparing to save Alsa Options, stopping services first Apr 12 12:04:43 volumiopi volumio[1383]: info: CoreCommandRouter::volumioGetState Apr 12 12:04:43 volumiopi volumio[1383]: info: CorePlayQueue::getTrack 0 Apr 12 12:04:43 volumiopi volumio[1383]: info: CoreCommandRouter::volumioPause Apr 12 12:04:43 volumiopi volumio[1383]: info: CoreStateMachine::pause Apr 12 12:04:43 volumiopi volumio[1383]: info: Saving Audio Output to: {"i2s":false,"output_device":{"value":"0","label":"HDMI Out"},"disallowPush":true} Apr 12 12:04:43 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 12 12:04:43 volumiopi volumio[1383]: info: Enabling PI HDMI Output Apr 12 12:04:43 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 12 12:04:43 volumiopi volumio[1383]: info: Found match in Cards Database: setting mixer PCM for card HDMI Out Apr 12 12:04:43 volumiopi volumio[1383]: info: CoreCommandRouter::volumioUpdateVolumeSettings Apr 12 12:04:43 volumiopi volumio[1383]: info: Updating Volume Controller Parameters: Device: 0 Name: HDMI Out Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Apr 12 12:04:43 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Apr 12 12:04:43 volumiopi volumio[1383]: info: Disabling external Volume Control Apr 12 12:04:43 volumiopi volumio[1383]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 12 12:04:43 volumiopi volumio[1383]: info: Preparing to generate the ALSA configuration file Apr 12 12:04:43 volumiopi volumio[1383]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 12 12:04:43 volumiopi volumio[1383]: info: Retrieving Cloud Streaming UI Apr 12 12:04:43 volumiopi volumio[1383]: info: Raspberry PI HDMI Output Enabled Apr 12 12:04:43 volumiopi volumio[1383]: info: VolumeController:: Volume=86 Mute =false Apr 12 12:04:43 volumiopi volumio[1383]: info: CoreStateMachine::pushState Apr 12 12:04:43 volumiopi volumio[1383]: info: CorePlayQueue::getTrack 0 Apr 12 12:04:43 volumiopi volumio[1383]: info: CoreCommandRouter::volumioPushState Apr 12 12:04:43 volumiopi sudo[5100]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/sbin/alsactl store Apr 12 12:04:43 volumiopi sudo[5100]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 12:04:43 volumiopi volumio[1383]: info: Asound.conf file unchanged, so no further update is needed Apr 12 12:04:43 volumiopi volumio[1383]: info: Output device has changed, restarting MPD Apr 12 12:04:43 volumiopi volumio[1383]: info: Output device has changed, restarting Shairport Sync Apr 12 12:04:43 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 12:04:43 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 12 12:04:43 volumiopi sudo[5105]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 12 12:04:43 volumiopi sudo[5105]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 12:04:43 volumiopi sudo[5104]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 12 12:04:43 volumiopi sudo[5104]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 12:04:43 volumiopi sudo[5104]: pam_unix(sudo:session): session closed for user root Apr 12 12:04:43 volumiopi systemd[1]: Stopping mpd.service - Music Player Daemon... Apr 12 12:04:43 volumiopi volumio[1383]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 12 12:04:43 volumiopi sudo[5100]: pam_unix(sudo:session): session closed for user root Apr 12 12:04:43 volumiopi volumio[1383]: info: Getting Tidal Cloud Configuration Apr 12 12:04:43 volumiopi volumio[1383]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 12 12:04:43 volumiopi volumio[1383]: info: Getting Qobuz Cloud Configuration Apr 12 12:04:43 volumiopi volumio[1383]: info: Asking plugin for UI Config Apr 12 12:04:43 volumiopi volumio[1383]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 12 12:04:43 volumiopi volumio[1383]: info: Getting Spotify Cloud Configuration Apr 12 12:04:43 volumiopi volumio[1383]: info: Asking plugin for UI Config Apr 12 12:04:43 volumiopi volumio[1383]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 12 12:04:43 volumiopi volumio[1383]: info: Saving Spotify Acccount Apr 12 12:04:43 volumiopi volumio[1383]: info: Got Tidal Cloud Configuration Apr 12 12:04:43 volumiopi volumio[1383]: info: Got it Apr 12 12:04:43 volumiopi volumio[1383]: info: Got it Apr 12 12:04:43 volumiopi volumio[1383]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Apr 12 12:04:43 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Apr 12 12:04:43 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 12 12:04:43 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 12 12:04:43 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 12 12:04:43 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 12 12:04:43 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 12 12:04:43 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 12 12:04:43 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 12 12:04:43 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 12 12:04:43 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 12 12:04:43 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Apr 12 12:04:43 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 12 12:04:43 volumiopi volumio[1383]: info: MPD Permissions set Apr 12 12:04:43 volumiopi volumio[1383]: info: Alsa Settings successfully stored Apr 12 12:04:43 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 12:04:43 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 12:04:43 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 12:04:43 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 12:04:43 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 12:04:43 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 12:04:43 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 12:04:43 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 12:04:43 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 12 12:04:43 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 12:04:43 volumiopi volumio[1383]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 12 12:04:43 volumiopi volumio[1383]: error: Error retrieving Highresaudio conf: TypeError: Cannot read properties of undefined (reading 'onSave') Apr 12 12:04:43 volumiopi volumio[1383]: info: Starting Shairport Sync Apr 12 12:04:43 volumiopi sudo[5127]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 12 12:04:43 volumiopi sudo[5127]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 12:04:43 volumiopi systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Apr 12 12:04:43 volumiopi systemd[1]: shairport-sync.service: Deactivated successfully. Apr 12 12:04:43 volumiopi systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Apr 12 12:04:43 volumiopi systemd[1]: shairport-sync.service: Consumed 1.545s CPU time. Apr 12 12:04:43 volumiopi systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Apr 12 12:04:43 volumiopi sudo[5127]: pam_unix(sudo:session): session closed for user root Apr 12 12:04:43 volumiopi volumio[1383]: info: Shairport-Sync Started Apr 12 12:04:43 volumiopi systemd[1]: mpd.service: Deactivated successfully. Apr 12 12:04:43 volumiopi systemd[1]: Stopped mpd.service - Music Player Daemon. Apr 12 12:04:43 volumiopi systemd[1]: mpd.service: Consumed 2.524s CPU time. Apr 12 12:04:43 volumiopi systemd[1]: mpd.socket: Deactivated successfully. Apr 12 12:04:43 volumiopi systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Apr 12 12:04:43 volumiopi systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Apr 12 12:04:43 volumiopi systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Apr 12 12:04:43 volumiopi systemd[1]: Starting mpd.service - Music Player Daemon... Apr 12 12:04:43 volumiopi sudo[5145]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 12 12:04:43 volumiopi sudo[5145]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Apr 12 12:04:43 volumiopi sudo[5145]: pam_unix(sudo:session): session closed for user root Apr 12 12:04:45 volumiopi mpd[5147]: 2026-04-12T12:04:45 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 12 12:04:45 volumiopi systemd[1]: Started mpd.service - Music Player Daemon. Apr 12 12:04:45 volumiopi sudo[5105]: pam_unix(sudo:session): session closed for user root Apr 12 12:04:45 volumiopi volumio[1383]: error: updateQueue error: null Apr 12 12:04:45 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonation Apr 12 12:04:45 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware Apr 12 12:04:45 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonationsArray Apr 12 12:04:45 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: wizard , getDoneMessage Apr 12 12:04:45 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware Apr 12 12:04:45 volumiopi sudo[5174]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/samba/smb.conf Apr 12 12:04:45 volumiopi sudo[5174]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 12:04:45 volumiopi sudo[5176]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /data/INTERNAL Apr 12 12:04:45 volumiopi sudo[5176]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 12:04:46 volumiopi sudo[5180]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 12 12:04:46 volumiopi sudo[5180]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 12:04:46 volumiopi sudo[5180]: pam_unix(sudo:session): session closed for user root Apr 12 12:04:46 volumiopi sudo[5182]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 12 12:04:46 volumiopi sudo[5182]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 12:04:46 volumiopi sudo[5182]: pam_unix(sudo:session): session closed for user root Apr 12 12:04:46 volumiopi sudo[5176]: pam_unix(sudo:session): session closed for user root Apr 12 12:04:46 volumiopi volumio[1383]: info: Internal perms successfully set Apr 12 12:04:46 volumiopi sudo[5185]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Apr 12 12:04:46 volumiopi sudo[5185]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 12:04:46 volumiopi sudo[5174]: pam_unix(sudo:session): session closed for user root Apr 12 12:04:46 volumiopi volumio[1383]: info: smb.conf Permissions set Apr 12 12:04:46 volumiopi sudo[5189]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart nmbd.service Apr 12 12:04:46 volumiopi sudo[5189]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 12:04:46 volumiopi nmbd[1265]: [2026/04/12 12:04:46.110596, 0] ../../source3/nmbd/nmbd.c:59(terminate) Apr 12 12:04:46 volumiopi nmbd[1265]: Got SIGTERM: going down... Apr 12 12:04:46 volumiopi systemd[1]: Stopping nmbd.service - Samba NMB Daemon... Apr 12 12:04:46 volumiopi systemd[1]: nmbd.service: Deactivated successfully. Apr 12 12:04:46 volumiopi systemd[1]: Stopped nmbd.service - Samba NMB Daemon. Apr 12 12:04:46 volumiopi systemd[1]: Starting nmbd.service - Samba NMB Daemon... Apr 12 12:04:46 volumiopi nmbd[5195]: [2026/04/12 12:04:46.366269, 0] ../../source3/nmbd/nmbd.c:901(main) Apr 12 12:04:46 volumiopi nmbd[5195]: nmbd version 4.17.8-Raspbian started. Apr 12 12:04:46 volumiopi nmbd[5195]: Copyright Andrew Tridgell and the Samba Team 1992-2022 Apr 12 12:04:46 volumiopi nmbd[5195]: [2026/04/12 12:04:46.369181, 0] ../../source3/nmbd/asyncdns.c:158(start_async_dns) Apr 12 12:04:46 volumiopi nmbd[5195]: started asyncdns process 5196 Apr 12 12:04:46 volumiopi systemd[1]: Started nmbd.service - Samba NMB Daemon. Apr 12 12:04:46 volumiopi sudo[5189]: pam_unix(sudo:session): session closed for user root Apr 12 12:04:46 volumiopi sudo[5198]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart smbd.service Apr 12 12:04:46 volumiopi sudo[5198]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 12:04:46 volumiopi systemd[1]: Stopping smbd.service - Samba SMB Daemon... Apr 12 12:04:46 volumiopi systemd[1]: smbd.service: Deactivated successfully. Apr 12 12:04:46 volumiopi systemd[1]: Stopped smbd.service - Samba SMB Daemon. Apr 12 12:04:46 volumiopi systemd[1]: Starting smbd.service - Samba SMB Daemon... Apr 12 12:04:46 volumiopi smbd[5203]: [2026/04/12 12:04:46.647315, 0] ../../source3/smbd/server.c:1741(main) Apr 12 12:04:46 volumiopi smbd[5203]: smbd version 4.17.8-Raspbian started. Apr 12 12:04:46 volumiopi smbd[5203]: Copyright Andrew Tridgell and the Samba Team 1992-2022 Apr 12 12:04:46 volumiopi systemd[1]: Started smbd.service - Samba SMB Daemon. Apr 12 12:04:46 volumiopi sudo[5198]: pam_unix(sudo:session): session closed for user root Apr 12 12:04:46 volumiopi volumio[1383]: info: SAMBA Restarted Apr 12 12:04:47 volumiopi volumio[1383]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Apr 12 12:04:47 volumiopi volumio[1383]: info: CoreStateMachine::getcurrentVolume Apr 12 12:04:47 volumiopi volumio[1383]: info: CoreCommandRouter::volumioRetrievevolume Apr 12 12:04:47 volumiopi volumio[1383]: info: VolumeController:: Volume=86 Mute =false Apr 12 12:04:47 volumiopi volumio[1383]: info: CoreStateMachine::pushState Apr 12 12:04:47 volumiopi volumio[1383]: info: CorePlayQueue::getTrack 0 Apr 12 12:04:47 volumiopi volumio[1383]: info: CoreCommandRouter::volumioPushState Apr 12 12:04:47 volumiopi volumio[1383]: info: CoreStateMachine::updateTrackBlock Apr 12 12:04:47 volumiopi volumio[1383]: info: CorePlayQueue::getTrackBlock Apr 12 12:04:47 volumiopi volumio[1383]: info: CoreCommandRouter::volumioRetrievevolume Apr 12 12:04:47 volumiopi volumio[1383]: info: VolumeController:: Volume=86 Mute =false Apr 12 12:04:47 volumiopi volumio[1383]: info: CoreStateMachine::pushState Apr 12 12:04:47 volumiopi volumio[1383]: info: CorePlayQueue::getTrack 0 Apr 12 12:04:47 volumiopi volumio[1383]: info: CoreCommandRouter::volumioPushState Apr 12 12:04:49 volumiopi volumio[1383]: info: CALLMETHOD: system_controller system saveUpdateSettings [object Object] Apr 12 12:04:49 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: system , saveUpdateSettings Apr 12 12:04:49 volumiopi volumio[1383]: error: Failed callmethod call: TypeError: Cannot read properties of undefined (reading 'value') Apr 12 12:04:50 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule Apr 12 12:04:50 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 12 12:04:50 volumiopi systemd[1]: systemd-timedated.service: Deactivated successfully. Apr 12 12:04:50 volumiopi volumio-remote-updater[846]: Test mode disabled Apr 12 12:04:50 volumiopi volumio-remote-updater[846]: Alpha mode disabled Apr 12 12:04:50 volumiopi volumio-remote-updater[846]: Alpha legacy test mode disabled Apr 12 12:04:50 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Apr 12 12:04:50 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: wizard , setWizardAction Apr 12 12:04:50 volumiopi volumio[1383]: info: CoreCommandRouter::Reload Ui Apr 12 12:04:50 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: system , setShowWizard Apr 12 12:04:50 volumiopi volumio[1383]: info: Wizard terminated Successfully Apr 12 12:04:50 volumiopi volumio[1383]: info: CoreCommandRouter::volumiosetStartupVolume Apr 12 12:04:50 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 12:04:50 volumiopi volumio[1383]: info: Received Get System Info Apr 12 12:04:50 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 12 12:04:50 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 12 12:04:50 volumiopi volumio[1383]: info: Discovery: Getting this device information Apr 12 12:04:50 volumiopi volumio[1383]: info: CoreCommandRouter::volumioGetState Apr 12 12:04:50 volumiopi volumio[1383]: info: CorePlayQueue::getTrack 0 Apr 12 12:04:50 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 12 12:04:50 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 12 12:04:50 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 12 12:04:50 volumiopi volumio[1383]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Apr 12 12:04:50 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Apr 12 12:04:51 volumiopi systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 5. Apr 12 12:04:51 volumiopi systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Apr 12 12:04:51 volumiopi systemd[1]: upmpdcli.service: Consumed 12.080s CPU time. Apr 12 12:04:51 volumiopi systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Apr 12 12:04:51 volumiopi sudo[5185]: pam_unix(sudo:session): session closed for user root Apr 12 12:04:51 volumiopi volumio[1383]: info: Upmpdcli Daemon Started Apr 12 12:04:51 volumiopi upmpdcli[5236]: writing RSA key Apr 12 12:04:51 volumiopi volumio5-onboarding[1804]: time=2026-04-12T09:04:51.843Z level=INFO msg="service successfully established" component=discovery/localnet Apr 12 12:04:53 volumiopi sudo[5245]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 12 12:04:53 volumiopi sudo[5245]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 12:04:53 volumiopi sudo[5245]: pam_unix(sudo:session): session closed for user root Apr 12 12:04:53 volumiopi sudo[5247]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 12 12:04:53 volumiopi sudo[5247]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 12:04:53 volumiopi sudo[5247]: pam_unix(sudo:session): session closed for user root Apr 12 12:04:53 volumiopi volumio[1383]: verbose: New Socket.io Connection to 192.168.1.10 from 192.168.1.13 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:149.0) Gecko/20100101 Firefox/149.0 Engine version: 3 Transport: polling Total Clients: 5 Apr 12 12:04:53 volumiopi sudo[5251]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 12 12:04:53 volumiopi sudo[5251]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 12:04:53 volumiopi sudo[5251]: pam_unix(sudo:session): session closed for user root Apr 12 12:04:53 volumiopi sudo[5253]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 12 12:04:53 volumiopi sudo[5253]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Apr 12 12:04:53 volumiopi sudo[5253]: pam_unix(sudo:session): session closed for user root Apr 12 12:04:53 volumiopi volumio[1383]: verbose: New Socket.io Connection to 192.168.1.10 from 192.168.1.13 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:149.0) Gecko/20100101 Firefox/149.0 Engine version: 3 Transport: polling Total Clients: 5 Apr 12 12:04:53 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 12 12:04:53 volumiopi volumio[1383]: info: CoreCommandRouter::volumioGetVisibleSources Apr 12 12:04:53 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 12 12:04:53 volumiopi volumio[1383]: info: CoreCommandRouter::volumioGetState Apr 12 12:04:53 volumiopi volumio[1383]: info: CorePlayQueue::getTrack 0 Apr 12 12:04:53 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 12 12:04:53 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 12 12:04:53 volumiopi volumio[1383]: info: Received Get System Info Apr 12 12:04:53 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 12 12:04:53 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 12 12:04:53 volumiopi volumio[1383]: info: Discovery: Getting this device information Apr 12 12:04:53 volumiopi volumio[1383]: info: CoreCommandRouter::volumioGetState Apr 12 12:04:53 volumiopi volumio[1383]: info: CorePlayQueue::getTrack 0 Apr 12 12:04:53 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 12 12:04:53 volumiopi volumio[1383]: info: CoreCommandRouter::volumioGetState Apr 12 12:04:53 volumiopi volumio[1383]: info: CorePlayQueue::getTrack 0 Apr 12 12:04:53 volumiopi volumio[1383]: info: Listing playlists Apr 12 12:04:53 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Apr 12 12:04:53 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 12 12:04:53 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Apr 12 12:04:57 volumiopi volumio[1383]: info: CoreCommandRouter::volumioGetState Apr 12 12:04:57 volumiopi volumio[1383]: info: CorePlayQueue::getTrack 0 Apr 12 12:04:58 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Apr 12 12:04:58 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 12 12:04:58 volumiopi volumio[1383]: info: Received Get System Info Apr 12 12:04:58 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 12 12:04:58 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 12 12:04:58 volumiopi volumio[1383]: info: Discovery: Getting this device information Apr 12 12:04:58 volumiopi volumio[1383]: info: CoreCommandRouter::volumioGetState Apr 12 12:04:58 volumiopi volumio[1383]: info: CorePlayQueue::getTrack 0 Apr 12 12:04:58 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 12 12:04:59 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Apr 12 12:05:01 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 12 12:05:01 volumiopi volumio[1383]: info: Received Get System Info Apr 12 12:05:01 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 12 12:05:01 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 12 12:05:01 volumiopi volumio[1383]: info: Discovery: Getting this device information Apr 12 12:05:01 volumiopi volumio[1383]: info: CoreCommandRouter::volumioGetState Apr 12 12:05:01 volumiopi volumio[1383]: info: CorePlayQueue::getTrack 0 Apr 12 12:05:01 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 12 12:05:02 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 12 12:05:02 volumiopi volumio[1383]: info: Received Get System Info Apr 12 12:05:02 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 12 12:05:02 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 12 12:05:02 volumiopi volumio[1383]: info: Discovery: Getting this device information Apr 12 12:05:02 volumiopi volumio[1383]: info: CoreCommandRouter::volumioGetState Apr 12 12:05:02 volumiopi volumio[1383]: info: CorePlayQueue::getTrack 0 Apr 12 12:05:02 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 12 12:05:03 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 12 12:05:03 volumiopi volumio[1383]: info: Received Get System Info Apr 12 12:05:03 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 12 12:05:03 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 12 12:05:03 volumiopi volumio[1383]: info: Discovery: Getting this device information Apr 12 12:05:03 volumiopi volumio[1383]: info: CoreCommandRouter::volumioGetState Apr 12 12:05:03 volumiopi volumio[1383]: info: CorePlayQueue::getTrack 0 Apr 12 12:05:03 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 12 12:05:03 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Apr 12 12:05:11 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 12 12:05:11 volumiopi volumio[1383]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Apr 12 12:05:11 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Apr 12 12:05:11 volumiopi volumio[1383]: info: Received Get System Version Apr 12 12:05:11 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 12 12:05:11 volumiopi volumio[1383]: info: Received Get System Info Apr 12 12:05:11 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 12 12:05:11 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 12 12:05:11 volumiopi volumio[1383]: info: Discovery: Getting this device information Apr 12 12:05:11 volumiopi volumio[1383]: info: CoreCommandRouter::volumioGetState Apr 12 12:05:11 volumiopi volumio[1383]: info: CorePlayQueue::getTrack 0 Apr 12 12:05:11 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 12 12:05:12 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: wizard , setOnboardingWizardFalse Apr 12 12:05:13 volumiopi volumio[1383]: info: CoreCommandRouter::volumioPlay Apr 12 12:05:13 volumiopi volumio[1383]: info: CoreStateMachine::play index undefined Apr 12 12:05:13 volumiopi volumio[1383]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 12 12:05:13 volumiopi volumio[1383]: info: CorePlayQueue::getTrack 0 Apr 12 12:05:17 volumiopi volumio[1383]: info: CoreCommandRouter::volumioGetQueue Apr 12 12:05:17 volumiopi volumio[1383]: info: CoreStateMachine::getQueue Apr 12 12:05:17 volumiopi volumio[1383]: info: CorePlayQueue::getQueue Apr 12 12:05:20 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Apr 12 12:05:20 volumiopi volumio[1383]: info: Preload queue cleared Apr 12 12:05:22 volumiopi volumio[1383]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Apr 12 12:05:22 volumiopi volumio[1383]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 12 12:05:22 volumiopi volumio[1383]: Error Apr 12 12:05:22 volumiopi volumio[1383]: at /volumio/app/plugins/music_service/webradio/index.js:427:31 Apr 12 12:05:22 volumiopi volumio[1383]: at Request.handleRequestResponse [as _callback] (/volumio/node_modules/unirest/index.js:444:15) Apr 12 12:05:22 volumiopi volumio[1383]: at self.callback (/volumio/node_modules/request/request.js:185:22) Apr 12 12:05:22 volumiopi volumio[1383]: at Request.emit (node:events:514:28) Apr 12 12:05:22 volumiopi volumio[1383]: at Request.onRequestError (/volumio/node_modules/request/request.js:877:8) Apr 12 12:05:22 volumiopi volumio[1383]: at ClientRequest.emit (node:events:514:28) Apr 12 12:05:22 volumiopi volumio[1383]: at Socket.socketErrorListener (node:_http_client:495:9) Apr 12 12:05:22 volumiopi volumio[1383]: at Socket.emit (node:events:514:28) Apr 12 12:05:22 volumiopi volumio[1383]: at emitErrorNT (node:internal/streams/destroy:151:8) Apr 12 12:05:22 volumiopi volumio[1383]: at emitErrorCloseNT (node:internal/streams/destroy:116:3) Apr 12 12:05:22 volumiopi volumio[1383]: at process.processTicksAndRejections (node:internal/process/task_queues:82:21) Apr 12 12:05:22 volumiopi volumio[1383]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 12 12:05:23 volumiopi sudo[5319]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-04-12 12:04' Apr 12 12:05:23 volumiopi sudo[5319]: 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"