Mar 29 17:56:00 music volumio[1332]: info: Received Get System Info Mar 29 17:56:00 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:56:00 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:56:00 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:56:00 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:56:00 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:56:00 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:56:00 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 29 17:56:00 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 29 17:56:00 music volumio5-onboarding[1317587]: time=2026-03-29T17:56:00.758Z level=INFO msg="enabling local network discovery" Mar 29 17:56:00 music volumio5-onboarding[1317587]: time=2026-03-29T17:56:00.765Z level=INFO msg="enabling BLE discovery" Mar 29 17:56:00 music volumio5-onboarding[1317587]: failed to configure discovery: failed to enable BLE discovery: failed to listen for BLE connections: failed to add service to adapter: Method "RegisterApplication" with signature "oa{sv}" on interface "org.bluez.GattManager1" doesn't exist Mar 29 17:56:00 music systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE Mar 29 17:56:00 music systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. Mar 29 17:56:00 music systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 65387. Mar 29 17:56:00 music systemd[1]: Stopped volumio5-onboarding.service - Volumio5 Onboarding Server. Mar 29 17:56:00 music systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. Mar 29 17:56:00 music volumio5-onboarding[1317602]: time=2026-03-29T17:56:00.909Z level=INFO msg="running volumio5-device-gateway" version=10ca7e93+CHANGES buildDate=2026-03-06T14:30:20Z Mar 29 17:56:00 music 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: 4 Mar 29 17:56:00 music 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: 4 Mar 29 17:56:00 music volumio[1332]: info: Received Get System Info Mar 29 17:56:00 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:56:00 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:56:00 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:56:00 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:56:00 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:56:00 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:56:00 music volumio5-onboarding[1317602]: time=2026-03-29T17:56:00.920Z level=INFO msg="system info for 06fe5fe157f017a1685d46c8acca718b" deviceName=music deviceVariant=volumio deviceModel= softwareVersion=4.103 Mar 29 17:56:00 music volumio5-onboarding[1317602]: time=2026-03-29T17:56:00.954Z level=INFO msg="bootstrapping state" hasInternet=true Mar 29 17:56:00 music volumio[1332]: info: Received Get System Info Mar 29 17:56:00 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:56:00 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:56:00 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:56:00 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:56:00 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:56:00 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:56:00 music volumio-remote-updater[576087]: Test mode disabled Mar 29 17:56:00 music volumio-remote-updater[576087]: Alpha mode disabled Mar 29 17:56:00 music volumio-remote-updater[576087]: Alpha legacy test mode disabled Mar 29 17:56:01 music volumio[1332]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"

FIXES

NEW ADDITIONS

","title":"Update v4.119","updateavailable":true} Mar 29 17:56:01 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 29 17:56:01 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:01 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:01 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:56:01 music volumio5-onboarding[1317602]: time=2026-03-29T17:56:01.957Z 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" Mar 29 17:56:01 music volumio5-onboarding[1317602]: time=2026-03-29T17:56:01.958Z 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" Mar 29 17:56:01 music volumio5-onboarding[1317602]: time=2026-03-29T17:56:01.958Z 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" Mar 29 17:56:01 music volumio5-onboarding[1317602]: time=2026-03-29T17:56:01.958Z level=WARN msg="could not read OAuth data for music provider" component=volumio provider=spotify error="could not open plugin config file for \"spop\": open /data/configuration/music_service/spop/config.json: no such file or directory" Mar 29 17:56:01 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:01 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:01 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:56:02 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:02 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:56:03 music volumio5-onboarding[1317602]: time=2026-03-29T17:56:03.590Z level=INFO msg="authenticated Firebase client" component=volumio/firebase userId=PQcO8WbVdWT3mYwk7uwfewO5Yr43 tokenExpiry=2026-03-29T18:56:03.590Z Mar 29 17:56:04 music volumio[1332]: info: Received Get System Info Mar 29 17:56:04 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:56:04 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:56:04 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:56:04 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:56:04 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:56:04 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:56:04 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 29 17:56:04 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 29 17:56:04 music volumio5-onboarding[1317602]: time=2026-03-29T17:56:04.473Z level=INFO msg="enabling local network discovery" Mar 29 17:56:04 music volumio5-onboarding[1317602]: time=2026-03-29T17:56:04.480Z level=INFO msg="enabling BLE discovery" Mar 29 17:56:04 music volumio5-onboarding[1317602]: failed to configure discovery: failed to enable BLE discovery: failed to listen for BLE connections: failed to add service to adapter: Method "RegisterApplication" with signature "oa{sv}" on interface "org.bluez.GattManager1" doesn't exist Mar 29 17:56:04 music systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE Mar 29 17:56:04 music systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. Mar 29 17:56:04 music systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 65388. Mar 29 17:56:04 music systemd[1]: Stopped volumio5-onboarding.service - Volumio5 Onboarding Server. Mar 29 17:56:04 music systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. Mar 29 17:56:04 music volumio5-onboarding[1317631]: time=2026-03-29T17:56:04.653Z level=INFO msg="running volumio5-device-gateway" version=10ca7e93+CHANGES buildDate=2026-03-06T14:30:20Z Mar 29 17:56:04 music 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: 4 Mar 29 17:56:04 music 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: 4 Mar 29 17:56:04 music volumio[1332]: info: Received Get System Info Mar 29 17:56:04 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:56:04 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:56:04 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:56:04 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:56:04 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:56:04 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:56:04 music volumio5-onboarding[1317631]: time=2026-03-29T17:56:04.664Z level=INFO msg="system info for 06fe5fe157f017a1685d46c8acca718b" deviceName=music deviceVariant=volumio deviceModel= softwareVersion=4.103 Mar 29 17:56:04 music volumio5-onboarding[1317631]: time=2026-03-29T17:56:04.712Z level=INFO msg="bootstrapping state" hasInternet=true Mar 29 17:56:04 music volumio[1332]: info: Received Get System Info Mar 29 17:56:04 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:56:04 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:56:04 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:56:04 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:56:04 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:56:04 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:56:04 music volumio-remote-updater[576087]: Test mode disabled Mar 29 17:56:04 music volumio-remote-updater[576087]: Alpha mode disabled Mar 29 17:56:04 music volumio-remote-updater[576087]: Alpha legacy test mode disabled Mar 29 17:56:04 music volumio[1332]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"

FIXES

  • Fix for missing PWM backlight module
  • Fix for crash loop on Onboarding plugin

NEW ADDITIONS

  • Bump RPi/CM4 kernel to 6.12.74

","title":"Update v4.119","updateavailable":true} Mar 29 17:56:04 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 29 17:56:04 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:04 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:04 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:56:05 music volumio5-onboarding[1317631]: time=2026-03-29T17:56:05.290Z 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" Mar 29 17:56:05 music volumio5-onboarding[1317631]: time=2026-03-29T17:56:05.291Z 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" Mar 29 17:56:05 music volumio5-onboarding[1317631]: time=2026-03-29T17:56:05.291Z 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" Mar 29 17:56:05 music volumio5-onboarding[1317631]: time=2026-03-29T17:56:05.291Z level=WARN msg="could not read OAuth data for music provider" component=volumio provider=spotify error="could not open plugin config file for \"spop\": open /data/configuration/music_service/spop/config.json: no such file or directory" Mar 29 17:56:05 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:05 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:05 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:56:05 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:05 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:56:06 music volumio5-onboarding[1317631]: time=2026-03-29T17:56:06.532Z level=INFO msg="authenticated Firebase client" component=volumio/firebase userId=PQcO8WbVdWT3mYwk7uwfewO5Yr43 tokenExpiry=2026-03-29T18:56:06.532Z Mar 29 17:56:07 music volumio[1332]: info: Received Get System Info Mar 29 17:56:07 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:56:07 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:56:07 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:56:07 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:56:07 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:56:07 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:56:07 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 29 17:56:07 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 29 17:56:07 music volumio5-onboarding[1317631]: time=2026-03-29T17:56:07.323Z level=INFO msg="enabling local network discovery" Mar 29 17:56:07 music volumio5-onboarding[1317631]: time=2026-03-29T17:56:07.330Z level=INFO msg="enabling BLE discovery" Mar 29 17:56:07 music volumio5-onboarding[1317631]: failed to configure discovery: failed to enable BLE discovery: failed to listen for BLE connections: failed to add service to adapter: Method "RegisterApplication" with signature "oa{sv}" on interface "org.bluez.GattManager1" doesn't exist Mar 29 17:56:07 music systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE Mar 29 17:56:07 music systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. Mar 29 17:56:07 music systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 65389. Mar 29 17:56:07 music systemd[1]: Stopped volumio5-onboarding.service - Volumio5 Onboarding Server. Mar 29 17:56:07 music systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. Mar 29 17:56:07 music volumio5-onboarding[1317646]: time=2026-03-29T17:56:07.653Z level=INFO msg="running volumio5-device-gateway" version=10ca7e93+CHANGES buildDate=2026-03-06T14:30:20Z Mar 29 17:56:07 music 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: 4 Mar 29 17:56:07 music 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: 4 Mar 29 17:56:07 music volumio[1332]: info: Received Get System Info Mar 29 17:56:07 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:56:07 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:56:07 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:56:07 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:56:07 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:56:07 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:56:07 music volumio5-onboarding[1317646]: time=2026-03-29T17:56:07.665Z level=INFO msg="system info for 06fe5fe157f017a1685d46c8acca718b" deviceName=music deviceVariant=volumio deviceModel= softwareVersion=4.103 Mar 29 17:56:07 music volumio5-onboarding[1317646]: time=2026-03-29T17:56:07.692Z level=INFO msg="bootstrapping state" hasInternet=true Mar 29 17:56:07 music volumio[1332]: info: Received Get System Info Mar 29 17:56:07 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:56:07 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:56:07 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:56:07 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:56:07 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:56:07 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:56:07 music volumio-remote-updater[576087]: Test mode disabled Mar 29 17:56:07 music volumio-remote-updater[576087]: Alpha mode disabled Mar 29 17:56:07 music volumio-remote-updater[576087]: Alpha legacy test mode disabled Mar 29 17:56:07 music volumio[1332]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"

FIXES

  • Fix for missing PWM backlight module
  • Fix for crash loop on Onboarding plugin

NEW ADDITIONS

  • Bump RPi/CM4 kernel to 6.12.74

","title":"Update v4.119","updateavailable":true} Mar 29 17:56:07 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 29 17:56:07 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:07 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:07 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:56:08 music volumio5-onboarding[1317646]: time=2026-03-29T17:56:08.280Z 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" Mar 29 17:56:08 music volumio5-onboarding[1317646]: time=2026-03-29T17:56:08.280Z 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" Mar 29 17:56:08 music volumio5-onboarding[1317646]: time=2026-03-29T17:56:08.280Z 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" Mar 29 17:56:08 music volumio5-onboarding[1317646]: time=2026-03-29T17:56:08.280Z level=WARN msg="could not read OAuth data for music provider" component=volumio provider=spotify error="could not open plugin config file for \"spop\": open /data/configuration/music_service/spop/config.json: no such file or directory" Mar 29 17:56:08 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:08 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:08 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:56:08 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:08 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:56:09 music volumio5-onboarding[1317646]: time=2026-03-29T17:56:09.452Z level=INFO msg="authenticated Firebase client" component=volumio/firebase userId=PQcO8WbVdWT3mYwk7uwfewO5Yr43 tokenExpiry=2026-03-29T18:56:09.452Z Mar 29 17:56:10 music volumio[1332]: info: Received Get System Info Mar 29 17:56:10 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:56:10 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:56:10 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:56:10 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:56:10 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:56:10 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:56:10 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 29 17:56:10 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 29 17:56:10 music volumio5-onboarding[1317646]: time=2026-03-29T17:56:10.480Z level=INFO msg="enabling local network discovery" Mar 29 17:56:10 music volumio5-onboarding[1317646]: time=2026-03-29T17:56:10.486Z level=INFO msg="enabling BLE discovery" Mar 29 17:56:10 music volumio5-onboarding[1317646]: failed to configure discovery: failed to enable BLE discovery: failed to listen for BLE connections: failed to add service to adapter: Method "RegisterApplication" with signature "oa{sv}" on interface "org.bluez.GattManager1" doesn't exist Mar 29 17:56:10 music systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE Mar 29 17:56:10 music systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. Mar 29 17:56:10 music systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 65390. Mar 29 17:56:10 music systemd[1]: Stopped volumio5-onboarding.service - Volumio5 Onboarding Server. Mar 29 17:56:10 music systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. Mar 29 17:56:10 music volumio5-onboarding[1317661]: time=2026-03-29T17:56:10.649Z level=INFO msg="running volumio5-device-gateway" version=10ca7e93+CHANGES buildDate=2026-03-06T14:30:20Z Mar 29 17:56:10 music 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: 4 Mar 29 17:56:10 music 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: 4 Mar 29 17:56:10 music volumio[1332]: info: Received Get System Info Mar 29 17:56:10 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:56:10 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:56:10 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:56:10 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:56:10 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:56:10 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:56:10 music volumio5-onboarding[1317661]: time=2026-03-29T17:56:10.659Z level=INFO msg="system info for 06fe5fe157f017a1685d46c8acca718b" deviceName=music deviceVariant=volumio deviceModel= softwareVersion=4.103 Mar 29 17:56:10 music volumio5-onboarding[1317661]: time=2026-03-29T17:56:10.694Z level=INFO msg="bootstrapping state" hasInternet=true Mar 29 17:56:10 music volumio[1332]: info: Received Get System Info Mar 29 17:56:10 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:56:10 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:56:10 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:56:10 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:56:10 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:56:10 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:56:10 music volumio-remote-updater[576087]: Test mode disabled Mar 29 17:56:10 music volumio-remote-updater[576087]: Alpha mode disabled Mar 29 17:56:10 music volumio-remote-updater[576087]: Alpha legacy test mode disabled Mar 29 17:56:10 music volumio[1332]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"

