# Checking port 63568
# Found port 63568
Name: primary
Data directory: /tmp/cirrus-ci-build/src/test/recovery/tmp_check/t_027_stream_regress_primary_data/pgdata
Backup directory: /tmp/cirrus-ci-build/src/test/recovery/tmp_check/t_027_stream_regress_primary_data/backup
Archive directory: /tmp/cirrus-ci-build/src/test/recovery/tmp_check/t_027_stream_regress_primary_data/archives
Connection string: port=63568 host=/tmp/e5t8kNAcra
Log file: /tmp/cirrus-ci-build/src/test/recovery/tmp_check/log/027_stream_regress_primary.log
[03:39:48.770](0.013s) # initializing database system by copying initdb template
# Running: cp -RPp /tmp/cirrus-ci-build/tmp_install/initdb-template /tmp/cirrus-ci-build/src/test/recovery/tmp_check/t_027_stream_regress_primary_data/pgdata
# Running: /tmp/cirrus-ci-build/src/test/recovery/../../../src/test/regress/pg_regress --config-auth /tmp/cirrus-ci-build/src/test/recovery/tmp_check/t_027_stream_regress_primary_data/pgdata
### Starting node "primary"
# Running: pg_ctl -w -D /tmp/cirrus-ci-build/src/test/recovery/tmp_check/t_027_stream_regress_primary_data/pgdata -l /tmp/cirrus-ci-build/src/test/recovery/tmp_check/log/027_stream_regress_primary.log -o --cluster-name=primary start
waiting for server to start.... done
server started
# Postmaster PID for node "primary" is 43272
(standby_1,)
[03:39:48.975](0.205s) ok 1 - physical slot created on primary
# Taking pg_basebackup my_backup from node "primary"
# Running: pg_basebackup -D /tmp/cirrus-ci-build/src/test/recovery/tmp_check/t_027_stream_regress_primary_data/backup/my_backup -h /tmp/e5t8kNAcra -p 63568 --checkpoint fast --no-sync
# Backup finished
# Checking port 63569
# Found port 63569
Name: standby_1
Data directory: /tmp/cirrus-ci-build/src/test/recovery/tmp_check/t_027_stream_regress_standby_1_data/pgdata
Backup directory: /tmp/cirrus-ci-build/src/test/recovery/tmp_check/t_027_stream_regress_standby_1_data/backup
Archive directory: /tmp/cirrus-ci-build/src/test/recovery/tmp_check/t_027_stream_regress_standby_1_data/archives
Connection string: port=63569 host=/tmp/e5t8kNAcra
Log file: /tmp/cirrus-ci-build/src/test/recovery/tmp_check/log/027_stream_regress_standby_1.log
# Initializing node "standby_1" from backup "my_backup" of node "primary"
### Enabling streaming replication for node "standby_1"
### Starting node "standby_1"
# Running: pg_ctl -w -D /tmp/cirrus-ci-build/src/test/recovery/tmp_check/t_027_stream_regress_standby_1_data/pgdata -l /tmp/cirrus-ci-build/src/test/recovery/tmp_check/log/027_stream_regress_standby_1.log -o --cluster-name=standby_1 start
waiting for server to start.... done
server started
# Postmaster PID for node "standby_1" is 43333
# using postmaster on /tmp/e5t8kNAcra, port 63568
ok 1         - test_setup                                348 ms
# parallel group (20 tests):  char varchar text pg_lsn txid name oid int2 money int4 regproc float4 uuid int8 float8 enum boolean bit numeric rangetypes
ok 2         + boolean                                   436 ms
ok 3         + char                                      120 ms
ok 4         + name                                      165 ms
ok 5         + varchar                                   141 ms
ok 6         + text                                      145 ms
ok 7         + int2                                      195 ms
ok 8         + int4                                      217 ms
ok 9         + int8                                      278 ms
ok 10        + oid                                       170 ms
ok 11        + float4                                    232 ms
ok 12        + float8                                    279 ms
ok 13        + bit                                       542 ms
ok 14        + numeric                                   848 ms
ok 15        + txid                                      157 ms
ok 16        + uuid                                      250 ms
ok 17        + enum                                      349 ms
ok 18        + money                                     205 ms
ok 19        + rangetypes                               1092 ms
ok 20        + pg_lsn                                    140 ms
ok 21        + regproc                                   212 ms
# parallel group (20 tests):  md5 line lseg path time circle timetz macaddr macaddr8 date numerology inet point interval strings timestamp timestamptz polygon multirangetypes box
ok 22        + strings                                   528 ms
ok 23        + md5                                        64 ms
ok 24        + numerology                                251 ms
ok 25        + point                                     359 ms
ok 26        + lseg                                       94 ms
ok 27        + line                                       82 ms
ok 28        + box                                      1243 ms
ok 29        + path                                       99 ms
ok 30        + polygon                                   937 ms
ok 31        + circle                                    117 ms
ok 32        + date                                      238 ms
ok 33        + time                                      113 ms
ok 34        + timetz                                    170 ms
ok 35        + timestamp                                 524 ms
ok 36        + timestamptz                               574 ms
ok 37        + interval                                  496 ms
ok 38        + inet                                      265 ms
ok 39        + macaddr                                   182 ms
ok 40        + macaddr8                                  197 ms
ok 41        + multirangetypes                          1141 ms
# parallel group (13 tests):  comments unicode misc_sanity xid tstypes expressions stats_export_import mvcc type_sanity geometry regex horology opr_sanity
ok 42        + geometry                                  343 ms
ok 43        + horology                                  500 ms
ok 44        + tstypes                                   161 ms
ok 45        + regex                                     489 ms
ok 46        + type_sanity                               328 ms
ok 47        + opr_sanity                                726 ms
ok 48        + misc_sanity                               109 ms
ok 49        + comments                                   52 ms
ok 50        + expressions                               198 ms
ok 51        + unicode                                    73 ms
ok 52        + xid                                       149 ms
ok 53        + mvcc                                      276 ms
ok 54        + stats_export_import                       234 ms
# parallel group (5 tests):  copyselect copydml copy insert_conflict insert
ok 55        + copy                                      215 ms
ok 56        + copyselect                                 61 ms
ok 57        + copydml                                    70 ms
ok 58        + insert                                    654 ms
ok 59        + insert_conflict                           273 ms
# parallel group (7 tests):  create_function_c create_operator create_procedure create_misc create_type create_schema create_table
ok 60        + create_function_c                          40 ms
ok 61        + create_misc                               134 ms
ok 62        + create_operator                            63 ms
ok 63        + create_procedure                          115 ms
ok 64        + create_table                              669 ms
ok 65        + create_type                               134 ms
ok 66        + create_schema                             155 ms
# parallel group (5 tests):  index_including index_including_gist create_view create_index_spgist create_index
ok 67        + create_index                             1837 ms
ok 68        + create_index_spgist                      1624 ms
ok 69        + create_view                               790 ms
ok 70        + index_including                           489 ms
ok 71        + index_including_gist                      558 ms
# parallel group (16 tests):  create_cast roleattributes errors create_aggregate hash_func drop_if_exists typed_table create_function_sql select infinite_recurse create_am vacuum constraints updatable_views inherit triggers
ok 72        + create_aggregate                          230 ms
ok 73        + create_function_sql                       492 ms
ok 74        + create_cast                               132 ms
ok 75        + constraints                              1389 ms
ok 76        + triggers                                 2419 ms
ok 77        + select                                    584 ms
ok 78        + inherit                                  2268 ms
ok 79        + typed_table                               427 ms
ok 80        + vacuum                                   1070 ms
ok 81        + drop_if_exists                            289 ms
ok 82        + updatable_views                          1655 ms
ok 83        + roleattributes                            168 ms
ok 84        + create_am                                 673 ms
ok 85        + hash_func                                 241 ms
ok 86        + errors                                    182 ms
ok 87        + infinite_recurse                          597 ms
ok 88        - sanity_check                              176 ms
# parallel group (20 tests):  select_distinct_on delete select_having select_implicit case select_into namespace prepared_xacts random transactions portals select_distinct union arrays subselect hash_index update join aggregates btree_index
ok 89        + select_into                               375 ms
ok 90        + select_distinct                           922 ms
ok 91        + select_distinct_on                        135 ms
ok 92        + select_implicit                           273 ms
ok 93        + select_having                             218 ms
ok 94        + subselect                                1172 ms
ok 95        + union                                     953 ms
ok 96        + case                                      297 ms
ok 97        + join                                     2770 ms
ok 98        + aggregates                               2805 ms
ok 99        + transactions                              564 ms
ok 100       + random                                    471 ms
ok 101       + portals                                   646 ms
ok 102       + arrays                                    992 ms
ok 103       + btree_index                              3223 ms
ok 104       + hash_index                               1677 ms
ok 105       + update                                   1755 ms
ok 106       + delete                                    156 ms
ok 107       + namespace                                 367 ms
ok 108       + prepared_xacts                            458 ms
# parallel group (20 tests):  init_privs drop_operator security_label password lock tablesample object_address replica_identity collate matview identity generated rowsecurity spgist groupingsets gist gin join_hash brin privileges
ok 109       + brin                                     8395 ms
ok 110       + gin                                      3486 ms
ok 111       + gist                                     3219 ms
ok 112       + spgist                                   2987 ms
ok 113       + privileges                               8823 ms
ok 114       + init_privs                                 99 ms
ok 115       + security_label                            178 ms
ok 116       + collate                                  1723 ms
ok 117       + matview                                  2031 ms
ok 118       + lock                                      445 ms
ok 119       + replica_identity                         1078 ms
ok 120       + rowsecurity                              2918 ms
ok 121       + object_address                            699 ms
ok 122       + tablesample                               448 ms
ok 123       + groupingsets                             3008 ms
ok 124       + drop_operator                             154 ms
ok 125       + password                                  276 ms
ok 126       + identity                                 2127 ms
ok 127       + generated                                2774 ms
ok 128       + join_hash                                8382 ms
# parallel group (2 tests):  brin_bloom brin_multi
ok 129       + brin_bloom                                148 ms
ok 130       + brin_multi                                913 ms
# parallel group (18 tests):  async dbsize collate.utf8 tid alter_operator tsrf tidscan create_role sysviews misc_functions alter_generic tidrangescan incremental_sort create_table_like merge misc without_overlaps collate.icu.utf8
ok 131       + create_table_like                        1220 ms
ok 132       + alter_generic                             548 ms
ok 133       + alter_operator                            251 ms
ok 134       + misc                                     1377 ms
ok 135       + async                                      62 ms
ok 136       + dbsize                                     99 ms
ok 137       + merge                                    1235 ms
ok 138       + misc_functions                            469 ms
ok 139       + sysviews                                  382 ms
ok 140       + tsrf                                      262 ms
ok 141       + tid                                       227 ms
ok 142       + tidscan                                   291 ms
ok 143       + tidrangescan                              701 ms
ok 144       + collate.utf8                              140 ms
ok 145       + collate.icu.utf8                         1487 ms
ok 146       + incremental_sort                          999 ms
ok 147       + create_role                               312 ms
ok 148       + without_overlaps                         1428 ms
# parallel group (7 tests):  collate.windows.win1252 amutils psql_crosstab collate.linux.utf8 rules psql stats_ext
ok 149       + rules                                     935 ms
ok 150       + psql                                     1157 ms
ok 151       + psql_crosstab                             119 ms
ok 152       + amutils                                    72 ms
ok 153       + stats_ext                                2117 ms
ok 154       + collate.linux.utf8                        650 ms
ok 155       + collate.windows.win1252                    22 ms
ok 156       - select_parallel                          3262 ms
ok 157       - write_parallel                            158 ms
ok 158       - vacuum_parallel                           173 ms
# parallel group (2 tests):  subscription publication
ok 159       + publication                              2687 ms
ok 160       + subscription                               96 ms
# parallel group (17 tests):  portals_p2 advisory_lock combocid xmlmap equivclass tsdicts functional_deps dependency guc select_views bitmapops indirect_toast window cluster foreign_data foreign_key tsearch
ok 161       + select_views                              596 ms
ok 162       + portals_p2                                148 ms
ok 163       + foreign_key                              2392 ms
ok 164       + cluster                                  1278 ms
ok 165       + dependency                                582 ms
ok 166       + guc                                       581 ms
ok 167       + bitmapops                                 993 ms
ok 168       + combocid                                  207 ms
ok 169       + tsearch                                  2418 ms
ok 170       + tsdicts                                   487 ms
ok 171       + foreign_data                             1811 ms
ok 172       + window                                   1138 ms
ok 173       + xmlmap                                    319 ms
ok 174       + functional_deps                           526 ms
ok 175       + advisory_lock                             195 ms
ok 176       + indirect_toast                           1117 ms
ok 177       + equivclass                                477 ms
# parallel group (9 tests):  json_encoding jsonpath_encoding jsonpath sqljson sqljson_jsontable sqljson_queryfuncs json jsonb_jsonpath jsonb
ok 178       + json                                      299 ms
ok 179       + jsonb                                     582 ms
ok 180       + json_encoding                              50 ms
ok 181       + jsonpath                                  137 ms
ok 182       + jsonpath_encoding                          52 ms
ok 183       + jsonb_jsonpath                            343 ms
ok 184       + sqljson                                   201 ms
ok 185       + sqljson_queryfuncs                        279 ms
ok 186       + sqljson_jsontable                         224 ms
# parallel group (18 tests):  prepare returning plancache limit conversion temp sequence largeobject copy2 rowtypes polymorphism truncate with domain rangefuncs plpgsql xml alter_table
ok 187       + plancache                                 409 ms
ok 188       + limit                                     574 ms
ok 189       + plpgsql                                  2565 ms
ok 190       + copy2                                    1006 ms
ok 191       + temp                                      729 ms
ok 192       + domain                                   1420 ms
ok 193       + rangefuncs                               1584 ms
ok 194       + prepare                                   234 ms
ok 195       + conversion                                581 ms
ok 196       + truncate                                 1239 ms
ok 197       + alter_table                              3334 ms
ok 198       + sequence                                  851 ms
ok 199       + polymorphism                             1088 ms
ok 200       + rowtypes                                 1077 ms
ok 201       + returning                                 319 ms
ok 202       + largeobject                               998 ms
ok 203       + with                                     1341 ms
ok 204       + xml                                      3139 ms
# parallel group (15 tests):  hash_part reloptions predicate explain partition_info compression partition_merge memoize partition_split stats partition_aggregate partition_join indexing tuplesort partition_prune
ok 205       + partition_merge                          1191 ms
ok 206       + partition_split                          1577 ms
ok 207       + partition_join                           2323 ms
ok 208       + partition_prune                          3065 ms
ok 209       + reloptions                                230 ms
ok 210       + hash_part                                 209 ms
ok 211       + indexing                                 2519 ms
ok 212       + partition_aggregate                      2056 ms
ok 213       + partition_info                            382 ms
ok 214       + tuplesort                                2540 ms
ok 215       + explain                                   345 ms
ok 216       + compression                               757 ms
ok 217       + memoize                                  1485 ms
ok 218       + stats                                    1915 ms
ok 219       + predicate                                 303 ms
# parallel group (2 tests):  oidjoins event_trigger
ok 220       + oidjoins                                  431 ms
ok 221       + event_trigger                             492 ms
ok 222       - event_trigger_login                        49 ms
ok 223       - fast_default                              293 ms
ok 224       - tablespace                                578 ms
1..224
# All 224 tests passed.
[03:40:32.489](43.515s) ok 2 - regression tests pass
1
1
1
1
2
1
1
5
9
5
1
3
4
3
4
4
1
32
1
1
1
6
104
2
1
5
4001
1006
1
2
41
5
17
-2
33
34
9
1
1
1
1
-1
1
1
-1
-32768
32767
1
46
1
1
Waiting for replication conn standby_1's replay_lsn to pass 0/14C194F0 on primary
done
# Running: pg_dumpall -f /tmp/cirrus-ci-build/src/test/recovery/tmp_check/primary.dump --no-sync -p 63568 --no-unlogged-table-data
=================================================================
==47172==ERROR: AddressSanitizer: global-buffer-overflow on address 0x5585813e967c at pc 0x558581378c5b bp 0x7ffda3959050 sp 0x7ffda3959048
READ of size 4 at 0x5585813e967c thread T0
    #0 0x558581378c5a in DOTypeNameCompare /tmp/cirrus-ci-build/src/bin/pg_dump/pg_dump_sort.c:204
    #1 0x5585813b7c25 in pg_qsort ../../src/include/lib/sort_template.h:354
    #2 0x55858137d371 in sortDumpableObjectsByTypeName /tmp/cirrus-ci-build/src/bin/pg_dump/pg_dump_sort.c:192
    #3 0x55858136d555 in main /tmp/cirrus-ci-build/src/bin/pg_dump/pg_dump.c:993
    #4 0x7fe32f67ed09 in __libc_start_main (/lib/x86_64-linux-gnu/libc.so.6+0x23d09)
    #5 0x558581322ec9 in _start (/tmp/cirrus-ci-build/tmp_install/usr/local/pgsql/bin/pg_dump+0x3aec9)

