Project

General

Profile

Defect #4105 ยป production.log

Production.log file showing the svn list --xml commands at the end of file. - Stuart Mathews, 2009-10-25 14:16

 
1
# Logfile created on Sun Oct 25 10:45:53 +0000 2009checking plugin 'engines' for 'application_helper'
2
checking plugin 'actionwebservice' for 'application_helper'
3
checking plugin 'acts_as_activity_provider' for 'application_helper'
4
checking plugin 'acts_as_attachable' for 'application_helper'
5
checking plugin 'acts_as_customizable' for 'application_helper'
6
checking plugin 'acts_as_event' for 'application_helper'
7
checking plugin 'acts_as_list' for 'application_helper'
8
checking plugin 'acts_as_searchable' for 'application_helper'
9
checking plugin 'acts_as_tree' for 'application_helper'
10
checking plugin 'acts_as_versioned' for 'application_helper'
11
checking plugin 'acts_as_watchable' for 'application_helper'
12
checking plugin 'classic_pagination' for 'application_helper'
13
checking plugin 'coderay-0.7.6.227' for 'application_helper'
14
checking plugin 'gloc-1.1.0' for 'application_helper'
15
checking plugin 'gravatar' for 'application_helper'
16
checking plugin 'rfpdf' for 'application_helper'
17
checking plugin 'ruby-net-ldap-0.0.4' for 'application_helper'
18
loading from application: application_helper
19
loading routes from /opt/redmine/vendor/plugins/engines/routes.rb
20
loading routes from /opt/redmine/vendor/plugins/actionwebservice/routes.rb
21
loading routes from /opt/redmine/vendor/plugins/acts_as_activity_provider/routes.rb
22
loading routes from /opt/redmine/vendor/plugins/acts_as_attachable/routes.rb
23
loading routes from /opt/redmine/vendor/plugins/acts_as_customizable/routes.rb
24
loading routes from /opt/redmine/vendor/plugins/acts_as_event/routes.rb
25
loading routes from /opt/redmine/vendor/plugins/acts_as_list/routes.rb
26
loading routes from /opt/redmine/vendor/plugins/acts_as_searchable/routes.rb
27
loading routes from /opt/redmine/vendor/plugins/acts_as_tree/routes.rb
28
loading routes from /opt/redmine/vendor/plugins/acts_as_versioned/routes.rb
29
loading routes from /opt/redmine/vendor/plugins/acts_as_watchable/routes.rb
30
loading routes from /opt/redmine/vendor/plugins/classic_pagination/routes.rb
31
loading routes from /opt/redmine/vendor/plugins/coderay-0.7.6.227/routes.rb
32
loading routes from /opt/redmine/vendor/plugins/gloc-1.1.0/routes.rb
33
loading routes from /opt/redmine/vendor/plugins/gravatar/routes.rb
34
loading routes from /opt/redmine/vendor/plugins/rfpdf/routes.rb
35
loading routes from /opt/redmine/vendor/plugins/ruby-net-ldap-0.0.4/routes.rb
36
checking plugin 'engines' for 'application_controller'
37
checking plugin 'actionwebservice' for 'application_controller'
38
checking plugin 'acts_as_activity_provider' for 'application_controller'
39
checking plugin 'acts_as_attachable' for 'application_controller'
40
checking plugin 'acts_as_customizable' for 'application_controller'
41
checking plugin 'acts_as_event' for 'application_controller'
42
checking plugin 'acts_as_list' for 'application_controller'
43
checking plugin 'acts_as_searchable' for 'application_controller'
44
checking plugin 'acts_as_tree' for 'application_controller'
45
checking plugin 'acts_as_versioned' for 'application_controller'
46
checking plugin 'acts_as_watchable' for 'application_controller'
47
checking plugin 'classic_pagination' for 'application_controller'
48
checking plugin 'coderay-0.7.6.227' for 'application_controller'
49
checking plugin 'gloc-1.1.0' for 'application_controller'
50
checking plugin 'gravatar' for 'application_controller'
51
checking plugin 'rfpdf' for 'application_controller'
52
checking plugin 'ruby-net-ldap-0.0.4' for 'application_controller'
53
(file not found in application)
54
checking plugin 'engines' for 'repositories_controller'
55
checking plugin 'actionwebservice' for 'repositories_controller'
56
checking plugin 'acts_as_activity_provider' for 'repositories_controller'
57
checking plugin 'acts_as_attachable' for 'repositories_controller'
58
checking plugin 'acts_as_customizable' for 'repositories_controller'
59
checking plugin 'acts_as_event' for 'repositories_controller'
60
checking plugin 'acts_as_list' for 'repositories_controller'
61
checking plugin 'acts_as_searchable' for 'repositories_controller'
62
checking plugin 'acts_as_tree' for 'repositories_controller'
63
checking plugin 'acts_as_versioned' for 'repositories_controller'
64
checking plugin 'acts_as_watchable' for 'repositories_controller'
65
checking plugin 'classic_pagination' for 'repositories_controller'
66
checking plugin 'coderay-0.7.6.227' for 'repositories_controller'
67
checking plugin 'gloc-1.1.0' for 'repositories_controller'
68
checking plugin 'gravatar' for 'repositories_controller'
69
checking plugin 'rfpdf' for 'repositories_controller'
70
checking plugin 'ruby-net-ldap-0.0.4' for 'repositories_controller'
71
loading from application: repositories_controller
72
checking plugin 'engines' for 'repositories_helper'
73
checking plugin 'actionwebservice' for 'repositories_helper'
74
checking plugin 'acts_as_activity_provider' for 'repositories_helper'
75
checking plugin 'acts_as_attachable' for 'repositories_helper'
76
checking plugin 'acts_as_customizable' for 'repositories_helper'
77
checking plugin 'acts_as_event' for 'repositories_helper'
78
checking plugin 'acts_as_list' for 'repositories_helper'
79
checking plugin 'acts_as_searchable' for 'repositories_helper'
80
checking plugin 'acts_as_tree' for 'repositories_helper'
81
checking plugin 'acts_as_versioned' for 'repositories_helper'
82
checking plugin 'acts_as_watchable' for 'repositories_helper'
83
checking plugin 'classic_pagination' for 'repositories_helper'
84
checking plugin 'coderay-0.7.6.227' for 'repositories_helper'
85
checking plugin 'gloc-1.1.0' for 'repositories_helper'
86
checking plugin 'gravatar' for 'repositories_helper'
87
checking plugin 'rfpdf' for 'repositories_helper'
88
checking plugin 'ruby-net-ldap-0.0.4' for 'repositories_helper'
89
loading from application: repositories_helper
90

    
91

    
92
Processing RepositoriesController#show (for 78.86.23.141 at 2009-10-25 12:11:44) [GET]
93
  Session ID: ebbf9b6d1966d73faa37b351db04f99c
94
  Parameters: {"action"=>"show", "id"=>"test", "controller"=>"repositories"}
95
  SQL (0.000087)   SET NAMES 'utf8'
96
  SQL (0.000038)   SET SQL_AUTO_IS_NULL=0
97
  Setting Columns (0.000539)   SHOW FIELDS FROM `settings`
98
  SQL (0.000056)   SELECT max(`settings`.updated_on) AS max_updated_on FROM `settings` 
99
  User Columns (0.000635)   SHOW FIELDS FROM `users`
100
  User Load (0.000095)   SELECT * FROM `users` WHERE (`users`.`id` = 1) AND (users.status = 1) 
101
  Project Columns (0.000778)   SHOW FIELDS FROM `projects`
102
  Project Load (0.000116)   SELECT * FROM `projects` WHERE (`projects`.`identifier` = 'test') LIMIT 1
103
  Repository Load (0.000092)   SELECT * FROM `repositories` WHERE (`repositories`.project_id = 2) LIMIT 1
104
  Repository Columns (0.000554)   SHOW FIELDS FROM `repositories`
105
  EnabledModule Load (0.000079)   SELECT * FROM `enabled_modules` WHERE (`enabled_modules`.project_id = 2) 
106
  EnabledModule Columns (0.000520)   SHOW FIELDS FROM `enabled_modules`
107
  Setting Load (0.000082)   SELECT * FROM `settings` WHERE (`settings`.`name` = 'autofetch_changesets') LIMIT 1
108
  Repository::Subversion Columns (0.000551)   SHOW FIELDS FROM `repositories`