FIXES

  • Fix for missing PWM backlight module
  • Fix for crash loop on Onboarding plugin

NEW ADDITIONS

  • Bump RPi/CM4 kernel to 6.12.74

","title":"Update v4.119","updateavailable":true} Mar 29 17:56:10 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 29 17:56:10 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:10 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:10 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:56:11 music volumio5-onboarding[1317661]: time=2026-03-29T17:56:11.237Z 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" Mar 29 17:56:11 music volumio5-onboarding[1317661]: time=2026-03-29T17:56:11.237Z 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" Mar 29 17:56:11 music volumio5-onboarding[1317661]: time=2026-03-29T17:56:11.237Z 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" Mar 29 17:56:11 music volumio5-onboarding[1317661]: time=2026-03-29T17:56:11.237Z level=WARN msg="could not read OAuth data for music provider" component=volumio provider=spotify error="could not open plugin config file for \"spop\": open /data/configuration/music_service/spop/config.json: no such file or directory" Mar 29 17:56:11 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:11 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:11 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:56:11 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:11 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:56:12 music volumio5-onboarding[1317661]: time=2026-03-29T17:56:12.833Z level=INFO msg="authenticated Firebase client" component=volumio/firebase userId=PQcO8WbVdWT3mYwk7uwfewO5Yr43 tokenExpiry=2026-03-29T18:56:12.833Z Mar 29 17:56:13 music volumio[1332]: info: Received Get System Info Mar 29 17:56:13 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:56:13 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:56:13 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:56:13 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:56:13 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:56:13 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:56:13 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 29 17:56:13 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 29 17:56:13 music volumio5-onboarding[1317661]: time=2026-03-29T17:56:13.597Z level=INFO msg="enabling local network discovery" Mar 29 17:56:13 music volumio5-onboarding[1317661]: time=2026-03-29T17:56:13.604Z level=INFO msg="enabling BLE discovery" Mar 29 17:56:13 music volumio5-onboarding[1317661]: failed to configure discovery: failed to enable BLE discovery: failed to listen for BLE connections: failed to add service to adapter: Method "RegisterApplication" with signature "oa{sv}" on interface "org.bluez.GattManager1" doesn't exist Mar 29 17:56:13 music systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE Mar 29 17:56:13 music systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. Mar 29 17:56:13 music systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 65391. Mar 29 17:56:13 music systemd[1]: Stopped volumio5-onboarding.service - Volumio5 Onboarding Server. Mar 29 17:56:13 music systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. Mar 29 17:56:13 music volumio5-onboarding[1317675]: time=2026-03-29T17:56:13.913Z level=INFO msg="running volumio5-device-gateway" version=10ca7e93+CHANGES buildDate=2026-03-06T14:30:20Z Mar 29 17:56:13 music 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: 4 Mar 29 17:56:13 music 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: 4 Mar 29 17:56:13 music volumio[1332]: info: Received Get System Info Mar 29 17:56:13 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:56:13 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:56:13 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:56:13 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:56:13 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:56:13 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:56:13 music volumio5-onboarding[1317675]: time=2026-03-29T17:56:13.926Z level=INFO msg="system info for 06fe5fe157f017a1685d46c8acca718b" deviceName=music deviceVariant=volumio deviceModel= softwareVersion=4.103 Mar 29 17:56:13 music volumio5-onboarding[1317675]: time=2026-03-29T17:56:13.982Z level=INFO msg="bootstrapping state" hasInternet=true Mar 29 17:56:13 music volumio[1332]: info: Received Get System Info Mar 29 17:56:13 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:56:13 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:56:13 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:56:13 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:56:13 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:56:13 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:56:13 music volumio-remote-updater[576087]: Test mode disabled Mar 29 17:56:13 music volumio-remote-updater[576087]: Alpha mode disabled Mar 29 17:56:13 music volumio-remote-updater[576087]: Alpha legacy test mode disabled Mar 29 17:56:14 music volumio[1332]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"

FIXES

  • Fix for missing PWM backlight module
  • Fix for crash loop on Onboarding plugin

NEW ADDITIONS

  • Bump RPi/CM4 kernel to 6.12.74

","title":"Update v4.119","updateavailable":true} Mar 29 17:56:14 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 29 17:56:14 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:14 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:14 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:56:14 music volumio5-onboarding[1317675]: time=2026-03-29T17:56:14.786Z 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" Mar 29 17:56:14 music volumio5-onboarding[1317675]: time=2026-03-29T17:56:14.786Z 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" Mar 29 17:56:14 music volumio5-onboarding[1317675]: time=2026-03-29T17:56:14.787Z 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" Mar 29 17:56:14 music volumio5-onboarding[1317675]: time=2026-03-29T17:56:14.787Z level=WARN msg="could not read OAuth data for music provider" component=volumio provider=spotify error="could not open plugin config file for \"spop\": open /data/configuration/music_service/spop/config.json: no such file or directory" Mar 29 17:56:14 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:14 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:14 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:56:15 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:15 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:56:16 music volumio5-onboarding[1317675]: time=2026-03-29T17:56:16.464Z level=INFO msg="authenticated Firebase client" component=volumio/firebase userId=PQcO8WbVdWT3mYwk7uwfewO5Yr43 tokenExpiry=2026-03-29T18:56:16.464Z Mar 29 17:56:17 music volumio[1332]: info: Received Get System Info Mar 29 17:56:17 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:56:17 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:56:17 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:56:17 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:56:17 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:56:17 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:56:17 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 29 17:56:17 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 29 17:56:17 music volumio5-onboarding[1317675]: time=2026-03-29T17:56:17.234Z level=INFO msg="enabling local network discovery" Mar 29 17:56:17 music volumio5-onboarding[1317675]: time=2026-03-29T17:56:17.241Z level=INFO msg="enabling BLE discovery" Mar 29 17:56:17 music volumio5-onboarding[1317675]: failed to configure discovery: failed to enable BLE discovery: failed to listen for BLE connections: failed to add service to adapter: Method "RegisterApplication" with signature "oa{sv}" on interface "org.bluez.GattManager1" doesn't exist Mar 29 17:56:17 music systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE Mar 29 17:56:17 music systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. Mar 29 17:56:17 music systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 65392. Mar 29 17:56:17 music systemd[1]: Stopped volumio5-onboarding.service - Volumio5 Onboarding Server. Mar 29 17:56:17 music systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. Mar 29 17:56:17 music volumio5-onboarding[1317704]: time=2026-03-29T17:56:17.409Z level=INFO msg="running volumio5-device-gateway" version=10ca7e93+CHANGES buildDate=2026-03-06T14:30:20Z Mar 29 17:56:17 music 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: 4 Mar 29 17:56:17 music 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: 4 Mar 29 17:56:17 music volumio[1332]: info: Received Get System Info Mar 29 17:56:17 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:56:17 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:56:17 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:56:17 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:56:17 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:56:17 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:56:17 music volumio5-onboarding[1317704]: time=2026-03-29T17:56:17.421Z level=INFO msg="system info for 06fe5fe157f017a1685d46c8acca718b" deviceName=music deviceVariant=volumio deviceModel= softwareVersion=4.103 Mar 29 17:56:17 music volumio5-onboarding[1317704]: time=2026-03-29T17:56:17.453Z level=INFO msg="bootstrapping state" hasInternet=true Mar 29 17:56:17 music volumio[1332]: info: Received Get System Info Mar 29 17:56:17 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:56:17 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:56:17 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:56:17 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:56:17 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:56:17 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:56:17 music volumio-remote-updater[576087]: Test mode disabled Mar 29 17:56:17 music volumio-remote-updater[576087]: Alpha mode disabled Mar 29 17:56:17 music volumio-remote-updater[576087]: Alpha legacy test mode disabled Mar 29 17:56:17 music volumio[1332]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"

FIXES

  • Fix for missing PWM backlight module
  • Fix for crash loop on Onboarding plugin

NEW ADDITIONS

  • Bump RPi/CM4 kernel to 6.12.74

","title":"Update v4.119","updateavailable":true} Mar 29 17:56:17 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 29 17:56:17 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:17 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:17 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:56:18 music volumio5-onboarding[1317704]: time=2026-03-29T17:56:18.099Z 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" Mar 29 17:56:18 music volumio5-onboarding[1317704]: time=2026-03-29T17:56:18.100Z 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" Mar 29 17:56:18 music volumio5-onboarding[1317704]: time=2026-03-29T17:56:18.100Z 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" Mar 29 17:56:18 music volumio5-onboarding[1317704]: time=2026-03-29T17:56:18.100Z level=WARN msg="could not read OAuth data for music provider" component=volumio provider=spotify error="could not open plugin config file for \"spop\": open /data/configuration/music_service/spop/config.json: no such file or directory" Mar 29 17:56:18 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:18 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:18 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:56:18 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:18 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:56:19 music volumio5-onboarding[1317704]: time=2026-03-29T17:56:19.361Z level=INFO msg="authenticated Firebase client" component=volumio/firebase userId=PQcO8WbVdWT3mYwk7uwfewO5Yr43 tokenExpiry=2026-03-29T18:56:19.361Z Mar 29 17:56:20 music volumio[1332]: info: Received Get System Info Mar 29 17:56:20 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:56:20 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:56:20 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:56:20 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:56:20 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:56:20 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:56:20 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 29 17:56:20 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 29 17:56:20 music volumio5-onboarding[1317704]: time=2026-03-29T17:56:20.169Z level=INFO msg="enabling local network discovery" Mar 29 17:56:20 music volumio5-onboarding[1317704]: time=2026-03-29T17:56:20.175Z level=INFO msg="enabling BLE discovery" Mar 29 17:56:20 music volumio5-onboarding[1317704]: failed to configure discovery: failed to enable BLE discovery: failed to listen for BLE connections: failed to add service to adapter: Method "RegisterApplication" with signature "oa{sv}" on interface "org.bluez.GattManager1" doesn't exist Mar 29 17:56:20 music systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE Mar 29 17:56:20 music systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. Mar 29 17:56:20 music systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 65393. Mar 29 17:56:20 music systemd[1]: Stopped volumio5-onboarding.service - Volumio5 Onboarding Server. Mar 29 17:56:20 music systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. Mar 29 17:56:20 music volumio5-onboarding[1317720]: time=2026-03-29T17:56:20.410Z level=INFO msg="running volumio5-device-gateway" version=10ca7e93+CHANGES buildDate=2026-03-06T14:30:20Z Mar 29 17:56:20 music 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: 4 Mar 29 17:56:20 music 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: 4 Mar 29 17:56:20 music volumio[1332]: info: Received Get System Info Mar 29 17:56:20 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:56:20 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:56:20 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:56:20 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:56:20 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:56:20 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:56:20 music volumio5-onboarding[1317720]: time=2026-03-29T17:56:20.421Z level=INFO msg="system info for 06fe5fe157f017a1685d46c8acca718b" deviceName=music deviceVariant=volumio deviceModel= softwareVersion=4.103 Mar 29 17:56:20 music volumio5-onboarding[1317720]: time=2026-03-29T17:56:20.473Z level=INFO msg="bootstrapping state" hasInternet=true Mar 29 17:56:20 music volumio[1332]: info: Received Get System Info Mar 29 17:56:20 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:56:20 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:56:20 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:56:20 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:56:20 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:56:20 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:56:20 music volumio-remote-updater[576087]: Test mode disabled Mar 29 17:56:20 music volumio-remote-updater[576087]: Alpha mode disabled Mar 29 17:56:20 music volumio-remote-updater[576087]: Alpha legacy test mode disabled Mar 29 17:56:20 music volumio[1332]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"

FIXES

  • Fix for missing PWM backlight module
  • Fix for crash loop on Onboarding plugin

NEW ADDITIONS

  • Bump RPi/CM4 kernel to 6.12.74

