Received: from malur.postgresql.org ([217.196.149.56]) by arkaria.postgresql.org with esmtps (TLS1.3) tls TLS_ECDHE_RSA_WITH_AES_256_GCM_SHA384 (Exim 4.94.2) (envelope-from ) id 1u7wgM-00ALUZ-Ko for pgsql-general@arkaria.postgresql.org; Thu, 24 Apr 2025 13:32:03 +0000 Received: from localhost ([127.0.0.1] helo=malur.postgresql.org) by malur.postgresql.org with esmtp (Exim 4.94.2) (envelope-from ) id 1u7wgK-0002DH-TO for pgsql-general@arkaria.postgresql.org; Thu, 24 Apr 2025 13:32:01 +0000 Received: from magus.postgresql.org ([2a02:c0:301:0:ffff::29]) by malur.postgresql.org with esmtps (TLS1.3) tls TLS_ECDHE_RSA_WITH_AES_256_GCM_SHA384 (Exim 4.94.2) (envelope-from ) id 1u7wgK-0002C1-Eq for pgsql-general@lists.postgresql.org; Thu, 24 Apr 2025 13:32:01 +0000 Received: from mail-oi1-x22e.google.com ([2607:f8b0:4864:20::22e]) by magus.postgresql.org with esmtps (TLS1.3) tls TLS_ECDHE_RSA_WITH_AES_128_GCM_SHA256 (Exim 4.96) (envelope-from ) id 1u7wgH-001moi-18 for pgsql-general@lists.postgresql.org; Thu, 24 Apr 2025 13:32:00 +0000 Received: by mail-oi1-x22e.google.com with SMTP id 5614622812f47-3f9a7cbc8f1so308818b6e.0 for ; Thu, 24 Apr 2025 06:31:58 -0700 (PDT) DKIM-Signature: v=1; a=rsa-sha256; c=relaxed/relaxed; d=mokadb-com.20230601.gappssmtp.com; s=20230601; t=1745501516; x=1746106316; darn=lists.postgresql.org; h=to:subject:message-id:date:from:mime-version:from:to:cc:subject :date:message-id:reply-to; bh=0PNPMOuCMlHrHivephfuNvEUlyTMc3LJML27HNUylLo=; b=VEWxCwK98+imtHjPxSMnNSvXeWg0SSBcuKAxy7aIPVzW/GuCeEMe3X9XikBI60ytbY xxZQXVQaNQLD+dgx2zx2nzoYgFnwRDIbjlR7bC2ZfSnlQ6WAVXM/cn7+9JSLz4TpRW0w CtYyokQKlM3HycxYsk9//0B8HhEQ0KqpqRFCEpit2Euk7BsDboz8qWZjE3VroDztUxpy Z/uEhaSPCism6OlV4AOySuttRHo6hgh/nT8J9ak/x6HC9w2N/sZDtmBYLbeYKUCRGx4s 68P7+cLtvhPS4xTuKSkRo507qxaYty2VOF43TxKx8FvIEONVisvT7Dd6jwRCwkvypXdn 63lg== X-Google-DKIM-Signature: v=1; a=rsa-sha256; c=relaxed/relaxed; d=1e100.net; s=20230601; t=1745501516; x=1746106316; h=to:subject:message-id:date:from:mime-version:x-gm-message-state :from:to:cc:subject:date:message-id:reply-to; bh=0PNPMOuCMlHrHivephfuNvEUlyTMc3LJML27HNUylLo=; b=TnHd8G67DFHtSOqaPNeYtygFq1bpGbLB5/87dK1CCxLrVtxZtW6gUk/MoA4LPVllHT 5BRGfRH9LPI3BLW8Vc5eW3Z2jj9n1GA5l+xh/cJs/I1IDZ+eLW66So4ckU+e52Gqh1hN J3EPtmui0V1M9rvjLLFBWBkaiLL7s8EzxvVvMUvCaswT1biVu5WPtYrsoRJgkP7MQWbO 2FedtOY5cKMnmDx09uF+qft4uj2jurKMi+Cosoe1dCaZz0KBn2MCMlwGIdcNS634JTCM PGnuYc7jQZUcOcaeM0uxQhcgT0jmC/5yreQB55vRlQsDhur+fmg6ggVUk3dWbAX6a48D cJQA== X-Gm-Message-State: AOJu0Yx2jZDz1M3iPiOkz+7iJaEMRjREMa9uQ1R9FQOLYqzmpCaVD37y JgawE+q0IfPP1pvUP2oIgZsmwuzOeSFLuovgwBHNcSLOxLnsuOm/M20h3S+T3BRXg53/J52tbhM uGd2Kau8BcBwGBkBSuzm//0xCiL/Mk09U0ZqNdBzmJmdspSA7/pc= X-Gm-Gg: ASbGncvDe9fm1n7O+tzeFYRtwLhavZPmSHJxhtMS/rYeAkfjndIeAruH9o2XUVQ4r6a pWOgHFlbrpct6mBVyS+++mCbiCYGHNKdZ9lG+qyJvYhEY5ZtQGUmfzPrLViPfx5KGDe+IvMZ4N6 qqvBwBQf1cxBOV63rYlnIvhA== X-Google-Smtp-Source: AGHT+IG6R2DtnzKF2vhbGXPFxbaLYPFoU3q/uqZyaClc0zSQ4eyTMsh5Ag122QkaEZlSy3hn3jfILixwCWzaGLs2RGw= X-Received: by 2002:a05:6808:6c8e:b0:3f6:7832:77f1 with SMTP id 5614622812f47-401eb3cf753mr1440035b6e.33.1745501515858; Thu, 24 Apr 2025 06:31:55 -0700 (PDT) MIME-Version: 1.0 From: Marc Millas Date: Thu, 24 Apr 2025 15:31:46 +0200 X-Gm-Features: ATxdqUGlYRUnML0DR63uxCxsQSJ--n2nVtL4gbMct3_NN5lHtx6R1rsggqwD4jM Message-ID: Subject: explain To: "pgsql-general@lists.postgresql.org" Content-Type: multipart/alternative; boundary="000000000000cedabc0633863de2" List-Id: List-Help: List-Subscribe: List-Post: List-Owner: List-Archive: Archived-At: Precedence: bulk --000000000000cedabc0633863de2 Content-Type: text/plain; charset="UTF-8" hello, there is something I seem missing in explain analyze buffers results when track_io_timing is on: this is the first lines of an explain: (the request is of no interest, such a result is quite frequent) Nested Loop Left Join (cost=941400.77..966327.57 rows=3 width=653) (actual time=52655.694..62533.811 rows=346 loops=1) Buffers: shared hit=10068265 read=396705 dirtied=1858 written=218, temp read=429687 written=115187 I/O Timings: read=79368.246 write=11.486 So, the total execution time is 52655 ms ok and the total time for i/o is...79368 ms how ??? thanks Marc MILLAS Senior Architect +33607850334 www.mokadb.com --000000000000cedabc0633863de2 Content-Type: text/html; charset="UTF-8" Content-Transfer-Encoding: quoted-printable
hello,

there is something I = seem missing in explain analyze buffers results when track_io_timing is on:=

this is the first=C2=A0lines of an explain: (the = request is of no interest, such a result is quite frequent)

<= /div>
Nested Loop Left Join =C2=A0(cost=3D941400.77..966327.57 rows=3D3= width=3D653) (actual time=3D52655.694..62533.811 rows=3D346 loops=3D1)
= =C2=A0 Buffers: shared hit=3D10068265 read=3D396705 dirtied=3D1858 written= =3D218, temp read=3D429687 written=3D115187
=C2=A0 I/O Timings: read=3D7= 9368.246 write=3D11.486

So, the total execution ti= me is 52655 ms ok
and the total time for i/o is...79368 ms
<= div>
how ???

thanks

Marc MILLAS
Senior A= rchitect
+33607850334

--000000000000cedabc0633863de2--