109
Shelling out: svn info --xml 'svn+ssh://stuart@devel.stuartmathews.com/var/repos/compliancestream/'
110
Shelling out: svn list --xml 'svn+ssh://stuart@devel.stuartmathews.com/var/repos/compliancestream/'@HEAD
111
Error parsing svn output: #<REXML::ParseException: No close tag for /lists/list>
112
/usr/lib/ruby/1.8/rexml/parsers/treeparser.rb:28:in `parse'
113
/usr/lib/ruby/1.8/rexml/document.rb:228:in `build'
114
/usr/lib/ruby/1.8/rexml/document.rb:43:in `initialize'
115
/opt/redmine/lib/redmine/scm/adapters/subversion_adapter.rb:85:in `new'
116
/opt/redmine/lib/redmine/scm/adapters/subversion_adapter.rb:85:in `entries'
117
/opt/redmine/lib/redmine/scm/adapters/abstract_adapter.rb:177:in `call'
118
/opt/redmine/lib/redmine/scm/adapters/abstract_adapter.rb:177:in `shellout'
119
/opt/redmine/lib/redmine/scm/adapters/abstract_adapter.rb:175:in `popen'
120
/opt/redmine/lib/redmine/scm/adapters/abstract_adapter.rb:175:in `shellout'
121
/opt/redmine/lib/redmine/scm/adapters/abstract_adapter.rb:165:in `shellout'
122
/opt/redmine/lib/redmine/scm/adapters/subversion_adapter.rb:82:in `entries'
123
/opt/redmine/app/models/repository.rb:63:in `entries'
124
/opt/redmine/vendor/rails/activerecord/lib/active_record/associations/association_proxy.rb:173:in `send'
125
/opt/redmine/vendor/rails/activerecord/lib/active_record/associations/association_proxy.rb:173:in `method_missing'
126
/opt/redmine/app/controllers/repositories_controller.rb:71:in `show'
127
/opt/redmine/vendor/rails/actionpack/lib/action_controller/base.rb:1166:in `send'
128
/opt/redmine/vendor/rails/actionpack/lib/action_controller/base.rb:1166:in `perform_action_without_filters'
129
/opt/redmine/vendor/rails/actionpack/lib/action_controller/filters.rb:579:in `call_filters'
130
/opt/redmine/vendor/rails/actionpack/lib/action_controller/filters.rb:572:in `perform_action_without_benchmark'
131
/opt/redmine/vendor/rails/actionpack/lib/action_controller/benchmarking.rb:68:in `perform_action_without_rescue'
132
/usr/lib/ruby/1.8/benchmark.rb:293:in `measure'
133
/opt/redmine/vendor/rails/actionpack/lib/action_controller/benchmarking.rb:68:in `perform_action_without_rescue'
134
/opt/redmine/vendor/rails/actionpack/lib/action_controller/rescue.rb:201:in `perform_action_without_caching'
135
/opt/redmine/vendor/rails/actionpack/lib/action_controller/caching/sql_cache.rb:13:in `passenger_orig_perform_action'
136
/opt/redmine/vendor/rails/activerecord/lib/active_record/connection_adapters/abstract/query_cache.rb:33:in `cache'
137
/opt/redmine/vendor/rails/activerecord/lib/active_record/query_cache.rb:8:in `cache'
138
/opt/redmine/vendor/rails/actionpack/lib/action_controller/caching/sql_cache.rb:12:in `passenger_orig_perform_action'
139
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/railz/request_handler.rb:65:in `perform_action'
140
/opt/redmine/vendor/rails/actionpack/lib/action_controller/base.rb:529:in `send'
141
/opt/redmine/vendor/rails/actionpack/lib/action_controller/base.rb:529:in `process_without_filters'
142
/opt/redmine/vendor/rails/actionpack/lib/action_controller/filters.rb:568:in `process_without_session_management_support'
143
/opt/redmine/vendor/rails/actionpack/lib/action_controller/session_management.rb:130:in `process'
144
/opt/redmine/vendor/rails/actionpack/lib/action_controller/base.rb:389:in `process'
145
/opt/redmine/vendor/rails/actionpack/lib/action_controller/dispatcher.rb:149:in `handle_request'
146
/opt/redmine/vendor/rails/actionpack/lib/action_controller/dispatcher.rb:107:in `dispatch'
147
/opt/redmine/vendor/rails/actionpack/lib/action_controller/dispatcher.rb:104:in `synchronize'
148
/opt/redmine/vendor/rails/actionpack/lib/action_controller/dispatcher.rb:104:in `dispatch'
149
/opt/redmine/vendor/rails/actionpack/lib/action_controller/dispatcher.rb:120:in `dispatch_cgi'
150
/opt/redmine/vendor/rails/actionpack/lib/action_controller/dispatcher.rb:35:in `dispatch'
151
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/railz/request_handler.rb:50:in `process_request'
152
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_request_handler.rb:207:in `main_loop'
153
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/railz/application_spawner.rb:378:in `start_request_handler'
154
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/railz/application_spawner.rb:336:in `handle_spawn_application'
155
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/utils.rb:183:in `safe_fork'
156
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/railz/application_spawner.rb:334:in `handle_spawn_application'
157
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:352:in `__send__'
158
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:352:in `main_loop'
159
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:196:in `start_synchronously'
160
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:163:in `start'
161
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/railz/application_spawner.rb:213:in `start'
162
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/spawn_manager.rb:262:in `spawn_rails_application'
163
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server_collection.rb:126:in `lookup_or_add'
164
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/spawn_manager.rb:256:in `spawn_rails_application'
165
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server_collection.rb:80:in `synchronize'
166
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server_collection.rb:79:in `synchronize'
167
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/spawn_manager.rb:255:in `spawn_rails_application'
168
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/spawn_manager.rb:154:in `spawn_application'
169
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/spawn_manager.rb:287:in `handle_spawn_application'
170
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:352:in `__send__'
171
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:352:in `main_loop'
172
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:196:in `start_synchronously'
173
/var/lib/gems/1.8/gems/passenger-2.2.5/bin/passenger-spawn-server:61
174
...
175
No close tag for /lists/list
176
Line: 
177
Position: 
178
Last 80 unconsumed characters:
179
Output was:
180
 <?xml version="1.0"?>
181
<lists>
182
<list
183
   path="svn+ssh://stuart@devel.stuartmathews.com/var/repos/compliancestream">
184
  Changeset Load (0.000128)   SELECT * FROM `changesets` WHERE (`changesets`.repository_id = 2) ORDER BY committed_on DESC, changesets.committed_on DESC, changesets.id DESC LIMIT 10
185
Rendering template within layouts/base
186
Rendering repositories/show
187
  Changeset Columns (0.000676)   SHOW FIELDS FROM `changesets`
188
  UserPreference Load (0.000072)   SELECT * FROM `user_preferences` WHERE (`user_preferences`.user_id = 1) LIMIT 1
189
  UserPreference Columns (0.000399)   SHOW FIELDS FROM `user_preferences`
190
  Setting Load (0.000053)   SELECT * FROM `settings` WHERE (`settings`.`name` = 'date_format') LIMIT 1
191
  Setting Load (0.000057)   SELECT * FROM `settings` WHERE (`settings`.`name` = 'time_format') LIMIT 1
192
  User Load (0.000060)   SELECT * FROM `users` WHERE (`users`.`id` = 3) 
193
  Setting Load (0.000043)   SELECT * FROM `settings` WHERE (`settings`.`name` = 'user_format') LIMIT 1
194
  Setting Load (0.000046)   SELECT * FROM `settings` WHERE (`settings`.`name` = 'text_formatting') LIMIT 1
195
  CACHE (0.000000)   SELECT * FROM `users` WHERE (`users`.`id` = 3) 
196
  CACHE (0.000000)   SELECT * FROM `users` WHERE (`users`.`id` = 3) 
197
  CACHE (0.000000)   SELECT * FROM `users` WHERE (`users`.`id` = 3) 
198
Rendered repositories/_revisions (0.01902)
199
  Token Load (0.000074)   SELECT * FROM `tokens` WHERE (`tokens`.user_id = 1 AND (action='feeds')) LIMIT 1
200
  Token Columns (0.000394)   SHOW FIELDS FROM `tokens`
201
  Setting Load (0.000054)   SELECT * FROM `settings` WHERE (`settings`.`name` = 'ui_theme') LIMIT 1
202
  Setting Load (0.000058)   SELECT * FROM `settings` WHERE (`settings`.`name` = 'app_title') LIMIT 1
203
  Member Columns (0.000464)   SHOW FIELDS FROM `members`
204
  SQL (0.000085)   SELECT count(DISTINCT `members`.id) AS count_all FROM `members` LEFT OUTER JOIN `projects` ON `projects`.id = `members`.project_id LEFT OUTER JOIN `roles` ON `roles`.id = `members`.role_id WHERE (`members`.user_id = 1 AND (projects.status=1)) 
205
  Version Columns (0.000549)   SHOW FIELDS FROM `versions`
206
  SQL (0.000044)   SELECT count(*) AS count_all FROM `versions` WHERE (`versions`.project_id = 2) 
207
  Wiki Load (0.000063)   SELECT * FROM `wikis` WHERE (`wikis`.project_id = 2) LIMIT 1
208
  Board Columns (0.001085)   SHOW FIELDS FROM `boards`
209
  SQL (0.000046)   SELECT count(*) AS count_all FROM `boards` WHERE (`boards`.project_id = 2) 
210
Completed in 0.58750 (1 reqs/sec) | Rendering: 0.21271 (36%) | DB: 0.00867 (1%) | 200 OK [http://devel.stuartmathews.com/repositories/show/test]
211

    
212

    
213
Processing RepositoriesController#revision (for 78.86.23.141 at 2009-10-25 12:12:03) [GET]
214
  Session ID: ebbf9b6d1966d73faa37b351db04f99c
215
  Parameters: {"rev"=>"4", "action"=>"revision", "id"=>"test", "controller"=>"repositories"}
216
  SQL (0.000069)   SELECT max(`settings`.updated_on) AS max_updated_on FROM `settings` 
217
  User Load (0.000092)   SELECT * FROM `users` WHERE (`users`.`id` = 1) AND (users.status = 1) 
218
  Project Load (0.000061)   SELECT * FROM `projects` WHERE (`projects`.`identifier` = 'test') LIMIT 1
219
  Repository Load (0.000047)   SELECT * FROM `repositories` WHERE (`repositories`.project_id = 2) LIMIT 1
220
  EnabledModule Load (0.000125)   SELECT * FROM `enabled_modules` WHERE (`enabled_modules`.project_id = 2) 
221
  Changeset Load (0.000262)   SELECT * FROM `changesets` WHERE (`changesets`.`revision` = '4') AND (`changesets`.repository_id = 2) ORDER BY changesets.committed_on DESC, changesets.id DESC LIMIT 1
222
Rendering template within layouts/base
223
Rendering repositories/revision
224
  Changeset Load (0.000463)   SELECT * FROM `changesets` WHERE (id < 8 AND repository_id = 2) ORDER BY id DESC LIMIT 1
225
  Changeset Load (0.000151)   SELECT * FROM `changesets` WHERE (id > 8 AND repository_id = 2) ORDER BY id ASC LIMIT 1
226
  User Load (0.000067)   SELECT * FROM `users` WHERE (`users`.`id` = 3) 
227
  UserPreference Load (0.000048)   SELECT * FROM `user_preferences` WHERE (`user_preferences`.user_id = 1) LIMIT 1
228
  Join Table Columns (0.000510)   SHOW FIELDS FROM `changesets_issues`
229
  Issue Load (0.000073)   SELECT * FROM `issues` INNER JOIN `changesets_issues` ON `issues`.id = `changesets_issues`.issue_id WHERE (`changesets_issues`.changeset_id = 8 ) 
230
  Change Columns (0.000621)   SHOW FIELDS FROM `changes`
231
  SQL (0.000253)   SELECT count(*) AS count_all FROM `changes` WHERE (`changes`.changeset_id = 8) 
232
  Change Load (0.000308)   SELECT * FROM `changes` WHERE (`changes`.changeset_id = 8) ORDER BY path LIMIT 1000
233
  SQL (0.000114)   SELECT count(DISTINCT `members`.id) AS count_all FROM `members` LEFT OUTER JOIN `projects` ON `projects`.id = `members`.project_id LEFT OUTER JOIN `roles` ON `roles`.id = `members`.role_id WHERE (`members`.user_id = 1 AND (projects.status=1)) 
234
  SQL (0.000063)   SELECT count(*) AS count_all FROM `versions` WHERE (`versions`.project_id = 2) 
235
  Wiki Load (0.000076)   SELECT * FROM `wikis` WHERE (`wikis`.project_id = 2) LIMIT 1
236
  SQL (0.000043)   SELECT count(*) AS count_all FROM `boards` WHERE (`boards`.project_id = 2) 
237
Completed in 0.13631 (7 reqs/sec) | Rendering: 0.12500 (91%) | DB: 0.00345 (2%) | 200 OK [http://devel.stuartmathews.com/repositories/revision/test/4]
238

    
239

    
240
Processing RepositoriesController#entry (for 78.86.23.141 at 2009-10-25 12:12:07) [GET]
241
  Session ID: ebbf9b6d1966d73faa37b351db04f99c
242
  Parameters: {"rev"=>"4", "action"=>"entry", "id"=>"test", "path"=>["ComplianceStream", "ComplianceStream.xcodeproj", "stuartmathews.mode1v3"], "controller"=>"repositories"}
243
  SQL (0.000068)   SELECT max(`settings`.updated_on) AS max_updated_on FROM `settings` 
244
  User Load (0.000064)   SELECT * FROM `users` WHERE (`users`.`id` = 1) AND (users.status = 1) 
245
  Project Load (0.000061)   SELECT * FROM `projects` WHERE (`projects`.`identifier` = 'test') LIMIT 1
246
  Repository Load (0.000046)   SELECT * FROM `repositories` WHERE (`repositories`.project_id = 2) LIMIT 1
247
  EnabledModule Load (0.000062)   SELECT * FROM `enabled_modules` WHERE (`enabled_modules`.project_id = 2) 
248
Shelling out: svn list --xml 'svn+ssh://stuart@devel.stuartmathews.com/var/repos/compliancestream/ComplianceStream/ComplianceStream.xcodeproj'@4
249
Error parsing svn output: #<REXML::ParseException: No close tag for /lists/list>
250
/usr/lib/ruby/1.8/rexml/parsers/treeparser.rb:28:in `parse'
251
/usr/lib/ruby/1.8/rexml/document.rb:228:in `build'
252
/usr/lib/ruby/1.8/rexml/document.rb:43:in `initialize'
253
/opt/redmine/lib/redmine/scm/adapters/subversion_adapter.rb:85:in `new'
254
/opt/redmine/lib/redmine/scm/adapters/subversion_adapter.rb:85:in `entries'
255
/opt/redmine/lib/redmine/scm/adapters/abstract_adapter.rb:177:in `call'
256
/opt/redmine/lib/redmine/scm/adapters/abstract_adapter.rb:177:in `shellout'
257
/opt/redmine/lib/redmine/scm/adapters/abstract_adapter.rb:175:in `popen'
258
/opt/redmine/lib/redmine/scm/adapters/abstract_adapter.rb:175:in `shellout'
259
/opt/redmine/lib/redmine/scm/adapters/abstract_adapter.rb:165:in `shellout'
260
/opt/redmine/lib/redmine/scm/adapters/subversion_adapter.rb:82:in `entries'
261
/opt/redmine/lib/redmine/scm/adapters/abstract_adapter.rb:93:in `entry'
262
/opt/redmine/app/models/repository.rb:59:in `entry'
263
/opt/redmine/vendor/rails/activerecord/lib/active_record/associations/association_proxy.rb:173:in `send'
264
/opt/redmine/vendor/rails/activerecord/lib/active_record/associations/association_proxy.rb:173:in `method_missing'
265
/opt/redmine/app/controllers/repositories_controller.rb:112:in `entry'
266
/opt/redmine/vendor/rails/actionpack/lib/action_controller/base.rb:1166:in `send'
267
/opt/redmine/vendor/rails/actionpack/lib/action_controller/base.rb:1166:in `perform_action_without_filters'
268
/opt/redmine/vendor/rails/actionpack/lib/action_controller/filters.rb:579:in `call_filters'
269
/opt/redmine/vendor/rails/actionpack/lib/action_controller/filters.rb:572:in `perform_action_without_benchmark'
270
/opt/redmine/vendor/rails/actionpack/lib/action_controller/benchmarking.rb:68:in `perform_action_without_rescue'
271
/usr/lib/ruby/1.8/benchmark.rb:293:in `measure'
272
/opt/redmine/vendor/rails/actionpack/lib/action_controller/benchmarking.rb:68:in `perform_action_without_rescue'
273
/opt/redmine/vendor/rails/actionpack/lib/action_controller/rescue.rb:201:in `perform_action_without_caching'
274
/opt/redmine/vendor/rails/actionpack/lib/action_controller/caching/sql_cache.rb:13:in `passenger_orig_perform_action'
275
/opt/redmine/vendor/rails/activerecord/lib/active_record/connection_adapters/abstract/query_cache.rb:33:in `cache'
276
/opt/redmine/vendor/rails/activerecord/lib/active_record/query_cache.rb:8:in `cache'
277
/opt/redmine/vendor/rails/actionpack/lib/action_controller/caching/sql_cache.rb:12:in `passenger_orig_perform_action'
278
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/railz/request_handler.rb:65:in `perform_action'
279
/opt/redmine/vendor/rails/actionpack/lib/action_controller/base.rb:529:in `send'
280
/opt/redmine/vendor/rails/actionpack/lib/action_controller/base.rb:529:in `process_without_filters'
281
/opt/redmine/vendor/rails/actionpack/lib/action_controller/filters.rb:568:in `process_without_session_management_support'
282
/opt/redmine/vendor/rails/actionpack/lib/action_controller/session_management.rb:130:in `process'
283
/opt/redmine/vendor/rails/actionpack/lib/action_controller/base.rb:389:in `process'
284
/opt/redmine/vendor/rails/actionpack/lib/action_controller/dispatcher.rb:149:in `handle_request'
285
/opt/redmine/vendor/rails/actionpack/lib/action_controller/dispatcher.rb:107:in `dispatch'
286
/opt/redmine/vendor/rails/actionpack/lib/action_controller/dispatcher.rb:104:in `synchronize'
287
/opt/redmine/vendor/rails/actionpack/lib/action_controller/dispatcher.rb:104:in `dispatch'
288
/opt/redmine/vendor/rails/actionpack/lib/action_controller/dispatcher.rb:120:in `dispatch_cgi'
289
/opt/redmine/vendor/rails/actionpack/lib/action_controller/dispatcher.rb:35:in `dispatch'
290
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/railz/request_handler.rb:50:in `process_request'
291
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_request_handler.rb:207:in `main_loop'
292
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/railz/application_spawner.rb:378:in `start_request_handler'
293
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/railz/application_spawner.rb:336:in `handle_spawn_application'
294
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/utils.rb:183:in `safe_fork'
295
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/railz/application_spawner.rb:334:in `handle_spawn_application'
296
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:352:in `__send__'
297
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:352:in `main_loop'
298
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:196:in `start_synchronously'
299
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:163:in `start'
300
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/railz/application_spawner.rb:213:in `start'
301
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/spawn_manager.rb:262:in `spawn_rails_application'
302
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server_collection.rb:126:in `lookup_or_add'
303
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/spawn_manager.rb:256:in `spawn_rails_application'
304
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server_collection.rb:80:in `synchronize'
305
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server_collection.rb:79:in `synchronize'
306
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/spawn_manager.rb:255:in `spawn_rails_application'
307
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/spawn_manager.rb:154:in `spawn_application'
308
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/spawn_manager.rb:287:in `handle_spawn_application'
309
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:352:in `__send__'
310
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:352:in `main_loop'
311
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:196:in `start_synchronously'
312
/var/lib/gems/1.8/gems/passenger-2.2.5/bin/passenger-spawn-server:61
313
...
314
No close tag for /lists/list
315
Line: 
316
Position: 
317
Last 80 unconsumed characters:
318
Output was:
319
 <?xml version="1.0"?>
320
<lists>
321
<list
322
   path="svn+ssh://stuart@devel.stuartmathews.com/var/repos/compliancestream/ComplianceStream/ComplianceStream.xcodeproj">
323
Rendering template within layouts/base
324
  SQL (0.000115)   SELECT count(DISTINCT `members`.id) AS count_all FROM `members` LEFT OUTER JOIN `projects` ON `projects`.id = `members`.project_id LEFT OUTER JOIN `roles` ON `roles`.id = `members`.role_id WHERE (`members`.user_id = 1 AND (projects.status=1)) 
325
  SQL (0.000055)   SELECT count(*) AS count_all FROM `versions` WHERE (`versions`.project_id = 2) 
326
  Wiki Load (0.000121)   SELECT * FROM `wikis` WHERE (`wikis`.project_id = 2) LIMIT 1
327
  SQL (0.000069)   SELECT count(*) AS count_all FROM `boards` WHERE (`boards`.project_id = 2) 
328
Completed in 0.20328 (4 reqs/sec) | Rendering: 0.01341 (6%) | DB: 0.00066 (0%) | 500 Internal Server Error [http://devel.stuartmathews.com/repositories/entry/test/ComplianceStream/ComplianceStream.xcodeproj/stuartmathews.mode1v3?rev=4]
329

    
330

    
331
Processing RepositoriesController#revision (for 78.86.23.141 at 2009-10-25 12:12:20) [GET]
332
  Session ID: ebbf9b6d1966d73faa37b351db04f99c
333
  Parameters: {"rev"=>"1", "action"=>"revision", "id"=>"test", "controller"=>"repositories"}
334
  SQL (0.000072)   SELECT max(`settings`.updated_on) AS max_updated_on FROM `settings` 
335
  User Load (0.000720)   SELECT * FROM `users` WHERE (`users`.`id` = 1) AND (users.status = 1) 
336
  Project Load (0.000079)   SELECT * FROM `projects` WHERE (`projects`.`identifier` = 'test') LIMIT 1
337
  Repository Load (0.000083)   SELECT * FROM `repositories` WHERE (`repositories`.project_id = 2) LIMIT 1
338
  EnabledModule Load (0.000076)   SELECT * FROM `enabled_modules` WHERE (`enabled_modules`.project_id = 2) 
339
  Changeset Load (0.000085)   SELECT * FROM `changesets` WHERE (`changesets`.`revision` = '1') AND (`changesets`.repository_id = 2) ORDER BY changesets.committed_on DESC, changesets.id DESC LIMIT 1
340
Rendering template within layouts/base
341
Rendering repositories/revision
342
  Changeset Load (0.000065)   SELECT * FROM `changesets` WHERE (id < 5 AND repository_id = 2) ORDER BY id DESC LIMIT 1
343
  Changeset Load (0.000057)   SELECT * FROM `changesets` WHERE (id > 5 AND repository_id = 2) ORDER BY id ASC LIMIT 1
344
  User Load (0.000070)   SELECT * FROM `users` WHERE (`users`.`id` = 3) 
345
  UserPreference Load (0.000057)   SELECT * FROM `user_preferences` WHERE (`user_preferences`.user_id = 1) LIMIT 1
346
  Join Table Columns (0.000456)   SHOW FIELDS FROM `changesets_issues`
347
  Issue Load (0.000077)   SELECT * FROM `issues` INNER JOIN `changesets_issues` ON `issues`.id = `changesets_issues`.issue_id WHERE (`changesets_issues`.changeset_id = 5 ) 
348
  SQL (0.000092)   SELECT count(*) AS count_all FROM `changes` WHERE (`changes`.changeset_id = 5) 
349
  Change Load (0.000116)   SELECT * FROM `changes` WHERE (`changes`.changeset_id = 5) ORDER BY path LIMIT 1000
350
  SQL (0.000105)   SELECT count(DISTINCT `members`.id) AS count_all FROM `members` LEFT OUTER JOIN `projects` ON `projects`.id = `members`.project_id LEFT OUTER JOIN `roles` ON `roles`.id = `members`.role_id WHERE (`members`.user_id = 1 AND (projects.status=1)) 
351
  SQL (0.000051)   SELECT count(*) AS count_all FROM `versions` WHERE (`versions`.project_id = 2) 
352
  Wiki Load (0.000053)   SELECT * FROM `wikis` WHERE (`wikis`.project_id = 2) LIMIT 1
353
  SQL (0.000049)   SELECT count(*) AS count_all FROM `boards` WHERE (`boards`.project_id = 2) 
354
Completed in 0.07699 (12 reqs/sec) | Rendering: 0.06670 (86%) | DB: 0.00236 (3%) | 200 OK [http://devel.stuartmathews.com/repositories/revision/test?rev=1]
355

    
356

    
357
Processing RepositoriesController#entry (for 78.86.23.141 at 2009-10-25 12:12:29) [GET]
358
  Session ID: ebbf9b6d1966d73faa37b351db04f99c
359
  Parameters: {"rev"=>"1", "action"=>"entry", "id"=>"test", "path"=>["ComplianceStream", "build.xml"], "controller"=>"repositories"}
360
  SQL (0.000128)   SELECT max(`settings`.updated_on) AS max_updated_on FROM `settings` 
361
  User Load (0.000082)   SELECT * FROM `users` WHERE (`users`.`id` = 1) AND (users.status = 1) 
362
  Project Load (0.000147)   SELECT * FROM `projects` WHERE (`projects`.`identifier` = 'test') LIMIT 1
363
  Repository Load (0.000122)   SELECT * FROM `repositories` WHERE (`repositories`.project_id = 2) LIMIT 1
364
  EnabledModule Load (0.000073)   SELECT * FROM `enabled_modules` WHERE (`enabled_modules`.project_id = 2) 
365
Shelling out: svn list --xml 'svn+ssh://stuart@devel.stuartmathews.com/var/repos/compliancestream/ComplianceStream'@1
366
Error parsing svn output: #<REXML::ParseException: No close tag for /lists/list>
367
/usr/lib/ruby/1.8/rexml/parsers/treeparser.rb:28:in `parse'
368
/usr/lib/ruby/1.8/rexml/document.rb:228:in `build'
369
/usr/lib/ruby/1.8/rexml/document.rb:43:in `initialize'
370
/opt/redmine/lib/redmine/scm/adapters/subversion_adapter.rb:85:in `new'
371
/opt/redmine/lib/redmine/scm/adapters/subversion_adapter.rb:85:in `entries'
372
/opt/redmine/lib/redmine/scm/adapters/abstract_adapter.rb:177:in `call'
373
/opt/redmine/lib/redmine/scm/adapters/abstract_adapter.rb:177:in `shellout'
374
/opt/redmine/lib/redmine/scm/adapters/abstract_adapter.rb:175:in `popen'
375
/opt/redmine/lib/redmine/scm/adapters/abstract_adapter.rb:175:in `shellout'
376
/opt/redmine/lib/redmine/scm/adapters/abstract_adapter.rb:165:in `shellout'
377
/opt/redmine/lib/redmine/scm/adapters/subversion_adapter.rb:82:in `entries'
378
/opt/redmine/lib/redmine/scm/adapters/abstract_adapter.rb:93:in `entry'
379
/opt/redmine/app/models/repository.rb:59:in `entry'
380
/opt/redmine/vendor/rails/activerecord/lib/active_record/associations/association_proxy.rb:173:in `send'
381
/opt/redmine/vendor/rails/activerecord/lib/active_record/associations/association_proxy.rb:173:in `method_missing'
382
/opt/redmine/app/controllers/repositories_controller.rb:112:in `entry'
383
/opt/redmine/vendor/rails/actionpack/lib/action_controller/base.rb:1166:in `send'
384
/opt/redmine/vendor/rails/actionpack/lib/action_controller/base.rb:1166:in `perform_action_without_filters'
385
/opt/redmine/vendor/rails/actionpack/lib/action_controller/filters.rb:579:in `call_filters'
386
/opt/redmine/vendor/rails/actionpack/lib/action_controller/filters.rb:572:in `perform_action_without_benchmark'
387
/opt/redmine/vendor/rails/actionpack/lib/action_controller/benchmarking.rb:68:in `perform_action_without_rescue'
388
/usr/lib/ruby/1.8/benchmark.rb:293:in `measure'
389
/opt/redmine/vendor/rails/actionpack/lib/action_controller/benchmarking.rb:68:in `perform_action_without_rescue'
390
/opt/redmine/vendor/rails/actionpack/lib/action_controller/rescue.rb:201:in `perform_action_without_caching'
391
/opt/redmine/vendor/rails/actionpack/lib/action_controller/caching/sql_cache.rb:13:in `passenger_orig_perform_action'
392
/opt/redmine/vendor/rails/activerecord/lib/active_record/connection_adapters/abstract/query_cache.rb:33:in `cache'
393
/opt/redmine/vendor/rails/activerecord/lib/active_record/query_cache.rb:8:in `cache'
394
/opt/redmine/vendor/rails/actionpack/lib/action_controller/caching/sql_cache.rb:12:in `passenger_orig_perform_action'
395
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/railz/request_handler.rb:65:in `perform_action'
396
/opt/redmine/vendor/rails/actionpack/lib/action_controller/base.rb:529:in `send'
397
/opt/redmine/vendor/rails/actionpack/lib/action_controller/base.rb:529:in `process_without_filters'
398
/opt/redmine/vendor/rails/actionpack/lib/action_controller/filters.rb:568:in `process_without_session_management_support'
399
/opt/redmine/vendor/rails/actionpack/lib/action_controller/session_management.rb:130:in `process'
400
/opt/redmine/vendor/rails/actionpack/lib/action_controller/base.rb:389:in `process'
401
/opt/redmine/vendor/rails/actionpack/lib/action_controller/dispatcher.rb:149:in `handle_request'
402
/opt/redmine/vendor/rails/actionpack/lib/action_controller/dispatcher.rb:107:in `dispatch'
403
/opt/redmine/vendor/rails/actionpack/lib/action_controller/dispatcher.rb:104:in `synchronize'
404
/opt/redmine/vendor/rails/actionpack/lib/action_controller/dispatcher.rb:104:in `dispatch'
405
/opt/redmine/vendor/rails/actionpack/lib/action_controller/dispatcher.rb:120:in `dispatch_cgi'
406
/opt/redmine/vendor/rails/actionpack/lib/action_controller/dispatcher.rb:35:in `dispatch'
407
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/railz/request_handler.rb:50:in `process_request'
408
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_request_handler.rb:207:in `main_loop'
409
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/railz/application_spawner.rb:378:in `start_request_handler'
410
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/railz/application_spawner.rb:336:in `handle_spawn_application'
411
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/utils.rb:183:in `safe_fork'
412
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/railz/application_spawner.rb:334:in `handle_spawn_application'
413
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:352:in `__send__'
414
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:352:in `main_loop'
415
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:196:in `start_synchronously'
416
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:163:in `start'
417
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/railz/application_spawner.rb:213:in `start'
418
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/spawn_manager.rb:262:in `spawn_rails_application'
419
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server_collection.rb:126:in `lookup_or_add'
420
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/spawn_manager.rb:256:in `spawn_rails_application'
421
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server_collection.rb:80:in `synchronize'
422
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server_collection.rb:79:in `synchronize'
423
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/spawn_manager.rb:255:in `spawn_rails_application'
424
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/spawn_manager.rb:154:in `spawn_application'
425
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/spawn_manager.rb:287:in `handle_spawn_application'
426
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:352:in `__send__'
427
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:352:in `main_loop'
428
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:196:in `start_synchronously'
429
/var/lib/gems/1.8/gems/passenger-2.2.5/bin/passenger-spawn-server:61
430
...
431
No close tag for /lists/list
432
Line: 
433
Position: 
434
Last 80 unconsumed characters:
435
Output was:
436
 <?xml version="1.0"?>
437
<lists>
438
<list
439
   path="svn+ssh://stuart@devel.stuartmathews.com/var/repos/compliancestream/ComplianceStream">
440
Rendering template within layouts/base
441
  SQL (0.000104)   SELECT count(DISTINCT `members`.id) AS count_all FROM `members` LEFT OUTER JOIN `projects` ON `projects`.id = `members`.project_id LEFT OUTER JOIN `roles` ON `roles`.id = `members`.role_id WHERE (`members`.user_id = 1 AND (projects.status=1)) 
442
  SQL (0.000049)   SELECT count(*) AS count_all FROM `versions` WHERE (`versions`.project_id = 2) 
443
  Wiki Load (0.000049)   SELECT * FROM `wikis` WHERE (`wikis`.project_id = 2) LIMIT 1
444
  SQL (0.000085)   SELECT count(*) AS count_all FROM `boards` WHERE (`boards`.project_id = 2) 
445
Completed in 0.09216 (10 reqs/sec) | Rendering: 0.01341 (14%) | DB: 0.00084 (0%) | 500 Internal Server Error [http://devel.stuartmathews.com/repositories/entry/test/ComplianceStream/build.xml?rev=1]
446
checking plugin 'engines' for 'projects_controller'
447
checking plugin 'actionwebservice' for 'projects_controller'
448
checking plugin 'acts_as_activity_provider' for 'projects_controller'
449
checking plugin 'acts_as_attachable' for 'projects_controller'
450
checking plugin 'acts_as_customizable' for 'projects_controller'
451
checking plugin 'acts_as_event' for 'projects_controller'
452
checking plugin 'acts_as_list' for 'projects_controller'
453
checking plugin 'acts_as_searchable' for 'projects_controller'
454
checking plugin 'acts_as_tree' for 'projects_controller'
455
checking plugin 'acts_as_versioned' for 'projects_controller'
456
checking plugin 'acts_as_watchable' for 'projects_controller'
457
checking plugin 'classic_pagination' for 'projects_controller'
458
checking plugin 'coderay-0.7.6.227' for 'projects_controller'
459
checking plugin 'gloc-1.1.0' for 'projects_controller'
460
checking plugin 'gravatar' for 'projects_controller'
461
checking plugin 'rfpdf' for 'projects_controller'
462
checking plugin 'ruby-net-ldap-0.0.4' for 'projects_controller'
463
loading from application: projects_controller
464
checking plugin 'engines' for 'projects_helper'
465
checking plugin 'actionwebservice' for 'projects_helper'
466
checking plugin 'acts_as_activity_provider' for 'projects_helper'
467
checking plugin 'acts_as_attachable' for 'projects_helper'
468
checking plugin 'acts_as_customizable' for 'projects_helper'
469
checking plugin 'acts_as_event' for 'projects_helper'
470
checking plugin 'acts_as_list' for 'projects_helper'
471
checking plugin 'acts_as_searchable' for 'projects_helper'
472
checking plugin 'acts_as_tree' for 'projects_helper'
473
checking plugin 'acts_as_versioned' for 'projects_helper'
474
checking plugin 'acts_as_watchable' for 'projects_helper'
475
checking plugin 'classic_pagination' for 'projects_helper'
476
checking plugin 'coderay-0.7.6.227' for 'projects_helper'
477
checking plugin 'gloc-1.1.0' for 'projects_helper'
478
checking plugin 'gravatar' for 'projects_helper'
479
checking plugin 'rfpdf' for 'projects_helper'
480
checking plugin 'ruby-net-ldap-0.0.4' for 'projects_helper'
481
loading from application: projects_helper
482
checking plugin 'engines' for 'sort_helper'
483
checking plugin 'actionwebservice' for 'sort_helper'
484
checking plugin 'acts_as_activity_provider' for 'sort_helper'
485
checking plugin 'acts_as_attachable' for 'sort_helper'
486
checking plugin 'acts_as_customizable' for 'sort_helper'
487
checking plugin 'acts_as_event' for 'sort_helper'
488
checking plugin 'acts_as_list' for 'sort_helper'
489
checking plugin 'acts_as_searchable' for 'sort_helper'
490
checking plugin 'acts_as_tree' for 'sort_helper'
491
checking plugin 'acts_as_versioned' for 'sort_helper'
492
checking plugin 'acts_as_watchable' for 'sort_helper'
493
checking plugin 'classic_pagination' for 'sort_helper'
494
checking plugin 'coderay-0.7.6.227' for 'sort_helper'
495
checking plugin 'gloc-1.1.0' for 'sort_helper'
496
checking plugin 'gravatar' for 'sort_helper'
497
checking plugin 'rfpdf' for 'sort_helper'
498
checking plugin 'ruby-net-ldap-0.0.4' for 'sort_helper'
499
loading from application: sort_helper
500
checking plugin 'engines' for 'custom_fields_helper'
501
checking plugin 'actionwebservice' for 'custom_fields_helper'
502
checking plugin 'acts_as_activity_provider' for 'custom_fields_helper'
503
checking plugin 'acts_as_attachable' for 'custom_fields_helper'
504
checking plugin 'acts_as_customizable' for 'custom_fields_helper'
505
checking plugin 'acts_as_event' for 'custom_fields_helper'
506
checking plugin 'acts_as_list' for 'custom_fields_helper'
507
checking plugin 'acts_as_searchable' for 'custom_fields_helper'
508
checking plugin 'acts_as_tree' for 'custom_fields_helper'
509
checking plugin 'acts_as_versioned' for 'custom_fields_helper'
510
checking plugin 'acts_as_watchable' for 'custom_fields_helper'
511
checking plugin 'classic_pagination' for 'custom_fields_helper'
512
checking plugin 'coderay-0.7.6.227' for 'custom_fields_helper'
513
checking plugin 'gloc-1.1.0' for 'custom_fields_helper'
514
checking plugin 'gravatar' for 'custom_fields_helper'
515
checking plugin 'rfpdf' for 'custom_fields_helper'
516
checking plugin 'ruby-net-ldap-0.0.4' for 'custom_fields_helper'
517
loading from application: custom_fields_helper
518
checking plugin 'engines' for 'issues_helper'
519
checking plugin 'actionwebservice' for 'issues_helper'
520
checking plugin 'acts_as_activity_provider' for 'issues_helper'
521
checking plugin 'acts_as_attachable' for 'issues_helper'
522
checking plugin 'acts_as_customizable' for 'issues_helper'
523
checking plugin 'acts_as_event' for 'issues_helper'
524
checking plugin 'acts_as_list' for 'issues_helper'
525
checking plugin 'acts_as_searchable' for 'issues_helper'
526
checking plugin 'acts_as_tree' for 'issues_helper'
527
checking plugin 'acts_as_versioned' for 'issues_helper'
528
checking plugin 'acts_as_watchable' for 'issues_helper'
529
checking plugin 'classic_pagination' for 'issues_helper'
530
checking plugin 'coderay-0.7.6.227' for 'issues_helper'
531
checking plugin 'gloc-1.1.0' for 'issues_helper'
532
checking plugin 'gravatar' for 'issues_helper'
533
checking plugin 'rfpdf' for 'issues_helper'
534
checking plugin 'ruby-net-ldap-0.0.4' for 'issues_helper'
535
loading from application: issues_helper
536
checking plugin 'engines' for 'queries_helper'
537
checking plugin 'actionwebservice' for 'queries_helper'
538
checking plugin 'acts_as_activity_provider' for 'queries_helper'
539
checking plugin 'acts_as_attachable' for 'queries_helper'
540
checking plugin 'acts_as_customizable' for 'queries_helper'
541
checking plugin 'acts_as_event' for 'queries_helper'
542
checking plugin 'acts_as_list' for 'queries_helper'
543
checking plugin 'acts_as_searchable' for 'queries_helper'
544
checking plugin 'acts_as_tree' for 'queries_helper'
545
checking plugin 'acts_as_versioned' for 'queries_helper'
546
checking plugin 'acts_as_watchable' for 'queries_helper'
547
checking plugin 'classic_pagination' for 'queries_helper'
548
checking plugin 'coderay-0.7.6.227' for 'queries_helper'
549
checking plugin 'gloc-1.1.0' for 'queries_helper'
550
checking plugin 'gravatar' for 'queries_helper'
551
checking plugin 'rfpdf' for 'queries_helper'
552
checking plugin 'ruby-net-ldap-0.0.4' for 'queries_helper'
553
loading from application: queries_helper
554
checking plugin 'engines' for 'repositories_helper'
555
checking plugin 'actionwebservice' for 'repositories_helper'
556
checking plugin 'acts_as_activity_provider' for 'repositories_helper'
557
checking plugin 'acts_as_attachable' for 'repositories_helper'
558
checking plugin 'acts_as_customizable' for 'repositories_helper'
559
checking plugin 'acts_as_event' for 'repositories_helper'
560
checking plugin 'acts_as_list' for 'repositories_helper'
561
checking plugin 'acts_as_searchable' for 'repositories_helper'
562
checking plugin 'acts_as_tree' for 'repositories_helper'
563
checking plugin 'acts_as_versioned' for 'repositories_helper'
564
checking plugin 'acts_as_watchable' for 'repositories_helper'
565
checking plugin 'classic_pagination' for 'repositories_helper'
566
checking plugin 'coderay-0.7.6.227' for 'repositories_helper'
567
checking plugin 'gloc-1.1.0' for 'repositories_helper'
568
checking plugin 'gravatar' for 'repositories_helper'
569
checking plugin 'rfpdf' for 'repositories_helper'
570
checking plugin 'ruby-net-ldap-0.0.4' for 'repositories_helper'
571
loading from application: repositories_helper
572

    
573

    
574
Processing ProjectsController#settings (for 78.86.23.141 at 2009-10-25 12:14:43) [GET]
575
  Session ID: ebbf9b6d1966d73faa37b351db04f99c
576
  Parameters: {"action"=>"settings", "id"=>"test", "controller"=>"projects"}
577
  SQL (0.000099)   SELECT max(`settings`.updated_on) AS max_updated_on FROM `settings` 
578
  User Load (0.000101)   SELECT * FROM `users` WHERE (`users`.`id` = 1) AND (users.status = 1) 
579
  Project Load (0.000056)   SELECT * FROM `projects` WHERE (`projects`.`identifier` = 'test') LIMIT 1
580
  EnabledModule Load (0.000048)   SELECT * FROM `enabled_modules` WHERE (`enabled_modules`.project_id = 2) 
581
  Project Load (0.000063)   SELECT * FROM `projects` WHERE (parent_id IS NULL AND status = 1 AND id <> 2) ORDER BY name
582
  IssueCustomField Columns (0.000767)   SHOW FIELDS FROM `custom_fields`
583
  IssueCustomField Load (0.000059)   SELECT * FROM `custom_fields` WHERE ( (`custom_fields`.`type` = 'IssueCustomField' ) ) ORDER BY custom_fields.position
584
  IssueCategory Columns (0.009259)   SHOW FIELDS FROM `issue_categories`
585
  Tracker Load (0.000059)   SELECT * FROM `trackers` ORDER BY position
586
  Repository Load (0.000055)   SELECT * FROM `repositories` WHERE (`repositories`.project_id = 2) LIMIT 1
587
  Wiki Load (0.000048)   SELECT * FROM `wikis` WHERE (`wikis`.project_id = 2) LIMIT 1
588
Rendering template within layouts/base
589
Rendering projects/settings
590
  CustomField Load (0.000151)   SELECT * FROM `custom_fields` WHERE (type = 'ProjectCustomField') ORDER BY position
591
  Tracker Columns (0.000544)   SHOW FIELDS FROM `trackers`
592
  Tracker Exists (0.000053)   SELECT `trackers`.id FROM `trackers` INNER JOIN `projects_trackers` ON `trackers`.id = `projects_trackers`.tracker_id WHERE (`trackers`.`id` = 1) AND (`projects_trackers`.project_id = 2 ) ORDER BY trackers.position LIMIT 1
593
  Tracker Exists (0.000039)   SELECT `trackers`.id FROM `trackers` INNER JOIN `projects_trackers` ON `trackers`.id = `projects_trackers`.tracker_id WHERE (`trackers`.`id` = 2) AND (`projects_trackers`.project_id = 2 ) ORDER BY trackers.position LIMIT 1
594
  Tracker Exists (0.000034)   SELECT `trackers`.id FROM `trackers` INNER JOIN `projects_trackers` ON `trackers`.id = `projects_trackers`.tracker_id WHERE (`trackers`.`id` = 3) AND (`projects_trackers`.project_id = 2 ) ORDER BY trackers.position LIMIT 1
595
Rendered projects/_form (0.01315)
596
Rendered projects/_edit (0.05334)
597
Rendered projects/settings/_modules (0.00664)
598
  Role Load (0.000080)   SELECT * FROM `roles` WHERE (`roles`.`builtin` = 0) ORDER BY position
599
  User Load (0.000051)   SELECT * FROM `users` WHERE (users.status = 1) 
600
  User Load (0.000850)   SELECT `users`.* FROM `users` INNER JOIN members ON users.id = members.user_id WHERE ((`members`.project_id = 2) AND ((users.status=1))) 
601
  Role Columns (0.000971)   SHOW FIELDS FROM `roles`
602
  Member Load Including Associations (0.000086)   SELECT `members`.`id` AS t0_r0, `members`.`user_id` AS t0_r1, `members`.`project_id` AS t0_r2, `members`.`role_id` AS t0_r3, `members`.`created_on` AS t0_r4, `members`.`mail_notification` AS t0_r5, `roles`.`id` AS t1_r0, `roles`.`name` AS t1_r1, `roles`.`position` AS t1_r2, `roles`.`assignable` AS t1_r3, `roles`.`builtin` AS t1_r4, `roles`.`permissions` AS t1_r5, `users`.`id` AS t2_r0, `users`.`login` AS t2_r1, `users`.`hashed_password` AS t2_r2, `users`.`firstname` AS t2_r3, `users`.`lastname` AS t2_r4, `users`.`mail` AS t2_r5, `users`.`mail_notification` AS t2_r6, `users`.`admin` AS t2_r7, `users`.`status` AS t2_r8, `users`.`last_login_on` AS t2_r9, `users`.`language` AS t2_r10, `users`.`auth_source_id` AS t2_r11, `users`.`created_on` AS t2_r12, `users`.`updated_on` AS t2_r13, `users`.`type` AS t2_r14 FROM `members` LEFT OUTER JOIN `roles` ON `roles`.id = `members`.role_id LEFT OUTER JOIN `users` ON `users`.id = `members`.user_id WHERE (`members`.project_id = 2 AND (users.status=1)) 
603
Rendered projects/settings/_members (0.00969)
604
  SQL (0.000058)   SELECT count(*) AS count_all FROM `versions` WHERE (`versions`.project_id = 2) 
605
Rendered projects/settings/_versions (0.00104)
606
  SQL (0.000061)   SELECT count(*) AS count_all FROM `issue_categories` WHERE (`issue_categories`.project_id = 2) 
607
Rendered projects/settings/_issue_categories (0.00107)
608
Rendered projects/settings/_wiki (0.00278)
609
  Setting Load (0.000720)   SELECT * FROM `settings` WHERE (`settings`.`name` = 'enabled_scm') LIMIT 1
610
Rendered projects/settings/_repository (0.01144)
611
  SQL (0.000080)   SELECT count(*) AS count_all FROM `boards` WHERE (`boards`.project_id = 2) 
612
Rendered projects/settings/_boards (0.00162)
613
  SQL (0.000059)   SELECT count(DISTINCT `members`.id) AS count_all FROM `members` LEFT OUTER JOIN `projects` ON `projects`.id = `members`.project_id LEFT OUTER JOIN `roles` ON `roles`.id = `members`.role_id WHERE (`members`.user_id = 1 AND (projects.status=1)) 
614
Completed in 0.21632 (4 reqs/sec) | Rendering: 0.18254 (84%) | DB: 0.01445 (6%) | 200 OK [http://devel.stuartmathews.com/projects/settings/test]
615

    
616

    
617
Processing RepositoriesController#show (for 78.86.23.141 at 2009-10-25 12:14:46) [GET]
618
  Session ID: ebbf9b6d1966d73faa37b351db04f99c
619
  Parameters: {"action"=>"show", "id"=>"test", "controller"=>"repositories"}
620
  SQL (0.000093)   SELECT max(`settings`.updated_on) AS max_updated_on FROM `settings` 
621
  User Load (0.000069)   SELECT * FROM `users` WHERE (`users`.`id` = 1) AND (users.status = 1) 
622
  Project Load (0.000067)   SELECT * FROM `projects` WHERE (`projects`.`identifier` = 'test') LIMIT 1
623
  Repository Load (0.000051)   SELECT * FROM `repositories` WHERE (`repositories`.project_id = 2) LIMIT 1
624
  EnabledModule Load (0.000062)   SELECT * FROM `enabled_modules` WHERE (`enabled_modules`.project_id = 2) 
625
Shelling out: svn info --xml 'svn+ssh://stuart@devel.stuartmathews.com/var/repos/compliancestream/'
626
Shelling out: svn list --xml 'svn+ssh://stuart@devel.stuartmathews.com/var/repos/compliancestream/'@HEAD
627
Error parsing svn output: #<REXML::ParseException: No close tag for /lists/list>
628
/usr/lib/ruby/1.8/rexml/parsers/treeparser.rb:28:in `parse'
629
/usr/lib/ruby/1.8/rexml/document.rb:228:in `build'
630
/usr/lib/ruby/1.8/rexml/document.rb:43:in `initialize'
631
/opt/redmine/lib/redmine/scm/adapters/subversion_adapter.rb:85:in `new'
632
/opt/redmine/lib/redmine/scm/adapters/subversion_adapter.rb:85:in `entries'
633
/opt/redmine/lib/redmine/scm/adapters/abstract_adapter.rb:177:in `call'
634
/opt/redmine/lib/redmine/scm/adapters/abstract_adapter.rb:177:in `shellout'
635
/opt/redmine/lib/redmine/scm/adapters/abstract_adapter.rb:175:in `popen'
636
/opt/redmine/lib/redmine/scm/adapters/abstract_adapter.rb:175:in `shellout'
637
/opt/redmine/lib/redmine/scm/adapters/abstract_adapter.rb:165:in `shellout'
638
/opt/redmine/lib/redmine/scm/adapters/subversion_adapter.rb:82:in `entries'
639
/opt/redmine/app/models/repository.rb:63:in `entries'
640
/opt/redmine/vendor/rails/activerecord/lib/active_record/associations/association_proxy.rb:173:in `send'
641
/opt/redmine/vendor/rails/activerecord/lib/active_record/associations/association_proxy.rb:173:in `method_missing'
642
/opt/redmine/app/controllers/repositories_controller.rb:71:in `show'
643
/opt/redmine/vendor/rails/actionpack/lib/action_controller/base.rb:1166:in `send'
644
/opt/redmine/vendor/rails/actionpack/lib/action_controller/base.rb:1166:in `perform_action_without_filters'
645
/opt/redmine/vendor/rails/actionpack/lib/action_controller/filters.rb:579:in `call_filters'
646
/opt/redmine/vendor/rails/actionpack/lib/action_controller/filters.rb:572:in `perform_action_without_benchmark'
647
/opt/redmine/vendor/rails/actionpack/lib/action_controller/benchmarking.rb:68:in `perform_action_without_rescue'
648
/usr/lib/ruby/1.8/benchmark.rb:293:in `measure'
649
/opt/redmine/vendor/rails/actionpack/lib/action_controller/benchmarking.rb:68:in `perform_action_without_rescue'
650
/opt/redmine/vendor/rails/actionpack/lib/action_controller/rescue.rb:201:in `perform_action_without_caching'
651
/opt/redmine/vendor/rails/actionpack/lib/action_controller/caching/sql_cache.rb:13:in `passenger_orig_perform_action'
652
/opt/redmine/vendor/rails/activerecord/lib/active_record/connection_adapters/abstract/query_cache.rb:33:in `cache'
653
/opt/redmine/vendor/rails/activerecord/lib/active_record/query_cache.rb:8:in `cache'
654
/opt/redmine/vendor/rails/actionpack/lib/action_controller/caching/sql_cache.rb:12:in `passenger_orig_perform_action'
655
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/railz/request_handler.rb:65:in `perform_action'
656
/opt/redmine/vendor/rails/actionpack/lib/action_controller/base.rb:529:in `send'
657
/opt/redmine/vendor/rails/actionpack/lib/action_controller/base.rb:529:in `process_without_filters'
658
/opt/redmine/vendor/rails/actionpack/lib/action_controller/filters.rb:568:in `process_without_session_management_support'
659
/opt/redmine/vendor/rails/actionpack/lib/action_controller/session_management.rb:130:in `process'
660
/opt/redmine/vendor/rails/actionpack/lib/action_controller/base.rb:389:in `process'
661
/opt/redmine/vendor/rails/actionpack/lib/action_controller/dispatcher.rb:149:in `handle_request'
662
/opt/redmine/vendor/rails/actionpack/lib/action_controller/dispatcher.rb:107:in `dispatch'
663
/opt/redmine/vendor/rails/actionpack/lib/action_controller/dispatcher.rb:104:in `synchronize'
664
/opt/redmine/vendor/rails/actionpack/lib/action_controller/dispatcher.rb:104:in `dispatch'
665
/opt/redmine/vendor/rails/actionpack/lib/action_controller/dispatcher.rb:120:in `dispatch_cgi'
666
/opt/redmine/vendor/rails/actionpack/lib/action_controller/dispatcher.rb:35:in `dispatch'
667
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/railz/request_handler.rb:50:in `process_request'
668
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_request_handler.rb:207:in `main_loop'
669
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/railz/application_spawner.rb:378:in `start_request_handler'
670
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/railz/application_spawner.rb:336:in `handle_spawn_application'
671
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/utils.rb:183:in `safe_fork'
672
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/railz/application_spawner.rb:334:in `handle_spawn_application'
673
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:352:in `__send__'
674
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:352:in `main_loop'
675
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:196:in `start_synchronously'
676
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:163:in `start'
677
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/railz/application_spawner.rb:213:in `start'
678
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/spawn_manager.rb:262:in `spawn_rails_application'
679
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server_collection.rb:126:in `lookup_or_add'
680
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/spawn_manager.rb:256:in `spawn_rails_application'
681
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server_collection.rb:80:in `synchronize'
682
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server_collection.rb:79:in `synchronize'
683
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/spawn_manager.rb:255:in `spawn_rails_application'
684
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/spawn_manager.rb:154:in `spawn_application'
685
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/spawn_manager.rb:287:in `handle_spawn_application'
686
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:352:in `__send__'
687
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:352:in `main_loop'
688
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:196:in `start_synchronously'
689
/var/lib/gems/1.8/gems/passenger-2.2.5/bin/passenger-spawn-server:61
690
...
691
No close tag for /lists/list
692
Line: 
693
Position: 
694
Last 80 unconsumed characters:
695
Output was:
696
 <?xml version="1.0"?>
