nytprof run results of /variantgraph/<ID> and /relation/<ID>/relationships
[scpubgit/stemmatology.git] / stemmaweb / nytprof-runs / variantgraph-uuid / (eval 480)[IPC-Run-Debug-pm-104]-735-line.html
CommitLineData
8e30e889 1 <!DOCTYPE html PUBLIC "-//W3C//DTD XHTML 1.0 Transitional//EN" "http://www.w3.org/TR/xhtml1/DTD/xhtml1-transitional.dtd">
2 <html xmlns="http://www.w3.org/1999/xhtml">
3<!--
4This file was generated by Devel::NYTProf version 4.06
5-->
6<head>
7 <meta http-equiv="Content-Type" content="text/html; charset=utf-8" />
8 <meta http-equiv="Content-Language" content="en-us" />
9 <title>Profile of (eval 480)[IPC/Run/Debug.pm:104]</title>
10<link rel="stylesheet" type="text/css" href="style.css" />
11 <script type="text/javascript" src="js/jquery-min.js"></script>
12
13 <script type="text/javascript" src="js/jquery-tablesorter-min.js"></script>
14 <link rel="stylesheet" type="text/css" href="js/style-tablesorter.css" />
15 <script type="text/javascript">
16 // when a column is first clicked on to sort it, use descending order
17 // XXX doesn't seem to work (and not just because the tablesorter formatSortingOrder() is broken)
18 $.tablesorter.defaults.sortInitialOrder = "desc";
19 // add parser through the tablesorter addParser method
20 $.tablesorter.addParser({
21 id: 'fmt_time', // name of this parser
22 is: function(s) {
23 return false; // return false so this parser is not auto detected
24 },
25 format: function(orig) { // format data for normalization
26 // console.log(orig);
27 val = orig.replace(/ns/,'');
28 if (val != orig) { return val / (1000*1000*1000); }
29 val = orig.replace(/µs/,''); /* XXX use &micro; ? */
30 if (val != orig) { return val / (1000*1000); }
31 var val = orig.replace(/ms/,'');
32 if (val != orig) { return val / (1000); }
33 var val = orig.replace(/s/,'');
34 if (val != orig) { return val; }
35 if (orig == '0') { return orig; }
36 console.log('no match for fmt_time of '.concat(orig));
37 return orig;
38 },
39 type: 'numeric' // set type, either numeric or text
40 });
41 </script>
42</head>
43
44<body >
45<div class="header" style="position: relative; overflow-x: hidden; overflow-y: hidden; z-index: 0; ">
46<div class="header_back">
47 <a href="index.html">&larr; Index</a>
48 </div>
49<div class="headerForeground" style="float: left">
50 <span class="siteTitle">NYTProf Performance Profile</span>
51 <span class="siteSubtitle">&emsp;&emsp;<br />
52 For script/nytprof.pl
53 </span>
54</div>
55<div class="headerForeground" style="float: right; text-align: right">
56 <span class="siteTitle">&nbsp;</span>
57 <span class="siteSubtitle">Run on Thu May 31 16:29:39 2012<br />Reported on Thu May 31 16:39:22 2012</span>
58</div>
59<div style="position: absolute; left: 0px; top: 0%; width: 100%; height: 101%; z-index: -1; background-color: rgb(17, 136, 255); "></div>
60<div style="position: absolute; left: 0px; top: 2%; width: 100%; height: 99%; z-index: -1; background-color: rgb(16, 134, 253); "></div>
61<div style="position: absolute; left: 0px; top: 4%; width: 100%; height: 97%; z-index: -1; background-color: rgb(16, 133, 252); "></div>
62<div style="position: absolute; left: 0px; top: 6%; width: 100%; height: 95%; z-index: -1; background-color: rgb(15, 131, 250); "></div>
63<div style="position: absolute; left: 0px; top: 8%; width: 100%; height: 93%; z-index: -1; background-color: rgb(15, 130, 249); "></div>
64<div style="position: absolute; left: 0px; top: 10%; width: 100%; height: 91%; z-index: -1; background-color: rgb(15, 129, 248); "></div>
65<div style="position: absolute; left: 0px; top: 12%; width: 100%; height: 89%; z-index: -1; background-color: rgb(14, 127, 246); "></div>
66<div style="position: absolute; left: 0px; top: 14%; width: 100%; height: 87%; z-index: -1; background-color: rgb(14, 126, 245); "></div>
67<div style="position: absolute; left: 0px; top: 16%; width: 100%; height: 85%; z-index: -1; background-color: rgb(14, 125, 244); "></div>
68<div style="position: absolute; left: 0px; top: 18%; width: 100%; height: 83%; z-index: -1; background-color: rgb(13, 123, 242); "></div>
69<div style="position: absolute; left: 0px; top: 20%; width: 100%; height: 81%; z-index: -1; background-color: rgb(13, 122, 241); "></div>
70<div style="position: absolute; left: 0px; top: 22%; width: 100%; height: 79%; z-index: -1; background-color: rgb(13, 121, 240); "></div>
71<div style="position: absolute; left: 0px; top: 24%; width: 100%; height: 77%; z-index: -1; background-color: rgb(12, 119, 238); "></div>
72<div style="position: absolute; left: 0px; top: 26%; width: 100%; height: 75%; z-index: -1; background-color: rgb(12, 118, 237); "></div>
73<div style="position: absolute; left: 0px; top: 28%; width: 100%; height: 73%; z-index: -1; background-color: rgb(12, 116, 235); "></div>
74<div style="position: absolute; left: 0px; top: 30%; width: 100%; height: 71%; z-index: -1; background-color: rgb(11, 115, 234); "></div>
75<div style="position: absolute; left: 0px; top: 32%; width: 100%; height: 69%; z-index: -1; background-color: rgb(11, 114, 233); "></div>
76<div style="position: absolute; left: 0px; top: 34%; width: 100%; height: 67%; z-index: -1; background-color: rgb(11, 112, 231); "></div>
77<div style="position: absolute; left: 0px; top: 36%; width: 100%; height: 65%; z-index: -1; background-color: rgb(10, 111, 230); "></div>
78<div style="position: absolute; left: 0px; top: 38%; width: 100%; height: 63%; z-index: -1; background-color: rgb(10, 110, 229); "></div>
79<div style="position: absolute; left: 0px; top: 40%; width: 100%; height: 61%; z-index: -1; background-color: rgb(10, 108, 227); "></div>
80<div style="position: absolute; left: 0px; top: 42%; width: 100%; height: 59%; z-index: -1; background-color: rgb(9, 107, 226); "></div>
81<div style="position: absolute; left: 0px; top: 44%; width: 100%; height: 57%; z-index: -1; background-color: rgb(9, 106, 225); "></div>
82<div style="position: absolute; left: 0px; top: 46%; width: 100%; height: 55%; z-index: -1; background-color: rgb(9, 104, 223); "></div>
83<div style="position: absolute; left: 0px; top: 48%; width: 100%; height: 53%; z-index: -1; background-color: rgb(8, 103, 222); "></div>
84<div style="position: absolute; left: 0px; top: 50%; width: 100%; height: 51%; z-index: -1; background-color: rgb(8, 102, 221); "></div>
85<div style="position: absolute; left: 0px; top: 52%; width: 100%; height: 49%; z-index: -1; background-color: rgb(8, 100, 219); "></div>
86<div style="position: absolute; left: 0px; top: 54%; width: 100%; height: 47%; z-index: -1; background-color: rgb(7, 99, 218); "></div>
87<div style="position: absolute; left: 0px; top: 56%; width: 100%; height: 45%; z-index: -1; background-color: rgb(7, 97, 216); "></div>
88<div style="position: absolute; left: 0px; top: 58%; width: 100%; height: 43%; z-index: -1; background-color: rgb(7, 96, 215); "></div>
89<div style="position: absolute; left: 0px; top: 60%; width: 100%; height: 41%; z-index: -1; background-color: rgb(6, 95, 214); "></div>
90<div style="position: absolute; left: 0px; top: 62%; width: 100%; height: 39%; z-index: -1; background-color: rgb(6, 93, 212); "></div>
91<div style="position: absolute; left: 0px; top: 64%; width: 100%; height: 37%; z-index: -1; background-color: rgb(6, 92, 211); "></div>
92<div style="position: absolute; left: 0px; top: 66%; width: 100%; height: 35%; z-index: -1; background-color: rgb(5, 91, 210); "></div>
93<div style="position: absolute; left: 0px; top: 68%; width: 100%; height: 33%; z-index: -1; background-color: rgb(5, 89, 208); "></div>
94<div style="position: absolute; left: 0px; top: 70%; width: 100%; height: 31%; z-index: -1; background-color: rgb(5, 88, 207); "></div>
95<div style="position: absolute; left: 0px; top: 72%; width: 100%; height: 29%; z-index: -1; background-color: rgb(4, 87, 206); "></div>
96<div style="position: absolute; left: 0px; top: 74%; width: 100%; height: 27%; z-index: -1; background-color: rgb(4, 85, 204); "></div>
97<div style="position: absolute; left: 0px; top: 76%; width: 100%; height: 25%; z-index: -1; background-color: rgb(4, 84, 203); "></div>
98<div style="position: absolute; left: 0px; top: 78%; width: 100%; height: 23%; z-index: -1; background-color: rgb(3, 82, 201); "></div>
99<div style="position: absolute; left: 0px; top: 80%; width: 100%; height: 21%; z-index: -1; background-color: rgb(3, 81, 200); "></div>
100<div style="position: absolute; left: 0px; top: 82%; width: 100%; height: 19%; z-index: -1; background-color: rgb(3, 80, 199); "></div>
101<div style="position: absolute; left: 0px; top: 84%; width: 100%; height: 17%; z-index: -1; background-color: rgb(2, 78, 197); "></div>
102<div style="position: absolute; left: 0px; top: 86%; width: 100%; height: 15%; z-index: -1; background-color: rgb(2, 77, 196); "></div>
103<div style="position: absolute; left: 0px; top: 88%; width: 100%; height: 13%; z-index: -1; background-color: rgb(2, 76, 195); "></div>
104<div style="position: absolute; left: 0px; top: 90%; width: 100%; height: 11%; z-index: -1; background-color: rgb(1, 74, 193); "></div>
105<div style="position: absolute; left: 0px; top: 92%; width: 100%; height: 9%; z-index: -1; background-color: rgb(1, 73, 192); "></div>
106<div style="position: absolute; left: 0px; top: 94%; width: 100%; height: 7%; z-index: -1; background-color: rgb(1, 72, 191); "></div>
107<div style="position: absolute; left: 0px; top: 96%; width: 100%; height: 5%; z-index: -1; background-color: rgb(0, 70, 189); "></div>
108<div style="position: absolute; left: 0px; top: 98%; width: 100%; height: 3%; z-index: -1; background-color: rgb(0, 69, 188); "></div>
109<div style="position: absolute; left: 0px; top: 100%; width: 100%; height: 1%; z-index: -1; background-color: rgb(0, 68, 187); "></div>
110</div>
111
112<div class="body_content"><br />
113<table class="file_summary"><tr><td class="h">Filename</td><td align="left">(eval 480)[/Users/edenc/perl5/lib/perl5/IPC/Run/Debug.pm:104]</td></tr>
114<tr><td class="h">Statements</td><td align="left">Executed 5826 statements in 8.85ms</td></tr>
115<tr><td class="h">Eval Invoked At</td><td align="left"><a href="IPC-Run-Debug-pm-734-line.html#104">/Users/edenc/perl5/lib/perl5/IPC/Run/Debug.pm line 104</a></td></tr></table>
116
117 <table id="subs_table" border="1" cellpadding="0" class="tablesorter">
118 <caption>Subroutines</caption>
119 <thead>
120 <tr>
121 <th>Calls</th>
122 <th><span title="Number of Places sub is called from">P</span></th>
123 <th><span title="Number of Files sub is called from">F</span></th>
124 <th>Exclusive<br />Time</th>
125 <th>Inclusive<br />Time</th>
126 <th>Subroutine</th>
127 </tr>
128 </thead>
129 <tbody>
130<tr><td class="c0">727</td><td class="c0">3</td><td class="c3">1</td><td class="c0"><span title="0.0%">3.11ms</span></td><td class="c1"><span title="0.0%">5.02ms</span></td><td class="sub_name"><span style="display: none;">IPC::Run::Debug::::_debugging_atleast</span>IPC::Run::Debug::<a href="(eval 480)[IPC-Run-Debug-pm-104]-735-line.html#83">_debugging_atleast</a></span></td></tr>
131<tr><td class="c0">605</td><td class="c0">20</td><td class="c1">2</td><td class="c0"><span title="0.0%">2.26ms</span></td><td class="c0"><span title="0.0%">6.54ms</span></td><td class="sub_name"><span style="display: none;">IPC::Run::Debug::::_debugging_details</span>IPC::Run::Debug::<a href="(eval 480)[IPC-Run-Debug-pm-104]-735-line.html#93">_debugging_details</a></span></td></tr>
132<tr><td class="c0">727</td><td class="c3">1</td><td class="c3">1</td><td class="c0"><span title="0.0%">1.91ms</span></td><td class="c3"><span title="0.0%">1.91ms</span></td><td class="sub_name"><span style="display: none;">IPC::Run::Debug::::_debugging_level</span>IPC::Run::Debug::<a href="(eval 480)[IPC-Run-Debug-pm-104]-735-line.html#64">_debugging_level</a></span></td></tr>
133<tr><td class="c3">1</td><td class="c3">1</td><td class="c3">1</td><td class="c3"><span title="0.0%">647&micro;s</span></td><td class="c0"><span title="0.0%">6.56ms</span></td><td class="sub_name"><span style="display: none;">IPC::Run::Debug::::BEGIN@2</span>IPC::Run::Debug::<a href="(eval 480)[IPC-Run-Debug-pm-104]-735-line.html#2">BEGIN@2</a></span></td></tr>
134<tr><td class="c3">114</td><td class="c3">1</td><td class="c3">1</td><td class="c3"><span title="0.0%">569&micro;s</span></td><td class="c3"><span title="0.0%">1.24ms</span></td><td class="sub_name"><span style="display: none;">IPC::Run::Debug::::_debugging_data</span>IPC::Run::Debug::<a href="(eval 480)[IPC-Run-Debug-pm-104]-735-line.html#92">_debugging_data</a></span></td></tr>
135<tr><td class="c3">8</td><td class="c0">7</td><td class="c3">1</td><td class="c3"><span title="0.0%">40&micro;s</span></td><td class="c3"><span title="0.0%">113&micro;s</span></td><td class="sub_name"><span style="display: none;">IPC::Run::Debug::::_debugging</span>IPC::Run::Debug::<a href="(eval 480)[IPC-Run-Debug-pm-104]-735-line.html#91">_debugging</a></span></td></tr>
136<tr><td class="c3">1</td><td class="c3">1</td><td class="c3">1</td><td class="c3"><span title="0.0%">13&micro;s</span></td><td class="c3"><span title="0.0%">46&micro;s</span></td><td class="sub_name"><span style="display: none;">IPC::Run::Debug::::BEGIN@25</span>IPC::Run::Debug::<a href="(eval 480)[IPC-Run-Debug-pm-104]-735-line.html#25">BEGIN@25</a></span></td></tr>
137<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;">IPC::Run::Debug::::_debug</span>IPC::Run::Debug::<a href="(eval 480)[IPC-Run-Debug-pm-104]-735-line.html#110">_debug</a></span></td></tr>
138<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;">IPC::Run::Debug::::_debug_desc_fd</span>IPC::Run::Debug::<a href="(eval 480)[IPC-Run-Debug-pm-104]-735-line.html#147">_debug_desc_fd</a></span></td></tr>
139<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;">IPC::Run::Debug::::_debug_init</span>IPC::Run::Debug::<a href="(eval 480)[IPC-Run-Debug-pm-104]-735-line.html#97">_debug_init</a></span></td></tr>
140<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;">IPC::Run::Debug::::_debugging_gory_details</span>IPC::Run::Debug::<a href="(eval 480)[IPC-Run-Debug-pm-104]-735-line.html#94">_debugging_gory_details</a></span></td></tr>
141<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;">IPC::Run::Debug::::_debugging_not_optimized</span>IPC::Run::Debug::<a href="(eval 480)[IPC-Run-Debug-pm-104]-735-line.html#95">_debugging_not_optimized</a></span></td></tr>
142<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;">IPC::Run::Debug::::_map_fds</span>IPC::Run::Debug::<a href="(eval 480)[IPC-Run-Debug-pm-104]-735-line.html#4">_map_fds</a></span></td></tr>
143<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;">IPC::Run::Debug::::_set_child_debug_name</span>IPC::Run::Debug::<a href="(eval 480)[IPC-Run-Debug-pm-104]-735-line.html#35">_set_child_debug_name</a></span></td></tr>
144</tbody></table>
145 Call graph for these subroutines as a
146 <a href="http://en.wikipedia.org/wiki/Graphviz">Graphviz</a>
147 <a href="(eval 480)[-Users-edenc-perl5-lib-perl5-IPC-Run-Debug-pm-104].dot">dot language file</a>.
148
149 <table border="1" cellpadding="0">
150 <thead>
151 <tr><th>Line</th>
152 <th><span title="Number of statements executed">State<br />ments</span></th>
153 <th><span title="Time spend executing statements on the line,
154 excluding time spent executing statements in any called subroutines">Time<br />on line</span></th>
155 <th><span title="Number of subroutines calls">Calls</span></th>
156 <th><span title="Time spent in subroutines called (inclusive)">Time<br />in subs</span></th>
157 <th class="left_indent_header">Code</th>
158 </tr>
159
160 </thead>
161 <tbody>
162 <tr><td class="h"><a name="1"></a>1</td><td></td><td></td><td></td><td></td><td class="s"></td></tr>
163<tr><td class="h"><a name="2"></a>2</td><td class="c3">2</td><td class="c3"><span title="Avg 137&micro;s">274&micro;s</span></td><td class="c3">2</td><td class="c0">10.8ms</td><td class="s"><div class="calls"><div class="calls_in"># spent 6.56ms (647&micro;s+5.91) within IPC::Run::Debug::BEGIN@2 which was called:
164# once (647&micro;s+5.91ms) by IPC::Run::BEGIN@1049 at <a href="(eval 480)[IPC-Run-Debug-pm-104]-735-line.html#2">line 2</a></div></div>use POSIX;<div class="calls"><div class="calls_out"># spent 6.56ms making 1 call to <a href="(eval 480)[IPC-Run-Debug-pm-104]-735-line.html#2">IPC::Run::Debug::BEGIN@2</a>
165# spent 4.20ms making 1 call to <a href="POSIX-pm-736-line.html#24">POSIX::import</a></div></div></td></tr>
166<tr><td class="h"><a name="3"></a>3</td><td></td><td></td><td></td><td></td><td class="s"></td></tr>
167<tr><td class="h"><a name="4"></a>4</td><td></td><td></td><td></td><td></td><td class="s">sub _map_fds {</td></tr>
168<tr><td class="h"><a name="5"></a>5</td><td></td><td></td><td></td><td></td><td class="s"> my $map = '';</td></tr>
169<tr><td class="h"><a name="6"></a>6</td><td></td><td></td><td></td><td></td><td class="s"> my $digit = 0;</td></tr>
170<tr><td class="h"><a name="7"></a>7</td><td></td><td></td><td></td><td></td><td class="s"> my $in_use;</td></tr>
171<tr><td class="h"><a name="8"></a>8</td><td></td><td></td><td></td><td></td><td class="s"> my $dummy;</td></tr>
172<tr><td class="h"><a name="9"></a>9</td><td></td><td></td><td></td><td></td><td class="s"> for my $fd (0..63) {</td></tr>
173<tr><td class="h"><a name="10"></a>10</td><td></td><td></td><td></td><td></td><td class="s"> ## I'd like a quicker way (less user, cpu &amp; expecially sys and kernal</td></tr>
174<tr><td class="h"><a name="11"></a>11</td><td></td><td></td><td></td><td></td><td class="s"> ## calls) to detect open file descriptors. Let me know...</td></tr>
175<tr><td class="h"><a name="12"></a>12</td><td></td><td></td><td></td><td></td><td class="s"> ## Hmmm, could do a 0 length read and check for bad file descriptor...</td></tr>
176<tr><td class="h"><a name="13"></a>13</td><td></td><td></td><td></td><td></td><td class="s"> ## but that segfaults on Win32</td></tr>
177<tr><td class="h"><a name="14"></a>14</td><td></td><td></td><td></td><td></td><td class="s"> my $test_fd = POSIX::dup( $fd );</td></tr>
178<tr><td class="h"><a name="15"></a>15</td><td></td><td></td><td></td><td></td><td class="s"> $in_use = defined $test_fd;</td></tr>
179<tr><td class="h"><a name="16"></a>16</td><td></td><td></td><td></td><td></td><td class="s"> POSIX::close $test_fd if $in_use;</td></tr>
180<tr><td class="h"><a name="17"></a>17</td><td></td><td></td><td></td><td></td><td class="s"> $map .= $in_use ? $digit : '-';</td></tr>
181<tr><td class="h"><a name="18"></a>18</td><td></td><td></td><td></td><td></td><td class="s"> $digit = 0 if ++$digit &gt; 9;</td></tr>
182<tr><td class="h"><a name="19"></a>19</td><td></td><td></td><td></td><td></td><td class="s"> }</td></tr>
183<tr><td class="h"><a name="20"></a>20</td><td></td><td></td><td></td><td></td><td class="s"> warn &quot;No fds open???&quot; unless $map =~ /\d/;</td></tr>
184<tr><td class="h"><a name="21"></a>21</td><td></td><td></td><td></td><td></td><td class="s"> $map =~ s/(.{1,12})-*$/$1/;</td></tr>
185<tr><td class="h"><a name="22"></a>22</td><td></td><td></td><td></td><td></td><td class="s"> return $map;</td></tr>
186<tr><td class="h"><a name="23"></a>23</td><td></td><td></td><td></td><td></td><td class="s">}</td></tr>
187<tr><td class="h"><a name="24"></a>24</td><td></td><td></td><td></td><td></td><td class="s"></td></tr>
188<tr><td class="h"><a name="25"></a>25</td><td class="c3">2</td><td class="c0"><span title="Avg 307&micro;s">615&micro;s</span></td><td class="c3">2</td><td class="c3">80&micro;s</td><td class="s"><div class="calls"><div class="calls_in"># spent 46&micro;s (13+33) within IPC::Run::Debug::BEGIN@25 which was called:
189# once (13&micro;s+33&micro;s) by IPC::Run::BEGIN@1049 at <a href="(eval 480)[IPC-Run-Debug-pm-104]-735-line.html#25">line 25</a></div></div>use vars qw( $parent_pid );<div class="calls"><div class="calls_out"># spent 46&micro;s making 1 call to <a href="(eval 480)[IPC-Run-Debug-pm-104]-735-line.html#25">IPC::Run::Debug::BEGIN@25</a>
190# spent 33&micro;s making 1 call to <a href="vars-pm-6-line.html#10">vars::import</a></div></div></td></tr>
191<tr><td class="h"><a name="26"></a>26</td><td></td><td></td><td></td><td></td><td class="s"></td></tr>
192<tr><td class="h"><a name="27"></a>27</td><td class="c3">1</td><td class="c3"><span title="Avg 300ns">300ns</span></td><td></td><td></td><td class="s">$parent_pid = $$;</td></tr>
193<tr><td class="h"><a name="28"></a>28</td><td></td><td></td><td></td><td></td><td class="s"></td></tr>
194<tr><td class="h"><a name="29"></a>29</td><td></td><td></td><td></td><td></td><td class="s">## TODO: move debugging to it's own module and make it compile-time</td></tr>
195<tr><td class="h"><a name="30"></a>30</td><td></td><td></td><td></td><td></td><td class="s">## optimizable.</td></tr>
196<tr><td class="h"><a name="31"></a>31</td><td></td><td></td><td></td><td></td><td class="s"></td></tr>
197<tr><td class="h"><a name="32"></a>32</td><td></td><td></td><td></td><td></td><td class="s">## Give kid process debugging nice names</td></tr>
198<tr><td class="h"><a name="33"></a>33</td><td class="c3">1</td><td class="c3"><span title="Avg 100ns">100ns</span></td><td></td><td></td><td class="s">my $debug_name;</td></tr>
199<tr><td class="h"><a name="34"></a>34</td><td></td><td></td><td></td><td></td><td class="s"></td></tr>
200<tr><td class="h"><a name="35"></a>35</td><td></td><td></td><td></td><td></td><td class="s">sub _set_child_debug_name {</td></tr>
201<tr><td class="h"><a name="36"></a>36</td><td></td><td></td><td></td><td></td><td class="s"> $debug_name = shift;</td></tr>
202<tr><td class="h"><a name="37"></a>37</td><td></td><td></td><td></td><td></td><td class="s">}</td></tr>
203<tr><td class="h"><a name="38"></a>38</td><td></td><td></td><td></td><td></td><td class="s"></td></tr>
204<tr><td class="h"><a name="39"></a>39</td><td></td><td></td><td></td><td></td><td class="s">## There's a bit of hackery going on here.</td></tr>
205<tr><td class="h"><a name="40"></a>40</td><td></td><td></td><td></td><td></td><td class="s">##</td></tr>
206<tr><td class="h"><a name="41"></a>41</td><td></td><td></td><td></td><td></td><td class="s">## We want to have any code anywhere be able to emit</td></tr>
207<tr><td class="h"><a name="42"></a>42</td><td></td><td></td><td></td><td></td><td class="s">## debugging statements without knowing what harness the code is</td></tr>
208<tr><td class="h"><a name="43"></a>43</td><td></td><td></td><td></td><td></td><td class="s">## being called in/from, since we'd need to pass a harness around to</td></tr>
209<tr><td class="h"><a name="44"></a>44</td><td></td><td></td><td></td><td></td><td class="s">## everything.</td></tr>
210<tr><td class="h"><a name="45"></a>45</td><td></td><td></td><td></td><td></td><td class="s">##</td></tr>
211<tr><td class="h"><a name="46"></a>46</td><td></td><td></td><td></td><td></td><td class="s">## Thus, $cur_self was born.</td></tr>
212<tr><td class="h"><a name="47"></a>47</td><td></td><td></td><td></td><td></td><td class="s">#</td></tr>
213<tr><td class="h"><a name="48"></a>48</td><td class="c3">1</td><td class="c3"><span title="Avg 6&micro;s">6&micro;s</span></td><td></td><td></td><td class="s">my %debug_levels = (</td></tr>
214<tr><td class="h"><a name="49"></a>49</td><td></td><td></td><td></td><td></td><td class="s"> none =&gt; 0,</td></tr>
215<tr><td class="h"><a name="50"></a>50</td><td></td><td></td><td></td><td></td><td class="s"> basic =&gt; 1,</td></tr>
216<tr><td class="h"><a name="51"></a>51</td><td></td><td></td><td></td><td></td><td class="s"> data =&gt; 2,</td></tr>
217<tr><td class="h"><a name="52"></a>52</td><td></td><td></td><td></td><td></td><td class="s"> details =&gt; 3,</td></tr>
218<tr><td class="h"><a name="53"></a>53</td><td></td><td></td><td></td><td></td><td class="s"> gore =&gt; 4,</td></tr>
219<tr><td class="h"><a name="54"></a>54</td><td></td><td></td><td></td><td></td><td class="s"> gory_details =&gt; 4,</td></tr>
220<tr><td class="h"><a name="55"></a>55</td><td></td><td></td><td></td><td></td><td class="s"> &quot;gory details&quot; =&gt; 4,</td></tr>
221<tr><td class="h"><a name="56"></a>56</td><td></td><td></td><td></td><td></td><td class="s"> gory =&gt; 4,</td></tr>
222<tr><td class="h"><a name="57"></a>57</td><td></td><td></td><td></td><td></td><td class="s"> gorydetails =&gt; 4,</td></tr>
223<tr><td class="h"><a name="58"></a>58</td><td></td><td></td><td></td><td></td><td class="s"> all =&gt; 10,</td></tr>
224<tr><td class="h"><a name="59"></a>59</td><td></td><td></td><td></td><td></td><td class="s"> notopt =&gt; 0,</td></tr>
225<tr><td class="h"><a name="60"></a>60</td><td></td><td></td><td></td><td></td><td class="s">);</td></tr>
226<tr><td class="h"><a name="61"></a>61</td><td></td><td></td><td></td><td></td><td class="s"></td></tr>
227<tr><td class="h"><a name="62"></a>62</td><td class="c3">1</td><td class="c3"><span title="Avg 0s">0s</span></td><td></td><td></td><td class="s">my $warned;</td></tr>
228<tr><td class="h"><a name="63"></a>63</td><td></td><td></td><td></td><td></td><td class="s"></td></tr>
229<tr><td class="h"><a name="64"></a>64</td><td></td><td></td><td></td><td></td><td class="s"><div class="calls"><div class="calls_in"># spent 1.91ms within IPC::Run::Debug::_debugging_level which was called 727 times, avg 3&micro;s/call:
230# 727 times (1.91ms+0s) by IPC::Run::Debug::_debugging_atleast at <a href="(eval 480)[IPC-Run-Debug-pm-104]-735-line.html#86">line 86</a>, avg 3&micro;s/call</div></div>sub _debugging_level() {</td></tr>
231<tr><td class="h"><a name="65"></a>65</td><td class="c0">727</td><td class="c3"><span title="Avg 127ns">93&micro;s</span></td><td></td><td></td><td class="s"> my $level = 0;</td></tr>
232<tr><td class="h"><a name="66"></a>66</td><td></td><td></td><td></td><td></td><td class="s"></td></tr>
233<tr><td class="h"><a name="67"></a>67</td><td class="c0">727</td><td class="c1"><span title="Avg 780ns">567&micro;s</span></td><td></td><td></td><td class="s"> $level = $IPC::Run::cur_self-&gt;{debug} || 0</td></tr>
234<tr><td class="h"><a name="68"></a>68</td><td></td><td></td><td></td><td></td><td class="s"> if $IPC::Run::cur_self</td></tr>
235<tr><td class="h"><a name="69"></a>69</td><td></td><td></td><td></td><td></td><td class="s"> &amp;&amp; ( $IPC::Run::cur_self-&gt;{debug} || 0 ) &gt;= $level;</td></tr>
236<tr><td class="h"><a name="70"></a>70</td><td></td><td></td><td></td><td></td><td class="s"></td></tr>
237<tr><td class="h"><a name="71"></a>71</td><td class="c0">727</td><td class="c3"><span title="Avg 266ns">193&micro;s</span></td><td></td><td></td><td class="s"> if ( defined $ENV{IPCRUNDEBUG} ) {</td></tr>
238<tr><td class="h"><a name="72"></a>72</td><td></td><td></td><td></td><td></td><td class="s"> my $v = $ENV{IPCRUNDEBUG};</td></tr>
239<tr><td class="h"><a name="73"></a>73</td><td></td><td></td><td></td><td></td><td class="s"> $v = $debug_levels{lc $v} if $v =~ /[a-zA-Z]/;</td></tr>
240<tr><td class="h"><a name="74"></a>74</td><td></td><td></td><td></td><td></td><td class="s"> unless ( defined $v ) {</td></tr>
241<tr><td class="h"><a name="75"></a>75</td><td></td><td></td><td></td><td></td><td class="s"> $warned ||= warn &quot;Unknown debug level $ENV{IPCRUNDEBUG}, assuming 'basic' (1)\n&quot;;</td></tr>
242<tr><td class="h"><a name="76"></a>76</td><td></td><td></td><td></td><td></td><td class="s"> $v = 1;</td></tr>
243<tr><td class="h"><a name="77"></a>77</td><td></td><td></td><td></td><td></td><td class="s"> }</td></tr>
244<tr><td class="h"><a name="78"></a>78</td><td></td><td></td><td></td><td></td><td class="s"> $level = $v if $v &gt; $level;</td></tr>
245<tr><td class="h"><a name="79"></a>79</td><td></td><td></td><td></td><td></td><td class="s"> }</td></tr>
246<tr><td class="h"><a name="80"></a>80</td><td class="c0">727</td><td class="c0"><span title="Avg 3&micro;s">1.91ms</span></td><td></td><td></td><td class="s"> return $level;</td></tr>
247<tr><td class="h"><a name="81"></a>81</td><td></td><td></td><td></td><td></td><td class="s">}</td></tr>
248<tr><td class="h"><a name="82"></a>82</td><td></td><td></td><td></td><td></td><td class="s"></td></tr>
249<tr><td class="h"><a name="83"></a>83</td><td></td><td></td><td></td><td></td><td class="s"><div class="calls"><div class="calls_in"># spent 5.02ms (3.11+1.91) within IPC::Run::Debug::_debugging_atleast which was called 727 times, avg 7&micro;s/call:
250# 605 times (2.66ms+1.62ms) by IPC::Run::Debug::_debugging_details at <a href="(eval 480)[IPC-Run-Debug-pm-104]-735-line.html#93">line 93</a>, avg 7&micro;s/call
251# 114 times (409&micro;s+264&micro;s) by IPC::Run::Debug::_debugging_data at <a href="(eval 480)[IPC-Run-Debug-pm-104]-735-line.html#92">line 92</a>, avg 6&micro;s/call
252# 8 times (41&micro;s+31&micro;s) by IPC::Run::Debug::_debugging at <a href="(eval 480)[IPC-Run-Debug-pm-104]-735-line.html#91">line 91</a>, avg 9&micro;s/call</div></div>sub _debugging_atleast($) {</td></tr>
253<tr><td class="h"><a name="84"></a>84</td><td class="c0">727</td><td class="c3"><span title="Avg 253ns">184&micro;s</span></td><td></td><td></td><td class="s"> my $min_level = shift || 1;</td></tr>
254<tr><td class="h"><a name="85"></a>85</td><td></td><td></td><td></td><td></td><td class="s"></td></tr>
255<tr><td class="h"><a name="86"></a>86</td><td class="c0">727</td><td class="c0"><span title="Avg 1&micro;s">799&micro;s</span></td><td class="c0">727</td><td class="c3">1.91ms</td><td class="s"> my $level = _debugging_level;<div class="calls"><div class="calls_out"> # spent 1.91ms making 727 calls to <a href="(eval 480)[IPC-Run-Debug-pm-104]-735-line.html#64">IPC::Run::Debug::_debugging_level</a>, avg 3&micro;s/call</div></div></td></tr>
256<tr><td class="h"><a name="87"></a>87</td><td></td><td></td><td></td><td></td><td class="s"> </td></tr>
257<tr><td class="h"><a name="88"></a>88</td><td class="c0">727</td><td class="c0"><span title="Avg 2&micro;s">1.71ms</span></td><td></td><td></td><td class="s"> return $level &gt;= $min_level ? $level : 0;</td></tr>
258<tr><td class="h"><a name="89"></a>89</td><td></td><td></td><td></td><td></td><td class="s">}</td></tr>
259<tr><td class="h"><a name="90"></a>90</td><td></td><td></td><td></td><td></td><td class="s"></td></tr>
260<tr><td class="h"><a name="91"></a>91</td><td class="c3">8</td><td class="c3"><span title="Avg 9&micro;s">69&micro;s</span></td><td class="c3">8</td><td class="c3">72&micro;s</td><td class="s"><div class="calls"><div class="calls_in"># spent 113&micro;s (40+72) within IPC::Run::Debug::_debugging which was called 8 times, avg 14&micro;s/call:
261# 2 times (5&micro;s+10&micro;s) by IPC::Run::harness at <a href="IPC-Run-pm-733-line.html#1718">line 1718 of IPC/Run.pm</a>, avg 8&micro;s/call
262# once (12&micro;s+12&micro;s) by IPC::Run::finish at <a href="IPC-Run-pm-733-line.html#3466">line 3466 of IPC/Run.pm</a>
263# once (6&micro;s+16&micro;s) by IPC::Run::reap_nb at <a href="IPC-Run-pm-733-line.html#3423">line 3423 of IPC/Run.pm</a>
264# once (6&micro;s+12&micro;s) by IPC::Run::harness at <a href="IPC-Run-pm-733-line.html#1710">line 1710 of IPC/Run.pm</a>
265# once (6&micro;s+12&micro;s) by IPC::Run::_debug_fd at <a href="IPC-Run-pm-733-line.html#1119">line 1119 of IPC/Run.pm</a>
266# once (3&micro;s+5&micro;s) by IPC::Run::reap_nb at <a href="IPC-Run-pm-733-line.html#3428">line 3428 of IPC/Run.pm</a>
267# once (3&micro;s+5&micro;s) by IPC::Run::start at <a href="IPC-Run-pm-733-line.html#2753">line 2753 of IPC/Run.pm</a></div></div>sub _debugging() { _debugging_atleast 1 }<div class="calls"><div class="calls_out"># spent 72&micro;s making 8 calls to <a href="(eval 480)[IPC-Run-Debug-pm-104]-735-line.html#83">IPC::Run::Debug::_debugging_atleast</a>, avg 9&micro;s/call</div></div></td></tr>
268<tr><td class="h"><a name="92"></a>92</td><td class="c3">114</td><td class="c1"><span title="Avg 4&micro;s">441&micro;s</span></td><td class="c3">114</td><td class="c3">673&micro;s</td><td class="s"><div class="calls"><div class="calls_in"># spent 1.24ms (569&micro;s+673&micro;s) within IPC::Run::Debug::_debugging_data which was called 114 times, avg 11&micro;s/call:
269# 114 times (569&micro;s+673&micro;s) by IPC::Run::_read at <a href="IPC-Run-pm-733-line.html#1360">line 1360 of IPC/Run.pm</a>, avg 11&micro;s/call</div></div>sub _debugging_data() { _debugging_atleast 2 }<div class="calls"><div class="calls_out"># spent 673&micro;s making 114 calls to <a href="(eval 480)[IPC-Run-Debug-pm-104]-735-line.html#83">IPC::Run::Debug::_debugging_atleast</a>, avg 6&micro;s/call</div></div></td></tr>
270<tr><td class="h"><a name="93"></a>93</td><td class="c0">605</td><td class="c0"><span title="Avg 3&micro;s">1.97ms</span></td><td class="c0">605</td><td class="c1">4.28ms</td><td class="s"><div class="calls"><div class="calls_in"># spent 6.54ms (2.26+4.28) within IPC::Run::Debug::_debugging_details which was called 605 times, avg 11&micro;s/call:
271# 120 times (639&micro;s+1.08ms) by IPC::Run::_select_loop at <a href="IPC-Run-pm-733-line.html#3077">line 3077 of IPC/Run.pm</a>, avg 14&micro;s/call
272# 120 times (371&micro;s+745&micro;s) by IPC::Run::_select_loop at <a href="IPC-Run-pm-733-line.html#2991">line 2991 of IPC/Run.pm</a>, avg 9&micro;s/call
273# 120 times (350&micro;s+692&micro;s) by IPC::Run::_select_loop at <a href="IPC-Run-pm-733-line.html#3039">line 3039 of IPC/Run.pm</a>, avg 9&micro;s/call
274# 113 times (343&micro;s+718&micro;s) by IPC::Run::IO::poll at <a href="IPC-Run-IO-pm-740-line.html#536">line 536 of IPC/Run/IO.pm</a>, avg 9&micro;s/call
275# 113 times (314&micro;s+702&micro;s) by IPC::Run::__ANON__[/Users/edenc/perl5/lib/perl5/IPC/Run.pm:2434] at <a href="IPC-Run-pm-733-line.html#2411">line 2411 of IPC/Run.pm</a>, avg 9&micro;s/call
276# 4 times (39&micro;s+66&micro;s) by IPC::Run::_close at <a href="IPC-Run-pm-733-line.html#1242">line 1242 of IPC/Run.pm</a>, avg 26&micro;s/call
277# 2 times (13&micro;s+28&micro;s) by IPC::Run::_pipe at <a href="IPC-Run-pm-733-line.html#1314">line 1314 of IPC/Run.pm</a>, avg 20&micro;s/call
278# once (132&micro;s+114&micro;s) by IPC::Run::_spawn at <a href="IPC-Run-pm-733-line.html#1381">line 1381 of IPC/Run.pm</a>
279# once (10&micro;s+22&micro;s) by IPC::Run::_search_path at <a href="IPC-Run-pm-733-line.html#1223">line 1223 of IPC/Run.pm</a>
280# once (5&micro;s+19&micro;s) by IPC::Run::_cleanup at <a href="IPC-Run-pm-733-line.html#3146">line 3146 of IPC/Run.pm</a>
281# once (7&micro;s+13&micro;s) by IPC::Run::start at <a href="IPC-Run-pm-733-line.html#2796">line 2796 of IPC/Run.pm</a>
282# once (7&micro;s+13&micro;s) by IPC::Run::_open_pipes at <a href="IPC-Run-pm-733-line.html#2378">line 2378 of IPC/Run.pm</a>
283# once (6&micro;s+13&micro;s) by IPC::Run::_open_pipes at <a href="IPC-Run-pm-733-line.html#2230">line 2230 of IPC/Run.pm</a>
284# once (6&micro;s+12&micro;s) by IPC::Run::_spawn at <a href="IPC-Run-pm-733-line.html#1370">line 1370 of IPC/Run.pm</a>
285# once (6&micro;s+9&micro;s) by IPC::Run::_cleanup at <a href="IPC-Run-pm-733-line.html#3207">line 3207 of IPC/Run.pm</a>
286# once (3&micro;s+9&micro;s) by IPC::Run::_cleanup at <a href="IPC-Run-pm-733-line.html#3193">line 3193 of IPC/Run.pm</a>
287# once (3&micro;s+9&micro;s) by IPC::Run::_cleanup at <a href="IPC-Run-pm-733-line.html#3167">line 3167 of IPC/Run.pm</a>
288# once (4&micro;s+5&micro;s) by IPC::Run::harness at <a href="IPC-Run-pm-733-line.html#1916">line 1916 of IPC/Run.pm</a>
289# once (3&micro;s+6&micro;s) by IPC::Run::_clobber at <a href="IPC-Run-pm-733-line.html#2903">line 2903 of IPC/Run.pm</a>
290# once (3&micro;s+6&micro;s) by IPC::Run::_cleanup at <a href="IPC-Run-pm-733-line.html#3162">line 3162 of IPC/Run.pm</a></div></div>sub _debugging_details() { _debugging_atleast 3 }<div class="calls"><div class="calls_out"># spent 4.28ms making 605 calls to <a href="(eval 480)[IPC-Run-Debug-pm-104]-735-line.html#83">IPC::Run::Debug::_debugging_atleast</a>, avg 7&micro;s/call</div></div></td></tr>
291<tr><td class="h"><a name="94"></a>94</td><td></td><td></td><td></td><td></td><td class="s">sub _debugging_gory_details() { _debugging_atleast 4 }</td></tr>
292<tr><td class="h"><a name="95"></a>95</td><td></td><td></td><td></td><td></td><td class="s">sub _debugging_not_optimized() { ( $ENV{IPCRUNDEBUG} || &quot;&quot; ) eq &quot;notopt&quot; }</td></tr>
293<tr><td class="h"><a name="96"></a>96</td><td></td><td></td><td></td><td></td><td class="s"></td></tr>
294<tr><td class="h"><a name="97"></a>97</td><td></td><td></td><td></td><td></td><td class="s">sub _debug_init {</td></tr>
295<tr><td class="h"><a name="98"></a>98</td><td></td><td></td><td></td><td></td><td class="s"> ## This routine is called only in spawned children to fake out the</td></tr>
296<tr><td class="h"><a name="99"></a>99</td><td></td><td></td><td></td><td></td><td class="s"> ## debug routines so they'll emit debugging info.</td></tr>
297<tr><td class="h"><a name="100"></a>100</td><td></td><td></td><td></td><td></td><td class="s"> $IPC::Run::cur_self = {};</td></tr>
298<tr><td class="h"><a name="101"></a>101</td><td></td><td></td><td></td><td></td><td class="s"> ( $parent_pid,</td></tr>
299<tr><td class="h"><a name="102"></a>102</td><td></td><td></td><td></td><td></td><td class="s"> $^T, </td></tr>
300<tr><td class="h"><a name="103"></a>103</td><td></td><td></td><td></td><td></td><td class="s"> $IPC::Run::cur_self-&gt;{debug}, </td></tr>
301<tr><td class="h"><a name="104"></a>104</td><td></td><td></td><td></td><td></td><td class="s"> $IPC::Run::cur_self-&gt;{DEBUG_FD}, </td></tr>
302<tr><td class="h"><a name="105"></a>105</td><td></td><td></td><td></td><td></td><td class="s"> $debug_name </td></tr>
303<tr><td class="h"><a name="106"></a>106</td><td></td><td></td><td></td><td></td><td class="s"> ) = @_;</td></tr>
304<tr><td class="h"><a name="107"></a>107</td><td></td><td></td><td></td><td></td><td class="s">}</td></tr>
305<tr><td class="h"><a name="108"></a>108</td><td></td><td></td><td></td><td></td><td class="s"></td></tr>
306<tr><td class="h"><a name="109"></a>109</td><td></td><td></td><td></td><td></td><td class="s"></td></tr>
307<tr><td class="h"><a name="110"></a>110</td><td></td><td></td><td></td><td></td><td class="s">sub _debug {</td></tr>
308<tr><td class="h"><a name="111"></a>111</td><td></td><td></td><td></td><td></td><td class="s"># return unless _debugging || _debugging_not_optimized;</td></tr>
309<tr><td class="h"><a name="112"></a>112</td><td></td><td></td><td></td><td></td><td class="s"></td></tr>
310<tr><td class="h"><a name="113"></a>113</td><td></td><td></td><td></td><td></td><td class="s"> my $fd = defined &amp;IPC::Run::_debug_fd</td></tr>
311<tr><td class="h"><a name="114"></a>114</td><td></td><td></td><td></td><td></td><td class="s"> ? IPC::Run::_debug_fd()</td></tr>
312<tr><td class="h"><a name="115"></a>115</td><td></td><td></td><td></td><td></td><td class="s"> : fileno STDERR;</td></tr>
313<tr><td class="h"><a name="116"></a>116</td><td></td><td></td><td></td><td></td><td class="s"></td></tr>
314<tr><td class="h"><a name="117"></a>117</td><td></td><td></td><td></td><td></td><td class="s"> my $s;</td></tr>
315<tr><td class="h"><a name="118"></a>118</td><td></td><td></td><td></td><td></td><td class="s"> my $debug_id;</td></tr>
316<tr><td class="h"><a name="119"></a>119</td><td></td><td></td><td></td><td></td><td class="s"> $debug_id = join( </td></tr>
317<tr><td class="h"><a name="120"></a>120</td><td></td><td></td><td></td><td></td><td class="s"> &quot; &quot;,</td></tr>
318<tr><td class="h"><a name="121"></a>121</td><td></td><td></td><td></td><td></td><td class="s"> join(</td></tr>
319<tr><td class="h"><a name="122"></a>122</td><td></td><td></td><td></td><td></td><td class="s"> &quot;&quot;,</td></tr>
320<tr><td class="h"><a name="123"></a>123</td><td></td><td></td><td></td><td></td><td class="s"> defined $IPC::Run::cur_self ? &quot;#$IPC::Run::cur_self-&gt;{ID}&quot; : (),</td></tr>
321<tr><td class="h"><a name="124"></a>124</td><td></td><td></td><td></td><td></td><td class="s"> &quot;($$)&quot;,</td></tr>
322<tr><td class="h"><a name="125"></a>125</td><td></td><td></td><td></td><td></td><td class="s"> ),</td></tr>
323<tr><td class="h"><a name="126"></a>126</td><td></td><td></td><td></td><td></td><td class="s"> defined $debug_name &amp;&amp; length $debug_name ? $debug_name : (),</td></tr>
324<tr><td class="h"><a name="127"></a>127</td><td></td><td></td><td></td><td></td><td class="s"> );</td></tr>
325<tr><td class="h"><a name="128"></a>128</td><td></td><td></td><td></td><td></td><td class="s"> my $prefix = join(</td></tr>
326<tr><td class="h"><a name="129"></a>129</td><td></td><td></td><td></td><td></td><td class="s"> &quot;&quot;,</td></tr>
327<tr><td class="h"><a name="130"></a>130</td><td></td><td></td><td></td><td></td><td class="s"> &quot;IPC::Run&quot;,</td></tr>
328<tr><td class="h"><a name="131"></a>131</td><td></td><td></td><td></td><td></td><td class="s"> sprintf( &quot; %04d&quot;, time - $^T ),</td></tr>
329<tr><td class="h"><a name="132"></a>132</td><td></td><td></td><td></td><td></td><td class="s"> ( _debugging_details ? ( &quot; &quot;, _map_fds ) : () ),</td></tr>
330<tr><td class="h"><a name="133"></a>133</td><td></td><td></td><td></td><td></td><td class="s"> length $debug_id ? ( &quot; [&quot;, $debug_id, &quot;]&quot; ) : (),</td></tr>
331<tr><td class="h"><a name="134"></a>134</td><td></td><td></td><td></td><td></td><td class="s"> &quot;: &quot;,</td></tr>
332<tr><td class="h"><a name="135"></a>135</td><td></td><td></td><td></td><td></td><td class="s"> );</td></tr>
333<tr><td class="h"><a name="136"></a>136</td><td></td><td></td><td></td><td></td><td class="s"></td></tr>
334<tr><td class="h"><a name="137"></a>137</td><td></td><td></td><td></td><td></td><td class="s"> my $msg = join( '', map defined $_ ? $_ : &quot;&lt;undef&gt;&quot;, @_ );</td></tr>
335<tr><td class="h"><a name="138"></a>138</td><td></td><td></td><td></td><td></td><td class="s"> chomp $msg;</td></tr>
336<tr><td class="h"><a name="139"></a>139</td><td></td><td></td><td></td><td></td><td class="s"> $msg =~ s{^}{$prefix}gm;</td></tr>
337<tr><td class="h"><a name="140"></a>140</td><td></td><td></td><td></td><td></td><td class="s"> $msg .= &quot;\n&quot;;</td></tr>
338<tr><td class="h"><a name="141"></a>141</td><td></td><td></td><td></td><td></td><td class="s"> POSIX::write( $fd, $msg, length $msg );</td></tr>
339<tr><td class="h"><a name="142"></a>142</td><td></td><td></td><td></td><td></td><td class="s">}</td></tr>
340<tr><td class="h"><a name="143"></a>143</td><td></td><td></td><td></td><td></td><td class="s"></td></tr>
341<tr><td class="h"><a name="144"></a>144</td><td></td><td></td><td></td><td></td><td class="s"></td></tr>
342<tr><td class="h"><a name="145"></a>145</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">my @fd_descs = ( 'stdin', 'stdout', 'stderr' );</td></tr>
343<tr><td class="h"><a name="146"></a>146</td><td></td><td></td><td></td><td></td><td class="s"></td></tr>
344<tr><td class="h"><a name="147"></a>147</td><td></td><td></td><td></td><td></td><td class="s">sub _debug_desc_fd {</td></tr>
345<tr><td class="h"><a name="148"></a>148</td><td></td><td></td><td></td><td></td><td class="s"> return unless _debugging;</td></tr>
346<tr><td class="h"><a name="149"></a>149</td><td></td><td></td><td></td><td></td><td class="s"> my $text = shift;</td></tr>
347<tr><td class="h"><a name="150"></a>150</td><td></td><td></td><td></td><td></td><td class="s"> my $op = pop;</td></tr>
348<tr><td class="h"><a name="151"></a>151</td><td></td><td></td><td></td><td></td><td class="s"> my $kid = $_[0];</td></tr>
349<tr><td class="h"><a name="152"></a>152</td><td></td><td></td><td></td><td></td><td class="s"></td></tr>
350<tr><td class="h"><a name="153"></a>153</td><td></td><td></td><td></td><td></td><td class="s">Carp::carp join &quot; &quot;, caller(0), $text, $op if defined $op &amp;&amp; UNIVERSAL::isa( $op, &quot;IO::Pty&quot; );</td></tr>
351<tr><td class="h"><a name="154"></a>154</td><td></td><td></td><td></td><td></td><td class="s"></td></tr>
352<tr><td class="h"><a name="155"></a>155</td><td></td><td></td><td></td><td></td><td class="s"> _debug(</td></tr>
353<tr><td class="h"><a name="156"></a>156</td><td></td><td></td><td></td><td></td><td class="s"> $text,</td></tr>
354<tr><td class="h"><a name="157"></a>157</td><td></td><td></td><td></td><td></td><td class="s"> ' ',</td></tr>
355<tr><td class="h"><a name="158"></a>158</td><td></td><td></td><td></td><td></td><td class="s"> ( defined $op-&gt;{FD}</td></tr>
356<tr><td class="h"><a name="159"></a>159</td><td></td><td></td><td></td><td></td><td class="s"> ? $op-&gt;{FD} &lt; 3</td></tr>
357<tr><td class="h"><a name="160"></a>160</td><td></td><td></td><td></td><td></td><td class="s"> ? ( $fd_descs[$op-&gt;{FD}] )</td></tr>
358<tr><td class="h"><a name="161"></a>161</td><td></td><td></td><td></td><td></td><td class="s"> : ( 'fd ', $op-&gt;{FD} )</td></tr>
359<tr><td class="h"><a name="162"></a>162</td><td></td><td></td><td></td><td></td><td class="s"> : $op-&gt;{FD}</td></tr>
360<tr><td class="h"><a name="163"></a>163</td><td></td><td></td><td></td><td></td><td class="s"> ),</td></tr>
361<tr><td class="h"><a name="164"></a>164</td><td></td><td></td><td></td><td></td><td class="s"> ( defined $op-&gt;{KFD}</td></tr>
362<tr><td class="h"><a name="165"></a>165</td><td></td><td></td><td></td><td></td><td class="s"> ? (</td></tr>
363<tr><td class="h"><a name="166"></a>166</td><td></td><td></td><td></td><td></td><td class="s"> ' (kid',</td></tr>
364<tr><td class="h"><a name="167"></a>167</td><td></td><td></td><td></td><td></td><td class="s"> ( defined $kid ? ( ' ', $kid-&gt;{NUM}, ) : () ),</td></tr>
365<tr><td class="h"><a name="168"></a>168</td><td></td><td></td><td></td><td></td><td class="s"> &quot;'s &quot;,</td></tr>
366<tr><td class="h"><a name="169"></a>169</td><td></td><td></td><td></td><td></td><td class="s"> ( $op-&gt;{KFD} &lt; 3</td></tr>
367<tr><td class="h"><a name="170"></a>170</td><td></td><td></td><td></td><td></td><td class="s"> ? $fd_descs[$op-&gt;{KFD}]</td></tr>
368<tr><td class="h"><a name="171"></a>171</td><td></td><td></td><td></td><td></td><td class="s"> : defined $kid</td></tr>
369<tr><td class="h"><a name="172"></a>172</td><td></td><td></td><td></td><td></td><td class="s"> &amp;&amp; defined $kid-&gt;{DEBUG_FD}</td></tr>
370<tr><td class="h"><a name="173"></a>173</td><td></td><td></td><td></td><td></td><td class="s"> &amp;&amp; $op-&gt;{KFD} == $kid-&gt;{DEBUG_FD}</td></tr>
371<tr><td class="h"><a name="174"></a>174</td><td></td><td></td><td></td><td></td><td class="s"> ? ( 'debug (', $op-&gt;{KFD}, ')' )</td></tr>
372<tr><td class="h"><a name="175"></a>175</td><td></td><td></td><td></td><td></td><td class="s"> : ( 'fd ', $op-&gt;{KFD} )</td></tr>
373<tr><td class="h"><a name="176"></a>176</td><td></td><td></td><td></td><td></td><td class="s"> ),</td></tr>
374<tr><td class="h"><a name="177"></a>177</td><td></td><td></td><td></td><td></td><td class="s"> ')',</td></tr>
375<tr><td class="h"><a name="178"></a>178</td><td></td><td></td><td></td><td></td><td class="s"> )</td></tr>
376<tr><td class="h"><a name="179"></a>179</td><td></td><td></td><td></td><td></td><td class="s"> : ()</td></tr>
377<tr><td class="h"><a name="180"></a>180</td><td></td><td></td><td></td><td></td><td class="s"> ),</td></tr>
378<tr><td class="h"><a name="181"></a>181</td><td></td><td></td><td></td><td></td><td class="s"> );</td></tr>
379<tr><td class="h"><a name="182"></a>182</td><td></td><td></td><td></td><td></td><td class="s">}</td></tr>
380<tr><td class="h"><a name="183"></a>183</td><td></td><td></td><td></td><td></td><td class="s"></td></tr>
381<tr><td class="h"><a name="184"></a>184</td><td class="c3">1</td><td class="c3"><span title="Avg 15&micro;s">15&micro;s</span></td><td></td><td></td><td class="s">1;</td></tr>
382<tr><td class="h"><a name="185"></a>185</td><td></td><td></td><td></td><td></td><td class="s"></td></tr>
383<tr><td class="h"><a name="186"></a>186</td><td></td><td></td><td></td><td></td><td class="s"></td></tr>
384<tr><td class="h"><a name="187"></a>187</td><td></td><td></td><td></td><td></td><td class="s">;</td></tr>
385</tbody></table></div>
386
387 <script type="text/javascript"> $(document).ready(function() {
388
389 $("#subs_table").tablesorter({
390 sortList: [[3,1]],
391 headers: {
392 3: { sorter: 'fmt_time' },
393 4: { sorter: 'fmt_time' }
394 }
395 });
396
397 } ); </script>
398
399 <div class="footer">Report produced by the
400 <a href="http://search.cpan.org/dist/Devel-NYTProf/">NYTProf 4.06</a>
401 Perl profiler, developed by
402 <a href="http://www.linkedin.com/in/timbunce">Tim Bunce</a> and
403 <a href="http://code.nytimes.com">Adam Kaplan</a>.
404 </div>
405 <br /><br /><br /><br /><br /><br /><br /><br /><br /><br />
406 </body></html>