","title":"Update v4.119","updateavailable":true} Mar 29 17:56:20 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 29 17:56:20 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:20 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:20 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:56:21 music volumio5-onboarding[1317720]: time=2026-03-29T17:56:21.039Z 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" Mar 29 17:56:21 music volumio5-onboarding[1317720]: time=2026-03-29T17:56:21.039Z 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" Mar 29 17:56:21 music volumio5-onboarding[1317720]: time=2026-03-29T17:56:21.039Z 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" Mar 29 17:56:21 music volumio5-onboarding[1317720]: time=2026-03-29T17:56:21.039Z level=WARN msg="could not read OAuth data for music provider" component=volumio provider=spotify error="could not open plugin config file for \"spop\": open /data/configuration/music_service/spop/config.json: no such file or directory" Mar 29 17:56:21 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:21 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:21 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:56:21 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:21 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:56:22 music volumio5-onboarding[1317720]: time=2026-03-29T17:56:22.544Z level=INFO msg="authenticated Firebase client" component=volumio/firebase userId=PQcO8WbVdWT3mYwk7uwfewO5Yr43 tokenExpiry=2026-03-29T18:56:22.544Z Mar 29 17:56:23 music volumio[1332]: info: Received Get System Info Mar 29 17:56:23 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:56:23 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:56:23 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:56:23 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:56:23 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:56:23 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:56:23 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 29 17:56:23 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 29 17:56:23 music volumio5-onboarding[1317720]: time=2026-03-29T17:56:23.313Z level=INFO msg="enabling local network discovery" Mar 29 17:56:23 music volumio5-onboarding[1317720]: time=2026-03-29T17:56:23.320Z level=INFO msg="enabling BLE discovery" Mar 29 17:56:23 music volumio5-onboarding[1317720]: failed to configure discovery: failed to enable BLE discovery: failed to listen for BLE connections: failed to add service to adapter: Method "RegisterApplication" with signature "oa{sv}" on interface "org.bluez.GattManager1" doesn't exist Mar 29 17:56:23 music systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE Mar 29 17:56:23 music systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. Mar 29 17:56:23 music systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 65394. Mar 29 17:56:23 music systemd[1]: Stopped volumio5-onboarding.service - Volumio5 Onboarding Server. Mar 29 17:56:23 music systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. Mar 29 17:56:23 music volumio5-onboarding[1317736]: time=2026-03-29T17:56:23.665Z level=INFO msg="running volumio5-device-gateway" version=10ca7e93+CHANGES buildDate=2026-03-06T14:30:20Z Mar 29 17:56:23 music 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: 4 Mar 29 17:56:23 music 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: 4 Mar 29 17:56:23 music volumio[1332]: info: Received Get System Info Mar 29 17:56:23 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:56:23 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:56:23 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:56:23 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:56:23 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:56:23 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:56:23 music volumio5-onboarding[1317736]: time=2026-03-29T17:56:23.677Z level=INFO msg="system info for 06fe5fe157f017a1685d46c8acca718b" deviceName=music deviceVariant=volumio deviceModel= softwareVersion=4.103 Mar 29 17:56:23 music volumio5-onboarding[1317736]: time=2026-03-29T17:56:23.713Z level=INFO msg="bootstrapping state" hasInternet=true Mar 29 17:56:23 music volumio[1332]: info: Received Get System Info Mar 29 17:56:23 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:56:23 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:56:23 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:56:23 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:56:23 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:56:23 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:56:23 music volumio-remote-updater[576087]: Test mode disabled Mar 29 17:56:23 music volumio-remote-updater[576087]: Alpha mode disabled Mar 29 17:56:23 music volumio-remote-updater[576087]: Alpha legacy test mode disabled Mar 29 17:56:23 music volumio[1332]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"

FIXES

  • Fix for missing PWM backlight module
  • Fix for crash loop on Onboarding plugin

NEW ADDITIONS

  • Bump RPi/CM4 kernel to 6.12.74

","title":"Update v4.119","updateavailable":true} Mar 29 17:56:23 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 29 17:56:23 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:23 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:23 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:56:24 music volumio5-onboarding[1317736]: time=2026-03-29T17:56:24.324Z 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" Mar 29 17:56:24 music volumio5-onboarding[1317736]: time=2026-03-29T17:56:24.324Z 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" Mar 29 17:56:24 music volumio5-onboarding[1317736]: time=2026-03-29T17:56:24.324Z 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" Mar 29 17:56:24 music volumio5-onboarding[1317736]: time=2026-03-29T17:56:24.324Z level=WARN msg="could not read OAuth data for music provider" component=volumio provider=spotify error="could not open plugin config file for \"spop\": open /data/configuration/music_service/spop/config.json: no such file or directory" Mar 29 17:56:24 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:24 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:24 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:56:24 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:24 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:56:25 music volumio5-onboarding[1317736]: time=2026-03-29T17:56:25.751Z level=INFO msg="authenticated Firebase client" component=volumio/firebase userId=PQcO8WbVdWT3mYwk7uwfewO5Yr43 tokenExpiry=2026-03-29T18:56:25.751Z Mar 29 17:56:26 music volumio[1332]: info: Received Get System Info Mar 29 17:56:26 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:56:26 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:56:26 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:56:26 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:56:26 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:56:26 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:56:26 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 29 17:56:26 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 29 17:56:26 music volumio5-onboarding[1317736]: time=2026-03-29T17:56:26.518Z level=INFO msg="enabling local network discovery" Mar 29 17:56:26 music volumio5-onboarding[1317736]: time=2026-03-29T17:56:26.525Z level=INFO msg="enabling BLE discovery" Mar 29 17:56:26 music volumio5-onboarding[1317736]: failed to configure discovery: failed to enable BLE discovery: failed to listen for BLE connections: failed to add service to adapter: Method "RegisterApplication" with signature "oa{sv}" on interface "org.bluez.GattManager1" doesn't exist Mar 29 17:56:26 music systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE Mar 29 17:56:26 music systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. Mar 29 17:56:26 music systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 65395. Mar 29 17:56:26 music systemd[1]: Stopped volumio5-onboarding.service - Volumio5 Onboarding Server. Mar 29 17:56:26 music systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. Mar 29 17:56:26 music volumio5-onboarding[1317765]: time=2026-03-29T17:56:26.910Z level=INFO msg="running volumio5-device-gateway" version=10ca7e93+CHANGES buildDate=2026-03-06T14:30:20Z Mar 29 17:56:26 music 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: 4 Mar 29 17:56:26 music 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: 4 Mar 29 17:56:26 music volumio[1332]: info: Received Get System Info Mar 29 17:56:26 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:56:26 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:56:26 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:56:26 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:56:26 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:56:26 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:56:26 music volumio5-onboarding[1317765]: time=2026-03-29T17:56:26.921Z level=INFO msg="system info for 06fe5fe157f017a1685d46c8acca718b" deviceName=music deviceVariant=volumio deviceModel= softwareVersion=4.103 Mar 29 17:56:26 music volumio5-onboarding[1317765]: time=2026-03-29T17:56:26.959Z level=INFO msg="bootstrapping state" hasInternet=true Mar 29 17:56:26 music volumio[1332]: info: Received Get System Info Mar 29 17:56:26 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:56:26 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:56:26 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:56:26 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:56:26 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:56:26 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:56:26 music volumio-remote-updater[576087]: Test mode disabled Mar 29 17:56:26 music volumio-remote-updater[576087]: Alpha mode disabled Mar 29 17:56:26 music volumio-remote-updater[576087]: Alpha legacy test mode disabled Mar 29 17:56:27 music volumio[1332]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"

FIXES

  • Fix for missing PWM backlight module
  • Fix for crash loop on Onboarding plugin

NEW ADDITIONS

  • Bump RPi/CM4 kernel to 6.12.74

","title":"Update v4.119","updateavailable":true} Mar 29 17:56:27 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 29 17:56:27 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:27 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:27 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:56:27 music volumio5-onboarding[1317765]: time=2026-03-29T17:56:27.553Z 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" Mar 29 17:56:27 music volumio5-onboarding[1317765]: time=2026-03-29T17:56:27.554Z 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" Mar 29 17:56:27 music volumio5-onboarding[1317765]: time=2026-03-29T17:56:27.554Z 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" Mar 29 17:56:27 music volumio5-onboarding[1317765]: time=2026-03-29T17:56:27.554Z level=WARN msg="could not read OAuth data for music provider" component=volumio provider=spotify error="could not open plugin config file for \"spop\": open /data/configuration/music_service/spop/config.json: no such file or directory" Mar 29 17:56:27 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:27 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:27 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:56:27 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:27 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:56:28 music volumio5-onboarding[1317765]: time=2026-03-29T17:56:28.864Z level=INFO msg="authenticated Firebase client" component=volumio/firebase userId=PQcO8WbVdWT3mYwk7uwfewO5Yr43 tokenExpiry=2026-03-29T18:56:28.864Z Mar 29 17:56:29 music volumio[1332]: info: Received Get System Info Mar 29 17:56:29 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:56:29 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:56:29 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:56:29 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:56:29 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:56:29 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:56:29 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 29 17:56:29 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 29 17:56:29 music volumio5-onboarding[1317765]: time=2026-03-29T17:56:29.662Z level=INFO msg="enabling local network discovery" Mar 29 17:56:29 music volumio5-onboarding[1317765]: time=2026-03-29T17:56:29.669Z level=INFO msg="enabling BLE discovery" Mar 29 17:56:29 music volumio5-onboarding[1317765]: failed to configure discovery: failed to enable BLE discovery: failed to listen for BLE connections: failed to add service to adapter: Method "RegisterApplication" with signature "oa{sv}" on interface "org.bluez.GattManager1" doesn't exist Mar 29 17:56:29 music systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE Mar 29 17:56:29 music systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. Mar 29 17:56:29 music systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 65396. Mar 29 17:56:29 music systemd[1]: Stopped volumio5-onboarding.service - Volumio5 Onboarding Server. Mar 29 17:56:29 music systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. Mar 29 17:56:29 music volumio5-onboarding[1317779]: time=2026-03-29T17:56:29.909Z level=INFO msg="running volumio5-device-gateway" version=10ca7e93+CHANGES buildDate=2026-03-06T14:30:20Z Mar 29 17:56:29 music 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: 4 Mar 29 17:56:29 music 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: 4 Mar 29 17:56:29 music volumio[1332]: info: Received Get System Info Mar 29 17:56:29 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:56:29 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:56:29 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:56:29 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:56:29 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:56:29 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:56:29 music volumio5-onboarding[1317779]: time=2026-03-29T17:56:29.920Z level=INFO msg="system info for 06fe5fe157f017a1685d46c8acca718b" deviceName=music deviceVariant=volumio deviceModel= softwareVersion=4.103 Mar 29 17:56:29 music volumio5-onboarding[1317779]: time=2026-03-29T17:56:29.960Z level=INFO msg="bootstrapping state" hasInternet=true Mar 29 17:56:29 music volumio[1332]: info: Received Get System Info Mar 29 17:56:29 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:56:29 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:56:29 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:56:29 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:56:29 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:56:29 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:56:29 music volumio-remote-updater[576087]: Test mode disabled Mar 29 17:56:29 music volumio-remote-updater[576087]: Alpha mode disabled Mar 29 17:56:29 music volumio-remote-updater[576087]: Alpha legacy test mode disabled Mar 29 17:56:30 music volumio[1332]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"

FIXES

  • Fix for missing PWM backlight module
  • Fix for crash loop on Onboarding plugin

NEW ADDITIONS

  • Bump RPi/CM4 kernel to 6.12.74

","title":"Update v4.119","updateavailable":true} Mar 29 17:56:30 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 29 17:56:30 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:30 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:30 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:56:30 music volumio5-onboarding[1317779]: time=2026-03-29T17:56:30.496Z 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" Mar 29 17:56:30 music volumio5-onboarding[1317779]: time=2026-03-29T17:56:30.497Z 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" Mar 29 17:56:30 music volumio5-onboarding[1317779]: time=2026-03-29T17:56:30.497Z 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" Mar 29 17:56:30 music volumio5-onboarding[1317779]: time=2026-03-29T17:56:30.497Z level=WARN msg="could not read OAuth data for music provider" component=volumio provider=spotify error="could not open plugin config file for \"spop\": open /data/configuration/music_service/spop/config.json: no such file or directory" Mar 29 17:56:30 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:30 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:30 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:56:31 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:31 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:56:32 music volumio5-onboarding[1317779]: time=2026-03-29T17:56:32.192Z level=INFO msg="authenticated Firebase client" component=volumio/firebase userId=PQcO8WbVdWT3mYwk7uwfewO5Yr43 tokenExpiry=2026-03-29T18:56:32.192Z Mar 29 17:56:33 music volumio[1332]: info: Received Get System Info Mar 29 17:56:33 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:56:33 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:56:33 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:56:33 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:56:33 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:56:33 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:56:33 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 29 17:56:33 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 29 17:56:33 music volumio5-onboarding[1317779]: time=2026-03-29T17:56:33.296Z level=INFO msg="enabling local network discovery" Mar 29 17:56:33 music volumio5-onboarding[1317779]: time=2026-03-29T17:56:33.303Z level=INFO msg="enabling BLE discovery" Mar 29 17:56:33 music volumio5-onboarding[1317779]: failed to configure discovery: failed to enable BLE discovery: failed to listen for BLE connections: failed to add service to adapter: Method "RegisterApplication" with signature "oa{sv}" on interface "org.bluez.GattManager1" doesn't exist Mar 29 17:56:33 music systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE Mar 29 17:56:33 music systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. Mar 29 17:56:33 music systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 65397. Mar 29 17:56:33 music systemd[1]: Stopped volumio5-onboarding.service - Volumio5 Onboarding Server. Mar 29 17:56:33 music systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. Mar 29 17:56:33 music volumio5-onboarding[1317794]: time=2026-03-29T17:56:33.654Z level=INFO msg="running volumio5-device-gateway" version=10ca7e93+CHANGES buildDate=2026-03-06T14:30:20Z Mar 29 17:56:33 music 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: 4 Mar 29 17:56:33 music 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: 4 Mar 29 17:56:33 music volumio[1332]: info: Received Get System Info Mar 29 17:56:33 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:56:33 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:56:33 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:56:33 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:56:33 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:56:33 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:56:33 music volumio5-onboarding[1317794]: time=2026-03-29T17:56:33.664Z level=INFO msg="system info for 06fe5fe157f017a1685d46c8acca718b" deviceName=music deviceVariant=volumio deviceModel= softwareVersion=4.103 Mar 29 17:56:33 music volumio5-onboarding[1317794]: time=2026-03-29T17:56:33.713Z level=INFO msg="bootstrapping state" hasInternet=true Mar 29 17:56:33 music volumio[1332]: info: Received Get System Info Mar 29 17:56:33 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:56:33 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:56:33 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:56:33 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:56:33 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:56:33 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:56:33 music volumio-remote-updater[576087]: Test mode disabled Mar 29 17:56:33 music volumio-remote-updater[576087]: Alpha mode disabled Mar 29 17:56:33 music volumio-remote-updater[576087]: Alpha legacy test mode disabled Mar 29 17:56:33 music volumio[1332]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"