0x5585813e967c is located 0 bytes to the right of global variable 'dbObjectTypePriority' defined in 'pg_dump_sort.c:105:18' (0x5585813e95c0) of size 188
SUMMARY: AddressSanitizer: global-buffer-overflow /tmp/cirrus-ci-build/src/bin/pg_dump/pg_dump_sort.c:204 in DOTypeNameCompare
Shadow bytes around the buggy address:
  0x0ab130275270: 00 00 00 00 00 00 00 00 00 00 04 f9 f9 f9 f9 f9
  0x0ab130275280: 00 00 00 00 00 00 00 00 00 00 f9 f9 f9 f9 f9 f9
  0x0ab130275290: 00 00 00 00 00 00 05 f9 f9 f9 f9 f9 00 00 00 00
  0x0ab1302752a0: 03 f9 f9 f9 f9 f9 f9 f9 00 00 02 f9 f9 f9 f9 f9
  0x0ab1302752b0: 00 00 06 f9 f9 f9 f9 f9 00 00 00 00 00 00 00 00
=>0x0ab1302752c0: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00[04]
  0x0ab1302752d0: f9 f9 f9 f9 00 00 00 00 00 00 00 00 00 00 00 00
  0x0ab1302752e0: 00 00 00 00 00 00 00 04 f9 f9 f9 f9 00 00 00 00
  0x0ab1302752f0: 07 f9 f9 f9 f9 f9 f9 f9 07 f9 f9 f9 f9 f9 f9 f9
  0x0ab130275300: 00 00 00 00 00 05 f9 f9 f9 f9 f9 f9 00 00 00 06
  0x0ab130275310: f9 f9 f9 f9 00 00 00 00 00 f9 f9 f9 f9 f9 f9 f9
