# Checking port 27398
# Found port 27398
Name: publisher
Version: 19devel
Data directory: /tmp/cirrus-ci-build/src/test/subscription/tmp_check/t_035_conflicts_publisher_data/pgdata
Backup directory: /tmp/cirrus-ci-build/src/test/subscription/tmp_check/t_035_conflicts_publisher_data/backup
Archive directory: /tmp/cirrus-ci-build/src/test/subscription/tmp_check/t_035_conflicts_publisher_data/archives
Connection string: port=27398 host=/tmp/IpOwV2borZ
Log file: /tmp/cirrus-ci-build/src/test/subscription/tmp_check/log/035_conflicts_publisher.log
[15:15:54.976](0.021s) # initializing database system by copying initdb template
# Running: cp -RPp /tmp/cirrus-ci-build/tmp_install/initdb-template /tmp/cirrus-ci-build/src/test/subscription/tmp_check/t_035_conflicts_publisher_data/pgdata
# Running: /tmp/cirrus-ci-build/src/test/subscription/../../../src/test/regress/pg_regress --config-auth /tmp/cirrus-ci-build/src/test/subscription/tmp_check/t_035_conflicts_publisher_data/pgdata
### Starting node "publisher"
# Running: pg_ctl --wait --pgdata /tmp/cirrus-ci-build/src/test/subscription/tmp_check/t_035_conflicts_publisher_data/pgdata --log /tmp/cirrus-ci-build/src/test/subscription/tmp_check/log/035_conflicts_publisher.log --options --cluster-name=publisher start
waiting for server to start.... done
server started
# Postmaster PID for node "publisher" is 92287
# Checking port 27399
# Found port 27399
Name: subscriber
Version: 19devel
Data directory: /tmp/cirrus-ci-build/src/test/subscription/tmp_check/t_035_conflicts_subscriber_data/pgdata
Backup directory: /tmp/cirrus-ci-build/src/test/subscription/tmp_check/t_035_conflicts_subscriber_data/backup
Archive directory: /tmp/cirrus-ci-build/src/test/subscription/tmp_check/t_035_conflicts_subscriber_data/archives
Connection string: port=27399 host=/tmp/IpOwV2borZ
Log file: /tmp/cirrus-ci-build/src/test/subscription/tmp_check/log/035_conflicts_subscriber.log
[15:15:55.186](0.210s) # initializing database system by copying initdb template
# Running: cp -RPp /tmp/cirrus-ci-build/tmp_install/initdb-template /tmp/cirrus-ci-build/src/test/subscription/tmp_check/t_035_conflicts_subscriber_data/pgdata
# Running: /tmp/cirrus-ci-build/src/test/subscription/../../../src/test/regress/pg_regress --config-auth /tmp/cirrus-ci-build/src/test/subscription/tmp_check/t_035_conflicts_subscriber_data/pgdata
### Starting node "subscriber"
# Running: pg_ctl --wait --pgdata /tmp/cirrus-ci-build/src/test/subscription/tmp_check/t_035_conflicts_subscriber_data/pgdata --log /tmp/cirrus-ci-build/src/test/subscription/tmp_check/log/035_conflicts_subscriber.log --options --cluster-name=subscriber start
waiting for server to start.... done
server started
# Postmaster PID for node "subscriber" is 92302
#### Begin standard error
psql:<stdin>:3: NOTICE:  created conflict log table "pg_conflict.pg_conflict_log_16410" for subscription "sub_tab"
psql:<stdin>:3: NOTICE:  created replication slot "sub_tab" on publisher
#### End standard error
Waiting for all subscriptions in "subscriber" to synchronize data
Waiting for replication conn sub_tab's replay_lsn to pass 0/017F49C8 on publisher
done
done
[15:15:56.037](0.851s) ok 1 - Verified multiple_unique_conflicts logged into conflict log table
[15:15:56.061](0.024s) ok 2 - Verified that key 2 exists in the local_conflicts
[15:15:56.061](0.000s) ok 3 - multiple_unique_conflicts detected during insert
[15:15:56.241](0.180s) ok 4 - Verified multiple_unique_conflicts logged into conflict log table
[15:15:56.266](0.025s) ok 5 - Verified that key 6 exists in the local_conflicts
[15:15:56.266](0.000s) ok 6 - multiple_unique_conflicts detected during update
[15:15:56.744](0.478s) ok 7 - multiple_unique_conflicts detected on a leaf partition during insert
### Restarting node "publisher"
# Running: pg_ctl --wait --pgdata /tmp/cirrus-ci-build/src/test/subscription/tmp_check/t_035_conflicts_publisher_data/pgdata --log /tmp/cirrus-ci-build/src/test/subscription/tmp_check/log/035_conflicts_publisher.log restart
waiting for server to shut down.... done
server stopped
waiting for server to start.... done
server started
# Postmaster PID for node "publisher" is 92381
### Restarting node "subscriber"
# Running: pg_ctl --wait --pgdata /tmp/cirrus-ci-build/src/test/subscription/tmp_check/t_035_conflicts_subscriber_data/pgdata --log /tmp/cirrus-ci-build/src/test/subscription/tmp_check/log/035_conflicts_subscriber.log restart
waiting for server to shut down.... done
server stopped
waiting for server to start.... done
server started
# Postmaster PID for node "subscriber" is 92390
#### Begin standard error
psql:<stdin>:5: NOTICE:  created replication slot "tap_sub_b_a" on publisher
#### End standard error
#### Begin standard error
psql:<stdin>:5: NOTICE:  created replication slot "tap_sub_a_b" on publisher
#### End standard error
Waiting for all subscriptions in "publisher" to synchronize data
Waiting for replication conn tap_sub_a_b's replay_lsn to pass 0/01827788 on subscriber
done
done
Waiting for all subscriptions in "subscriber" to synchronize data
Waiting for replication conn tap_sub_b_a's replay_lsn to pass 0/0181CA58 on publisher
done
done
[15:15:57.591](0.847s) ok 8 - Bidirectional replication setup is complete
[15:15:57.620](0.030s) ok 9 - the xmin value of slot 'pg_conflict_detection' is valid on Node B
[15:15:57.646](0.025s) ok 10 - altering retain_dead_tuples is not allowed for enabled subscription
[15:15:57.741](0.095s) ok 11 - altering retain_dead_tuples is allowed for disabled subscription
[15:15:57.806](0.066s) ok 12 - the xmin value of slot 'pg_conflict_detection' is valid on Node A
[15:15:57.862](0.055s) ok 13 - warn of the possibility of receiving changes from origins other than the publisher
Waiting for replication conn tap_sub_b_a's replay_lsn to pass 0/0181D2D8 on publisher
done
[15:15:58.026](0.164s) ok 14 - check replicated insert on node B
#### Begin standard error
psql:<stdin>:1: WARNING:  deleted rows to detect conflicts would not be removed until the subscription is enabled
HINT:  Consider setting retain_dead_tuples to false.
#### End standard error
[15:15:58.170](0.144s) ok 15 - the deleted column is non-removable
Waiting for replication conn tap_sub_b_a's replay_lsn to pass 0/0181D4A8 on publisher
[15:19:55.279](237.109s) # poll_query_until timed out executing this query:
# SELECT '0/0181D4A8' <= replay_lsn AND state = 'streaming'
#          FROM pg_catalog.pg_stat_replication
#          WHERE application_name IN ('tap_sub_b_a', 'walreceiver')
# expecting this output:
# t
# last actual query output:
# 
# with stderr:
[15:19:55.312](0.033s) # Last pg_stat_replication contents:
[15:19:55.312](0.000s) # die: timed out waiting for catchup at t/035_conflicts.pl line 355.
[15:19:55.312](0.000s) 1..15
timed out waiting for catchup at t/035_conflicts.pl line 355.
# Postmaster PID for node "publisher" is 92381
### Stopping node "publisher" using mode immediate
# Running: pg_ctl --pgdata /tmp/cirrus-ci-build/src/test/subscription/tmp_check/t_035_conflicts_publisher_data/pgdata --mode immediate stop
waiting for server to shut down.... done
server stopped
# No postmaster PID for node "publisher"
# No postmaster PID for node "subscriber"
[15:19:55.423](0.110s) # Looks like your test exited with 29 just after 15.