FIXES

  • Fix for missing PWM backlight module
  • Fix for crash loop on Onboarding plugin

NEW ADDITIONS

  • Bump RPi/CM4 kernel to 6.12.74

","title":"Update v4.119","updateavailable":true} Mar 29 17:56:33 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 29 17:56:33 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:33 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:33 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:56:34 music volumio5-onboarding[1317794]: time=2026-03-29T17:56:34.311Z 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" Mar 29 17:56:34 music volumio5-onboarding[1317794]: time=2026-03-29T17:56:34.311Z 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" Mar 29 17:56:34 music volumio5-onboarding[1317794]: time=2026-03-29T17:56:34.311Z 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" Mar 29 17:56:34 music volumio5-onboarding[1317794]: time=2026-03-29T17:56:34.311Z level=WARN msg="could not read OAuth data for music provider" component=volumio provider=spotify error="could not open plugin config file for \"spop\": open /data/configuration/music_service/spop/config.json: no such file or directory" Mar 29 17:56:34 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:34 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:34 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:56:35 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:35 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:56:35 music volumio5-onboarding[1317794]: time=2026-03-29T17:56:35.910Z level=INFO msg="authenticated Firebase client" component=volumio/firebase userId=PQcO8WbVdWT3mYwk7uwfewO5Yr43 tokenExpiry=2026-03-29T18:56:35.910Z Mar 29 17:56:36 music volumio[1332]: info: Received Get System Info Mar 29 17:56:36 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:56:36 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:56:36 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:56:36 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:56:36 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:56:36 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:56:36 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 29 17:56:36 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 29 17:56:36 music volumio5-onboarding[1317794]: time=2026-03-29T17:56:36.646Z level=INFO msg="enabling local network discovery" Mar 29 17:56:36 music volumio5-onboarding[1317794]: time=2026-03-29T17:56:36.653Z level=INFO msg="enabling BLE discovery" Mar 29 17:56:36 music volumio5-onboarding[1317794]: failed to configure discovery: failed to enable BLE discovery: failed to listen for BLE connections: failed to add service to adapter: Method "RegisterApplication" with signature "oa{sv}" on interface "org.bluez.GattManager1" doesn't exist Mar 29 17:56:36 music systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE Mar 29 17:56:36 music systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. Mar 29 17:56:36 music systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 65398. Mar 29 17:56:36 music systemd[1]: Stopped volumio5-onboarding.service - Volumio5 Onboarding Server. Mar 29 17:56:36 music systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. Mar 29 17:56:36 music volumio5-onboarding[1317822]: time=2026-03-29T17:56:36.921Z level=INFO msg="running volumio5-device-gateway" version=10ca7e93+CHANGES buildDate=2026-03-06T14:30:20Z Mar 29 17:56:36 music 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: 4 Mar 29 17:56:36 music 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: 4 Mar 29 17:56:36 music volumio[1332]: info: Received Get System Info Mar 29 17:56:36 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:56:36 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:56:36 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:56:36 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:56:36 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:56:36 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:56:36 music volumio5-onboarding[1317822]: time=2026-03-29T17:56:36.931Z level=INFO msg="system info for 06fe5fe157f017a1685d46c8acca718b" deviceName=music deviceVariant=volumio deviceModel= softwareVersion=4.103 Mar 29 17:56:36 music volumio5-onboarding[1317822]: time=2026-03-29T17:56:36.981Z level=INFO msg="bootstrapping state" hasInternet=true Mar 29 17:56:36 music volumio[1332]: info: Received Get System Info Mar 29 17:56:36 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:56:36 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:56:36 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:56:36 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:56:36 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:56:36 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:56:36 music volumio-remote-updater[576087]: Test mode disabled Mar 29 17:56:36 music volumio-remote-updater[576087]: Alpha mode disabled Mar 29 17:56:36 music volumio-remote-updater[576087]: Alpha legacy test mode disabled Mar 29 17:56:37 music volumio[1332]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"

FIXES

  • Fix for missing PWM backlight module
  • Fix for crash loop on Onboarding plugin

NEW ADDITIONS

  • Bump RPi/CM4 kernel to 6.12.74

","title":"Update v4.119","updateavailable":true} Mar 29 17:56:37 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 29 17:56:37 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:37 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:37 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:56:37 music volumio5-onboarding[1317822]: time=2026-03-29T17:56:37.519Z 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" Mar 29 17:56:37 music volumio5-onboarding[1317822]: time=2026-03-29T17:56:37.519Z 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" Mar 29 17:56:37 music volumio5-onboarding[1317822]: time=2026-03-29T17:56:37.519Z 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" Mar 29 17:56:37 music volumio5-onboarding[1317822]: time=2026-03-29T17:56:37.519Z level=WARN msg="could not read OAuth data for music provider" component=volumio provider=spotify error="could not open plugin config file for \"spop\": open /data/configuration/music_service/spop/config.json: no such file or directory" Mar 29 17:56:37 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:37 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:37 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:56:37 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:37 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:56:38 music volumio5-onboarding[1317822]: time=2026-03-29T17:56:38.798Z level=INFO msg="authenticated Firebase client" component=volumio/firebase userId=PQcO8WbVdWT3mYwk7uwfewO5Yr43 tokenExpiry=2026-03-29T18:56:38.798Z Mar 29 17:56:39 music volumio[1332]: info: Received Get System Info Mar 29 17:56:39 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:56:39 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:56:39 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:56:39 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:56:39 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:56:39 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:56:39 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 29 17:56:39 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 29 17:56:39 music volumio5-onboarding[1317822]: time=2026-03-29T17:56:39.669Z level=INFO msg="enabling local network discovery" Mar 29 17:56:39 music volumio5-onboarding[1317822]: time=2026-03-29T17:56:39.675Z level=INFO msg="enabling BLE discovery" Mar 29 17:56:39 music volumio5-onboarding[1317822]: failed to configure discovery: failed to enable BLE discovery: failed to listen for BLE connections: failed to add service to adapter: Method "RegisterApplication" with signature "oa{sv}" on interface "org.bluez.GattManager1" doesn't exist Mar 29 17:56:39 music systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE Mar 29 17:56:39 music systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. Mar 29 17:56:39 music systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 65399. Mar 29 17:56:39 music systemd[1]: Stopped volumio5-onboarding.service - Volumio5 Onboarding Server. Mar 29 17:56:39 music systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. Mar 29 17:56:39 music volumio5-onboarding[1317837]: time=2026-03-29T17:56:39.921Z level=INFO msg="running volumio5-device-gateway" version=10ca7e93+CHANGES buildDate=2026-03-06T14:30:20Z Mar 29 17:56:39 music 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: 4 Mar 29 17:56:39 music 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: 4 Mar 29 17:56:39 music volumio[1332]: info: Received Get System Info Mar 29 17:56:39 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:56:39 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:56:39 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:56:39 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:56:39 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:56:39 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:56:39 music volumio5-onboarding[1317837]: time=2026-03-29T17:56:39.934Z level=INFO msg="system info for 06fe5fe157f017a1685d46c8acca718b" deviceName=music deviceVariant=volumio deviceModel= softwareVersion=4.103 Mar 29 17:56:39 music volumio5-onboarding[1317837]: time=2026-03-29T17:56:39.981Z level=INFO msg="bootstrapping state" hasInternet=true Mar 29 17:56:39 music volumio[1332]: info: Received Get System Info Mar 29 17:56:39 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:56:39 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:56:39 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:56:39 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:56:39 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:56:39 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:56:39 music volumio-remote-updater[576087]: Test mode disabled Mar 29 17:56:39 music volumio-remote-updater[576087]: Alpha mode disabled Mar 29 17:56:39 music volumio-remote-updater[576087]: Alpha legacy test mode disabled Mar 29 17:56:40 music volumio[1332]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"

FIXES

  • Fix for missing PWM backlight module
  • Fix for crash loop on Onboarding plugin

NEW ADDITIONS

  • Bump RPi/CM4 kernel to 6.12.74

","title":"Update v4.119","updateavailable":true} Mar 29 17:56:40 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 29 17:56:40 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:40 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:40 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:56:40 music volumio5-onboarding[1317837]: time=2026-03-29T17:56:40.585Z 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" Mar 29 17:56:40 music volumio5-onboarding[1317837]: time=2026-03-29T17:56:40.585Z 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" Mar 29 17:56:40 music volumio5-onboarding[1317837]: time=2026-03-29T17:56:40.585Z 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" Mar 29 17:56:40 music volumio5-onboarding[1317837]: time=2026-03-29T17:56:40.585Z level=WARN msg="could not read OAuth data for music provider" component=volumio provider=spotify error="could not open plugin config file for \"spop\": open /data/configuration/music_service/spop/config.json: no such file or directory" Mar 29 17:56:40 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:40 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:40 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:56:41 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:41 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:56:42 music volumio5-onboarding[1317837]: time=2026-03-29T17:56:42.261Z level=INFO msg="authenticated Firebase client" component=volumio/firebase userId=PQcO8WbVdWT3mYwk7uwfewO5Yr43 tokenExpiry=2026-03-29T18:56:42.261Z Mar 29 17:56:43 music volumio[1332]: info: Received Get System Info Mar 29 17:56:43 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:56:43 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:56:43 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:56:43 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:56:43 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:56:43 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:56:43 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 29 17:56:43 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 29 17:56:43 music volumio5-onboarding[1317837]: time=2026-03-29T17:56:43.273Z level=INFO msg="enabling local network discovery" Mar 29 17:56:43 music volumio5-onboarding[1317837]: time=2026-03-29T17:56:43.280Z level=INFO msg="enabling BLE discovery" Mar 29 17:56:43 music volumio5-onboarding[1317837]: failed to configure discovery: failed to enable BLE discovery: failed to listen for BLE connections: failed to add service to adapter: Method "RegisterApplication" with signature "oa{sv}" on interface "org.bluez.GattManager1" doesn't exist Mar 29 17:56:43 music systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE Mar 29 17:56:43 music systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. Mar 29 17:56:43 music systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 65400. Mar 29 17:56:43 music systemd[1]: Stopped volumio5-onboarding.service - Volumio5 Onboarding Server. Mar 29 17:56:43 music systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. Mar 29 17:56:43 music volumio5-onboarding[1317853]: time=2026-03-29T17:56:43.653Z level=INFO msg="running volumio5-device-gateway" version=10ca7e93+CHANGES buildDate=2026-03-06T14:30:20Z Mar 29 17:56:43 music 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: 4 Mar 29 17:56:43 music 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: 4 Mar 29 17:56:43 music volumio[1332]: info: Received Get System Info Mar 29 17:56:43 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:56:43 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:56:43 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:56:43 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:56:43 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:56:43 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:56:43 music volumio5-onboarding[1317853]: time=2026-03-29T17:56:43.664Z level=INFO msg="system info for 06fe5fe157f017a1685d46c8acca718b" deviceName=music deviceVariant=volumio deviceModel= softwareVersion=4.103 Mar 29 17:56:43 music volumio5-onboarding[1317853]: time=2026-03-29T17:56:43.713Z level=INFO msg="bootstrapping state" hasInternet=true Mar 29 17:56:43 music volumio[1332]: info: Received Get System Info Mar 29 17:56:43 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:56:43 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:56:43 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:56:43 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:56:43 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:56:43 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:56:43 music volumio-remote-updater[576087]: Test mode disabled Mar 29 17:56:43 music volumio-remote-updater[576087]: Alpha mode disabled Mar 29 17:56:43 music volumio-remote-updater[576087]: Alpha legacy test mode disabled Mar 29 17:56:43 music volumio[1332]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"

FIXES

  • Fix for missing PWM backlight module
  • Fix for crash loop on Onboarding plugin

NEW ADDITIONS

  • Bump RPi/CM4 kernel to 6.12.74

