[06:20:01.154](0.034s) # setting up data directory
# Checking port 54924
# Found port 54924
Name: primary
Data directory: /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/data/t_001_ssltests_primary_data/pgdata
Backup directory: /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/data/t_001_ssltests_primary_data/backup
Archive directory: /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/data/t_001_ssltests_primary_data/archives
Connection string: port=54924 host=/tmp/Ku4LRdRDqg
Log file: /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/log/001_ssltests_primary.log
[06:20:01.162](0.008s) # 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/ssl/001_ssltests/data/t_001_ssltests_primary_data/pgdata
# Running: /tmp/cirrus-ci-build/build/src/test/regress/pg_regress --config-auth /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/data/t_001_ssltests_primary_data/pgdata
### Starting node "primary"
# Running: pg_ctl -w -D /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/data/t_001_ssltests_primary_data/pgdata -l /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/log/001_ssltests_primary.log -o --cluster-name=primary start
waiting for server to start.... done
server started
# Postmaster PID for node "primary" is 38768
[06:20:01.370](0.208s) ok 1 - ssl_library parameter
psql:<stdin>:1: WARNING:  roles created by regression test cases should have names starting with "regress_"
psql:<stdin>:1: WARNING:  roles created by regression test cases should have names starting with "regress_"
psql:<stdin>:1: WARNING:  roles created by regression test cases should have names starting with "regress_"
psql:<stdin>:1: WARNING:  roles created by regression test cases should have names starting with "regress_"
psql:<stdin>:1: WARNING:  databases created by regression test cases should have names including "regression"
psql:<stdin>:1: WARNING:  databases created by regression test cases should have names including "regression"
psql:<stdin>:1: WARNING:  databases created by regression test cases should have names including "regression"
psql:<stdin>:1: WARNING:  databases created by regression test cases should have names including "regression"
psql:<stdin>:1: WARNING:  databases created by regression test cases should have names including "regression"
psql:<stdin>:1: WARNING:  databases created by regression test cases should have names including "regression"
### Restarting node "primary"
# Running: pg_ctl -w -D /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/data/t_001_ssltests_primary_data/pgdata -l /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/log/001_ssltests_primary.log restart
waiting for server to shut down.... done
server stopped
waiting for server to start.... done
server started
# Postmaster PID for node "primary" is 39040
[06:20:02.188](0.818s) # testing password-protected keys
### Restarting node "primary"
# Running: pg_ctl -w -D /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/data/t_001_ssltests_primary_data/pgdata -l /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/log/001_ssltests_primary.log restart
waiting for server to shut down.... done
server stopped
waiting for server to start.... stopped waiting
pg_ctl: could not start server
Examine the log output.
# pg_ctl restart failed; see logfile for details: /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/log/001_ssltests_primary.log
# No postmaster PID for node "primary"
[06:20:02.395](0.207s) ok 2 - restart fails with password-protected key file with wrong password
### Restarting node "primary"
# Running: pg_ctl -w -D /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/data/t_001_ssltests_primary_data/pgdata -l /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/log/001_ssltests_primary.log restart
pg_ctl: PID file "/tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/data/t_001_ssltests_primary_data/pgdata/postmaster.pid" does not exist
Is server running?
trying to start server anyway
waiting for server to start.... done
server started
# Postmaster PID for node "primary" is 39185
[06:20:02.500](0.105s) ok 3 - restart succeeds with password-protected key file
### Restarting node "primary"
# Running: pg_ctl -w -D /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/data/t_001_ssltests_primary_data/pgdata -l /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/log/001_ssltests_primary.log restart
waiting for server to shut down.... done
server stopped
waiting for server to start.... stopped waiting
pg_ctl: could not start server
Examine the log output.
# pg_ctl restart failed; see logfile for details: /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/log/001_ssltests_primary.log
# No postmaster PID for node "primary"
[06:20:02.710](0.210s) ok 4 - restart fails with incorrect SSL protocol bounds
### Restarting node "primary"
# Running: pg_ctl -w -D /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/data/t_001_ssltests_primary_data/pgdata -l /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/log/001_ssltests_primary.log restart
pg_ctl: PID file "/tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/data/t_001_ssltests_primary_data/pgdata/postmaster.pid" does not exist
Is server running?
trying to start server anyway
waiting for server to start.... done
server started
# Postmaster PID for node "primary" is 39343
[06:20:02.820](0.110s) ok 5 - restart succeeds with correct SSL protocol bounds
[06:20:02.820](0.000s) # running client tests
### Restarting node "primary"
# Running: pg_ctl -w -D /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/data/t_001_ssltests_primary_data/pgdata -l /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/log/001_ssltests_primary.log restart
waiting for server to shut down.... done
server stopped
waiting for server to start.... done
server started
# Postmaster PID for node "primary" is 39430
[06:20:03.060](0.240s) ok 6 - server doesn't accept non-SSL connections
[06:20:03.061](0.001s) ok 7 - server doesn't accept non-SSL connections: matches
[06:20:03.083](0.023s) ok 8 - connect without server root cert sslmode=require
[06:20:03.083](0.000s) ok 9 - connect without server root cert sslmode=require: no stderr
[06:20:03.094](0.011s) ok 10 - connect without server root cert sslmode=verify-ca
[06:20:03.095](0.000s) ok 11 - connect without server root cert sslmode=verify-ca: matches
[06:20:03.105](0.011s) ok 12 - connect without server root cert sslmode=verify-full
[06:20:03.106](0.001s) ok 13 - connect without server root cert sslmode=verify-full: matches
[06:20:03.122](0.016s) ok 14 - connect with wrong server root cert sslmode=require
[06:20:03.122](0.000s) ok 15 - connect with wrong server root cert sslmode=require: matches
[06:20:03.139](0.016s) ok 16 - connect with wrong server root cert sslmode=verify-ca
[06:20:03.139](0.001s) ok 17 - connect with wrong server root cert sslmode=verify-ca: matches
[06:20:03.154](0.015s) ok 18 - connect with wrong server root cert sslmode=verify-full
[06:20:03.154](0.000s) ok 19 - connect with wrong server root cert sslmode=verify-full: matches
[06:20:03.168](0.013s) ok 20 - connect with server CA cert, without root CA
[06:20:03.168](0.000s) ok 21 - connect with server CA cert, without root CA: matches
[06:20:03.183](0.014s) ok 22 - connect with correct server CA cert file sslmode=require
[06:20:03.183](0.000s) ok 23 - connect with correct server CA cert file sslmode=require: no stderr
[06:20:03.197](0.014s) ok 24 - connect with correct server CA cert file sslmode=verify-ca
[06:20:03.197](0.000s) ok 25 - connect with correct server CA cert file sslmode=verify-ca: no stderr
[06:20:03.212](0.015s) ok 26 - connect with correct server CA cert file sslmode=verify-full
[06:20:03.212](0.000s) ok 27 - connect with correct server CA cert file sslmode=verify-full: no stderr
[06:20:03.226](0.014s) ok 28 - cert root file that contains two certificates, order 1
[06:20:03.226](0.000s) ok 29 - cert root file that contains two certificates, order 1: no stderr
[06:20:03.242](0.016s) ok 30 - cert root file that contains two certificates, order 2
[06:20:03.243](0.000s) ok 31 - cert root file that contains two certificates, order 2: no stderr
[06:20:03.257](0.015s) ok 32 - connect with sslcertmode=disable
[06:20:03.258](0.000s) ok 33 - connect with sslcertmode=disable: no stderr
[06:20:03.273](0.015s) ok 34 - connect with sslcertmode=allow
[06:20:03.273](0.000s) ok 35 - connect with sslcertmode=allow: no stderr
[06:20:03.288](0.015s) ok 36 - connect with sslcertmode=require fails without a client certificate
[06:20:03.289](0.001s) ok 37 - connect with sslcertmode=require fails without a client certificate: matches
[06:20:03.305](0.016s) ok 38 - sslcrl option with invalid file name
[06:20:03.305](0.000s) ok 39 - sslcrl option with invalid file name: no stderr
[06:20:03.319](0.014s) ok 40 - CRL belonging to a different CA
[06:20:03.319](0.000s) ok 41 - CRL belonging to a different CA: matches
[06:20:03.332](0.013s) ok 42 - directory CRL belonging to a different CA
[06:20:03.333](0.000s) ok 43 - directory CRL belonging to a different CA: matches
[06:20:03.348](0.015s) ok 44 - CRL with a non-revoked cert
[06:20:03.348](0.000s) ok 45 - CRL with a non-revoked cert: no stderr
[06:20:03.363](0.016s) ok 46 - directory CRL with a non-revoked cert
[06:20:03.364](0.000s) ok 47 - directory CRL with a non-revoked cert: no stderr
[06:20:03.379](0.016s) ok 48 - mismatch between host name and server certificate sslmode=require
[06:20:03.380](0.000s) ok 49 - mismatch between host name and server certificate sslmode=require: no stderr
[06:20:03.396](0.016s) ok 50 - mismatch between host name and server certificate sslmode=verify-ca
[06:20:03.396](0.000s) ok 51 - mismatch between host name and server certificate sslmode=verify-ca: no stderr
[06:20:03.410](0.014s) ok 52 - mismatch between host name and server certificate sslmode=verify-full
[06:20:03.410](0.000s) ok 53 - mismatch between host name and server certificate sslmode=verify-full: matches
### Restarting node "primary"
# Running: pg_ctl -w -D /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/data/t_001_ssltests_primary_data/pgdata -l /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/log/001_ssltests_primary.log restart
waiting for server to shut down.... done
server stopped
waiting for server to start.... done
server started
# Postmaster PID for node "primary" is 39537
[06:20:03.635](0.225s) ok 54 - IP address in the Common Name
[06:20:03.636](0.000s) ok 55 - IP address in the Common Name: no stderr
[06:20:03.648](0.012s) ok 56 - mismatch between host name and server certificate IP address
[06:20:03.648](0.000s) ok 57 - mismatch between host name and server certificate IP address: matches
### Restarting node "primary"
# Running: pg_ctl -w -D /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/data/t_001_ssltests_primary_data/pgdata -l /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/log/001_ssltests_primary.log restart
waiting for server to shut down.... done
server stopped
waiting for server to start.... done
server started
# Postmaster PID for node "primary" is 39568
[06:20:03.876](0.228s) ok 58 - IP address in a dNSName
[06:20:03.876](0.000s) ok 59 - IP address in a dNSName: no stderr
### Restarting node "primary"
# Running: pg_ctl -w -D /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/data/t_001_ssltests_primary_data/pgdata -l /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/log/001_ssltests_primary.log restart
waiting for server to shut down.... done
server stopped
waiting for server to start.... done
server started
# Postmaster PID for node "primary" is 39592
[06:20:04.102](0.226s) ok 60 - host name matching with X.509 Subject Alternative Names 1
[06:20:04.102](0.000s) ok 61 - host name matching with X.509 Subject Alternative Names 1: no stderr
[06:20:04.117](0.015s) ok 62 - host name matching with X.509 Subject Alternative Names 2
[06:20:04.117](0.000s) ok 63 - host name matching with X.509 Subject Alternative Names 2: no stderr
[06:20:04.132](0.015s) ok 64 - host name matching with X.509 Subject Alternative Names wildcard
[06:20:04.132](0.000s) ok 65 - host name matching with X.509 Subject Alternative Names wildcard: no stderr
[06:20:04.146](0.013s) ok 66 - host name not matching with X.509 Subject Alternative Names
[06:20:04.146](0.000s) ok 67 - host name not matching with X.509 Subject Alternative Names: matches
[06:20:04.159](0.013s) ok 68 - host name not matching with X.509 Subject Alternative Names wildcard
[06:20:04.159](0.000s) ok 69 - host name not matching with X.509 Subject Alternative Names wildcard: matches
### Restarting node "primary"
# Running: pg_ctl -w -D /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/data/t_001_ssltests_primary_data/pgdata -l /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/log/001_ssltests_primary.log restart
waiting for server to shut down.... done
server stopped
waiting for server to start.... done
server started
# Postmaster PID for node "primary" is 39632
[06:20:04.389](0.230s) ok 70 - host name matching with a single X.509 Subject Alternative Name
[06:20:04.389](0.000s) ok 71 - host name matching with a single X.509 Subject Alternative Name: no stderr
[06:20:04.406](0.017s) ok 72 - host name not matching with a single X.509 Subject Alternative Name
[06:20:04.407](0.000s) ok 73 - host name not matching with a single X.509 Subject Alternative Name: matches
[06:20:04.421](0.015s) ok 74 - host name not matching with a single X.509 Subject Alternative Name wildcard
[06:20:04.422](0.000s) ok 75 - host name not matching with a single X.509 Subject Alternative Name wildcard: matches
### Restarting node "primary"
# Running: pg_ctl -w -D /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/data/t_001_ssltests_primary_data/pgdata -l /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/log/001_ssltests_primary.log restart
waiting for server to shut down.... done
server stopped
waiting for server to start.... done
server started
# Postmaster PID for node "primary" is 39659
[06:20:04.664](0.242s) ok 76 - host matching an IPv4 address (Subject Alternative Name 1)
[06:20:04.664](0.000s) ok 77 - host matching an IPv4 address (Subject Alternative Name 1): no stderr
[06:20:04.680](0.016s) ok 78 - host matching an IPv4 address in alternate form (Subject Alternative Name 1)
[06:20:04.681](0.000s) ok 79 - host matching an IPv4 address in alternate form (Subject Alternative Name 1): no stderr
[06:20:04.694](0.013s) ok 80 - host not matching an IPv4 address (Subject Alternative Name 1)
[06:20:04.694](0.000s) ok 81 - host not matching an IPv4 address (Subject Alternative Name 1): matches
[06:20:04.708](0.014s) ok 82 - host matching an IPv6 address (Subject Alternative Name 2)
[06:20:04.709](0.000s) ok 83 - host matching an IPv6 address (Subject Alternative Name 2): no stderr
[06:20:04.723](0.014s) ok 84 - host matching an IPv6 address in alternate form (Subject Alternative Name 2)
[06:20:04.723](0.000s) ok 85 - host matching an IPv6 address in alternate form (Subject Alternative Name 2): no stderr
[06:20:04.739](0.016s) ok 86 - host matching an IPv6 address in mixed form (Subject Alternative Name 2)
[06:20:04.739](0.000s) ok 87 - host matching an IPv6 address in mixed form (Subject Alternative Name 2): no stderr
[06:20:04.752](0.013s) ok 88 - host not matching an IPv6 address (Subject Alternative Name 2)
[06:20:04.752](0.000s) ok 89 - host not matching an IPv6 address (Subject Alternative Name 2): matches
[06:20:04.765](0.013s) ok 90 - IPv6 host with CIDR mask does not match
[06:20:04.766](0.000s) ok 91 - IPv6 host with CIDR mask does not match: matches
### Restarting node "primary"
# Running: pg_ctl -w -D /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/data/t_001_ssltests_primary_data/pgdata -l /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/log/001_ssltests_primary.log restart
waiting for server to shut down.... done
server stopped
waiting for server to start.... done
server started
# Postmaster PID for node "primary" is 39700
[06:20:04.999](0.233s) ok 92 - certificate with both a CN and SANs 1
[06:20:04.999](0.000s) ok 93 - certificate with both a CN and SANs 1: no stderr
[06:20:05.011](0.012s) ok 94 - certificate with both a CN and SANs 2
[06:20:05.011](0.000s) ok 95 - certificate with both a CN and SANs 2: no stderr
[06:20:05.021](0.010s) ok 96 - certificate with both a CN and SANs ignores CN
[06:20:05.021](0.000s) ok 97 - certificate with both a CN and SANs ignores CN: matches
### Restarting node "primary"
# Running: pg_ctl -w -D /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/data/t_001_ssltests_primary_data/pgdata -l /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/log/001_ssltests_primary.log restart
waiting for server to shut down.... done
server stopped
waiting for server to start.... done
server started
# Postmaster PID for node "primary" is 39725
[06:20:05.262](0.240s) ok 98 - certificate with both a CN and IP SANs matches CN
[06:20:05.262](0.000s) ok 99 - certificate with both a CN and IP SANs matches CN: no stderr
[06:20:05.278](0.016s) ok 100 - certificate with both a CN and IP SANs matches SAN 1
[06:20:05.278](0.000s) ok 101 - certificate with both a CN and IP SANs matches SAN 1: no stderr
[06:20:05.293](0.015s) ok 102 - certificate with both a CN and IP SANs matches SAN 2
[06:20:05.294](0.000s) ok 103 - certificate with both a CN and IP SANs matches SAN 2: no stderr
### Restarting node "primary"
# Running: pg_ctl -w -D /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/data/t_001_ssltests_primary_data/pgdata -l /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/log/001_ssltests_primary.log restart
waiting for server to shut down.... done
server stopped
waiting for server to start.... done
server started
# Postmaster PID for node "primary" is 39749
[06:20:05.530](0.237s) ok 104 - certificate with both an IP CN and IP SANs 1
[06:20:05.531](0.000s) ok 105 - certificate with both an IP CN and IP SANs 1: no stderr
[06:20:05.545](0.014s) ok 106 - certificate with both an IP CN and IP SANs 2
[06:20:05.545](0.000s) ok 107 - certificate with both an IP CN and IP SANs 2: no stderr
[06:20:05.557](0.012s) ok 108 - certificate with both an IP CN and IP SANs ignores CN
[06:20:05.557](0.000s) ok 109 - certificate with both an IP CN and IP SANs ignores CN: matches
### Restarting node "primary"
# Running: pg_ctl -w -D /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/data/t_001_ssltests_primary_data/pgdata -l /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/log/001_ssltests_primary.log restart
waiting for server to shut down.... done
server stopped
waiting for server to start.... done
server started
# Postmaster PID for node "primary" is 39776
[06:20:05.788](0.231s) ok 110 - certificate with both an IP CN and DNS SANs matches CN
[06:20:05.789](0.000s) ok 111 - certificate with both an IP CN and DNS SANs matches CN: no stderr
[06:20:05.803](0.014s) ok 112 - certificate with both an IP CN and DNS SANs matches SAN 1
[06:20:05.803](0.000s) ok 113 - certificate with both an IP CN and DNS SANs matches SAN 1: no stderr
[06:20:05.816](0.014s) ok 114 - certificate with both an IP CN and DNS SANs matches SAN 2
[06:20:05.817](0.000s) ok 115 - certificate with both an IP CN and DNS SANs matches SAN 2: no stderr
### Restarting node "primary"
# Running: pg_ctl -w -D /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/data/t_001_ssltests_primary_data/pgdata -l /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/log/001_ssltests_primary.log restart
waiting for server to shut down.... done
server stopped
waiting for server to start.... done
server started
# Postmaster PID for node "primary" is 39800
[06:20:06.049](0.232s) ok 116 - server certificate without CN or SANs sslmode=verify-ca
[06:20:06.049](0.000s) ok 117 - server certificate without CN or SANs sslmode=verify-ca: no stderr
[06:20:06.064](0.014s) ok 118 - server certificate without CN or SANs sslmode=verify-full
[06:20:06.064](0.000s) ok 119 - server certificate without CN or SANs sslmode=verify-full: matches
### Restarting node "primary"
# Running: pg_ctl -w -D /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/data/t_001_ssltests_primary_data/pgdata -l /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/log/001_ssltests_primary.log restart
waiting for server to shut down.... done
server stopped
waiting for server to start.... done
server started
# Postmaster PID for node "primary" is 39812
[06:20:06.294](0.230s) ok 120 - sslrootcert=system does not connect with private CA
[06:20:06.294](0.000s) ok 121 - sslrootcert=system does not connect with private CA: matches
[06:20:06.300](0.006s) ok 122 - sslrootcert=system only accepts sslmode=verify-full
[06:20:06.300](0.000s) ok 123 - sslrootcert=system only accepts sslmode=verify-full: matches
[06:20:06.317](0.016s) ok 124 - sslrootcert=system connects with overridden SSL_CERT_FILE
[06:20:06.317](0.000s) ok 125 - sslrootcert=system connects with overridden SSL_CERT_FILE: no stderr
[06:20:06.328](0.011s) ok 126 - sslrootcert=system defaults to sslmode=verify-full
[06:20:06.328](0.000s) ok 127 - sslrootcert=system defaults to sslmode=verify-full: matches
### Restarting node "primary"
# Running: pg_ctl -w -D /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/data/t_001_ssltests_primary_data/pgdata -l /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/log/001_ssltests_primary.log restart
waiting for server to shut down.... done
server stopped
waiting for server to start.... done
server started
# Postmaster PID for node "primary" is 39827
[06:20:06.562](0.234s) ok 128 - connects without client-side CRL
[06:20:06.563](0.000s) ok 129 - connects without client-side CRL: no stderr
[06:20:06.574](0.012s) ok 130 - does not connect with client-side CRL file
[06:20:06.575](0.000s) ok 131 - does not connect with client-side CRL file: matches
[06:20:06.586](0.011s) ok 132 - does not connect with client-side CRL directory
[06:20:06.586](0.000s) ok 133 - does not connect with client-side CRL directory: matches
# Running: psql -X -A -F , -P null=_null_ -d sslkey=invalid sslcert=invalid sslrootcert=invalid sslcrl=invalid sslcrldir=invalid user=ssltestuser dbname=trustdb hostaddr=127.0.0.1 host=common-name.pg-ssltest.test sslrootcert=invalid -c SELECT * FROM pg_stat_ssl WHERE pid = pg_backend_pid()
[06:20:06.599](0.013s) ok 134 - pg_stat_ssl view without client certificate: exit code 0
[06:20:06.599](0.000s) ok 135 - pg_stat_ssl view without client certificate: no stderr
[06:20:06.599](0.000s) ok 136 - pg_stat_ssl view without client certificate: matches
[06:20:06.613](0.014s) ok 137 - connection success with correct range of TLS protocol versions
[06:20:06.614](0.000s) ok 138 - connection success with correct range of TLS protocol versions: no stderr
[06:20:06.619](0.005s) ok 139 - connection failure with incorrect range of TLS protocol versions
[06:20:06.619](0.000s) ok 140 - connection failure with incorrect range of TLS protocol versions: matches
[06:20:06.624](0.005s) ok 141 - connection failure with an incorrect SSL protocol minimum bound
[06:20:06.624](0.000s) ok 142 - connection failure with an incorrect SSL protocol minimum bound: matches
[06:20:06.630](0.006s) ok 143 - connection failure with an incorrect SSL protocol maximum bound
[06:20:06.630](0.000s) ok 144 - connection failure with an incorrect SSL protocol maximum bound: matches
[06:20:06.631](0.000s) # running server tests
[06:20:06.642](0.011s) ok 145 - certificate authorization fails without client cert
[06:20:06.642](0.000s) ok 146 - certificate authorization fails without client cert: matches
[06:20:06.660](0.018s) ok 147 - certificate authorization succeeds with correct client cert in PEM format
[06:20:06.660](0.000s) ok 148 - certificate authorization succeeds with correct client cert in PEM format: no stderr
[06:20:06.673](0.013s) ok 149 - certificate authorization succeeds with correct client cert in DER format
[06:20:06.673](0.000s) ok 150 - certificate authorization succeeds with correct client cert in DER format: no stderr
[06:20:06.687](0.014s) ok 151 - certificate authorization succeeds with correct client cert in encrypted PEM format
[06:20:06.687](0.000s) ok 152 - certificate authorization succeeds with correct client cert in encrypted PEM format: no stderr
[06:20:06.703](0.015s) ok 153 - certificate authorization succeeds with correct client cert in encrypted DER format
[06:20:06.703](0.000s) ok 154 - certificate authorization succeeds with correct client cert in encrypted DER format: no stderr
[06:20:06.717](0.014s) ok 155 - certificate authorization succeeds with correct client cert and sslcertmode=require
[06:20:06.717](0.000s) ok 156 - certificate authorization succeeds with correct client cert and sslcertmode=require: no stderr
[06:20:06.729](0.013s) ok 157 - certificate authorization succeeds with correct client cert and sslcertmode=allow
[06:20:06.730](0.000s) ok 158 - certificate authorization succeeds with correct client cert and sslcertmode=allow: no stderr
[06:20:06.740](0.010s) ok 159 - certificate authorization fails with correct client cert and sslcertmode=disable
[06:20:06.740](0.000s) ok 160 - certificate authorization fails with correct client cert and sslcertmode=disable: matches
[06:20:06.747](0.008s) ok 161 - certificate authorization fails with correct client cert and wrong password in encrypted PEM format
[06:20:06.748](0.000s) ok 162 - certificate authorization fails with correct client cert and wrong password in encrypted PEM format: matches
[06:20:06.764](0.016s) ok 163 - certificate authorization succeeds with DN mapping
[06:20:06.764](0.000s) ok 164 - certificate authorization succeeds with DN mapping: no stderr
[06:20:06.764](0.000s) ok 165 - certificate authorization succeeds with DN mapping: log matches
[06:20:06.781](0.017s) ok 166 - certificate authorization succeeds with DN regex mapping
[06:20:06.781](0.000s) ok 167 - certificate authorization succeeds with DN regex mapping: no stderr
[06:20:06.798](0.017s) ok 168 - certificate authorization succeeds with CN mapping
[06:20:06.799](0.000s) ok 169 - certificate authorization succeeds with CN mapping: no stderr
[06:20:06.799](0.000s) ok 170 - certificate authorization succeeds with CN mapping: log matches
[06:20:06.799](0.000s) not ok 171 # TODO & SKIP Need Pty support
[06:20:06.799](0.000s) not ok 172 # TODO & SKIP Need Pty support
[06:20:06.799](0.000s) not ok 173 # TODO & SKIP Need Pty support
[06:20:06.800](0.000s) not ok 174 # TODO & SKIP Need Pty support
# Running: psql -X -A -F , -P null=_null_ -d sslkey=invalid sslcert=invalid sslrootcert=invalid sslcrl=invalid sslcrldir=invalid sslrootcert=ssl/root+server_ca.crt sslmode=require dbname=certdb hostaddr=127.0.0.1 host=localhost user=ssltestuser sslcert=ssl/client.crt  sslkey=/tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/data/tmp_test_GsL1/client.key -c SELECT * FROM pg_stat_ssl WHERE pid = pg_backend_pid()
[06:20:06.833](0.034s) ok 175 - pg_stat_ssl with client certificate: exit code 0
[06:20:06.834](0.000s) ok 176 - pg_stat_ssl with client certificate: no stderr
[06:20:06.834](0.000s) ok 177 - pg_stat_ssl with client certificate: matches
[06:20:06.844](0.010s) ok 178 - certificate authorization fails because of file permissions
[06:20:06.845](0.000s) ok 179 - certificate authorization fails because of file permissions: matches
[06:20:06.859](0.015s) ok 180 - certificate authorization fails with client cert belonging to another user
[06:20:06.860](0.000s) ok 181 - certificate authorization fails with client cert belonging to another user: matches
[06:20:06.873](0.014s) ok 182 - certificate authorization fails with revoked client cert
[06:20:06.873](0.000s) ok 183 - certificate authorization fails with revoked client cert: matches
[06:20:06.874](0.000s) ok 184 - certificate authorization fails with revoked client cert: log does not match
[06:20:06.894](0.020s) ok 185 - auth_option clientcert=verify-full succeeds with matching username and Common Name
[06:20:06.894](0.000s) ok 186 - auth_option clientcert=verify-full succeeds with matching username and Common Name: no stderr
[06:20:06.894](0.000s) ok 187 - auth_option clientcert=verify-full succeeds with matching username and Common Name: log matches
[06:20:06.909](0.014s) ok 188 - auth_option clientcert=verify-full fails with mismatching username and Common Name
[06:20:06.909](0.000s) ok 189 - auth_option clientcert=verify-full fails with mismatching username and Common Name: matches
[06:20:06.909](0.000s) ok 190 - auth_option clientcert=verify-full fails with mismatching username and Common Name: log does not match
[06:20:06.924](0.015s) ok 191 - auth_option clientcert=verify-ca succeeds with mismatching username and Common Name
[06:20:06.924](0.000s) ok 192 - auth_option clientcert=verify-ca succeeds with mismatching username and Common Name: no stderr
[06:20:06.924](0.000s) ok 193 - auth_option clientcert=verify-ca succeeds with mismatching username and Common Name: log matches
### Restarting node "primary"
# Running: pg_ctl -w -D /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/data/t_001_ssltests_primary_data/pgdata -l /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/log/001_ssltests_primary.log restart
waiting for server to shut down.... done
server stopped
waiting for server to start.... done
server started
# Postmaster PID for node "primary" is 39887
[06:20:07.160](0.235s) ok 194 - intermediate client certificate is provided by client
[06:20:07.160](0.000s) ok 195 - intermediate client certificate is provided by client: no stderr
[06:20:07.172](0.012s) ok 196 - intermediate client certificate is missing
[06:20:07.172](0.000s) ok 197 - intermediate client certificate is missing: matches
[06:20:07.184](0.012s) ok 198 - logged client certificate Subjects are truncated if they're too long
[06:20:07.184](0.000s) ok 199 - logged client certificate Subjects are truncated if they're too long: matches
### Restarting node "primary"
# Running: pg_ctl -w -D /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/data/t_001_ssltests_primary_data/pgdata -l /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/log/001_ssltests_primary.log restart
waiting for server to shut down.... done
server stopped
waiting for server to start.... done
server started
# Postmaster PID for node "primary" is 39901
[06:20:07.415](0.231s) ok 200 - intermediate client certificate is untrusted
[06:20:07.415](0.000s) ok 201 - intermediate client certificate is untrusted: matches
### Restarting node "primary"
# Running: pg_ctl -w -D /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/data/t_001_ssltests_primary_data/pgdata -l /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/log/001_ssltests_primary.log restart
waiting for server to shut down.... done
server stopped
waiting for server to start.... done
server started
# Postmaster PID for node "primary" is 39911
[06:20:07.642](0.227s) ok 202 - certificate authorization fails with revoked client cert with server-side CRL directory
[06:20:07.643](0.000s) ok 203 - certificate authorization fails with revoked client cert with server-side CRL directory: matches
[06:20:07.654](0.011s) ok 204 - certificate authorization fails with revoked UTF-8 client cert with server-side CRL directory
[06:20:07.654](0.000s) ok 205 - certificate authorization fails with revoked UTF-8 client cert with server-side CRL directory: matches
### Restarting node "primary"
# Running: pg_ctl -w -D /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/data/t_001_ssltests_primary_data/pgdata -l /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/log/001_ssltests_primary.log restart
waiting for server to shut down.... done
server stopped
waiting for server to start.... done
server started
# Postmaster PID for node "primary" is 39923
[06:20:07.877](0.223s) not ok 206 - connect with valid stapled ocsp response when sslocspstapling=1
[06:20:07.877](0.000s) #   Failed test 'connect with valid stapled ocsp response when sslocspstapling=1'
#   at /tmp/cirrus-ci-build/src/test/ssl/t/001_ssltests.pl line 923.
[06:20:07.877](0.000s) #          got: '2'
#     expected: '0'
[06:20:07.878](0.000s) not ok 207 - connect with valid stapled ocsp response when sslocspstapling=1: no stderr
[06:20:07.878](0.000s) #   Failed test 'connect with valid stapled ocsp response when sslocspstapling=1: no stderr'
#   at /tmp/cirrus-ci-build/src/test/ssl/t/001_ssltests.pl line 923.
[06:20:07.878](0.000s) #          got: 'psql: error: connection to server at "127.0.0.1", port 54924 failed: SSL SYSCALL error: EOF detected'
#     expected: ''
[06:20:07.894](0.016s) ok 208 - connect without requesting ocsp response when sslocspstapling=0
[06:20:07.894](0.000s) ok 209 - connect without requesting ocsp response when sslocspstapling=0: no stderr
### Restarting node "primary"
# Running: pg_ctl -w -D /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/data/t_001_ssltests_primary_data/pgdata -l /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/log/001_ssltests_primary.log restart
waiting for server to shut down.... done
server stopped
waiting for server to start.... done
server started
# Postmaster PID for node "primary" is 39935
[06:20:08.121](0.226s) ok 210 - failed with a revoked ocsp response when sslocspstapling=1
[06:20:08.137](0.016s) ok 211 - connect without requesting ocsp response when sslocspstapling=0
[06:20:08.137](0.000s) ok 212 - connect without requesting ocsp response when sslocspstapling=0: no stderr
### Restarting node "primary"
# Running: pg_ctl -w -D /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/data/t_001_ssltests_primary_data/pgdata -l /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/log/001_ssltests_primary.log restart
waiting for server to shut down.... done
server stopped
waiting for server to start.... done
server started
# Postmaster PID for node "primary" is 39947
[06:20:08.364](0.227s) ok 213 - failed with a revoked ocsp response when sslocspstapling=1
[06:20:08.381](0.018s) ok 214 - connect without requesting ocsp response when sslocspstapling=0
[06:20:08.382](0.000s) ok 215 - connect without requesting ocsp response when sslocspstapling=0: no stderr
### Restarting node "primary"
# Running: pg_ctl -w -D /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/data/t_001_ssltests_primary_data/pgdata -l /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/log/001_ssltests_primary.log restart
waiting for server to shut down.... done
server stopped
waiting for server to start.... done
server started
# Postmaster PID for node "primary" is 39959
[06:20:08.608](0.226s) ok 216 - failed with an expired ocsp response when sslocspstapling=1
[06:20:08.624](0.016s) ok 217 - connect without requesting ocsp response when sslocspstapling=0
[06:20:08.624](0.000s) ok 218 - connect without requesting ocsp response when sslocspstapling=0: no stderr
### Restarting node "primary"
# Running: pg_ctl -w -D /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/data/t_001_ssltests_primary_data/pgdata -l /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/log/001_ssltests_primary.log restart
waiting for server to shut down.... done
server stopped
waiting for server to start.... done
server started
# Postmaster PID for node "primary" is 39971
[06:20:08.851](0.227s) not ok 219 - connect with valid stapled ocsp response when sslocspstapling=1
[06:20:08.851](0.000s) #   Failed test 'connect with valid stapled ocsp response when sslocspstapling=1'
#   at /tmp/cirrus-ci-build/src/test/ssl/t/001_ssltests.pl line 1001.
[06:20:08.851](0.000s) #          got: '2'
#     expected: '0'
[06:20:08.852](0.000s) not ok 220 - connect with valid stapled ocsp response when sslocspstapling=1: no stderr
[06:20:08.852](0.000s) #   Failed test 'connect with valid stapled ocsp response when sslocspstapling=1: no stderr'
#   at /tmp/cirrus-ci-build/src/test/ssl/t/001_ssltests.pl line 1001.
[06:20:08.852](0.000s) #          got: 'psql: error: connection to server at "127.0.0.1", port 54924 failed: SSL SYSCALL error: EOF detected'
#     expected: ''
[06:20:08.869](0.017s) ok 221 - connect without requesting ocsp response when sslocspstapling=0
[06:20:08.869](0.000s) ok 222 - connect without requesting ocsp response when sslocspstapling=0: no stderr
### Restarting node "primary"
# Running: pg_ctl -w -D /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/data/t_001_ssltests_primary_data/pgdata -l /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/log/001_ssltests_primary.log restart
waiting for server to shut down.... done
server stopped
waiting for server to start.... done
server started
# Postmaster PID for node "primary" is 39983
[06:20:09.096](0.226s) ok 223 - failed with a revoked ocsp response when sslocspstapling=1
[06:20:09.112](0.016s) ok 224 - connect without requesting ocsp response when sslocspstapling=0
[06:20:09.112](0.000s) ok 225 - connect without requesting ocsp response when sslocspstapling=0: no stderr
### Restarting node "primary"
# Running: pg_ctl -w -D /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/data/t_001_ssltests_primary_data/pgdata -l /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/log/001_ssltests_primary.log restart
waiting for server to shut down.... done
server stopped
waiting for server to start.... done
server started
# Postmaster PID for node "primary" is 39995
[06:20:09.338](0.226s) ok 226 - failed with a revoked ocsp response when sslocspstapling=1
[06:20:09.353](0.016s) ok 227 - connect without requesting ocsp response when sslocspstapling=0
[06:20:09.354](0.000s) ok 228 - connect without requesting ocsp response when sslocspstapling=0: no stderr
### Restarting node "primary"
# Running: pg_ctl -w -D /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/data/t_001_ssltests_primary_data/pgdata -l /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/log/001_ssltests_primary.log restart
waiting for server to shut down.... done
server stopped
waiting for server to start.... done
server started
# Postmaster PID for node "primary" is 40007
[06:20:09.580](0.226s) ok 229 - failed with an expired ocsp response when sslocspstapling=1
[06:20:09.597](0.017s) ok 230 - connect without requesting ocsp response when sslocspstapling=0
[06:20:09.598](0.000s) ok 231 - connect without requesting ocsp response when sslocspstapling=0: no stderr
### Restarting node "primary"
# Running: pg_ctl -w -D /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/data/t_001_ssltests_primary_data/pgdata -l /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/log/001_ssltests_primary.log restart
waiting for server to shut down.... done
server stopped
waiting for server to start.... done
server started
# Postmaster PID for node "primary" is 40019
[06:20:09.824](0.227s) ok 232 - failed with an expired ocsp response when sslocspstapling=1
[06:20:09.843](0.018s) ok 233 - connect without requesting ocsp response when sslocspstapling=0
[06:20:09.843](0.000s) ok 234 - connect without requesting ocsp response when sslocspstapling=0: no stderr
### Restarting node "primary"
# Running: pg_ctl -w -D /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/data/t_001_ssltests_primary_data/pgdata -l /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/log/001_ssltests_primary.log restart
waiting for server to shut down.... done
server stopped
waiting for server to start.... stopped waiting
pg_ctl: could not start server
Examine the log output.
# pg_ctl restart failed; see logfile for details: /tmp/cirrus-ci-build/build/testrun/ssl/001_ssltests/log/001_ssltests_primary.log
# No postmaster PID for node "primary"
[06:20:10.059](0.217s) Bail out!  pg_ctl restart failed
# No postmaster PID for node "primary"