-- Logs begin at Sat 2026-01-17 16:08:37 EST, end at Fri 2026-02-06 16:45:16 EST. -- Feb 06 16:44:09 rivoplus qobuz-connect[4309]: 20260206 16:44:09.805 [4309.19811] INFO SampleApp: API endpoint invoked: get-connect-info Feb 06 16:44:10 rivoplus qobuz-connect[4309]: 20260206 16:44:10.191 [4309.19811] INFO SampleApp: API endpoint invoked: connect-to-qconnect Feb 06 16:44:36 rivoplus volumio5-onboarding[3873]: time=2026-02-06T16:44:36.171-05:00 level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.12.217:49330 Feb 06 16:44:36 rivoplus volumio5-onboarding[3873]: time=2026-02-06T16:44:36.223-05:00 level=INFO msg="app ready event" component=server event=CLIENT_EVENT_TYPE_APP_READY peer="192.168.12.217:49330 @ 0x30c6240" latency=2.571985ms platform=PLATFORM_IOS version=5.260120.0 Feb 06 16:44:36 rivoplus volumio5-onboarding[3873]: time=2026-02-06T16:44:36.225-05:00 level=INFO msg="device data request" component=server type=REQUEST_TYPE_DEVICE_DATA peer="192.168.12.217:49330 @ 0x30c6240" latency=3.133278ms timeout=10s Feb 06 16:44:36 rivoplus volumio[3109]: info: Received Get System Info Feb 06 16:44:36 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 06 16:44:36 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 06 16:44:36 rivoplus volumio[3109]: info: Discovery: Getting this device information Feb 06 16:44:36 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState Feb 06 16:44:36 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 06 16:44:36 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: system , getCurrentTimezone Feb 06 16:44:36 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getExtendedOutputDevices Feb 06 16:44:36 rivoplus volumio[3109]: No protocol specified Feb 06 16:44:36 rivoplus volumio[3109]: xcb_connection_has_error() returned true Feb 06 16:44:36 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Feb 06 16:44:36 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 06 16:44:36 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 06 16:44:36 rivoplus volumio[3109]: amixer -c 5 info | grep "Comtrue-inc UAC2 Device" Feb 06 16:44:36 rivoplus volumio[3109]: No protocol specified Feb 06 16:44:36 rivoplus volumio[3109]: xcb_connection_has_error() returned true Feb 06 16:44:36 rivoplus volumio[3109]: Card hw:5 'Device'/'Comtrue-inc Comtrue-inc UAC2 Device at usb-xhci-hcd.0.auto-1.4.3, high speed' Feb 06 16:44:36 rivoplus volumio[3109]: amixer -c 5 info | grep "Comtrue-inc UAC2 Device" Feb 06 16:44:36 rivoplus volumio[3109]: No protocol specified Feb 06 16:44:36 rivoplus volumio[3109]: xcb_connection_has_error() returned true Feb 06 16:44:36 rivoplus volumio[3109]: Card hw:5 'Device'/'Comtrue-inc Comtrue-inc UAC2 Device at usb-xhci-hcd.0.auto-1.4.3, high speed' Feb 06 16:44:36 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 06 16:44:36 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 06 16:44:36 rivoplus volumio[3109]: info: Discovery: Getting this device information Feb 06 16:44:36 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState Feb 06 16:44:36 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 06 16:44:36 rivoplus volumio[3109]: info: Received Get System Info Feb 06 16:44:36 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 06 16:44:36 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 06 16:44:36 rivoplus volumio[3109]: info: Discovery: Getting this device information Feb 06 16:44:36 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState Feb 06 16:44:36 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 06 16:44:36 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState Feb 06 16:44:36 rivoplus volumio[3109]: verbose: New Socket.io Connection to 192.168.12.158:3000 from 192.168.12.217 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 8 Feb 06 16:44:36 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 06 16:44:36 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 06 16:44:38 rivoplus volumio5-onboarding[3873]: time=2026-02-06T16:44:38.124-05:00 level=INFO msg="continue navigation request" component=server type=REQUEST_TYPE_CONTINUE_NAVIGATION peer="192.168.12.217:49330 @ 0x30c6240" latency=3.260801ms timeout=10s from=APP_PAGE_ROOT Feb 06 16:44:38 rivoplus sudo[9709]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 06 16:44:38 rivoplus sudo[9709]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 06 16:44:38 rivoplus sudo[9709]: pam_unix(sudo:session): session closed for user root Feb 06 16:44:38 rivoplus sudo[9713]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 06 16:44:38 rivoplus sudo[9713]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 06 16:44:38 rivoplus sudo[9713]: pam_unix(sudo:session): session closed for user root Feb 06 16:44:38 rivoplus volumio[3109]: verbose: New Socket.io Connection to 192.168.12.158 from 192.168.12.217 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 8 Feb 06 16:44:38 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 06 16:44:38 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Feb 06 16:44:38 rivoplus sudo[9717]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 06 16:44:38 rivoplus sudo[9717]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 06 16:44:39 rivoplus sudo[9717]: pam_unix(sudo:session): session closed for user root Feb 06 16:44:39 rivoplus sudo[9719]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 06 16:44:39 rivoplus sudo[9719]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 06 16:44:39 rivoplus sudo[9719]: pam_unix(sudo:session): session closed for user root Feb 06 16:44:39 rivoplus volumio[3109]: verbose: New Socket.io Connection to 192.168.12.158 from 192.168.12.217 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 9 Feb 06 16:44:39 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 06 16:44:39 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetVisibleSources Feb 06 16:44:39 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 06 16:44:39 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState Feb 06 16:44:39 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Feb 06 16:44:39 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 06 16:44:39 rivoplus volumio[3109]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Feb 06 16:44:39 rivoplus volumio[3109]: info: Received Get System Info Feb 06 16:44:39 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 06 16:44:39 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 06 16:44:39 rivoplus volumio[3109]: info: Discovery: Getting this device information Feb 06 16:44:39 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState Feb 06 16:44:39 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 06 16:44:39 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState Feb 06 16:44:39 rivoplus volumio[3109]: info: Listing playlists Feb 06 16:44:39 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 06 16:44:39 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 06 16:44:39 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Feb 06 16:44:40 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Feb 06 16:44:40 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 06 16:44:40 rivoplus volumio[3109]: info: Received Get System Info Feb 06 16:44:40 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 06 16:44:40 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 06 16:44:40 rivoplus volumio[3109]: info: Discovery: Getting this device information Feb 06 16:44:40 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState Feb 06 16:44:40 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 06 16:44:41 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 06 16:44:41 rivoplus volumio[3109]: info: Received Get System Info Feb 06 16:44:41 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 06 16:44:41 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 06 16:44:41 rivoplus volumio[3109]: info: Discovery: Getting this device information Feb 06 16:44:41 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState Feb 06 16:44:41 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 06 16:44:44 rivoplus volumio5-onboarding[3873]: time=2026-02-06T16:44:44.549-05:00 level=INFO msg="new address was allocated" component=conn/ble old=214 new=215 Feb 06 16:44:44 rivoplus dbus-daemon[2831]: [system] Rejected send message, 1 matched rules; type="error", sender=":1.18" (uid=0 pid=3873 comm="/usr/bin/volumio5-onboarding " label="kernel") interface="(unset)" member="(unset)" error name="org.freedesktop.DBus.Error.UnknownMethod" requested_reply="0" destination=":1.7" (uid=0 pid=3318 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap,hostn" label="kernel") Feb 06 16:44:45 rivoplus volumio5-onboarding[3873]: time=2026-02-06T16:44:45.270-05:00 level=INFO msg="new address was allocated" component=conn/ble old=215 new=216 Feb 06 16:44:49 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Feb 06 16:44:56 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetQueue Feb 06 16:44:56 rivoplus volumio[3109]: info: CoreStateMachine::getQueue Feb 06 16:44:56 rivoplus volumio[3109]: info: CorePlayQueue::getQueue Feb 06 16:44:56 rivoplus volumio[3109]: info: Executing endpoint metavolumio Feb 06 16:44:56 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 06 16:44:56 rivoplus volumio[3109]: info: Executing endpoint metavolumio Feb 06 16:44:56 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 06 16:44:57 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 06 16:44:57 rivoplus volumio[3109]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Feb 06 16:44:57 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Feb 06 16:44:57 rivoplus volumio[3109]: info: Received Get System Version Feb 06 16:44:57 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 06 16:44:57 rivoplus volumio[3109]: info: Received Get System Info Feb 06 16:44:57 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 06 16:44:57 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 06 16:44:57 rivoplus volumio[3109]: info: Discovery: Getting this device information Feb 06 16:44:57 rivoplus volumio[3109]: info: CoreCommandRouter::volumioGetState Feb 06 16:44:57 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 06 16:45:04 rivoplus volumio[3109]: Searching plugin music_service/qobuz Feb 06 16:45:04 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Feb 06 16:45:05 rivoplus volumio[3109]: Searching plugin music_service/qobuz Feb 06 16:45:05 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Feb 06 16:45:05 rivoplus volumio[3109]: info: searchQOBUZUri took 1588 milliseconds Feb 06 16:45:05 rivoplus volumio[3109]: info: All search sources collected, pushing search results Feb 06 16:45:05 rivoplus volumio[3109]: Searching plugin music_service/qobuz Feb 06 16:45:05 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Feb 06 16:45:06 rivoplus volumio[3109]: info: searchQOBUZUri took 1336 milliseconds Feb 06 16:45:06 rivoplus volumio[3109]: info: All search sources collected, pushing search results Feb 06 16:45:07 rivoplus volumio[3109]: Searching plugin music_service/qobuz Feb 06 16:45:07 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Feb 06 16:45:07 rivoplus volumio[3109]: info: searchQOBUZUri took 1711 milliseconds Feb 06 16:45:07 rivoplus volumio[3109]: info: All search sources collected, pushing search results Feb 06 16:45:08 rivoplus volumio[3109]: Searching plugin music_service/qobuz Feb 06 16:45:08 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Feb 06 16:45:08 rivoplus volumio[3109]: info: searchQOBUZUri took 1207 milliseconds Feb 06 16:45:08 rivoplus volumio[3109]: info: All search sources collected, pushing search results Feb 06 16:45:09 rivoplus volumio[3109]: info: searchQOBUZUri took 1650 milliseconds Feb 06 16:45:09 rivoplus volumio[3109]: info: All search sources collected, pushing search results Feb 06 16:45:12 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: qobuz , handleBrowseUri Feb 06 16:45:14 rivoplus volumio[3109]: info: handleBrowseUri took 1906 milliseconds Feb 06 16:45:14 rivoplus volumio[3109]: info: Preload queue cleared Feb 06 16:45:14 rivoplus volumio[3109]: info: Executing endpoint getSimilarArtists Feb 06 16:45:14 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarArtists Feb 06 16:45:14 rivoplus volumio[3109]: info: Executing endpoint metavolumio Feb 06 16:45:14 rivoplus volumio[3109]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 06 16:45:15 rivoplus volumio[3109]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 06 16:45:15 rivoplus volumio[3109]: TypeError: Cannot read property 'slice' of null Feb 06 16:45:15 rivoplus volumio[3109]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:718:41) Feb 06 16:45:15 rivoplus volumio[3109]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:728:7) Feb 06 16:45:15 rivoplus volumio[3109]: at Object.onceWrapper (events.js:520:26) Feb 06 16:45:15 rivoplus volumio[3109]: at ClientRequest.emit (events.js:400:28) Feb 06 16:45:15 rivoplus volumio[3109]: at HTTPParser.parserOnIncomingClient [as onIncoming] (_http_client.js:647:27) Feb 06 16:45:15 rivoplus volumio[3109]: at HTTPParser.parserOnHeadersComplete (_http_common.js:127:17) Feb 06 16:45:15 rivoplus volumio[3109]: at TLSSocket.socketOnData (_http_client.js:515:22) Feb 06 16:45:15 rivoplus volumio[3109]: at TLSSocket.emit (events.js:400:28) Feb 06 16:45:15 rivoplus volumio[3109]: at addChunk (internal/streams/readable.js:293:12) Feb 06 16:45:15 rivoplus volumio[3109]: at readableAddChunk (internal/streams/readable.js:267:9) Feb 06 16:45:15 rivoplus volumio[3109]: at TLSSocket.Readable.push (internal/streams/readable.js:206:10) Feb 06 16:45:15 rivoplus volumio[3109]: at TLSWrap.onStreamRead (internal/stream_base_commons.js:188:23) Feb 06 16:45:15 rivoplus volumio[3109]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 06 16:45:16 rivoplus sudo[9836]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-02-06 16:44 Feb 06 16:45:16 rivoplus sudo[9836]: 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="rivoplus" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 11 Dec 2025 06:47:33 PM CET" VOLUMIO_VERSION="3.886" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo Plus" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo Plus" VOLUMIO_HASH="9e8aa5d6afb5e5d87a87bafae7aa5647"