","title":"Update v4.119","updateavailable":true} Mar 29 17:56:43 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 29 17:56:43 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:43 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:43 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:56:44 music volumio5-onboarding[1317853]: time=2026-03-29T17:56:44.279Z 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" Mar 29 17:56:44 music volumio5-onboarding[1317853]: time=2026-03-29T17:56:44.280Z 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" Mar 29 17:56:44 music volumio5-onboarding[1317853]: time=2026-03-29T17:56:44.280Z 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" Mar 29 17:56:44 music volumio5-onboarding[1317853]: time=2026-03-29T17:56:44.280Z level=WARN msg="could not read OAuth data for music provider" component=volumio provider=spotify error="could not open plugin config file for \"spop\": open /data/configuration/music_service/spop/config.json: no such file or directory" Mar 29 17:56:44 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:44 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:44 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:56:45 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:45 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:56:46 music volumio5-onboarding[1317853]: time=2026-03-29T17:56:46.273Z level=INFO msg="authenticated Firebase client" component=volumio/firebase userId=PQcO8WbVdWT3mYwk7uwfewO5Yr43 tokenExpiry=2026-03-29T18:56:46.273Z Mar 29 17:56:47 music volumio[1332]: info: Received Get System Info Mar 29 17:56:47 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:56:47 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:56:47 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:56:47 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:56:47 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:56:47 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:56:47 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 29 17:56:47 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 29 17:56:47 music volumio5-onboarding[1317853]: time=2026-03-29T17:56:47.058Z level=INFO msg="enabling local network discovery" Mar 29 17:56:47 music volumio5-onboarding[1317853]: time=2026-03-29T17:56:47.065Z level=INFO msg="enabling BLE discovery" Mar 29 17:56:47 music volumio5-onboarding[1317853]: failed to configure discovery: failed to enable BLE discovery: failed to listen for BLE connections: failed to add service to adapter: Method "RegisterApplication" with signature "oa{sv}" on interface "org.bluez.GattManager1" doesn't exist Mar 29 17:56:47 music systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE Mar 29 17:56:47 music systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. Mar 29 17:56:47 music systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 65401. Mar 29 17:56:47 music systemd[1]: Stopped volumio5-onboarding.service - Volumio5 Onboarding Server. Mar 29 17:56:47 music systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. Mar 29 17:56:47 music volumio5-onboarding[1317884]: time=2026-03-29T17:56:47.413Z level=INFO msg="running volumio5-device-gateway" version=10ca7e93+CHANGES buildDate=2026-03-06T14:30:20Z Mar 29 17:56:47 music 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: 4 Mar 29 17:56:47 music 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: 4 Mar 29 17:56:47 music volumio[1332]: info: Received Get System Info Mar 29 17:56:47 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:56:47 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:56:47 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:56:47 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:56:47 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:56:47 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:56:47 music volumio5-onboarding[1317884]: time=2026-03-29T17:56:47.424Z level=INFO msg="system info for 06fe5fe157f017a1685d46c8acca718b" deviceName=music deviceVariant=volumio deviceModel= softwareVersion=4.103 Mar 29 17:56:47 music volumio5-onboarding[1317884]: time=2026-03-29T17:56:47.453Z level=INFO msg="bootstrapping state" hasInternet=true Mar 29 17:56:47 music volumio[1332]: info: Received Get System Info Mar 29 17:56:47 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:56:47 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:56:47 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:56:47 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:56:47 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:56:47 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:56:47 music volumio-remote-updater[576087]: Test mode disabled Mar 29 17:56:47 music volumio-remote-updater[576087]: Alpha mode disabled Mar 29 17:56:47 music volumio-remote-updater[576087]: Alpha legacy test mode disabled Mar 29 17:56:47 music volumio[1332]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"

FIXES

  • Fix for missing PWM backlight module
  • Fix for crash loop on Onboarding plugin

NEW ADDITIONS

  • Bump RPi/CM4 kernel to 6.12.74

","title":"Update v4.119","updateavailable":true} Mar 29 17:56:47 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 29 17:56:47 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:47 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:47 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:56:48 music volumio5-onboarding[1317884]: time=2026-03-29T17:56:48.336Z 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" Mar 29 17:56:48 music volumio5-onboarding[1317884]: time=2026-03-29T17:56:48.336Z 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" Mar 29 17:56:48 music volumio5-onboarding[1317884]: time=2026-03-29T17:56:48.336Z 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" Mar 29 17:56:48 music volumio5-onboarding[1317884]: time=2026-03-29T17:56:48.336Z level=WARN msg="could not read OAuth data for music provider" component=volumio provider=spotify error="could not open plugin config file for \"spop\": open /data/configuration/music_service/spop/config.json: no such file or directory" Mar 29 17:56:48 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:48 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:48 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:56:48 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:48 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:56:50 music volumio5-onboarding[1317884]: time=2026-03-29T17:56:50.061Z level=INFO msg="authenticated Firebase client" component=volumio/firebase userId=PQcO8WbVdWT3mYwk7uwfewO5Yr43 tokenExpiry=2026-03-29T18:56:50.061Z Mar 29 17:56:50 music volumio[1332]: info: Received Get System Info Mar 29 17:56:50 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:56:50 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:56:50 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:56:50 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:56:50 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:56:50 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:56:50 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 29 17:56:50 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 29 17:56:50 music volumio5-onboarding[1317884]: time=2026-03-29T17:56:50.892Z level=INFO msg="enabling local network discovery" Mar 29 17:56:50 music volumio5-onboarding[1317884]: time=2026-03-29T17:56:50.899Z level=INFO msg="enabling BLE discovery" Mar 29 17:56:50 music volumio5-onboarding[1317884]: failed to configure discovery: failed to enable BLE discovery: failed to listen for BLE connections: failed to add service to adapter: Method "RegisterApplication" with signature "oa{sv}" on interface "org.bluez.GattManager1" doesn't exist Mar 29 17:56:50 music systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE Mar 29 17:56:50 music systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. Mar 29 17:56:51 music systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 65402. Mar 29 17:56:51 music systemd[1]: Stopped volumio5-onboarding.service - Volumio5 Onboarding Server. Mar 29 17:56:51 music systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. Mar 29 17:56:51 music volumio5-onboarding[1317900]: time=2026-03-29T17:56:51.157Z level=INFO msg="running volumio5-device-gateway" version=10ca7e93+CHANGES buildDate=2026-03-06T14:30:20Z Mar 29 17:56:51 music 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: 4 Mar 29 17:56:51 music 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: 4 Mar 29 17:56:51 music volumio[1332]: info: Received Get System Info Mar 29 17:56:51 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:56:51 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:56:51 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:56:51 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:56:51 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:56:51 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:56:51 music volumio5-onboarding[1317900]: time=2026-03-29T17:56:51.168Z level=INFO msg="system info for 06fe5fe157f017a1685d46c8acca718b" deviceName=music deviceVariant=volumio deviceModel= softwareVersion=4.103 Mar 29 17:56:51 music volumio5-onboarding[1317900]: time=2026-03-29T17:56:51.213Z level=INFO msg="bootstrapping state" hasInternet=true Mar 29 17:56:51 music volumio[1332]: info: Received Get System Info Mar 29 17:56:51 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:56:51 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:56:51 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:56:51 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:56:51 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:56:51 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:56:51 music volumio-remote-updater[576087]: Test mode disabled Mar 29 17:56:51 music volumio-remote-updater[576087]: Alpha mode disabled Mar 29 17:56:51 music volumio-remote-updater[576087]: Alpha legacy test mode disabled Mar 29 17:56:51 music volumio[1332]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"

FIXES

  • Fix for missing PWM backlight module
  • Fix for crash loop on Onboarding plugin

NEW ADDITIONS

  • Bump RPi/CM4 kernel to 6.12.74

","title":"Update v4.119","updateavailable":true} Mar 29 17:56:51 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 29 17:56:51 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:51 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:51 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:56:51 music volumio5-onboarding[1317900]: time=2026-03-29T17:56:51.759Z 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" Mar 29 17:56:51 music volumio5-onboarding[1317900]: time=2026-03-29T17:56:51.759Z 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" Mar 29 17:56:51 music volumio5-onboarding[1317900]: time=2026-03-29T17:56:51.759Z 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" Mar 29 17:56:51 music volumio5-onboarding[1317900]: time=2026-03-29T17:56:51.759Z level=WARN msg="could not read OAuth data for music provider" component=volumio provider=spotify error="could not open plugin config file for \"spop\": open /data/configuration/music_service/spop/config.json: no such file or directory" Mar 29 17:56:51 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:51 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:51 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:56:52 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:52 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:56:52 music volumio5-onboarding[1317900]: time=2026-03-29T17:56:52.979Z level=INFO msg="authenticated Firebase client" component=volumio/firebase userId=PQcO8WbVdWT3mYwk7uwfewO5Yr43 tokenExpiry=2026-03-29T18:56:52.979Z Mar 29 17:56:53 music volumio[1332]: info: Received Get System Info Mar 29 17:56:53 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:56:53 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:56:53 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:56:53 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:56:53 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:56:53 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:56:53 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 29 17:56:53 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 29 17:56:53 music volumio5-onboarding[1317900]: time=2026-03-29T17:56:53.730Z level=INFO msg="enabling local network discovery" Mar 29 17:56:53 music volumio5-onboarding[1317900]: time=2026-03-29T17:56:53.737Z level=INFO msg="enabling BLE discovery" Mar 29 17:56:53 music volumio5-onboarding[1317900]: failed to configure discovery: failed to enable BLE discovery: failed to listen for BLE connections: failed to add service to adapter: Method "RegisterApplication" with signature "oa{sv}" on interface "org.bluez.GattManager1" doesn't exist Mar 29 17:56:53 music systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE Mar 29 17:56:53 music systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. Mar 29 17:56:53 music systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 65403. Mar 29 17:56:53 music systemd[1]: Stopped volumio5-onboarding.service - Volumio5 Onboarding Server. Mar 29 17:56:53 music systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. Mar 29 17:56:53 music volumio5-onboarding[1317915]: time=2026-03-29T17:56:53.910Z level=INFO msg="running volumio5-device-gateway" version=10ca7e93+CHANGES buildDate=2026-03-06T14:30:20Z Mar 29 17:56:53 music 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: 4 Mar 29 17:56:53 music 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: 4 Mar 29 17:56:53 music volumio[1332]: info: Received Get System Info Mar 29 17:56:53 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:56:53 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:56:53 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:56:53 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:56:53 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:56:53 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:56:53 music volumio5-onboarding[1317915]: time=2026-03-29T17:56:53.920Z level=INFO msg="system info for 06fe5fe157f017a1685d46c8acca718b" deviceName=music deviceVariant=volumio deviceModel= softwareVersion=4.103 Mar 29 17:56:53 music volumio5-onboarding[1317915]: time=2026-03-29T17:56:53.952Z level=INFO msg="bootstrapping state" hasInternet=true Mar 29 17:56:53 music volumio[1332]: info: Received Get System Info Mar 29 17:56:53 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:56:53 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:56:53 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:56:53 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:56:53 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:56:53 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:56:53 music volumio-remote-updater[576087]: Test mode disabled Mar 29 17:56:53 music volumio-remote-updater[576087]: Alpha mode disabled Mar 29 17:56:53 music volumio-remote-updater[576087]: Alpha legacy test mode disabled Mar 29 17:56:54 music volumio[1332]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"

FIXES

  • Fix for missing PWM backlight module
  • Fix for crash loop on Onboarding plugin

NEW ADDITIONS

  • Bump RPi/CM4 kernel to 6.12.74

","title":"Update v4.119","updateavailable":true} Mar 29 17:56:54 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 29 17:56:54 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:54 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:54 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:56:54 music volumio5-onboarding[1317915]: time=2026-03-29T17:56:54.938Z 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" Mar 29 17:56:54 music volumio5-onboarding[1317915]: time=2026-03-29T17:56:54.938Z 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" Mar 29 17:56:54 music volumio5-onboarding[1317915]: time=2026-03-29T17:56:54.938Z 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" Mar 29 17:56:54 music volumio5-onboarding[1317915]: time=2026-03-29T17:56:54.938Z level=WARN msg="could not read OAuth data for music provider" component=volumio provider=spotify error="could not open plugin config file for \"spop\": open /data/configuration/music_service/spop/config.json: no such file or directory" Mar 29 17:56:54 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:54 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:54 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:56:55 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:55 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:56:56 music volumio5-onboarding[1317915]: time=2026-03-29T17:56:56.466Z level=INFO msg="authenticated Firebase client" component=volumio/firebase userId=PQcO8WbVdWT3mYwk7uwfewO5Yr43 tokenExpiry=2026-03-29T18:56:56.466Z Mar 29 17:56:57 music volumio[1332]: info: Received Get System Info Mar 29 17:56:57 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:56:57 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:56:57 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:56:57 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:56:57 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:56:57 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:56:57 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 29 17:56:57 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 29 17:56:57 music volumio5-onboarding[1317915]: time=2026-03-29T17:56:57.282Z level=INFO msg="enabling local network discovery" Mar 29 17:56:57 music volumio5-onboarding[1317915]: time=2026-03-29T17:56:57.289Z level=INFO msg="enabling BLE discovery" Mar 29 17:56:57 music volumio5-onboarding[1317915]: failed to configure discovery: failed to enable BLE discovery: failed to listen for BLE connections: failed to add service to adapter: Method "RegisterApplication" with signature "oa{sv}" on interface "org.bluez.GattManager1" doesn't exist Mar 29 17:56:57 music systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE Mar 29 17:56:57 music systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. Mar 29 17:56:57 music systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 65404. Mar 29 17:56:57 music systemd[1]: Stopped volumio5-onboarding.service - Volumio5 Onboarding Server. Mar 29 17:56:57 music systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. Mar 29 17:56:57 music volumio5-onboarding[1317944]: time=2026-03-29T17:56:57.653Z level=INFO msg="running volumio5-device-gateway" version=10ca7e93+CHANGES buildDate=2026-03-06T14:30:20Z Mar 29 17:56:57 music 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: 4 Mar 29 17:56:57 music 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: 4 Mar 29 17:56:57 music volumio[1332]: info: Received Get System Info Mar 29 17:56:57 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:56:57 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:56:57 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:56:57 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:56:57 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:56:57 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:56:57 music volumio5-onboarding[1317944]: time=2026-03-29T17:56:57.667Z level=INFO msg="system info for 06fe5fe157f017a1685d46c8acca718b" deviceName=music deviceVariant=volumio deviceModel= softwareVersion=4.103 Mar 29 17:56:57 music volumio5-onboarding[1317944]: time=2026-03-29T17:56:57.718Z level=INFO msg="bootstrapping state" hasInternet=true Mar 29 17:56:57 music volumio[1332]: info: Received Get System Info Mar 29 17:56:57 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:56:57 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:56:57 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:56:57 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:56:57 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:56:57 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:56:57 music volumio-remote-updater[576087]: Test mode disabled Mar 29 17:56:57 music volumio-remote-updater[576087]: Alpha mode disabled Mar 29 17:56:57 music volumio-remote-updater[576087]: Alpha legacy test mode disabled Mar 29 17:56:57 music volumio[1332]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"

