-- Logs begin at Sat 2025-08-30 08:56:59 +07, end at Sat 2025-08-30 10:53:31 +07. -- Aug 30 10:52:10 rivoplus ntpd[30546]: Soliciting pool server 2400:6760:0:200::254 Aug 30 10:52:11 rivoplus ntpd[30546]: Soliciting pool server 115.165.161.155 Aug 30 10:52:12 rivoplus ntpd[30546]: Soliciting pool server 103.184.124.254 Aug 30 10:52:13 rivoplus ntpd[30546]: Soliciting pool server 115.165.161.155 Aug 30 10:52:25 rivoplus volumio[28827]: Searching plugin music_service/qobuz Aug 30 10:52:25 rivoplus volumio[28827]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Aug 30 10:52:26 rivoplus volumio[28827]: Searching plugin music_service/qobuz Aug 30 10:52:26 rivoplus volumio[28827]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Aug 30 10:52:27 rivoplus volumio[28827]: info: searchQOBUZUri took 1999 milliseconds Aug 30 10:52:27 rivoplus volumio[28827]: info: All search sources collected, pushing search results Aug 30 10:52:28 rivoplus volumio[28827]: Searching plugin music_service/qobuz Aug 30 10:52:28 rivoplus volumio[28827]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Aug 30 10:52:28 rivoplus volumio[28827]: info: searchQOBUZUri took 1669 milliseconds Aug 30 10:52:28 rivoplus volumio[28827]: info: All search sources collected, pushing search results Aug 30 10:52:29 rivoplus volumio[28827]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 10:52:29 rivoplus volumio[28827]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 10:52:29 rivoplus volumio[28827]: info: Discovery: Getting this device information Aug 30 10:52:29 rivoplus volumio[28827]: info: CoreCommandRouter::volumioGetState Aug 30 10:52:29 rivoplus volumio[28827]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 10:52:29 rivoplus volumio[28827]: Searching plugin music_service/qobuz Aug 30 10:52:29 rivoplus volumio[28827]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Aug 30 10:52:32 rivoplus volumio[28827]: info: searchQOBUZUri took 2479 milliseconds Aug 30 10:52:32 rivoplus volumio[28827]: info: All search sources collected, pushing search results Aug 30 10:52:33 rivoplus volumio[28827]: info: searchQOBUZUri took 5258 milliseconds Aug 30 10:52:33 rivoplus volumio[28827]: info: All search sources collected, pushing search results Aug 30 10:52:33 rivoplus volumio[28827]: Searching plugin music_service/qobuz Aug 30 10:52:33 rivoplus volumio[28827]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Aug 30 10:52:35 rivoplus volumio[28827]: info: searchQOBUZUri took 1476 milliseconds Aug 30 10:52:35 rivoplus volumio[28827]: info: All search sources collected, pushing search results Aug 30 10:52:38 rivoplus volumio[28827]: Searching plugin music_service/qobuz Aug 30 10:52:38 rivoplus volumio[28827]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Aug 30 10:52:39 rivoplus volumio[28827]: info: searchQOBUZUri took 1271 milliseconds Aug 30 10:52:39 rivoplus volumio[28827]: info: All search sources collected, pushing search results Aug 30 10:52:39 rivoplus volumio[28827]: Searching plugin music_service/qobuz Aug 30 10:52:39 rivoplus volumio[28827]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Aug 30 10:52:41 rivoplus volumio[28827]: info: searchQOBUZUri took 1203 milliseconds Aug 30 10:52:41 rivoplus volumio[28827]: info: All search sources collected, pushing search results Aug 30 10:52:48 rivoplus volumio[28827]: info: CoreCommandRouter::executeOnPlugin: qobuz , handleBrowseUri Aug 30 10:52:49 rivoplus volumio[28827]: info: handleBrowseUri took 1156 milliseconds Aug 30 10:52:49 rivoplus volumio[28827]: info: Preload queue cleared Aug 30 10:52:49 rivoplus volumio[28827]: info: Preloading song: qobuz://song/49900128 Aug 30 10:52:49 rivoplus volumio[28827]: info: Preloading song: qobuz://song/49900129 Aug 30 10:52:49 rivoplus volumio[28827]: info: Preloading song: qobuz://song/49900130 Aug 30 10:52:49 rivoplus volumio[28827]: info: Preloading song: qobuz://song/49900131 Aug 30 10:52:49 rivoplus volumio[28827]: info: Preloading song: qobuz://song/49900132 Aug 30 10:52:49 rivoplus volumio[28827]: info: Preloading song: qobuz://song/49900133 Aug 30 10:52:49 rivoplus volumio[28827]: info: Preloading song: qobuz://song/49900134 Aug 30 10:52:49 rivoplus volumio[28827]: info: Preloading song: qobuz://song/49900135 Aug 30 10:52:49 rivoplus volumio[28827]: info: Preloading song: qobuz://song/49900136 Aug 30 10:52:49 rivoplus volumio[28827]: info: Preloading song: qobuz://song/49900137 Aug 30 10:52:49 rivoplus volumio[28827]: info: Preloading song: qobuz://song/49900138 Aug 30 10:52:49 rivoplus volumio[28827]: info: Preloading song: qobuz://song/49900139 Aug 30 10:52:49 rivoplus volumio[28827]: info: Preloading song: qobuz://song/49900140 Aug 30 10:52:49 rivoplus volumio[28827]: info: Preloading song: qobuz://song/49900141 Aug 30 10:52:49 rivoplus volumio[28827]: info: Preloading song: qobuz://song/49900142 Aug 30 10:52:49 rivoplus volumio[28827]: info: Preloading song: qobuz://song/49900143 Aug 30 10:52:49 rivoplus volumio[28827]: info: Preloading song: qobuz://song/49900144 Aug 30 10:52:49 rivoplus volumio[28827]: info: Preloading song: qobuz://song/49900145 Aug 30 10:52:49 rivoplus volumio[28827]: info: Exploding uri qobuz://song/49900128 in service qobuz Aug 30 10:52:49 rivoplus volumio[28827]: https://prod.vlmapi.io/v2/qobuz/explodeUri Aug 30 10:52:49 rivoplus volumio[28827]: info: Exploding uri qobuz://song/49900129 in service qobuz Aug 30 10:52:49 rivoplus volumio[28827]: https://prod.vlmapi.io/v2/qobuz/explodeUri Aug 30 10:52:49 rivoplus volumio[28827]: info: Exploding uri qobuz://song/49900130 in service qobuz Aug 30 10:52:49 rivoplus volumio[28827]: https://prod.vlmapi.io/v2/qobuz/explodeUri Aug 30 10:52:49 rivoplus volumio[28827]: info: Exploding uri qobuz://song/49900131 in service qobuz Aug 30 10:52:49 rivoplus volumio[28827]: https://prod.vlmapi.io/v2/qobuz/explodeUri Aug 30 10:52:49 rivoplus volumio[28827]: info: Exploding uri qobuz://song/49900132 in service qobuz Aug 30 10:52:49 rivoplus volumio[28827]: https://prod.vlmapi.io/v2/qobuz/explodeUri Aug 30 10:52:49 rivoplus volumio[28827]: info: Executing endpoint getSimilarAlbums Aug 30 10:52:49 rivoplus volumio[28827]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums Aug 30 10:52:49 rivoplus volumio[28827]: info: Executing endpoint getSimilarAlbums Aug 30 10:52:49 rivoplus volumio[28827]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums Aug 30 10:52:49 rivoplus volumio[28827]: info: Executing endpoint getSimilarAlbums Aug 30 10:52:49 rivoplus volumio[28827]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums Aug 30 10:52:49 rivoplus volumio[28827]: info: Exploding uri qobuz://song/49900133 in service qobuz Aug 30 10:52:49 rivoplus volumio[28827]: https://prod.vlmapi.io/v2/qobuz/explodeUri Aug 30 10:52:49 rivoplus volumio[28827]: info: Executing endpoint getSimilarAlbums Aug 30 10:52:49 rivoplus volumio[28827]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums Aug 30 10:52:49 rivoplus volumio[28827]: info: Executing endpoint getSimilarAlbums Aug 30 10:52:49 rivoplus volumio[28827]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums Aug 30 10:52:49 rivoplus volumio[28827]: info: Executing endpoint getSimilarAlbums Aug 30 10:52:49 rivoplus volumio[28827]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums Aug 30 10:52:49 rivoplus volumio[28827]: info: Exploding uri qobuz://song/49900134 in service qobuz Aug 30 10:52:49 rivoplus volumio[28827]: https://prod.vlmapi.io/v2/qobuz/explodeUri Aug 30 10:52:49 rivoplus volumio[28827]: info: Exploding uri qobuz://song/49900135 in service qobuz Aug 30 10:52:49 rivoplus volumio[28827]: https://prod.vlmapi.io/v2/qobuz/explodeUri Aug 30 10:52:49 rivoplus volumio[28827]: info: Exploding uri qobuz://song/49900136 in service qobuz Aug 30 10:52:49 rivoplus volumio[28827]: https://prod.vlmapi.io/v2/qobuz/explodeUri Aug 30 10:52:49 rivoplus volumio[28827]: info: Exploding uri qobuz://song/49900137 in service qobuz Aug 30 10:52:49 rivoplus volumio[28827]: https://prod.vlmapi.io/v2/qobuz/explodeUri Aug 30 10:52:49 rivoplus volumio[28827]: info: Exploding uri qobuz://song/49900138 in service qobuz Aug 30 10:52:49 rivoplus volumio[28827]: https://prod.vlmapi.io/v2/qobuz/explodeUri Aug 30 10:52:49 rivoplus volumio[28827]: info: Exploding uri qobuz://song/49900139 in service qobuz Aug 30 10:52:49 rivoplus volumio[28827]: https://prod.vlmapi.io/v2/qobuz/explodeUri Aug 30 10:52:50 rivoplus volumio[28827]: info: Exploding uri qobuz://song/49900140 in service qobuz Aug 30 10:52:50 rivoplus volumio[28827]: https://prod.vlmapi.io/v2/qobuz/explodeUri Aug 30 10:52:50 rivoplus volumio[28827]: info: explodeUri took 615 milliseconds Aug 30 10:52:50 rivoplus volumio[28827]: info: Exploding uri qobuz://song/49900141 in service qobuz Aug 30 10:52:50 rivoplus volumio[28827]: https://prod.vlmapi.io/v2/qobuz/explodeUri Aug 30 10:52:50 rivoplus volumio[28827]: info: Exploding uri qobuz://song/49900142 in service qobuz Aug 30 10:52:50 rivoplus volumio[28827]: https://prod.vlmapi.io/v2/qobuz/explodeUri Aug 30 10:52:50 rivoplus volumio[28827]: info: explodeUri took 612 milliseconds Aug 30 10:52:50 rivoplus volumio[28827]: info: Exploding uri qobuz://song/49900143 in service qobuz Aug 30 10:52:50 rivoplus volumio[28827]: https://prod.vlmapi.io/v2/qobuz/explodeUri Aug 30 10:52:50 rivoplus volumio[28827]: info: explodeUri took 730 milliseconds Aug 30 10:52:50 rivoplus volumio[28827]: info: Exploding uri qobuz://song/49900144 in service qobuz Aug 30 10:52:50 rivoplus volumio[28827]: https://prod.vlmapi.io/v2/qobuz/explodeUri Aug 30 10:52:50 rivoplus volumio[28827]: info: Exploding uri qobuz://song/49900145 in service qobuz Aug 30 10:52:50 rivoplus volumio[28827]: https://prod.vlmapi.io/v2/qobuz/explodeUri Aug 30 10:52:50 rivoplus volumio[28827]: info: explodeUri took 608 milliseconds Aug 30 10:52:50 rivoplus volumio[28827]: info: explodeUri took 745 milliseconds Aug 30 10:52:50 rivoplus volumio[28827]: info: explodeUri took 759 milliseconds Aug 30 10:52:50 rivoplus volumio[28827]: info: Executing endpoint getSimilarAlbums Aug 30 10:52:50 rivoplus volumio[28827]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums Aug 30 10:52:50 rivoplus volumio[28827]: info: explodeUri took 1048 milliseconds Aug 30 10:52:50 rivoplus volumio[28827]: info: Executing endpoint getSimilarAlbums Aug 30 10:52:50 rivoplus volumio[28827]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums Aug 30 10:52:50 rivoplus volumio[28827]: info: Executing endpoint metavolumio Aug 30 10:52:50 rivoplus volumio[28827]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Aug 30 10:52:50 rivoplus volumio[28827]: info: explodeUri took 1077 milliseconds Aug 30 10:52:50 rivoplus volumio[28827]: info: explodeUri took 1100 milliseconds Aug 30 10:52:50 rivoplus volumio[28827]: info: explodeUri took 590 milliseconds Aug 30 10:52:50 rivoplus volumio[28827]: info: explodeUri took 1183 milliseconds Aug 30 10:52:50 rivoplus volumio[28827]: info: explodeUri took 1063 milliseconds Aug 30 10:52:50 rivoplus volumio[28827]: info: explodeUri took 1031 milliseconds Aug 30 10:52:51 rivoplus volumio[28827]: info: explodeUri took 1007 milliseconds Aug 30 10:52:51 rivoplus volumio[28827]: info: explodeUri took 1028 milliseconds Aug 30 10:52:51 rivoplus volumio[28827]: info: explodeUri took 993 milliseconds Aug 30 10:52:51 rivoplus volumio[28827]: info: explodeUri took 1062 milliseconds Aug 30 10:52:51 rivoplus volumio[28827]: info: Executing endpoint getSimilarAlbums Aug 30 10:52:51 rivoplus volumio[28827]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums Aug 30 10:52:51 rivoplus volumio[28827]: info: Executing endpoint metavolumio Aug 30 10:52:51 rivoplus volumio[28827]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Aug 30 10:52:51 rivoplus volumio[28827]: info: explodeUri took 965 milliseconds Aug 30 10:52:51 rivoplus volumio[28827]: info: Executing endpoint metavolumio Aug 30 10:52:51 rivoplus volumio[28827]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Aug 30 10:52:52 rivoplus volumio[28827]: info: Executing endpoint metavolumio Aug 30 10:52:52 rivoplus volumio[28827]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Aug 30 10:52:52 rivoplus volumio[28827]: info: Executing endpoint metavolumio Aug 30 10:52:52 rivoplus volumio[28827]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Aug 30 10:52:54 rivoplus volumio[28827]: info: Executing endpoint metavolumio Aug 30 10:52:54 rivoplus volumio[28827]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Aug 30 10:52:54 rivoplus volumio[28827]: info: Executing endpoint metavolumio Aug 30 10:52:54 rivoplus volumio[28827]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Aug 30 10:52:56 rivoplus volumio[28827]: info: Executing endpoint metavolumio Aug 30 10:52:56 rivoplus volumio[28827]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Aug 30 10:52:56 rivoplus volumio[28827]: info: Executing endpoint metavolumio Aug 30 10:52:56 rivoplus volumio[28827]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Aug 30 10:52:56 rivoplus volumio[28827]: info: Executing endpoint metavolumio Aug 30 10:52:56 rivoplus volumio[28827]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Aug 30 10:52:56 rivoplus volumio[28827]: info: Executing endpoint metavolumio Aug 30 10:52:56 rivoplus volumio[28827]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Aug 30 10:52:59 rivoplus volumio[28827]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 10:52:59 rivoplus volumio[28827]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 10:52:59 rivoplus volumio[28827]: info: Discovery: Getting this device information Aug 30 10:52:59 rivoplus volumio[28827]: info: CoreCommandRouter::volumioGetState Aug 30 10:52:59 rivoplus volumio[28827]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 10:53:03 rivoplus volumio[28827]: error: Failed request for metavolumio API Aug 30 10:53:09 rivoplus volumio[28827]: error: Failed request for metavolumio API Aug 30 10:53:09 rivoplus volumio[28827]: error: Failed request for metavolumio API Aug 30 10:53:09 rivoplus volumio[28827]: error: Failed request for metavolumio API Aug 30 10:53:15 rivoplus ntpd[30546]: Soliciting pool server 2401:5b60:0:1::52 Aug 30 10:53:18 rivoplus ntpd[30546]: Soliciting pool server 103.184.124.254 Aug 30 10:53:18 rivoplus ntpd[30546]: Soliciting pool server 103.184.124.254 Aug 30 10:53:19 rivoplus ntpd[30546]: Soliciting pool server 103.184.124.254 Aug 30 10:53:29 rivoplus volumio[28827]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 10:53:29 rivoplus volumio[28827]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 10:53:29 rivoplus volumio[28827]: info: Discovery: Getting this device information Aug 30 10:53:29 rivoplus volumio[28827]: info: CoreCommandRouter::volumioGetState Aug 30 10:53:29 rivoplus volumio[28827]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 10:53:31 rivoplus volumio[28827]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 30 10:53:31 rivoplus volumio[28827]: Error: connect ETIMEDOUT 151.101.66.79:443 Aug 30 10:53:31 rivoplus volumio[28827]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Aug 30 10:53:31 rivoplus volumio[28827]: errno: -110, Aug 30 10:53:31 rivoplus volumio[28827]: code: 'ETIMEDOUT', Aug 30 10:53:31 rivoplus volumio[28827]: syscall: 'connect', Aug 30 10:53:31 rivoplus volumio[28827]: address: '151.101.66.79', Aug 30 10:53:31 rivoplus volumio[28827]: port: 443 Aug 30 10:53:31 rivoplus volumio[28827]: } Aug 30 10:53:31 rivoplus volumio[28827]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 30 10:53:31 rivoplus sudo[32330]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-08-30 10:52 Aug 30 10:53:31 rivoplus sudo[32330]: 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="669bb6cc406bb77b11c5184fedb8a4dfd19ba4ec" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="rivoplus" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 11:23:19 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo" VOLUMIO_HASH="ca35d8983c8e34dfa9cca80071cf9105"