Thread: Several problems with installation on FreeBSD - how to reinstall without loosing data

Several problems with installation on FreeBSD - how to reinstall without loosing data

From
Jon Theil Nielsen
Date:
Hi list,

Even though I have had PostgreSQL for years, I think I am in fact a true novice. :-)

I have installed postgresql-server-9.2.4 on FreeBSD 9.1-Release.
A couple of month ago, I had a break-down of my server and since then, I have had problems with a lot of things. But at least I can see that pgsql is not configured correctly.

First, it started to complain about the role "root" did not exist. I don't think I have created anything that should refer to "root". Even though it's a potentially dangerous thing to do, I created the role. After that, the error message was that the "root" database did not exist. So I just created an empty database called "root". Then the server complained about loosing connection to a client.

I think that the best solution would be to reinstall pgsql. But it would be very inconvenient to loose at least one of the databases (I use it as part of at calendar server). Can I reinstall following a tutorial like this one and get the vital databases back? 

PS
I am not completely sure that pgsql is my only problem. I am using davical as a CalDAV server which can/could be accessed from both Thunderbird and an iPhone.

Regards,
Jon Theil Nielsen
Jon Theil Nielsen <jontheil@gmail.com> wrote:

> First, it started to complain about the role "root" did not
> exist. I don't think I have created anything that should refer to
> "root". Even though it's a potentially dangerous thing to do, I
> created the role. After that, the error message was that the
> "root" database did not exist. So I just created an empty
> database called "root". Then the server complained about loosing
> connection to a client.

To maximize your chances of getting suggestions which are most
helpful, it is better to copy and paste the specific error messages
with details about what led up to each error.

http://wiki.postgresql.org/wiki/Guide_to_reporting_problems

--
Kevin Grittner
EDB: http://www.enterprisedb.com
The Enterprise PostgreSQL Company


Re: Several problems with installation on FreeBSD - how to reinstall without loosing data

From
Jon Theil Nielsen
Date:
> First, it started to complain about the role "root" did not
> exist. I don't think I have created anything that should refer to
> "root". Even though it's a potentially dangerous thing to do, I
> created the role. After that, the error message was that the
> "root" database did not exist. So I just created an empty
> database called "root". Then the server complained about loosing
> connection to a client.

To maximize your chances of getting suggestions which are most
helpful, it is better to copy and paste the specific error messages
with details about what led up to each error.

http://wiki.postgresql.org/wiki/Guide_to_reporting_problems

--
Kevin Grittner
EDB: http://www.enterprisedb.com
The Enterprise PostgreSQL Company

Sure, I know that. It's a bit difficult though since a have used some commands that I can't really find in the history. But I'll give it a try.

First error message:
"postgres[15928]: [29993-1] FATAL:  role "root" does not exist"

Created user "root" with a command like "createuser -sdrP root" (not absolutely sure).

After restart, I got the error message:
"FATAL:  database "root" does not exist"

Then, from the webmin interface, I created an empty database called "root" owned by user "root" using no template.

After restart, I now got the error message:
"FATAL:  connection to client lost".

I don't know if this information is of any use in this context. Of course I can provide the content of some of my configuration files. I just don't know what to look for.

Regards,
Jon
Jon Theil Nielsen <jontheil@gmail.com> wrote:

> First error message:

> "postgres[15928]: [29993-1] FATAL:  role "root" does not exist"

When doing what?  Starting the cluster?  If so, what else is
showing in the log at startup?

> Created user "root" with a command like "createuser -sdrP root"
> (not absolutely sure).
>
> After restart, I got the error message:
> "FATAL:  database "root" does not exist"

Same questoins as above.

> Then, from the webmin interface, I created an empty database
> called "root" owned by user "root" using no template.
>
> After restart, I now got the error message:
> "FATAL:  connection to client lost".
>
>
> I don't know if this information is of any use in this context.
> Of course I can provide the content of some of my configuration
> files. I just don't know what to look for.

It would be great if you could provide all non-comment lines in the
postgresql.conf file (stripped of any comments, for readability).

Also, exactly how are you starting (or restarting) the cluster?  It
does seem as though it might be starting under the root OS login,
which is a bad idea.  A service script, when run by root, should
switch to a different user before starting PostgreSQL.

--
Kevin Grittner
EDB: http://www.enterprisedb.com
The Enterprise PostgreSQL Company


Re: Several problems with installation on FreeBSD - how to reinstall without loosing data

From
Jon Theil Nielsen
Date:
> First error message:

> "postgres[15928]: [29993-1] FATAL:  role "root" does not exist"

When doing what?  Starting the cluster?  If so, what else is
showing in the log at startup?

> Created user "root" with a command like "createuser -sdrP root"
> (not absolutely sure).
>
> After restart, I got the error message:
> "FATAL:  database "root" does not exist"

Same questoins as above.

> Then, from the webmin interface, I created an empty database
> called "root" owned by user "root" using no template.
>
> After restart, I now got the error message:
> "FATAL:  connection to client lost".
>
>
> I don't know if this information is of any use in this context.
> Of course I can provide the content of some of my configuration
> files. I just don't know what to look for.

It would be great if you could provide all non-comment lines in the
postgresql.conf file (stripped of any comments, for readability).

Also, exactly how are you starting (or restarting) the cluster?  It
does seem as though it might be starting under the root OS login,
which is a bad idea.  A service script, when run by root, should
switch to a different user before starting PostgreSQL.

--
Kevin Grittner

The server is started by a service script (/usr/local/etc/rc.d/postgresql start) and runs as the user "pgsql".

Uncommented content of postgresql.conf:
listen_addresses = '*'
port = 5432
shared_buffers = 32MB
log_destination = 'syslog'logging_collector = on
log_directory = 'pg_log'
log_filename = 'postgresql-%Y-%m-%d_%H%M%S.log'
log_file_mode = 0600
log_rotation_age = 1d
log_rotation_size = 0
syslog_facility = 'LOCAL5'
syslog_ident = 'postgres'
client_min_messages = debug5
log_min_messages = debug5
log_min_error_statement = debug5
log_min_duration_statement = 0
debug_pretty_print = on
log_connections = on
log_disconnections = on
log_duration = off
log_error_verbosity = default
log_hostname = on
log_statement = 'mod'
#log_temp_files = -1
log_timezone = 'Europe/Copenhagen'
update_process_title = off
datestyle = 'iso, mdy'
timezone = 'Europe/Copenhagen'
lc_messages = 'C'
lc_monetary = 'C' 
lc_numeric = 'C' 
lc_time = 'C'
default_text_search_config = 'pg_catalog.english'

Regards,
Jon

Re: Several problems with installation on FreeBSD - how to reinstall without loosing data

From
"Christofer C. Bell"
Date:
On Mon, Sep 16, 2013 at 1:10 PM, Jon Theil Nielsen <jontheil@gmail.com> wrote:

I think that the best solution would be to reinstall pgsql. But it would be very inconvenient to loose at least one of the databases (I use it as part of at calendar server). Can I reinstall following a tutorial like this one and get the vital databases back? 

If it comes to that, you still don't have to lose your data.  Since you have the starting (even if it's not working correctly) you should be able to pg_dump your calendar database and then restore it after reinstalling/reinitializing PostgreSQL.  

I am not suggesting this at this point (others on the list are still helping you) but don't think you need to panic over data loss just yet, even if you end up having to reinitialize PostgreSQL.

Good luck!

--
Chris

"If you wish to make an apple pie from scratch, you must first invent the Universe." -- Carl Sagan


Theil Nielsen wrote:
> First error message:
> "postgres[15928]: [29993-1] FATAL:  role "root" does not exist"
> 
> Created user "root" with a command like "createuser -sdrP root" (not absolutely sure).
> 
> After restart, I got the error message:
> "FATAL:  database "root" does not exist"
> 
> Then, from the webmin interface, I created an empty database called "root" owned by user "root" using
> no template.

That looks like you are OS user "root" and type "psql" on the command line.
By default PostgreSQL will try to use the OS user name for database user and
database.

A wild guess: could it be that you mean to call "psql"
as OS user "pgsql" and not as "root"?

> After restart, I now got the error message:
> "FATAL:  connection to client lost".

Ok, that seems to be a different problem.

Are there any odd things in the database log?

Yours,
Laurenz Albe

Re: Several problems with installation on FreeBSD - how to reinstall without loosing data

From
Jon Theil Nielsen
Date:
> First error message:
> "postgres[15928]: [29993-1] FATAL:  role "root" does not exist"
>
> Created user "root" with a command like "createuser -sdrP root" (not absolutely sure).
>
> After restart, I got the error message:
> "FATAL:  database "root" does not exist"
>
> Then, from the webmin interface, I created an empty database called "root" owned by user "root" using
> no template.

That looks like you are OS user "root" and type "psql" on the command line.
By default PostgreSQL will try to use the OS user name for database user and
database.

A wild guess: could it be that you mean to call "psql"
as OS user "pgsql" and not as "root"?

> After restart, I now got the error message:
> "FATAL:  connection to client lost".

Ok, that seems to be a different problem.

Are there any odd things in the database log?

Yours,
Laurenz Albe

Thanks for your answer!

As stated earlier, I am a true novice when it comes to postgresql. So it is not very often I run anything manually from a prompt. The server itself start at boot time and run as the correct user. I think I always use "su pgsql" if I want to do something from the prompt.

I am not sure if there is any clues in the log. And I am not sure if I have the optimal log settings. But I will have a look and report back.

Regards, Jon
Jon Theil Nielsen <jontheil@gmail.com> wrote:

> The server is started by a service script
> (/usr/local/etc/rc.d/postgresql start) and runs as the user
> "pgsql".

That would not explain why it started looking for user or database
"root".

> Uncommented content of postgresql.conf:

That includes some options which could probably be tuned to boost
performance, but those are not related to the current issue.  Of
interest for the current problems:

> log_connections = on
> log_disconnections = on

With those turned on, there should be more lines of interest in the
cluster's log.  Reviewing the log is your best bet.

--
Kevin Grittner
EDB: http://www.enterprisedb.com
The Enterprise PostgreSQL Company


Re: Several problems with installation on FreeBSD - how to reinstall without loosing data

From
Jon Theil Nielsen
Date:
> log_connections = on
> log_disconnections = on

With those turned on, there should be more lines of interest in the
cluster's log.  Reviewing the log is your best bet.

--
Kevin Grittner
EDB: http://www.enterprisedb.com
The Enterprise PostgreSQL Company

The suggested log settings were already on. Debug level is currently 5.
 
