# Checking port 53227 # Found port 53227 Name: london Data directory: /tmp/cirrus-ci-build/build/testrun/recovery/009_twophase/data/t_009_twophase_london_data/pgdata Backup directory: /tmp/cirrus-ci-build/build/testrun/recovery/009_twophase/data/t_009_twophase_london_data/backup Archive directory: /tmp/cirrus-ci-build/build/testrun/recovery/009_twophase/data/t_009_twophase_london_data/archives Connection string: port=53227 host=/tmp/NnL00iuWHj Log file: /tmp/cirrus-ci-build/build/testrun/recovery/009_twophase/log/009_twophase_london.log [11:13:31.956](0.014s) # 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/009_twophase/data/t_009_twophase_london_data/pgdata # Running: /tmp/cirrus-ci-build/build/src/test/regress/pg_regress --config-auth /tmp/cirrus-ci-build/build/testrun/recovery/009_twophase/data/t_009_twophase_london_data/pgdata ### Starting node "london" # Running: pg_ctl -w -D /tmp/cirrus-ci-build/build/testrun/recovery/009_twophase/data/t_009_twophase_london_data/pgdata -l /tmp/cirrus-ci-build/build/testrun/recovery/009_twophase/log/009_twophase_london.log -o --cluster-name=london start pg_ctl: another server might be running; trying to start server anyway waiting for server to start.... done server started # Postmaster PID for node "london" is 22025 # Taking pg_basebackup london_backup from node "london" # Running: pg_basebackup -D /tmp/cirrus-ci-build/build/testrun/recovery/009_twophase/data/t_009_twophase_london_data/backup/london_backup -h /tmp/NnL00iuWHj -p 53227 --checkpoint fast --no-sync # Backup finished # Checking port 53228 # Found port 53228 Name: paris Data directory: /tmp/cirrus-ci-build/build/testrun/recovery/009_twophase/data/t_009_twophase_paris_data/pgdata Backup directory: /tmp/cirrus-ci-build/build/testrun/recovery/009_twophase/data/t_009_twophase_paris_data/backup Archive directory: /tmp/cirrus-ci-build/build/testrun/recovery/009_twophase/data/t_009_twophase_paris_data/archives Connection string: port=53228 host=/tmp/NnL00iuWHj Log file: /tmp/cirrus-ci-build/build/testrun/recovery/009_twophase/log/009_twophase_paris.log # Initializing node "paris" from backup "london_backup" of node "london" ### Enabling streaming replication for node "paris" ### Starting node "paris" # Running: pg_ctl -w -D /tmp/cirrus-ci-build/build/testrun/recovery/009_twophase/data/t_009_twophase_paris_data/pgdata -l /tmp/cirrus-ci-build/build/testrun/recovery/009_twophase/log/009_twophase_paris.log -o --cluster-name=paris start waiting for server to start.... done server started # Postmaster PID for node "paris" is 22152 psql: error: connection to server on socket "/tmp/NnL00iuWHj/.s.PGSQL.53227" failed: FATAL: database "postgres" does not exist [11:13:32.478](0.522s) not ok 1 - reload node london with synchronous_standby_names = 'paris' [11:13:32.478](0.000s) # Failed test 'reload node london with synchronous_standby_names = 'paris'' # at /tmp/cirrus-ci-build/src/test/recovery/t/009_twophase.pl line 55. [11:13:32.478](0.000s) # got: '' # expected: 't' psql: error: connection to server on socket "/tmp/NnL00iuWHj/.s.PGSQL.53228" failed: FATAL: database "postgres" does not exist [11:13:32.491](0.013s) not ok 2 - reload node paris with synchronous_standby_names = 'london' [11:13:32.491](0.000s) # Failed test 'reload node paris with synchronous_standby_names = 'london'' # at /tmp/cirrus-ci-build/src/test/recovery/t/009_twophase.pl line 56. [11:13:32.491](0.000s) # got: '' # expected: 't' [11:13:32.491](0.000s) # Initially, london is primary and paris is standby psql: error: connection to server on socket "/tmp/NnL00iuWHj/.s.PGSQL.53227" failed: FATAL: database "postgres" does not exist psql: error: connection to server on socket "/tmp/NnL00iuWHj/.s.PGSQL.53227" failed: FATAL: database "postgres" does not exist ### Stopping node "london" using mode fast # Running: pg_ctl -D /tmp/cirrus-ci-build/build/testrun/recovery/009_twophase/data/t_009_twophase_london_data/pgdata -m fast stop waiting for server to shut down.... done server stopped # No postmaster PID for node "london" ### Starting node "london" # Running: pg_ctl -w -D /tmp/cirrus-ci-build/build/testrun/recovery/009_twophase/data/t_009_twophase_london_data/pgdata -l /tmp/cirrus-ci-build/build/testrun/recovery/009_twophase/log/009_twophase_london.log -o --cluster-name=london start waiting for server to start.... done server started # Postmaster PID for node "london" is 22253 psql: error: connection to server on socket "/tmp/NnL00iuWHj/.s.PGSQL.53227" failed: FATAL: database "postgres" does not exist [11:13:33.048](0.557s) not ok 3 - Commit prepared transaction after restart [11:13:33.049](0.000s) # Failed test 'Commit prepared transaction after restart' # at /tmp/cirrus-ci-build/src/test/recovery/t/009_twophase.pl line 89. [11:13:33.049](0.000s) # got: '2' # expected: '0' psql: error: connection to server on socket "/tmp/NnL00iuWHj/.s.PGSQL.53227" failed: FATAL: database "postgres" does not exist [11:13:33.092](0.043s) not ok 4 - Rollback prepared transaction after restart [11:13:33.093](0.000s) # Failed test 'Rollback prepared transaction after restart' # at /tmp/cirrus-ci-build/src/test/recovery/t/009_twophase.pl line 92. [11:13:33.093](0.000s) # got: '2' # expected: '0' psql: error: connection to server on socket "/tmp/NnL00iuWHj/.s.PGSQL.53227" failed: FATAL: database "postgres" does not exist ### Stopping node "london" using mode immediate # Running: pg_ctl -D /tmp/cirrus-ci-build/build/testrun/recovery/009_twophase/data/t_009_twophase_london_data/pgdata -m immediate stop waiting for server to shut down.... done server stopped # No postmaster PID for node "london" ### Starting node "london" # Running: pg_ctl -w -D /tmp/cirrus-ci-build/build/testrun/recovery/009_twophase/data/t_009_twophase_london_data/pgdata -l /tmp/cirrus-ci-build/build/testrun/recovery/009_twophase/log/009_twophase_london.log -o --cluster-name=london start waiting for server to start.... done server started # Postmaster PID for node "london" is 22425 psql: error: connection to server on socket "/tmp/NnL00iuWHj/.s.PGSQL.53227" failed: FATAL: database "postgres" does not exist [11:13:33.409](0.316s) not ok 5 - Commit prepared transaction after teardown [11:13:33.409](0.000s) # Failed test 'Commit prepared transaction after teardown' # at /tmp/cirrus-ci-build/src/test/recovery/t/009_twophase.pl line 117. [11:13:33.409](0.000s) # got: '2' # expected: '0' psql: error: connection to server on socket "/tmp/NnL00iuWHj/.s.PGSQL.53227" failed: FATAL: database "postgres" does not exist [11:13:33.452](0.043s) not ok 6 - Rollback prepared transaction after teardown [11:13:33.452](0.000s) # Failed test 'Rollback prepared transaction after teardown' # at /tmp/cirrus-ci-build/src/test/recovery/t/009_twophase.pl line 120. [11:13:33.452](0.000s) # got: '2' # expected: '0' psql: error: connection to server on socket "/tmp/NnL00iuWHj/.s.PGSQL.53227" failed: FATAL: database "postgres" does not exist ### Stopping node "london" using mode immediate # Running: pg_ctl -D /tmp/cirrus-ci-build/build/testrun/recovery/009_twophase/data/t_009_twophase_london_data/pgdata -m immediate stop waiting for server to shut down.... done server stopped # No postmaster PID for node "london" ### Starting node "london" # Running: pg_ctl -w -D /tmp/cirrus-ci-build/build/testrun/recovery/009_twophase/data/t_009_twophase_london_data/pgdata -l /tmp/cirrus-ci-build/build/testrun/recovery/009_twophase/log/009_twophase_london.log -o --cluster-name=london start waiting for server to start.... done server started # Postmaster PID for node "london" is 22513 psql: error: connection to server on socket "/tmp/NnL00iuWHj/.s.PGSQL.53227" failed: FATAL: database "postgres" does not exist [11:13:33.772](0.320s) not ok 7 - Replay several transactions with same GID [11:13:33.772](0.000s) # Failed test 'Replay several transactions with same GID' # at /tmp/cirrus-ci-build/src/test/recovery/t/009_twophase.pl line 144. [11:13:33.772](0.000s) # got: '2' # expected: '0' psql: error: connection to server on socket "/tmp/NnL00iuWHj/.s.PGSQL.53227" failed: FATAL: database "postgres" does not exist ### Stopping node "london" using mode immediate # Running: pg_ctl -D /tmp/cirrus-ci-build/build/testrun/recovery/009_twophase/data/t_009_twophase_london_data/pgdata -m immediate stop waiting for server to shut down.... done server stopped # No postmaster PID for node "london" ### Starting node "london" # Running: pg_ctl -w -D /tmp/cirrus-ci-build/build/testrun/recovery/009_twophase/data/t_009_twophase_london_data/pgdata -l /tmp/cirrus-ci-build/build/testrun/recovery/009_twophase/log/009_twophase_london.log -o --cluster-name=london start waiting for server to start.... done server started # Postmaster PID for node "london" is 22616 psql: error: connection to server on socket "/tmp/NnL00iuWHj/.s.PGSQL.53227" failed: FATAL: database "postgres" does not exist [11:13:34.181](0.408s) not ok 8 - Cleanup of shared memory state for 2PC commit [11:13:34.181](0.000s) # Failed test 'Cleanup of shared memory state for 2PC commit' # at /tmp/cirrus-ci-build/src/test/recovery/t/009_twophase.pl line 170. [11:13:34.181](0.000s) # got: '2' # expected: '0' psql: error: connection to server on socket "/tmp/NnL00iuWHj/.s.PGSQL.53227" failed: FATAL: database "postgres" does not exist psql: error: connection to server on socket "/tmp/NnL00iuWHj/.s.PGSQL.53227" failed: FATAL: database "postgres" does not exist psql: error: connection to server on socket "/tmp/NnL00iuWHj/.s.PGSQL.53228" failed: FATAL: database "postgres" does not exist [11:13:34.289](0.108s) not ok 9 - Cleanup of shared memory state on running standby without checkpoint [11:13:34.290](0.000s) # Failed test 'Cleanup of shared memory state on running standby without checkpoint' # at /tmp/cirrus-ci-build/src/test/recovery/t/009_twophase.pl line 190. [11:13:34.290](0.000s) # got: '' # expected: '0' psql: error: connection to server on socket "/tmp/NnL00iuWHj/.s.PGSQL.53227" failed: FATAL: database "postgres" does not exist psql: error: connection to server on socket "/tmp/NnL00iuWHj/.s.PGSQL.53228" failed: FATAL: database "postgres" does not exist psql: error: connection to server on socket "/tmp/NnL00iuWHj/.s.PGSQL.53227" failed: FATAL: database "postgres" does not exist psql: error: connection to server on socket "/tmp/NnL00iuWHj/.s.PGSQL.53228" failed: FATAL: database "postgres" does not exist [11:13:34.433](0.144s) not ok 10 - Cleanup of shared memory state on running standby after checkpoint [11:13:34.434](0.000s) # Failed test 'Cleanup of shared memory state on running standby after checkpoint' # at /tmp/cirrus-ci-build/src/test/recovery/t/009_twophase.pl line 211. [11:13:34.434](0.000s) # got: '' # expected: '0' psql: error: connection to server on socket "/tmp/NnL00iuWHj/.s.PGSQL.53227" failed: FATAL: database "postgres" does not exist ### Stopping node "london" using mode immediate # Running: pg_ctl -D /tmp/cirrus-ci-build/build/testrun/recovery/009_twophase/data/t_009_twophase_london_data/pgdata -m immediate stop waiting for server to shut down.... done server stopped # No postmaster PID for node "london" ### Promoting node "paris" # Running: pg_ctl -D /tmp/cirrus-ci-build/build/testrun/recovery/009_twophase/data/t_009_twophase_paris_data/pgdata -l /tmp/cirrus-ci-build/build/testrun/recovery/009_twophase/log/009_twophase_paris.log promote waiting for server to promote.... done server promoted [11:13:34.688](0.255s) # Now paris is primary and london is standby psql: error: connection to server on socket "/tmp/NnL00iuWHj/.s.PGSQL.53228" failed: FATAL: database "postgres" does not exist [11:13:34.732](0.043s) not ok 11 - Restore of prepared transaction on promoted standby [11:13:34.732](0.000s) # Failed test 'Restore of prepared transaction on promoted standby' # at /tmp/cirrus-ci-build/src/test/recovery/t/009_twophase.pl line 237. [11:13:34.732](0.000s) # got: '2' # expected: '0' ### Enabling streaming replication for node "london" ### Starting node "london" # Running: pg_ctl -w -D /tmp/cirrus-ci-build/build/testrun/recovery/009_twophase/data/t_009_twophase_london_data/pgdata -l /tmp/cirrus-ci-build/build/testrun/recovery/009_twophase/log/009_twophase_london.log -o --cluster-name=london start waiting for server to start.... done server started # Postmaster PID for node "london" is 22921 psql: error: connection to server on socket "/tmp/NnL00iuWHj/.s.PGSQL.53228" failed: FATAL: database "postgres" does not exist ### Stopping node "paris" using mode fast # Running: pg_ctl -D /tmp/cirrus-ci-build/build/testrun/recovery/009_twophase/data/t_009_twophase_paris_data/pgdata -m fast stop waiting for server to shut down.... done server stopped # No postmaster PID for node "paris" ### Restarting node "london" # Running: pg_ctl -w -D /tmp/cirrus-ci-build/build/testrun/recovery/009_twophase/data/t_009_twophase_london_data/pgdata -l /tmp/cirrus-ci-build/build/testrun/recovery/009_twophase/log/009_twophase_london.log restart waiting for server to shut down.... done server stopped waiting for server to start.... done server started # Postmaster PID for node "london" is 23019 ### Promoting node "london" # Running: pg_ctl -D /tmp/cirrus-ci-build/build/testrun/recovery/009_twophase/data/t_009_twophase_london_data/pgdata -l /tmp/cirrus-ci-build/build/testrun/recovery/009_twophase/log/009_twophase_london.log promote waiting for server to promote.... done server promoted [11:13:35.320](0.587s) # Now london is primary and paris is standby psql: error: connection to server on socket "/tmp/NnL00iuWHj/.s.PGSQL.53227" failed: FATAL: database "postgres" does not exist [11:13:35.329](0.010s) not ok 12 - Restore prepared transactions from files with primary down [11:13:35.330](0.000s) # Failed test 'Restore prepared transactions from files with primary down' # at /tmp/cirrus-ci-build/src/test/recovery/t/009_twophase.pl line 270. [11:13:35.330](0.000s) # got: '' # expected: '1' ### Enabling streaming replication for node "paris" ### Starting node "paris" # Running: pg_ctl -w -D /tmp/cirrus-ci-build/build/testrun/recovery/009_twophase/data/t_009_twophase_paris_data/pgdata -l /tmp/cirrus-ci-build/build/testrun/recovery/009_twophase/log/009_twophase_paris.log -o --cluster-name=paris start waiting for server to start.... done server started # Postmaster PID for node "paris" is 23102 psql: error: connection to server on socket "/tmp/NnL00iuWHj/.s.PGSQL.53227" failed: FATAL: database "postgres" does not exist psql: error: connection to server on socket "/tmp/NnL00iuWHj/.s.PGSQL.53227" failed: FATAL: database "postgres" does not exist ### Stopping node "london" using mode fast # Running: pg_ctl -D /tmp/cirrus-ci-build/build/testrun/recovery/009_twophase/data/t_009_twophase_london_data/pgdata -m fast stop waiting for server to shut down.... done server stopped # No postmaster PID for node "london" ### Stopping node "paris" using mode immediate # Running: pg_ctl -D /tmp/cirrus-ci-build/build/testrun/recovery/009_twophase/data/t_009_twophase_paris_data/pgdata -m immediate stop waiting for server to shut down.... done server stopped # No postmaster PID for node "paris" ### Starting node "paris" # Running: pg_ctl -w -D /tmp/cirrus-ci-build/build/testrun/recovery/009_twophase/data/t_009_twophase_paris_data/pgdata -l /tmp/cirrus-ci-build/build/testrun/recovery/009_twophase/log/009_twophase_paris.log -o --cluster-name=paris start waiting for server to start.... done server started # Postmaster PID for node "paris" is 23219 ### Promoting node "paris" # Running: pg_ctl -D /tmp/cirrus-ci-build/build/testrun/recovery/009_twophase/data/t_009_twophase_paris_data/pgdata -l /tmp/cirrus-ci-build/build/testrun/recovery/009_twophase/log/009_twophase_paris.log promote waiting for server to promote.... done server promoted [11:13:35.968](0.638s) # Now paris is primary and london is standby psql: error: connection to server on socket "/tmp/NnL00iuWHj/.s.PGSQL.53228" failed: FATAL: database "postgres" does not exist [11:13:35.979](0.011s) not ok 13 - Restore prepared transactions from records with primary down [11:13:35.979](0.000s) # Failed test 'Restore prepared transactions from records with primary down' # at /tmp/cirrus-ci-build/src/test/recovery/t/009_twophase.pl line 306. [11:13:35.979](0.000s) # got: '' # expected: '1' ### Enabling streaming replication for node "london" ### Starting node "london" # Running: pg_ctl -w -D /tmp/cirrus-ci-build/build/testrun/recovery/009_twophase/data/t_009_twophase_london_data/pgdata -l /tmp/cirrus-ci-build/build/testrun/recovery/009_twophase/log/009_twophase_london.log -o --cluster-name=london start waiting for server to start.... done server started # Postmaster PID for node "london" is 23299 psql: error: connection to server on socket "/tmp/NnL00iuWHj/.s.PGSQL.53228" failed: FATAL: database "postgres" does not exist psql: error: connection to server on socket "/tmp/NnL00iuWHj/.s.PGSQL.53228" failed: FATAL: database "postgres" does not exist connection error: 'psql: error: connection to server on socket "/tmp/NnL00iuWHj/.s.PGSQL.53228" failed: FATAL: database "postgres" does not exist' while running 'psql -XAtq -d port=53228 host=/tmp/NnL00iuWHj dbname='postgres' -f - -v ON_ERROR_STOP=1' at /tmp/cirrus-ci-build/src/test/perl/PostgreSQL/Test/Cluster.pm line 2043. # Postmaster PID for node "london" is 23299 ### Stopping node "london" using mode immediate # Running: pg_ctl -D /tmp/cirrus-ci-build/build/testrun/recovery/009_twophase/data/t_009_twophase_london_data/pgdata -m immediate stop waiting for server to shut down.... done server stopped # No postmaster PID for node "london" # Postmaster PID for node "paris" is 23219 ### Stopping node "paris" using mode immediate # Running: pg_ctl -D /tmp/cirrus-ci-build/build/testrun/recovery/009_twophase/data/t_009_twophase_paris_data/pgdata -m immediate stop waiting for server to shut down.... done server stopped # No postmaster PID for node "paris" [11:13:36.402](0.423s) # Tests were run but no plan was declared and done_testing() was not seen. [11:13:36.403](0.000s) # Looks like your test exited with 29 just after 13.