Using only RootTree patch:

Index: src/IOPool/Input/src/RootFile.cc
===================================================================
RCS file: /cvs_server/repositories/CMSSW/CMSSW/IOPool/Input/src/RootFile.cc,v
retrieving revision 1.195.2.2
diff -u -r1.195.2.2 RootFile.cc
--- src/IOPool/Input/src/RootFile.cc    3 Dec 2009 20:52:00 -0000       1.195.2.2
+++ src/IOPool/Input/src/RootFile.cc    20 Jan 2010 01:44:31 -0000
@@ -850,6 +850,9 @@
     while(fileIndexIter_ != fileIndexEnd_ && fileIndexIter_->getEntryType() != FileIndex::kEvent) {
       ++fileIndexIter_;
     }
+
+    eventTree_.fHasTrained_ = kFALSE;
+
     return (fileIndexIter_ == fileIndexEnd_);
   }

Index: src/IOPool/Input/src/RootTree.cc
===================================================================
RCS file: /cvs_server/repositories/CMSSW/CMSSW/IOPool/Input/src/RootTree.cc,v
retrieving revision 1.50
diff -u -r1.50 RootTree.cc
--- src/IOPool/Input/src/RootTree.cc    20 Aug 2009 15:31:44 -0000      1.50
+++ src/IOPool/Input/src/RootTree.cc    20 Jan 2010 01:44:31 -0000
@@ -12,6 +12,7 @@
 #include "TTreeCache.h"

 #include <iostream>