FIXES

  • Fix for missing PWM backlight module
  • Fix for crash loop on Onboarding plugin

NEW ADDITIONS

  • Bump RPi/CM4 kernel to 6.12.74

","title":"Update v4.119","updateavailable":true} Mar 29 17:56:57 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 29 17:56:57 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:57 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:57 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:56:58 music volumio5-onboarding[1317944]: time=2026-03-29T17:56:58.681Z 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" Mar 29 17:56:58 music volumio5-onboarding[1317944]: time=2026-03-29T17:56:58.681Z 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" Mar 29 17:56:58 music volumio5-onboarding[1317944]: time=2026-03-29T17:56:58.681Z 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" Mar 29 17:56:58 music volumio5-onboarding[1317944]: time=2026-03-29T17:56:58.681Z level=WARN msg="could not read OAuth data for music provider" component=volumio provider=spotify error="could not open plugin config file for \"spop\": open /data/configuration/music_service/spop/config.json: no such file or directory" Mar 29 17:56:58 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:58 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:58 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:56:59 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:56:59 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:57:00 music volumio5-onboarding[1317944]: time=2026-03-29T17:57:00.365Z level=INFO msg="authenticated Firebase client" component=volumio/firebase userId=PQcO8WbVdWT3mYwk7uwfewO5Yr43 tokenExpiry=2026-03-29T18:57:00.365Z Mar 29 17:57:01 music volumio[1332]: info: Received Get System Info Mar 29 17:57:01 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:57:01 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:57:01 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:57:01 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:57:01 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:57:01 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:57:01 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 29 17:57:01 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 29 17:57:01 music volumio5-onboarding[1317944]: time=2026-03-29T17:57:01.185Z level=INFO msg="enabling local network discovery" Mar 29 17:57:01 music volumio5-onboarding[1317944]: time=2026-03-29T17:57:01.192Z level=INFO msg="enabling BLE discovery" Mar 29 17:57:01 music volumio5-onboarding[1317944]: failed to configure discovery: failed to enable BLE discovery: failed to listen for BLE connections: failed to add service to adapter: Method "RegisterApplication" with signature "oa{sv}" on interface "org.bluez.GattManager1" doesn't exist Mar 29 17:57:01 music systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE Mar 29 17:57:01 music systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. Mar 29 17:57:01 music systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 65405. Mar 29 17:57:01 music systemd[1]: Stopped volumio5-onboarding.service - Volumio5 Onboarding Server. Mar 29 17:57:01 music systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. Mar 29 17:57:01 music volumio5-onboarding[1317960]: time=2026-03-29T17:57:01.409Z level=INFO msg="running volumio5-device-gateway" version=10ca7e93+CHANGES buildDate=2026-03-06T14:30:20Z Mar 29 17:57:01 music 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: 4 Mar 29 17:57:01 music 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: 4 Mar 29 17:57:01 music volumio[1332]: info: Received Get System Info Mar 29 17:57:01 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:57:01 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:57:01 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:57:01 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:57:01 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:57:01 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:57:01 music volumio5-onboarding[1317960]: time=2026-03-29T17:57:01.421Z level=INFO msg="system info for 06fe5fe157f017a1685d46c8acca718b" deviceName=music deviceVariant=volumio deviceModel= softwareVersion=4.103 Mar 29 17:57:01 music volumio5-onboarding[1317960]: time=2026-03-29T17:57:01.503Z level=INFO msg="bootstrapping state" hasInternet=true Mar 29 17:57:01 music volumio[1332]: info: Received Get System Info Mar 29 17:57:01 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:57:01 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:57:01 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:57:01 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:57:01 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:57:01 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:57:01 music volumio-remote-updater[576087]: Test mode disabled Mar 29 17:57:01 music volumio-remote-updater[576087]: Alpha mode disabled Mar 29 17:57:01 music volumio-remote-updater[576087]: Alpha legacy test mode disabled Mar 29 17:57:01 music volumio[1332]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"

FIXES

  • Fix for missing PWM backlight module
  • Fix for crash loop on Onboarding plugin

NEW ADDITIONS

  • Bump RPi/CM4 kernel to 6.12.74

","title":"Update v4.119","updateavailable":true} Mar 29 17:57:01 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 29 17:57:01 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:57:01 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:57:01 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:57:02 music volumio5-onboarding[1317960]: time=2026-03-29T17:57:02.086Z 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" Mar 29 17:57:02 music volumio5-onboarding[1317960]: time=2026-03-29T17:57:02.086Z 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" Mar 29 17:57:02 music volumio5-onboarding[1317960]: time=2026-03-29T17:57:02.086Z 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" Mar 29 17:57:02 music volumio5-onboarding[1317960]: time=2026-03-29T17:57:02.086Z level=WARN msg="could not read OAuth data for music provider" component=volumio provider=spotify error="could not open plugin config file for \"spop\": open /data/configuration/music_service/spop/config.json: no such file or directory" Mar 29 17:57:02 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:57:02 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:57:02 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:57:02 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:57:02 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:57:03 music volumio5-onboarding[1317960]: time=2026-03-29T17:57:03.758Z level=INFO msg="authenticated Firebase client" component=volumio/firebase userId=PQcO8WbVdWT3mYwk7uwfewO5Yr43 tokenExpiry=2026-03-29T18:57:03.758Z Mar 29 17:57:05 music volumio[1332]: info: Received Get System Info Mar 29 17:57:05 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:57:05 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:57:05 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:57:05 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:57:05 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:57:05 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:57:05 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 29 17:57:05 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 29 17:57:05 music volumio5-onboarding[1317960]: time=2026-03-29T17:57:05.430Z level=INFO msg="enabling local network discovery" Mar 29 17:57:05 music volumio5-onboarding[1317960]: time=2026-03-29T17:57:05.437Z level=INFO msg="enabling BLE discovery" Mar 29 17:57:05 music volumio5-onboarding[1317960]: failed to configure discovery: failed to enable BLE discovery: failed to listen for BLE connections: failed to add service to adapter: Method "RegisterApplication" with signature "oa{sv}" on interface "org.bluez.GattManager1" doesn't exist Mar 29 17:57:05 music systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE Mar 29 17:57:05 music systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. Mar 29 17:57:05 music systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 65406. Mar 29 17:57:05 music systemd[1]: Stopped volumio5-onboarding.service - Volumio5 Onboarding Server. Mar 29 17:57:05 music systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. Mar 29 17:57:05 music volumio5-onboarding[1317989]: time=2026-03-29T17:57:05.649Z level=INFO msg="running volumio5-device-gateway" version=10ca7e93+CHANGES buildDate=2026-03-06T14:30:20Z Mar 29 17:57:05 music 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: 4 Mar 29 17:57:05 music 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: 4 Mar 29 17:57:05 music volumio[1332]: info: Received Get System Info Mar 29 17:57:05 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:57:05 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:57:05 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:57:05 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:57:05 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:57:05 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:57:05 music volumio5-onboarding[1317989]: time=2026-03-29T17:57:05.660Z level=INFO msg="system info for 06fe5fe157f017a1685d46c8acca718b" deviceName=music deviceVariant=volumio deviceModel= softwareVersion=4.103 Mar 29 17:57:07 music volumio5-onboarding[1317989]: time=2026-03-29T17:57:07.443Z level=INFO msg="bootstrapping state" hasInternet=true Mar 29 17:57:07 music volumio[1332]: info: Received Get System Info Mar 29 17:57:07 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:57:07 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:57:07 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:57:07 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:57:07 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:57:07 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:57:07 music volumio-remote-updater[576087]: Test mode disabled Mar 29 17:57:07 music volumio-remote-updater[576087]: Alpha mode disabled Mar 29 17:57:07 music volumio-remote-updater[576087]: Alpha legacy test mode disabled Mar 29 17:57:09 music volumio[1332]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"

FIXES

  • Fix for missing PWM backlight module
  • Fix for crash loop on Onboarding plugin

NEW ADDITIONS

  • Bump RPi/CM4 kernel to 6.12.74

","title":"Update v4.119","updateavailable":true} Mar 29 17:57:09 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 29 17:57:09 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:57:09 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:57:09 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:57:09 music volumio5-onboarding[1317989]: time=2026-03-29T17:57:09.889Z 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" Mar 29 17:57:09 music volumio5-onboarding[1317989]: time=2026-03-29T17:57:09.889Z 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" Mar 29 17:57:09 music volumio5-onboarding[1317989]: time=2026-03-29T17:57:09.889Z 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" Mar 29 17:57:09 music volumio5-onboarding[1317989]: time=2026-03-29T17:57:09.889Z level=WARN msg="could not read OAuth data for music provider" component=volumio provider=spotify error="could not open plugin config file for \"spop\": open /data/configuration/music_service/spop/config.json: no such file or directory" Mar 29 17:57:09 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:57:09 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:57:09 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:57:10 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:57:10 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:57:11 music volumio5-onboarding[1317989]: time=2026-03-29T17:57:11.215Z level=INFO msg="authenticated Firebase client" component=volumio/firebase userId=PQcO8WbVdWT3mYwk7uwfewO5Yr43 tokenExpiry=2026-03-29T18:57:11.215Z Mar 29 17:57:12 music volumio[1332]: info: Received Get System Info Mar 29 17:57:12 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:57:12 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:57:12 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:57:12 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:57:12 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:57:12 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:57:12 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 29 17:57:12 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 29 17:57:12 music volumio5-onboarding[1317989]: time=2026-03-29T17:57:12.040Z level=INFO msg="enabling local network discovery" Mar 29 17:57:12 music volumio5-onboarding[1317989]: time=2026-03-29T17:57:12.047Z level=INFO msg="enabling BLE discovery" Mar 29 17:57:12 music volumio5-onboarding[1317989]: failed to configure discovery: failed to enable BLE discovery: failed to listen for BLE connections: failed to add service to adapter: Method "RegisterApplication" with signature "oa{sv}" on interface "org.bluez.GattManager1" doesn't exist Mar 29 17:57:12 music systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE Mar 29 17:57:12 music systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. Mar 29 17:57:12 music systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 65407. Mar 29 17:57:12 music systemd[1]: Stopped volumio5-onboarding.service - Volumio5 Onboarding Server. Mar 29 17:57:12 music systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. Mar 29 17:57:12 music volumio5-onboarding[1318009]: time=2026-03-29T17:57:12.409Z level=INFO msg="running volumio5-device-gateway" version=10ca7e93+CHANGES buildDate=2026-03-06T14:30:20Z Mar 29 17:57:12 music 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: 4 Mar 29 17:57:12 music 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: 4 Mar 29 17:57:12 music volumio[1332]: info: Received Get System Info Mar 29 17:57:12 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:57:12 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:57:12 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:57:12 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:57:12 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:57:12 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:57:12 music volumio5-onboarding[1318009]: time=2026-03-29T17:57:12.420Z level=INFO msg="system info for 06fe5fe157f017a1685d46c8acca718b" deviceName=music deviceVariant=volumio deviceModel= softwareVersion=4.103 Mar 29 17:57:12 music volumio5-onboarding[1318009]: time=2026-03-29T17:57:12.562Z level=INFO msg="bootstrapping state" hasInternet=true Mar 29 17:57:12 music volumio[1332]: info: Received Get System Info Mar 29 17:57:12 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:57:12 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:57:12 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:57:12 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:57:12 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:57:12 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:57:12 music volumio-remote-updater[576087]: Test mode disabled Mar 29 17:57:12 music volumio-remote-updater[576087]: Alpha mode disabled Mar 29 17:57:12 music volumio-remote-updater[576087]: Alpha legacy test mode disabled Mar 29 17:57:12 music volumio[1332]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"

FIXES

  • Fix for missing PWM backlight module
  • Fix for crash loop on Onboarding plugin

NEW ADDITIONS

  • Bump RPi/CM4 kernel to 6.12.74

