-- Logs begin at Sat 2026-02-21 21:07:27 MSK, end at Sat 2026-02-21 22:07:46 MSK. -- Feb 21 22:06:28 volumio volumio[786]: info: CoreCommandRouter::executeOnPlugin: qobuz , handleBrowseUri Feb 21 22:06:29 volumio volumio[786]: info: handleBrowseUri took 822 milliseconds Feb 21 22:06:29 volumio volumio[786]: info: Preload queue cleared Feb 21 22:06:29 volumio volumio[786]: info: Executing endpoint getSimilarArtists Feb 21 22:06:29 volumio volumio[786]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarArtists Feb 21 22:06:29 volumio volumio[786]: info: Executing endpoint getSimilarArtists Feb 21 22:06:29 volumio volumio[786]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarArtists Feb 21 22:06:29 volumio volumio[786]: info: Executing endpoint metavolumio Feb 21 22:06:29 volumio volumio[786]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 21 22:06:29 volumio volumio[786]: info: Executing endpoint metavolumio Feb 21 22:06:29 volumio volumio[786]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 21 22:06:48 volumio volumio[786]: info: CorePlayQueue::getTrack 2 Feb 21 22:06:48 volumio volumio[786]: info: CorePlayQueue::getTrack 3 Feb 21 22:06:48 volumio volumio[786]: info: Prefetching next song Feb 21 22:06:48 volumio volumio[786]: info: [1771700808022] ControllerQobuz::prefetch Feb 21 22:06:48 volumio volumio[786]: verbose: ControllerMpd::sendMpdCommand load "http://127.0.0.1:3245?data=qobuz://song/358736959" Feb 21 22:06:48 volumio volumio[786]: STREAMING PROXY: Handling url /?data=qobuz://song/358736959 Feb 21 22:06:48 volumio volumio[786]: info: Executing endpoint getStreamUrlqobuz Feb 21 22:06:48 volumio volumio[786]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI Feb 21 22:06:48 volumio volumio[786]: info: getStreamUrl took 318 milliseconds Feb 21 22:06:48 volumio volumio[786]: STREAMING PROXY: Got real url: https://streaming-qobuz-std.akamaized.net/file?uid=2254030&eid=358736959&fmt=7&profile=raw&app_id=539451548&cid=3800232&etsp=1771704408&hmac=KSwVihGWoORNHUvmEM6sJfImFBM Feb 21 22:06:48 volumio volumio[786]: STREAMING PROXY: Response: 200, length: 101635431 Feb 21 22:06:48 volumio volumio[786]: STREAMING PROXY: Client dropped request, destroying Feb 21 22:06:48 volumio volumio[786]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/358736959" Feb 21 22:06:48 volumio volumio[786]: info: Feb 21 22:06:48 volumio volumio[786]: ---------------------------- MPD announces system playlist update Feb 21 22:06:48 volumio volumio[786]: info: Ignoring MPD Status Update Feb 21 22:06:48 volumio volumio[786]: info: sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/358736959" took 2 milliseconds Feb 21 22:06:48 volumio volumio[786]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 21 22:06:48 volumio volumio[786]: verbose: ControllerMpd::sendMpdCommand consume 1 Feb 21 22:06:48 volumio volumio[786]: info: ------------------------------ 2ms Feb 21 22:06:48 volumio volumio[786]: info: sendMpdCommand consume 1 took 1 milliseconds Feb 21 22:06:49 volumio volumio[786]: STREAMING PROXY: Handling url /?data=qobuz://song/358736959 Feb 21 22:06:49 volumio volumio[786]: info: Executing endpoint getStreamUrlqobuz Feb 21 22:06:49 volumio volumio[786]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI Feb 21 22:06:49 volumio volumio[786]: info: getStreamUrl took 235 milliseconds Feb 21 22:06:49 volumio volumio[786]: STREAMING PROXY: Got real url: https://streaming-qobuz-std.akamaized.net/file?uid=2254030&eid=358736959&fmt=7&profile=raw&app_id=539451548&cid=3800232&etsp=1771704409&hmac=eWfWLiLIh8mfAvQd81YZfBaCssg Feb 21 22:06:49 volumio volumio[786]: STREAMING PROXY: Response: 200, length: 101635431 Feb 21 22:06:52 volumio volumio[786]: info: CoreStateMachine::startPlaybackTimer Feb 21 22:06:52 volumio volumio[786]: info: CorePlayQueue::getTrack 3 Feb 21 22:06:52 volumio volumio[786]: info: CoreStateMachine::pushState Feb 21 22:06:52 volumio volumio[786]: info: CorePlayQueue::getTrack 3 Feb 21 22:06:52 volumio volumio[786]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 22:06:52 volumio volumio[786]: info: CoreCommandRouter::volumioPushState Feb 21 22:06:52 volumio volumio[786]: info: MRS: Pushing multiroomSync output update for this device Feb 21 22:06:52 volumio volumio[786]: info: MRS: Pushing multiroomSync output Feb 21 22:06:52 volumio volumio[786]: info: CoreCommandRouter::volumioGetState Feb 21 22:06:52 volumio volumio[786]: info: CorePlayQueue::getTrack 3 Feb 21 22:06:53 volumio volumio[786]: info: CoreCommandRouter::executeOnPlugin: qobuz , handleBrowseUri Feb 21 22:06:53 volumio volumio[786]: info: Feb 21 22:06:53 volumio volumio[786]: ---------------------------- MPD announces system playlist update Feb 21 22:06:53 volumio volumio[786]: info: Ignoring MPD Status Update Feb 21 22:06:53 volumio volumio[786]: info: Feb 21 22:06:53 volumio volumio[786]: ---------------------------- MPD announces state update: player Feb 21 22:06:53 volumio volumio[786]: info: ControllerMpd::getState Feb 21 22:06:53 volumio volumio[786]: verbose: ControllerMpd::sendMpdCommand status Feb 21 22:06:53 volumio volumio[786]: info: ------------------------------ 2ms Feb 21 22:06:53 volumio volumio[786]: info: sendMpdCommand status took 1 milliseconds Feb 21 22:06:53 volumio volumio[786]: verbose: ControllerMpd::parseState Feb 21 22:06:53 volumio volumio[786]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 22:06:53 volumio volumio[786]: info: sendMpdCommand playlistinfo took 0 milliseconds Feb 21 22:06:53 volumio volumio[786]: verbose: ControllerMpd::parseTrackInfo Feb 21 22:06:53 volumio volumio[786]: info: ControllerMpd::pushState Feb 21 22:06:53 volumio volumio[786]: info: CoreCommandRouter::servicePushState Feb 21 22:06:53 volumio volumio[786]: info: CorePlayQueue::getTrack 3 Feb 21 22:06:53 volumio volumio[786]: verbose: STATE SERVICE {"status":"play","position":0,"seek":26,"duration":310,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1877 Kbps","isStreaming":false,"title":"358736959","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/358736959","trackType":"qobuz"} Feb 21 22:06:53 volumio volumio[786]: verbose: CURRENT POSITION 3 Feb 21 22:06:53 volumio volumio[786]: info: CoreStateMachine::syncState stateService play Feb 21 22:06:53 volumio volumio[786]: info: CoreStateMachine::syncState currentStatus play Feb 21 22:06:53 volumio volumio[786]: info: Received an update from plugin. extracting info from payload Feb 21 22:06:53 volumio volumio[786]: info: CoreStateMachine::pushState Feb 21 22:06:53 volumio volumio[786]: info: CorePlayQueue::getTrack 3 Feb 21 22:06:53 volumio volumio[786]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 22:06:53 volumio volumio[786]: info: CoreCommandRouter::volumioPushState Feb 21 22:06:53 volumio volumio[786]: info: MRS: Pushing multiroomSync output update for this device Feb 21 22:06:53 volumio volumio[786]: info: MRS: Pushing multiroomSync output Feb 21 22:06:53 volumio volumio[786]: info: CoreCommandRouter::volumioGetState Feb 21 22:06:53 volumio volumio[786]: info: CorePlayQueue::getTrack 3 Feb 21 22:06:53 volumio volumio[786]: info: CoreStateMachine::pushState Feb 21 22:06:53 volumio volumio[786]: info: CorePlayQueue::getTrack 3 Feb 21 22:06:53 volumio volumio[786]: info: CoreCommandRouter::volumioPushState Feb 21 22:06:53 volumio volumio[786]: info: MRS: Pushing multiroomSync output update for this device Feb 21 22:06:53 volumio volumio[786]: info: MRS: Pushing multiroomSync output Feb 21 22:06:53 volumio volumio[786]: info: CoreCommandRouter::volumioGetState Feb 21 22:06:53 volumio volumio[786]: info: CorePlayQueue::getTrack 3 Feb 21 22:06:53 volumio volumio[786]: info: ------------------------------ 47ms Feb 21 22:06:54 volumio volumio[786]: info: handleBrowseUri took 964 milliseconds Feb 21 22:06:54 volumio volumio[786]: info: Preload queue cleared Feb 21 22:06:54 volumio volumio[786]: info: Executing endpoint getSimilarArtists Feb 21 22:06:54 volumio volumio[786]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarArtists Feb 21 22:06:54 volumio volumio[786]: info: Executing endpoint getSimilarArtists Feb 21 22:06:54 volumio volumio[786]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarArtists Feb 21 22:06:55 volumio volumio[786]: info: Executing endpoint metavolumio Feb 21 22:06:55 volumio volumio[786]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 21 22:06:55 volumio volumio[786]: info: Executing endpoint metavolumio Feb 21 22:06:55 volumio volumio[786]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 21 22:06:58 volumio volumio[786]: STREAMING PROXY: Client dropped request, destroying Feb 21 22:06:59 volumio volumio[786]: info: CoreCommandRouter::executeOnPlugin: qobuz , handleBrowseUri Feb 21 22:07:00 volumio volumio[786]: info: handleBrowseUri took 237 milliseconds Feb 21 22:07:00 volumio volumio[786]: info: Preload queue cleared Feb 21 22:07:00 volumio volumio[786]: info: Preloading song: qobuz://song/24747023 Feb 21 22:07:00 volumio volumio[786]: info: Preloading song: qobuz://song/24747024 Feb 21 22:07:00 volumio volumio[786]: info: Preloading song: qobuz://song/24747025 Feb 21 22:07:00 volumio volumio[786]: info: Preloading song: qobuz://song/24747026 Feb 21 22:07:00 volumio volumio[786]: info: Preloading song: qobuz://song/24747027 Feb 21 22:07:00 volumio volumio[786]: info: Preloading song: qobuz://song/24747028 Feb 21 22:07:00 volumio volumio[786]: info: Preloading song: qobuz://song/24747029 Feb 21 22:07:00 volumio volumio[786]: info: Preloading song: qobuz://song/24747030 Feb 21 22:07:00 volumio volumio[786]: info: Preloading song: qobuz://song/24747031 Feb 21 22:07:00 volumio volumio[786]: info: Preloading song: qobuz://song/24747032 Feb 21 22:07:00 volumio volumio[786]: info: Preloading song: qobuz://song/24747033 Feb 21 22:07:00 volumio volumio[786]: info: Preloading song: qobuz://song/24747034 Feb 21 22:07:00 volumio volumio[786]: info: Preloading song: qobuz://song/24747035 Feb 21 22:07:00 volumio volumio[786]: info: Preloading song: qobuz://song/24747036 Feb 21 22:07:00 volumio volumio[786]: info: Preloading song: qobuz://song/24747037 Feb 21 22:07:00 volumio volumio[786]: info: Preloading song: qobuz://song/24747038 Feb 21 22:07:00 volumio volumio[786]: info: Preloading song: qobuz://song/24747039 Feb 21 22:07:00 volumio volumio[786]: info: Preloading song: qobuz://song/24747040 Feb 21 22:07:00 volumio volumio[786]: info: Preloading song: qobuz://song/24747041 Feb 21 22:07:00 volumio volumio[786]: info: Preloading song: qobuz://song/24747042 Feb 21 22:07:00 volumio volumio[786]: info: Preloading song: qobuz://song/24747043 Feb 21 22:07:00 volumio volumio[786]: info: Preloading song: qobuz://song/24747044 Feb 21 22:07:00 volumio volumio[786]: info: Preloading song: qobuz://song/24747045 Feb 21 22:07:00 volumio volumio[786]: info: Preloading song: qobuz://song/24747046 Feb 21 22:07:00 volumio volumio[786]: info: Preloading song: qobuz://song/24747047 Feb 21 22:07:00 volumio volumio[786]: info: Preloading song: qobuz://song/24747048 Feb 21 22:07:00 volumio volumio[786]: info: Preloading song: qobuz://song/24747049 Feb 21 22:07:00 volumio volumio[786]: info: Preloading song: qobuz://song/24747050 Feb 21 22:07:00 volumio volumio[786]: info: Preloading song: qobuz://song/24747051 Feb 21 22:07:00 volumio volumio[786]: info: Preloading song: qobuz://song/24747052 Feb 21 22:07:00 volumio volumio[786]: info: Exploding uri qobuz://song/24747023 in service qobuz Feb 21 22:07:00 volumio volumio[786]: https://prod.vlmapi.io/v2/qobuz/explodeUri Feb 21 22:07:00 volumio volumio[786]: info: Exploding uri qobuz://song/24747024 in service qobuz Feb 21 22:07:00 volumio volumio[786]: https://prod.vlmapi.io/v2/qobuz/explodeUri Feb 21 22:07:00 volumio volumio[786]: info: Exploding uri qobuz://song/24747025 in service qobuz Feb 21 22:07:00 volumio volumio[786]: https://prod.vlmapi.io/v2/qobuz/explodeUri Feb 21 22:07:00 volumio volumio[786]: info: Exploding uri qobuz://song/24747026 in service qobuz Feb 21 22:07:00 volumio volumio[786]: https://prod.vlmapi.io/v2/qobuz/explodeUri Feb 21 22:07:00 volumio volumio[786]: info: Executing endpoint getSimilarAlbums Feb 21 22:07:00 volumio volumio[786]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums Feb 21 22:07:00 volumio volumio[786]: info: Executing endpoint getSimilarAlbums Feb 21 22:07:00 volumio volumio[786]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums Feb 21 22:07:00 volumio volumio[786]: info: Exploding uri qobuz://song/24747027 in service qobuz Feb 21 22:07:00 volumio volumio[786]: https://prod.vlmapi.io/v2/qobuz/explodeUri Feb 21 22:07:00 volumio volumio[786]: info: Executing endpoint metavolumio Feb 21 22:07:00 volumio volumio[786]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 21 22:07:00 volumio volumio[786]: info: Exploding uri qobuz://song/24747028 in service qobuz Feb 21 22:07:00 volumio volumio[786]: https://prod.vlmapi.io/v2/qobuz/explodeUri Feb 21 22:07:00 volumio volumio[786]: info: Executing endpoint metavolumio Feb 21 22:07:00 volumio volumio[786]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 21 22:07:00 volumio volumio[786]: info: Executing endpoint metavolumio Feb 21 22:07:00 volumio volumio[786]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 21 22:07:00 volumio volumio[786]: info: Executing endpoint metavolumio Feb 21 22:07:00 volumio volumio[786]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 21 22:07:00 volumio volumio[786]: info: Exploding uri qobuz://song/24747029 in service qobuz Feb 21 22:07:00 volumio volumio[786]: https://prod.vlmapi.io/v2/qobuz/explodeUri Feb 21 22:07:00 volumio volumio[786]: info: explodeUri took 306 milliseconds Feb 21 22:07:00 volumio volumio[786]: info: explodeUri took 272 milliseconds Feb 21 22:07:00 volumio volumio[786]: info: Exploding uri qobuz://song/24747030 in service qobuz Feb 21 22:07:00 volumio volumio[786]: https://prod.vlmapi.io/v2/qobuz/explodeUri Feb 21 22:07:00 volumio volumio[786]: info: explodeUri took 292 milliseconds Feb 21 22:07:00 volumio volumio[786]: info: Exploding uri qobuz://song/24747031 in service qobuz Feb 21 22:07:00 volumio volumio[786]: https://prod.vlmapi.io/v2/qobuz/explodeUri Feb 21 22:07:00 volumio volumio[786]: info: Exploding uri qobuz://song/24747032 in service qobuz Feb 21 22:07:00 volumio volumio[786]: https://prod.vlmapi.io/v2/qobuz/explodeUri Feb 21 22:07:00 volumio volumio[786]: info: explodeUri took 306 milliseconds Feb 21 22:07:00 volumio volumio[786]: info: Exploding uri qobuz://song/24747033 in service qobuz Feb 21 22:07:00 volumio volumio[786]: https://prod.vlmapi.io/v2/qobuz/explodeUri Feb 21 22:07:00 volumio volumio[786]: info: explodeUri took 313 milliseconds Feb 21 22:07:00 volumio volumio[786]: info: Exploding uri qobuz://song/24747034 in service qobuz Feb 21 22:07:00 volumio volumio[786]: https://prod.vlmapi.io/v2/qobuz/explodeUri Feb 21 22:07:00 volumio volumio[786]: info: explodeUri took 456 milliseconds Feb 21 22:07:00 volumio volumio[786]: info: Exploding uri qobuz://song/24747035 in service qobuz Feb 21 22:07:00 volumio volumio[786]: https://prod.vlmapi.io/v2/qobuz/explodeUri Feb 21 22:07:00 volumio volumio[786]: info: explodeUri took 327 milliseconds Feb 21 22:07:00 volumio volumio[786]: info: explodeUri took 280 milliseconds Feb 21 22:07:00 volumio volumio[786]: info: Exploding uri qobuz://song/24747036 in service qobuz Feb 21 22:07:00 volumio volumio[786]: https://prod.vlmapi.io/v2/qobuz/explodeUri Feb 21 22:07:01 volumio volumio[786]: info: Exploding uri qobuz://song/24747037 in service qobuz Feb 21 22:07:01 volumio volumio[786]: https://prod.vlmapi.io/v2/qobuz/explodeUri Feb 21 22:07:01 volumio volumio[786]: info: explodeUri took 319 milliseconds Feb 21 22:07:01 volumio volumio[786]: info: Exploding uri qobuz://song/24747038 in service qobuz Feb 21 22:07:01 volumio volumio[786]: https://prod.vlmapi.io/v2/qobuz/explodeUri Feb 21 22:07:01 volumio volumio[786]: info: Exploding uri qobuz://song/24747039 in service qobuz Feb 21 22:07:01 volumio volumio[786]: https://prod.vlmapi.io/v2/qobuz/explodeUri Feb 21 22:07:01 volumio volumio[786]: info: explodeUri took 296 milliseconds Feb 21 22:07:01 volumio volumio[786]: info: Exploding uri qobuz://song/24747040 in service qobuz Feb 21 22:07:01 volumio volumio[786]: https://prod.vlmapi.io/v2/qobuz/explodeUri Feb 21 22:07:01 volumio volumio[786]: info: explodeUri took 409 milliseconds Feb 21 22:07:01 volumio volumio[786]: info: Exploding uri qobuz://song/24747041 in service qobuz Feb 21 22:07:01 volumio volumio[786]: https://prod.vlmapi.io/v2/qobuz/explodeUri Feb 21 22:07:01 volumio volumio[786]: info: Exploding uri qobuz://song/24747042 in service qobuz Feb 21 22:07:01 volumio volumio[786]: https://prod.vlmapi.io/v2/qobuz/explodeUri Feb 21 22:07:01 volumio volumio[786]: info: explodeUri took 409 milliseconds Feb 21 22:07:01 volumio volumio[786]: info: explodeUri took 271 milliseconds Feb 21 22:07:01 volumio volumio[786]: info: explodeUri took 336 milliseconds Feb 21 22:07:01 volumio volumio[786]: info: explodeUri took 386 milliseconds Feb 21 22:07:01 volumio volumio[786]: info: Exploding uri qobuz://song/24747043 in service qobuz Feb 21 22:07:01 volumio volumio[786]: https://prod.vlmapi.io/v2/qobuz/explodeUri Feb 21 22:07:01 volumio volumio[786]: info: Exploding uri qobuz://song/24747044 in service qobuz Feb 21 22:07:01 volumio volumio[786]: https://prod.vlmapi.io/v2/qobuz/explodeUri Feb 21 22:07:01 volumio volumio[786]: info: explodeUri took 322 milliseconds Feb 21 22:07:01 volumio volumio[786]: info: Exploding uri qobuz://song/24747045 in service qobuz Feb 21 22:07:01 volumio volumio[786]: https://prod.vlmapi.io/v2/qobuz/explodeUri Feb 21 22:07:01 volumio volumio[786]: info: explodeUri took 318 milliseconds Feb 21 22:07:01 volumio volumio[786]: info: Exploding uri qobuz://song/24747046 in service qobuz Feb 21 22:07:01 volumio volumio[786]: https://prod.vlmapi.io/v2/qobuz/explodeUri Feb 21 22:07:01 volumio volumio[786]: info: explodeUri took 310 milliseconds Feb 21 22:07:01 volumio volumio[786]: info: explodeUri took 274 milliseconds Feb 21 22:07:01 volumio volumio[786]: info: Exploding uri qobuz://song/24747047 in service qobuz Feb 21 22:07:01 volumio volumio[786]: https://prod.vlmapi.io/v2/qobuz/explodeUri Feb 21 22:07:01 volumio volumio[786]: info: Exploding uri qobuz://song/24747048 in service qobuz Feb 21 22:07:01 volumio volumio[786]: https://prod.vlmapi.io/v2/qobuz/explodeUri Feb 21 22:07:01 volumio volumio[786]: info: Exploding uri qobuz://song/24747049 in service qobuz Feb 21 22:07:01 volumio volumio[786]: https://prod.vlmapi.io/v2/qobuz/explodeUri Feb 21 22:07:01 volumio volumio[786]: info: explodeUri took 354 milliseconds Feb 21 22:07:01 volumio volumio[786]: info: Exploding uri qobuz://song/24747050 in service qobuz Feb 21 22:07:01 volumio volumio[786]: https://prod.vlmapi.io/v2/qobuz/explodeUri Feb 21 22:07:01 volumio volumio[786]: info: explodeUri took 305 milliseconds Feb 21 22:07:01 volumio volumio[786]: info: Exploding uri qobuz://song/24747051 in service qobuz Feb 21 22:07:01 volumio volumio[786]: https://prod.vlmapi.io/v2/qobuz/explodeUri Feb 21 22:07:01 volumio volumio[786]: info: Exploding uri qobuz://song/24747052 in service qobuz Feb 21 22:07:01 volumio volumio[786]: https://prod.vlmapi.io/v2/qobuz/explodeUri Feb 21 22:07:01 volumio volumio[786]: info: explodeUri took 307 milliseconds Feb 21 22:07:01 volumio volumio[786]: info: explodeUri took 572 milliseconds Feb 21 22:07:01 volumio volumio[786]: info: explodeUri took 324 milliseconds Feb 21 22:07:01 volumio volumio[786]: info: explodeUri took 294 milliseconds Feb 21 22:07:01 volumio volumio[786]: info: explodeUri took 477 milliseconds Feb 21 22:07:01 volumio volumio[786]: info: explodeUri took 318 milliseconds Feb 21 22:07:02 volumio volumio[786]: info: explodeUri took 630 milliseconds Feb 21 22:07:02 volumio volumio[786]: info: explodeUri took 307 milliseconds Feb 21 22:07:02 volumio volumio[786]: info: explodeUri took 363 milliseconds Feb 21 22:07:15 volumio volumio[786]: info: CoreCommandRouter::volumioPause Feb 21 22:07:15 volumio volumio[786]: info: CoreStateMachine::pause Feb 21 22:07:15 volumio volumio[786]: info: CoreStateMachine::stPlaybackTimer Feb 21 22:07:15 volumio volumio[786]: info: CoreStateMachine::servicePause Feb 21 22:07:15 volumio volumio[786]: info: CorePlayQueue::getTrack 3 Feb 21 22:07:15 volumio volumio[786]: info: CoreCommandRouter::servicePause Feb 21 22:07:15 volumio volumio[786]: info: [1771700835345] ControllerQobuz::pause Feb 21 22:07:15 volumio volumio[786]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 21 22:07:15 volumio volumio[786]: info: ControllerMpd::pause Feb 21 22:07:15 volumio volumio[786]: verbose: ControllerMpd::sendMpdCommand pause Feb 21 22:07:15 volumio volumio[786]: info: Feb 21 22:07:15 volumio volumio[786]: ---------------------------- MPD announces state update: player Feb 21 22:07:15 volumio volumio[786]: info: sendMpdCommand pause took 2 milliseconds Feb 21 22:07:15 volumio volumio[786]: info: ControllerMpd::getState Feb 21 22:07:15 volumio volumio[786]: verbose: ControllerMpd::sendMpdCommand status Feb 21 22:07:15 volumio volumio[786]: info: sendMpdCommand status took 1 milliseconds Feb 21 22:07:15 volumio volumio[786]: verbose: ControllerMpd::parseState Feb 21 22:07:15 volumio volumio[786]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 22:07:15 volumio volumio[786]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 21 22:07:15 volumio volumio[786]: verbose: ControllerMpd::parseTrackInfo Feb 21 22:07:15 volumio volumio[786]: info: ControllerMpd::pushState Feb 21 22:07:15 volumio volumio[786]: info: CoreCommandRouter::servicePushState Feb 21 22:07:15 volumio volumio[786]: info: CorePlayQueue::getTrack 3 Feb 21 22:07:15 volumio volumio[786]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":21525,"duration":310,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2492 Kbps","isStreaming":false,"title":"358736959","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/358736959","trackType":"qobuz"} Feb 21 22:07:15 volumio volumio[786]: verbose: CURRENT POSITION 3 Feb 21 22:07:15 volumio volumio[786]: info: CoreStateMachine::syncState stateService pause Feb 21 22:07:15 volumio volumio[786]: info: CoreStateMachine::syncState currentStatus pause Feb 21 22:07:15 volumio volumio[786]: info: CoreStateMachine::pushState Feb 21 22:07:15 volumio volumio[786]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 22:07:15 volumio volumio[786]: info: CoreCommandRouter::volumioPushState Feb 21 22:07:15 volumio volumio[786]: info: MRS: Pushing multiroomSync output update for this device Feb 21 22:07:15 volumio volumio[786]: info: MRS: Pushing multiroomSync output Feb 21 22:07:15 volumio volumio[786]: info: CoreCommandRouter::volumioGetState Feb 21 22:07:15 volumio volumio[786]: info: CoreStateMachine::stPlaybackTimer Feb 21 22:07:15 volumio volumio[786]: info: ------------------------------ 24ms Feb 21 22:07:19 volumio volumio[786]: info: Preload queue cleared Feb 21 22:07:19 volumio volumio[786]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 21 22:07:19 volumio volumio[786]: info: CoreStateMachine::ClearQueue Feb 21 22:07:19 volumio volumio[786]: info: CoreStateMachine::stop Feb 21 22:07:19 volumio volumio[786]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 21 22:07:19 volumio volumio[786]: info: CoreStateMachine::updateTrackBlock Feb 21 22:07:19 volumio volumio[786]: info: CorePlayQueue::getTrackBlock Feb 21 22:07:19 volumio volumio[786]: info: CoreStateMachine::stPlaybackTimer Feb 21 22:07:19 volumio volumio[786]: info: CoreStateMachine::pushState Feb 21 22:07:19 volumio volumio[786]: info: CorePlayQueue::getTrack 3 Feb 21 22:07:19 volumio volumio[786]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 22:07:19 volumio volumio[786]: info: CoreCommandRouter::volumioPushState Feb 21 22:07:19 volumio volumio[786]: info: MRS: Pushing multiroomSync output update for this device Feb 21 22:07:19 volumio volumio[786]: info: MRS: Pushing multiroomSync output Feb 21 22:07:19 volumio volumio[786]: info: CoreCommandRouter::volumioGetState Feb 21 22:07:19 volumio volumio[786]: info: CorePlayQueue::getTrack 3 Feb 21 22:07:19 volumio volumio[786]: info: CoreStateMachine::serviceStop Feb 21 22:07:19 volumio volumio[786]: info: CorePlayQueue::getTrack 3 Feb 21 22:07:19 volumio volumio[786]: info: CoreCommandRouter::serviceStop Feb 21 22:07:19 volumio volumio[786]: info: [1771700839101] ControllerQobuz::stop Feb 21 22:07:19 volumio volumio[786]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 21 22:07:19 volumio volumio[786]: info: ControllerMpd::stop Feb 21 22:07:19 volumio volumio[786]: verbose: ControllerMpd::sendMpdCommand stop Feb 21 22:07:19 volumio volumio[786]: info: CorePlayQueue::clearPlayQueue Feb 21 22:07:19 volumio volumio[786]: info: CorePlayQueue::saveQueue Feb 21 22:07:19 volumio volumio[786]: info: CoreCommandRouter::volumioPushQueue Feb 21 22:07:19 volumio volumio[786]: info: CoreStateMachine::addQueueItems Feb 21 22:07:19 volumio volumio[786]: info: CorePlayQueue::addQueueItems Feb 21 22:07:19 volumio volumio[786]: info: Preload queue cleared Feb 21 22:07:19 volumio volumio[786]: info: Adding Item to queue: qobuz://album/5055354410840 Feb 21 22:07:19 volumio volumio[786]: info: Exploding uri qobuz://album/5055354410840 in service qobuz Feb 21 22:07:19 volumio volumio[786]: https://prod.vlmapi.io/v2/qobuz/explodeUri Feb 21 22:07:19 volumio volumio[786]: info: Feb 21 22:07:19 volumio volumio[786]: ---------------------------- MPD announces state update: player Feb 21 22:07:19 volumio volumio[786]: info: sendMpdCommand stop took 28 milliseconds Feb 21 22:07:19 volumio volumio[786]: info: ControllerMpd::getState Feb 21 22:07:19 volumio volumio[786]: verbose: ControllerMpd::sendMpdCommand status Feb 21 22:07:19 volumio volumio[786]: info: sendMpdCommand status took 1 milliseconds Feb 21 22:07:19 volumio volumio[786]: verbose: ControllerMpd::parseState Feb 21 22:07:19 volumio volumio[786]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 22:07:19 volumio volumio[786]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 21 22:07:19 volumio volumio[786]: verbose: ControllerMpd::parseTrackInfo Feb 21 22:07:19 volumio volumio[786]: info: ControllerMpd::pushState Feb 21 22:07:19 volumio volumio[786]: info: CoreCommandRouter::servicePushState Feb 21 22:07:19 volumio volumio[786]: info: CoreStateMachine::pushState Feb 21 22:07:19 volumio volumio[786]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 22:07:19 volumio volumio[786]: info: CoreCommandRouter::volumioPushState Feb 21 22:07:19 volumio volumio[786]: info: MRS: Pushing multiroomSync output update for this device Feb 21 22:07:19 volumio volumio[786]: info: MRS: Pushing multiroomSync output Feb 21 22:07:19 volumio volumio[786]: info: CoreCommandRouter::volumioGetState Feb 21 22:07:19 volumio volumio[786]: info: CorePlayQueue::getTrack 3 Feb 21 22:07:19 volumio volumio[786]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"358736959","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/358736959","trackType":"qobuz"} Feb 21 22:07:19 volumio volumio[786]: verbose: CURRENT POSITION 3 Feb 21 22:07:19 volumio volumio[786]: info: CoreStateMachine::syncState stateService stop Feb 21 22:07:19 volumio volumio[786]: info: CoreStateMachine::syncState currentStatus stop Feb 21 22:07:19 volumio volumio[786]: info: CoreStateMachine::pushState Feb 21 22:07:19 volumio volumio[786]: info: CoreCommandRouter::volumioPushState Feb 21 22:07:19 volumio volumio[786]: info: MRS: Pushing multiroomSync output update for this device Feb 21 22:07:19 volumio volumio[786]: info: MRS: Pushing multiroomSync output Feb 21 22:07:19 volumio volumio[786]: info: CoreCommandRouter::volumioGetState Feb 21 22:07:19 volumio volumio[786]: info: No code Feb 21 22:07:19 volumio volumio[786]: info: CoreStateMachine::pushState Feb 21 22:07:19 volumio volumio[786]: info: CoreCommandRouter::volumioPushState Feb 21 22:07:19 volumio volumio[786]: info: MRS: Pushing multiroomSync output update for this device Feb 21 22:07:19 volumio volumio[786]: info: MRS: Pushing multiroomSync output Feb 21 22:07:19 volumio volumio[786]: info: CoreCommandRouter::volumioGetState Feb 21 22:07:19 volumio volumio[786]: info: ------------------------------ 63ms Feb 21 22:07:19 volumio volumio[786]: info: explodeUri took 307 milliseconds Feb 21 22:07:19 volumio volumio[786]: info: CoreCommandRouter::volumioPushQueue Feb 21 22:07:19 volumio volumio[786]: info: CorePlayQueue::saveQueue Feb 21 22:07:19 volumio volumio[786]: info: CoreStateMachine::updateTrackBlock Feb 21 22:07:19 volumio volumio[786]: info: CorePlayQueue::getTrackBlock Feb 21 22:07:19 volumio volumio[786]: info: CoreCommandRouter::volumioPlay Feb 21 22:07:19 volumio volumio[786]: info: CoreStateMachine::play index 0 Feb 21 22:07:19 volumio volumio[786]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 21 22:07:19 volumio volumio[786]: info: CoreStateMachine::stop Feb 21 22:07:19 volumio volumio[786]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 21 22:07:19 volumio volumio[786]: info: CoreStateMachine::play index undefined Feb 21 22:07:19 volumio volumio[786]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 21 22:07:19 volumio volumio[786]: info: CorePlayQueue::getTrack 0 Feb 21 22:07:19 volumio volumio[786]: info: CoreStateMachine::startPlaybackTimer Feb 21 22:07:19 volumio volumio[786]: info: CorePlayQueue::getTrack 0 Feb 21 22:07:19 volumio volumio[786]: info: [1771700839419] ControllerQobuz::clearAddPlayTrack Feb 21 22:07:19 volumio volumio[786]: verbose: ControllerMpd::sendMpdCommand stop Feb 21 22:07:19 volumio volumio[786]: info: sendMpdCommand stop took 3 milliseconds Feb 21 22:07:19 volumio volumio[786]: verbose: ControllerMpd::sendMpdCommand clear Feb 21 22:07:19 volumio volumio[786]: info: Feb 21 22:07:19 volumio volumio[786]: ---------------------------- MPD announces system playlist update Feb 21 22:07:19 volumio volumio[786]: info: Ignoring MPD Status Update Feb 21 22:07:19 volumio volumio[786]: info: sendMpdCommand clear took 1 milliseconds Feb 21 22:07:19 volumio volumio[786]: verbose: ControllerMpd::sendMpdCommand load "http://127.0.0.1:3245?data=qobuz://song/24747023" Feb 21 22:07:19 volumio volumio[786]: error: updateQueue error: null Feb 21 22:07:19 volumio volumio[786]: info: ------------------------------ 1ms Feb 21 22:07:19 volumio volumio[786]: STREAMING PROXY: Handling url /?data=qobuz://song/24747023 Feb 21 22:07:19 volumio volumio[786]: info: Executing endpoint getStreamUrlqobuz Feb 21 22:07:19 volumio volumio[786]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI Feb 21 22:07:19 volumio volumio[786]: info: getStreamUrl took 251 milliseconds Feb 21 22:07:19 volumio volumio[786]: STREAMING PROXY: Got real url: https://streaming-qobuz-std.akamaized.net/file?uid=2254030&eid=24747023&fmt=6&profile=raw&app_id=539451548&cid=3800232&etsp=1771704439&hmac=rF6R5iFWBpXCqH1n_-zqq78tj5Q Feb 21 22:07:20 volumio volumio[786]: STREAMING PROXY: Response: 200, length: 4251280 Feb 21 22:07:20 volumio volumio[786]: STREAMING PROXY: Client dropped request, destroying Feb 21 22:07:20 volumio volumio[786]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/24747023" Feb 21 22:07:20 volumio volumio[786]: info: Feb 21 22:07:20 volumio volumio[786]: ---------------------------- MPD announces system playlist update Feb 21 22:07:20 volumio volumio[786]: info: Ignoring MPD Status Update Feb 21 22:07:20 volumio volumio[786]: info: sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/24747023" took 2 milliseconds Feb 21 22:07:20 volumio volumio[786]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 21 22:07:20 volumio volumio[786]: verbose: ControllerMpd::sendMpdCommand play Feb 21 22:07:20 volumio volumio[786]: info: ------------------------------ 3ms Feb 21 22:07:20 volumio volumio[786]: info: sendMpdCommand play took 1 milliseconds Feb 21 22:07:20 volumio volumio[786]: STREAMING PROXY: Handling url /?data=qobuz://song/24747023 Feb 21 22:07:20 volumio volumio[786]: info: Executing endpoint getStreamUrlqobuz Feb 21 22:07:20 volumio volumio[786]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI Feb 21 22:07:20 volumio volumio[786]: info: getStreamUrl took 278 milliseconds Feb 21 22:07:20 volumio volumio[786]: STREAMING PROXY: Got real url: https://streaming-qobuz-std.akamaized.net/file?uid=2254030&eid=24747023&fmt=6&profile=raw&app_id=539451548&cid=3800232&etsp=1771704440&hmac=kD8s-9r9adI5QQGSE6KL13OAkOc Feb 21 22:07:20 volumio volumio[786]: STREAMING PROXY: Response: 200, length: 4251280 Feb 21 22:07:20 volumio volumio[786]: info: Feb 21 22:07:20 volumio volumio[786]: ---------------------------- MPD announces state update: player Feb 21 22:07:20 volumio volumio[786]: info: ControllerMpd::getState Feb 21 22:07:20 volumio volumio[786]: verbose: ControllerMpd::sendMpdCommand status Feb 21 22:07:20 volumio volumio[786]: info: Feb 21 22:07:20 volumio volumio[786]: ---------------------------- MPD announces state update: player Feb 21 22:07:20 volumio volumio[786]: info: sendMpdCommand status took 2 milliseconds Feb 21 22:07:20 volumio volumio[786]: info: ControllerMpd::getState Feb 21 22:07:20 volumio volumio[786]: verbose: ControllerMpd::sendMpdCommand status Feb 21 22:07:20 volumio volumio[786]: verbose: ControllerMpd::parseState Feb 21 22:07:20 volumio volumio[786]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 22:07:20 volumio volumio[786]: info: sendMpdCommand status took 1 milliseconds Feb 21 22:07:20 volumio volumio[786]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 21 22:07:20 volumio volumio[786]: verbose: ControllerMpd::parseState Feb 21 22:07:20 volumio volumio[786]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 22:07:20 volumio volumio[786]: verbose: ControllerMpd::parseTrackInfo Feb 21 22:07:20 volumio volumio[786]: info: ControllerMpd::pushState Feb 21 22:07:20 volumio volumio[786]: info: CoreCommandRouter::servicePushState Feb 21 22:07:20 volumio volumio[786]: info: CorePlayQueue::getTrack 0 Feb 21 22:07:20 volumio volumio[786]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":91,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"24747023","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/24747023","trackType":"qobuz"} Feb 21 22:07:20 volumio volumio[786]: verbose: CURRENT POSITION 0 Feb 21 22:07:20 volumio volumio[786]: info: CoreStateMachine::syncState stateService play Feb 21 22:07:20 volumio volumio[786]: info: CoreStateMachine::syncState currentStatus stop Feb 21 22:07:20 volumio volumio[786]: info: ------------------------------ 7ms Feb 21 22:07:20 volumio volumio[786]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 21 22:07:20 volumio volumio[786]: verbose: ControllerMpd::parseTrackInfo Feb 21 22:07:20 volumio volumio[786]: info: ControllerMpd::pushState Feb 21 22:07:20 volumio volumio[786]: info: CoreCommandRouter::servicePushState Feb 21 22:07:20 volumio volumio[786]: info: CorePlayQueue::getTrack 0 Feb 21 22:07:20 volumio volumio[786]: verbose: STATE SERVICE {"status":"play","position":0,"seek":45,"duration":91,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1 Kbps","isStreaming":false,"title":"24747023","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/24747023","trackType":"qobuz"} Feb 21 22:07:20 volumio volumio[786]: verbose: CURRENT POSITION 0 Feb 21 22:07:20 volumio volumio[786]: info: CoreStateMachine::syncState stateService play Feb 21 22:07:20 volumio volumio[786]: info: CoreStateMachine::syncState currentStatus play Feb 21 22:07:20 volumio volumio[786]: info: Received an update from plugin. extracting info from payload Feb 21 22:07:20 volumio volumio[786]: info: CoreStateMachine::pushState Feb 21 22:07:20 volumio volumio[786]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 22:07:20 volumio volumio[786]: info: CoreCommandRouter::volumioPushState Feb 21 22:07:20 volumio volumio[786]: info: MRS: Pushing multiroomSync output update for this device Feb 21 22:07:20 volumio volumio[786]: info: MRS: Pushing multiroomSync output Feb 21 22:07:20 volumio volumio[786]: info: CoreCommandRouter::volumioGetState Feb 21 22:07:20 volumio volumio[786]: info: CoreStateMachine::pushState Feb 21 22:07:20 volumio volumio[786]: info: CoreCommandRouter::volumioPushState Feb 21 22:07:20 volumio volumio[786]: info: MRS: Pushing multiroomSync output update for this device Feb 21 22:07:20 volumio volumio[786]: info: MRS: Pushing multiroomSync output Feb 21 22:07:20 volumio volumio[786]: info: CoreCommandRouter::volumioGetState Feb 21 22:07:20 volumio volumio[786]: info: ------------------------------ 43ms Feb 21 22:07:21 volumio volumio[786]: STREAMING PROXY: Client dropped request, destroying Feb 21 22:07:22 volumio volumio[786]: info: Executing endpoint metavolumio Feb 21 22:07:22 volumio volumio[786]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 21 22:07:22 volumio volumio[786]: info: Executing endpoint metavolumio Feb 21 22:07:22 volumio volumio[786]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 21 22:07:22 volumio volumio[786]: info: Executing endpoint metavolumio Feb 21 22:07:22 volumio volumio[786]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 21 22:07:43 volumio volumio[786]: info: CoreCommandRouter::executeOnPlugin: qobuz , handleBrowseUri Feb 21 22:07:43 volumio volumio[786]: info: handleBrowseUri took 273 milliseconds Feb 21 22:07:43 volumio volumio[786]: info: Preload queue cleared Feb 21 22:07:43 volumio volumio[786]: info: Preloading song: qobuz://song/291633679 Feb 21 22:07:43 volumio volumio[786]: info: Preloading song: qobuz://song/291633680 Feb 21 22:07:43 volumio volumio[786]: info: Preloading song: qobuz://song/291633681 Feb 21 22:07:43 volumio volumio[786]: info: Exploding uri qobuz://song/291633679 in service qobuz Feb 21 22:07:43 volumio volumio[786]: https://prod.vlmapi.io/v2/qobuz/explodeUri Feb 21 22:07:43 volumio volumio[786]: info: Exploding uri qobuz://song/291633680 in service qobuz Feb 21 22:07:43 volumio volumio[786]: https://prod.vlmapi.io/v2/qobuz/explodeUri Feb 21 22:07:43 volumio volumio[786]: info: Executing endpoint getSimilarAlbums Feb 21 22:07:43 volumio volumio[786]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums Feb 21 22:07:43 volumio volumio[786]: info: Executing endpoint getSimilarAlbums Feb 21 22:07:43 volumio volumio[786]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums Feb 21 22:07:43 volumio volumio[786]: info: Exploding uri qobuz://song/291633681 in service qobuz Feb 21 22:07:43 volumio volumio[786]: https://prod.vlmapi.io/v2/qobuz/explodeUri Feb 21 22:07:43 volumio volumio[786]: info: Executing endpoint metavolumio Feb 21 22:07:43 volumio volumio[786]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 21 22:07:43 volumio volumio[786]: info: Executing endpoint metavolumio Feb 21 22:07:43 volumio volumio[786]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 21 22:07:43 volumio volumio[786]: info: Executing endpoint metavolumio Feb 21 22:07:43 volumio volumio[786]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 21 22:07:43 volumio volumio[786]: info: Executing endpoint metavolumio Feb 21 22:07:43 volumio volumio[786]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Feb 21 22:07:43 volumio volumio[786]: info: explodeUri took 376 milliseconds Feb 21 22:07:43 volumio volumio[786]: info: explodeUri took 327 milliseconds Feb 21 22:07:43 volumio volumio[786]: info: explodeUri took 366 milliseconds Feb 21 22:07:46 volumio volumio[786]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 21 22:07:46 volumio volumio[786]: Error: connect ETIMEDOUT 23.73.2.88:443 Feb 21 22:07:46 volumio volumio[786]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Feb 21 22:07:46 volumio volumio[786]: errno: -110, Feb 21 22:07:46 volumio volumio[786]: code: 'ETIMEDOUT', Feb 21 22:07:46 volumio volumio[786]: syscall: 'connect', Feb 21 22:07:46 volumio volumio[786]: address: '23.73.2.88', Feb 21 22:07:46 volumio volumio[786]: port: 443 Feb 21 22:07:46 volumio volumio[786]: } Feb 21 22:07:46 volumio volumio[786]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 21 22:07:46 volumio sudo[11053]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-02-21 22:06 Feb 21 22:07:46 volumio sudo[11053]: 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="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 11 Dec 2025 06:03:54 PM CET" VOLUMIO_VERSION="3.886" VOLUMIO_HARDWARE="tinkerboard" VOLUMIO_DEVICENAME="Asus Tinkerboard" VOLUMIO_HASH="35e446ff98e90abcfcab1bb2733dfd3a"