Shadow byte legend (one shadow byte represents 8 application bytes):
  Addressable:           00
  Partially addressable: 01 02 03 04 05 06 07 
  Heap left redzone:       fa
  Freed heap region:       fd
  Stack left redzone:      f1
  Stack mid redzone:       f2
  Stack right redzone:     f3
  Stack after return:      f5
  Stack use after scope:   f8
  Global redzone:          f9
  Global init order:       f6
  Poisoned by user:        f7
  Container overflow:      fc
  Array cookie:            ac
  Intra object redzone:    bb
  ASan internal:           fe
  Left alloca redzone:     ca
  Right alloca redzone:    cb
  Shadow gap:              cc
==47172==ABORTING
Aborted (core dumped)
pg_dumpall: error: pg_dump failed on database "regression", exiting
[03:40:33.435](0.946s) not ok 3 - dump primary server
[03:40:33.435](0.000s) 
[03:40:33.435](0.000s) #   Failed test 'dump primary server'
#   at t/027_stream_regress.pl line 106.
# Running: pg_dumpall -f /tmp/cirrus-ci-build/src/test/recovery/tmp_check/standby.dump --no-sync -p 63569
=================================================================
==47185==ERROR: AddressSanitizer: global-buffer-overflow on address 0x562f3385567c at pc 0x562f337e4c5b bp 0x7ffd95654380 sp 0x7ffd95654378
READ of size 4 at 0x562f3385567c thread T0
    #0 0x562f337e4c5a in DOTypeNameCompare /tmp/cirrus-ci-build/src/bin/pg_dump/pg_dump_sort.c:204
    #1 0x562f33823c25 in pg_qsort ../../src/include/lib/sort_template.h:354
    #2 0x562f337e9371 in sortDumpableObjectsByTypeName /tmp/cirrus-ci-build/src/bin/pg_dump/pg_dump_sort.c:192
    #3 0x562f337d9555 in main /tmp/cirrus-ci-build/src/bin/pg_dump/pg_dump.c:993
    #4 0x7f4757b20d09 in __libc_start_main (/lib/x86_64-linux-gnu/libc.so.6+0x23d09)
    #5 0x562f3378eec9 in _start (/tmp/cirrus-ci-build/tmp_install/usr/local/pgsql/bin/pg_dump+0x3aec9)

