public inbox for [email protected]  
help / color / mirror / Atom feed
[PATCH v28 5/5] Avoid some calls to RelationGetRelationName
29+ messages / 7 participants
[nested] [flat]

* [PATCH v28 5/5] Avoid some calls to RelationGetRelationName
@ 2020-02-27 01:22  Justin Pryzby <[email protected]>
  0 siblings, 0 replies; 29+ messages in thread

From: Justin Pryzby @ 2020-02-27 01:22 UTC (permalink / raw)

---
 src/backend/access/heap/vacuumlazy.c | 20 ++++++++++----------
 1 file changed, 10 insertions(+), 10 deletions(-)

diff --git a/src/backend/access/heap/vacuumlazy.c b/src/backend/access/heap/vacuumlazy.c
index b8ac28d609..70d81f9566 100644
--- a/src/backend/access/heap/vacuumlazy.c
+++ b/src/backend/access/heap/vacuumlazy.c
@@ -623,8 +623,8 @@ heap_vacuum_rel(Relation onerel, VacuumParams *params,
 			}
 			appendStringInfo(&buf, msgfmt,
 							 get_database_name(MyDatabaseId),
-							 get_namespace_name(RelationGetNamespace(onerel)),
-							 RelationGetRelationName(onerel),
+							 vacrelstats->relnamespace,
+							 vacrelstats->relname,
 							 vacrelstats->num_index_scans);
 			appendStringInfo(&buf, _("pages: %u removed, %u remain, %u skipped due to pins, %u skipped frozen\n"),
 							 vacrelstats->pages_removed,
@@ -796,7 +796,7 @@ lazy_scan_heap(Relation onerel, VacuumParams *params, LVRelStats *vacrelstats,
 			if (params->nworkers > 0)
 				ereport(WARNING,
 						(errmsg("disabling parallel option of vacuum on \"%s\" --- cannot vacuum temporary tables in parallel",
-								RelationGetRelationName(onerel))));
+								vacrelstats->relname)));
 		}
 		else
 			lps = begin_parallel_vacuum(RelationGetRelid(onerel), Irel,
@@ -1704,7 +1704,7 @@ lazy_scan_heap(Relation onerel, VacuumParams *params, LVRelStats *vacrelstats,
 	if (vacuumed_pages)
 		ereport(elevel,
 				(errmsg("\"%s\": removed %.0f row versions in %u pages",
-						RelationGetRelationName(onerel),
+						vacrelstats->relname,
 						tups_vacuumed, vacuumed_pages)));
 
 	/*
@@ -1733,7 +1733,7 @@ lazy_scan_heap(Relation onerel, VacuumParams *params, LVRelStats *vacrelstats,
 
 	ereport(elevel,
 			(errmsg("\"%s\": found %.0f removable, %.0f nonremovable row versions in %u out of %u pages",
-					RelationGetRelationName(onerel),
+					vacrelstats->relname,
 					tups_vacuumed, num_tuples,
 					vacrelstats->scanned_pages, nblocks),
 			 errdetail_internal("%s", buf.data)));
@@ -1865,7 +1865,7 @@ lazy_vacuum_heap(Relation onerel, LVRelStats *vacrelstats)
 
 	ereport(elevel,
 			(errmsg("\"%s\": removed %d row versions in %d pages",
-					RelationGetRelationName(onerel),
+					vacrelstats->relname,
 					tupindex, npages),
 			 errdetail_internal("%s", pg_rusage_show(&ru0))));
 
@@ -2413,7 +2413,7 @@ lazy_vacuum_index(Relation indrel, IndexBulkDeleteResult **stats,
 
 	ereport(elevel,
 			(errmsg(msg,
-					RelationGetRelationName(indrel),
+					vacrelstats->relname,
 					dead_tuples->num_tuples),
 			 errdetail_internal("%s", pg_rusage_show(&ru0))));
 
@@ -2582,7 +2582,7 @@ lazy_truncate_heap(Relation onerel, LVRelStats *vacrelstats)
 				vacrelstats->lock_waiter_detected = true;
 				ereport(elevel,
 						(errmsg("\"%s\": stopping truncate due to conflicting lock request",
-								RelationGetRelationName(onerel))));
+								vacrelstats->relname)));
 				return;
 			}
 
@@ -2660,7 +2660,7 @@ lazy_truncate_heap(Relation onerel, LVRelStats *vacrelstats)
 
 		ereport(elevel,
 				(errmsg("\"%s\": truncated %u to %u pages",
-						RelationGetRelationName(onerel),
+						vacrelstats->relname,
 						old_rel_pages, new_rel_pages),
 				 errdetail_internal("%s",
 									pg_rusage_show(&ru0))));
@@ -2733,7 +2733,7 @@ count_nondeletable_pages(Relation onerel, LVRelStats *vacrelstats)
 				{
 					ereport(elevel,
 							(errmsg("\"%s\": suspending truncate due to conflicting lock request",
-									RelationGetRelationName(onerel))));
+									vacrelstats->relname)));
 
 					vacrelstats->lock_waiter_detected = true;
 					return blkno;
-- 
2.17.0


--rG8Oha4Ryswg1dZ8--





^ permalink  raw  reply  [nested|flat] 29+ messages in thread

* [PATCH v23 3/3] Avoid some calls to RelationGetRelationName
@ 2020-02-27 01:22  Justin Pryzby <[email protected]>
  0 siblings, 0 replies; 29+ messages in thread

From: Justin Pryzby @ 2020-02-27 01:22 UTC (permalink / raw)

---
 src/backend/access/heap/vacuumlazy.c | 20 ++++++++++----------
 1 file changed, 10 insertions(+), 10 deletions(-)

diff --git a/src/backend/access/heap/vacuumlazy.c b/src/backend/access/heap/vacuumlazy.c
index d10a1bcc96..170b85f7b4 100644
--- a/src/backend/access/heap/vacuumlazy.c
+++ b/src/backend/access/heap/vacuumlazy.c
@@ -611,8 +611,8 @@ heap_vacuum_rel(Relation onerel, VacuumParams *params,
 			}
 			appendStringInfo(&buf, msgfmt,
 							 get_database_name(MyDatabaseId),
-							 get_namespace_name(RelationGetNamespace(onerel)),
-							 RelationGetRelationName(onerel),
+							 vacrelstats->relnamespace,
+							 vacrelstats->relname,
 							 vacrelstats->num_index_scans);
 			appendStringInfo(&buf, _("pages: %u removed, %u remain, %u skipped due to pins, %u skipped frozen\n"),
 							 vacrelstats->pages_removed,
@@ -784,7 +784,7 @@ lazy_scan_heap(Relation onerel, VacuumParams *params, LVRelStats *vacrelstats,
 			if (params->nworkers > 0)
 				ereport(WARNING,
 						(errmsg("disabling parallel option of vacuum on \"%s\" --- cannot vacuum temporary tables in parallel",
-								RelationGetRelationName(onerel))));
+								vacrelstats->relname)));
 		}
 		else
 			lps = begin_parallel_vacuum(RelationGetRelid(onerel), Irel,
@@ -1695,7 +1695,7 @@ lazy_scan_heap(Relation onerel, VacuumParams *params, LVRelStats *vacrelstats,
 	if (vacuumed_pages)
 		ereport(elevel,
 				(errmsg("\"%s\": removed %.0f row versions in %u pages",
-						RelationGetRelationName(onerel),
+						vacrelstats->relname,
 						tups_vacuumed, vacuumed_pages)));
 
 	/*
@@ -1724,7 +1724,7 @@ lazy_scan_heap(Relation onerel, VacuumParams *params, LVRelStats *vacrelstats,
 
 	ereport(elevel,
 			(errmsg("\"%s\": found %.0f removable, %.0f nonremovable row versions in %u out of %u pages",
-					RelationGetRelationName(onerel),
+					vacrelstats->relname,
 					tups_vacuumed, num_tuples,
 					vacrelstats->scanned_pages, nblocks),
 			 errdetail_internal("%s", buf.data)));
@@ -1855,7 +1855,7 @@ lazy_vacuum_heap(Relation onerel, LVRelStats *vacrelstats)
 
 	ereport(elevel,
 			(errmsg("\"%s\": removed %d row versions in %d pages",
-					RelationGetRelationName(onerel),
+					vacrelstats->relname,
 					tupindex, npages),
 			 errdetail_internal("%s", pg_rusage_show(&ru0))));
 }
@@ -2383,7 +2383,7 @@ lazy_vacuum_index(Relation indrel, IndexBulkDeleteResult **stats,
 
 	ereport(elevel,
 			(errmsg(msg,
-					RelationGetRelationName(indrel),
+					vacrelstats->relname,
 					dead_tuples->num_tuples),
 			 errdetail_internal("%s", pg_rusage_show(&ru0))));
 }
@@ -2531,7 +2531,7 @@ lazy_truncate_heap(Relation onerel, LVRelStats *vacrelstats)
 				vacrelstats->lock_waiter_detected = true;
 				ereport(elevel,
 						(errmsg("\"%s\": stopping truncate due to conflicting lock request",
-								RelationGetRelationName(onerel))));
+								vacrelstats->relname)));
 				return;
 			}
 
@@ -2600,7 +2600,7 @@ lazy_truncate_heap(Relation onerel, LVRelStats *vacrelstats)
 
 		ereport(elevel,
 				(errmsg("\"%s\": truncated %u to %u pages",
-						RelationGetRelationName(onerel),
+						vacrelstats->relname,
 						old_rel_pages, new_rel_pages),
 				 errdetail_internal("%s",
 									pg_rusage_show(&ru0))));
@@ -2665,7 +2665,7 @@ count_nondeletable_pages(Relation onerel, LVRelStats *vacrelstats)
 				{
 					ereport(elevel,
 							(errmsg("\"%s\": suspending truncate due to conflicting lock request",
-									RelationGetRelationName(onerel))));
+									vacrelstats->relname)));
 
 					vacrelstats->lock_waiter_detected = true;
 					return blkno;
-- 
2.17.0


--HcAYCG3uE/tztfnV--





^ permalink  raw  reply  [nested|flat] 29+ messages in thread

* [PATCH v39 1/2] Avoid some calls to RelationGetRelationName
@ 2020-02-27 01:22  Justin Pryzby <[email protected]>
  0 siblings, 0 replies; 29+ messages in thread

From: Justin Pryzby @ 2020-02-27 01:22 UTC (permalink / raw)

---
 src/backend/access/heap/vacuumlazy.c | 20 ++++++++++----------
 1 file changed, 10 insertions(+), 10 deletions(-)

diff --git a/src/backend/access/heap/vacuumlazy.c b/src/backend/access/heap/vacuumlazy.c
index 0d2e724a7d..803e7660f7 100644
--- a/src/backend/access/heap/vacuumlazy.c
+++ b/src/backend/access/heap/vacuumlazy.c
@@ -655,8 +655,8 @@ heap_vacuum_rel(Relation onerel, VacuumParams *params,
 			}
 			appendStringInfo(&buf, msgfmt,
 							 get_database_name(MyDatabaseId),
-							 get_namespace_name(RelationGetNamespace(onerel)),
-							 RelationGetRelationName(onerel),
+							 vacrelstats->relnamespace,
+							 vacrelstats->relname,
 							 vacrelstats->num_index_scans);
 			appendStringInfo(&buf, _("pages: %u removed, %u remain, %u skipped due to pins, %u skipped frozen\n"),
 							 vacrelstats->pages_removed,
@@ -827,7 +827,7 @@ lazy_scan_heap(Relation onerel, VacuumParams *params, LVRelStats *vacrelstats,
 			if (params->nworkers > 0)
 				ereport(WARNING,
 						(errmsg("disabling parallel option of vacuum on \"%s\" --- cannot vacuum temporary tables in parallel",
-								RelationGetRelationName(onerel))));
+								vacrelstats->relname)));
 		}
 		else
 			lps = begin_parallel_vacuum(RelationGetRelid(onerel), Irel,
@@ -1722,7 +1722,7 @@ lazy_scan_heap(Relation onerel, VacuumParams *params, LVRelStats *vacrelstats,
 	if (vacuumed_pages)
 		ereport(elevel,
 				(errmsg("\"%s\": removed %.0f row versions in %u pages",
-						RelationGetRelationName(onerel),
+						vacrelstats->relname,
 						tups_vacuumed, vacuumed_pages)));
 
 	/*
@@ -1751,7 +1751,7 @@ lazy_scan_heap(Relation onerel, VacuumParams *params, LVRelStats *vacrelstats,
 
 	ereport(elevel,
 			(errmsg("\"%s\": found %.0f removable, %.0f nonremovable row versions in %u out of %u pages",
-					RelationGetRelationName(onerel),
+					vacrelstats->relname,
 					tups_vacuumed, num_tuples,
 					vacrelstats->scanned_pages, nblocks),
 			 errdetail_internal("%s", buf.data)));
@@ -1883,7 +1883,7 @@ lazy_vacuum_heap(Relation onerel, LVRelStats *vacrelstats)
 
 	ereport(elevel,
 			(errmsg("\"%s\": removed %d row versions in %d pages",
-					RelationGetRelationName(onerel),
+					vacrelstats->relname,
 					tupindex, npages),
 			 errdetail_internal("%s", pg_rusage_show(&ru0))));
 
@@ -2431,7 +2431,7 @@ lazy_vacuum_index(Relation indrel, IndexBulkDeleteResult **stats,
 
 	ereport(elevel,
 			(errmsg(msg,
-					RelationGetRelationName(indrel),
+					vacrelstats->indname,
 					dead_tuples->num_tuples),
 			 errdetail_internal("%s", pg_rusage_show(&ru0))));
 
@@ -2602,7 +2602,7 @@ lazy_truncate_heap(Relation onerel, LVRelStats *vacrelstats)
 				vacrelstats->lock_waiter_detected = true;
 				ereport(elevel,
 						(errmsg("\"%s\": stopping truncate due to conflicting lock request",
-								RelationGetRelationName(onerel))));
+								vacrelstats->relname)));
 				return;
 			}
 
@@ -2668,7 +2668,7 @@ lazy_truncate_heap(Relation onerel, LVRelStats *vacrelstats)
 
 		ereport(elevel,
 				(errmsg("\"%s\": truncated %u to %u pages",
-						RelationGetRelationName(onerel),
+						vacrelstats->relname,
 						old_rel_pages, new_rel_pages),
 				 errdetail_internal("%s",
 									pg_rusage_show(&ru0))));
@@ -2733,7 +2733,7 @@ count_nondeletable_pages(Relation onerel, LVRelStats *vacrelstats)
 				{
 					ereport(elevel,
 							(errmsg("\"%s\": suspending truncate due to conflicting lock request",
-									RelationGetRelationName(onerel))));
+									vacrelstats->relname)));
 
 					vacrelstats->lock_waiter_detected = true;
 					return blkno;
-- 
2.17.0


--TD8GDToEDw0WLGOL
Content-Type: text/x-diff; charset=us-ascii
Content-Disposition: attachment; filename="v39-0002-Drop-reltuples.patch"



^ permalink  raw  reply  [nested|flat] 29+ messages in thread

* [PATCH v37 3/3] Avoid some calls to RelationGetRelationName
@ 2020-02-27 01:22  Justin Pryzby <[email protected]>
  0 siblings, 0 replies; 29+ messages in thread

From: Justin Pryzby @ 2020-02-27 01:22 UTC (permalink / raw)

---
 src/backend/access/heap/vacuumlazy.c | 20 ++++++++++----------
 1 file changed, 10 insertions(+), 10 deletions(-)

diff --git a/src/backend/access/heap/vacuumlazy.c b/src/backend/access/heap/vacuumlazy.c
index 514fbcd314..d6482cf1eb 100644
--- a/src/backend/access/heap/vacuumlazy.c
+++ b/src/backend/access/heap/vacuumlazy.c
@@ -643,8 +643,8 @@ heap_vacuum_rel(Relation onerel, VacuumParams *params,
 			}
 			appendStringInfo(&buf, msgfmt,
 							 get_database_name(MyDatabaseId),
-							 get_namespace_name(RelationGetNamespace(onerel)),
-							 RelationGetRelationName(onerel),
+							 vacrelstats->relnamespace,
+							 vacrelstats->relname,
 							 vacrelstats->num_index_scans);
 			appendStringInfo(&buf, _("pages: %u removed, %u remain, %u skipped due to pins, %u skipped frozen\n"),
 							 vacrelstats->pages_removed,
@@ -815,7 +815,7 @@ lazy_scan_heap(Relation onerel, VacuumParams *params, LVRelStats *vacrelstats,
 			if (params->nworkers > 0)
 				ereport(WARNING,
 						(errmsg("disabling parallel option of vacuum on \"%s\" --- cannot vacuum temporary tables in parallel",
-								RelationGetRelationName(onerel))));
+								vacrelstats->relname)));
 		}
 		else
 			lps = begin_parallel_vacuum(RelationGetRelid(onerel), Irel,
@@ -1710,7 +1710,7 @@ lazy_scan_heap(Relation onerel, VacuumParams *params, LVRelStats *vacrelstats,
 	if (vacuumed_pages)
 		ereport(elevel,
 				(errmsg("\"%s\": removed %.0f row versions in %u pages",
-						RelationGetRelationName(onerel),
+						vacrelstats->relname,
 						tups_vacuumed, vacuumed_pages)));
 
 	/*
@@ -1739,7 +1739,7 @@ lazy_scan_heap(Relation onerel, VacuumParams *params, LVRelStats *vacrelstats,
 
 	ereport(elevel,
 			(errmsg("\"%s\": found %.0f removable, %.0f nonremovable row versions in %u out of %u pages",
-					RelationGetRelationName(onerel),
+					vacrelstats->relname,
 					tups_vacuumed, num_tuples,
 					vacrelstats->scanned_pages, nblocks),
 			 errdetail_internal("%s", buf.data)));
@@ -1871,7 +1871,7 @@ lazy_vacuum_heap(Relation onerel, LVRelStats *vacrelstats)
 
 	ereport(elevel,
 			(errmsg("\"%s\": removed %d row versions in %d pages",
-					RelationGetRelationName(onerel),
+					vacrelstats->relname,
 					tupindex, npages),
 			 errdetail_internal("%s", pg_rusage_show(&ru0))));
 
@@ -2416,7 +2416,7 @@ lazy_vacuum_index(Relation indrel, IndexBulkDeleteResult **stats,
 
 	ereport(elevel,
 			(errmsg(msg,
-					RelationGetRelationName(indrel),
+					vacrelstats->indname,
 					dead_tuples->num_tuples),
 			 errdetail_internal("%s", pg_rusage_show(&ru0))));
 
@@ -2581,7 +2581,7 @@ lazy_truncate_heap(Relation onerel, LVRelStats *vacrelstats)
 				vacrelstats->lock_waiter_detected = true;
 				ereport(elevel,
 						(errmsg("\"%s\": stopping truncate due to conflicting lock request",
-								RelationGetRelationName(onerel))));
+								vacrelstats->relname)));
 				return;
 			}
 
@@ -2647,7 +2647,7 @@ lazy_truncate_heap(Relation onerel, LVRelStats *vacrelstats)
 
 		ereport(elevel,
 				(errmsg("\"%s\": truncated %u to %u pages",
-						RelationGetRelationName(onerel),
+						vacrelstats->relname,
 						old_rel_pages, new_rel_pages),
 				 errdetail_internal("%s",
 									pg_rusage_show(&ru0))));
@@ -2712,7 +2712,7 @@ count_nondeletable_pages(Relation onerel, LVRelStats *vacrelstats)
 				{
 					ereport(elevel,
 							(errmsg("\"%s\": suspending truncate due to conflicting lock request",
-									RelationGetRelationName(onerel))));
+									vacrelstats->relname)));
 
 					vacrelstats->lock_waiter_detected = true;
 					return blkno;
-- 
2.17.0


--1SQmhf2mF2YjsYvc--





^ permalink  raw  reply  [nested|flat] 29+ messages in thread

* [PATCH v36 3/3] Avoid some calls to RelationGetRelationName
@ 2020-02-27 01:22  Justin Pryzby <[email protected]>
  0 siblings, 0 replies; 29+ messages in thread

From: Justin Pryzby @ 2020-02-27 01:22 UTC (permalink / raw)

---
 src/backend/access/heap/vacuumlazy.c | 20 ++++++++++----------
 1 file changed, 10 insertions(+), 10 deletions(-)

diff --git a/src/backend/access/heap/vacuumlazy.c b/src/backend/access/heap/vacuumlazy.c
index a996d73e48..36b92f207f 100644
--- a/src/backend/access/heap/vacuumlazy.c
+++ b/src/backend/access/heap/vacuumlazy.c
@@ -643,8 +643,8 @@ heap_vacuum_rel(Relation onerel, VacuumParams *params,
 			}
 			appendStringInfo(&buf, msgfmt,
 							 get_database_name(MyDatabaseId),
-							 get_namespace_name(RelationGetNamespace(onerel)),
-							 RelationGetRelationName(onerel),
+							 vacrelstats->relnamespace,
+							 vacrelstats->relname,
 							 vacrelstats->num_index_scans);
 			appendStringInfo(&buf, _("pages: %u removed, %u remain, %u skipped due to pins, %u skipped frozen\n"),
 							 vacrelstats->pages_removed,
@@ -815,7 +815,7 @@ lazy_scan_heap(Relation onerel, VacuumParams *params, LVRelStats *vacrelstats,
 			if (params->nworkers > 0)
 				ereport(WARNING,
 						(errmsg("disabling parallel option of vacuum on \"%s\" --- cannot vacuum temporary tables in parallel",
-								RelationGetRelationName(onerel))));
+								vacrelstats->relname)));
 		}
 		else
 			lps = begin_parallel_vacuum(RelationGetRelid(onerel), Irel,
@@ -1710,7 +1710,7 @@ lazy_scan_heap(Relation onerel, VacuumParams *params, LVRelStats *vacrelstats,
 	if (vacuumed_pages)
 		ereport(elevel,
 				(errmsg("\"%s\": removed %.0f row versions in %u pages",
-						RelationGetRelationName(onerel),
+						vacrelstats->relname,
 						tups_vacuumed, vacuumed_pages)));
 
 	/*
@@ -1739,7 +1739,7 @@ lazy_scan_heap(Relation onerel, VacuumParams *params, LVRelStats *vacrelstats,
 
 	ereport(elevel,
 			(errmsg("\"%s\": found %.0f removable, %.0f nonremovable row versions in %u out of %u pages",
-					RelationGetRelationName(onerel),
+					vacrelstats->relname,
 					tups_vacuumed, num_tuples,
 					vacrelstats->scanned_pages, nblocks),
 			 errdetail_internal("%s", buf.data)));
@@ -1871,7 +1871,7 @@ lazy_vacuum_heap(Relation onerel, LVRelStats *vacrelstats)
 
 	ereport(elevel,
 			(errmsg("\"%s\": removed %d row versions in %d pages",
-					RelationGetRelationName(onerel),
+					vacrelstats->relname,
 					tupindex, npages),
 			 errdetail_internal("%s", pg_rusage_show(&ru0))));
 
@@ -2416,7 +2416,7 @@ lazy_vacuum_index(Relation indrel, IndexBulkDeleteResult **stats,
 
 	ereport(elevel,
 			(errmsg(msg,
-					RelationGetRelationName(indrel),
+					vacrelstats->indname,
 					dead_tuples->num_tuples),
 			 errdetail_internal("%s", pg_rusage_show(&ru0))));
 
@@ -2581,7 +2581,7 @@ lazy_truncate_heap(Relation onerel, LVRelStats *vacrelstats)
 				vacrelstats->lock_waiter_detected = true;
 				ereport(elevel,
 						(errmsg("\"%s\": stopping truncate due to conflicting lock request",
-								RelationGetRelationName(onerel))));
+								vacrelstats->relname)));
 				return;
 			}
 
@@ -2647,7 +2647,7 @@ lazy_truncate_heap(Relation onerel, LVRelStats *vacrelstats)
 
 		ereport(elevel,
 				(errmsg("\"%s\": truncated %u to %u pages",
-						RelationGetRelationName(onerel),
+						vacrelstats->relname,
 						old_rel_pages, new_rel_pages),
 				 errdetail_internal("%s",
 									pg_rusage_show(&ru0))));
@@ -2712,7 +2712,7 @@ count_nondeletable_pages(Relation onerel, LVRelStats *vacrelstats)
 				{
 					ereport(elevel,
 							(errmsg("\"%s\": suspending truncate due to conflicting lock request",
-									RelationGetRelationName(onerel))));
+									vacrelstats->relname)));
 
 					vacrelstats->lock_waiter_detected = true;
 					return blkno;
-- 
2.17.0


--jKBxcB1XkHIR0Eqt--





^ permalink  raw  reply  [nested|flat] 29+ messages in thread

* [PATCH v33 3/3] Avoid some calls to RelationGetRelationName
@ 2020-02-27 01:22  Justin Pryzby <[email protected]>
  0 siblings, 0 replies; 29+ messages in thread

From: Justin Pryzby @ 2020-02-27 01:22 UTC (permalink / raw)

---
 src/backend/access/heap/vacuumlazy.c | 20 ++++++++++----------
 1 file changed, 10 insertions(+), 10 deletions(-)

diff --git a/src/backend/access/heap/vacuumlazy.c b/src/backend/access/heap/vacuumlazy.c
index f784ec2a8b..6f0c558e8a 100644
--- a/src/backend/access/heap/vacuumlazy.c
+++ b/src/backend/access/heap/vacuumlazy.c
@@ -634,8 +634,8 @@ heap_vacuum_rel(Relation onerel, VacuumParams *params,
 			}
 			appendStringInfo(&buf, msgfmt,
 							 get_database_name(MyDatabaseId),
-							 get_namespace_name(RelationGetNamespace(onerel)),
-							 RelationGetRelationName(onerel),
+							 vacrelstats->relnamespace,
+							 vacrelstats->relname,
 							 vacrelstats->num_index_scans);
 			appendStringInfo(&buf, _("pages: %u removed, %u remain, %u skipped due to pins, %u skipped frozen\n"),
 							 vacrelstats->pages_removed,
@@ -807,7 +807,7 @@ lazy_scan_heap(Relation onerel, VacuumParams *params, LVRelStats *vacrelstats,
 			if (params->nworkers > 0)
 				ereport(WARNING,
 						(errmsg("disabling parallel option of vacuum on \"%s\" --- cannot vacuum temporary tables in parallel",
-								RelationGetRelationName(onerel))));
+								vacrelstats->relname)));
 		}
 		else
 			lps = begin_parallel_vacuum(RelationGetRelid(onerel), Irel,
@@ -1702,7 +1702,7 @@ lazy_scan_heap(Relation onerel, VacuumParams *params, LVRelStats *vacrelstats,
 	if (vacuumed_pages)
 		ereport(elevel,
 				(errmsg("\"%s\": removed %.0f row versions in %u pages",
-						RelationGetRelationName(onerel),
+						vacrelstats->relname,
 						tups_vacuumed, vacuumed_pages)));
 
 	/*
@@ -1731,7 +1731,7 @@ lazy_scan_heap(Relation onerel, VacuumParams *params, LVRelStats *vacrelstats,
 
 	ereport(elevel,
 			(errmsg("\"%s\": found %.0f removable, %.0f nonremovable row versions in %u out of %u pages",
-					RelationGetRelationName(onerel),
+					vacrelstats->relname,
 					tups_vacuumed, num_tuples,
 					vacrelstats->scanned_pages, nblocks),
 			 errdetail_internal("%s", buf.data)));
@@ -1863,7 +1863,7 @@ lazy_vacuum_heap(Relation onerel, LVRelStats *vacrelstats)
 
 	ereport(elevel,
 			(errmsg("\"%s\": removed %d row versions in %d pages",
-					RelationGetRelationName(onerel),
+					vacrelstats->relname,
 					tupindex, npages),
 			 errdetail_internal("%s", pg_rusage_show(&ru0))));
 
@@ -2411,7 +2411,7 @@ lazy_vacuum_index(Relation indrel, IndexBulkDeleteResult **stats,
 
 	ereport(elevel,
 			(errmsg(msg,
-					RelationGetRelationName(indrel),
+					vacrelstats->relname,
 					dead_tuples->num_tuples),
 			 errdetail_internal("%s", pg_rusage_show(&ru0))));
 
@@ -2580,7 +2580,7 @@ lazy_truncate_heap(Relation onerel, LVRelStats *vacrelstats)
 				vacrelstats->lock_waiter_detected = true;
 				ereport(elevel,
 						(errmsg("\"%s\": stopping truncate due to conflicting lock request",
-								RelationGetRelationName(onerel))));
+								vacrelstats->relname)));
 				return;
 			}
 
@@ -2658,7 +2658,7 @@ lazy_truncate_heap(Relation onerel, LVRelStats *vacrelstats)
 
 		ereport(elevel,
 				(errmsg("\"%s\": truncated %u to %u pages",
-						RelationGetRelationName(onerel),
+						vacrelstats->relname,
 						old_rel_pages, new_rel_pages),
 				 errdetail_internal("%s",
 									pg_rusage_show(&ru0))));
@@ -2723,7 +2723,7 @@ count_nondeletable_pages(Relation onerel, LVRelStats *vacrelstats)
 				{
 					ereport(elevel,
 							(errmsg("\"%s\": suspending truncate due to conflicting lock request",
-									RelationGetRelationName(onerel))));
+									vacrelstats->relname)));
 
 					vacrelstats->lock_waiter_detected = true;
 					return blkno;
-- 
2.17.0


--E13BgyNx05feLLmH--





^ permalink  raw  reply  [nested|flat] 29+ messages in thread

* [PATCH v32 3/3] Avoid some calls to RelationGetRelationName
@ 2020-02-27 01:22  Justin Pryzby <[email protected]>
  0 siblings, 0 replies; 29+ messages in thread

From: Justin Pryzby @ 2020-02-27 01:22 UTC (permalink / raw)

---
 src/backend/access/heap/vacuumlazy.c | 20 ++++++++++----------
 1 file changed, 10 insertions(+), 10 deletions(-)

diff --git a/src/backend/access/heap/vacuumlazy.c b/src/backend/access/heap/vacuumlazy.c
index 3b4c7fe66c..652446dbf2 100644
--- a/src/backend/access/heap/vacuumlazy.c
+++ b/src/backend/access/heap/vacuumlazy.c
@@ -634,8 +634,8 @@ heap_vacuum_rel(Relation onerel, VacuumParams *params,
 			}
 			appendStringInfo(&buf, msgfmt,
 							 get_database_name(MyDatabaseId),
-							 get_namespace_name(RelationGetNamespace(onerel)),
-							 RelationGetRelationName(onerel),
+							 vacrelstats->relnamespace,
+							 vacrelstats->relname,
 							 vacrelstats->num_index_scans);
 			appendStringInfo(&buf, _("pages: %u removed, %u remain, %u skipped due to pins, %u skipped frozen\n"),
 							 vacrelstats->pages_removed,
@@ -807,7 +807,7 @@ lazy_scan_heap(Relation onerel, VacuumParams *params, LVRelStats *vacrelstats,
 			if (params->nworkers > 0)
 				ereport(WARNING,
 						(errmsg("disabling parallel option of vacuum on \"%s\" --- cannot vacuum temporary tables in parallel",
-								RelationGetRelationName(onerel))));
+								vacrelstats->relname)));
 		}
 		else
 			lps = begin_parallel_vacuum(RelationGetRelid(onerel), Irel,
@@ -1711,7 +1711,7 @@ lazy_scan_heap(Relation onerel, VacuumParams *params, LVRelStats *vacrelstats,
 	if (vacuumed_pages)
 		ereport(elevel,
 				(errmsg("\"%s\": removed %.0f row versions in %u pages",
-						RelationGetRelationName(onerel),
+						vacrelstats->relname,
 						tups_vacuumed, vacuumed_pages)));
 
 	/*
@@ -1740,7 +1740,7 @@ lazy_scan_heap(Relation onerel, VacuumParams *params, LVRelStats *vacrelstats,
 
 	ereport(elevel,
 			(errmsg("\"%s\": found %.0f removable, %.0f nonremovable row versions in %u out of %u pages",
-					RelationGetRelationName(onerel),
+					vacrelstats->relname,
 					tups_vacuumed, num_tuples,
 					vacrelstats->scanned_pages, nblocks),
 			 errdetail_internal("%s", buf.data)));
@@ -1872,7 +1872,7 @@ lazy_vacuum_heap(Relation onerel, LVRelStats *vacrelstats)
 
 	ereport(elevel,
 			(errmsg("\"%s\": removed %d row versions in %d pages",
-					RelationGetRelationName(onerel),
+					vacrelstats->relname,
 					tupindex, npages),
 			 errdetail_internal("%s", pg_rusage_show(&ru0))));
 
@@ -2420,7 +2420,7 @@ lazy_vacuum_index(Relation indrel, IndexBulkDeleteResult **stats,
 
 	ereport(elevel,
 			(errmsg(msg,
-					RelationGetRelationName(indrel),
+					vacrelstats->relname,
 					dead_tuples->num_tuples),
 			 errdetail_internal("%s", pg_rusage_show(&ru0))));
 
@@ -2589,7 +2589,7 @@ lazy_truncate_heap(Relation onerel, LVRelStats *vacrelstats)
 				vacrelstats->lock_waiter_detected = true;
 				ereport(elevel,
 						(errmsg("\"%s\": stopping truncate due to conflicting lock request",
-								RelationGetRelationName(onerel))));
+								vacrelstats->relname)));
 				return;
 			}
 
@@ -2668,7 +2668,7 @@ lazy_truncate_heap(Relation onerel, LVRelStats *vacrelstats)
 
 		ereport(elevel,
 				(errmsg("\"%s\": truncated %u to %u pages",
-						RelationGetRelationName(onerel),
+						vacrelstats->relname,
 						old_rel_pages, new_rel_pages),
 				 errdetail_internal("%s",
 									pg_rusage_show(&ru0))));
@@ -2733,7 +2733,7 @@ count_nondeletable_pages(Relation onerel, LVRelStats *vacrelstats)
 				{
 					ereport(elevel,
 							(errmsg("\"%s\": suspending truncate due to conflicting lock request",
-									RelationGetRelationName(onerel))));
+									vacrelstats->relname)));
 
 					vacrelstats->lock_waiter_detected = true;
 					return blkno;
-- 
2.17.0


--MW5yreqqjyrRcusr--





^ permalink  raw  reply  [nested|flat] 29+ messages in thread

* [PATCH v24 4/4] Avoid some calls to RelationGetRelationName
@ 2020-02-27 01:22  Justin Pryzby <[email protected]>
  0 siblings, 0 replies; 29+ messages in thread

From: Justin Pryzby @ 2020-02-27 01:22 UTC (permalink / raw)

---
 src/backend/access/heap/vacuumlazy.c | 20 ++++++++++----------
 1 file changed, 10 insertions(+), 10 deletions(-)

diff --git a/src/backend/access/heap/vacuumlazy.c b/src/backend/access/heap/vacuumlazy.c
index a77aa3ed99..7cfd19da7d 100644
--- a/src/backend/access/heap/vacuumlazy.c
+++ b/src/backend/access/heap/vacuumlazy.c
@@ -622,8 +622,8 @@ heap_vacuum_rel(Relation onerel, VacuumParams *params,
 			}
 			appendStringInfo(&buf, msgfmt,
 							 get_database_name(MyDatabaseId),
-							 get_namespace_name(RelationGetNamespace(onerel)),
-							 RelationGetRelationName(onerel),
+							 vacrelstats->relnamespace,
+							 vacrelstats->relname,
 							 vacrelstats->num_index_scans);
 			appendStringInfo(&buf, _("pages: %u removed, %u remain, %u skipped due to pins, %u skipped frozen\n"),
 							 vacrelstats->pages_removed,
@@ -795,7 +795,7 @@ lazy_scan_heap(Relation onerel, VacuumParams *params, LVRelStats *vacrelstats,
 			if (params->nworkers > 0)
 				ereport(WARNING,
 						(errmsg("disabling parallel option of vacuum on \"%s\" --- cannot vacuum temporary tables in parallel",
-								RelationGetRelationName(onerel))));
+								vacrelstats->relname)));
 		}
 		else
 			lps = begin_parallel_vacuum(RelationGetRelid(onerel), Irel,
@@ -1716,7 +1716,7 @@ lazy_scan_heap(Relation onerel, VacuumParams *params, LVRelStats *vacrelstats,
 	if (vacuumed_pages)
 		ereport(elevel,
 				(errmsg("\"%s\": removed %.0f row versions in %u pages",
-						RelationGetRelationName(onerel),
+						vacrelstats->relname,
 						tups_vacuumed, vacuumed_pages)));
 
 	/*
@@ -1745,7 +1745,7 @@ lazy_scan_heap(Relation onerel, VacuumParams *params, LVRelStats *vacrelstats,
 
 	ereport(elevel,
 			(errmsg("\"%s\": found %.0f removable, %.0f nonremovable row versions in %u out of %u pages",
-					RelationGetRelationName(onerel),
+					vacrelstats->relname,
 					tups_vacuumed, num_tuples,
 					vacrelstats->scanned_pages, nblocks),
 			 errdetail_internal("%s", buf.data)));
@@ -1870,7 +1870,7 @@ lazy_vacuum_heap(Relation onerel, LVRelStats *vacrelstats)
 
 	ereport(elevel,
 			(errmsg("\"%s\": removed %d row versions in %d pages",
-					RelationGetRelationName(onerel),
+					vacrelstats->relname,
 					tupindex, npages),
 			 errdetail_internal("%s", pg_rusage_show(&ru0))));
 }
@@ -2399,7 +2399,7 @@ lazy_vacuum_index(Relation indrel, IndexBulkDeleteResult **stats,
 
 	ereport(elevel,
 			(errmsg(msg,
-					RelationGetRelationName(indrel),
+					vacrelstats->relname,
 					dead_tuples->num_tuples),
 			 errdetail_internal("%s", pg_rusage_show(&ru0))));
 }
@@ -2548,7 +2548,7 @@ lazy_truncate_heap(Relation onerel, LVRelStats *vacrelstats)
 				vacrelstats->lock_waiter_detected = true;
 				ereport(elevel,
 						(errmsg("\"%s\": stopping truncate due to conflicting lock request",
-								RelationGetRelationName(onerel))));
+								vacrelstats->relname)));
 				return;
 			}
 
@@ -2617,7 +2617,7 @@ lazy_truncate_heap(Relation onerel, LVRelStats *vacrelstats)
 
 		ereport(elevel,
 				(errmsg("\"%s\": truncated %u to %u pages",
-						RelationGetRelationName(onerel),
+						vacrelstats->relname,
 						old_rel_pages, new_rel_pages),
 				 errdetail_internal("%s",
 									pg_rusage_show(&ru0))));
@@ -2682,7 +2682,7 @@ count_nondeletable_pages(Relation onerel, LVRelStats *vacrelstats)
 				{
 					ereport(elevel,
 							(errmsg("\"%s\": suspending truncate due to conflicting lock request",
-									RelationGetRelationName(onerel))));
+									vacrelstats->relname)));
 
 					vacrelstats->lock_waiter_detected = true;
 					return blkno;
-- 
2.17.0


--a8Wt8u1KmwUX3Y2C--





^ permalink  raw  reply  [nested|flat] 29+ messages in thread

* [PATCH v25 4/4] Avoid some calls to RelationGetRelationName
@ 2020-02-27 01:22  Justin Pryzby <[email protected]>
  0 siblings, 0 replies; 29+ messages in thread

From: Justin Pryzby @ 2020-02-27 01:22 UTC (permalink / raw)

---
 src/backend/access/heap/vacuumlazy.c | 20 ++++++++++----------
 1 file changed, 10 insertions(+), 10 deletions(-)

diff --git a/src/backend/access/heap/vacuumlazy.c b/src/backend/access/heap/vacuumlazy.c
index ed7ff5e1c4..0b6d9a59f3 100644
--- a/src/backend/access/heap/vacuumlazy.c
+++ b/src/backend/access/heap/vacuumlazy.c
@@ -622,8 +622,8 @@ heap_vacuum_rel(Relation onerel, VacuumParams *params,
 			}
 			appendStringInfo(&buf, msgfmt,
 							 get_database_name(MyDatabaseId),
-							 get_namespace_name(RelationGetNamespace(onerel)),
-							 RelationGetRelationName(onerel),
+							 vacrelstats->relnamespace,
+							 vacrelstats->relname,
 							 vacrelstats->num_index_scans);
 			appendStringInfo(&buf, _("pages: %u removed, %u remain, %u skipped due to pins, %u skipped frozen\n"),
 							 vacrelstats->pages_removed,
@@ -795,7 +795,7 @@ lazy_scan_heap(Relation onerel, VacuumParams *params, LVRelStats *vacrelstats,
 			if (params->nworkers > 0)
 				ereport(WARNING,
 						(errmsg("disabling parallel option of vacuum on \"%s\" --- cannot vacuum temporary tables in parallel",
-								RelationGetRelationName(onerel))));
+								vacrelstats->relname)));
 		}
 		else
 			lps = begin_parallel_vacuum(RelationGetRelid(onerel), Irel,
@@ -1718,7 +1718,7 @@ lazy_scan_heap(Relation onerel, VacuumParams *params, LVRelStats *vacrelstats,
 	if (vacuumed_pages)
 		ereport(elevel,
 				(errmsg("\"%s\": removed %.0f row versions in %u pages",
-						RelationGetRelationName(onerel),
+						vacrelstats->relname,
 						tups_vacuumed, vacuumed_pages)));
 
 	/*
@@ -1747,7 +1747,7 @@ lazy_scan_heap(Relation onerel, VacuumParams *params, LVRelStats *vacrelstats,
 
 	ereport(elevel,
 			(errmsg("\"%s\": found %.0f removable, %.0f nonremovable row versions in %u out of %u pages",
-					RelationGetRelationName(onerel),
+					vacrelstats->relname,
 					tups_vacuumed, num_tuples,
 					vacrelstats->scanned_pages, nblocks),
 			 errdetail_internal("%s", buf.data)));
@@ -1877,7 +1877,7 @@ lazy_vacuum_heap(Relation onerel, LVRelStats *vacrelstats)
 
 	ereport(elevel,
 			(errmsg("\"%s\": removed %d row versions in %d pages",
-					RelationGetRelationName(onerel),
+					vacrelstats->relname,
 					tupindex, npages),
 			 errdetail_internal("%s", pg_rusage_show(&ru0))));
 }
@@ -2406,7 +2406,7 @@ lazy_vacuum_index(Relation indrel, IndexBulkDeleteResult **stats,
 
 	ereport(elevel,
 			(errmsg(msg,
-					RelationGetRelationName(indrel),
+					vacrelstats->relname,
 					dead_tuples->num_tuples),
 			 errdetail_internal("%s", pg_rusage_show(&ru0))));
 }
@@ -2555,7 +2555,7 @@ lazy_truncate_heap(Relation onerel, LVRelStats *vacrelstats)
 				vacrelstats->lock_waiter_detected = true;
 				ereport(elevel,
 						(errmsg("\"%s\": stopping truncate due to conflicting lock request",
-								RelationGetRelationName(onerel))));
+								vacrelstats->relname)));
 				return;
 			}
 
@@ -2624,7 +2624,7 @@ lazy_truncate_heap(Relation onerel, LVRelStats *vacrelstats)
 
 		ereport(elevel,
 				(errmsg("\"%s\": truncated %u to %u pages",
-						RelationGetRelationName(onerel),
+						vacrelstats->relname,
 						old_rel_pages, new_rel_pages),
 				 errdetail_internal("%s",
 									pg_rusage_show(&ru0))));
@@ -2689,7 +2689,7 @@ count_nondeletable_pages(Relation onerel, LVRelStats *vacrelstats)
 				{
 					ereport(elevel,
 							(errmsg("\"%s\": suspending truncate due to conflicting lock request",
-									RelationGetRelationName(onerel))));
+									vacrelstats->relname)));
 
 					vacrelstats->lock_waiter_detected = true;
 					return blkno;
-- 
2.17.0


--EcLUEBHJhOmOUQ0C--





^ permalink  raw  reply  [nested|flat] 29+ messages in thread

* [PATCH v27 5/5] Avoid some calls to RelationGetRelationName
@ 2020-02-27 01:22  Justin Pryzby <[email protected]>
  0 siblings, 0 replies; 29+ messages in thread

From: Justin Pryzby @ 2020-02-27 01:22 UTC (permalink / raw)

---
 src/backend/access/heap/vacuumlazy.c | 20 ++++++++++----------
 1 file changed, 10 insertions(+), 10 deletions(-)

diff --git a/src/backend/access/heap/vacuumlazy.c b/src/backend/access/heap/vacuumlazy.c
index 73aced36d2..6f8987ad81 100644
--- a/src/backend/access/heap/vacuumlazy.c
+++ b/src/backend/access/heap/vacuumlazy.c
@@ -623,8 +623,8 @@ heap_vacuum_rel(Relation onerel, VacuumParams *params,
 			}
 			appendStringInfo(&buf, msgfmt,
 							 get_database_name(MyDatabaseId),
-							 get_namespace_name(RelationGetNamespace(onerel)),
-							 RelationGetRelationName(onerel),
+							 vacrelstats->relnamespace,
+							 vacrelstats->relname,
 							 vacrelstats->num_index_scans);
 			appendStringInfo(&buf, _("pages: %u removed, %u remain, %u skipped due to pins, %u skipped frozen\n"),
 							 vacrelstats->pages_removed,
@@ -797,7 +797,7 @@ lazy_scan_heap(Relation onerel, VacuumParams *params, LVRelStats *vacrelstats,
 			if (params->nworkers > 0)
 				ereport(WARNING,
 						(errmsg("disabling parallel option of vacuum on \"%s\" --- cannot vacuum temporary tables in parallel",
-								RelationGetRelationName(onerel))));
+								vacrelstats->relname)));
 		}
 		else
 			lps = begin_parallel_vacuum(RelationGetRelid(onerel), Irel,
@@ -1719,7 +1719,7 @@ lazy_scan_heap(Relation onerel, VacuumParams *params, LVRelStats *vacrelstats,
 	if (vacuumed_pages)
 		ereport(elevel,
 				(errmsg("\"%s\": removed %.0f row versions in %u pages",
-						RelationGetRelationName(onerel),
+						vacrelstats->relname,
 						tups_vacuumed, vacuumed_pages)));
 
 	/*
@@ -1748,7 +1748,7 @@ lazy_scan_heap(Relation onerel, VacuumParams *params, LVRelStats *vacrelstats,
 
 	ereport(elevel,
 			(errmsg("\"%s\": found %.0f removable, %.0f nonremovable row versions in %u out of %u pages",
-					RelationGetRelationName(onerel),
+					vacrelstats->relname,
 					tups_vacuumed, num_tuples,
 					vacrelstats->scanned_pages, nblocks),
 			 errdetail_internal("%s", buf.data)));
@@ -1879,7 +1879,7 @@ lazy_vacuum_heap(Relation onerel, LVRelStats *vacrelstats)
 
 	ereport(elevel,
 			(errmsg("\"%s\": removed %d row versions in %d pages",
-					RelationGetRelationName(onerel),
+					vacrelstats->relname,
 					tupindex, npages),
 			 errdetail_internal("%s", pg_rusage_show(&ru0))));
 
@@ -2424,7 +2424,7 @@ lazy_vacuum_index(Relation indrel, IndexBulkDeleteResult **stats,
 
 	ereport(elevel,
 			(errmsg(msg,
-					RelationGetRelationName(indrel),
+					vacrelstats->relname,
 					dead_tuples->num_tuples),
 			 errdetail_internal("%s", pg_rusage_show(&ru0))));
 
@@ -2590,7 +2590,7 @@ lazy_truncate_heap(Relation onerel, LVRelStats *vacrelstats)
 				vacrelstats->lock_waiter_detected = true;
 				ereport(elevel,
 						(errmsg("\"%s\": stopping truncate due to conflicting lock request",
-								RelationGetRelationName(onerel))));
+								vacrelstats->relname)));
 				return;
 			}
 
@@ -2659,7 +2659,7 @@ lazy_truncate_heap(Relation onerel, LVRelStats *vacrelstats)
 
 		ereport(elevel,
 				(errmsg("\"%s\": truncated %u to %u pages",
-						RelationGetRelationName(onerel),
+						vacrelstats->relname,
 						old_rel_pages, new_rel_pages),
 				 errdetail_internal("%s",
 									pg_rusage_show(&ru0))));
@@ -2724,7 +2724,7 @@ count_nondeletable_pages(Relation onerel, LVRelStats *vacrelstats)
 				{
 					ereport(elevel,
 							(errmsg("\"%s\": suspending truncate due to conflicting lock request",
-									RelationGetRelationName(onerel))));
+									vacrelstats->relname)));
 
 					vacrelstats->lock_waiter_detected = true;
 					return blkno;
-- 
2.17.0


--gPQW1Pk7T/0rhUBV--





^ permalink  raw  reply  [nested|flat] 29+ messages in thread

* [PATCH v29 3/3] Avoid some calls to RelationGetRelationName
@ 2020-02-27 01:22  Justin Pryzby <[email protected]>
  0 siblings, 0 replies; 29+ messages in thread

From: Justin Pryzby @ 2020-02-27 01:22 UTC (permalink / raw)

---
 src/backend/access/heap/vacuumlazy.c | 20 ++++++++++----------
 1 file changed, 10 insertions(+), 10 deletions(-)

diff --git a/src/backend/access/heap/vacuumlazy.c b/src/backend/access/heap/vacuumlazy.c
index c6c659142f..a26a57d8d1 100644
--- a/src/backend/access/heap/vacuumlazy.c
+++ b/src/backend/access/heap/vacuumlazy.c
@@ -623,8 +623,8 @@ heap_vacuum_rel(Relation onerel, VacuumParams *params,
 			}
 			appendStringInfo(&buf, msgfmt,
 							 get_database_name(MyDatabaseId),
-							 get_namespace_name(RelationGetNamespace(onerel)),
-							 RelationGetRelationName(onerel),
+							 vacrelstats->relnamespace,
+							 vacrelstats->relname,
 							 vacrelstats->num_index_scans);
 			appendStringInfo(&buf, _("pages: %u removed, %u remain, %u skipped due to pins, %u skipped frozen\n"),
 							 vacrelstats->pages_removed,
@@ -796,7 +796,7 @@ lazy_scan_heap(Relation onerel, VacuumParams *params, LVRelStats *vacrelstats,
 			if (params->nworkers > 0)
 				ereport(WARNING,
 						(errmsg("disabling parallel option of vacuum on \"%s\" --- cannot vacuum temporary tables in parallel",
-								RelationGetRelationName(onerel))));
+								vacrelstats->relname)));
 		}
 		else
 			lps = begin_parallel_vacuum(RelationGetRelid(onerel), Irel,
@@ -1700,7 +1700,7 @@ lazy_scan_heap(Relation onerel, VacuumParams *params, LVRelStats *vacrelstats,
 	if (vacuumed_pages)
 		ereport(elevel,
 				(errmsg("\"%s\": removed %.0f row versions in %u pages",
-						RelationGetRelationName(onerel),
+						vacrelstats->relname,
 						tups_vacuumed, vacuumed_pages)));
 
 	/*
@@ -1729,7 +1729,7 @@ lazy_scan_heap(Relation onerel, VacuumParams *params, LVRelStats *vacrelstats,
 
 	ereport(elevel,
 			(errmsg("\"%s\": found %.0f removable, %.0f nonremovable row versions in %u out of %u pages",
-					RelationGetRelationName(onerel),
+					vacrelstats->relname,
 					tups_vacuumed, num_tuples,
 					vacrelstats->scanned_pages, nblocks),
 			 errdetail_internal("%s", buf.data)));
@@ -1861,7 +1861,7 @@ lazy_vacuum_heap(Relation onerel, LVRelStats *vacrelstats)
 
 	ereport(elevel,
 			(errmsg("\"%s\": removed %d row versions in %d pages",
-					RelationGetRelationName(onerel),
+					vacrelstats->relname,
 					tupindex, npages),
 			 errdetail_internal("%s", pg_rusage_show(&ru0))));
 
@@ -2409,7 +2409,7 @@ lazy_vacuum_index(Relation indrel, IndexBulkDeleteResult **stats,
 
 	ereport(elevel,
 			(errmsg(msg,
-					RelationGetRelationName(indrel),
+					vacrelstats->relname,
 					dead_tuples->num_tuples),
 			 errdetail_internal("%s", pg_rusage_show(&ru0))));
 
@@ -2578,7 +2578,7 @@ lazy_truncate_heap(Relation onerel, LVRelStats *vacrelstats)
 				vacrelstats->lock_waiter_detected = true;
 				ereport(elevel,
 						(errmsg("\"%s\": stopping truncate due to conflicting lock request",
-								RelationGetRelationName(onerel))));
+								vacrelstats->relname)));
 				return;
 			}
 
@@ -2656,7 +2656,7 @@ lazy_truncate_heap(Relation onerel, LVRelStats *vacrelstats)
 
 		ereport(elevel,
 				(errmsg("\"%s\": truncated %u to %u pages",
-						RelationGetRelationName(onerel),
+						vacrelstats->relname,
 						old_rel_pages, new_rel_pages),
 				 errdetail_internal("%s",
 									pg_rusage_show(&ru0))));
@@ -2721,7 +2721,7 @@ count_nondeletable_pages(Relation onerel, LVRelStats *vacrelstats)
 				{
 					ereport(elevel,
 							(errmsg("\"%s\": suspending truncate due to conflicting lock request",
-									RelationGetRelationName(onerel))));
+									vacrelstats->relname)));
 
 					vacrelstats->lock_waiter_detected = true;
 					return blkno;
-- 
2.17.0


--3C3ZMpwu25Mtx3MN--





^ permalink  raw  reply  [nested|flat] 29+ messages in thread

* Re: Add PQsendSyncMessage() to libpq
@ 2024-01-18 23:11  Anton Kirilov <[email protected]>
  0 siblings, 0 replies; 29+ messages in thread

From: Anton Kirilov @ 2024-01-18 23:11 UTC (permalink / raw)
  To: Michael Paquier <[email protected]>; +Cc: Alvaro Herrera <[email protected]>; Anthonin Bonnefoy <[email protected]>; Jelte Fennema-Nio <[email protected]>; Robert Haas <[email protected]>; pgsql-hackers

Hello,

On 17/01/2024 07:30, Michael Paquier wrote:
> Thanks for double-checking.  Done.
Thank you very much for taking care of my patch!

One thing that I noticed is that the TODO list on the PostgreSQL Wiki 
still contained an entry ( https://wiki.postgresql.org/wiki/Todo#libpq ) 
about adding pipelining support to libpq - perhaps it ought to be updated?

Best wishes,
Anton Kirilov





^ permalink  raw  reply  [nested|flat] 29+ messages in thread

* RE: Why is parula failing?
@ 2024-04-02 04:27  Tharakan, Robins <[email protected]>
  0 siblings, 1 reply; 29+ messages in thread

From: Tharakan, Robins @ 2024-04-02 04:27 UTC (permalink / raw)
  To: Tom Lane <[email protected]>; David Rowley <[email protected]>; +Cc: [email protected] <[email protected]>

> I've now switched to GCC v13.2 and triggered a run. Let's see if the tests stabilize now.

So although HEAD ran fine, but I saw multiple failures (v12, v13, v16) all of which passed on subsequent-tries,
of which some were even"signal 6: Aborted".

FWIW, I compiled gcc v13.2 (default options) from source which IIUC shouldn't be to blame. Two other possible
reasons could be that the buildfarm doesn't have an aarch64 + gcc 13.2 combination (quick check I couldn't
see any), or, that this hardware is flaky.

Either way, this instance is a throw-away so let me know if this isn't helping. I'll swap it out in case there's not
much benefit to be had.

Also, it'd be great if someone could point me to a way to update the "Compiler" section in "System Detail" on
the buildfarm page (it wrongly shows GCC as v7.3.1).

-
thanks
robins






^ permalink  raw  reply  [nested|flat] 29+ messages in thread

* Re: Why is parula failing?
@ 2024-04-02 04:31  Tom Lane <[email protected]>
  parent: Tharakan, Robins <[email protected]>
  0 siblings, 1 reply; 29+ messages in thread

From: Tom Lane @ 2024-04-02 04:31 UTC (permalink / raw)
  To: Tharakan, Robins <[email protected]>; +Cc: David Rowley <[email protected]>; [email protected] <[email protected]>

"Tharakan, Robins" <[email protected]> writes:
>> I've now switched to GCC v13.2 and triggered a run. Let's see if the tests stabilize now.

> So although HEAD ran fine, but I saw multiple failures (v12, v13, v16) all of which passed on subsequent-tries,
> of which some were even"signal 6: Aborted".

Ugh...

> Also, it'd be great if someone could point me to a way to update the "Compiler" section in "System Detail" on
> the buildfarm page (it wrongly shows GCC as v7.3.1).

The update_personality.pl script in the buildfarm client distro
is what to use to adjust OS version or compiler version data.

			regards, tom lane






^ permalink  raw  reply  [nested|flat] 29+ messages in thread

* Re: Why is parula failing?
@ 2024-04-08 11:55  Robins Tharakan <[email protected]>
  parent: Tom Lane <[email protected]>
  0 siblings, 2 replies; 29+ messages in thread

From: Robins Tharakan @ 2024-04-08 11:55 UTC (permalink / raw)
  To: Tom Lane <[email protected]>; +Cc: Tharakan, Robins <[email protected]>; David Rowley <[email protected]>; [email protected] <[email protected]>

On Tue, 2 Apr 2024 at 15:01, Tom Lane <[email protected]> wrote:
> "Tharakan, Robins" <[email protected]> writes:
> > So although HEAD ran fine, but I saw multiple failures (v12, v13, v16)
all of which passed on subsequent-tries,
> > of which some were even"signal 6: Aborted".
>
> Ugh...


parula didn't send any reports to buildfarm for the past 44 hours. Logged in
to see that postgres was stuck on pg_sleep(), which was quite odd! I
captured
the backtrace and triggered another run on HEAD, which came out
okay.

I'll keep an eye on this instance more often for the next few days.
(Let me know if I could capture more if a run gets stuck again)


(gdb) bt
#0  0x0000ffff952ae954 in epoll_pwait () from /lib64/libc.so.6
#1  0x000000000083e9c8 in WaitEventSetWaitBlock (nevents=1,
occurred_events=<optimized out>, cur_timeout=297992, set=0x2816dac0) at
latch.c:1570
#2  WaitEventSetWait (set=0x2816dac0, timeout=timeout@entry=600000,
occurred_events=occurred_events@entry=0xffffc395ed28, nevents=nevents@entry=1,
wait_event_info=wait_event_info@entry=150994946) at latch.c:1516
#3  0x000000000083ed84 in WaitLatch (latch=<optimized out>,
wakeEvents=wakeEvents@entry=41, timeout=600000,
wait_event_info=wait_event_info@entry=150994946) at latch.c:538
#4  0x0000000000907404 in pg_sleep (fcinfo=<optimized out>) at misc.c:406
#5  0x0000000000696b10 in ExecInterpExpr (state=0x28384040,
econtext=0x28383e38, isnull=<optimized out>) at execExprInterp.c:764
#6  0x00000000006ceef8 in ExecEvalExprSwitchContext (isNull=0xffffc395ee9f,
econtext=0x28383e38, state=<optimized out>) at
../../../src/include/executor/executor.h:356
#7  ExecProject (projInfo=<optimized out>) at
../../../src/include/executor/executor.h:390
#8  ExecResult (pstate=<optimized out>) at nodeResult.c:135
#9  0x00000000006b7aec in ExecProcNode (node=0x28383d28) at
../../../src/include/executor/executor.h:274
#10 gather_getnext (gatherstate=0x28383b38) at nodeGather.c:287
#11 ExecGather (pstate=0x28383b38) at nodeGather.c:222
#12 0x000000000069aa4c in ExecProcNode (node=0x28383b38) at
../../../src/include/executor/executor.h:274
#13 ExecutePlan (execute_once=<optimized out>, dest=0x2831ffb0,
direction=<optimized out>, numberTuples=0, sendTuples=<optimized out>,
operation=CMD_SELECT, use_parallel_mode=<optimized out>,
planstate=0x28383b38, estate=0x28383910) at execMain.c:1646
#14 standard_ExecutorRun (queryDesc=0x283239c0, direction=<optimized out>,
count=0, execute_once=<optimized out>) at execMain.c:363
#15 0x000000000086d454 in PortalRunSelect (portal=portal@entry=0x281f0fb0,
forward=forward@entry=true, count=0, count@entry=9223372036854775807,
dest=dest@entry=0x2831ffb0) at pquery.c:924
#16 0x000000000086ec70 in PortalRun (portal=portal@entry=0x281f0fb0,
count=count@entry=9223372036854775807, isTopLevel=isTopLevel@entry=true,
run_once=run_once@entry=true, dest=dest@entry=0x2831ffb0,
altdest=altdest@entry=0x2831ffb0, qc=qc@entry=0xffffc395f250) at
pquery.c:768
#17 0x000000000086a944 in exec_simple_query
(query_string=query_string@entry=0x28171c90
"SELECT pg_sleep(0.1);") at postgres.c:1274
#18 0x000000000086b480 in PostgresMain (dbname=<optimized out>,
username=<optimized out>) at postgres.c:4680
#19 0x0000000000866a0c in BackendMain (startup_data=<optimized out>,
startup_data_len=<optimized out>) at backend_startup.c:101
#20 0x00000000007c1738 in postmaster_child_launch
(child_type=child_type@entry=B_BACKEND,
startup_data=startup_data@entry=0xffffc395f718
"", startup_data_len=startup_data_len@entry=4,
client_sock=client_sock@entry=0xffffc395f720)
at launch_backend.c:265
#21 0x00000000007c5120 in BackendStartup (client_sock=0xffffc395f720) at
postmaster.c:3593
#22 ServerLoop () at postmaster.c:1674
#23 0x00000000007c6dc8 in PostmasterMain (argc=argc@entry=8,
argv=argv@entry=0x2816d320)
at postmaster.c:1372
#24 0x0000000000496bb8 in main (argc=8, argv=0x2816d320) at main.c:197


>
> The update_personality.pl script in the buildfarm client distro
> is what to use to adjust OS version or compiler version data.
>
Thanks. Fixed that.

-
robins


^ permalink  raw  reply  [nested|flat] 29+ messages in thread

* Re: Why is parula failing?
@ 2024-04-09 03:48  David Rowley <[email protected]>
  parent: Robins Tharakan <[email protected]>
  1 sibling, 2 replies; 29+ messages in thread

From: David Rowley @ 2024-04-09 03:48 UTC (permalink / raw)
  To: Robins Tharakan <[email protected]>; +Cc: Tom Lane <[email protected]>; Tharakan, Robins <[email protected]>; [email protected] <[email protected]>

On Mon, 8 Apr 2024 at 23:56, Robins Tharakan <[email protected]> wrote:
> #3  0x000000000083ed84 in WaitLatch (latch=<optimized out>, wakeEvents=wakeEvents@entry=41, timeout=600000, wait_event_info=wait_event_info@entry=150994946) at latch.c:538
> #4  0x0000000000907404 in pg_sleep (fcinfo=<optimized out>) at misc.c:406

> #17 0x000000000086a944 in exec_simple_query (query_string=query_string@entry=0x28171c90 "SELECT pg_sleep(0.1);") at postgres.c:1274

I have no idea why WaitLatch has timeout=600000.  That should be no
higher than timeout=100 for "SELECT pg_sleep(0.1);".  I have no
theories aside from a failing RAM module, cosmic ray or a well-timed
clock change between the first call to gettimeofday() in pg_sleep()
and the next one.

I know this animal is running debug_parallel_query = regress, so that
0.1 Const did have to get serialized and copied to the worker, so
there's another opportunity for the sleep duration to be stomped on,
but that seems pretty unlikely.

I can't think of a reason why the erroneous  reltuples=48 would be
consistent over 2 failing runs if it were failing RAM or a cosmic ray.

Still no partition_prune failures on master since the compiler version
change.  There has been one [1] in REL_16_STABLE. I'm thinking it
might be worth backpatching the partition_prune debug to REL_16_STABLE
to see if we can learn anything new from it.

David

[1] https://buildfarm.postgresql.org/cgi-bin/show_log.pl?nm=parula&dt=2024-04-08%2002%3A12%3A02






^ permalink  raw  reply  [nested|flat] 29+ messages in thread

* Re: Why is parula failing?
@ 2024-04-10 00:54  David Rowley <[email protected]>
  parent: David Rowley <[email protected]>
  1 sibling, 2 replies; 29+ messages in thread

From: David Rowley @ 2024-04-10 00:54 UTC (permalink / raw)
  To: Robins Tharakan <[email protected]>; +Cc: Tom Lane <[email protected]>; Tharakan, Robins <[email protected]>; [email protected] <[email protected]>

On Tue, 9 Apr 2024 at 15:48, David Rowley <[email protected]> wrote:
> Still no partition_prune failures on master since the compiler version
> change.  There has been one [1] in REL_16_STABLE. I'm thinking it
> might be worth backpatching the partition_prune debug to REL_16_STABLE
> to see if we can learn anything new from it.

Master failed today for the first time since the compiler upgrade.
Again reltuples == 48.

https://buildfarm.postgresql.org/cgi-bin/show_log.pl?nm=parula&dt=2024-04-10%2000%3A27%3A02

David






^ permalink  raw  reply  [nested|flat] 29+ messages in thread

* Re: Why is parula failing?
@ 2024-04-10 01:13  Robins Tharakan <[email protected]>
  parent: David Rowley <[email protected]>
  1 sibling, 0 replies; 29+ messages in thread

From: Robins Tharakan @ 2024-04-10 01:13 UTC (permalink / raw)
  To: David Rowley <[email protected]>; +Cc: Tom Lane <[email protected]>; Tharakan, Robins <[email protected]>; [email protected] <[email protected]>

On Wed, 10 Apr 2024 at 10:24, David Rowley <[email protected]> wrote:
> Master failed today for the first time since the compiler upgrade.
> Again reltuples == 48.

From the buildfarm members page, parula seems to be the only aarch64 + gcc
13.2
combination today, and then I suspect whether this is about gcc v13.2
maturity on aarch64?

I'll try to upgrade one of the other aarch64s I have (massasauga or
snakefly) and
see if this is more about gcc 13.2 maturity on this architecture.
-
robins


^ permalink  raw  reply  [nested|flat] 29+ messages in thread

* Re: Why is parula failing?
@ 2024-04-13 13:02  Robins Tharakan <[email protected]>
  parent: David Rowley <[email protected]>
  1 sibling, 1 reply; 29+ messages in thread

From: Robins Tharakan @ 2024-04-13 13:02 UTC (permalink / raw)
  To: David Rowley <[email protected]>; +Cc: Tom Lane <[email protected]>; Tharakan, Robins <[email protected]>; [email protected] <[email protected]>

On Wed, 10 Apr 2024 at 10:24, David Rowley <[email protected]> wrote:
>
> Master failed today for the first time since the compiler upgrade.
> Again reltuples == 48.

Here's what I can add over the past few days:
- Almost all failures are either reltuples=48 or SIGABRTs
- Almost all SIGABRTs are DDLs - CREATE INDEX / CREATE AGGREGATEs / CTAS
  - A little too coincidental? Recent crashes have stack-trace if
interested.

Barring the initial failures (during move to gcc 13.2), in the past week:
- v15 somehow hasn't had a failure yet
- v14 / v16 have got only 1 failure each
- but v12 / v13 are lit up - failed multiple times.

-
robins


^ permalink  raw  reply  [nested|flat] 29+ messages in thread

* Re: Why is parula failing?
@ 2024-04-13 13:31  Robins Tharakan <[email protected]>
  parent: Robins Tharakan <[email protected]>
  1 sibling, 1 reply; 29+ messages in thread

From: Robins Tharakan @ 2024-04-13 13:31 UTC (permalink / raw)
  To: Tharakan, Robins <[email protected]>; +Cc: Tom Lane <[email protected]>; David Rowley <[email protected]>; [email protected] <[email protected]>

On Mon, 8 Apr 2024 at 21:25, Robins Tharakan <[email protected]> wrote:
>
>
> I'll keep an eye on this instance more often for the next few days.
> (Let me know if I could capture more if a run gets stuck again)


HEAD is stuck again on pg_sleep(), no CPU for the past hour or so.
Stack trace seems to be similar to last time.


$ pstack 24930
#0  0x0000ffffb8280954 in epoll_pwait () from /lib64/libc.so.6
#1  0x0000000000843408 in WaitEventSetWaitBlock (nevents=1,
occurred_events=<optimized out>, cur_timeout=600000, set=0x3b38dac0) at
latch.c:1570
#2  WaitEventSetWait (set=0x3b38dac0, timeout=timeout@entry=600000,
occurred_events=occurred_events@entry=0xfffffd1d66c8, nevents=nevents@entry=1,
wait_event_info=wait_event_info@entry=150994946) at latch.c:1516
#3  0x00000000008437c4 in WaitLatch (latch=<optimized out>,
wakeEvents=wakeEvents@entry=41, timeout=600000,
wait_event_info=wait_event_info@entry=150994946) at latch.c:538
#4  0x000000000090c384 in pg_sleep (fcinfo=<optimized out>) at misc.c:406
#5  0x0000000000699350 in ExecInterpExpr (state=0x3b5a41a0,
econtext=0x3b5a3f98, isnull=<optimized out>) at execExprInterp.c:764
#6  0x00000000006d1668 in ExecEvalExprSwitchContext (isNull=0xfffffd1d683f,
econtext=0x3b5a3f98, state=<optimized out>) at
../../../src/include/executor/executor.h:356
#7  ExecProject (projInfo=<optimized out>) at
../../../src/include/executor/executor.h:390
#8  ExecResult (pstate=<optimized out>) at nodeResult.c:135
#9  0x00000000006ba26c in ExecProcNode (node=0x3b5a3e88) at
../../../src/include/executor/executor.h:274
#10 gather_getnext (gatherstate=0x3b5a3c98) at nodeGather.c:287
#11 ExecGather (pstate=0x3b5a3c98) at nodeGather.c:222
#12 0x000000000069d28c in ExecProcNode (node=0x3b5a3c98) at
../../../src/include/executor/executor.h:274
#13 ExecutePlan (execute_once=<optimized out>, dest=0x3b5ae8e0,
direction=<optimized out>, numberTuples=0, sendTuples=<optimized out>,
operation=CMD_SELECT, use_parallel_mode=<optimized out>,
planstate=0x3b5a3c98, estate=0x3b5a3a70) at execMain.c:1646
#14 standard_ExecutorRun (queryDesc=0x3b59c250, direction=<optimized out>,
count=0, execute_once=<optimized out>) at execMain.c:363
#15 0x00000000008720e4 in PortalRunSelect (portal=portal@entry=0x3b410fb0,
forward=forward@entry=true, count=0, count@entry=9223372036854775807,
dest=dest@entry=0x3b5ae8e0) at pquery.c:924
#16 0x0000000000873900 in PortalRun (portal=portal@entry=0x3b410fb0,
count=count@entry=9223372036854775807, isTopLevel=isTopLevel@entry=true,
run_once=run_once@entry=true, dest=dest@entry=0x3b5ae8e0,
altdest=altdest@entry=0x3b5ae8e0, qc=qc@entry=0xfffffd1d6bf0) at
pquery.c:768
#17 0x000000000086f5d4 in exec_simple_query
(query_string=query_string@entry=0x3b391c90
"SELECT pg_sleep(0.1);") at postgres.c:1274
#18 0x0000000000870110 in PostgresMain (dbname=<optimized out>,
username=<optimized out>) at postgres.c:4680
#19 0x000000000086b6a0 in BackendMain (startup_data=<optimized out>,
startup_data_len=<optimized out>) at backend_startup.c:105
#20 0x00000000007c6268 in postmaster_child_launch
(child_type=child_type@entry=B_BACKEND,
startup_data=startup_data@entry=0xfffffd1d70b8
"", startup_data_len=startup_data_len@entry=4,
client_sock=client_sock@entry=0xfffffd1d70c0)
at launch_backend.c:265
#21 0x00000000007c9c50 in BackendStartup (client_sock=0xfffffd1d70c0) at
postmaster.c:3593
#22 ServerLoop () at postmaster.c:1674
#23 0x00000000007cb8f8 in PostmasterMain (argc=argc@entry=8,
argv=argv@entry=0x3b38d320)
at postmaster.c:1372
#24 0x0000000000496e18 in main (argc=8, argv=0x3b38d320) at main.c:197



 CPU% MEM%   TIME+  Command
.
.
  0.0  0.0  0:00.00 │     └─ /bin/sh -c cd /opt/postgres/build-farm-14 &&
PATH=/opt/gcc/home/ec2-user/proj/gcc/target/bin/
  0.0  0.1  0:00.07 │        └─ /usr/bin/perl ./run_build.pl
--config=build-farm.conf HEAD --verbose
  0.0  0.0  0:00.00 │           └─ sh -c { cd pgsql.build/src/test/regress
&& make NO_LOCALE=1 check; echo $? > /opt/postg
  0.0  0.0  0:00.00 │              └─ make NO_LOCALE=1 check
  0.0  0.0  0:00.00 │                 └─ /bin/sh -c echo "# +++ regress
check in src/test/regress +++" && PATH="/opt/postg
  0.0  0.0  0:00.10 │                    └─
../../../src/test/regress/pg_regress --temp-instance=./tmp_check
--inputdir=.
  0.0  0.0  0:00.01 │                       ├─ psql -X -a -q -d regression
-v HIDE_TABLEAM=on -v HIDE_TOAST_COMPRESSION=on
  0.0  0.1  0:02.64 │                       └─ postgres -D
/opt/postgres/build-farm-14/buildroot/HEAD/pgsql.build/src/test
  0.0  0.2  0:00.05 │                          ├─ postgres: postgres
regression [local] SELECT
  0.0  0.0  0:00.06 │                          ├─ postgres: logical
replication launcher
  0.0  0.1  0:00.36 │                          ├─ postgres: autovacuum
launcher
  0.0  0.1  0:00.34 │                          ├─ postgres: walwriter
  0.0  0.0  0:00.32 │                          ├─ postgres: background
writer
  0.0  0.3  0:00.05 │                          └─ postgres: checkpointer

-
robins

>


^ permalink  raw  reply  [nested|flat] 29+ messages in thread

* Re: Why is parula failing?
@ 2024-04-13 14:42  Tom Lane <[email protected]>
  parent: Robins Tharakan <[email protected]>
  0 siblings, 1 reply; 29+ messages in thread

From: Tom Lane @ 2024-04-13 14:42 UTC (permalink / raw)
  To: Robins Tharakan <[email protected]>; +Cc: Tharakan, Robins <[email protected]>; David Rowley <[email protected]>; [email protected] <[email protected]>

Robins Tharakan <[email protected]> writes:
> HEAD is stuck again on pg_sleep(), no CPU for the past hour or so.
> Stack trace seems to be similar to last time.

> #3  0x00000000008437c4 in WaitLatch (latch=<optimized out>,
> wakeEvents=wakeEvents@entry=41, timeout=600000,
> wait_event_info=wait_event_info@entry=150994946) at latch.c:538
> #4  0x000000000090c384 in pg_sleep (fcinfo=<optimized out>) at misc.c:406
> ...
> #17 0x000000000086f5d4 in exec_simple_query
> (query_string=query_string@entry=0x3b391c90
> "SELECT pg_sleep(0.1);") at postgres.c:1274

If we were only supposed to sleep 0.1 seconds, how is it waiting
for 600000 ms (and, presumably, repeating that)?  The logic in
pg_sleep is pretty simple, and it's hard to think of anything except
the system clock jumping (far) backwards that would make this
happen.  Any chance of extracting the local variables from the
pg_sleep stack frame?

			regards, tom lane






^ permalink  raw  reply  [nested|flat] 29+ messages in thread

* Re: Why is parula failing?
@ 2024-04-13 18:05  Tomas Vondra <[email protected]>
  parent: David Rowley <[email protected]>
  1 sibling, 0 replies; 29+ messages in thread

From: Tomas Vondra @ 2024-04-13 18:05 UTC (permalink / raw)
  To: David Rowley <[email protected]>; Robins Tharakan <[email protected]>; +Cc: Tom Lane <[email protected]>; Tharakan, Robins <[email protected]>; [email protected] <[email protected]>



On 4/9/24 05:48, David Rowley wrote:
> On Mon, 8 Apr 2024 at 23:56, Robins Tharakan <[email protected]> wrote:
>> #3  0x000000000083ed84 in WaitLatch (latch=<optimized out>, wakeEvents=wakeEvents@entry=41, timeout=600000, wait_event_info=wait_event_info@entry=150994946) at latch.c:538
>> #4  0x0000000000907404 in pg_sleep (fcinfo=<optimized out>) at misc.c:406
> 
>> #17 0x000000000086a944 in exec_simple_query (query_string=query_string@entry=0x28171c90 "SELECT pg_sleep(0.1);") at postgres.c:1274
> 
> I have no idea why WaitLatch has timeout=600000.  That should be no
> higher than timeout=100 for "SELECT pg_sleep(0.1);".  I have no
> theories aside from a failing RAM module, cosmic ray or a well-timed
> clock change between the first call to gettimeofday() in pg_sleep()
> and the next one.
> 
> I know this animal is running debug_parallel_query = regress, so that
> 0.1 Const did have to get serialized and copied to the worker, so
> there's another opportunity for the sleep duration to be stomped on,
> but that seems pretty unlikely.
> 

AFAIK that GUC is set only for HEAD, so it would not explain the
failures on the other branches.

> I can't think of a reason why the erroneous  reltuples=48 would be
> consistent over 2 failing runs if it were failing RAM or a cosmic ray.
> 

Yeah, that seems very unlikely.


regards

-- 
Tomas Vondra
EnterpriseDB: http://www.enterprisedb.com
The Enterprise PostgreSQL Company






^ permalink  raw  reply  [nested|flat] 29+ messages in thread

* Re: Why is parula failing?
@ 2024-04-13 18:11  Tomas Vondra <[email protected]>
  parent: Robins Tharakan <[email protected]>
  0 siblings, 0 replies; 29+ messages in thread

From: Tomas Vondra @ 2024-04-13 18:11 UTC (permalink / raw)
  To: Robins Tharakan <[email protected]>; David Rowley <[email protected]>; +Cc: Tom Lane <[email protected]>; Tharakan, Robins <[email protected]>; [email protected] <[email protected]>

On 4/13/24 15:02, Robins Tharakan wrote:
> On Wed, 10 Apr 2024 at 10:24, David Rowley <[email protected]> wrote:
>>
>> Master failed today for the first time since the compiler upgrade.
>> Again reltuples == 48.
> 
> Here's what I can add over the past few days:
> - Almost all failures are either reltuples=48 or SIGABRTs
> - Almost all SIGABRTs are DDLs - CREATE INDEX / CREATE AGGREGATEs / CTAS
>   - A little too coincidental? Recent crashes have stack-trace if
> interested.
> 
> Barring the initial failures (during move to gcc 13.2), in the past week:
> - v15 somehow hasn't had a failure yet
> - v14 / v16 have got only 1 failure each
> - but v12 / v13 are lit up - failed multiple times.
> 

I happened to have an unused rpi5, so I installed Armbian aarch64 with
gcc 13.2.0, built with exactly the same configure options as parula, and
did ~300 loops of "make check" without a single failure.

So either parula has packages in a different way, or maybe it's a more
of a timing issue and rpi5 is way slower than graviton3.


regards

-- 
Tomas Vondra
EnterpriseDB: http://www.enterprisedb.com
The Enterprise PostgreSQL Company






^ permalink  raw  reply  [nested|flat] 29+ messages in thread

* Re: Why is parula failing?
@ 2024-04-15 04:09  Robins Tharakan <[email protected]>
  parent: Tom Lane <[email protected]>
  0 siblings, 2 replies; 29+ messages in thread

From: Robins Tharakan @ 2024-04-15 04:09 UTC (permalink / raw)
  To: Tom Lane <[email protected]>; Tomas Vondra <[email protected]>; +Cc: Tharakan, Robins <[email protected]>; David Rowley <[email protected]>; [email protected] <[email protected]>

On Sun, 14 Apr 2024 at 00:12, Tom Lane <[email protected]> wrote:
> If we were only supposed to sleep 0.1 seconds, how is it waiting
> for 600000 ms (and, presumably, repeating that)?  The logic in
> pg_sleep is pretty simple, and it's hard to think of anything except
> the system clock jumping (far) backwards that would make this
> happen.  Any chance of extracting the local variables from the
> pg_sleep stack frame?

- I now have 2 separate runs stuck on pg_sleep() - HEAD / REL_16_STABLE
- I'll keep them (stuck) for this week, in case there's more we can get
from them (and to see how long they take)
- Attached are 'bt full' outputs for both (b.txt - HEAD / a.txt -
REL_16_STABLE)

A few things to add:
- To reiterate, this instance has gcc v13.2 compiled without any
flags (my first time ever TBH) IIRC 'make -k check' came out okay,
so at this point I don't think I did something obviously wrong when
building gcc from git.
- I installed gcc v14.0.1 experimental on massasauga (also an aarch64
and built from git) and despite multiple runs, it seems to be doing okay
[1].
- Next week (if I'm still scratching my head - and unless someone advises
otherwise), I'll upgrade parula to gcc 14 experimental to see if this is
about
gcc maturity on graviton (for some reason). I don't expect much to come
out of it though (given Tomas testing on rpi5, but doesn't hurt)

Ref:
1.
https://buildfarm.postgresql.org/cgi-bin/show_history.pl?nm=massasauga&br=REL_12_STABLE

-
robins

[postgres@ip-172-31-18-25 ~]$ pstack 26147
#0  0x0000ffffadeda954 in epoll_pwait () from /lib64/libc.so.6
#1  0x0000000000842888 in WaitEventSetWaitBlock (nevents=1, occurred_events=<optimized out>, cur_timeout=600000, set=0x3148fac0) at latch.c:1570
#2  WaitEventSetWait (set=0x3148fac0, timeout=timeout@entry=600000, occurred_events=occurred_events@entry=0xffffd1194748, nevents=nevents@entry=1, wait_event_info=wait_event_info@entry=150994946) at latch.c:1516
#3  0x0000000000842c44 in WaitLatch (latch=<optimized out>, wakeEvents=wakeEvents@entry=41, timeout=600000, wait_event_info=wait_event_info@entry=150994946) at latch.c:538
#4  0x000000000090b7b4 in pg_sleep (fcinfo=<optimized out>) at misc.c:406
#5  0x0000000000698430 in ExecInterpExpr (state=0x316a6040, econtext=0x316a5e38, isnull=<optimized out>) at execExprInterp.c:764
#6  0x00000000006d0898 in ExecEvalExprSwitchContext (isNull=0xffffd11948bf, econtext=0x316a5e38, state=<optimized out>) at ../../../src/include/executor/executor.h:356
#7  ExecProject (projInfo=<optimized out>) at ../../../src/include/executor/executor.h:390
#8  ExecResult (pstate=<optimized out>) at nodeResult.c:135
#9  0x00000000006b92ec in ExecProcNode (node=0x316a5d28) at ../../../src/include/executor/executor.h:274
#10 gather_getnext (gatherstate=0x316a5b38) at nodeGather.c:287
#11 ExecGather (pstate=0x316a5b38) at nodeGather.c:222
#12 0x000000000069c36c in ExecProcNode (node=0x316a5b38) at ../../../src/include/executor/executor.h:274
#13 ExecutePlan (execute_once=<optimized out>, dest=0x31641e90, direction=<optimized out>, numberTuples=0, sendTuples=<optimized out>, operation=CMD_SELECT, use_parallel_mode=<optimized out>, planstate=0x316a5b38, estate=0x316a5910) at execMain.c:1646
#14 standard_ExecutorRun (queryDesc=0x316459c0, direction=<optimized out>, count=0, execute_once=<optimized out>) at execMain.c:363
#15 0x0000000000871564 in PortalRunSelect (portal=portal@entry=0x31512fb0, forward=forward@entry=true, count=0, count@entry=9223372036854775807, dest=dest@entry=0x31641e90) at pquery.c:924
#16 0x0000000000872d80 in PortalRun (portal=portal@entry=0x31512fb0, count=count@entry=9223372036854775807, isTopLevel=isTopLevel@entry=true, run_once=run_once@entry=true, dest=dest@entry=0x31641e90, altdest=altdest@entry=0x31641e90, qc=qc@entry=0xffffd1194c70) at pquery.c:768
#17 0x000000000086ea54 in exec_simple_query (query_string=query_string@entry=0x31493c90 "SELECT pg_sleep(0.1);") at postgres.c:1274
#18 0x000000000086f590 in PostgresMain (dbname=<optimized out>, username=<optimized out>) at postgres.c:4680
#19 0x000000000086ab20 in BackendMain (startup_data=<optimized out>, startup_data_len=<optimized out>) at backend_startup.c:105
#20 0x00000000007c54d8 in postmaster_child_launch (child_type=child_type@entry=B_BACKEND, startup_data=startup_data@entry=0xffffd1195138 "", startup_data_len=startup_data_len@entry=4, client_sock=client_sock@entry=0xffffd1195140) at launch_backend.c:265
#21 0x00000000007c8ec0 in BackendStartup (client_sock=0xffffd1195140) at postmaster.c:3593
#22 ServerLoop () at postmaster.c:1674
#23 0x00000000007cab68 in PostmasterMain (argc=argc@entry=8, argv=argv@entry=0x3148f320) at postmaster.c:1372
#24 0x0000000000496cb8 in main (argc=8, argv=0x3148f320) at main.c:197
[postgres@ip-172-31-18-25 ~]$


 2072 root       20   0  117M  4376  3192 S  0.0  0.0  0:00.00 │  └─ /usr/sbin/CROND -n
 2087 postgres   20   0 20988  6496  5504 S  0.0  0.0  0:00.00 │     ├─ /usr/sbin/sendmail -FCronDaemon -i -odi -oem -oi -t -f postgres
 2092 postgres   20   0 20960  6328  5336 S  0.0  0.0  0:00.00 │     │  └─ /usr/sbin/postdrop -r
 2074 postgres   20   0  111M  2660  2488 S  0.0  0.0  0:00.00 │     └─ /bin/sh -c cd /opt/postgres/build-farm-14 && PATH=/opt/gcc/home/ec2-user/proj/gcc/target/bin/:$PATH:/usr/local/bin PERL5LIB=/home/postgres/perl5/lib/perl5  ./run_build.pl --config=build-farm.conf HEAD --verbose
 2075 postgres   20   0  128M 18128  3940 S  0.0  0.1  0:00.08 │        └─ /usr/bin/perl ./run_build.pl --config=build-farm.conf HEAD --verbose
 8751 postgres   20   0  111M  2660  2480 S  0.0  0.0  0:00.00 │           └─ sh -c { cd pgsql.build/src/test/regress && make NO_LOCALE=1 check; echo $? > /opt/postgres/build-farm-14/buildroot/HEAD/parula.lastrun-logs/laststatus; } > /opt/postgres/build-farm-14/buildroot/HEAD/parula.lastrun-logs/lastcommand.log 2>&1; read st < /opt/postgres/buil
 8752 postgres   20   0  110M  2084  1712 S  0.0  0.0  0:00.00 │              └─ make NO_LOCALE=1 check
 9947 postgres   20   0  111M  2836  2640 S  0.0  0.0  0:00.00 │                 └─ /bin/sh -c echo "# +++ regress check in src/test/regress +++" && PATH="/opt/postgres/build-farm-14/buildroot/HEAD/pgsql.build/tmp_install/opt/postgres/build-farm-14/buildroot/HEAD/inst/bin:/opt/postgres/build-farm-14/buildroot/HEAD/pgsql.build/src/test/regress:$P
 9948 postgres   20   0  121M  5540  4716 S  0.0  0.0  0:00.08 │                    └─ ../../../src/test/regress/pg_regress --temp-instance=./tmp_check --inputdir=. --bindir= --temp-config=/tmp/buildfarm-RoyKTG/bfextra.conf --no-locale --port=5678 --dlpath=. --max-concurrent-tests=20 --port=5678 --schedule=./parallel_schedule
26137 postgres   20   0 15448  5636  4816 S  0.0  0.0  0:00.01 │                       ├─ psql -X -a -q -d regression -v HIDE_TABLEAM=on -v HIDE_TOAST_COMPRESSION=on
 9960 postgres   20   0  167M 20704 19564 S  0.0  0.1  0:04.08 │                       └─ postgres -D /opt/postgres/build-farm-14/buildroot/HEAD/pgsql.build/src/test/regress/tmp_check/data -F -c listen_addresses= -k /tmp/pg_regress-wqlrdh
26147 postgres   20   0  172M 41980 37516 S  0.0  0.3  0:00.06 │                          ├─ postgres: postgres regression [local] SELECT
 9966 postgres   20   0  170M  8684  7256 S  0.0  0.1  0:00.02 │                          ├─ postgres: logical replication launcher
 9965 postgres   20   0  169M  8548  7124 S  0.0  0.1  0:00.20 │                          ├─ postgres: autovacuum launcher
 9964 postgres   20   0  167M 10044  8876 S  0.0  0.1  0:00.07 │                          ├─ postgres: walwriter
 9962 postgres   20   0  167M  5388  4232 S  0.0  0.0  0:00.05 │                          ├─ postgres: background writer
 9961 postgres   20   0  168M  114M  112M S  0.0  0.7  0:00.15 │                          └─ postgres: checkpointer
 

#0  0x0000ffffadeda954 in epoll_pwait () from /lib64/libc.so.6
No symbol table info available.
#1  0x0000000000842888 in WaitEventSetWaitBlock (nevents=1, occurred_events=<optimized out>, cur_timeout=600000, set=0x3148fac0) at latch.c:1570
        returned_events = 0
        rc = <optimized out>
        cur_event = <optimized out>
        cur_epoll_event = <optimized out>
        __func__ = "WaitEventSetWaitBlock"
#2  WaitEventSetWait (set=0x3148fac0, timeout=timeout@entry=600000, occurred_events=occurred_events@entry=0xffffd1194748, nevents=nevents@entry=1, wait_event_info=wait_event_info@entry=150994946) at latch.c:1516
        rc = <optimized out>
        returned_events = 0
        start_time = <optimized out>
        cur_time = <optimized out>
        cur_timeout = 600000
#3  0x0000000000842c44 in WaitLatch (latch=<optimized out>, wakeEvents=wakeEvents@entry=41, timeout=600000, wait_event_info=wait_event_info@entry=150994946) at latch.c:538
        event = {pos = 9484124, events = 0, fd = 1713148331, user_data = 0x44f0b}
#4  0x000000000090b7b4 in pg_sleep (fcinfo=<optimized out>) at misc.c:406
        delay = <optimized out>
        delay_ms = <optimized out>
        endtime = 0
#5  0x0000000000698430 in ExecInterpExpr (state=0x316a6040, econtext=0x316a5e38, isnull=<optimized out>) at execExprInterp.c:764
        fcinfo = 0x316a6198
        args = 0x316a61b8
        nargs = <optimized out>
        d = <optimized out>
        op = <optimized out>
        resultslot = 0x316a5f58
        innerslot = 0x0
        outerslot = 0x0
        scanslot = 0x0
        dispatch_table = {0x697590 <ExecInterpExpr+2044>, 0x69728c <ExecInterpExpr+1272>, 0x697268 <ExecInterpExpr+1236>, 0x697244 <ExecInterpExpr+1200>, 0x697208 <ExecInterpExpr+1140>, 0x6978cc <ExecInterpExpr+2872>, 0x697890 <ExecInterpExpr+2812>, 0x697874 <ExecInterpExpr+2784>, 0x697858 <ExecInterpExpr+2756>, 0x69783c <ExecInterpExpr+2728>,
          0x697824 <ExecInterpExpr+2704>, 0x6977d4 <ExecInterpExpr+2624>, 0x697784 <ExecInterpExpr+2544>, 0x697734 <ExecInterpExpr+2464>, 0x6976fc <ExecInterpExpr+2408>, 0x6976b4 <ExecInterpExpr+2336>, 0x697694 <ExecInterpExpr+2304>, 0x697664 <ExecInterpExpr+2256>, 0x697620 <ExecInterpExpr+2188>, 0x6975d4 <ExecInterpExpr+2112>,
          0x6975bc <ExecInterpExpr+2088>, 0x696dd8 <ExecInterpExpr+68>, 0x696de0 <ExecInterpExpr+76>, 0x697d7c <ExecInterpExpr+4072>, 0x696e00 <ExecInterpExpr+108>, 0x696e08 <ExecInterpExpr+116>, 0x697dc0 <ExecInterpExpr+4140>, 0x697d60 <ExecInterpExpr+4044>, 0x697d1c <ExecInterpExpr+3976>, 0x697d04 <ExecInterpExpr+3952>,
          0x697ce0 <ExecInterpExpr+3916>, 0x697cbc <ExecInterpExpr+3880>, 0x697c84 <ExecInterpExpr+3824>, 0x697c68 <ExecInterpExpr+3796>, 0x697c48 <ExecInterpExpr+3764>, 0x697c34 <ExecInterpExpr+3744>, 0x697c20 <ExecInterpExpr+3724>, 0x697bfc <ExecInterpExpr+3688>, 0x697bd4 <ExecInterpExpr+3648>, 0x697bb0 <ExecInterpExpr+3612>,
          0x697b88 <ExecInterpExpr+3572>, 0x697b70 <ExecInterpExpr+3548>, 0x697b58 <ExecInterpExpr+3524>, 0x697b3c <ExecInterpExpr+3496>, 0x697b10 <ExecInterpExpr+3452>, 0x697ac8 <ExecInterpExpr+3380>, 0x697a1c <ExecInterpExpr+3208>, 0x697a08 <ExecInterpExpr+3188>, 0x6979dc <ExecInterpExpr+3144>, 0x6979ac <ExecInterpExpr+3096>,
          0x697944 <ExecInterpExpr+2992>, 0x697930 <ExecInterpExpr+2972>, 0x698990 <ExecInterpExpr+7164>, 0x69791c <ExecInterpExpr+2952>, 0x697908 <ExecInterpExpr+2932>, 0x698018 <ExecInterpExpr+4740>, 0x697fec <ExecInterpExpr+4696>, 0x697f68 <ExecInterpExpr+4564>, 0x697f24 <ExecInterpExpr+4496>, 0x697f10 <ExecInterpExpr+4476>,
          0x697ef8 <ExecInterpExpr+4452>, 0x697ee0 <ExecInterpExpr+4428>, 0x697ec8 <ExecInterpExpr+4404>, 0x697ea8 <ExecInterpExpr+4372>, 0x697e8c <ExecInterpExpr+4344>, 0x697e70 <ExecInterpExpr+4316>, 0x697e54 <ExecInterpExpr+4288>, 0x697ae4 <ExecInterpExpr+3408>, 0x697dfc <ExecInterpExpr+4200>, 0x698128 <ExecInterpExpr+5012>,
          0x697e3c <ExecInterpExpr+4264>, 0x697e28 <ExecInterpExpr+4244>, 0x697e10 <ExecInterpExpr+4220>, 0x698114 <ExecInterpExpr+4992>, 0x6980fc <ExecInterpExpr+4968>, 0x6980e8 <ExecInterpExpr+4948>, 0x6980c4 <ExecInterpExpr+4912>, 0x698098 <ExecInterpExpr+4868>, 0x698080 <ExecInterpExpr+4844>, 0x698050 <ExecInterpExpr+4796>,
          0x6981b0 <ExecInterpExpr+5148>, 0x698178 <ExecInterpExpr+5092>, 0x698160 <ExecInterpExpr+5068>, 0x69813c <ExecInterpExpr+5032>, 0x696e28 <ExecInterpExpr+148>, 0x696e34 <ExecInterpExpr+160>, 0x697548 <ExecInterpExpr+1972>, 0x697504 <ExecInterpExpr+1904>, 0x6974d8 <ExecInterpExpr+1860>, 0x697418 <ExecInterpExpr+1668>,
          0x697360 <ExecInterpExpr+1484>, 0x6972b0 <ExecInterpExpr+1308>, 0x697108 <ExecInterpExpr+884>, 0x697014 <ExecInterpExpr+640>, 0x696f00 <ExecInterpExpr+364>, 0x696fec <ExecInterpExpr+600>, 0x696ed8 <ExecInterpExpr+324>, 0x696eb0 <ExecInterpExpr+284>, 0x696e98 <ExecInterpExpr+260>, 0x698734 <ExecInterpExpr+6560>}
#6  0x00000000006d0898 in ExecEvalExprSwitchContext (isNull=0xffffd11948bf, econtext=0x316a5e38, state=<optimized out>) at ../../../src/include/executor/executor.h:356
        oldContext = 0x316a5810
#7  ExecProject (projInfo=<optimized out>) at ../../../src/include/executor/executor.h:390
        econtext = 0x316a5e38
        state = <optimized out>
        slot = 0x316a5f58
        isnull = false
#8  ExecResult (pstate=<optimized out>) at nodeResult.c:135
        node = <optimized out>
        outerTupleSlot = <optimized out>
        outerPlan = <optimized out>
        econtext = <optimized out>
#9  0x00000000006b92ec in ExecProcNode (node=0x316a5d28) at ../../../src/include/executor/executor.h:274
No locals.
#10 gather_getnext (gatherstate=0x316a5b38) at nodeGather.c:287
        estate = 0x316a5910
        outerPlan = 0x316a5d28
        outerTupleSlot = <optimized out>
        fslot = 0x316a6688
        tup = <optimized out>
#11 ExecGather (pstate=0x316a5b38) at nodeGather.c:222
        node = 0x316a5b38
        slot = <optimized out>
        econtext = 0x316a5c48
#12 0x000000000069c36c in ExecProcNode (node=0x316a5b38) at ../../../src/include/executor/executor.h:274
No locals.
#13 ExecutePlan (execute_once=<optimized out>, dest=0x31641e90, direction=<optimized out>, numberTuples=0, sendTuples=<optimized out>, operation=CMD_SELECT, use_parallel_mode=<optimized out>, planstate=0x316a5b38, estate=0x316a5910) at execMain.c:1646
        slot = <optimized out>
        current_tuple_count = 0
#14 standard_ExecutorRun (queryDesc=0x316459c0, direction=<optimized out>, count=0, execute_once=<optimized out>) at execMain.c:363
        estate = 0x316a5910
        operation = CMD_SELECT
        dest = 0x31641e90
        sendTuples = 252
        oldcontext = 0x316458c0
        __func__ = "standard_ExecutorRun"
#15 0x0000000000871564 in PortalRunSelect (portal=portal@entry=0x31512fb0, forward=forward@entry=true, count=0, count@entry=9223372036854775807, dest=dest@entry=0x31641e90) at pquery.c:924
        queryDesc = 0x316459c0
        direction = <optimized out>
        nprocessed = <optimized out>
        __func__ = "PortalRunSelect"
#16 0x0000000000872d80 in PortalRun (portal=portal@entry=0x31512fb0, count=count@entry=9223372036854775807, isTopLevel=isTopLevel@entry=true, run_once=run_once@entry=true, dest=dest@entry=0x31641e90, altdest=altdest@entry=0x31641e90, qc=qc@entry=0xffffd1194c70) at pquery.c:768
        _save_exception_stack = 0xffffd1194f28
        _save_context_stack = 0x0
        _local_sigjmp_buf = {{__jmpbuf = {1, 827404208, 826886624, 826886672, 0, 828645008, 0, 2, 14136744, 826886704, 281474189838832, 7012751731486407017, 0, 7012864883735583905, 0, 13830554455654793216, 0, 0, 0, 0, 0, 0}, __mask_was_saved = 0, __saved_mask = {__val = {14136744, 826886704, 1, 12271232, 14135296, 14136808, 281474189839232,
                10405572, 281474189839264, 4891912, 2, 827404208, 281474189839296, 8841760, 826886696, 8841696}}}}
        result = <optimized out>
        nprocessed = <optimized out>
        saveTopTransactionResourceOwner = 0x314d1e28
        saveTopTransactionContext = 0x314bb5c0
        saveActivePortal = 0x0
        saveResourceOwner = 0x314d1e28
        savePortalContext = 0x0
        saveMemoryContext = 0x314bb5c0
        __func__ = "PortalRun"
#17 0x000000000086ea54 in exec_simple_query (query_string=query_string@entry=0x31493c90 "SELECT pg_sleep(0.1);") at postgres.c:1274
        cmdtaglen = 6
        snapshot_set = <optimized out>
        per_parsetree_context = 0x0
        plantree_list = 0x31641e40
        parsetree = <error reading variable parsetree (dwarf2_find_location_expression: Corrupted DWARF expression.)>
        commandTag = <optimized out>
        qc = {commandTag = CMDTAG_UNKNOWN, nprocessed = 0}
        querytree_list = <error reading variable querytree_list (dwarf2_find_location_expression: Corrupted DWARF expression.)>
        portal = 0x31512fb0
        receiver = 0x31641e90
        format = 0
        cmdtagname = <error reading variable cmdtagname (dwarf2_find_location_expression: Corrupted DWARF expression.)>
        parsetree_item__state = {l = 0x31494a10, i = 0}
        dest = DestRemote
        oldcontext = 0x314bb5c0
        parsetree_list = 0x31494a10
        parsetree_item = 0x31494a28
        save_log_statement_stats = <optimized out>
        was_logged = true
        use_implicit_block = false
        msec_str = "\000\000\000\000\377\377\000\000\000\000\000\000\000\000\000\000`\024\327\000\000\000\000\000Q\000\000\000\000\000\000"
        __func__ = "exec_simple_query"
#18 0x000000000086f590 in PostgresMain (dbname=<optimized out>, username=<optimized out>) at postgres.c:4680
        query_string = <error reading variable query_string (dwarf2_find_location_expression: Corrupted DWARF expression.)>
        firstchar = <optimized out>
        input_message = {data = 0x31493c90 "SELECT pg_sleep(0.1);", len = 22, maxlen = 1024, cursor = 22}
        local_sigjmp_buf = {{__jmpbuf = {14135296, 14135296, 8833856, 1, 281474189841896, 11850784, 826883984, 13979648, 0, 14080304, 281474189839520, 7012751731486456521, 15680, 7012864883735583169, 4631952216750555136, 0, 0, 0, 0, 0, 0, 0}, __mask_was_saved = 1, __saved_mask = {__val = {4194304, 14127104, 14135296, 24, 826864816, 10405400,
                281474189840416, 8724296, 281474189840480, 8825600, 281474189840704, 4, 281474189840696, 1, 281474189841896, 1}}}}
        send_ready_for_query = false
        idle_in_transaction_timeout_enabled = false
        idle_session_timeout_enabled = false
        __func__ = "PostgresMain"
#19 0x000000000086ab20 in BackendMain (startup_data=<optimized out>, startup_data_len=<optimized out>) at backend_startup.c:105
        bsdata = <optimized out>
#20 0x00000000007c54d8 in postmaster_child_launch (child_type=child_type@entry=B_BACKEND, startup_data=startup_data@entry=0xffffd1195138 "", startup_data_len=startup_data_len@entry=4, client_sock=client_sock@entry=0xffffd1195140) at launch_backend.c:265
        pid = <optimized out>
#21 0x00000000007c8ec0 in BackendStartup (client_sock=0xffffd1195140) at postmaster.c:3593
        bn = 0x314cafc8
        pid = <optimized out>
        startup_data = {canAcceptConnections = CAC_OK}
        __func__ = "BackendStartup"
#22 ServerLoop () at postmaster.c:1674
        s = {sock = 9, raddr = {addr = {ss_family = 1,
              __ss_padding = "\000\000\000\000\000\000pEI1\000\000\000\000\250Q\031\321\377\377\000\000\262Q\031\321\377\377\000\000\000\340\367\255\377\377\000\000\000\367`\256\377\377\000\000 \000\000\000\000\000\000\000\260Q\031\321\377\377\000\000\000\000\000\000\000\000\000\000\060R\031\321\377\377\000\000(R\031\321\377\377\000\000(\363K1\000\000\000\000i-L1", '\000' <repeats 13 times>, "f\023\243hh\223\231", __ss_align = 281474189840960}, salen = 2}}
        i = 0
        now = <optimized out>
        last_lockfile_recheck_time = 1713117687
        last_touch_time = 1713117687
        events = {{pos = 1, events = 2, fd = 7, user_data = 0x0}, {pos = 1, events = 2, fd = 7, user_data = 0x0}, {pos = 32768, events = 0, fd = 8, user_data = 0x1}, {pos = 10739224, events = 0, fd = -786868688, user_data = 0x400}, {pos = -786868496, events = 65535, fd = -1377151316, user_data = 0xffffadf7e000 <argp_default_argp+16>}, {
            pos = 8, events = 0, fd = -786868632, user_data = 0x0}, {pos = -786868384, events = 65535, fd = 66305, user_data = 0xb808831}, {pos = 16832, events = 2, fd = 1001, user_data = 0x0}, {pos = 0, events = 0, fd = 6, user_data = 0x1000}, {pos = 0, events = 0, fd = -786868368, user_data = 0xffffade7ca0c <malloc+156>}, {pos = -786868352,
            events = 65535, fd = -1377318388, user_data = 0xffffadf7fa88 <main_arena>}, {pos = 4096, events = 0, fd = -1369376944, user_data = 0xffffae60f700}, {pos = 80, events = 0, fd = 827061624, user_data = 0x0}, {pos = 1, events = 0, fd = 0, user_data = 0xb20310}, {pos = -1377763712, events = 65535, fd = 1867, user_data = 0x1}, {
            pos = -1377818740, events = 65535, fd = -786868320, user_data = 0xffffae5f3cbc <do_lookup_x+556>}, {pos = -1374700376, events = 65535, fd = 173, user_data = 0x1}, {pos = -1374708840, events = 65535, fd = -1369314960, user_data = 0x5}, {pos = -1369314960, events = 65535, fd = -786868120, user_data = 0xffffd1195864}, {
            pos = 826860128, events = 0, fd = -786868080, user_data = 0xffffae5f4644 <_dl_lookup_symbol_x+260>}, {pos = 2090263927, events = 0, fd = -1369258712, user_data = 0x455fee}, {pos = -786867736, events = 65535, fd = -1369359776, user_data = 0x1}, {pos = -1369259616, events = 65535, fd = 1, user_data = 0xffffd1195930}, {pos = 0,
            events = 0, fd = 32, user_data = 0x0}, {pos = 6, events = 0, fd = -1369360088, user_data = 0x0}, {pos = -786867920, events = 65535, fd = -786867904, user_data = 0x43fec0}, {pos = 4546542, events = 0, fd = -786868120, user_data = 0xffffd1195864}, {pos = 32660373, events = 0, fd = 826860128, user_data = 0x0}, {pos = 1, events = 0,
            fd = 0, user_data = 0xffff00000001}, {pos = -1369259616, events = 65535, fd = -786867808, user_data = 0xffffae5f8820 <_dl_fixup+192>}, {pos = 0, events = 0, fd = 13961616, user_data = 0xffffae60ef00}, {pos = -1369377024, events = 65535, fd = 14077952, user_data = 0xd6d930 <NumListenSockets>}, {pos = 826860128, events = 0,
            fd = 10766128, user_data = 0xb0fe70}, {pos = 11666192, events = 0, fd = 827059992, user_data = 0x99936868a3136600}, {pos = -786867872, events = 65535, fd = 10371416, user_data = 0x314bef18}, {pos = 0, events = 0, fd = -1369258712, user_data = 0xffffd1195940}, {pos = 448139, events = 0, fd = -786867256, user_data = 0xffffae0fae38}, {
            pos = -1369314960, events = 65535, fd = 0, user_data = 0x314bef18}, {pos = -786867808, events = 65535, fd = 10401956, user_data = 0x314bee50}, {pos = 827059792, events = 0, fd = 827059992, user_data = 0x1}, {pos = 827060816, events = 0, fd = 11733408, user_data = 0xffffd1195ad0}, {pos = -1369445388, events = 65535, fd = 0,
            user_data = 0x0}, {pos = 0, events = 0, fd = 10, user_data = 0xd6d000 <PqRecvBuffer+7072>}, {pos = 827059792, events = 0, fd = 14136736, user_data = 0xffffae0fae38}, {pos = 135, events = 0, fd = -40, user_data = 0xffffd1195a70}, {pos = -1377343468, events = 65535, fd = -1376250456, user_data = 0xffffadf81590 <dealloc_buffers>}, {
            pos = 1, events = 0, fd = -1369378800, user_data = 0x1}, {pos = 0, events = 0, fd = 10, user_data = 0xffffade75100 <flush_cleanup>}, {pos = -1376246672, events = 65535, fd = 0, user_data = 0x0}, {pos = -1559009792, events = 2576574568, fd = -786867504, user_data = 0x99936868a3136600}, {pos = -786867504, events = 65535,
            fd = 8147532, user_data = 0x0}, {pos = -1559009792, events = 2576574568, fd = -786867504, user_data = 0x7c529c <fork_process+124>}, {pos = 9963, events = 0, fd = 0, user_data = 0x0}, {pos = 11, events = 0, fd = -786867328, user_data = 0x7c542c <postmaster_child_launch+60>}, {pos = 0, events = 0, fd = 0, user_data = 0x400}, {
            pos = 826861016, events = 0, fd = 4194304, user_data = 0x9ebb9c <MemoryContextDelete+168>}, {pos = 826882960, events = 0, fd = 826860816, user_data = 0xd7b5a0 <TopMemoryContext>}, {pos = 826860816, events = 0, fd = 14135296, user_data = 0xd6d930 <NumListenSockets>}, {pos = -786867344, events = 65535, fd = 7280632,
            user_data = 0xffffd1195bd0}, {pos = 8170340, events = 0, fd = 14131200, user_data = 0x8}, {pos = 8, events = 0, fd = 14131200, user_data = 0xd6d000 <PqRecvBuffer+7072>}, {pos = 14080304, events = 0, fd = 826860128, user_data = 0xa44730}, {pos = 11599472, events = 0, fd = 14131200, user_data = 0xffffd1195bd0}, {pos = 0, events = 0,
            fd = 0, user_data = 0x31494570}}
        nevents = <optimized out>
        __func__ = "ServerLoop"
#23 0x00000000007cab68 in PostmasterMain (argc=argc@entry=8, argv=argv@entry=0x3148f320) at postmaster.c:1372
        opt = <optimized out>
        status = <optimized out>
        userDoption = <optimized out>
        listen_addr_saved = false
        output_config_variable = <optimized out>
        __func__ = "PostmasterMain"
#24 0x0000000000496cb8 in main (argc=8, argv=0x3148f320) at main.c:197
        do_check_root = <optimized out>
(gdb)

[postgres@ip-172-31-18-25 ~]$ pstack 8098
#0  0x0000ffff8a9c9954 in epoll_pwait () from /lib64/libc.so.6
#1  0x000000000081aa40 in WaitEventSetWaitBlock (nevents=1, occurred_events=<optimized out>, cur_timeout=600000, set=0x108d59b8) at latch.c:1535
#2  WaitEventSetWait (set=0x108d59b8, timeout=timeout@entry=600000, occurred_events=occurred_events@entry=0xfffff9c83678, nevents=nevents@entry=1, wait_event_info=wait_event_info@entry=150994946) at latch.c:1481
#3  0x000000000081ae04 in WaitLatch (latch=<optimized out>, wakeEvents=wakeEvents@entry=41, timeout=600000, wait_event_info=wait_event_info@entry=150994946) at latch.c:513
#4  0x00000000008dd9b4 in pg_sleep (fcinfo=<optimized out>) at misc.c:406
#5  0x000000000067f5dc in ExecInterpExpr (state=0x10ad7ae8, econtext=0x10ad7810, isnull=<optimized out>) at execExprInterp.c:758
#6  0x00000000006b7808 in ExecEvalExprSwitchContext (isNull=0xfffff9c837ef, econtext=0x10ad7810, state=<optimized out>) at ../../../src/include/executor/executor.h:355
#7  ExecProject (projInfo=<optimized out>) at ../../../src/include/executor/executor.h:389
#8  ExecResult (pstate=<optimized out>) at nodeResult.c:136
#9  0x00000000006833cc in ExecProcNode (node=0x10ad7700) at ../../../src/include/executor/executor.h:273
#10 ExecutePlan (execute_once=<optimized out>, dest=0x109f2a50, direction=<optimized out>, numberTuples=0, sendTuples=<optimized out>, operation=CMD_SELECT, use_parallel_mode=<optimized out>, planstate=0x10ad7700, estate=0x10ad74d8) at execMain.c:1670
#11 standard_ExecutorRun (queryDesc=0x10adb4f8, direction=<optimized out>, count=0, execute_once=<optimized out>) at execMain.c:365
#12 0x0000000000847b44 in PortalRunSelect (portal=portal@entry=0x10952f48, forward=forward@entry=true, count=0, count@entry=9223372036854775807, dest=dest@entry=0x109f2a50) at pquery.c:924
#13 0x0000000000849360 in PortalRun (portal=portal@entry=0x10952f48, count=count@entry=9223372036854775807, isTopLevel=isTopLevel@entry=true, run_once=run_once@entry=true, dest=dest@entry=0x109f2a50, altdest=altdest@entry=0x109f2a50, qc=qc@entry=0xfffff9c83b30) at pquery.c:768
#14 0x0000000000845044 in exec_simple_query (query_string=query_string@entry=0x108d9c88 "SELECT pg_sleep(0.1);") at postgres.c:1274
#15 0x0000000000845b68 in PostgresMain (dbname=<optimized out>, username=<optimized out>) at postgres.c:4637
#16 0x00000000007ab284 in BackendRun (port=0x109050b0) at postmaster.c:4464
#17 BackendStartup (port=0x109050b0) at postmaster.c:4192
#18 ServerLoop () at postmaster.c:1782
#19 0x00000000007ac3a4 in PostmasterMain (argc=argc@entry=8, argv=argv@entry=0x108d5310) at postmaster.c:1466
#20 0x0000000000493260 in main (argc=8, argv=0x108d5310) at main.c:198
[postgres@ip-172-31-18-25 ~]$



31292 root       20   0  117M  4320  3136 S  0.0  0.0  0:00.00 │  ├─ /usr/sbin/CROND -n
31298 postgres   20   0 20988  6312  5320 S  0.0  0.0  0:00.00 │  │  ├─ /usr/sbin/sendmail -FCronDaemon -i -odi -oem -oi -t -f postgres
31307 postgres   20   0 20960  6144  5152 S  0.0  0.0  0:00.00 │  │  │  └─ /usr/sbin/postdrop -r
31293 postgres   20   0  111M  2616  2440 S  0.0  0.0  0:00.00 │  │  └─ /bin/sh -c cd /opt/postgres/build-farm-14 && PATH=/opt/gcc/home/ec2-user/proj/gcc/target/bin/:$PATH:/usr/local/bin PERL5LIB=/home/postgres/perl5/lib/perl5 ./run_build.pl --config=build-farm.conf REL_16_STABLE --verbose
31295 postgres   20   0  128M 17988  3928 S  0.0  0.1  0:00.08 │  │     └─ /usr/bin/perl ./run_build.pl --config=build-farm.conf REL_16_STABLE --verbose
 5657 postgres   20   0  111M  2628  2448 S  0.0  0.0  0:00.00 │  │        └─ sh -c { cd pgsql.build/src/test/regress && make NO_LOCALE=1 check; echo $? > /opt/postgres/build-farm-14/buildroot/REL_16_STABLE/parula.lastrun-logs/laststatus; } > /opt/postgres/build-farm-14/buildroot/REL_16_STABLE/parula.lastrun-logs/lastcommand.log 2>&1; read st <
 5658 postgres   20   0  110M  2084  1712 S  0.0  0.0  0:00.00 │  │           └─ make NO_LOCALE=1 check
 6834 postgres   20   0  111M  2676  2480 S  0.0  0.0  0:00.00 │  │              └─ /bin/sh -c echo "# +++ regress check in src/test/regress +++" && PATH="/opt/postgres/build-farm-14/buildroot/REL_16_STABLE/pgsql.build/tmp_install/opt/postgres/build-farm-14/buildroot/REL_16_STABLE/inst/bin:/opt/postgres/build-farm-14/buildroot/REL_16_STABLE/pgsq
 6835 postgres   20   0  110M  1960  1800 S  0.0  0.0  0:00.03 │  │                 └─ ../../../src/test/regress/pg_regress --temp-instance=./tmp_check --inputdir=. --bindir= --temp-config=/tmp/buildfarm-w4K7O0/bfextra.conf --no-locale --port=5768 --dlpath=. --max-concurrent-tests=20 --port=5768 --schedule=./parallel_schedule
 8090 postgres   20   0 15448  5536  4708 S  0.0  0.0  0:00.00 │  │                    ├─ psql -X -a -q -d regression -v HIDE_TABLEAM=on -v HIDE_TOAST_COMPRESSION=on
 6849 postgres   20   0  166M 20544 19404 S  0.0  0.1  0:00.33 │  │                    └─ postgres -D /opt/postgres/build-farm-14/buildroot/REL_16_STABLE/pgsql.build/src/test/regress/tmp_check/data -F -c listen_addresses= -k /tmp/pg_regress-Frl3F3
 8098 postgres   20   0  171M 41404 37216 S  0.0  0.3  0:00.05 │  │                       ├─ postgres: postgres regression [local] SELECT
 6857 postgres   20   0  169M  8752  7344 S  0.0  0.1  0:00.01 │  │                       ├─ postgres: logical replication launcher
 6856 postgres   20   0  168M  8484  7032 S  0.0  0.1  0:00.08 │  │                       ├─ postgres: autovacuum launcher
 6855 postgres   20   0  166M 10040  8868 S  0.0  0.1  0:00.06 │  │                       ├─ postgres: walwriter
 6853 postgres   20   0  166M  5400  4244 S  0.0  0.0  0:00.02 │  │                       ├─ postgres: background writer
 6852 postgres   20   0  168M  111M  109M S  0.0  0.7  0:00.12 │  │                       └─ postgres: checkpointer
 
 
#0  0x0000ffff8a9c9954 in epoll_pwait () from /lib64/libc.so.6
No symbol table info available.
#1  0x000000000081aa40 in WaitEventSetWaitBlock (nevents=1, occurred_events=<optimized out>, cur_timeout=335257, set=0x108d59b8) at latch.c:1535
        returned_events = 0
        rc = <optimized out>
        cur_event = <optimized out>
        cur_epoll_event = <optimized out>
        __func__ = "WaitEventSetWaitBlock"
#2  WaitEventSetWait (set=0x108d59b8, timeout=timeout@entry=600000, occurred_events=occurred_events@entry=0xfffff9c83678, nevents=nevents@entry=1, wait_event_info=wait_event_info@entry=150994946) at latch.c:1481
        rc = <optimized out>
        returned_events = 0
        start_time = <optimized out>
        cur_time = <optimized out>
        cur_timeout = 335257
#3  0x000000000081ae04 in WaitLatch (latch=<optimized out>, wakeEvents=wakeEvents@entry=41, timeout=600000, wait_event_info=wait_event_info@entry=150994946) at latch.c:513
        event = {pos = 9296220, events = 0, fd = 1713147409, user_data = 0xbc95e}
#4  0x00000000008dd9b4 in pg_sleep (fcinfo=<optimized out>) at misc.c:406
        delay = <optimized out>
        delay_ms = <optimized out>
        endtime = 0
#5  0x000000000067f5dc in ExecInterpExpr (state=0x10ad7ae8, econtext=0x10ad7810, isnull=<optimized out>) at execExprInterp.c:758
        fcinfo = 0x10ad7bc0
        args = 0x10ad7be0
        nargs = <optimized out>
        d = <optimized out>
        op = <optimized out>
        resultslot = 0x10ad7a00
        innerslot = 0x0
        outerslot = 0x0
        scanslot = 0x0
        dispatch_table = {0x67e6f0 <ExecInterpExpr+1840>, 0x67e104 <ExecInterpExpr+324>, 0x67e938 <ExecInterpExpr+2424>, 0x67e914 <ExecInterpExpr+2388>, 0x67e8d8 <ExecInterpExpr+2328>, 0x67e89c <ExecInterpExpr+2268>, 0x67e860 <ExecInterpExpr+2208>, 0x67e844 <ExecInterpExpr+2180>, 0x67e828 <ExecInterpExpr+2152>, 0x67e80c <ExecInterpExpr+2124>,
          0x67eb1c <ExecInterpExpr+2908>, 0x67eacc <ExecInterpExpr+2828>, 0x67ea7c <ExecInterpExpr+2748>, 0x67ea2c <ExecInterpExpr+2668>, 0x67e9f4 <ExecInterpExpr+2612>, 0x67e9ac <ExecInterpExpr+2540>, 0x67e98c <ExecInterpExpr+2508>, 0x67e95c <ExecInterpExpr+2460>, 0x67e7c8 <ExecInterpExpr+2056>, 0x67e77c <ExecInterpExpr+1980>,
          0x67e764 <ExecInterpExpr+1956>, 0x67e004 <ExecInterpExpr+68>, 0x67e00c <ExecInterpExpr+76>, 0x67efcc <ExecInterpExpr+4108>, 0x67e02c <ExecInterpExpr+108>, 0x67e034 <ExecInterpExpr+116>, 0x67f010 <ExecInterpExpr+4176>, 0x67efb0 <ExecInterpExpr+4080>, 0x67ef6c <ExecInterpExpr+4012>, 0x67ef54 <ExecInterpExpr+3988>,
          0x67ef30 <ExecInterpExpr+3952>, 0x67ef0c <ExecInterpExpr+3916>, 0x67eed4 <ExecInterpExpr+3860>, 0x67eeb8 <ExecInterpExpr+3832>, 0x67ee98 <ExecInterpExpr+3800>, 0x67ee84 <ExecInterpExpr+3780>, 0x67ee70 <ExecInterpExpr+3760>, 0x67ee4c <ExecInterpExpr+3724>, 0x67ee24 <ExecInterpExpr+3684>, 0x67ee00 <ExecInterpExpr+3648>,
          0x67edd8 <ExecInterpExpr+3608>, 0x67edc0 <ExecInterpExpr+3584>, 0x67eda8 <ExecInterpExpr+3560>, 0x67ed8c <ExecInterpExpr+3532>, 0x67ed60 <ExecInterpExpr+3488>, 0x67ed18 <ExecInterpExpr+3416>, 0x67ec6c <ExecInterpExpr+3244>, 0x67ec40 <ExecInterpExpr+3200>, 0x67ec10 <ExecInterpExpr+3152>, 0x67eba8 <ExecInterpExpr+3048>,
          0x67eb94 <ExecInterpExpr+3028>, 0x67fb08 <ExecInterpExpr+6984>, 0x67eb80 <ExecInterpExpr+3008>, 0x67eb6c <ExecInterpExpr+2988>, 0x67eb34 <ExecInterpExpr+2932>, 0x67f33c <ExecInterpExpr+4988>, 0x67f2b8 <ExecInterpExpr+4856>, 0x67f274 <ExecInterpExpr+4788>, 0x67f260 <ExecInterpExpr+4768>, 0x67f248 <ExecInterpExpr+4744>,
          0x67f230 <ExecInterpExpr+4720>, 0x67f218 <ExecInterpExpr+4696>, 0x67f1f8 <ExecInterpExpr+4664>, 0x67f0fc <ExecInterpExpr+4412>, 0x67f0e0 <ExecInterpExpr+4384>, 0x67f0c4 <ExecInterpExpr+4356>, 0x67ed34 <ExecInterpExpr+3444>, 0x67f06c <ExecInterpExpr+4268>, 0x67f04c <ExecInterpExpr+4236>, 0x67f0ac <ExecInterpExpr+4332>,
          0x67f098 <ExecInterpExpr+4312>, 0x67f080 <ExecInterpExpr+4288>, 0x67f1e4 <ExecInterpExpr+4644>, 0x67f1cc <ExecInterpExpr+4620>, 0x67f1b8 <ExecInterpExpr+4600>, 0x67f188 <ExecInterpExpr+4552>, 0x67f174 <ExecInterpExpr+4532>, 0x67f13c <ExecInterpExpr+4476>, 0x67f118 <ExecInterpExpr+4440>, 0x67e054 <ExecInterpExpr+148>,
          0x67e060 <ExecInterpExpr+160>, 0x67e71c <ExecInterpExpr+1884>, 0x67e6ac <ExecInterpExpr+1772>, 0x67e680 <ExecInterpExpr+1728>, 0x67e5c0 <ExecInterpExpr+1536>, 0x67e508 <ExecInterpExpr+1352>, 0x67e358 <ExecInterpExpr+920>, 0x67e408 <ExecInterpExpr+1096>, 0x67e264 <ExecInterpExpr+676>, 0x67e178 <ExecInterpExpr+440>,
          0x67e150 <ExecInterpExpr+400>, 0x67e128 <ExecInterpExpr+360>, 0x67e0dc <ExecInterpExpr+284>, 0x67e0c4 <ExecInterpExpr+260>, 0x67f89c <ExecInterpExpr+6364>}
#6  0x00000000006b7808 in ExecEvalExprSwitchContext (isNull=0xfffff9c837ef, econtext=0x10ad7810, state=<optimized out>) at ../../../src/include/executor/executor.h:355
        oldContext = 0x10ad73c0
#7  ExecProject (projInfo=<optimized out>) at ../../../src/include/executor/executor.h:389
        econtext = 0x10ad7810
        state = <optimized out>
        slot = 0x10ad7a00
        isnull = 33
#8  ExecResult (pstate=<optimized out>) at nodeResult.c:136
        node = <optimized out>
        outerTupleSlot = <optimized out>
        outerPlan = <optimized out>
        econtext = <optimized out>
#9  0x00000000006833cc in ExecProcNode (node=0x10ad7700) at ../../../src/include/executor/executor.h:273
No locals.
#10 ExecutePlan (execute_once=<optimized out>, dest=0x109f2a50, direction=<optimized out>, numberTuples=0, sendTuples=<optimized out>, operation=CMD_SELECT, use_parallel_mode=<optimized out>, planstate=0x10ad7700, estate=0x10ad74d8) at execMain.c:1670
        slot = <optimized out>
        current_tuple_count = 0
#11 standard_ExecutorRun (queryDesc=0x10adb4f8, direction=<optimized out>, count=0, execute_once=<optimized out>) at execMain.c:365
        estate = 0x10ad74d8
        operation = CMD_SELECT
        dest = 0x109f2a50
        sendTuples = 252
        oldcontext = 0x10adb3e0
        __func__ = "standard_ExecutorRun"
#12 0x0000000000847b44 in PortalRunSelect (portal=portal@entry=0x10952f48, forward=forward@entry=true, count=0, count@entry=9223372036854775807, dest=dest@entry=0x109f2a50) at pquery.c:924
        queryDesc = 0x10adb4f8
        direction = <optimized out>
        nprocessed = <optimized out>
        __func__ = "PortalRunSelect"
#13 0x0000000000849360 in PortalRun (portal=portal@entry=0x10952f48, count=count@entry=9223372036854775807, isTopLevel=isTopLevel@entry=true, run_once=run_once@entry=true, dest=dest@entry=0x109f2a50, altdest=altdest@entry=0x109f2a50, qc=qc@entry=0xfffff9c83b30) at pquery.c:768
        _save_exception_stack = 0xfffff9c83de8
        _save_context_stack = 0x0
        _local_sigjmp_buf = {{__jmpbuf = {1, 278212424, 277719512, 277719560, 0, 278866512, 0, 2, 13605592, 277719592, 281474872391856, 2455851481445542082, 277697712, 2455605387221598826, 4631952216750555136, 0, 0, 0, 0, 0, 0, 0}, __mask_was_saved = 0, __saved_mask = {__val = {112, 277715824, 277719512, 13602816, 281474872392256, 8686156,
                281474872392288, 4874408, 2, 278212424, 277719512, 277719560, 281474872392320, 8671248, 277719584, 8671184}}}}
        result = <optimized out>
        nprocessed = <optimized out>
        saveTopTransactionResourceOwner = 0x109673a8
        saveTopTransactionContext = 0x1090cd40
        saveActivePortal = 0x0
        saveResourceOwner = 0x109673a8
        savePortalContext = 0x0
        saveMemoryContext = 0x1090cd40
        __func__ = "PortalRun"
#14 0x0000000000845044 in exec_simple_query (query_string=query_string@entry=0x108d9c88 "SELECT pg_sleep(0.1);") at postgres.c:1274
        cmdtaglen = 6
        snapshot_set = <optimized out>
        per_parsetree_context = 0x0
        plantree_list = 0x109f2a00
        parsetree = <error reading variable parsetree (dwarf2_find_location_expression: Corrupted DWARF expression.)>
        commandTag = <optimized out>
        qc = {commandTag = CMDTAG_UNKNOWN, nprocessed = 0}
        querytree_list = <error reading variable querytree_list (dwarf2_find_location_expression: Corrupted DWARF expression.)>
        portal = 0x10952f48
        receiver = 0x109f2a50
        format = 0
        cmdtagname = <error reading variable cmdtagname (dwarf2_find_location_expression: Corrupted DWARF expression.)>
        parsetree_item__state = {l = 0x108daa08, i = 0}
        dest = DestRemote
        oldcontext = 0x1090cd40
        parsetree_list = 0x108daa08
        parsetree_item = 0x108daa20
        save_log_statement_stats = <optimized out>
        was_logged = true
        use_implicit_block = false
        msec_str = "\000\000\000\000\377\377\000\000\000\000\000\000\000\000\000\000X\002\317\000\000\000\000\000Q\000\000\000\000\000\000"
        __func__ = "exec_simple_query"
#15 0x0000000000845b68 in PostgresMain (dbname=<optimized out>, username=<optimized out>) at postgres.c:4637
        query_string = <error reading variable query_string (dwarf2_find_location_expression: Corrupted DWARF expression.)>
        firstchar = <optimized out>
        input_message = {data = 0x108d9c88 "SELECT pg_sleep(0.1);", len = 22, maxlen = 1024, cursor = 22}
        local_sigjmp_buf = {{__jmpbuf = {13602816, 13602816, 8662912, 281474872393704, 277894208, 281474872394760, 277888464, 13455360, 0, 13551280, 281474872392544, 2455851481445527378, 15624, 2455605387221598602, 4631952216750555136, 0, 0, 0, 0, 0, 0, 0}, __mask_was_saved = 1, __saved_mask = {__val = {4194304, 7834284, 281474872393440,
                8561608, 13562696, 13598720, 13602816, 8625692, 281474872393504, 8041068, 281474872393648, 277893296, 11145024, 281474872393704, 277894208, 277893296}}}}
        send_ready_for_query = false
        idle_in_transaction_timeout_enabled = false
        idle_session_timeout_enabled = false
        __func__ = "PostgresMain"
#16 0x00000000007ab284 in BackendRun (port=0x109050b0) at postmaster.c:4464
No locals.
#17 BackendStartup (port=0x109050b0) at postmaster.c:4192
        bn = 0x10905440
        pid = <optimized out>
        __func__ = "BackendStartup"
#18 ServerLoop () at postmaster.c:1782
        port = 0x109050b0
        i = <optimized out>
        now = <optimized out>
        last_lockfile_recheck_time = 1713135987
        last_touch_time = 1713135987
        events = {{pos = 1, events = 2, fd = 7, user_data = 0x0}, {pos = 32816, events = 0, fd = -104315824, user_data = 0xffff8a9945a8 <__alloc_dir+72>}, {pos = 32768, events = 0, fd = 8, user_data = 0x1}, {pos = 10502040, events = 0, fd = -104315824, user_data = 0x400}, {pos = -104315632, events = 65535, fd = -1969666388,
            user_data = 0xffff8aa6d000 <argp_default_argp+16>}, {pos = 8, events = 0, fd = -104315768, user_data = 0x0}, {pos = -104315520, events = 65535, fd = 66305, user_data = 0x1a81d3c4}, {pos = 16832, events = 2, fd = 1001, user_data = 0x0}, {pos = 0, events = 0, fd = 6, user_data = 0x1000}, {pos = 0, events = 0, fd = -104315504,
            user_data = 0xffff8a96ba0c <malloc+156>}, {pos = -104315488, events = 65535, fd = -1969833460, user_data = 0xffff8aa6ea88 <main_arena>}, {pos = 4096, events = 0, fd = -1961892016, user_data = 0xffff8b0fe700}, {pos = 80, events = 0, fd = 277883320, user_data = 0x0}, {pos = 1, events = 0, fd = 0, user_data = 0xadaa98}, {
            pos = -1970278784, events = 65535, fd = 1867, user_data = 0x1}, {pos = -1970333812, events = 65535, fd = -1961839552, user_data = 0x0}, {pos = 119, events = 124, fd = 1, user_data = 0x630000006f}, {pos = 0, events = 0, fd = -104315408, user_data = 0xffff8b0e2cbc <do_lookup_x+556>}, {pos = -1967215448, events = 65535, fd = 173,
            user_data = 0x1}, {pos = -1967223912, events = 65535, fd = -1961797040, user_data = 0x5}, {pos = -1961797040, events = 65535, fd = -104315208, user_data = 0xfffff9c846b4}, {pos = 66305, events = 0, fd = -104315168, user_data = 0xffff8b0e3644 <_dl_lookup_symbol_x+260>}, {pos = 2090263927, events = 0, fd = -1961773784,
            user_data = 0x4540dd}, {pos = -104314824, events = 65535, fd = -1961874848, user_data = 0x1}, {pos = -1961774688, events = 65535, fd = 1, user_data = 0xfffff9c84780}, {pos = 0, events = 0, fd = 32, user_data = 0x0}, {pos = 6, events = 0, fd = -1961875160, user_data = 0xffff00000000}, {pos = -104315008, events = 65535,
            fd = -104314992, user_data = 0x43e740}, {pos = 4538589, events = 0, fd = -104315208, user_data = 0xfffff9c846b4}, {pos = 32660373, events = 0, fd = -104315168, user_data = 0x0}, {pos = 1, events = 0, fd = 0, user_data = 0x1}, {pos = -1961774688, events = 65535, fd = -104314896, user_data = 0xffff8b0e7820 <_dl_fixup+192>}, {pos = 0,
            events = 0, fd = 13437312, user_data = 0xffff8b0fdf00}, {pos = -1961892096, events = 65535, fd = 13549568, user_data = 0xcec6b0 <ListenSocket>}, {pos = 277693024, events = 0, fd = 10528136, user_data = 0xacaed8}, {pos = 11381400, events = 0, fd = -104314944, user_data = 0x9b00b8 <AllocSetReset+40>}, {pos = 277882224, events = 0,
            fd = 1343407616, user_data = 0xfffff9c847c0}, {pos = 0, events = 0, fd = -1961773784, user_data = 0xfffff9c84790}, {pos = 448139, events = 0, fd = 1024, user_data = 0xffff8abe9e38}, {pos = -1961797040, events = 65535, fd = 277883321, user_data = 0x108d9b70}, {pos = 0, events = 0, fd = 5120, user_data = 0xfffff9c847f0}, {
            pos = 10185012, events = 0, fd = 277882224, user_data = 0x10902570}, {pos = 277882224, events = 0, fd = 277883248, user_data = 0xfffff9c84920}, {pos = -1961960460, events = 65535, fd = 3, user_data = 0x8}, {pos = 8, events = 0, fd = 13602816, user_data = 0xcec000 <PqRecvBuffer+7712>}, {pos = 277693024, events = 0, fd = 277882224,
            user_data = 0xffff8abe9e38}, {pos = 135, events = 0, fd = -40, user_data = 0xfffff9c848c0}, {pos = -1969858540, events = 65535, fd = -1968765528, user_data = 0xffff8aa70590 <dealloc_buffers>}, {pos = 1, events = 0, fd = -1961893872, user_data = 0x1}, {pos = 0, events = 0, fd = 1635021578,
            user_data = 0xffff8a964100 <flush_cleanup>}, {pos = -1968761744, events = 65535, fd = 0, user_data = 0x0}, {pos = 1343407616, events = 3428591778, fd = -104314592, user_data = 0xcc5c28a25012c600}, {pos = -104314592, events = 65535, fd = 8019644, user_data = 0x0}, {pos = 1343407616, events = 3428591778, fd = -104314592,
            user_data = 0x7a5f0c <fork_process+124>}, {pos = 6854, events = 0, fd = 8, user_data = 0x8}, {pos = 13602816, events = 0, fd = -104314416, user_data = 0x7a8d64 <StartChildProcess+20>}, {pos = 0, events = 0, fd = 8, user_data = 0x108d4510}, {pos = 1024, events = 0, fd = 4194304, user_data = 0x6d8e78 <load_ident+388>}, {
            pos = 13541376, events = 0, fd = 0, user_data = 0xfffff9c849f0}, {pos = 8045472, events = 0, fd = 13602816, user_data = 0x8}, {pos = 8, events = 0, fd = 13602816, user_data = 0xcec000 <PqRecvBuffer+7712>}, {pos = 13551280, events = 0, fd = 277693024, user_data = 0xa0a588}, {pos = 11316952, events = 0, fd = 8,
            user_data = 0xfffff9c849f0}, {pos = 0, events = 0, fd = 0, user_data = 0x10904010}}
        nevents = <optimized out>
        __func__ = "ServerLoop"
#19 0x00000000007ac3a4 in PostmasterMain (argc=argc@entry=8, argv=argv@entry=0x108d5310) at postmaster.c:1466
        opt = <optimized out>
        status = <optimized out>
        userDoption = <optimized out>
        listen_addr_saved = false
        i = <optimized out>
        output_config_variable = <optimized out>
        __func__ = "PostmasterMain"
#20 0x0000000000493260 in main (argc=8, argv=0x108d5310) at main.c:198
        do_check_root = <optimized out>
(gdb)


Attachments:

  [text/plain] b.txt (23.3K, ../../CAEP4nAyKmw=4i8agOyfaNHU0CEGyMRQu83vk3=PDoYyik9FfTQ@mail.gmail.com/3-b.txt)
  download | inline:
[postgres@ip-172-31-18-25 ~]$ pstack 26147
#0  0x0000ffffadeda954 in epoll_pwait () from /lib64/libc.so.6
#1  0x0000000000842888 in WaitEventSetWaitBlock (nevents=1, occurred_events=<optimized out>, cur_timeout=600000, set=0x3148fac0) at latch.c:1570
#2  WaitEventSetWait (set=0x3148fac0, timeout=timeout@entry=600000, occurred_events=occurred_events@entry=0xffffd1194748, nevents=nevents@entry=1, wait_event_info=wait_event_info@entry=150994946) at latch.c:1516
#3  0x0000000000842c44 in WaitLatch (latch=<optimized out>, wakeEvents=wakeEvents@entry=41, timeout=600000, wait_event_info=wait_event_info@entry=150994946) at latch.c:538
#4  0x000000000090b7b4 in pg_sleep (fcinfo=<optimized out>) at misc.c:406
#5  0x0000000000698430 in ExecInterpExpr (state=0x316a6040, econtext=0x316a5e38, isnull=<optimized out>) at execExprInterp.c:764
#6  0x00000000006d0898 in ExecEvalExprSwitchContext (isNull=0xffffd11948bf, econtext=0x316a5e38, state=<optimized out>) at ../../../src/include/executor/executor.h:356
#7  ExecProject (projInfo=<optimized out>) at ../../../src/include/executor/executor.h:390
#8  ExecResult (pstate=<optimized out>) at nodeResult.c:135
#9  0x00000000006b92ec in ExecProcNode (node=0x316a5d28) at ../../../src/include/executor/executor.h:274
#10 gather_getnext (gatherstate=0x316a5b38) at nodeGather.c:287
#11 ExecGather (pstate=0x316a5b38) at nodeGather.c:222
#12 0x000000000069c36c in ExecProcNode (node=0x316a5b38) at ../../../src/include/executor/executor.h:274
#13 ExecutePlan (execute_once=<optimized out>, dest=0x31641e90, direction=<optimized out>, numberTuples=0, sendTuples=<optimized out>, operation=CMD_SELECT, use_parallel_mode=<optimized out>, planstate=0x316a5b38, estate=0x316a5910) at execMain.c:1646
#14 standard_ExecutorRun (queryDesc=0x316459c0, direction=<optimized out>, count=0, execute_once=<optimized out>) at execMain.c:363
#15 0x0000000000871564 in PortalRunSelect (portal=portal@entry=0x31512fb0, forward=forward@entry=true, count=0, count@entry=9223372036854775807, dest=dest@entry=0x31641e90) at pquery.c:924
#16 0x0000000000872d80 in PortalRun (portal=portal@entry=0x31512fb0, count=count@entry=9223372036854775807, isTopLevel=isTopLevel@entry=true, run_once=run_once@entry=true, dest=dest@entry=0x31641e90, altdest=altdest@entry=0x31641e90, qc=qc@entry=0xffffd1194c70) at pquery.c:768
#17 0x000000000086ea54 in exec_simple_query (query_string=query_string@entry=0x31493c90 "SELECT pg_sleep(0.1);") at postgres.c:1274
#18 0x000000000086f590 in PostgresMain (dbname=<optimized out>, username=<optimized out>) at postgres.c:4680
#19 0x000000000086ab20 in BackendMain (startup_data=<optimized out>, startup_data_len=<optimized out>) at backend_startup.c:105
#20 0x00000000007c54d8 in postmaster_child_launch (child_type=child_type@entry=B_BACKEND, startup_data=startup_data@entry=0xffffd1195138 "", startup_data_len=startup_data_len@entry=4, client_sock=client_sock@entry=0xffffd1195140) at launch_backend.c:265
#21 0x00000000007c8ec0 in BackendStartup (client_sock=0xffffd1195140) at postmaster.c:3593
#22 ServerLoop () at postmaster.c:1674
#23 0x00000000007cab68 in PostmasterMain (argc=argc@entry=8, argv=argv@entry=0x3148f320) at postmaster.c:1372
#24 0x0000000000496cb8 in main (argc=8, argv=0x3148f320) at main.c:197
[postgres@ip-172-31-18-25 ~]$


 2072 root       20   0  117M  4376  3192 S  0.0  0.0  0:00.00 │  └─ /usr/sbin/CROND -n
 2087 postgres   20   0 20988  6496  5504 S  0.0  0.0  0:00.00 │     ├─ /usr/sbin/sendmail -FCronDaemon -i -odi -oem -oi -t -f postgres
 2092 postgres   20   0 20960  6328  5336 S  0.0  0.0  0:00.00 │     │  └─ /usr/sbin/postdrop -r
 2074 postgres   20   0  111M  2660  2488 S  0.0  0.0  0:00.00 │     └─ /bin/sh -c cd /opt/postgres/build-farm-14 && PATH=/opt/gcc/home/ec2-user/proj/gcc/target/bin/:$PATH:/usr/local/bin PERL5LIB=/home/postgres/perl5/lib/perl5  ./run_build.pl --config=build-farm.conf HEAD --verbose
 2075 postgres   20   0  128M 18128  3940 S  0.0  0.1  0:00.08 │        └─ /usr/bin/perl ./run_build.pl --config=build-farm.conf HEAD --verbose
 8751 postgres   20   0  111M  2660  2480 S  0.0  0.0  0:00.00 │           └─ sh -c { cd pgsql.build/src/test/regress && make NO_LOCALE=1 check; echo $? > /opt/postgres/build-farm-14/buildroot/HEAD/parula.lastrun-logs/laststatus; } > /opt/postgres/build-farm-14/buildroot/HEAD/parula.lastrun-logs/lastcommand.log 2>&1; read st < /opt/postgres/buil
 8752 postgres   20   0  110M  2084  1712 S  0.0  0.0  0:00.00 │              └─ make NO_LOCALE=1 check
 9947 postgres   20   0  111M  2836  2640 S  0.0  0.0  0:00.00 │                 └─ /bin/sh -c echo "# +++ regress check in src/test/regress +++" && PATH="/opt/postgres/build-farm-14/buildroot/HEAD/pgsql.build/tmp_install/opt/postgres/build-farm-14/buildroot/HEAD/inst/bin:/opt/postgres/build-farm-14/buildroot/HEAD/pgsql.build/src/test/regress:$P
 9948 postgres   20   0  121M  5540  4716 S  0.0  0.0  0:00.08 │                    └─ ../../../src/test/regress/pg_regress --temp-instance=./tmp_check --inputdir=. --bindir= --temp-config=/tmp/buildfarm-RoyKTG/bfextra.conf --no-locale --port=5678 --dlpath=. --max-concurrent-tests=20 --port=5678 --schedule=./parallel_schedule
26137 postgres   20   0 15448  5636  4816 S  0.0  0.0  0:00.01 │                       ├─ psql -X -a -q -d regression -v HIDE_TABLEAM=on -v HIDE_TOAST_COMPRESSION=on
 9960 postgres   20   0  167M 20704 19564 S  0.0  0.1  0:04.08 │                       └─ postgres -D /opt/postgres/build-farm-14/buildroot/HEAD/pgsql.build/src/test/regress/tmp_check/data -F -c listen_addresses= -k /tmp/pg_regress-wqlrdh
26147 postgres   20   0  172M 41980 37516 S  0.0  0.3  0:00.06 │                          ├─ postgres: postgres regression [local] SELECT
 9966 postgres   20   0  170M  8684  7256 S  0.0  0.1  0:00.02 │                          ├─ postgres: logical replication launcher
 9965 postgres   20   0  169M  8548  7124 S  0.0  0.1  0:00.20 │                          ├─ postgres: autovacuum launcher
 9964 postgres   20   0  167M 10044  8876 S  0.0  0.1  0:00.07 │                          ├─ postgres: walwriter
 9962 postgres   20   0  167M  5388  4232 S  0.0  0.0  0:00.05 │                          ├─ postgres: background writer
 9961 postgres   20   0  168M  114M  112M S  0.0  0.7  0:00.15 │                          └─ postgres: checkpointer
 

#0  0x0000ffffadeda954 in epoll_pwait () from /lib64/libc.so.6
No symbol table info available.
#1  0x0000000000842888 in WaitEventSetWaitBlock (nevents=1, occurred_events=<optimized out>, cur_timeout=600000, set=0x3148fac0) at latch.c:1570
        returned_events = 0
        rc = <optimized out>
        cur_event = <optimized out>
        cur_epoll_event = <optimized out>
        __func__ = "WaitEventSetWaitBlock"
#2  WaitEventSetWait (set=0x3148fac0, timeout=timeout@entry=600000, occurred_events=occurred_events@entry=0xffffd1194748, nevents=nevents@entry=1, wait_event_info=wait_event_info@entry=150994946) at latch.c:1516
        rc = <optimized out>
        returned_events = 0
        start_time = <optimized out>
        cur_time = <optimized out>
        cur_timeout = 600000
#3  0x0000000000842c44 in WaitLatch (latch=<optimized out>, wakeEvents=wakeEvents@entry=41, timeout=600000, wait_event_info=wait_event_info@entry=150994946) at latch.c:538
        event = {pos = 9484124, events = 0, fd = 1713148331, user_data = 0x44f0b}
#4  0x000000000090b7b4 in pg_sleep (fcinfo=<optimized out>) at misc.c:406
        delay = <optimized out>
        delay_ms = <optimized out>
        endtime = 0
#5  0x0000000000698430 in ExecInterpExpr (state=0x316a6040, econtext=0x316a5e38, isnull=<optimized out>) at execExprInterp.c:764
        fcinfo = 0x316a6198
        args = 0x316a61b8
        nargs = <optimized out>
        d = <optimized out>
        op = <optimized out>
        resultslot = 0x316a5f58
        innerslot = 0x0
        outerslot = 0x0
        scanslot = 0x0
        dispatch_table = {0x697590 <ExecInterpExpr+2044>, 0x69728c <ExecInterpExpr+1272>, 0x697268 <ExecInterpExpr+1236>, 0x697244 <ExecInterpExpr+1200>, 0x697208 <ExecInterpExpr+1140>, 0x6978cc <ExecInterpExpr+2872>, 0x697890 <ExecInterpExpr+2812>, 0x697874 <ExecInterpExpr+2784>, 0x697858 <ExecInterpExpr+2756>, 0x69783c <ExecInterpExpr+2728>,
          0x697824 <ExecInterpExpr+2704>, 0x6977d4 <ExecInterpExpr+2624>, 0x697784 <ExecInterpExpr+2544>, 0x697734 <ExecInterpExpr+2464>, 0x6976fc <ExecInterpExpr+2408>, 0x6976b4 <ExecInterpExpr+2336>, 0x697694 <ExecInterpExpr+2304>, 0x697664 <ExecInterpExpr+2256>, 0x697620 <ExecInterpExpr+2188>, 0x6975d4 <ExecInterpExpr+2112>,
          0x6975bc <ExecInterpExpr+2088>, 0x696dd8 <ExecInterpExpr+68>, 0x696de0 <ExecInterpExpr+76>, 0x697d7c <ExecInterpExpr+4072>, 0x696e00 <ExecInterpExpr+108>, 0x696e08 <ExecInterpExpr+116>, 0x697dc0 <ExecInterpExpr+4140>, 0x697d60 <ExecInterpExpr+4044>, 0x697d1c <ExecInterpExpr+3976>, 0x697d04 <ExecInterpExpr+3952>,
          0x697ce0 <ExecInterpExpr+3916>, 0x697cbc <ExecInterpExpr+3880>, 0x697c84 <ExecInterpExpr+3824>, 0x697c68 <ExecInterpExpr+3796>, 0x697c48 <ExecInterpExpr+3764>, 0x697c34 <ExecInterpExpr+3744>, 0x697c20 <ExecInterpExpr+3724>, 0x697bfc <ExecInterpExpr+3688>, 0x697bd4 <ExecInterpExpr+3648>, 0x697bb0 <ExecInterpExpr+3612>,
          0x697b88 <ExecInterpExpr+3572>, 0x697b70 <ExecInterpExpr+3548>, 0x697b58 <ExecInterpExpr+3524>, 0x697b3c <ExecInterpExpr+3496>, 0x697b10 <ExecInterpExpr+3452>, 0x697ac8 <ExecInterpExpr+3380>, 0x697a1c <ExecInterpExpr+3208>, 0x697a08 <ExecInterpExpr+3188>, 0x6979dc <ExecInterpExpr+3144>, 0x6979ac <ExecInterpExpr+3096>,
          0x697944 <ExecInterpExpr+2992>, 0x697930 <ExecInterpExpr+2972>, 0x698990 <ExecInterpExpr+7164>, 0x69791c <ExecInterpExpr+2952>, 0x697908 <ExecInterpExpr+2932>, 0x698018 <ExecInterpExpr+4740>, 0x697fec <ExecInterpExpr+4696>, 0x697f68 <ExecInterpExpr+4564>, 0x697f24 <ExecInterpExpr+4496>, 0x697f10 <ExecInterpExpr+4476>,
          0x697ef8 <ExecInterpExpr+4452>, 0x697ee0 <ExecInterpExpr+4428>, 0x697ec8 <ExecInterpExpr+4404>, 0x697ea8 <ExecInterpExpr+4372>, 0x697e8c <ExecInterpExpr+4344>, 0x697e70 <ExecInterpExpr+4316>, 0x697e54 <ExecInterpExpr+4288>, 0x697ae4 <ExecInterpExpr+3408>, 0x697dfc <ExecInterpExpr+4200>, 0x698128 <ExecInterpExpr+5012>,
          0x697e3c <ExecInterpExpr+4264>, 0x697e28 <ExecInterpExpr+4244>, 0x697e10 <ExecInterpExpr+4220>, 0x698114 <ExecInterpExpr+4992>, 0x6980fc <ExecInterpExpr+4968>, 0x6980e8 <ExecInterpExpr+4948>, 0x6980c4 <ExecInterpExpr+4912>, 0x698098 <ExecInterpExpr+4868>, 0x698080 <ExecInterpExpr+4844>, 0x698050 <ExecInterpExpr+4796>,
          0x6981b0 <ExecInterpExpr+5148>, 0x698178 <ExecInterpExpr+5092>, 0x698160 <ExecInterpExpr+5068>, 0x69813c <ExecInterpExpr+5032>, 0x696e28 <ExecInterpExpr+148>, 0x696e34 <ExecInterpExpr+160>, 0x697548 <ExecInterpExpr+1972>, 0x697504 <ExecInterpExpr+1904>, 0x6974d8 <ExecInterpExpr+1860>, 0x697418 <ExecInterpExpr+1668>,
          0x697360 <ExecInterpExpr+1484>, 0x6972b0 <ExecInterpExpr+1308>, 0x697108 <ExecInterpExpr+884>, 0x697014 <ExecInterpExpr+640>, 0x696f00 <ExecInterpExpr+364>, 0x696fec <ExecInterpExpr+600>, 0x696ed8 <ExecInterpExpr+324>, 0x696eb0 <ExecInterpExpr+284>, 0x696e98 <ExecInterpExpr+260>, 0x698734 <ExecInterpExpr+6560>}
#6  0x00000000006d0898 in ExecEvalExprSwitchContext (isNull=0xffffd11948bf, econtext=0x316a5e38, state=<optimized out>) at ../../../src/include/executor/executor.h:356
        oldContext = 0x316a5810
#7  ExecProject (projInfo=<optimized out>) at ../../../src/include/executor/executor.h:390
        econtext = 0x316a5e38
        state = <optimized out>
        slot = 0x316a5f58
        isnull = false
#8  ExecResult (pstate=<optimized out>) at nodeResult.c:135
        node = <optimized out>
        outerTupleSlot = <optimized out>
        outerPlan = <optimized out>
        econtext = <optimized out>
#9  0x00000000006b92ec in ExecProcNode (node=0x316a5d28) at ../../../src/include/executor/executor.h:274
No locals.
#10 gather_getnext (gatherstate=0x316a5b38) at nodeGather.c:287
        estate = 0x316a5910
        outerPlan = 0x316a5d28
        outerTupleSlot = <optimized out>
        fslot = 0x316a6688
        tup = <optimized out>
#11 ExecGather (pstate=0x316a5b38) at nodeGather.c:222
        node = 0x316a5b38
        slot = <optimized out>
        econtext = 0x316a5c48
#12 0x000000000069c36c in ExecProcNode (node=0x316a5b38) at ../../../src/include/executor/executor.h:274
No locals.
#13 ExecutePlan (execute_once=<optimized out>, dest=0x31641e90, direction=<optimized out>, numberTuples=0, sendTuples=<optimized out>, operation=CMD_SELECT, use_parallel_mode=<optimized out>, planstate=0x316a5b38, estate=0x316a5910) at execMain.c:1646
        slot = <optimized out>
        current_tuple_count = 0
#14 standard_ExecutorRun (queryDesc=0x316459c0, direction=<optimized out>, count=0, execute_once=<optimized out>) at execMain.c:363
        estate = 0x316a5910
        operation = CMD_SELECT
        dest = 0x31641e90
        sendTuples = 252
        oldcontext = 0x316458c0
        __func__ = "standard_ExecutorRun"
#15 0x0000000000871564 in PortalRunSelect (portal=portal@entry=0x31512fb0, forward=forward@entry=true, count=0, count@entry=9223372036854775807, dest=dest@entry=0x31641e90) at pquery.c:924
        queryDesc = 0x316459c0
        direction = <optimized out>
        nprocessed = <optimized out>
        __func__ = "PortalRunSelect"
#16 0x0000000000872d80 in PortalRun (portal=portal@entry=0x31512fb0, count=count@entry=9223372036854775807, isTopLevel=isTopLevel@entry=true, run_once=run_once@entry=true, dest=dest@entry=0x31641e90, altdest=altdest@entry=0x31641e90, qc=qc@entry=0xffffd1194c70) at pquery.c:768
        _save_exception_stack = 0xffffd1194f28
        _save_context_stack = 0x0
        _local_sigjmp_buf = {{__jmpbuf = {1, 827404208, 826886624, 826886672, 0, 828645008, 0, 2, 14136744, 826886704, 281474189838832, 7012751731486407017, 0, 7012864883735583905, 0, 13830554455654793216, 0, 0, 0, 0, 0, 0}, __mask_was_saved = 0, __saved_mask = {__val = {14136744, 826886704, 1, 12271232, 14135296, 14136808, 281474189839232,
                10405572, 281474189839264, 4891912, 2, 827404208, 281474189839296, 8841760, 826886696, 8841696}}}}
        result = <optimized out>
        nprocessed = <optimized out>
        saveTopTransactionResourceOwner = 0x314d1e28
        saveTopTransactionContext = 0x314bb5c0
        saveActivePortal = 0x0
        saveResourceOwner = 0x314d1e28
        savePortalContext = 0x0
        saveMemoryContext = 0x314bb5c0
        __func__ = "PortalRun"
#17 0x000000000086ea54 in exec_simple_query (query_string=query_string@entry=0x31493c90 "SELECT pg_sleep(0.1);") at postgres.c:1274
        cmdtaglen = 6
        snapshot_set = <optimized out>
        per_parsetree_context = 0x0
        plantree_list = 0x31641e40
        parsetree = <error reading variable parsetree (dwarf2_find_location_expression: Corrupted DWARF expression.)>
        commandTag = <optimized out>
        qc = {commandTag = CMDTAG_UNKNOWN, nprocessed = 0}
        querytree_list = <error reading variable querytree_list (dwarf2_find_location_expression: Corrupted DWARF expression.)>
        portal = 0x31512fb0
        receiver = 0x31641e90
        format = 0
        cmdtagname = <error reading variable cmdtagname (dwarf2_find_location_expression: Corrupted DWARF expression.)>
        parsetree_item__state = {l = 0x31494a10, i = 0}
        dest = DestRemote
        oldcontext = 0x314bb5c0
        parsetree_list = 0x31494a10
        parsetree_item = 0x31494a28
        save_log_statement_stats = <optimized out>
        was_logged = true
        use_implicit_block = false
        msec_str = "\000\000\000\000\377\377\000\000\000\000\000\000\000\000\000\000`\024\327\000\000\000\000\000Q\000\000\000\000\000\000"
        __func__ = "exec_simple_query"
#18 0x000000000086f590 in PostgresMain (dbname=<optimized out>, username=<optimized out>) at postgres.c:4680
        query_string = <error reading variable query_string (dwarf2_find_location_expression: Corrupted DWARF expression.)>
        firstchar = <optimized out>
        input_message = {data = 0x31493c90 "SELECT pg_sleep(0.1);", len = 22, maxlen = 1024, cursor = 22}
        local_sigjmp_buf = {{__jmpbuf = {14135296, 14135296, 8833856, 1, 281474189841896, 11850784, 826883984, 13979648, 0, 14080304, 281474189839520, 7012751731486456521, 15680, 7012864883735583169, 4631952216750555136, 0, 0, 0, 0, 0, 0, 0}, __mask_was_saved = 1, __saved_mask = {__val = {4194304, 14127104, 14135296, 24, 826864816, 10405400,
                281474189840416, 8724296, 281474189840480, 8825600, 281474189840704, 4, 281474189840696, 1, 281474189841896, 1}}}}
        send_ready_for_query = false
        idle_in_transaction_timeout_enabled = false
        idle_session_timeout_enabled = false
        __func__ = "PostgresMain"
#19 0x000000000086ab20 in BackendMain (startup_data=<optimized out>, startup_data_len=<optimized out>) at backend_startup.c:105
        bsdata = <optimized out>
#20 0x00000000007c54d8 in postmaster_child_launch (child_type=child_type@entry=B_BACKEND, startup_data=startup_data@entry=0xffffd1195138 "", startup_data_len=startup_data_len@entry=4, client_sock=client_sock@entry=0xffffd1195140) at launch_backend.c:265
        pid = <optimized out>
#21 0x00000000007c8ec0 in BackendStartup (client_sock=0xffffd1195140) at postmaster.c:3593
        bn = 0x314cafc8
        pid = <optimized out>
        startup_data = {canAcceptConnections = CAC_OK}
        __func__ = "BackendStartup"
#22 ServerLoop () at postmaster.c:1674
        s = {sock = 9, raddr = {addr = {ss_family = 1,
              __ss_padding = "\000\000\000\000\000\000pEI1\000\000\000\000\250Q\031\321\377\377\000\000\262Q\031\321\377\377\000\000\000\340\367\255\377\377\000\000\000\367`\256\377\377\000\000 \000\000\000\000\000\000\000\260Q\031\321\377\377\000\000\000\000\000\000\000\000\000\000\060R\031\321\377\377\000\000(R\031\321\377\377\000\000(\363K1\000\000\000\000i-L1", '\000' <repeats 13 times>, "f\023\243hh\223\231", __ss_align = 281474189840960}, salen = 2}}
        i = 0
        now = <optimized out>
        last_lockfile_recheck_time = 1713117687
        last_touch_time = 1713117687
        events = {{pos = 1, events = 2, fd = 7, user_data = 0x0}, {pos = 1, events = 2, fd = 7, user_data = 0x0}, {pos = 32768, events = 0, fd = 8, user_data = 0x1}, {pos = 10739224, events = 0, fd = -786868688, user_data = 0x400}, {pos = -786868496, events = 65535, fd = -1377151316, user_data = 0xffffadf7e000 <argp_default_argp+16>}, {
            pos = 8, events = 0, fd = -786868632, user_data = 0x0}, {pos = -786868384, events = 65535, fd = 66305, user_data = 0xb808831}, {pos = 16832, events = 2, fd = 1001, user_data = 0x0}, {pos = 0, events = 0, fd = 6, user_data = 0x1000}, {pos = 0, events = 0, fd = -786868368, user_data = 0xffffade7ca0c <malloc+156>}, {pos = -786868352,
            events = 65535, fd = -1377318388, user_data = 0xffffadf7fa88 <main_arena>}, {pos = 4096, events = 0, fd = -1369376944, user_data = 0xffffae60f700}, {pos = 80, events = 0, fd = 827061624, user_data = 0x0}, {pos = 1, events = 0, fd = 0, user_data = 0xb20310}, {pos = -1377763712, events = 65535, fd = 1867, user_data = 0x1}, {
            pos = -1377818740, events = 65535, fd = -786868320, user_data = 0xffffae5f3cbc <do_lookup_x+556>}, {pos = -1374700376, events = 65535, fd = 173, user_data = 0x1}, {pos = -1374708840, events = 65535, fd = -1369314960, user_data = 0x5}, {pos = -1369314960, events = 65535, fd = -786868120, user_data = 0xffffd1195864}, {
            pos = 826860128, events = 0, fd = -786868080, user_data = 0xffffae5f4644 <_dl_lookup_symbol_x+260>}, {pos = 2090263927, events = 0, fd = -1369258712, user_data = 0x455fee}, {pos = -786867736, events = 65535, fd = -1369359776, user_data = 0x1}, {pos = -1369259616, events = 65535, fd = 1, user_data = 0xffffd1195930}, {pos = 0,
            events = 0, fd = 32, user_data = 0x0}, {pos = 6, events = 0, fd = -1369360088, user_data = 0x0}, {pos = -786867920, events = 65535, fd = -786867904, user_data = 0x43fec0}, {pos = 4546542, events = 0, fd = -786868120, user_data = 0xffffd1195864}, {pos = 32660373, events = 0, fd = 826860128, user_data = 0x0}, {pos = 1, events = 0,
            fd = 0, user_data = 0xffff00000001}, {pos = -1369259616, events = 65535, fd = -786867808, user_data = 0xffffae5f8820 <_dl_fixup+192>}, {pos = 0, events = 0, fd = 13961616, user_data = 0xffffae60ef00}, {pos = -1369377024, events = 65535, fd = 14077952, user_data = 0xd6d930 <NumListenSockets>}, {pos = 826860128, events = 0,
            fd = 10766128, user_data = 0xb0fe70}, {pos = 11666192, events = 0, fd = 827059992, user_data = 0x99936868a3136600}, {pos = -786867872, events = 65535, fd = 10371416, user_data = 0x314bef18}, {pos = 0, events = 0, fd = -1369258712, user_data = 0xffffd1195940}, {pos = 448139, events = 0, fd = -786867256, user_data = 0xffffae0fae38}, {
            pos = -1369314960, events = 65535, fd = 0, user_data = 0x314bef18}, {pos = -786867808, events = 65535, fd = 10401956, user_data = 0x314bee50}, {pos = 827059792, events = 0, fd = 827059992, user_data = 0x1}, {pos = 827060816, events = 0, fd = 11733408, user_data = 0xffffd1195ad0}, {pos = -1369445388, events = 65535, fd = 0,
            user_data = 0x0}, {pos = 0, events = 0, fd = 10, user_data = 0xd6d000 <PqRecvBuffer+7072>}, {pos = 827059792, events = 0, fd = 14136736, user_data = 0xffffae0fae38}, {pos = 135, events = 0, fd = -40, user_data = 0xffffd1195a70}, {pos = -1377343468, events = 65535, fd = -1376250456, user_data = 0xffffadf81590 <dealloc_buffers>}, {
            pos = 1, events = 0, fd = -1369378800, user_data = 0x1}, {pos = 0, events = 0, fd = 10, user_data = 0xffffade75100 <flush_cleanup>}, {pos = -1376246672, events = 65535, fd = 0, user_data = 0x0}, {pos = -1559009792, events = 2576574568, fd = -786867504, user_data = 0x99936868a3136600}, {pos = -786867504, events = 65535,
            fd = 8147532, user_data = 0x0}, {pos = -1559009792, events = 2576574568, fd = -786867504, user_data = 0x7c529c <fork_process+124>}, {pos = 9963, events = 0, fd = 0, user_data = 0x0}, {pos = 11, events = 0, fd = -786867328, user_data = 0x7c542c <postmaster_child_launch+60>}, {pos = 0, events = 0, fd = 0, user_data = 0x400}, {
            pos = 826861016, events = 0, fd = 4194304, user_data = 0x9ebb9c <MemoryContextDelete+168>}, {pos = 826882960, events = 0, fd = 826860816, user_data = 0xd7b5a0 <TopMemoryContext>}, {pos = 826860816, events = 0, fd = 14135296, user_data = 0xd6d930 <NumListenSockets>}, {pos = -786867344, events = 65535, fd = 7280632,
            user_data = 0xffffd1195bd0}, {pos = 8170340, events = 0, fd = 14131200, user_data = 0x8}, {pos = 8, events = 0, fd = 14131200, user_data = 0xd6d000 <PqRecvBuffer+7072>}, {pos = 14080304, events = 0, fd = 826860128, user_data = 0xa44730}, {pos = 11599472, events = 0, fd = 14131200, user_data = 0xffffd1195bd0}, {pos = 0, events = 0,
            fd = 0, user_data = 0x31494570}}
        nevents = <optimized out>
        __func__ = "ServerLoop"
#23 0x00000000007cab68 in PostmasterMain (argc=argc@entry=8, argv=argv@entry=0x3148f320) at postmaster.c:1372
        opt = <optimized out>
        status = <optimized out>
        userDoption = <optimized out>
        listen_addr_saved = false
        output_config_variable = <optimized out>
        __func__ = "PostmasterMain"
#24 0x0000000000496cb8 in main (argc=8, argv=0x3148f320) at main.c:197
        do_check_root = <optimized out>
(gdb)

  [text/plain] a.txt (21.3K, ../../CAEP4nAyKmw=4i8agOyfaNHU0CEGyMRQu83vk3=PDoYyik9FfTQ@mail.gmail.com/4-a.txt)
  download | inline:
[postgres@ip-172-31-18-25 ~]$ pstack 8098
#0  0x0000ffff8a9c9954 in epoll_pwait () from /lib64/libc.so.6
#1  0x000000000081aa40 in WaitEventSetWaitBlock (nevents=1, occurred_events=<optimized out>, cur_timeout=600000, set=0x108d59b8) at latch.c:1535
#2  WaitEventSetWait (set=0x108d59b8, timeout=timeout@entry=600000, occurred_events=occurred_events@entry=0xfffff9c83678, nevents=nevents@entry=1, wait_event_info=wait_event_info@entry=150994946) at latch.c:1481
#3  0x000000000081ae04 in WaitLatch (latch=<optimized out>, wakeEvents=wakeEvents@entry=41, timeout=600000, wait_event_info=wait_event_info@entry=150994946) at latch.c:513
#4  0x00000000008dd9b4 in pg_sleep (fcinfo=<optimized out>) at misc.c:406
#5  0x000000000067f5dc in ExecInterpExpr (state=0x10ad7ae8, econtext=0x10ad7810, isnull=<optimized out>) at execExprInterp.c:758
#6  0x00000000006b7808 in ExecEvalExprSwitchContext (isNull=0xfffff9c837ef, econtext=0x10ad7810, state=<optimized out>) at ../../../src/include/executor/executor.h:355
#7  ExecProject (projInfo=<optimized out>) at ../../../src/include/executor/executor.h:389
#8  ExecResult (pstate=<optimized out>) at nodeResult.c:136
#9  0x00000000006833cc in ExecProcNode (node=0x10ad7700) at ../../../src/include/executor/executor.h:273
#10 ExecutePlan (execute_once=<optimized out>, dest=0x109f2a50, direction=<optimized out>, numberTuples=0, sendTuples=<optimized out>, operation=CMD_SELECT, use_parallel_mode=<optimized out>, planstate=0x10ad7700, estate=0x10ad74d8) at execMain.c:1670
#11 standard_ExecutorRun (queryDesc=0x10adb4f8, direction=<optimized out>, count=0, execute_once=<optimized out>) at execMain.c:365
#12 0x0000000000847b44 in PortalRunSelect (portal=portal@entry=0x10952f48, forward=forward@entry=true, count=0, count@entry=9223372036854775807, dest=dest@entry=0x109f2a50) at pquery.c:924
#13 0x0000000000849360 in PortalRun (portal=portal@entry=0x10952f48, count=count@entry=9223372036854775807, isTopLevel=isTopLevel@entry=true, run_once=run_once@entry=true, dest=dest@entry=0x109f2a50, altdest=altdest@entry=0x109f2a50, qc=qc@entry=0xfffff9c83b30) at pquery.c:768
#14 0x0000000000845044 in exec_simple_query (query_string=query_string@entry=0x108d9c88 "SELECT pg_sleep(0.1);") at postgres.c:1274
#15 0x0000000000845b68 in PostgresMain (dbname=<optimized out>, username=<optimized out>) at postgres.c:4637
#16 0x00000000007ab284 in BackendRun (port=0x109050b0) at postmaster.c:4464
#17 BackendStartup (port=0x109050b0) at postmaster.c:4192
#18 ServerLoop () at postmaster.c:1782
#19 0x00000000007ac3a4 in PostmasterMain (argc=argc@entry=8, argv=argv@entry=0x108d5310) at postmaster.c:1466
#20 0x0000000000493260 in main (argc=8, argv=0x108d5310) at main.c:198
[postgres@ip-172-31-18-25 ~]$



31292 root       20   0  117M  4320  3136 S  0.0  0.0  0:00.00 │  ├─ /usr/sbin/CROND -n
31298 postgres   20   0 20988  6312  5320 S  0.0  0.0  0:00.00 │  │  ├─ /usr/sbin/sendmail -FCronDaemon -i -odi -oem -oi -t -f postgres
31307 postgres   20   0 20960  6144  5152 S  0.0  0.0  0:00.00 │  │  │  └─ /usr/sbin/postdrop -r
31293 postgres   20   0  111M  2616  2440 S  0.0  0.0  0:00.00 │  │  └─ /bin/sh -c cd /opt/postgres/build-farm-14 && PATH=/opt/gcc/home/ec2-user/proj/gcc/target/bin/:$PATH:/usr/local/bin PERL5LIB=/home/postgres/perl5/lib/perl5 ./run_build.pl --config=build-farm.conf REL_16_STABLE --verbose
31295 postgres   20   0  128M 17988  3928 S  0.0  0.1  0:00.08 │  │     └─ /usr/bin/perl ./run_build.pl --config=build-farm.conf REL_16_STABLE --verbose
 5657 postgres   20   0  111M  2628  2448 S  0.0  0.0  0:00.00 │  │        └─ sh -c { cd pgsql.build/src/test/regress && make NO_LOCALE=1 check; echo $? > /opt/postgres/build-farm-14/buildroot/REL_16_STABLE/parula.lastrun-logs/laststatus; } > /opt/postgres/build-farm-14/buildroot/REL_16_STABLE/parula.lastrun-logs/lastcommand.log 2>&1; read st <
 5658 postgres   20   0  110M  2084  1712 S  0.0  0.0  0:00.00 │  │           └─ make NO_LOCALE=1 check
 6834 postgres   20   0  111M  2676  2480 S  0.0  0.0  0:00.00 │  │              └─ /bin/sh -c echo "# +++ regress check in src/test/regress +++" && PATH="/opt/postgres/build-farm-14/buildroot/REL_16_STABLE/pgsql.build/tmp_install/opt/postgres/build-farm-14/buildroot/REL_16_STABLE/inst/bin:/opt/postgres/build-farm-14/buildroot/REL_16_STABLE/pgsq
 6835 postgres   20   0  110M  1960  1800 S  0.0  0.0  0:00.03 │  │                 └─ ../../../src/test/regress/pg_regress --temp-instance=./tmp_check --inputdir=. --bindir= --temp-config=/tmp/buildfarm-w4K7O0/bfextra.conf --no-locale --port=5768 --dlpath=. --max-concurrent-tests=20 --port=5768 --schedule=./parallel_schedule
 8090 postgres   20   0 15448  5536  4708 S  0.0  0.0  0:00.00 │  │                    ├─ psql -X -a -q -d regression -v HIDE_TABLEAM=on -v HIDE_TOAST_COMPRESSION=on
 6849 postgres   20   0  166M 20544 19404 S  0.0  0.1  0:00.33 │  │                    └─ postgres -D /opt/postgres/build-farm-14/buildroot/REL_16_STABLE/pgsql.build/src/test/regress/tmp_check/data -F -c listen_addresses= -k /tmp/pg_regress-Frl3F3
 8098 postgres   20   0  171M 41404 37216 S  0.0  0.3  0:00.05 │  │                       ├─ postgres: postgres regression [local] SELECT
 6857 postgres   20   0  169M  8752  7344 S  0.0  0.1  0:00.01 │  │                       ├─ postgres: logical replication launcher
 6856 postgres   20   0  168M  8484  7032 S  0.0  0.1  0:00.08 │  │                       ├─ postgres: autovacuum launcher
 6855 postgres   20   0  166M 10040  8868 S  0.0  0.1  0:00.06 │  │                       ├─ postgres: walwriter
 6853 postgres   20   0  166M  5400  4244 S  0.0  0.0  0:00.02 │  │                       ├─ postgres: background writer
 6852 postgres   20   0  168M  111M  109M S  0.0  0.7  0:00.12 │  │                       └─ postgres: checkpointer
 
 
#0  0x0000ffff8a9c9954 in epoll_pwait () from /lib64/libc.so.6
No symbol table info available.
#1  0x000000000081aa40 in WaitEventSetWaitBlock (nevents=1, occurred_events=<optimized out>, cur_timeout=335257, set=0x108d59b8) at latch.c:1535
        returned_events = 0
        rc = <optimized out>
        cur_event = <optimized out>
        cur_epoll_event = <optimized out>
        __func__ = "WaitEventSetWaitBlock"
#2  WaitEventSetWait (set=0x108d59b8, timeout=timeout@entry=600000, occurred_events=occurred_events@entry=0xfffff9c83678, nevents=nevents@entry=1, wait_event_info=wait_event_info@entry=150994946) at latch.c:1481
        rc = <optimized out>
        returned_events = 0
        start_time = <optimized out>
        cur_time = <optimized out>
        cur_timeout = 335257
#3  0x000000000081ae04 in WaitLatch (latch=<optimized out>, wakeEvents=wakeEvents@entry=41, timeout=600000, wait_event_info=wait_event_info@entry=150994946) at latch.c:513
        event = {pos = 9296220, events = 0, fd = 1713147409, user_data = 0xbc95e}
#4  0x00000000008dd9b4 in pg_sleep (fcinfo=<optimized out>) at misc.c:406
        delay = <optimized out>
        delay_ms = <optimized out>
        endtime = 0
#5  0x000000000067f5dc in ExecInterpExpr (state=0x10ad7ae8, econtext=0x10ad7810, isnull=<optimized out>) at execExprInterp.c:758
        fcinfo = 0x10ad7bc0
        args = 0x10ad7be0
        nargs = <optimized out>
        d = <optimized out>
        op = <optimized out>
        resultslot = 0x10ad7a00
        innerslot = 0x0
        outerslot = 0x0
        scanslot = 0x0
        dispatch_table = {0x67e6f0 <ExecInterpExpr+1840>, 0x67e104 <ExecInterpExpr+324>, 0x67e938 <ExecInterpExpr+2424>, 0x67e914 <ExecInterpExpr+2388>, 0x67e8d8 <ExecInterpExpr+2328>, 0x67e89c <ExecInterpExpr+2268>, 0x67e860 <ExecInterpExpr+2208>, 0x67e844 <ExecInterpExpr+2180>, 0x67e828 <ExecInterpExpr+2152>, 0x67e80c <ExecInterpExpr+2124>,
          0x67eb1c <ExecInterpExpr+2908>, 0x67eacc <ExecInterpExpr+2828>, 0x67ea7c <ExecInterpExpr+2748>, 0x67ea2c <ExecInterpExpr+2668>, 0x67e9f4 <ExecInterpExpr+2612>, 0x67e9ac <ExecInterpExpr+2540>, 0x67e98c <ExecInterpExpr+2508>, 0x67e95c <ExecInterpExpr+2460>, 0x67e7c8 <ExecInterpExpr+2056>, 0x67e77c <ExecInterpExpr+1980>,
          0x67e764 <ExecInterpExpr+1956>, 0x67e004 <ExecInterpExpr+68>, 0x67e00c <ExecInterpExpr+76>, 0x67efcc <ExecInterpExpr+4108>, 0x67e02c <ExecInterpExpr+108>, 0x67e034 <ExecInterpExpr+116>, 0x67f010 <ExecInterpExpr+4176>, 0x67efb0 <ExecInterpExpr+4080>, 0x67ef6c <ExecInterpExpr+4012>, 0x67ef54 <ExecInterpExpr+3988>,
          0x67ef30 <ExecInterpExpr+3952>, 0x67ef0c <ExecInterpExpr+3916>, 0x67eed4 <ExecInterpExpr+3860>, 0x67eeb8 <ExecInterpExpr+3832>, 0x67ee98 <ExecInterpExpr+3800>, 0x67ee84 <ExecInterpExpr+3780>, 0x67ee70 <ExecInterpExpr+3760>, 0x67ee4c <ExecInterpExpr+3724>, 0x67ee24 <ExecInterpExpr+3684>, 0x67ee00 <ExecInterpExpr+3648>,
          0x67edd8 <ExecInterpExpr+3608>, 0x67edc0 <ExecInterpExpr+3584>, 0x67eda8 <ExecInterpExpr+3560>, 0x67ed8c <ExecInterpExpr+3532>, 0x67ed60 <ExecInterpExpr+3488>, 0x67ed18 <ExecInterpExpr+3416>, 0x67ec6c <ExecInterpExpr+3244>, 0x67ec40 <ExecInterpExpr+3200>, 0x67ec10 <ExecInterpExpr+3152>, 0x67eba8 <ExecInterpExpr+3048>,
          0x67eb94 <ExecInterpExpr+3028>, 0x67fb08 <ExecInterpExpr+6984>, 0x67eb80 <ExecInterpExpr+3008>, 0x67eb6c <ExecInterpExpr+2988>, 0x67eb34 <ExecInterpExpr+2932>, 0x67f33c <ExecInterpExpr+4988>, 0x67f2b8 <ExecInterpExpr+4856>, 0x67f274 <ExecInterpExpr+4788>, 0x67f260 <ExecInterpExpr+4768>, 0x67f248 <ExecInterpExpr+4744>,
          0x67f230 <ExecInterpExpr+4720>, 0x67f218 <ExecInterpExpr+4696>, 0x67f1f8 <ExecInterpExpr+4664>, 0x67f0fc <ExecInterpExpr+4412>, 0x67f0e0 <ExecInterpExpr+4384>, 0x67f0c4 <ExecInterpExpr+4356>, 0x67ed34 <ExecInterpExpr+3444>, 0x67f06c <ExecInterpExpr+4268>, 0x67f04c <ExecInterpExpr+4236>, 0x67f0ac <ExecInterpExpr+4332>,
          0x67f098 <ExecInterpExpr+4312>, 0x67f080 <ExecInterpExpr+4288>, 0x67f1e4 <ExecInterpExpr+4644>, 0x67f1cc <ExecInterpExpr+4620>, 0x67f1b8 <ExecInterpExpr+4600>, 0x67f188 <ExecInterpExpr+4552>, 0x67f174 <ExecInterpExpr+4532>, 0x67f13c <ExecInterpExpr+4476>, 0x67f118 <ExecInterpExpr+4440>, 0x67e054 <ExecInterpExpr+148>,
          0x67e060 <ExecInterpExpr+160>, 0x67e71c <ExecInterpExpr+1884>, 0x67e6ac <ExecInterpExpr+1772>, 0x67e680 <ExecInterpExpr+1728>, 0x67e5c0 <ExecInterpExpr+1536>, 0x67e508 <ExecInterpExpr+1352>, 0x67e358 <ExecInterpExpr+920>, 0x67e408 <ExecInterpExpr+1096>, 0x67e264 <ExecInterpExpr+676>, 0x67e178 <ExecInterpExpr+440>,
          0x67e150 <ExecInterpExpr+400>, 0x67e128 <ExecInterpExpr+360>, 0x67e0dc <ExecInterpExpr+284>, 0x67e0c4 <ExecInterpExpr+260>, 0x67f89c <ExecInterpExpr+6364>}
#6  0x00000000006b7808 in ExecEvalExprSwitchContext (isNull=0xfffff9c837ef, econtext=0x10ad7810, state=<optimized out>) at ../../../src/include/executor/executor.h:355
        oldContext = 0x10ad73c0
#7  ExecProject (projInfo=<optimized out>) at ../../../src/include/executor/executor.h:389
        econtext = 0x10ad7810
        state = <optimized out>
        slot = 0x10ad7a00
        isnull = 33
#8  ExecResult (pstate=<optimized out>) at nodeResult.c:136
        node = <optimized out>
        outerTupleSlot = <optimized out>
        outerPlan = <optimized out>
        econtext = <optimized out>
#9  0x00000000006833cc in ExecProcNode (node=0x10ad7700) at ../../../src/include/executor/executor.h:273
No locals.
#10 ExecutePlan (execute_once=<optimized out>, dest=0x109f2a50, direction=<optimized out>, numberTuples=0, sendTuples=<optimized out>, operation=CMD_SELECT, use_parallel_mode=<optimized out>, planstate=0x10ad7700, estate=0x10ad74d8) at execMain.c:1670
        slot = <optimized out>
        current_tuple_count = 0
#11 standard_ExecutorRun (queryDesc=0x10adb4f8, direction=<optimized out>, count=0, execute_once=<optimized out>) at execMain.c:365
        estate = 0x10ad74d8
        operation = CMD_SELECT
        dest = 0x109f2a50
        sendTuples = 252
        oldcontext = 0x10adb3e0
        __func__ = "standard_ExecutorRun"
#12 0x0000000000847b44 in PortalRunSelect (portal=portal@entry=0x10952f48, forward=forward@entry=true, count=0, count@entry=9223372036854775807, dest=dest@entry=0x109f2a50) at pquery.c:924
        queryDesc = 0x10adb4f8
        direction = <optimized out>
        nprocessed = <optimized out>
        __func__ = "PortalRunSelect"
#13 0x0000000000849360 in PortalRun (portal=portal@entry=0x10952f48, count=count@entry=9223372036854775807, isTopLevel=isTopLevel@entry=true, run_once=run_once@entry=true, dest=dest@entry=0x109f2a50, altdest=altdest@entry=0x109f2a50, qc=qc@entry=0xfffff9c83b30) at pquery.c:768
        _save_exception_stack = 0xfffff9c83de8
        _save_context_stack = 0x0
        _local_sigjmp_buf = {{__jmpbuf = {1, 278212424, 277719512, 277719560, 0, 278866512, 0, 2, 13605592, 277719592, 281474872391856, 2455851481445542082, 277697712, 2455605387221598826, 4631952216750555136, 0, 0, 0, 0, 0, 0, 0}, __mask_was_saved = 0, __saved_mask = {__val = {112, 277715824, 277719512, 13602816, 281474872392256, 8686156,
                281474872392288, 4874408, 2, 278212424, 277719512, 277719560, 281474872392320, 8671248, 277719584, 8671184}}}}
        result = <optimized out>
        nprocessed = <optimized out>
        saveTopTransactionResourceOwner = 0x109673a8
        saveTopTransactionContext = 0x1090cd40
        saveActivePortal = 0x0
        saveResourceOwner = 0x109673a8
        savePortalContext = 0x0
        saveMemoryContext = 0x1090cd40
        __func__ = "PortalRun"
#14 0x0000000000845044 in exec_simple_query (query_string=query_string@entry=0x108d9c88 "SELECT pg_sleep(0.1);") at postgres.c:1274
        cmdtaglen = 6
        snapshot_set = <optimized out>
        per_parsetree_context = 0x0
        plantree_list = 0x109f2a00
        parsetree = <error reading variable parsetree (dwarf2_find_location_expression: Corrupted DWARF expression.)>
        commandTag = <optimized out>
        qc = {commandTag = CMDTAG_UNKNOWN, nprocessed = 0}
        querytree_list = <error reading variable querytree_list (dwarf2_find_location_expression: Corrupted DWARF expression.)>
        portal = 0x10952f48
        receiver = 0x109f2a50
        format = 0
        cmdtagname = <error reading variable cmdtagname (dwarf2_find_location_expression: Corrupted DWARF expression.)>
        parsetree_item__state = {l = 0x108daa08, i = 0}
        dest = DestRemote
        oldcontext = 0x1090cd40
        parsetree_list = 0x108daa08
        parsetree_item = 0x108daa20
        save_log_statement_stats = <optimized out>
        was_logged = true
        use_implicit_block = false
        msec_str = "\000\000\000\000\377\377\000\000\000\000\000\000\000\000\000\000X\002\317\000\000\000\000\000Q\000\000\000\000\000\000"
        __func__ = "exec_simple_query"
#15 0x0000000000845b68 in PostgresMain (dbname=<optimized out>, username=<optimized out>) at postgres.c:4637
        query_string = <error reading variable query_string (dwarf2_find_location_expression: Corrupted DWARF expression.)>
        firstchar = <optimized out>
        input_message = {data = 0x108d9c88 "SELECT pg_sleep(0.1);", len = 22, maxlen = 1024, cursor = 22}
        local_sigjmp_buf = {{__jmpbuf = {13602816, 13602816, 8662912, 281474872393704, 277894208, 281474872394760, 277888464, 13455360, 0, 13551280, 281474872392544, 2455851481445527378, 15624, 2455605387221598602, 4631952216750555136, 0, 0, 0, 0, 0, 0, 0}, __mask_was_saved = 1, __saved_mask = {__val = {4194304, 7834284, 281474872393440,
                8561608, 13562696, 13598720, 13602816, 8625692, 281474872393504, 8041068, 281474872393648, 277893296, 11145024, 281474872393704, 277894208, 277893296}}}}
        send_ready_for_query = false
        idle_in_transaction_timeout_enabled = false
        idle_session_timeout_enabled = false
        __func__ = "PostgresMain"
#16 0x00000000007ab284 in BackendRun (port=0x109050b0) at postmaster.c:4464
No locals.
#17 BackendStartup (port=0x109050b0) at postmaster.c:4192
        bn = 0x10905440
        pid = <optimized out>
        __func__ = "BackendStartup"
#18 ServerLoop () at postmaster.c:1782
        port = 0x109050b0
        i = <optimized out>
        now = <optimized out>
        last_lockfile_recheck_time = 1713135987
        last_touch_time = 1713135987
        events = {{pos = 1, events = 2, fd = 7, user_data = 0x0}, {pos = 32816, events = 0, fd = -104315824, user_data = 0xffff8a9945a8 <__alloc_dir+72>}, {pos = 32768, events = 0, fd = 8, user_data = 0x1}, {pos = 10502040, events = 0, fd = -104315824, user_data = 0x400}, {pos = -104315632, events = 65535, fd = -1969666388,
            user_data = 0xffff8aa6d000 <argp_default_argp+16>}, {pos = 8, events = 0, fd = -104315768, user_data = 0x0}, {pos = -104315520, events = 65535, fd = 66305, user_data = 0x1a81d3c4}, {pos = 16832, events = 2, fd = 1001, user_data = 0x0}, {pos = 0, events = 0, fd = 6, user_data = 0x1000}, {pos = 0, events = 0, fd = -104315504,
            user_data = 0xffff8a96ba0c <malloc+156>}, {pos = -104315488, events = 65535, fd = -1969833460, user_data = 0xffff8aa6ea88 <main_arena>}, {pos = 4096, events = 0, fd = -1961892016, user_data = 0xffff8b0fe700}, {pos = 80, events = 0, fd = 277883320, user_data = 0x0}, {pos = 1, events = 0, fd = 0, user_data = 0xadaa98}, {
            pos = -1970278784, events = 65535, fd = 1867, user_data = 0x1}, {pos = -1970333812, events = 65535, fd = -1961839552, user_data = 0x0}, {pos = 119, events = 124, fd = 1, user_data = 0x630000006f}, {pos = 0, events = 0, fd = -104315408, user_data = 0xffff8b0e2cbc <do_lookup_x+556>}, {pos = -1967215448, events = 65535, fd = 173,
            user_data = 0x1}, {pos = -1967223912, events = 65535, fd = -1961797040, user_data = 0x5}, {pos = -1961797040, events = 65535, fd = -104315208, user_data = 0xfffff9c846b4}, {pos = 66305, events = 0, fd = -104315168, user_data = 0xffff8b0e3644 <_dl_lookup_symbol_x+260>}, {pos = 2090263927, events = 0, fd = -1961773784,
            user_data = 0x4540dd}, {pos = -104314824, events = 65535, fd = -1961874848, user_data = 0x1}, {pos = -1961774688, events = 65535, fd = 1, user_data = 0xfffff9c84780}, {pos = 0, events = 0, fd = 32, user_data = 0x0}, {pos = 6, events = 0, fd = -1961875160, user_data = 0xffff00000000}, {pos = -104315008, events = 65535,
            fd = -104314992, user_data = 0x43e740}, {pos = 4538589, events = 0, fd = -104315208, user_data = 0xfffff9c846b4}, {pos = 32660373, events = 0, fd = -104315168, user_data = 0x0}, {pos = 1, events = 0, fd = 0, user_data = 0x1}, {pos = -1961774688, events = 65535, fd = -104314896, user_data = 0xffff8b0e7820 <_dl_fixup+192>}, {pos = 0,
            events = 0, fd = 13437312, user_data = 0xffff8b0fdf00}, {pos = -1961892096, events = 65535, fd = 13549568, user_data = 0xcec6b0 <ListenSocket>}, {pos = 277693024, events = 0, fd = 10528136, user_data = 0xacaed8}, {pos = 11381400, events = 0, fd = -104314944, user_data = 0x9b00b8 <AllocSetReset+40>}, {pos = 277882224, events = 0,
            fd = 1343407616, user_data = 0xfffff9c847c0}, {pos = 0, events = 0, fd = -1961773784, user_data = 0xfffff9c84790}, {pos = 448139, events = 0, fd = 1024, user_data = 0xffff8abe9e38}, {pos = -1961797040, events = 65535, fd = 277883321, user_data = 0x108d9b70}, {pos = 0, events = 0, fd = 5120, user_data = 0xfffff9c847f0}, {
            pos = 10185012, events = 0, fd = 277882224, user_data = 0x10902570}, {pos = 277882224, events = 0, fd = 277883248, user_data = 0xfffff9c84920}, {pos = -1961960460, events = 65535, fd = 3, user_data = 0x8}, {pos = 8, events = 0, fd = 13602816, user_data = 0xcec000 <PqRecvBuffer+7712>}, {pos = 277693024, events = 0, fd = 277882224,
            user_data = 0xffff8abe9e38}, {pos = 135, events = 0, fd = -40, user_data = 0xfffff9c848c0}, {pos = -1969858540, events = 65535, fd = -1968765528, user_data = 0xffff8aa70590 <dealloc_buffers>}, {pos = 1, events = 0, fd = -1961893872, user_data = 0x1}, {pos = 0, events = 0, fd = 1635021578,
            user_data = 0xffff8a964100 <flush_cleanup>}, {pos = -1968761744, events = 65535, fd = 0, user_data = 0x0}, {pos = 1343407616, events = 3428591778, fd = -104314592, user_data = 0xcc5c28a25012c600}, {pos = -104314592, events = 65535, fd = 8019644, user_data = 0x0}, {pos = 1343407616, events = 3428591778, fd = -104314592,
            user_data = 0x7a5f0c <fork_process+124>}, {pos = 6854, events = 0, fd = 8, user_data = 0x8}, {pos = 13602816, events = 0, fd = -104314416, user_data = 0x7a8d64 <StartChildProcess+20>}, {pos = 0, events = 0, fd = 8, user_data = 0x108d4510}, {pos = 1024, events = 0, fd = 4194304, user_data = 0x6d8e78 <load_ident+388>}, {
            pos = 13541376, events = 0, fd = 0, user_data = 0xfffff9c849f0}, {pos = 8045472, events = 0, fd = 13602816, user_data = 0x8}, {pos = 8, events = 0, fd = 13602816, user_data = 0xcec000 <PqRecvBuffer+7712>}, {pos = 13551280, events = 0, fd = 277693024, user_data = 0xa0a588}, {pos = 11316952, events = 0, fd = 8,
            user_data = 0xfffff9c849f0}, {pos = 0, events = 0, fd = 0, user_data = 0x10904010}}
        nevents = <optimized out>
        __func__ = "ServerLoop"
#19 0x00000000007ac3a4 in PostmasterMain (argc=argc@entry=8, argv=argv@entry=0x108d5310) at postmaster.c:1466
        opt = <optimized out>
        status = <optimized out>
        userDoption = <optimized out>
        listen_addr_saved = false
        i = <optimized out>
        output_config_variable = <optimized out>
        __func__ = "PostmasterMain"
#20 0x0000000000493260 in main (argc=8, argv=0x108d5310) at main.c:198
        do_check_root = <optimized out>
(gdb)

^ permalink  raw  reply  [nested|flat] 29+ messages in thread

* Re: Why is parula failing?
@ 2024-04-15 05:24  David Rowley <[email protected]>
  parent: Robins Tharakan <[email protected]>
  1 sibling, 1 reply; 29+ messages in thread

From: David Rowley @ 2024-04-15 05:24 UTC (permalink / raw)
  To: Robins Tharakan <[email protected]>; +Cc: Tom Lane <[email protected]>; Tomas Vondra <[email protected]>; Tharakan, Robins <[email protected]>; [email protected] <[email protected]>

On Mon, 15 Apr 2024 at 16:10, Robins Tharakan <[email protected]> wrote:
> - I now have 2 separate runs stuck on pg_sleep() - HEAD / REL_16_STABLE
> - I'll keep them (stuck) for this week, in case there's more we can get
> from them (and to see how long they take)
> - Attached are 'bt full' outputs for both (b.txt - HEAD / a.txt - REL_16_STABLE)

Thanks for getting those.

#4  0x000000000090b7b4 in pg_sleep (fcinfo=<optimized out>) at misc.c:406
        delay = <optimized out>
        delay_ms = <optimized out>
        endtime = 0

This endtime looks like a problem. It seems unlikely to be caused by
gettimeofday's timeval fields being zeroed given that the number of
seconds should have been added to that.

I can't quite make sense of how we end up sleeping at all with a zero
endtime. Assuming the subsequent GetNowFloats() worked, "delay =
endtime - GetNowFloat();" would result in a negative sleep duration
and we'd break out of the sleep loop.

If GetNowFloat() somehow was returning a negative number then we could
end up with a large delay.  But if gettimeofday() was so badly broken
then wouldn't there be some evidence of this in the log timestamps on
failing runs?

I'm not that familiar with the buildfarm config, but I do see some
Valgrind related setting in there. Is PostgreSQL running under
Valgrind on these runs?

David






^ permalink  raw  reply  [nested|flat] 29+ messages in thread

* Re: Why is parula failing?
@ 2024-04-15 05:42  Robins Tharakan <[email protected]>
  parent: David Rowley <[email protected]>
  0 siblings, 0 replies; 29+ messages in thread

From: Robins Tharakan @ 2024-04-15 05:42 UTC (permalink / raw)
  To: David Rowley <[email protected]>; +Cc: Tom Lane <[email protected]>; Tomas Vondra <[email protected]>; Tharakan, Robins <[email protected]>; [email protected] <[email protected]>

On Mon, 15 Apr 2024 at 14:55, David Rowley <[email protected]> wrote:
> If GetNowFloat() somehow was returning a negative number then we could
> end up with a large delay.  But if gettimeofday() was so badly broken
> then wouldn't there be some evidence of this in the log timestamps on
> failing runs?

3 things stand out for me here, unsure if they're related somehow:

1. Issue where reltuples=48 (in essence runs complete, but few tests fail)
2. SIGABRT - most of which are DDLs (runs complete, but engine crashes +
many tests fail)
3. pg_sleep() stuck - (runs never complete, IIUC never gets reported to
buildfarm)

For #3, one thing I had done earlier (and then reverted) was to set the
'wait_timeout' from current undef to 2 hours. I'll set it again to 2hrs
in hopes that #3 starts getting reported to buildfarm too.

> I'm not that familiar with the buildfarm config, but I do see some
> Valgrind related setting in there. Is PostgreSQL running under
> Valgrind on these runs?

Not yet. I was tempted, but valgrind has not yet been enabled on
this member. IIUC by default they're disabled.

                   'use_valgrind' => undef,

-
robins


^ permalink  raw  reply  [nested|flat] 29+ messages in thread

* Re: Why is parula failing?
@ 2024-04-15 06:31  Tom Lane <[email protected]>
  parent: Robins Tharakan <[email protected]>
  1 sibling, 1 reply; 29+ messages in thread

From: Tom Lane @ 2024-04-15 06:31 UTC (permalink / raw)
  To: David Rowley <[email protected]>; +Cc: Robins Tharakan <[email protected]>; Tomas Vondra <[email protected]>; Tharakan, Robins <[email protected]>; [email protected] <[email protected]>

David Rowley <[email protected]> writes:
> #4  0x000000000090b7b4 in pg_sleep (fcinfo=<optimized out>) at misc.c:406
>         delay = <optimized out>
>         delay_ms = <optimized out>
>         endtime = 0

> This endtime looks like a problem. It seems unlikely to be caused by
> gettimeofday's timeval fields being zeroed given that the number of
> seconds should have been added to that.

Yes, that is very odd.

> I can't quite make sense of how we end up sleeping at all with a zero
> endtime. Assuming the subsequent GetNowFloats() worked, "delay =
> endtime - GetNowFloat();" would result in a negative sleep duration
> and we'd break out of the sleep loop.

If GetCurrentTimestamp() were returning assorted random values, it
wouldn't be hard to imagine this loop sleeping for a long time.
But it's very hard to see how that theory leads to an "endtime"
of exactly zero rather than some other number, and even harder
to credit two different runs getting "endtime" of exactly zero.

> If GetNowFloat() somehow was returning a negative number then we could
> end up with a large delay.  But if gettimeofday() was so badly broken
> then wouldn't there be some evidence of this in the log timestamps on
> failing runs?

And indeed that too.  I'm finding the "compiler bug" theory
palatable.  Robins mentioned having built the compiler from
source, which theoretically should work, but maybe something
went wrong?  Or it's missing some important bug fix?

It might be interesting to back the animal's CFLAGS down
to -O0 and see if things get more stable.

			regards, tom lane






^ permalink  raw  reply  [nested|flat] 29+ messages in thread

* Re: Why is parula failing?
@ 2024-04-16 06:57  Robins Tharakan <[email protected]>
  parent: Tom Lane <[email protected]>
  0 siblings, 1 reply; 29+ messages in thread

From: Robins Tharakan @ 2024-04-16 06:57 UTC (permalink / raw)
  To: Tom Lane <[email protected]>; +Cc: David Rowley <[email protected]>; Tomas Vondra <[email protected]>; Tharakan, Robins <[email protected]>; [email protected] <[email protected]>

On Mon, 15 Apr 2024 at 16:02, Tom Lane <[email protected]> wrote:
> David Rowley <[email protected]> writes:
> > If GetNowFloat() somehow was returning a negative number then we could
> > end up with a large delay.  But if gettimeofday() was so badly broken
> > then wouldn't there be some evidence of this in the log timestamps on
> > failing runs?
>
> And indeed that too.  I'm finding the "compiler bug" theory
> palatable.  Robins mentioned having built the compiler from
> source, which theoretically should work, but maybe something
> went wrong?  Or it's missing some important bug fix?
>
> It might be interesting to back the animal's CFLAGS down
> to -O0 and see if things get more stable.

The last 25 consecutive runs have passed [1] after switching
REL_12_STABLE to -O0 ! So I am wondering whether that confirms that
the compiler version is to blame, and while we're still here,
is there anything else I could try?

If not, by Sunday, I am considering switching parula to gcc v12 (or even
v14 experimental - given that massasauga [2] has been pretty stable since
its upgrade a few days back).

Reference:
1.
https://buildfarm.postgresql.org/cgi-bin/show_history.pl?nm=parula&br=REL_12_STABLE
2.
https://buildfarm.postgresql.org/cgi-bin/show_history.pl?nm=massasauga&br=REL_12_STABLE
-
robins


^ permalink  raw  reply  [nested|flat] 29+ messages in thread

* Re: Why is parula failing?
@ 2024-04-17 01:34  David Rowley <[email protected]>
  parent: Robins Tharakan <[email protected]>
  0 siblings, 0 replies; 29+ messages in thread

From: David Rowley @ 2024-04-17 01:34 UTC (permalink / raw)
  To: Robins Tharakan <[email protected]>; +Cc: Tom Lane <[email protected]>; Tomas Vondra <[email protected]>; Tharakan, Robins <[email protected]>; [email protected] <[email protected]>

On Tue, 16 Apr 2024 at 18:58, Robins Tharakan <[email protected]> wrote:
> The last 25 consecutive runs have passed [1] after switching
> REL_12_STABLE to -O0 ! So I am wondering whether that confirms that
> the compiler version is to blame, and while we're still here,
> is there anything else I could try?

I don't think it's conclusive proof that it's a compiler bug.  -O0
could equally just have changed the timing sufficiently to not trigger
the issue.

It might be a long shot, but I wonder if it might be worth running a
workload such as:

psql -c "create table a (a int primary key, b text not null, c int not
null); insert into a values(1,'',0);" postgres
echo "update a set b = repeat('a', random(1,10)), c=c+1 where a = 1;"
> bench.sql
pgbench -n -t 12500 -c 8 -j 8 -f bench.sql postgres
psql -c "table a;" postgres

On a build with the original CFLAGS.  I expect the value of "c" to be
100k after running that. If it's not then something bad has happened.

That would exercise the locking code heavily and would show us if any
updates were missed due to locks not being correctly respected or seen
by other backends.

David






^ permalink  raw  reply  [nested|flat] 29+ messages in thread


end of thread, other threads:[~2024-04-17 01:34 UTC | newest]

Thread overview: 29+ messages (download: mbox mbox.gz follow: Atom feed)
-- links below jump to the message on this page --
2020-02-27 01:22 [PATCH v29 3/3] Avoid some calls to RelationGetRelationName Justin Pryzby <[email protected]>
2020-02-27 01:22 [PATCH v28 5/5] Avoid some calls to RelationGetRelationName Justin Pryzby <[email protected]>
2020-02-27 01:22 [PATCH v39 1/2] Avoid some calls to RelationGetRelationName Justin Pryzby <[email protected]>
2020-02-27 01:22 [PATCH v32 3/3] Avoid some calls to RelationGetRelationName Justin Pryzby <[email protected]>
2020-02-27 01:22 [PATCH v25 4/4] Avoid some calls to RelationGetRelationName Justin Pryzby <[email protected]>
2020-02-27 01:22 [PATCH v37 3/3] Avoid some calls to RelationGetRelationName Justin Pryzby <[email protected]>
2020-02-27 01:22 [PATCH v27 5/5] Avoid some calls to RelationGetRelationName Justin Pryzby <[email protected]>
2020-02-27 01:22 [PATCH v33 3/3] Avoid some calls to RelationGetRelationName Justin Pryzby <[email protected]>
2020-02-27 01:22 [PATCH v24 4/4] Avoid some calls to RelationGetRelationName Justin Pryzby <[email protected]>
2020-02-27 01:22 [PATCH v23 3/3] Avoid some calls to RelationGetRelationName Justin Pryzby <[email protected]>
2020-02-27 01:22 [PATCH v36 3/3] Avoid some calls to RelationGetRelationName Justin Pryzby <[email protected]>
2024-01-18 23:11 Re: Add PQsendSyncMessage() to libpq Anton Kirilov <[email protected]>
2024-04-02 04:27 RE: Why is parula failing? Tharakan, Robins <[email protected]>
2024-04-02 04:31 ` Re: Why is parula failing? Tom Lane <[email protected]>
2024-04-08 11:55   ` Re: Why is parula failing? Robins Tharakan <[email protected]>
2024-04-09 03:48     ` Re: Why is parula failing? David Rowley <[email protected]>
2024-04-10 00:54       ` Re: Why is parula failing? David Rowley <[email protected]>
2024-04-10 01:13         ` Re: Why is parula failing? Robins Tharakan <[email protected]>
2024-04-13 13:02         ` Re: Why is parula failing? Robins Tharakan <[email protected]>
2024-04-13 18:11           ` Re: Why is parula failing? Tomas Vondra <[email protected]>
2024-04-13 18:05       ` Re: Why is parula failing? Tomas Vondra <[email protected]>
2024-04-13 13:31     ` Re: Why is parula failing? Robins Tharakan <[email protected]>
2024-04-13 14:42       ` Re: Why is parula failing? Tom Lane <[email protected]>
2024-04-15 04:09         ` Re: Why is parula failing? Robins Tharakan <[email protected]>
2024-04-15 05:24           ` Re: Why is parula failing? David Rowley <[email protected]>
2024-04-15 05:42             ` Re: Why is parula failing? Robins Tharakan <[email protected]>
2024-04-15 06:31           ` Re: Why is parula failing? Tom Lane <[email protected]>
2024-04-16 06:57             ` Re: Why is parula failing? Robins Tharakan <[email protected]>
2024-04-17 01:34               ` Re: Why is parula failing? David Rowley <[email protected]>

This inbox is served by agora; see mirroring instructions
for how to clone and mirror all data and code used for this inbox