","title":"Update v4.119","updateavailable":true} Mar 29 17:57:12 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 29 17:57:12 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:57:12 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:57:12 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:57:13 music volumio5-onboarding[1318009]: time=2026-03-29T17:57:13.162Z 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" Mar 29 17:57:13 music volumio5-onboarding[1318009]: time=2026-03-29T17:57:13.162Z 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" Mar 29 17:57:13 music volumio5-onboarding[1318009]: time=2026-03-29T17:57:13.162Z 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" Mar 29 17:57:13 music volumio5-onboarding[1318009]: time=2026-03-29T17:57:13.162Z level=WARN msg="could not read OAuth data for music provider" component=volumio provider=spotify error="could not open plugin config file for \"spop\": open /data/configuration/music_service/spop/config.json: no such file or directory" Mar 29 17:57:13 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:57:13 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:57:13 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:57:13 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:57:13 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:57:14 music volumio5-onboarding[1318009]: time=2026-03-29T17:57:14.359Z level=INFO msg="authenticated Firebase client" component=volumio/firebase userId=PQcO8WbVdWT3mYwk7uwfewO5Yr43 tokenExpiry=2026-03-29T18:57:14.359Z Mar 29 17:57:15 music volumio[1332]: info: Received Get System Info Mar 29 17:57:15 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:57:15 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:57:15 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:57:15 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:57:15 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:57:15 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:57:15 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 29 17:57:15 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 29 17:57:15 music volumio5-onboarding[1318009]: time=2026-03-29T17:57:15.152Z level=INFO msg="enabling local network discovery" Mar 29 17:57:15 music volumio5-onboarding[1318009]: time=2026-03-29T17:57:15.158Z level=INFO msg="enabling BLE discovery" Mar 29 17:57:15 music volumio5-onboarding[1318009]: failed to configure discovery: failed to enable BLE discovery: failed to listen for BLE connections: failed to add service to adapter: Method "RegisterApplication" with signature "oa{sv}" on interface "org.bluez.GattManager1" doesn't exist Mar 29 17:57:15 music systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE Mar 29 17:57:15 music systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. Mar 29 17:57:15 music systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 65408. Mar 29 17:57:15 music systemd[1]: Stopped volumio5-onboarding.service - Volumio5 Onboarding Server. Mar 29 17:57:15 music systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. Mar 29 17:57:15 music volumio5-onboarding[1318037]: time=2026-03-29T17:57:15.413Z level=INFO msg="running volumio5-device-gateway" version=10ca7e93+CHANGES buildDate=2026-03-06T14:30:20Z Mar 29 17:57:15 music 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: 4 Mar 29 17:57:15 music 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: 4 Mar 29 17:57:15 music volumio[1332]: info: Received Get System Info Mar 29 17:57:15 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:57:15 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:57:15 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:57:15 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:57:15 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:57:15 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:57:15 music volumio5-onboarding[1318037]: time=2026-03-29T17:57:15.431Z level=INFO msg="system info for 06fe5fe157f017a1685d46c8acca718b" deviceName=music deviceVariant=volumio deviceModel= softwareVersion=4.103 Mar 29 17:57:15 music volumio5-onboarding[1318037]: time=2026-03-29T17:57:15.475Z level=INFO msg="bootstrapping state" hasInternet=true Mar 29 17:57:15 music volumio[1332]: info: Received Get System Info Mar 29 17:57:15 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:57:15 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:57:15 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:57:15 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:57:15 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:57:15 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:57:15 music volumio-remote-updater[576087]: Test mode disabled Mar 29 17:57:15 music volumio-remote-updater[576087]: Alpha mode disabled Mar 29 17:57:15 music volumio-remote-updater[576087]: Alpha legacy test mode disabled Mar 29 17:57:15 music volumio[1332]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"

FIXES

  • Fix for missing PWM backlight module
  • Fix for crash loop on Onboarding plugin

NEW ADDITIONS

  • Bump RPi/CM4 kernel to 6.12.74

","title":"Update v4.119","updateavailable":true} Mar 29 17:57:15 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 29 17:57:15 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:57:15 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:57:15 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:57:16 music volumio5-onboarding[1318037]: time=2026-03-29T17:57:16.025Z 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" Mar 29 17:57:16 music volumio5-onboarding[1318037]: time=2026-03-29T17:57:16.026Z 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" Mar 29 17:57:16 music volumio5-onboarding[1318037]: time=2026-03-29T17:57:16.026Z 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" Mar 29 17:57:16 music volumio5-onboarding[1318037]: time=2026-03-29T17:57:16.026Z level=WARN msg="could not read OAuth data for music provider" component=volumio provider=spotify error="could not open plugin config file for \"spop\": open /data/configuration/music_service/spop/config.json: no such file or directory" Mar 29 17:57:16 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:57:16 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:57:16 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:57:16 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:57:16 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:57:17 music volumio5-onboarding[1318037]: time=2026-03-29T17:57:17.525Z level=INFO msg="authenticated Firebase client" component=volumio/firebase userId=PQcO8WbVdWT3mYwk7uwfewO5Yr43 tokenExpiry=2026-03-29T18:57:17.525Z Mar 29 17:57:18 music volumio[1332]: info: Received Get System Info Mar 29 17:57:18 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:57:18 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:57:18 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:57:18 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:57:18 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:57:18 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:57:18 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 29 17:57:18 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 29 17:57:18 music volumio5-onboarding[1318037]: time=2026-03-29T17:57:18.305Z level=INFO msg="enabling local network discovery" Mar 29 17:57:18 music volumio5-onboarding[1318037]: time=2026-03-29T17:57:18.312Z level=INFO msg="enabling BLE discovery" Mar 29 17:57:18 music volumio5-onboarding[1318037]: failed to configure discovery: failed to enable BLE discovery: failed to listen for BLE connections: failed to add service to adapter: Method "RegisterApplication" with signature "oa{sv}" on interface "org.bluez.GattManager1" doesn't exist Mar 29 17:57:18 music systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE Mar 29 17:57:18 music systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. Mar 29 17:57:18 music systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 65409. Mar 29 17:57:18 music systemd[1]: Stopped volumio5-onboarding.service - Volumio5 Onboarding Server. Mar 29 17:57:18 music systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. Mar 29 17:57:18 music volumio5-onboarding[1318052]: time=2026-03-29T17:57:18.653Z level=INFO msg="running volumio5-device-gateway" version=10ca7e93+CHANGES buildDate=2026-03-06T14:30:20Z Mar 29 17:57:18 music 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: 4 Mar 29 17:57:18 music 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: 4 Mar 29 17:57:18 music volumio[1332]: info: Received Get System Info Mar 29 17:57:18 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:57:18 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:57:18 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:57:18 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:57:18 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:57:18 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:57:18 music volumio5-onboarding[1318052]: time=2026-03-29T17:57:18.663Z level=INFO msg="system info for 06fe5fe157f017a1685d46c8acca718b" deviceName=music deviceVariant=volumio deviceModel= softwareVersion=4.103 Mar 29 17:57:18 music volumio5-onboarding[1318052]: time=2026-03-29T17:57:18.715Z level=INFO msg="bootstrapping state" hasInternet=true Mar 29 17:57:18 music volumio[1332]: info: Received Get System Info Mar 29 17:57:18 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:57:18 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:57:18 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:57:18 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:57:18 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:57:18 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:57:18 music volumio-remote-updater[576087]: Test mode disabled Mar 29 17:57:18 music volumio-remote-updater[576087]: Alpha mode disabled Mar 29 17:57:18 music volumio-remote-updater[576087]: Alpha legacy test mode disabled Mar 29 17:57:18 music volumio[1332]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"

FIXES

  • Fix for missing PWM backlight module
  • Fix for crash loop on Onboarding plugin

NEW ADDITIONS

  • Bump RPi/CM4 kernel to 6.12.74

","title":"Update v4.119","updateavailable":true} Mar 29 17:57:18 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 29 17:57:18 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:57:18 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:57:18 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:57:19 music volumio5-onboarding[1318052]: time=2026-03-29T17:57:19.268Z 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" Mar 29 17:57:19 music volumio5-onboarding[1318052]: time=2026-03-29T17:57:19.268Z 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" Mar 29 17:57:19 music volumio5-onboarding[1318052]: time=2026-03-29T17:57:19.268Z 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" Mar 29 17:57:19 music volumio5-onboarding[1318052]: time=2026-03-29T17:57:19.268Z level=WARN msg="could not read OAuth data for music provider" component=volumio provider=spotify error="could not open plugin config file for \"spop\": open /data/configuration/music_service/spop/config.json: no such file or directory" Mar 29 17:57:19 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:57:19 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:57:19 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:57:19 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:57:19 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:57:20 music volumio5-onboarding[1318052]: time=2026-03-29T17:57:20.572Z level=INFO msg="authenticated Firebase client" component=volumio/firebase userId=PQcO8WbVdWT3mYwk7uwfewO5Yr43 tokenExpiry=2026-03-29T18:57:20.572Z Mar 29 17:57:21 music volumio[1332]: info: Received Get System Info Mar 29 17:57:21 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:57:21 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:57:21 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:57:21 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:57:21 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:57:21 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:57:21 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 29 17:57:21 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 29 17:57:21 music volumio5-onboarding[1318052]: time=2026-03-29T17:57:21.427Z level=INFO msg="enabling local network discovery" Mar 29 17:57:21 music volumio5-onboarding[1318052]: time=2026-03-29T17:57:21.434Z level=INFO msg="enabling BLE discovery" Mar 29 17:57:21 music volumio5-onboarding[1318052]: failed to configure discovery: failed to enable BLE discovery: failed to listen for BLE connections: failed to add service to adapter: Method "RegisterApplication" with signature "oa{sv}" on interface "org.bluez.GattManager1" doesn't exist Mar 29 17:57:21 music systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE Mar 29 17:57:21 music systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. Mar 29 17:57:21 music systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 65410. Mar 29 17:57:21 music systemd[1]: Stopped volumio5-onboarding.service - Volumio5 Onboarding Server. Mar 29 17:57:21 music systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. Mar 29 17:57:21 music volumio5-onboarding[1318067]: time=2026-03-29T17:57:21.653Z level=INFO msg="running volumio5-device-gateway" version=10ca7e93+CHANGES buildDate=2026-03-06T14:30:20Z Mar 29 17:57:21 music 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: 4 Mar 29 17:57:21 music 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: 4 Mar 29 17:57:21 music volumio[1332]: info: Received Get System Info Mar 29 17:57:21 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:57:21 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:57:21 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:57:21 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:57:21 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:57:21 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:57:21 music volumio5-onboarding[1318067]: time=2026-03-29T17:57:21.665Z level=INFO msg="system info for 06fe5fe157f017a1685d46c8acca718b" deviceName=music deviceVariant=volumio deviceModel= softwareVersion=4.103 Mar 29 17:57:21 music volumio5-onboarding[1318067]: time=2026-03-29T17:57:21.713Z level=INFO msg="bootstrapping state" hasInternet=true Mar 29 17:57:21 music volumio[1332]: info: Received Get System Info Mar 29 17:57:21 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:57:21 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:57:21 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:57:21 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:57:21 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:57:21 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:57:21 music volumio-remote-updater[576087]: Test mode disabled Mar 29 17:57:21 music volumio-remote-updater[576087]: Alpha mode disabled Mar 29 17:57:21 music volumio-remote-updater[576087]: Alpha legacy test mode disabled Mar 29 17:57:21 music volumio[1332]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"

FIXES

  • Fix for missing PWM backlight module
  • Fix for crash loop on Onboarding plugin

NEW ADDITIONS

  • Bump RPi/CM4 kernel to 6.12.74

","title":"Update v4.119","updateavailable":true} Mar 29 17:57:21 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 29 17:57:21 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:57:21 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:57:21 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:57:22 music volumio5-onboarding[1318067]: time=2026-03-29T17:57:22.271Z 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" Mar 29 17:57:22 music volumio5-onboarding[1318067]: time=2026-03-29T17:57:22.271Z 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" Mar 29 17:57:22 music volumio5-onboarding[1318067]: time=2026-03-29T17:57:22.271Z 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" Mar 29 17:57:22 music volumio5-onboarding[1318067]: time=2026-03-29T17:57:22.271Z level=WARN msg="could not read OAuth data for music provider" component=volumio provider=spotify error="could not open plugin config file for \"spop\": open /data/configuration/music_service/spop/config.json: no such file or directory" Mar 29 17:57:22 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:57:22 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:57:22 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:57:22 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:57:22 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:57:23 music volumio5-onboarding[1318067]: time=2026-03-29T17:57:23.445Z level=INFO msg="authenticated Firebase client" component=volumio/firebase userId=PQcO8WbVdWT3mYwk7uwfewO5Yr43 tokenExpiry=2026-03-29T18:57:23.445Z Mar 29 17:57:24 music volumio[1332]: info: Received Get System Info Mar 29 17:57:24 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:57:24 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:57:24 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:57:24 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:57:24 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:57:24 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:57:24 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 29 17:57:24 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 29 17:57:24 music volumio5-onboarding[1318067]: time=2026-03-29T17:57:24.229Z level=INFO msg="enabling local network discovery" Mar 29 17:57:24 music volumio5-onboarding[1318067]: time=2026-03-29T17:57:24.235Z level=INFO msg="enabling BLE discovery" Mar 29 17:57:24 music volumio5-onboarding[1318067]: failed to configure discovery: failed to enable BLE discovery: failed to listen for BLE connections: failed to add service to adapter: Method "RegisterApplication" with signature "oa{sv}" on interface "org.bluez.GattManager1" doesn't exist Mar 29 17:57:24 music systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE Mar 29 17:57:24 music systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. Mar 29 17:57:24 music systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 65411. Mar 29 17:57:24 music systemd[1]: Stopped volumio5-onboarding.service - Volumio5 Onboarding Server. Mar 29 17:57:24 music systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. Mar 29 17:57:24 music volumio5-onboarding[1318081]: time=2026-03-29T17:57:24.409Z level=INFO msg="running volumio5-device-gateway" version=10ca7e93+CHANGES buildDate=2026-03-06T14:30:20Z Mar 29 17:57:24 music 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: 4 Mar 29 17:57:24 music 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: 4 Mar 29 17:57:24 music volumio[1332]: info: Received Get System Info Mar 29 17:57:24 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:57:24 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:57:24 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:57:24 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:57:24 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:57:24 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:57:24 music volumio5-onboarding[1318081]: time=2026-03-29T17:57:24.421Z level=INFO msg="system info for 06fe5fe157f017a1685d46c8acca718b" deviceName=music deviceVariant=volumio deviceModel= softwareVersion=4.103 Mar 29 17:57:24 music volumio5-onboarding[1318081]: time=2026-03-29T17:57:24.473Z level=INFO msg="bootstrapping state" hasInternet=true Mar 29 17:57:24 music volumio[1332]: info: Received Get System Info Mar 29 17:57:24 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:57:24 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:57:24 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:57:24 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:57:24 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:57:24 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:57:24 music volumio-remote-updater[576087]: Test mode disabled Mar 29 17:57:24 music volumio-remote-updater[576087]: Alpha mode disabled Mar 29 17:57:24 music volumio-remote-updater[576087]: Alpha legacy test mode disabled Mar 29 17:57:24 music volumio[1332]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"

