-- Logs begin at Thu 2019-02-14 21:11:59 +11, end at Wed 2026-01-28 14:08:14 +11. -- Jan 28 14:07:01 volumio volumio[741]: info: handleBrowseUri took 1304 milliseconds Jan 28 14:07:01 volumio volumio[741]: info: Preload queue cleared Jan 28 14:07:01 volumio volumio[741]: info: Executing endpoint getSimilarArtists Jan 28 14:07:01 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarArtists Jan 28 14:07:01 volumio volumio[741]: info: Executing endpoint getSimilarArtists Jan 28 14:07:01 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarArtists Jan 28 14:07:01 volumio volumio[741]: info: Executing endpoint metavolumio Jan 28 14:07:01 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jan 28 14:07:01 volumio volumio[741]: info: Executing endpoint metavolumio Jan 28 14:07:01 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jan 28 14:07:08 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: qobuz , handleBrowseUri Jan 28 14:07:08 volumio volumio[741]: info: handleBrowseUri took 511 milliseconds Jan 28 14:07:08 volumio volumio[741]: info: Preload queue cleared Jan 28 14:07:08 volumio volumio[741]: info: Preloading song: qobuz://song/79801030 Jan 28 14:07:08 volumio volumio[741]: info: Preloading song: qobuz://song/79801031 Jan 28 14:07:08 volumio volumio[741]: info: Preloading song: qobuz://song/79801032 Jan 28 14:07:08 volumio volumio[741]: info: Preloading song: qobuz://song/79801033 Jan 28 14:07:08 volumio volumio[741]: info: Preloading song: qobuz://song/79801034 Jan 28 14:07:08 volumio volumio[741]: info: Preloading song: qobuz://song/79801035 Jan 28 14:07:08 volumio volumio[741]: info: Preloading song: qobuz://song/79801036 Jan 28 14:07:08 volumio volumio[741]: info: Preloading song: qobuz://song/79801037 Jan 28 14:07:08 volumio volumio[741]: info: Preloading song: qobuz://song/79801038 Jan 28 14:07:08 volumio volumio[741]: info: Exploding uri qobuz://song/79801030 in service qobuz Jan 28 14:07:08 volumio volumio[741]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jan 28 14:07:08 volumio volumio[741]: info: Exploding uri qobuz://song/79801031 in service qobuz Jan 28 14:07:08 volumio volumio[741]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jan 28 14:07:08 volumio volumio[741]: info: Exploding uri qobuz://song/79801032 in service qobuz Jan 28 14:07:08 volumio volumio[741]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jan 28 14:07:08 volumio volumio[741]: info: Executing endpoint getSimilarAlbums Jan 28 14:07:08 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums Jan 28 14:07:08 volumio volumio[741]: info: Executing endpoint getSimilarAlbums Jan 28 14:07:08 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums Jan 28 14:07:08 volumio volumio[741]: info: Exploding uri qobuz://song/79801033 in service qobuz Jan 28 14:07:08 volumio volumio[741]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jan 28 14:07:08 volumio volumio[741]: info: Executing endpoint metavolumio Jan 28 14:07:08 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jan 28 14:07:09 volumio volumio[741]: info: Exploding uri qobuz://song/79801034 in service qobuz Jan 28 14:07:09 volumio volumio[741]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jan 28 14:07:09 volumio volumio[741]: info: Exploding uri qobuz://song/79801035 in service qobuz Jan 28 14:07:09 volumio volumio[741]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jan 28 14:07:09 volumio volumio[741]: info: Exploding uri qobuz://song/79801036 in service qobuz Jan 28 14:07:09 volumio volumio[741]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jan 28 14:07:09 volumio volumio[741]: info: Executing endpoint metavolumio Jan 28 14:07:09 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jan 28 14:07:09 volumio volumio[741]: info: Executing endpoint metavolumio Jan 28 14:07:09 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jan 28 14:07:09 volumio volumio[741]: info: Exploding uri qobuz://song/79801037 in service qobuz Jan 28 14:07:09 volumio volumio[741]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jan 28 14:07:09 volumio volumio[741]: info: Exploding uri qobuz://song/79801038 in service qobuz Jan 28 14:07:09 volumio volumio[741]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jan 28 14:07:09 volumio volumio[741]: info: explodeUri took 513 milliseconds Jan 28 14:07:09 volumio volumio[741]: info: explodeUri took 510 milliseconds Jan 28 14:07:09 volumio volumio[741]: info: explodeUri took 495 milliseconds Jan 28 14:07:09 volumio volumio[741]: info: explodeUri took 484 milliseconds Jan 28 14:07:09 volumio volumio[741]: info: explodeUri took 513 milliseconds Jan 28 14:07:09 volumio volumio[741]: info: explodeUri took 484 milliseconds Jan 28 14:07:09 volumio volumio[741]: info: explodeUri took 529 milliseconds Jan 28 14:07:09 volumio volumio[741]: info: Executing endpoint metavolumio Jan 28 14:07:09 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jan 28 14:07:09 volumio volumio[741]: info: explodeUri took 525 milliseconds Jan 28 14:07:09 volumio volumio[741]: info: explodeUri took 704 milliseconds Jan 28 14:07:14 volumio volumio[741]: info: Preload queue cleared Jan 28 14:07:14 volumio volumio[741]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 28 14:07:14 volumio volumio[741]: info: CoreStateMachine::ClearQueue Jan 28 14:07:14 volumio volumio[741]: info: CoreStateMachine::stop Jan 28 14:07:14 volumio volumio[741]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 28 14:07:14 volumio volumio[741]: info: CoreStateMachine::updateTrackBlock Jan 28 14:07:14 volumio volumio[741]: info: CorePlayQueue::getTrackBlock Jan 28 14:07:14 volumio volumio[741]: info: CoreStateMachine::stPlaybackTimer Jan 28 14:07:14 volumio volumio[741]: info: CoreStateMachine::pushState Jan 28 14:07:14 volumio volumio[741]: info: CorePlayQueue::getTrack 10 Jan 28 14:07:14 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 28 14:07:14 volumio volumio[741]: info: CoreCommandRouter::volumioPushState Jan 28 14:07:14 volumio volumio[741]: info: MRS: Pushing multiroomSync output update for this device Jan 28 14:07:14 volumio volumio[741]: info: MRS: Pushing multiroomSync output Jan 28 14:07:14 volumio volumio[741]: info: CoreCommandRouter::volumioGetState Jan 28 14:07:14 volumio volumio[741]: info: CorePlayQueue::getTrack 10 Jan 28 14:07:14 volumio volumio[741]: info: CoreStateMachine::serviceStop Jan 28 14:07:14 volumio volumio[741]: info: CorePlayQueue::getTrack 10 Jan 28 14:07:14 volumio volumio[741]: info: CoreCommandRouter::serviceStop Jan 28 14:07:14 volumio volumio[741]: info: [1769569634317] ControllerQobuz::stop Jan 28 14:07:14 volumio volumio[741]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 28 14:07:14 volumio volumio[741]: info: ControllerMpd::stop Jan 28 14:07:14 volumio volumio[741]: verbose: ControllerMpd::sendMpdCommand stop Jan 28 14:07:14 volumio volumio[741]: info: CorePlayQueue::clearPlayQueue Jan 28 14:07:14 volumio volumio[741]: info: CorePlayQueue::saveQueue Jan 28 14:07:14 volumio volumio[741]: info: CoreCommandRouter::volumioPushQueue Jan 28 14:07:14 volumio volumio[741]: info: CoreStateMachine::addQueueItems Jan 28 14:07:14 volumio volumio[741]: info: CorePlayQueue::addQueueItems Jan 28 14:07:14 volumio volumio[741]: info: Preload queue cleared Jan 28 14:07:14 volumio volumio[741]: info: Adding Item to queue: qobuz://album/dilbzc9pi2jzb Jan 28 14:07:14 volumio volumio[741]: info: Exploding uri qobuz://album/dilbzc9pi2jzb in service qobuz Jan 28 14:07:14 volumio volumio[741]: https://prod.vlmapi.io/v2/qobuz/explodeUri Jan 28 14:07:14 volumio volumio[741]: info: Jan 28 14:07:14 volumio volumio[741]: ---------------------------- MPD announces state update: player Jan 28 14:07:14 volumio volumio[741]: info: sendMpdCommand stop took 86 milliseconds Jan 28 14:07:14 volumio volumio[741]: info: ControllerMpd::getState Jan 28 14:07:14 volumio volumio[741]: verbose: ControllerMpd::sendMpdCommand status Jan 28 14:07:14 volumio volumio[741]: info: sendMpdCommand status took 1 milliseconds Jan 28 14:07:14 volumio volumio[741]: verbose: ControllerMpd::parseState Jan 28 14:07:14 volumio volumio[741]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 28 14:07:14 volumio volumio[741]: info: sendMpdCommand playlistinfo took 3 milliseconds Jan 28 14:07:14 volumio volumio[741]: verbose: ControllerMpd::parseTrackInfo Jan 28 14:07:14 volumio volumio[741]: info: ControllerMpd::pushState Jan 28 14:07:14 volumio volumio[741]: info: CoreCommandRouter::servicePushState Jan 28 14:07:14 volumio volumio[741]: info: CoreStateMachine::pushState Jan 28 14:07:14 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 28 14:07:14 volumio volumio[741]: info: CoreCommandRouter::volumioPushState Jan 28 14:07:14 volumio volumio[741]: info: MRS: Pushing multiroomSync output update for this device Jan 28 14:07:14 volumio volumio[741]: info: MRS: Pushing multiroomSync output Jan 28 14:07:14 volumio volumio[741]: info: CoreCommandRouter::volumioGetState Jan 28 14:07:14 volumio volumio[741]: info: CorePlayQueue::getTrack 10 Jan 28 14:07:14 volumio volumio[741]: 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":"45972981","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/45972981","trackType":"qobuz"} Jan 28 14:07:14 volumio volumio[741]: verbose: CURRENT POSITION 10 Jan 28 14:07:14 volumio volumio[741]: info: CoreStateMachine::syncState stateService stop Jan 28 14:07:14 volumio volumio[741]: info: CoreStateMachine::syncState currentStatus stop Jan 28 14:07:14 volumio volumio[741]: info: CoreStateMachine::pushState Jan 28 14:07:14 volumio volumio[741]: info: CoreCommandRouter::volumioPushState Jan 28 14:07:14 volumio volumio[741]: info: MRS: Pushing multiroomSync output update for this device Jan 28 14:07:14 volumio volumio[741]: info: MRS: Pushing multiroomSync output Jan 28 14:07:14 volumio volumio[741]: info: CoreCommandRouter::volumioGetState Jan 28 14:07:14 volumio volumio[741]: info: No code Jan 28 14:07:14 volumio volumio[741]: info: CoreStateMachine::pushState Jan 28 14:07:14 volumio volumio[741]: info: CoreCommandRouter::volumioPushState Jan 28 14:07:14 volumio volumio[741]: info: MRS: Pushing multiroomSync output update for this device Jan 28 14:07:14 volumio volumio[741]: info: MRS: Pushing multiroomSync output Jan 28 14:07:14 volumio volumio[741]: info: CoreCommandRouter::volumioGetState Jan 28 14:07:14 volumio volumio[741]: info: ------------------------------ 91ms Jan 28 14:07:14 volumio volumio[741]: info: explodeUri took 602 milliseconds Jan 28 14:07:14 volumio volumio[741]: info: CoreCommandRouter::volumioPushQueue Jan 28 14:07:14 volumio volumio[741]: info: CorePlayQueue::saveQueue Jan 28 14:07:14 volumio volumio[741]: info: CoreStateMachine::updateTrackBlock Jan 28 14:07:14 volumio volumio[741]: info: CorePlayQueue::getTrackBlock Jan 28 14:07:14 volumio volumio[741]: info: CoreCommandRouter::volumioPlay Jan 28 14:07:14 volumio volumio[741]: info: CoreStateMachine::play index 0 Jan 28 14:07:14 volumio volumio[741]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 28 14:07:14 volumio volumio[741]: info: CoreStateMachine::stop Jan 28 14:07:14 volumio volumio[741]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 28 14:07:14 volumio volumio[741]: info: CoreStateMachine::play index undefined Jan 28 14:07:14 volumio volumio[741]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 28 14:07:14 volumio volumio[741]: info: CorePlayQueue::getTrack 0 Jan 28 14:07:14 volumio volumio[741]: info: CoreStateMachine::startPlaybackTimer Jan 28 14:07:14 volumio volumio[741]: info: CorePlayQueue::getTrack 0 Jan 28 14:07:14 volumio volumio[741]: info: [1769569634948] ControllerQobuz::clearAddPlayTrack Jan 28 14:07:14 volumio volumio[741]: verbose: ControllerMpd::sendMpdCommand stop Jan 28 14:07:14 volumio volumio[741]: info: sendMpdCommand stop took 7 milliseconds Jan 28 14:07:14 volumio volumio[741]: verbose: ControllerMpd::sendMpdCommand clear Jan 28 14:07:14 volumio volumio[741]: info: Jan 28 14:07:14 volumio volumio[741]: ---------------------------- MPD announces system playlist update Jan 28 14:07:14 volumio volumio[741]: info: Ignoring MPD Status Update Jan 28 14:07:14 volumio volumio[741]: info: sendMpdCommand clear took 3 milliseconds Jan 28 14:07:14 volumio volumio[741]: verbose: ControllerMpd::sendMpdCommand load "http://127.0.0.1:3245?data=qobuz://song/79801030" Jan 28 14:07:14 volumio volumio[741]: STREAMING PROXY: Handling url /?data=qobuz://song/79801030 Jan 28 14:07:14 volumio volumio[741]: info: Executing endpoint getStreamUrlqobuz Jan 28 14:07:14 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI Jan 28 14:07:15 volumio volumio[741]: info: getStreamUrl took 412 milliseconds Jan 28 14:07:15 volumio volumio[741]: STREAMING PROXY: Got real url: https://streaming-qobuz-std.akamaized.net/file?uid=1173764&eid=79801030&fmt=6&profile=raw&app_id=539451548&cid=1465254&etsp=1769573235&hmac=V_0SH68ORgRYZzOiz9fvTlgiTGg Jan 28 14:07:17 volumio volumio[741]: STREAMING PROXY: Response: 200, length: 27846832 Jan 28 14:07:17 volumio volumio[741]: STREAMING PROXY: Client dropped request, destroying Jan 28 14:07:17 volumio volumio[741]: error: updateQueue error: null Jan 28 14:07:17 volumio volumio[741]: info: ------------------------------ 2709ms Jan 28 14:07:17 volumio volumio[741]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/79801030" Jan 28 14:07:17 volumio volumio[741]: info: Jan 28 14:07:17 volumio volumio[741]: ---------------------------- MPD announces system playlist update Jan 28 14:07:17 volumio volumio[741]: info: Ignoring MPD Status Update Jan 28 14:07:17 volumio volumio[741]: info: sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/79801030" took 3 milliseconds Jan 28 14:07:17 volumio volumio[741]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 28 14:07:17 volumio volumio[741]: verbose: ControllerMpd::sendMpdCommand play Jan 28 14:07:17 volumio volumio[741]: info: ------------------------------ 5ms Jan 28 14:07:17 volumio volumio[741]: info: sendMpdCommand play took 3 milliseconds Jan 28 14:07:17 volumio volumio[741]: STREAMING PROXY: Handling url /?data=qobuz://song/79801030 Jan 28 14:07:17 volumio volumio[741]: info: Executing endpoint getStreamUrlqobuz Jan 28 14:07:17 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI Jan 28 14:07:18 volumio volumio[741]: info: getStreamUrl took 457 milliseconds Jan 28 14:07:18 volumio volumio[741]: STREAMING PROXY: Got real url: https://streaming-qobuz-std.akamaized.net/file?uid=1173764&eid=79801030&fmt=6&profile=raw&app_id=539451548&cid=1465254&etsp=1769573237&hmac=WEO7MgARAvTtEugRht6So_XxbkY Jan 28 14:07:18 volumio volumio[741]: STREAMING PROXY: Response: 200, length: 27846832 Jan 28 14:07:18 volumio volumio[741]: info: Jan 28 14:07:18 volumio volumio[741]: ---------------------------- MPD announces state update: player Jan 28 14:07:18 volumio volumio[741]: info: ControllerMpd::getState Jan 28 14:07:18 volumio volumio[741]: verbose: ControllerMpd::sendMpdCommand status Jan 28 14:07:18 volumio volumio[741]: info: Jan 28 14:07:18 volumio volumio[741]: ---------------------------- MPD announces state update: player Jan 28 14:07:18 volumio volumio[741]: info: sendMpdCommand status took 6 milliseconds Jan 28 14:07:18 volumio volumio[741]: info: ControllerMpd::getState Jan 28 14:07:18 volumio volumio[741]: verbose: ControllerMpd::sendMpdCommand status Jan 28 14:07:18 volumio volumio[741]: verbose: ControllerMpd::parseState Jan 28 14:07:18 volumio volumio[741]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 28 14:07:18 volumio volumio[741]: info: sendMpdCommand status took 3 milliseconds Jan 28 14:07:18 volumio volumio[741]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 28 14:07:18 volumio volumio[741]: verbose: ControllerMpd::parseState Jan 28 14:07:18 volumio volumio[741]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 28 14:07:18 volumio volumio[741]: verbose: ControllerMpd::parseTrackInfo Jan 28 14:07:18 volumio volumio[741]: info: ControllerMpd::pushState Jan 28 14:07:18 volumio volumio[741]: info: CoreCommandRouter::servicePushState Jan 28 14:07:18 volumio volumio[741]: info: CorePlayQueue::getTrack 0 Jan 28 14:07:18 volumio volumio[741]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":343,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"79801030","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/79801030","trackType":"qobuz"} Jan 28 14:07:18 volumio volumio[741]: verbose: CURRENT POSITION 0 Jan 28 14:07:18 volumio volumio[741]: info: CoreStateMachine::syncState stateService play Jan 28 14:07:18 volumio volumio[741]: info: CoreStateMachine::syncState currentStatus stop Jan 28 14:07:18 volumio volumio[741]: info: ------------------------------ 18ms Jan 28 14:07:18 volumio volumio[741]: info: sendMpdCommand playlistinfo took 5 milliseconds Jan 28 14:07:18 volumio volumio[741]: verbose: ControllerMpd::parseTrackInfo Jan 28 14:07:18 volumio volumio[741]: info: ControllerMpd::pushState Jan 28 14:07:18 volumio volumio[741]: info: CoreCommandRouter::servicePushState Jan 28 14:07:18 volumio volumio[741]: info: CorePlayQueue::getTrack 0 Jan 28 14:07:18 volumio volumio[741]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":343,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"79801030","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/79801030","trackType":"qobuz"} Jan 28 14:07:18 volumio volumio[741]: verbose: CURRENT POSITION 0 Jan 28 14:07:18 volumio volumio[741]: info: CoreStateMachine::syncState stateService play Jan 28 14:07:18 volumio volumio[741]: info: CoreStateMachine::syncState currentStatus play Jan 28 14:07:18 volumio volumio[741]: info: Received an update from plugin. extracting info from payload Jan 28 14:07:18 volumio volumio[741]: info: CoreStateMachine::pushState Jan 28 14:07:18 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 28 14:07:18 volumio volumio[741]: info: CoreCommandRouter::volumioPushState Jan 28 14:07:18 volumio volumio[741]: info: MRS: Pushing multiroomSync output update for this device Jan 28 14:07:18 volumio volumio[741]: info: MRS: Pushing multiroomSync output Jan 28 14:07:18 volumio volumio[741]: info: CoreCommandRouter::volumioGetState Jan 28 14:07:18 volumio volumio[741]: info: CoreStateMachine::pushState Jan 28 14:07:18 volumio volumio[741]: info: CoreCommandRouter::volumioPushState Jan 28 14:07:18 volumio volumio[741]: info: MRS: Pushing multiroomSync output update for this device Jan 28 14:07:18 volumio volumio[741]: info: MRS: Pushing multiroomSync output Jan 28 14:07:18 volumio volumio[741]: info: CoreCommandRouter::volumioGetState Jan 28 14:07:18 volumio volumio[741]: info: ------------------------------ 81ms Jan 28 14:07:22 volumio ntpd[724]: Soliciting pool server 2404:2a00::30 Jan 28 14:07:22 volumio volumio[741]: STREAMING PROXY: Client dropped request, destroying Jan 28 14:07:27 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: qobuz , handleBrowseUri Jan 28 14:07:28 volumio volumio[741]: info: handleBrowseUri took 511 milliseconds Jan 28 14:07:28 volumio volumio[741]: info: Preload queue cleared Jan 28 14:07:28 volumio volumio[741]: info: Executing endpoint getSimilarAlbums Jan 28 14:07:28 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums Jan 28 14:07:28 volumio volumio[741]: info: Executing endpoint getSimilarAlbums Jan 28 14:07:28 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums Jan 28 14:07:28 volumio volumio[741]: info: Executing endpoint metavolumio Jan 28 14:07:28 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jan 28 14:07:28 volumio volumio[741]: info: Executing endpoint metavolumio Jan 28 14:07:28 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jan 28 14:07:28 volumio volumio[741]: info: Executing endpoint metavolumio Jan 28 14:07:28 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jan 28 14:07:28 volumio volumio[741]: info: Executing endpoint metavolumio Jan 28 14:07:28 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jan 28 14:07:41 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: qobuz , handleBrowseUri Jan 28 14:07:42 volumio volumio[741]: info: handleBrowseUri took 521 milliseconds Jan 28 14:07:42 volumio volumio[741]: info: Preload queue cleared Jan 28 14:07:42 volumio volumio[741]: info: Executing endpoint getSimilarAlbums Jan 28 14:07:42 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums Jan 28 14:07:42 volumio volumio[741]: info: Executing endpoint getSimilarAlbums Jan 28 14:07:42 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums Jan 28 14:07:42 volumio volumio[741]: info: Executing endpoint metavolumio Jan 28 14:07:42 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jan 28 14:07:42 volumio volumio[741]: info: Executing endpoint metavolumio Jan 28 14:07:42 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jan 28 14:07:42 volumio volumio[741]: info: Executing endpoint metavolumio Jan 28 14:07:42 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jan 28 14:07:42 volumio volumio[741]: info: Executing endpoint metavolumio Jan 28 14:07:42 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jan 28 14:07:52 volumio volumio[741]: Searching plugin music_service/qobuz Jan 28 14:07:52 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Jan 28 14:07:53 volumio volumio[741]: info: searchQOBUZUri took 1088 milliseconds Jan 28 14:07:53 volumio volumio[741]: info: All search sources collected, pushing search results Jan 28 14:07:54 volumio volumio[741]: Searching plugin music_service/qobuz Jan 28 14:07:54 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Jan 28 14:07:55 volumio volumio[741]: info: searchQOBUZUri took 1086 milliseconds Jan 28 14:07:55 volumio volumio[741]: info: All search sources collected, pushing search results Jan 28 14:07:59 volumio volumio[741]: Searching plugin music_service/qobuz Jan 28 14:07:59 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Jan 28 14:08:00 volumio volumio[741]: info: searchQOBUZUri took 1497 milliseconds Jan 28 14:08:00 volumio volumio[741]: info: All search sources collected, pushing search results Jan 28 14:08:02 volumio volumio[741]: Searching plugin music_service/qobuz Jan 28 14:08:02 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Jan 28 14:08:03 volumio volumio[741]: info: searchQOBUZUri took 886 milliseconds Jan 28 14:08:03 volumio volumio[741]: info: All search sources collected, pushing search results Jan 28 14:08:06 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: qobuz , handleBrowseUri Jan 28 14:08:07 volumio volumio[741]: info: handleBrowseUri took 1360 milliseconds Jan 28 14:08:08 volumio volumio[741]: info: Preload queue cleared Jan 28 14:08:08 volumio volumio[741]: info: Executing endpoint getSimilarArtists Jan 28 14:08:08 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarArtists Jan 28 14:08:08 volumio volumio[741]: info: Executing endpoint getSimilarArtists Jan 28 14:08:08 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarArtists Jan 28 14:08:08 volumio volumio[741]: info: Executing endpoint metavolumio Jan 28 14:08:08 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jan 28 14:08:08 volumio volumio[741]: info: Executing endpoint metavolumio Jan 28 14:08:08 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jan 28 14:08:12 volumio volumio[741]: info: CoreCommandRouter::executeOnPlugin: qobuz , handleBrowseUri Jan 28 14:08:13 volumio volumio[741]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 28 14:08:13 volumio volumio[741]: Error: connect ECONNREFUSED 158.69.210.98:443 Jan 28 14:08:13 volumio volumio[741]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Jan 28 14:08:13 volumio volumio[741]: errno: -111, Jan 28 14:08:13 volumio volumio[741]: code: 'ECONNREFUSED', Jan 28 14:08:13 volumio volumio[741]: syscall: 'connect', Jan 28 14:08:13 volumio volumio[741]: address: '158.69.210.98', Jan 28 14:08:13 volumio volumio[741]: port: 443 Jan 28 14:08:13 volumio volumio[741]: } Jan 28 14:08:13 volumio volumio[741]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 28 14:08:14 volumio sudo[13473]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-01-28 14:07 Jan 28 14:08:14 volumio sudo[13473]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="b43c85cc0006d3f1efecba101311ec96e334d1fd" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 11 Dec 2025 05:43:24 PM CET" VOLUMIO_VERSION="3.886" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="15d0241b0cd805792809f3ddf4a0fc4e"