Print Preview: Add some debug logging so one can time when print preview operations starts/finishes.

chrome/browser/ui/webui/print_preview_handler.cc

 // Copyright (c) 2011 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/browser/ui/webui/print_preview_handler.h"
 
 #include <string>
 
 #include "base/i18n/file_util_icu.h"
 #include "base/json/json_reader.h"
@@ skipping 101 matching lines @@
  public:
   PrintSystemTaskProxy(const base::WeakPtr<PrintPreviewHandler>& handler,
                        printing::PrintBackend* print_backend,
                        bool has_logged_printers_count)
       : handler_(handler),
         print_backend_(print_backend),
         has_logged_printers_count_(has_logged_printers_count) {
   }
 
   void EnumeratePrinters() {
+    VLOG(1) << "Enumerate printers start";
     ListValue* printers = new ListValue;
     int default_printer_index = -1;
 
     printing::PrinterList printer_list;
     print_backend_->EnumeratePrinters(&printer_list);
 
     if (!has_logged_printers_count_) {
       // Record the total number of printers.
       UMA_HISTOGRAM_COUNTS(kNumberOfPrinters, printer_list.size());
     }
 
     int i = 0;
-    for (printing::PrinterList::iterator index = printer_list.begin();
-         index != printer_list.end(); ++index, ++i) {
+    for (printing::PrinterList::iterator iter = printer_list.begin();
+         iter != printer_list.end(); ++iter, ++i) {
       DictionaryValue* printer_info = new DictionaryValue;
       std::string printerName;
   #if defined(OS_MACOSX)
-      // On Mac, |index->printer_description| specifies the printer name and
-      // |index->printer_name| specifies the device name / printer queue name.
-      printerName = index->printer_description;
+      // On Mac, |iter->printer_description| specifies the printer name and
+      // |iter->printer_name| specifies the device name / printer queue name.
+      printerName = iter->printer_description;
   #else
-      printerName = index->printer_name;
+      printerName = iter->printer_name;
   #endif
       printer_info->SetString(printing::kSettingPrinterName, printerName);
-      printer_info->SetString(printing::kSettingDeviceName,
-                              index->printer_name);
+      printer_info->SetString(printing::kSettingDeviceName, iter->printer_name);
       printers->Append(printer_info);
-      if (index->is_default)
+      if (iter->is_default)
         default_printer_index = i;
     }
+    VLOG(1) << "Enumerate printers finished, found " << i << " printers";
 
     BrowserThread::PostTask(
         BrowserThread::UI, FROM_HERE,
         NewRunnableMethod(this,
                           &PrintSystemTaskProxy::SendPrinterList,
                           printers,
                           new FundamentalValue(default_printer_index)));
   }
 
   void SendPrinterList(ListValue* printers,
                        FundamentalValue* default_printer_index) {
     if (handler_)
       handler_->SendPrinterList(*printers, *default_printer_index);
     delete printers;
     delete default_printer_index;
   }
 
   void GetPrinterCapabilities(const std::string& printer_name) {
+    VLOG(1) << "Get printer capabilities start for " << printer_name;
     printing::PrinterCapsAndDefaults printer_info;
     bool supports_color = true;
     if (!print_backend_->GetPrinterCapsAndDefaults(printer_name,
                                                    &printer_info)) {
       return;
     }
 
 #if defined(USE_CUPS)
     FilePath ppd_file_path;
     if (!file_util::CreateTemporaryFile(&ppd_file_path))
@@ skipping 143 matching lines @@
   TabContents* initiator_tab = GetInitiatorTab();
   if (!initiator_tab) {
     ++print_preview_failed_count_;
     web_ui_->CallJavascriptFunction("printPreviewFailed");
     return;
   }
   scoped_ptr<DictionaryValue> settings(GetSettingsDictionary(args));
   if (!settings.get())
     return;
 
+  VLOG(1) << "Print preview request start";
   RenderViewHost* rvh = initiator_tab->render_view_host();
   rvh->Send(new PrintMsg_PrintPreview(rvh->routing_id(), *settings));
 }
 
 void PrintPreviewHandler::HandlePrint(const ListValue* args) {
   ReportStats();
 
   // Record the number of times the user requests to regenerate preview data
   // before printing.
   UMA_HISTOGRAM_COUNTS(kRegeneratePreviewRequestsRcvdBeforePrint,
@@ skipping 119 matching lines @@
 
 void PrintPreviewHandler::ActivateInitiatorTabAndClosePreviewTab() {
   TabContents* initiator_tab = GetInitiatorTab();
   if (initiator_tab)
     initiator_tab->Activate();
   ClosePrintPreviewTab();
 }
 
 void PrintPreviewHandler::SendPrinterCapabilities(
     const DictionaryValue& settings_info) {
+  VLOG(1) << "Get printer capabilities finished";
   web_ui_->CallJavascriptFunction("updateWithPrinterCapabilities",
                                   settings_info);
 }
 
 void PrintPreviewHandler::SendPrinterList(
     const ListValue& printers,
     const FundamentalValue& default_printer_index) {
   web_ui_->CallJavascriptFunction("setPrinters", printers,
                                   default_printer_index);
 }
@@ skipping 63 matching lines @@
   metafile->InitFromData(data.first->memory(), data.second);
 
   // Updating last_saved_path_ to the newly selected folder.
   *last_saved_path_ = path.DirName();
 
   PrintToPdfTask* task = new PrintToPdfTask(metafile, path);
   BrowserThread::PostTask(BrowserThread::FILE, FROM_HERE, task);
 
   ActivateInitiatorTabAndClosePreviewTab();
 }