参数简介

log_min_duration_statement两个参数记录一下。

参数简介

none关闭默认ddlDDL语句modDDL和所有涉及数据修改的语句DML、COPY

FROM、PREPARE、EXECUTE等。

对于explain和explain

记录时机

SQL语句解析成功后执行前。

因此即使设置为all也不会记录有语法错误的语句如果想记录应该使用log_min_error_statement参数。

记录内容

记录SQL语句包含参数但不包含执行用户、主机名等信息这些需要审计插件才有。

-1关闭默认0所有语句正数慢SQL阈值

记录SQL语句、执行时间但不包含参数。

对于使用扩展查询协议的客户端对语法分析、绑定、执行每一步所花时间会独立记录。

语句在解析完成后、执行开始前即被记入日志log_statement生效语句执行完成后单独将duration记入日志log_min_duration_statement生效但不再重复记录语句因此建议使用log_line_prefix记录PID或会话ID避免duration和语句关联不上

效果测试

log_statementall,log_min_duration_statement0s

2023-11-28

语句记录为开始时间log_statement生效duration在执行完成时单独记录log_min_duration_statement生效但不再重复记录语句。

仅设置log_statement

log_statementall,log_min_duration_statement-1禁用

2023-11-28

log_statementnone禁用,log_min_duration_statement0s

2023-11-28

从上面文档可以知道两个参数记录时机都在SQL执行阶段只是一个在前一个在后。

源码中SQL执行相关的函数主要是exec_simple_query因此我们就看看这个函数。

pg_parse_query

whereToSendOutput;MemoryContext

oldcontext;List

pg_parse_query(query_string);/*

Log

(check_log_statement(parsetree_list)){ereport(LOG,(errmsg(statement:

%s,

query_string),errhidestmt(true),errdetail_execute(parsetree_list)));was_logged

true;}

pg_parse_query函数用于SQL解析符合log_statement记录的语句发生在解析完成后check_log_statement函数就用于检查log_statement的设置标记是否需要记录was_loggedtrue表示已记录SQL语句主要是给后面的慢SQL记录函数提示其不需重复记录SQL文本

/**

后面一大堆是SQL执行相关的代码非本次重点直接拉到函数末尾可以看到check_log_duration函数看名字都能猜到是它了也符合在SQL执行完才记录。

.../**

1:ereport(LOG,(errmsg(duration:

ms,

msec_str),errhidestmt(true)));break;case

2:ereport(LOG,(errmsg(duration:

statement:

query_string),errhidestmt(true),errdetail_execute(parsetree_list)));break;}if

(save_log_statement_stats)ShowUsage(QUERY

STATISTICS);TRACE_POSTGRESQL_QUERY_DONE(query_string);debug_query_string

NULL;

1仅记录duration即前面提到的两个参数均生效的场景2记录duration和语句即前面提到的仅log_min_duration_statement生效的场景

log_duration、log_min_duration_sample

/**

false;TimestampDifference(GetCurrentStatementStartTimestamp(),GetCurrentTimestamp(),secs,

usecs);msecs

log_min_duration_statement)));exceeded_sample_duration

(secs

(exceeded_sample_duration)in_sample

||random()

xact_is_sampled){snprintf(msec_str,

32,

https://www.postgresql.org/docs/current/runtime-config-logging.html#GUC-LOG-STATEMENT

https://www.postgresql.org/docs/current/protocol-flow.html#PROTOCOL-FLOW-EXT-QUERY

https://blog.csdn.net/qq_35423190/article/details/129138740

https://iwmj.wordpress.com/2018/04/03/postgresql-%E5%89%8D%E5%90%8E%E7%AB%AF%E5%8D%8F%E8%AE%AE%E4%B8%AD%E7%9A%84%E6%9F%A5%E8%AF%A2%E6%96%B9%E5%BC%8F%EF%BC%9A%E7%AE%80%E5%8D%95%E6%9F%A5%E8%AF%A2%E3%80%81%E6%89%A9%E5%B1%95%E6%9F%A5%E8%AF%A2/