I don't know if it is right to use attachments on this list, so I will insert the output of my log file from a restart and a few minutes afterwards. Sorry, it takes a lot of space. But maybe someone clearly can see what the problem(s) is (are):

Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21006]: [1-1] DEBUG:  postgres: PostmasterMain: initial environment dump:
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21006]: [2-1] DEBUG:  -----------------------------------------
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21006]: [3-1] DEBUG:   LC_TIME=C
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21006]: [4-1] DEBUG:   LC_NUMERIC=C
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21006]: [5-1] DEBUG:   LC_MONETARY=C
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21006]: [6-1] DEBUG:   LC_MESSAGES=C
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21006]: [7-1] DEBUG:   LC_CTYPE=C
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21006]: [8-1] DEBUG:   LC_COLLATE=C
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21006]: [9-1] DEBUG:   MAIL=/var/mail/pgsql
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21006]: [10-1] DEBUG:   PGLOCALEDIR=/usr/local/share/locale
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21006]: [11-1] DEBUG:   PATH=/sbin:/bin:/usr/sbin:/usr/bin:/usr/games:/usr/local/sbin:/usr/local/bin:/usr/local/pgsql/bin
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21006]: [12-1] DEBUG:   PGDATA=/usr/local/pgsql/data
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21006]: [13-1] DEBUG:   PWD=/usr/local/pgsql
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21006]: [14-1] DEBUG:   PGSYSCONFDIR=/usr/local/etc/postgresql
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21006]: [15-1] DEBUG:   TERM=xterm
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21006]: [16-1] DEBUG:   HOME=/usr/local/pgsql
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21006]: [17-1] DEBUG:   USER=pgsql
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21006]: [18-1] DEBUG:   SHELL=/bin/sh
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21006]: [19-1] DEBUG:   PG_GRANDPARENT_PID=21003
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21006]: [20-1] DEBUG:   BLOCKSIZE=K
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21006]: [21-1] DEBUG:  -----------------------------------------
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21006]: [22-1] DEBUG:  invoking IpcMemoryCreate(size=41279488)
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21006]: [23-1] DEBUG:  SlruScanDirectory invoking callback on pg_notify/0000
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21006]: [24-1] DEBUG:  removing file "pg_notify/0000"
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21006]: [25-1] DEBUG:  max_safe_fds = 983, usable_fds = 1000, already_open = 7
Sep 17 17:39:38 <local5.info> mflserver4 postgres[21008]: [26-1] LOG:  database system was shut down at 2013-09-17 17:39:37 CEST
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21008]: [27-1] DEBUG:  checkpoint record is at 0/DDB13D0
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21008]: [28-1] DEBUG:  redo record is at 0/DDB13D0; shutdown TRUE
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21008]: [29-1] DEBUG:  next transaction ID: 0/12904; next OID: 52598
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21008]: [30-1] DEBUG:  next MultiXactId: 1597; next MultiXactOffset: 4415
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21008]: [31-1] DEBUG:  oldest unfrozen transaction ID: 983, in database 1
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21008]: [32-1] DEBUG:  transaction ID wrap limit is 2147484630, limited by database with OID 1
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21008]: [33-1] DEBUG:  shmem_exit(0): 4 callbacks to make
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21008]: [34-1] DEBUG:  proc_exit(0): 2 callbacks to make
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21008]: [35-1] DEBUG:  exit(0)
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21008]: [36-1] DEBUG:  shmem_exit(-1): 0 callbacks to make
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21008]: [37-1] DEBUG:  proc_exit(-1): 0 callbacks to make
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21006]: [26-1] DEBUG:  reaping dead processes
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21009]: [27-1] DEBUG:  checkpointer updated shared memory configuration values
Sep 17 17:39:38 <local5.info> mflserver4 postgres[21006]: [27-1] LOG:  database system is ready to accept connections
Sep 17 17:39:38 <local5.info> mflserver4 postgres[21012]: [27-1] LOG:  autovacuum launcher started
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21012]: [28-1] DEBUG:  InitPostgres
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21012]: [29-1] DEBUG:  my backend ID is 1
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21012]: [30-1] DEBUG:  StartTransaction
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21012]: [31-1] DEBUG:  name: unnamed; blockState:       DEFAULT; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21012]: [32-1] DEBUG:  CommitTransaction
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21012]: [33-1] DEBUG:  name: unnamed; blockState:       STARTED; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
Sep 17 17:39:39 <local5.debug> mflserver4 postgres[21006]: [28-1] DEBUG:  forked new backend, pid=21014 socket=11
Sep 17 17:39:39 <local5.info> mflserver4 postgres[21014]: [28-1] LOG:  connection received: host=[local]
Sep 17 17:39:39 <local5.debug> mflserver4 postgres[21014]: [29-1] DEBUG:  postgres child[21014]: starting with (
Sep 17 17:39:39 <local5.debug> mflserver4 postgres[21014]: [30-1] DEBUG:   postgres
Sep 17 17:39:39 <local5.debug> mflserver4 postgres[21014]: [31-1] DEBUG:  )
Sep 17 17:39:39 <local5.debug> mflserver4 postgres[21014]: [32-1] DEBUG:  InitPostgres
Sep 17 17:39:39 <local5.debug> mflserver4 postgres[21014]: [33-1] DEBUG:  my backend ID is 2
Sep 17 17:39:39 <local5.debug> mflserver4 postgres[21014]: [34-1] DEBUG:  StartTransaction
Sep 17 17:39:39 <local5.debug> mflserver4 postgres[21014]: [35-1] DEBUG:  name: unnamed; blockState:       DEFAULT; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
Sep 17 17:39:39 <local5.info> mflserver4 postgres[21014]: [36-1] LOG:  connection authorized: user=pgsql database=postgres
Sep 17 17:39:39 <local5.debug> mflserver4 postgres[21014]: [37-1] DEBUG:  CommitTransaction
Sep 17 17:39:39 <local5.debug> mflserver4 postgres[21014]: [38-1] DEBUG:  name: unnamed; blockState:       STARTED; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
Sep 17 17:39:39 <local5.debug> mflserver4 postgres[21014]: [39-1] DEBUG:  shmem_exit(0): 7 callbacks to make
Sep 17 17:39:39 <local5.debug> mflserver4 postgres[21014]: [40-1] DEBUG:  proc_exit(0): 4 callbacks to make
Sep 17 17:39:39 <local5.info> mflserver4 postgres[21014]: [41-1] LOG:  disconnection: session time: 0:00:00.006 user=pgsql database=postgres host=[local]
Sep 17 17:39:39 <local5.debug> mflserver4 postgres[21014]: [42-1] DEBUG:  exit(0)
Sep 17 17:39:39 <local5.debug> mflserver4 postgres[21014]: [43-1] DEBUG:  shmem_exit(-1): 0 callbacks to make
Sep 17 17:39:39 <local5.debug> mflserver4 postgres[21014]: [44-1] DEBUG:  proc_exit(-1): 0 callbacks to make
Sep 17 17:39:39 <local5.debug> mflserver4 postgres[21006]: [29-1] DEBUG:  reaping dead processes
Sep 17 17:39:39 <local5.debug> mflserver4 postgres[21006]: [30-1] DEBUG:  server process (PID 21014) exited with exit code 0
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21006]: [31-1] DEBUG:  forked new backend, pid=21022 socket=11
Sep 17 17:39:43 <local5.info> mflserver4 postgres[21022]: [31-1] LOG:  connection received: host=localhost port=40319
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21022]: [32-1] DEBUG:  postgres child[21022]: starting with (
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21022]: [33-1] DEBUG:   postgres
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21022]: [34-1] DEBUG:  )
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21022]: [35-1] DEBUG:  InitPostgres
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21022]: [36-1] DEBUG:  my backend ID is 2
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21022]: [37-1] DEBUG:  StartTransaction
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21022]: [38-1] DEBUG:  name: unnamed; blockState:       DEFAULT; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
Sep 17 17:39:43 <local5.info> mflserver4 postgres[21022]: [39-1] LOG:  connection authorized: user=root database=root
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21022]: [40-1] DEBUG:  CommitTransaction
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21022]: [41-1] DEBUG:  name: unnamed; blockState:       STARTED; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21022]: [42-1] DEBUG:  shmem_exit(0): 7 callbacks to make
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21022]: [43-1] DEBUG:  proc_exit(0): 4 callbacks to make
Sep 17 17:39:43 <local5.info> mflserver4 postgres[21022]: [44-1] LOG:  disconnection: session time: 0:00:00.006 user=root database=root host=localhost port=40319
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21022]: [45-1] DEBUG:  exit(0)
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21006]: [32-1] DEBUG:  forked new backend, pid=21023 socket=11
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21022]: [46-1] DEBUG:  shmem_exit(-1): 0 callbacks to make
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21022]: [47-1] DEBUG:  proc_exit(-1): 0 callbacks to make
Sep 17 17:39:43 <local5.info> mflserver4 postgres[21023]: [32-1] LOG:  connection received: host=[local]
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21023]: [33-1] DEBUG:  postgres child[21023]: starting with (
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21023]: [34-1] DEBUG:   postgres
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21023]: [35-1] DEBUG:  )
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21006]: [33-1] DEBUG:  reaping dead processes
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21006]: [34-1] DEBUG:  server process (PID 21022) exited with exit code 0
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21023]: [36-1] DEBUG:  InitPostgres
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21023]: [37-1] DEBUG:  my backend ID is 2
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21023]: [38-1] DEBUG:  StartTransaction
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21023]: [39-1] DEBUG:  name: unnamed; blockState:       DEFAULT; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
Sep 17 17:39:43 <local5.info> mflserver4 postgres[21023]: [40-1] LOG:  connection authorized: user=root database=root
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21023]: [41-1] DEBUG:  CommitTransaction
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21023]: [42-1] DEBUG:  name: unnamed; blockState:       STARTED; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
Sep 17 17:39:43 <local5.info> mflserver4 postgres[21023]: [43-1] LOG:  could not send data to client: Broken pipe
Sep 17 17:39:43 <local5.err> mflserver4 postgres[21023]: [44-1] FATAL:  connection to client lost
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21023]: [45-1] DEBUG:  shmem_exit(1): 7 callbacks to make
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21023]: [46-1] DEBUG:  proc_exit(1): 4 callbacks to make
Sep 17 17:39:43 <local5.info> mflserver4 postgres[21023]: [47-1] LOG:  disconnection: session time: 0:00:00.003 user=root database=root host=[local]
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21023]: [48-1] DEBUG:  exit(1)
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21023]: [49-1] DEBUG:  shmem_exit(-1): 0 callbacks to make
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21023]: [50-1] DEBUG:  proc_exit(-1): 0 callbacks to make
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21006]: [35-1] DEBUG:  reaping dead processes
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21006]: [36-1] DEBUG:  server process (PID 21023) exited with exit code 1
Sep 17 17:39:54 <local5.debug> mflserver4 postgres[21012]: [34-1] DEBUG:  StartTransaction
Sep 17 17:39:54 <local5.debug> mflserver4 postgres[21012]: [35-1] DEBUG:  name: unnamed; blockState:       DEFAULT; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
Sep 17 17:39:54 <local5.debug> mflserver4 postgres[21012]: [36-1] DEBUG:  CommitTransaction
Sep 17 17:39:54 <local5.debug> mflserver4 postgres[21012]: [37-1] DEBUG:  name: unnamed; blockState:       STARTED; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
Sep 17 17:39:54 <local5.debug> mflserver4 postgres[21030]: [37-1] DEBUG:  InitPostgres
Sep 17 17:39:54 <local5.debug> mflserver4 postgres[21030]: [38-1] DEBUG:  my backend ID is 2
Sep 17 17:39:54 <local5.debug> mflserver4 postgres[21030]: [39-1] DEBUG:  StartTransaction
Sep 17 17:39:54 <local5.debug> mflserver4 postgres[21030]: [40-1] DEBUG:  name: unnamed; blockState:       DEFAULT; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
Sep 17 17:39:54 <local5.debug> mflserver4 postgres[21030]: [41-1] DEBUG:  CommitTransaction
Sep 17 17:39:54 <local5.debug> mflserver4 postgres[21030]: [42-1] DEBUG:  name: unnamed; blockState:       STARTED; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
Sep 17 17:39:54 <local5.debug> mflserver4 postgres[21030]: [43-1] DEBUG:  autovacuum: processing database "root"
Sep 17 17:39:54 <local5.debug> mflserver4 postgres[21030]: [44-1] DEBUG:  StartTransaction
Sep 17 17:39:54 <local5.debug> mflserver4 postgres[21030]: [45-1] DEBUG:  name: unnamed; blockState:       DEFAULT; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
Sep 17 17:39:54 <local5.debug> mflserver4 postgres[21030]: [46-1] DEBUG:  pg_authid: vac: 0 (threshold 50), anl: 1 (threshold 50)
Sep 17 17:39:54 <local5.debug> mflserver4 postgres[21030]: [47-1] DEBUG:  pg_class: vac: 0 (threshold 108), anl: 0 (threshold 79)
Sep 17 17:39:54 <local5.debug> mflserver4 postgres[21030]: [48-1] DEBUG:  pg_attribute: vac: 0 (threshold 499), anl: 0 (threshold 275)
Sep 17 17:39:54 <local5.debug> mflserver4 postgres[21030]: [49-1] DEBUG:  pg_opclass: vac: 0 (threshold 74), anl: 0 (threshold 62)
Sep 17 17:39:54 <local5.debug> mflserver4 postgres[21030]: [50-1] DEBUG:  pg_am: vac: 0 (threshold 51), anl: 0 (threshold 50)
Sep 17 17:39:54 <local5.debug> mflserver4 postgres[21030]: [51-1] DEBUG:  pg_amproc: vac: 0 (threshold 107), anl: 0 (threshold 79)
Sep 17 17:39:54 <local5.debug> mflserver4 postgres[21030]: [52-1] DEBUG:  pg_database: vac: 1 (threshold 50), anl: 3 (threshold 50)
Sep 17 17:39:54 <local5.debug> mflserver4 postgres[21030]: [53-1] DEBUG:  pg_db_role_setting: vac: 0 (threshold 50), anl: 0 (threshold 50)
Sep 17 17:39:54 <local5.debug> mflserver4 postgres[21030]: [54-1] DEBUG:  pg_tablespace: vac: 0 (threshold 50), anl: 0 (threshold 50)
Sep 17 17:39:54 <local5.debug> mflserver4 postgres[21030]: [55-1] DEBUG:  pg_shdepend: vac: 0 (threshold 76), anl: 0 (threshold 63)
Sep 17 17:39:54 <local5.debug> mflserver4 postgres[21030]: [56-1] DEBUG:  pg_index: vac: 0 (threshold 72), anl: 0 (threshold 61)
Sep 17 17:39:54 <local5.debug> mflserver4 postgres[21030]: [57-1] DEBUG:  CommitTransaction
Sep 17 17:39:54 <local5.debug> mflserver4 postgres[21030]: [58-1] DEBUG:  name: unnamed; blockState:       STARTED; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
Sep 17 17:39:54 <local5.debug> mflserver4 postgres[21030]: [59-1] DEBUG:  shmem_exit(0): 8 callbacks to make
Sep 17 17:39:54 <local5.debug> mflserver4 postgres[21030]: [60-1] DEBUG:  proc_exit(0): 2 callbacks to make
Sep 17 17:39:54 <local5.debug> mflserver4 postgres[21030]: [61-1] DEBUG:  exit(0)
Sep 17 17:39:54 <local5.debug> mflserver4 postgres[21030]: [62-1] DEBUG:  shmem_exit(-1): 0 callbacks to make
Sep 17 17:39:54 <local5.debug> mflserver4 postgres[21030]: [63-1] DEBUG:  proc_exit(-1): 0 callbacks to make
Sep 17 17:39:54 <local5.debug> mflserver4 postgres[21006]: [37-1] DEBUG:  reaping dead processes
Sep 17 17:39:54 <local5.debug> mflserver4 postgres[21006]: [38-1] DEBUG:  server process (PID 21030) exited with exit code 0
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21006]: [39-1] DEBUG:  forked new backend, pid=21031 socket=11
Sep 17 17:39:58 <local5.info> mflserver4 postgres[21031]: [39-1] LOG:  connection received: host=localhost port=16707
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21031]: [40-1] DEBUG:  postgres child[21031]: starting with (
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21031]: [41-1] DEBUG:   postgres
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21031]: [42-1] DEBUG:  )
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21031]: [43-1] DEBUG:  InitPostgres
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21031]: [44-1] DEBUG:  my backend ID is 2
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21031]: [45-1] DEBUG:  StartTransaction
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21031]: [46-1] DEBUG:  name: unnamed; blockState:       DEFAULT; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
Sep 17 17:39:58 <local5.info> mflserver4 postgres[21031]: [47-1] LOG:  connection authorized: user=root database=root
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21031]: [48-1] DEBUG:  CommitTransaction
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21031]: [49-1] DEBUG:  name: unnamed; blockState:       STARTED; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21031]: [50-1] DEBUG:  shmem_exit(0): 7 callbacks to make
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21031]: [51-1] DEBUG:  proc_exit(0): 4 callbacks to make
Sep 17 17:39:58 <local5.info> mflserver4 postgres[21031]: [52-1] LOG:  disconnection: session time: 0:00:00.002 user=root database=root host=localhost port=16707
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21031]: [53-1] DEBUG:  exit(0)
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21006]: [40-1] DEBUG:  forked new backend, pid=21032 socket=11
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21031]: [54-1] DEBUG:  shmem_exit(-1): 0 callbacks to make
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21031]: [55-1] DEBUG:  proc_exit(-1): 0 callbacks to make
Sep 17 17:39:58 <local5.info> mflserver4 postgres[21032]: [40-1] LOG:  connection received: host=[local]
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21032]: [41-1] DEBUG:  postgres child[21032]: starting with (
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21032]: [42-1] DEBUG:   postgres
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21032]: [43-1] DEBUG:  )
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21006]: [41-1] DEBUG:  reaping dead processes
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21006]: [42-1] DEBUG:  server process (PID 21031) exited with exit code 0
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21032]: [44-1] DEBUG:  InitPostgres
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21032]: [45-1] DEBUG:  my backend ID is 2
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21032]: [46-1] DEBUG:  StartTransaction
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21032]: [47-1] DEBUG:  name: unnamed; blockState:       DEFAULT; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
Sep 17 17:39:58 <local5.info> mflserver4 postgres[21032]: [48-1] LOG:  connection authorized: user=root database=root
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21032]: [49-1] DEBUG:  CommitTransaction
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21032]: [50-1] DEBUG:  name: unnamed; blockState:       STARTED; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
Sep 17 17:39:58 <local5.info> mflserver4 postgres[21032]: [51-1] LOG:  could not send data to client: Broken pipe
Sep 17 17:39:58 <local5.err> mflserver4 postgres[21032]: [52-1] FATAL:  connection to client lost
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21032]: [53-1] DEBUG:  shmem_exit(1): 7 callbacks to make
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21032]: [54-1] DEBUG:  proc_exit(1): 3 callbacks to make
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21032]: [55-1] DEBUG:  exit(1)
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21032]: [56-1] DEBUG:  shmem_exit(-1): 0 callbacks to make
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21032]: [57-1] DEBUG:  proc_exit(-1): 0 callbacks to make
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21006]: [43-1] DEBUG:  reaping dead processes
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21006]: [44-1] DEBUG:  server process (PID 21032) exited with exit code 1
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21012]: [38-1] DEBUG:  StartTransaction
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21012]: [39-1] DEBUG:  name: unnamed; blockState:       DEFAULT; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21012]: [40-1] DEBUG:  CommitTransaction
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21012]: [41-1] DEBUG:  name: unnamed; blockState:       STARTED; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [45-1] DEBUG:  InitPostgres
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [46-1] DEBUG:  my backend ID is 2
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [47-1] DEBUG:  StartTransaction
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [48-1] DEBUG:  name: unnamed; blockState:       DEFAULT; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [49-1] DEBUG:  CommitTransaction
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [50-1] DEBUG:  name: unnamed; blockState:       STARTED; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [51-1] DEBUG:  autovacuum: processing database "davical"
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [52-1] DEBUG:  StartTransaction
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [53-1] DEBUG:  name: unnamed; blockState:       DEFAULT; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [54-1] DEBUG:  pg_statistic: vac: 5 (threshold 140), anl: 50 (threshold 95)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [55-1] DEBUG:  pg_type: vac: 0 (threshold 138), anl: 0 (threshold 94)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [56-1] DEBUG:  pg_authid: vac: 0 (threshold 50), anl: 1 (threshold 50)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [57-1] DEBUG:  pg_proc: vac: 0 (threshold 548), anl: 0 (threshold 299)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [58-1] DEBUG:  pg_class: vac: 0 (threshold 135), anl: 0 (threshold 93)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [59-1] DEBUG:  pg_attribute: vac: 0 (threshold 688), anl: 0 (threshold 369)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [60-1] DEBUG:  pg_constraint: vac: 0 (threshold 65), anl: 0 (threshold 57)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [61-1] DEBUG:  pg_operator: vac: 0 (threshold 196), anl: 0 (threshold 123)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [62-1] DEBUG:  pg_opclass: vac: 0 (threshold 74), anl: 0 (threshold 62)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [63-1] DEBUG:  pg_am: vac: 0 (threshold 51), anl: 0 (threshold 50)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [64-1] DEBUG:  pg_amop: vac: 0 (threshold 129), anl: 0 (threshold 89)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [65-1] DEBUG:  pg_amproc: vac: 0 (threshold 107), anl: 0 (threshold 79)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [66-1] DEBUG:  pg_language: vac: 0 (threshold 51), anl: 0 (threshold 50)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [67-1] DEBUG:  pg_aggregate: vac: 0 (threshold 74), anl: 0 (threshold 62)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [68-1] DEBUG:  pg_rewrite: vac: 0 (threshold 71), anl: 0 (threshold 61)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [69-1] DEBUG:  pg_trigger: vac: 0 (threshold 85), anl: 0 (threshold 68)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [70-1] DEBUG:  pg_namespace: vac: 0 (threshold 51), anl: 0 (threshold 51)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [71-1] DEBUG:  pg_database: vac: 1 (threshold 50), anl: 3 (threshold 50)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [72-1] DEBUG:  pg_db_role_setting: vac: 0 (threshold 50), anl: 0 (threshold 50)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [73-1] DEBUG:  pg_tablespace: vac: 0 (threshold 50), anl: 0 (threshold 50)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [74-1] DEBUG:  pg_shdepend: vac: 0 (threshold 69), anl: 0 (threshold 60)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [75-1] DEBUG:  pg_attrdef: vac: 0 (threshold 50), anl: 0 (threshold 50)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [76-1] DEBUG:  calendar_alarm: vac: 79 (threshold 172), anl: 47 (threshold 111)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [77-1] DEBUG:  pg_index: vac: 0 (threshold 85), anl: 0 (threshold 68)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [78-1] DEBUG:  awl_db_revision: vac: 0 (threshold 50), anl: 0 (threshold 50)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [79-1] DEBUG:  caldav_data: vac: 12 (threshold 300), anl: 142 (threshold 175)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [80-1] DEBUG:  calendar_item: vac: 1 (threshold 300), anl: 142 (threshold 175)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [81-1] DEBUG:  calendar_attendee: vac: 0 (threshold 52), anl: 0 (threshold 51)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [82-1] DEBUG:  dav_binding: vac: 0 (threshold 50), anl: 0 (threshold 50)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [83-1] DEBUG:  pg_cast: vac: 0 (threshold 89), anl: 0 (threshold 70)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [84-1] DEBUG:  collection: vac: 4 (threshold 51), anl: 40 (threshold 51)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [85-1] DEBUG:  addressbook_resource: vac: 0 (threshold 50), anl: 0 (threshold 50)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [86-1] DEBUG:  roles: vac: 0 (threshold 51), anl: 0 (threshold 50)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [87-1] DEBUG:  supported_locales: vac: 0 (threshold 50), anl: 0 (threshold 50)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [88-1] DEBUG:  sync_changes: vac: 0 (threshold 2320), anl: 142 (threshold 1185)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [89-1] DEBUG:  property: vac: 0 (threshold 52), anl: 0 (threshold 51)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [90-1] DEBUG:  role_member: vac: 0 (threshold 50), anl: 0 (threshold 50)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [91-1] DEBUG:  grants: vac: 2 (threshold 50), anl: 0 (threshold 50)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [92-1] DEBUG:  group_member: vac: 0 (threshold 51), anl: 0 (threshold 50)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [93-1] DEBUG:  locks: vac: 0 (threshold 50), anl: 0 (threshold 50)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [94-1] DEBUG:  session: vac: 11 (threshold 57), anl: 12 (threshold 53)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [95-1] DEBUG:  principal: vac: 0 (threshold 51), anl: 0 (threshold 50)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [96-1] DEBUG:  principal_type: vac: 0 (threshold 51), anl: 0 (threshold 50)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [97-1] DEBUG:  usr: vac: 1 (threshold 51), anl: 1 (threshold 50)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [98-1] DEBUG:  sync_tokens: vac: 75 (threshold 8553), anl: 334 (threshold 4302)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [99-1] DEBUG:  access_ticket: vac: 0 (threshold 50), anl: 0 (threshold 50)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [100-1] DEBUG:  timezones: vac: 0 (threshold 51), anl: 0 (threshold 50)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [101-1] DEBUG:  pg_toast_2619: vac: 6 (threshold 58), anl: 12 (threshold 54)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [102-1] DEBUG:  pg_toast_2618: vac: 0 (threshold 84), anl: 0 (threshold 67)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [103-1] DEBUG:  pg_toast_18402: vac: 22 (threshold 51), anl: 128 (threshold 50)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [104-1] DEBUG:  CommitTransaction
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [105-1] DEBUG:  name: unnamed; blockState:       STARTED; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [106-1] DEBUG:  shmem_exit(0): 8 callbacks to make
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [107-1] DEBUG:  proc_exit(0): 2 callbacks to make
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [108-1] DEBUG:  exit(0)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [109-1] DEBUG:  shmem_exit(-1): 0 callbacks to make
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [110-1] DEBUG:  proc_exit(-1): 0 callbacks to make
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21006]: [45-1] DEBUG:  reaping dead processes
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21006]: [46-1] DEBUG:  server process (PID 21037) exited with exit code 0
Sep 17 17:40:13 <local5.debug> mflserver4 postgres[21006]: [47-1] DEBUG:  forked new backend, pid=21038 socket=11
Sep 17 17:40:13 <local5.info> mflserver4 postgres[21038]: [47-1] LOG:  connection received: host=localhost port=16712
Sep 17 17:40:13 <local5.debug> mflserver4 postgres[21038]: [48-1] DEBUG:  postgres child[21038]: starting with (
Sep 17 17:40:13 <local5.debug> mflserver4 postgres[21038]: [49-1] DEBUG:   postgres
Sep 17 17:40:13 <local5.debug> mflserver4 postgres[21038]: [50-1] DEBUG:  )
Sep 17 17:40:13 <local5.debug> mflserver4 postgres[21038]: [51-1] DEBUG:  InitPostgres
Sep 17 17:40:13 <local5.debug> mflserver4 postgres[21038]: [52-1] DEBUG:  my backend ID is 2
Sep 17 17:40:13 <local5.debug> mflserver4 postgres[21038]: [53-1] DEBUG:  StartTransaction
Sep 17 17:40:13 <local5.debug> mflserver4 postgres[21038]: [54-1] DEBUG:  name: unnamed; blockState:       DEFAULT; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
Sep 17 17:40:13 <local5.info> mflserver4 postgres[21038]: [55-1] LOG:  connection authorized: user=root database=root
Sep 17 17:40:13 <local5.debug> mflserver4 postgres[21038]: [56-1] DEBUG:  CommitTransaction
Sep 17 17:40:13 <local5.debug> mflserver4 postgres[21038]: [57-1] DEBUG:  name: unnamed; blockState:       STARTED; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
Sep 17 17:40:13 <local5.debug> mflserver4 postgres[21038]: [58-1] DEBUG:  shmem_exit(0): 7 callbacks to make
Sep 17 17:40:13 <local5.debug> mflserver4 postgres[21038]: [59-1] DEBUG:  proc_exit(0): 4 callbacks to make
Sep 17 17:40:13 <local5.info> mflserver4 postgres[21038]: [60-1] LOG:  disconnection: session time: 0:00:00.002 user=root database=root host=localhost port=16712
Sep 17 17:40:13 <local5.debug> mflserver4 postgres[21038]: [61-1] DEBUG:  exit(0)
Sep 17 17:40:13 <local5.debug> mflserver4 postgres[21006]: [48-1] DEBUG:  forked new backend, pid=21039 socket=11
Sep 17 17:40:13 <local5.debug> mflserver4 postgres[21038]: [62-1] DEBUG:  shmem_exit(-1): 0 callbacks to make
Sep 17 17:40:13 <local5.debug> mflserver4 postgres[21038]: [63-1] DEBUG:  proc_exit(-1): 0 callbacks to make
Sep 17 17:40:13 <local5.info> mflserver4 postgres[21039]: [48-1] LOG:  connection received: host=[local]
Sep 17 17:40:13 <local5.debug> mflserver4 postgres[21039]: [49-1] DEBUG:  postgres child[21039]: starting with (
Sep 17 17:40:13 <local5.debug> mflserver4 postgres[21039]: [50-1] DEBUG:   postgres
Sep 17 17:40:13 <local5.debug> mflserver4 postgres[21039]: [51-1] DEBUG:  )
Sep 17 17:40:13 <local5.debug> mflserver4 postgres[21006]: [49-1] DEBUG:  reaping dead processes
Sep 17 17:40:13 <local5.debug> mflserver4 postgres[21039]: [52-1] DEBUG:  InitPostgres
Sep 17 17:40:13 <local5.debug> mflserver4 postgres[21039]: [53-1] DEBUG:  my backend ID is 2
Sep 17 17:40:13 <local5.debug> mflserver4 postgres[21006]: [50-1] DEBUG:  server process (PID 21038) exited with exit code 0
Sep 17 17:40:13 <local5.debug> mflserver4 postgres[21039]: [54-1] DEBUG:  StartTransaction
Sep 17 17:40:13 <local5.debug> mflserver4 postgres[21039]: [55-1] DEBUG:  name: unnamed; blockState:       DEFAULT; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
Sep 17 17:40:13 <local5.info> mflserver4 postgres[21039]: [56-1] LOG:  connection authorized: user=root database=root
Sep 17 17:40:13 <local5.debug> mflserver4 postgres[21039]: [57-1] DEBUG:  CommitTransaction
Sep 17 17:40:13 <local5.debug> mflserver4 postgres[21039]: [58-1] DEBUG:  name: unnamed; blockState:       STARTED; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
Sep 17 17:40:23 <local5.debug> mflserver4 postgres[21012]: [42-1] DEBUG:  StartTransaction
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21012]: [43-1] DEBUG:  name: unnamed; blockState:       DEFAULT; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
Sep 17 17:40:13 <local5.info> mflserver4 postgres[21039]: [59-1] LOG:  could not send data to client: Broken pipe
Sep 17 17:40:26 <local5.err> mflserver4 postgres[21039]: [60-1] FATAL:  connection to client lost
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21012]: [44-1] DEBUG:  CommitTransaction
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21039]: [61-1] DEBUG:  shmem_exit(1): 7 callbacks to make
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21039]: [62-1] DEBUG:  proc_exit(1): 4 callbacks to make
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21012]: [45-1] DEBUG:  name: unnamed; blockState:       STARTED; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
Sep 17 17:40:26 <local5.info> mflserver4 postgres[21039]: [63-1] LOG:  disconnection: session time: 0:00:12.618 user=root database=root host=[local]
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21039]: [64-1] DEBUG:  exit(1)
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21039]: [65-1] DEBUG:  shmem_exit(-1): 0 callbacks to make
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21039]: [66-1] DEBUG:  proc_exit(-1): 0 callbacks to make
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21006]: [51-1] DEBUG:  reaping dead processes
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21006]: [52-1] DEBUG:  server process (PID 21039) exited with exit code 1
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21043]: [53-1] DEBUG:  InitPostgres
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21043]: [54-1] DEBUG:  my backend ID is 2
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21043]: [55-1] DEBUG:  StartTransaction
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21043]: [56-1] DEBUG:  name: unnamed; blockState:       DEFAULT; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21043]: [57-1] DEBUG:  CommitTransaction
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21043]: [58-1] DEBUG:  name: unnamed; blockState:       STARTED; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21043]: [59-1] DEBUG:  autovacuum: processing database "postgres"
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21043]: [60-1] DEBUG:  StartTransaction
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21043]: [61-1] DEBUG:  name: unnamed; blockState:       DEFAULT; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21043]: [62-1] DEBUG:  pg_statistic: vac: 0 (threshold 127), anl: 0 (threshold 88)
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21043]: [63-1] DEBUG:  pg_type: vac: 0 (threshold 116), anl: 0 (threshold 83)
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21043]: [64-1] DEBUG:  pg_authid: vac: 0 (threshold 50), anl: 1 (threshold 50)
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21043]: [65-1] DEBUG:  pg_proc: vac: 0 (threshold 548), anl: 0 (threshold 299)
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21043]: [66-1] DEBUG:  pg_class: vac: 0 (threshold 108), anl: 0 (threshold 79)
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21043]: [67-1] DEBUG:  pg_attribute: vac: 0 (threshold 499), anl: 0 (threshold 275)
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21043]: [68-1] DEBUG:  pg_operator: vac: 0 (threshold 196), anl: 0 (threshold 123)
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21043]: [69-1] DEBUG:  pg_opclass: vac: 0 (threshold 74), anl: 0 (threshold 62)
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21043]: [70-1] DEBUG:  pg_am: vac: 0 (threshold 51), anl: 0 (threshold 50)
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21043]: [71-1] DEBUG:  pg_amop: vac: 0 (threshold 129), anl: 0 (threshold 89)
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21043]: [72-1] DEBUG:  pg_amproc: vac: 0 (threshold 107), anl: 0 (threshold 79)
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21043]: [73-1] DEBUG:  pg_database: vac: 1 (threshold 50), anl: 3 (threshold 50)
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21043]: [74-1] DEBUG:  pg_namespace: vac: 0 (threshold 51), anl: 0 (threshold 51)
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21043]: [75-1] DEBUG:  pg_db_role_setting: vac: 0 (threshold 50), anl: 0 (threshold 50)
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21043]: [76-1] DEBUG:  pg_tablespace: vac: 0 (threshold 50), anl: 0 (threshold 50)
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21043]: [77-1] DEBUG:  pg_shdepend: vac: 0 (threshold 50), anl: 0 (threshold 50)
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21043]: [78-1] DEBUG:  pg_index: vac: 0 (threshold 72), anl: 0 (threshold 61)
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21043]: [79-1] DEBUG:  pg_cast: vac: 0 (threshold 89), anl: 0 (threshold 70)
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21043]: [80-1] DEBUG:  pg_toast_2619: vac: 0 (threshold 52), anl: 0 (threshold 51)
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21043]: [81-1] DEBUG:  CommitTransaction

