pgbench test failing on 14beta1 on Debian/i386 - Mailing list pgsql-hackers

From Christoph Berg
Subject pgbench test failing on 14beta1 on Debian/i386
Date
Msg-id YKQnUoYV63GRJBDD@msg.df7cb.de
Whole thread Raw
Responses Re: pgbench test failing on 14beta1 on Debian/i386
List pgsql-hackers
Hi,

I can reproducibly get build failures in pgbench on 32-bit i386
Debian, both on sid and buster. (The older Debian stretch and Ubuntu
bionic are unaffected. Other architectures are also fine.)

https://pgdgbuild.dus.dg-i.net/view/Binaries/job/postgresql-14-binaries/635/


https://pgdgbuild.dus.dg-i.net/view/Binaries/job/postgresql-14-binaries/635/architecture=i386,distribution=sid/consoleFull

17:39:41 make[2]: Entering directory '/<<PKGBUILDDIR>>/build/src/bin/pgbench'
17:39:41 rm -rf '/<<PKGBUILDDIR>>/build/src/bin/pgbench'/tmp_check
17:39:41 /bin/mkdir -p '/<<PKGBUILDDIR>>/build/src/bin/pgbench'/tmp_check
17:39:41 cd /<<PKGBUILDDIR>>/build/../src/bin/pgbench && TESTDIR='/<<PKGBUILDDIR>>/build/src/bin/pgbench'
PATH="/<<PKGBUILDDIR>>/build/tmp_install/usr/lib/postgresql/14/bin:$PATH"
LD_LIBRARY_PATH="/<<PKGBUILDDIR>>/build/tmp_install/usr/lib/i386-linux-gnu" PGPORT='65432'
PG_REGRESS='/<<PKGBUILDDIR>>/build/src/bin/pgbench/../../../src/test/regress/pg_regress'
REGRESS_SHLIB='/<<PKGBUILDDIR>>/build/src/test/regress/regress.so'/usr/bin/prove -I
/<<PKGBUILDDIR>>/build/../src/test/perl/-I /<<PKGBUILDDIR>>/build/../src/bin/pgbench --verbose t/*.pl
 
17:39:50 
17:39:50 #   Failed test 'pgbench expressions stderr /(?^:command=113.: boolean true\b)/'
17:39:50 #   at t/001_pgbench_with_server.pl line 421.
17:39:50 #                   'pgbench: setting random seed to 5432
17:39:50 # starting vacuum...end.
17:39:50 # debug(script=0,command=1): int 13
17:39:50 # debug(script=0,command=2): int 116
17:39:50 # debug(script=0,command=3): int 1498
17:39:50 # debug(script=0,command=4): int 4
17:39:50 # debug(script=0,command=5): int 5
17:39:50 # debug(script=0,command=6): int 6
17:39:50 # debug(script=0,command=7): int 7
17:39:50 # debug(script=0,command=8): int 8
17:39:50 # debug(script=0,command=9): int 9
17:39:50 # debug(script=0,command=10): int 10
17:39:50 # debug(script=0,command=11): int 11
17:39:50 # debug(script=0,command=12): int 12
17:39:50 # debug(script=0,command=13): double 13.856406460551
17:39:50 # debug(script=0,command=14): double 14.8514851485149
17:39:50 # debug(script=0,command=15): double 15.39380400259
17:39:50 # debug(script=0,command=16): double 16
17:39:50 # debug(script=0,command=17): double 17.094
17:39:50 # debug(script=0,command=20): int 1
17:39:50 # debug(script=0,command=21): double -27
17:39:50 # debug(script=0,command=22): double 1024
17:39:50 # debug(script=0,command=23): double 1
17:39:50 # debug(script=0,command=24): double 1
17:39:50 # debug(script=0,command=25): double -0.125
17:39:50 # debug(script=0,command=26): double -0.125
17:39:50 # debug(script=0,command=27): double -0.00032
17:39:50 # debug(script=0,command=28): double 8.50705917302346e+37
17:39:50 # debug(script=0,command=29): double 1e+30
17:39:50 # debug(script=0,command=30): boolean false
17:39:50 # debug(script=0,command=31): boolean true
17:39:50 # debug(script=0,command=32): int 32
17:39:50 # debug(script=0,command=33): int 33
17:39:50 # debug(script=0,command=34): double 34
17:39:50 # debug(script=0,command=35): int 35
17:39:50 # debug(script=0,command=36): int 36
17:39:50 # debug(script=0,command=37): double 37.0000002
17:39:50 # debug(script=0,command=38): int 38
17:39:50 # debug(script=0,command=39): int 39
17:39:50 # debug(script=0,command=40): boolean true
17:39:50 # debug(script=0,command=41): null
17:39:50 # debug(script=0,command=42): null
17:39:50 # debug(script=0,command=43): boolean true
17:39:50 # debug(script=0,command=44): boolean true
17:39:50 # debug(script=0,command=45): boolean true
17:39:50 # debug(script=0,command=46): int 46
17:39:50 # debug(script=0,command=47): boolean true
17:39:50 # debug(script=0,command=48): boolean true
17:39:50 # debug(script=0,command=49): int -5817877081768721676
17:39:50 # debug(script=0,command=50): boolean true
17:39:50 # debug(script=0,command=51): int -7793829335365542153
17:39:50 # debug(script=0,command=52): int -1464711246773187029
17:39:50 # debug(script=0,command=53): boolean true
17:39:50 # debug(script=0,command=55): int -1
17:39:50 # debug(script=0,command=56): int -1
17:39:50 # debug(script=0,command=57): int 1
17:39:50 # debug(script=0,command=65): int 65
17:39:50 # debug(script=0,command=74): int 74
17:39:50 # debug(script=0,command=83): int 83
17:39:50 # debug(script=0,command=86): int 86
17:39:50 # debug(script=0,command=93): int 93
17:39:50 # debug(script=0,command=95): int 0
17:39:50 # debug(script=0,command=96): int 1
17:39:50 # debug(script=0,command=97): int 0
17:39:50 # debug(script=0,command=98): int 5432
17:39:50 # debug(script=0,command=99): int -9223372036854775808
17:39:50 # debug(script=0,command=100): int 9223372036854775807
17:39:50 # debug(script=0,command=101): boolean true
17:39:50 # debug(script=0,command=102): boolean true
17:39:50 # debug(script=0,command=103): boolean true
17:39:50 # debug(script=0,command=104): boolean true
17:39:50 # debug(script=0,command=105): boolean true
17:39:50 # debug(script=0,command=109): boolean true
17:39:50 # debug(script=0,command=110): boolean true
17:39:50 # debug(script=0,command=111): boolean true
17:39:50 # debug(script=0,command=112): int 9223372036854775797
17:39:50 # debug(script=0,command=113): boolean false
17:39:50 # '
17:39:50 #     doesn't match '(?^:command=113.: boolean true\b)'
17:39:52 # Looks like you failed 1 test of 415.
17:39:52 t/001_pgbench_with_server.pl .. 
17:39:52 ok 1 - concurrent OID generation status (got 0 vs expected 0)
17:39:52 ok 2 - concurrent OID generation stdout /(?^:processed: 125/125)/
17:39:52 ok 3 - concurrent OID generation stderr /(?^:^$)/
17:39:52 ok 4 - no such database status (got 1 vs expected 1)
17:39:52 ok 5 - no such database stdout /(?^:^$)/
17:39:52 ok 6 - no such database stderr /(?^:connection to server .* failed)/
17:39:52 ok 7 - no such database stderr /(?^:FATAL:  database "no-such-database" does not exist)/
17:39:52 ok 8 - run without init status (got 1 vs expected 1)
17:39:52 ok 9 - run without init stdout /(?^:^$)/
17:39:52 ok 10 - run without init stderr /(?^:Perhaps you need to do initialization)/
17:39:52 ok 11 - pgbench scale 1 initialization status (got 0 vs expected 0)
17:39:52 ok 12 - pgbench scale 1 initialization stdout /(?^:^$)/

[...]

17:39:52 ok 172 - pgbench expressions stderr /(?^:command=110.: boolean true\b)/
17:39:52 ok 173 - pgbench expressions stderr /(?^:command=111.: boolean true\b)/
17:39:52 ok 174 - pgbench expressions stderr /(?^:command=112.: int 9223372036854775797\b)/
17:39:52 not ok 175 - pgbench expressions stderr /(?^:command=113.: boolean true\b)/
17:39:52 ok 176 - random seeded with 733446049 status (got 0 vs expected 0)
17:39:52 ok 177 - random seeded with 733446049 stdout /(?^:processed: 1/1)/
17:39:52 ok 178 - random seeded with 733446049 stderr /(?^:setting random seed to 733446049\b)/

[...]

17:39:52 ok 415 - remove log files
17:39:52 1..415
17:39:52 Dubious, test returned 1 (wstat 256, 0x100)
17:39:52 Failed 1/415 subtests
17:39:53 t/002_pgbench_no_server.pl ....

Christoph



pgsql-hackers by date:

Previous
From: Peter Geoghegan
Date:
Subject: Re: Lowering the ever-growing heap->pd_lower
Next
From: Peter Geoghegan
Date:
Subject: Re: Teaching users how they can get the most out of HOT in Postgres 14