697
<lists>
698
<list
699
   path="svn+ssh://stuart@devel.stuartmathews.com/var/repos/compliancestream">
700
  Changeset Load (0.000140)   SELECT * FROM `changesets` WHERE (`changesets`.repository_id = 2) ORDER BY committed_on DESC, changesets.committed_on DESC, changesets.id DESC LIMIT 10
701
Rendering template within layouts/base
702
Rendering repositories/show
703
  UserPreference Load (0.000093)   SELECT * FROM `user_preferences` WHERE (`user_preferences`.user_id = 1) LIMIT 1
704
  User Load (0.000058)   SELECT * FROM `users` WHERE (`users`.`id` = 3) 
705
  CACHE (0.000000)   SELECT * FROM `users` WHERE (`users`.`id` = 3) 
706
  CACHE (0.000000)   SELECT * FROM `users` WHERE (`users`.`id` = 3) 
707
  CACHE (0.000000)   SELECT * FROM `users` WHERE (`users`.`id` = 3) 
708
Rendered repositories/_revisions (0.00765)
709
  Token Load (0.000079)   SELECT * FROM `tokens` WHERE (`tokens`.user_id = 1 AND (action='feeds')) LIMIT 1
710
  SQL (0.000103)   SELECT count(DISTINCT `members`.id) AS count_all FROM `members` LEFT OUTER JOIN `projects` ON `projects`.id = `members`.project_id LEFT OUTER JOIN `roles` ON `roles`.id = `members`.role_id WHERE (`members`.user_id = 1 AND (projects.status=1)) 
