| line |
stmt |
bran |
cond |
sub |
pod |
time |
code |
|
1
|
|
|
|
|
|
|
package Tool::Bench::Item; |
|
2
|
|
|
|
|
|
|
{ |
|
3
|
|
|
|
|
|
|
$Tool::Bench::Item::VERSION = '0.003'; |
|
4
|
|
|
|
|
|
|
} |
|
5
|
2
|
|
|
2
|
|
100185
|
use Mouse; |
|
|
2
|
|
|
|
|
35677
|
|
|
|
2
|
|
|
|
|
14
|
|
|
6
|
2
|
|
|
2
|
|
632
|
use List::Util qw{min max sum}; |
|
|
2
|
|
|
|
|
4
|
|
|
|
2
|
|
|
|
|
183
|
|
|
7
|
2
|
|
|
2
|
|
10
|
use Time::HiRes qw{time}; |
|
|
2
|
|
|
|
|
2
|
|
|
|
2
|
|
|
|
|
18
|
|
|
8
|
|
|
|
|
|
|
|
|
9
|
|
|
|
|
|
|
# ABSTRACT: A single item to be benchmarked |
|
10
|
|
|
|
|
|
|
|
|
11
|
|
|
|
|
|
|
=head1 SYNOPSIS |
|
12
|
|
|
|
|
|
|
|
|
13
|
|
|
|
|
|
|
Here you are, looking at the object for one specific item. At this level things |
|
14
|
|
|
|
|
|
|
start to look much more like the unix 'time' command as this is a clock wrapped |
|
15
|
|
|
|
|
|
|
around a single 'item'. |
|
16
|
|
|
|
|
|
|
|
|
17
|
|
|
|
|
|
|
As a matter of comparison, lets look at a simple example: |
|
18
|
|
|
|
|
|
|
|
|
19
|
|
|
|
|
|
|
time perl -e 'for(1..3){print $_}' |
|
20
|
|
|
|
|
|
|
|
|
21
|
|
|
|
|
|
|
As a Tool::Bench::Item things would look something like: |
|
22
|
|
|
|
|
|
|
|
|
23
|
|
|
|
|
|
|
my $item = Tool::Bench::Item->new( |
|
24
|
|
|
|
|
|
|
name => 'Example', |
|
25
|
|
|
|
|
|
|
code => sub{qx{perl -e 'for(1..3){print $_}'}}, |
|
26
|
|
|
|
|
|
|
# to be fair we call perl again to include compile time |
|
27
|
|
|
|
|
|
|
); |
|
28
|
|
|
|
|
|
|
$item->run; |
|
29
|
|
|
|
|
|
|
printf qq{%0.3f\n} $item->times->[0]; |
|
30
|
|
|
|
|
|
|
|
|
31
|
|
|
|
|
|
|
This is a very simple example, with very simular outcomes. But there's more |
|
32
|
|
|
|
|
|
|
that an item provides, speciflcy the startup and teardown events. These are |
|
33
|
|
|
|
|
|
|
untimed CodeRefs that get run before and after the core 'code'. |
|
34
|
|
|
|
|
|
|
|
|
35
|
|
|
|
|
|
|
Here is another set of examples comparing to 'time': |
|
36
|
|
|
|
|
|
|
|
|
37
|
|
|
|
|
|
|
echo 'hello' > /tmp/example && time cat /tmp/example && rm /tmp/example |
|
38
|
|
|
|
|
|
|
|
|
39
|
|
|
|
|
|
|
Tool::Bench::Item->new( |
|
40
|
|
|
|
|
|
|
name => 'Example with startup and teardown', |
|
41
|
|
|
|
|
|
|
startup => sub{qx{echo 'hello' > /tmp/example}}, |
|
42
|
|
|
|
|
|
|
code => sub{qx{cat /tmp/example}}, |
|
43
|
|
|
|
|
|
|
teardown => sub{qx{rm /tmp/example}}, |
|
44
|
|
|
|
|
|
|
)->run; |
|
45
|
|
|
|
|
|
|
|
|
46
|
|
|
|
|
|
|
In both cases we only timed 'cat' not 'echo' or 'rm'. |
|
47
|
|
|
|
|
|
|
|
|
48
|
|
|
|
|
|
|
=head1 ATTRIBUTES |
|
49
|
|
|
|
|
|
|
|
|
50
|
|
|
|
|
|
|
=head2 name |
|
51
|
|
|
|
|
|
|
|
|
52
|
|
|
|
|
|
|
REQUIRED. |
|
53
|
|
|
|
|
|
|
|
|
54
|
|
|
|
|
|
|
Stores a string name for this item. |
|
55
|
|
|
|
|
|
|
|
|
56
|
|
|
|
|
|
|
=cut |
|
57
|
|
|
|
|
|
|
|
|
58
|
|
|
|
|
|
|
has name => |
|
59
|
|
|
|
|
|
|
is => 'ro', |
|
60
|
|
|
|
|
|
|
isa => 'Str', |
|
61
|
|
|
|
|
|
|
required => 1, |
|
62
|
|
|
|
|
|
|
; |
|
63
|
|
|
|
|
|
|
|
|
64
|
|
|
|
|
|
|
=head2 code |
|
65
|
|
|
|
|
|
|
|
|
66
|
|
|
|
|
|
|
REQUIRED. |
|
67
|
|
|
|
|
|
|
|
|
68
|
|
|
|
|
|
|
A CodeRef that is to be run. |
|
69
|
|
|
|
|
|
|
|
|
70
|
|
|
|
|
|
|
=cut |
|
71
|
|
|
|
|
|
|
|
|
72
|
|
|
|
|
|
|
has code => |
|
73
|
|
|
|
|
|
|
is => 'ro', |
|
74
|
|
|
|
|
|
|
isa => 'CodeRef', |
|
75
|
|
|
|
|
|
|
required => 1, |
|
76
|
|
|
|
|
|
|
; |
|
77
|
|
|
|
|
|
|
|
|
78
|
|
|
|
|
|
|
has [qw{pre_run buildup teardown post_run}] => |
|
79
|
|
|
|
|
|
|
is => 'ro', |
|
80
|
|
|
|
|
|
|
isa => 'CodeRef', |
|
81
|
|
|
|
|
|
|
default => sub{sub{}}, |
|
82
|
|
|
|
|
|
|
; |
|
83
|
|
|
|
|
|
|
|
|
84
|
|
|
|
|
|
|
has note => |
|
85
|
|
|
|
|
|
|
is => 'ro', |
|
86
|
|
|
|
|
|
|
isa => 'Str', |
|
87
|
|
|
|
|
|
|
default => '', |
|
88
|
|
|
|
|
|
|
; |
|
89
|
|
|
|
|
|
|
|
|
90
|
|
|
|
|
|
|
=head2 pre_run |
|
91
|
|
|
|
|
|
|
|
|
92
|
|
|
|
|
|
|
An untimed CodeRef that is executed only once before the run is 'executed'. |
|
93
|
|
|
|
|
|
|
|
|
94
|
|
|
|
|
|
|
=head2 buildup |
|
95
|
|
|
|
|
|
|
|
|
96
|
|
|
|
|
|
|
An untimed CodeRef that is executed everytime before 'run' is called. |
|
97
|
|
|
|
|
|
|
|
|
98
|
|
|
|
|
|
|
=head2 teardown |
|
99
|
|
|
|
|
|
|
|
|
100
|
|
|
|
|
|
|
An untimed CodeRef that is executed everytime after 'run' is called. |
|
101
|
|
|
|
|
|
|
|
|
102
|
|
|
|
|
|
|
=head2 post_run |
|
103
|
|
|
|
|
|
|
|
|
104
|
|
|
|
|
|
|
An untimed CodeRef that is executed only once after the run is 'executed'. |
|
105
|
|
|
|
|
|
|
|
|
106
|
|
|
|
|
|
|
=head2 note |
|
107
|
|
|
|
|
|
|
|
|
108
|
|
|
|
|
|
|
An optional string to better explain the item. |
|
109
|
|
|
|
|
|
|
|
|
110
|
|
|
|
|
|
|
=head2 results |
|
111
|
|
|
|
|
|
|
|
|
112
|
|
|
|
|
|
|
An ArrayRef that contains all the results. |
|
113
|
|
|
|
|
|
|
|
|
114
|
|
|
|
|
|
|
=head2 times |
|
115
|
|
|
|
|
|
|
|
|
116
|
|
|
|
|
|
|
An ArrayRef that contains all the times that a specific run took. |
|
117
|
|
|
|
|
|
|
|
|
118
|
|
|
|
|
|
|
=head2 errors |
|
119
|
|
|
|
|
|
|
|
|
120
|
|
|
|
|
|
|
An ArrayRef that contains all any errors that were captured. |
|
121
|
|
|
|
|
|
|
|
|
122
|
|
|
|
|
|
|
=cut |
|
123
|
|
|
|
|
|
|
|
|
124
|
|
|
|
|
|
|
has [qw{results times errors}] => |
|
125
|
|
|
|
|
|
|
is => 'rw', |
|
126
|
|
|
|
|
|
|
isa => 'ArrayRef', |
|
127
|
|
|
|
|
|
|
default => sub{[]}, |
|
128
|
|
|
|
|
|
|
; |
|
129
|
|
|
|
|
|
|
|
|
130
|
|
|
|
|
|
|
=head1 METHODS |
|
131
|
|
|
|
|
|
|
|
|
132
|
|
|
|
|
|
|
=head2 run |
|
133
|
|
|
|
|
|
|
|
|
134
|
|
|
|
|
|
|
$item->run; # a single run |
|
135
|
|
|
|
|
|
|
$item->run(3); # run the code 3 times |
|
136
|
|
|
|
|
|
|
|
|
137
|
|
|
|
|
|
|
Execute code and capture results, errors, and the time for each run. |
|
138
|
|
|
|
|
|
|
|
|
139
|
|
|
|
|
|
|
=cut |
|
140
|
|
|
|
|
|
|
|
|
141
|
|
|
|
|
|
|
before run => sub{ shift->buildup->() }; |
|
142
|
|
|
|
|
|
|
after run => sub{ shift->teardown->() }; |
|
143
|
|
|
|
|
|
|
|
|
144
|
|
|
|
|
|
|
sub run { |
|
145
|
|
|
|
|
|
|
my $self = shift; |
|
146
|
|
|
|
|
|
|
my $loop = shift || 1; |
|
147
|
|
|
|
|
|
|
for (1..$loop) { |
|
148
|
|
|
|
|
|
|
local $@; |
|
149
|
|
|
|
|
|
|
my $result; |
|
150
|
|
|
|
|
|
|
my $start = time(); |
|
151
|
|
|
|
|
|
|
eval { $result = $self->code->(); }; |
|
152
|
|
|
|
|
|
|
my $stop = time(); |
|
153
|
|
|
|
|
|
|
push @{ $self->times }, $stop - $start; |
|
154
|
|
|
|
|
|
|
push @{ $self->results }, $result; |
|
155
|
|
|
|
|
|
|
push @{ $self->errors }, $@; |
|
156
|
|
|
|
|
|
|
} |
|
157
|
|
|
|
|
|
|
return $self->total_runs; |
|
158
|
|
|
|
|
|
|
} |
|
159
|
|
|
|
|
|
|
|
|
160
|
|
|
|
|
|
|
|
|
161
|
|
|
|
|
|
|
#--------------------------------------------------------------------------- |
|
162
|
|
|
|
|
|
|
# REPORTING HOOKS |
|
163
|
|
|
|
|
|
|
#--------------------------------------------------------------------------- |
|
164
|
|
|
|
|
|
|
=head2 total_time |
|
165
|
|
|
|
|
|
|
|
|
166
|
|
|
|
|
|
|
The total time that all runs took to execute. |
|
167
|
|
|
|
|
|
|
|
|
168
|
|
|
|
|
|
|
=head2 min_time |
|
169
|
|
|
|
|
|
|
|
|
170
|
|
|
|
|
|
|
The fastest execute time. |
|
171
|
|
|
|
|
|
|
|
|
172
|
|
|
|
|
|
|
=head2 max_time |
|
173
|
|
|
|
|
|
|
|
|
174
|
|
|
|
|
|
|
The slowest execute time. |
|
175
|
|
|
|
|
|
|
|
|
176
|
|
|
|
|
|
|
=head2 avg_time |
|
177
|
|
|
|
|
|
|
|
|
178
|
|
|
|
|
|
|
The averge execute time, total_time / total_runs. |
|
179
|
|
|
|
|
|
|
|
|
180
|
|
|
|
|
|
|
= head2 total_runs |
|
181
|
|
|
|
|
|
|
|
|
182
|
|
|
|
|
|
|
The number of runs that we've captured thus far. |
|
183
|
|
|
|
|
|
|
|
|
184
|
|
|
|
|
|
|
=cut |
|
185
|
|
|
|
|
|
|
|
|
186
|
36
|
|
|
36
|
0
|
46
|
sub total_time { sum @{shift->times} } |
|
|
36
|
|
|
|
|
253
|
|
|
187
|
8
|
|
|
8
|
1
|
12
|
sub min_time { min @{shift->times} } |
|
|
8
|
|
|
|
|
44
|
|
|
188
|
8
|
|
|
8
|
1
|
10
|
sub max_time { max @{shift->times} } |
|
|
8
|
|
|
|
|
44
|
|
|
189
|
|
|
|
|
|
|
|
|
190
|
|
|
|
|
|
|
sub avg_time { |
|
191
|
8
|
|
|
8
|
1
|
12
|
my $self = shift; |
|
192
|
8
|
|
|
|
|
26
|
$self->total_time / $self->total_runs |
|
193
|
|
|
|
|
|
|
} |
|
194
|
|
|
|
|
|
|
|
|
195
|
39
|
|
|
39
|
0
|
1492
|
sub total_runs { scalar(@{ shift->results }) } |
|
|
39
|
|
|
|
|
353
|
|
|
196
|
|
|
|
|
|
|
|
|
197
|
|
|
|
|
|
|
1; |