+using namespace std;

 namespace edm {
   namespace {
@@ -43,6 +44,7 @@
     entryNumber_(-1),
     branchNames_(),
     branches_(new BranchMap),
+    fHasTrained_(kFALSE),
     productStatuses_(), // backward compatibility
     pProductStatuses_(&productStatuses_), // backward compatibility
     infoTree_(dynamic_cast<TTree *>(filePtr_.get() != 0 ? filePtr->Get(BranchTypeToInfoTreeName(branchType).c_str()) : 0)), // backward compatibility
@@ -123,6 +125,7 @@
   RootTree::setCacheSize(unsigned int cacheSize) {
     tree_->SetCacheSize(static_cast<Long64_t>(cacheSize));
     treeCache_ = dynamic_cast<TTreeCache *>(filePtr_->GetCacheRead());
+    cout << "setCacheSize " << cacheSize << ", TTreeCache " << treeCache_ << endl;
     filePtr_->SetCacheRead(0);
   }

@@ -134,18 +137,11 @@
   void
   RootTree::setEntryNumber(EntryNumber theEntryNumber) {
     filePtr_->SetCacheRead(treeCache_);
-    if (treeCache_) {
-      assert(treeCache_->GetOwner() == tree_);
-      if (theEntryNumber >= 0 && treeCache_->IsLearning()) {
-       treeCache_->SetLearnEntries(1);
-       treeCache_->SetEntryRange(0, tree_->GetEntries());
-        for (BranchMap::const_iterator i = branches_->begin(), e = branches_->end(); i != e; ++i) {
-         if (i->second.productBranch_) {
-           treeCache_->AddBranch(i->second.productBranch_, kTRUE);
-         }
-       }
-        treeCache_->StopLearningPhase();
-      }
+    if (treeCache_ && !fHasTrained_ && theEntryNumber >= 0) {
+        cout << "Training started on event " << theEntryNumber << endl;
+        treeCache_->SetLearnEntries(20);
+        treeCache_->SetEntryRange(theEntryNumber, tree_->GetEntries());
+        fHasTrained_ = kTRUE;
     }
     entryNumber_ = theEntryNumber;
     tree_->LoadTree(theEntryNumber);
@@ -160,6 +156,7 @@
     auxBranch_  = branchEntryInfoBranch_ = statusBranch_ = 0;
     tree_ = metaTree_ = infoTree_ = 0;
     treeCache_ = 0;
+    fHasTrained_ = kFALSE;
     filePtr_.reset();
   }

Index: src/IOPool/Input/src/RootTree.h
===================================================================
RCS file: /cvs_server/repositories/CMSSW/CMSSW/IOPool/Input/src/RootTree.h,v
retrieving revision 1.39
diff -u -r1.39 RootTree.h
--- src/IOPool/Input/src/RootTree.h     1 Sep 2009 23:31:59 -0000       1.39
+++ src/IOPool/Input/src/RootTree.h     20 Jan 2010 01:44:31 -0000
@@ -69,6 +69,7 @@
     } // backward compatibility

     TBranch *const branchEntryInfoBranch() const {return branchEntryInfoBranch_;}
+    bool fHasTrained_;

   private:
     boost::shared_ptr<TFile> filePtr_;
cvs diff: Diffing src/IOPool/Input/test

  CSCS PAT1 CMSSW_3_3_2 CSCS PAT1_RHAUTO_CHAPP_CACHE20 CMSSW_3_3_2_rootTreePatch
Success 100.0% (20 / 20) 100.0% (20 / 20)
WrapperTime 4748.45 +- 269.03 2736.20 +- 40.01
ExeTime 4734.60 +- 268.75 2724.90 +- 40.05
MinEventTime 0.07 +- 0.01 0.04 +- 0.00
UserTime 2775.18 +- 137.25 2218.44 +- 20.10
CpuPercentage 59.40 +- 1.93 81.90 +- 1.14
User_ReadkBEvt 89.96 +- 0.26 89.96 +- 0.26
AvgEventTime 0.47 +- 0.03 0.27 +- 0.00
MaxEventTime 29.35 +- 4.97 28.74 +- 4.77
TotalJobTime 4670.27 +- 268.66 2679.77 +- 40.05
StageoutTime -1.00 +- 0.00 -1.00 +- 0.00
SysTime 62.79 +- 7.68 28.37 +- 1.53
OPEN
dcap-open-total-megabytes 0.00 +- 0.00 0.00 +- 0.00
file-open-total-megabytes 0.00 +- 0.00 0.00 +- 0.00
dcap-open-total-msecs 9135.83 +- 4294.10 1762.04 +- 772.98
file-open-total-msecs 0.31 +- 0.01 0.30 +- 0.02
dcap-open-num-operations 2.50 +- 0.50 2.50 +- 0.50
file-open-num-operations 1.00 +- 0.00 1.00 +- 0.00
dcap-open-num-successful-operations 2.50 +- 0.50 2.50 +- 0.50
file-open-num-successful-operations 1.00 +- 0.00 1.00 +- 0.00
READ
tstoragefile-read-actual-total-megabytes 878.52 +- 2.59 54.37 +- 2.54
tstoragefile-read-async-total-megabytes // 0.00 +- 0.00
tstoragefile-read-total-megabytes 878.52 +- 2.59 878.52 +- 2.59
dcap-read-total-megabytes 878.52 +- 2.59 54.37 +- 2.54
file-read-total-megabytes 0.00 +- 0.00 0.00 +- 0.00
tstoragefile-read-via-cache-total-megabytes // 824.15 +- 2.94
tstoragefile-read-actual-total-msecs 1886837.50 +- 170578.68 31299.67 +- 4631.72
tstoragefile-read-async-total-msecs // 0.00 +- 0.00
tstoragefile-read-total-msecs 1887085.50 +- 170593.32 481780.40 +- 34881.48
dcap-read-total-msecs 1886553.00 +- 170565.43 31277.04 +- 4631.38
file-read-total-msecs 0.00 +- 0.00 0.00 +- 0.00
tstoragefile-read-via-cache-total-msecs // 432281.30 +- 33929.62
tstoragefile-read-actual-num-operations 134683.15 +- 311.18 11367.05 +- 238.83
tstoragefile-read-actual-num-successful-operations 134683.15 +- 311.18 11367.05 +- 238.83
tstoragefile-read-async-num-operations // 2.50 +- 0.50
tstoragefile-read-async-num-successful-operations // 0.00 +- 0.00
tstoragefile-read-num-operations 134683.15 +- 311.18 134683.15 +- 311.18
dcap-read-num-operations 134683.15 +- 311.18 11367.05 +- 238.83
file-read-num-operations 0.00 +- 0.00 0.00 +- 0.00
tstoragefile-read-num-successful-operations 134683.15 +- 311.18 134683.15 +- 311.18
dcap-read-num-successful-operations 134683.15 +- 311.18 11367.05 +- 238.83
file-read-num-successful-operations 0.00 +- 0.00 0.00 +- 0.00
tstoragefile-read-via-cache-num-operations // 124485.90 +- 314.45
tstoragefile-read-via-cache-num-successful-operations // 123316.10 +- 445.90
READV
tstoragefile-readv-actual-total-megabytes // 881.20 +- 7.51
dcap-readv-total-megabytes 0.00 +- 0.00 881.20 +- 7.51
file-readv-total-megabytes 0.00 +- 0.00 0.00 +- 0.00
tstoragefile-readv-actual-total-msecs // 448544.10 +- 33454.43
dcap-readv-total-msecs 0.00 +- 0.00 448543.95 +- 33454.43
file-readv-total-msecs 0.00 +- 0.00 0.00 +- 0.00
tstoragefile-readv-actual-num-operations // 44.70 +- 0.56
tstoragefile-readv-actual-num-successful-operations // 44.70 +- 0.56
dcap-readv-num-operations 0.00 +- 0.00 44.70 +- 0.56
file-readv-num-operations 0.00 +- 0.00 0.00 +- 0.00
dcap-readv-num-successful-operations 0.00 +- 0.00 44.70 +- 0.56
file-readv-num-successful-operations 0.00 +- 0.00 0.00 +- 0.00

  • CSCS-PAT1-QCD_Pt80Summer09-Overview.jpg:
    CSCS-PAT1-QCD_Pt80Summer09-Overview.jpg

All patches

 /usr/bin/curl -k https://twiki.cern.ch/twiki/pub/Sandbox/CmsIOWork/ttreecache_rollup.patch | patch -p 0
 /usr/bin/curl https://twiki.cern.ch/twiki/pub/Sandbox/CmsIOWork/read_coalesce.patch | patch -p0

CSCS

  CSCS PAT1 CMSSW_3_3_2 CSCS PAT1_RHAUTO_CHAPP_CACHE20 CMSSW_3_3_2 CSCS PAT1_RHAUTO_CHAPP_CACHE20 CMSSW_3_3_2_patched4 CSCS PAT1_RHAUTO_CHAPP_CACHE20 CMSSW_3_3_2_rootTreePatch
Success 100.0% (11 / 11) 100.0% (20 / 20) 100.0% (20 / 20) 100.0% (20 / 20)
WrapperTime 4732.82 +- 151.96 2467.10 +- 30.58 2440.25 +- 29.97 3530.70 +- 405.78
ExeTime 4721.73 +- 152.11 2457.05 +- 30.59 2426.95 +- 29.23 3520.45 +- 405.82
UserTime 2756.67 +- 47.30 2186.42 +- 18.67 2204.76 +- 21.06 2390.27 +- 92.41
CpuPercentage 59.09 +- 1.50 90.00 +- 0.89 91.55 +- 0.92 69.25 +- 5.35
User_ReadkBEvt 90.03 +- 0.20 89.96 +- 0.26 89.96 +- 0.26 89.96 +- 0.26
StageoutTime -1.00 +- 0.00 -1.00 +- 0.00 -1.00 +- 0.00 -1.00 +- 0.00
SysTime 45.36 +- 8.20 37.25 +- 3.55 27.37 +- 1.79 42.50 +- 8.18
MinEventTime // 0.04 +- 0.00 0.04 +- 0.00 0.05 +- 0.00
AvgEventTime // 0.24 +- 0.00 0.24 +- 0.00 0.35 +- 0.04
MaxEventTime // 27.13 +- 5.72 29.23 +- 4.76 28.31 +- 4.71
TotalJobTime // 2415.22 +- 31.45 2372.19 +- 26.72 3476.76 +- 406.49
OPEN
dcap-open-total-megabytes 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00
file-open-total-megabytes 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00
dcap-open-total-msecs 847.53 +- 204.39 716.40 +- 134.08 2534.65 +- 1267.04 807.05 +- 259.33
file-open-total-msecs 0.35 +- 0.09 0.31 +- 0.03 0.30 +- 0.02 0.34 +- 0.10
dcap-open-num-operations 2.55 +- 0.50 2.50 +- 0.50 2.50 +- 0.50 2.50 +- 0.50
file-open-num-operations 1.00 +- 0.00 1.00 +- 0.00 1.00 +- 0.00 1.00 +- 0.00
dcap-open-num-successful-operations 2.55 +- 0.50 2.50 +- 0.50 2.50 +- 0.50 2.50 +- 0.50
file-open-num-successful-operations 1.00 +- 0.00 1.00 +- 0.00 1.00 +- 0.00 1.00 +- 0.00
READ
tstoragefile-read-actual-total-megabytes 879.19 +- 1.98 49.76 +- 1.61 1437.38 +- 11.68 365.69 +- 148.17
tstoragefile-read-async-total-megabytes // 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00
tstoragefile-read-total-megabytes 879.19 +- 1.98 878.52 +- 2.59 878.52 +- 2.59 878.52 +- 2.59
dcap-read-total-megabytes 879.19 +- 1.98 49.76 +- 1.61 1437.38 +- 11.68 365.69 +- 148.17
file-read-total-megabytes 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00
tstoragefile-read-via-cache-total-megabytes // 828.76 +- 2.60 824.15 +- 2.94 512.83 +- 148.39
tstoragefile-read-actual-total-msecs 1928058.18 +- 126387.52 18615.19 +- 923.84 183529.65 +- 20441.47 769208.59 +- 377209.96
tstoragefile-read-async-total-msecs // 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00
tstoragefile-read-total-msecs 1928302.73 +- 126388.89 241545.55 +- 22323.80 186929.55 +- 20471.96 1091234.45 +- 313019.43
dcap-read-total-msecs 1927770.00 +- 126382.43 18594.75 +- 923.61 183490.30 +- 20441.00 769070.90 +- 377155.81
file-read-total-msecs 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00
tstoragefile-read-via-cache-total-msecs // 1662.01 +- 33.99 142257.75 +- 8164.77 243617.38 +- 94074.05
tstoragefile-read-actual-num-operations 134718.55 +- 317.96 10308.65 +- 7.33 17720.55 +- 218.43 59502.30 +- 21988.79
tstoragefile-read-actual-num-successful-operations 134718.55 +- 317.96 10308.65 +- 7.33 17720.55 +- 218.43 59502.30 +- 21988.79
tstoragefile-read-async-num-operations // 2.50 +- 0.50 2.50 +- 0.50 2.50 +- 0.50
tstoragefile-read-async-num-successful-operations // 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00
tstoragefile-read-num-operations 134718.55 +- 317.96 134683.15 +- 311.18 134683.15 +- 311.18 134683.15 +- 311.18
dcap-read-num-operations 134718.55 +- 317.96 10308.65 +- 7.33 17720.55 +- 218.43 59502.30 +- 21988.79
file-read-num-operations 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00
tstoragefile-read-num-successful-operations 134718.55 +- 317.96 134683.15 +- 311.18 134683.15 +- 311.18 134683.15 +- 311.18
dcap-read-num-successful-operations 134718.55 +- 317.96 10308.65 +- 7.33 17720.55 +- 218.43 59502.30 +- 21988.79
file-read-num-successful-operations 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00
tstoragefile-read-via-cache-num-operations // 124485.90 +- 314.45 124485.90 +- 314.45 124485.90 +- 314.45
tstoragefile-read-via-cache-num-successful-operations // 124374.50 +- 314.36 123316.10 +- 445.90 75180.85 +- 21833.96
READV
tstoragefile-readv-actual-total-megabytes // 2303.24 +- 20.72 // 551.14 +- 157.24
dcap-readv-total-megabytes 0.00 +- 0.00 2303.24 +- 20.72 0.00 +- 0.00 551.14 +- 157.24
file-readv-total-megabytes 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00
tstoragefile-readv-actual-total-msecs // 224297.75 +- 21278.53 // 320325.20 +- 87660.07
dcap-readv-total-msecs 0.00 +- 0.00 224296.85 +- 21278.62 0.00 +- 0.00 320325.10 +- 87660.15
file-readv-total-msecs 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00
tstoragefile-readv-actual-num-operations // 111.40 +- 0.86 // 28.65 +- 7.93
tstoragefile-readv-actual-num-successful-operations // 111.40 +- 0.86 // 28.65 +- 7.93
dcap-readv-num-operations 0.00 +- 0.00 111.40 +- 0.86 0.00 +- 0.00 28.65 +- 7.93
file-readv-num-operations 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00
dcap-readv-num-successful-operations 0.00 +- 0.00 111.40 +- 0.86 0.00 +- 0.00 28.65 +- 7.93
file-readv-num-successful-operations 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00

KNU

  KNU PAT1 CMSSW_3_3_2 KNU PAT1_RHAUTO_CHAPP_CACHE20 CMSSW_3_3_2 KNU PAT1_RHAUTO_CHAPP_CACHE20 CMSSW_3_3_2_patched4 KNU PAT1_RHAUTO_CHAPP_CACHE20 CMSSW_3_3_2_rootTreePatch
Success 100.0% (20 / 20) 100.0% (18 / 18) 100.0% (20 / 20) 100.0% (18 / 18)
WrapperTime 3117.40 +- 129.42 2519.94 +- 331.85 2351.70 +- 50.21 2498.56 +- 222.58
ExeTime 3104.85 +- 129.12 2509.67 +- 329.85 2342.50 +- 50.07 2489.39 +- 221.78
UserTime 2398.57 +- 136.59 2337.22 +- 259.17 2122.69 +- 35.11 2176.17 +- 188.66
CpuPercentage 79.20 +- 3.30 94.78 +- 2.76 92.15 +- 1.01 89.44 +- 6.22
User_ReadkBEvt 89.96 +- 0.26 89.95 +- 0.28 89.96 +- 0.26 89.95 +- 0.28
StageoutTime -1.00 +- 0.00 -1.00 +- 0.00 -1.00 +- 0.00 -1.00 +- 0.00
SysTime 73.72 +- 6.67 48.01 +- 9.28 45.85 +- 2.76 54.94 +- 7.10
MinEventTime // 0.05 +- 0.01 0.04 +- 0.00 0.05 +- 0.00
AvgEventTime // 0.24 +- 0.03 0.23 +- 0.00 0.25 +- 0.02
MaxEventTime // 30.88 +- 9.54 30.19 +- 7.38 27.42 +- 4.07
TotalJobTime // 2448.73 +- 305.33 2304.22 +- 46.93 2451.03 +- 218.89
OPEN
dcap-open-total-megabytes 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00
file-open-total-megabytes 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00
dcap-open-total-msecs 4825.49 +- 1429.57 1061.99 +- 237.30 1145.66 +- 320.54 1160.44 +- 251.95
file-open-total-msecs 0.28 +- 0.13 0.22 +- 0.04 0.18 +- 0.01 0.19 +- 0.03
dcap-open-num-operations 2.50 +- 0.50 2.50 +- 0.50 2.50 +- 0.50 2.50 +- 0.50
file-open-num-operations 1.00 +- 0.00 1.00 +- 0.00 1.00 +- 0.00 1.00 +- 0.00
dcap-open-num-successful-operations 2.50 +- 0.50 2.50 +- 0.50 2.50 +- 0.50 2.50 +- 0.50
file-open-num-successful-operations 1.00 +- 0.00 1.00 +- 0.00 1.00 +- 0.00 1.00 +- 0.00
READ
tstoragefile-read-actual-total-megabytes 878.52 +- 2.59 49.77 +- 1.61 1437.38 +- 11.68 365.70 +- 148.86
tstoragefile-read-async-total-megabytes // 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00
tstoragefile-read-total-megabytes 878.52 +- 2.59 878.46 +- 2.71 878.52 +- 2.59 878.46 +- 2.71
dcap-read-total-megabytes 878.52 +- 2.59 49.77 +- 1.61 1437.38 +- 11.68 365.70 +- 148.86
file-read-total-megabytes 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00
tstoragefile-read-via-cache-total-megabytes // 828.69 +- 2.61 824.15 +- 2.94 512.76 +- 149.20
tstoragefile-read-actual-total-msecs 526871.40 +- 107766.07 18091.31 +- 16507.88 165575.15 +- 16929.67 222456.59 +- 163869.85
tstoragefile-read-async-total-msecs // 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00
tstoragefile-read-total-msecs 527494.80 +- 107766.91 104278.78 +- 77166.90 167770.65 +- 16937.70 263819.54 +- 178747.62
dcap-read-total-msecs 526218.80 +- 107767.87 18058.23 +- 16508.13 165536.10 +- 16929.20 222310.43 +- 163864.65
file-read-total-msecs 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00
tstoragefile-read-via-cache-total-msecs // 2217.80 +- 999.39 139755.15 +- 14865.02 28032.85 +- 35457.34
tstoragefile-read-actual-num-operations 134683.15 +- 311.18 10308.67 +- 7.31 17720.55 +- 218.43 59409.17 +- 22122.85
tstoragefile-read-actual-num-successful-operations 134683.15 +- 311.18 10308.67 +- 7.31 17720.55 +- 218.43 59409.17 +- 22122.85
tstoragefile-read-async-num-operations // 2.50 +- 0.50 2.50 +- 0.50 2.50 +- 0.50
tstoragefile-read-async-num-successful-operations // 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00
tstoragefile-read-num-operations 134683.15 +- 311.18 134668.78 +- 316.80 134683.15 +- 311.18 134668.78 +- 316.80
dcap-read-num-operations 134683.15 +- 311.18 10308.67 +- 7.31 17720.55 +- 218.43 59409.17 +- 22122.85
file-read-num-operations 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00
tstoragefile-read-num-successful-operations 134683.15 +- 311.18 134668.78 +- 316.80 134683.15 +- 311.18 134668.78 +- 316.80
dcap-read-num-successful-operations 134683.15 +- 311.18 10308.67 +- 7.31 17720.55 +- 218.43 59409.17 +- 22122.85
file-read-num-successful-operations 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00
tstoragefile-read-via-cache-num-operations // 124471.56 +- 319.82 124485.90 +- 314.45 124471.56 +- 319.82
tstoragefile-read-via-cache-num-successful-operations // 124360.11 +- 319.70 123316.10 +- 445.90 75259.61 +- 21974.83
READV
tstoragefile-readv-actual-total-megabytes // 2304.69 +- 21.24 // 551.28 +- 158.17
dcap-readv-total-megabytes 0.00 +- 0.00 2304.69 +- 21.24 0.00 +- 0.00 551.28 +- 158.17
file-readv-total-megabytes 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00
tstoragefile-readv-actual-total-msecs // 84795.18 +- 62519.79 // 39679.26 +- 53880.67
dcap-readv-total-msecs 0.00 +- 0.00 84794.50 +- 62519.83 0.00 +- 0.00 39679.13 +- 53880.71
file-readv-total-msecs 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00
tstoragefile-readv-actual-num-operations // 111.44 +- 0.90 // 28.67 +- 7.97
tstoragefile-readv-actual-num-successful-operations // 111.44 +- 0.90 // 28.67 +- 7.97
dcap-readv-num-operations 0.00 +- 0.00 111.44 +- 0.90 0.00 +- 0.00 28.67 +- 7.97
file-readv-num-operations 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00
dcap-readv-num-successful-operations 0.00 +- 0.00 111.44 +- 0.90 0.00 +- 0.00 28.67 +- 7.97
file-readv-num-successful-operations 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00

--+++ Nebraska

  Nebraska PAT1 CMSSW_3_3_2 Nebraska PAT1_RHAUTO_CHAPP_CACHE20 CMSSW_3_3_2 Nebraska PAT1_RHAUTO_CHAPP_CACHE20 CMSSW_3_3_2_patched4 Nebraska PAT1_RHAUTO_CHAPP_CACHE20 CMSSW_3_3_2_rootTreePatch
Success 100.0% (20 / 20) 100.0% (20 / 20) 100.0% (20 / 20) 100.0% (20 / 20)
WrapperTime 3055.00 +- 300.52 2867.95 +- 294.78 2570.90 +- 192.19 2773.65 +- 241.05
ExeTime 2974.55 +- 228.05 2850.30 +- 298.12 2557.50 +- 191.01 2760.65 +- 240.27
UserTime 2528.75 +- 227.45 2453.92 +- 196.99 2366.86 +- 147.68 2470.26 +- 235.93
CpuPercentage 85.25 +- 2.09 87.50 +- 7.48 93.20 +- 1.57 90.10 +- 2.45
User_ReadkBEvt 89.96 +- 0.26 89.96 +- 0.26 89.96 +- 0.26 89.96 +- 0.26
StageoutTime -1.00 +- 0.00 -1.00 +- 0.00 -1.00 +- 0.00 -1.00 +- 0.00
SysTime 21.81 +- 6.42 38.70 +- 7.93 29.07 +- 9.97 33.36 +- 10.01
AvgEventTime // 0.28 +- 0.03 0.24 +- 0.02 0.27 +- 0.02
MaxEventTime // 34.18 +- 10.48 31.75 +- 4.55 30.28 +- 5.53
TotalJobTime // 2789.91 +- 288.02 2434.70 +- 172.80 2711.66 +- 240.81
MinEventTime // 0.05 +- 0.00 0.05 +- 0.00 0.05 +- 0.00
OPEN
file-open-total-megabytes 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00
file-open-total-msecs 335.86 +- 151.22 726.49 +- 614.13 1929.13 +- 4673.02 487.17 +- 773.49
file-open-num-operations 3.50 +- 0.50 3.50 +- 0.50 3.50 +- 0.50 3.50 +- 0.50
file-open-num-successful-operations 3.50 +- 0.50 3.50 +- 0.50 3.50 +- 0.50 3.50 +- 0.50
READ
tstoragefile-read-actual-total-megabytes 878.52 +- 2.59 49.76 +- 1.61 1437.38 +- 11.68 365.69 +- 148.17
tstoragefile-read-async-total-megabytes // 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00
tstoragefile-read-total-megabytes 878.52 +- 2.59 878.52 +- 2.59 878.52 +- 2.59 878.52 +- 2.59
file-read-total-megabytes 878.52 +- 2.59 49.76 +- 1.61 1437.38 +- 11.68 365.69 +- 148.17
tstoragefile-read-via-cache-total-megabytes // 828.76 +- 2.60 824.15 +- 2.94 512.83 +- 148.39
tstoragefile-read-actual-total-msecs 372326.85 +- 40256.55 12412.33 +- 6401.97 59079.74 +- 10524.47 167948.04 +- 80316.19
tstoragefile-read-async-total-msecs // 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00
tstoragefile-read-total-msecs 372786.70 +- 40197.80 291516.35 +- 247376.46 62936.93 +- 11071.13 219815.30 +- 68130.07
file-read-total-msecs 371793.10 +- 40318.89 12381.02 +- 6404.85 59022.55 +- 10516.61 167772.79 +- 80252.77
tstoragefile-read-via-cache-total-msecs // 2469.50 +- 982.68 50172.16 +- 5373.73 37995.43 +- 15522.05
tstoragefile-read-actual-num-operations 134683.15 +- 311.18 10308.65 +- 7.33 17720.55 +- 218.43 59502.30 +- 21988.79
tstoragefile-read-actual-num-successful-operations 134683.15 +- 311.18 10308.65 +- 7.33 17720.55 +- 218.43 59502.30 +- 21988.79
tstoragefile-read-async-num-operations // 2.50 +- 0.50 2.50 +- 0.50 2.50 +- 0.50
tstoragefile-read-async-num-successful-operations // 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00
tstoragefile-read-num-operations 134683.15 +- 311.18 134683.15 +- 311.18 134683.15 +- 311.18 134683.15 +- 311.18
file-read-num-operations 134683.15 +- 311.18 10308.65 +- 7.33 17720.55 +- 218.43 59502.30 +- 21988.79
tstoragefile-read-num-successful-operations 134683.15 +- 311.18 134683.15 +- 311.18 134683.15 +- 311.18 134683.15 +- 311.18
file-read-num-successful-operations 134683.15 +- 311.18 10308.65 +- 7.33 17720.55 +- 218.43 59502.30 +- 21988.79
tstoragefile-read-via-cache-num-operations // 124485.90 +- 314.45 124485.90 +- 314.45 124485.90 +- 314.45
tstoragefile-read-via-cache-num-successful-operations // 124374.50 +- 314.36 123316.10 +- 445.90 75180.85 +- 21833.96
READV
tstoragefile-readv-actual-total-megabytes // 2303.24 +- 20.72 // 551.14 +- 157.24
file-readv-total-megabytes 0.00 +- 0.00 2303.24 +- 20.72 0.00 +- 0.00 551.14 +- 157.24
tstoragefile-readv-actual-total-msecs // 281730.40 +- 244216.74 // 49453.27 +- 17405.46
file-readv-total-msecs 0.00 +- 0.00 281729.75 +- 244216.76 0.00 +- 0.00 49453.04 +- 17405.40
tstoragefile-readv-actual-num-operations // 111.40 +- 0.86 // 28.65 +- 7.93
tstoragefile-readv-actual-num-successful-operations // 111.40 +- 0.86 // 28.65 +- 7.93
file-readv-num-operations 0.00 +- 0.00 111.40 +- 0.86 0.00 +- 0.00 28.65 +- 7.93
file-readv-num-successful-operations 0.00 +- 0.00 111.40 +- 0.86 0.00 +- 0.00 28.65 +- 7.93

Pisa

  Pisa PAT1 CMSSW_3_3_2 Pisa PAT1_RHAUTO_CHAPP_CACHE20 CMSSW_3_3_2 Pisa PAT1_RHAUTO_CHAPP_CACHE20 CMSSW_3_3_2_patched4 Pisa PAT1_RHAUTO_CHAPP_CACHE20 CMSSW_3_3_2_rootTreePatch
Success 100.0% (20 / 20) 80.0% (16 / 20) 100.0% (20 / 20) 90.0% (18 / 20)
Error 50115 // 100.0% // 100.0%
WrapperTime 4073.60 +- 1788.58 2557.12 +- 172.88 2555.60 +- 156.76 3203.33 +- 426.76
ExeTime 4053.95 +- 1777.40 2541.62 +- 172.60 2543.10 +- 155.81 3186.61 +- 426.97
UserTime 2612.46 +- 708.52 2300.05 +- 301.43 2409.24 +- 136.90 2341.63 +- 156.55
CpuPercentage 71.05 +- 16.34 91.44 +- 7.00 96.05 +- 1.69 75.72 +- 11.39
User_ReadkBEvt 89.96 +- 0.26 71.98 +- 35.99 89.96 +- 0.26 80.96 +- 26.99
StageoutTime -1.00 +- 0.00 -1.00 +- 0.00 -1.00 +- 0.00 -1.00 +- 0.00
SysTime 38.93 +- 6.86 44.44 +- 9.27 45.29 +- 3.34 46.75 +- 4.52
MinEventTime // 0.05 +- 0.00 0.05 +- 0.01 0.05 +- 0.00
AvgEventTime // 0.25 +- 0.02 0.25 +- 0.02 0.31 +- 0.04
MaxEventTime // 29.18 +- 6.00 30.24 +- 5.09 31.45 +- 5.98
TotalJobTime // 2487.73 +- 170.37 2495.45 +- 151.58 3129.46 +- 427.72
OPEN
dcap-open-total-megabytes 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00
file-open-total-megabytes 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00
dcap-open-total-msecs 1404.32 +- 1789.73 492.52 +- 126.45 563.70 +- 136.50 650.06 +- 753.18
file-open-total-msecs 0.25 +- 0.05 3.04 +- 7.43 0.59 +- 1.04 0.29 +- 0.17
dcap-open-num-operations 2.50 +- 0.50 2.62 +- 0.48 2.50 +- 0.50 2.50 +- 0.50
file-open-num-operations 1.00 +- 0.00 1.00 +- 0.00 1.00 +- 0.00 1.00 +- 0.00
dcap-open-num-successful-operations 2.50 +- 0.50 2.62 +- 0.48 2.50 +- 0.50 2.50 +- 0.50
file-open-num-successful-operations 1.00 +- 0.00 1.00 +- 0.00 1.00 +- 0.00 1.00 +- 0.00
READ
tstoragefile-read-actual-total-megabytes 878.52 +- 2.59 50.18 +- 1.54 1437.38 +- 11.68 388.05 +- 133.87
tstoragefile-read-async-total-megabytes // 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00
tstoragefile-read-total-megabytes 878.52 +- 2.59 878.64 +- 2.86 878.52 +- 2.59 878.48 +- 2.70
dcap-read-total-megabytes 878.52 +- 2.59 50.18 +- 1.54 1437.38 +- 11.68 388.05 +- 133.87
file-read-total-megabytes 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00
tstoragefile-read-via-cache-total-megabytes // 828.46 +- 2.81 824.15 +- 2.94 490.43 +- 134.19
tstoragefile-read-actual-total-msecs 1365057.10 +- 1485344.30 40657.73 +- 35772.71 79453.78 +- 39744.07 596392.63 +- 411073.71
tstoragefile-read-async-total-msecs // 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00
tstoragefile-read-total-msecs 1365573.85 +- 1485304.29 177276.51 +- 152145.51 84105.03 +- 39798.85 779819.89 +- 449826.59
dcap-read-total-msecs 1364517.95 +- 1485379.45 40617.71 +- 35784.47 79382.27 +- 39742.28 596160.67 +- 411041.80
file-read-total-msecs 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00
tstoragefile-read-via-cache-total-msecs // 2782.58 +- 805.00 46117.97 +- 28072.87 128744.12 +- 91141.75
tstoragefile-read-actual-num-operations 134683.15 +- 311.18 10310.50 +- 7.04 17720.55 +- 218.43 62987.44 +- 19569.20
tstoragefile-read-actual-num-successful-operations 134683.15 +- 311.18 10310.50 +- 7.04 17720.55 +- 218.43 62987.44 +- 19569.20
tstoragefile-read-async-num-operations // 2.62 +- 0.48 2.50 +- 0.50 2.50 +- 0.50
tstoragefile-read-async-num-successful-operations // 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00
tstoragefile-read-num-operations 134683.15 +- 311.18 134659.56 +- 337.14 134683.15 +- 311.18 134695.61 +- 324.77
dcap-read-num-operations 134683.15 +- 311.18 10310.50 +- 7.04 17720.55 +- 218.43 62987.44 +- 19569.20
file-read-num-operations 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00
tstoragefile-read-num-successful-operations 134683.15 +- 311.18 134659.56 +- 337.14 134683.15 +- 311.18 134695.61 +- 324.77
dcap-read-num-successful-operations 134683.15 +- 311.18 10310.50 +- 7.04 17720.55 +- 218.43 62987.44 +- 19569.20
file-read-num-successful-operations 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00
tstoragefile-read-via-cache-num-operations // 124460.38 +- 340.26 124485.90 +- 314.45 124498.39 +- 328.03
tstoragefile-read-via-cache-num-successful-operations // 124349.06 +- 340.28 123316.10 +- 445.90 71708.17 +- 19390.97
READV
tstoragefile-readv-actual-total-megabytes // 2301.22 +- 18.94 // 527.12 +- 141.80
dcap-readv-total-megabytes 0.00 +- 0.00 2301.22 +- 18.94 0.00 +- 0.00 527.12 +- 141.80
file-readv-total-megabytes 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00
tstoragefile-readv-actual-total-msecs // 135572.09 +- 121178.57 // 180543.27 +- 118860.38
dcap-readv-total-msecs 0.00 +- 0.00 135571.36 +- 121178.64 0.00 +- 0.00 180543.03 +- 118860.39
file-readv-total-msecs 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00
tstoragefile-readv-actual-num-operations // 111.31 +- 0.77 // 27.44 +- 7.21
tstoragefile-readv-actual-num-successful-operations // 111.31 +- 0.77 // 27.44 +- 7.21
dcap-readv-num-operations 0.00 +- 0.00 111.31 +- 0.77 0.00 +- 0.00 27.44 +- 7.21
file-readv-num-operations 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00
dcap-readv-num-successful-operations 0.00 +- 0.00 111.31 +- 0.77 0.00 +- 0.00 27.44 +- 7.21
file-readv-num-successful-operations 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00

Wisconsin

  Wisconsin PAT1 CMSSW_3_3_2 Wisconsin PAT1_RHAUTO_CHAPP_CACHE20 CMSSW_3_3_2 Wisconsin PAT1_RHAUTO_CHAPP_CACHE20 CMSSW_3_3_2_patched4 Wisconsin PAT1_RHAUTO_CHAPP_CACHE20 CMSSW_3_3_2_rootTreePatch
Success 100.0% (20 / 20) 100.0% (20 / 20) 100.0% (20 / 20) 100.0% (20 / 20)
WrapperTime 3327.35 +- 3669.03 1674.85 +- 39.71 2340.10 +- 856.93 3153.55 +- 898.66
ExeTime 3298.15 +- 3670.07 1661.90 +- 39.04 2320.95 +- 852.10 3109.10 +- 882.55
UserTime 1618.79 +- 391.79 1497.20 +- 11.33 2113.72 +- 847.51 2837.66 +- 825.76
CpuPercentage 70.05 +- 23.96 91.45 +- 1.72 91.45 +- 5.55 92.65 +- 2.63
User_ReadkBEvt 89.96 +- 0.26 89.96 +- 0.26 89.96 +- 0.26 89.96 +- 0.26
StageoutTime -1.00 +- 0.00 -1.00 +- 0.00 -1.00 +- 0.00 -1.00 +- 0.00
SysTime 38.58 +- 12.82 29.03 +- 5.30 38.46 +- 17.16 65.70 +- 24.43
MinEventTime // 0.03 +- 0.00 0.04 +- 0.02 0.06 +- 0.02
AvgEventTime // 0.16 +- 0.00 0.23 +- 0.08 0.30 +- 0.09
MaxEventTime // 20.81 +- 4.15 28.99 +- 9.59 43.67 +- 19.32
TotalJobTime // 1614.59 +- 37.41 2271.75 +- 844.72 3042.59 +- 865.99
OPEN
dcap-open-total-megabytes 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00
file-open-total-megabytes 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00
dcap-open-total-msecs 1673.65 +- 2533.49 1344.98 +- 294.79 934.82 +- 182.22 910.35 +- 330.36
file-open-total-msecs 0.28 +- 0.05 0.20 +- 0.03 0.30 +- 0.09 0.37 +- 0.10
dcap-open-num-operations 2.50 +- 0.50 2.50 +- 0.50 2.50 +- 0.50 2.50 +- 0.50
file-open-num-operations 1.00 +- 0.00 1.00 +- 0.00 1.00 +- 0.00 1.00 +- 0.00
dcap-open-num-successful-operations 2.50 +- 0.50 2.50 +- 0.50 2.50 +- 0.50 2.50 +- 0.50
file-open-num-successful-operations 1.00 +- 0.00 1.00 +- 0.00 1.00 +- 0.00 1.00 +- 0.00
READ
tstoragefile-read-actual-total-megabytes 878.52 +- 2.59 49.76 +- 1.61 1437.38 +- 11.68 365.69 +- 148.17
tstoragefile-read-async-total-megabytes // 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00
tstoragefile-read-total-megabytes 878.52 +- 2.59 878.52 +- 2.59 878.52 +- 2.59 878.52 +- 2.59
dcap-read-total-megabytes 878.52 +- 2.59 49.76 +- 1.61 1437.38 +- 11.68 365.69 +- 148.17
file-read-total-megabytes 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00
tstoragefile-read-via-cache-total-megabytes // 828.76 +- 2.60 824.15 +- 2.94 512.83 +- 148.39
tstoragefile-read-actual-total-msecs 1631995.45 +- 3678892.59 29340.17 +- 6010.88 112424.95 +- 35225.41 139802.88 +- 85277.87
tstoragefile-read-async-total-msecs // 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00
tstoragefile-read-total-msecs 1632183.30 +- 3678872.52 115837.72 +- 28556.73 115809.66 +- 35036.44 175547.26 +- 79315.13
dcap-read-total-msecs 1631781.50 +- 3678894.21 29321.81 +- 6010.24 112379.18 +- 35230.71 139602.16 +- 85197.57
file-read-total-msecs 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00
tstoragefile-read-via-cache-total-msecs // 1371.00 +- 41.02 76054.89 +- 22848.60 27416.27 +- 12756.85
tstoragefile-read-actual-num-operations 134683.15 +- 311.18 10308.65 +- 7.33 17720.55 +- 218.43 59502.30 +- 21988.79
tstoragefile-read-actual-num-successful-operations 134683.15 +- 311.18 10308.65 +- 7.33 17720.55 +- 218.43 59502.30 +- 21988.79
tstoragefile-read-async-num-operations // 2.50 +- 0.50 2.50 +- 0.50 2.50 +- 0.50
tstoragefile-read-async-num-successful-operations // 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00
tstoragefile-read-num-operations 134683.15 +- 311.18 134683.15 +- 311.18 134683.15 +- 311.18 134683.15 +- 311.18
dcap-read-num-operations 134683.15 +- 311.18 10308.65 +- 7.33 17720.55 +- 218.43 59502.30 +- 21988.79
file-read-num-operations 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00
tstoragefile-read-num-successful-operations 134683.15 +- 311.18 134683.15 +- 311.18 134683.15 +- 311.18 134683.15 +- 311.18
dcap-read-num-successful-operations 134683.15 +- 311.18 10308.65 +- 7.33 17720.55 +- 218.43 59502.30 +- 21988.79
file-read-num-successful-operations 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00
tstoragefile-read-via-cache-num-operations // 124485.90 +- 314.45 124485.90 +- 314.45 124485.90 +- 314.45
tstoragefile-read-via-cache-num-successful-operations // 124374.50 +- 314.36 123316.10 +- 445.90 75180.85 +- 21833.96
READV
tstoragefile-readv-actual-total-megabytes // 2303.24 +- 20.72 // 551.14 +- 157.24
dcap-readv-total-megabytes 0.00 +- 0.00 2303.24 +- 20.72 0.00 +- 0.00 551.14 +- 157.24
file-readv-total-megabytes 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00
tstoragefile-readv-actual-total-msecs // 86809.03 +- 24583.40 // 33162.23 +- 14808.51
dcap-readv-total-msecs 0.00 +- 0.00 86808.37 +- 24583.26 0.00 +- 0.00 33162.03 +- 14808.48
file-readv-total-msecs 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00
tstoragefile-readv-actual-num-operations // 111.40 +- 0.86 // 28.65 +- 7.93
tstoragefile-readv-actual-num-successful-operations // 111.40 +- 0.86 // 28.65 +- 7.93
dcap-readv-num-operations 0.00 +- 0.00 111.40 +- 0.86 0.00 +- 0.00 28.65 +- 7.93
file-readv-num-operations 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00
dcap-readv-num-successful-operations 0.00 +- 0.00 111.40 +- 0.86 0.00 +- 0.00 28.65 +- 7.93
file-readv-num-successful-operations 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00 0.00 +- 0.00
Edit | Attach | Watch | Print version | History: r4 < r3 < r2 < r1 | Backlinks | Raw View | WYSIWYG | More topic actions
Topic revision: r4 - 2010-05-13 - BrianBockelman
 
    • Cern Search Icon Cern Search
    • TWiki Search Icon TWiki Search
    • Google Search Icon Google Search

    Main All webs login

This site is powered by the TWiki collaboration platform Powered by PerlCopyright &© 2008-2024 by the contributing authors. All material on this collaboration platform is the property of the contributing authors.
or Ideas, requests, problems regarding TWiki? use Discourse or Send feedback