Обсуждение: [ADMIN] Repeating autovacuum
Hello, I have a PostgreSQL 9.6.2 running on Windows 10 EnterpriseDB binaries. This is a software development desktop computer having i7 entry level CPU and Sandisk Extreme SSD and 8GB RAM. While trying to figure some login related stuff, I realize that autovacuum is repeating non-stop. Below is about 15-20 minute debug2 level log entries after restarting the server. I have 2 databases which have only table definitions in them. Only one of them named "tracker" have about 15 records in it. Basically they are empty. Memory related parameters in my config file are not modified, just removed remarks on below items: shared_buffers = 128M work_mem = 4MB maintenance_work_mem = 64MB autovacuum_work_mem = -1 No autovacuum parameters are changed or used. They are all remarked as in default config file. I wonder if that is a normal behavior as system is idle. ----- LOG: database system was shut down at 2017-04-08 01:04:50 +03 DEBUG: checkpoint record is at 0/17662D8 DEBUG: redo record is at 0/17662D8; shutdown TRUE DEBUG: next transaction ID: 0:697; next OID: 16888 DEBUG: next MultiXactId: 1; next MultiXactOffset: 0 DEBUG: oldest unfrozen transaction ID: 536, in database 12401 DEBUG: oldest MultiXactId: 1, in database 16526 DEBUG: commit timestamp Xid oldest/newest: 0/0 DEBUG: transaction ID wrap limit is 2147484183, limited by database with OID 12401 DEBUG: MultiXactId wrap limit is 2147483648, limited by database with OID 16526 DEBUG: starting up replication slots DEBUG: MultiXactId wrap limit is 2147483648, limited by database with OID 16526 LOG: MultiXact member wraparound protections are now enabled DEBUG: MultiXact member stop limit is now 4294914944 based on MultiXact 1 LOG: database system is ready to accept connections DEBUG: checkpointer updated shared memory configuration values LOG: autovacuum launcher started DEBUG: removing permanent stats file "pg_stat/db_12401.stat" DEBUG: removing permanent stats file "pg_stat/db_1.stat" DEBUG: removing permanent stats file "pg_stat/db_16526.stat" DEBUG: removing permanent stats file "pg_stat/db_16461.stat" DEBUG: removing permanent stats file "pg_stat/db_0.stat" DEBUG: removing permanent stats file "pg_stat/global.stat" DEBUG: received inquiry for database 0 DEBUG: writing stats file "pg_stat_tmp/global.stat" DEBUG: writing stats file "pg_stat_tmp/db_0.stat" DEBUG: forked new backend, pid=8716 socket=5016 LOG: connection received: host=::1 port=60268 LOG: connection authorized: user=DESKTOP-L63HSP2$ database=postgres DEBUG: server process (PID 8716) exited with exit code 0 DEBUG: received inquiry for database 0 DEBUG: writing stats file "pg_stat_tmp/global.stat" DEBUG: writing stats file "pg_stat_tmp/db_0.stat" DEBUG: autovacuum: processing database "tracker" DEBUG: received inquiry for database 16526 DEBUG: writing stats file "pg_stat_tmp/global.stat" DEBUG: writing stats file "pg_stat_tmp/db_16526.stat" DEBUG: writing stats file "pg_stat_tmp/db_0.stat" DEBUG: server process (PID 14664) exited with exit code 0 DEBUG: received inquiry for database 0 DEBUG: writing stats file "pg_stat_tmp/global.stat" DEBUG: writing stats file "pg_stat_tmp/db_0.stat" DEBUG: autovacuum: processing database "spanc" DEBUG: received inquiry for database 16461 DEBUG: writing stats file "pg_stat_tmp/global.stat" DEBUG: writing stats file "pg_stat_tmp/db_16461.stat" DEBUG: writing stats file "pg_stat_tmp/db_0.stat" DEBUG: server process (PID 16176) exited with exit code 0 DEBUG: received inquiry for database 0 DEBUG: writing stats file "pg_stat_tmp/global.stat" DEBUG: writing stats file "pg_stat_tmp/db_0.stat" DEBUG: autovacuum: processing database "template1" DEBUG: received inquiry for database 1 DEBUG: writing stats file "pg_stat_tmp/global.stat" DEBUG: writing stats file "pg_stat_tmp/db_1.stat" DEBUG: writing stats file "pg_stat_tmp/db_0.stat" DEBUG: server process (PID 16220) exited with exit code 0 DEBUG: received inquiry for database 0 DEBUG: writing stats file "pg_stat_tmp/global.stat" DEBUG: writing stats file "pg_stat_tmp/db_0.stat" DEBUG: autovacuum: processing database "postgres" DEBUG: received inquiry for database 12401 DEBUG: writing stats file "pg_stat_tmp/global.stat" DEBUG: writing stats file "pg_stat_tmp/db_12401.stat" DEBUG: writing stats file "pg_stat_tmp/db_0.stat" DEBUG: server process (PID 8568) exited with exit code 0 DEBUG: received inquiry for database 0 DEBUG: writing stats file "pg_stat_tmp/global.stat" DEBUG: writing stats file "pg_stat_tmp/db_0.stat" DEBUG: autovacuum: processing database "tracker" DEBUG: received inquiry for database 16526 DEBUG: writing stats file "pg_stat_tmp/global.stat" DEBUG: writing stats file "pg_stat_tmp/db_16526.stat" DEBUG: writing stats file "pg_stat_tmp/db_0.stat" DEBUG: server process (PID 16156) exited with exit code 0 DEBUG: received inquiry for database 0 DEBUG: writing stats file "pg_stat_tmp/global.stat" DEBUG: writing stats file "pg_stat_tmp/db_0.stat" DEBUG: autovacuum: processing database "spanc" DEBUG: received inquiry for database 16461 DEBUG: writing stats file "pg_stat_tmp/global.stat" DEBUG: writing stats file "pg_stat_tmp/db_16461.stat" DEBUG: writing stats file "pg_stat_tmp/db_0.stat" DEBUG: server process (PID 14892) exited with exit code 0 DEBUG: received inquiry for database 0 DEBUG: writing stats file "pg_stat_tmp/global.stat" DEBUG: writing stats file "pg_stat_tmp/db_0.stat" DEBUG: autovacuum: processing database "template1" DEBUG: received inquiry for database 1 DEBUG: writing stats file "pg_stat_tmp/global.stat" DEBUG: writing stats file "pg_stat_tmp/db_1.stat" DEBUG: writing stats file "pg_stat_tmp/db_0.stat" DEBUG: server process (PID 17756) exited with exit code 0 DEBUG: received inquiry for database 0 DEBUG: writing stats file "pg_stat_tmp/global.stat" DEBUG: writing stats file "pg_stat_tmp/db_0.stat" DEBUG: autovacuum: processing database "postgres" DEBUG: received inquiry for database 12401 DEBUG: writing stats file "pg_stat_tmp/global.stat" DEBUG: writing stats file "pg_stat_tmp/db_12401.stat" DEBUG: writing stats file "pg_stat_tmp/db_0.stat" DEBUG: server process (PID 18316) exited with exit code 0 DEBUG: received inquiry for database 0 DEBUG: writing stats file "pg_stat_tmp/global.stat" DEBUG: writing stats file "pg_stat_tmp/db_0.stat" DEBUG: autovacuum: processing database "tracker" DEBUG: received inquiry for database 16526 DEBUG: writing stats file "pg_stat_tmp/global.stat" DEBUG: writing stats file "pg_stat_tmp/db_16526.stat" DEBUG: writing stats file "pg_stat_tmp/db_0.stat" DEBUG: server process (PID 14204) exited with exit code 0 DEBUG: received inquiry for database 0 DEBUG: writing stats file "pg_stat_tmp/global.stat" DEBUG: writing stats file "pg_stat_tmp/db_0.stat" DEBUG: autovacuum: processing database "spanc" DEBUG: received inquiry for database 16461 DEBUG: writing stats file "pg_stat_tmp/global.stat" DEBUG: writing stats file "pg_stat_tmp/db_16461.stat" DEBUG: writing stats file "pg_stat_tmp/db_0.stat" DEBUG: server process (PID 5668) exited with exit code 0 DEBUG: received inquiry for database 0 DEBUG: writing stats file "pg_stat_tmp/global.stat" DEBUG: writing stats file "pg_stat_tmp/db_0.stat" DEBUG: autovacuum: processing database "template1" DEBUG: received inquiry for database 1 DEBUG: writing stats file "pg_stat_tmp/global.stat" DEBUG: writing stats file "pg_stat_tmp/db_1.stat" DEBUG: writing stats file "pg_stat_tmp/db_0.stat" DEBUG: server process (PID 15884) exited with exit code 0 DEBUG: received inquiry for database 0 DEBUG: writing stats file "pg_stat_tmp/global.stat" DEBUG: writing stats file "pg_stat_tmp/db_0.stat" DEBUG: autovacuum: processing database "postgres" DEBUG: received inquiry for database 12401 DEBUG: writing stats file "pg_stat_tmp/global.stat" DEBUG: writing stats file "pg_stat_tmp/db_12401.stat" DEBUG: writing stats file "pg_stat_tmp/db_0.stat" DEBUG: server process (PID 5188) exited with exit code 0 -----
No autovacuum parameters are changed or used. They are all remarked as in
default config file.
I wonder if that is a normal behavior as system is idle.
See "autovacuum_naptime (integer)"
Its "auto" vacuum which means it runs (nearly) continuously looking for things to do.
I suppose that in theory it could operate in a kind of "wait/notify" mode where every DDL against the database wakes the daemon otherwise it stays asleep. I recall some work being done a number of years back on making the system more energy efficient during no-activity periods - but there are trade-offs to consider here for which I am not up-to-speed on the specifics.
It would be interesting to see the timestamps on those log entries...
David J.
I don't see any timestamp in the log. I myself wanted that, too. Do I need to turn some switch on?No autovacuum parameters are changed or used. They are all remarked as in
default config file.
I wonder if that is a normal behavior as system is idle.See "autovacuum_naptime (integer)"Its "auto" vacuum which means it runs (nearly) continuously looking for things to do.I suppose that in theory it could operate in a kind of "wait/notify" mode where every DDL against the database wakes the daemon otherwise it stays asleep. I recall some work being done a number of years back on making the system more energy efficient during no-activity periods - but there are trade-offs to consider here for which I am not up-to-speed on the specifics.It would be interesting to see the timestamps on those log entries...David J.
Ertan Küçükoğlu
On Fri, Apr 7, 2017 at 7:33 PM, Ertan Küçükoğlu <ertan.kucukoglu@1nar.com.tr> wrote:
I don't see any timestamp in the log. I myself wanted that, too. Do I need to turn some switch on?No autovacuum parameters are changed or used. They are all remarked as in
default config file.
I wonder if that is a normal behavior as system is idle.See "autovacuum_naptime (integer)"Its "auto" vacuum which means it runs (nearly) continuously looking for things to do.I suppose that in theory it could operate in a kind of "wait/notify" mode where every DDL against the database wakes the daemon otherwise it stays asleep. I recall some work being done a number of years back on making the system more energy efficient during no-activity periods - but there are trade-offs to consider here for which I am not up-to-speed on the specifics.It would be interesting to see the timestamps on those log entries...David J.Ertan Küçükoğlu
Look at log_line_prefix for postgresql.conf. There's a whole set of macros you can use to add logging information, including timestamps.
https://www.postgresql.org/docs/9.6/static/runtime-config-logging.html#GUC-LOG-LINE-PREFIX
https://www.postgresql.org/docs/9.6/static/runtime-config-logging.html#GUC-LOG-LINE-PREFIX
Keith
> From: pgsql-admin-owner@postgresql.org [mailto:pgsql-admin-owner@postgresql.org] On Behalf Of David G. Johnston > Sent: Saturday, April 8, 2017 1:53 AM > To: Ertan Küçükoğlu <ertan.kucukoglu@1nar.com.tr> > Cc: pgsql-admin@postgresql.org > Subject: Re: [ADMIN] Repeating autovacuum > > > It would be interesting to see the timestamps on those log entries... > > David J. Below is a cropped log with timestamps ----- 2017-04-08 15:52:34 +03LOG: database system was shut down at 2017-04-08 15:52:32 +03 2017-04-08 15:52:34 +03DEBUG: checkpoint record is at 0/176E540 2017-04-08 15:52:34 +03DEBUG: redo record is at 0/176E540; shutdown TRUE 2017-04-08 15:52:34 +03DEBUG: next transaction ID: 0:702; next OID: 16888 2017-04-08 15:52:34 +03DEBUG: next MultiXactId: 1; next MultiXactOffset: 0 2017-04-08 15:52:34 +03DEBUG: oldest unfrozen transaction ID: 536, in database 12401 2017-04-08 15:52:34 +03DEBUG: oldest MultiXactId: 1, in database 16526 2017-04-08 15:52:34 +03DEBUG: commit timestamp Xid oldest/newest: 0/0 2017-04-08 15:52:34 +03DEBUG: transaction ID wrap limit is 2147484183, limited by database with OID 12401 2017-04-08 15:52:34 +03DEBUG: MultiXactId wrap limit is 2147483648, limited by database with OID 16526 2017-04-08 15:52:34 +03DEBUG: starting up replication slots 2017-04-08 15:52:34 +03DEBUG: MultiXactId wrap limit is 2147483648, limited by database with OID 16526 2017-04-08 15:52:34 +03LOG: MultiXact member wraparound protections are now enabled 2017-04-08 15:52:34 +03DEBUG: MultiXact member stop limit is now 4294914944 based on MultiXact 1 2017-04-08 15:52:34 +03LOG: database system is ready to accept connections 2017-04-08 15:52:34 +03DEBUG: checkpointer updated shared memory configuration values 2017-04-08 15:52:34 +03LOG: autovacuum launcher started 2017-04-08 15:52:34 +03DEBUG: removing permanent stats file "pg_stat/db_12401.stat" 2017-04-08 15:52:34 +03DEBUG: removing permanent stats file "pg_stat/db_1.stat" 2017-04-08 15:52:34 +03DEBUG: removing permanent stats file "pg_stat/db_16526.stat" 2017-04-08 15:52:34 +03DEBUG: removing permanent stats file "pg_stat/db_16461.stat" 2017-04-08 15:52:34 +03DEBUG: removing permanent stats file "pg_stat/db_0.stat" 2017-04-08 15:52:34 +03DEBUG: removing permanent stats file "pg_stat/global.stat" 2017-04-08 15:52:34 +03DEBUG: received inquiry for database 0 2017-04-08 15:52:34 +03DEBUG: writing stats file "pg_stat_tmp/global.stat" 2017-04-08 15:52:34 +03DEBUG: writing stats file "pg_stat_tmp/db_0.stat" 2017-04-08 15:52:34 +03DEBUG: forked new backend, pid=7048 socket=5072 2017-04-08 15:52:34 +03LOG: connection received: host=::1 port=58851 2017-04-08 15:52:34 +03LOG: connection authorized: user=DESKTOP-L63HSP2$ database=postgres 2017-04-08 15:52:35 +03DEBUG: server process (PID 7048) exited with exit code 0 2017-04-08 15:52:49 +03DEBUG: received inquiry for database 0 2017-04-08 15:52:49 +03DEBUG: writing stats file "pg_stat_tmp/global.stat" 2017-04-08 15:52:49 +03DEBUG: writing stats file "pg_stat_tmp/db_0.stat" 2017-04-08 15:52:49 +03DEBUG: autovacuum: processing database "tracker" 2017-04-08 15:52:49 +03DEBUG: received inquiry for database 16526 2017-04-08 15:52:49 +03DEBUG: writing stats file "pg_stat_tmp/global.stat" 2017-04-08 15:52:49 +03DEBUG: writing stats file "pg_stat_tmp/db_16526.stat" 2017-04-08 15:52:49 +03DEBUG: writing stats file "pg_stat_tmp/db_0.stat" 2017-04-08 15:52:49 +03DEBUG: server process (PID 2724) exited with exit code 0 2017-04-08 15:53:04 +03DEBUG: received inquiry for database 0 2017-04-08 15:53:04 +03DEBUG: writing stats file "pg_stat_tmp/global.stat" 2017-04-08 15:53:04 +03DEBUG: writing stats file "pg_stat_tmp/db_0.stat" 2017-04-08 15:53:04 +03DEBUG: autovacuum: processing database "spanc" 2017-04-08 15:53:04 +03DEBUG: received inquiry for database 16461 2017-04-08 15:53:04 +03DEBUG: writing stats file "pg_stat_tmp/global.stat" 2017-04-08 15:53:04 +03DEBUG: writing stats file "pg_stat_tmp/db_16461.stat" 2017-04-08 15:53:04 +03DEBUG: writing stats file "pg_stat_tmp/db_0.stat" 2017-04-08 15:53:04 +03DEBUG: server process (PID 18440) exited with exit code 0 2017-04-08 15:53:19 +03DEBUG: received inquiry for database 0 2017-04-08 15:53:19 +03DEBUG: writing stats file "pg_stat_tmp/global.stat" 2017-04-08 15:53:19 +03DEBUG: writing stats file "pg_stat_tmp/db_0.stat" 2017-04-08 15:53:19 +03DEBUG: autovacuum: processing database "template1" 2017-04-08 15:53:19 +03DEBUG: received inquiry for database 1 2017-04-08 15:53:19 +03DEBUG: writing stats file "pg_stat_tmp/global.stat" 2017-04-08 15:53:19 +03DEBUG: writing stats file "pg_stat_tmp/db_1.stat" 2017-04-08 15:53:19 +03DEBUG: writing stats file "pg_stat_tmp/db_0.stat" 2017-04-08 15:53:19 +03DEBUG: server process (PID 12944) exited with exit code 0 2017-04-08 15:53:34 +03DEBUG: received inquiry for database 0 2017-04-08 15:53:34 +03DEBUG: writing stats file "pg_stat_tmp/global.stat" 2017-04-08 15:53:34 +03DEBUG: writing stats file "pg_stat_tmp/db_0.stat" 2017-04-08 15:53:34 +03DEBUG: autovacuum: processing database "postgres" 2017-04-08 15:53:34 +03DEBUG: received inquiry for database 12401 2017-04-08 15:53:34 +03DEBUG: writing stats file "pg_stat_tmp/global.stat" 2017-04-08 15:53:34 +03DEBUG: writing stats file "pg_stat_tmp/db_12401.stat" 2017-04-08 15:53:34 +03DEBUG: writing stats file "pg_stat_tmp/db_0.stat" 2017-04-08 15:53:34 +03DEBUG: server process (PID 18672) exited with exit code 0 2017-04-08 15:53:49 +03DEBUG: received inquiry for database 0 2017-04-08 15:53:49 +03DEBUG: writing stats file "pg_stat_tmp/global.stat" 2017-04-08 15:53:49 +03DEBUG: writing stats file "pg_stat_tmp/db_0.stat" 2017-04-08 15:53:49 +03DEBUG: autovacuum: processing database "tracker" 2017-04-08 15:53:49 +03DEBUG: received inquiry for database 16526 2017-04-08 15:53:49 +03DEBUG: writing stats file "pg_stat_tmp/global.stat" 2017-04-08 15:53:49 +03DEBUG: writing stats file "pg_stat_tmp/db_16526.stat" 2017-04-08 15:53:49 +03DEBUG: writing stats file "pg_stat_tmp/db_0.stat" 2017-04-08 15:53:49 +03DEBUG: server process (PID 8352) exited with exit code 0 2017-04-08 15:54:04 +03DEBUG: received inquiry for database 0 2017-04-08 15:54:04 +03DEBUG: writing stats file "pg_stat_tmp/global.stat" 2017-04-08 15:54:04 +03DEBUG: writing stats file "pg_stat_tmp/db_0.stat" 2017-04-08 15:54:04 +03DEBUG: autovacuum: processing database "spanc" 2017-04-08 15:54:04 +03DEBUG: received inquiry for database 16461 2017-04-08 15:54:04 +03DEBUG: writing stats file "pg_stat_tmp/global.stat" 2017-04-08 15:54:04 +03DEBUG: writing stats file "pg_stat_tmp/db_16461.stat" 2017-04-08 15:54:04 +03DEBUG: writing stats file "pg_stat_tmp/db_0.stat" 2017-04-08 15:54:04 +03DEBUG: server process (PID 18548) exited with exit code 0 2017-04-08 15:54:19 +03DEBUG: received inquiry for database 0 2017-04-08 15:54:19 +03DEBUG: writing stats file "pg_stat_tmp/global.stat" 2017-04-08 15:54:19 +03DEBUG: writing stats file "pg_stat_tmp/db_0.stat" 2017-04-08 15:54:19 +03DEBUG: autovacuum: processing database "template1" 2017-04-08 15:54:19 +03DEBUG: received inquiry for database 1 2017-04-08 15:54:19 +03DEBUG: writing stats file "pg_stat_tmp/global.stat" 2017-04-08 15:54:19 +03DEBUG: writing stats file "pg_stat_tmp/db_1.stat" 2017-04-08 15:54:19 +03DEBUG: writing stats file "pg_stat_tmp/db_0.stat" 2017-04-08 15:54:19 +03DEBUG: server process (PID 14840) exited with exit code 0 2017-04-08 15:54:34 +03DEBUG: received inquiry for database 0 2017-04-08 15:54:34 +03DEBUG: writing stats file "pg_stat_tmp/global.stat" 2017-04-08 15:54:34 +03DEBUG: writing stats file "pg_stat_tmp/db_0.stat" 2017-04-08 15:54:34 +03DEBUG: autovacuum: processing database "postgres" 2017-04-08 15:54:34 +03DEBUG: received inquiry for database 12401 2017-04-08 15:54:34 +03DEBUG: writing stats file "pg_stat_tmp/global.stat" 2017-04-08 15:54:34 +03DEBUG: writing stats file "pg_stat_tmp/db_12401.stat" 2017-04-08 15:54:34 +03DEBUG: writing stats file "pg_stat_tmp/db_0.stat" 2017-04-08 15:54:34 +03DEBUG: server process (PID 19172) exited with exit code 0 2017-04-08 15:54:44 +03DEBUG: forked new backend, pid=19448 socket=5024 2017-04-08 15:54:44 +03LOG: connection received: host=::1 port=58984 2017-04-08 15:54:44 +03LOG: connection authorized: user=postgres database=tracker 2017-04-08 15:54:49 +03DEBUG: received inquiry for database 0 2017-04-08 15:54:49 +03DEBUG: writing stats file "pg_stat_tmp/global.stat" 2017-04-08 15:54:49 +03DEBUG: writing stats file "pg_stat_tmp/db_0.stat" 2017-04-08 15:54:49 +03DEBUG: autovacuum: processing database "tracker" 2017-04-08 15:54:49 +03DEBUG: received inquiry for database 16526 2017-04-08 15:54:49 +03DEBUG: writing stats file "pg_stat_tmp/global.stat" 2017-04-08 15:54:49 +03DEBUG: writing stats file "pg_stat_tmp/db_16526.stat" 2017-04-08 15:54:49 +03DEBUG: writing stats file "pg_stat_tmp/db_0.stat" 2017-04-08 15:54:49 +03DEBUG: server process (PID 12448) exited with exit code 0 2017-04-08 15:54:54 +03DEBUG: forked new backend, pid=18744 socket=5032 2017-04-08 15:54:54 +03LOG: connection received: host=::1 port=58994 2017-04-08 15:54:54 +03LOG: connection authorized: user=postgres database=tracker 2017-04-08 15:55:04 +03DEBUG: received inquiry for database 0 2017-04-08 15:55:04 +03DEBUG: writing stats file "pg_stat_tmp/global.stat" 2017-04-08 15:55:04 +03DEBUG: writing stats file "pg_stat_tmp/db_0.stat" 2017-04-08 15:55:04 +03DEBUG: autovacuum: processing database "spanc" 2017-04-08 15:55:04 +03DEBUG: received inquiry for database 16461 2017-04-08 15:55:04 +03DEBUG: writing stats file "pg_stat_tmp/global.stat" 2017-04-08 15:55:04 +03DEBUG: writing stats file "pg_stat_tmp/db_16461.stat" 2017-04-08 15:55:04 +03DEBUG: writing stats file "pg_stat_tmp/db_0.stat" 2017-04-08 15:55:04 +03DEBUG: server process (PID 4500) exited with exit code 0 2017-04-08 15:55:19 +03DEBUG: received inquiry for database 0 2017-04-08 15:55:19 +03DEBUG: writing stats file "pg_stat_tmp/global.stat" 2017-04-08 15:55:19 +03DEBUG: writing stats file "pg_stat_tmp/db_0.stat" 2017-04-08 15:55:19 +03DEBUG: autovacuum: processing database "template1" 2017-04-08 15:55:19 +03DEBUG: received inquiry for database 1 2017-04-08 15:55:19 +03DEBUG: writing stats file "pg_stat_tmp/global.stat" 2017-04-08 15:55:19 +03DEBUG: writing stats file "pg_stat_tmp/db_1.stat" 2017-04-08 15:55:19 +03DEBUG: writing stats file "pg_stat_tmp/db_0.stat" 2017-04-08 15:55:19 +03DEBUG: server process (PID 11156) exited with exit code 0 2017-04-08 15:55:19 +03DEBUG: server process (PID 18744) exited with exit code 0 2017-04-08 15:55:27 +03DEBUG: forked new backend, pid=14356 socket=5032 2017-04-08 15:55:27 +03LOG: connection received: host=::1 port=59027 2017-04-08 15:55:27 +03LOG: connection authorized: user=postgres database=tracker 2017-04-08 15:55:34 +03DEBUG: received inquiry for database 0 2017-04-08 15:55:34 +03DEBUG: writing stats file "pg_stat_tmp/global.stat" 2017-04-08 15:55:34 +03DEBUG: writing stats file "pg_stat_tmp/db_0.stat" 2017-04-08 15:55:34 +03DEBUG: autovacuum: processing database "postgres" 2017-04-08 15:55:34 +03DEBUG: received inquiry for database 12401 2017-04-08 15:55:34 +03DEBUG: writing stats file "pg_stat_tmp/global.stat" 2017-04-08 15:55:34 +03DEBUG: writing stats file "pg_stat_tmp/db_12401.stat" 2017-04-08 15:55:34 +03DEBUG: writing stats file "pg_stat_tmp/db_0.stat" 2017-04-08 15:55:34 +03DEBUG: server process (PID 11412) exited with exit code 0 2017-04-08 15:55:49 +03DEBUG: received inquiry for database 0 2017-04-08 15:55:49 +03DEBUG: writing stats file "pg_stat_tmp/global.stat" 2017-04-08 15:55:49 +03DEBUG: writing stats file "pg_stat_tmp/db_0.stat" 2017-04-08 15:55:49 +03DEBUG: autovacuum: processing database "tracker" 2017-04-08 15:55:49 +03DEBUG: received inquiry for database 16526 2017-04-08 15:55:49 +03DEBUG: writing stats file "pg_stat_tmp/global.stat" 2017-04-08 15:55:49 +03DEBUG: writing stats file "pg_stat_tmp/db_16526.stat" 2017-04-08 15:55:49 +03DEBUG: writing stats file "pg_stat_tmp/db_0.stat" 2017-04-08 15:55:49 +03DEBUG: server process (PID 13888) exited with exit code 0 2017-04-08 15:56:04 +03DEBUG: received inquiry for database 0 2017-04-08 15:56:04 +03DEBUG: writing stats file "pg_stat_tmp/global.stat" 2017-04-08 15:56:04 +03DEBUG: writing stats file "pg_stat_tmp/db_0.stat" 2017-04-08 15:56:04 +03DEBUG: autovacuum: processing database "spanc" 2017-04-08 15:56:04 +03DEBUG: received inquiry for database 16461 2017-04-08 15:56:04 +03DEBUG: writing stats file "pg_stat_tmp/global.stat" 2017-04-08 15:56:04 +03DEBUG: writing stats file "pg_stat_tmp/db_16461.stat" 2017-04-08 15:56:04 +03DEBUG: writing stats file "pg_stat_tmp/db_0.stat" 2017-04-08 15:56:04 +03DEBUG: server process (PID 10268) exited with exit code 0 2017-04-08 15:56:19 +03DEBUG: received inquiry for database 0 2017-04-08 15:56:19 +03DEBUG: writing stats file "pg_stat_tmp/global.stat" 2017-04-08 15:56:19 +03DEBUG: writing stats file "pg_stat_tmp/db_0.stat" 2017-04-08 15:56:19 +03DEBUG: autovacuum: processing database "template1" 2017-04-08 15:56:19 +03DEBUG: received inquiry for database 1 2017-04-08 15:56:19 +03DEBUG: writing stats file "pg_stat_tmp/global.stat" 2017-04-08 15:56:19 +03DEBUG: writing stats file "pg_stat_tmp/db_1.stat" 2017-04-08 15:56:19 +03DEBUG: writing stats file "pg_stat_tmp/db_0.stat" 2017-04-08 15:56:19 +03DEBUG: server process (PID 7676) exited with exit code 0 2017-04-08 15:56:34 +03DEBUG: received inquiry for database 0 2017-04-08 15:56:34 +03DEBUG: writing stats file "pg_stat_tmp/global.stat" 2017-04-08 15:56:34 +03DEBUG: writing stats file "pg_stat_tmp/db_0.stat" 2017-04-08 15:56:34 +03DEBUG: autovacuum: processing database "postgres" 2017-04-08 15:56:34 +03DEBUG: received inquiry for database 12401 2017-04-08 15:56:34 +03DEBUG: writing stats file "pg_stat_tmp/global.stat" 2017-04-08 15:56:34 +03DEBUG: writing stats file "pg_stat_tmp/db_12401.stat" 2017-04-08 15:56:34 +03DEBUG: writing stats file "pg_stat_tmp/db_0.stat" 2017-04-08 15:56:34 +03DEBUG: server process (PID 18516) exited with exit code 0 2017-04-08 15:56:49 +03DEBUG: received inquiry for database 0 2017-04-08 15:56:49 +03DEBUG: writing stats file "pg_stat_tmp/global.stat" 2017-04-08 15:56:49 +03DEBUG: writing stats file "pg_stat_tmp/db_0.stat" 2017-04-08 15:56:49 +03DEBUG: autovacuum: processing database "tracker" 2017-04-08 15:56:49 +03DEBUG: received inquiry for database 16526 2017-04-08 15:56:49 +03DEBUG: writing stats file "pg_stat_tmp/global.stat" 2017-04-08 15:56:49 +03DEBUG: writing stats file "pg_stat_tmp/db_16526.stat" 2017-04-08 15:56:49 +03DEBUG: writing stats file "pg_stat_tmp/db_0.stat" 2017-04-08 15:56:49 +03DEBUG: server process (PID 10112) exited with exit code 0 2017-04-08 15:57:04 +03DEBUG: received inquiry for database 0 2017-04-08 15:57:04 +03DEBUG: writing stats file "pg_stat_tmp/global.stat" 2017-04-08 15:57:04 +03DEBUG: writing stats file "pg_stat_tmp/db_0.stat" 2017-04-08 15:57:04 +03DEBUG: autovacuum: processing database "spanc" 2017-04-08 15:57:04 +03DEBUG: received inquiry for database 16461 2017-04-08 15:57:04 +03DEBUG: writing stats file "pg_stat_tmp/global.stat" 2017-04-08 15:57:04 +03DEBUG: writing stats file "pg_stat_tmp/db_16461.stat" 2017-04-08 15:57:04 +03DEBUG: writing stats file "pg_stat_tmp/db_0.stat" 2017-04-08 15:57:04 +03DEBUG: server process (PID 12396) exited with exit code 0 2017-04-08 15:57:19 +03DEBUG: received inquiry for database 0 2017-04-08 15:57:19 +03DEBUG: writing stats file "pg_stat_tmp/global.stat" 2017-04-08 15:57:19 +03DEBUG: writing stats file "pg_stat_tmp/db_0.stat" 2017-04-08 15:57:19 +03DEBUG: autovacuum: processing database "template1" 2017-04-08 15:57:19 +03DEBUG: received inquiry for database 1 2017-04-08 15:57:19 +03DEBUG: writing stats file "pg_stat_tmp/global.stat" 2017-04-08 15:57:19 +03DEBUG: writing stats file "pg_stat_tmp/db_1.stat" 2017-04-08 15:57:19 +03DEBUG: writing stats file "pg_stat_tmp/db_0.stat" 2017-04-08 15:57:19 +03DEBUG: server process (PID 12048) exited with exit code 0 2017-04-08 15:57:34 +03DEBUG: received inquiry for database 0 2017-04-08 15:57:34 +03DEBUG: writing stats file "pg_stat_tmp/global.stat" 2017-04-08 15:57:34 +03DEBUG: writing stats file "pg_stat_tmp/db_0.stat" 2017-04-08 15:57:34 +03DEBUG: autovacuum: processing database "postgres" 2017-04-08 15:57:34 +03DEBUG: received inquiry for database 12401 2017-04-08 15:57:34 +03DEBUG: writing stats file "pg_stat_tmp/global.stat" 2017-04-08 15:57:34 +03DEBUG: writing stats file "pg_stat_tmp/db_12401.stat" 2017-04-08 15:57:34 +03DEBUG: writing stats file "pg_stat_tmp/db_0.stat" 2017-04-08 15:57:34 +03DEBUG: server process (PID 2188) exited with exit code 0 2017-04-08 15:57:49 +03DEBUG: received inquiry for database 0 2017-04-08 15:57:49 +03DEBUG: writing stats file "pg_stat_tmp/global.stat" 2017-04-08 15:57:49 +03DEBUG: writing stats file "pg_stat_tmp/db_0.stat" 2017-04-08 15:57:49 +03DEBUG: autovacuum: processing database "tracker" 2017-04-08 15:57:49 +03DEBUG: received inquiry for database 16526 2017-04-08 15:57:49 +03DEBUG: writing stats file "pg_stat_tmp/global.stat" 2017-04-08 15:57:49 +03DEBUG: writing stats file "pg_stat_tmp/db_16526.stat" 2017-04-08 15:57:49 +03DEBUG: writing stats file "pg_stat_tmp/db_0.stat" 2017-04-08 15:57:49 +03DEBUG: server process (PID 9560) exited with exit code 0 2017-04-08 15:58:04 +03DEBUG: received inquiry for database 0 2017-04-08 15:58:04 +03DEBUG: writing stats file "pg_stat_tmp/global.stat" 2017-04-08 15:58:04 +03DEBUG: writing stats file "pg_stat_tmp/db_0.stat" 2017-04-08 15:58:04 +03DEBUG: autovacuum: processing database "spanc" 2017-04-08 15:58:04 +03DEBUG: received inquiry for database 16461 2017-04-08 15:58:04 +03DEBUG: writing stats file "pg_stat_tmp/global.stat" 2017-04-08 15:58:04 +03DEBUG: writing stats file "pg_stat_tmp/db_16461.stat" 2017-04-08 15:58:04 +03DEBUG: writing stats file "pg_stat_tmp/db_0.stat" 2017-04-08 15:58:04 +03DEBUG: server process (PID 8704) exited with exit code 0 2017-04-08 15:58:19 +03DEBUG: received inquiry for database 0 2017-04-08 15:58:19 +03DEBUG: writing stats file "pg_stat_tmp/global.stat" 2017-04-08 15:58:19 +03DEBUG: writing stats file "pg_stat_tmp/db_0.stat" 2017-04-08 15:58:19 +03DEBUG: autovacuum: processing database "template1" 2017-04-08 15:58:19 +03DEBUG: received inquiry for database 1 2017-04-08 15:58:19 +03DEBUG: writing stats file "pg_stat_tmp/global.stat" 2017-04-08 15:58:19 +03DEBUG: writing stats file "pg_stat_tmp/db_1.stat" 2017-04-08 15:58:19 +03DEBUG: writing stats file "pg_stat_tmp/db_0.stat" 2017-04-08 15:58:19 +03DEBUG: server process (PID 10236) exited with exit code 0 2017-04-08 15:58:34 +03DEBUG: received inquiry for database 0 2017-04-08 15:58:34 +03DEBUG: writing stats file "pg_stat_tmp/global.stat" 2017-04-08 15:58:34 +03DEBUG: writing stats file "pg_stat_tmp/db_0.stat" 2017-04-08 15:58:34 +03DEBUG: autovacuum: processing database "postgres" 2017-04-08 15:58:34 +03DEBUG: received inquiry for database 12401 2017-04-08 15:58:34 +03DEBUG: writing stats file "pg_stat_tmp/global.stat" 2017-04-08 15:58:34 +03DEBUG: writing stats file "pg_stat_tmp/db_12401.stat" 2017-04-08 15:58:34 +03DEBUG: writing stats file "pg_stat_tmp/db_0.stat" 2017-04-08 15:58:34 +03DEBUG: server process (PID 12848) exited with exit code 0 2017-04-08 15:58:49 +03DEBUG: received inquiry for database 0 2017-04-08 15:58:49 +03DEBUG: writing stats file "pg_stat_tmp/global.stat" 2017-04-08 15:58:49 +03DEBUG: writing stats file "pg_stat_tmp/db_0.stat" 2017-04-08 15:58:49 +03DEBUG: autovacuum: processing database "tracker" 2017-04-08 15:58:49 +03DEBUG: received inquiry for database 16526 2017-04-08 15:58:49 +03DEBUG: writing stats file "pg_stat_tmp/global.stat" 2017-04-08 15:58:49 +03DEBUG: writing stats file "pg_stat_tmp/db_16526.stat" 2017-04-08 15:58:49 +03DEBUG: writing stats file "pg_stat_tmp/db_0.stat" 2017-04-08 15:58:49 +03DEBUG: server process (PID 2484) exited with exit code 0 2017-04-08 15:59:04 +03DEBUG: received inquiry for database 0 2017-04-08 15:59:04 +03DEBUG: writing stats file "pg_stat_tmp/global.stat" 2017-04-08 15:59:04 +03DEBUG: writing stats file "pg_stat_tmp/db_0.stat" 2017-04-08 15:59:04 +03DEBUG: autovacuum: processing database "spanc" 2017-04-08 15:59:04 +03DEBUG: received inquiry for database 16461 2017-04-08 15:59:04 +03DEBUG: writing stats file "pg_stat_tmp/global.stat" 2017-04-08 15:59:04 +03DEBUG: writing stats file "pg_stat_tmp/db_16461.stat" 2017-04-08 15:59:04 +03DEBUG: writing stats file "pg_stat_tmp/db_0.stat" 2017-04-08 15:59:04 +03DEBUG: server process (PID 1168) exited with exit code 0 2017-04-08 15:59:19 +03DEBUG: received inquiry for database 0 2017-04-08 15:59:19 +03DEBUG: writing stats file "pg_stat_tmp/global.stat" 2017-04-08 15:59:19 +03DEBUG: writing stats file "pg_stat_tmp/db_0.stat" 2017-04-08 15:59:19 +03DEBUG: autovacuum: processing database "template1" 2017-04-08 15:59:19 +03DEBUG: received inquiry for database 1 2017-04-08 15:59:19 +03DEBUG: writing stats file "pg_stat_tmp/global.stat" 2017-04-08 15:59:19 +03DEBUG: writing stats file "pg_stat_tmp/db_1.stat" 2017-04-08 15:59:19 +03DEBUG: writing stats file "pg_stat_tmp/db_0.stat" 2017-04-08 15:59:19 +03DEBUG: server process (PID 19000) exited with exit code 0 2017-04-08 15:59:34 +03DEBUG: received inquiry for database 0 2017-04-08 15:59:34 +03DEBUG: writing stats file "pg_stat_tmp/global.stat" 2017-04-08 15:59:34 +03DEBUG: writing stats file "pg_stat_tmp/db_0.stat" 2017-04-08 15:59:34 +03DEBUG: autovacuum: processing database "postgres" 2017-04-08 15:59:34 +03DEBUG: received inquiry for database 12401 2017-04-08 15:59:34 +03DEBUG: writing stats file "pg_stat_tmp/global.stat" 2017-04-08 15:59:34 +03DEBUG: writing stats file "pg_stat_tmp/db_12401.stat" 2017-04-08 15:59:34 +03DEBUG: writing stats file "pg_stat_tmp/db_0.stat" 2017-04-08 15:59:34 +03DEBUG: server process (PID 572) exited with exit code 0 2017-04-08 15:59:40 +03DEBUG: server process (PID 14356) exited with exit code 0 2017-04-08 15:59:40 +03DEBUG: server process (PID 19448) exited with exit code 0 2017-04-08 15:59:49 +03DEBUG: received inquiry for database 0 2017-04-08 15:59:49 +03DEBUG: writing stats file "pg_stat_tmp/global.stat" 2017-04-08 15:59:49 +03DEBUG: writing stats file "pg_stat_tmp/db_0.stat" 2017-04-08 15:59:49 +03DEBUG: autovacuum: processing database "tracker" 2017-04-08 15:59:49 +03DEBUG: received inquiry for database 16526 2017-04-08 15:59:49 +03DEBUG: writing stats file "pg_stat_tmp/global.stat" 2017-04-08 15:59:49 +03DEBUG: writing stats file "pg_stat_tmp/db_16526.stat" 2017-04-08 15:59:49 +03DEBUG: writing stats file "pg_stat_tmp/db_0.stat" 2017-04-08 15:59:49 +03DEBUG: server process (PID 2172) exited with exit code 0 2017-04-08 16:00:04 +03DEBUG: received inquiry for database 0 2017-04-08 16:00:04 +03DEBUG: writing stats file "pg_stat_tmp/global.stat" 2017-04-08 16:00:04 +03DEBUG: writing stats file "pg_stat_tmp/db_0.stat" -----