nytprof run results of /variantgraph/<ID> and /relation/<ID>/relationships
[scpubgit/stemmatology.git] / stemmaweb / nytprof-runs / variantgraph-uuid / Opcode-pm-726-line.html
diff --git a/stemmaweb/nytprof-runs/variantgraph-uuid/Opcode-pm-726-line.html b/stemmaweb/nytprof-runs/variantgraph-uuid/Opcode-pm-726-line.html
new file mode 100644 (file)
index 0000000..97af74e
--- /dev/null
@@ -0,0 +1,306 @@
+    <!DOCTYPE html PUBLIC "-//W3C//DTD XHTML 1.0 Transitional//EN" "http://www.w3.org/TR/xhtml1/DTD/xhtml1-transitional.dtd">
+    <html xmlns="http://www.w3.org/1999/xhtml">
+<!--
+This file was generated by Devel::NYTProf version 4.06
+-->
+<head>
+    <meta http-equiv="Content-Type" content="text/html; charset=utf-8" />
+    <meta http-equiv="Content-Language" content="en-us" />
+    <title>Profile of Opcode.pm</title>
+<link rel="stylesheet" type="text/css" href="style.css" />
+    <script type="text/javascript" src="js/jquery-min.js"></script> 
+
+    <script type="text/javascript" src="js/jquery-tablesorter-min.js"></script> 
+    <link rel="stylesheet" type="text/css" href="js/style-tablesorter.css" />
+    <script type="text/javascript">
+    // when a column is first clicked on to sort it, use descending order
+    // XXX doesn't seem to work (and not just because the tablesorter formatSortingOrder() is broken)
+    $.tablesorter.defaults.sortInitialOrder = "desc";
+    // add parser through the tablesorter addParser method 
+    $.tablesorter.addParser({
+        id: 'fmt_time',   // name of this parser
+        is: function(s) { 
+            return false; // return false so this parser is not auto detected 
+        }, 
+        format: function(orig) { // format data for normalization 
+            // console.log(orig);
+            val = orig.replace(/ns/,'');
+            if (val != orig) { return val / (1000*1000*1000); } 
+            val = orig.replace(/µs/,''); /* XXX use &micro; ? */
+            if (val != orig) { return val / (1000*1000); } 
+            var val = orig.replace(/ms/,'');
+            if (val != orig) { return val / (1000); }
+            var val = orig.replace(/s/,'');
+            if (val != orig) { return val; }
+            if (orig == '0') { return orig; } 
+            console.log('no match for fmt_time of '.concat(orig));
+            return orig;
+        },
+        type: 'numeric' // set type, either numeric or text 
+    }); 
+    </script> 
+</head>
+
+<body > 
+<div class="header" style="position: relative; overflow-x: hidden; overflow-y: hidden; z-index: 0; ">
+<div class="header_back">
+            <a href="index.html">&larr; Index</a>
+        </div>
+<div class="headerForeground" style="float: left">
+    <span class="siteTitle">NYTProf Performance Profile</span>
+    <span class="siteSubtitle">&emsp;&emsp;<span>&laquo;&emsp;<span class="mode_btn"><a href="Opcode-pm-726-block.html">block view</a></span>&emsp;&bull;&emsp;<span class="mode_btn mode_btn_selected">line view</span>&emsp;&bull;&emsp;<span class="mode_btn"><a href="Opcode-pm-726-sub.html">sub view</a></span>&emsp;&raquo;</span><br />
+            For script/nytprof.pl
+        </span>
+</div>
+<div class="headerForeground" style="float: right; text-align: right">
+    <span class="siteTitle">&nbsp;</span>
+    <span class="siteSubtitle">Run on Thu May 31 16:29:39 2012<br />Reported on Thu May 31 16:39:20 2012</span>
+</div>
+<div style="position: absolute; left: 0px; top: 0%; width: 100%; height: 101%; z-index: -1; background-color: rgb(17, 136, 255); "></div>
+<div style="position: absolute; left: 0px; top: 2%; width: 100%; height: 99%; z-index: -1; background-color: rgb(16, 134, 253); "></div>
+<div style="position: absolute; left: 0px; top: 4%; width: 100%; height: 97%; z-index: -1; background-color: rgb(16, 133, 252); "></div>
+<div style="position: absolute; left: 0px; top: 6%; width: 100%; height: 95%; z-index: -1; background-color: rgb(15, 131, 250); "></div>
+<div style="position: absolute; left: 0px; top: 8%; width: 100%; height: 93%; z-index: -1; background-color: rgb(15, 130, 249); "></div>
+<div style="position: absolute; left: 0px; top: 10%; width: 100%; height: 91%; z-index: -1; background-color: rgb(15, 129, 248); "></div>
+<div style="position: absolute; left: 0px; top: 12%; width: 100%; height: 89%; z-index: -1; background-color: rgb(14, 127, 246); "></div>
+<div style="position: absolute; left: 0px; top: 14%; width: 100%; height: 87%; z-index: -1; background-color: rgb(14, 126, 245); "></div>
+<div style="position: absolute; left: 0px; top: 16%; width: 100%; height: 85%; z-index: -1; background-color: rgb(14, 125, 244); "></div>
+<div style="position: absolute; left: 0px; top: 18%; width: 100%; height: 83%; z-index: -1; background-color: rgb(13, 123, 242); "></div>
+<div style="position: absolute; left: 0px; top: 20%; width: 100%; height: 81%; z-index: -1; background-color: rgb(13, 122, 241); "></div>
+<div style="position: absolute; left: 0px; top: 22%; width: 100%; height: 79%; z-index: -1; background-color: rgb(13, 121, 240); "></div>
+<div style="position: absolute; left: 0px; top: 24%; width: 100%; height: 77%; z-index: -1; background-color: rgb(12, 119, 238); "></div>
+<div style="position: absolute; left: 0px; top: 26%; width: 100%; height: 75%; z-index: -1; background-color: rgb(12, 118, 237); "></div>
+<div style="position: absolute; left: 0px; top: 28%; width: 100%; height: 73%; z-index: -1; background-color: rgb(12, 116, 235); "></div>
+<div style="position: absolute; left: 0px; top: 30%; width: 100%; height: 71%; z-index: -1; background-color: rgb(11, 115, 234); "></div>
+<div style="position: absolute; left: 0px; top: 32%; width: 100%; height: 69%; z-index: -1; background-color: rgb(11, 114, 233); "></div>
+<div style="position: absolute; left: 0px; top: 34%; width: 100%; height: 67%; z-index: -1; background-color: rgb(11, 112, 231); "></div>
+<div style="position: absolute; left: 0px; top: 36%; width: 100%; height: 65%; z-index: -1; background-color: rgb(10, 111, 230); "></div>
+<div style="position: absolute; left: 0px; top: 38%; width: 100%; height: 63%; z-index: -1; background-color: rgb(10, 110, 229); "></div>
+<div style="position: absolute; left: 0px; top: 40%; width: 100%; height: 61%; z-index: -1; background-color: rgb(10, 108, 227); "></div>
+<div style="position: absolute; left: 0px; top: 42%; width: 100%; height: 59%; z-index: -1; background-color: rgb(9, 107, 226); "></div>
+<div style="position: absolute; left: 0px; top: 44%; width: 100%; height: 57%; z-index: -1; background-color: rgb(9, 106, 225); "></div>
+<div style="position: absolute; left: 0px; top: 46%; width: 100%; height: 55%; z-index: -1; background-color: rgb(9, 104, 223); "></div>
+<div style="position: absolute; left: 0px; top: 48%; width: 100%; height: 53%; z-index: -1; background-color: rgb(8, 103, 222); "></div>
+<div style="position: absolute; left: 0px; top: 50%; width: 100%; height: 51%; z-index: -1; background-color: rgb(8, 102, 221); "></div>
+<div style="position: absolute; left: 0px; top: 52%; width: 100%; height: 49%; z-index: -1; background-color: rgb(8, 100, 219); "></div>
+<div style="position: absolute; left: 0px; top: 54%; width: 100%; height: 47%; z-index: -1; background-color: rgb(7, 99, 218); "></div>
+<div style="position: absolute; left: 0px; top: 56%; width: 100%; height: 45%; z-index: -1; background-color: rgb(7, 97, 216); "></div>
+<div style="position: absolute; left: 0px; top: 58%; width: 100%; height: 43%; z-index: -1; background-color: rgb(7, 96, 215); "></div>
+<div style="position: absolute; left: 0px; top: 60%; width: 100%; height: 41%; z-index: -1; background-color: rgb(6, 95, 214); "></div>
+<div style="position: absolute; left: 0px; top: 62%; width: 100%; height: 39%; z-index: -1; background-color: rgb(6, 93, 212); "></div>
+<div style="position: absolute; left: 0px; top: 64%; width: 100%; height: 37%; z-index: -1; background-color: rgb(6, 92, 211); "></div>
+<div style="position: absolute; left: 0px; top: 66%; width: 100%; height: 35%; z-index: -1; background-color: rgb(5, 91, 210); "></div>
+<div style="position: absolute; left: 0px; top: 68%; width: 100%; height: 33%; z-index: -1; background-color: rgb(5, 89, 208); "></div>
+<div style="position: absolute; left: 0px; top: 70%; width: 100%; height: 31%; z-index: -1; background-color: rgb(5, 88, 207); "></div>
+<div style="position: absolute; left: 0px; top: 72%; width: 100%; height: 29%; z-index: -1; background-color: rgb(4, 87, 206); "></div>
+<div style="position: absolute; left: 0px; top: 74%; width: 100%; height: 27%; z-index: -1; background-color: rgb(4, 85, 204); "></div>
+<div style="position: absolute; left: 0px; top: 76%; width: 100%; height: 25%; z-index: -1; background-color: rgb(4, 84, 203); "></div>
+<div style="position: absolute; left: 0px; top: 78%; width: 100%; height: 23%; z-index: -1; background-color: rgb(3, 82, 201); "></div>
+<div style="position: absolute; left: 0px; top: 80%; width: 100%; height: 21%; z-index: -1; background-color: rgb(3, 81, 200); "></div>
+<div style="position: absolute; left: 0px; top: 82%; width: 100%; height: 19%; z-index: -1; background-color: rgb(3, 80, 199); "></div>
+<div style="position: absolute; left: 0px; top: 84%; width: 100%; height: 17%; z-index: -1; background-color: rgb(2, 78, 197); "></div>
+<div style="position: absolute; left: 0px; top: 86%; width: 100%; height: 15%; z-index: -1; background-color: rgb(2, 77, 196); "></div>
+<div style="position: absolute; left: 0px; top: 88%; width: 100%; height: 13%; z-index: -1; background-color: rgb(2, 76, 195); "></div>
+<div style="position: absolute; left: 0px; top: 90%; width: 100%; height: 11%; z-index: -1; background-color: rgb(1, 74, 193); "></div>
+<div style="position: absolute; left: 0px; top: 92%; width: 100%; height: 9%; z-index: -1; background-color: rgb(1, 73, 192); "></div>
+<div style="position: absolute; left: 0px; top: 94%; width: 100%; height: 7%; z-index: -1; background-color: rgb(1, 72, 191); "></div>
+<div style="position: absolute; left: 0px; top: 96%; width: 100%; height: 5%; z-index: -1; background-color: rgb(0, 70, 189); "></div>
+<div style="position: absolute; left: 0px; top: 98%; width: 100%; height: 3%; z-index: -1; background-color: rgb(0, 69, 188); "></div>
+<div style="position: absolute; left: 0px; top: 100%; width: 100%; height: 1%; z-index: -1; background-color: rgb(0, 68, 187); "></div>
+</div>
+
+<div class="body_content"><br />
+<table class="file_summary"><tr><td class="h">Filename</td><td align="left"><a href="file:///opt/local/lib/perl5/5.14.2/darwin-multi-2level/Opcode.pm">/opt/local/lib/perl5/5.14.2/darwin-multi-2level/Opcode.pm</a></td></tr>
+<tr><td class="h">Statements</td><td align="left">Executed 1794 statements in 3.19ms</td></tr></table>
+        
+        <table id="subs_table" border="1" cellpadding="0" class="tablesorter">
+        <caption>Subroutines</caption>
+        <thead>
+        <tr>
+        <th>Calls</th>
+        <th><span title="Number of Places sub is called from">P</span></th>
+        <th><span title="Number of Files sub is called from">F</span></th>
+        <th>Exclusive<br />Time</th>
+        <th>Inclusive<br />Time</th>
+        <th>Subroutine</th>
+        </tr>
+        </thead>
+    <tbody>
+<tr><td class="c3">1</td><td class="c3">1</td><td class="c3">1</td><td class="c0"><span title="0.0%">1.94ms</span></td><td class="c0"><span title="0.0%">2.34ms</span></td><td class="sub_name"><span style="display: none;">Opcode::::_init_optags</span>Opcode::<a href="Opcode-pm-726-line.html#54">_init_optags</a></span></td></tr>
+<tr><td class="c0">316</td><td class="c1">2</td><td class="c3">1</td><td class="c0"><span title="0.0%">123&micro;s</span></td><td class="c0"><span title="0.0%">123&micro;s</span></td><td class="sub_name"><span style="display: none;">Opcode::::CORE:match</span>Opcode::<a href="Opcode-pm-726-line.html#Opcode__CORE_match">CORE:match</a>&nbsp;(opcode)</span></td></tr>
+<tr><td class="c0">28</td><td class="c0">3</td><td class="c3">1</td><td class="c0"><span title="0.0%">66&micro;s</span></td><td class="c2"><span title="0.0%">66&micro;s</span></td><td class="sub_name"><span style="display: none;">Opcode::::CORE:readline</span>Opcode::<a href="Opcode-pm-726-line.html#Opcode__CORE_readline">CORE:readline</a>&nbsp;(opcode)</span></td></tr>
+<tr><td class="c0">19</td><td class="c3">1</td><td class="c3">1</td><td class="c0"><span title="0.0%">64&micro;s</span></td><td class="c2"><span title="0.0%">64&micro;s</span></td><td class="sub_name"><span style="display: none;">Opcode::::opset</span>Opcode::<a href="Opcode-pm-726-line.html#Opcode__opset">opset</a>&nbsp;(xsub)</span></td></tr>
+<tr><td class="c3">1</td><td class="c3">1</td><td class="c3">1</td><td class="c0"><span title="0.0%">60&micro;s</span></td><td class="c3"><span title="0.0%">60&micro;s</span></td><td class="sub_name"><span style="display: none;">Opcode::::opset_to_ops</span>Opcode::<a href="Opcode-pm-726-line.html#Opcode__opset_to_ops">opset_to_ops</a>&nbsp;(xsub)</span></td></tr>
+<tr><td class="c0">101</td><td class="c3">1</td><td class="c3">1</td><td class="c1"><span title="0.0%">46&micro;s</span></td><td class="c3"><span title="0.0%">46&micro;s</span></td><td class="sub_name"><span style="display: none;">Opcode::::CORE:subst</span>Opcode::<a href="Opcode-pm-726-line.html#Opcode__CORE_subst">CORE:subst</a>&nbsp;(opcode)</span></td></tr>
+<tr><td class="c3">1</td><td class="c3">1</td><td class="c3">1</td><td class="c3"><span title="0.0%">26&micro;s</span></td><td class="c3"><span title="0.0%">26&micro;s</span></td><td class="sub_name"><span style="display: none;">Opcode::::BEGIN@3</span>Opcode::<a href="Opcode-pm-726-line.html#3">BEGIN@3</a></span></td></tr>
+<tr><td class="c0">19</td><td class="c3">1</td><td class="c3">1</td><td class="c3"><span title="0.0%">21&micro;s</span></td><td class="c3"><span title="0.0%">21&micro;s</span></td><td class="sub_name"><span style="display: none;">Opcode::::define_optag</span>Opcode::<a href="Opcode-pm-726-line.html#Opcode__define_optag">define_optag</a>&nbsp;(xsub)</span></td></tr>
+<tr><td class="c3">1</td><td class="c3">1</td><td class="c3">1</td><td class="c3"><span title="0.0%">19&micro;s</span></td><td class="c3"><span title="0.0%">19&micro;s</span></td><td class="sub_name"><span style="display: none;">Opcode::::BEGIN@15</span>Opcode::<a href="Opcode-pm-726-line.html#15">BEGIN@15</a></span></td></tr>
+<tr><td class="c3">1</td><td class="c3">1</td><td class="c3">1</td><td class="c3"><span title="0.0%">15&micro;s</span></td><td class="c3"><span title="0.0%">15&micro;s</span></td><td class="sub_name"><span style="display: none;">Opcode::::CORE:close</span>Opcode::<a href="Opcode-pm-726-line.html#Opcode__CORE_close">CORE:close</a>&nbsp;(opcode)</span></td></tr>
+<tr><td class="c3">1</td><td class="c3">1</td><td class="c3">1</td><td class="c3"><span title="0.0%">10&micro;s</span></td><td class="c1"><span title="0.0%">89&micro;s</span></td><td class="sub_name"><span style="display: none;">Opcode::::BEGIN@29</span>Opcode::<a href="Opcode-pm-726-line.html#29">BEGIN@29</a></span></td></tr>
+<tr><td class="c3">1</td><td class="c3">1</td><td class="c3">1</td><td class="c3"><span title="0.0%">9&micro;s</span></td><td class="c3"><span title="0.0%">12&micro;s</span></td><td class="sub_name"><span style="display: none;">Opcode::::BEGIN@5</span>Opcode::<a href="Opcode-pm-726-line.html#5">BEGIN@5</a></span></td></tr>
+<tr><td class="c3">1</td><td class="c3">1</td><td class="c3">1</td><td class="c3"><span title="0.0%">9&micro;s</span></td><td class="c3"><span title="0.0%">48&micro;s</span></td><td class="sub_name"><span style="display: none;">Opcode::::BEGIN@11</span>Opcode::<a href="Opcode-pm-726-line.html#11">BEGIN@11</a></span></td></tr>
+<tr><td class="c3">1</td><td class="c3">1</td><td class="c3">1</td><td class="c3"><span title="0.0%">5&micro;s</span></td><td class="c3"><span title="0.0%">5&micro;s</span></td><td class="sub_name"><span style="display: none;">Opcode::::BEGIN@13</span>Opcode::<a href="Opcode-pm-726-line.html#13">BEGIN@13</a></span></td></tr>
+<tr><td class="c3">1</td><td class="c3">1</td><td class="c3">1</td><td class="c3"><span title="0.0%">4&micro;s</span></td><td class="c3"><span title="0.0%">4&micro;s</span></td><td class="sub_name"><span style="display: none;">Opcode::::BEGIN@12</span>Opcode::<a href="Opcode-pm-726-line.html#12">BEGIN@12</a></span></td></tr>
+<tr><td class="c3">1</td><td class="c3">1</td><td class="c3">1</td><td class="c3"><span title="0.0%">2&micro;s</span></td><td class="c3"><span title="0.0%">2&micro;s</span></td><td class="sub_name"><span style="display: none;">Opcode::::full_opset</span>Opcode::<a href="Opcode-pm-726-line.html#Opcode__full_opset">full_opset</a>&nbsp;(xsub)</span></td></tr>
+<tr><td class="c3">0</td><td class="c3">0</td><td class="c3">0</td><td class="c3"><span title="0.0%">0s</span></td><td class="c3"><span title="0.0%">0s</span></td><td class="sub_name"><span style="display: none;">Opcode::::opdump</span>Opcode::<a href="Opcode-pm-726-line.html#42">opdump</a></span></td></tr>
+<tr><td class="c3">0</td><td class="c3">0</td><td class="c3">0</td><td class="c3"><span title="0.0%">0s</span></td><td class="c3"><span title="0.0%">0s</span></td><td class="sub_name"><span style="display: none;">Opcode::::ops_to_opset</span>Opcode::<a href="Opcode-pm-726-line.html#35">ops_to_opset</a></span></td></tr>
+<tr><td class="c3">0</td><td class="c3">0</td><td class="c3">0</td><td class="c3"><span title="0.0%">0s</span></td><td class="c3"><span title="0.0%">0s</span></td><td class="sub_name"><span style="display: none;">Opcode::::opset_to_hex</span>Opcode::<a href="Opcode-pm-726-line.html#37">opset_to_hex</a></span></td></tr>
+</tbody></table>
+                Call graph for these subroutines as a
+                <a href="http://en.wikipedia.org/wiki/Graphviz">Graphviz</a>
+                <a href="opt-local-lib-perl5-5-14-2-darwin-multi-2level-Opcode-pm.dot">dot language file</a>.
+            
+      <table border="1" cellpadding="0">
+      <thead>
+      <tr><th>Line</th>
+      <th><span title="Number of statements executed">State<br />ments</span></th>
+      <th><span title="Time spend executing statements on the line,
+        excluding time spent executing statements in any called subroutines">Time<br />on line</span></th>
+      <th><span title="Number of subroutines calls">Calls</span></th>
+      <th><span title="Time spent in subroutines called (inclusive)">Time<br />in subs</span></th>
+      <th class="left_indent_header">Code</th>
+      </tr>
+
+      </thead>
+      <tbody>
+    <tr><td class="h"><a name="1"></a>1</td><td></td><td></td><td></td><td></td><td class="s">package Opcode;</td></tr>
+<tr><td class="h"><a name="2"></a>2</td><td></td><td></td><td></td><td></td><td class="s"></td></tr>
+<tr><td class="h"><a name="3"></a>3</td><td class="c1">2</td><td class="c3"><span title="Avg 25&micro;s">50&micro;s</span></td><td class="c3">1</td><td class="c3">26&micro;s</td><td class="s"><div class="calls"><div class="calls_in"># spent 26&micro;s within Opcode::BEGIN@3 which was called:
+#    once (26&micro;s+0s) by Safe::BEGIN@46 at <a href="Opcode-pm-726-line.html#3">line 3</a></div></div>use 5.006_001;<div class="calls"><div class="calls_out"># spent    26&micro;s making 1 call to <a href="Opcode-pm-726-line.html#3">Opcode::BEGIN@3</a></div></div></td></tr>
+<tr><td class="h"><a name="4"></a>4</td><td></td><td></td><td></td><td></td><td class="s"></td></tr>
+<tr><td class="h"><a name="5"></a>5</td><td class="c1">2</td><td class="c2"><span title="Avg 26&micro;s">53&micro;s</span></td><td class="c3">2</td><td class="c3">15&micro;s</td><td class="s"><div class="calls"><div class="calls_in"># spent 12&micro;s (9+3) within Opcode::BEGIN@5 which was called:
+#    once (9&micro;s+3&micro;s) by Safe::BEGIN@46 at <a href="Opcode-pm-726-line.html#5">line 5</a></div></div>use strict;<div class="calls"><div class="calls_out"># spent    12&micro;s making 1 call to <a href="Opcode-pm-726-line.html#5">Opcode::BEGIN@5</a>
+# spent     3&micro;s making 1 call to <a href="strict-pm-3-line.html#34">strict::import</a></div></div></td></tr>
+<tr><td class="h"><a name="6"></a>6</td><td></td><td></td><td></td><td></td><td class="s"></td></tr>
+<tr><td class="h"><a name="7"></a>7</td><td class="c3">1</td><td class="c3"><span title="Avg 400ns">400ns</span></td><td></td><td></td><td class="s">our($VERSION, @ISA, @EXPORT_OK);</td></tr>
+<tr><td class="h"><a name="8"></a>8</td><td></td><td></td><td></td><td></td><td class="s"></td></tr>
+<tr><td class="h"><a name="9"></a>9</td><td class="c3">1</td><td class="c3"><span title="Avg 500ns">500ns</span></td><td></td><td></td><td class="s">$VERSION = &quot;1.18&quot;;</td></tr>
+<tr><td class="h"><a name="10"></a>10</td><td></td><td></td><td></td><td></td><td class="s"></td></tr>
+<tr><td class="h"><a name="11"></a>11</td><td class="c1">2</td><td class="c3"><span title="Avg 12&micro;s">24&micro;s</span></td><td class="c3">2</td><td class="c1">87&micro;s</td><td class="s"><div class="calls"><div class="calls_in"># spent 48&micro;s (9+39) within Opcode::BEGIN@11 which was called:
+#    once (9&micro;s+39&micro;s) by Safe::BEGIN@46 at <a href="Opcode-pm-726-line.html#11">line 11</a></div></div>use Carp;<div class="calls"><div class="calls_out"># spent    48&micro;s making 1 call to <a href="Opcode-pm-726-line.html#11">Opcode::BEGIN@11</a>
+# spent    39&micro;s making 1 call to <a href="Exporter-pm-8-line.html#28">Exporter::import</a></div></div></td></tr>
+<tr><td class="h"><a name="12"></a>12</td><td class="c1">2</td><td class="c3"><span title="Avg 10&micro;s">20&micro;s</span></td><td class="c3">1</td><td class="c3">4&micro;s</td><td class="s"><div class="calls"><div class="calls_in"># spent 4&micro;s within Opcode::BEGIN@12 which was called:
+#    once (4&micro;s+0s) by Safe::BEGIN@46 at <a href="Opcode-pm-726-line.html#12">line 12</a></div></div>use Exporter ();<div class="calls"><div class="calls_out"># spent     4&micro;s making 1 call to <a href="Opcode-pm-726-line.html#12">Opcode::BEGIN@12</a></div></div></td></tr>
+<tr><td class="h"><a name="13"></a>13</td><td class="c1">2</td><td class="c3"><span title="Avg 26&micro;s">51&micro;s</span></td><td class="c3">1</td><td class="c3">5&micro;s</td><td class="s"><div class="calls"><div class="calls_in"># spent 5&micro;s within Opcode::BEGIN@13 which was called:
+#    once (5&micro;s+0s) by Safe::BEGIN@46 at <a href="Opcode-pm-726-line.html#13">line 13</a></div></div>use XSLoader;<div class="calls"><div class="calls_out"># spent     5&micro;s making 1 call to <a href="Opcode-pm-726-line.html#13">Opcode::BEGIN@13</a></div></div></td></tr>
+<tr><td class="h"><a name="14"></a>14</td><td></td><td></td><td></td><td></td><td class="s"></td></tr>
+<tr><td class="h"><a name="15"></a>15</td><td></td><td></td><td></td><td></td><td class="s"><div class="calls"><div class="calls_in"># spent 19&micro;s within Opcode::BEGIN@15 which was called:
+#    once (19&micro;s+0s) by Safe::BEGIN@46 at <a href="Opcode-pm-726-line.html#24">line 24</a></div></div>BEGIN {</td></tr>
+<tr><td class="h"><a name="16"></a>16</td><td class="c3">1</td><td class="c3"><span title="Avg 12&micro;s">12&micro;s</span></td><td></td><td></td><td class="s">    @ISA = qw(Exporter);</td></tr>
+<tr><td class="h"><a name="17"></a>17</td><td class="c3">1</td><td class="c3"><span title="Avg 7&micro;s">7&micro;s</span></td><td></td><td></td><td class="s">    @EXPORT_OK = qw(</td></tr>
+<tr><td class="h"><a name="18"></a>18</td><td></td><td></td><td></td><td></td><td class="s">        opset ops_to_opset</td></tr>
+<tr><td class="h"><a name="19"></a>19</td><td></td><td></td><td></td><td></td><td class="s">        opset_to_ops opset_to_hex invert_opset</td></tr>
+<tr><td class="h"><a name="20"></a>20</td><td></td><td></td><td></td><td></td><td class="s">        empty_opset full_opset</td></tr>
+<tr><td class="h"><a name="21"></a>21</td><td></td><td></td><td></td><td></td><td class="s">        opdesc opcodes opmask define_optag</td></tr>
+<tr><td class="h"><a name="22"></a>22</td><td></td><td></td><td></td><td></td><td class="s">        opmask_add verify_opset opdump</td></tr>
+<tr><td class="h"><a name="23"></a>23</td><td></td><td></td><td></td><td></td><td class="s">    );</td></tr>
+<tr><td class="h"><a name="24"></a>24</td><td class="c3">1</td><td class="c3"><span title="Avg 43&micro;s">43&micro;s</span></td><td class="c3">1</td><td class="c3">19&micro;s</td><td class="s">}<div class="calls"><div class="calls_out"># spent    19&micro;s making 1 call to <a href="Opcode-pm-726-line.html#15">Opcode::BEGIN@15</a></div></div></td></tr>
+<tr><td class="h"><a name="25"></a>25</td><td></td><td></td><td></td><td></td><td class="s"></td></tr>
+<tr><td class="h"><a name="26"></a>26</td><td></td><td></td><td></td><td></td><td class="s">sub opset (;@);</td></tr>
+<tr><td class="h"><a name="27"></a>27</td><td></td><td></td><td></td><td></td><td class="s">sub opset_to_hex ($);</td></tr>
+<tr><td class="h"><a name="28"></a>28</td><td></td><td></td><td></td><td></td><td class="s">sub opdump (;$);</td></tr>
+<tr><td class="h"><a name="29"></a>29</td><td class="c1">2</td><td class="c0"><span title="Avg 192&micro;s">385&micro;s</span></td><td class="c3">2</td><td class="c0">169&micro;s</td><td class="s"><div class="calls"><div class="calls_in"># spent 89&micro;s (10+80) within Opcode::BEGIN@29 which was called:
+#    once (10&micro;s+80&micro;s) by Safe::BEGIN@46 at <a href="Opcode-pm-726-line.html#29">line 29</a></div></div>use subs @EXPORT_OK;<div class="calls"><div class="calls_out"># spent    89&micro;s making 1 call to <a href="Opcode-pm-726-line.html#29">Opcode::BEGIN@29</a>
+# spent    80&micro;s making 1 call to <a href="subs-pm-473-line.html#31">subs::import</a></div></div></td></tr>
+<tr><td class="h"><a name="30"></a>30</td><td></td><td></td><td></td><td></td><td class="s"></td></tr>
+<tr><td class="h"><a name="31"></a>31</td><td class="c3">1</td><td class="c0"><span title="Avg 453&micro;s">453&micro;s</span></td><td class="c3">1</td><td class="c0">444&micro;s</td><td class="s">XSLoader::load();<div class="calls"><div class="calls_out"># spent   444&micro;s making 1 call to <a href="XSLoader-pm-681-line.html#20">XSLoader::load</a></div></div></td></tr>
+<tr><td class="h"><a name="32"></a>32</td><td></td><td></td><td></td><td></td><td class="s"></td></tr>
+<tr><td class="h"><a name="33"></a>33</td><td class="c3">1</td><td class="c3"><span title="Avg 2&micro;s">2&micro;s</span></td><td class="c3">1</td><td class="c0">2.34ms</td><td class="s">_init_optags();<div class="calls"><div class="calls_out"># spent  2.34ms making 1 call to <a href="Opcode-pm-726-line.html#54">Opcode::_init_optags</a></div></div></td></tr>
+<tr><td class="h"><a name="34"></a>34</td><td></td><td></td><td></td><td></td><td class="s"></td></tr>
+<tr><td class="h"><a name="35"></a>35</td><td></td><td></td><td></td><td></td><td class="s">sub ops_to_opset { opset @_ }        # alias for old name</td></tr>
+<tr><td class="h"><a name="36"></a>36</td><td></td><td></td><td></td><td></td><td class="s"></td></tr>
+<tr><td class="h"><a name="37"></a>37</td><td></td><td></td><td></td><td></td><td class="s">sub opset_to_hex ($) {</td></tr>
+<tr><td class="h"><a name="38"></a>38</td><td></td><td></td><td></td><td></td><td class="s">    return &quot;(invalid opset)&quot; unless verify_opset($_[0]);</td></tr>
+<tr><td class="h"><a name="39"></a>39</td><td></td><td></td><td></td><td></td><td class="s">    unpack(&quot;h*&quot;,$_[0]);</td></tr>
+<tr><td class="h"><a name="40"></a>40</td><td></td><td></td><td></td><td></td><td class="s">}</td></tr>
+<tr><td class="h"><a name="41"></a>41</td><td></td><td></td><td></td><td></td><td class="s"></td></tr>
+<tr><td class="h"><a name="42"></a>42</td><td></td><td></td><td></td><td></td><td class="s">sub opdump (;$) {</td></tr>
+<tr><td class="h"><a name="43"></a>43</td><td></td><td></td><td></td><td></td><td class="s">        my $pat = shift;</td></tr>
+<tr><td class="h"><a name="44"></a>44</td><td></td><td></td><td></td><td></td><td class="s">    # handy utility: perl -MOpcode=opdump -e 'opdump File'</td></tr>
+<tr><td class="h"><a name="45"></a>45</td><td></td><td></td><td></td><td></td><td class="s">    foreach(opset_to_ops(full_opset)) {</td></tr>
+<tr><td class="h"><a name="46"></a>46</td><td></td><td></td><td></td><td></td><td class="s">        my $op = sprintf &quot;  %12s  %s\n&quot;, $_, opdesc($_);</td></tr>
+<tr><td class="h"><a name="47"></a>47</td><td></td><td></td><td></td><td></td><td class="s">                next if defined $pat and $op !~ m/$pat/i;</td></tr>
+<tr><td class="h"><a name="48"></a>48</td><td></td><td></td><td></td><td></td><td class="s">                print $op;</td></tr>
+<tr><td class="h"><a name="49"></a>49</td><td></td><td></td><td></td><td></td><td class="s">    }</td></tr>
+<tr><td class="h"><a name="50"></a>50</td><td></td><td></td><td></td><td></td><td class="s">}</td></tr>
+<tr><td class="h"><a name="51"></a>51</td><td></td><td></td><td></td><td></td><td class="s"></td></tr>
+<tr><td class="h"><a name="- -"></a>- -</td><td></td><td></td><td></td><td></td><td class="s"></td></tr>
+<tr><td class="h"><a name="54"></a>54</td><td></td><td></td><td></td><td></td><td class="s"><div class="calls"><div class="calls_in"># spent 2.34ms (1.94+397&micro;s) within Opcode::_init_optags which was called:
+#    once (1.94ms+397&micro;s) by Safe::BEGIN@46 at <a href="Opcode-pm-726-line.html#33">line 33</a></div></div>sub _init_optags {</td></tr>
+<tr><td class="h"><a name="55"></a>55</td><td class="c3">1</td><td class="c3"><span title="Avg 200ns">200ns</span></td><td></td><td></td><td class="s">    my(%all, %seen);</td></tr>
+<tr><td class="h"><a name="56"></a>56</td><td class="c3">1</td><td class="c0"><span title="Avg 167&micro;s">167&micro;s</span></td><td class="c3">2</td><td class="c3">62&micro;s</td><td class="s">    @all{opset_to_ops(full_opset)} = (); # keys only<div class="calls"><div class="calls_out">    # spent    60&micro;s making 1 call to <a href="Opcode-pm-726-line.html#Opcode__opset_to_ops">Opcode::opset_to_ops</a>
+    # spent     2&micro;s making 1 call to <a href="Opcode-pm-726-line.html#Opcode__full_opset">Opcode::full_opset</a></div></div></td></tr>
+<tr><td class="h"><a name="57"></a>57</td><td></td><td></td><td></td><td></td><td class="s"></td></tr>
+<tr><td class="h"><a name="58"></a>58</td><td class="c3">1</td><td class="c3"><span title="Avg 300ns">300ns</span></td><td></td><td></td><td class="s">    local($_);</td></tr>
+<tr><td class="h"><a name="59"></a>59</td><td class="c3">1</td><td class="c3"><span title="Avg 3&micro;s">3&micro;s</span></td><td></td><td></td><td class="s">    local($/) = &quot;\n=cut&quot;; # skip to optags definition section</td></tr>
+<tr><td class="h"><a name="60"></a>60</td><td class="c3">1</td><td class="c3"><span title="Avg 35&micro;s">35&micro;s</span></td><td class="c3">1</td><td class="c3">29&micro;s</td><td class="s">    &lt;DATA&gt;;<div class="calls"><div class="calls_out">    # spent    29&micro;s making 1 call to <a href="Opcode-pm-726-line.html#Opcode__CORE_readline">Opcode::CORE:readline</a></div></div></td></tr>
+<tr><td class="h"><a name="61"></a>61</td><td class="c3">1</td><td class="c3"><span title="Avg 1&micro;s">1&micro;s</span></td><td></td><td></td><td class="s">    $/ = &quot;\n=&quot;;                # now read in 'pod section' chunks</td></tr>
+<tr><td class="h"><a name="62"></a>62</td><td class="c3">1</td><td class="c3"><span title="Avg 31&micro;s">31&micro;s</span></td><td class="c0">8</td><td class="c3">19&micro;s</td><td class="s">    while(&lt;DATA&gt;) {<div class="calls"><div class="calls_out">    # spent    19&micro;s making 8 calls to <a href="Opcode-pm-726-line.html#Opcode__CORE_readline">Opcode::CORE:readline</a>, avg 2&micro;s/call</div></div></td></tr>
+<tr><td class="h"><a name="63"></a>63</td><td class="c0">26</td><td class="c1"><span title="Avg 3&micro;s">84&micro;s</span></td><td class="c0">26</td><td class="c3">47&micro;s</td><td class="s">        next unless m/^item\s+(:\w+)/;<div class="calls"><div class="calls_out">        # spent    47&micro;s making 26 calls to <a href="Opcode-pm-726-line.html#Opcode__CORE_match">Opcode::CORE:match</a>, avg 2&micro;s/call</div></div></td></tr>
+<tr><td class="h"><a name="64"></a>64</td><td class="c0">19</td><td class="c3"><span title="Avg 916ns">17&micro;s</span></td><td></td><td></td><td class="s">        my $tag = $1;</td></tr>
+<tr><td class="h"><a name="65"></a>65</td><td></td><td></td><td></td><td></td><td class="s"></td></tr>
+<tr><td class="h"><a name="66"></a>66</td><td></td><td></td><td></td><td></td><td class="s">        # Split into lines, keep only indented lines</td></tr>
+<tr><td class="h"><a name="67"></a>67</td><td class="c0">309</td><td class="c0"><span title="Avg 2&micro;s">688&micro;s</span></td><td class="c0">290</td><td class="c2">76&micro;s</td><td class="s">        my @lines = grep { m/^\s/    } split(/\n/);<div class="calls"><div class="calls_out">        # spent    76&micro;s making 290 calls to <a href="Opcode-pm-726-line.html#Opcode__CORE_match">Opcode::CORE:match</a>, avg 261ns/call</div></div></td></tr>
+<tr><td class="h"><a name="68"></a>68</td><td class="c0">120</td><td class="c0"><span title="Avg 2&micro;s">189&micro;s</span></td><td class="c0">101</td><td class="c3">46&micro;s</td><td class="s">        foreach (@lines) { s/--.*//  } # delete comments<div class="calls"><div class="calls_out">        # spent    46&micro;s making 101 calls to <a href="Opcode-pm-726-line.html#Opcode__CORE_subst">Opcode::CORE:subst</a>, avg 459ns/call</div></div></td></tr>
+<tr><td class="h"><a name="69"></a>69</td><td class="c0">120</td><td class="c0"><span title="Avg 1&micro;s">146&micro;s</span></td><td></td><td></td><td class="s">        my @ops   = map  { split ' ' } @lines; # get op words</td></tr>
+<tr><td class="h"><a name="70"></a>70</td><td></td><td></td><td></td><td></td><td class="s"></td></tr>
+<tr><td class="h"><a name="71"></a>71</td><td class="c0">19</td><td class="c3"><span title="Avg 495ns">9&micro;s</span></td><td></td><td></td><td class="s">        foreach(@ops) {</td></tr>
+<tr><td class="h"><a name="72"></a>72</td><td class="c0">378</td><td class="c2"><span title="Avg 137ns">52&micro;s</span></td><td></td><td></td><td class="s">            warn &quot;$tag - $_ already tagged in $seen{$_}\n&quot; if $seen{$_};</td></tr>
+<tr><td class="h"><a name="73"></a>73</td><td class="c0">378</td><td class="c0"><span title="Avg 431ns">163&micro;s</span></td><td></td><td></td><td class="s">            $seen{$_} = $tag;</td></tr>
+<tr><td class="h"><a name="74"></a>74</td><td class="c0">378</td><td class="c0"><span title="Avg 303ns">115&micro;s</span></td><td></td><td></td><td class="s">            delete $all{$_};</td></tr>
+<tr><td class="h"><a name="75"></a>75</td><td></td><td></td><td></td><td></td><td class="s">        }</td></tr>
+<tr><td class="h"><a name="76"></a>76</td><td></td><td></td><td></td><td></td><td class="s">        # opset will croak on invalid names</td></tr>
+<tr><td class="h"><a name="77"></a>77</td><td class="c0">19</td><td class="c0"><span title="Avg 14&micro;s">261&micro;s</span></td><td class="c0">57</td><td class="c1">103&micro;s</td><td class="s">        define_optag($tag, opset(@ops));<div class="calls"><div class="calls_out">        # spent    64&micro;s making 19 calls to <a href="Opcode-pm-726-line.html#Opcode__opset">Opcode::opset</a>, avg 3&micro;s/call
+        # spent    21&micro;s making 19 calls to <a href="Opcode-pm-726-line.html#Opcode__define_optag">Opcode::define_optag</a>, avg 1&micro;s/call
+        # spent    18&micro;s making 19 calls to <a href="Opcode-pm-726-line.html#Opcode__CORE_readline">Opcode::CORE:readline</a>, avg 921ns/call</div></div></td></tr>
+<tr><td class="h"><a name="78"></a>78</td><td></td><td></td><td></td><td></td><td class="s">    }</td></tr>
+<tr><td class="h"><a name="79"></a>79</td><td class="c3">1</td><td class="c3"><span title="Avg 23&micro;s">23&micro;s</span></td><td class="c3">1</td><td class="c3">15&micro;s</td><td class="s">    close(DATA);<div class="calls"><div class="calls_out">    # spent    15&micro;s making 1 call to <a href="Opcode-pm-726-line.html#Opcode__CORE_close">Opcode::CORE:close</a></div></div></td></tr>
+<tr><td class="h"><a name="80"></a>80</td><td class="c3">1</td><td class="c1"><span title="Avg 83&micro;s">83&micro;s</span></td><td></td><td></td><td class="s">    warn &quot;Untagged opnames: &quot;.join(' ',keys %all).&quot;\n&quot; if %all;</td></tr>
+<tr><td class="h"><a name="81"></a>81</td><td></td><td></td><td></td><td></td><td class="s">}</td></tr>
+<tr><td class="h"><a name="82"></a>82</td><td></td><td></td><td></td><td></td><td class="s"></td></tr>
+<tr><td class="h"><a name="83"></a>83</td><td></td><td></td><td></td><td></td><td class="s"></td></tr>
+<tr><td class="h"><a name="84"></a>84</td><td class="c3">1</td><td class="c3"><span title="Avg 23&micro;s">23&micro;s</span></td><td></td><td></td><td class="s">1;</td></tr>
+<tr><td class="h"><a name="85"></a>85</td><td></td><td></td><td></td><td></td><td class="s"></td></tr>
+<tr><td class="h"><a name="86"></a>86</td><td></td><td></td><td></td><td></td><td class="s">__DATA__</td></tr>
+<tr><td class="s"><a name=""></a>&nbsp;</td><td></td><td></td><td></td><td></td><td class="s"></td></tr>
+<tr><td class="h"><a name="Opcode__CORE_close"></a></td><td></td><td></td><td></td><td></td><td class="s"><div class="calls"><div class="calls_in"># spent 15&micro;s within Opcode::CORE:close which was called:
+#    once (15&micro;s+0s) by Opcode::_init_optags at <a href="Opcode-pm-726-line.html#79">line 79</a></div></div>sub Opcode::CORE:close; # opcode<br />        </td></tr>
+<tr><td class="h"><a name="Opcode__CORE_match"></a></td><td></td><td></td><td></td><td></td><td class="s"><div class="calls"><div class="calls_in"># spent 123&micro;s within Opcode::CORE:match which was called 316 times, avg 389ns/call:
+# 290 times (76&micro;s+0s) by Opcode::_init_optags at <a href="Opcode-pm-726-line.html#67">line 67</a>, avg 261ns/call
+#  26 times (47&micro;s+0s) by Opcode::_init_optags at <a href="Opcode-pm-726-line.html#63">line 63</a>, avg 2&micro;s/call</div></div>sub Opcode::CORE:match; # opcode<br />        </td></tr>
+<tr><td class="h"><a name="Opcode__CORE_readline"></a></td><td></td><td></td><td></td><td></td><td class="s"><div class="calls"><div class="calls_in"># spent 66&micro;s within Opcode::CORE:readline which was called 28 times, avg 2&micro;s/call:
+# 19 times (18&micro;s+0s) by Opcode::_init_optags at <a href="Opcode-pm-726-line.html#77">line 77</a>, avg 921ns/call
+#  8 times (19&micro;s+0s) by Opcode::_init_optags at <a href="Opcode-pm-726-line.html#62">line 62</a>, avg 2&micro;s/call
+#     once (29&micro;s+0s) by Opcode::_init_optags at <a href="Opcode-pm-726-line.html#60">line 60</a></div></div>sub Opcode::CORE:readline; # opcode<br />        </td></tr>
+<tr><td class="h"><a name="Opcode__CORE_subst"></a></td><td></td><td></td><td></td><td></td><td class="s"><div class="calls"><div class="calls_in"># spent 46&micro;s within Opcode::CORE:subst which was called 101 times, avg 459ns/call:
+# 101 times (46&micro;s+0s) by Opcode::_init_optags at <a href="Opcode-pm-726-line.html#68">line 68</a>, avg 459ns/call</div></div>sub Opcode::CORE:subst; # opcode<br />        </td></tr>
+<tr><td class="h"><a name="Opcode__define_optag"></a></td><td></td><td></td><td></td><td></td><td class="s"><div class="calls"><div class="calls_in"># spent 21&micro;s within Opcode::define_optag which was called 19 times, avg 1&micro;s/call:
+# 19 times (21&micro;s+0s) by Opcode::_init_optags at <a href="Opcode-pm-726-line.html#77">line 77</a>, avg 1&micro;s/call</div></div>sub Opcode::define_optag; # xsub<br />        </td></tr>
+<tr><td class="h"><a name="Opcode__full_opset"></a></td><td></td><td></td><td></td><td></td><td class="s"><div class="calls"><div class="calls_in"># spent 2&micro;s within Opcode::full_opset which was called:
+#    once (2&micro;s+0s) by Opcode::_init_optags at <a href="Opcode-pm-726-line.html#56">line 56</a></div></div>sub Opcode::full_opset; # xsub<br />        </td></tr>
+<tr><td class="h"><a name="Opcode__opset"></a></td><td></td><td></td><td></td><td></td><td class="s"><div class="calls"><div class="calls_in"># spent 64&micro;s within Opcode::opset which was called 19 times, avg 3&micro;s/call:
+# 19 times (64&micro;s+0s) by Opcode::_init_optags at <a href="Opcode-pm-726-line.html#77">line 77</a>, avg 3&micro;s/call</div></div>sub Opcode::opset; # xsub<br />        </td></tr>
+<tr><td class="h"><a name="Opcode__opset_to_ops"></a></td><td></td><td></td><td></td><td></td><td class="s"><div class="calls"><div class="calls_in"># spent 60&micro;s within Opcode::opset_to_ops which was called:
+#    once (60&micro;s+0s) by Opcode::_init_optags at <a href="Opcode-pm-726-line.html#56">line 56</a></div></div>sub Opcode::opset_to_ops; # xsub<br />        </td></tr>
+</tbody></table></div>
+        
+            <script type="text/javascript"> $(document).ready(function() { 
+
+        $("#subs_table").tablesorter({
+            sortList: [[3,1]],
+            headers: {
+                3: { sorter: 'fmt_time' },
+                4: { sorter: 'fmt_time' }
+            }
+        });
+    
+ } ); </script>
+        
+        <div class="footer">Report produced by the
+        <a href="http://search.cpan.org/dist/Devel-NYTProf/">NYTProf 4.06</a>
+        Perl profiler, developed by
+        <a href="http://www.linkedin.com/in/timbunce">Tim Bunce</a> and
+        <a href="http://code.nytimes.com">Adam Kaplan</a>.
+        </div>
+        <br /><br /><br /><br /><br /><br /><br /><br /><br /><br />
+    </body></html>
\ No newline at end of file