Package: postgresql-8.4
Version: 8.4.1-1
Severity: grave
Justification: renders package unusable
When ssl is turned on in postgresql.conf, performing a restore using pg_restore
fails with a message like:
pg_restore: [archiver (db)] Error while PROCESSING TOC:
pg_restore: [archiver (db)] Error from TOC entry 2581; 0 209332 TABLE DATA
frame_status dgardner
pg_restore: [archiver (db)] COPY failed: server closed the connection
unexpectedly
This probably means the server terminated abnormally
before or while processing the request.
In /var/log/postgresql/postgresql-8.4-main.log there is:
2009-12-09 08:12:53 PST ERROR: canceling autovacuum task
2009-12-09 08:12:53 PST CONTEXT: automatic analyze of table
"hdpsdb.asset.asset_move_map"
2009-12-09 08:12:53 PST LOG: SSL renegotiation failure
2009-12-09 08:12:53 PST LOG: SSL renegotiation failure
2009-12-09 08:12:53 PST LOG: SSL error: internal error
2009-12-09 08:12:53 PST LOG: could not send data to client: Connection reset
by peer
2009-12-09 08:12:53 PST LOG: SSL error: internal error
2009-12-09 08:12:53 PST LOG: could not receive data from client: Connection
reset by peer
2009-12-09 08:12:53 PST LOG: unexpected EOF on client connection
If I set ssl=false and restart the server, then the restore will work as
expected.
This is reproducable, the errors occur on the same three tables, which are also
my largest tables (in terms of data size not rows).
I was also able to repeat this behavior on two Debian systems both running
postgresql-8.4, however the other system is on 2.6.30-2-amd64.
Example log:
--------------
dgard...@cssun31 /pgtest:$ psql -h localhost -c "SELECT * FROM version();" -d
postgres
Password:
version
------------------------------------------------------------------------------------------------------
PostgreSQL 8.4.1 on x86_64-pc-linux-gnu, compiled by GCC gcc-4.3.real (Debian
4.3.4-2) 4.3.4, 64-bit
(1 row)
dgard...@cssun31 /pgtest:$ time pg_dump -Fc -f testing_backup_restore.dump
hdpsdb
real 11m21.854s
user 10m24.958s
sys 0m17.614s
dgard...@cssun31 /pgtest:$ psql -h localhost -c "DROP DATABASE hdpsdb;" -d
postgres
Password:
DROP DATABASE
dgard...@cssun31 /pgtest:$ time pg_restore -F c -j 4 -C -W -d postgres -h
localhost ./testing_backup_restore.dump
Password:
pg_restore: [archiver (db)] Error while PROCESSING TOC:
pg_restore: [archiver (db)] Error from TOC entry 2581; 0 209332 TABLE DATA
frame_status dgardner
pg_restore: [archiver (db)] COPY failed: server closed the connection
unexpectedly
This probably means the server terminated abnormally
before or while processing the request.
pg_restore: [archiver (db)] could not commit database transaction: no
connection to the server
Command was: COMMIT
pg_restore: [archiver (db)] Error while PROCESSING TOC:
pg_restore: [archiver (db)] Error from TOC entry 2580; 0 209326 TABLE DATA
frame dgardner
pg_restore: [archiver (db)] COPY failed: server closed the connection
unexpectedly
This probably means the server terminated abnormally
before or while processing the request.
pg_restore: [archiver (db)] could not commit database transaction: no
connection to the server
Command was: COMMIT
pg_restore: [archiver (db)] Error while PROCESSING TOC:
pg_restore: [archiver (db)] Error from TOC entry 2566; 0 209223 TABLE DATA
thumbnail dgardner
pg_restore: [archiver (db)] COPY failed: server closed the connection
unexpectedly
This probably means the server terminated abnormally
before or while processing the request.
pg_restore: [archiver (db)] could not commit database transaction: no
connection to the server
Command was: COMMIT
WARNING: errors ignored on restore: 3
real 9m29.089s
user 12m1.279s
sys 0m25.997s
dgard...@cssun31 /pgtest:$ su
Password:
cssun31:/pgtest# sed -i 's|ssl = true|ssl = false|g'
/etc/postgresql/8.4/main/postgresql.conf
cssun31:/pgtest# /etc/init.d/postgresql-8.4 restart
Restarting PostgreSQL 8.4 database server: main.
cssun31:/pgtest# exit
exit
dgard...@cssun31 /pgtest:$ psql -h localhost -c "DROP DATABASE hdpsdb;" -d
postgres
Password:
DROP DATABASE
dgard...@cssun31 /pgtest:$ time pg_restore -F c -j 4 -C -W -d postgres -h
localhost ./testing_backup_restore.dump
Password:
real 40m6.959s
user 1m6.223s
sys 0m8.605s
dgard...@cssun31 /pgtest:$ su
Password:
cssun31:/pgtest# sed -i 's|ssl = false|ssl = true|g'
/etc/postgresql/8.4/main/postgresql.conf
cssun31:/pgtest# /etc/init.d/postgresql-8.4 restart
Restarting PostgreSQL 8.4 database server: main.
cssun31:/pgtest# exit
exit
dgard...@cssun31 /pgtest:$ psql -h localhost -c "DROP DATABASE hdpsdb;" -d
postgres
Password:
DROP DATABASE
dgard...@cssun31 /pgtest:$ time pg_restore -F c -j 4 -C -W -d postgres -h
localhost ./testing_backup_restore.dump
Password:
pg_restore: [archiver (db)] Error while PROCESSING TOC:
pg_restore: [archiver (db)] Error from TOC entry 2581; 0 209332 TABLE DATA
frame_status dgardner
pg_restore: [archiver (db)] COPY failed: server closed the connection
unexpectedly
This probably means the server terminated abnormally
before or while processing the request.
pg_restore: [archiver (db)] could not commit database transaction: no
connection to the server
Command was: COMMIT
pg_restore: [archiver (db)] Error while PROCESSING TOC:
pg_restore: [archiver (db)] Error from TOC entry 2580; 0 209326 TABLE DATA
frame dgardner
pg_restore: [archiver (db)] COPY failed: server closed the connection
unexpectedly
This probably means the server terminated abnormally
before or while processing the request.
pg_restore: [archiver (db)] could not commit database transaction: no
connection to the server
Command was: COMMIT
pg_restore: [archiver (db)] Error while PROCESSING TOC:
pg_restore: [archiver (db)] Error from TOC entry 2566; 0 209223 TABLE DATA
thumbnail dgardner
pg_restore: [archiver (db)] COPY failed: server closed the connection
unexpectedly
This probably means the server terminated abnormally
before or while processing the request.
pg_restore: [archiver (db)] could not commit database transaction: no
connection to the server
Command was: COMMIT
WARNING: errors ignored on restore: 3
real 8m56.379s
user 12m0.001s
sys 0m19.130s
dgard...@cssun31 /pgtest:$
-----------------------------
/var/log/postgresql/postgresql-8.4-main.log:
2009-12-08 17:20:39 PST ERROR: canceling autovacuum task
2009-12-08 17:20:39 PST CONTEXT: automatic analyze of table
"hdpsdb.asset.asset_history"
2009-12-08 17:21:09 PST LOG: SSL renegotiation failure
2009-12-08 17:21:09 PST LOG: SSL renegotiation failure
2009-12-08 17:21:09 PST LOG: SSL error: internal error
2009-12-08 17:21:09 PST LOG: could not send data to client: Connection reset
by peer
2009-12-08 17:21:09 PST LOG: SSL error: internal error
2009-12-08 17:21:09 PST LOG: could not receive data from client: Connection
reset by peer
2009-12-08 17:21:09 PST LOG: unexpected EOF on client connection
2009-12-08 17:21:26 PST ERROR: canceling autovacuum task
2009-12-08 17:21:26 PST CONTEXT: automatic analyze of table
"hdpsdb.asset.note_history"
2009-12-08 17:21:48 PST ERROR: canceling autovacuum task
2009-12-08 17:21:48 PST CONTEXT: automatic analyze of table
"hdpsdb.farm.cam_job"
2009-12-08 17:21:49 PST ERROR: canceling autovacuum task
2009-12-08 17:21:49 PST CONTEXT: automatic analyze of table "hdpsdb.farm.chunk"
2009-12-08 17:21:51 PST ERROR: canceling autovacuum task
2009-12-08 17:21:51 PST CONTEXT: automatic analyze of table
"hdpsdb.farm.cmp_job"
2009-12-08 17:22:02 PST ERROR: canceling autovacuum task
2009-12-08 17:22:02 PST CONTEXT: automatic analyze of table
"hdpsdb.farm.pass_job_name_path"
2009-12-08 17:22:18 PST ERROR: canceling autovacuum task
2009-12-08 17:22:18 PST CONTEXT: automatic analyze of table
"hdpsdb.farm.job_submission"
2009-12-08 17:22:30 PST ERROR: canceling autovacuum task
2009-12-08 17:22:30 PST CONTEXT: automatic analyze of table
"hdpsdb.farm.take_job"
2009-12-08 17:23:46 PST LOG: SSL renegotiation failure
2009-12-08 17:23:46 PST LOG: SSL renegotiation failure
2009-12-08 17:23:46 PST LOG: SSL error: internal error
2009-12-08 17:23:46 PST LOG: could not send data to client: Connection reset
by peer
2009-12-08 17:23:46 PST LOG: SSL error: internal error
2009-12-08 17:23:46 PST LOG: could not receive data from client: Connection
reset by peer
2009-12-08 17:23:46 PST LOG: unexpected EOF on client connection
2009-12-08 17:24:35 PST ERROR: canceling autovacuum task
2009-12-08 17:24:35 PST CONTEXT: automatic analyze of table "hdpsdb.farm.chunk"
2009-12-08 17:27:48 PST LOG: SSL renegotiation failure
2009-12-08 17:27:48 PST LOG: SSL renegotiation failure
2009-12-08 17:27:48 PST LOG: SSL error: internal error
2009-12-08 17:27:48 PST LOG: could not send data to client: Connection reset
by peer
2009-12-08 17:27:48 PST LOG: SSL error: internal error
2009-12-08 17:27:48 PST LOG: could not receive data from client: Connection
reset by peer
2009-12-08 17:27:48 PST LOG: unexpected EOF on client connection
2009-12-08 17:28:15 PST LOG: incomplete startup packet
2009-12-08 17:28:15 PST LOG: received fast shutdown request
2009-12-08 17:28:15 PST LOG: aborting any active transactions
2009-12-08 17:28:15 PST LOG: autovacuum launcher shutting down
2009-12-08 17:28:15 PST LOG: shutting down
2009-12-08 17:28:31 PST LOG: database system is shut down
2009-12-08 17:28:32 PST LOG: database system was shut down at 2009-12-08
17:28:31 PST
2009-12-08 17:28:32 PST LOG: autovacuum launcher started
2009-12-08 17:28:32 PST LOG: database system is ready to accept connections
2009-12-08 17:28:32 PST LOG: incomplete startup packet
2009-12-08 17:31:07 PST ERROR: canceling autovacuum task
2009-12-08 17:31:07 PST CONTEXT: automatic analyze of table
"hdpsdb.asset.asset"
2009-12-08 17:32:08 PST ERROR: canceling autovacuum task
2009-12-08 17:32:08 PST CONTEXT: automatic analyze of table
"hdpsdb.farm.cam_job"
2009-12-08 17:32:09 PST ERROR: canceling autovacuum task
2009-12-08 17:32:09 PST CONTEXT: automatic analyze of table "hdpsdb.farm.chunk"
2009-12-08 17:32:19 PST ERROR: canceling autovacuum task
2009-12-08 17:32:19 PST CONTEXT: automatic analyze of table
"hdpsdb.farm.frame_status"
2009-12-08 17:34:52 PST ERROR: canceling autovacuum task
2009-12-08 17:34:52 PST CONTEXT: automatic analyze of table "hdpsdb.farm.chunk"
2009-12-08 17:35:28 PST ERROR: canceling autovacuum task
2009-12-08 17:35:28 PST CONTEXT: automatic analyze of table "hdpsdb.farm.chunk"
2009-12-08 17:39:04 PST ERROR: canceling autovacuum task
2009-12-08 17:39:04 PST CONTEXT: automatic analyze of table
"hdpsdb.farm.frame_status"
2009-12-08 17:46:22 PST ERROR: canceling autovacuum task
2009-12-08 17:46:22 PST CONTEXT: automatic analyze of table
"hdpsdb.farm.frame_status"
2009-12-08 17:46:23 PST ERROR: canceling autovacuum task
2009-12-08 17:46:23 PST CONTEXT: automatic analyze of table "hdpsdb.farm.chunk"
2009-12-08 17:57:03 PST ERROR: canceling autovacuum task
2009-12-08 17:57:03 PST CONTEXT: automatic analyze of table
"hdpsdb.farm.frame_status"
2009-12-08 18:06:14 PST ERROR: canceling autovacuum task
2009-12-08 18:06:14 PST CONTEXT: automatic analyze of table "hdpsdb.farm.frame"
2009-12-08 18:08:19 PST ERROR: canceling autovacuum task
2009-12-08 18:08:19 PST CONTEXT: automatic analyze of table "hdpsdb.farm.frame"
2009-12-09 08:09:19 PST LOG: incomplete startup packet
2009-12-09 08:09:19 PST LOG: received fast shutdown request
2009-12-09 08:09:19 PST LOG: aborting any active transactions
2009-12-09 08:09:19 PST LOG: autovacuum launcher shutting down
2009-12-09 08:09:19 PST LOG: shutting down
2009-12-09 08:09:19 PST LOG: database system is shut down
2009-12-09 08:09:20 PST LOG: database system was shut down at 2009-12-09
08:09:19 PST
2009-12-09 08:09:20 PST LOG: incomplete startup packet
2009-12-09 08:09:20 PST LOG: autovacuum launcher started
2009-12-09 08:09:20 PST LOG: database system is ready to accept connections
2009-12-09 08:09:34 PST LOG: could not receive data from client: Connection
reset by peer
2009-12-09 08:12:53 PST ERROR: canceling autovacuum task
2009-12-09 08:12:53 PST CONTEXT: automatic analyze of table
"hdpsdb.asset.asset_move_map"
2009-12-09 08:12:53 PST LOG: SSL renegotiation failure
2009-12-09 08:12:53 PST LOG: SSL renegotiation failure
2009-12-09 08:12:53 PST LOG: SSL error: internal error
2009-12-09 08:12:53 PST LOG: could not send data to client: Connection reset
by peer
2009-12-09 08:12:53 PST LOG: SSL error: internal error
2009-12-09 08:12:53 PST LOG: could not receive data from client: Connection
reset by peer
2009-12-09 08:12:53 PST LOG: unexpected EOF on client connection
2009-12-09 08:14:31 PST ERROR: canceling autovacuum task
2009-12-09 08:14:31 PST CONTEXT: automatic analyze of table "hdpsdb.farm.chunk"
2009-12-09 08:14:50 PST ERROR: canceling autovacuum task
2009-12-09 08:14:50 PST CONTEXT: automatic analyze of table "hdpsdb.farm.job"
2009-12-09 08:14:55 PST ERROR: canceling autovacuum task
2009-12-09 08:14:55 PST CONTEXT: automatic analyze of table
"hdpsdb.farm.job_property"
2009-12-09 08:15:10 PST ERROR: canceling autovacuum task
2009-12-09 08:15:10 PST CONTEXT: automatic analyze of table
"hdpsdb.farm.job_submission"
2009-12-09 08:15:23 PST ERROR: canceling autovacuum task
2009-12-09 08:15:23 PST CONTEXT: automatic analyze of table
"hdpsdb.farm.pass_job"
2009-12-09 08:15:38 PST ERROR: canceling autovacuum task
2009-12-09 08:15:38 PST CONTEXT: automatic analyze of table
"hdpsdb.farm.take_job"
2009-12-09 08:15:40 PST LOG: SSL renegotiation failure
2009-12-09 08:15:40 PST LOG: SSL renegotiation failure
2009-12-09 08:15:40 PST LOG: SSL error: internal error
2009-12-09 08:15:40 PST LOG: could not send data to client: Connection reset
by peer
2009-12-09 08:15:40 PST LOG: SSL error: internal error
2009-12-09 08:15:40 PST LOG: could not receive data from client: Connection
reset by peer
2009-12-09 08:15:40 PST LOG: unexpected EOF on client connection
2009-12-09 08:17:16 PST ERROR: canceling autovacuum task
2009-12-09 08:17:16 PST CONTEXT: automatic analyze of table "hdpsdb.farm.chunk"
2009-12-09 08:17:55 PST ERROR: canceling autovacuum task
2009-12-09 08:17:55 PST CONTEXT: automatic analyze of table "hdpsdb.farm.chunk"
2009-12-09 08:19:18 PST LOG: SSL renegotiation failure
2009-12-09 08:19:18 PST LOG: SSL renegotiation failure
2009-12-09 08:19:18 PST LOG: SSL error: internal error
2009-12-09 08:19:18 PST LOG: could not send data to client: Connection reset
by peer
2009-12-09 08:19:18 PST LOG: SSL error: internal error
2009-12-09 08:19:18 PST LOG: could not receive data from client: Connection
reset by peer
2009-12-09 08:19:18 PST LOG: unexpected EOF on client connection
-- System Information:
Debian Release: squeeze/sid
APT prefers stable
APT policy: (990, 'stable'), (500, 'unstable'), (1, 'experimental')
Architecture: amd64 (x86_64)
Kernel: Linux 2.6.26-hpcs (SMP w/4 CPU cores; PREEMPT)
Locale: LANG=en_US, LC_CTYPE=en_US (charmap=ISO-8859-1)
Shell: /bin/sh linked to /bin/bash
Versions of packages postgresql-8.4 depends on:
ii libc6 2.10.2-2 GNU C Library: Shared libraries
ii libcomerr2 1.41.9-1 common error description library
ii libgssapi-krb5-2 1.7+dfsg-3 MIT Kerberos runtime libraries - k
ii libkrb5-3 1.7+dfsg-3 MIT Kerberos runtime libraries
ii libldap-2.4-2 2.4.17-1 OpenLDAP libraries
ii libpam0g 1.1.0-2 Pluggable Authentication Modules l
ii libpq5 8.4.1-1 PostgreSQL C client library
ii libssl0.9.8 0.9.8k-7 SSL shared libraries
ii libxml2 2.7.3.dfsg-2.1 GNOME XML library
ii locales 2.10.2-2 GNU C Library: National Language (
ii postgresql-client-8.4 8.4.1-1 front-end programs for PostgreSQL
ii postgresql-common 101 PostgreSQL database-cluster manage
ii ssl-cert 1.0.23 simple debconf wrapper for OpenSSL
ii tzdata 2009l-1 time zone and daylight-saving time
postgresql-8.4 recommends no packages.
Versions of packages postgresql-8.4 suggests:
pn oidentd | ident-server <none> (no description available)
-- no debconf information
--
To UNSUBSCRIBE, email to [email protected]
with a subject of "unsubscribe". Trouble? Contact [email protected]
