-- Logs begin at Thu 2019-02-14 16:11:58 +06, end at Fri 2026-03-27 01:34:59 +06. -- Mar 27 01:33:00 dap-10 volumio[28228]: info: CoreCommandRouter::executeOnPlugin: qobuz , handleBrowseUri Mar 27 01:33:03 dap-10 volumio[28228]: error: Failed request for metavolumio API Mar 27 01:33:03 dap-10 volumio[28228]: error: Failed request for metavolumio API Mar 27 01:33:07 dap-10 volumio[28228]: info: handleBrowseUri took 6496 milliseconds Mar 27 01:33:07 dap-10 volumio[28228]: info: Preload queue cleared Mar 27 01:33:07 dap-10 volumio[28228]: info: Executing endpoint getSimilarArtists Mar 27 01:33:07 dap-10 volumio[28228]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarArtists Mar 27 01:33:07 dap-10 volumio[28228]: info: Executing endpoint getSimilarArtists Mar 27 01:33:07 dap-10 volumio[28228]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarArtists Mar 27 01:33:08 dap-10 volumio[28228]: info: Executing endpoint getSimilarArtists Mar 27 01:33:08 dap-10 volumio[28228]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarArtists Mar 27 01:33:08 dap-10 volumio[28228]: info: Executing endpoint getSimilarArtists Mar 27 01:33:08 dap-10 volumio[28228]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarArtists Mar 27 01:33:08 dap-10 volumio[28228]: info: Executing endpoint getSimilarArtists Mar 27 01:33:08 dap-10 volumio[28228]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarArtists Mar 27 01:33:08 dap-10 volumio[28228]: info: Executing endpoint metavolumio Mar 27 01:33:08 dap-10 volumio[28228]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Mar 27 01:33:11 dap-10 volumio[28228]: info: Executing endpoint metavolumio Mar 27 01:33:11 dap-10 volumio[28228]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Mar 27 01:33:13 dap-10 volumio[28228]: info: Executing endpoint metavolumio Mar 27 01:33:13 dap-10 volumio[28228]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Mar 27 01:33:20 dap-10 volumio[28228]: error: Failed request for metavolumio API Mar 27 01:33:27 dap-10 volumio[28228]: error: Failed request for metavolumio API Mar 27 01:33:46 dap-10 volumio[28228]: info: CoreCommandRouter::executeOnPlugin: qobuz , handleBrowseUri Mar 27 01:33:47 dap-10 volumio[28228]: info: handleBrowseUri took 733 milliseconds Mar 27 01:33:47 dap-10 volumio[28228]: info: Preload queue cleared Mar 27 01:33:47 dap-10 volumio[28228]: info: Preloading song: qobuz://song/170679594 Mar 27 01:33:47 dap-10 volumio[28228]: info: Preloading song: qobuz://song/170679595 Mar 27 01:33:47 dap-10 volumio[28228]: info: Preloading song: qobuz://song/170679596 Mar 27 01:33:47 dap-10 volumio[28228]: info: Preloading song: qobuz://song/170679597 Mar 27 01:33:47 dap-10 volumio[28228]: info: Preloading song: qobuz://song/170679598 Mar 27 01:33:47 dap-10 volumio[28228]: info: Preloading song: qobuz://song/170679599 Mar 27 01:33:47 dap-10 volumio[28228]: info: Preloading song: qobuz://song/170679600 Mar 27 01:33:47 dap-10 volumio[28228]: info: Preloading song: qobuz://song/170679601 Mar 27 01:33:47 dap-10 volumio[28228]: info: Preloading song: qobuz://song/170679602 Mar 27 01:33:47 dap-10 volumio[28228]: info: Preloading song: qobuz://song/170679603 Mar 27 01:33:47 dap-10 volumio[28228]: info: Preloading song: qobuz://song/170679604 Mar 27 01:33:47 dap-10 volumio[28228]: info: Preloading song: qobuz://song/170679605 Mar 27 01:33:47 dap-10 volumio[28228]: info: Exploding uri qobuz://song/170679594 in service qobuz Mar 27 01:33:47 dap-10 volumio[28228]: https://prod.vlmapi.io/v2/qobuz/explodeUri Mar 27 01:33:47 dap-10 volumio[28228]: info: Exploding uri qobuz://song/170679595 in service qobuz Mar 27 01:33:47 dap-10 volumio[28228]: https://prod.vlmapi.io/v2/qobuz/explodeUri Mar 27 01:33:47 dap-10 volumio[28228]: info: Exploding uri qobuz://song/170679596 in service qobuz Mar 27 01:33:47 dap-10 volumio[28228]: https://prod.vlmapi.io/v2/qobuz/explodeUri Mar 27 01:33:47 dap-10 volumio[28228]: info: Exploding uri qobuz://song/170679597 in service qobuz Mar 27 01:33:47 dap-10 volumio[28228]: https://prod.vlmapi.io/v2/qobuz/explodeUri Mar 27 01:33:47 dap-10 volumio[28228]: info: Exploding uri qobuz://song/170679598 in service qobuz Mar 27 01:33:47 dap-10 volumio[28228]: https://prod.vlmapi.io/v2/qobuz/explodeUri Mar 27 01:33:47 dap-10 volumio[28228]: info: Exploding uri qobuz://song/170679599 in service qobuz Mar 27 01:33:47 dap-10 volumio[28228]: https://prod.vlmapi.io/v2/qobuz/explodeUri Mar 27 01:33:47 dap-10 volumio[28228]: info: Exploding uri qobuz://song/170679600 in service qobuz Mar 27 01:33:47 dap-10 volumio[28228]: https://prod.vlmapi.io/v2/qobuz/explodeUri Mar 27 01:33:47 dap-10 volumio[28228]: info: Exploding uri qobuz://song/170679601 in service qobuz Mar 27 01:33:47 dap-10 volumio[28228]: https://prod.vlmapi.io/v2/qobuz/explodeUri Mar 27 01:33:48 dap-10 volumio[28228]: info: Exploding uri qobuz://song/170679602 in service qobuz Mar 27 01:33:48 dap-10 volumio[28228]: https://prod.vlmapi.io/v2/qobuz/explodeUri Mar 27 01:33:48 dap-10 volumio[28228]: info: Exploding uri qobuz://song/170679603 in service qobuz Mar 27 01:33:48 dap-10 volumio[28228]: https://prod.vlmapi.io/v2/qobuz/explodeUri Mar 27 01:33:48 dap-10 volumio[28228]: info: explodeUri took 503 milliseconds Mar 27 01:33:48 dap-10 volumio[28228]: info: Exploding uri qobuz://song/170679604 in service qobuz Mar 27 01:33:48 dap-10 volumio[28228]: https://prod.vlmapi.io/v2/qobuz/explodeUri Mar 27 01:33:48 dap-10 volumio[28228]: info: Exploding uri qobuz://song/170679605 in service qobuz Mar 27 01:33:48 dap-10 volumio[28228]: https://prod.vlmapi.io/v2/qobuz/explodeUri Mar 27 01:33:48 dap-10 volumio[28228]: info: explodeUri took 503 milliseconds Mar 27 01:33:48 dap-10 volumio[28228]: info: explodeUri took 461 milliseconds Mar 27 01:33:48 dap-10 volumio[28228]: info: explodeUri took 662 milliseconds Mar 27 01:33:48 dap-10 volumio[28228]: info: explodeUri took 593 milliseconds Mar 27 01:33:48 dap-10 volumio[28228]: info: explodeUri took 775 milliseconds Mar 27 01:33:48 dap-10 volumio[28228]: info: explodeUri took 567 milliseconds Mar 27 01:33:48 dap-10 volumio[28228]: info: explodeUri took 471 milliseconds Mar 27 01:33:48 dap-10 volumio[28228]: info: explodeUri took 601 milliseconds Mar 27 01:33:48 dap-10 volumio[28228]: info: explodeUri took 482 milliseconds Mar 27 01:33:48 dap-10 volumio[28228]: info: explodeUri took 453 milliseconds Mar 27 01:33:48 dap-10 volumio[28228]: info: explodeUri took 540 milliseconds Mar 27 01:33:54 dap-10 volumio[28228]: info: Preload queue cleared Mar 27 01:33:54 dap-10 volumio[28228]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 27 01:33:54 dap-10 volumio[28228]: info: CoreStateMachine::ClearQueue Mar 27 01:33:54 dap-10 volumio[28228]: info: CoreStateMachine::stop Mar 27 01:33:54 dap-10 volumio[28228]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 27 01:33:54 dap-10 volumio[28228]: info: CorePlayQueue::clearPlayQueue Mar 27 01:33:54 dap-10 volumio[28228]: info: CorePlayQueue::saveQueue Mar 27 01:33:54 dap-10 volumio[28228]: info: CoreCommandRouter::volumioPushQueue Mar 27 01:33:54 dap-10 volumio[28228]: info: CoreStateMachine::addQueueItems Mar 27 01:33:54 dap-10 volumio[28228]: info: CorePlayQueue::addQueueItems Mar 27 01:33:54 dap-10 volumio[28228]: info: Preload queue cleared Mar 27 01:33:54 dap-10 volumio[28228]: info: Adding Item to queue: qobuz://song/170679594 Mar 27 01:33:54 dap-10 volumio[28228]: info: Using cached record of: qobuz://song/170679594 Mar 27 01:33:54 dap-10 volumio[28228]: info: Adding Item to queue: qobuz://song/170679595 Mar 27 01:33:54 dap-10 volumio[28228]: info: Using cached record of: qobuz://song/170679595 Mar 27 01:33:54 dap-10 volumio[28228]: info: Adding Item to queue: qobuz://song/170679596 Mar 27 01:33:54 dap-10 volumio[28228]: info: Using cached record of: qobuz://song/170679596 Mar 27 01:33:54 dap-10 volumio[28228]: info: CoreCommandRouter::volumioPushQueue Mar 27 01:33:54 dap-10 volumio[28228]: info: CorePlayQueue::saveQueue Mar 27 01:33:54 dap-10 volumio[28228]: info: CoreStateMachine::updateTrackBlock Mar 27 01:33:54 dap-10 volumio[28228]: info: CorePlayQueue::getTrackBlock Mar 27 01:33:54 dap-10 volumio[28228]: info: CoreCommandRouter::volumioPlay Mar 27 01:33:54 dap-10 volumio[28228]: info: CoreStateMachine::play index 2 Mar 27 01:33:54 dap-10 volumio[28228]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 27 01:33:54 dap-10 volumio[28228]: info: CoreStateMachine::addQueueItems Mar 27 01:33:54 dap-10 volumio[28228]: info: CorePlayQueue::addQueueItems Mar 27 01:33:54 dap-10 volumio[28228]: info: Preload queue cleared Mar 27 01:33:54 dap-10 volumio[28228]: info: Adding Item to queue: qobuz://song/170679597 Mar 27 01:33:54 dap-10 volumio[28228]: info: Using cached record of: qobuz://song/170679597 Mar 27 01:33:54 dap-10 volumio[28228]: info: Adding Item to queue: qobuz://song/170679598 Mar 27 01:33:54 dap-10 volumio[28228]: info: Using cached record of: qobuz://song/170679598 Mar 27 01:33:54 dap-10 volumio[28228]: info: Adding Item to queue: qobuz://song/170679599 Mar 27 01:33:54 dap-10 volumio[28228]: info: Using cached record of: qobuz://song/170679599 Mar 27 01:33:54 dap-10 volumio[28228]: info: Adding Item to queue: qobuz://song/170679600 Mar 27 01:33:54 dap-10 volumio[28228]: info: Using cached record of: qobuz://song/170679600 Mar 27 01:33:54 dap-10 volumio[28228]: info: Adding Item to queue: qobuz://song/170679601 Mar 27 01:33:54 dap-10 volumio[28228]: info: Using cached record of: qobuz://song/170679601 Mar 27 01:33:54 dap-10 volumio[28228]: info: Adding Item to queue: qobuz://song/170679602 Mar 27 01:33:54 dap-10 volumio[28228]: info: Using cached record of: qobuz://song/170679602 Mar 27 01:33:54 dap-10 volumio[28228]: info: Adding Item to queue: qobuz://song/170679603 Mar 27 01:33:54 dap-10 volumio[28228]: info: Using cached record of: qobuz://song/170679603 Mar 27 01:33:54 dap-10 volumio[28228]: info: Adding Item to queue: qobuz://song/170679604 Mar 27 01:33:54 dap-10 volumio[28228]: info: Using cached record of: qobuz://song/170679604 Mar 27 01:33:54 dap-10 volumio[28228]: info: Adding Item to queue: qobuz://song/170679605 Mar 27 01:33:54 dap-10 volumio[28228]: info: Using cached record of: qobuz://song/170679605 Mar 27 01:33:54 dap-10 volumio[28228]: info: CoreStateMachine::stop Mar 27 01:33:54 dap-10 volumio[28228]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 27 01:33:54 dap-10 volumio[28228]: info: CoreCommandRouter::volumioPushQueue Mar 27 01:33:54 dap-10 volumio[28228]: info: CorePlayQueue::saveQueue Mar 27 01:33:54 dap-10 volumio[28228]: info: CoreStateMachine::play index undefined Mar 27 01:33:54 dap-10 volumio[28228]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 27 01:33:54 dap-10 volumio[28228]: info: CoreStateMachine::updateTrackBlock Mar 27 01:33:54 dap-10 volumio[28228]: info: CorePlayQueue::getTrackBlock Mar 27 01:33:54 dap-10 volumio[28228]: info: CorePlayQueue::getTrack 2 Mar 27 01:33:54 dap-10 volumio[28228]: info: CoreStateMachine::startPlaybackTimer Mar 27 01:33:54 dap-10 volumio[28228]: info: CorePlayQueue::getTrack 2 Mar 27 01:33:54 dap-10 volumio[28228]: info: [1774553634389] ControllerQobuz::clearAddPlayTrack Mar 27 01:33:54 dap-10 volumio[28228]: verbose: ControllerMpd::sendMpdCommand stop Mar 27 01:33:54 dap-10 volumio[28228]: info: sendMpdCommand stop took 14 milliseconds Mar 27 01:33:54 dap-10 volumio[28228]: verbose: ControllerMpd::sendMpdCommand clear Mar 27 01:33:54 dap-10 volumio[28228]: info: Mar 27 01:33:54 dap-10 volumio[28228]: ---------------------------- MPD announces system playlist update Mar 27 01:33:54 dap-10 volumio[28228]: info: Ignoring MPD Status Update Mar 27 01:33:54 dap-10 volumio[28228]: info: sendMpdCommand clear took 5 milliseconds Mar 27 01:33:54 dap-10 volumio[28228]: verbose: ControllerMpd::sendMpdCommand load "http://127.0.0.1:3245?data=qobuz://song/170679596" Mar 27 01:33:54 dap-10 volumio[28228]: error: updateQueue error: null Mar 27 01:33:54 dap-10 volumio[28228]: info: ------------------------------ 11ms Mar 27 01:33:54 dap-10 volumio[28228]: STREAMING PROXY: Handling url /?data=qobuz://song/170679596 Mar 27 01:33:54 dap-10 volumio[28228]: info: Executing endpoint getStreamUrlqobuz Mar 27 01:33:54 dap-10 volumio[28228]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI Mar 27 01:33:54 dap-10 volumio[28228]: info: getStreamUrl took 397 milliseconds Mar 27 01:33:54 dap-10 volumio[28228]: STREAMING PROXY: Got real url: https://streaming-qobuz-std.akamaized.net/file?uid=1944053&eid=170679596&fmt=6&profile=raw&app_id=539451548&cid=3976494&etsp=1774557234&hmac=7kUS0c8UEo_22Uba91vPpRLfSgk Mar 27 01:33:54 dap-10 volumio[28228]: STREAMING PROXY: Requesting upstream with range: none Mar 27 01:33:56 dap-10 volumio[28228]: STREAMING PROXY: Upstream status code: 200 Mar 27 01:33:56 dap-10 volumio[28228]: verbose: ControllerMpd::sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/170679596" Mar 27 01:33:56 dap-10 volumio[28228]: STREAMING PROXY: Client closed connection Mar 27 01:33:56 dap-10 volumio[28228]: info: Mar 27 01:33:56 dap-10 volumio[28228]: ---------------------------- MPD announces system playlist update Mar 27 01:33:56 dap-10 volumio[28228]: info: Ignoring MPD Status Update Mar 27 01:33:56 dap-10 volumio[28228]: info: sendMpdCommand add "http://127.0.0.1:3245?data=qobuz://song/170679596" took 3 milliseconds Mar 27 01:33:56 dap-10 volumio[28228]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 27 01:33:56 dap-10 volumio[28228]: STREAMING PROXY: Upstream closed. Received 16384 bytes Mar 27 01:33:56 dap-10 volumio[28228]: verbose: ControllerMpd::sendMpdCommand play Mar 27 01:33:56 dap-10 volumio[28228]: STREAMING PROXY: Incomplete transfer. Expected 21998334, got 16384 Mar 27 01:33:56 dap-10 volumio[28228]: STREAMING PROXY: Retrying with range: bytes=16384- (attempt 1) Mar 27 01:33:56 dap-10 volumio[28228]: info: ------------------------------ 7ms Mar 27 01:33:56 dap-10 volumio[28228]: info: sendMpdCommand play took 4 milliseconds Mar 27 01:33:56 dap-10 volumio[28228]: STREAMING PROXY: Handling url /?data=qobuz://song/170679596 Mar 27 01:33:56 dap-10 volumio[28228]: info: Executing endpoint getStreamUrlqobuz Mar 27 01:33:56 dap-10 volumio[28228]: info: CoreCommandRouter::executeOnPlugin: qobuz , getStreamUrlAPI Mar 27 01:33:56 dap-10 volumio[28228]: info: getStreamUrl took 405 milliseconds Mar 27 01:33:56 dap-10 volumio[28228]: STREAMING PROXY: Got real url: https://streaming-qobuz-std.akamaized.net/file?uid=1944053&eid=170679596&fmt=6&profile=raw&app_id=539451548&cid=3976494&etsp=1774557236&hmac=40HQNNXrtqOC9loZeZfQK5LHKRs Mar 27 01:33:56 dap-10 volumio[28228]: STREAMING PROXY: Requesting upstream with range: none Mar 27 01:33:56 dap-10 volumio[28228]: STREAMING PROXY: Upstream status code: 200 Mar 27 01:33:56 dap-10 volumio[28228]: info: Mar 27 01:33:56 dap-10 volumio[28228]: ---------------------------- MPD announces state update: player Mar 27 01:33:56 dap-10 volumio[28228]: info: ControllerMpd::getState Mar 27 01:33:56 dap-10 volumio[28228]: verbose: ControllerMpd::sendMpdCommand status Mar 27 01:33:57 dap-10 volumio[28228]: info: Mar 27 01:33:57 dap-10 volumio[28228]: ---------------------------- MPD announces state update: player Mar 27 01:33:57 dap-10 volumio[28228]: info: sendMpdCommand status took 61 milliseconds Mar 27 01:33:57 dap-10 volumio[28228]: info: ControllerMpd::getState Mar 27 01:33:57 dap-10 volumio[28228]: verbose: ControllerMpd::sendMpdCommand status Mar 27 01:33:57 dap-10 volumio[28228]: verbose: ControllerMpd::parseState Mar 27 01:33:57 dap-10 volumio[28228]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 27 01:33:57 dap-10 volumio[28228]: info: sendMpdCommand status took 6 milliseconds Mar 27 01:33:57 dap-10 volumio[28228]: info: sendMpdCommand playlistinfo took 4 milliseconds Mar 27 01:33:57 dap-10 volumio[28228]: verbose: ControllerMpd::parseState Mar 27 01:33:57 dap-10 volumio[28228]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 27 01:33:57 dap-10 volumio[28228]: verbose: ControllerMpd::parseTrackInfo Mar 27 01:33:57 dap-10 volumio[28228]: info: ControllerMpd::pushState Mar 27 01:33:57 dap-10 volumio[28228]: info: CoreCommandRouter::servicePushState Mar 27 01:33:57 dap-10 volumio[28228]: info: CorePlayQueue::getTrack 2 Mar 27 01:33:57 dap-10 volumio[28228]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":221,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"170679596","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/170679596","trackType":"qobuz"} Mar 27 01:33:57 dap-10 volumio[28228]: verbose: CURRENT POSITION 2 Mar 27 01:33:57 dap-10 volumio[28228]: info: CoreStateMachine::syncState stateService play Mar 27 01:33:57 dap-10 volumio[28228]: info: CoreStateMachine::syncState currentStatus stop Mar 27 01:33:57 dap-10 volumio[28228]: info: ------------------------------ 84ms Mar 27 01:33:57 dap-10 volumio[28228]: info: sendMpdCommand playlistinfo took 12 milliseconds Mar 27 01:33:57 dap-10 volumio[28228]: verbose: ControllerMpd::parseTrackInfo Mar 27 01:33:57 dap-10 volumio[28228]: info: ControllerMpd::pushState Mar 27 01:33:57 dap-10 volumio[28228]: info: CoreCommandRouter::servicePushState Mar 27 01:33:57 dap-10 volumio[28228]: info: CorePlayQueue::getTrack 2 Mar 27 01:33:57 dap-10 volumio[28228]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":221,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"714 Kbps","isStreaming":false,"title":"170679596","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=qobuz://song/170679596","trackType":"qobuz"} Mar 27 01:33:57 dap-10 volumio[28228]: verbose: CURRENT POSITION 2 Mar 27 01:33:57 dap-10 volumio[28228]: info: CoreStateMachine::syncState stateService play Mar 27 01:33:57 dap-10 volumio[28228]: info: CoreStateMachine::syncState currentStatus play Mar 27 01:33:57 dap-10 volumio[28228]: info: Received an update from plugin. extracting info from payload Mar 27 01:33:57 dap-10 volumio[28228]: info: CoreStateMachine::pushState Mar 27 01:33:57 dap-10 volumio[28228]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 27 01:33:57 dap-10 volumio[28228]: info: CoreCommandRouter::volumioPushState Mar 27 01:33:57 dap-10 volumio[28228]: info: CoreCommandRouter::volumioGetState Mar 27 01:33:57 dap-10 volumio[28228]: info: CoreStateMachine::pushState Mar 27 01:33:57 dap-10 volumio[28228]: info: CoreCommandRouter::volumioPushState Mar 27 01:33:57 dap-10 volumio[28228]: info: CoreCommandRouter::volumioGetState Mar 27 01:33:57 dap-10 volumio5-onboarding[1604]: time=2026-03-27T01:33:57.079+06:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.37:48366 @ 0x3000390" state=STATUS_PLAYING positionMs=0 volume=100 Mar 27 01:33:57 dap-10 volumio5-onboarding[1604]: time=2026-03-27T01:33:57.080+06:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.50.37:48366 @ 0x3000390" state=STATUS_PLAYING positionMs=0 volume=100 Mar 27 01:33:57 dap-10 volumio5-onboarding[1604]: time=2026-03-27T01:33:57.081+06:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.37:48366 @ 0x3000390" id=qobuz://song/170679596 title="Someone You Love" Mar 27 01:33:57 dap-10 volumio5-onboarding[1604]: time=2026-03-27T01:33:57.082+06:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.50.37:48366 @ 0x3000390" id=qobuz://song/170679596 title="Someone You Love" Mar 27 01:33:57 dap-10 volumio[28228]: info: ------------------------------ 70ms Mar 27 01:33:57 dap-10 volumio[28228]: STREAMING PROXY: Resuming with range: bytes=16384- Mar 27 01:33:58 dap-10 volumio[28228]: STREAMING PROXY: Resume upstream status code: 206 Mar 27 01:33:58 dap-10 volumio[28228]: STREAMING PROXY: Upstream closed. Received 21998334 bytes Mar 27 01:33:58 dap-10 volumio[28228]: STREAMING PROXY: Client closed connection Mar 27 01:33:59 dap-10 volumio[28228]: STREAMING PROXY: Resume ended. Received 21981950 bytes Mar 27 01:33:59 dap-10 volumio[28228]: info: Executing endpoint metavolumio Mar 27 01:33:59 dap-10 volumio[28228]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Mar 27 01:33:59 dap-10 volumio[28228]: info: Executing endpoint metavolumio Mar 27 01:33:59 dap-10 volumio[28228]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Mar 27 01:33:59 dap-10 volumio[28228]: info: Executing endpoint metavolumio Mar 27 01:33:59 dap-10 volumio[28228]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Mar 27 01:34:00 dap-10 volumio[28228]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 27 01:34:01 dap-10 volumio[28228]: xcb_connection_has_error() returned true Mar 27 01:34:01 dap-10 volumio[28228]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Mar 27 01:34:01 dap-10 volumio[28228]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 27 01:34:01 dap-10 volumio[28228]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 27 01:34:01 dap-10 volumio[28228]: xcb_connection_has_error() returned true Mar 27 01:34:01 dap-10 volumio[28228]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 27 01:34:01 dap-10 volumio[28228]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 27 01:34:01 dap-10 volumio[28228]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 27 01:34:01 dap-10 volumio[28228]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 27 01:34:01 dap-10 volumio[28228]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 27 01:34:01 dap-10 volumio[28228]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 27 01:34:01 dap-10 volumio[28228]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 27 01:34:01 dap-10 volumio[28228]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Mar 27 01:34:01 dap-10 volumio[28228]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 27 01:34:06 dap-10 volumio[28228]: error: Failed request for metavolumio API Mar 27 01:34:49 dap-10 volumio[28228]: Searching plugin music_service/qobuz Mar 27 01:34:49 dap-10 volumio[28228]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Mar 27 01:34:51 dap-10 volumio[28228]: Searching plugin music_service/qobuz Mar 27 01:34:51 dap-10 volumio[28228]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Mar 27 01:34:51 dap-10 volumio[28228]: info: searchQOBUZUri took 2228 milliseconds Mar 27 01:34:51 dap-10 volumio[28228]: info: All search sources collected, pushing search results Mar 27 01:34:52 dap-10 volumio[28228]: info: searchQOBUZUri took 1464 milliseconds Mar 27 01:34:52 dap-10 volumio[28228]: info: All search sources collected, pushing search results Mar 27 01:34:52 dap-10 volumio[28228]: Searching plugin music_service/qobuz Mar 27 01:34:52 dap-10 volumio[28228]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Mar 27 01:34:53 dap-10 volumio[28228]: info: searchQOBUZUri took 1038 milliseconds Mar 27 01:34:53 dap-10 volumio[28228]: info: All search sources collected, pushing search results Mar 27 01:34:54 dap-10 volumio[28228]: Searching plugin music_service/qobuz Mar 27 01:34:54 dap-10 volumio[28228]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Mar 27 01:34:55 dap-10 volumio[28228]: Searching plugin music_service/qobuz Mar 27 01:34:55 dap-10 volumio[28228]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Mar 27 01:34:55 dap-10 volumio[28228]: info: searchQOBUZUri took 1813 milliseconds Mar 27 01:34:55 dap-10 volumio[28228]: info: All search sources collected, pushing search results Mar 27 01:34:56 dap-10 volumio[28228]: info: searchQOBUZUri took 1791 milliseconds Mar 27 01:34:56 dap-10 volumio[28228]: info: All search sources collected, pushing search results Mar 27 01:34:58 dap-10 volumio[28228]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 27 01:34:58 dap-10 volumio[28228]: Error: connect ETIMEDOUT 151.101.2.79:443 Mar 27 01:34:58 dap-10 volumio[28228]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Mar 27 01:34:58 dap-10 volumio[28228]: errno: -110, Mar 27 01:34:58 dap-10 volumio[28228]: code: 'ETIMEDOUT', Mar 27 01:34:58 dap-10 volumio[28228]: syscall: 'connect', Mar 27 01:34:58 dap-10 volumio[28228]: address: '151.101.2.79', Mar 27 01:34:58 dap-10 volumio[28228]: port: 443 Mar 27 01:34:58 dap-10 volumio[28228]: } Mar 27 01:34:58 dap-10 volumio[28228]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 27 01:34:59 dap-10 sudo[29036]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-03-27 01:33 Mar 27 01:34:59 dap-10 sudo[29036]: 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="e9612ec5034fb2e958508aaefbca2962fd6f6654" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="464fc672d77d3df6ee72b331d36cdf1fa936e1ec" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 27 Feb 2026 10:59:40 AM CET" VOLUMIO_VERSION="3.912" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="37c6ab864cb114e1344d540995c69f86"