# Checking port 18099 # Found port 18099 Name: publisher Version: 19devel Data directory: /tmp/cirrus-ci-build/build/testrun/subscription/001_rep_changes/data/t_001_rep_changes_publisher_data/pgdata Backup directory: /tmp/cirrus-ci-build/build/testrun/subscription/001_rep_changes/data/t_001_rep_changes_publisher_data/backup Archive directory: /tmp/cirrus-ci-build/build/testrun/subscription/001_rep_changes/data/t_001_rep_changes_publisher_data/archives Connection string: port=18099 host=/tmp/8Er4CgCWMd Log file: /tmp/cirrus-ci-build/build/testrun/subscription/001_rep_changes/log/001_rep_changes_publisher.log [14:55:45.542](0.019s) # initializing database system by running initdb # Running: initdb --no-sync --pgdata /tmp/cirrus-ci-build/build/testrun/subscription/001_rep_changes/data/t_001_rep_changes_publisher_data/pgdata --auth trust -c debug_copy_parse_plan_trees=on -c debug_write_read_parse_plan_trees=on -c debug_raw_expression_coverage_test=on -c debug_parallel_query=regress The files belonging to this database system will be owned by user "postgres". This user must also own the server process. The database cluster will be initialized with this locale configuration: locale provider: libc LC_COLLATE: en_US.UTF-8 LC_CTYPE: en_US.UTF-8 LC_MESSAGES: C LC_MONETARY: en_US.UTF-8 LC_NUMERIC: C LC_TIME: en_US.UTF-8 The default database encoding has accordingly been set to "UTF8". The default text search configuration will be set to "english". Data page checksums are enabled. creating directory /tmp/cirrus-ci-build/build/testrun/subscription/001_rep_changes/data/t_001_rep_changes_publisher_data/pgdata ... ok creating subdirectories ... ok selecting dynamic shared memory implementation ... posix selecting default "max_connections" ... 100 selecting default "shared_buffers" ... 128MB selecting default time zone ... UTC creating configuration files ... ok running bootstrap script ... ok performing post-bootstrap initialization ... ok Sync to disk skipped. The data directory might become corrupt if the operating system crashes. Success. You can now start the database server using: pg_ctl -D /tmp/cirrus-ci-build/build/testrun/subscription/001_rep_changes/data/t_001_rep_changes_publisher_data/pgdata -l logfile start # Running: /tmp/cirrus-ci-build/build/src/test/regress/pg_regress --config-auth /tmp/cirrus-ci-build/build/testrun/subscription/001_rep_changes/data/t_001_rep_changes_publisher_data/pgdata ### Starting node "publisher" # Running: pg_ctl --wait --pgdata /tmp/cirrus-ci-build/build/testrun/subscription/001_rep_changes/data/t_001_rep_changes_publisher_data/pgdata --log /tmp/cirrus-ci-build/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 46364 # Checking port 18100 # Found port 18100 Name: subscriber Version: 19devel Data directory: /tmp/cirrus-ci-build/build/testrun/subscription/001_rep_changes/data/t_001_rep_changes_subscriber_data/pgdata Backup directory: /tmp/cirrus-ci-build/build/testrun/subscription/001_rep_changes/data/t_001_rep_changes_subscriber_data/backup Archive directory: /tmp/cirrus-ci-build/build/testrun/subscription/001_rep_changes/data/t_001_rep_changes_subscriber_data/archives Connection string: port=18100 host=/tmp/8Er4CgCWMd Log file: /tmp/cirrus-ci-build/build/testrun/subscription/001_rep_changes/log/001_rep_changes_subscriber.log [14:55:47.455](1.913s) # initializing database system by running initdb # Running: initdb --no-sync --pgdata /tmp/cirrus-ci-build/build/testrun/subscription/001_rep_changes/data/t_001_rep_changes_subscriber_data/pgdata --auth trust -c debug_copy_parse_plan_trees=on -c debug_write_read_parse_plan_trees=on -c debug_raw_expression_coverage_test=on -c debug_parallel_query=regress The files belonging to this database system will be owned by user "postgres". This user must also own the server process. The database cluster will be initialized with this locale configuration: locale provider: libc LC_COLLATE: en_US.UTF-8 LC_CTYPE: en_US.UTF-8 LC_MESSAGES: C LC_MONETARY: en_US.UTF-8 LC_NUMERIC: C LC_TIME: en_US.UTF-8 The default database encoding has accordingly been set to "UTF8". The default text search configuration will be set to "english". Data page checksums are enabled. creating directory /tmp/cirrus-ci-build/build/testrun/subscription/001_rep_changes/data/t_001_rep_changes_subscriber_data/pgdata ... ok creating subdirectories ... ok selecting dynamic shared memory implementation ... posix selecting default "max_connections" ... 100 selecting default "shared_buffers" ... 128MB selecting default time zone ... UTC creating configuration files ... ok running bootstrap script ... ok performing post-bootstrap initialization ... ok Sync to disk skipped. The data directory might become corrupt if the operating system crashes. Success. You can now start the database server using: pg_ctl -D /tmp/cirrus-ci-build/build/testrun/subscription/001_rep_changes/data/t_001_rep_changes_subscriber_data/pgdata -l logfile start # Running: /tmp/cirrus-ci-build/build/src/test/regress/pg_regress --config-auth /tmp/cirrus-ci-build/build/testrun/subscription/001_rep_changes/data/t_001_rep_changes_subscriber_data/pgdata ### Starting node "subscriber" # Running: pg_ctl --wait --pgdata /tmp/cirrus-ci-build/build/testrun/subscription/001_rep_changes/data/t_001_rep_changes_subscriber_data/pgdata --log /tmp/cirrus-ci-build/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 46568 #### Begin standard error psql::1: WARNING: subscriptions created by regression test cases should have names starting with "regress_" 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/01817458 on publisher done done [14:55:51.403](3.948s) ok 1 - check non-replicated table is empty on subscriber [14:55:51.448](0.045s) ok 2 - check initial data was copied to subscriber Waiting for replication conn tap_sub's replay_lsn to pass 0/0182D768 on publisher done [14:55:51.834](0.386s) ok 3 - check replicated inserts on subscriber [14:55:51.864](0.029s) ok 4 - check replicated changes on subscriber [14:55:51.894](0.030s) ok 5 - check replicated changes with different column order [14:55:51.918](0.025s) ok 6 - check replicated changes with REPLICA IDENTITY NOTHING [14:55:51.946](0.028s) ok 7 - check replicated changes with primary key index with included columns [14:55:52.010](0.064s) ok 8 - value replicated to subscriber without replica identity index [14:55:52.038](0.028s) ok 9 - check replicated changes for table having no columns [14:55:52.155](0.117s) ok 10 - check rows on subscriber before table drop from publication Waiting for replication conn tap_sub's replay_lsn to pass 0/0182DCC8 on publisher done [14:55:52.293](0.139s) ok 11 - check rows on subscriber after table drop from publication #### Begin standard error psql::1: WARNING: subscriptions created by regression test cases should have names starting with "regress_" 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/01831998 on publisher done done [14:55:53.102](0.809s) ok 12 - check initial rows on subscriber with multiple publications Waiting for replication conn tap_sub_temp1's replay_lsn to pass 0/01831A08 on publisher done [14:55:53.284](0.182s) 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/01834200 on publisher done [14:55:54.119](0.835s) ok 14 - update works with REPLICA IDENTITY FULL and duplicate tuples [14:55:54.147](0.028s) ok 15 - update works with REPLICA IDENTITY FULL and text datums [14:55:54.179](0.032s) ok 16 - update works with different column order and subscriber local values [14:55:54.212](0.033s) ok 17 - update works with REPLICA IDENTITY FULL and a primary key Waiting for replication conn tap_sub's replay_lsn to pass 0/018343D8 on publisher [14:59:33.557](219.345s) # poll_query_until timed out executing this query: # SELECT '0/018343D8' <= 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:59:33.569](0.012s) # Last pg_stat_replication contents: [14:59:33.570](0.001s) # die: timed out waiting for catchup at /tmp/cirrus-ci-build/src/test/subscription/t/001_rep_changes.pl line 365. [14:59:33.571](0.000s) 1..17 timed out waiting for catchup at /tmp/cirrus-ci-build/src/test/subscription/t/001_rep_changes.pl line 365. # Postmaster PID for node "publisher" is 46364 ### Stopping node "publisher" using mode immediate # Running: pg_ctl --pgdata /tmp/cirrus-ci-build/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:59:33.677](0.106s) # Looks like your test exited with 29 just after 17.