Commit | Line | Data |
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 | <!-- |
4 | This 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 µ ? */ |
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">← Index</a> |
48 | </div> |
49 | <div class="headerForeground" style="float: left"> |
50 | <span class="siteTitle">NYTProf Performance Profile</span> |
51 | <span class="siteSubtitle">  <br /> |
52 | For script/nytprof.pl |
53 | </span> |
54 | </div> |
55 | <div class="headerForeground" style="float: right; text-align: right"> |
56 | <span class="siteTitle"> </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µ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µ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µs</span></td><td class="c3"><span title="0.0%">113µ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µs</span></td><td class="c3"><span title="0.0%">46µ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µs">274µ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µs+5.91) within IPC::Run::Debug::BEGIN@2 which was called: |
164 | # once (647µ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 & 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 > 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 "No fds open???" 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µs">615µs</span></td><td class="c3">2</td><td class="c3">80µs</td><td class="s"><div class="calls"><div class="calls_in"># spent 46µs (13+33) within IPC::Run::Debug::BEGIN@25 which was called: |
189 | # once (13µs+33µ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µ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µ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µs">6µ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 => 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 => 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 => 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 => 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 => 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 => 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"> "gory details" => 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 => 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 => 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 => 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 => 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µ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µ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µ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µs</span></td><td></td><td></td><td class="s"> $level = $IPC::Run::cur_self->{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"> && ( $IPC::Run::cur_self->{debug} || 0 ) >= $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µ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 "Unknown debug level $ENV{IPCRUNDEBUG}, assuming 'basic' (1)\n";</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 > $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µ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µ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µs/call |
251 | # 114 times (409µs+264µ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µs/call |
252 | # 8 times (41µs+31µ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µ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µ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µs">799µ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µ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µs">1.71ms</span></td><td></td><td></td><td class="s"> return $level >= $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µs">69µs</span></td><td class="c3">8</td><td class="c3">72µs</td><td class="s"><div class="calls"><div class="calls_in"># spent 113µs (40+72) within IPC::Run::Debug::_debugging which was called 8 times, avg 14µs/call: |
261 | # 2 times (5µs+10µs) by IPC::Run::harness at <a href="IPC-Run-pm-733-line.html#1718">line 1718 of IPC/Run.pm</a>, avg 8µs/call |
262 | # once (12µs+12µ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µs+16µ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µs+12µ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µs+12µ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µs+5µ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µs+5µ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µ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µ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µs">441µs</span></td><td class="c3">114</td><td class="c3">673µs</td><td class="s"><div class="calls"><div class="calls_in"># spent 1.24ms (569µs+673µs) within IPC::Run::Debug::_debugging_data which was called 114 times, avg 11µs/call: |
269 | # 114 times (569µs+673µs) by IPC::Run::_read at <a href="IPC-Run-pm-733-line.html#1360">line 1360 of IPC/Run.pm</a>, avg 11µs/call</div></div>sub _debugging_data() { _debugging_atleast 2 }<div class="calls"><div class="calls_out"># spent 673µ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µ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µ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µs/call: |
271 | # 120 times (639µ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µs/call |
272 | # 120 times (371µs+745µ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µs/call |
273 | # 120 times (350µs+692µ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µs/call |
274 | # 113 times (343µs+718µ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µs/call |
275 | # 113 times (314µs+702µ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µs/call |
276 | # 4 times (39µs+66µs) by IPC::Run::_close at <a href="IPC-Run-pm-733-line.html#1242">line 1242 of IPC/Run.pm</a>, avg 26µs/call |
277 | # 2 times (13µs+28µs) by IPC::Run::_pipe at <a href="IPC-Run-pm-733-line.html#1314">line 1314 of IPC/Run.pm</a>, avg 20µs/call |
278 | # once (132µs+114µ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µs+22µ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µs+19µ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µs+13µ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µs+13µ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µs+13µ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µs+12µ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µs+9µ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µs+9µ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µs+9µ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µs+5µ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µs+6µ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µs+6µ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µ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} || "" ) eq "notopt" }</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->{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->{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 &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"> " ",</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"> "",</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 ? "#$IPC::Run::cur_self->{ID}" : (),</td></tr> |
321 | <tr><td class="h"><a name="124"></a>124</td><td></td><td></td><td></td><td></td><td class="s"> "($$)",</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 && 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"> "",</td></tr> |
327 | <tr><td class="h"><a name="130"></a>130</td><td></td><td></td><td></td><td></td><td class="s"> "IPC::Run",</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( " %04d", 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 ? ( " ", _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 ? ( " [", $debug_id, "]" ) : (),</td></tr> |
331 | <tr><td class="h"><a name="134"></a>134</td><td></td><td></td><td></td><td></td><td class="s"> ": ",</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 $_ ? $_ : "<undef>", @_ );</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 .= "\n";</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µs">1µ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 " ", caller(0), $text, $op if defined $op && UNIVERSAL::isa( $op, "IO::Pty" );</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->{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->{FD} < 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->{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->{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->{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->{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->{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"> "'s ",</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->{KFD} < 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->{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"> && defined $kid->{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"> && $op->{KFD} == $kid->{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->{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->{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µs">15µ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> |