Log the PLT to the log file. This is a convenience for...

chrome/renderer/render_view.cc

 // Copyright (c) 2009 The Chromium Authors. All rights reserved.
 // Use of this source code is governed by a BSD-style license that can be
 // found in the LICENSE file.
 
 #include "chrome/renderer/render_view.h"
 
 #include <algorithm>
 #include <string>
 #include <vector>
 
@@ skipping 3402 matching lines @@
 void RenderView::DumpLoadHistograms() const {
   WebFrame* main_frame = webview()->mainFrame();
   NavigationState* navigation_state =
       NavigationState::FromDataSource(main_frame->dataSource());
   Time finish = navigation_state->finish_load_time();
 
   // If we've already dumped or we haven't finished loading, do nothing.
   if (navigation_state->load_histograms_recorded() || finish.is_null())
     return;
 
+  LogNavigationState(navigation_state, main_frame->dataSource());
+
   Time request = navigation_state->request_time();
   Time start = navigation_state->start_load_time();
   Time commit = navigation_state->commit_load_time();
   Time finish_doc = navigation_state->finish_document_load_time();
   Time first_paint = navigation_state->first_paint_time();
   Time first_paint_after_load =
       navigation_state->first_paint_after_load_time();
 
   Time begin;
   // Client side redirects will have no request time.
@@ skipping 128 matching lines @@
         "Renderer4.CommitToFirstPaintAfterLoad",
         first_paint_after_load - commit);
     UMA_HISTOGRAM_MEDIUM_TIMES(
         "Renderer4.FinishToFirstPaintAfterLoad",
         first_paint_after_load - finish);
   }
 
   navigation_state->set_load_histograms_recorded(true);
 }
 
+void RenderView::LogNavigationState(const NavigationState* state,
+                                    const WebDataSource* ds) const {
+  // Because this function gets called on every page load,
+  // take extra care to optimize it away if logging is turned off.
+  if (logging::LOG_INFO < logging::GetMinLogLevel())
+    return;
+
+  DCHECK(state);
+  DCHECK(ds);
+  GURL url(ds->request().url());
+  Time start = state->start_load_time();
+  Time finish = state->finish_load_time();
+  // TODO(mbelshe): should we log more stats?
+  LOG(INFO) << "PLT: "
+            << (finish - start).InMilliseconds()
+            << "ms "
+            << url.spec();
+}
+
 void RenderView::focusAccessibilityObject(
     const WebAccessibilityObject& acc_obj) {
 #if defined(OS_WIN)
   if (!web_accessibility_manager_.get()) {
     web_accessibility_manager_.reset(
         webkit_glue::WebAccessibilityManager::Create());
   }
 
   // Retrieve the accessibility object id of the AccessibilityObject.
   int acc_obj_id = web_accessibility_manager_->FocusAccObj(acc_obj);
@@ skipping 101 matching lines @@
       new PluginMsg_SignalModalDialogEvent(host_window_));
 
   message->EnableMessagePumping();  // Runs a nested message loop.
   bool rv = Send(message);
 
   PluginChannelHost::Broadcast(
       new PluginMsg_ResetModalDialogEvent(host_window_));
 
   return rv;
 }