Project

General

Profile

Sloooow repository open

Added by Yuri Bardashev about 12 years ago

i've got redmine_1.3 + subversion_1.6 + postgreSQL_9.1 and very small project.
when i'm trying to open "repository" tab it freezes for 5 seconds.

production.log:

.....
DEBUG:  name: unnamed; blockState:       STARTED; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
DEBUG:  StartTransactionCommand
DEBUG:  StartTransaction
DEBUG:  name: unnamed; blockState:       DEFAULT; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
LOG:  statement: SELECT name FROM "enabled_modules" WHERE ("enabled_modules".project_id = 2) 
DEBUG:  CommitTransactionCommand
DEBUG:  CommitTransaction
DEBUG:  name: unnamed; blockState:       STARTED; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
DEBUG:  StartTransactionCommand
DEBUG:  StartTransaction
DEBUG:  name: unnamed; blockState:       DEFAULT; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
LOG:  statement: SELECT * FROM "changesets" WHERE ("changesets".repository_id = 2)  ORDER BY changesets.committed_on DESC, changesets.id DESC LIMIT 1
DEBUG:  CommitTransactionCommand
DEBUG:  CommitTransaction
DEBUG:  name: unnamed; blockState:       STARTED; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 

... freezed for 5 sec ....

DEBUG:  StartTransactionCommand
DEBUG:  StartTransaction
DEBUG:  name: unnamed; blockState:       DEFAULT; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
LOG:  statement: SELECT * FROM "changesets" WHERE ("changesets"."revision" IN ('78','77','76','75','74','73','72','71','70','69')) AND ("changesets".repository_id = 2)  ORDER BY committed_on DESC, changesets.committed_on DESC, changesets.id DESC
DEBUG:  CommitTransactionCommand
DEBUG:  CommitTransaction
DEBUG:  name: unnamed; blockState:       STARTED; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
DEBUG:  StartTransactionCommand
DEBUG:  StartTransaction
DEBUG:  name: unnamed; blockState:       DEFAULT; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
LOG:  statement: SELECT * FROM "users" WHERE ("users"."id" = 1) AND ( ("users"."type" = 'User' OR "users"."type" = 'AnonymousUser' ) ) 
DEBUG:  CommitTransactionCommand
DEBUG:  CommitTransaction
DEBUG:  name: unnamed; blockState:       STARTED; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
DEBUG:  StartTransactionCommand
DEBUG:  StartTransaction
DEBUG:  name: unnamed; blockState:       DEFAULT; state: INPROGR, xid/subid/cid: 0/1/0, nestlvl: 1, children: 
LOG:  statement: SELECT * FROM "changesets" WHERE ("changesets".repository_id = 2 AND (revision = '71'))  ORDER BY changesets.committed_on DESC, changesets.id DESC LIMIT 1
DEBUG:  CommitTransactionCommand
.....
Completed in 5100ms (View: 186, DB: 48) | 200 OK [http://localhost/projects/reactor2/repository]

postgresql-9.1-main.log:

2012-03-18 22:32:24 MSK LOG:  connection received: host=127.0.0.1 port=60445
2012-03-18 22:32:24 MSK LOG:  connection authorized: user=redmine database=redmine
2012-03-18 22:32:24 MSK LOG:  execute dbdpg_p5543_1: SELECT value FROM settings where settings.name = 'login_required';
2012-03-18 22:32:24 MSK LOG:  statement: DEALLOCATE dbdpg_p5543_1
2012-03-18 22:32:24 MSK LOG:  disconnection: session time: 0:00:00.032 user=redmine database=redmine host=127.0.0.1 port=60445
2012-03-18 22:32:24 MSK LOG:  connection received: host=127.0.0.1 port=60446
2012-03-18 22:32:25 MSK LOG:  connection authorized: user=redmine database=redmine
2012-03-18 22:32:25 MSK LOG:  execute dbdpg_p5543_1: SELECT value FROM settings where settings.name = 'login_required';
2012-03-18 22:32:25 MSK LOG:  statement: DEALLOCATE dbdpg_p5543_1
2012-03-18 22:32:25 MSK LOG:  disconnection: session time: 0:00:00.030 user=redmine database=redmine host=127.0.0.1 port=60446
2012-03-18 22:32:25 MSK LOG:  connection received: host=127.0.0.1 port=60447
2012-03-18 22:32:25 MSK LOG:  connection authorized: user=redmine database=redmine
2012-03-18 22:32:25 MSK LOG:  execute dbdpg_p5543_1: SELECT value FROM settings where settings.name = 'login_required';
2012-03-18 22:32:25 MSK LOG:  statement: DEALLOCATE dbdpg_p5543_1
2012-03-18 22:32:25 MSK LOG:  disconnection: session time: 0:00:00.029 user=redmine database=redmine host=127.0.0.1 port=60447
2012-03-18 22:32:25 MSK LOG:  connection received: host=127.0.0.1 port=60448
2012-03-18 22:32:25 MSK LOG:  connection authorized: user=redmine database=redmine
2012-03-18 22:32:25 MSK LOG:  execute dbdpg_p5543_1: SELECT value FROM settings where settings.name = 'login_required';
2012-03-18 22:32:25 MSK LOG:  statement: DEALLOCATE dbdpg_p5543_1
2012-03-18 22:32:25 MSK LOG:  disconnection: session time: 0:00:00.027 user=redmine database=redmine host=127.0.0.1 port=60448
2012-03-18 22:32:25 MSK LOG:  connection received: host=127.0.0.1 port=60449
2012-03-18 22:32:25 MSK LOG:  connection authorized: user=redmine database=redmine
2012-03-18 22:32:25 MSK LOG:  execute dbdpg_p5543_1: SELECT value FROM settings where settings.name = 'login_required';
2012-03-18 22:32:25 MSK LOG:  statement: DEALLOCATE dbdpg_p5543_1
2012-03-18 22:32:25 MSK LOG:  disconnection: session time: 0:00:00.028 user=redmine database=redmine host=127.0.0.1 port=60449
.... and so on for 3-4 sec

why it happens? what i'm doing wrong?? please help.