如何测量Postgres处理JDBC请求的实际耗时？

你原来在executeQuery()前后计时的方式，会包含客户端请求准备、本地套接字传输、PostgreSQL处理、结果返回客户端、客户端解析ResultSet等多个环节的耗时，无法精准得到PostgreSQL自身的处理时间。以下是几种更细粒度的方法：

1. 使用PostgreSQL JDBC扩展接口获取服务器端执行时间 #

PostgreSQL的JDBC驱动提供了PGStatement扩展类，直接暴露了服务器端的执行耗时统计，不需要修改查询语句，代码实现简单：

import org.postgresql.PGStatement;
import java.sql.Connection;
import java.sql.PreparedStatement;
import java.sql.ResultSet;

// 假设已获取数据库连接connection
String sql = "SELECT * FROM your_table WHERE your_condition";
PreparedStatement pstmt = connection.prepareStatement(sql);

ResultSet rs = pstmt.executeQuery();

// 转换为PGStatement获取服务器端执行时间
PGStatement pgStmt = (PGStatement) pstmt;
long serverExecTimeMs = pgStmt.getExecutionTime();
System.out.println("PostgreSQL服务器端处理耗时: " + serverExecTimeMs + " ms");

// 后续处理ResultSet

这个方法返回的是PostgreSQL从接收查询请求到完成结果发送的纯服务器端耗时，排除了客户端解析ResultSet的时间，精度较高。

2. 用EXPLAIN ANALYZE获取详细执行耗时 #

EXPLAIN ANALYZE会实际执行查询，并输出PostgreSQL内部每个执行阶段的耗时（比如扫描表、排序、关联等），适合排查查询性能瓶颈：

String sql = "EXPLAIN ANALYZE SELECT * FROM your_table WHERE your_condition";
Statement stmt = connection.createStatement();
ResultSet rs = stmt.executeQuery(sql);

// 解析结果，提取总执行时间
while (rs.next()) {
    String line = rs.getString(1);
    if (line.startsWith("Execution Time:")) {
        String timeInfo = line.split(": ")[1];
        System.out.println("PostgreSQL查询总执行耗时: " + timeInfo);
    }
}

注意：EXPLAIN ANALYZE会实际执行查询，若查询是写操作（如INSERT/UPDATE）会修改数据，仅适合读查询或测试环境使用。

3. 开启PostgreSQL日志记录查询耗时 #

不需要修改应用代码，通过配置PostgreSQL日志直接记录所有查询的执行时间，适合批量监控：

1. 修改postgresql.conf配置文件：

   log_statement = 'all'          # 记录所有SQL语句
   log_min_duration_statement = 0 # 记录所有耗时的语句（0表示全部）
   log_duration = on              # 单独记录语句执行耗时
   log_line_prefix = '%t [%p]: [%c-%l] user=%u,db=%d,app=%a ' # 日志前缀包含时间、进程、应用等信息
   

2. 重启PostgreSQL服务后，查看日志文件（默认路径如/var/log/postgresql/），会看到类似日志：

   2024-05-20 14:30:00 [12345]: [1-1] user=postgres,db=mydb,app=MyApp duration=8.567 ms statement=SELECT * FROM your_table WHERE ...
   

   其中duration字段就是PostgreSQL处理该查询的耗时。

4. 用pg_stat_statements扩展统计长期查询性能 #

如果需要统计查询的长期执行趋势（比如平均耗时、调用次数），可以启用pg_stat_statements扩展：

1. 修改postgresql.conf：

   shared_preload_libraries = 'pg_stat_statements'
   pg_stat_statements.track = 'all'
   

2. 重启PostgreSQL后，在目标数据库中创建扩展：

   CREATE EXTENSION pg_stat_statements;
   

3. 查询统计信息：

   SELECT query, mean_time AS 平均耗时_ms, total_time AS 总耗时_ms, calls AS 调用次数
   FROM pg_stat_statements
   WHERE query LIKE 'SELECT * FROM your_table%';
   

   这个方法适合分析高频查询的性能瓶颈，不适合单次查询的实时测量。

内容的提问来源于stack exchange，提问作者xxks-kkk