File: benchmark.pl

package info (click to toggle)
liblog-handler-perl 0.90-2
  • links: PTS, VCS
  • area: main
  • in suites: bookworm, forky, sid, trixie
  • size: 576 kB
  • sloc: perl: 2,758; makefile: 4
file content (175 lines) | stat: -rw-r----- 4,328 bytes parent folder | download | duplicates (4)
1
2
3
4
5
6
7
8
9
10
11
12
13
14
15
16
17
18
19
20
21
22
23
24
25
26
27
28
29
30
31
32
33
34
35
36
37
38
39
40
41
42
43
44
45
46
47
48
49
50
51
52
53
54
55
56
57
58
59
60
61
62
63
64
65
66
67
68
69
70
71
72
73
74
75
76
77
78
79
80
81
82
83
84
85
86
87
88
89
90
91
92
93
94
95
96
97
98
99
100
101
102
103
104
105
106
107
108
109
110
111
112
113
114
115
116
117
118
119
120
121
122
123
124
125
126
127
128
129
130
131
132
133
134
135
136
137
138
139
140
141
142
143
144
145
146
147
148
149
150
151
152
153
154
155
156
157
158
159
160
161
162
163
164
165
166
167
168
169
170
171
172
173
174
175
#!/usr/bin/perl

=head1 AUTHOR

Jonny Schulz <jschulz.cpan(at)bloonix.de>

=head1 DESCRIPTION

Benchmarks... what else could I say...

=head1 POWERED BY

     _    __ _____ _____ __  __ __ __   __
    | |__|  |     |     |  \|  |__|\  \/  /
    |  . |  |  |  |  |  |      |  | >    <
    |____|__|_____|_____|__|\__|__|/__/\__\

=head1 COPYRIGHT

Copyright (C) 2007-2009 by Jonny Schulz. All rights reserved.

This program is free software; you can redistribute it and/or
modify it under the same terms as Perl itself.

=cut

use strict;
use warnings;
use Log::Handler;
use Benchmark;

sub buffer { }
my $log1 = Log::Handler->new(); # simple pattern
my $log2 = Log::Handler->new(); # default pattern & suppressed
my $log3 = Log::Handler->new(); # complex pattern
my $log4 = Log::Handler->new(); # message pattern
my $log5 = Log::Handler->new(); # filtered caller
my $log6 = Log::Handler->new(); # filtered message
my $log7 = Log::Handler->new(); # categories

$log1->add(
    forward => {
        alias      => 'simple pattern',
        maxlevel   => 'notice',
        minlevel   => 'notice',
        forward_to => \&buffer,
        message_layout => '%L - %m',
    }
);

$log2->add(
    forward => {
        alias      => 'default pattern & suppressed',
        maxlevel   => 'warning',
        minlevel   => 'warning',
        forward_to => \&buffer,
    }
);

$log3->add(
    forward => {
        alias      => 'complex pattern',
        maxlevel   => 'info',
        minlevel   => 'info',
        forward_to => \&buffer,
        message_layout => '%T [%L] %H(%P) %m (%C)%N',
    }
);

$log4->add(
    forward => {
        alias      => 'message pattern',
        maxlevel   => 'error',
        minlevel   => 'error',
        forward_to => \&buffer,
        message_layout  => '%m',
        message_pattern => [qw/%T %L %P/],
    }
);

$log5->add(
    forward => {
        alias      => 'filtered caller',
        maxlevel   => 'emerg',
        minlevel   => 'emerg',
        forward_to => \&buffer,
        filter_caller => qr/^Foo\z/,
    }
);

$log5->add(
    forward => {
        alias      => 'filtered caller',
        maxlevel   => 'emerg',
        minlevel   => 'emerg',
        forward_to => \&buffer,
        filter_caller => qr/^Bar\z/,
    }
);

$log5->add(
    forward => {
        alias      => 'filtered caller',
        maxlevel   => 'emerg',
        minlevel   => 'emerg',
        forward_to => \&buffer,
        filter_caller => qr/^Baz\z/,
    }
);

$log6->add(
    forward => {
        alias      => 'filtered message',
        maxlevel   => 'alert',
        minlevel   => 'alert',
        forward_to => \&buffer,
        filter_message => qr/bar/,
    }
);

$log6->add(
    forward => {
        alias      => 'filtered message',
        maxlevel   => 'alert',
        minlevel   => 'alert',
        forward_to => \&buffer,
        filter_message => qr/bar/,
    }
);

$log7->add(
    forward => {
        alias      => 'categories',
        maxlevel   => 'alert',
        minlevel   => 'alert',
        forward_to => \&buffer,
        category   => "Cat::Foo",
    }
);

my $count   = 100_000;
my $message = 'foo bar baz';

run("simple pattern output took", $count, sub { $log1->notice($message) } );
run("default pattern output took", $count, sub { $log2->warning($message) } );
run("complex pattern output took", $count, sub { $log3->info($message) } );
run("message pattern output took", $count, sub { $log4->error($message) } );
run("suppressed output took", $count, sub { $log2->debug($message) } );
run("filtered caller output took", $count, \&Foo::emerg );
run("suppressed caller output took", $count, \&Foo::Bar::emerg );
run("filtered messages output took", $count, sub { $log6->alert($message) } );
run("categorized messages output took", $count, \&Cat::Foo::Bar::alert );
run("suppressed categories output took", $count, \&Cat::Bar::Baz::alert );

sub run {
    my ($desc, $count, $bench) = @_;
    my $time = timeit($count, $bench);
    print sprintf('%-30s', $desc), ' : ', timestr($time), "\n";
}

# Filter messages by caller
package Foo;
sub emerg { $log5->emerg($message) }

# Suppressed messages by caller
package Foo::Bar;
sub emerg { $log5->emerg($message) }

package Cat::Foo::Bar;
sub alert { $log7->alert($message) }

package Cat::Bar::Baz;
sub alert { $log7->alert($message) }

1;