Regards,
Jon
Hi,
You have lines in the output which say
"Sep 17 17:39:43 <local5.info> mflserver4 postgres[21022]: [39-1] LOG:  connection authorized: user=root database=root"
In case you are not doing it manually, do you have some cron job that is expected to backup the database or vacuum the database, and it is trying to connect to the database as root user, to database root?
Regards,
Jayadevan


On Tue, Sep 17, 2013 at 11:37 PM, Jon Theil Nielsen <jontheil@gmail.com> wrote:
> log_connections = on
> log_disconnections = on

With those turned on, there should be more lines of interest in the
cluster's log.  Reviewing the log is your best bet.

--
Kevin Grittner
EDB: http://www.enterprisedb.com
The Enterprise PostgreSQL Company

The suggested log settings were already on. Debug level is currently 5.
 
I don't know if it is right to use attachments on this list, so I will insert the output of my log file from a restart and a few minutes afterwards. Sorry, it takes a lot of space. But maybe someone clearly can see what the problem(s) is (are):

Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21006]: [1-1] DEBUG:  postgres: PostmasterMain: initial environment dump:
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21006]: [2-1] DEBUG:  -----------------------------------------
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21006]: [3-1] DEBUG:   LC_TIME=C
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21006]: [4-1] DEBUG:   LC_NUMERIC=C
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21006]: [5-1] DEBUG:   LC_MONETARY=C
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21006]: [6-1] DEBUG:   LC_MESSAGES=C
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21006]: [7-1] DEBUG:   LC_CTYPE=C
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21006]: [8-1] DEBUG:   LC_COLLATE=C
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21006]: [9-1] DEBUG:   MAIL=/var/mail/pgsql
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21006]: [10-1] DEBUG:   PGLOCALEDIR=/usr/local/share/locale
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21006]: [11-1] DEBUG:   PATH=/sbin:/bin:/usr/sbin:/usr/bin:/usr/games:/usr/local/sbin:/usr/local/bin:/usr/local/pgsql/bin
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21006]: [12-1] DEBUG:   PGDATA=/usr/local/pgsql/data
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21006]: [13-1] DEBUG:   PWD=/usr/local/pgsql
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21006]: [14-1] DEBUG:   PGSYSCONFDIR=/usr/local/etc/postgresql
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21006]: [15-1] DEBUG:   TERM=xterm
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21006]: [16-1] DEBUG:   HOME=/usr/local/pgsql
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21006]: [17-1] DEBUG:   USER=pgsql
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21006]: [18-1] DEBUG:   SHELL=/bin/sh
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21006]: [19-1] DEBUG:   PG_GRANDPARENT_PID=21003
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21006]: [20-1] DEBUG:   BLOCKSIZE=K
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21006]: [21-1] DEBUG:  -----------------------------------------
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21006]: [22-1] DEBUG:  invoking IpcMemoryCreate(size=41279488)
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21006]: [23-1] DEBUG:  SlruScanDirectory invoking callback on pg_notify/0000
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21006]: [24-1] DEBUG:  removing file "pg_notify/0000"
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21006]: [25-1] DEBUG:  max_safe_fds = 983, usable_fds = 1000, already_open = 7
Sep 17 17:39:38 <local5.info> mflserver4 postgres[21008]: [26-1] LOG:  database system was shut down at 2013-09-17 17:39:37 CEST
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21008]: [27-1] DEBUG:  checkpoint record is at 0/DDB13D0
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21008]: [28-1] DEBUG:  redo record is at 0/DDB13D0; shutdown TRUE
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21008]: [29-1] DEBUG:  next transaction ID: 0/12904; next OID: 52598
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21008]: [30-1] DEBUG:  next MultiXactId: 1597; next MultiXactOffset: 4415
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21008]: [31-1] DEBUG:  oldest unfrozen transaction ID: 983, in database 1
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21008]: [32-1] DEBUG:  transaction ID wrap limit is 2147484630, limited by database with OID 1
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21008]: [33-1] DEBUG:  shmem_exit(0): 4 callbacks to make
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21008]: [34-1] DEBUG:  proc_exit(0): 2 callbacks to make
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21008]: [35-1] DEBUG:  exit(0)
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21008]: [36-1] DEBUG:  shmem_exit(-1): 0 callbacks to make
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21008]: [37-1] DEBUG:  proc_exit(-1): 0 callbacks to make
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21006]: [26-1] DEBUG:  reaping dead processes
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21009]: [27-1] DEBUG:  checkpointer updated shared memory configuration values
Sep 17 17:39:38 <local5.info> mflserver4 postgres[21006]: [27-1] LOG:  database system is ready to accept connections
Sep 17 17:39:38 <local5.info> mflserver4 postgres[21012]: [27-1] LOG:  autovacuum launcher started
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21012]: [28-1] DEBUG:  InitPostgres
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21012]: [29-1] DEBUG:  my backend ID is 1
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21012]: [30-1] DEBUG:  StartTransaction
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21012]: [31-1] DEBUG:  name: unnamed; blockState:       DEFAULT; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21012]: [32-1] DEBUG:  CommitTransaction
Sep 17 17:39:38 <local5.debug> mflserver4 postgres[21012]: [33-1] DEBUG:  name: unnamed; blockState:       STARTED; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
Sep 17 17:39:39 <local5.debug> mflserver4 postgres[21006]: [28-1] DEBUG:  forked new backend, pid=21014 socket=11
Sep 17 17:39:39 <local5.info> mflserver4 postgres[21014]: [28-1] LOG:  connection received: host=[local]
Sep 17 17:39:39 <local5.debug> mflserver4 postgres[21014]: [29-1] DEBUG:  postgres child[21014]: starting with (
Sep 17 17:39:39 <local5.debug> mflserver4 postgres[21014]: [30-1] DEBUG:   postgres
Sep 17 17:39:39 <local5.debug> mflserver4 postgres[21014]: [31-1] DEBUG:  )
Sep 17 17:39:39 <local5.debug> mflserver4 postgres[21014]: [32-1] DEBUG:  InitPostgres
Sep 17 17:39:39 <local5.debug> mflserver4 postgres[21014]: [33-1] DEBUG:  my backend ID is 2
Sep 17 17:39:39 <local5.debug> mflserver4 postgres[21014]: [34-1] DEBUG:  StartTransaction
Sep 17 17:39:39 <local5.debug> mflserver4 postgres[21014]: [35-1] DEBUG:  name: unnamed; blockState:       DEFAULT; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
Sep 17 17:39:39 <local5.info> mflserver4 postgres[21014]: [36-1] LOG:  connection authorized: user=pgsql database=postgres
Sep 17 17:39:39 <local5.debug> mflserver4 postgres[21014]: [37-1] DEBUG:  CommitTransaction
Sep 17 17:39:39 <local5.debug> mflserver4 postgres[21014]: [38-1] DEBUG:  name: unnamed; blockState:       STARTED; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
Sep 17 17:39:39 <local5.debug> mflserver4 postgres[21014]: [39-1] DEBUG:  shmem_exit(0): 7 callbacks to make
Sep 17 17:39:39 <local5.debug> mflserver4 postgres[21014]: [40-1] DEBUG:  proc_exit(0): 4 callbacks to make
Sep 17 17:39:39 <local5.info> mflserver4 postgres[21014]: [41-1] LOG:  disconnection: session time: 0:00:00.006 user=pgsql database=postgres host=[local]
Sep 17 17:39:39 <local5.debug> mflserver4 postgres[21014]: [42-1] DEBUG:  exit(0)
Sep 17 17:39:39 <local5.debug> mflserver4 postgres[21014]: [43-1] DEBUG:  shmem_exit(-1): 0 callbacks to make
Sep 17 17:39:39 <local5.debug> mflserver4 postgres[21014]: [44-1] DEBUG:  proc_exit(-1): 0 callbacks to make
Sep 17 17:39:39 <local5.debug> mflserver4 postgres[21006]: [29-1] DEBUG:  reaping dead processes
Sep 17 17:39:39 <local5.debug> mflserver4 postgres[21006]: [30-1] DEBUG:  server process (PID 21014) exited with exit code 0
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21006]: [31-1] DEBUG:  forked new backend, pid=21022 socket=11
Sep 17 17:39:43 <local5.info> mflserver4 postgres[21022]: [31-1] LOG:  connection received: host=localhost port=40319
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21022]: [32-1] DEBUG:  postgres child[21022]: starting with (
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21022]: [33-1] DEBUG:   postgres
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21022]: [34-1] DEBUG:  )
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21022]: [35-1] DEBUG:  InitPostgres
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21022]: [36-1] DEBUG:  my backend ID is 2
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21022]: [37-1] DEBUG:  StartTransaction
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21022]: [38-1] DEBUG:  name: unnamed; blockState:       DEFAULT; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
Sep 17 17:39:43 <local5.info> mflserver4 postgres[21022]: [39-1] LOG:  connection authorized: user=root database=root
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21022]: [40-1] DEBUG:  CommitTransaction
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21022]: [41-1] DEBUG:  name: unnamed; blockState:       STARTED; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21022]: [42-1] DEBUG:  shmem_exit(0): 7 callbacks to make
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21022]: [43-1] DEBUG:  proc_exit(0): 4 callbacks to make
Sep 17 17:39:43 <local5.info> mflserver4 postgres[21022]: [44-1] LOG:  disconnection: session time: 0:00:00.006 user=root database=root host=localhost port=40319
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21022]: [45-1] DEBUG:  exit(0)
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21006]: [32-1] DEBUG:  forked new backend, pid=21023 socket=11
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21022]: [46-1] DEBUG:  shmem_exit(-1): 0 callbacks to make
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21022]: [47-1] DEBUG:  proc_exit(-1): 0 callbacks to make
Sep 17 17:39:43 <local5.info> mflserver4 postgres[21023]: [32-1] LOG:  connection received: host=[local]
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21023]: [33-1] DEBUG:  postgres child[21023]: starting with (
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21023]: [34-1] DEBUG:   postgres
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21023]: [35-1] DEBUG:  )
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21006]: [33-1] DEBUG:  reaping dead processes
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21006]: [34-1] DEBUG:  server process (PID 21022) exited with exit code 0
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21023]: [36-1] DEBUG:  InitPostgres
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21023]: [37-1] DEBUG:  my backend ID is 2
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21023]: [38-1] DEBUG:  StartTransaction
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21023]: [39-1] DEBUG:  name: unnamed; blockState:       DEFAULT; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
Sep 17 17:39:43 <local5.info> mflserver4 postgres[21023]: [40-1] LOG:  connection authorized: user=root database=root
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21023]: [41-1] DEBUG:  CommitTransaction
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21023]: [42-1] DEBUG:  name: unnamed; blockState:       STARTED; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
Sep 17 17:39:43 <local5.info> mflserver4 postgres[21023]: [43-1] LOG:  could not send data to client: Broken pipe
Sep 17 17:39:43 <local5.err> mflserver4 postgres[21023]: [44-1] FATAL:  connection to client lost
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21023]: [45-1] DEBUG:  shmem_exit(1): 7 callbacks to make
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21023]: [46-1] DEBUG:  proc_exit(1): 4 callbacks to make
Sep 17 17:39:43 <local5.info> mflserver4 postgres[21023]: [47-1] LOG:  disconnection: session time: 0:00:00.003 user=root database=root host=[local]
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21023]: [48-1] DEBUG:  exit(1)
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21023]: [49-1] DEBUG:  shmem_exit(-1): 0 callbacks to make
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21023]: [50-1] DEBUG:  proc_exit(-1): 0 callbacks to make
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21006]: [35-1] DEBUG:  reaping dead processes
Sep 17 17:39:43 <local5.debug> mflserver4 postgres[21006]: [36-1] DEBUG:  server process (PID 21023) exited with exit code 1
Sep 17 17:39:54 <local5.debug> mflserver4 postgres[21012]: [34-1] DEBUG:  StartTransaction
Sep 17 17:39:54 <local5.debug> mflserver4 postgres[21012]: [35-1] DEBUG:  name: unnamed; blockState:       DEFAULT; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
Sep 17 17:39:54 <local5.debug> mflserver4 postgres[21012]: [36-1] DEBUG:  CommitTransaction
Sep 17 17:39:54 <local5.debug> mflserver4 postgres[21012]: [37-1] DEBUG:  name: unnamed; blockState:       STARTED; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
Sep 17 17:39:54 <local5.debug> mflserver4 postgres[21030]: [37-1] DEBUG:  InitPostgres
Sep 17 17:39:54 <local5.debug> mflserver4 postgres[21030]: [38-1] DEBUG:  my backend ID is 2
Sep 17 17:39:54 <local5.debug> mflserver4 postgres[21030]: [39-1] DEBUG:  StartTransaction
Sep 17 17:39:54 <local5.debug> mflserver4 postgres[21030]: [40-1] DEBUG:  name: unnamed; blockState:       DEFAULT; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
Sep 17 17:39:54 <local5.debug> mflserver4 postgres[21030]: [41-1] DEBUG:  CommitTransaction
Sep 17 17:39:54 <local5.debug> mflserver4 postgres[21030]: [42-1] DEBUG:  name: unnamed; blockState:       STARTED; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
Sep 17 17:39:54 <local5.debug> mflserver4 postgres[21030]: [43-1] DEBUG:  autovacuum: processing database "root"
Sep 17 17:39:54 <local5.debug> mflserver4 postgres[21030]: [44-1] DEBUG:  StartTransaction
Sep 17 17:39:54 <local5.debug> mflserver4 postgres[21030]: [45-1] DEBUG:  name: unnamed; blockState:       DEFAULT; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
Sep 17 17:39:54 <local5.debug> mflserver4 postgres[21030]: [46-1] DEBUG:  pg_authid: vac: 0 (threshold 50), anl: 1 (threshold 50)
Sep 17 17:39:54 <local5.debug> mflserver4 postgres[21030]: [47-1] DEBUG:  pg_class: vac: 0 (threshold 108), anl: 0 (threshold 79)
Sep 17 17:39:54 <local5.debug> mflserver4 postgres[21030]: [48-1] DEBUG:  pg_attribute: vac: 0 (threshold 499), anl: 0 (threshold 275)
Sep 17 17:39:54 <local5.debug> mflserver4 postgres[21030]: [49-1] DEBUG:  pg_opclass: vac: 0 (threshold 74), anl: 0 (threshold 62)
Sep 17 17:39:54 <local5.debug> mflserver4 postgres[21030]: [50-1] DEBUG:  pg_am: vac: 0 (threshold 51), anl: 0 (threshold 50)
Sep 17 17:39:54 <local5.debug> mflserver4 postgres[21030]: [51-1] DEBUG:  pg_amproc: vac: 0 (threshold 107), anl: 0 (threshold 79)
Sep 17 17:39:54 <local5.debug> mflserver4 postgres[21030]: [52-1] DEBUG:  pg_database: vac: 1 (threshold 50), anl: 3 (threshold 50)
Sep 17 17:39:54 <local5.debug> mflserver4 postgres[21030]: [53-1] DEBUG:  pg_db_role_setting: vac: 0 (threshold 50), anl: 0 (threshold 50)
Sep 17 17:39:54 <local5.debug> mflserver4 postgres[21030]: [54-1] DEBUG:  pg_tablespace: vac: 0 (threshold 50), anl: 0 (threshold 50)
Sep 17 17:39:54 <local5.debug> mflserver4 postgres[21030]: [55-1] DEBUG:  pg_shdepend: vac: 0 (threshold 76), anl: 0 (threshold 63)
Sep 17 17:39:54 <local5.debug> mflserver4 postgres[21030]: [56-1] DEBUG:  pg_index: vac: 0 (threshold 72), anl: 0 (threshold 61)
Sep 17 17:39:54 <local5.debug> mflserver4 postgres[21030]: [57-1] DEBUG:  CommitTransaction
Sep 17 17:39:54 <local5.debug> mflserver4 postgres[21030]: [58-1] DEBUG:  name: unnamed; blockState:       STARTED; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
Sep 17 17:39:54 <local5.debug> mflserver4 postgres[21030]: [59-1] DEBUG:  shmem_exit(0): 8 callbacks to make
Sep 17 17:39:54 <local5.debug> mflserver4 postgres[21030]: [60-1] DEBUG:  proc_exit(0): 2 callbacks to make
Sep 17 17:39:54 <local5.debug> mflserver4 postgres[21030]: [61-1] DEBUG:  exit(0)
Sep 17 17:39:54 <local5.debug> mflserver4 postgres[21030]: [62-1] DEBUG:  shmem_exit(-1): 0 callbacks to make
Sep 17 17:39:54 <local5.debug> mflserver4 postgres[21030]: [63-1] DEBUG:  proc_exit(-1): 0 callbacks to make
Sep 17 17:39:54 <local5.debug> mflserver4 postgres[21006]: [37-1] DEBUG:  reaping dead processes
Sep 17 17:39:54 <local5.debug> mflserver4 postgres[21006]: [38-1] DEBUG:  server process (PID 21030) exited with exit code 0
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21006]: [39-1] DEBUG:  forked new backend, pid=21031 socket=11
Sep 17 17:39:58 <local5.info> mflserver4 postgres[21031]: [39-1] LOG:  connection received: host=localhost port=16707
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21031]: [40-1] DEBUG:  postgres child[21031]: starting with (
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21031]: [41-1] DEBUG:   postgres
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21031]: [42-1] DEBUG:  )
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21031]: [43-1] DEBUG:  InitPostgres
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21031]: [44-1] DEBUG:  my backend ID is 2
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21031]: [45-1] DEBUG:  StartTransaction
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21031]: [46-1] DEBUG:  name: unnamed; blockState:       DEFAULT; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
Sep 17 17:39:58 <local5.info> mflserver4 postgres[21031]: [47-1] LOG:  connection authorized: user=root database=root
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21031]: [48-1] DEBUG:  CommitTransaction
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21031]: [49-1] DEBUG:  name: unnamed; blockState:       STARTED; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21031]: [50-1] DEBUG:  shmem_exit(0): 7 callbacks to make
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21031]: [51-1] DEBUG:  proc_exit(0): 4 callbacks to make
Sep 17 17:39:58 <local5.info> mflserver4 postgres[21031]: [52-1] LOG:  disconnection: session time: 0:00:00.002 user=root database=root host=localhost port=16707
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21031]: [53-1] DEBUG:  exit(0)
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21006]: [40-1] DEBUG:  forked new backend, pid=21032 socket=11
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21031]: [54-1] DEBUG:  shmem_exit(-1): 0 callbacks to make
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21031]: [55-1] DEBUG:  proc_exit(-1): 0 callbacks to make
Sep 17 17:39:58 <local5.info> mflserver4 postgres[21032]: [40-1] LOG:  connection received: host=[local]
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21032]: [41-1] DEBUG:  postgres child[21032]: starting with (
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21032]: [42-1] DEBUG:   postgres
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21032]: [43-1] DEBUG:  )
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21006]: [41-1] DEBUG:  reaping dead processes
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21006]: [42-1] DEBUG:  server process (PID 21031) exited with exit code 0
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21032]: [44-1] DEBUG:  InitPostgres
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21032]: [45-1] DEBUG:  my backend ID is 2
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21032]: [46-1] DEBUG:  StartTransaction
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21032]: [47-1] DEBUG:  name: unnamed; blockState:       DEFAULT; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
Sep 17 17:39:58 <local5.info> mflserver4 postgres[21032]: [48-1] LOG:  connection authorized: user=root database=root
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21032]: [49-1] DEBUG:  CommitTransaction
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21032]: [50-1] DEBUG:  name: unnamed; blockState:       STARTED; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
Sep 17 17:39:58 <local5.info> mflserver4 postgres[21032]: [51-1] LOG:  could not send data to client: Broken pipe
Sep 17 17:39:58 <local5.err> mflserver4 postgres[21032]: [52-1] FATAL:  connection to client lost
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21032]: [53-1] DEBUG:  shmem_exit(1): 7 callbacks to make
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21032]: [54-1] DEBUG:  proc_exit(1): 3 callbacks to make
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21032]: [55-1] DEBUG:  exit(1)
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21032]: [56-1] DEBUG:  shmem_exit(-1): 0 callbacks to make
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21032]: [57-1] DEBUG:  proc_exit(-1): 0 callbacks to make
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21006]: [43-1] DEBUG:  reaping dead processes
Sep 17 17:39:58 <local5.debug> mflserver4 postgres[21006]: [44-1] DEBUG:  server process (PID 21032) exited with exit code 1
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21012]: [38-1] DEBUG:  StartTransaction
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21012]: [39-1] DEBUG:  name: unnamed; blockState:       DEFAULT; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21012]: [40-1] DEBUG:  CommitTransaction
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21012]: [41-1] DEBUG:  name: unnamed; blockState:       STARTED; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [45-1] DEBUG:  InitPostgres
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [46-1] DEBUG:  my backend ID is 2
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [47-1] DEBUG:  StartTransaction
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [48-1] DEBUG:  name: unnamed; blockState:       DEFAULT; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [49-1] DEBUG:  CommitTransaction
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [50-1] DEBUG:  name: unnamed; blockState:       STARTED; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [51-1] DEBUG:  autovacuum: processing database "davical"
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [52-1] DEBUG:  StartTransaction
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [53-1] DEBUG:  name: unnamed; blockState:       DEFAULT; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [54-1] DEBUG:  pg_statistic: vac: 5 (threshold 140), anl: 50 (threshold 95)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [55-1] DEBUG:  pg_type: vac: 0 (threshold 138), anl: 0 (threshold 94)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [56-1] DEBUG:  pg_authid: vac: 0 (threshold 50), anl: 1 (threshold 50)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [57-1] DEBUG:  pg_proc: vac: 0 (threshold 548), anl: 0 (threshold 299)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [58-1] DEBUG:  pg_class: vac: 0 (threshold 135), anl: 0 (threshold 93)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [59-1] DEBUG:  pg_attribute: vac: 0 (threshold 688), anl: 0 (threshold 369)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [60-1] DEBUG:  pg_constraint: vac: 0 (threshold 65), anl: 0 (threshold 57)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [61-1] DEBUG:  pg_operator: vac: 0 (threshold 196), anl: 0 (threshold 123)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [62-1] DEBUG:  pg_opclass: vac: 0 (threshold 74), anl: 0 (threshold 62)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [63-1] DEBUG:  pg_am: vac: 0 (threshold 51), anl: 0 (threshold 50)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [64-1] DEBUG:  pg_amop: vac: 0 (threshold 129), anl: 0 (threshold 89)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [65-1] DEBUG:  pg_amproc: vac: 0 (threshold 107), anl: 0 (threshold 79)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [66-1] DEBUG:  pg_language: vac: 0 (threshold 51), anl: 0 (threshold 50)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [67-1] DEBUG:  pg_aggregate: vac: 0 (threshold 74), anl: 0 (threshold 62)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [68-1] DEBUG:  pg_rewrite: vac: 0 (threshold 71), anl: 0 (threshold 61)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [69-1] DEBUG:  pg_trigger: vac: 0 (threshold 85), anl: 0 (threshold 68)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [70-1] DEBUG:  pg_namespace: vac: 0 (threshold 51), anl: 0 (threshold 51)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [71-1] DEBUG:  pg_database: vac: 1 (threshold 50), anl: 3 (threshold 50)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [72-1] DEBUG:  pg_db_role_setting: vac: 0 (threshold 50), anl: 0 (threshold 50)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [73-1] DEBUG:  pg_tablespace: vac: 0 (threshold 50), anl: 0 (threshold 50)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [74-1] DEBUG:  pg_shdepend: vac: 0 (threshold 69), anl: 0 (threshold 60)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [75-1] DEBUG:  pg_attrdef: vac: 0 (threshold 50), anl: 0 (threshold 50)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [76-1] DEBUG:  calendar_alarm: vac: 79 (threshold 172), anl: 47 (threshold 111)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [77-1] DEBUG:  pg_index: vac: 0 (threshold 85), anl: 0 (threshold 68)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [78-1] DEBUG:  awl_db_revision: vac: 0 (threshold 50), anl: 0 (threshold 50)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [79-1] DEBUG:  caldav_data: vac: 12 (threshold 300), anl: 142 (threshold 175)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [80-1] DEBUG:  calendar_item: vac: 1 (threshold 300), anl: 142 (threshold 175)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [81-1] DEBUG:  calendar_attendee: vac: 0 (threshold 52), anl: 0 (threshold 51)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [82-1] DEBUG:  dav_binding: vac: 0 (threshold 50), anl: 0 (threshold 50)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [83-1] DEBUG:  pg_cast: vac: 0 (threshold 89), anl: 0 (threshold 70)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [84-1] DEBUG:  collection: vac: 4 (threshold 51), anl: 40 (threshold 51)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [85-1] DEBUG:  addressbook_resource: vac: 0 (threshold 50), anl: 0 (threshold 50)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [86-1] DEBUG:  roles: vac: 0 (threshold 51), anl: 0 (threshold 50)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [87-1] DEBUG:  supported_locales: vac: 0 (threshold 50), anl: 0 (threshold 50)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [88-1] DEBUG:  sync_changes: vac: 0 (threshold 2320), anl: 142 (threshold 1185)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [89-1] DEBUG:  property: vac: 0 (threshold 52), anl: 0 (threshold 51)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [90-1] DEBUG:  role_member: vac: 0 (threshold 50), anl: 0 (threshold 50)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [91-1] DEBUG:  grants: vac: 2 (threshold 50), anl: 0 (threshold 50)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [92-1] DEBUG:  group_member: vac: 0 (threshold 51), anl: 0 (threshold 50)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [93-1] DEBUG:  locks: vac: 0 (threshold 50), anl: 0 (threshold 50)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [94-1] DEBUG:  session: vac: 11 (threshold 57), anl: 12 (threshold 53)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [95-1] DEBUG:  principal: vac: 0 (threshold 51), anl: 0 (threshold 50)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [96-1] DEBUG:  principal_type: vac: 0 (threshold 51), anl: 0 (threshold 50)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [97-1] DEBUG:  usr: vac: 1 (threshold 51), anl: 1 (threshold 50)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [98-1] DEBUG:  sync_tokens: vac: 75 (threshold 8553), anl: 334 (threshold 4302)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [99-1] DEBUG:  access_ticket: vac: 0 (threshold 50), anl: 0 (threshold 50)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [100-1] DEBUG:  timezones: vac: 0 (threshold 51), anl: 0 (threshold 50)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [101-1] DEBUG:  pg_toast_2619: vac: 6 (threshold 58), anl: 12 (threshold 54)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [102-1] DEBUG:  pg_toast_2618: vac: 0 (threshold 84), anl: 0 (threshold 67)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [103-1] DEBUG:  pg_toast_18402: vac: 22 (threshold 51), anl: 128 (threshold 50)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [104-1] DEBUG:  CommitTransaction
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [105-1] DEBUG:  name: unnamed; blockState:       STARTED; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [106-1] DEBUG:  shmem_exit(0): 8 callbacks to make
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [107-1] DEBUG:  proc_exit(0): 2 callbacks to make
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [108-1] DEBUG:  exit(0)
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [109-1] DEBUG:  shmem_exit(-1): 0 callbacks to make
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21037]: [110-1] DEBUG:  proc_exit(-1): 0 callbacks to make
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21006]: [45-1] DEBUG:  reaping dead processes
Sep 17 17:40:09 <local5.debug> mflserver4 postgres[21006]: [46-1] DEBUG:  server process (PID 21037) exited with exit code 0
Sep 17 17:40:13 <local5.debug> mflserver4 postgres[21006]: [47-1] DEBUG:  forked new backend, pid=21038 socket=11
Sep 17 17:40:13 <local5.info> mflserver4 postgres[21038]: [47-1] LOG:  connection received: host=localhost port=16712
Sep 17 17:40:13 <local5.debug> mflserver4 postgres[21038]: [48-1] DEBUG:  postgres child[21038]: starting with (
Sep 17 17:40:13 <local5.debug> mflserver4 postgres[21038]: [49-1] DEBUG:   postgres
Sep 17 17:40:13 <local5.debug> mflserver4 postgres[21038]: [50-1] DEBUG:  )
Sep 17 17:40:13 <local5.debug> mflserver4 postgres[21038]: [51-1] DEBUG:  InitPostgres
Sep 17 17:40:13 <local5.debug> mflserver4 postgres[21038]: [52-1] DEBUG:  my backend ID is 2
Sep 17 17:40:13 <local5.debug> mflserver4 postgres[21038]: [53-1] DEBUG:  StartTransaction
Sep 17 17:40:13 <local5.debug> mflserver4 postgres[21038]: [54-1] DEBUG:  name: unnamed; blockState:       DEFAULT; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
Sep 17 17:40:13 <local5.info> mflserver4 postgres[21038]: [55-1] LOG:  connection authorized: user=root database=root
Sep 17 17:40:13 <local5.debug> mflserver4 postgres[21038]: [56-1] DEBUG:  CommitTransaction
Sep 17 17:40:13 <local5.debug> mflserver4 postgres[21038]: [57-1] DEBUG:  name: unnamed; blockState:       STARTED; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
Sep 17 17:40:13 <local5.debug> mflserver4 postgres[21038]: [58-1] DEBUG:  shmem_exit(0): 7 callbacks to make
Sep 17 17:40:13 <local5.debug> mflserver4 postgres[21038]: [59-1] DEBUG:  proc_exit(0): 4 callbacks to make
Sep 17 17:40:13 <local5.info> mflserver4 postgres[21038]: [60-1] LOG:  disconnection: session time: 0:00:00.002 user=root database=root host=localhost port=16712
Sep 17 17:40:13 <local5.debug> mflserver4 postgres[21038]: [61-1] DEBUG:  exit(0)
Sep 17 17:40:13 <local5.debug> mflserver4 postgres[21006]: [48-1] DEBUG:  forked new backend, pid=21039 socket=11
Sep 17 17:40:13 <local5.debug> mflserver4 postgres[21038]: [62-1] DEBUG:  shmem_exit(-1): 0 callbacks to make
Sep 17 17:40:13 <local5.debug> mflserver4 postgres[21038]: [63-1] DEBUG:  proc_exit(-1): 0 callbacks to make
Sep 17 17:40:13 <local5.info> mflserver4 postgres[21039]: [48-1] LOG:  connection received: host=[local]
Sep 17 17:40:13 <local5.debug> mflserver4 postgres[21039]: [49-1] DEBUG:  postgres child[21039]: starting with (
Sep 17 17:40:13 <local5.debug> mflserver4 postgres[21039]: [50-1] DEBUG:   postgres
Sep 17 17:40:13 <local5.debug> mflserver4 postgres[21039]: [51-1] DEBUG:  )
Sep 17 17:40:13 <local5.debug> mflserver4 postgres[21006]: [49-1] DEBUG:  reaping dead processes
Sep 17 17:40:13 <local5.debug> mflserver4 postgres[21039]: [52-1] DEBUG:  InitPostgres
Sep 17 17:40:13 <local5.debug> mflserver4 postgres[21039]: [53-1] DEBUG:  my backend ID is 2
Sep 17 17:40:13 <local5.debug> mflserver4 postgres[21006]: [50-1] DEBUG:  server process (PID 21038) exited with exit code 0
Sep 17 17:40:13 <local5.debug> mflserver4 postgres[21039]: [54-1] DEBUG:  StartTransaction
Sep 17 17:40:13 <local5.debug> mflserver4 postgres[21039]: [55-1] DEBUG:  name: unnamed; blockState:       DEFAULT; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
Sep 17 17:40:13 <local5.info> mflserver4 postgres[21039]: [56-1] LOG:  connection authorized: user=root database=root
Sep 17 17:40:13 <local5.debug> mflserver4 postgres[21039]: [57-1] DEBUG:  CommitTransaction
Sep 17 17:40:13 <local5.debug> mflserver4 postgres[21039]: [58-1] DEBUG:  name: unnamed; blockState:       STARTED; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
Sep 17 17:40:23 <local5.debug> mflserver4 postgres[21012]: [42-1] DEBUG:  StartTransaction
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21012]: [43-1] DEBUG:  name: unnamed; blockState:       DEFAULT; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
Sep 17 17:40:13 <local5.info> mflserver4 postgres[21039]: [59-1] LOG:  could not send data to client: Broken pipe
Sep 17 17:40:26 <local5.err> mflserver4 postgres[21039]: [60-1] FATAL:  connection to client lost
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21012]: [44-1] DEBUG:  CommitTransaction
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21039]: [61-1] DEBUG:  shmem_exit(1): 7 callbacks to make
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21039]: [62-1] DEBUG:  proc_exit(1): 4 callbacks to make
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21012]: [45-1] DEBUG:  name: unnamed; blockState:       STARTED; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
Sep 17 17:40:26 <local5.info> mflserver4 postgres[21039]: [63-1] LOG:  disconnection: session time: 0:00:12.618 user=root database=root host=[local]
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21039]: [64-1] DEBUG:  exit(1)
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21039]: [65-1] DEBUG:  shmem_exit(-1): 0 callbacks to make
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21039]: [66-1] DEBUG:  proc_exit(-1): 0 callbacks to make
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21006]: [51-1] DEBUG:  reaping dead processes
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21006]: [52-1] DEBUG:  server process (PID 21039) exited with exit code 1
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21043]: [53-1] DEBUG:  InitPostgres
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21043]: [54-1] DEBUG:  my backend ID is 2
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21043]: [55-1] DEBUG:  StartTransaction
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21043]: [56-1] DEBUG:  name: unnamed; blockState:       DEFAULT; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21043]: [57-1] DEBUG:  CommitTransaction
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21043]: [58-1] DEBUG:  name: unnamed; blockState:       STARTED; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21043]: [59-1] DEBUG:  autovacuum: processing database "postgres"
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21043]: [60-1] DEBUG:  StartTransaction
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21043]: [61-1] DEBUG:  name: unnamed; blockState:       DEFAULT; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21043]: [62-1] DEBUG:  pg_statistic: vac: 0 (threshold 127), anl: 0 (threshold 88)
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21043]: [63-1] DEBUG:  pg_type: vac: 0 (threshold 116), anl: 0 (threshold 83)
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21043]: [64-1] DEBUG:  pg_authid: vac: 0 (threshold 50), anl: 1 (threshold 50)
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21043]: [65-1] DEBUG:  pg_proc: vac: 0 (threshold 548), anl: 0 (threshold 299)
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21043]: [66-1] DEBUG:  pg_class: vac: 0 (threshold 108), anl: 0 (threshold 79)
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21043]: [67-1] DEBUG:  pg_attribute: vac: 0 (threshold 499), anl: 0 (threshold 275)
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21043]: [68-1] DEBUG:  pg_operator: vac: 0 (threshold 196), anl: 0 (threshold 123)
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21043]: [69-1] DEBUG:  pg_opclass: vac: 0 (threshold 74), anl: 0 (threshold 62)
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21043]: [70-1] DEBUG:  pg_am: vac: 0 (threshold 51), anl: 0 (threshold 50)
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21043]: [71-1] DEBUG:  pg_amop: vac: 0 (threshold 129), anl: 0 (threshold 89)
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21043]: [72-1] DEBUG:  pg_amproc: vac: 0 (threshold 107), anl: 0 (threshold 79)
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21043]: [73-1] DEBUG:  pg_database: vac: 1 (threshold 50), anl: 3 (threshold 50)
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21043]: [74-1] DEBUG:  pg_namespace: vac: 0 (threshold 51), anl: 0 (threshold 51)
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21043]: [75-1] DEBUG:  pg_db_role_setting: vac: 0 (threshold 50), anl: 0 (threshold 50)
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21043]: [76-1] DEBUG:  pg_tablespace: vac: 0 (threshold 50), anl: 0 (threshold 50)
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21043]: [77-1] DEBUG:  pg_shdepend: vac: 0 (threshold 50), anl: 0 (threshold 50)
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21043]: [78-1] DEBUG:  pg_index: vac: 0 (threshold 72), anl: 0 (threshold 61)
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21043]: [79-1] DEBUG:  pg_cast: vac: 0 (threshold 89), anl: 0 (threshold 70)
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21043]: [80-1] DEBUG:  pg_toast_2619: vac: 0 (threshold 52), anl: 0 (threshold 51)
Sep 17 17:40:26 <local5.debug> mflserver4 postgres[21043]: [81-1] DEBUG:  CommitTransaction

