-- Logs begin at Sun 2026-08-30 18:01:38 +08, end at Sun 2026-08-30 20:54:24 +08. -- Aug 30 20:53:00 rivo volumio[3478]: Searching plugin music_service/tidal Aug 30 20:53:00 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: tidal , search Aug 30 20:53:01 rivo volumio[3478]: info: searchTIDALUri took 624 milliseconds Aug 30 20:53:01 rivo volumio[3478]: info: search took 626 milliseconds Aug 30 20:53:01 rivo volumio[3478]: info: All search sources collected, pushing search results Aug 30 20:53:02 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: tidal , handleBrowseUri Aug 30 20:53:06 rivo volumio[3478]: info: Received Get System Info Aug 30 20:53:06 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 20:53:06 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 20:53:06 rivo volumio[3478]: info: Discovery: Getting this device information Aug 30 20:53:06 rivo volumio[3478]: info: CoreCommandRouter::volumioGetState Aug 30 20:53:06 rivo volumio[3478]: info: CorePlayQueue::getTrack 0 Aug 30 20:53:06 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 20:53:06 rivo volumio5-onboarding[3976]: time=2026-08-30T20:53:06.441+08:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.100.19:56485 @ 0x2800960" available=true connected=false macAddress= ip4Address= ip6Address= ssid= Aug 30 20:53:06 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 30 20:53:06 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 30 20:53:07 rivo volumio[3478]: info: browseTIDALUri took 4806 milliseconds Aug 30 20:53:07 rivo volumio[3478]: info: Preload queue cleared Aug 30 20:53:07 rivo volumio[3478]: info: Preload queue cleared Aug 30 20:53:07 rivo volumio[3478]: info: Preload queue cleared Aug 30 20:53:07 rivo volumio[3478]: info: Preloading song: tidal://song/3227795 Aug 30 20:53:07 rivo volumio[3478]: info: Preloading song: tidal://song/3227787 Aug 30 20:53:07 rivo volumio[3478]: info: Preloading song: tidal://song/1408744 Aug 30 20:53:07 rivo volumio[3478]: info: Preloading song: tidal://song/93628417 Aug 30 20:53:07 rivo volumio[3478]: info: Preloading song: tidal://song/3227797 Aug 30 20:53:07 rivo volumio[3478]: info: Preloading song: tidal://song/1454433 Aug 30 20:53:07 rivo volumio[3478]: info: Preloading song: tidal://song/45639517 Aug 30 20:53:07 rivo volumio[3478]: info: Preloading song: tidal://song/26313101 Aug 30 20:53:07 rivo volumio[3478]: info: Preloading song: tidal://song/1408755 Aug 30 20:53:07 rivo volumio[3478]: info: Preloading song: tidal://song/1408752 Aug 30 20:53:07 rivo volumio[3478]: info: Preloading song: tidal://song/543019385 Aug 30 20:53:07 rivo volumio[3478]: info: Preloading song: tidal://song/543019384 Aug 30 20:53:07 rivo volumio[3478]: info: Preloading song: tidal://song/543019383 Aug 30 20:53:07 rivo volumio[3478]: info: Preloading song: tidal://song/3227793 Aug 30 20:53:07 rivo volumio[3478]: info: Preloading song: tidal://song/53186432 Aug 30 20:53:07 rivo volumio[3478]: info: Preloading song: tidal://song/1408745 Aug 30 20:53:07 rivo volumio[3478]: info: Preloading song: tidal://song/137828187 Aug 30 20:53:07 rivo volumio[3478]: info: Preloading song: tidal://song/4129666 Aug 30 20:53:07 rivo volumio[3478]: info: Preloading song: tidal://song/1408749 Aug 30 20:53:07 rivo volumio[3478]: info: Preloading song: tidal://song/4129660 Aug 30 20:53:07 rivo volumio[3478]: info: Preloading song: tidal://song/4793875 Aug 30 20:53:07 rivo volumio[3478]: info: Preloading song: tidal://song/1408747 Aug 30 20:53:07 rivo volumio[3478]: info: Preloading song: tidal://song/26643986 Aug 30 20:53:07 rivo volumio[3478]: info: Preloading song: tidal://song/1408743 Aug 30 20:53:07 rivo volumio[3478]: info: Preloading song: tidal://song/77687257 Aug 30 20:53:07 rivo volumio[3478]: info: Preloading song: tidal://song/1284015 Aug 30 20:53:07 rivo volumio[3478]: info: Preloading song: tidal://song/77687255 Aug 30 20:53:07 rivo volumio[3478]: info: Preloading song: tidal://song/4129661 Aug 30 20:53:07 rivo volumio[3478]: info: Preloading song: tidal://song/4129668 Aug 30 20:53:07 rivo volumio[3478]: info: Preloading song: tidal://song/77687261 Aug 30 20:53:07 rivo volumio[3478]: info: Preloading song: tidal://song/26644005 Aug 30 20:53:07 rivo volumio[3478]: info: Preloading song: tidal://song/133423739 Aug 30 20:53:07 rivo volumio[3478]: info: Preloading song: tidal://song/4013085 Aug 30 20:53:07 rivo volumio[3478]: info: Preloading song: tidal://song/1408746 Aug 30 20:53:07 rivo volumio[3478]: info: Preloading song: tidal://song/1454444 Aug 30 20:53:07 rivo volumio[3478]: info: Preloading song: tidal://song/93628424 Aug 30 20:53:07 rivo volumio[3478]: info: Preloading song: tidal://song/77687262 Aug 30 20:53:07 rivo volumio[3478]: info: Preloading song: tidal://song/93628436 Aug 30 20:53:07 rivo volumio[3478]: info: Preloading song: tidal://song/1408751 Aug 30 20:53:07 rivo volumio[3478]: info: Preloading song: tidal://song/93628408 Aug 30 20:53:07 rivo volumio[3478]: info: Preloading song: tidal://song/58462875 Aug 30 20:53:07 rivo volumio[3478]: info: Preloading song: tidal://song/1408753 Aug 30 20:53:07 rivo volumio[3478]: info: Preloading song: tidal://song/1408757 Aug 30 20:53:07 rivo volumio[3478]: info: Preloading song: tidal://song/1408754 Aug 30 20:53:07 rivo volumio[3478]: info: Preloading song: tidal://song/598087 Aug 30 20:53:07 rivo volumio[3478]: info: Preloading song: tidal://song/53186429 Aug 30 20:53:07 rivo volumio[3478]: info: Preloading song: tidal://song/1284016 Aug 30 20:53:07 rivo volumio[3478]: info: Preloading song: tidal://song/77687264 Aug 30 20:53:07 rivo volumio[3478]: info: Preloading song: tidal://song/77687260 Aug 30 20:53:07 rivo volumio[3478]: info: Preloading song: tidal://song/26644032 Aug 30 20:53:07 rivo volumio[3478]: info: Exploding uri tidal://song/3227795 in service tidal Aug 30 20:53:07 rivo volumio5-onboarding[3976]: time=2026-08-30T20:53:07.434+08:00 level=INFO msg="service successfully established" component=discovery/localnet Aug 30 20:53:07 rivo volumio[3478]: info: Exploding uri tidal://song/3227787 in service tidal Aug 30 20:53:07 rivo volumio[3478]: info: Exploding uri tidal://song/1408744 in service tidal Aug 30 20:53:07 rivo volumio[3478]: info: No valid Plugin REST Endpoint: getSimilarArtists Aug 30 20:53:07 rivo volumio[3478]: info: Exploding uri tidal://song/93628417 in service tidal Aug 30 20:53:07 rivo volumio[3478]: info: Exploding uri tidal://song/3227797 in service tidal Aug 30 20:53:07 rivo volumio[3478]: info: Exploding uri tidal://song/1454433 in service tidal Aug 30 20:53:07 rivo volumio[3478]: info: Exploding uri tidal://song/45639517 in service tidal Aug 30 20:53:07 rivo volumio[3478]: info: explodeTIDALUri took 305 milliseconds Aug 30 20:53:07 rivo volumio[3478]: info: Exploding uri tidal://song/26313101 in service tidal Aug 30 20:53:07 rivo volumio[3478]: info: Exploding uri tidal://song/1408755 in service tidal Aug 30 20:53:07 rivo volumio[3478]: info: Exploding uri tidal://song/1408752 in service tidal Aug 30 20:53:07 rivo volumio[3478]: info: Exploding uri tidal://song/543019385 in service tidal Aug 30 20:53:07 rivo volumio[3478]: info: explodeTIDALUri took 511 milliseconds Aug 30 20:53:07 rivo volumio[3478]: info: Exploding uri tidal://song/543019384 in service tidal Aug 30 20:53:07 rivo volumio[3478]: info: explodeTIDALUri took 461 milliseconds Aug 30 20:53:08 rivo volumio[3478]: info: Exploding uri tidal://song/543019383 in service tidal Aug 30 20:53:08 rivo volumio[3478]: info: Exploding uri tidal://song/3227793 in service tidal Aug 30 20:53:08 rivo volumio[3478]: info: Exploding uri tidal://song/53186432 in service tidal Aug 30 20:53:08 rivo volumio[3478]: info: explodeTIDALUri took 488 milliseconds Aug 30 20:53:08 rivo volumio[3478]: info: explodeTIDALUri took 569 milliseconds Aug 30 20:53:08 rivo volumio[3478]: info: Exploding uri tidal://song/1408745 in service tidal Aug 30 20:53:08 rivo volumio[3478]: info: explodeTIDALUri took 488 milliseconds Aug 30 20:53:08 rivo volumio[3478]: info: explodeTIDALUri took 497 milliseconds Aug 30 20:53:08 rivo volumio[3478]: info: explodeTIDALUri took 444 milliseconds Aug 30 20:53:08 rivo volumio[3478]: info: Exploding uri tidal://song/137828187 in service tidal Aug 30 20:53:08 rivo volumio[3478]: info: Exploding uri tidal://song/4129666 in service tidal Aug 30 20:53:08 rivo volumio[3478]: info: Exploding uri tidal://song/1408749 in service tidal Aug 30 20:53:08 rivo volumio[3478]: info: explodeTIDALUri took 485 milliseconds Aug 30 20:53:08 rivo volumio[3478]: info: Exploding uri tidal://song/4129660 in service tidal Aug 30 20:53:08 rivo volumio[3478]: info: explodeTIDALUri took 531 milliseconds Aug 30 20:53:08 rivo volumio[3478]: info: Exploding uri tidal://song/4793875 in service tidal Aug 30 20:53:08 rivo volumio[3478]: info: explodeTIDALUri took 489 milliseconds Aug 30 20:53:08 rivo volumio[3478]: info: explodeTIDALUri took 537 milliseconds Aug 30 20:53:08 rivo volumio[3478]: info: Exploding uri tidal://song/1408747 in service tidal Aug 30 20:53:08 rivo volumio[3478]: info: explodeTIDALUri took 414 milliseconds Aug 30 20:53:08 rivo volumio[3478]: info: Exploding uri tidal://song/26643986 in service tidal Aug 30 20:53:08 rivo volumio[3478]: info: Exploding uri tidal://song/1408743 in service tidal Aug 30 20:53:08 rivo volumio[3478]: info: explodeTIDALUri took 410 milliseconds Aug 30 20:53:08 rivo volumio[3478]: info: explodeTIDALUri took 491 milliseconds Aug 30 20:53:08 rivo volumio[3478]: info: Exploding uri tidal://song/77687257 in service tidal Aug 30 20:53:08 rivo volumio[3478]: info: Exploding uri tidal://song/1284015 in service tidal Aug 30 20:53:08 rivo volumio[3478]: info: explodeTIDALUri took 456 milliseconds Aug 30 20:53:08 rivo volumio[3478]: info: explodeTIDALUri took 417 milliseconds Aug 30 20:53:08 rivo volumio[3478]: info: explodeTIDALUri took 735 milliseconds Aug 30 20:53:08 rivo volumio[3478]: info: Exploding uri tidal://song/77687255 in service tidal Aug 30 20:53:08 rivo volumio[3478]: info: explodeTIDALUri took 414 milliseconds Aug 30 20:53:08 rivo volumio[3478]: info: explodeTIDALUri took 394 milliseconds Aug 30 20:53:08 rivo volumio[3478]: info: Exploding uri tidal://song/4129661 in service tidal Aug 30 20:53:08 rivo volumio[3478]: info: Exploding uri tidal://song/4129668 in service tidal Aug 30 20:53:08 rivo volumio[3478]: info: explodeTIDALUri took 365 milliseconds Aug 30 20:53:08 rivo volumio[3478]: info: explodeTIDALUri took 404 milliseconds Aug 30 20:53:08 rivo volumio[3478]: info: Exploding uri tidal://song/77687261 in service tidal Aug 30 20:53:08 rivo volumio[3478]: info: Exploding uri tidal://song/26644005 in service tidal Aug 30 20:53:08 rivo volumio[3478]: info: explodeTIDALUri took 445 milliseconds Aug 30 20:53:08 rivo volumio[3478]: info: explodeTIDALUri took 399 milliseconds Aug 30 20:53:08 rivo volumio[3478]: info: Exploding uri tidal://song/133423739 in service tidal Aug 30 20:53:09 rivo volumio[3478]: info: explodeTIDALUri took 399 milliseconds Aug 30 20:53:09 rivo volumio[3478]: info: Exploding uri tidal://song/4013085 in service tidal Aug 30 20:53:09 rivo volumio[3478]: info: Exploding uri tidal://song/1408746 in service tidal Aug 30 20:53:09 rivo volumio[3478]: info: explodeTIDALUri took 439 milliseconds Aug 30 20:53:09 rivo volumio[3478]: info: Exploding uri tidal://song/1454444 in service tidal Aug 30 20:53:09 rivo volumio[3478]: info: Exploding uri tidal://song/93628424 in service tidal Aug 30 20:53:09 rivo volumio[3478]: info: explodeTIDALUri took 469 milliseconds Aug 30 20:53:09 rivo volumio[3478]: info: explodeTIDALUri took 457 milliseconds Aug 30 20:53:09 rivo volumio[3478]: info: Exploding uri tidal://song/77687262 in service tidal Aug 30 20:53:09 rivo volumio[3478]: info: explodeTIDALUri took 413 milliseconds Aug 30 20:53:09 rivo volumio[3478]: info: Exploding uri tidal://song/93628436 in service tidal Aug 30 20:53:09 rivo volumio[3478]: info: Exploding uri tidal://song/1408751 in service tidal Aug 30 20:53:09 rivo volumio[3478]: info: explodeTIDALUri took 393 milliseconds Aug 30 20:53:09 rivo volumio[3478]: info: Exploding uri tidal://song/93628408 in service tidal Aug 30 20:53:09 rivo volumio[3478]: info: explodeTIDALUri took 474 milliseconds Aug 30 20:53:09 rivo volumio[3478]: info: Exploding uri tidal://song/58462875 in service tidal Aug 30 20:53:09 rivo volumio[3478]: info: explodeTIDALUri took 485 milliseconds Aug 30 20:53:09 rivo volumio[3478]: info: Exploding uri tidal://song/1408753 in service tidal Aug 30 20:53:09 rivo volumio[3478]: info: explodeTIDALUri took 460 milliseconds Aug 30 20:53:09 rivo volumio[3478]: info: explodeTIDALUri took 387 milliseconds Aug 30 20:53:09 rivo volumio[3478]: info: explodeTIDALUri took 401 milliseconds Aug 30 20:53:09 rivo volumio[3478]: info: Exploding uri tidal://song/1408757 in service tidal Aug 30 20:53:09 rivo volumio[3478]: info: Exploding uri tidal://song/1408754 in service tidal Aug 30 20:53:09 rivo volumio[3478]: info: Exploding uri tidal://song/598087 in service tidal Aug 30 20:53:09 rivo volumio[3478]: info: explodeTIDALUri took 428 milliseconds Aug 30 20:53:09 rivo volumio[3478]: info: Exploding uri tidal://song/53186429 in service tidal Aug 30 20:53:09 rivo volumio[3478]: info: Exploding uri tidal://song/1284016 in service tidal Aug 30 20:53:09 rivo volumio[3478]: info: explodeTIDALUri took 464 milliseconds Aug 30 20:53:09 rivo volumio[3478]: info: explodeTIDALUri took 572 milliseconds Aug 30 20:53:09 rivo volumio[3478]: info: explodeTIDALUri took 404 milliseconds Aug 30 20:53:09 rivo volumio[3478]: info: explodeTIDALUri took 438 milliseconds Aug 30 20:53:09 rivo volumio[3478]: info: Exploding uri tidal://song/77687264 in service tidal Aug 30 20:53:09 rivo volumio[3478]: info: Exploding uri tidal://song/77687260 in service tidal Aug 30 20:53:09 rivo volumio[3478]: info: explodeTIDALUri took 366 milliseconds Aug 30 20:53:09 rivo volumio[3478]: info: Exploding uri tidal://song/26644032 in service tidal Aug 30 20:53:09 rivo volumio[3478]: info: explodeTIDALUri took 484 milliseconds Aug 30 20:53:09 rivo volumio[3478]: info: explodeTIDALUri took 453 milliseconds Aug 30 20:53:10 rivo volumio[3478]: info: explodeTIDALUri took 453 milliseconds Aug 30 20:53:10 rivo volumio[3478]: info: explodeTIDALUri took 430 milliseconds Aug 30 20:53:10 rivo volumio[3478]: info: explodeTIDALUri took 458 milliseconds Aug 30 20:53:10 rivo volumio[3478]: info: explodeTIDALUri took 426 milliseconds Aug 30 20:53:10 rivo volumio[3478]: info: explodeTIDALUri took 405 milliseconds Aug 30 20:53:10 rivo volumio[3478]: info: explodeTIDALUri took 404 milliseconds Aug 30 20:53:10 rivo volumio[3478]: info: explodeTIDALUri took 389 milliseconds Aug 30 20:53:13 rivo volumio[3478]: info: Received Get System Info Aug 30 20:53:13 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 20:53:13 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 20:53:13 rivo volumio[3478]: info: Discovery: Getting this device information Aug 30 20:53:13 rivo volumio[3478]: info: CoreCommandRouter::volumioGetState Aug 30 20:53:13 rivo volumio[3478]: info: CorePlayQueue::getTrack 0 Aug 30 20:53:13 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 20:53:13 rivo volumio5-onboarding[3976]: time=2026-08-30T20:53:13.444+08:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.100.19:56485 @ 0x2800960" available=true connected=false macAddress= ip4Address= ip6Address= ssid= Aug 30 20:53:13 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 30 20:53:13 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 30 20:53:14 rivo volumio5-onboarding[3976]: time=2026-08-30T20:53:14.443+08:00 level=INFO msg="service successfully established" component=discovery/localnet Aug 30 20:53:20 rivo volumio5-onboarding[3976]: time=2026-08-30T20:53:20.460+08:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.100.19:56485 @ 0x2800960" available=true connected=false macAddress= ip4Address= ip6Address= ssid= Aug 30 20:53:20 rivo volumio[3478]: info: Received Get System Info Aug 30 20:53:20 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 20:53:20 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 20:53:20 rivo volumio[3478]: info: Discovery: Getting this device information Aug 30 20:53:20 rivo volumio[3478]: info: CoreCommandRouter::volumioGetState Aug 30 20:53:20 rivo volumio[3478]: info: CorePlayQueue::getTrack 0 Aug 30 20:53:20 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 20:53:20 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 30 20:53:20 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 30 20:53:21 rivo volumio5-onboarding[3976]: time=2026-08-30T20:53:21.270+08:00 level=INFO msg="service successfully established" component=discovery/localnet Aug 30 20:53:27 rivo volumio5-onboarding[3976]: time=2026-08-30T20:53:27.465+08:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.100.19:56485 @ 0x2800960" available=true connected=false macAddress= ip4Address= ip6Address= ssid= Aug 30 20:53:27 rivo volumio[3478]: info: Received Get System Info Aug 30 20:53:27 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 20:53:27 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 20:53:27 rivo volumio[3478]: info: Discovery: Getting this device information Aug 30 20:53:27 rivo volumio[3478]: info: CoreCommandRouter::volumioGetState Aug 30 20:53:27 rivo volumio[3478]: info: CorePlayQueue::getTrack 0 Aug 30 20:53:27 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 20:53:27 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 30 20:53:27 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 30 20:53:28 rivo volumio5-onboarding[3976]: time=2026-08-30T20:53:28.264+08:00 level=INFO msg="service successfully established" component=discovery/localnet Aug 30 20:53:34 rivo volumio[3478]: info: Received Get System Info Aug 30 20:53:34 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 20:53:34 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 20:53:34 rivo volumio[3478]: info: Discovery: Getting this device information Aug 30 20:53:34 rivo volumio[3478]: info: CoreCommandRouter::volumioGetState Aug 30 20:53:34 rivo volumio[3478]: info: CorePlayQueue::getTrack 0 Aug 30 20:53:34 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 20:53:34 rivo volumio5-onboarding[3976]: time=2026-08-30T20:53:34.476+08:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.100.19:56485 @ 0x2800960" available=true connected=false macAddress= ip4Address= ip6Address= ssid= Aug 30 20:53:34 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 30 20:53:34 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 30 20:53:35 rivo volumio5-onboarding[3976]: time=2026-08-30T20:53:35.270+08:00 level=INFO msg="service successfully established" component=discovery/localnet Aug 30 20:53:41 rivo volumio5-onboarding[3976]: time=2026-08-30T20:53:41.471+08:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.100.19:56485 @ 0x2800960" available=true connected=false macAddress= ip4Address= ip6Address= ssid= Aug 30 20:53:41 rivo volumio[3478]: info: Received Get System Info Aug 30 20:53:41 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 20:53:41 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 20:53:41 rivo volumio[3478]: info: Discovery: Getting this device information Aug 30 20:53:41 rivo volumio[3478]: info: CoreCommandRouter::volumioGetState Aug 30 20:53:41 rivo volumio[3478]: info: CorePlayQueue::getTrack 0 Aug 30 20:53:41 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 20:53:41 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 30 20:53:41 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 30 20:53:42 rivo volumio5-onboarding[3976]: time=2026-08-30T20:53:42.290+08:00 level=INFO msg="service successfully established" component=discovery/localnet Aug 30 20:53:46 rivo volumio5-onboarding[3976]: time=2026-08-30T20:53:46.638+08:00 level=INFO msg="check connectivity" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.100.19:56485 @ 0x2800960" latency=23.332289ms timeout=10s Aug 30 20:53:46 rivo volumio5-onboarding[3976]: time=2026-08-30T20:53:46.646+08:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.100.19:56485 @ 0x2800960" latency=23.332289ms timeout=10s endpoint=https://radio-directory.firebaseapp.com duration=7.380846ms Aug 30 20:53:46 rivo volumio5-onboarding[3976]: time=2026-08-30T20:53:46.653+08:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.100.19:56485 @ 0x2800960" latency=23.332289ms timeout=10s endpoint=https://browsing-performer.dfs.volumio.org duration=12.820593ms Aug 30 20:53:46 rivo volumio5-onboarding[3976]: time=2026-08-30T20:53:46.657+08:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.100.19:56485 @ 0x2800960" latency=23.332289ms timeout=10s endpoint=https://oauth-performer.dfs.volumio.org duration=16.284077ms Aug 30 20:53:46 rivo volumio5-onboarding[3976]: time=2026-08-30T20:53:46.672+08:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.100.19:56485 @ 0x2800960" latency=23.332289ms timeout=10s endpoint=https://google.com duration=33.274576ms Aug 30 20:53:46 rivo volumio5-onboarding[3976]: time=2026-08-30T20:53:46.749+08:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.100.19:56485 @ 0x2800960" latency=23.332289ms timeout=10s endpoint=https://www.googleapis.com duration=110.817891ms Aug 30 20:53:46 rivo volumio5-onboarding[3976]: time=2026-08-30T20:53:46.822+08:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.100.19:56485 @ 0x2800960" latency=23.332289ms timeout=10s endpoint=http://pushupdates.volumio.org duration=182.900375ms Aug 30 20:53:46 rivo volumio5-onboarding[3976]: time=2026-08-30T20:53:46.853+08:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.100.19:56485 @ 0x2800960" latency=23.332289ms timeout=10s endpoint=https://securetoken.googleapis.com duration=214.317271ms Aug 30 20:53:46 rivo volumio5-onboarding[3976]: time=2026-08-30T20:53:46.868+08:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.100.19:56485 @ 0x2800960" latency=23.332289ms timeout=10s endpoint=https://myvolumio.firebaseio.com duration=227.67491ms Aug 30 20:53:46 rivo volumio5-onboarding[3976]: time=2026-08-30T20:53:46.870+08:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.100.19:56485 @ 0x2800960" latency=23.332289ms timeout=10s endpoint=https://functions.volumio.cloud duration=231.497229ms Aug 30 20:53:46 rivo volumio5-onboarding[3976]: time=2026-08-30T20:53:46.875+08:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.100.19:56485 @ 0x2800960" latency=23.332289ms timeout=10s endpoint=https://database.volumio.cloud duration=233.98008ms Aug 30 20:53:46 rivo volumio5-onboarding[3976]: time=2026-08-30T20:53:46.879+08:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.100.19:56485 @ 0x2800960" latency=23.332289ms timeout=10s endpoint=https://functions.volumio.cloud duration=238.449488ms Aug 30 20:53:47 rivo volumio5-onboarding[3976]: time=2026-08-30T20:53:47.529+08:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.100.19:56485 @ 0x2800960" latency=23.332289ms timeout=10s endpoint=http://cddb.volumio.org duration=890.217239ms Aug 30 20:53:48 rivo volumio[3478]: info: Received Get System Info Aug 30 20:53:48 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 20:53:48 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 20:53:48 rivo volumio[3478]: info: Discovery: Getting this device information Aug 30 20:53:48 rivo volumio[3478]: info: CoreCommandRouter::volumioGetState Aug 30 20:53:48 rivo volumio[3478]: info: CorePlayQueue::getTrack 0 Aug 30 20:53:48 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 20:53:48 rivo volumio5-onboarding[3976]: time=2026-08-30T20:53:48.484+08:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.100.19:56485 @ 0x2800960" available=true connected=false macAddress= ip4Address= ip6Address= ssid= Aug 30 20:53:48 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 30 20:53:48 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 30 20:53:48 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 20:53:48 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 20:53:48 rivo volumio[3478]: info: Discovery: Getting this device information Aug 30 20:53:48 rivo volumio[3478]: info: CoreCommandRouter::volumioGetState Aug 30 20:53:48 rivo volumio[3478]: info: CorePlayQueue::getTrack 0 Aug 30 20:53:48 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 20:53:48 rivo volumio[3478]: verbose: New Socket.io Connection to 192.168.100.182:3000 from 192.168.100.19 UA: Dart/3.12 (dart:io) Engine version: 3 Transport: websocket Total Clients: 8 Aug 30 20:53:48 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 30 20:53:48 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 30 20:53:49 rivo volumio5-onboarding[3976]: time=2026-08-30T20:53:49.311+08:00 level=INFO msg="service successfully established" component=discovery/localnet Aug 30 20:53:49 rivo volumio5-onboarding[3976]: time=2026-08-30T20:53:49.600+08:00 level=INFO msg="endpoint is reachable" component=server type=REQUEST_TYPE_CHECK_INTERNET_CONNECTIVITY peer="192.168.100.19:56485 @ 0x2800960" latency=23.332289ms timeout=10s endpoint=http://plugins.volumio.org duration=2.960581628s Aug 30 20:53:50 rivo volumio[3478]: Searching plugin music_service/tidal Aug 30 20:53:50 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: tidal , search Aug 30 20:53:51 rivo volumio[3478]: info: searchTIDALUri took 649 milliseconds Aug 30 20:53:51 rivo volumio[3478]: info: search took 650 milliseconds Aug 30 20:53:51 rivo volumio[3478]: info: All search sources collected, pushing search results Aug 30 20:53:51 rivo volumio[3478]: Searching plugin music_service/tidal Aug 30 20:53:51 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: tidal , search Aug 30 20:53:52 rivo volumio[3478]: info: searchTIDALUri took 571 milliseconds Aug 30 20:53:52 rivo volumio[3478]: info: search took 573 milliseconds Aug 30 20:53:52 rivo volumio[3478]: info: All search sources collected, pushing search results Aug 30 20:53:52 rivo volumio[3478]: Searching plugin music_service/tidal Aug 30 20:53:52 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: tidal , search Aug 30 20:53:52 rivo volumio[3478]: info: searchTIDALUri took 577 milliseconds Aug 30 20:53:52 rivo volumio[3478]: info: search took 578 milliseconds Aug 30 20:53:52 rivo volumio[3478]: info: All search sources collected, pushing search results Aug 30 20:53:54 rivo volumio[3478]: Searching plugin music_service/tidal Aug 30 20:53:54 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: tidal , search Aug 30 20:53:54 rivo volumio[3478]: info: searchTIDALUri took 642 milliseconds Aug 30 20:53:54 rivo volumio[3478]: info: search took 644 milliseconds Aug 30 20:53:54 rivo volumio[3478]: info: All search sources collected, pushing search results Aug 30 20:53:55 rivo volumio[3478]: info: Received Get System Info Aug 30 20:53:55 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 20:53:55 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 20:53:55 rivo volumio[3478]: info: Discovery: Getting this device information Aug 30 20:53:55 rivo volumio[3478]: info: CoreCommandRouter::volumioGetState Aug 30 20:53:55 rivo volumio[3478]: info: CorePlayQueue::getTrack 0 Aug 30 20:53:55 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 20:53:55 rivo volumio5-onboarding[3976]: time=2026-08-30T20:53:55.487+08:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.100.19:56485 @ 0x2800960" available=true connected=false macAddress= ip4Address= ip6Address= ssid= Aug 30 20:53:55 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 30 20:53:55 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 30 20:53:56 rivo volumio[3478]: Searching plugin music_service/tidal Aug 30 20:53:56 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: tidal , search Aug 30 20:53:56 rivo volumio5-onboarding[3976]: time=2026-08-30T20:53:56.321+08:00 level=INFO msg="service successfully established" component=discovery/localnet Aug 30 20:53:57 rivo volumio[3478]: info: searchTIDALUri took 880 milliseconds Aug 30 20:53:57 rivo volumio[3478]: info: search took 882 milliseconds Aug 30 20:53:57 rivo volumio[3478]: info: All search sources collected, pushing search results Aug 30 20:53:57 rivo volumio[3478]: Searching plugin music_service/tidal Aug 30 20:53:57 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: tidal , search Aug 30 20:53:58 rivo volumio[3478]: info: searchTIDALUri took 625 milliseconds Aug 30 20:53:58 rivo volumio[3478]: info: search took 626 milliseconds Aug 30 20:53:58 rivo volumio[3478]: info: All search sources collected, pushing search results Aug 30 20:53:59 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: tidal , handleBrowseUri Aug 30 20:54:00 rivo volumio[3478]: info: browseTIDALUri took 1188 milliseconds Aug 30 20:54:00 rivo volumio[3478]: info: Preload queue cleared Aug 30 20:54:00 rivo volumio[3478]: info: Preload queue cleared Aug 30 20:54:00 rivo volumio[3478]: info: Preload queue cleared Aug 30 20:54:00 rivo volumio[3478]: info: No valid Plugin REST Endpoint: getSimilarArtists Aug 30 20:54:02 rivo volumio5-onboarding[3976]: time=2026-08-30T20:54:02.491+08:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.100.19:56485 @ 0x2800960" available=true connected=false macAddress= ip4Address= ip6Address= ssid= Aug 30 20:54:02 rivo volumio[3478]: info: Received Get System Info Aug 30 20:54:02 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 20:54:02 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 20:54:02 rivo volumio[3478]: info: Discovery: Getting this device information Aug 30 20:54:02 rivo volumio[3478]: info: CoreCommandRouter::volumioGetState Aug 30 20:54:02 rivo volumio[3478]: info: CorePlayQueue::getTrack 0 Aug 30 20:54:02 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 20:54:02 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 30 20:54:02 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 30 20:54:03 rivo volumio5-onboarding[3976]: time=2026-08-30T20:54:03.454+08:00 level=INFO msg="service successfully established" component=discovery/localnet Aug 30 20:54:09 rivo volumio5-onboarding[3976]: time=2026-08-30T20:54:09.495+08:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.100.19:56485 @ 0x2800960" available=true connected=false macAddress= ip4Address= ip6Address= ssid= Aug 30 20:54:09 rivo volumio[3478]: info: Received Get System Info Aug 30 20:54:09 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 20:54:09 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 20:54:09 rivo volumio[3478]: info: Discovery: Getting this device information Aug 30 20:54:09 rivo volumio[3478]: info: CoreCommandRouter::volumioGetState Aug 30 20:54:09 rivo volumio[3478]: info: CorePlayQueue::getTrack 0 Aug 30 20:54:09 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 20:54:09 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 30 20:54:09 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 30 20:54:10 rivo volumio5-onboarding[3976]: time=2026-08-30T20:54:10.305+08:00 level=INFO msg="service successfully established" component=discovery/localnet Aug 30 20:54:16 rivo volumio5-onboarding[3976]: time=2026-08-30T20:54:16.497+08:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.100.19:56485 @ 0x2800960" available=true connected=false macAddress= ip4Address= ip6Address= ssid= Aug 30 20:54:16 rivo volumio[3478]: info: Received Get System Info Aug 30 20:54:16 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 20:54:16 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 20:54:16 rivo volumio[3478]: info: Discovery: Getting this device information Aug 30 20:54:16 rivo volumio[3478]: info: CoreCommandRouter::volumioGetState Aug 30 20:54:16 rivo volumio[3478]: info: CorePlayQueue::getTrack 0 Aug 30 20:54:16 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 20:54:16 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 30 20:54:16 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 30 20:54:17 rivo volumio5-onboarding[3976]: time=2026-08-30T20:54:17.336+08:00 level=INFO msg="service successfully established" component=discovery/localnet Aug 30 20:54:20 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: tidal , handleBrowseUri Aug 30 20:54:20 rivo volumio[3478]: info: browseTIDALUri took 102 milliseconds Aug 30 20:54:20 rivo volumio[3478]: info: Preload queue cleared Aug 30 20:54:20 rivo volumio[3478]: info: Preload queue cleared Aug 30 20:54:23 rivo volumio5-onboarding[3976]: time=2026-08-30T20:54:23.502+08:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.100.19:56485 @ 0x2800960" available=true connected=false macAddress= ip4Address= ip6Address= ssid= Aug 30 20:54:23 rivo volumio[3478]: info: Received Get System Info Aug 30 20:54:23 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 20:54:23 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 20:54:23 rivo volumio[3478]: info: Discovery: Getting this device information Aug 30 20:54:23 rivo volumio[3478]: info: CoreCommandRouter::volumioGetState Aug 30 20:54:23 rivo volumio[3478]: info: CorePlayQueue::getTrack 0 Aug 30 20:54:23 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 20:54:23 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 30 20:54:23 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 30 20:54:23 rivo volumio[3478]: info: CoreCommandRouter::executeOnPlugin: metavolumio , superSearch Aug 30 20:54:23 rivo volumio[3478]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 30 20:54:23 rivo volumio[3478]: TypeError: Cannot read property 'then' of undefined Aug 30 20:54:23 rivo volumio[3478]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:498:20) Aug 30 20:54:23 rivo volumio[3478]: at Socket.emit (events.js:400:28) Aug 30 20:54:23 rivo volumio[3478]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Aug 30 20:54:23 rivo volumio[3478]: at processTicksAndRejections (internal/process/task_queues.js:77:11) Aug 30 20:54:23 rivo volumio[3478]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 30 20:54:24 rivo sudo[11160]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-08-30 20:53 Aug 30 20:54:24 rivo sudo[11160]: 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="e9612ec5034fb2e958508aaefbca2962fd6f6654" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="464fc672d77d3df6ee72b331d36cdf1fa936e1ec" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="rivo" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 27 Feb 2026 11:38:48 AM CET" VOLUMIO_VERSION="3.912" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo" VOLUMIO_HASH="8e381701610c2a79deb52e712150c089"