# Checking port 29580 # Found port 29580 Name: publisher Version: 19devel Data directory: /home/postgres/postgres/build/testrun/subscription/001_rep_changes/data/t_001_rep_changes_publisher_data/pgdata Backup directory: /home/postgres/postgres/build/testrun/subscription/001_rep_changes/data/t_001_rep_changes_publisher_data/backup Archive directory: /home/postgres/postgres/build/testrun/subscription/001_rep_changes/data/t_001_rep_changes_publisher_data/archives Connection string: port=29580 host=/tmp/KF9fGsnuVs Log file: /home/postgres/postgres/build/testrun/subscription/001_rep_changes/log/001_rep_changes_publisher.log [14:53:47.215](0.018s) # initializing database system by copying initdb template # Running: cp -RPp /home/postgres/postgres/build/tmp_install/initdb-template /home/postgres/postgres/build/testrun/subscription/001_rep_changes/data/t_001_rep_changes_publisher_data/pgdata # Running: /home/postgres/postgres/build/src/test/regress/pg_regress --config-auth /home/postgres/postgres/build/testrun/subscription/001_rep_changes/data/t_001_rep_changes_publisher_data/pgdata ### Starting node "publisher" # Running: pg_ctl --wait --pgdata /home/postgres/postgres/build/testrun/subscription/001_rep_changes/data/t_001_rep_changes_publisher_data/pgdata --log /home/postgres/postgres/build/testrun/subscription/001_rep_changes/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 24972 # Checking port 29581 # Found port 29581 Name: subscriber Version: 19devel Data directory: /home/postgres/postgres/build/testrun/subscription/001_rep_changes/data/t_001_rep_changes_subscriber_data/pgdata Backup directory: /home/postgres/postgres/build/testrun/subscription/001_rep_changes/data/t_001_rep_changes_subscriber_data/backup Archive directory: /home/postgres/postgres/build/testrun/subscription/001_rep_changes/data/t_001_rep_changes_subscriber_data/archives Connection string: port=29581 host=/tmp/KF9fGsnuVs Log file: /home/postgres/postgres/build/testrun/subscription/001_rep_changes/log/001_rep_changes_subscriber.log [14:53:47.425](0.209s) # initializing database system by copying initdb template # Running: cp -RPp /home/postgres/postgres/build/tmp_install/initdb-template /home/postgres/postgres/build/testrun/subscription/001_rep_changes/data/t_001_rep_changes_subscriber_data/pgdata # Running: /home/postgres/postgres/build/src/test/regress/pg_regress --config-auth /home/postgres/postgres/build/testrun/subscription/001_rep_changes/data/t_001_rep_changes_subscriber_data/pgdata ### Starting node "subscriber" # Running: pg_ctl --wait --pgdata /home/postgres/postgres/build/testrun/subscription/001_rep_changes/data/t_001_rep_changes_subscriber_data/pgdata --log /home/postgres/postgres/build/testrun/subscription/001_rep_changes/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 8857 #### 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/01819ED0 on publisher done done [14:53:49.416](1.992s) ok 1 - check non-replicated table is empty on subscriber [14:53:49.477](0.061s) ok 2 - check initial data was copied to subscriber Waiting for replication conn tap_sub's replay_lsn to pass 0/018301F8 on publisher done [14:53:50.375](0.897s) ok 3 - check replicated inserts on subscriber [14:53:50.469](0.094s) ok 4 - check replicated changes on subscriber [14:53:50.531](0.062s) ok 5 - check replicated changes with different column order [14:53:50.560](0.029s) ok 6 - check replicated changes with REPLICA IDENTITY NOTHING [14:53:50.588](0.028s) ok 7 - check replicated changes with primary key index with included columns [14:53:50.615](0.027s) ok 8 - value replicated to subscriber without replica identity index [14:53:50.656](0.040s) ok 9 - check replicated changes for table having no columns [14:53:50.848](0.192s) ok 10 - check rows on subscriber before table drop from publication Waiting for replication conn tap_sub's replay_lsn to pass 0/01830758 on publisher done [14:53:51.306](0.458s) 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/01834428 on publisher done done [14:53:52.126](0.820s) ok 12 - check initial rows on subscriber with multiple publications Waiting for replication conn tap_sub_temp1's replay_lsn to pass 0/01834498 on publisher done [14:53:52.607](0.481s) 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/01836C78 on publisher done [14:53:53.973](1.365s) ok 14 - update works with REPLICA IDENTITY FULL and duplicate tuples [14:53:54.002](0.029s) ok 15 - update works with REPLICA IDENTITY FULL and text datums [14:53:54.039](0.037s) ok 16 - update works with different column order and subscriber local values [14:53:54.182](0.143s) ok 17 - update works with REPLICA IDENTITY FULL and a primary key Waiting for replication conn tap_sub's replay_lsn to pass 0/01836E50 on publisher [14:57:38.023](223.840s) # poll_query_until timed out executing this query: # SELECT '0/01836E50' <= 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:57:38.045](0.023s) # Last pg_stat_replication contents: [14:57:38.046](0.000s) # die: timed out waiting for catchup at /home/postgres/postgres/src/test/subscription/t/001_rep_changes.pl line 365. [14:57:38.046](0.000s) 1..17 timed out waiting for catchup at /home/postgres/postgres/src/test/subscription/t/001_rep_changes.pl line 365. # Postmaster PID for node "publisher" is 24972 ### Stopping node "publisher" using mode immediate # Running: pg_ctl --pgdata /home/postgres/postgres/build/testrun/subscription/001_rep_changes/data/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:57:38.152](0.106s) # Looks like your test exited with 4 just after 17.