# Checking port 62697
# Found port 62697
Name: mynode
Data directory: /tmp/cirrus-ci-build/build/testrun/worker_spi/001_worker_spi/data/t_001_worker_spi_mynode_data/pgdata
Backup directory: /tmp/cirrus-ci-build/build/testrun/worker_spi/001_worker_spi/data/t_001_worker_spi_mynode_data/backup
Archive directory: /tmp/cirrus-ci-build/build/testrun/worker_spi/001_worker_spi/data/t_001_worker_spi_mynode_data/archives
Connection string: port=62697 host=/tmp/xuyfrVE3XQ
Log file: /tmp/cirrus-ci-build/build/testrun/worker_spi/001_worker_spi/log/001_worker_spi_mynode.log
[14:17:28.066](0.016s) # 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/worker_spi/001_worker_spi/data/t_001_worker_spi_mynode_data/pgdata
# Running: /tmp/cirrus-ci-build/build/src/test/regress/pg_regress --config-auth /tmp/cirrus-ci-build/build/testrun/worker_spi/001_worker_spi/data/t_001_worker_spi_mynode_data/pgdata
### Starting node "mynode"
# Running: pg_ctl -w -D /tmp/cirrus-ci-build/build/testrun/worker_spi/001_worker_spi/data/t_001_worker_spi_mynode_data/pgdata -l /tmp/cirrus-ci-build/build/testrun/worker_spi/001_worker_spi/log/001_worker_spi_mynode.log -o --cluster-name=mynode start
waiting for server to start.... done
server started
# Postmaster PID for node "mynode" is 29088
[14:17:28.218](0.152s) # testing dynamic bgworkers
[14:17:28.249](0.031s) ok 1 - dynamic bgworker launched
[14:21:00.459](212.209s) # poll_query_until timed out executing this query:
# SELECT count(*) > 0 FROM information_schema.tables
# 	    WHERE table_schema = 'schema4' AND table_name = 'counted';
# expecting this output:
# t
# last actual query output:
# t
# with stderr:
# WARNING:  outfuncs/readfuncs failed to produce an equal rewritten parse tree
#### Begin standard error
psql:<stdin>:1: WARNING:  outfuncs/readfuncs failed to produce an equal rewritten parse tree
#### End standard error
### Reloading node "mynode"
# Running: pg_ctl -D /tmp/cirrus-ci-build/build/testrun/worker_spi/001_worker_spi/data/t_001_worker_spi_mynode_data/pgdata reload
server signaled
[14:24:30.669](210.211s) # poll_query_until timed out executing this query:
# SELECT count(*) FROM schema4.counted WHERE type = 'delta';
# expecting this output:
# 0
# last actual query output:
# 1
# with stderr:
[14:24:30.681](0.012s) not ok 2 - dynamic bgworker correctly consumed tuple data
[14:24:30.681](0.000s) #   Failed test 'dynamic bgworker correctly consumed tuple data'
#   at /tmp/cirrus-ci-build/src/test/modules/worker_spi/t/001_worker_spi.pl line 42.
[14:24:30.681](0.000s) #          got: 'total|0
# delta|1'
#     expected: 'total|1'
[14:28:04.890](214.209s) # poll_query_until timed out executing this query:
# SELECT wait_event FROM pg_stat_activity WHERE backend_type ~ 'worker_spi';
# expecting this output:
# WorkerSpiMain
# last actual query output:
# 
# with stderr:
# WARNING:  outfuncs/readfuncs failed to produce an equal rewritten parse tree
[14:28:04.891](0.001s) not ok 3 - dynamic bgworker has reported "WorkerSpiMain" as wait event
[14:28:04.891](0.000s) #   Failed test 'dynamic bgworker has reported "WorkerSpiMain" as wait event'
#   at /tmp/cirrus-ci-build/src/test/modules/worker_spi/t/001_worker_spi.pl line 49.
[14:28:04.891](0.000s) #          got: '0'
#     expected: '1'
#### Begin standard error
psql:<stdin>:1: WARNING:  outfuncs/readfuncs failed to produce an equal rewritten parse tree
#### End standard error
[14:28:04.903](0.012s) ok 4 - "WorkerSpiMain" is reported in pg_wait_events
[14:28:04.904](0.000s) # testing bgworkers loaded with shared_preload_libraries
#### Begin standard error
psql:<stdin>:1: WARNING:  databases created by regression test cases should have names including "regression"
#### End standard error
#### Begin standard error
psql:<stdin>:1: WARNING:  roles created by regression test cases should have names starting with "regress_"
#### End standard error
### Restarting node "mynode"
# Running: pg_ctl -w -D /tmp/cirrus-ci-build/build/testrun/worker_spi/001_worker_spi/data/t_001_worker_spi_mynode_data/pgdata -l /tmp/cirrus-ci-build/build/testrun/worker_spi/001_worker_spi/log/001_worker_spi_mynode.log restart
waiting for server to shut down.... done
server stopped
waiting for server to start.... done
server started
# Postmaster PID for node "mynode" is 54718
[14:31:42.620](217.716s) # poll_query_until timed out executing this query:
# SELECT datname, count(datname), wait_event FROM pg_stat_activity
#             WHERE backend_type = 'worker_spi' GROUP BY datname, wait_event;
# expecting this output:
# mydb|3|WorkerSpiMain
# last actual query output:
# 
# with stderr:
# WARNING:  outfuncs/readfuncs failed to produce an equal rewritten parse tree
[14:31:42.620](0.000s) not ok 5 - bgworkers all launched
[14:31:42.620](0.000s) #   Failed test 'bgworkers all launched'
#   at /tmp/cirrus-ci-build/src/test/modules/worker_spi/t/001_worker_spi.pl line 78.
Timed out while waiting for bgworkers to be launched at /tmp/cirrus-ci-build/src/test/modules/worker_spi/t/001_worker_spi.pl line 78.
# Postmaster PID for node "mynode" is 54718
### Stopping node "mynode" using mode immediate
# Running: pg_ctl -D /tmp/cirrus-ci-build/build/testrun/worker_spi/001_worker_spi/data/t_001_worker_spi_mynode_data/pgdata -m immediate stop
waiting for server to shut down.... done
server stopped
# No postmaster PID for node "mynode"
[14:31:42.731](0.111s) # Tests were run but no plan was declared and done_testing() was not seen.
[14:31:42.731](0.000s) # Looks like your test exited with 29 just after 5.