trac performance: reload all plugins on every click really necessary ?
22 views
Skip to first unread message
rupert....@gmail.com
Aug 7, 2009, 12:23:24 PM8/7/09
to Trac Development
i am not enough python developer to judge this, but it looks so much
overload that on every click we have 160 lines caused by plugins in
our log file. is this really necessary?
2009-08-07 17:36:44,918 Trac[loader] DEBUG: Loading datefield.filter
from /opt/csw/lib/python/site-packages/TracDateField-1.0.1-py2.5.egg
2009-08-07 17:36:45,189 Trac[loader] DEBUG: Loading tracreposearch
from /opt/csw/lib/python/site-packages/tracreposearch-0.2-py2.5.egg
2009-08-07 17:36:45,223 Trac[loader] DEBUG: Loading newsflash.macro
from /opt/csw/lib/python/site-packages/TracNewsFlash-0.1-py2.5.egg
2009-08-07 17:36:45,335 Trac[loader] DEBUG: Loading tracwysiwyg from /
opt/csw/lib/python/site-packages/TracWysiwyg-0.2_r4353-py2.5.egg
2009-08-07 17:36:45,358 Trac[loader] DEBUG: Loading
ticketdelete.web_ui from /opt/csw/lib/python/site-packages/
TracTicketDelete-2.0-py2.5.egg
2009-08-07 17:36:45,415 Trac[loader] DEBUG: Loading iniadmin from /opt/
csw/lib/python/site-packages/IniAdmin-0.2-py2.5.egg
2009-08-07 17:36:45,449 Trac[loader] DEBUG: Loading
customfieldadmin.api from /opt/csw/lib/python/site-packages/
TracCustomFieldAdmin-0.2-py2.5.egg
2009-08-07 17:36:45,481 Trac[loader] DEBUG: Loading
customfieldadmin.customfieldadmin from /opt/csw/lib/python/site-
packages/TracCustomFieldAdmin-0.2-py2.5.egg
2009-08-07 17:36:45,514 Trac[loader] DEBUG: Loading announcerplugin
from /opt/csw/lib/python/site-packages/AnnouncerPlugin-0.2-py2.5.egg
2009-08-07 17:36:46,179 Trac[loader] DEBUG: Loading
TracDownloads.timeline from /opt/csw/lib/python/site-packages/
TracDownloads-0.2-py2.5.egg
2009-08-07 17:36:46,425 Trac[loader] DEBUG: Loading TracDownloads.api
from /opt/csw/lib/python/site-packages/TracDownloads-0.2-py2.5.egg
2009-08-07 17:36:46,428 Trac[loader] DEBUG: Loading TracDownloads.wiki
from /opt/csw/lib/python/site-packages/TracDownloads-0.2-py2.5.egg
2009-08-07 17:36:46,441 Trac[loader] DEBUG: Loading TracDownloads.core
from /opt/csw/lib/python/site-packages/TracDownloads-0.2-py2.5.egg
2009-08-07 17:36:46,461 Trac[loader] DEBUG: Loading TracDownloads.init
from /opt/csw/lib/python/site-packages/TracDownloads-0.2-py2.5.egg
2009-08-07 17:36:46,474 Trac[loader] DEBUG: Loading TracDownloads.tags
from /opt/csw/lib/python/site-packages/TracDownloads-0.2-py2.5.egg
2009-08-07 17:36:46,680 Trac[loader] DEBUG: Loading
TracDownloads.admin from /opt/csw/lib/python/site-packages/
TracDownloads-0.2-py2.5.egg
2009-08-07 17:36:46,712 Trac[loader] DEBUG: Loading tracfullblog.db
from /opt/csw/lib/python/site-packages/TracFullBlogPlugin-0.1-
py2.5.egg
2009-08-07 17:36:46,730 Trac[loader] DEBUG: Loading tracfullblog.core
from /opt/csw/lib/python/site-packages/TracFullBlogPlugin-0.1-
py2.5.egg
2009-08-07 17:36:46,790 Trac[loader] DEBUG: Loading
tracfullblog.web_ui from /opt/csw/lib/python/site-packages/
TracFullBlogPlugin-0.1-py2.5.egg
2009-08-07 17:36:46,802 Trac[loader] DEBUG: Loading
tracfullblog.macros from /opt/csw/lib/python/site-packages/
TracFullBlogPlugin-0.1-py2.5.egg
2009-08-07 17:36:46,808 Trac[loader] DEBUG: Loading
tracfullblog.spamfilter from /opt/csw/lib/python/site-packages/
TracFullBlogPlugin-0.1-py2.5.egg
2009-08-07 17:36:47,295 Trac[loader] DEBUG: Skipping
"tracfullblog.spamfilter = tracfullblog.spamfilter [spamfilter]":
("DistributionNotFound: TracSpamFilter>=0.2" not found)
2009-08-07 17:36:47,297 Trac[loader] DEBUG: Loading tracfullblog.tags
from /opt/csw/lib/python/site-packages/TracFullBlogPlugin-0.1-
py2.5.egg
2009-08-07 17:36:47,308 Trac[loader] DEBUG: Loading tracfullblog.admin
from /opt/csw/lib/python/site-packages/TracFullBlogPlugin-0.1-
py2.5.egg
2009-08-07 17:36:47,317 Trac[loader] DEBUG: Loading CustomRoadmap
from /opt/csw/lib/python/site-packages/TracCustomRoadmap-0.4-py2.5.egg
2009-08-07 17:36:47,446 Trac[loader] DEBUG: Loading tractoc.macro
from /opt/csw/lib/python/site-packages/TracTocMacro-11.0.0.3-py2.5.egg
2009-08-07 17:36:47,501 Trac[loader] DEBUG: Loading
includemacro.macros from /opt/csw/lib/python/site-packages/
TracIncludeMacro-2.1-py2.5.egg
2009-08-07 17:36:47,652 Trac[loader] DEBUG: Loading
TracDiscussion.core from /opt/csw/lib/python/site-packages/
TracDiscussion-0.6-py2.5.egg
2009-08-07 17:36:47,915 Trac[loader] DEBUG: Loading TracDiscussion.api
from /opt/csw/lib/python/site-packages/TracDiscussion-0.6-py2.5.egg
2009-08-07 17:36:47,918 Trac[loader] DEBUG: Loading
TracDiscussion.init from /opt/csw/lib/python/site-packages/
TracDiscussion-0.6-py2.5.egg
2009-08-07 17:36:47,932 Trac[loader] DEBUG: Loading
TracDiscussion.search from /opt/csw/lib/python/site-packages/
TracDiscussion-0.6-py2.5.egg
2009-08-07 17:36:47,956 Trac[loader] DEBUG: Loading
TracDiscussion.timeline from /opt/csw/lib/python/site-packages/
TracDiscussion-0.6-py2.5.egg
2009-08-07 17:36:47,995 Trac[loader] DEBUG: Loading
TracDiscussion.wiki from /opt/csw/lib/python/site-packages/
TracDiscussion-0.6-py2.5.egg
2009-08-07 17:36:48,030 Trac[loader] DEBUG: Loading
TracDiscussion.admin from /opt/csw/lib/python/site-packages/
TracDiscussion-0.6-py2.5.egg
2009-08-07 17:36:48,043 Trac[loader] DEBUG: Loading
TracDiscussion.notification from /opt/csw/lib/python/site-packages/
TracDiscussion-0.6-py2.5.egg
2009-08-07 17:36:48,076 Trac[loader] DEBUG: Loading graphviz from /opt/
csw/lib/python/site-packages/graphviz-0.7.5dev-py2.5.egg
2009-08-07 17:36:48,348 Trac[loader] DEBUG: Loading acct_mgr.admin
from /opt/csw/lib/python/site-packages/
TracAccountManager-0.2.1dev_r4698-py2.5.egg
2009-08-07 17:36:48,572 Trac[loader] DEBUG: Loading acct_mgr.db from /
opt/csw/lib/python/site-packages/TracAccountManager-0.2.1dev_r4698-
py2.5.egg
2009-08-07 17:36:48,696 Trac[loader] DEBUG: Loading acct_mgr.htfile
from /opt/csw/lib/python/site-packages/
TracAccountManager-0.2.1dev_r4698-py2.5.egg
2009-08-07 17:36:48,756 Trac[loader] DEBUG: Loading acct_mgr.http
from /opt/csw/lib/python/site-packages/
TracAccountManager-0.2.1dev_r4698-py2.5.egg
2009-08-07 17:36:48,767 Trac[loader] DEBUG: Loading
acct_mgr.notification from /opt/csw/lib/python/site-packages/
TracAccountManager-0.2.1dev_r4698-py2.5.egg
2009-08-07 17:36:48,811 Trac[loader] DEBUG: Loading acct_mgr.pwhash
from /opt/csw/lib/python/site-packages/
TracAccountManager-0.2.1dev_r4698-py2.5.egg
2009-08-07 17:36:48,813 Trac[loader] DEBUG: Loading acct_mgr.svnserve
from /opt/csw/lib/python/site-packages/
TracAccountManager-0.2.1dev_r4698-py2.5.egg
2009-08-07 17:36:48,831 Trac[loader] DEBUG: Loading acct_mgr.web_ui
from /opt/csw/lib/python/site-packages/
TracAccountManager-0.2.1dev_r4698-py2.5.egg
2009-08-07 17:36:48,833 Trac[loader] DEBUG: Loading acct_mgr.api from /
opt/csw/lib/python/site-packages/TracAccountManager-0.2.1dev_r4698-
py2.5.egg
2009-08-07 17:36:48,839 Trac[loader] DEBUG: Loading
permredirect.filter from /opt/csw/lib/python/site-packages/
TracPermRedirect-2.0-py2.5.egg
2009-08-07 17:36:48,923 Trac[loader] DEBUG: Loading
TracScreenshots.core from /opt/csw/lib/python/site-packages/
TracScreenshots-0.7-py2.5.egg
2009-08-07 17:36:49,418 Trac[loader] DEBUG: Loading
TracScreenshots.tags from /opt/csw/lib/python/site-packages/
TracScreenshots-0.7-py2.5.egg
2009-08-07 17:36:49,443 Trac[loader] DEBUG: Loading
TracScreenshots.timeline from /opt/csw/lib/python/site-packages/
TracScreenshots-0.7-py2.5.egg
2009-08-07 17:36:49,459 Trac[loader] DEBUG: Loading
TracScreenshots.init from /opt/csw/lib/python/site-packages/
TracScreenshots-0.7-py2.5.egg
2009-08-07 17:36:49,474 Trac[loader] DEBUG: Loading
TracScreenshots.matrix_view from /opt/csw/lib/python/site-packages/
TracScreenshots-0.7-py2.5.egg
2009-08-07 17:36:49,502 Trac[loader] DEBUG: Loading
TracScreenshots.api from /opt/csw/lib/python/site-packages/
TracScreenshots-0.7-py2.5.egg
2009-08-07 17:36:49,504 Trac[loader] DEBUG: Loading
TracScreenshots.wiki from /opt/csw/lib/python/site-packages/
TracScreenshots-0.7-py2.5.egg
2009-08-07 17:36:49,607 Trac[loader] DEBUG: Loading TracNav from /opt/
csw/lib/python/site-packages/TracNav-4.2.dev_r3275-py2.5.egg
2009-08-07 17:36:49,678 Trac[loader] DEBUG: Loading
tracsectionedit.web_ui from /opt/csw/lib/python/site-packages/
TracSectionEditPlugin-0.1-py2.5.egg
2009-08-07 17:36:49,716 Trac[loader] DEBUG: Loading codereview from /
opt/csw/lib/python/site-packages/TracCodeReview-2.0dev-py2.5.egg
2009-08-07 17:36:50,327 Trac[loader] DEBUG: Loading tracextracturl
from /opt/csw/lib/python/site-packages/TracExtractUrl-0.1-py2.5.egg
2009-08-07 17:36:50,351 Trac[loader] DEBUG: Loading
tracusermanager.account from /opt/csw/lib/python/site-packages/
TracUserManagerPlugin-0.4-py2.5.egg
2009-08-07 17:36:50,538 Trac[loader] DEBUG: Loading
tracusermanager.api from /opt/csw/lib/python/site-packages/
TracUserManagerPlugin-0.4-py2.5.egg
2009-08-07 17:36:50,541 Trac[loader] DEBUG: Loading
tracusermanager.profile from /opt/csw/lib/python/site-packages/
TracUserManagerPlugin-0.4-py2.5.egg
2009-08-07 17:36:50,702 Trac[loader] DEBUG: Loading
tracusermanager.permissions from /opt/csw/lib/python/site-packages/
TracUserManagerPlugin-0.4-py2.5.egg
2009-08-07 17:36:50,724 Trac[loader] DEBUG: Loading
tracusermanager.admin from /opt/csw/lib/python/site-packages/
TracUserManagerPlugin-0.4-py2.5.egg
2009-08-07 17:36:50,768 Trac[loader] DEBUG: Loading agilo.ticket.query
from /opt/csw/lib/python/site-packages/agilo-0.7.3.3_r1417_20090313-
py2.5.egg
2009-08-07 17:36:50,780 Trac[loader] ERROR: Skipping
"agilo.ticket.query = agilo.ticket.query": (version conflict
"VersionConflict: (Genshi 0.6dev-r0 (/opt/csw/lib/python/site-packages/
Genshi-0.6dev_r0-py2.6-solaris-2.10-sun4v.egg), Requirement.parse
('genshi>=0.5.1,<0.6dev'))")
2009-08-07 17:36:50,782 Trac[loader] DEBUG: Loading agilo.init from /
opt/csw/lib/python/site-packages/agilo-0.7.3.3_r1417_20090313-
py2.5.egg
2009-08-07 17:36:50,785 Trac[loader] ERROR: Skipping "agilo.init =
agilo.init": (version conflict "VersionConflict: (Genshi 0.6dev-r0 (/
opt/csw/lib/python/site-packages/Genshi-0.6dev_r0-py2.6-solaris-2.10-
sun4v.egg), Requirement.parse('genshi>=0.5.1,<0.6dev'))")
2009-08-07 17:36:50,788 Trac[loader] DEBUG: Loading agilo.help from /
opt/csw/lib/python/site-packages/agilo-0.7.3.3_r1417_20090313-
py2.5.egg
2009-08-07 17:36:50,791 Trac[loader] ERROR: Skipping "agilo.help =
agilo.help": (version conflict "VersionConflict: (Genshi 0.6dev-r0 (/
opt/csw/lib/python/site-packages/Genshi-0.6dev_r0-py2.6-solaris-2.10-
sun4v.egg), Requirement.parse('genshi>=0.5.1,<0.6dev'))")
2009-08-07 17:36:50,793 Trac[loader] DEBUG: Loading
agilo.ticket.web_ui from /opt/csw/lib/python/site-packages/
agilo-0.7.3.3_r1417_20090313-py2.5.egg
2009-08-07 17:36:50,797 Trac[loader] ERROR: Skipping
"agilo.ticket.web_ui = agilo.ticket.web_ui": (version conflict
"VersionConflict: (Genshi 0.6dev-r0 (/opt/csw/lib/python/site-packages/
Genshi-0.6dev_r0-py2.6-solaris-2.10-sun4v.egg), Requirement.parse
('genshi>=0.5.1,<0.6dev'))")
2009-08-07 17:36:50,799 Trac[loader] DEBUG: Loading agilo.scrum.web_ui
from /opt/csw/lib/python/site-packages/agilo-0.7.3.3_r1417_20090313-
py2.5.egg
2009-08-07 17:36:50,802 Trac[loader] ERROR: Skipping
"agilo.scrum.web_ui = agilo.scrum.web_ui": (version conflict
"VersionConflict: (Genshi 0.6dev-r0 (/opt/csw/lib/python/site-packages/
Genshi-0.6dev_r0-py2.6-solaris-2.10-sun4v.egg), Requirement.parse
('genshi>=0.5.1,<0.6dev'))")
2009-08-07 17:36:50,804 Trac[loader] DEBUG: Loading agilo.links.web_ui
from /opt/csw/lib/python/site-packages/agilo-0.7.3.3_r1417_20090313-
py2.5.egg
2009-08-07 17:36:50,808 Trac[loader] ERROR: Skipping
"agilo.links.web_ui = agilo.links.web_ui": (version conflict
"VersionConflict: (Genshi 0.6dev-r0 (/opt/csw/lib/python/site-packages/
Genshi-0.6dev_r0-py2.6-solaris-2.10-sun4v.egg), Requirement.parse
('genshi>=0.5.1,<0.6dev'))")
2009-08-07 17:36:50,810 Trac[loader] DEBUG: Loading
agilo.charts.chart_cache_invalidator from /opt/csw/lib/python/site-
packages/agilo-0.7.3.3_r1417_20090313-py2.5.egg
2009-08-07 17:36:50,813 Trac[loader] ERROR: Skipping
"agilo.charts.chart_cache_invalidator =
agilo.charts.chart_cache_invalidator": (version conflict
"VersionConflict: (Genshi 0.6dev-r0 (/opt/csw/lib/python/site-packages/
Genshi-0.6dev_r0-py2.6-solaris-2.10-sun4v.egg), Requirement.parse
('genshi>=0.5.1,<0.6dev'))")
2009-08-07 17:36:50,815 Trac[loader] DEBUG: Loading agilo.links.search
from /opt/csw/lib/python/site-packages/agilo-0.7.3.3_r1417_20090313-
py2.5.egg
2009-08-07 17:36:50,818 Trac[loader] ERROR: Skipping
"agilo.links.search = agilo.links.search": (version conflict
"VersionConflict: (Genshi 0.6dev-r0 (/opt/csw/lib/python/site-packages/
Genshi-0.6dev_r0-py2.6-solaris-2.10-sun4v.egg), Requirement.parse
('genshi>=0.5.1,<0.6dev'))")
2009-08-07 17:36:50,821 Trac[loader] DEBUG: Loading
agilo.scrum.burndown from /opt/csw/lib/python/site-packages/
agilo-0.7.3.3_r1417_20090313-py2.5.egg
2009-08-07 17:36:50,824 Trac[loader] ERROR: Skipping
"agilo.scrum.burndown = agilo.scrum.burndown": (version conflict
"VersionConflict: (Genshi 0.6dev-r0 (/opt/csw/lib/python/site-packages/
Genshi-0.6dev_r0-py2.6-solaris-2.10-sun4v.egg), Requirement.parse
('genshi>=0.5.1,<0.6dev'))")
2009-08-07 17:36:50,826 Trac[loader] DEBUG: Loading
agilo.charts.sprint_ticket_stats_chart from /opt/csw/lib/python/site-
packages/agilo-0.7.3.3_r1417_20090313-py2.5.egg
2009-08-07 17:36:50,829 Trac[loader] ERROR: Skipping
"agilo.charts.sprint_ticket_stats_chart =
agilo.charts.sprint_ticket_stats_chart": (version conflict
"VersionConflict: (Genshi 0.6dev-r0 (/opt/csw/lib/python/site-packages/
Genshi-0.6dev_r0-py2.6-solaris-2.10-sun4v.egg), Requirement.parse
('genshi>=0.5.1,<0.6dev'))")
2009-08-07 17:36:50,831 Trac[loader] DEBUG: Loading agilo.admin from /
opt/csw/lib/python/site-packages/agilo-0.7.3.3_r1417_20090313-
py2.5.egg
2009-08-07 17:36:50,834 Trac[loader] ERROR: Skipping "agilo.admin =
agilo.admin": (version conflict "VersionConflict: (Genshi 0.6dev-r0 (/
opt/csw/lib/python/site-packages/Genshi-0.6dev_r0-py2.6-solaris-2.10-
sun4v.egg), Requirement.parse('genshi>=0.5.1,<0.6dev'))")
2009-08-07 17:36:50,837 Trac[loader] DEBUG: Loading
agilo.charts.resource_assignment_piechart from /opt/csw/lib/python/
site-packages/agilo-0.7.3.3_r1417_20090313-py2.5.egg
2009-08-07 17:36:50,840 Trac[loader] ERROR: Skipping
"agilo.charts.resource_assignment_piechart =
agilo.charts.resource_assignment_piechart": (version conflict
"VersionConflict: (Genshi 0.6dev-r0 (/opt/csw/lib/python/site-packages/
Genshi-0.6dev_r0-py2.6-solaris-2.10-sun4v.egg), Requirement.parse
('genshi>=0.5.1,<0.6dev'))")
2009-08-07 17:36:50,842 Trac[loader] DEBUG: Loading
agilo.ticket.report from /opt/csw/lib/python/site-packages/
agilo-0.7.3.3_r1417_20090313-py2.5.egg
2009-08-07 17:36:50,845 Trac[loader] ERROR: Skipping
"agilo.ticket.report = agilo.ticket.report": (version conflict
"VersionConflict: (Genshi 0.6dev-r0 (/opt/csw/lib/python/site-packages/
Genshi-0.6dev_r0-py2.6-solaris-2.10-sun4v.egg), Requirement.parse
('genshi>=0.5.1,<0.6dev'))")
2009-08-07 17:36:50,848 Trac[loader] DEBUG: Loading
agilo.charts.metrics_chart from /opt/csw/lib/python/site-packages/
agilo-0.7.3.3_r1417_20090313-py2.5.egg
2009-08-07 17:36:50,851 Trac[loader] ERROR: Skipping
"agilo.charts.metrics_chart = agilo.charts.metrics_chart": (version
conflict "VersionConflict: (Genshi 0.6dev-r0 (/opt/csw/lib/python/site-
packages/Genshi-0.6dev_r0-py2.6-solaris-2.10-sun4v.egg),
Requirement.parse('genshi>=0.5.1,<0.6dev'))")
2009-08-07 17:36:50,853 Trac[loader] DEBUG: Loading
agilo.charts.burndown_chart from /opt/csw/lib/python/site-packages/
agilo-0.7.3.3_r1417_20090313-py2.5.egg
2009-08-07 17:36:50,856 Trac[loader] ERROR: Skipping
"agilo.charts.burndown_chart = agilo.charts.burndown_chart": (version
conflict "VersionConflict: (Genshi 0.6dev-r0 (/opt/csw/lib/python/site-
packages/Genshi-0.6dev_r0-py2.6-solaris-2.10-sun4v.egg),
Requirement.parse('genshi>=0.5.1,<0.6dev'))")
2009-08-07 17:36:50,858 Trac[loader] DEBUG: Loading
agilo.csv_import.web_ui from /opt/csw/lib/python/site-packages/
agilo-0.7.3.3_r1417_20090313-py2.5.egg
2009-08-07 17:36:50,862 Trac[loader] ERROR: Skipping
"agilo.csv_import.web_ui = agilo.csv_import.web_ui": (version conflict
"VersionConflict: (Genshi 0.6dev-r0 (/opt/csw/lib/python/site-packages/
Genshi-0.6dev_r0-py2.6-solaris-2.10-sun4v.egg), Requirement.parse
('genshi>=0.5.1,<0.6dev'))")
2009-08-07 17:36:50,864 Trac[loader] DEBUG: Loading
agilo.workflow.rules from /opt/csw/lib/python/site-packages/
agilo-0.7.3.3_r1417_20090313-py2.5.egg
2009-08-07 17:36:50,867 Trac[loader] ERROR: Skipping
"agilo.workflow.rules = agilo.workflow.rules": (version conflict
"VersionConflict: (Genshi 0.6dev-r0 (/opt/csw/lib/python/site-packages/
Genshi-0.6dev_r0-py2.6-solaris-2.10-sun4v.egg), Requirement.parse
('genshi>=0.5.1,<0.6dev'))")
2009-08-07 17:36:50,870 Trac[loader] DEBUG: Loading
agilo.utils.permissions from /opt/csw/lib/python/site-packages/
agilo-0.7.3.3_r1417_20090313-py2.5.egg
2009-08-07 17:36:50,873 Trac[loader] ERROR: Skipping
"agilo.utils.permissions = agilo.utils.permissions": (version conflict
"VersionConflict: (Genshi 0.6dev-r0 (/opt/csw/lib/python/site-packages/
Genshi-0.6dev_r0-py2.6-solaris-2.10-sun4v.egg), Requirement.parse
('genshi>=0.5.1,<0.6dev'))")
2009-08-07 17:36:50,875 Trac[loader] DEBUG: Loading agilo.utils.web_ui
from /opt/csw/lib/python/site-packages/agilo-0.7.3.3_r1417_20090313-
py2.5.egg
2009-08-07 17:36:50,878 Trac[loader] ERROR: Skipping
"agilo.utils.web_ui = agilo.utils.web_ui": (version conflict
"VersionConflict: (Genshi 0.6dev-r0 (/opt/csw/lib/python/site-packages/
Genshi-0.6dev_r0-py2.6-solaris-2.10-sun4v.egg), Requirement.parse
('genshi>=0.5.1,<0.6dev'))")
2009-08-07 17:36:50,880 Trac[loader] DEBUG: Loading
agilo.charts.macros from /opt/csw/lib/python/site-packages/
agilo-0.7.3.3_r1417_20090313-py2.5.egg
2009-08-07 17:36:50,883 Trac[loader] ERROR: Skipping
"agilo.charts.macros = agilo.charts.macros": (version conflict
"VersionConflict: (Genshi 0.6dev-r0 (/opt/csw/lib/python/site-packages/
Genshi-0.6dev_r0-py2.6-solaris-2.10-sun4v.egg), Requirement.parse
('genshi>=0.5.1,<0.6dev'))")
2009-08-07 17:36:50,888 Trac[loader] DEBUG: Loading autoupgrade from /
opt/csw/lib/python/site-packages/AutoUpgrade-0.1-py2.5.egg
2009-08-07 17:36:50,912 Trac[loader] DEBUG: Loading TracTicketDepgraph
from /opt/csw/lib/python/site-packages/TracTicketDepgraph-0.11-
py2.5.egg
2009-08-07 17:36:51,059 Trac[loader] DEBUG: Loading
mastertickets.web_ui from /opt/csw/lib/python/site-packages/
TracMasterTickets-2.1.3-py2.5.egg
2009-08-07 17:36:51,155 Trac[loader] DEBUG: Loading mastertickets.api
from /opt/csw/lib/python/site-packages/TracMasterTickets-2.1.3-
py2.5.egg
2009-08-07 17:36:51,203 Trac[loader] DEBUG: Loading
repositoryhooksystem from /opt/csw/lib/python/site-packages/
RepositoryHookSystem-0.1.1-py2.5.egg
2009-08-07 17:36:51,420 Trac[loader] DEBUG: Loading trachours.setup
from /opt/csw/lib/python/site-packages/TracHoursPlugin-0.3-py2.5.egg
2009-08-07 17:36:51,450 Trac[loader] DEBUG: Loading
trachours.multiproject from /opt/csw/lib/python/site-packages/
TracHoursPlugin-0.3-py2.5.egg
2009-08-07 17:36:53,035 Trac[loader] DEBUG: Loading
trachours.trachours from /opt/csw/lib/python/site-packages/
TracHoursPlugin-0.3-py2.5.egg
2009-08-07 17:36:53,150 Trac[loader] DEBUG: Loading
workfloweditor.workfloweditor_admin from /opt/csw/lib/python/site-
packages/WorkflowEditorPlugin-1.0.1_r5329-py2.5.egg
2009-08-07 17:36:53,201 Trac[loader] DEBUG: Loading
ticketchange.web_ui from /opt/csw/lib/python/site-packages/
TracTicketChange-0.0.4-py2.5.egg
2009-08-07 17:36:53,263 Trac[loader] DEBUG: Loading
tracserversideredirect.plugin from /opt/csw/lib/python/site-packages/
TracServerSideRedirectPlugin-0.1-py2.5.egg
2009-08-07 17:36:53,326 Trac[loader] DEBUG: Loading wikiprint.formats
from /opt/csw/lib/python/site-packages/TracWikiPrintPlugin-1.1-
py2.5.egg
2009-08-07 17:36:53,823 Trac[loader] DEBUG: Skipping
"wikiprint.formats = wikiprint.formats": ("DistributionNotFound:
reportlab" not found)
2009-08-07 17:36:53,825 Trac[loader] DEBUG: Loading wikiprint.web_ui
from /opt/csw/lib/python/site-packages/TracWikiPrintPlugin-1.1-
py2.5.egg
2009-08-07 17:36:54,291 Trac[loader] DEBUG: Skipping "wikiprint.web_ui
= wikiprint.web_ui": ("DistributionNotFound: reportlab" not found)
2009-08-07 17:36:54,293 Trac[loader] DEBUG: Loading
wikiprint.wikitopdf from /opt/csw/lib/python/site-packages/
TracWikiPrintPlugin-1.1-py2.5.egg
2009-08-07 17:36:54,795 Trac[loader] DEBUG: Skipping
"wikiprint.wikitopdf = wikiprint.wikitopdf": ("DistributionNotFound:
reportlab" not found)
2009-08-07 17:36:54,938 Trac[loader] DEBUG: Loading TracXMLRPC from /
opt/csw/lib/python/site-packages/TracXMLRPC-1.0.5-py2.6.egg
2009-08-07 17:36:55,383 Trac[loader] DEBUG: Loading trac.ticket.web_ui
from /opt/csw/lib/python/site-packages/Trac-0.11.5stable_r0-py2.6.egg
2009-08-07 17:36:55,388 Trac[loader] DEBUG: Loading trac.mimeview.php
from /opt/csw/lib/python/site-packages/Trac-0.11.5stable_r0-py2.6.egg
2009-08-07 17:36:55,399 Trac[loader] DEBUG: Loading trac.ticket.query
from /opt/csw/lib/python/site-packages/Trac-0.11.5stable_r0-py2.6.egg
2009-08-07 17:36:55,404 Trac[loader] DEBUG: Loading trac.attachment
from /opt/csw/lib/python/site-packages/Trac-0.11.5stable_r0-py2.6.egg
2009-08-07 17:36:55,408 Trac[loader] DEBUG: Loading
trac.versioncontrol.svn_fs from /opt/csw/lib/python/site-packages/
Trac-0.11.5stable_r0-py2.6.egg
2009-08-07 17:36:55,441 Trac[loader] DEBUG: Loading
trac.mimeview.patch from /opt/csw/lib/python/site-packages/
Trac-0.11.5stable_r0-py2.6.egg
2009-08-07 17:36:55,450 Trac[loader] DEBUG: Loading trac.mimeview.txtl
from /opt/csw/lib/python/site-packages/Trac-0.11.5stable_r0-py2.6.egg
2009-08-07 17:36:55,912 Trac[loader] DEBUG: Skipping
"trac.mimeview.txtl = trac.mimeview.txtl [textile]":
("DistributionNotFound: textile>=2.0" not found)
2009-08-07 17:36:55,914 Trac[loader] DEBUG: Loading trac.admin.web_ui
from /opt/csw/lib/python/site-packages/Trac-0.11.5stable_r0-py2.6.egg
2009-08-07 17:36:55,919 Trac[loader] DEBUG: Loading trac.ticket.admin
from /opt/csw/lib/python/site-packages/Trac-0.11.5stable_r0-py2.6.egg
2009-08-07 17:36:55,936 Trac[loader] DEBUG: Loading trac.mimeview.rst
from /opt/csw/lib/python/site-packages/Trac-0.11.5stable_r0-py2.6.egg
2009-08-07 17:36:57,278 Trac[loader] DEBUG: Loading trac.db.postgres
from /opt/csw/lib/python/site-packages/Trac-0.11.5stable_r0-py2.6.egg
2009-08-07 17:36:57,299 Trac[loader] DEBUG: Loading
trac.versioncontrol.web_ui from /opt/csw/lib/python/site-packages/
Trac-0.11.5stable_r0-py2.6.egg
2009-08-07 17:36:57,305 Trac[loader] DEBUG: Loading trac.timeline
from /opt/csw/lib/python/site-packages/Trac-0.11.5stable_r0-py2.6.egg
2009-08-07 17:36:57,325 Trac[loader] DEBUG: Loading
trac.mimeview.pygments from /opt/csw/lib/python/site-packages/
Trac-0.11.5stable_r0-py2.6.egg
2009-08-07 17:36:57,640 Trac[loader] DEBUG: Loading trac.about from /
opt/csw/lib/python/site-packages/Trac-0.11.5stable_r0-py2.6.egg
2009-08-07 17:36:57,649 Trac[loader] DEBUG: Loading
trac.wiki.interwiki from /opt/csw/lib/python/site-packages/
Trac-0.11.5stable_r0-py2.6.egg
2009-08-07 17:36:57,673 Trac[loader] DEBUG: Loading
trac.ticket.roadmap from /opt/csw/lib/python/site-packages/
Trac-0.11.5stable_r0-py2.6.egg
2009-08-07 17:36:57,678 Trac[loader] DEBUG: Loading
trac.mimeview.silvercity from /opt/csw/lib/python/site-packages/
Trac-0.11.5stable_r0-py2.6.egg
2009-08-07 17:36:58,166 Trac[loader] DEBUG: Skipping
"trac.mimeview.silvercity = trac.mimeview.silvercity [silvercity]":
("DistributionNotFound: SilverCity>=0.9.4" not found)
2009-08-07 17:36:58,168 Trac[loader] DEBUG: Loading trac.wiki.macros
from /opt/csw/lib/python/site-packages/Trac-0.11.5stable_r0-py2.6.egg
2009-08-07 17:36:58,173 Trac[loader] DEBUG: Loading trac.db.sqlite
from /opt/csw/lib/python/site-packages/Trac-0.11.5stable_r0-py2.6.egg
2009-08-07 17:36:58,248 Trac[loader] DEBUG: Loading trac.wiki.web_ui
from /opt/csw/lib/python/site-packages/Trac-0.11.5stable_r0-py2.6.egg
2009-08-07 17:36:58,263 Trac[loader] DEBUG: Loading
trac.mimeview.enscript from /opt/csw/lib/python/site-packages/
Trac-0.11.5stable_r0-py2.6.egg
2009-08-07 17:36:58,273 Trac[loader] DEBUG: Loading trac.web.auth
from /opt/csw/lib/python/site-packages/Trac-0.11.5stable_r0-py2.6.egg
2009-08-07 17:36:58,278 Trac[loader] DEBUG: Loading trac.admin.console
from /opt/csw/lib/python/site-packages/Trac-0.11.5stable_r0-py2.6.egg
2009-08-07 17:36:58,388 Trac[loader] DEBUG: Loading trac.db.mysql
from /opt/csw/lib/python/site-packages/Trac-0.11.5stable_r0-py2.6.egg
2009-08-07 17:36:58,427 Trac[loader] DEBUG: Loading trac.search from /
opt/csw/lib/python/site-packages/Trac-0.11.5stable_r0-py2.6.egg
2009-08-07 17:36:58,432 Trac[loader] DEBUG: Loading trac.prefs from /
opt/csw/lib/python/site-packages/Trac-0.11.5stable_r0-py2.6.egg
2009-08-07 17:36:58,447 Trac[loader] DEBUG: Loading trac.ticket.report
from /opt/csw/lib/python/site-packages/Trac-0.11.5stable_r0-py2.6.egg
2009-08-07 17:36:58,463 Trac[loader] DEBUG: Loading tractags from /opt/
csw/lib/python/site-packages/TracTags-0.6-py2.6.egg
2009-08-07 17:36:58,482 Trac[loader] DEBUG: Loading qatracker from /
opt/csw/lib/python/site-packages/QATracker-0.1_alpha-py2.6.egg
2009-08-07 17:36:58,510 Trac[loader] DEBUG: Loading autocompleteusers
from /opt/csw/lib/python/site-packages/AutocompleteUsers-0.4.1-
py2.6.egg
2009-08-07 17:36:58,604 Trac[loader] DEBUG: Loading svnauthz.admin_ui
from /opt/csw/lib/python/site-packages/
SvnAuthzAdminPlugin-0.1.2._Moved.to.Trac.0.11_-py2.6.egg
2009-08-07 17:36:59,015 Trac[default_workflow] DEBUG: Workflow actions
at initialization: {'resolve': {'operations': [u'set_resolution'],
'name': 'resolve', 'default': 0, 'newstate': u'closed', 'oldstates':
[u'new', u'assigned', u'reopened'], 'permissions':
[u'TICKET_MODIFY']}, 'accept': {'operations': [u'set_owner_to_self'],
'name': 'accept', 'default': 0, 'newstate': u'assigned', 'oldstates':
[u'new'], 'permissions': [u'TICKET_MODIFY']}, 'leave': {'operations':
[u'leave_status'], 'name': 'leave', 'default': 1, 'newstate': u'*',
'oldstates': [u'*'], 'permissions': []}, 'reopen': {'operations':
[u'del_resolution'], 'name': 'reopen', 'default': 0, 'newstate':
u'reopened', 'oldstates': [u'closed'], 'permissions':
[u'TICKET_CREATE']}, 'reassign': {'operations': [u'set_owner'],
'name': 'reassign', 'default': 0, 'newstate': u'new', 'oldstates':
[u'new', u'assigned', u'reopened'], 'permissions':
[u'TICKET_MODIFY']}, '_reset': {'operations': ['reset_workflow'],
'name': 'reset', 'default': 0, 'newstate': 'new', 'oldstates': [],
'permissions': []}}
2009-08-07 17:36:59,257 Trac[main] DEBUG: Dispatching <Request "POST
u'/admin/subversion/svnauthz'">
2009-08-07 17:37:00,465 Trac[api] DEBUG: action controllers for ticket
workflow: ['ConfigurableTicketWorkflow']
2009-08-07 17:37:02,079 Trac[svn_fs] DEBUG: Subversion bindings
imported
2009-08-07 17:37:02,627 Trac[admin_ui] DEBUG: SvnAuthzAdminPlugin:
cat=subversion page=svnauthz path_info=None
2009-08-07 17:37:02,811 Trac[chrome] DEBUG: Prepare chrome data for
request
2009-08-07 17:37:02,956 Trac[session] DEBUG: Retrieving session for ID
'rupert.thurner'
overload that on every click we have 160 lines caused by plugins in
our log file. is this really necessary?
2009-08-07 17:36:44,918 Trac[loader] DEBUG: Loading datefield.filter
from /opt/csw/lib/python/site-packages/TracDateField-1.0.1-py2.5.egg
2009-08-07 17:36:45,189 Trac[loader] DEBUG: Loading tracreposearch
from /opt/csw/lib/python/site-packages/tracreposearch-0.2-py2.5.egg
2009-08-07 17:36:45,223 Trac[loader] DEBUG: Loading newsflash.macro
from /opt/csw/lib/python/site-packages/TracNewsFlash-0.1-py2.5.egg
2009-08-07 17:36:45,335 Trac[loader] DEBUG: Loading tracwysiwyg from /
opt/csw/lib/python/site-packages/TracWysiwyg-0.2_r4353-py2.5.egg
2009-08-07 17:36:45,358 Trac[loader] DEBUG: Loading
ticketdelete.web_ui from /opt/csw/lib/python/site-packages/
TracTicketDelete-2.0-py2.5.egg
2009-08-07 17:36:45,415 Trac[loader] DEBUG: Loading iniadmin from /opt/
csw/lib/python/site-packages/IniAdmin-0.2-py2.5.egg
2009-08-07 17:36:45,449 Trac[loader] DEBUG: Loading
customfieldadmin.api from /opt/csw/lib/python/site-packages/
TracCustomFieldAdmin-0.2-py2.5.egg
2009-08-07 17:36:45,481 Trac[loader] DEBUG: Loading
customfieldadmin.customfieldadmin from /opt/csw/lib/python/site-
packages/TracCustomFieldAdmin-0.2-py2.5.egg
2009-08-07 17:36:45,514 Trac[loader] DEBUG: Loading announcerplugin
from /opt/csw/lib/python/site-packages/AnnouncerPlugin-0.2-py2.5.egg
2009-08-07 17:36:46,179 Trac[loader] DEBUG: Loading
TracDownloads.timeline from /opt/csw/lib/python/site-packages/
TracDownloads-0.2-py2.5.egg
2009-08-07 17:36:46,425 Trac[loader] DEBUG: Loading TracDownloads.api
from /opt/csw/lib/python/site-packages/TracDownloads-0.2-py2.5.egg
2009-08-07 17:36:46,428 Trac[loader] DEBUG: Loading TracDownloads.wiki
from /opt/csw/lib/python/site-packages/TracDownloads-0.2-py2.5.egg
2009-08-07 17:36:46,441 Trac[loader] DEBUG: Loading TracDownloads.core
from /opt/csw/lib/python/site-packages/TracDownloads-0.2-py2.5.egg
2009-08-07 17:36:46,461 Trac[loader] DEBUG: Loading TracDownloads.init
from /opt/csw/lib/python/site-packages/TracDownloads-0.2-py2.5.egg
2009-08-07 17:36:46,474 Trac[loader] DEBUG: Loading TracDownloads.tags
from /opt/csw/lib/python/site-packages/TracDownloads-0.2-py2.5.egg
2009-08-07 17:36:46,680 Trac[loader] DEBUG: Loading
TracDownloads.admin from /opt/csw/lib/python/site-packages/
TracDownloads-0.2-py2.5.egg
2009-08-07 17:36:46,712 Trac[loader] DEBUG: Loading tracfullblog.db
from /opt/csw/lib/python/site-packages/TracFullBlogPlugin-0.1-
py2.5.egg
2009-08-07 17:36:46,730 Trac[loader] DEBUG: Loading tracfullblog.core
from /opt/csw/lib/python/site-packages/TracFullBlogPlugin-0.1-
py2.5.egg
2009-08-07 17:36:46,790 Trac[loader] DEBUG: Loading
tracfullblog.web_ui from /opt/csw/lib/python/site-packages/
TracFullBlogPlugin-0.1-py2.5.egg
2009-08-07 17:36:46,802 Trac[loader] DEBUG: Loading
tracfullblog.macros from /opt/csw/lib/python/site-packages/
TracFullBlogPlugin-0.1-py2.5.egg
2009-08-07 17:36:46,808 Trac[loader] DEBUG: Loading
tracfullblog.spamfilter from /opt/csw/lib/python/site-packages/
TracFullBlogPlugin-0.1-py2.5.egg
2009-08-07 17:36:47,295 Trac[loader] DEBUG: Skipping
"tracfullblog.spamfilter = tracfullblog.spamfilter [spamfilter]":
("DistributionNotFound: TracSpamFilter>=0.2" not found)
2009-08-07 17:36:47,297 Trac[loader] DEBUG: Loading tracfullblog.tags
from /opt/csw/lib/python/site-packages/TracFullBlogPlugin-0.1-
py2.5.egg
2009-08-07 17:36:47,308 Trac[loader] DEBUG: Loading tracfullblog.admin
from /opt/csw/lib/python/site-packages/TracFullBlogPlugin-0.1-
py2.5.egg
2009-08-07 17:36:47,317 Trac[loader] DEBUG: Loading CustomRoadmap
from /opt/csw/lib/python/site-packages/TracCustomRoadmap-0.4-py2.5.egg
2009-08-07 17:36:47,446 Trac[loader] DEBUG: Loading tractoc.macro
from /opt/csw/lib/python/site-packages/TracTocMacro-11.0.0.3-py2.5.egg
2009-08-07 17:36:47,501 Trac[loader] DEBUG: Loading
includemacro.macros from /opt/csw/lib/python/site-packages/
TracIncludeMacro-2.1-py2.5.egg
2009-08-07 17:36:47,652 Trac[loader] DEBUG: Loading
TracDiscussion.core from /opt/csw/lib/python/site-packages/
TracDiscussion-0.6-py2.5.egg
2009-08-07 17:36:47,915 Trac[loader] DEBUG: Loading TracDiscussion.api
from /opt/csw/lib/python/site-packages/TracDiscussion-0.6-py2.5.egg
2009-08-07 17:36:47,918 Trac[loader] DEBUG: Loading
TracDiscussion.init from /opt/csw/lib/python/site-packages/
TracDiscussion-0.6-py2.5.egg
2009-08-07 17:36:47,932 Trac[loader] DEBUG: Loading
TracDiscussion.search from /opt/csw/lib/python/site-packages/
TracDiscussion-0.6-py2.5.egg
2009-08-07 17:36:47,956 Trac[loader] DEBUG: Loading
TracDiscussion.timeline from /opt/csw/lib/python/site-packages/
TracDiscussion-0.6-py2.5.egg
2009-08-07 17:36:47,995 Trac[loader] DEBUG: Loading
TracDiscussion.wiki from /opt/csw/lib/python/site-packages/
TracDiscussion-0.6-py2.5.egg
2009-08-07 17:36:48,030 Trac[loader] DEBUG: Loading
TracDiscussion.admin from /opt/csw/lib/python/site-packages/
TracDiscussion-0.6-py2.5.egg
2009-08-07 17:36:48,043 Trac[loader] DEBUG: Loading
TracDiscussion.notification from /opt/csw/lib/python/site-packages/
TracDiscussion-0.6-py2.5.egg
2009-08-07 17:36:48,076 Trac[loader] DEBUG: Loading graphviz from /opt/
csw/lib/python/site-packages/graphviz-0.7.5dev-py2.5.egg
2009-08-07 17:36:48,348 Trac[loader] DEBUG: Loading acct_mgr.admin
from /opt/csw/lib/python/site-packages/
TracAccountManager-0.2.1dev_r4698-py2.5.egg
2009-08-07 17:36:48,572 Trac[loader] DEBUG: Loading acct_mgr.db from /
opt/csw/lib/python/site-packages/TracAccountManager-0.2.1dev_r4698-
py2.5.egg
2009-08-07 17:36:48,696 Trac[loader] DEBUG: Loading acct_mgr.htfile
from /opt/csw/lib/python/site-packages/
TracAccountManager-0.2.1dev_r4698-py2.5.egg
2009-08-07 17:36:48,756 Trac[loader] DEBUG: Loading acct_mgr.http
from /opt/csw/lib/python/site-packages/
TracAccountManager-0.2.1dev_r4698-py2.5.egg
2009-08-07 17:36:48,767 Trac[loader] DEBUG: Loading
acct_mgr.notification from /opt/csw/lib/python/site-packages/
TracAccountManager-0.2.1dev_r4698-py2.5.egg
2009-08-07 17:36:48,811 Trac[loader] DEBUG: Loading acct_mgr.pwhash
from /opt/csw/lib/python/site-packages/
TracAccountManager-0.2.1dev_r4698-py2.5.egg
2009-08-07 17:36:48,813 Trac[loader] DEBUG: Loading acct_mgr.svnserve
from /opt/csw/lib/python/site-packages/
TracAccountManager-0.2.1dev_r4698-py2.5.egg
2009-08-07 17:36:48,831 Trac[loader] DEBUG: Loading acct_mgr.web_ui
from /opt/csw/lib/python/site-packages/
TracAccountManager-0.2.1dev_r4698-py2.5.egg
2009-08-07 17:36:48,833 Trac[loader] DEBUG: Loading acct_mgr.api from /
opt/csw/lib/python/site-packages/TracAccountManager-0.2.1dev_r4698-
py2.5.egg
2009-08-07 17:36:48,839 Trac[loader] DEBUG: Loading
permredirect.filter from /opt/csw/lib/python/site-packages/
TracPermRedirect-2.0-py2.5.egg
2009-08-07 17:36:48,923 Trac[loader] DEBUG: Loading
TracScreenshots.core from /opt/csw/lib/python/site-packages/
TracScreenshots-0.7-py2.5.egg
2009-08-07 17:36:49,418 Trac[loader] DEBUG: Loading
TracScreenshots.tags from /opt/csw/lib/python/site-packages/
TracScreenshots-0.7-py2.5.egg
2009-08-07 17:36:49,443 Trac[loader] DEBUG: Loading
TracScreenshots.timeline from /opt/csw/lib/python/site-packages/
TracScreenshots-0.7-py2.5.egg
2009-08-07 17:36:49,459 Trac[loader] DEBUG: Loading
TracScreenshots.init from /opt/csw/lib/python/site-packages/
TracScreenshots-0.7-py2.5.egg
2009-08-07 17:36:49,474 Trac[loader] DEBUG: Loading
TracScreenshots.matrix_view from /opt/csw/lib/python/site-packages/
TracScreenshots-0.7-py2.5.egg
2009-08-07 17:36:49,502 Trac[loader] DEBUG: Loading
TracScreenshots.api from /opt/csw/lib/python/site-packages/
TracScreenshots-0.7-py2.5.egg
2009-08-07 17:36:49,504 Trac[loader] DEBUG: Loading
TracScreenshots.wiki from /opt/csw/lib/python/site-packages/
TracScreenshots-0.7-py2.5.egg
2009-08-07 17:36:49,607 Trac[loader] DEBUG: Loading TracNav from /opt/
csw/lib/python/site-packages/TracNav-4.2.dev_r3275-py2.5.egg
2009-08-07 17:36:49,678 Trac[loader] DEBUG: Loading
tracsectionedit.web_ui from /opt/csw/lib/python/site-packages/
TracSectionEditPlugin-0.1-py2.5.egg
2009-08-07 17:36:49,716 Trac[loader] DEBUG: Loading codereview from /
opt/csw/lib/python/site-packages/TracCodeReview-2.0dev-py2.5.egg
2009-08-07 17:36:50,327 Trac[loader] DEBUG: Loading tracextracturl
from /opt/csw/lib/python/site-packages/TracExtractUrl-0.1-py2.5.egg
2009-08-07 17:36:50,351 Trac[loader] DEBUG: Loading
tracusermanager.account from /opt/csw/lib/python/site-packages/
TracUserManagerPlugin-0.4-py2.5.egg
2009-08-07 17:36:50,538 Trac[loader] DEBUG: Loading
tracusermanager.api from /opt/csw/lib/python/site-packages/
TracUserManagerPlugin-0.4-py2.5.egg
2009-08-07 17:36:50,541 Trac[loader] DEBUG: Loading
tracusermanager.profile from /opt/csw/lib/python/site-packages/
TracUserManagerPlugin-0.4-py2.5.egg
2009-08-07 17:36:50,702 Trac[loader] DEBUG: Loading
tracusermanager.permissions from /opt/csw/lib/python/site-packages/
TracUserManagerPlugin-0.4-py2.5.egg
2009-08-07 17:36:50,724 Trac[loader] DEBUG: Loading
tracusermanager.admin from /opt/csw/lib/python/site-packages/
TracUserManagerPlugin-0.4-py2.5.egg
2009-08-07 17:36:50,768 Trac[loader] DEBUG: Loading agilo.ticket.query
from /opt/csw/lib/python/site-packages/agilo-0.7.3.3_r1417_20090313-
py2.5.egg
2009-08-07 17:36:50,780 Trac[loader] ERROR: Skipping
"agilo.ticket.query = agilo.ticket.query": (version conflict
"VersionConflict: (Genshi 0.6dev-r0 (/opt/csw/lib/python/site-packages/
Genshi-0.6dev_r0-py2.6-solaris-2.10-sun4v.egg), Requirement.parse
('genshi>=0.5.1,<0.6dev'))")
2009-08-07 17:36:50,782 Trac[loader] DEBUG: Loading agilo.init from /
opt/csw/lib/python/site-packages/agilo-0.7.3.3_r1417_20090313-
py2.5.egg
2009-08-07 17:36:50,785 Trac[loader] ERROR: Skipping "agilo.init =
agilo.init": (version conflict "VersionConflict: (Genshi 0.6dev-r0 (/
opt/csw/lib/python/site-packages/Genshi-0.6dev_r0-py2.6-solaris-2.10-
sun4v.egg), Requirement.parse('genshi>=0.5.1,<0.6dev'))")
2009-08-07 17:36:50,788 Trac[loader] DEBUG: Loading agilo.help from /
opt/csw/lib/python/site-packages/agilo-0.7.3.3_r1417_20090313-
py2.5.egg
2009-08-07 17:36:50,791 Trac[loader] ERROR: Skipping "agilo.help =
agilo.help": (version conflict "VersionConflict: (Genshi 0.6dev-r0 (/
opt/csw/lib/python/site-packages/Genshi-0.6dev_r0-py2.6-solaris-2.10-
sun4v.egg), Requirement.parse('genshi>=0.5.1,<0.6dev'))")
2009-08-07 17:36:50,793 Trac[loader] DEBUG: Loading
agilo.ticket.web_ui from /opt/csw/lib/python/site-packages/
agilo-0.7.3.3_r1417_20090313-py2.5.egg
2009-08-07 17:36:50,797 Trac[loader] ERROR: Skipping
"agilo.ticket.web_ui = agilo.ticket.web_ui": (version conflict
"VersionConflict: (Genshi 0.6dev-r0 (/opt/csw/lib/python/site-packages/
Genshi-0.6dev_r0-py2.6-solaris-2.10-sun4v.egg), Requirement.parse
('genshi>=0.5.1,<0.6dev'))")
2009-08-07 17:36:50,799 Trac[loader] DEBUG: Loading agilo.scrum.web_ui
from /opt/csw/lib/python/site-packages/agilo-0.7.3.3_r1417_20090313-
py2.5.egg
2009-08-07 17:36:50,802 Trac[loader] ERROR: Skipping
"agilo.scrum.web_ui = agilo.scrum.web_ui": (version conflict
"VersionConflict: (Genshi 0.6dev-r0 (/opt/csw/lib/python/site-packages/
Genshi-0.6dev_r0-py2.6-solaris-2.10-sun4v.egg), Requirement.parse
('genshi>=0.5.1,<0.6dev'))")
2009-08-07 17:36:50,804 Trac[loader] DEBUG: Loading agilo.links.web_ui
from /opt/csw/lib/python/site-packages/agilo-0.7.3.3_r1417_20090313-
py2.5.egg
2009-08-07 17:36:50,808 Trac[loader] ERROR: Skipping
"agilo.links.web_ui = agilo.links.web_ui": (version conflict
"VersionConflict: (Genshi 0.6dev-r0 (/opt/csw/lib/python/site-packages/
Genshi-0.6dev_r0-py2.6-solaris-2.10-sun4v.egg), Requirement.parse
('genshi>=0.5.1,<0.6dev'))")
2009-08-07 17:36:50,810 Trac[loader] DEBUG: Loading
agilo.charts.chart_cache_invalidator from /opt/csw/lib/python/site-
packages/agilo-0.7.3.3_r1417_20090313-py2.5.egg
2009-08-07 17:36:50,813 Trac[loader] ERROR: Skipping
"agilo.charts.chart_cache_invalidator =
agilo.charts.chart_cache_invalidator": (version conflict
"VersionConflict: (Genshi 0.6dev-r0 (/opt/csw/lib/python/site-packages/
Genshi-0.6dev_r0-py2.6-solaris-2.10-sun4v.egg), Requirement.parse
('genshi>=0.5.1,<0.6dev'))")
2009-08-07 17:36:50,815 Trac[loader] DEBUG: Loading agilo.links.search
from /opt/csw/lib/python/site-packages/agilo-0.7.3.3_r1417_20090313-
py2.5.egg
2009-08-07 17:36:50,818 Trac[loader] ERROR: Skipping
"agilo.links.search = agilo.links.search": (version conflict
"VersionConflict: (Genshi 0.6dev-r0 (/opt/csw/lib/python/site-packages/
Genshi-0.6dev_r0-py2.6-solaris-2.10-sun4v.egg), Requirement.parse
('genshi>=0.5.1,<0.6dev'))")
2009-08-07 17:36:50,821 Trac[loader] DEBUG: Loading
agilo.scrum.burndown from /opt/csw/lib/python/site-packages/
agilo-0.7.3.3_r1417_20090313-py2.5.egg
2009-08-07 17:36:50,824 Trac[loader] ERROR: Skipping
"agilo.scrum.burndown = agilo.scrum.burndown": (version conflict
"VersionConflict: (Genshi 0.6dev-r0 (/opt/csw/lib/python/site-packages/
Genshi-0.6dev_r0-py2.6-solaris-2.10-sun4v.egg), Requirement.parse
('genshi>=0.5.1,<0.6dev'))")
2009-08-07 17:36:50,826 Trac[loader] DEBUG: Loading
agilo.charts.sprint_ticket_stats_chart from /opt/csw/lib/python/site-
packages/agilo-0.7.3.3_r1417_20090313-py2.5.egg
2009-08-07 17:36:50,829 Trac[loader] ERROR: Skipping
"agilo.charts.sprint_ticket_stats_chart =
agilo.charts.sprint_ticket_stats_chart": (version conflict
"VersionConflict: (Genshi 0.6dev-r0 (/opt/csw/lib/python/site-packages/
Genshi-0.6dev_r0-py2.6-solaris-2.10-sun4v.egg), Requirement.parse
('genshi>=0.5.1,<0.6dev'))")
2009-08-07 17:36:50,831 Trac[loader] DEBUG: Loading agilo.admin from /
opt/csw/lib/python/site-packages/agilo-0.7.3.3_r1417_20090313-
py2.5.egg
2009-08-07 17:36:50,834 Trac[loader] ERROR: Skipping "agilo.admin =
agilo.admin": (version conflict "VersionConflict: (Genshi 0.6dev-r0 (/
opt/csw/lib/python/site-packages/Genshi-0.6dev_r0-py2.6-solaris-2.10-
sun4v.egg), Requirement.parse('genshi>=0.5.1,<0.6dev'))")
2009-08-07 17:36:50,837 Trac[loader] DEBUG: Loading
agilo.charts.resource_assignment_piechart from /opt/csw/lib/python/
site-packages/agilo-0.7.3.3_r1417_20090313-py2.5.egg
2009-08-07 17:36:50,840 Trac[loader] ERROR: Skipping
"agilo.charts.resource_assignment_piechart =
agilo.charts.resource_assignment_piechart": (version conflict
"VersionConflict: (Genshi 0.6dev-r0 (/opt/csw/lib/python/site-packages/
Genshi-0.6dev_r0-py2.6-solaris-2.10-sun4v.egg), Requirement.parse
('genshi>=0.5.1,<0.6dev'))")
2009-08-07 17:36:50,842 Trac[loader] DEBUG: Loading
agilo.ticket.report from /opt/csw/lib/python/site-packages/
agilo-0.7.3.3_r1417_20090313-py2.5.egg
2009-08-07 17:36:50,845 Trac[loader] ERROR: Skipping
"agilo.ticket.report = agilo.ticket.report": (version conflict
"VersionConflict: (Genshi 0.6dev-r0 (/opt/csw/lib/python/site-packages/
Genshi-0.6dev_r0-py2.6-solaris-2.10-sun4v.egg), Requirement.parse
('genshi>=0.5.1,<0.6dev'))")
2009-08-07 17:36:50,848 Trac[loader] DEBUG: Loading
agilo.charts.metrics_chart from /opt/csw/lib/python/site-packages/
agilo-0.7.3.3_r1417_20090313-py2.5.egg
2009-08-07 17:36:50,851 Trac[loader] ERROR: Skipping
"agilo.charts.metrics_chart = agilo.charts.metrics_chart": (version
conflict "VersionConflict: (Genshi 0.6dev-r0 (/opt/csw/lib/python/site-
packages/Genshi-0.6dev_r0-py2.6-solaris-2.10-sun4v.egg),
Requirement.parse('genshi>=0.5.1,<0.6dev'))")
2009-08-07 17:36:50,853 Trac[loader] DEBUG: Loading
agilo.charts.burndown_chart from /opt/csw/lib/python/site-packages/
agilo-0.7.3.3_r1417_20090313-py2.5.egg
2009-08-07 17:36:50,856 Trac[loader] ERROR: Skipping
"agilo.charts.burndown_chart = agilo.charts.burndown_chart": (version
conflict "VersionConflict: (Genshi 0.6dev-r0 (/opt/csw/lib/python/site-
packages/Genshi-0.6dev_r0-py2.6-solaris-2.10-sun4v.egg),
Requirement.parse('genshi>=0.5.1,<0.6dev'))")
2009-08-07 17:36:50,858 Trac[loader] DEBUG: Loading
agilo.csv_import.web_ui from /opt/csw/lib/python/site-packages/
agilo-0.7.3.3_r1417_20090313-py2.5.egg
2009-08-07 17:36:50,862 Trac[loader] ERROR: Skipping
"agilo.csv_import.web_ui = agilo.csv_import.web_ui": (version conflict
"VersionConflict: (Genshi 0.6dev-r0 (/opt/csw/lib/python/site-packages/
Genshi-0.6dev_r0-py2.6-solaris-2.10-sun4v.egg), Requirement.parse
('genshi>=0.5.1,<0.6dev'))")
2009-08-07 17:36:50,864 Trac[loader] DEBUG: Loading
agilo.workflow.rules from /opt/csw/lib/python/site-packages/
agilo-0.7.3.3_r1417_20090313-py2.5.egg
2009-08-07 17:36:50,867 Trac[loader] ERROR: Skipping
"agilo.workflow.rules = agilo.workflow.rules": (version conflict
"VersionConflict: (Genshi 0.6dev-r0 (/opt/csw/lib/python/site-packages/
Genshi-0.6dev_r0-py2.6-solaris-2.10-sun4v.egg), Requirement.parse
('genshi>=0.5.1,<0.6dev'))")
2009-08-07 17:36:50,870 Trac[loader] DEBUG: Loading
agilo.utils.permissions from /opt/csw/lib/python/site-packages/
agilo-0.7.3.3_r1417_20090313-py2.5.egg
2009-08-07 17:36:50,873 Trac[loader] ERROR: Skipping
"agilo.utils.permissions = agilo.utils.permissions": (version conflict
"VersionConflict: (Genshi 0.6dev-r0 (/opt/csw/lib/python/site-packages/
Genshi-0.6dev_r0-py2.6-solaris-2.10-sun4v.egg), Requirement.parse
('genshi>=0.5.1,<0.6dev'))")
2009-08-07 17:36:50,875 Trac[loader] DEBUG: Loading agilo.utils.web_ui
from /opt/csw/lib/python/site-packages/agilo-0.7.3.3_r1417_20090313-
py2.5.egg
2009-08-07 17:36:50,878 Trac[loader] ERROR: Skipping
"agilo.utils.web_ui = agilo.utils.web_ui": (version conflict
"VersionConflict: (Genshi 0.6dev-r0 (/opt/csw/lib/python/site-packages/
Genshi-0.6dev_r0-py2.6-solaris-2.10-sun4v.egg), Requirement.parse
('genshi>=0.5.1,<0.6dev'))")
2009-08-07 17:36:50,880 Trac[loader] DEBUG: Loading
agilo.charts.macros from /opt/csw/lib/python/site-packages/
agilo-0.7.3.3_r1417_20090313-py2.5.egg
2009-08-07 17:36:50,883 Trac[loader] ERROR: Skipping
"agilo.charts.macros = agilo.charts.macros": (version conflict
"VersionConflict: (Genshi 0.6dev-r0 (/opt/csw/lib/python/site-packages/
Genshi-0.6dev_r0-py2.6-solaris-2.10-sun4v.egg), Requirement.parse
('genshi>=0.5.1,<0.6dev'))")
2009-08-07 17:36:50,888 Trac[loader] DEBUG: Loading autoupgrade from /
opt/csw/lib/python/site-packages/AutoUpgrade-0.1-py2.5.egg
2009-08-07 17:36:50,912 Trac[loader] DEBUG: Loading TracTicketDepgraph
from /opt/csw/lib/python/site-packages/TracTicketDepgraph-0.11-
py2.5.egg
2009-08-07 17:36:51,059 Trac[loader] DEBUG: Loading
mastertickets.web_ui from /opt/csw/lib/python/site-packages/
TracMasterTickets-2.1.3-py2.5.egg
2009-08-07 17:36:51,155 Trac[loader] DEBUG: Loading mastertickets.api
from /opt/csw/lib/python/site-packages/TracMasterTickets-2.1.3-
py2.5.egg
2009-08-07 17:36:51,203 Trac[loader] DEBUG: Loading
repositoryhooksystem from /opt/csw/lib/python/site-packages/
RepositoryHookSystem-0.1.1-py2.5.egg
2009-08-07 17:36:51,420 Trac[loader] DEBUG: Loading trachours.setup
from /opt/csw/lib/python/site-packages/TracHoursPlugin-0.3-py2.5.egg
2009-08-07 17:36:51,450 Trac[loader] DEBUG: Loading
trachours.multiproject from /opt/csw/lib/python/site-packages/
TracHoursPlugin-0.3-py2.5.egg
2009-08-07 17:36:53,035 Trac[loader] DEBUG: Loading
trachours.trachours from /opt/csw/lib/python/site-packages/
TracHoursPlugin-0.3-py2.5.egg
2009-08-07 17:36:53,150 Trac[loader] DEBUG: Loading
workfloweditor.workfloweditor_admin from /opt/csw/lib/python/site-
packages/WorkflowEditorPlugin-1.0.1_r5329-py2.5.egg
2009-08-07 17:36:53,201 Trac[loader] DEBUG: Loading
ticketchange.web_ui from /opt/csw/lib/python/site-packages/
TracTicketChange-0.0.4-py2.5.egg
2009-08-07 17:36:53,263 Trac[loader] DEBUG: Loading
tracserversideredirect.plugin from /opt/csw/lib/python/site-packages/
TracServerSideRedirectPlugin-0.1-py2.5.egg
2009-08-07 17:36:53,326 Trac[loader] DEBUG: Loading wikiprint.formats
from /opt/csw/lib/python/site-packages/TracWikiPrintPlugin-1.1-
py2.5.egg
2009-08-07 17:36:53,823 Trac[loader] DEBUG: Skipping
"wikiprint.formats = wikiprint.formats": ("DistributionNotFound:
reportlab" not found)
2009-08-07 17:36:53,825 Trac[loader] DEBUG: Loading wikiprint.web_ui
from /opt/csw/lib/python/site-packages/TracWikiPrintPlugin-1.1-
py2.5.egg
2009-08-07 17:36:54,291 Trac[loader] DEBUG: Skipping "wikiprint.web_ui
= wikiprint.web_ui": ("DistributionNotFound: reportlab" not found)
2009-08-07 17:36:54,293 Trac[loader] DEBUG: Loading
wikiprint.wikitopdf from /opt/csw/lib/python/site-packages/
TracWikiPrintPlugin-1.1-py2.5.egg
2009-08-07 17:36:54,795 Trac[loader] DEBUG: Skipping
"wikiprint.wikitopdf = wikiprint.wikitopdf": ("DistributionNotFound:
reportlab" not found)
2009-08-07 17:36:54,938 Trac[loader] DEBUG: Loading TracXMLRPC from /
opt/csw/lib/python/site-packages/TracXMLRPC-1.0.5-py2.6.egg
2009-08-07 17:36:55,383 Trac[loader] DEBUG: Loading trac.ticket.web_ui
from /opt/csw/lib/python/site-packages/Trac-0.11.5stable_r0-py2.6.egg
2009-08-07 17:36:55,388 Trac[loader] DEBUG: Loading trac.mimeview.php
from /opt/csw/lib/python/site-packages/Trac-0.11.5stable_r0-py2.6.egg
2009-08-07 17:36:55,399 Trac[loader] DEBUG: Loading trac.ticket.query
from /opt/csw/lib/python/site-packages/Trac-0.11.5stable_r0-py2.6.egg
2009-08-07 17:36:55,404 Trac[loader] DEBUG: Loading trac.attachment
from /opt/csw/lib/python/site-packages/Trac-0.11.5stable_r0-py2.6.egg
2009-08-07 17:36:55,408 Trac[loader] DEBUG: Loading
trac.versioncontrol.svn_fs from /opt/csw/lib/python/site-packages/
Trac-0.11.5stable_r0-py2.6.egg
2009-08-07 17:36:55,441 Trac[loader] DEBUG: Loading
trac.mimeview.patch from /opt/csw/lib/python/site-packages/
Trac-0.11.5stable_r0-py2.6.egg
2009-08-07 17:36:55,450 Trac[loader] DEBUG: Loading trac.mimeview.txtl
from /opt/csw/lib/python/site-packages/Trac-0.11.5stable_r0-py2.6.egg
2009-08-07 17:36:55,912 Trac[loader] DEBUG: Skipping
"trac.mimeview.txtl = trac.mimeview.txtl [textile]":
("DistributionNotFound: textile>=2.0" not found)
2009-08-07 17:36:55,914 Trac[loader] DEBUG: Loading trac.admin.web_ui
from /opt/csw/lib/python/site-packages/Trac-0.11.5stable_r0-py2.6.egg
2009-08-07 17:36:55,919 Trac[loader] DEBUG: Loading trac.ticket.admin
from /opt/csw/lib/python/site-packages/Trac-0.11.5stable_r0-py2.6.egg
2009-08-07 17:36:55,936 Trac[loader] DEBUG: Loading trac.mimeview.rst
from /opt/csw/lib/python/site-packages/Trac-0.11.5stable_r0-py2.6.egg
2009-08-07 17:36:57,278 Trac[loader] DEBUG: Loading trac.db.postgres
from /opt/csw/lib/python/site-packages/Trac-0.11.5stable_r0-py2.6.egg
2009-08-07 17:36:57,299 Trac[loader] DEBUG: Loading
trac.versioncontrol.web_ui from /opt/csw/lib/python/site-packages/
Trac-0.11.5stable_r0-py2.6.egg
2009-08-07 17:36:57,305 Trac[loader] DEBUG: Loading trac.timeline
from /opt/csw/lib/python/site-packages/Trac-0.11.5stable_r0-py2.6.egg
2009-08-07 17:36:57,325 Trac[loader] DEBUG: Loading
trac.mimeview.pygments from /opt/csw/lib/python/site-packages/
Trac-0.11.5stable_r0-py2.6.egg
2009-08-07 17:36:57,640 Trac[loader] DEBUG: Loading trac.about from /
opt/csw/lib/python/site-packages/Trac-0.11.5stable_r0-py2.6.egg
2009-08-07 17:36:57,649 Trac[loader] DEBUG: Loading
trac.wiki.interwiki from /opt/csw/lib/python/site-packages/
Trac-0.11.5stable_r0-py2.6.egg
2009-08-07 17:36:57,673 Trac[loader] DEBUG: Loading
trac.ticket.roadmap from /opt/csw/lib/python/site-packages/
Trac-0.11.5stable_r0-py2.6.egg
2009-08-07 17:36:57,678 Trac[loader] DEBUG: Loading
trac.mimeview.silvercity from /opt/csw/lib/python/site-packages/
Trac-0.11.5stable_r0-py2.6.egg
2009-08-07 17:36:58,166 Trac[loader] DEBUG: Skipping
"trac.mimeview.silvercity = trac.mimeview.silvercity [silvercity]":
("DistributionNotFound: SilverCity>=0.9.4" not found)
2009-08-07 17:36:58,168 Trac[loader] DEBUG: Loading trac.wiki.macros
from /opt/csw/lib/python/site-packages/Trac-0.11.5stable_r0-py2.6.egg
2009-08-07 17:36:58,173 Trac[loader] DEBUG: Loading trac.db.sqlite
from /opt/csw/lib/python/site-packages/Trac-0.11.5stable_r0-py2.6.egg
2009-08-07 17:36:58,248 Trac[loader] DEBUG: Loading trac.wiki.web_ui
from /opt/csw/lib/python/site-packages/Trac-0.11.5stable_r0-py2.6.egg
2009-08-07 17:36:58,263 Trac[loader] DEBUG: Loading
trac.mimeview.enscript from /opt/csw/lib/python/site-packages/
Trac-0.11.5stable_r0-py2.6.egg
2009-08-07 17:36:58,273 Trac[loader] DEBUG: Loading trac.web.auth
from /opt/csw/lib/python/site-packages/Trac-0.11.5stable_r0-py2.6.egg
2009-08-07 17:36:58,278 Trac[loader] DEBUG: Loading trac.admin.console
from /opt/csw/lib/python/site-packages/Trac-0.11.5stable_r0-py2.6.egg
2009-08-07 17:36:58,388 Trac[loader] DEBUG: Loading trac.db.mysql
from /opt/csw/lib/python/site-packages/Trac-0.11.5stable_r0-py2.6.egg
2009-08-07 17:36:58,427 Trac[loader] DEBUG: Loading trac.search from /
opt/csw/lib/python/site-packages/Trac-0.11.5stable_r0-py2.6.egg
2009-08-07 17:36:58,432 Trac[loader] DEBUG: Loading trac.prefs from /
opt/csw/lib/python/site-packages/Trac-0.11.5stable_r0-py2.6.egg
2009-08-07 17:36:58,447 Trac[loader] DEBUG: Loading trac.ticket.report
from /opt/csw/lib/python/site-packages/Trac-0.11.5stable_r0-py2.6.egg
2009-08-07 17:36:58,463 Trac[loader] DEBUG: Loading tractags from /opt/
csw/lib/python/site-packages/TracTags-0.6-py2.6.egg
2009-08-07 17:36:58,482 Trac[loader] DEBUG: Loading qatracker from /
opt/csw/lib/python/site-packages/QATracker-0.1_alpha-py2.6.egg
2009-08-07 17:36:58,510 Trac[loader] DEBUG: Loading autocompleteusers
from /opt/csw/lib/python/site-packages/AutocompleteUsers-0.4.1-
py2.6.egg
2009-08-07 17:36:58,604 Trac[loader] DEBUG: Loading svnauthz.admin_ui
from /opt/csw/lib/python/site-packages/
SvnAuthzAdminPlugin-0.1.2._Moved.to.Trac.0.11_-py2.6.egg
2009-08-07 17:36:59,015 Trac[default_workflow] DEBUG: Workflow actions
at initialization: {'resolve': {'operations': [u'set_resolution'],
'name': 'resolve', 'default': 0, 'newstate': u'closed', 'oldstates':
[u'new', u'assigned', u'reopened'], 'permissions':
[u'TICKET_MODIFY']}, 'accept': {'operations': [u'set_owner_to_self'],
'name': 'accept', 'default': 0, 'newstate': u'assigned', 'oldstates':
[u'new'], 'permissions': [u'TICKET_MODIFY']}, 'leave': {'operations':
[u'leave_status'], 'name': 'leave', 'default': 1, 'newstate': u'*',
'oldstates': [u'*'], 'permissions': []}, 'reopen': {'operations':
[u'del_resolution'], 'name': 'reopen', 'default': 0, 'newstate':
u'reopened', 'oldstates': [u'closed'], 'permissions':
[u'TICKET_CREATE']}, 'reassign': {'operations': [u'set_owner'],
'name': 'reassign', 'default': 0, 'newstate': u'new', 'oldstates':
[u'new', u'assigned', u'reopened'], 'permissions':
[u'TICKET_MODIFY']}, '_reset': {'operations': ['reset_workflow'],
'name': 'reset', 'default': 0, 'newstate': 'new', 'oldstates': [],
'permissions': []}}
2009-08-07 17:36:59,257 Trac[main] DEBUG: Dispatching <Request "POST
u'/admin/subversion/svnauthz'">
2009-08-07 17:37:00,465 Trac[api] DEBUG: action controllers for ticket
workflow: ['ConfigurableTicketWorkflow']
2009-08-07 17:37:02,079 Trac[svn_fs] DEBUG: Subversion bindings
imported
2009-08-07 17:37:02,627 Trac[admin_ui] DEBUG: SvnAuthzAdminPlugin:
cat=subversion page=svnauthz path_info=None
2009-08-07 17:37:02,811 Trac[chrome] DEBUG: Prepare chrome data for
request
2009-08-07 17:37:02,956 Trac[session] DEBUG: Retrieving session for ID
'rupert.thurner'
Tim Hatch
Aug 7, 2009, 12:38:16 PM8/7/09
to trac...@googlegroups.com
On 8/7/09 9:23 AM, rupert....@gmail.com wrote:
>
> i am not enough python developer to judge this, but it looks so much
> overload that on every click we have 160 lines caused by plugins in
> our log file. is this really necessary?
>
> i am not enough python developer to judge this, but it looks so much
> overload that on every click we have 160 lines caused by plugins in
> our log file. is this really necessary?
1. IIRC you shouldn't get that that for every page load, you should get
it only when a trac process is starting up (so once per apache worker or
fcgi process, etc).
2. You have debug logging on. The point of debug logging is to log
everything that might be useful. If you've decided it's not useful,
change your log level down to info or warning.
Tim
Christian Boos
Aug 7, 2009, 12:39:07 PM8/7/09
to trac...@googlegroups.com
rupert....@gmail.com wrote:
> i am not enough python developer to judge this, but it looks so much
> overload that on every click we have 160 lines caused by plugins in
> our log file. is this really necessary?
> i am not enough python developer to judge this, but it looks so much
> overload that on every click we have 160 lines caused by plugins in
> our log file. is this really necessary?
Well, assuming you're using latest Trac 0.11, I'd say one of these
plugins is doing a "config.touch()" at every request, which triggers the
reload of the whole environment at the next request.
Either grep the plugins sources for the above pattern, or identify the
faulty plugin by re-enabling them one by one, starting with an
environment with no plugins enabled. I'm pretty sure that you won't get
this problematic behavior at first, unless you're using an old version
of Trac which had such an issue (pre-0.11, see r6893).
Then you'd want to fix your "r0" problems for some plugins, due to
setuptools and svn 1.6, see the Notes in
http://trac.edgewall.org/wiki/setuptools
-- Christian
Remy Blank
Aug 7, 2009, 1:06:23 PM8/7/09
to trac...@googlegroups.com
Christian Boos wrote:
> Well, assuming you're using latest Trac 0.11, I'd say one of these
> plugins is doing a "config.touch()" at every request, which triggers the
> reload of the whole environment at the next request.
> Well, assuming you're using latest Trac 0.11, I'd say one of these
> plugins is doing a "config.touch()" at every request, which triggers the
> reload of the whole environment at the next request.
And this should give you a taste of what CGI was like ;-)
-- Remy
rupert.thurner
Aug 8, 2009, 6:31:45 AM8/8/09
to Trac Development
On Aug 7, 6:39 pm, Christian Boos <cb...@neuf.fr> wrote:
am not sure if it was the cause as every process started by mod_wsgi
also causes a load as pointed out by tim before.
with the naked trac it looks much better now, the remote user is set
via apache.
2009-08-08 11:20:25,932 Trac[main] DEBUG: Dispatching <Request "GET u'/
wiki'">
2009-08-08 11:20:26,045 Trac[chrome] DEBUG: Prepare chrome data for
request
2009-08-08 11:20:26,065 Trac[perm] DEBUG: No policy allowed
rupert.thurner performing TRAC_ADMIN on None
2009-08-08 11:20:26,069 Trac[perm] DEBUG: No policy allowed
rupert.thurner performing PERMISSION_GRANT on None
2009-08-08 11:20:26,072 Trac[perm] DEBUG: No policy allowed
rupert.thurner performing PERMISSION_REVOKE on None
2009-08-08 11:20:26,075 Trac[perm] DEBUG: No policy allowed
rupert.thurner performing TICKET_ADMIN on None
2009-08-08 11:20:26,139 Trac[api] DEBUG: Updating wiki page index
2009-08-08 11:20:26,192 Trac[session] DEBUG: Retrieving session for ID
'rupert.thurner'
2009-08-08 11:20:27,368 Trac[perm] DEBUG: No policy allowed
rupert.thurner performing EMAIL_VIEW on None
2009-08-08 11:20:31,244 Trac[api] DEBUG: Updating wiki page index
2009-08-08 11:20:31,409 Trac[perm] DEBUG: No policy allowed
rupert.thurner performing WIKI_DELETE on <Resource u'wiki:WikiStart'>
2009-08-08 11:20:31,414 Trac[perm] DEBUG: No policy allowed
rupert.thurner performing WIKI_ADMIN on <Resource u'wiki:WikiStart'>
2009-08-08 11:20:31,828 Trac[main] DEBUG: Dispatching <Request "GET u'/
chrome/site/your_project_logo.png'">
2009-08-08 11:20:31,836 Trac[chrome] WARNING: File
your_project_logo.png not found in any of ['/opt/csw/apache2/data/
trac010/noplug/htdocs']
2009-08-08 11:20:31,839 Trac[main] WARNING: HTTPNotFound: 404 Not
Found (File your_project_logo.png not found)
2009-08-08 11:20:31,841 Trac[chrome] DEBUG: Prepare chrome data for
request
2009-08-08 11:20:31,862 Trac[perm] DEBUG: No policy allowed
rupert.thurner performing TRAC_ADMIN on None
2009-08-08 11:20:31,865 Trac[perm] DEBUG: No policy allowed
rupert.thurner performing PERMISSION_GRANT on None
2009-08-08 11:20:31,868 Trac[perm] DEBUG: No policy allowed
rupert.thurner performing PERMISSION_REVOKE on None
2009-08-08 11:20:31,872 Trac[perm] DEBUG: No policy allowed
rupert.thurner performing TICKET_ADMIN on None
2009-08-08 11:20:31,905 Trac[session] DEBUG: Retrieving session for ID
'rupert.thurner'
2009-08-08 11:20:31,931 Trac[perm] DEBUG: No policy allowed
rupert.thurner performing EMAIL_VIEW on None
> rupert.thur...@gmail.com wrote:
> > i am not enough python developer to judge this, but it looks so much
> > overload that on every click we have 160 lines caused by plugins in
> > our log file. is this really necessary?
>
> Well, assuming you're using latest Trac 0.11, I'd say one of these
> plugins is doing a "config.touch()" at every request, which triggers the
> reload of the whole environment at the next request.
> Either grep the plugins sources for the above pattern, or identify the
> faulty plugin by re-enabling them one by one, starting with an
> environment with no plugins enabled. I'm pretty sure that you won't get
> this problematic behavior at first, unless you're using an old version
> of Trac which had such an issue (pre-0.11, see r6893).
many thanks for the hint! the agilo plugin contained such touch, but i
> > i am not enough python developer to judge this, but it looks so much
> > overload that on every click we have 160 lines caused by plugins in
> > our log file. is this really necessary?
>
> Well, assuming you're using latest Trac 0.11, I'd say one of these
> plugins is doing a "config.touch()" at every request, which triggers the
> reload of the whole environment at the next request.
> Either grep the plugins sources for the above pattern, or identify the
> faulty plugin by re-enabling them one by one, starting with an
> environment with no plugins enabled. I'm pretty sure that you won't get
> this problematic behavior at first, unless you're using an old version
> of Trac which had such an issue (pre-0.11, see r6893).
am not sure if it was the cause as every process started by mod_wsgi
also causes a load as pointed out by tim before.
with the naked trac it looks much better now, the remote user is set
via apache.
2009-08-08 11:20:25,932 Trac[main] DEBUG: Dispatching <Request "GET u'/
wiki'">
2009-08-08 11:20:26,045 Trac[chrome] DEBUG: Prepare chrome data for
request
2009-08-08 11:20:26,065 Trac[perm] DEBUG: No policy allowed
rupert.thurner performing TRAC_ADMIN on None
2009-08-08 11:20:26,069 Trac[perm] DEBUG: No policy allowed
rupert.thurner performing PERMISSION_GRANT on None
2009-08-08 11:20:26,072 Trac[perm] DEBUG: No policy allowed
rupert.thurner performing PERMISSION_REVOKE on None
2009-08-08 11:20:26,075 Trac[perm] DEBUG: No policy allowed
rupert.thurner performing TICKET_ADMIN on None
2009-08-08 11:20:26,139 Trac[api] DEBUG: Updating wiki page index
2009-08-08 11:20:26,192 Trac[session] DEBUG: Retrieving session for ID
'rupert.thurner'
2009-08-08 11:20:27,368 Trac[perm] DEBUG: No policy allowed
rupert.thurner performing EMAIL_VIEW on None
2009-08-08 11:20:31,244 Trac[api] DEBUG: Updating wiki page index
2009-08-08 11:20:31,409 Trac[perm] DEBUG: No policy allowed
rupert.thurner performing WIKI_DELETE on <Resource u'wiki:WikiStart'>
2009-08-08 11:20:31,414 Trac[perm] DEBUG: No policy allowed
rupert.thurner performing WIKI_ADMIN on <Resource u'wiki:WikiStart'>
2009-08-08 11:20:31,828 Trac[main] DEBUG: Dispatching <Request "GET u'/
chrome/site/your_project_logo.png'">
2009-08-08 11:20:31,836 Trac[chrome] WARNING: File
your_project_logo.png not found in any of ['/opt/csw/apache2/data/
trac010/noplug/htdocs']
2009-08-08 11:20:31,839 Trac[main] WARNING: HTTPNotFound: 404 Not
Found (File your_project_logo.png not found)
2009-08-08 11:20:31,841 Trac[chrome] DEBUG: Prepare chrome data for
request
2009-08-08 11:20:31,862 Trac[perm] DEBUG: No policy allowed
rupert.thurner performing TRAC_ADMIN on None
2009-08-08 11:20:31,865 Trac[perm] DEBUG: No policy allowed
rupert.thurner performing PERMISSION_GRANT on None
2009-08-08 11:20:31,868 Trac[perm] DEBUG: No policy allowed
rupert.thurner performing PERMISSION_REVOKE on None
2009-08-08 11:20:31,872 Trac[perm] DEBUG: No policy allowed
rupert.thurner performing TICKET_ADMIN on None
2009-08-08 11:20:31,905 Trac[session] DEBUG: Retrieving session for ID
'rupert.thurner'
2009-08-08 11:20:31,931 Trac[perm] DEBUG: No policy allowed
rupert.thurner performing EMAIL_VIEW on None
ANdreaT
Aug 8, 2009, 11:10:45 AM8/8/09
to Trac Development
On Aug 8, 12:31 pm, "rupert.thurner" <rupert.thur...@gmail.com> wrote:
> On Aug 7, 6:39 pm, Christian Boos <cb...@neuf.fr> wrote:
>
> > rupert.thur...@gmail.com wrote:
> > > i am not enough python developer to judge this, but it looks so much
> > > overload that on every click we have 160 lines caused by plugins in
> > > our log file. is this really necessary?
>
> > Well, assuming you're using latest Trac 0.11, I'd say one of these
> > plugins is doing a "config.touch()" at every request, which triggers the
> > reload of the whole environment at the next request.
> > Either grep the plugins sources for the above pattern, or identify the
> > faulty plugin by re-enabling them one by one, starting with an
> > environment with no plugins enabled. I'm pretty sure that you won't get
> > this problematic behavior at first, unless you're using an old version
> > of Trac which had such an issue (pre-0.11, see r6893).
>
> many thanks for the hint! the agilo plugin contained such touch, but i
> am not sure if it was the cause as every process started by mod_wsgi
> also causes a load as pointed out by tim before.
I had a chat with Christian today about the touch thing, and pointed
me here to have a look at this thread :-) You are right Agilo uses the
touch() in two specific situations, when the types definition changes
(because you add your own new type for example, or changed and
alias... or add some additional properties). We are very sensible to
performance issues, and we will investigate more on the flow
generating the reload of the plugins, that may be dependent on many
others connections/references with other modules.
I had a look today again, while fixing another bug, and I have noted
down a couple of FIXME... so there is for sure space for improvement,
we need to research through it and improve the config wrapping. So
apologies if Agilo caused too many reload, I anyway would exclude
completely the fact that it does this at every page call :-)
Best
ANdreaT
rupert.thurner
Aug 9, 2009, 12:32:53 AM8/9/09
to Trac Development
can the times between the debug statements also taken as performance
points? if yes, then the following is slow here:
1. retrieving the session id
taking up to 5 seconds, on the third click coming down.
2. update wiki page index
taking up to 5 seconds, and happening quite often when only
clicking once
there is " if now > self._last_index_update +
WikiSystem.INDEX_UPDATE_INTERVAL:"
which is set to 5 sec - but for us 10 minutes are sufficient i
guess.
log excerpt 1, one click on main wiki page:
2009-08-09 00:31:09,282 Trac[main] DEBUG: Dispatching <Request "GET u'/
wiki'">
2009-08-09 00:31:09,700 Trac[api] DEBUG: action controllers for ticket
workflow: ['ConfigurableTicketWorkflow']
2009-08-09 00:31:09,868 Trac[svn_fs] DEBUG: Subversion bindings
imported
2009-08-09 00:31:09,912 Trac[chrome] DEBUG: Prepare chrome data for
request
2009-08-09 00:31:10,151 Trac[api] DEBUG: Updating wiki page index
2009-08-09 00:31:10,180 Trac[session] DEBUG: Retrieving session for ID
'rupert.thurner'
2009-08-09 00:31:12,958 Trac[formatter] DEBUG: Executing Wiki macro
TracNav by provider <tracnav.tracnav.TracNav object at 0x16d6eb0>
log excerpt 2, one click on timeline:
the funny thing the double entry, the second time happening while the
page is already displayed on the browser.
2009-08-08 23:50:33,749 Trac[main] DEBUG: Dispatching <Request "GET u'/
timeline'">
2009-08-08 23:50:33,807 Trac[session] DEBUG: Retrieving session for ID
'rupert.thurner'
2009-08-08 23:50:35,841 Trac[chrome] DEBUG: Prepare chrome data for
request
2009-08-08 23:50:36,049 Trac[api] DEBUG: Updating wiki page index
2009-08-08 23:50:41,081 Trac[api] DEBUG: Updating wiki page index
2009-08-08 23:50:45,150 Trac[main] DEBUG: Dispatching <Request "GET u'/
timeline'">
2009-08-08 23:50:45,197 Trac[session] DEBUG: Retrieving session for ID
'rupert.thurner'
2009-08-08 23:50:51,241 Trac[chrome] DEBUG: Prepare chrome data for
request
2009-08-08 23:50:51,607 Trac[api] DEBUG: Updating wiki page index
sqlite> select * from session where sid = "rupert.thurner";
rupert.thurner|1|1249737873
sqlite> select * from session_attribute where sid = "rupert.thurner";
rupert.thurner|1|timeline.daysback|30
rupert.thurner|1|timeline.filter.changeset|1
rupert.thurner|1|timeline.filter.milestone|1
rupert.thurner|1|timeline.filter.ticket|1
rupert.thurner|1|timeline.filter.wiki|1
sqlite> select count(*) from session;
26573
sqlite> select count(*) from session_attribute;
27626
points? if yes, then the following is slow here:
1. retrieving the session id
taking up to 5 seconds, on the third click coming down.
2. update wiki page index
taking up to 5 seconds, and happening quite often when only
clicking once
there is " if now > self._last_index_update +
WikiSystem.INDEX_UPDATE_INTERVAL:"
which is set to 5 sec - but for us 10 minutes are sufficient i
guess.
log excerpt 1, one click on main wiki page:
2009-08-09 00:31:09,282 Trac[main] DEBUG: Dispatching <Request "GET u'/
wiki'">
2009-08-09 00:31:09,700 Trac[api] DEBUG: action controllers for ticket
workflow: ['ConfigurableTicketWorkflow']
2009-08-09 00:31:09,868 Trac[svn_fs] DEBUG: Subversion bindings
imported
2009-08-09 00:31:09,912 Trac[chrome] DEBUG: Prepare chrome data for
request
2009-08-09 00:31:10,151 Trac[api] DEBUG: Updating wiki page index
2009-08-09 00:31:10,180 Trac[session] DEBUG: Retrieving session for ID
'rupert.thurner'
2009-08-09 00:31:12,958 Trac[formatter] DEBUG: Executing Wiki macro
TracNav by provider <tracnav.tracnav.TracNav object at 0x16d6eb0>
log excerpt 2, one click on timeline:
the funny thing the double entry, the second time happening while the
page is already displayed on the browser.
2009-08-08 23:50:33,749 Trac[main] DEBUG: Dispatching <Request "GET u'/
timeline'">
2009-08-08 23:50:33,807 Trac[session] DEBUG: Retrieving session for ID
'rupert.thurner'
2009-08-08 23:50:35,841 Trac[chrome] DEBUG: Prepare chrome data for
request
2009-08-08 23:50:36,049 Trac[api] DEBUG: Updating wiki page index
2009-08-08 23:50:41,081 Trac[api] DEBUG: Updating wiki page index
2009-08-08 23:50:45,150 Trac[main] DEBUG: Dispatching <Request "GET u'/
timeline'">
2009-08-08 23:50:45,197 Trac[session] DEBUG: Retrieving session for ID
'rupert.thurner'
2009-08-08 23:50:51,241 Trac[chrome] DEBUG: Prepare chrome data for
request
2009-08-08 23:50:51,607 Trac[api] DEBUG: Updating wiki page index
sqlite> select * from session where sid = "rupert.thurner";
rupert.thurner|1|1249737873
sqlite> select * from session_attribute where sid = "rupert.thurner";
rupert.thurner|1|timeline.daysback|30
rupert.thurner|1|timeline.filter.changeset|1
rupert.thurner|1|timeline.filter.milestone|1
rupert.thurner|1|timeline.filter.ticket|1
rupert.thurner|1|timeline.filter.wiki|1
sqlite> select count(*) from session;
26573
sqlite> select count(*) from session_attribute;
27626
Christian Boos
Aug 9, 2009, 5:38:26 AM8/9/09
to trac...@googlegroups.com
No, there's no rule currently about when we write the debug statements.
Here, "Updating wiki page index" is written before updating the index,
so all we know is that the duration of this operation is less than 29
ms... as the "Retrieving session for ID" is unrelated. But the retrieval
of a session doesn't take 2.7 seconds ... the "Execute Wiki macro" is
output during the template generation, as the wiki_to() calls are
triggered there.
I'm not sure, but I don't think that systematic start/stop debug output
will help. Maybe we could do this in a few selected places, though, in
order to help spot the potential problems (e.g. those listed in the new
TracPerformance page). A bit in the spirit of
http://trac.edgewall.org/changeset/7322, but more systematic (e.g. "mail
submitted (took ... seconds)").
> log excerpt 2, one click on timeline:
> the funny thing the double entry, the second time happening while the
> page is already displayed on the browser.
>
> 2009-08-08 23:50:33,749 Trac[main] DEBUG: Dispatching <Request "GET u'/
> timeline'">
> 2009-08-08 23:50:33,807 Trac[session] DEBUG: Retrieving session for ID
> 'rupert.thurner'
> 2009-08-08 23:50:35,841 Trac[chrome] DEBUG: Prepare chrome data for
> request
> 2009-08-08 23:50:36,049 Trac[api] DEBUG: Updating wiki page index
> 2009-08-08 23:50:41,081 Trac[api] DEBUG: Updating wiki page index
> 2009-08-08 23:50:45,150 Trac[main] DEBUG: Dispatching <Request "GET u'/
> timeline'">
> 2009-08-08 23:50:45,197 Trac[session] DEBUG: Retrieving session for ID
> 'rupert.thurner'
> 2009-08-08 23:50:51,241 Trac[chrome] DEBUG: Prepare chrome data for
> request
> 2009-08-08 23:50:51,607 Trac[api] DEBUG: Updating wiki page index
>
Were you using Firefox? Firefox often sends one more request than
necessary, though usually only for rel="next" links (see
https://developer.mozilla.org/en/Link_prefetching_FAQ). The "/timeline"
page normally doesn't contain such a next link, only when you browse at
an older date, but that would be visible in the GET url. Maybe some
Firefox plugin is triggering this (try disabling them)?
Alternatively, you may have subscribed a RSS feed on the timeline which
by chance fired a request at the same time...
-- Christian
Reply all
Reply to author
Forward
0 new messages