0x562f3385567c is located 0 bytes to the right of global variable 'dbObjectTypePriority' defined in 'pg_dump_sort.c:105:18' (0x562f338555c0) of size 188
SUMMARY: AddressSanitizer: global-buffer-overflow /tmp/cirrus-ci-build/src/bin/pg_dump/pg_dump_sort.c:204 in DOTypeNameCompare
Shadow bytes around the buggy address:
  0x0ac666702a70: 00 00 00 00 00 00 00 00 00 00 04 f9 f9 f9 f9 f9
  0x0ac666702a80: 00 00 00 00 00 00 00 00 00 00 f9 f9 f9 f9 f9 f9
  0x0ac666702a90: 00 00 00 00 00 00 05 f9 f9 f9 f9 f9 00 00 00 00
  0x0ac666702aa0: 03 f9 f9 f9 f9 f9 f9 f9 00 00 02 f9 f9 f9 f9 f9
  0x0ac666702ab0: 00 00 06 f9 f9 f9 f9 f9 00 00 00 00 00 00 00 00
=>0x0ac666702ac0: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00[04]
  0x0ac666702ad0: f9 f9 f9 f9 00 00 00 00 00 00 00 00 00 00 00 00
  0x0ac666702ae0: 00 00 00 00 00 00 00 04 f9 f9 f9 f9 00 00 00 00
  0x0ac666702af0: 07 f9 f9 f9 f9 f9 f9 f9 07 f9 f9 f9 f9 f9 f9 f9
  0x0ac666702b00: 00 00 00 00 00 05 f9 f9 f9 f9 f9 f9 00 00 00 06
  0x0ac666702b10: f9 f9 f9 f9 00 00 00 00 00 f9 f9 f9 f9 f9 f9 f9
