-- Logs begin at Thu 2026-03-26 12:12:52 +07, end at Thu 2026-03-26 12:15:03 +07. --
Mar 26 12:14:00 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Mar 26 12:14:00 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Mar 26 12:14:00 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Mar 26 12:14:00 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Mar 26 12:14:01 rivolek volumio5-onboarding[3767]: failed to bootstrap state: failed to get music providers: could not get available plugins: could not get available plugins: context deadline exceeded
Mar 26 12:14:01 rivolek systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE
Mar 26 12:14:01 rivolek systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'.
Mar 26 12:14:01 rivolek systemd[1]: volumio5-onboarding.service: Service RestartSec=100ms expired, scheduling restart.
Mar 26 12:14:01 rivolek systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 1.
Mar 26 12:14:01 rivolek systemd[1]: Stopped Volumio5 Onboarding Server.
Mar 26 12:14:01 rivolek systemd[1]: Started Volumio5 Onboarding Server.
Mar 26 12:14:01 rivolek volumio5-onboarding[4373]: time=2026-03-26T12:14:01.512+07:00 level=INFO msg="running volumio5-device-gateway" version=5bca5789+CHANGES buildDate=2025-12-11T14:07:23Z
Mar 26 12:14:01 rivolek volumio[3110]: 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: 8
Mar 26 12:14:01 rivolek volumio[3110]: 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: 8
Mar 26 12:14:01 rivolek volumio5-onboarding[4373]: time=2026-03-26T12:14:01.558+07:00 level=INFO msg="listening for BLE messages" address=B8:13:32:E3:4B:C1%00
Mar 26 12:14:01 rivolek volumio5-onboarding[4373]: time=2026-03-26T12:14:01.560+07:00 level=INFO msg="listening for WebSocket messages" address=[::]:7331
Mar 26 12:14:01 rivolek volumio[3110]: info: Received Get System Info
Mar 26 12:14:01 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 26 12:14:01 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 26 12:14:01 rivolek volumio[3110]: info: Discovery: Getting this device information
Mar 26 12:14:01 rivolek volumio[3110]: info: CoreCommandRouter::volumioGetState
Mar 26 12:14:01 rivolek volumio[3110]: info: CorePlayQueue::getTrack 0
Mar 26 12:14:01 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 26 12:14:01 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Mar 26 12:14:01 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Mar 26 12:14:01 rivolek volumio5-onboarding[4373]: time=2026-03-26T12:14:01.574+07:00 level=INFO msg="BLE descriptor updated" deviceId=3f07be88d1cc0f3282ac72679aa9cfed deviceName=Rivolek deviceModel=0x1c92170
Mar 26 12:14:01 rivolek volumio5-onboarding[4373]: time=2026-03-26T12:14:01.574+07:00 level=INFO msg="mDNS descriptor updated" deviceId=3f07be88d1cc0f3282ac72679aa9cfed deviceName=Rivolek deviceModel=0x1c92170
Mar 26 12:14:01 rivolek volumio5-onboarding[4373]: time=2026-03-26T12:14:01.582+07:00 level=INFO msg="bootstrapping state" hasInternet=true
Mar 26 12:14:01 rivolek volumio[3110]: info: Received Get System Info
Mar 26 12:14:01 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 26 12:14:01 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 26 12:14:01 rivolek volumio[3110]: info: Discovery: Getting this device information
Mar 26 12:14:01 rivolek volumio[3110]: info: CoreCommandRouter::volumioGetState
Mar 26 12:14:01 rivolek volumio[3110]: info: CorePlayQueue::getTrack 0
Mar 26 12:14:01 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 26 12:14:01 rivolek volumio-remote-updater[2832]: No test mode
Mar 26 12:14:01 rivolek volumio-remote-updater[2832]: No alpha test mode
Mar 26 12:14:01 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Mar 26 12:14:01 rivolek volumio[3110]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9
Mar 26 12:14:01 rivolek volumio[3110]: info: CoreCommandRouter::volumioGetState
Mar 26 12:14:01 rivolek volumio[3110]: info: CorePlayQueue::getTrack 0
Mar 26 12:14:02 rivolek volumio[3110]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"FIXES
\n\n- Fix for BLE notification issues
\n- Fix for mDNS/BCT
\n
\nNEW ADDITIONS
\n\n- Update Tidal SDK
\n- Update Qobuz Connect SDK
\n
\n","title":"Update v3.912","updateavailable":true}
Mar 26 12:14:02 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache
Mar 26 12:14:02 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Mar 26 12:14:02 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Mar 26 12:14:02 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Mar 26 12:14:02 rivolek volumio5-onboarding[4373]: time=2026-03-26T12:14:02.273+07:00 level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.51.13:45676
Mar 26 12:14:02 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Mar 26 12:14:02 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Mar 26 12:14:02 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Mar 26 12:14:02 rivolek volumio5-onboarding[4373]: time=2026-03-26T12:14:02.905+07:00 level=INFO msg="WebSocket connection closed" component=conn/ws remoteAddr=192.168.51.13:45676
Mar 26 12:14:02 rivolek volumio5-onboarding[4373]: time=2026-03-26T12:14:02.905+07:00 level=INFO msg="connection to address closed" component=conn/multi addr=192.168.51.13:45676
Mar 26 12:14:02 rivolek volumio5-onboarding[4373]: time=2026-03-26T12:14:02.923+07:00 level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.51.13:45680
Mar 26 12:14:03 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Mar 26 12:14:03 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Mar 26 12:14:03 rivolek volumio[3110]: info: BOOT COMPLETED
Mar 26 12:14:04 rivolek volumio5-onboarding[4373]: time=2026-03-26T12:14:04.604+07:00 level=INFO msg="authenticated Firebase client" component=volumio/firebase userId=abMxPW44HaOfLCpzLFJm7DiBJ6u2 tokenExpiry=2026-03-26T13:14:04.604+07:00
Mar 26 12:14:05 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 26 12:14:05 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Mar 26 12:14:05 rivolek volumio[3110]: info: Not Reporting Auto name since its the default one
Mar 26 12:14:05 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkCurrentAudioDeviceAvailable
Mar 26 12:14:05 rivolek volumio[3110]: No protocol specified
Mar 26 12:14:05 rivolek volumio[3110]: xcb_connection_has_error() returned true
Mar 26 12:14:05 rivolek volumio[3110]: info: Configured Audio card not found, not starting RAAT
Mar 26 12:14:06 rivolek volumio5-onboarding[4373]: time=2026-03-26T12:14:06.379+07:00 level=INFO msg="app ready event" component=server event=CLIENT_EVENT_TYPE_APP_READY peer="192.168.51.13:45680 @ 0x1ecd230" latency=36.365145ms platform=PLATFORM_ANDROID version=5.260209.0
Mar 26 12:14:06 rivolek volumio5-onboarding[4373]: time=2026-03-26T12:14:06.379+07:00 level=INFO msg="device data request" component=server type=REQUEST_TYPE_DEVICE_DATA peer="192.168.51.13:45680 @ 0x1ecd230" latency=35.319481ms timeout=10s
Mar 26 12:14:06 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Mar 26 12:14:06 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Mar 26 12:14:06 rivolek volumio[3110]: info: Received Get System Info
Mar 26 12:14:06 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 26 12:14:06 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 26 12:14:06 rivolek volumio[3110]: info: Discovery: Getting this device information
Mar 26 12:14:06 rivolek volumio[3110]: info: CoreCommandRouter::volumioGetState
Mar 26 12:14:06 rivolek volumio[3110]: info: CorePlayQueue::getTrack 0
Mar 26 12:14:06 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 26 12:14:06 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: system , getCurrentTimezone
Mar 26 12:14:06 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getExtendedOutputDevices
Mar 26 12:14:06 rivolek volumio[3110]: No protocol specified
Mar 26 12:14:06 rivolek volumio[3110]: xcb_connection_has_error() returned true
Mar 26 12:14:06 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions
Mar 26 12:14:06 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 26 12:14:06 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Mar 26 12:14:06 rivolek kernel: aml_spdif_open
Mar 26 12:14:06 rivolek kernel: audio_ddr_mngr: frddrs[0] registered by device ff660000.audiobus:spdif@0
Mar 26 12:14:06 rivolek kernel: spdif_a keep clk continuous
Mar 26 12:14:06 rivolek kernel: aml_spdif_close
Mar 26 12:14:06 rivolek kernel: audio_ddr_mngr: frddrs[0] released by device ff660000.audiobus:spdif@0
Mar 26 12:14:06 rivolek volumio[3110]: Invalid card number.
Mar 26 12:14:06 rivolek volumio[3110]: amixer -c 5 info | grep "ESOTERIC USB AUDIO DEVICE"
Mar 26 12:14:06 rivolek volumio[3110]: Invalid card number.
Mar 26 12:14:06 rivolek volumio[3110]: Invalid card number.
Mar 26 12:14:06 rivolek volumio5-onboarding[4373]: time=2026-03-26T12:14:06.686+07:00 level=WARN msg="active output device not found in available devices" component=volumio/socket activeDeviceId=5
Mar 26 12:14:06 rivolek volumio[3110]: info: Received Get System Info
Mar 26 12:14:06 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 26 12:14:06 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 26 12:14:06 rivolek volumio[3110]: info: Discovery: Getting this device information
Mar 26 12:14:06 rivolek volumio[3110]: info: CoreCommandRouter::volumioGetState
Mar 26 12:14:06 rivolek volumio[3110]: info: CorePlayQueue::getTrack 0
Mar 26 12:14:06 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 26 12:14:06 rivolek volumio[3110]: info: CoreCommandRouter::volumioGetState
Mar 26 12:14:06 rivolek volumio[3110]: info: CorePlayQueue::getTrack 0
Mar 26 12:14:06 rivolek volumio5-onboarding[4373]: time=2026-03-26T12:14:06.782+07:00 level=INFO msg="continue navigation request" component=server type=REQUEST_TYPE_CONTINUE_NAVIGATION peer="192.168.51.13:45680 @ 0x1ecd230" latency=-458.793133ms timeout=10s from=APP_PAGE_ROOT
Mar 26 12:14:06 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 26 12:14:06 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 26 12:14:06 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
Mar 26 12:14:06 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
Mar 26 12:14:06 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
Mar 26 12:14:06 rivolek volumio[3110]: info: CoreCommandRouter::volumioGetBrowseSources
Mar 26 12:14:06 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Mar 26 12:14:07 rivolek sudo[4433]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Mar 26 12:14:07 rivolek sudo[4433]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 26 12:14:07 rivolek sudo[4433]: pam_unix(sudo:session): session closed for user root
Mar 26 12:14:07 rivolek sudo[4436]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Mar 26 12:14:07 rivolek sudo[4436]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 26 12:14:07 rivolek sudo[4436]: pam_unix(sudo:session): session closed for user root
Mar 26 12:14:07 rivolek volumio[3110]: verbose: New Socket.io Connection to 192.168.51.205 from 192.168.51.13 UA: Mozilla/5.0 (Linux; Android 10; ELE-L29 Build/HUAWEIELE-L29; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/145.0.7632.159 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9
Mar 26 12:14:08 rivolek sudo[4441]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Mar 26 12:14:08 rivolek sudo[4441]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 26 12:14:08 rivolek volumio[3110]: info: RAAT: Requesting Headphone Status
Mar 26 12:14:08 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: inputs , getHeadphoneStatus
Mar 26 12:14:08 rivolek sudo[4441]: pam_unix(sudo:session): session closed for user root
Mar 26 12:14:08 rivolek sudo[4445]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Mar 26 12:14:08 rivolek sudo[4445]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 26 12:14:08 rivolek volumio[3110]: info: MCU Signalled Headphone Mode Disabled
Mar 26 12:14:08 rivolek sudo[4445]: pam_unix(sudo:session): session closed for user root
Mar 26 12:14:08 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState
Mar 26 12:14:08 rivolek volumio[3110]: info: Reporting Headphone State: false
Mar 26 12:14:08 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 26 12:14:08 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 26 12:14:08 rivolek volumio[3110]: info: Updating RAAT Signal Path
Mar 26 12:14:08 rivolek volumio[3110]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined
Mar 26 12:14:08 rivolek volumio[3110]: verbose: New Socket.io Connection to 192.168.51.205 from 192.168.51.13 UA: Mozilla/5.0 (Linux; Android 10; ELE-L29 Build/HUAWEIELE-L29; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/145.0.7632.159 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9
Mar 26 12:14:08 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Mar 26 12:14:08 rivolek volumio[3110]: info: CoreCommandRouter::volumioGetVisibleSources
Mar 26 12:14:08 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Mar 26 12:14:08 rivolek volumio[3110]: info: CoreCommandRouter::volumioGetState
Mar 26 12:14:08 rivolek volumio[3110]: info: CorePlayQueue::getTrack 0
Mar 26 12:14:08 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Mar 26 12:14:08 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Mar 26 12:14:08 rivolek volumio[3110]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
Mar 26 12:14:08 rivolek volumio[3110]: info: Received Get System Info
Mar 26 12:14:08 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 26 12:14:08 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 26 12:14:08 rivolek volumio[3110]: info: Discovery: Getting this device information
Mar 26 12:14:08 rivolek volumio[3110]: info: CoreCommandRouter::volumioGetState
Mar 26 12:14:08 rivolek volumio[3110]: info: CorePlayQueue::getTrack 0
Mar 26 12:14:08 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 26 12:14:08 rivolek volumio[3110]: info: CoreCommandRouter::volumioGetState
Mar 26 12:14:08 rivolek volumio[3110]: info: CorePlayQueue::getTrack 0
Mar 26 12:14:08 rivolek volumio[3110]: info: Listing playlists
Mar 26 12:14:08 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
Mar 26 12:14:08 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Mar 26 12:14:08 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Mar 26 12:14:09 rivolek volumio[3110]: info: CoreCommandRouter::volumioGetQueue
Mar 26 12:14:09 rivolek volumio[3110]: info: CoreStateMachine::getQueue
Mar 26 12:14:09 rivolek volumio[3110]: info: CorePlayQueue::getQueue
Mar 26 12:14:10 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
Mar 26 12:14:10 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Mar 26 12:14:10 rivolek volumio[3110]: info: Received Get System Info
Mar 26 12:14:10 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 26 12:14:10 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 26 12:14:10 rivolek volumio[3110]: info: Discovery: Getting this device information
Mar 26 12:14:10 rivolek volumio[3110]: info: CoreCommandRouter::volumioGetState
Mar 26 12:14:10 rivolek volumio[3110]: info: CorePlayQueue::getTrack 0
Mar 26 12:14:10 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 26 12:14:11 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Mar 26 12:14:11 rivolek volumio[3110]: info: Received Get System Info
Mar 26 12:14:11 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 26 12:14:11 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 26 12:14:11 rivolek volumio[3110]: info: Discovery: Getting this device information
Mar 26 12:14:11 rivolek volumio[3110]: info: CoreCommandRouter::volumioGetState
Mar 26 12:14:11 rivolek volumio[3110]: info: CorePlayQueue::getTrack 0
Mar 26 12:14:11 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 26 12:14:12 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Mar 26 12:14:12 rivolek volumio[3110]: info: CURURI: music-library
Mar 26 12:14:12 rivolek volumio[3110]: error: Failed LSINFO: null
Mar 26 12:14:12 rivolek volumio[3110]: info: Preload queue cleared
Mar 26 12:14:17 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: tidal , handleBrowseUri
Mar 26 12:14:17 rivolek volumio[3110]: info: browseTIDALUri took 258 milliseconds
Mar 26 12:14:17 rivolek volumio[3110]: info: Preload queue cleared
Mar 26 12:14:17 rivolek volumio[3110]: info: Preload queue cleared
Mar 26 12:14:17 rivolek ntpd[3403]: Soliciting pool server 240b:400f:8:3a07:400:115:974f:c952
Mar 26 12:14:18 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted
Mar 26 12:14:19 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: tidal , handleBrowseUri
Mar 26 12:14:19 rivolek volumio[3110]: info: browseTIDALUri took 620 milliseconds
Mar 26 12:14:19 rivolek volumio[3110]: info: Preload queue cleared
Mar 26 12:14:19 rivolek volumio[3110]: info: Preload queue cleared
Mar 26 12:14:27 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Mar 26 12:14:27 rivolek volumio[3110]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Mar 26 12:14:27 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Mar 26 12:14:27 rivolek volumio[3110]: info: Received Get System Version
Mar 26 12:14:27 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Mar 26 12:14:27 rivolek volumio[3110]: info: Received Get System Info
Mar 26 12:14:27 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 26 12:14:27 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 26 12:14:27 rivolek volumio[3110]: info: Discovery: Getting this device information
Mar 26 12:14:27 rivolek volumio[3110]: info: CoreCommandRouter::volumioGetState
Mar 26 12:14:27 rivolek volumio[3110]: info: CorePlayQueue::getTrack 0
Mar 26 12:14:27 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 26 12:14:39 rivolek volumio5-onboarding[4373]: time=2026-03-26T12:14:39.169+07:00 level=ERROR msg="failed to read message" component=conn/ws remoteAddr=192.168.51.13:45680 error="read tcp 192.168.51.205:7331->192.168.51.13:45680: read: connection reset by peer"
Mar 26 12:14:39 rivolek volumio5-onboarding[4373]: time=2026-03-26T12:14:39.169+07:00 level=INFO msg="WebSocket connection closed" component=conn/ws remoteAddr=192.168.51.13:45680
Mar 26 12:14:39 rivolek volumio5-onboarding[4373]: time=2026-03-26T12:14:39.169+07:00 level=INFO msg="connection to address closed" component=conn/multi addr=192.168.51.13:45680
Mar 26 12:14:43 rivolek volumio5-onboarding[4373]: time=2026-03-26T12:14:43.150+07:00 level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.51.13:45810
Mar 26 12:14:44 rivolek volumio[3110]: verbose: New Socket.io Connection to 192.168.51.205 from 192.168.51.13 UA: Mozilla/5.0 (Linux; Android 10; ELE-L29 Build/HUAWEIELE-L29; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/145.0.7632.159 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8
Mar 26 12:14:44 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Mar 26 12:14:44 rivolek volumio[3110]: info: CoreCommandRouter::volumioGetVisibleSources
Mar 26 12:14:44 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Mar 26 12:14:44 rivolek volumio[3110]: info: CoreCommandRouter::volumioGetState
Mar 26 12:14:44 rivolek volumio[3110]: info: CorePlayQueue::getTrack 0
Mar 26 12:14:44 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Mar 26 12:14:44 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Mar 26 12:14:44 rivolek volumio[3110]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom
Mar 26 12:14:44 rivolek volumio[3110]: info: Received Get System Info
Mar 26 12:14:44 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 26 12:14:44 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 26 12:14:44 rivolek volumio[3110]: info: Discovery: Getting this device information
Mar 26 12:14:44 rivolek volumio[3110]: info: CoreCommandRouter::volumioGetState
Mar 26 12:14:44 rivolek volumio[3110]: info: CorePlayQueue::getTrack 0
Mar 26 12:14:44 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 26 12:14:44 rivolek volumio[3110]: info: CoreCommandRouter::volumioGetState
Mar 26 12:14:44 rivolek volumio[3110]: info: CorePlayQueue::getTrack 0
Mar 26 12:14:44 rivolek volumio[3110]: info: Listing playlists
Mar 26 12:14:44 rivolek volumio[3110]: info: CoreCommandRouter::volumioGetQueue
Mar 26 12:14:44 rivolek volumio[3110]: info: CoreStateMachine::getQueue
Mar 26 12:14:44 rivolek volumio[3110]: info: CorePlayQueue::getQueue
Mar 26 12:14:44 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Mar 26 12:14:48 rivolek volumio5-onboarding[4373]: time=2026-03-26T12:14:48.658+07:00 level=INFO msg="WebSocket connection closed" component=conn/ws remoteAddr=192.168.51.13:45810
Mar 26 12:14:48 rivolek volumio5-onboarding[4373]: time=2026-03-26T12:14:48.658+07:00 level=INFO msg="connection to address closed" component=conn/multi addr=192.168.51.13:45810
Mar 26 12:14:48 rivolek volumio5-onboarding[4373]: time=2026-03-26T12:14:48.670+07:00 level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.51.13:45830
Mar 26 12:14:54 rivolek volumio[3110]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 26 12:14:54 rivolek volumio[3110]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 26 12:14:54 rivolek volumio[3110]: info: Retrieving Cloud Streaming UI
Mar 26 12:14:54 rivolek volumio[3110]: info: Getting Tidal Cloud Configuration
Mar 26 12:14:54 rivolek volumio[3110]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 26 12:14:54 rivolek volumio[3110]: info: Getting Qobuz Cloud Configuration
Mar 26 12:14:54 rivolek volumio[3110]: info: Asking plugin for UI Config
Mar 26 12:14:54 rivolek volumio[3110]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 26 12:14:54 rivolek volumio[3110]: info: Getting Spotify Cloud Configuration
Mar 26 12:14:54 rivolek volumio[3110]: info: Asking plugin for UI Config
Mar 26 12:14:54 rivolek volumio[3110]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 26 12:14:54 rivolek volumio[3110]: info: Saving Spotify Acccount
Mar 26 12:14:54 rivolek volumio[3110]: info: Got it
Mar 26 12:14:54 rivolek volumio[3110]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
Mar 26 12:14:55 rivolek volumio[3110]: info: Got Tidal Cloud Configuration
Mar 26 12:14:55 rivolek volumio[3110]: info: Got it
Mar 26 12:14:55 rivolek volumio[3110]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 26 12:14:55 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Mar 26 12:14:55 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Mar 26 12:14:55 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Mar 26 12:14:55 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Mar 26 12:14:55 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Mar 26 12:14:55 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Mar 26 12:14:55 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Mar 26 12:14:55 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Mar 26 12:14:55 rivolek volumio[3110]: info: CoreCommandRouter::volumioGetBrowseSources
Mar 26 12:14:55 rivolek volumio[3110]: info: CoreCommandRouter::volumioGetBrowseSources
Mar 26 12:14:55 rivolek volumio[3110]: info: CoreCommandRouter::volumioGetBrowseSources
Mar 26 12:14:55 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Mar 26 12:14:55 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Mar 26 12:14:59 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Mar 26 12:15:00 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare
Mar 26 12:15:01 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Mar 26 12:15:02 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares
Mar 26 12:15:02 rivolek volumio[3110]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService
Mar 26 12:15:02 rivolek volumio[3110]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Mar 26 12:15:02 rivolek volumio[3110]: Error: getaddrinfo -3007
Mar 26 12:15:02 rivolek volumio[3110]: at errnoException (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:199:11)
Mar 26 12:15:02 rivolek volumio[3110]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:112:10)
Mar 26 12:15:02 rivolek volumio[3110]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) {
Mar 26 12:15:02 rivolek volumio[3110]: code: -3007,
Mar 26 12:15:02 rivolek volumio[3110]: errno: -3007,
Mar 26 12:15:02 rivolek volumio[3110]: syscall: 'getaddrinfo'
Mar 26 12:15:02 rivolek volumio[3110]: }
Mar 26 12:15:02 rivolek volumio[3110]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Mar 26 12:15:03 rivolek sudo[4606]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-03-26 12:14
Mar 26 12:15:03 rivolek sudo[4606]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Debian GNU/Linux 10 (buster)"
NAME="Debian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
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="b43c85cc0006d3f1efecba101311ec96e334d1fd"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="2f25e1a98e53e2dbc4f3878604e250b0379f3ea4"
VOLUMIO_ARCH="armv7"
VOLUMIO_VARIANT="rivo"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Thu 11 Dec 2025 07:07:40 PM CET"
VOLUMIO_VERSION="3.886"
VOLUMIO_HARDWARE="mp1"
VOLUMIO_DEVICENAME="Volumio MP1"
VOLUMIO_VENDOR_MODEL="Volumio Rivo"
VOLUMIO_VENDOR="Volumio"
VOLUMIO_MODEL="Rivo"
VOLUMIO_HASH="90457dc663650a5d2f936402ef6c7dc1"