# Checking port 25985 # Found port 25985 Name: publisher Version: 19devel Data directory: /tmp/cirrus-ci-build/src/test/subscription/tmp_check/t_001_rep_changes_publisher_data/pgdata Backup directory: /tmp/cirrus-ci-build/src/test/subscription/tmp_check/t_001_rep_changes_publisher_data/backup Archive directory: /tmp/cirrus-ci-build/src/test/subscription/tmp_check/t_001_rep_changes_publisher_data/archives Connection string: port=25985 host=/tmp/R4oLjiWZWp Log file: /tmp/cirrus-ci-build/src/test/subscription/tmp_check/log/001_rep_changes_publisher.log [14:52:17.324](0.102s) # 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_001_rep_changes_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_001_rep_changes_publisher_data/pgdata ### Starting node "publisher" # Running: pg_ctl --wait --pgdata /tmp/cirrus-ci-build/src/test/subscription/tmp_check/t_001_rep_changes_publisher_data/pgdata --log /tmp/cirrus-ci-build/src/test/subscription/tmp_check/log/001_rep_changes_publisher.log --options --cluster-name=publisher start waiting for server to start.... done server started # Postmaster PID for node "publisher" is 28836 # Checking port 25986 # Found port 25986 Name: subscriber Version: 19devel Data directory: /tmp/cirrus-ci-build/src/test/subscription/tmp_check/t_001_rep_changes_subscriber_data/pgdata Backup directory: /tmp/cirrus-ci-build/src/test/subscription/tmp_check/t_001_rep_changes_subscriber_data/backup Archive directory: /tmp/cirrus-ci-build/src/test/subscription/tmp_check/t_001_rep_changes_subscriber_data/archives Connection string: port=25986 host=/tmp/R4oLjiWZWp Log file: /tmp/cirrus-ci-build/src/test/subscription/tmp_check/log/001_rep_changes_subscriber.log [14:52:18.042](0.718s) # 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_001_rep_changes_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_001_rep_changes_subscriber_data/pgdata ### Starting node "subscriber" # Running: pg_ctl --wait --pgdata /tmp/cirrus-ci-build/src/test/subscription/tmp_check/t_001_rep_changes_subscriber_data/pgdata --log /tmp/cirrus-ci-build/src/test/subscription/tmp_check/log/001_rep_changes_subscriber.log --options --cluster-name=subscriber start waiting for server to start.... done server started # Postmaster PID for node "subscriber" is 28900 #### Begin standard error psql::1: NOTICE: created replication slot "tap_sub" on publisher #### End standard error Waiting for all subscriptions in "subscriber" to synchronize data Waiting for replication conn tap_sub's replay_lsn to pass 0/01833EF0 on publisher done done [14:52:22.469](4.427s) ok 1 - check non-replicated table is empty on subscriber [14:52:22.516](0.047s) ok 2 - check initial data was copied to subscriber Waiting for replication conn tap_sub's replay_lsn to pass 0/0184A218 on publisher done [14:52:23.366](0.849s) ok 3 - check replicated inserts on subscriber [14:52:23.443](0.077s) ok 4 - check replicated changes on subscriber [14:52:23.515](0.072s) ok 5 - check replicated changes with different column order [14:52:23.602](0.086s) ok 6 - check replicated changes with REPLICA IDENTITY NOTHING [14:52:23.650](0.048s) ok 7 - check replicated changes with primary key index with included columns [14:52:23.704](0.054s) ok 8 - value replicated to subscriber without replica identity index [14:52:23.742](0.038s) ok 9 - check replicated changes for table having no columns [14:52:23.896](0.154s) ok 10 - check rows on subscriber before table drop from publication Waiting for replication conn tap_sub's replay_lsn to pass 0/0184A778 on publisher done [14:52:24.279](0.383s) ok 11 - check rows on subscriber after table drop from publication #### Begin standard error psql::1: NOTICE: created replication slot "tap_sub_temp1" on publisher #### End standard error Waiting for all subscriptions in "subscriber" to synchronize data Waiting for replication conn tap_sub_temp1's replay_lsn to pass 0/0184E448 on publisher done done [14:52:25.846](1.566s) ok 12 - check initial rows on subscriber with multiple publications Waiting for replication conn tap_sub_temp1's replay_lsn to pass 0/0184E4B8 on publisher done [14:52:26.266](0.420s) ok 13 - check rows on subscriber with multiple publications #### Begin standard error psql::1: NOTICE: dropped replication slot "tap_sub_temp1" on publisher #### End standard error Waiting for replication conn tap_sub's replay_lsn to pass 0/01850C98 on publisher done [14:52:27.936](1.670s) ok 14 - update works with REPLICA IDENTITY FULL and duplicate tuples [14:52:28.018](0.082s) ok 15 - update works with REPLICA IDENTITY FULL and text datums [14:52:28.114](0.096s) ok 16 - update works with different column order and subscriber local values [14:52:28.190](0.076s) ok 17 - update works with REPLICA IDENTITY FULL and a primary key Waiting for replication conn tap_sub's replay_lsn to pass 0/01850E70 on publisher [14:58:39.953](371.763s) # poll_query_until timed out executing this query: # SELECT '0/01850E70' <= replay_lsn AND state = 'streaming' # FROM pg_catalog.pg_stat_replication # WHERE application_name IN ('tap_sub', 'walreceiver') # expecting this output: # t # last actual query output: # # with stderr: [14:58:39.987](0.034s) # Last pg_stat_replication contents: [14:58:39.989](0.002s) # die: timed out waiting for catchup at t/001_rep_changes.pl line 365. [14:58:39.989](0.000s) 1..17 timed out waiting for catchup at t/001_rep_changes.pl line 365. # Postmaster PID for node "publisher" is 28836 ### Stopping node "publisher" using mode immediate # Running: pg_ctl --pgdata /tmp/cirrus-ci-build/src/test/subscription/tmp_check/t_001_rep_changes_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" [14:58:40.101](0.111s) # Looks like your test exited with 29 just after 17.