FIXES

  • Fix for missing PWM backlight module
  • Fix for crash loop on Onboarding plugin

NEW ADDITIONS

  • Bump RPi/CM4 kernel to 6.12.74

","title":"Update v4.119","updateavailable":true} Mar 29 17:57:24 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 29 17:57:24 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:57:24 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:57:24 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:57:25 music volumio5-onboarding[1318081]: time=2026-03-29T17:57:25.038Z 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" Mar 29 17:57:25 music volumio5-onboarding[1318081]: time=2026-03-29T17:57:25.039Z 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" Mar 29 17:57:25 music volumio5-onboarding[1318081]: time=2026-03-29T17:57:25.039Z 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" Mar 29 17:57:25 music volumio5-onboarding[1318081]: time=2026-03-29T17:57:25.039Z level=WARN msg="could not read OAuth data for music provider" component=volumio provider=spotify error="could not open plugin config file for \"spop\": open /data/configuration/music_service/spop/config.json: no such file or directory" Mar 29 17:57:25 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:57:25 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:57:25 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:57:25 music volumio[1332]: verbose: New Socket.io Connection to 192.168.1.87 from 192.168.1.93 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) FxiOS/148.2 Mobile/15E148 Safari/604.1 Engine version: 3 Transport: polling Total Clients: 5 Mar 29 17:57:25 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:57:25 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:57:25 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 29 17:57:25 music volumio[1332]: info: CoreCommandRouter::volumioGetVisibleSources Mar 29 17:57:25 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 29 17:57:25 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:57:25 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:57:25 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Mar 29 17:57:25 music volumio[1332]: info: CoreCommandRouter::volumioGetQueue Mar 29 17:57:25 music volumio[1332]: info: CoreStateMachine::getQueue Mar 29 17:57:25 music volumio[1332]: info: CorePlayQueue::getQueue Mar 29 17:57:25 music volumio[1332]: info: Listing playlists Mar 29 17:57:25 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 29 17:57:25 music volumio[1332]: info: Received Get System Info Mar 29 17:57:25 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:57:25 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:57:25 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:57:25 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:57:25 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:57:25 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:57:25 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:57:25 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:57:25 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Mar 29 17:57:25 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 29 17:57:26 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Mar 29 17:57:26 music volumio5-onboarding[1318081]: time=2026-03-29T17:57:26.663Z level=INFO msg="authenticated Firebase client" component=volumio/firebase userId=PQcO8WbVdWT3mYwk7uwfewO5Yr43 tokenExpiry=2026-03-29T18:57:26.663Z Mar 29 17:57:27 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:57:27 music volumio[1332]: info: Received Get System Info Mar 29 17:57:27 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:57:27 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:57:27 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:57:27 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:57:27 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:57:27 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:57:27 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:57:27 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Mar 29 17:57:27 music volumio[1332]: info: Received Get System Info Mar 29 17:57:27 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:57:27 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:57:27 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:57:27 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:57:27 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:57:27 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:57:27 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 29 17:57:27 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 29 17:57:27 music volumio5-onboarding[1318081]: time=2026-03-29T17:57:27.598Z level=INFO msg="enabling local network discovery" Mar 29 17:57:27 music volumio5-onboarding[1318081]: time=2026-03-29T17:57:27.606Z level=INFO msg="enabling BLE discovery" Mar 29 17:57:27 music volumio5-onboarding[1318081]: failed to configure discovery: failed to enable BLE discovery: failed to listen for BLE connections: failed to add service to adapter: Method "RegisterApplication" with signature "oa{sv}" on interface "org.bluez.GattManager1" doesn't exist Mar 29 17:57:27 music systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE Mar 29 17:57:27 music systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. Mar 29 17:57:27 music systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 65412. Mar 29 17:57:27 music systemd[1]: Stopped volumio5-onboarding.service - Volumio5 Onboarding Server. Mar 29 17:57:27 music systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. Mar 29 17:57:27 music volumio5-onboarding[1318112]: time=2026-03-29T17:57:27.917Z level=INFO msg="running volumio5-device-gateway" version=10ca7e93+CHANGES buildDate=2026-03-06T14:30:20Z Mar 29 17:57:27 music 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: 5 Mar 29 17:57:27 music 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: 5 Mar 29 17:57:27 music volumio[1332]: info: Received Get System Info Mar 29 17:57:27 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:57:27 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:57:27 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:57:27 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:57:27 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:57:27 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:57:27 music volumio5-onboarding[1318112]: time=2026-03-29T17:57:27.932Z level=INFO msg="system info for 06fe5fe157f017a1685d46c8acca718b" deviceName=music deviceVariant=volumio deviceModel= softwareVersion=4.103 Mar 29 17:57:27 music volumio5-onboarding[1318112]: time=2026-03-29T17:57:27.973Z level=INFO msg="bootstrapping state" hasInternet=true Mar 29 17:57:27 music volumio[1332]: info: Received Get System Info Mar 29 17:57:27 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:57:27 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:57:27 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:57:27 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:57:27 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:57:27 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:57:27 music volumio-remote-updater[576087]: Test mode disabled Mar 29 17:57:27 music volumio-remote-updater[576087]: Alpha mode disabled Mar 29 17:57:27 music volumio-remote-updater[576087]: Alpha legacy test mode disabled Mar 29 17:57:28 music volumio[1332]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"

FIXES

  • Fix for missing PWM backlight module
  • Fix for crash loop on Onboarding plugin

NEW ADDITIONS

  • Bump RPi/CM4 kernel to 6.12.74

","title":"Update v4.119","updateavailable":true} Mar 29 17:57:28 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 29 17:57:28 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:57:28 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:57:28 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:57:28 music volumio5-onboarding[1318112]: time=2026-03-29T17:57:28.912Z 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" Mar 29 17:57:28 music volumio5-onboarding[1318112]: time=2026-03-29T17:57:28.912Z 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" Mar 29 17:57:28 music volumio5-onboarding[1318112]: time=2026-03-29T17:57:28.912Z 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" Mar 29 17:57:28 music volumio5-onboarding[1318112]: time=2026-03-29T17:57:28.912Z level=WARN msg="could not read OAuth data for music provider" component=volumio provider=spotify error="could not open plugin config file for \"spop\": open /data/configuration/music_service/spop/config.json: no such file or directory" Mar 29 17:57:28 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:57:28 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:57:28 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:57:29 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:57:29 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:57:30 music volumio5-onboarding[1318112]: time=2026-03-29T17:57:30.649Z level=INFO msg="authenticated Firebase client" component=volumio/firebase userId=PQcO8WbVdWT3mYwk7uwfewO5Yr43 tokenExpiry=2026-03-29T18:57:30.649Z Mar 29 17:57:31 music volumio[1332]: info: Received Get System Info Mar 29 17:57:31 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:57:31 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:57:31 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:57:31 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:57:31 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:57:31 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:57:31 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 29 17:57:31 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 29 17:57:31 music volumio5-onboarding[1318112]: time=2026-03-29T17:57:31.597Z level=INFO msg="enabling local network discovery" Mar 29 17:57:31 music volumio5-onboarding[1318112]: time=2026-03-29T17:57:31.611Z level=INFO msg="enabling BLE discovery" Mar 29 17:57:31 music volumio5-onboarding[1318112]: failed to configure discovery: failed to enable BLE discovery: failed to listen for BLE connections: failed to add service to adapter: Method "RegisterApplication" with signature "oa{sv}" on interface "org.bluez.GattManager1" doesn't exist Mar 29 17:57:31 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:57:31 music volumio[1332]: info: Received Get System Info Mar 29 17:57:31 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:57:31 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:57:31 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:57:31 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:57:31 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:57:31 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:57:31 music systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE Mar 29 17:57:31 music systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. Mar 29 17:57:31 music systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 65413. Mar 29 17:57:31 music systemd[1]: Stopped volumio5-onboarding.service - Volumio5 Onboarding Server. Mar 29 17:57:31 music systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. Mar 29 17:57:31 music volumio5-onboarding[1318135]: time=2026-03-29T17:57:31.933Z level=INFO msg="running volumio5-device-gateway" version=10ca7e93+CHANGES buildDate=2026-03-06T14:30:20Z Mar 29 17:57:31 music 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: 5 Mar 29 17:57:31 music 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: 5 Mar 29 17:57:31 music volumio[1332]: info: Received Get System Info Mar 29 17:57:31 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:57:31 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:57:31 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:57:31 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:57:31 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:57:31 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:57:31 music volumio5-onboarding[1318135]: time=2026-03-29T17:57:31.985Z level=INFO msg="system info for 06fe5fe157f017a1685d46c8acca718b" deviceName=music deviceVariant=volumio deviceModel= softwareVersion=4.103 Mar 29 17:57:32 music volumio5-onboarding[1318135]: time=2026-03-29T17:57:32.038Z level=INFO msg="bootstrapping state" hasInternet=true Mar 29 17:57:32 music volumio[1332]: info: Received Get System Info Mar 29 17:57:32 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:57:32 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:57:32 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:57:32 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:57:32 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:57:32 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:57:32 music volumio-remote-updater[576087]: Test mode disabled Mar 29 17:57:32 music volumio-remote-updater[576087]: Alpha mode disabled Mar 29 17:57:32 music volumio-remote-updater[576087]: Alpha legacy test mode disabled Mar 29 17:57:32 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:57:32 music volumio[1332]: info: Received Get System Info Mar 29 17:57:32 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:57:32 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:57:32 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:57:32 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:57:32 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:57:32 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:57:32 music volumio[1332]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"

FIXES

  • Fix for missing PWM backlight module
  • Fix for crash loop on Onboarding plugin

NEW ADDITIONS

  • Bump RPi/CM4 kernel to 6.12.74

","title":"Update v4.119","updateavailable":true} Mar 29 17:57:32 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 29 17:57:32 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:57:32 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:57:32 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:57:32 music volumio5-onboarding[1318135]: time=2026-03-29T17:57:32.753Z 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" Mar 29 17:57:32 music volumio5-onboarding[1318135]: time=2026-03-29T17:57:32.756Z 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" Mar 29 17:57:32 music volumio5-onboarding[1318135]: time=2026-03-29T17:57:32.756Z 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" Mar 29 17:57:32 music volumio5-onboarding[1318135]: time=2026-03-29T17:57:32.756Z level=WARN msg="could not read OAuth data for music provider" component=volumio provider=spotify error="could not open plugin config file for \"spop\": open /data/configuration/music_service/spop/config.json: no such file or directory" Mar 29 17:57:32 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:57:32 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:57:32 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:57:32 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:57:32 music volumio[1332]: info: Received Get System Info Mar 29 17:57:32 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 29 17:57:32 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 29 17:57:32 music volumio[1332]: info: Discovery: Getting this device information Mar 29 17:57:32 music volumio[1332]: info: CoreCommandRouter::volumioGetState Mar 29 17:57:32 music volumio[1332]: info: CorePlayQueue::getTrack 0 Mar 29 17:57:32 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 29 17:57:33 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 17:57:33 music volumio[1332]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 29 17:57:33 music volumio5-onboarding[1318135]: time=2026-03-29T17:57:33.968Z level=INFO msg="authenticated Firebase client" component=volumio/firebase userId=PQcO8WbVdWT3mYwk7uwfewO5Yr43 tokenExpiry=2026-03-29T18:57:33.968Z Mar 29 17:57:35 music volumio[1332]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 29 17:57:35 music volumio[1332]: TypeError: Cannot read properties of null (reading 'slice') Mar 29 17:57:35 music volumio[1332]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:718:41) Mar 29 17:57:35 music volumio[1332]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:728:7) Mar 29 17:57:35 music volumio[1332]: at Object.onceWrapper (node:events:629:26) Mar 29 17:57:35 music volumio[1332]: at ClientRequest.emit (node:events:514:28) Mar 29 17:57:35 music volumio[1332]: at HTTPParser.parserOnIncomingClient [as onIncoming] (node:_http_client:693:27) Mar 29 17:57:35 music volumio[1332]: at HTTPParser.parserOnHeadersComplete (node:_http_common:119:17) Mar 29 17:57:35 music volumio[1332]: at TLSSocket.socketOnData (node:_http_client:535:22) Mar 29 17:57:35 music volumio[1332]: at TLSSocket.emit (node:events:514:28) Mar 29 17:57:35 music volumio[1332]: at addChunk (node:internal/streams/readable:343:12) Mar 29 17:57:35 music volumio[1332]: at readableAddChunk (node:internal/streams/readable:316:9) Mar 29 17:57:35 music volumio[1332]: at Readable.push (node:internal/streams/readable:253:10) Mar 29 17:57:35 music volumio[1332]: at TLSWrap.onStreamRead (node:internal/stream_base_commons:190:23) Mar 29 17:57:35 music volumio[1332]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 29 17:57:35 music sudo[1318177]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-03-29 17:56' Mar 29 17:57:35 music sudo[1318177]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="dc61260dec5515dafd2b634881860b4c46c919ff" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Mar 6 17:11:42 UTC 2026" VOLUMIO_VERSION="4.103" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="21a5161aef4cb85a1f93b140ccadc4f1"