# Checking port 60298
# Found port 60298
Name: primary
Data directory: /tmp/cirrus-ci-build/build/testrun/recovery/032_relfilenode_reuse/data/t_032_relfilenode_reuse_primary_data/pgdata
Backup directory: /tmp/cirrus-ci-build/build/testrun/recovery/032_relfilenode_reuse/data/t_032_relfilenode_reuse_primary_data/backup
Archive directory: /tmp/cirrus-ci-build/build/testrun/recovery/032_relfilenode_reuse/data/t_032_relfilenode_reuse_primary_data/archives
Connection string: port=60298 host=/tmp/o993MKp56E
Log file: /tmp/cirrus-ci-build/build/testrun/recovery/032_relfilenode_reuse/log/032_relfilenode_reuse_primary.log
[13:47:47.051](0.015s) # initializing database system by copying initdb template
# Running: cp -RPp /tmp/cirrus-ci-build/build/tmp_install/initdb-template /tmp/cirrus-ci-build/build/testrun/recovery/032_relfilenode_reuse/data/t_032_relfilenode_reuse_primary_data/pgdata
# Running: /tmp/cirrus-ci-build/build/src/test/regress/pg_regress --config-auth /tmp/cirrus-ci-build/build/testrun/recovery/032_relfilenode_reuse/data/t_032_relfilenode_reuse_primary_data/pgdata
### Starting node "primary"
# Running: pg_ctl -w -D /tmp/cirrus-ci-build/build/testrun/recovery/032_relfilenode_reuse/data/t_032_relfilenode_reuse_primary_data/pgdata -l /tmp/cirrus-ci-build/build/testrun/recovery/032_relfilenode_reuse/log/032_relfilenode_reuse_primary.log -o --cluster-name=primary start
waiting for server to start.... done
server started
# Postmaster PID for node "primary" is 89118
# Taking pg_basebackup my_backup from node "primary"
# Running: pg_basebackup -D /tmp/cirrus-ci-build/build/testrun/recovery/032_relfilenode_reuse/data/t_032_relfilenode_reuse_primary_data/backup/my_backup -h /tmp/o993MKp56E -p 60298 --checkpoint fast --no-sync
# Backup finished
# Checking port 60299
# Found port 60299
Name: standby
Data directory: /tmp/cirrus-ci-build/build/testrun/recovery/032_relfilenode_reuse/data/t_032_relfilenode_reuse_standby_data/pgdata
Backup directory: /tmp/cirrus-ci-build/build/testrun/recovery/032_relfilenode_reuse/data/t_032_relfilenode_reuse_standby_data/backup
Archive directory: /tmp/cirrus-ci-build/build/testrun/recovery/032_relfilenode_reuse/data/t_032_relfilenode_reuse_standby_data/archives
Connection string: port=60299 host=/tmp/o993MKp56E
Log file: /tmp/cirrus-ci-build/build/testrun/recovery/032_relfilenode_reuse/log/032_relfilenode_reuse_standby.log
# Initializing node "standby" from backup "my_backup" of node "primary"
### Enabling streaming replication for node "standby"
### Starting node "standby"
# Running: pg_ctl -w -D /tmp/cirrus-ci-build/build/testrun/recovery/032_relfilenode_reuse/data/t_032_relfilenode_reuse_standby_data/pgdata -l /tmp/cirrus-ci-build/build/testrun/recovery/032_relfilenode_reuse/log/032_relfilenode_reuse_standby.log -o --cluster-name=standby start
waiting for server to start.... done
server started
# Postmaster PID for node "standby" is 89165
#### Begin standard error
psql:<stdin>:1: WARNING:  databases created by regression test cases should have names including "regression"
#### End standard error
#### Begin standard error
psql:<stdin>:3: WARNING:  outfuncs/readfuncs failed to produce an equal rewritten parse tree
#### End standard error
#### Begin standard error
psql:<stdin>:1: WARNING:  databases created by regression test cases should have names including "regression"
#### End standard error
#### Begin standard error
psql:<stdin>:4: WARNING:  outfuncs/readfuncs failed to produce an equal rewritten parse tree
#### End standard error
Waiting for replication conn standby's replay_lsn to pass 0/3A81528 on primary
[13:51:28.644](221.593s) # poll_query_until timed out executing this query:
# SELECT '0/3A81528' <= replay_lsn AND state = 'streaming'
#          FROM pg_catalog.pg_stat_replication
#          WHERE application_name IN ('standby', 'walreceiver')
# expecting this output:
# t
# last actual query output:
# t
# with stderr:
# WARNING:  outfuncs/readfuncs failed to produce an equal rewritten parse tree
timed out waiting for catchup at /tmp/cirrus-ci-build/src/test/recovery/t/032_relfilenode_reuse.pl line 81.
# Postmaster PID for node "primary" is 89118
### Stopping node "primary" using mode immediate
# Running: pg_ctl -D /tmp/cirrus-ci-build/build/testrun/recovery/032_relfilenode_reuse/data/t_032_relfilenode_reuse_primary_data/pgdata -m immediate stop
waiting for server to shut down.... done
server stopped
# No postmaster PID for node "primary"
# Postmaster PID for node "standby" is 89165
### Stopping node "standby" using mode immediate
# Running: pg_ctl -D /tmp/cirrus-ci-build/build/testrun/recovery/032_relfilenode_reuse/data/t_032_relfilenode_reuse_standby_data/pgdata -m immediate stop
waiting for server to shut down.... done
server stopped
# No postmaster PID for node "standby"