# Checking port 53246
# Found port 53246
Name: primary1_FILE_COPY
Data directory: /tmp/cirrus-ci-build/build/testrun/recovery/033_replay_tsp_drops/data/t_033_replay_tsp_drops_primary1_FILE_COPY_data/pgdata
Backup directory: /tmp/cirrus-ci-build/build/testrun/recovery/033_replay_tsp_drops/data/t_033_replay_tsp_drops_primary1_FILE_COPY_data/backup
Archive directory: /tmp/cirrus-ci-build/build/testrun/recovery/033_replay_tsp_drops/data/t_033_replay_tsp_drops_primary1_FILE_COPY_data/archives
Connection string: port=53246 host=/tmp/59sO9Z_CoL
Log file: /tmp/cirrus-ci-build/build/testrun/recovery/033_replay_tsp_drops/log/033_replay_tsp_drops_primary1_FILE_COPY.log
[16:42:27.946](0.016s) # 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/033_replay_tsp_drops/data/t_033_replay_tsp_drops_primary1_FILE_COPY_data/pgdata
# Running: /tmp/cirrus-ci-build/build/src/test/regress/pg_regress --config-auth /tmp/cirrus-ci-build/build/testrun/recovery/033_replay_tsp_drops/data/t_033_replay_tsp_drops_primary1_FILE_COPY_data/pgdata
### Starting node "primary1_FILE_COPY"
# Running: pg_ctl -w -D /tmp/cirrus-ci-build/build/testrun/recovery/033_replay_tsp_drops/data/t_033_replay_tsp_drops_primary1_FILE_COPY_data/pgdata -l /tmp/cirrus-ci-build/build/testrun/recovery/033_replay_tsp_drops/log/033_replay_tsp_drops_primary1_FILE_COPY.log -o --cluster-name=primary1_FILE_COPY start
waiting for server to start.... done
server started
# Postmaster PID for node "primary1_FILE_COPY" is 89349
psql:<stdin>:3: WARNING:  tablespaces created by regression test cases should have names starting with "regress_"
psql:<stdin>:4: WARNING:  tablespaces created by regression test cases should have names starting with "regress_"
psql:<stdin>:5: WARNING:  tablespaces created by regression test cases should have names starting with "regress_"
psql:<stdin>:6: WARNING:  tablespaces created by regression test cases should have names starting with "regress_"
psql:<stdin>:7: WARNING:  databases created by regression test cases should have names including "regression"
(slot,0/151A638)
# Taking pg_basebackup my_backup from node "primary1_FILE_COPY"
# Running: pg_basebackup -D /tmp/cirrus-ci-build/build/testrun/recovery/033_replay_tsp_drops/data/t_033_replay_tsp_drops_primary1_FILE_COPY_data/backup/my_backup -h /tmp/59sO9Z_CoL -p 53246 --checkpoint fast --no-sync
# Backup finished
# Checking port 53247
# Found port 53247
Name: standby2_FILE_COPY
Data directory: /tmp/cirrus-ci-build/build/testrun/recovery/033_replay_tsp_drops/data/t_033_replay_tsp_drops_standby2_FILE_COPY_data/pgdata
Backup directory: /tmp/cirrus-ci-build/build/testrun/recovery/033_replay_tsp_drops/data/t_033_replay_tsp_drops_standby2_FILE_COPY_data/backup
Archive directory: /tmp/cirrus-ci-build/build/testrun/recovery/033_replay_tsp_drops/data/t_033_replay_tsp_drops_standby2_FILE_COPY_data/archives
Connection string: port=53247 host=/tmp/59sO9Z_CoL
Log file: /tmp/cirrus-ci-build/build/testrun/recovery/033_replay_tsp_drops/log/033_replay_tsp_drops_standby2_FILE_COPY.log
# Initializing node "standby2_FILE_COPY" from backup "my_backup" of node "primary1_FILE_COPY"
### Enabling streaming replication for node "standby2_FILE_COPY"
### Starting node "standby2_FILE_COPY"
# Running: pg_ctl -w -D /tmp/cirrus-ci-build/build/testrun/recovery/033_replay_tsp_drops/data/t_033_replay_tsp_drops_standby2_FILE_COPY_data/pgdata -l /tmp/cirrus-ci-build/build/testrun/recovery/033_replay_tsp_drops/log/033_replay_tsp_drops_standby2_FILE_COPY.log -o --cluster-name=standby2_FILE_COPY start
waiting for server to start.... done
server started
# Postmaster PID for node "standby2_FILE_COPY" is 89401
Waiting for replication conn standby2_FILE_COPY's write_lsn to pass 0/3000000 on primary1_FILE_COPY
[16:46:14.711](226.765s) # poll_query_until timed out executing this query:
# SELECT '0/3000000' <= write_lsn AND state = 'streaming'
#          FROM pg_catalog.pg_stat_replication
#          WHERE application_name IN ('standby2_FILE_COPY', '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/033_replay_tsp_drops.pl line 44.
# Postmaster PID for node "primary1_FILE_COPY" is 89349
### Stopping node "primary1_FILE_COPY" using mode immediate
# Running: pg_ctl -D /tmp/cirrus-ci-build/build/testrun/recovery/033_replay_tsp_drops/data/t_033_replay_tsp_drops_primary1_FILE_COPY_data/pgdata -m immediate stop
waiting for server to shut down.... done
server stopped
# No postmaster PID for node "primary1_FILE_COPY"
# Postmaster PID for node "standby2_FILE_COPY" is 89401
### Stopping node "standby2_FILE_COPY" using mode immediate
# Running: pg_ctl -D /tmp/cirrus-ci-build/build/testrun/recovery/033_replay_tsp_drops/data/t_033_replay_tsp_drops_standby2_FILE_COPY_data/pgdata -m immediate stop
waiting for server to shut down.... done
server stopped
# No postmaster PID for node "standby2_FILE_COPY"