diff options
author | David Heinemeier Hansson <david@loudthinking.com> | 2005-04-02 09:31:58 +0000 |
---|---|---|
committer | David Heinemeier Hansson <david@loudthinking.com> | 2005-04-02 09:31:58 +0000 |
commit | 91834e0c3f00786ce8e03008f485d18d6ff1d906 (patch) | |
tree | 6242683d1a795501d0e463ebc7aecfdd8f6c2420 /actionpack/lib/action_controller | |
parent | 7c8d2f28e16958b16812b5fef3d7eca8b640e445 (diff) | |
download | rails-91834e0c3f00786ce8e03008f485d18d6ff1d906.tar.gz rails-91834e0c3f00786ce8e03008f485d18d6ff1d906.tar.bz2 rails-91834e0c3f00786ce8e03008f485d18d6ff1d906.zip |
Fixed that benchmarking times for rendering included db runtimes #987 [skaes@web.de]
git-svn-id: http://svn-commit.rubyonrails.org/rails/trunk@1070 5ecf4fe2-1ee6-0310-87b1-e25e094e27de
Diffstat (limited to 'actionpack/lib/action_controller')
-rw-r--r-- | actionpack/lib/action_controller/benchmarking.rb | 14 |
1 files changed, 10 insertions, 4 deletions
diff --git a/actionpack/lib/action_controller/benchmarking.rb b/actionpack/lib/action_controller/benchmarking.rb index e6ff65e150..6f4c248d70 100644 --- a/actionpack/lib/action_controller/benchmarking.rb +++ b/actionpack/lib/action_controller/benchmarking.rb @@ -19,7 +19,11 @@ module ActionController #:nodoc: if logger.nil? render_without_benchmark(template_name, status) else + db_runtime = ActiveRecord::Base.connection.reset_runtime @rendering_runtime = Benchmark::measure{ render_without_benchmark(template_name, status) }.real + @db_rt_before_render = db_runtime + @db_rt_after_render = ActiveRecord::Base.connection.reset_runtime + @rendering_runtime -= @db_rt_after_render end end @@ -28,7 +32,7 @@ module ActionController #:nodoc: perform_action_without_benchmark else runtime = [Benchmark::measure{ perform_action_without_benchmark }.real, 0.0001].max - log_message = "Completed in #{sprintf("%4f", runtime)} (#{(1 / runtime).floor} reqs/sec)" + log_message = "Completed in #{sprintf("%.5f", runtime)} (#{(1 / runtime).floor} reqs/sec)" log_message << rendering_runtime(runtime) if @rendering_runtime log_message << active_record_runtime(runtime) if Object.const_defined?("ActiveRecord") && ActiveRecord::Base.connected? logger.info(log_message) @@ -37,13 +41,15 @@ module ActionController #:nodoc: private def rendering_runtime(runtime) - " | Rendering: #{sprintf("%f", @rendering_runtime)} (#{sprintf("%d", (@rendering_runtime / runtime) * 100)}%)" + " | Rendering: #{sprintf("%.5f", @rendering_runtime)} (#{sprintf("%d", (@rendering_runtime * 100) / runtime)}%)" end def active_record_runtime(runtime) db_runtime = ActiveRecord::Base.connection.reset_runtime - db_percentage = (db_runtime / runtime) * 100 - " | DB: #{sprintf("%f", db_runtime)} (#{sprintf("%d", db_percentage)}%)" + db_runtime += @db_rt_before_render if @db_rt_before_render + db_runtime += @db_rt_after_render if @db_rt_after_render + db_percentage = (db_runtime * 100) / runtime + " | DB: #{sprintf("%.5f", db_runtime)} (#{sprintf("%d", db_percentage)}%)" end end end |