Shadow byte legend (one shadow byte represents 8 application bytes):
  Addressable:           00
  Partially addressable: 01 02 03 04 05 06 07 
  Heap left redzone:       fa
  Freed heap region:       fd
  Stack left redzone:      f1
  Stack mid redzone:       f2
  Stack right redzone:     f3
  Stack after return:      f5
  Stack use after scope:   f8
  Global redzone:          f9
  Global init order:       f6
  Poisoned by user:        f7
  Container overflow:      fc
  Array cookie:            ac
  Intra object redzone:    bb
  ASan internal:           fe
  Left alloca redzone:     ca
  Right alloca redzone:    cb
  Shadow gap:              cc
==47185==ABORTING
Aborted (core dumped)
pg_dumpall: error: pg_dump failed on database "regression", exiting
[03:40:34.228](0.793s) not ok 4 - dump standby server
[03:40:34.229](0.000s) 
[03:40:34.229](0.000s) #   Failed test 'dump standby server'
#   at t/027_stream_regress.pl line 113.
# Running: diff /tmp/cirrus-ci-build/src/test/recovery/tmp_check/primary.dump /tmp/cirrus-ci-build/src/test/recovery/tmp_check/standby.dump
[03:40:34.231](0.002s) ok 5 - compare primary and standby dumps
[03:40:34.432](0.201s) ok 6 - check contents of pg_stat_statements on regression database
### Stopping node "standby_1" using mode fast
# Running: pg_ctl -D /tmp/cirrus-ci-build/src/test/recovery/tmp_check/t_027_stream_regress_standby_1_data/pgdata -m fast stop
waiting for server to shut down.... done
server stopped
# No postmaster PID for node "standby_1"
### Stopping node "primary" using mode fast
# Running: pg_ctl -D /tmp/cirrus-ci-build/src/test/recovery/tmp_check/t_027_stream_regress_primary_data/pgdata -m fast stop
waiting for server to shut down.... done
server stopped
# No postmaster PID for node "primary"
[03:40:34.641](0.210s) 1..6
[03:40:34.643](0.001s) # Looks like you failed 2 tests of 6.