Regards,
Jon

Jayadevan M <maymala.jayadevan@gmail.com> wrote:

> You have lines in the output which say

> "Sep 17 17:39:43 <local5.info> mflserver4 postgres[21022]: [39-1] LOG:  connection authorized: user=root
database=root"
> In case you are not doing it manually, do you have some cron job
> that is expected to backup the database or vacuum the database,
> and it is trying to connect to the database as root user, to
> database root?

... keeping in mind that many utilities will default user ID and
database name to the OS user if not specified on the command line.

Also, pg_ctl will attempt to connect to the database on a start or
restart to confirm that it is running.

--
Kevin Grittner
EDB: http://www.enterprisedb.com
The Enterprise PostgreSQL Company


Re: Several problems with installation on FreeBSD - how to reinstall without loosing data

From
Jon Theil Nielsen
Date:
2013/9/18 Kevin Grittner <kgrittn@ymail.com>
Jayadevan M <maymala.jayadevan@gmail.com> wrote:

> You have lines in the output which say

> "Sep 17 17:39:43 <local5.info> mflserver4 postgres[21022]: [39-1] LOG:  connection authorized: user=root database=root"
> In case you are not doing it manually, do you have some cron job
> that is expected to backup the database or vacuum the database,
> and it is trying to connect to the database as root user, to
> database root?

