Aug 30 14:26:00 volumio mpd[1529]: 2026-08-30T11:26:00 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Aug 30 14:26:00 volumio mpd[1529]: 2026-08-30T11:26:00 exception: Database corrupted
Aug 30 14:26:00 volumio systemd[1]: Started mpd.service - Music Player Daemon.
Aug 30 14:26:00 volumio sudo[1477]: pam_unix(sudo:session): session closed for user root
Aug 30 14:26:00 volumio sudo[1492]: pam_unix(sudo:session): session closed for user root
Aug 30 14:26:00 volumio volumio-remote-updater[774]: [2026-08-30 11:26:00] [connect] Successful connection
Aug 30 14:26:00 volumio systemd[1]: systemd-fsckd.service: Deactivated successfully.
Aug 30 14:26:00 volumio volumio[1332]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 1
Aug 30 14:26:00 volumio volumio[1332]: info: Received Get System Info
Aug 30 14:26:00 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Aug 30 14:26:00 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Aug 30 14:26:00 volumio volumio[1332]: info: Discovery: Getting this device information
Aug 30 14:26:00 volumio volumio[1332]: info: CoreCommandRouter::volumioGetState
Aug 30 14:26:00 volumio volumio[1332]: info: CorePlayQueue::getTrack 0
Aug 30 14:26:00 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Aug 30 14:26:00 volumio volumio5-onboarding[1504]: time=2026-08-30T11:26:00.529Z level=INFO msg="system info for cdc07ba13966bc70bdc5273795e36c3c" deviceName=Volumio deviceVariant=volumio deviceModel= softwareVersion=4.119
Aug 30 14:26:00 volumio volumio5-onboarding[1504]: time=2026-08-30T11:26:00.537Z level=INFO msg="bootstrapping state" hasInternet=true
Aug 30 14:26:00 volumio volumio[1332]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2
Aug 30 14:26:00 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 14:26:00 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 14:26:00 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 14:26:00 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 14:26:00 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 14:26:00 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 14:26:00 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 14:26:00 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 14:26:00 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 30 14:26:00 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 14:26:00 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 14:26:00 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 14:26:00 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 14:26:00 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 14:26:00 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 14:26:00 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 14:26:00 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 14:26:00 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 14:26:01 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 30 14:26:01 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 14:26:01 volumio volumio[1332]: info: Received Get System Info
Aug 30 14:26:01 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Aug 30 14:26:01 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Aug 30 14:26:01 volumio volumio[1332]: info: Discovery: Getting this device information
Aug 30 14:26:01 volumio volumio[1332]: info: CoreCommandRouter::volumioGetState
Aug 30 14:26:01 volumio volumio[1332]: info: CorePlayQueue::getTrack 0
Aug 30 14:26:01 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Aug 30 14:26:01 volumio volumio[1332]: info: Completed starting Core Plugins
Aug 30 14:26:01 volumio volumio[1332]: info: -------------------------------------------
Aug 30 14:26:01 volumio volumio[1332]: info: ----- MyVolumio plugins startup ----
Aug 30 14:26:01 volumio volumio[1332]: info: -------------------------------------------
Aug 30 14:26:01 volumio volumio[1332]: info: [MyVolumio PluginManager] Fetching plans data....
Aug 30 14:26:01 volumio volumio[1332]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 3 Transport: websocket Total Clients: 3
Aug 30 14:26:01 volumio volumio-remote-updater[774]: [2026-08-30 11:26:01] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=3&transport=websocket&t=1788089160 101
Aug 30 14:26:01 volumio volumio[1332]: error: MPD error: The expression evaluated to a falsy value:
Aug 30 14:26:01 volumio volumio[1332]: assert.ok(self.idling)
Aug 30 14:26:01 volumio volumio[1332]: error: The expression evaluated to a falsy value:
Aug 30 14:26:01 volumio volumio[1332]: assert.ok(self.idling)
Aug 30 14:26:01 volumio volumio[1332]: info: MPD running with PID1529
Aug 30 14:26:01 volumio volumio[1332]: ,establishing connection
Aug 30 14:26:02 volumio volumio[1332]: info: Starting Shairport Sync
Aug 30 14:26:02 volumio volumio[1332]: info: Starting Shairport Sync
Aug 30 14:26:02 volumio sudo[1610]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Aug 30 14:26:02 volumio sudo[1610]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Aug 30 14:26:02 volumio volumio[1332]: info: Starting Shairport Sync
Aug 30 14:26:02 volumio volumio[1332]: error: updateQueue error: null
Aug 30 14:26:02 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver...
Aug 30 14:26:02 volumio systemd[1]: shairport-sync.service: Deactivated successfully.
Aug 30 14:26:02 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
Aug 30 14:26:02 volumio systemd[1]: shairport-sync.service: Consumed 1.641s CPU time.
Aug 30 14:26:02 volumio sudo[1615]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Aug 30 14:26:02 volumio sudo[1615]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Aug 30 14:26:02 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
Aug 30 14:26:02 volumio sudo[1612]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Aug 30 14:26:02 volumio sudo[1612]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Aug 30 14:26:02 volumio volumio[1332]: error: updateQueue error: null
Aug 30 14:26:02 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver...
Aug 30 14:26:02 volumio systemd[1]: shairport-sync.service: Deactivated successfully.
Aug 30 14:26:02 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
Aug 30 14:26:02 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
Aug 30 14:26:02 volumio sudo[1610]: pam_unix(sudo:session): session closed for user root
Aug 30 14:26:02 volumio sudo[1615]: pam_unix(sudo:session): session closed for user root
Aug 30 14:26:02 volumio volumio[1332]: info: Shairport-Sync Started
Aug 30 14:26:02 volumio volumio[1332]: Error adding Membership: Error: addMembership EINVAL
Aug 30 14:26:02 volumio volumio[1332]: info: CoreCommandRouter::volumioGetState
Aug 30 14:26:02 volumio volumio[1332]: info: CorePlayQueue::getTrack 0
Aug 30 14:26:02 volumio volumio[1332]: info: Shairport-Sync Started
Aug 30 14:26:02 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver...
Aug 30 14:26:02 volumio sudo[1618]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Aug 30 14:26:02 volumio sudo[1618]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Aug 30 14:26:02 volumio systemd[1]: shairport-sync.service: Deactivated successfully.
Aug 30 14:26:02 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
Aug 30 14:26:02 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
Aug 30 14:26:02 volumio sudo[1612]: pam_unix(sudo:session): session closed for user root
Aug 30 14:26:02 volumio volumio[1332]: info: Shairport-Sync Started
Aug 30 14:26:03 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 2.
Aug 30 14:26:03 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD.
Aug 30 14:26:03 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD.
Aug 30 14:26:03 volumio sudo[1618]: pam_unix(sudo:session): session closed for user root
Aug 30 14:26:03 volumio volumio[1332]: info: Upmpdcli Daemon Started
Aug 30 14:26:04 volumio systemd[1]: systemd-hostnamed.service: Deactivated successfully.
Aug 30 14:26:06 volumio volumio[1332]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory
Aug 30 14:26:07 volumio sudo[1677]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Aug 30 14:26:07 volumio sudo[1677]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Aug 30 14:26:07 volumio sudo[1679]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Aug 30 14:26:07 volumio sudo[1677]: pam_unix(sudo:session): session closed for user root
Aug 30 14:26:07 volumio sudo[1679]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Aug 30 14:26:07 volumio sudo[1679]: pam_unix(sudo:session): session closed for user root
Aug 30 14:26:07 volumio volumio[1332]: verbose: New Socket.io Connection to 10.8.8.64 from 10.8.8.88 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/151.0.0.0 Safari/537.36 OPR/135.0.0.0 Engine version: 3 Transport: polling Total Clients: 4
Aug 30 14:26:07 volumio volumio[1332]: info: CoreCommandRouter::volumioGetVisibleSources
Aug 30 14:26:07 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Aug 30 14:26:07 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps
Aug 30 14:26:07 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode
Aug 30 14:26:07 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages
Aug 30 14:26:07 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones
Aug 30 14:26:07 volumio volumio[1332]: info: Received Get System Info
Aug 30 14:26:07 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Aug 30 14:26:07 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Aug 30 14:26:07 volumio volumio[1332]: info: Discovery: Getting this device information
Aug 30 14:26:07 volumio volumio[1332]: info: CoreCommandRouter::volumioGetState
Aug 30 14:26:07 volumio volumio[1332]: info: CorePlayQueue::getTrack 0
Aug 30 14:26:07 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Aug 30 14:26:07 volumio volumio-remote-updater[774]: Test mode disabled
Aug 30 14:26:07 volumio volumio-remote-updater[774]: Alpha mode disabled
Aug 30 14:26:07 volumio volumio-remote-updater[774]: Alpha legacy test mode disabled
Aug 30 14:26:07 volumio volumio[1332]: info: CoreCommandRouter::getUIConfigOnPlugin
Aug 30 14:26:07 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Aug 30 14:26:07 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Aug 30 14:26:07 volumio volumio[1332]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false}
Aug 30 14:26:07 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Aug 30 14:26:08 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Aug 30 14:26:08 volumio volumio5-onboarding[1504]: time=2026-08-30T11:26:08.059Z level=WARN msg="could not read OAuth data for music provider" component=volumio provider=tidal error="could not open plugin config file for \"tidal\": open /data/configuration/music_service/tidal/config.json: no such file or directory"
Aug 30 14:26:08 volumio volumio5-onboarding[1504]: time=2026-08-30T11:26:08.060Z level=WARN msg="could not read OAuth data for music provider" component=volumio provider=qobuz error="could not open plugin config file for \"qobuz\": open /data/configuration/music_service/qobuz/config.json: no such file or directory"
Aug 30 14:26:08 volumio volumio5-onboarding[1504]: time=2026-08-30T11:26:08.061Z level=WARN msg="could not read username/password data for music provider" component=volumio provider=hi_res_audio error="could not open plugin config file for \"hi_res_audio\": open /data/configuration/music_service/hi_res_audio/config.json: no such file or directory"
Aug 30 14:26:08 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Aug 30 14:26:08 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Aug 30 14:26:08 volumio volumio[1332]: info: Received Get System Info
Aug 30 14:26:08 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Aug 30 14:26:08 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Aug 30 14:26:08 volumio volumio[1332]: info: Discovery: Getting this device information
Aug 30 14:26:08 volumio volumio[1332]: info: CoreCommandRouter::volumioGetState
Aug 30 14:26:08 volumio volumio[1332]: info: CorePlayQueue::getTrack 0
Aug 30 14:26:08 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Aug 30 14:26:08 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Aug 30 14:26:08 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Aug 30 14:26:08 volumio volumio5-onboarding[1504]: time=2026-08-30T11:26:08.221Z level=INFO msg="enabling local network discovery"
Aug 30 14:26:08 volumio volumio5-onboarding[1504]: time=2026-08-30T11:26:08.243Z level=INFO msg="enabling BLE discovery"
Aug 30 14:26:09 volumio volumio5-onboarding[1504]: time=2026-08-30T11:26:09.141Z level=INFO msg="service successfully established" component=discovery/localnet
Aug 30 14:26:09 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Aug 30 14:26:09 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage
Aug 30 14:26:09 volumio volumio[1332]: info: Loading i18n strings for locale en
Aug 30 14:26:09 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone
Aug 30 14:26:09 volumio volumio[1332]: info: Setting timezone to Europe/Helsinki
Aug 30 14:26:09 volumio sudo[1702]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime
Aug 30 14:26:09 volumio sudo[1702]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Aug 30 14:26:09 volumio sudo[1702]: pam_unix(sudo:session): session closed for user root
Aug 30 14:26:09 volumio sudo[1706]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/Helsinki /etc/localtime
Aug 30 14:26:09 volumio sudo[1706]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Aug 30 14:26:09 volumio sudo[1706]: pam_unix(sudo:session): session closed for user root
Aug 30 14:26:10 volumio sudo[1710]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime
Aug 30 14:26:10 volumio sudo[1710]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Aug 30 14:26:10 volumio sudo[1710]: pam_unix(sudo:session): session closed for user root
Aug 30 14:26:10 volumio sudo[1714]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Helsinki
Aug 30 14:26:10 volumio sudo[1714]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Aug 30 14:26:10 volumio dbus-daemon[751]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.19' (uid=0 pid=1715 comm="/usr/bin/timedatectl set-timezone Europe/Helsinki")
Aug 30 14:26:10 volumio systemd[1]: Starting systemd-timedated.service - Time & Date Service...
Aug 30 14:26:10 volumio dbus-daemon[751]: [system] Successfully activated service 'org.freedesktop.timedate1'
Aug 30 14:26:10 volumio systemd[1]: Started systemd-timedated.service - Time & Date Service.
Aug 30 14:26:10 volumio sudo[1714]: pam_unix(sudo:session): session closed for user root
Aug 30 14:26:10 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Aug 30 14:26:10 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken
Aug 30 14:26:11 volumio volumio[1332]: Updating browse sources language
Aug 30 14:26:11 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Aug 30 14:26:11 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken
Aug 30 14:26:11 volumio volumio[1332]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium
Aug 30 14:26:11 volumio volumio[1332]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium
Aug 30 14:26:11 volumio volumio[1332]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium
Aug 30 14:26:11 volumio volumio[1332]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium
Aug 30 14:26:11 volumio volumio[1332]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium
Aug 30 14:26:11 volumio volumio[1332]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium
Aug 30 14:26:11 volumio volumio[1332]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium
Aug 30 14:26:11 volumio volumio[1332]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium
Aug 30 14:26:11 volumio volumio[1332]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium
Aug 30 14:26:11 volumio volumio[1332]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium
Aug 30 14:26:11 volumio volumio[1332]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium
Aug 30 14:26:11 volumio volumio[1332]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar
Aug 30 14:26:11 volumio volumio[1332]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar
Aug 30 14:26:11 volumio volumio[1332]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar
Aug 30 14:26:11 volumio volumio[1332]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar
Aug 30 14:26:11 volumio volumio[1332]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar
Aug 30 14:26:11 volumio volumio[1332]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar
Aug 30 14:26:11 volumio volumio[1332]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar
Aug 30 14:26:11 volumio volumio[1332]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar
Aug 30 14:26:11 volumio volumio[1332]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar
Aug 30 14:26:11 volumio volumio[1332]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar
Aug 30 14:26:11 volumio volumio[1332]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar
Aug 30 14:26:11 volumio volumio[1332]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso
Aug 30 14:26:11 volumio volumio[1332]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso
Aug 30 14:26:11 volumio volumio[1332]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso
Aug 30 14:26:11 volumio volumio[1332]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso
Aug 30 14:26:11 volumio volumio[1332]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso
Aug 30 14:26:11 volumio volumio[1332]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso
Aug 30 14:26:11 volumio volumio[1332]: info: Adding plugin bluetooth to MyMusic Plugins
Aug 30 14:26:11 volumio volumio[1332]: info: Adding plugin multiroom to MyMusic Plugins
Aug 30 14:26:11 volumio volumio[1332]: info: Adding plugin metavolumio to MyMusic Plugins
Aug 30 14:26:11 volumio volumio[1332]: info: Adding plugin cd_controller to MyMusic Plugins
Aug 30 14:26:12 volumio volumio[1332]: info: Adding plugin qobuzconnect to MyMusic Plugins
Aug 30 14:26:12 volumio volumio[1332]: info: Adding plugin smart_inputs to MyMusic Plugins
Aug 30 14:26:12 volumio volumio[1332]: info: Adding plugin tidalconnect to MyMusic Plugins
Aug 30 14:26:12 volumio volumio[1332]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"...
Aug 30 14:26:15 volumio volumio[1332]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded
Aug 30 14:26:15 volumio volumio[1332]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio
Aug 30 14:26:15 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 30 14:26:15 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 30 14:26:15 volumio volumio[1332]: info: Starting MyVolumio Remote Streaming Endpoints
Aug 30 14:26:15 volumio volumio[1332]: info: MyVolumio not started
Aug 30 14:26:15 volumio volumio[1332]: info: Initializing device activation check
Aug 30 14:26:15 volumio volumio[1332]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started
Aug 30 14:26:15 volumio volumio[1332]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"...
Aug 30 14:26:17 volumio upmpdcli[1717]: writing RSA key
Aug 30 14:26:17 volumio systemd[1]: Starting e2scrub_all.service - Online ext4 Metadata Check for All Filesystems...
Aug 30 14:26:17 volumio systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service...
Aug 30 14:26:17 volumio systemd[1]: e2scrub_all.service: Deactivated successfully.
Aug 30 14:26:17 volumio systemd[1]: Finished e2scrub_all.service - Online ext4 Metadata Check for All Filesystems.
Aug 30 14:26:19 volumio volumio[1332]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded
Aug 30 14:26:19 volumio volumio[1332]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services
Aug 30 14:26:19 volumio volumio[1332]: info: Streaming services startup
Aug 30 14:26:19 volumio volumio[1332]: info: Starting Streaming Daemon
Aug 30 14:26:19 volumio volumio[1332]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started
Aug 30 14:26:19 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage
Aug 30 14:26:19 volumio volumio[1332]: info: Loading i18n strings for locale en
Aug 30 14:26:19 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone
Aug 30 14:26:19 volumio volumio[1332]: info: Setting timezone to Europe/Helsinki
Aug 30 14:26:19 volumio sudo[1762]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime
Aug 30 14:26:19 volumio sudo[1762]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Aug 30 14:26:19 volumio sudo[1755]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Aug 30 14:26:19 volumio sudo[1755]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Aug 30 14:26:19 volumio sudo[1762]: pam_unix(sudo:session): session closed for user root
Aug 30 14:26:19 volumio sudo[1767]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/Helsinki /etc/localtime
Aug 30 14:26:19 volumio sudo[1767]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Aug 30 14:26:19 volumio sudo[1767]: pam_unix(sudo:session): session closed for user root
Aug 30 14:26:19 volumio sudo[1755]: pam_unix(sudo:session): session closed for user root
Aug 30 14:26:19 volumio sudo[1771]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime
Aug 30 14:26:19 volumio sudo[1771]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Aug 30 14:26:19 volumio sudo[1771]: pam_unix(sudo:session): session closed for user root
Aug 30 14:26:19 volumio sudo[1775]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Helsinki
Aug 30 14:26:19 volumio sudo[1775]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Aug 30 14:26:19 volumio sudo[1775]: pam_unix(sudo:session): session closed for user root
Aug 30 14:26:19 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache
Aug 30 14:26:19 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks
Aug 30 14:26:19 volumio sudo[1778]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Aug 30 14:26:19 volumio sudo[1778]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Aug 30 14:26:19 volumio volumio[1332]: error: Cannot start Volumio Streaming Daemon
Aug 30 14:26:19 volumio volumio[1332]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Aug 30 14:26:19 volumio volumio[1332]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Aug 30 14:26:19 volumio volumio[1332]: Updating browse sources language
Aug 30 14:26:19 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Aug 30 14:26:19 volumio volumio[1332]: info: Fetching Streaming Services browse cache
Aug 30 14:26:21 volumio systemd[1]: setdatetime-helper.service: Deactivated successfully.
Aug 30 14:26:21 volumio systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service.
Aug 30 14:26:21 volumio kernel: hwmon hwmon1: Undervoltage detected!
Aug 30 14:26:22 volumio sudo[1778]: pam_unix(sudo:session): session closed for user root
Aug 30 14:26:22 volumio volumio[1332]: info: Received Get System Info
Aug 30 14:26:22 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Aug 30 14:26:22 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Aug 30 14:26:22 volumio volumio[1332]: info: Discovery: Getting this device information
Aug 30 14:26:22 volumio volumio[1332]: info: CoreCommandRouter::volumioGetState
Aug 30 14:26:22 volumio volumio[1332]: info: CorePlayQueue::getTrack 0
Aug 30 14:26:22 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Aug 30 14:26:22 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Aug 30 14:26:22 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Aug 30 14:26:23 volumio volumio5-onboarding[1504]: time=2026-08-30T11:26:23.681Z level=INFO msg="service successfully established" component=discovery/localnet
Aug 30 14:26:25 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Aug 30 14:26:25 volumio volumio[1332]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Aug 30 14:26:25 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Aug 30 14:26:25 volumio volumio[1332]: info: Received Get System Version
Aug 30 14:26:25 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Aug 30 14:26:25 volumio volumio[1332]: info: Received Get System Info
Aug 30 14:26:25 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Aug 30 14:26:25 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Aug 30 14:26:25 volumio volumio[1332]: info: Discovery: Getting this device information
Aug 30 14:26:25 volumio volumio[1332]: info: CoreCommandRouter::volumioGetState
Aug 30 14:26:25 volumio volumio[1332]: info: CorePlayQueue::getTrack 0
Aug 30 14:26:25 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Aug 30 14:26:25 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Aug 30 14:26:25 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 30 14:26:25 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Aug 30 14:26:26 volumio kernel: hwmon hwmon1: Voltage normalised
Aug 30 14:26:26 volumio volumio-remote-updater[774]: Test mode disabled
Aug 30 14:26:26 volumio volumio-remote-updater[774]: Alpha mode disabled
Aug 30 14:26:26 volumio volumio-remote-updater[774]: Alpha legacy test mode disabled
Aug 30 14:26:26 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
Aug 30 14:26:26 volumio volumio[1332]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false}
Aug 30 14:26:26 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Aug 30 14:26:30 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Aug 30 14:26:30 volumio volumio[1332]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5
Aug 30 14:26:30 volumio volumio[1332]: info: CoreCommandRouter::volumioGetState
Aug 30 14:26:30 volumio volumio[1332]: info: CorePlayQueue::getTrack 0
Aug 30 14:26:35 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 14:26:35 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 14:26:35 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
Aug 30 14:26:35 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Aug 30 14:26:35 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
Aug 30 14:26:35 volumio volumio[1332]: info: CoreCommandRouter::volumioGetBrowseSources
Aug 30 14:26:35 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Aug 30 14:26:39 volumio volumio[1332]: error: MyVolumio Plugin failed to authenticate in a timely fashion
Aug 30 14:26:39 volumio volumio[1332]: info: Completed starting MyVolumio Plugin
Aug 30 14:26:39 volumio volumio[1332]: [Metrics] CommandRouter: 54s 161.99ms
Aug 30 14:26:39 volumio volumio[1332]: info: CoreCommandRouter::volumiosetStartupVolume
Aug 30 14:26:39 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 14:26:39 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 30 14:26:39 volumio volumio[1332]: info: CoreCommandRouter::Close All Modals sent
Aug 30 14:26:39 volumio volumio[1332]: info: CoreCommandRouter::Close All Modals sent
Aug 30 14:26:39 volumio volumio[1332]: info: CoreCommandRouter::getUIConfigOnPlugin
Aug 30 14:26:39 volumio volumio[1332]: info: Retrieving Cloud Streaming UI
Aug 30 14:26:39 volumio volumio[1332]: info: CoreCommandRouter::getUIConfigOnPlugin
Aug 30 14:26:39 volumio volumio[1332]: info: Retrieving Cloud Streaming UI
Aug 30 14:26:39 volumio volumio[1332]: info: Getting Tidal Cloud Configuration
Aug 30 14:26:39 volumio volumio[1332]: info: CoreCommandRouter::getUIConfigOnPlugin
Aug 30 14:26:39 volumio volumio[1332]: info: Getting Qobuz Cloud Configuration
Aug 30 14:26:39 volumio volumio[1332]: info: Asking plugin for UI Config
Aug 30 14:26:39 volumio volumio[1332]: info: CoreCommandRouter::getUIConfigOnPlugin
Aug 30 14:26:39 volumio volumio[1332]: info: Getting Spotify Cloud Configuration
Aug 30 14:26:39 volumio volumio[1332]: info: Asking plugin for UI Config
Aug 30 14:26:39 volumio volumio[1332]: info: CoreCommandRouter::getUIConfigOnPlugin
Aug 30 14:26:39 volumio volumio[1332]: info: Saving Spotify Acccount
Aug 30 14:26:39 volumio volumio[1332]: info: Got Tidal Cloud Configuration
Aug 30 14:26:39 volumio volumio[1332]: info: Got it
Aug 30 14:26:39 volumio volumio[1332]: info: Got it
Aug 30 14:26:39 volumio volumio[1332]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
Aug 30 14:26:39 volumio volumio[1332]: info: Getting Tidal Cloud Configuration
Aug 30 14:26:39 volumio volumio[1332]: info: CoreCommandRouter::getUIConfigOnPlugin
Aug 30 14:26:39 volumio volumio[1332]: info: Getting Qobuz Cloud Configuration
Aug 30 14:26:39 volumio volumio[1332]: info: Asking plugin for UI Config
Aug 30 14:26:39 volumio volumio[1332]: info: CoreCommandRouter::getUIConfigOnPlugin
Aug 30 14:26:39 volumio volumio[1332]: info: Getting Spotify Cloud Configuration
Aug 30 14:26:39 volumio volumio[1332]: info: Asking plugin for UI Config
Aug 30 14:26:39 volumio volumio[1332]: info: CoreCommandRouter::getUIConfigOnPlugin
Aug 30 14:26:39 volumio volumio[1332]: info: Saving Spotify Acccount
Aug 30 14:26:39 volumio volumio[1332]: info: Got Tidal Cloud Configuration
Aug 30 14:26:39 volumio volumio[1332]: info: Got it
Aug 30 14:26:39 volumio volumio[1332]: info: Got it
Aug 30 14:26:39 volumio volumio[1332]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
Aug 30 14:26:39 volumio volumio[1332]: info: CoreCommandRouter::getUIConfigOnPlugin
Aug 30 14:26:39 volumio volumio[1332]: error: Error retrieving Highresaudio conf: TypeError: Cannot read properties of undefined (reading 'onSave')
Aug 30 14:26:39 volumio volumio[1332]: info: CoreCommandRouter::getUIConfigOnPlugin
Aug 30 14:26:39 volumio volumio[1332]: error: Error retrieving Highresaudio conf: TypeError: Cannot read properties of undefined (reading 'onSave')
Aug 30 14:26:40 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Aug 30 14:26:40 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Aug 30 14:26:40 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Aug 30 14:26:40 volumio volumio[1332]: info: Version has changed, forcing UI Reload
Aug 30 14:26:40 volumio volumio[1332]: info: CoreCommandRouter::Reload Ui
Aug 30 14:26:40 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule
Aug 30 14:26:40 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Aug 30 14:26:40 volumio sudo[1835]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Aug 30 14:26:40 volumio sudo[1835]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Aug 30 14:26:40 volumio sudo[1837]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Aug 30 14:26:40 volumio sudo[1837]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Aug 30 14:26:41 volumio sudo[1835]: pam_unix(sudo:session): session closed for user root
Aug 30 14:26:41 volumio sudo[1837]: pam_unix(sudo:session): session closed for user root
Aug 30 14:26:41 volumio volumio[1332]: verbose: New Socket.io Connection to 10.8.8.64 from 10.8.8.88 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/151.0.0.0 Safari/537.36 OPR/135.0.0.0 Engine version: 3 Transport: polling Total Clients: 5
Aug 30 14:26:41 volumio volumio-remote-updater[774]: Test mode disabled
Aug 30 14:26:41 volumio volumio-remote-updater[774]: Alpha mode disabled
Aug 30 14:26:41 volumio volumio-remote-updater[774]: Alpha legacy test mode disabled
Aug 30 14:26:41 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
Aug 30 14:26:41 volumio volumio[1332]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false}
Aug 30 14:26:41 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Aug 30 14:26:41 volumio volumio[1332]: info: CoreCommandRouter::volumioGetVisibleSources
Aug 30 14:26:41 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Aug 30 14:26:41 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: wizard , getWizardSteps
Aug 30 14:26:41 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , showActivationCode
Aug 30 14:26:41 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableLanguages
Aug 30 14:26:41 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getAvailableTimezones
Aug 30 14:26:41 volumio volumio[1332]: info: Received Get System Info
Aug 30 14:26:41 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Aug 30 14:26:41 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Aug 30 14:26:41 volumio volumio[1332]: info: Discovery: Getting this device information
Aug 30 14:26:41 volumio volumio[1332]: info: CoreCommandRouter::volumioGetState
Aug 30 14:26:41 volumio volumio[1332]: info: CorePlayQueue::getTrack 0
Aug 30 14:26:41 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Aug 30 14:26:41 volumio volumio-remote-updater[774]: Test mode disabled
Aug 30 14:26:41 volumio volumio-remote-updater[774]: Alpha mode disabled
Aug 30 14:26:41 volumio volumio-remote-updater[774]: Alpha legacy test mode disabled
Aug 30 14:26:41 volumio volumio[1332]: info: CoreCommandRouter::getUIConfigOnPlugin
Aug 30 14:26:41 volumio volumio[1332]: info: Retrieving Cloud Streaming UI
Aug 30 14:26:41 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Aug 30 14:26:41 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Aug 30 14:26:41 volumio volumio[1332]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false}
Aug 30 14:26:41 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Aug 30 14:26:41 volumio volumio[1332]: info: Getting Tidal Cloud Configuration
Aug 30 14:26:41 volumio volumio[1332]: info: CoreCommandRouter::getUIConfigOnPlugin
Aug 30 14:26:41 volumio volumio[1332]: info: Getting Qobuz Cloud Configuration
Aug 30 14:26:41 volumio volumio[1332]: info: Asking plugin for UI Config
Aug 30 14:26:41 volumio volumio[1332]: info: CoreCommandRouter::getUIConfigOnPlugin
Aug 30 14:26:41 volumio volumio[1332]: info: Getting Spotify Cloud Configuration
Aug 30 14:26:41 volumio volumio[1332]: info: Asking plugin for UI Config
Aug 30 14:26:41 volumio volumio[1332]: info: CoreCommandRouter::getUIConfigOnPlugin
Aug 30 14:26:41 volumio volumio[1332]: info: Saving Spotify Acccount
Aug 30 14:26:41 volumio volumio[1332]: info: Got Tidal Cloud Configuration
Aug 30 14:26:41 volumio volumio[1332]: info: Got it
Aug 30 14:26:41 volumio volumio[1332]: info: Got it
Aug 30 14:26:41 volumio volumio[1332]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
Aug 30 14:26:41 volumio volumio[1332]: info: CoreCommandRouter::getUIConfigOnPlugin
Aug 30 14:26:41 volumio volumio[1332]: error: Error retrieving Highresaudio conf: TypeError: Cannot read properties of undefined (reading 'onSave')
Aug 30 14:26:42 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage
Aug 30 14:26:42 volumio volumio[1332]: info: Loading i18n strings for locale en
Aug 30 14:26:42 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone
Aug 30 14:26:42 volumio volumio[1332]: info: Setting timezone to Europe/Helsinki
Aug 30 14:26:42 volumio sudo[1849]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime
Aug 30 14:26:42 volumio sudo[1849]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Aug 30 14:26:42 volumio sudo[1849]: pam_unix(sudo:session): session closed for user root
Aug 30 14:26:43 volumio sudo[1853]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/Helsinki /etc/localtime
Aug 30 14:26:43 volumio sudo[1853]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Aug 30 14:26:43 volumio sudo[1853]: pam_unix(sudo:session): session closed for user root
Aug 30 14:26:43 volumio systemd[1]: Starting apt-daily-upgrade.service - Daily apt upgrade and clean activities...
Aug 30 14:26:43 volumio sudo[1858]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime
Aug 30 14:26:43 volumio sudo[1858]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Aug 30 14:26:43 volumio sudo[1858]: pam_unix(sudo:session): session closed for user root
Aug 30 14:26:43 volumio sudo[1863]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Helsinki
Aug 30 14:26:43 volumio sudo[1863]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Aug 30 14:26:43 volumio sudo[1863]: pam_unix(sudo:session): session closed for user root
Aug 30 14:26:43 volumio volumio[1332]: info: Fetching Streaming Services browse cache
Aug 30 14:26:43 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Aug 30 14:26:43 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Aug 30 14:26:43 volumio volumio[1332]: Updating browse sources language
Aug 30 14:26:43 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Aug 30 14:26:44 volumio systemd[1]: apt-daily-upgrade.service: Deactivated successfully.
Aug 30 14:26:44 volumio systemd[1]: Finished apt-daily-upgrade.service - Daily apt upgrade and clean activities.
Aug 30 14:26:44 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken
Aug 30 14:26:44 volumio volumio[1332]: info: MyVolumio login type: Token
Aug 30 14:26:44 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Aug 30 14:26:44 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken
Aug 30 14:26:44 volumio volumio[1332]: info: MyVolumio login type: Token
Aug 30 14:26:44 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Aug 30 14:26:44 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: appearance , setLanguage
Aug 30 14:26:44 volumio volumio[1332]: info: Loading i18n strings for locale en
Aug 30 14:26:44 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , setTimezone
Aug 30 14:26:44 volumio volumio[1332]: info: Setting timezone to Europe/Helsinki
Aug 30 14:26:45 volumio sudo[1922]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/unlink /etc/localtime
Aug 30 14:26:45 volumio sudo[1922]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Aug 30 14:26:45 volumio sudo[1922]: pam_unix(sudo:session): session closed for user root
Aug 30 14:26:45 volumio sudo[1926]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/ln -s /usr/share/zoneinfo/Europe/Helsinki /etc/localtime
Aug 30 14:26:45 volumio sudo[1926]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Aug 30 14:26:45 volumio sudo[1926]: pam_unix(sudo:session): session closed for user root
Aug 30 14:26:45 volumio sudo[1930]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/localtime
Aug 30 14:26:45 volumio sudo[1930]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Aug 30 14:26:45 volumio sudo[1930]: pam_unix(sudo:session): session closed for user root
Aug 30 14:26:45 volumio sudo[1934]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-timezone Europe/Helsinki
Aug 30 14:26:45 volumio sudo[1934]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Aug 30 14:26:45 volumio sudo[1934]: pam_unix(sudo:session): session closed for user root
Aug 30 14:26:45 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache
Aug 30 14:26:45 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks
Aug 30 14:26:45 volumio volumio[1332]: info: Fetching Streaming Services browse cache
Aug 30 14:26:45 volumio sudo[1937]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Aug 30 14:26:45 volumio sudo[1937]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Aug 30 14:26:46 volumio volumio[1332]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN
Aug 30 14:26:46 volumio volumio[1332]: info: BOOT COMPLETED
Aug 30 14:26:46 volumio volumio[1332]: Updating browse sources language
Aug 30 14:26:46 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Aug 30 14:26:46 volumio kernel: hwmon hwmon1: Undervoltage detected!
Aug 30 14:26:47 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Aug 30 14:26:47 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Aug 30 14:26:48 volumio sudo[1937]: pam_unix(sudo:session): session closed for user root
Aug 30 14:26:48 volumio volumio[1332]: info: Received Get System Info
Aug 30 14:26:48 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Aug 30 14:26:48 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Aug 30 14:26:48 volumio volumio[1332]: info: Discovery: Getting this device information
Aug 30 14:26:48 volumio volumio[1332]: info: CoreCommandRouter::volumioGetState
Aug 30 14:26:48 volumio volumio[1332]: info: CorePlayQueue::getTrack 0
Aug 30 14:26:48 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Aug 30 14:26:48 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Aug 30 14:26:48 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Aug 30 14:26:48 volumio volumio[1332]: info: MyVolumio token set successfully
Aug 30 14:26:48 volumio volumio[1332]: info: MYVOLUMIO: Adding device
Aug 30 14:26:48 volumio volumio[1332]: info: MYVOLUMIO: Evaluating Server
Aug 30 14:26:49 volumio volumio[1332]: info: MyVolumio status changed
Aug 30 14:26:49 volumio volumio[1332]: info: Streaming services startup
Aug 30 14:26:49 volumio volumio[1332]: info: Starting Streaming Daemon
Aug 30 14:26:49 volumio volumio[1332]: info: Removing browser output: myVolumio user plan is not superstar
Aug 30 14:26:49 volumio volumio[1332]: info: Removing audio output:
Aug 30 14:26:49 volumio volumio[1332]: info: Stoppping Tunnel 1
Aug 30 14:26:49 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: updater_comm , clearUpdateSchedule
Aug 30 14:26:49 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Aug 30 14:26:49 volumio volumio5-onboarding[1504]: time=2026-08-30T11:26:49.872Z level=INFO msg="service successfully established" component=discovery/localnet
Aug 30 14:26:49 volumio sudo[1978]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service
Aug 30 14:26:49 volumio sudo[1978]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Aug 30 14:26:49 volumio sudo[1976]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Aug 30 14:26:49 volumio sudo[1976]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Aug 30 14:26:49 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.
Aug 30 14:26:49 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.
Aug 30 14:26:49 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.
Aug 30 14:26:49 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.
Aug 30 14:26:49 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.
Aug 30 14:26:49 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.
Aug 30 14:26:50 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.
Aug 30 14:26:50 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.
Aug 30 14:26:50 volumio sudo[1978]: pam_unix(sudo:session): session closed for user root
Aug 30 14:26:50 volumio sudo[1976]: pam_unix(sudo:session): session closed for user root
Aug 30 14:26:50 volumio volumio-remote-updater[774]: Test mode disabled
Aug 30 14:26:50 volumio volumio-remote-updater[774]: Alpha mode disabled
Aug 30 14:26:50 volumio volumio-remote-updater[774]: Alpha legacy test mode disabled
Aug 30 14:26:50 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled
Aug 30 14:26:50 volumio volumio[1332]: error: Failed to ping endpoint eu2.myvolumio.org : unknown error
Aug 30 14:26:50 volumio volumio[1332]: info: Setting Geolocation for MyVolumio to eu7
Aug 30 14:26:50 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 30 14:26:50 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 30 14:26:50 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 30 14:26:50 volumio volumio[1332]: info: Remote SSH Stopped
Aug 30 14:26:50 volumio volumio[1332]: error: Cannot start Volumio Streaming Daemon
Aug 30 14:26:50 volumio volumio[1332]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Aug 30 14:26:50 volumio volumio[1332]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Aug 30 14:26:50 volumio volumio[1332]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false}
Aug 30 14:26:50 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Aug 30 14:26:51 volumio volumio[1332]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"}
Aug 30 14:26:51 volumio volumio[1332]: info: Updating MyVolumio device info
Aug 30 14:26:51 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 30 14:26:51 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 30 14:26:51 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 30 14:26:51 volumio volumio[1332]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"}
Aug 30 14:26:53 volumio kernel: hwmon hwmon1: Voltage normalised
Aug 30 14:26:55 volumio volumio[1332]: info: MYVOLUMIO: Adding device
Aug 30 14:26:55 volumio volumio[1332]: info: MYVOLUMIO: Evaluating Server
Aug 30 14:26:57 volumio volumio[1332]: info: Setting Geolocation for MyVolumio to eu7
Aug 30 14:26:57 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 30 14:26:57 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 30 14:26:57 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 30 14:26:57 volumio volumio[1332]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"}
Aug 30 14:26:58 volumio volumio[1332]: info: Updating MyVolumio device info
Aug 30 14:26:58 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 30 14:26:58 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 30 14:26:58 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 30 14:26:58 volumio volumio[1332]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"}
Aug 30 14:26:58 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Aug 30 14:26:58 volumio volumio[1332]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Aug 30 14:26:58 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Aug 30 14:26:58 volumio volumio[1332]: info: Received Get System Version
Aug 30 14:26:58 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Aug 30 14:26:58 volumio volumio[1332]: info: Received Get System Info
Aug 30 14:26:58 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Aug 30 14:26:58 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Aug 30 14:26:58 volumio volumio[1332]: info: Discovery: Getting this device information
Aug 30 14:26:58 volumio volumio[1332]: info: CoreCommandRouter::volumioGetState
Aug 30 14:26:58 volumio volumio[1332]: info: CorePlayQueue::getTrack 0
Aug 30 14:26:58 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Aug 30 14:27:02 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , saveGeneralSettings
Aug 30 14:27:02 volumio volumio[1332]: info: System name has changed, restarting Shairport Sync
Aug 30 14:27:02 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Aug 30 14:27:02 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 30 14:27:02 volumio volumio[1332]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Aug 30 14:27:02 volumio volumio[1332]: info: Updating MyVolumio device info
Aug 30 14:27:02 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 30 14:27:02 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 30 14:27:02 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 30 14:27:02 volumio volumio[1332]: info: Discovery: Restarting Advertising
Aug 30 14:27:02 volumio volumio[1332]: info: Discovery: Stopping existing advertisement
Aug 30 14:27:02 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAudioDevices
Aug 30 14:27:02 volumio sudo[2020]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/killall upmpdcli
Aug 30 14:27:02 volumio sudo[2020]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Aug 30 14:27:02 volumio sudo[2020]: pam_unix(sudo:session): session closed for user root
Aug 30 14:27:02 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Aug 30 14:27:02 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Aug 30 14:27:02 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Aug 30 14:27:02 volumio volumio[1332]: info: Received Get System Info
Aug 30 14:27:02 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Aug 30 14:27:02 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Aug 30 14:27:02 volumio volumio[1332]: info: Discovery: Getting this device information
Aug 30 14:27:02 volumio volumio[1332]: info: CoreCommandRouter::volumioGetState
Aug 30 14:27:02 volumio volumio[1332]: info: CorePlayQueue::getTrack 0
Aug 30 14:27:02 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Aug 30 14:27:02 volumio volumio[1332]: info: Received Get System Info
Aug 30 14:27:02 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Aug 30 14:27:02 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Aug 30 14:27:02 volumio volumio[1332]: info: Discovery: Getting this device information
Aug 30 14:27:02 volumio volumio[1332]: info: CoreCommandRouter::volumioGetState
Aug 30 14:27:02 volumio volumio[1332]: info: CorePlayQueue::getTrack 0
Aug 30 14:27:02 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Aug 30 14:27:02 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Aug 30 14:27:02 volumio volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Aug 30 14:27:02 volumio volumio5-onboarding[1504]: time=2026-08-30T11:27:02.453Z level=INFO msg="device name changed, resetting service group" component=discovery/localnet
Aug 30 14:27:02 volumio volumio[1332]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"}
Aug 30 14:27:02 volumio sudo[2026]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/hosts
Aug 30 14:27:02 volumio sudo[2026]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Aug 30 14:27:02 volumio volumio[1332]: info: Starting Shairport Sync
Aug 30 14:27:02 volumio sudo[2026]: pam_unix(sudo:session): session closed for user root
Aug 30 14:27:02 volumio volumio[1332]: info: Permissions for /etc/hosts set
Aug 30 14:27:02 volumio systemd[1]: upmpdcli.service: Deactivated successfully.
Aug 30 14:27:02 volumio systemd[1]: upmpdcli.service: Consumed 12.821s CPU time.
Aug 30 14:27:02 volumio sudo[2029]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Aug 30 14:27:02 volumio sudo[2029]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Aug 30 14:27:02 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver...
Aug 30 14:27:02 volumio systemd[1]: shairport-sync.service: Deactivated successfully.
Aug 30 14:27:02 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
Aug 30 14:27:02 volumio systemd[1]: shairport-sync.service: Consumed 1.523s CPU time.
Aug 30 14:27:02 volumio sudo[2031]: volumio : unable to resolve host volumio: System error
Aug 30 14:27:02 volumio sudo[2031]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/hostname rpi4-volumio
Aug 30 14:27:02 volumio sudo[2031]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Aug 30 14:27:02 rpi4-volumio sudo[2031]: pam_unix(sudo:session): session closed for user root
Aug 30 14:27:02 rpi4-volumio volumio[1332]: info: Hostname now is rpi4-volumio
Aug 30 14:27:02 rpi4-volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
Aug 30 14:27:02 rpi4-volumio volumio[1332]: info: New hostname set
Aug 30 14:27:03 rpi4-volumio sudo[2036]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /etc/avahi/services/
Aug 30 14:27:03 rpi4-volumio sudo[2036]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Aug 30 14:27:03 rpi4-volumio sudo[2029]: pam_unix(sudo:session): session closed for user root
Aug 30 14:27:03 rpi4-volumio volumio[1332]: info: Shairport-Sync Started
Aug 30 14:27:03 rpi4-volumio sudo[2036]: pam_unix(sudo:session): session closed for user root
Aug 30 14:27:03 rpi4-volumio volumio[1332]: info: Permissions for /etc/avahi/services/volumio.service
Aug 30 14:27:03 rpi4-volumio volumio[1332]: info: Discovery: A device disappeared from network
Aug 30 14:27:03 rpi4-volumio volumio[1332]: info: Discovery: A device disappeared from network
Aug 30 14:27:03 rpi4-volumio avahi-daemon[748]: Files changed, reloading.
Aug 30 14:27:03 rpi4-volumio avahi-daemon[748]: Loading service file /services/volumio.service.
Aug 30 14:27:03 rpi4-volumio volumio[1332]: info: Avahi name changed to rpi4-volumio
Aug 30 14:27:04 rpi4-volumio avahi-daemon[748]: Service "rpi4-Volumio" (/services/volumio.service) successfully established.
Aug 30 14:27:04 rpi4-volumio volumio5-onboarding[1504]: time=2026-08-30T11:27:04.344Z level=INFO msg="service successfully established" component=discovery/localnet
Aug 30 14:27:07 rpi4-volumio volumio[1332]: info: Discovery: Started advertising with name: rpi4-Volumio
Aug 30 14:27:08 rpi4-volumio volumio[1332]: compat.c: read() failed: Resource temporarily unavailable
Aug 30 14:27:08 rpi4-volumio volumio[1332]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Aug 30 14:27:08 rpi4-volumio volumio[1332]: Error: dns service error: unknown
Aug 30 14:27:08 rpi4-volumio volumio[1332]: at MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) {
Aug 30 14:27:08 rpi4-volumio volumio[1332]: errorCode: -65537
Aug 30 14:27:08 rpi4-volumio volumio[1332]: }
Aug 30 14:27:08 rpi4-volumio volumio[1332]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Aug 30 14:27:11 rpi4-volumio sudo[2085]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-08-30 14:26'
Aug 30 14:27:11 rpi4-volumio sudo[2085]: 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"