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
|
#!/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;
my $BUFFER;
sub buffer {
$BUFFER .= shift->{message};
}
my $log = Log::Handler->new();
$log->add(
forward => {
alias => 'complex',
maxlevel => 'info',
minlevel => 'info',
forward_to => \&buffer,
message_layout => '%T [%L] %H(%P) %m (%C)%N',
}
);
$log->add(
forward => {
alias => 'simple',
maxlevel => 'notice',
minlevel => 'notice',
newline => 1,
forward_to => \&buffer,
message_layout => '%L - %m',
}
);
$log->add(
forward => {
alias => 'default & suppressed',
maxlevel => 'warning',
minlevel => 'warning',
newline => 1,
forward_to => \&buffer,
}
);
$log->add(
forward => {
alias => 'message pattern',
maxlevel => 'error',
minlevel => 'error',
newline => 1,
forward_to => \&buffer,
message_layout => '%m',
message_pattern => [qw/%T %L %P/],
}
);
$log->add(
forward => {
alias => 'filter caller',
maxlevel => 'emerg',
minlevel => 'emerg',
newline => 1,
forward_to => \&buffer,
filter_caller => qr/^Foo::Bar\z/,
}
);
$log->add(
forward => {
alias => 'filter message',
maxlevel => 'alert',
minlevel => 'alert',
newline => 1,
forward_to => \&buffer,
filter_message => qr/bar/,
}
);
my $count = 100_000;
my $message = 'foo bar baz';
run("simple pattern output took", $count, sub { $log->notice($message) } );
run("default pattern output took", $count, sub { $log->warning($message) } );
run("complex pattern output took", $count, sub { $log->info($message) } );
run("message pattern output took", $count, sub { $log->error($message) } );
run("suppressed output took", $count, sub { $log->debug($message) } );
run("filtered caller output took", $count, \&Foo::Bar::emerg );
run("suppressed caller output took", $count, \&Foo::Baz::emerg );
run("filtered messages output took", $count, sub { $log->alert($message) } );
sub run {
my ($desc, $count, $bench) = @_;
my $time = timeit($count, $bench);
print sprintf('%-30s', $desc), ' : ', timestr($time), "\n";
undef $BUFFER;
}
# Filter messages by caller
package Foo::Bar;
sub emerg { $log->emerg($message) }
# Suppressed messages by caller
package Foo::Baz;
sub emerg { $log->emerg($message) }
1;
|
