Hello,
I have installed Trac using mod_wsgi and Apache on my QNAP TS-219p. The
loading of the pages is horribly slow, it takes up to 40 seconds.
Checking the trac log, I realized that it takes about 10 seconds from
pushing the RELOAD button in the browser to the first entry in the trac log.
Also, the message "INFO: -------------------------------- environment
startup [Trac 0.12] --------------------------------
" is seen multiple times during the load of a single page. That's odd.
2010-07-22 19:52:04,929 Trac[env] INFO: --------------------------------
environment startup [Trac 0.12] --------------------------------
2010-07-22 19:52:05,087 Trac[loader] DEBUG: Loading trac.about from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:05,109 Trac[loader] DEBUG: Loading trac.admin.console from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:05,169 Trac[loader] DEBUG: Loading trac.admin.web_ui from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:05,180 Trac[loader] DEBUG: Loading trac.attachment from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:05,182 Trac[loader] DEBUG: Loading trac.db.mysql from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:05,193 Trac[loader] DEBUG: Loading trac.db.postgres from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:05,200 Trac[loader] DEBUG: Loading trac.db.sqlite from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:05,236 Trac[loader] DEBUG: Loading trac.mimeview.patch from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:05,242 Trac[loader] DEBUG: Loading trac.mimeview.pygments
from /share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:05,295 Trac[loader] DEBUG: Skipping "trac.mimeview.pygments
= trac.mimeview.pygments [pygments]": ("DistributionNotFound: Pygments>=0.6"
not found)
2010-07-22 19:52:05,297 Trac[loader] DEBUG: Loading trac.mimeview.rst from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:05,351 Trac[loader] DEBUG: Skipping "trac.mimeview.rst =
trac.mimeview.rst [rest]": ("DistributionNotFound: docutils>=0.3" not found)
2010-07-22 19:52:05,353 Trac[loader] DEBUG: Loading trac.mimeview.silvercity
from /share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:05,406 Trac[loader] DEBUG: Skipping
"trac.mimeview.silvercity = trac.mimeview.silvercity [silvercity]":
("DistributionNotFound: SilverCity>=0.9.4" not found)
2010-07-22 19:52:05,408 Trac[loader] DEBUG: Loading trac.mimeview.txtl from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:05,460 Trac[loader] DEBUG: Skipping "trac.mimeview.txtl =
trac.mimeview.txtl [textile]": ("DistributionNotFound: textile>=2.0" not
found)
2010-07-22 19:52:05,462 Trac[loader] DEBUG: Loading trac.prefs from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:05,470 Trac[loader] DEBUG: Loading trac.search from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:05,477 Trac[loader] DEBUG: Loading trac.ticket.admin from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:05,491 Trac[loader] DEBUG: Loading trac.ticket.query from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:05,526 Trac[loader] DEBUG: Loading trac.ticket.report from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:05,533 Trac[loader] DEBUG: Loading trac.ticket.roadmap from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:05,548 Trac[loader] DEBUG: Loading trac.ticket.web_ui from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:05,577 Trac[loader] DEBUG: Loading trac.timeline from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:05,592 Trac[loader] DEBUG: Loading
trac.versioncontrol.admin from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:05,599 Trac[loader] DEBUG: Loading
trac.versioncontrol.svn_authz from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:05,604 Trac[loader] DEBUG: Loading
trac.versioncontrol.svn_fs from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:05,618 Trac[loader] DEBUG: Loading
trac.versioncontrol.svn_prop from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:05,689 Trac[loader] DEBUG: Loading
trac.versioncontrol.web_ui from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:05,692 Trac[loader] DEBUG: Loading trac.web.auth from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:05,726 Trac[loader] DEBUG: Loading trac.web.session from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:05,729 Trac[loader] DEBUG: Loading trac.wiki.admin from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:05,732 Trac[loader] DEBUG: Loading trac.wiki.interwiki from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:05,751 Trac[loader] DEBUG: Loading trac.wiki.macros from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:05,754 Trac[loader] DEBUG: Loading trac.wiki.web_api from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:05,758 Trac[loader] DEBUG: Loading trac.wiki.web_ui from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:05,784 Trac[loader] DEBUG: Loading
tracopt.mimeview.enscript from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:05,791 Trac[loader] DEBUG: Loading tracopt.mimeview.php
from /share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:05,797 Trac[loader] DEBUG: Loading
tracopt.perm.authz_policy from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:05,804 Trac[loader] DEBUG: Loading
tracopt.perm.config_perm_provider from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:05,808 Trac[loader] DEBUG: Loading
tracopt.ticket.commit_updater from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:05,825 Trac[loader] DEBUG: Loading tracopt.ticket.deleter
from /share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:05,872 Trac[default_workflow] DEBUG: Workflow actions at
initialization: {u'accept': {u'operations': [u'set_owner_to_self'], 'name':
u'accept', 'default': 0, 'newstate': u'accepted', 'oldstates': [u'new',
u'reopened'], u'permissions': [u'TICKET_MODIFY']}, u'leave': {'operations':
[], 'name': u'leave', u'default': 1, 'newstate': u'*', 'oldstates': [u'*'],
'permissions': []}, u'reopen': {u'operations': [u'del_resolution',
u'del_owner'], 'name': u'reopen', u'permission': u'TICKET_MODIFY',
'default': 0, 'newstate': u'reopened', 'oldstates': [u'closed'],
'permissions': []}, u'set_fixed': {u'operations': [u'del_owner',
u'set_resolution'], 'name': u'set_fixed', 'default': 0, 'newstate':
u'closed', u'set_resolution': u'fixed,not_reproducible', 'oldstates':
[u'accepted'], u'permissions': [u'TICKET_MODIFY']}, u'close':
{u'operations': [u'del_owner', u'set_resolution'], 'name': u'close',
'default': 0, 'newstate': u'closed', u'set_resolution':
u'wontfix,duplicate', 'oldstates': [u'new', u'accepted'], u'permissions':
[u'TICKET_MODIFY']}, '_reset': {'operations': ['reset_workflow'], 'name':
'reset', 'default': 0, 'newstate': 'new', 'oldstates': [], 'permissions':
[]}}
2010-07-22 19:52:05,887 Trac[main] DEBUG: Dispatching <Request "GET '/'">
2010-07-22 19:52:06,390 Trac[svn_fs] DEBUG: Subversion bindings imported
2010-07-22 19:52:06,421 Trac[api] INFO: Synchronized '' repository in 0.45
seconds
2010-07-22 19:52:06,475 Trac[session] DEBUG: Retrieving session for ID
u'markus'
2010-07-22 19:52:06,505 Trac[api] DEBUG: action controllers for ticket
workflow: ['ConfigurableTicketWorkflow']
2010-07-22 19:52:06,527 Trac[chrome] DEBUG: Prepare chrome data for request
2010-07-22 19:52:10,349 Trac[formatter] DEBUG: Executing Wiki macro Image by
provider <trac.wiki.macros.ImageMacro object at 0xd1f9f0>
2010-07-22 19:52:10,678 Trac[main] DEBUG: Dispatching <Request "GET
'/chrome/common/css/trac.css'">
2010-07-22 19:52:10,723 Trac[main] DEBUG: Dispatching <Request "GET
'/chrome/common/js/jquery.js'">
2010-07-22 19:52:11,187 Trac[main] DEBUG: Dispatching <Request "GET
'/chrome/common/js/babel.js'">
2010-07-22 19:52:11,522 Trac[main] DEBUG: Dispatching <Request "GET
'/chrome/common/js/trac.js'">
2010-07-22 19:52:11,869 Trac[main] DEBUG: Dispatching <Request "GET
'/chrome/common/js/search.js'">
2010-07-22 19:52:12,204 Trac[main] DEBUG: Dispatching <Request "GET
'/chrome/common/js/folding.js'">
2010-07-22 19:52:12,584 Trac[main] DEBUG: Dispatching <Request "GET
'/chrome/common/trac_banner.png'">
2010-07-22 19:52:12,593 Trac[main] DEBUG: Dispatching <Request "GET
'/chrome/common/topbar_gradient.png'">
2010-07-22 19:52:12,603 Trac[main] DEBUG: Dispatching <Request "GET
'/chrome/common/trac_logo_mini.png'">
2010-07-22 19:52:12,612 Trac[main] DEBUG: Dispatching <Request "GET
'/chrome/common/extlink.gif'">
2010-07-22 19:52:12,623 Trac[main] DEBUG: Dispatching <Request "GET
'/chrome/common/topbar_gradient2.png'">
2010-07-22 19:52:12,632 Trac[main] DEBUG: Dispatching <Request "GET
'/chrome/common/dots.gif'">
2010-07-22 19:52:12,643 Trac[main] DEBUG: Dispatching <Request "GET
'/raw-attachment/wiki/MILK/milk_logo3.jpg'">
2010-07-22 19:52:14,738 Trac[svn_fs] DEBUG: Subversion bindings imported
2010-07-22 19:52:14,830 Trac[api] INFO: Synchronized '' repository in 2.04
seconds
2010-07-22 19:52:14,834 Trac[api] DEBUG: action controllers for ticket
workflow: ['ConfigurableTicketWorkflow']
2010-07-22 19:52:14,857 Trac[chrome] DEBUG: Prepare chrome data for request
2010-07-22 19:52:15,009 Trac[session] DEBUG: Retrieving session for ID
u'markus'
2010-07-22 19:52:21,171 Trac[env] INFO: --------------------------------
environment startup [Trac 0.12] --------------------------------
2010-07-22 19:52:21,489 Trac[loader] DEBUG: Loading trac.about from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:21,531 Trac[loader] DEBUG: Loading trac.admin.console from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:21,600 Trac[env] INFO: --------------------------------
environment startup [Trac 0.12] --------------------------------
2010-07-22 19:52:21,652 Trac[loader] DEBUG: Loading trac.admin.web_ui from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:21,673 Trac[loader] DEBUG: Loading trac.attachment from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:21,676 Trac[loader] DEBUG: Loading trac.db.mysql from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:21,697 Trac[loader] DEBUG: Loading trac.db.postgres from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:21,714 Trac[loader] DEBUG: Loading trac.db.sqlite from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:21,790 Trac[loader] DEBUG: Loading trac.mimeview.patch from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:21,795 Trac[loader] DEBUG: Loading trac.mimeview.pygments
from /share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:21,909 Trac[loader] DEBUG: Skipping "trac.mimeview.pygments
= trac.mimeview.pygments [pygments]": ("DistributionNotFound: Pygments>=0.6"
not found)
2010-07-22 19:52:21,911 Trac[loader] DEBUG: Loading trac.mimeview.rst from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:21,925 Trac[loader] DEBUG: Loading trac.about from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:21,979 Trac[loader] DEBUG: Loading trac.admin.console from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:22,016 Trac[loader] DEBUG: Skipping "trac.mimeview.rst =
trac.mimeview.rst [rest]": ("DistributionNotFound: docutils>=0.3" not found)
2010-07-22 19:52:22,028 Trac[loader] DEBUG: Loading trac.mimeview.silvercity
from /share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:22,101 Trac[loader] DEBUG: Loading trac.admin.web_ui from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:22,123 Trac[loader] DEBUG: Loading trac.attachment from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:22,126 Trac[loader] DEBUG: Loading trac.db.mysql from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:22,132 Trac[loader] DEBUG: Skipping
"trac.mimeview.silvercity = trac.mimeview.silvercity [silvercity]":
("DistributionNotFound: SilverCity>=0.9.4" not found)
2010-07-22 19:52:22,134 Trac[loader] DEBUG: Loading trac.mimeview.txtl from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:22,147 Trac[loader] DEBUG: Loading trac.db.postgres from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:22,165 Trac[loader] DEBUG: Loading trac.db.sqlite from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:22,253 Trac[loader] DEBUG: Loading trac.mimeview.patch from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:22,258 Trac[loader] DEBUG: Skipping "trac.mimeview.txtl =
trac.mimeview.txtl [textile]": ("DistributionNotFound: textile>=2.0" not
found)
2010-07-22 19:52:22,260 Trac[loader] DEBUG: Loading trac.prefs from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:22,269 Trac[loader] DEBUG: Loading trac.mimeview.pygments
from /share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:22,278 Trac[loader] DEBUG: Loading trac.search from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:22,285 Trac[loader] DEBUG: Loading trac.ticket.admin from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:22,319 Trac[loader] DEBUG: Loading trac.ticket.query from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:22,375 Trac[loader] DEBUG: Skipping "trac.mimeview.pygments
= trac.mimeview.pygments [pygments]": ("DistributionNotFound: Pygments>=0.6"
not found)
2010-07-22 19:52:22,384 Trac[loader] DEBUG: Loading trac.ticket.report from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:22,392 Trac[loader] DEBUG: Loading trac.ticket.roadmap from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:22,377 Trac[loader] DEBUG: Loading trac.mimeview.rst from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:22,416 Trac[loader] DEBUG: Loading trac.ticket.web_ui from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:22,476 Trac[loader] DEBUG: Loading trac.timeline from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:22,504 Trac[loader] DEBUG: Skipping "trac.mimeview.rst =
trac.mimeview.rst [rest]": ("DistributionNotFound: docutils>=0.3" not found)
2010-07-22 19:52:22,506 Trac[loader] DEBUG: Loading trac.mimeview.silvercity
from /share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:22,512 Trac[loader] DEBUG: Loading
trac.versioncontrol.admin from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:22,528 Trac[loader] DEBUG: Loading
trac.versioncontrol.svn_authz from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:22,534 Trac[loader] DEBUG: Loading
trac.versioncontrol.svn_fs from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:22,568 Trac[loader] DEBUG: Loading
trac.versioncontrol.svn_prop from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:22,622 Trac[loader] DEBUG: Skipping
"trac.mimeview.silvercity = trac.mimeview.silvercity [silvercity]":
("DistributionNotFound: SilverCity>=0.9.4" not found)
2010-07-22 19:52:22,624 Trac[loader] DEBUG: Loading trac.mimeview.txtl from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:22,710 Trac[loader] DEBUG: Loading
trac.versioncontrol.web_ui from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:22,713 Trac[loader] DEBUG: Loading trac.web.auth from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:22,740 Trac[loader] DEBUG: Skipping "trac.mimeview.txtl =
trac.mimeview.txtl [textile]": ("DistributionNotFound: textile>=2.0" not
found)
2010-07-22 19:52:22,741 Trac[loader] DEBUG: Loading trac.prefs from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:22,760 Trac[loader] DEBUG: Loading trac.search from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:22,777 Trac[loader] DEBUG: Loading trac.ticket.admin from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:22,788 Trac[loader] DEBUG: Loading trac.web.session from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:22,791 Trac[loader] DEBUG: Loading trac.wiki.admin from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:22,794 Trac[loader] DEBUG: Loading trac.wiki.interwiki from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:22,802 Trac[loader] DEBUG: Loading trac.ticket.query from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:22,833 Trac[loader] DEBUG: Loading trac.wiki.macros from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:22,836 Trac[loader] DEBUG: Loading trac.wiki.web_api from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:22,850 Trac[loader] DEBUG: Loading trac.wiki.web_ui from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:22,879 Trac[loader] DEBUG: Loading trac.ticket.report from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:22,898 Trac[loader] DEBUG: Loading trac.ticket.roadmap from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:22,897 Trac[loader] DEBUG: Loading
tracopt.mimeview.enscript from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:22,914 Trac[loader] DEBUG: Loading tracopt.mimeview.php
from /share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:22,922 Trac[loader] DEBUG: Loading trac.ticket.web_ui from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:22,930 Trac[loader] DEBUG: Loading
tracopt.perm.authz_policy from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:22,937 Trac[loader] DEBUG: Loading
tracopt.perm.config_perm_provider from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:22,952 Trac[loader] DEBUG: Loading
tracopt.ticket.commit_updater from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:22,983 Trac[loader] DEBUG: Loading trac.timeline from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:22,988 Trac[loader] DEBUG: Loading tracopt.ticket.deleter
from /share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:23,020 Trac[loader] DEBUG: Loading
trac.versioncontrol.admin from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:23,026 Trac[loader] DEBUG: Loading
trac.versioncontrol.svn_authz from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:23,042 Trac[loader] DEBUG: Loading
trac.versioncontrol.svn_fs from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:23,066 Trac[loader] DEBUG: Loading
trac.versioncontrol.svn_prop from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:23,075 Trac[default_workflow] DEBUG: Workflow actions at
initialization: {u'accept': {u'operations': [u'set_owner_to_self'], 'name':
u'accept', 'default': 0, 'newstate': u'accepted', 'oldstates': [u'new',
u'reopened'], u'permissions': [u'TICKET_MODIFY']}, u'leave': {'operations':
[], 'name': u'leave', u'default': 1, 'newstate': u'*', 'oldstates': [u'*'],
'permissions': []}, u'reopen': {u'operations': [u'del_resolution',
u'del_owner'], 'name': u'reopen', u'permission': u'TICKET_MODIFY',
'default': 0, 'newstate': u'reopened', 'oldstates': [u'closed'],
'permissions': []}, u'set_fixed': {u'operations': [u'del_owner',
u'set_resolution'], 'name': u'set_fixed', 'default': 0, 'newstate':
u'closed', u'set_resolution': u'fixed,not_reproducible', 'oldstates':
[u'accepted'], u'permissions': [u'TICKET_MODIFY']}, u'close':
{u'operations': [u'del_owner', u'set_resolution'], 'name': u'close',
'default': 0, 'newstate': u'closed', u'set_resolution':
u'wontfix,duplicate', 'oldstates': [u'new', u'accepted'], u'permissions':
[u'TICKET_MODIFY']}, '_reset': {'operations': ['reset_workflow'], 'name':
'reset', 'default': 0, 'newstate': 'new', 'oldstates': [], 'permissions':
[]}}
2010-07-22 19:52:23,102 Trac[main] DEBUG: Dispatching <Request "GET
'/chrome/common/css/wiki.css'">
2010-07-22 19:52:23,231 Trac[loader] DEBUG: Loading
trac.versioncontrol.web_ui from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:23,234 Trac[loader] DEBUG: Loading trac.web.auth from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:23,310 Trac[loader] DEBUG: Loading trac.web.session from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:23,314 Trac[loader] DEBUG: Loading trac.wiki.admin from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:23,316 Trac[loader] DEBUG: Loading trac.wiki.interwiki from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:23,338 Trac[main] DEBUG: Dispatching <Request "GET
'/chrome/common/css/code.css'">
2010-07-22 19:52:23,355 Trac[loader] DEBUG: Loading trac.wiki.macros from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:23,360 Trac[loader] DEBUG: Loading trac.wiki.web_api from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:23,366 Trac[loader] DEBUG: Loading trac.wiki.web_ui from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:23,413 Trac[loader] DEBUG: Loading
tracopt.mimeview.enscript from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:23,431 Trac[loader] DEBUG: Loading tracopt.mimeview.php
from /share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:23,437 Trac[loader] DEBUG: Loading
tracopt.perm.authz_policy from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:23,464 Trac[loader] DEBUG: Loading
tracopt.perm.config_perm_provider from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:23,480 Trac[loader] DEBUG: Loading
tracopt.ticket.commit_updater from
/share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:23,518 Trac[loader] DEBUG: Loading tracopt.ticket.deleter
from /share/MD0_DATA/.qpkg/Optware/lib/python2.5/site-packages
2010-07-22 19:52:23,570 Trac[default_workflow] DEBUG: Workflow actions at
initialization: {u'accept': {u'operations': [u'set_owner_to_self'], 'name':
u'accept', 'default': 0, 'newstate': u'accepted', 'oldstates': [u'new',
u'reopened'], u'permissions': [u'TICKET_MODIFY']}, u'leave': {'operations':
[], 'name': u'leave', u'default': 1, 'newstate': u'*', 'oldstates': [u'*'],
'permissions': []}, u'reopen': {u'operations': [u'del_resolution',
u'del_owner'], 'name': u'reopen', u'permission': u'TICKET_MODIFY',
'default': 0, 'newstate': u'reopened', 'oldstates': [u'closed'],
'permissions': []}, u'set_fixed': {u'operations': [u'del_owner',
u'set_resolution'], 'name': u'set_fixed', 'default': 0, 'newstate':
u'closed', u'set_resolution': u'fixed,not_reproducible', 'oldstates':
[u'accepted'], u'permissions': [u'TICKET_MODIFY']}, u'close':
{u'operations': [u'del_owner', u'set_resolution'], 'name': u'close',
'default': 0, 'newstate': u'closed', u'set_resolution':
u'wontfix,duplicate', 'oldstates': [u'new', u'accepted'], u'permissions':
[u'TICKET_MODIFY']}, '_reset': {'operations': ['reset_workflow'], 'name':
'reset', 'default': 0, 'newstate': 'new', 'oldstates': [], 'permissions':
[]}}
2010-07-22 19:52:23,586 Trac[main] DEBUG: Dispatching <Request "GET
'/chrome/common/trac.ico'">
Further, in the log of Apache, I see that messages regarding python and
mod_wsgi initialization are repeating. That's odd, too.
[Thu Jul 22 19:33:02 2010] [error] [client 192.168.3.3] File does not exist:
/share/Qweb/favicon.ico, referer: http://192.168.3.13/trac
[Thu Jul 22 19:36:38 2010] [notice] SIGHUP received. Attempting to restart
apache: Could not reliably determine the server's fully qualified domain
name, using 192.168.3.13 for ServerName
[Thu Jul 22 19:36:39 2010] [info] mod_wsgi (pid=23630): Initializing Python.
[Thu Jul 22 19:36:39 2010] [info] mod_wsgi (pid=23629): Initializing Python.
[Thu Jul 22 19:36:39 2010] [info] mod_wsgi (pid=23631): Initializing Python.
[Thu Jul 22 19:36:39 2010] [info] mod_wsgi (pid=23632): Initializing Python.
[Thu Jul 22 19:36:39 2010] [info] mod_wsgi (pid=23633): Initializing Python.
[Thu Jul 22 19:36:39 2010] [notice] Apache/2.2.14 (Unix) DAV/2 PHP/5.2.11
mod_wsgi/3.2 Python/2.5.5 configured -- resuming normal operations
[Thu Jul 22 19:36:39 2010] [info] Server built: Jun 29 2010 03:25:25
[Thu Jul 22 19:36:39 2010] [info] mod_wsgi (pid=23630): Attach interpreter
''.
[Thu Jul 22 19:36:39 2010] [info] mod_wsgi (pid=23629): Attach interpreter
''.
[Thu Jul 22 19:36:39 2010] [info] mod_wsgi (pid=23631): Attach interpreter
''.
[Thu Jul 22 19:36:39 2010] [info] mod_wsgi (pid=23633): Attach interpreter
''.
[Thu Jul 22 19:36:39 2010] [info] mod_wsgi (pid=23632): Attach interpreter
''.
[Thu Jul 22 19:36:44 2010] [info] [client 192.168.3.3] mod_wsgi (pid=23630,
process='', application=''): Loading WSGI script
'/share/MD0_DATA/Trac/.apache/trac.wsgi'., referer: http://192.168.3.13/trac
[Thu Jul 22 19:36:44 2010] [info] mod_wsgi (pid=23636): Initializing Python.
[Thu Jul 22 19:36:44 2010] [info] mod_wsgi (pid=23636): Attach interpreter
''.
[Thu Jul 22 19:36:54 2010] [info] [client 192.168.3.3] mod_wsgi (pid=23631,
process='', application=''): Loading WSGI script
'/share/MD0_DATA/Trac/.apache/trac.wsgi'., referer:
http://192.168.3.13/trac/milk
[Thu Jul 22 19:36:54 2010] [info] [client 192.168.3.3] mod_wsgi (pid=23633,
process='', application=''): Loading WSGI script
'/share/MD0_DATA/Trac/.apache/trac.wsgi'., referer:
http://192.168.3.13/trac/milk
[Thu Jul 22 19:36:54 2010] [info] [client 192.168.3.3] mod_wsgi (pid=23629,
process='', application=''): Loading WSGI script
'/share/MD0_DATA/Trac/.apache/trac.wsgi'., referer:
http://192.168.3.13/trac/milk
[Thu Jul 22 19:36:54 2010] [info] mod_wsgi (pid=23640): Initializing Python.
[Thu Jul 22 19:36:54 2010] [info] mod_wsgi (pid=23640): Attach interpreter
''.
[Thu Jul 22 19:36:55 2010] [info] mod_wsgi (pid=23641): Initializing Python.
[Thu Jul 22 19:36:55 2010] [info] mod_wsgi (pid=23642): Initializing Python.
[Thu Jul 22 19:36:55 2010] [info] mod_wsgi (pid=23641): Attach interpreter
''.
[Thu Jul 22 19:36:56 2010] [info] mod_wsgi (pid=23642): Attach interpreter
''.
[Thu Jul 22 19:36:57 2010] [info] [client 192.168.3.3] mod_wsgi (pid=23632,
process='', application=''): Loading WSGI script
'/share/MD0_DATA/Trac/.apache/trac.wsgi'., referer:
http://192.168.3.13/trac/milk
[Thu Jul 22 19:36:57 2010] [info] [client 192.168.3.3] mod_wsgi (pid=23636,
process='', application=''): Loading WSGI script
'/share/MD0_DATA/Trac/.apache/trac.wsgi'., referer:
http://192.168.3.13/trac/milk
[Thu Jul 22 19:36:57 2010] [info] mod_wsgi (pid=23643): Initializing Python.
[Thu Jul 22 19:36:58 2010] [info] mod_wsgi (pid=23643): Attach interpreter
''.
[Thu Jul 22 19:36:58 2010] [info] mod_wsgi (pid=23646): Initializing Python.
[Thu Jul 22 19:36:58 2010] [info] mod_wsgi (pid=23647): Initializing Python.
[Thu Jul 22 19:36:59 2010] [info] mod_wsgi (pid=23646): Attach interpreter
''.
[Thu Jul 22 19:36:59 2010] [info] mod_wsgi (pid=23647): Attach interpreter
''.
[Thu Jul 22 19:37:20 2010] [info] [client 192.168.3.3] mod_wsgi (pid=23640,
process='', application=''): Loading WSGI script
'/share/MD0_DATA/Trac/.apache/trac.wsgi'., referer:
http://192.168.3.13/trac/milk
Any ideas how to track this down?
--
View this message in context:
http://old.nabble.com/Trac-response-very-slow-tp29239192p29239192.html
Sent from the Trac Users mailing list archive at Nabble.com.
--
You received this message because you are subscribed to the Google Groups "Trac
Users" group.
To post to this group, send email to [email protected].
To unsubscribe from this group, send email to
[email protected].
For more options, visit this group at
http://groups.google.com/group/trac-users?hl=en.