... keeping in mind that many utilities will default user ID and
database name to the OS user if not specified on the command line.

Also, pg_ctl will attempt to connect to the database on a start or
restart to confirm that it is running.

--
Kevin Grittner
EDB: http://www.enterprisedb.com
The Enterprise PostgreSQL Company

Once again: Thanks for the proposals.

I am not quite sure if files in /usr/local/etc/periodic/ are run, but I guess so. The command grep -ir sql . in this directory shows:

./daily/502.pgsql:# $FreeBSD: /tmp/pcvs/ports/databases/postgresql92-server/files/502.pgsql.in,v 1.4 2011-10-18 09:03:32 girgen Exp $
./daily/502.pgsql:# daily_pgsql_backup_enable="YES" # do backup of all databases
./daily/502.pgsql:# daily_pgsql_backup_enable="foo bar db1 db2" # only do backup of a limited selection of databases
./daily/502.pgsql:# daily_pgsql_vacuum_enable="YES" # do vacuum
./daily/502.pgsql:daily_pgsql_user=pgsql
./daily/502.pgsql:daily_pgsql_vacuum_args="-U ${daily_pgsql_user} -qaz"
./daily/502.pgsql:daily_pgsql_pgdump_args="-U ${daily_pgsql_user} -bF c"
./daily/502.pgsql:daily_pgsql_pgdumpall_globals_args="-U ${daily_pgsql_user}"
./daily/502.pgsql:# backupdir is relative to ~pgsql home directory unless it begins with a slash:
./daily/502.pgsql:daily_pgsql_backupdir="~${daily_pgsql_user}/backups"
./daily/502.pgsql:daily_pgsql_savedays="7"
./daily/502.pgsql:eval backupdir=${daily_pgsql_backupdir}
./daily/502.pgsql:pgsql_backup() {
./daily/502.pgsql:      # daily_pgsql_backupdir must be writeable by user pgsql
./daily/502.pgsql:      # ~pgsql is just that under normal circumstances,
./daily/502.pgsql:          mkdir -m 700 ${backupdir}; chown ${daily_pgsql_user} ${backupdir}
./daily/502.pgsql:      echo "PostgreSQL backups"
./daily/502.pgsql:      file=${daily_pgsql_backupdir}/pgglobals_${now}
./daily/502.pgsql:      su -l ${daily_pgsql_user} -c \
./daily/502.pgsql:              "umask 077; pg_dumpall -g ${daily_pgsql_pgdumpall_globals_args} | gzip -9 > ${file}.gz"
./daily/502.pgsql:          su -l ${daily_pgsql_user} -c "umask 077; pg_dump ${daily_pgsql_pgdump_args} -f ${file} ${db}"
./daily/502.pgsql:          -a -mtime +${daily_pgsql_savedays} -delete
./daily/502.pgsql:case "$daily_pgsql_backup_enable" in
./daily/502.pgsql:      dbnames=`su -l pgsql -c "umask 077; psql -q -t -A -d template1 -U pgsql -c SELECT\ datname\ FROM\ pg_database\ WHERE\ datname!=\'template0\'"`
./daily/502.pgsql:      pgsql_backup $dbnames
./daily/502.pgsql:      pgsql_backup $daily_pgsql_backup_enable
./daily/502.pgsql:case "$daily_pgsql_vacuum_enable" in
./daily/502.pgsql:      echo "PostgreSQL vacuum"
./daily/502.pgsql:      su -l ${daily_pgsql_user} -c "vacuumdb ${daily_pgsql_vacuum_args}"

Seems pretty harmless to me. And in any case, it only runs once daily.

I am pretty sure I have to make a fresh install and import the important databases from dump files. At least, that would show if it is the database configuration or something outside the database server that creates the errors. I am not happy to do it, but I think I have to...

Regards
Jon
On Wed, Sep 18, 2013 at 11:12 AM, Jon Theil Nielsen <jontheil@gmail.com> wrote:

> I am not quite sure if files in /usr/local/etc/periodic/ are run, but I
> guess so. The command grep -ir sql . in this directory shows:


 Have you checked the root crontab? Periodic scripts are supposed to
 work out of the box, so I don't believe the problem is there.

 Luca


Re: Several problems with installation on FreeBSD - how to reinstall without loosing data

From
Jon Theil Nielsen
Date:

On Wed, Sep 18, 2013 at 11:12 AM, Jon Theil Nielsen <jontheil@gmail.com> wrote:

> I am not quite sure if files in /usr/local/etc/periodic/ are run, but I
> guess so. The command grep -ir sql . in this directory shows:


 Have you checked the root crontab? Periodic scripts are supposed to
 work out of the box, so I don't believe the problem is there.

 Luca
I believe it does not run (from periodic.conf). 
I made a full backup of all databases and one extra copy of the most crucial one - by pg_dump.
Then I deleted the data directory and made a fresh install of PostgreSQL 9.3.
I will try to figure out the right configuration and restore at least the single database.
If this turns out to give problems, I might start a new thread here or at the other friends at FreeBSD. 
Thank you so far.

Regards
Jon 


--
Jon Theil Nielsen
Ægirsgade 12 2 th
2200  København N
Mobil 22 27 07 20 · Fastnet 35 83 05 01