Hello Masahiko-san, 01.12.2023 05:14, Masahiko Sawada wrote:
FYI I've configured the buildfarm animal perentie to run regression tests including xid_wraparound:https://buildfarm.postgresql.org/cgi-bin/show_history.pl?nm=perentie&br=HEAD
Please look at a failure produced by perentie recently: [1]. I've analyzed all the available detailed perentie logs (starting from 2024-04-04) and got the following durations of the pg_ctl stop operation at the end of the 001_emergency_vacuum.pl (from the module-xid_wraparound-check stage): see perentie-timings.txt and perentie-timings.png attached. So it looks like perentie needs larger PGCTLTIMEOUT for the test (maybe 180 seconds would work?). Though it's not clear to me, why this test takes so long on that animal, even when it succeeds. For example, [2] shows: [09:28:23] t/001_emergency_vacuum.pl .. ok 225894 ms ( 0.00 usr 0.00 sys + 0.31 cusr 0.43 csys = 0.74 CPU) [09:30:53] t/002_limits.pl ............ ok 150291 ms ( 0.00 usr 0.00 sys + 1.85 cusr 1.50 csys = 3.35 CPU) [09:49:33] t/003_wraparounds.pl ....... ok 1119766 ms ( 0.00 usr 0.00 sys + 1.68 cusr 2.39 csys = 4.07 CPU) While what I'm seeing locally on my Fedora 40 VM is: PG_TEST_EXTRA="xid_wraparound" make -s check -C src/test/modules/xid_wraparound/ PROVE_FLAGS="--timer" # +++ tap check in src/test/modules/xid_wraparound +++ [04:41:56] t/001_emergency_vacuum.pl .. ok 18852 ms ( 0.01 usr 0.00 sys + 0.14 cusr 0.28 csys = 0.43 CPU) [04:42:15] t/002_limits.pl ............ ok 18539 ms ( 0.00 usr 0.00 sys + 0.72 cusr 0.88 csys = 1.60 CPU) [04:42:34] t/003_wraparounds.pl ....... ok 74368 ms ( 0.00 usr 0.00 sys + 0.82 cusr 2.57 csys = 3.39 CPU) Also, maybe it would make sense to run this test for REL_17_STABLE too, as dodo is not with us since 2024-09-04, and I don't know if there are other animals running these tests (having xid_wraparound in PG_TEST_EXTRA). [1] https://buildfarm.postgresql.org/cgi-bin/show_log.pl?nm=perentie&dt=2024-10-05%2000%3A00%3A14 [2] https://buildfarm.postgresql.org/cgi-bin/show_log.pl?nm=perentie&dt=2024-10-06%2000%3A00%3A13 Best regards, Alexander
dt=2024-04-04 00:02:21-waiting for server to shut down.......................................................... done dt=2024-04-05 00:00:07-waiting for server to shut down............................ done dt=2024-04-06 00:00:07-waiting for server to shut down................................................. done dt=2024-04-07 00:00:05-waiting for server to shut down........................................................................................ done dt=2024-04-08 00:02:47-waiting for server to shut down................................ done dt=2024-04-09 00:02:43-waiting for server to shut down............................ done dt=2024-04-10 00:00:05-waiting for server to shut down............................... done dt=2024-04-11 00:00:06-waiting for server to shut down...... done dt=2024-04-12 00:00:06-waiting for server to shut down.......................... done dt=2024-04-13 00:00:07-waiting for server to shut down................................... done dt=2024-04-14 00:00:06-waiting for server to shut down......................................... done dt=2024-04-15 00:02:48-waiting for server to shut down............................. done dt=2024-04-16 00:00:07-waiting for server to shut down................................... done dt=2024-04-17 00:02:33-waiting for server to shut down....................................... done dt=2024-04-18 00:00:06-waiting for server to shut down................................ done dt=2024-04-19 00:00:05-waiting for server to shut down............................................................ done dt=2024-04-20 00:00:06-waiting for server to shut down....................................................... done dt=2024-04-21 00:00:05-waiting for server to shut down........................................................ done dt=2024-04-22 00:00:05-waiting for server to shut down........................................... done dt=2024-04-23 00:00:06-waiting for server to shut down.................................................... done dt=2024-04-24 00:00:05-waiting for server to shut down........................................ done dt=2024-04-25 00:02:47-waiting for server to shut down............................... done dt=2024-04-26 00:00:06-waiting for server to shut down.............................. done dt=2024-04-27 00:00:06-waiting for server to shut down....................................................................... done dt=2024-04-28 00:00:05-waiting for server to shut down....................................... done dt=2024-04-29 00:02:31-waiting for server to shut down............................. done dt=2024-05-01 00:00:03-waiting for server to shut down............................... done dt=2024-05-02 00:02:36-waiting for server to shut down......................................... done dt=2024-05-03 00:00:05-waiting for server to shut down......................... done dt=2024-05-04 00:00:06-waiting for server to shut down.................................. done dt=2024-05-06 00:00:04-waiting for server to shut down.............................. done dt=2024-05-07 00:00:05-waiting for server to shut down................................. done dt=2024-05-08 00:00:06-waiting for server to shut down................................... done dt=2024-05-10 00:00:04-waiting for server to shut down........................................ done dt=2024-05-11 00:02:23-waiting for server to shut down...................................................... done dt=2024-05-12 00:00:05-waiting for server to shut down....................................... done dt=2024-05-13 00:00:06-waiting for server to shut down.......................................... done dt=2024-05-14 00:02:27-waiting for server to shut down................................ done dt=2024-05-15 00:00:05-waiting for server to shut down................................. done dt=2024-05-16 00:00:06-waiting for server to shut down.................................................. done dt=2024-05-17 00:00:06-waiting for server to shut down.............................................. done dt=2024-05-18 00:02:33-waiting for server to shut down...................................... done dt=2024-05-19 00:00:06-waiting for server to shut down....................................... done dt=2024-05-21 00:00:04-waiting for server to shut down........................................ done dt=2024-05-22 00:02:19-waiting for server to shut down....................................... done dt=2024-05-23 00:00:07-waiting for server to shut down.................................. done dt=2024-05-24 00:00:06-waiting for server to shut down.......................... done dt=2024-05-25 00:00:05-waiting for server to shut down.................. done dt=2024-05-27 00:00:04-waiting for server to shut down................................................................. done dt=2024-05-28 00:00:06-waiting for server to shut down............................ done dt=2024-06-04 00:00:04-waiting for server to shut down...................................... done dt=2024-06-05 00:00:05-waiting for server to shut down.............................................. done dt=2024-06-06 00:00:05-waiting for server to shut down................................. done dt=2024-06-07 00:00:06-waiting for server to shut down....................... done dt=2024-06-08 00:00:06-waiting for server to shut down........................ done dt=2024-06-11 00:00:03-waiting for server to shut down....................................... done dt=2024-06-12 00:00:06-waiting for server to shut down................................ done dt=2024-06-13 00:00:06-waiting for server to shut down.................................. done dt=2024-06-14 00:00:06-waiting for server to shut down......................................................... done dt=2024-06-15 00:00:06-waiting for server to shut down.............................................. done dt=2024-06-17 00:00:04-waiting for server to shut down............................ done dt=2024-06-18 00:00:05-waiting for server to shut down.................................. done dt=2024-06-19 00:00:08-waiting for server to shut down.............................. done dt=2024-06-20 00:00:05-waiting for server to shut down................... done dt=2024-06-21 00:00:05-waiting for server to shut down....................................... done dt=2024-06-22 00:00:09-waiting for server to shut down.......................... done dt=2024-06-23 00:00:05-waiting for server to shut down....................... done dt=2024-06-25 00:00:05-waiting for server to shut down.................................. done dt=2024-06-26 00:00:06-waiting for server to shut down........................................... done dt=2024-06-27 00:00:06-waiting for server to shut down................................ done dt=2024-06-28 00:00:06-waiting for server to shut down....................... done dt=2024-06-29 00:00:06-waiting for server to shut down.......................................... done dt=2024-07-01 00:00:04-waiting for server to shut down.............................................................................. done dt=2024-07-01 00:00:04-waiting for server to shut down.............................................................................. done dt=2024-07-02 00:00:06-waiting for server to shut down............................................... done dt=2024-07-03 00:00:06-waiting for server to shut down.................................................................. done dt=2024-07-04 00:00:06-waiting for server to shut down................................................. done dt=2024-07-05 00:00:06-waiting for server to shut down......................... done dt=2024-07-06 00:00:05-waiting for server to shut down.................................................................... done dt=2024-07-07 00:00:06-waiting for server to shut down................................................... done dt=2024-07-09 00:00:04-waiting for server to shut down............................... done dt=2024-07-10 00:00:06-waiting for server to shut down.......................................... done dt=2024-07-11 00:00:05-waiting for server to shut down........................................... done dt=2024-07-12 00:00:06-waiting for server to shut down....................... done dt=2024-07-13 00:00:05-waiting for server to shut down.............................. done dt=2024-07-14 00:00:06-waiting for server to shut down.............................. done dt=2024-07-15 00:00:05-waiting for server to shut down.............................................. done dt=2024-07-16 00:00:05-waiting for server to shut down..................................... done dt=2024-07-17 00:00:03-waiting for server to shut down.............................. done dt=2024-07-18 00:00:04-waiting for server to shut down.............................. done dt=2024-07-19 00:00:06-waiting for server to shut down.................................. done dt=2024-07-20 00:00:06-waiting for server to shut down.............. done dt=2024-07-21 00:00:06-waiting for server to shut down.......................... done dt=2024-07-23 00:00:06-waiting for server to shut down..................................................................... done dt=2024-07-24 00:00:06-waiting for server to shut down................................. done dt=2024-07-25 00:00:11-waiting for server to shut down................................................................. done dt=2024-07-26 00:00:05-waiting for server to shut down.............. done dt=2024-07-27 00:00:03-waiting for server to shut down........................................... done dt=2024-07-28 00:00:04-waiting for server to shut down............................................................ done dt=2024-07-29 00:00:06-waiting for server to shut down........................................................................... done dt=2024-07-30 00:00:07-waiting for server to shut down................................ done dt=2024-07-31 00:00:06-waiting for server to shut down.................................... done dt=2024-08-02 00:00:04-waiting for server to shut down.................................. done dt=2024-08-03 00:00:05-waiting for server to shut down............................................................................... done dt=2024-08-04 00:00:05-waiting for server to shut down............................. done dt=2024-08-05 00:00:06-waiting for server to shut down.................................. done dt=2024-08-06 00:00:05-waiting for server to shut down...................... done dt=2024-08-07 00:00:05-waiting for server to shut down............................................................................... done dt=2024-08-08 00:00:06-waiting for server to shut down........ done dt=2024-08-09 00:00:04-waiting for server to shut down....................... done dt=2024-08-10 00:00:03-waiting for server to shut down................................................................................. done dt=2024-08-11 00:00:04-waiting for server to shut down.................................. done dt=2024-08-12 00:00:07-waiting for server to shut down.................................... done dt=2024-08-13 00:00:06-waiting for server to shut down...................................... done dt=2024-08-14 00:00:05-waiting for server to shut down................................ done dt=2024-08-15 00:00:07-waiting for server to shut down............................... done dt=2024-08-16 00:00:07-waiting for server to shut down...................... done dt=2024-08-17 00:00:06-waiting for server to shut down............................................ done dt=2024-08-18 00:00:04-waiting for server to shut down............................. done dt=2024-08-28 06:15:55-waiting for server to shut down................................................. done dt=2024-09-03 00:00:14-waiting for server to shut down........................................................................ done dt=2024-09-04 00:00:13-waiting for server to shut down...................... done dt=2024-09-05 00:00:45-waiting for server to shut down........................... done dt=2024-09-06 00:00:14-waiting for server to shut down............................... done dt=2024-09-07 00:00:23-waiting for server to shut down...................................... done dt=2024-09-08 00:01:08-waiting for server to shut down................................. done dt=2024-09-09 00:00:15-waiting for server to shut down................................. done dt=2024-09-10 00:00:21-waiting for server to shut down..................... done dt=2024-09-11 00:00:13-waiting for server to shut down........................... done dt=2024-09-12 00:00:14-waiting for server to shut down..................................... done dt=2024-09-13 00:00:15-waiting for server to shut down....................................... done dt=2024-09-14 00:00:12-waiting for server to shut down..................... done dt=2024-09-15 00:00:10-waiting for server to shut down.................................... done dt=2024-09-16 00:00:16-waiting for server to shut down.................................... done dt=2024-09-17 00:00:15-waiting for server to shut down.................................... done dt=2024-09-18 00:00:08-waiting for server to shut down........................................... done dt=2024-09-19 00:00:14-waiting for server to shut down........................................ done dt=2024-09-20 00:00:13-waiting for server to shut down................................. done dt=2024-09-21 00:00:21-waiting for server to shut down...................................... done dt=2024-09-22 00:00:13-waiting for server to shut down................................. done dt=2024-09-24 00:00:14-waiting for server to shut down................................. done dt=2024-09-25 00:00:11-waiting for server to shut down........................ done dt=2024-09-26 00:00:15-waiting for server to shut down............................... done dt=2024-09-27 00:00:16-waiting for server to shut down...................................... done dt=2024-09-28 00:00:14-waiting for server to shut down...................... done dt=2024-09-30 00:00:12-waiting for server to shut down........................................ done dt=2024-10-01 00:00:14-waiting for server to shut down................................... done dt=2024-10-02 00:00:13-waiting for server to shut down.................................... done dt=2024-10-03 00:00:11-waiting for server to shut down...................................... done dt=2024-10-04 00:00:12-waiting for server to shut down.......................... done dt=2024-10-05 00:00:14-waiting for server to shut down........................................................................................................................... failed dt=2024-10-06 00:00:13-waiting for server to shut down.......................................... done dt=2024-10-07 00:00:14-waiting for server to shut down........................................ done dt=2024-10-08 00:00:15-waiting for server to shut down............................ done dt=2024-10-09 00:00:09-waiting for server to shut down............. done
perentie-timings.tar.gz
Description: application/gzip