711
  SQL (0.000056)   SELECT count(*) AS count_all FROM `versions` WHERE (`versions`.project_id = 2) 
712
  Wiki Load (0.000050)   SELECT * FROM `wikis` WHERE (`wikis`.project_id = 2) LIMIT 1
713
  SQL (0.000048)   SELECT count(*) AS count_all FROM `boards` WHERE (`boards`.project_id = 2) 
714
Completed in 0.16863 (5 reqs/sec) | Rendering: 0.02581 (15%) | DB: 0.00097 (0%) | 200 OK [http://devel.stuartmathews.com/repositories/show/test]
715

    
716

    
717
Processing ProjectsController#settings (for 78.86.23.141 at 2009-10-25 12:14:48) [GET]
718
  Session ID: ebbf9b6d1966d73faa37b351db04f99c
719
  Parameters: {"action"=>"settings", "id"=>"test", "controller"=>"projects"}
720
  SQL (0.000256)   SELECT max(`settings`.updated_on) AS max_updated_on FROM `settings` 
721
  User Load (0.000063)   SELECT * FROM `users` WHERE (`users`.`id` = 1) AND (users.status = 1) 
722
  Project Load (0.000056)   SELECT * FROM `projects` WHERE (`projects`.`identifier` = 'test') LIMIT 1
723
  EnabledModule Load (0.000435)   SELECT * FROM `enabled_modules` WHERE (`enabled_modules`.project_id = 2) 
724
  Project Load (0.000048)   SELECT * FROM `projects` WHERE (parent_id IS NULL AND status = 1 AND id <> 2) ORDER BY name
725
  IssueCustomField Load (0.000053)   SELECT * FROM `custom_fields` WHERE ( (`custom_fields`.`type` = 'IssueCustomField' ) ) ORDER BY custom_fields.position
726
  Tracker Load (0.000402)   SELECT * FROM `trackers` ORDER BY position
727
  Repository Load (0.000044)   SELECT * FROM `repositories` WHERE (`repositories`.project_id = 2) LIMIT 1
728
  Wiki Load (0.000564)   SELECT * FROM `wikis` WHERE (`wikis`.project_id = 2) LIMIT 1
729
Rendering template within layouts/base
730
Rendering projects/settings
731
  CustomField Load (0.000084)   SELECT * FROM `custom_fields` WHERE (type = 'ProjectCustomField') ORDER BY position
732
  Tracker Exists (0.000052)   SELECT `trackers`.id FROM `trackers` INNER JOIN `projects_trackers` ON `trackers`.id = `projects_trackers`.tracker_id WHERE (`trackers`.`id` = 1) AND (`projects_trackers`.project_id = 2 ) ORDER BY trackers.position LIMIT 1
733
  Tracker Exists (0.000040)   SELECT `trackers`.id FROM `trackers` INNER JOIN `projects_trackers` ON `trackers`.id = `projects_trackers`.tracker_id WHERE (`trackers`.`id` = 2) AND (`projects_trackers`.project_id = 2 ) ORDER BY trackers.position LIMIT 1
734
  Tracker Exists (0.000077)   SELECT `trackers`.id FROM `trackers` INNER JOIN `projects_trackers` ON `trackers`.id = `projects_trackers`.tracker_id WHERE (`trackers`.`id` = 3) AND (`projects_trackers`.project_id = 2 ) ORDER BY trackers.position LIMIT 1
735
Rendered projects/_form (0.01022)
736
Rendered projects/_edit (0.01145)
737
Rendered projects/settings/_modules (0.00641)
738
  Role Load (0.000062)   SELECT * FROM `roles` WHERE (`roles`.`builtin` = 0) ORDER BY position
739
  User Load (0.000055)   SELECT * FROM `users` WHERE (users.status = 1) 
740
  User Load (0.000079)   SELECT `users`.* FROM `users` INNER JOIN members ON users.id = members.user_id WHERE ((`members`.project_id = 2) AND ((users.status=1))) 
741
  Member Load Including Associations (0.000072)   SELECT `members`.`id` AS t0_r0, `members`.`user_id` AS t0_r1, `members`.`project_id` AS t0_r2, `members`.`role_id` AS t0_r3, `members`.`created_on` AS t0_r4, `members`.`mail_notification` AS t0_r5, `roles`.`id` AS t1_r0, `roles`.`name` AS t1_r1, `roles`.`position` AS t1_r2, `roles`.`assignable` AS t1_r3, `roles`.`builtin` AS t1_r4, `roles`.`permissions` AS t1_r5, `users`.`id` AS t2_r0, `users`.`login` AS t2_r1, `users`.`hashed_password` AS t2_r2, `users`.`firstname` AS t2_r3, `users`.`lastname` AS t2_r4, `users`.`mail` AS t2_r5, `users`.`mail_notification` AS t2_r6, `users`.`admin` AS t2_r7, `users`.`status` AS t2_r8, `users`.`last_login_on` AS t2_r9, `users`.`language` AS t2_r10, `users`.`auth_source_id` AS t2_r11, `users`.`created_on` AS t2_r12, `users`.`updated_on` AS t2_r13, `users`.`type` AS t2_r14 FROM `members` LEFT OUTER JOIN `roles` ON `roles`.id = `members`.role_id LEFT OUTER JOIN `users` ON `users`.id = `members`.user_id WHERE (`members`.project_id = 2 AND (users.status=1)) 
742
Rendered projects/settings/_members (0.00554)
743
  SQL (0.000054)   SELECT count(*) AS count_all FROM `versions` WHERE (`versions`.project_id = 2) 
744
Rendered projects/settings/_versions (0.00085)
745
  SQL (0.000043)   SELECT count(*) AS count_all FROM `issue_categories` WHERE (`issue_categories`.project_id = 2) 
746
Rendered projects/settings/_issue_categories (0.00081)
747
Rendered projects/settings/_wiki (0.00263)
748
Rendered projects/settings/_repository (0.00916)
749
  SQL (0.000066)   SELECT count(*) AS count_all FROM `boards` WHERE (`boards`.project_id = 2) 
750
Rendered projects/settings/_boards (0.00091)
751
  SQL (0.000059)   SELECT count(DISTINCT `members`.id) AS count_all FROM `members` LEFT OUTER JOIN `projects` ON `projects`.id = `members`.project_id LEFT OUTER JOIN `roles` ON `roles`.id = `members`.role_id WHERE (`members`.user_id = 1 AND (projects.status=1)) 
752
Completed in 0.07052 (14 reqs/sec) | Rendering: 0.06014 (85%) | DB: 0.00266 (3%) | 200 OK [http://devel.stuartmathews.com/projects/settings/test]
753

    
754

    
755
Processing RepositoriesController#committers (for 78.86.23.141 at 2009-10-25 12:15:03) [GET]
756
  Session ID: ebbf9b6d1966d73faa37b351db04f99c
757
  Parameters: {"action"=>"committers", "id"=>"test", "controller"=>"repositories"}
758
  SQL (0.000073)   SELECT max(`settings`.updated_on) AS max_updated_on FROM `settings` 
759
  User Load (0.000066)   SELECT * FROM `users` WHERE (`users`.`id` = 1) AND (users.status = 1) 
760
  Project Load (0.000063)   SELECT * FROM `projects` WHERE (`projects`.`identifier` = 'test') LIMIT 1
761
  Repository Load (0.000050)   SELECT * FROM `repositories` WHERE (`repositories`.project_id = 2) LIMIT 1
762
  EnabledModule Load (0.000074)   SELECT * FROM `enabled_modules` WHERE (`enabled_modules`.project_id = 2) 
763
  SQL (0.000357)   SELECT DISTINCT committer, user_id FROM changesets WHERE repository_id = 2
764
  User Load (0.000082)   SELECT `users`.* FROM `users` INNER JOIN members ON users.id = members.user_id WHERE ((`members`.project_id = 2) AND ((users.status=1))) 
765
  User Load (0.000191)   SELECT * FROM `users` WHERE (`users`.`id` IN (3)) 
766
Rendering template within layouts/base
767
Rendering repositories/committers
768
  SQL (0.000193)   SELECT count(DISTINCT `members`.id) AS count_all FROM `members` LEFT OUTER JOIN `projects` ON `projects`.id = `members`.project_id LEFT OUTER JOIN `roles` ON `roles`.id = `members`.role_id WHERE (`members`.user_id = 1 AND (projects.status=1)) 
769
  SQL (0.000096)   SELECT count(*) AS count_all FROM `versions` WHERE (`versions`.project_id = 2) 
770
  Wiki Load (0.000057)   SELECT * FROM `wikis` WHERE (`wikis`.project_id = 2) LIMIT 1
771
  SQL (0.000047)   SELECT count(*) AS count_all FROM `boards` WHERE (`boards`.project_id = 2) 
772
Completed in 0.03865 (25 reqs/sec) | Rendering: 0.02947 (76%) | DB: 0.00135 (3%) | 200 OK [http://devel.stuartmathews.com/repositories/committers/test]
773

    
774

    
775
Processing RepositoriesController#show (for 78.86.23.141 at 2009-10-25 12:15:10) [GET]
776
  Session ID: ebbf9b6d1966d73faa37b351db04f99c
777
  Parameters: {"action"=>"show", "id"=>"test", "controller"=>"repositories"}
778
  SQL (0.000064)   SELECT max(`settings`.updated_on) AS max_updated_on FROM `settings` 
779
  User Load (0.000543)   SELECT * FROM `users` WHERE (`users`.`id` = 1) AND (users.status = 1) 
780
  Project Load (0.000089)   SELECT * FROM `projects` WHERE (`projects`.`identifier` = 'test') LIMIT 1
781
  Repository Load (0.000040)   SELECT * FROM `repositories` WHERE (`repositories`.project_id = 2) LIMIT 1
782
  EnabledModule Load (0.000453)   SELECT * FROM `enabled_modules` WHERE (`enabled_modules`.project_id = 2) 
783
Shelling out: svn info --xml 'svn+ssh://stuart@devel.stuartmathews.com/var/repos/compliancestream/'
784
Shelling out: svn list --xml 'svn+ssh://stuart@devel.stuartmathews.com/var/repos/compliancestream/'@HEAD
785
Error parsing svn output: #<REXML::ParseException: No close tag for /lists/list>
786
/usr/lib/ruby/1.8/rexml/parsers/treeparser.rb:28:in `parse'
787
/usr/lib/ruby/1.8/rexml/document.rb:228:in `build'
788
/usr/lib/ruby/1.8/rexml/document.rb:43:in `initialize'
789
/opt/redmine/lib/redmine/scm/adapters/subversion_adapter.rb:85:in `new'
790
/opt/redmine/lib/redmine/scm/adapters/subversion_adapter.rb:85:in `entries'
791
/opt/redmine/lib/redmine/scm/adapters/abstract_adapter.rb:177:in `call'
792
/opt/redmine/lib/redmine/scm/adapters/abstract_adapter.rb:177:in `shellout'
793
/opt/redmine/lib/redmine/scm/adapters/abstract_adapter.rb:175:in `popen'
794
/opt/redmine/lib/redmine/scm/adapters/abstract_adapter.rb:175:in `shellout'
795
/opt/redmine/lib/redmine/scm/adapters/abstract_adapter.rb:165:in `shellout'
796
/opt/redmine/lib/redmine/scm/adapters/subversion_adapter.rb:82:in `entries'
797
/opt/redmine/app/models/repository.rb:63:in `entries'
798
/opt/redmine/vendor/rails/activerecord/lib/active_record/associations/association_proxy.rb:173:in `send'
799
/opt/redmine/vendor/rails/activerecord/lib/active_record/associations/association_proxy.rb:173:in `method_missing'
800
/opt/redmine/app/controllers/repositories_controller.rb:71:in `show'
801
/opt/redmine/vendor/rails/actionpack/lib/action_controller/base.rb:1166:in `send'
802
/opt/redmine/vendor/rails/actionpack/lib/action_controller/base.rb:1166:in `perform_action_without_filters'
803
/opt/redmine/vendor/rails/actionpack/lib/action_controller/filters.rb:579:in `call_filters'
804
/opt/redmine/vendor/rails/actionpack/lib/action_controller/filters.rb:572:in `perform_action_without_benchmark'
805
/opt/redmine/vendor/rails/actionpack/lib/action_controller/benchmarking.rb:68:in `perform_action_without_rescue'
806
/usr/lib/ruby/1.8/benchmark.rb:293:in `measure'
807
/opt/redmine/vendor/rails/actionpack/lib/action_controller/benchmarking.rb:68:in `perform_action_without_rescue'
808
/opt/redmine/vendor/rails/actionpack/lib/action_controller/rescue.rb:201:in `perform_action_without_caching'
809
/opt/redmine/vendor/rails/actionpack/lib/action_controller/caching/sql_cache.rb:13:in `passenger_orig_perform_action'
810
/opt/redmine/vendor/rails/activerecord/lib/active_record/connection_adapters/abstract/query_cache.rb:33:in `cache'
811
/opt/redmine/vendor/rails/activerecord/lib/active_record/query_cache.rb:8:in `cache'
812
/opt/redmine/vendor/rails/actionpack/lib/action_controller/caching/sql_cache.rb:12:in `passenger_orig_perform_action'
813
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/railz/request_handler.rb:65:in `perform_action'
814
/opt/redmine/vendor/rails/actionpack/lib/action_controller/base.rb:529:in `send'
815
/opt/redmine/vendor/rails/actionpack/lib/action_controller/base.rb:529:in `process_without_filters'
816
/opt/redmine/vendor/rails/actionpack/lib/action_controller/filters.rb:568:in `process_without_session_management_support'
817
/opt/redmine/vendor/rails/actionpack/lib/action_controller/session_management.rb:130:in `process'
818
/opt/redmine/vendor/rails/actionpack/lib/action_controller/base.rb:389:in `process'
819
/opt/redmine/vendor/rails/actionpack/lib/action_controller/dispatcher.rb:149:in `handle_request'
820
/opt/redmine/vendor/rails/actionpack/lib/action_controller/dispatcher.rb:107:in `dispatch'
821
/opt/redmine/vendor/rails/actionpack/lib/action_controller/dispatcher.rb:104:in `synchronize'
822
/opt/redmine/vendor/rails/actionpack/lib/action_controller/dispatcher.rb:104:in `dispatch'
823
/opt/redmine/vendor/rails/actionpack/lib/action_controller/dispatcher.rb:120:in `dispatch_cgi'
824
/opt/redmine/vendor/rails/actionpack/lib/action_controller/dispatcher.rb:35:in `dispatch'
825
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/railz/request_handler.rb:50:in `process_request'
826
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_request_handler.rb:207:in `main_loop'
827
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/railz/application_spawner.rb:378:in `start_request_handler'
828
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/railz/application_spawner.rb:336:in `handle_spawn_application'
829
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/utils.rb:183:in `safe_fork'
830
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/railz/application_spawner.rb:334:in `handle_spawn_application'
831
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:352:in `__send__'
832
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:352:in `main_loop'
833
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:196:in `start_synchronously'
834
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:163:in `start'
835
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/railz/application_spawner.rb:213:in `start'
836
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/spawn_manager.rb:262:in `spawn_rails_application'
837
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server_collection.rb:126:in `lookup_or_add'
838
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/spawn_manager.rb:256:in `spawn_rails_application'
839
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server_collection.rb:80:in `synchronize'
840
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server_collection.rb:79:in `synchronize'
841
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/spawn_manager.rb:255:in `spawn_rails_application'
842
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/spawn_manager.rb:154:in `spawn_application'
843
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/spawn_manager.rb:287:in `handle_spawn_application'
844
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:352:in `__send__'
845
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:352:in `main_loop'
846
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:196:in `start_synchronously'
847
/var/lib/gems/1.8/gems/passenger-2.2.5/bin/passenger-spawn-server:61
848
...
849
No close tag for /lists/list
850
Line: 
851
Position: 
852
Last 80 unconsumed characters:
853
Output was:
854
 <?xml version="1.0"?>
855
<lists>
856
<list
857
   path="svn+ssh://stuart@devel.stuartmathews.com/var/repos/compliancestream">
858
  Changeset Load (0.000117)   SELECT * FROM `changesets` WHERE (`changesets`.repository_id = 2) ORDER BY committed_on DESC, changesets.committed_on DESC, changesets.id DESC LIMIT 10
859
Rendering template within layouts/base
860
Rendering repositories/show
861
  UserPreference Load (0.000082)   SELECT * FROM `user_preferences` WHERE (`user_preferences`.user_id = 1) LIMIT 1
862
  User Load (0.000135)   SELECT * FROM `users` WHERE (`users`.`id` = 3) 
863
  CACHE (0.000000)   SELECT * FROM `users` WHERE (`users`.`id` = 3) 
864
  CACHE (0.000000)   SELECT * FROM `users` WHERE (`users`.`id` = 3) 
865
  CACHE (0.000000)   SELECT * FROM `users` WHERE (`users`.`id` = 3) 
866
Rendered repositories/_revisions (0.00789)
867
  Token Load (0.000063)   SELECT * FROM `tokens` WHERE (`tokens`.user_id = 1 AND (action='feeds')) LIMIT 1
868
  SQL (0.000076)   SELECT count(DISTINCT `members`.id) AS count_all FROM `members` LEFT OUTER JOIN `projects` ON `projects`.id = `members`.project_id LEFT OUTER JOIN `roles` ON `roles`.id = `members`.role_id WHERE (`members`.user_id = 1 AND (projects.status=1)) 
869
  SQL (0.000841)   SELECT count(*) AS count_all FROM `versions` WHERE (`versions`.project_id = 2) 
870
  Wiki Load (0.000070)   SELECT * FROM `wikis` WHERE (`wikis`.project_id = 2) LIMIT 1
871
  SQL (0.000049)   SELECT count(*) AS count_all FROM `boards` WHERE (`boards`.project_id = 2) 
872
Completed in 0.17300 (5 reqs/sec) | Rendering: 0.02678 (15%) | DB: 0.00262 (1%) | 200 OK [http://devel.stuartmathews.com/repositories/show/test]
873

    
874

    
875
Processing RepositoriesController#stats (for 78.86.23.141 at 2009-10-25 12:15:13) [GET]
876
  Session ID: ebbf9b6d1966d73faa37b351db04f99c
877
  Parameters: {"action"=>"stats", "id"=>"test", "controller"=>"repositories"}
878
  SQL (0.000072)   SELECT max(`settings`.updated_on) AS max_updated_on FROM `settings` 
879
  User Load (0.000066)   SELECT * FROM `users` WHERE (`users`.`id` = 1) AND (users.status = 1) 
880
  Project Load (0.000060)   SELECT * FROM `projects` WHERE (`projects`.`identifier` = 'test') LIMIT 1
881
  Repository Load (0.000051)   SELECT * FROM `repositories` WHERE (`repositories`.project_id = 2) LIMIT 1
882
  EnabledModule Load (0.000066)   SELECT * FROM `enabled_modules` WHERE (`enabled_modules`.project_id = 2) 
883
Rendering template within layouts/base
884
Rendering repositories/stats
885
  SQL (0.000101)   SELECT count(DISTINCT `members`.id) AS count_all FROM `members` LEFT OUTER JOIN `projects` ON `projects`.id = `members`.project_id LEFT OUTER JOIN `roles` ON `roles`.id = `members`.role_id WHERE (`members`.user_id = 1 AND (projects.status=1)) 
886
  SQL (0.000057)   SELECT count(*) AS count_all FROM `versions` WHERE (`versions`.project_id = 2) 
887
  Wiki Load (0.000052)   SELECT * FROM `wikis` WHERE (`wikis`.project_id = 2) LIMIT 1
888
  SQL (0.000048)   SELECT count(*) AS count_all FROM `boards` WHERE (`boards`.project_id = 2) 
889
Completed in 0.08207 (12 reqs/sec) | Rendering: 0.07492 (91%) | DB: 0.00057 (0%) | 200 OK [http://devel.stuartmathews.com/repositories/stats/test]
890

    
891

    
892
Processing RepositoriesController#graph (for 78.86.23.141 at 2009-10-25 12:15:13) [GET]
893
  Session ID: ebbf9b6d1966d73faa37b351db04f99c
894
  Parameters: {"graph"=>"commits_per_month", "action"=>"graph", "id"=>"test", "controller"=>"repositories"}
895
  SQL (0.000117)   SELECT max(`settings`.updated_on) AS max_updated_on FROM `settings` 
896
  User Load (0.000086)   SELECT * FROM `users` WHERE (`users`.`id` = 1) AND (users.status = 1) 
897
  Project Load (0.000102)   SELECT * FROM `projects` WHERE (`projects`.`identifier` = 'test') LIMIT 1
898
  Repository Load (0.000057)   SELECT * FROM `repositories` WHERE (`repositories`.project_id = 2) LIMIT 1
899
  EnabledModule Load (0.000060)   SELECT * FROM `enabled_modules` WHERE (`enabled_modules`.project_id = 2) 
900
  SQL (0.000345)   SELECT count(*) AS count_all, commit_date AS commit_date FROM `changesets` WHERE (`changesets`.repository_id = 2 AND (commit_date BETWEEN '2008-11-01' AND '2009-10-25')) GROUP BY commit_date 
901
  SQL (0.000280)   SELECT count(*) AS count_all, commit_date AS commit_date FROM `changes` INNER JOIN changesets ON changes.changeset_id = changesets.id WHERE (commit_date BETWEEN '2008-11-01' AND '2009-10-25') AND ((`changesets`.repository_id = 2)) GROUP BY commit_date 
902
Sending data 
903
Completed in 0.04224 (23 reqs/sec) | Rendering: 0.00030 (0%) | DB: 0.00105 (2%) | 200 OK [http://devel.stuartmathews.com/repositories/graph/test?graph=commits_per_month]
904

    
905

    
906
Processing RepositoriesController#graph (for 78.86.23.141 at 2009-10-25 12:15:13) [GET]
907
  Session ID: ebbf9b6d1966d73faa37b351db04f99c
908
  Parameters: {"graph"=>"commits_per_author", "action"=>"graph", "id"=>"test", "controller"=>"repositories"}
909
  SQL (0.000101)   SELECT max(`settings`.updated_on) AS max_updated_on FROM `settings` 
910
  User Load (0.000072)   SELECT * FROM `users` WHERE (`users`.`id` = 1) AND (users.status = 1) 
911
  Project Load (0.000062)   SELECT * FROM `projects` WHERE (`projects`.`identifier` = 'test') LIMIT 1
912
  Repository Load (0.000051)   SELECT * FROM `repositories` WHERE (`repositories`.project_id = 2) LIMIT 1
913
  EnabledModule Load (0.000061)   SELECT * FROM `enabled_modules` WHERE (`enabled_modules`.project_id = 2) 
914
  SQL (0.000317)   SELECT count(*) AS count_all, committer AS committer FROM `changesets` WHERE (`changesets`.repository_id = 2) GROUP BY committer 
915
  SQL (0.000291)   SELECT count(*) AS count_all, committer AS committer FROM `changes` INNER JOIN changesets ON changes.changeset_id = changesets.id WHERE ((`changesets`.repository_id = 2)) GROUP BY committer 
916
Sending data 
917
Completed in 0.12219 (8 reqs/sec) | Rendering: 0.00030 (0%) | DB: 0.00096 (0%) | 200 OK [http://devel.stuartmathews.com/repositories/graph/test?graph=commits_per_author]
918

    
919

    
920
Processing ProjectsController#list_files (for 78.86.23.141 at 2009-10-25 12:15:23) [GET]
921
  Session ID: ebbf9b6d1966d73faa37b351db04f99c
922
  Parameters: {"action"=>"list_files", "id"=>"test", "controller"=>"projects"}
923
  SQL (0.000064)   SELECT max(`settings`.updated_on) AS max_updated_on FROM `settings` 
924
  User Load (0.000213)   SELECT * FROM `users` WHERE (`users`.`id` = 1) AND (users.status = 1) 
925
  Project Load (0.000046)   SELECT * FROM `projects` WHERE (`projects`.`identifier` = 'test') LIMIT 1
926
  EnabledModule Load (0.000042)   SELECT * FROM `enabled_modules` WHERE (`enabled_modules`.project_id = 2) 
927
  Attachment Columns (0.000696)   SHOW FIELDS FROM `attachments`
928
  Project Load Including Associations (0.000071)   SELECT `projects`.`id` AS t0_r0, `projects`.`name` AS t0_r1, `projects`.`description` AS t0_r2, `projects`.`homepage` AS t0_r3, `projects`.`is_public` AS t0_r4, `projects`.`parent_id` AS t0_r5, `projects`.`projects_count` AS t0_r6, `projects`.`created_on` AS t0_r7, `projects`.`updated_on` AS t0_r8, `projects`.`identifier` AS t0_r9, `projects`.`status` AS t0_r10, `attachments`.`id` AS t1_r0, `attachments`.`container_id` AS t1_r1, `attachments`.`container_type` AS t1_r2, `attachments`.`filename` AS t1_r3, `attachments`.`disk_filename` AS t1_r4, `attachments`.`filesize` AS t1_r5, `attachments`.`content_type` AS t1_r6, `attachments`.`digest` AS t1_r7, `attachments`.`downloads` AS t1_r8, `attachments`.`author_id` AS t1_r9, `attachments`.`created_on` AS t1_r10, `attachments`.`description` AS t1_r11 FROM `projects` LEFT OUTER JOIN `attachments` ON `attachments`.container_id = `projects`.id AND `attachments`.container_type = 'Project' WHERE (`projects`.`id` = 2) ORDER BY attachments.filename asc
929
  Version Load Including Associations (0.000064)   SELECT `versions`.`id` AS t0_r0, `versions`.`project_id` AS t0_r1, `versions`.`name` AS t0_r2, `versions`.`description` AS t0_r3, `versions`.`effective_date` AS t0_r4, `versions`.`created_on` AS t0_r5, `versions`.`updated_on` AS t0_r6, `versions`.`wiki_page_title` AS t0_r7, `attachments`.`id` AS t1_r0, `attachments`.`container_id` AS t1_r1, `attachments`.`container_type` AS t1_r2, `attachments`.`filename` AS t1_r3, `attachments`.`disk_filename` AS t1_r4, `attachments`.`filesize` AS t1_r5, `attachments`.`content_type` AS t1_r6, `attachments`.`digest` AS t1_r7, `attachments`.`downloads` AS t1_r8, `attachments`.`author_id` AS t1_r9, `attachments`.`created_on` AS t1_r10, `attachments`.`description` AS t1_r11 FROM `versions` LEFT OUTER JOIN `attachments` ON `attachments`.container_id = `versions`.id AND `attachments`.container_type = 'Version' WHERE (`versions`.project_id = 2) ORDER BY attachments.filename asc, versions.effective_date DESC, versions.name DESC
930
Rendering template within layouts/base
931
Rendering projects/list_files
932
  SQL (0.000087)   SELECT count(DISTINCT `members`.id) AS count_all FROM `members` LEFT OUTER JOIN `projects` ON `projects`.id = `members`.project_id LEFT OUTER JOIN `roles` ON `roles`.id = `members`.role_id WHERE (`members`.user_id = 1 AND (projects.status=1)) 
933
  SQL (0.000038)   SELECT count(*) AS count_all FROM `versions` WHERE (`versions`.project_id = 2) 
934
  Wiki Load (0.000050)   SELECT * FROM `wikis` WHERE (`wikis`.project_id = 2) LIMIT 1
935
  SQL (0.000034)   SELECT count(*) AS count_all FROM `boards` WHERE (`boards`.project_id = 2) 
936
  Repository Load (0.000171)   SELECT * FROM `repositories` WHERE (`repositories`.project_id = 2) LIMIT 1
937
Completed in 0.05225 (19 reqs/sec) | Rendering: 0.04226 (80%) | DB: 0.00158 (3%) | 200 OK [http://devel.stuartmathews.com/projects/list_files/test]
938

    
939

    
940
Processing RepositoriesController#show (for 78.86.23.141 at 2009-10-25 12:15:24) [GET]
941
  Session ID: ebbf9b6d1966d73faa37b351db04f99c
942
  Parameters: {"action"=>"show", "id"=>"test", "controller"=>"repositories"}
943
  SQL (0.000106)   SELECT max(`settings`.updated_on) AS max_updated_on FROM `settings` 
944
  User Load (0.000067)   SELECT * FROM `users` WHERE (`users`.`id` = 1) AND (users.status = 1) 
945
  Project Load (0.000054)   SELECT * FROM `projects` WHERE (`projects`.`identifier` = 'test') LIMIT 1
946
  Repository Load (0.000047)   SELECT * FROM `repositories` WHERE (`repositories`.project_id = 2) LIMIT 1
947
  EnabledModule Load (0.000124)   SELECT * FROM `enabled_modules` WHERE (`enabled_modules`.project_id = 2) 
948
Shelling out: svn info --xml 'svn+ssh://stuart@devel.stuartmathews.com/var/repos/compliancestream/'
949
Shelling out: svn list --xml 'svn+ssh://stuart@devel.stuartmathews.com/var/repos/compliancestream/'@HEAD
950
Error parsing svn output: #<REXML::ParseException: No close tag for /lists/list>
951
/usr/lib/ruby/1.8/rexml/parsers/treeparser.rb:28:in `parse'
952
/usr/lib/ruby/1.8/rexml/document.rb:228:in `build'
953
/usr/lib/ruby/1.8/rexml/document.rb:43:in `initialize'
954
/opt/redmine/lib/redmine/scm/adapters/subversion_adapter.rb:85:in `new'
955
/opt/redmine/lib/redmine/scm/adapters/subversion_adapter.rb:85:in `entries'
956
/opt/redmine/lib/redmine/scm/adapters/abstract_adapter.rb:177:in `call'
957
/opt/redmine/lib/redmine/scm/adapters/abstract_adapter.rb:177:in `shellout'
958
/opt/redmine/lib/redmine/scm/adapters/abstract_adapter.rb:175:in `popen'
959
/opt/redmine/lib/redmine/scm/adapters/abstract_adapter.rb:175:in `shellout'
960
/opt/redmine/lib/redmine/scm/adapters/abstract_adapter.rb:165:in `shellout'
961
/opt/redmine/lib/redmine/scm/adapters/subversion_adapter.rb:82:in `entries'
962
/opt/redmine/app/models/repository.rb:63:in `entries'
963
/opt/redmine/vendor/rails/activerecord/lib/active_record/associations/association_proxy.rb:173:in `send'
964
/opt/redmine/vendor/rails/activerecord/lib/active_record/associations/association_proxy.rb:173:in `method_missing'
965
/opt/redmine/app/controllers/repositories_controller.rb:71:in `show'
966
/opt/redmine/vendor/rails/actionpack/lib/action_controller/base.rb:1166:in `send'
967
/opt/redmine/vendor/rails/actionpack/lib/action_controller/base.rb:1166:in `perform_action_without_filters'
968
/opt/redmine/vendor/rails/actionpack/lib/action_controller/filters.rb:579:in `call_filters'
969
/opt/redmine/vendor/rails/actionpack/lib/action_controller/filters.rb:572:in `perform_action_without_benchmark'
970
/opt/redmine/vendor/rails/actionpack/lib/action_controller/benchmarking.rb:68:in `perform_action_without_rescue'
971
/usr/lib/ruby/1.8/benchmark.rb:293:in `measure'
972
/opt/redmine/vendor/rails/actionpack/lib/action_controller/benchmarking.rb:68:in `perform_action_without_rescue'
973
/opt/redmine/vendor/rails/actionpack/lib/action_controller/rescue.rb:201:in `perform_action_without_caching'
974
/opt/redmine/vendor/rails/actionpack/lib/action_controller/caching/sql_cache.rb:13:in `passenger_orig_perform_action'
975
/opt/redmine/vendor/rails/activerecord/lib/active_record/connection_adapters/abstract/query_cache.rb:33:in `cache'
976
/opt/redmine/vendor/rails/activerecord/lib/active_record/query_cache.rb:8:in `cache'
977
/opt/redmine/vendor/rails/actionpack/lib/action_controller/caching/sql_cache.rb:12:in `passenger_orig_perform_action'
978
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/railz/request_handler.rb:65:in `perform_action'
979
/opt/redmine/vendor/rails/actionpack/lib/action_controller/base.rb:529:in `send'
980
/opt/redmine/vendor/rails/actionpack/lib/action_controller/base.rb:529:in `process_without_filters'
981
/opt/redmine/vendor/rails/actionpack/lib/action_controller/filters.rb:568:in `process_without_session_management_support'
982
/opt/redmine/vendor/rails/actionpack/lib/action_controller/session_management.rb:130:in `process'
983
/opt/redmine/vendor/rails/actionpack/lib/action_controller/base.rb:389:in `process'
984
/opt/redmine/vendor/rails/actionpack/lib/action_controller/dispatcher.rb:149:in `handle_request'
985
/opt/redmine/vendor/rails/actionpack/lib/action_controller/dispatcher.rb:107:in `dispatch'
986
/opt/redmine/vendor/rails/actionpack/lib/action_controller/dispatcher.rb:104:in `synchronize'
987
/opt/redmine/vendor/rails/actionpack/lib/action_controller/dispatcher.rb:104:in `dispatch'
988
/opt/redmine/vendor/rails/actionpack/lib/action_controller/dispatcher.rb:120:in `dispatch_cgi'
989
/opt/redmine/vendor/rails/actionpack/lib/action_controller/dispatcher.rb:35:in `dispatch'
990
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/railz/request_handler.rb:50:in `process_request'
991
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_request_handler.rb:207:in `main_loop'
992
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/railz/application_spawner.rb:378:in `start_request_handler'
993
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/railz/application_spawner.rb:336:in `handle_spawn_application'
994
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/utils.rb:183:in `safe_fork'
995
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/railz/application_spawner.rb:334:in `handle_spawn_application'
996
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:352:in `__send__'
997
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:352:in `main_loop'
998
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:196:in `start_synchronously'
999
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:163:in `start'
1000
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/railz/application_spawner.rb:213:in `start'
1001
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/spawn_manager.rb:262:in `spawn_rails_application'
1002
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server_collection.rb:126:in `lookup_or_add'
1003
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/spawn_manager.rb:256:in `spawn_rails_application'
1004
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server_collection.rb:80:in `synchronize'
1005
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server_collection.rb:79:in `synchronize'
1006
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/spawn_manager.rb:255:in `spawn_rails_application'
1007
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/spawn_manager.rb:154:in `spawn_application'
1008
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/spawn_manager.rb:287:in `handle_spawn_application'
1009
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:352:in `__send__'
1010
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:352:in `main_loop'
1011
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:196:in `start_synchronously'
1012
/var/lib/gems/1.8/gems/passenger-2.2.5/bin/passenger-spawn-server:61
1013
...
1014
No close tag for /lists/list
1015
Line: 
1016
Position: 
1017
Last 80 unconsumed characters:
1018
Output was:
1019
 <?xml version="1.0"?>
1020
<lists>
1021
<list
1022
   path="svn+ssh://stuart@devel.stuartmathews.com/var/repos/compliancestream">
1023
  Changeset Load (0.000110)   SELECT * FROM `changesets` WHERE (`changesets`.repository_id = 2) ORDER BY committed_on DESC, changesets.committed_on DESC, changesets.id DESC LIMIT 10
1024
Rendering template within layouts/base
1025
Rendering repositories/show
1026
  UserPreference Load (0.000067)   SELECT * FROM `user_preferences` WHERE (`user_preferences`.user_id = 1) LIMIT 1
1027
  User Load (0.000049)   SELECT * FROM `users` WHERE (`users`.`id` = 3) 
1028
  CACHE (0.000000)   SELECT * FROM `users` WHERE (`users`.`id` = 3) 
1029
  CACHE (0.000000)   SELECT * FROM `users` WHERE (`users`.`id` = 3) 
1030
  CACHE (0.000000)   SELECT * FROM `users` WHERE (`users`.`id` = 3) 
1031
Rendered repositories/_revisions (0.00877)
1032
  Token Load (0.000067)   SELECT * FROM `tokens` WHERE (`tokens`.user_id = 1 AND (action='feeds')) LIMIT 1
1033
  SQL (0.000068)   SELECT count(DISTINCT `members`.id) AS count_all FROM `members` LEFT OUTER JOIN `projects` ON `projects`.id = `members`.project_id LEFT OUTER JOIN `roles` ON `roles`.id = `members`.role_id WHERE (`members`.user_id = 1 AND (projects.status=1)) 
1034
  SQL (0.000040)   SELECT count(*) AS count_all FROM `versions` WHERE (`versions`.project_id = 2) 
1035
  Wiki Load (0.000084)   SELECT * FROM `wikis` WHERE (`wikis`.project_id = 2) LIMIT 1
1036
  SQL (0.000051)   SELECT count(*) AS count_all FROM `boards` WHERE (`boards`.project_id = 2) 
1037
Completed in 0.17007 (5 reqs/sec) | Rendering: 0.02731 (16%) | DB: 0.00094 (0%) | 200 OK [http://devel.stuartmathews.com/repositories/show/test]
1038

    
1039

    
1040
Processing RepositoriesController#revision (for 78.86.23.141 at 2009-10-25 12:15:28) [GET]
1041
  Session ID: ebbf9b6d1966d73faa37b351db04f99c
1042
  Parameters: {"rev"=>"1", "action"=>"revision", "id"=>"test", "controller"=>"repositories"}
1043
  SQL (0.000071)   SELECT max(`settings`.updated_on) AS max_updated_on FROM `settings` 
1044
  User Load (0.000062)   SELECT * FROM `users` WHERE (`users`.`id` = 1) AND (users.status = 1) 
1045
  Project Load (0.000045)   SELECT * FROM `projects` WHERE (`projects`.`identifier` = 'test') LIMIT 1
1046
  Repository Load (0.000052)   SELECT * FROM `repositories` WHERE (`repositories`.project_id = 2) LIMIT 1
1047
  EnabledModule Load (0.000678)   SELECT * FROM `enabled_modules` WHERE (`enabled_modules`.project_id = 2) 
1048
  Changeset Load (0.000051)   SELECT * FROM `changesets` WHERE (`changesets`.`revision` = '1') AND (`changesets`.repository_id = 2) ORDER BY changesets.committed_on DESC, changesets.id DESC LIMIT 1
1049
Rendering template within layouts/base
1050
Rendering repositories/revision
1051
  Changeset Load (0.000855)   SELECT * FROM `changesets` WHERE (id < 5 AND repository_id = 2) ORDER BY id DESC LIMIT 1
1052
  Changeset Load (0.000044)   SELECT * FROM `changesets` WHERE (id > 5 AND repository_id = 2) ORDER BY id ASC LIMIT 1
1053
  User Load (0.000058)   SELECT * FROM `users` WHERE (`users`.`id` = 3) 
1054
  UserPreference Load (0.000284)   SELECT * FROM `user_preferences` WHERE (`user_preferences`.user_id = 1) LIMIT 1
1055
  Join Table Columns (0.000464)   SHOW FIELDS FROM `changesets_issues`
1056
  Issue Load (0.000064)   SELECT * FROM `issues` INNER JOIN `changesets_issues` ON `issues`.id = `changesets_issues`.issue_id WHERE (`changesets_issues`.changeset_id = 5 ) 
1057
  SQL (0.000036)   SELECT count(*) AS count_all FROM `changes` WHERE (`changes`.changeset_id = 5) 
1058
  Change Load (0.000112)   SELECT * FROM `changes` WHERE (`changes`.changeset_id = 5) ORDER BY path LIMIT 1000
1059
  SQL (0.000097)   SELECT count(DISTINCT `members`.id) AS count_all FROM `members` LEFT OUTER JOIN `projects` ON `projects`.id = `members`.project_id LEFT OUTER JOIN `roles` ON `roles`.id = `members`.role_id WHERE (`members`.user_id = 1 AND (projects.status=1)) 
1060
  SQL (0.000049)   SELECT count(*) AS count_all FROM `versions` WHERE (`versions`.project_id = 2) 
1061
  Wiki Load (0.000052)   SELECT * FROM `wikis` WHERE (`wikis`.project_id = 2) LIMIT 1
1062
  SQL (0.000046)   SELECT count(*) AS count_all FROM `boards` WHERE (`boards`.project_id = 2) 
1063
Completed in 0.07876 (12 reqs/sec) | Rendering: 0.06829 (86%) | DB: 0.00312 (3%) | 200 OK [http://devel.stuartmathews.com/repositories/revision/test/1]
1064

    
1065

    
1066
Processing RepositoriesController#entry (for 78.86.23.141 at 2009-10-25 12:15:30) [GET]
1067
  Session ID: ebbf9b6d1966d73faa37b351db04f99c
1068
  Parameters: {"rev"=>"1", "action"=>"entry", "id"=>"test", "path"=>["ComplianceStream", "ComplianceStream.xcodeproj", "default.pbxuser"], "controller"=>"repositories"}
1069
  SQL (0.000105)   SELECT max(`settings`.updated_on) AS max_updated_on FROM `settings` 
1070
  User Load (0.000071)   SELECT * FROM `users` WHERE (`users`.`id` = 1) AND (users.status = 1) 
1071
  Project Load (0.000072)   SELECT * FROM `projects` WHERE (`projects`.`identifier` = 'test') LIMIT 1
1072
  Repository Load (0.000054)   SELECT * FROM `repositories` WHERE (`repositories`.project_id = 2) LIMIT 1
1073
  EnabledModule Load (0.000467)   SELECT * FROM `enabled_modules` WHERE (`enabled_modules`.project_id = 2) 
1074
Shelling out: svn list --xml 'svn+ssh://stuart@devel.stuartmathews.com/var/repos/compliancestream/ComplianceStream/ComplianceStream.xcodeproj'@1
1075
Error parsing svn output: #<REXML::ParseException: No close tag for /lists/list>
1076
/usr/lib/ruby/1.8/rexml/parsers/treeparser.rb:28:in `parse'
1077
/usr/lib/ruby/1.8/rexml/document.rb:228:in `build'
1078
/usr/lib/ruby/1.8/rexml/document.rb:43:in `initialize'
1079
/opt/redmine/lib/redmine/scm/adapters/subversion_adapter.rb:85:in `new'
1080
/opt/redmine/lib/redmine/scm/adapters/subversion_adapter.rb:85:in `entries'
1081
/opt/redmine/lib/redmine/scm/adapters/abstract_adapter.rb:177:in `call'
1082
/opt/redmine/lib/redmine/scm/adapters/abstract_adapter.rb:177:in `shellout'
1083
/opt/redmine/lib/redmine/scm/adapters/abstract_adapter.rb:175:in `popen'
1084
/opt/redmine/lib/redmine/scm/adapters/abstract_adapter.rb:175:in `shellout'
1085
/opt/redmine/lib/redmine/scm/adapters/abstract_adapter.rb:165:in `shellout'
1086
/opt/redmine/lib/redmine/scm/adapters/subversion_adapter.rb:82:in `entries'
1087
/opt/redmine/lib/redmine/scm/adapters/abstract_adapter.rb:93:in `entry'
1088
/opt/redmine/app/models/repository.rb:59:in `entry'
1089
/opt/redmine/vendor/rails/activerecord/lib/active_record/associations/association_proxy.rb:173:in `send'
1090
/opt/redmine/vendor/rails/activerecord/lib/active_record/associations/association_proxy.rb:173:in `method_missing'
1091
/opt/redmine/app/controllers/repositories_controller.rb:112:in `entry'
1092
/opt/redmine/vendor/rails/actionpack/lib/action_controller/base.rb:1166:in `send'
1093
/opt/redmine/vendor/rails/actionpack/lib/action_controller/base.rb:1166:in `perform_action_without_filters'
1094
/opt/redmine/vendor/rails/actionpack/lib/action_controller/filters.rb:579:in `call_filters'
1095
/opt/redmine/vendor/rails/actionpack/lib/action_controller/filters.rb:572:in `perform_action_without_benchmark'
1096
/opt/redmine/vendor/rails/actionpack/lib/action_controller/benchmarking.rb:68:in `perform_action_without_rescue'
1097
/usr/lib/ruby/1.8/benchmark.rb:293:in `measure'
1098
/opt/redmine/vendor/rails/actionpack/lib/action_controller/benchmarking.rb:68:in `perform_action_without_rescue'
1099
/opt/redmine/vendor/rails/actionpack/lib/action_controller/rescue.rb:201:in `perform_action_without_caching'
1100
/opt/redmine/vendor/rails/actionpack/lib/action_controller/caching/sql_cache.rb:13:in `passenger_orig_perform_action'
1101
/opt/redmine/vendor/rails/activerecord/lib/active_record/connection_adapters/abstract/query_cache.rb:33:in `cache'
1102
/opt/redmine/vendor/rails/activerecord/lib/active_record/query_cache.rb:8:in `cache'
1103
/opt/redmine/vendor/rails/actionpack/lib/action_controller/caching/sql_cache.rb:12:in `passenger_orig_perform_action'
1104
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/railz/request_handler.rb:65:in `perform_action'
1105
/opt/redmine/vendor/rails/actionpack/lib/action_controller/base.rb:529:in `send'
1106
/opt/redmine/vendor/rails/actionpack/lib/action_controller/base.rb:529:in `process_without_filters'
1107
/opt/redmine/vendor/rails/actionpack/lib/action_controller/filters.rb:568:in `process_without_session_management_support'
1108
/opt/redmine/vendor/rails/actionpack/lib/action_controller/session_management.rb:130:in `process'
1109
/opt/redmine/vendor/rails/actionpack/lib/action_controller/base.rb:389:in `process'
1110
/opt/redmine/vendor/rails/actionpack/lib/action_controller/dispatcher.rb:149:in `handle_request'
1111
/opt/redmine/vendor/rails/actionpack/lib/action_controller/dispatcher.rb:107:in `dispatch'
1112
/opt/redmine/vendor/rails/actionpack/lib/action_controller/dispatcher.rb:104:in `synchronize'
1113
/opt/redmine/vendor/rails/actionpack/lib/action_controller/dispatcher.rb:104:in `dispatch'
1114
/opt/redmine/vendor/rails/actionpack/lib/action_controller/dispatcher.rb:120:in `dispatch_cgi'
1115
/opt/redmine/vendor/rails/actionpack/lib/action_controller/dispatcher.rb:35:in `dispatch'
1116
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/railz/request_handler.rb:50:in `process_request'
1117
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_request_handler.rb:207:in `main_loop'
1118
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/railz/application_spawner.rb:378:in `start_request_handler'
1119
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/railz/application_spawner.rb:336:in `handle_spawn_application'
1120
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/utils.rb:183:in `safe_fork'
1121
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/railz/application_spawner.rb:334:in `handle_spawn_application'
1122
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:352:in `__send__'
1123
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:352:in `main_loop'
1124
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:196:in `start_synchronously'
1125
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:163:in `start'
1126
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/railz/application_spawner.rb:213:in `start'
1127
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/spawn_manager.rb:262:in `spawn_rails_application'
1128
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server_collection.rb:126:in `lookup_or_add'
1129
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/spawn_manager.rb:256:in `spawn_rails_application'
1130
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server_collection.rb:80:in `synchronize'
1131
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server_collection.rb:79:in `synchronize'
1132
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/spawn_manager.rb:255:in `spawn_rails_application'
1133
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/spawn_manager.rb:154:in `spawn_application'
1134
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/spawn_manager.rb:287:in `handle_spawn_application'
1135
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:352:in `__send__'
1136
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:352:in `main_loop'
1137
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:196:in `start_synchronously'
1138
/var/lib/gems/1.8/gems/passenger-2.2.5/bin/passenger-spawn-server:61
1139
...
1140
No close tag for /lists/list
1141
Line: 
1142
Position: 
1143
Last 80 unconsumed characters:
1144
Output was:
1145
 <?xml version="1.0"?>
1146
<lists>
1147
<list
1148
   path="svn+ssh://stuart@devel.stuartmathews.com/var/repos/compliancestream/ComplianceStream/ComplianceStream.xcodeproj">
1149
Rendering template within layouts/base
1150
  SQL (0.000131)   SELECT count(DISTINCT `members`.id) AS count_all FROM `members` LEFT OUTER JOIN `projects` ON `projects`.id = `members`.project_id LEFT OUTER JOIN `roles` ON `roles`.id = `members`.role_id WHERE (`members`.user_id = 1 AND (projects.status=1)) 
1151
  SQL (0.000066)   SELECT count(*) AS count_all FROM `versions` WHERE (`versions`.project_id = 2) 
1152
  Wiki Load (0.000073)   SELECT * FROM `wikis` WHERE (`wikis`.project_id = 2) LIMIT 1
1153
  SQL (0.000062)   SELECT count(*) AS count_all FROM `boards` WHERE (`boards`.project_id = 2) 
1154
Completed in 0.13998 (7 reqs/sec) | Rendering: 0.01367 (9%) | DB: 0.00110 (0%) | 500 Internal Server Error [http://devel.stuartmathews.com/repositories/entry/test/ComplianceStream/ComplianceStream.xcodeproj/default.pbxuser?rev=1]
1155

    
1156

    
1157
Processing RepositoriesController#entry (for 78.86.23.141 at 2009-10-25 12:15:40) [GET]
1158
  Session ID: ebbf9b6d1966d73faa37b351db04f99c
1159
  Parameters: {"rev"=>"1", "action"=>"entry", "id"=>"test", "path"=>["ComplianceStream", "ComplianceStream.xcodeproj", "default.pbxuser"], "controller"=>"repositories"}
1160
  SQL (0.000086)   SELECT max(`settings`.updated_on) AS max_updated_on FROM `settings` 
1161
  User Load (0.000075)   SELECT * FROM `users` WHERE (`users`.`id` = 1) AND (users.status = 1) 
1162
  Project Load (0.000068)   SELECT * FROM `projects` WHERE (`projects`.`identifier` = 'test') LIMIT 1
1163
  Repository Load (0.000055)   SELECT * FROM `repositories` WHERE (`repositories`.project_id = 2) LIMIT 1
1164
  EnabledModule Load (0.000070)   SELECT * FROM `enabled_modules` WHERE (`enabled_modules`.project_id = 2) 
1165
Shelling out: svn list --xml 'svn+ssh://stuart@devel.stuartmathews.com/var/repos/compliancestream/ComplianceStream/ComplianceStream.xcodeproj'@1
1166
Error parsing svn output: #<REXML::ParseException: No close tag for /lists/list>
1167
/usr/lib/ruby/1.8/rexml/parsers/treeparser.rb:28:in `parse'
1168
/usr/lib/ruby/1.8/rexml/document.rb:228:in `build'
1169
/usr/lib/ruby/1.8/rexml/document.rb:43:in `initialize'
1170
/opt/redmine/lib/redmine/scm/adapters/subversion_adapter.rb:85:in `new'
1171
/opt/redmine/lib/redmine/scm/adapters/subversion_adapter.rb:85:in `entries'
1172
/opt/redmine/lib/redmine/scm/adapters/abstract_adapter.rb:177:in `call'
1173
/opt/redmine/lib/redmine/scm/adapters/abstract_adapter.rb:177:in `shellout'
1174
/opt/redmine/lib/redmine/scm/adapters/abstract_adapter.rb:175:in `popen'
1175
/opt/redmine/lib/redmine/scm/adapters/abstract_adapter.rb:175:in `shellout'
1176
/opt/redmine/lib/redmine/scm/adapters/abstract_adapter.rb:165:in `shellout'
1177
/opt/redmine/lib/redmine/scm/adapters/subversion_adapter.rb:82:in `entries'
1178
/opt/redmine/lib/redmine/scm/adapters/abstract_adapter.rb:93:in `entry'
1179
/opt/redmine/app/models/repository.rb:59:in `entry'
1180
/opt/redmine/vendor/rails/activerecord/lib/active_record/associations/association_proxy.rb:173:in `send'
1181
/opt/redmine/vendor/rails/activerecord/lib/active_record/associations/association_proxy.rb:173:in `method_missing'
1182
/opt/redmine/app/controllers/repositories_controller.rb:112:in `entry'
1183
/opt/redmine/vendor/rails/actionpack/lib/action_controller/base.rb:1166:in `send'
1184
/opt/redmine/vendor/rails/actionpack/lib/action_controller/base.rb:1166:in `perform_action_without_filters'
1185
/opt/redmine/vendor/rails/actionpack/lib/action_controller/filters.rb:579:in `call_filters'
1186
/opt/redmine/vendor/rails/actionpack/lib/action_controller/filters.rb:572:in `perform_action_without_benchmark'
1187
/opt/redmine/vendor/rails/actionpack/lib/action_controller/benchmarking.rb:68:in `perform_action_without_rescue'
1188
/usr/lib/ruby/1.8/benchmark.rb:293:in `measure'
1189
/opt/redmine/vendor/rails/actionpack/lib/action_controller/benchmarking.rb:68:in `perform_action_without_rescue'
1190
/opt/redmine/vendor/rails/actionpack/lib/action_controller/rescue.rb:201:in `perform_action_without_caching'
1191
/opt/redmine/vendor/rails/actionpack/lib/action_controller/caching/sql_cache.rb:13:in `passenger_orig_perform_action'
1192
/opt/redmine/vendor/rails/activerecord/lib/active_record/connection_adapters/abstract/query_cache.rb:33:in `cache'
1193
/opt/redmine/vendor/rails/activerecord/lib/active_record/query_cache.rb:8:in `cache'
1194
/opt/redmine/vendor/rails/actionpack/lib/action_controller/caching/sql_cache.rb:12:in `passenger_orig_perform_action'
1195
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/railz/request_handler.rb:65:in `perform_action'
1196
/opt/redmine/vendor/rails/actionpack/lib/action_controller/base.rb:529:in `send'
1197
/opt/redmine/vendor/rails/actionpack/lib/action_controller/base.rb:529:in `process_without_filters'
1198
/opt/redmine/vendor/rails/actionpack/lib/action_controller/filters.rb:568:in `process_without_session_management_support'
1199
/opt/redmine/vendor/rails/actionpack/lib/action_controller/session_management.rb:130:in `process'
1200
/opt/redmine/vendor/rails/actionpack/lib/action_controller/base.rb:389:in `process'
1201
/opt/redmine/vendor/rails/actionpack/lib/action_controller/dispatcher.rb:149:in `handle_request'
1202
/opt/redmine/vendor/rails/actionpack/lib/action_controller/dispatcher.rb:107:in `dispatch'
1203
/opt/redmine/vendor/rails/actionpack/lib/action_controller/dispatcher.rb:104:in `synchronize'
1204
/opt/redmine/vendor/rails/actionpack/lib/action_controller/dispatcher.rb:104:in `dispatch'
1205
/opt/redmine/vendor/rails/actionpack/lib/action_controller/dispatcher.rb:120:in `dispatch_cgi'
1206
/opt/redmine/vendor/rails/actionpack/lib/action_controller/dispatcher.rb:35:in `dispatch'
1207
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/railz/request_handler.rb:50:in `process_request'
1208
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_request_handler.rb:207:in `main_loop'
1209
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/railz/application_spawner.rb:378:in `start_request_handler'
1210
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/railz/application_spawner.rb:336:in `handle_spawn_application'
1211
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/utils.rb:183:in `safe_fork'
1212
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/railz/application_spawner.rb:334:in `handle_spawn_application'
1213
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:352:in `__send__'
1214
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:352:in `main_loop'
1215
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:196:in `start_synchronously'
1216
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:163:in `start'
1217
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/railz/application_spawner.rb:213:in `start'
1218
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/spawn_manager.rb:262:in `spawn_rails_application'
1219
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server_collection.rb:126:in `lookup_or_add'
1220
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/spawn_manager.rb:256:in `spawn_rails_application'
1221
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server_collection.rb:80:in `synchronize'
1222
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server_collection.rb:79:in `synchronize'
1223
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/spawn_manager.rb:255:in `spawn_rails_application'
1224
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/spawn_manager.rb:154:in `spawn_application'
1225
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/spawn_manager.rb:287:in `handle_spawn_application'
1226
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:352:in `__send__'
1227
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:352:in `main_loop'
1228
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:196:in `start_synchronously'
1229
/var/lib/gems/1.8/gems/passenger-2.2.5/bin/passenger-spawn-server:61
1230
...
1231
No close tag for /lists/list
1232
Line: 
1233
Position: 
1234
Last 80 unconsumed characters:
1235
Output was:
1236
 <?xml version="1.0"?>
1237
<lists>
1238
<list
1239
   path="svn+ssh://stuart@devel.stuartmathews.com/var/repos/compliancestream/ComplianceStream/ComplianceStream.xcodeproj">
1240
Rendering template within layouts/base
1241
  SQL (0.000112)   SELECT count(DISTINCT `members`.id) AS count_all FROM `members` LEFT OUTER JOIN `projects` ON `projects`.id = `members`.project_id LEFT OUTER JOIN `roles` ON `roles`.id = `members`.role_id WHERE (`members`.user_id = 1 AND (projects.status=1)) 
1242
  SQL (0.000054)   SELECT count(*) AS count_all FROM `versions` WHERE (`versions`.project_id = 2) 
1243
  Wiki Load (0.000052)   SELECT * FROM `wikis` WHERE (`wikis`.project_id = 2) LIMIT 1
1244
  SQL (0.000045)   SELECT count(*) AS count_all FROM `boards` WHERE (`boards`.project_id = 2) 
1245
Completed in 0.09792 (10 reqs/sec) | Rendering: 0.01361 (13%) | DB: 0.00062 (0%) | 500 Internal Server Error [http://devel.stuartmathews.com/repositories/entry/test/ComplianceStream/ComplianceStream.xcodeproj/default.pbxuser?rev=1]
1246

    
1247

    
1248
Processing RepositoriesController#entry (for 78.86.23.141 at 2009-10-25 12:16:09) [GET]
1249
  Session ID: ebbf9b6d1966d73faa37b351db04f99c
1250
  Parameters: {"rev"=>"1", "action"=>"entry", "id"=>"test", "path"=>["ComplianceStream", "ComplianceStream.xcodeproj", "default.pbxuser"], "controller"=>"repositories"}
1251
  SQL (0.000077)   SELECT max(`settings`.updated_on) AS max_updated_on FROM `settings` 
1252
  User Load (0.000070)   SELECT * FROM `users` WHERE (`users`.`id` = 1) AND (users.status = 1) 
1253
  Project Load (0.000055)   SELECT * FROM `projects` WHERE (`projects`.`identifier` = 'test') LIMIT 1
1254
  Repository Load (0.000052)   SELECT * FROM `repositories` WHERE (`repositories`.project_id = 2) LIMIT 1
1255
  EnabledModule Load (0.000058)   SELECT * FROM `enabled_modules` WHERE (`enabled_modules`.project_id = 2) 
1256
Shelling out: svn list --xml 'svn+ssh://stuart@devel.stuartmathews.com/var/repos/compliancestream/ComplianceStream/ComplianceStream.xcodeproj'@1
1257
Error parsing svn output: #<REXML::ParseException: No close tag for /lists/list>
1258
/usr/lib/ruby/1.8/rexml/parsers/treeparser.rb:28:in `parse'
1259
/usr/lib/ruby/1.8/rexml/document.rb:228:in `build'
1260
/usr/lib/ruby/1.8/rexml/document.rb:43:in `initialize'
1261
/opt/redmine/lib/redmine/scm/adapters/subversion_adapter.rb:85:in `new'
1262
/opt/redmine/lib/redmine/scm/adapters/subversion_adapter.rb:85:in `entries'
1263
/opt/redmine/lib/redmine/scm/adapters/abstract_adapter.rb:177:in `call'
1264
/opt/redmine/lib/redmine/scm/adapters/abstract_adapter.rb:177:in `shellout'
1265
/opt/redmine/lib/redmine/scm/adapters/abstract_adapter.rb:175:in `popen'
1266
/opt/redmine/lib/redmine/scm/adapters/abstract_adapter.rb:175:in `shellout'
1267
/opt/redmine/lib/redmine/scm/adapters/abstract_adapter.rb:165:in `shellout'
1268
/opt/redmine/lib/redmine/scm/adapters/subversion_adapter.rb:82:in `entries'
1269
/opt/redmine/lib/redmine/scm/adapters/abstract_adapter.rb:93:in `entry'
1270
/opt/redmine/app/models/repository.rb:59:in `entry'
1271
/opt/redmine/vendor/rails/activerecord/lib/active_record/associations/association_proxy.rb:173:in `send'
1272
/opt/redmine/vendor/rails/activerecord/lib/active_record/associations/association_proxy.rb:173:in `method_missing'
1273
/opt/redmine/app/controllers/repositories_controller.rb:112:in `entry'
1274
/opt/redmine/vendor/rails/actionpack/lib/action_controller/base.rb:1166:in `send'
1275
/opt/redmine/vendor/rails/actionpack/lib/action_controller/base.rb:1166:in `perform_action_without_filters'
1276
/opt/redmine/vendor/rails/actionpack/lib/action_controller/filters.rb:579:in `call_filters'
1277
/opt/redmine/vendor/rails/actionpack/lib/action_controller/filters.rb:572:in `perform_action_without_benchmark'
1278
/opt/redmine/vendor/rails/actionpack/lib/action_controller/benchmarking.rb:68:in `perform_action_without_rescue'
1279
/usr/lib/ruby/1.8/benchmark.rb:293:in `measure'
1280
/opt/redmine/vendor/rails/actionpack/lib/action_controller/benchmarking.rb:68:in `perform_action_without_rescue'
1281
/opt/redmine/vendor/rails/actionpack/lib/action_controller/rescue.rb:201:in `perform_action_without_caching'
1282
/opt/redmine/vendor/rails/actionpack/lib/action_controller/caching/sql_cache.rb:13:in `passenger_orig_perform_action'
1283
/opt/redmine/vendor/rails/activerecord/lib/active_record/connection_adapters/abstract/query_cache.rb:33:in `cache'
1284
/opt/redmine/vendor/rails/activerecord/lib/active_record/query_cache.rb:8:in `cache'
1285
/opt/redmine/vendor/rails/actionpack/lib/action_controller/caching/sql_cache.rb:12:in `passenger_orig_perform_action'
1286
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/railz/request_handler.rb:65:in `perform_action'
1287
/opt/redmine/vendor/rails/actionpack/lib/action_controller/base.rb:529:in `send'
1288
/opt/redmine/vendor/rails/actionpack/lib/action_controller/base.rb:529:in `process_without_filters'
1289
/opt/redmine/vendor/rails/actionpack/lib/action_controller/filters.rb:568:in `process_without_session_management_support'
1290
/opt/redmine/vendor/rails/actionpack/lib/action_controller/session_management.rb:130:in `process'
1291
/opt/redmine/vendor/rails/actionpack/lib/action_controller/base.rb:389:in `process'
1292
/opt/redmine/vendor/rails/actionpack/lib/action_controller/dispatcher.rb:149:in `handle_request'
1293
/opt/redmine/vendor/rails/actionpack/lib/action_controller/dispatcher.rb:107:in `dispatch'
1294
/opt/redmine/vendor/rails/actionpack/lib/action_controller/dispatcher.rb:104:in `synchronize'
1295
/opt/redmine/vendor/rails/actionpack/lib/action_controller/dispatcher.rb:104:in `dispatch'
1296
/opt/redmine/vendor/rails/actionpack/lib/action_controller/dispatcher.rb:120:in `dispatch_cgi'
1297
/opt/redmine/vendor/rails/actionpack/lib/action_controller/dispatcher.rb:35:in `dispatch'
1298
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/railz/request_handler.rb:50:in `process_request'
1299
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_request_handler.rb:207:in `main_loop'
1300
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/railz/application_spawner.rb:378:in `start_request_handler'
1301
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/railz/application_spawner.rb:336:in `handle_spawn_application'
1302
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/utils.rb:183:in `safe_fork'
1303
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/railz/application_spawner.rb:334:in `handle_spawn_application'
1304
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:352:in `__send__'
1305
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:352:in `main_loop'
1306
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:196:in `start_synchronously'
1307
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:163:in `start'
1308
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/railz/application_spawner.rb:213:in `start'
1309
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/spawn_manager.rb:262:in `spawn_rails_application'
1310
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server_collection.rb:126:in `lookup_or_add'
1311
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/spawn_manager.rb:256:in `spawn_rails_application'
1312
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server_collection.rb:80:in `synchronize'
1313
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server_collection.rb:79:in `synchronize'
1314
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/spawn_manager.rb:255:in `spawn_rails_application'
1315
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/spawn_manager.rb:154:in `spawn_application'
1316
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/spawn_manager.rb:287:in `handle_spawn_application'
1317
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:352:in `__send__'
1318
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:352:in `main_loop'
1319
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:196:in `start_synchronously'
1320
/var/lib/gems/1.8/gems/passenger-2.2.5/bin/passenger-spawn-server:61
1321
...
1322
No close tag for /lists/list
1323
Line: 
1324
Position: 
1325
Last 80 unconsumed characters:
1326
Output was:
1327
 <?xml version="1.0"?>
1328
<lists>
1329
<list
1330
   path="svn+ssh://stuart@devel.stuartmathews.com/var/repos/compliancestream/ComplianceStream/ComplianceStream.xcodeproj">
1331
Rendering template within layouts/base
1332
  SQL (0.000120)   SELECT count(DISTINCT `members`.id) AS count_all FROM `members` LEFT OUTER JOIN `projects` ON `projects`.id = `members`.project_id LEFT OUTER JOIN `roles` ON `roles`.id = `members`.role_id WHERE (`members`.user_id = 1 AND (projects.status=1)) 
1333
  SQL (0.000081)   SELECT count(*) AS count_all FROM `versions` WHERE (`versions`.project_id = 2) 
1334
  Wiki Load (0.000139)   SELECT * FROM `wikis` WHERE (`wikis`.project_id = 2) LIMIT 1
1335
  SQL (0.000044)   SELECT count(*) AS count_all FROM `boards` WHERE (`boards`.project_id = 2) 
1336
Completed in 0.09083 (11 reqs/sec) | Rendering: 0.01434 (15%) | DB: 0.00070 (0%) | 500 Internal Server Error [http://devel.stuartmathews.com/repositories/entry/test/ComplianceStream/ComplianceStream.xcodeproj/default.pbxuser?rev=1]
1337

    
1338

    
1339
Processing RepositoriesController#entry (for 78.86.23.141 at 2009-10-25 12:19:54) [GET]
1340
  Session ID: ebbf9b6d1966d73faa37b351db04f99c
1341
  Parameters: {"rev"=>"1", "action"=>"entry", "id"=>"test", "path"=>["ComplianceStream", "src", "AbilityModules", "MSSQLAbilityModule.java"], "controller"=>"repositories"}
1342
  SQL (0.000090)   SELECT max(`settings`.updated_on) AS max_updated_on FROM `settings` 
1343
  User Load (0.000123)   SELECT * FROM `users` WHERE (`users`.`id` = 1) AND (users.status = 1) 
1344
  Project Load (0.000065)   SELECT * FROM `projects` WHERE (`projects`.`identifier` = 'test') LIMIT 1
1345
  Repository Load (0.000052)   SELECT * FROM `repositories` WHERE (`repositories`.project_id = 2) LIMIT 1
1346
  EnabledModule Load (0.000058)   SELECT * FROM `enabled_modules` WHERE (`enabled_modules`.project_id = 2) 
1347
Shelling out: svn list --xml 'svn+ssh://stuart@devel.stuartmathews.com/var/repos/compliancestream/ComplianceStream/src/AbilityModules'@1
1348
Error parsing svn output: #<REXML::ParseException: No close tag for /lists/list>
1349
/usr/lib/ruby/1.8/rexml/parsers/treeparser.rb:28:in `parse'
1350
/usr/lib/ruby/1.8/rexml/document.rb:228:in `build'
1351
/usr/lib/ruby/1.8/rexml/document.rb:43:in `initialize'
1352
/opt/redmine/lib/redmine/scm/adapters/subversion_adapter.rb:85:in `new'
1353
/opt/redmine/lib/redmine/scm/adapters/subversion_adapter.rb:85:in `entries'
1354
/opt/redmine/lib/redmine/scm/adapters/abstract_adapter.rb:177:in `call'
1355
/opt/redmine/lib/redmine/scm/adapters/abstract_adapter.rb:177:in `shellout'
1356
/opt/redmine/lib/redmine/scm/adapters/abstract_adapter.rb:175:in `popen'
1357
/opt/redmine/lib/redmine/scm/adapters/abstract_adapter.rb:175:in `shellout'
1358
/opt/redmine/lib/redmine/scm/adapters/abstract_adapter.rb:165:in `shellout'
1359
/opt/redmine/lib/redmine/scm/adapters/subversion_adapter.rb:82:in `entries'
1360
/opt/redmine/lib/redmine/scm/adapters/abstract_adapter.rb:93:in `entry'
1361
/opt/redmine/app/models/repository.rb:59:in `entry'
1362
/opt/redmine/vendor/rails/activerecord/lib/active_record/associations/association_proxy.rb:173:in `send'
1363
/opt/redmine/vendor/rails/activerecord/lib/active_record/associations/association_proxy.rb:173:in `method_missing'
1364
/opt/redmine/app/controllers/repositories_controller.rb:112:in `entry'
1365
/opt/redmine/vendor/rails/actionpack/lib/action_controller/base.rb:1166:in `send'
1366
/opt/redmine/vendor/rails/actionpack/lib/action_controller/base.rb:1166:in `perform_action_without_filters'
1367
/opt/redmine/vendor/rails/actionpack/lib/action_controller/filters.rb:579:in `call_filters'
1368
/opt/redmine/vendor/rails/actionpack/lib/action_controller/filters.rb:572:in `perform_action_without_benchmark'
1369
/opt/redmine/vendor/rails/actionpack/lib/action_controller/benchmarking.rb:68:in `perform_action_without_rescue'
1370
/usr/lib/ruby/1.8/benchmark.rb:293:in `measure'
1371
/opt/redmine/vendor/rails/actionpack/lib/action_controller/benchmarking.rb:68:in `perform_action_without_rescue'
1372
/opt/redmine/vendor/rails/actionpack/lib/action_controller/rescue.rb:201:in `perform_action_without_caching'
1373
/opt/redmine/vendor/rails/actionpack/lib/action_controller/caching/sql_cache.rb:13:in `passenger_orig_perform_action'
1374
/opt/redmine/vendor/rails/activerecord/lib/active_record/connection_adapters/abstract/query_cache.rb:33:in `cache'
1375
/opt/redmine/vendor/rails/activerecord/lib/active_record/query_cache.rb:8:in `cache'
1376
/opt/redmine/vendor/rails/actionpack/lib/action_controller/caching/sql_cache.rb:12:in `passenger_orig_perform_action'
1377
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/railz/request_handler.rb:65:in `perform_action'
1378
/opt/redmine/vendor/rails/actionpack/lib/action_controller/base.rb:529:in `send'
1379
/opt/redmine/vendor/rails/actionpack/lib/action_controller/base.rb:529:in `process_without_filters'
1380
/opt/redmine/vendor/rails/actionpack/lib/action_controller/filters.rb:568:in `process_without_session_management_support'
1381
/opt/redmine/vendor/rails/actionpack/lib/action_controller/session_management.rb:130:in `process'
1382
/opt/redmine/vendor/rails/actionpack/lib/action_controller/base.rb:389:in `process'
1383
/opt/redmine/vendor/rails/actionpack/lib/action_controller/dispatcher.rb:149:in `handle_request'
1384
/opt/redmine/vendor/rails/actionpack/lib/action_controller/dispatcher.rb:107:in `dispatch'
1385
/opt/redmine/vendor/rails/actionpack/lib/action_controller/dispatcher.rb:104:in `synchronize'
1386
/opt/redmine/vendor/rails/actionpack/lib/action_controller/dispatcher.rb:104:in `dispatch'
1387
/opt/redmine/vendor/rails/actionpack/lib/action_controller/dispatcher.rb:120:in `dispatch_cgi'
1388
/opt/redmine/vendor/rails/actionpack/lib/action_controller/dispatcher.rb:35:in `dispatch'
1389
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/railz/request_handler.rb:50:in `process_request'
1390
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_request_handler.rb:207:in `main_loop'
1391
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/railz/application_spawner.rb:378:in `start_request_handler'
1392
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/railz/application_spawner.rb:336:in `handle_spawn_application'
1393
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/utils.rb:183:in `safe_fork'
1394
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/railz/application_spawner.rb:334:in `handle_spawn_application'
1395
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:352:in `__send__'
1396
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:352:in `main_loop'
1397
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:196:in `start_synchronously'
1398
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:163:in `start'
1399
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/railz/application_spawner.rb:213:in `start'
1400
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/spawn_manager.rb:262:in `spawn_rails_application'
1401
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server_collection.rb:126:in `lookup_or_add'
1402
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/spawn_manager.rb:256:in `spawn_rails_application'
1403
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server_collection.rb:80:in `synchronize'
1404
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server_collection.rb:79:in `synchronize'
1405
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/spawn_manager.rb:255:in `spawn_rails_application'
1406
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/spawn_manager.rb:154:in `spawn_application'
1407
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/spawn_manager.rb:287:in `handle_spawn_application'
1408
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:352:in `__send__'
1409
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:352:in `main_loop'
1410
/var/lib/gems/1.8/gems/passenger-2.2.5/lib/phusion_passenger/abstract_server.rb:196:in `start_synchronously'
1411
/var/lib/gems/1.8/gems/passenger-2.2.5/bin/passenger-spawn-server:61
1412
...
1413
No close tag for /lists/list
1414
Line: 
1415
Position: 
1416
Last 80 unconsumed characters:
1417
Output was:
1418
 <?xml version="1.0"?>
1419
<lists>
1420
<list
1421
   path="svn+ssh://stuart@devel.stuartmathews.com/var/repos/compliancestream/ComplianceStream/src/AbilityModules">
1422
Rendering template within layouts/base
1423
  SQL (0.000139)   SELECT count(DISTINCT `members`.id) AS count_all FROM `members` LEFT OUTER JOIN `projects` ON `projects`.id = `members`.project_id LEFT OUTER JOIN `roles` ON `roles`.id = `members`.role_id WHERE (`members`.user_id = 1 AND (projects.status=1)) 
1424
  SQL (0.000082)   SELECT count(*) AS count_all FROM `versions` WHERE (`versions`.project_id = 2) 
1425
  Wiki Load (0.000057)   SELECT * FROM `wikis` WHERE (`wikis`.project_id = 2) LIMIT 1
1426
  SQL (0.000046)   SELECT count(*) AS count_all FROM `boards` WHERE (`boards`.project_id = 2) 
1427
Completed in 0.09340 (10 reqs/sec) | Rendering: 0.01377 (14%) | DB: 0.00071 (0%) | 500 Internal Server Error [http://devel.stuartmathews.com/repositories/entry/test/ComplianceStream/src/AbilityModules/MSSQLAbilityModule.java?rev=1]
1428
checking plugin 'engines' for 'application_helper'
1429
checking plugin 'actionwebservice' for 'application_helper'
1430
checking plugin 'acts_as_activity_provider' for 'application_helper'
1431
checking plugin 'acts_as_attachable' for 'application_helper'
1432
checking plugin 'acts_as_customizable' for 'application_helper'
1433
checking plugin 'acts_as_event' for 'application_helper'
1434
checking plugin 'acts_as_list' for 'application_helper'
1435
checking plugin 'acts_as_searchable' for 'application_helper'
1436
checking plugin 'acts_as_tree' for 'application_helper'
1437
checking plugin 'acts_as_versioned' for 'application_helper'
1438
checking plugin 'acts_as_watchable' for 'application_helper'
1439
checking plugin 'classic_pagination' for 'application_helper'
1440
checking plugin 'coderay-0.7.6.227' for 'application_helper'
1441
checking plugin 'gloc-1.1.0' for 'application_helper'
1442
checking plugin 'gravatar' for 'application_helper'
1443
checking plugin 'rfpdf' for 'application_helper'
1444
checking plugin 'ruby-net-ldap-0.0.4' for 'application_helper'
1445
loading from application: application_helper
1446
loading routes from /opt/redmine/vendor/plugins/engines/routes.rb
1447
loading routes from /opt/redmine/vendor/plugins/actionwebservice/routes.rb
1448
loading routes from /opt/redmine/vendor/plugins/acts_as_activity_provider/routes.rb
1449
loading routes from /opt/redmine/vendor/plugins/acts_as_attachable/routes.rb
1450
loading routes from /opt/redmine/vendor/plugins/acts_as_customizable/routes.rb
1451
loading routes from /opt/redmine/vendor/plugins/acts_as_event/routes.rb
1452
loading routes from /opt/redmine/vendor/plugins/acts_as_list/routes.rb
1453
loading routes from /opt/redmine/vendor/plugins/acts_as_searchable/routes.rb
1454
loading routes from /opt/redmine/vendor/plugins/acts_as_tree/routes.rb
1455
loading routes from /opt/redmine/vendor/plugins/acts_as_versioned/routes.rb
1456
loading routes from /opt/redmine/vendor/plugins/acts_as_watchable/routes.rb
1457
loading routes from /opt/redmine/vendor/plugins/classic_pagination/routes.rb
1458
loading routes from /opt/redmine/vendor/plugins/coderay-0.7.6.227/routes.rb
1459
loading routes from /opt/redmine/vendor/plugins/gloc-1.1.0/routes.rb
1460
loading routes from /opt/redmine/vendor/plugins/gravatar/routes.rb
1461
loading routes from /opt/redmine/vendor/plugins/rfpdf/routes.rb
1462
loading routes from /opt/redmine/vendor/plugins/ruby-net-ldap-0.0.4/routes.rb
1463
checking plugin 'engines' for 'application_controller'
1464
checking plugin 'actionwebservice' for 'application_controller'
1465
checking plugin 'acts_as_activity_provider' for 'application_controller'
1466
checking plugin 'acts_as_attachable' for 'application_controller'
1467
checking plugin 'acts_as_customizable' for 'application_controller'
1468
checking plugin 'acts_as_event' for 'application_controller'
1469
checking plugin 'acts_as_list' for 'application_controller'
1470
checking plugin 'acts_as_searchable' for 'application_controller'
1471
checking plugin 'acts_as_tree' for 'application_controller'
1472
checking plugin 'acts_as_versioned' for 'application_controller'
1473
checking plugin 'acts_as_watchable' for 'application_controller'
1474
checking plugin 'classic_pagination' for 'application_controller'
1475
checking plugin 'coderay-0.7.6.227' for 'application_controller'
1476
checking plugin 'gloc-1.1.0' for 'application_controller'
1477
checking plugin 'gravatar' for 'application_controller'
1478
checking plugin 'rfpdf' for 'application_controller'
1479
checking plugin 'ruby-net-ldap-0.0.4' for 'application_controller'
1480
(file not found in application)
1481
checking plugin 'engines' for 'projects_controller'
1482
checking plugin 'actionwebservice' for 'projects_controller'
1483
checking plugin 'acts_as_activity_provider' for 'projects_controller'
1484
checking plugin 'acts_as_attachable' for 'projects_controller'
1485
checking plugin 'acts_as_customizable' for 'projects_controller'
1486
checking plugin 'acts_as_event' for 'projects_controller'
1487
checking plugin 'acts_as_list' for 'projects_controller'
1488
checking plugin 'acts_as_searchable' for 'projects_controller'
1489
checking plugin 'acts_as_tree' for 'projects_controller'
1490
checking plugin 'acts_as_versioned' for 'projects_controller'
1491
checking plugin 'acts_as_watchable' for 'projects_controller'
1492
checking plugin 'classic_pagination' for 'projects_controller'
1493
checking plugin 'coderay-0.7.6.227' for 'projects_controller'
1494
checking plugin 'gloc-1.1.0' for 'projects_controller'
1495
checking plugin 'gravatar' for 'projects_controller'
1496
checking plugin 'rfpdf' for 'projects_controller'
1497
checking plugin 'ruby-net-ldap-0.0.4' for 'projects_controller'
1498
loading from application: projects_controller
1499
checking plugin 'engines' for 'projects_helper'
1500
checking plugin 'actionwebservice' for 'projects_helper'
1501
checking plugin 'acts_as_activity_provider' for 'projects_helper'
1502
checking plugin 'acts_as_attachable' for 'projects_helper'
1503
checking plugin 'acts_as_customizable' for 'projects_helper'
1504
checking plugin 'acts_as_event' for 'projects_helper'
1505
checking plugin 'acts_as_list' for 'projects_helper'
1506
checking plugin 'acts_as_searchable' for 'projects_helper'
1507
checking plugin 'acts_as_tree' for 'projects_helper'
1508
checking plugin 'acts_as_versioned' for 'projects_helper'
1509
checking plugin 'acts_as_watchable' for 'projects_helper'
1510
checking plugin 'classic_pagination' for 'projects_helper'
1511
checking plugin 'coderay-0.7.6.227' for 'projects_helper'
1512
checking plugin 'gloc-1.1.0' for 'projects_helper'
1513
checking plugin 'gravatar' for 'projects_helper'
1514
checking plugin 'rfpdf' for 'projects_helper'
1515
checking plugin 'ruby-net-ldap-0.0.4' for 'projects_helper'
1516
loading from application: projects_helper
1517
checking plugin 'engines' for 'sort_helper'
1518
checking plugin 'actionwebservice' for 'sort_helper'
1519
checking plugin 'acts_as_activity_provider' for 'sort_helper'
1520
checking plugin 'acts_as_attachable' for 'sort_helper'
1521
checking plugin 'acts_as_customizable' for 'sort_helper'
1522
checking plugin 'acts_as_event' for 'sort_helper'
1523
checking plugin 'acts_as_list' for 'sort_helper'
1524
checking plugin 'acts_as_searchable' for 'sort_helper'
1525
checking plugin 'acts_as_tree' for 'sort_helper'
1526
checking plugin 'acts_as_versioned' for 'sort_helper'
1527
checking plugin 'acts_as_watchable' for 'sort_helper'
1528
checking plugin 'classic_pagination' for 'sort_helper'
1529
checking plugin 'coderay-0.7.6.227' for 'sort_helper'
1530
checking plugin 'gloc-1.1.0' for 'sort_helper'
1531
checking plugin 'gravatar' for 'sort_helper'
1532
checking plugin 'rfpdf' for 'sort_helper'
1533
checking plugin 'ruby-net-ldap-0.0.4' for 'sort_helper'
1534
loading from application: sort_helper
1535
checking plugin 'engines' for 'custom_fields_helper'
1536
checking plugin 'actionwebservice' for 'custom_fields_helper'
1537
checking plugin 'acts_as_activity_provider' for 'custom_fields_helper'
1538
checking plugin 'acts_as_attachable' for 'custom_fields_helper'
1539
checking plugin 'acts_as_customizable' for 'custom_fields_helper'
1540
checking plugin 'acts_as_event' for 'custom_fields_helper'
1541
checking plugin 'acts_as_list' for 'custom_fields_helper'
1542
checking plugin 'acts_as_searchable' for 'custom_fields_helper'
1543
checking plugin 'acts_as_tree' for 'custom_fields_helper'
1544
checking plugin 'acts_as_versioned' for 'custom_fields_helper'
1545
checking plugin 'acts_as_watchable' for 'custom_fields_helper'
1546
checking plugin 'classic_pagination' for 'custom_fields_helper'
1547
checking plugin 'coderay-0.7.6.227' for 'custom_fields_helper'
1548
checking plugin 'gloc-1.1.0' for 'custom_fields_helper'
1549
checking plugin 'gravatar' for 'custom_fields_helper'
1550
checking plugin 'rfpdf' for 'custom_fields_helper'
1551
checking plugin 'ruby-net-ldap-0.0.4' for 'custom_fields_helper'
1552
loading from application: custom_fields_helper
1553
checking plugin 'engines' for 'issues_helper'
1554
checking plugin 'actionwebservice' for 'issues_helper'
1555
checking plugin 'acts_as_activity_provider' for 'issues_helper'
1556
checking plugin 'acts_as_attachable' for 'issues_helper'
1557
checking plugin 'acts_as_customizable' for 'issues_helper'
1558
checking plugin 'acts_as_event' for 'issues_helper'
1559
checking plugin 'acts_as_list' for 'issues_helper'
1560
checking plugin 'acts_as_searchable' for 'issues_helper'
1561
checking plugin 'acts_as_tree' for 'issues_helper'
1562
checking plugin 'acts_as_versioned' for 'issues_helper'
1563
checking plugin 'acts_as_watchable' for 'issues_helper'
1564
checking plugin 'classic_pagination' for 'issues_helper'
1565
checking plugin 'coderay-0.7.6.227' for 'issues_helper'
1566
checking plugin 'gloc-1.1.0' for 'issues_helper'
1567
checking plugin 'gravatar' for 'issues_helper'
1568
checking plugin 'rfpdf' for 'issues_helper'
1569
checking plugin 'ruby-net-ldap-0.0.4' for 'issues_helper'
1570
loading from application: issues_helper
1571
checking plugin 'engines' for 'queries_helper'
1572
checking plugin 'actionwebservice' for 'queries_helper'
1573
checking plugin 'acts_as_activity_provider' for 'queries_helper'
1574
checking plugin 'acts_as_attachable' for 'queries_helper'
1575
checking plugin 'acts_as_customizable' for 'queries_helper'
1576
checking plugin 'acts_as_event' for 'queries_helper'
1577
checking plugin 'acts_as_list' for 'queries_helper'
1578
checking plugin 'acts_as_searchable' for 'queries_helper'
1579
checking plugin 'acts_as_tree' for 'queries_helper'
1580
checking plugin 'acts_as_versioned' for 'queries_helper'
1581
checking plugin 'acts_as_watchable' for 'queries_helper'
1582
checking plugin 'classic_pagination' for 'queries_helper'
1583
checking plugin 'coderay-0.7.6.227' for 'queries_helper'
1584
checking plugin 'gloc-1.1.0' for 'queries_helper'
1585
checking plugin 'gravatar' for 'queries_helper'
1586
checking plugin 'rfpdf' for 'queries_helper'
1587
checking plugin 'ruby-net-ldap-0.0.4' for 'queries_helper'
1588
loading from application: queries_helper
1589
checking plugin 'engines' for 'repositories_helper'
1590
checking plugin 'actionwebservice' for 'repositories_helper'
1591
checking plugin 'acts_as_activity_provider' for 'repositories_helper'
1592
checking plugin 'acts_as_attachable' for 'repositories_helper'
1593
checking plugin 'acts_as_customizable' for 'repositories_helper'
1594
checking plugin 'acts_as_event' for 'repositories_helper'
1595
checking plugin 'acts_as_list' for 'repositories_helper'
1596
checking plugin 'acts_as_searchable' for 'repositories_helper'
1597
checking plugin 'acts_as_tree' for 'repositories_helper'
1598
checking plugin 'acts_as_versioned' for 'repositories_helper'
1599
checking plugin 'acts_as_watchable' for 'repositories_helper'
1600
checking plugin 'classic_pagination' for 'repositories_helper'
1601
checking plugin 'coderay-0.7.6.227' for 'repositories_helper'
1602
checking plugin 'gloc-1.1.0' for 'repositories_helper'
1603
checking plugin 'gravatar' for 'repositories_helper'
1604
checking plugin 'rfpdf' for 'repositories_helper'
1605
checking plugin 'ruby-net-ldap-0.0.4' for 'repositories_helper'
1606
loading from application: repositories_helper
1607

    
1608

    
1609
Processing ProjectsController#settings (for 78.86.23.141 at 2009-10-25 12:43:55) [GET]
1610
  Session ID: ebbf9b6d1966d73faa37b351db04f99c
1611
  Parameters: {"action"=>"settings", "id"=>"test", "controller"=>"projects"}
1612
  SQL (0.000102)   SET NAMES 'utf8'
1613
  SQL (0.000047)   SET SQL_AUTO_IS_NULL=0
1614
  Setting Columns (0.000543)   SHOW FIELDS FROM `settings`
1615
  SQL (0.000058)   SELECT max(`settings`.updated_on) AS max_updated_on FROM `settings` 
1616
  User Columns (0.000627)   SHOW FIELDS FROM `users`
1617
  User Load (0.000082)   SELECT * FROM `users` WHERE (`users`.`id` = 1) AND (users.status = 1) 
1618
  Project Columns (0.000563)   SHOW FIELDS FROM `projects`
1619
  Project Load (0.000071)   SELECT * FROM `projects` WHERE (`projects`.`identifier` = 'test') LIMIT 1
1620
  EnabledModule Load (0.000076)   SELECT * FROM `enabled_modules` WHERE (`enabled_modules`.project_id = 2) 
1621
  EnabledModule Columns (0.000334)   SHOW FIELDS FROM `enabled_modules`
1622
  Project Load (0.000073)   SELECT * FROM `projects` WHERE (parent_id IS NULL AND status = 1 AND id <> 2) ORDER BY name
1623
  IssueCustomField Columns (0.000653)   SHOW FIELDS FROM `custom_fields`
1624
  IssueCustomField Load (0.000062)   SELECT * FROM `custom_fields` WHERE ( (`custom_fields`.`type` = 'IssueCustomField' ) ) ORDER BY custom_fields.position
1625
  IssueCategory Columns (0.000347)   SHOW FIELDS FROM `issue_categories`
1626
  Member Columns (0.000539)   SHOW FIELDS FROM `members`
1627
  Tracker Load (0.000063)   SELECT * FROM `trackers` ORDER BY position
1628
  Repository Load (0.000051)   SELECT * FROM `repositories` WHERE (`repositories`.project_id = 2) LIMIT 1
1629
  Repository Columns (0.000412)   SHOW FIELDS FROM `repositories`
1630
  Wiki Load (0.000384)   SELECT * FROM `wikis` WHERE (`wikis`.project_id = 2) LIMIT 1
1631
Rendering template within layouts/base
1632
Rendering projects/settings
1633
  Setting Load (0.000098)   SELECT * FROM `settings` WHERE (`settings`.`name` = 'text_formatting') LIMIT 1
1634
  CustomField Load (0.000076)   SELECT * FROM `custom_fields` WHERE (type = 'ProjectCustomField') ORDER BY position
1635
  Tracker Columns (0.000522)   SHOW FIELDS FROM `trackers`
1636
  Tracker Exists (0.000080)   SELECT `trackers`.id FROM `trackers` INNER JOIN `projects_trackers` ON `trackers`.id = `projects_trackers`.tracker_id WHERE (`trackers`.`id` = 1) AND (`projects_trackers`.project_id = 2 ) ORDER BY trackers.position LIMIT 1
1637
  Tracker Exists (0.000046)   SELECT `trackers`.id FROM `trackers` INNER JOIN `projects_trackers` ON `trackers`.id = `projects_trackers`.tracker_id WHERE (`trackers`.`id` = 2) AND (`projects_trackers`.project_id = 2 ) ORDER BY trackers.position LIMIT 1
1638
  Tracker Exists (0.000057)   SELECT `trackers`.id FROM `trackers` INNER JOIN `projects_trackers` ON `trackers`.id = `projects_trackers`.tracker_id WHERE (`trackers`.`id` = 3) AND (`projects_trackers`.project_id = 2 ) ORDER BY trackers.position LIMIT 1
1639
Rendered projects/_form (0.01459)
1640
Rendered projects/_edit (0.02471)
1641
Rendered projects/settings/_modules (0.00665)
1642
  Role Load (0.000075)   SELECT * FROM `roles` WHERE (`roles`.`builtin` = 0) ORDER BY position
1643
  User Load (0.000060)   SELECT * FROM `users` WHERE (users.status = 1) 
1644
  Setting Load (0.000046)   SELECT * FROM `settings` WHERE (`settings`.`name` = 'user_format') LIMIT 1
1645
  User Load (0.000059)   SELECT `users`.* FROM `users` INNER JOIN members ON users.id = members.user_id WHERE ((`members`.project_id = 2) AND ((users.status=1))) 
1646
  Role Columns (0.000445)   SHOW FIELDS FROM `roles`
1647
  Member Load Including Associations (0.000078)   SELECT `members`.`id` AS t0_r0, `members`.`user_id` AS t0_r1, `members`.`project_id` AS t0_r2, `members`.`role_id` AS t0_r3, `members`.`created_on` AS t0_r4, `members`.`mail_notification` AS t0_r5, `roles`.`id` AS t1_r0, `roles`.`name` AS t1_r1, `roles`.`position` AS t1_r2, `roles`.`assignable` AS t1_r3, `roles`.`builtin` AS t1_r4, `roles`.`permissions` AS t1_r5, `users`.`id` AS t2_r0, `users`.`login` AS t2_r1, `users`.`hashed_password` AS t2_r2, `users`.`firstname` AS t2_r3, `users`.`lastname` AS t2_r4, `users`.`mail` AS t2_r5, `users`.`mail_notification` AS t2_r6, `users`.`admin` AS t2_r7, `users`.`status` AS t2_r8, `users`.`last_login_on` AS t2_r9, `users`.`language` AS t2_r10, `users`.`auth_source_id` AS t2_r11, `users`.`created_on` AS t2_r12, `users`.`updated_on` AS t2_r13, `users`.`type` AS t2_r14 FROM `members` LEFT OUTER JOIN `roles` ON `roles`.id = `members`.role_id LEFT OUTER JOIN `users` ON `users`.id = `members`.user_id WHERE (`members`.project_id = 2 AND (users.status=1)) 
1648
Rendered projects/settings/_members (0.01651)
1649
  Version Columns (0.000515)   SHOW FIELDS FROM `versions`
1650
  SQL (0.000119)   SELECT count(*) AS count_all FROM `versions` WHERE (`versions`.project_id = 2) 
1651
Rendered projects/settings/_versions (0.00222)
1652
  SQL (0.000047)   SELECT count(*) AS count_all FROM `issue_categories` WHERE (`issue_categories`.project_id = 2) 
1653
Rendered projects/settings/_issue_categories (0.00104)
1654
Rendered projects/settings/_wiki (0.00281)
1655
  Setting Load (0.000060)   SELECT * FROM `settings` WHERE (`settings`.`name` = 'enabled_scm') LIMIT 1
1656
  Repository::Subversion Columns (0.000444)   SHOW FIELDS FROM `repositories`
1657
Rendered projects/settings/_repository (0.01248)
1658
  Board Columns (0.000546)   SHOW FIELDS FROM `boards`
1659
  SQL (0.000047)   SELECT count(*) AS count_all FROM `boards` WHERE (`boards`.project_id = 2) 
1660
Rendered projects/settings/_boards (0.00887)
1661
  Setting Load (0.000059)   SELECT * FROM `settings` WHERE (`settings`.`name` = 'app_title') LIMIT 1
1662
  Setting Load (0.000046)   SELECT * FROM `settings` WHERE (`settings`.`name` = 'ui_theme') LIMIT 1
1663
  SQL (0.000068)   SELECT count(DISTINCT `members`.id) AS count_all FROM `members` LEFT OUTER JOIN `projects` ON `projects`.id = `members`.project_id LEFT OUTER JOIN `roles` ON `roles`.id = `members`.role_id WHERE (`members`.user_id = 1 AND (projects.status=1)) 
1664
Completed in 0.23766 (4 reqs/sec) | Rendering: 0.11352 (47%) | DB: 0.00868 (3%) | 200 OK [http://devel.stuartmathews.com/projects/settings/test]
    (1-1/1)