ViewVC Help
View File | Revision Log | Show Annotations | Download File
/cvs/AnyEvent/lib/AnyEvent/Log.pm
(Generate patch)

Comparing AnyEvent/lib/AnyEvent/Log.pm (file contents):
Revision 1.2 by root, Tue Aug 16 14:47:27 2011 UTC vs.
Revision 1.16 by root, Sat Aug 20 02:19:18 2011 UTC

2 2
3AnyEvent::Log - simple logging "framework" 3AnyEvent::Log - simple logging "framework"
4 4
5=head1 SYNOPSIS 5=head1 SYNOPSIS
6 6
7 # simple use
8 use AnyEvent;
9
10 AE::log debug => "hit my knee";
11 AE::log warn => "it's a bit too hot";
12 AE::log error => "the flag was false!";
13 AE::log fatal => "the bit toggled! run!";
14
15 # "complex" use
7 use AnyEvent::Log; 16 use AnyEvent::Log;
17
18 my $tracer = AnyEvent::Log::logger trace => \$my $trace;
19
20 $tracer->("i am here") if $trace;
21 $tracer->(sub { "lots of data: " . Dumper $self }) if $trace;
22
23 # configuration
24
25 # set logging for this package to errors and higher only
26 AnyEvent::Log::ctx->level ("error");
27
28 # set logging globally to anything below debug
29 $AnyEvent::Log::Root->level ("notice");
30
31 # see also EXAMPLES, below
8 32
9=head1 DESCRIPTION 33=head1 DESCRIPTION
10 34
11This module implements a relatively simple "logging framework". It doesn't 35This module implements a relatively simple "logging framework". It doesn't
12attempt to be "the" logging solution or even "a" logging solution for 36attempt to be "the" logging solution or even "a" logging solution for
13AnyEvent - AnyEvent simply creates logging messages internally, and this 37AnyEvent - AnyEvent simply creates logging messages internally, and this
14module more or less exposes the mechanism, with some extra spiff to allow 38module more or less exposes the mechanism, with some extra spiff to allow
15using it from other modules as well. 39using it from other modules as well.
16 40
17Remember that the default verbosity level is C<0>, so nothing 41Remember that the default verbosity level is C<0>, so nothing will be
18will be logged, ever, unless you set C<$Anyvent::VERBOSE> or 42logged, unless you set C<PERL_ANYEVENT_VERBOSE> to a higher number before
19C<PERL_ANYEVENT_VERBOSE> to a higher number. 43starting your program, or change the logging level at runtime with
44something like:
20 45
21Possible future extensions are to allow custom log targets (where the 46 use AnyEvent;
22level is an object), log filtering based on package, formatting, aliasing 47 (AnyEvent::Log::ctx "")->level ("info");
23or package groups.
24 48
49The design goal behind this module was to keep it simple (and small),
50but make it powerful enough to be potentially useful for any module, and
51extensive enough for the most common tasks, such as logging to multiple
52targets, or being able to log into a database.
53
54The amount of documentation might indicate otherwise, but the module is
55still just 240 lines or so.
56
25=head1 LOG FUNCTIONS 57=head1 LOGGING FUNCTIONS
26 58
27These functions allow you to log messages. They always use the caller's 59These functions allow you to log messages. They always use the caller's
28package as a "logging module/source". Also, The main logging function is 60package as a "logging module/source". Also, the main logging function is
29easily available as C<AnyEvent::log> or C<AE::log> when the C<AnyEvent> 61callable as C<AnyEvent::log> or C<AE::log> when the C<AnyEvent> module is
30module is loaded. 62loaded.
31 63
32=over 4 64=over 4
33 65
34=cut 66=cut
35 67
37 69
38use Carp (); 70use Carp ();
39use POSIX (); 71use POSIX ();
40 72
41use AnyEvent (); BEGIN { AnyEvent::common_sense } 73use AnyEvent (); BEGIN { AnyEvent::common_sense }
74use AnyEvent::Util ();
75
76our $VERSION = $AnyEvent::VERSION;
42 77
43our ($now_int, $now_str1, $now_str2); 78our ($now_int, $now_str1, $now_str2);
44 79
45# Format Time, not public - yet? 80# Format Time, not public - yet?
46sub ft($) { 81sub ft($) {
51 if $now_int != $i; 86 if $now_int != $i;
52 87
53 "$now_str1$f$now_str2" 88 "$now_str1$f$now_str2"
54} 89}
55 90
91our %CTX; # all logging contexts
92
93# creates a default package context object for the given package
94sub _pkg_ctx($) {
95 my $ctx = bless [$_[0], (1 << 10) - 1 - 1, {}], "AnyEvent::Log::Ctx";
96
97 # link "parent" package
98 my $pkg = $_[0] =~ /^(.+)::/ ? $1 : "AE::Log::Top";
99
100 $pkg = $CTX{$pkg} ||= &_pkg_ctx ($pkg);
101 $ctx->[2]{$pkg+0} = $pkg;
102
103 $ctx
104}
105
56=item AnyEvent::Log::log $level, $msg[, @args] 106=item AnyEvent::Log::log $level, $msg[, @args]
57 107
58Requests logging of the given C<$msg> with the given log level (1..9). 108Requests logging of the given C<$msg> with the given log level (1..9).
59You can also use the following strings as log level: C<fatal> (1), 109You can also use the following strings as log level: C<fatal> (1),
60C<alert> (2), C<critical> (3), C<error> (4), C<warn> (5), C<note> (6), 110C<alert> (2), C<critical> (3), C<error> (4), C<warn> (5), C<note> (6),
66C<$msg> is interpreted as an sprintf format string. 116C<$msg> is interpreted as an sprintf format string.
67 117
68The C<$msg> should not end with C<\n>, but may if that is convenient for 118The C<$msg> should not end with C<\n>, but may if that is convenient for
69you. Also, multiline messages are handled properly. 119you. Also, multiline messages are handled properly.
70 120
71In addition, for possible future expansion, C<$msg> must not start with an 121Last not least, C<$msg> might be a code reference, in which case it is
72angle bracket (C<< < >>). 122supposed to return the message. It will be called only then the message
123actually gets logged, which is useful if it is costly to create the
124message in the first place.
73 125
74Whether the given message will be logged depends on the maximum log level 126Whether the given message will be logged depends on the maximum log level
75and the caller's package. 127and the caller's package.
76 128
77Note that you can (and should) call this function as C<AnyEvent::log> or 129Note that you can (and should) call this function as C<AnyEvent::log> or
78C<AE::log>, without C<use>-ing this module if possible, as those functions 130C<AE::log>, without C<use>-ing this module if possible (i.e. you don't
79will laod the logging module on demand only. 131need any additional functionality), as those functions will load the
132logging module on demand only. They are also much shorter to write.
133
134Also, if you optionally generate a lot of debug messages (such as when
135tracing some code), you should look into using a logger callback and a
136boolean enabler (see C<logger>, below).
137
138Example: log something at error level.
139
140 AE::log error => "something";
141
142Example: use printf-formatting.
143
144 AE::log info => "%5d %-10.10s %s", $index, $category, $msg;
145
146Example: only generate a costly dump when the message is actually being logged.
147
148 AE::log debug => sub { require Data::Dump; Data::Dump::dump \%cache };
80 149
81=cut 150=cut
82 151
83# also allow syslog equivalent names 152# also allow syslog equivalent names
84our %STR2LEVEL = ( 153our %STR2LEVEL = (
91 info => 7, 160 info => 7,
92 debug => 8, 161 debug => 8,
93 trace => 9, 162 trace => 9,
94); 163);
95 164
165sub now () { time }
166
167AnyEvent::post_detect {
168 *now = \&AE::now;
169};
170
96our @LEVEL2STR = qw(0 fatal alert crit error warn note info debug trace); 171our @LEVEL2STR = qw(0 fatal alert crit error warn note info debug trace);
97 172
173# time, ctx, level, msg
174sub _format($$$$) {
175 my $ts = ft $_[0];
176 my $ct = " ";
177
178 my @res;
179
180 for (split /\n/, sprintf "%-5s %s: %s", $LEVEL2STR[$_[2]], $_[1][0], $_[3]) {
181 push @res, "$ts$ct$_\n";
182 $ct = " + ";
183 }
184
185 join "", @res
186}
187
188sub _log {
189 my ($ctx, $level, $format, @args) = @_;
190
191 $level = $level > 0 && $level <= 9
192 ? $level+0
193 : $STR2LEVEL{$level} || Carp::croak "$level: not a valid logging level, caught";
194
195 my $mask = 1 << $level;
196
197 my (%seen, @ctx, $now, $fmt);
198
199 do
200 {
201 # skip if masked
202 if ($ctx->[1] & $mask && !$seen{$ctx+0}++) {
203 if ($ctx->[3]) {
204 # logging target found
205
206 # now get raw message, unless we have it already
207 unless ($now) {
208 $format = $format->() if ref $format;
209 $format = sprintf $format, @args if @args;
210 $format =~ s/\n$//;
211 $now = AE::now;
212 };
213
214 # format msg
215 my $str = $ctx->[4]
216 ? $ctx->[4]($now, $_[0], $level, $format)
217 : $fmt ||= _format $now, $_[0], $level, $format;
218
219 $ctx->[3]($str);
220 }
221
222 # not masked, not consumed - propagate to parent contexts
223 push @ctx, values %{ $ctx->[2] };
224 }
225 }
226 while $ctx = pop @ctx;
227
228 exit 1 if $level <= 1;
229}
230
98sub log($$;@) { 231sub log($$;@) {
99 my ($targ, $msg, @args) = @_; 232 _log
233 $CTX{ (caller)[0] } ||= _pkg_ctx +(caller)[0],
234 @_;
235}
100 236
101 my $level = ref $targ ? die "Can't use reference as logging level (yet)" 237*AnyEvent::log = *AE::log = \&log;
102 : $targ > 0 && $targ <= 9 ? $targ+0
103 : $STR2LEVEL{$targ} || Carp::croak "$targ: not a valid logging level, caught";
104 238
105 return if $level > $AnyEvent::VERBOSE; 239=item $logger = AnyEvent::Log::logger $level[, \$enabled]
106 240
107 my $pkg = (caller)[0]; 241Creates a code reference that, when called, acts as if the
242C<AnyEvent::Log::log> function was called at this point with the givne
243level. C<$logger> is passed a C<$msg> and optional C<@args>, just as with
244the C<AnyEvent::Log::log> function:
108 245
109 $msg = sprintf $msg, @args if @args; 246 my $debug_log = AnyEvent::Log::logger "debug";
110 $msg =~ s/\n$//;
111 247
112 # now we have a message, log it 248 $debug_log->("debug here");
113 #TODO: could do LOTS of stuff here, and should, at least in some later version 249 $debug_log->("%06d emails processed", 12345);
250 $debug_log->(sub { $obj->as_string });
114 251
115 $msg = sprintf "%5s (%s) %s", $LEVEL2STR[$level], $pkg, $msg; 252The idea behind this function is to decide whether to log before actually
116 my $pfx = ft AE::now; 253logging - when the C<logger> function is called once, but the returned
254logger callback often, then this can be a tremendous speed win.
117 255
118 for (split /\n/, $msg) { 256Despite this speed advantage, changes in logging configuration will
119 printf STDERR "$pfx $_\n"; 257still be reflected by the logger callback, even if configuration changes
120 $pfx = "\t"; 258I<after> it was created.
259
260To further speed up logging, you can bind a scalar variable to the logger,
261which contains true if the logger should be called or not - if it is
262false, calling the logger can be safely skipped. This variable will be
263updated as long as C<$logger> is alive.
264
265Full example:
266
267 # near the init section
268 use AnyEvent::Log;
269
270 my $debug_log = AnyEvent:Log::logger debug => \my $debug;
271
272 # and later in your program
273 $debug_log->("yo, stuff here") if $debug;
274
275 $debug and $debug_log->("123");
276
277=cut
278
279our %LOGGER;
280
281# re-assess logging status for all loggers
282sub _reassess {
283 for (@_ ? $LOGGER{$_[0]} : values %LOGGER) {
284 my ($ctx, $level, $renabled) = @$_;
285
286 # to detect whether a message would be logged, we # actually
287 # try to log one and die. this isn't fast, but we can be
288 # sure that the logging decision is correct :)
289
290 $$renabled = !eval {
291 local $SIG{__DIE__};
292
293 _log $ctx, $level, sub { die };
294
295 1
296 };
297
298 $$renabled = 1; # TODO
121 } 299 }
122
123 exit 1 if $level <= 1;
124} 300}
125 301
126*AnyEvent::log = *AE::log = \&log; 302sub _logger {
303 my ($ctx, $level, $renabled) = @_;
127 304
128#TODO 305 $$renabled = 1;
306
307 my $logger = [$ctx, $level, $renabled];
308
309 $LOGGER{$logger+0} = $logger;
310
311 _reassess $logger+0;
312
313 my $guard = AnyEvent::Util::guard {
314 # "clean up"
315 delete $LOGGER{$logger+0};
316 };
317
318 sub {
319 $guard if 0; # keep guard alive, but don't cause runtime overhead
320
321 _log $ctx, $level, @_
322 if $$renabled;
323 }
324}
325
326sub logger($;$) {
327 _logger
328 $CTX{ (caller)[0] } ||= _pkg_ctx +(caller)[0],
329 @_
330}
129 331
130=back 332=back
131 333
132=head1 CONFIGURATION FUNCTIONALITY 334=head1 LOGGING CONTEXTS
133 335
134None, yet, except for C<PERL_ANYEVENT_VERBOSE>, described in the L<AnyEvent> manpage. 336This module associates every log message with a so-called I<logging
337context>, based on the package of the caller. Every perl package has its
338own logging context.
339
340A logging context has three major responsibilities: filtering, logging and
341propagating the message.
342
343For the first purpose, filtering, each context has a set of logging
344levels, called the log level mask. Messages not in the set will be ignored
345by this context (masked).
346
347For logging, the context stores a formatting callback (which takes the
348timestamp, context, level and string message and formats it in the way
349it should be logged) and a logging callback (which is responsible for
350actually logging the formatted message and telling C<AnyEvent::Log>
351whether it has consumed the message, or whether it should be propagated).
352
353For propagation, a context can have any number of attached I<parent
354contexts>. Any message that is neither masked by the logging mask nor
355masked by the logging callback returning true will be passed to all parent
356contexts.
357
358Each call to a logging function will log the message at most once per
359context, so it does not matter (much) if there are cycles or if the
360message can arrive at the same context via multiple paths.
361
362=head2 DEFAULTS
363
364By default, all logging contexts have an full set of log levels ("all"), a
365disabled logging callback and the default formatting callback.
366
367Package contexts have the package name as logging title by default.
368
369They have exactly one parent - the context of the "parent" package. The
370parent package is simply defined to be the package name without the last
371component, i.e. C<AnyEvent::Debug::Wrapped> becomes C<AnyEvent::Debug>,
372and C<AnyEvent> becomes ... C<AnyEvent::Log::Top> which is the
373exception of the rule - just like the parent of any package name in
374Perl is C<main>, the default parent of any top-level package context is
375C<AnyEvent::Log::Top>.
376
377Since perl packages form only an approximate hierarchy, this parent
378context can of course be removed.
379
380All other (anonymous) contexts have no parents and an empty title by
381default.
382
383When the module is loaded it creates the default context called
384C<AnyEvent::Log::Default> (also stored in C<$AnyEvent::Log::Default>),
385which simply logs everything via C<warn> and doesn't propagate anything
386anywhere by default. The purpose of the default context is to provide
387a convenient place to override the global logging target or to attach
388additional log targets. It's not meant for filtering.
389
390It then creates the root context called C<AnyEvent::Log::Root> (also
391stored in C<$AnyEvent::Log::Root>) and sets its log level set to all
392levels up to the one specified by C<$ENV{PERL_ANYEVENT_VERBOSE}>. It
393then attached the default logging context to it. The purpose of the root
394context is to simply provide filtering according to some global log level.
395
396Finally it creates the top-level package context called
397C<AnyEvent::Log::Top> (also stored in, you might have guessed,
398C<$AnyEvent::Log::Top>) and attached the root context but otherwise leaves
399it at default config. It's purpose is simply to collect all log messages
400system-wide.
401
402These three special contexts can also be referred to by the
403package/context names C<AE::Log::Default>, C<AE::Log::Root> and
404C<AE::Log::Top>.
405
406The effect of all this is that log messages, by default, wander up
407to the root context where log messages with lower priority then
408C<$ENV{PERL_ANYEVENT_VERBOSE}> will be filtered away and then to the
409AnyEvent::Log::Default context to be passed to C<warn>.
410
411Splitting the top level context into three contexts makes it easy to set
412a global logging level (by modifying the root context), but still allow
413other contexts to log, for example, their debug and trace messages to the
414default target despite the global logging level, or to attach additional
415log targets that log messages, regardless of the global logging level.
416
417It also makes it easy to replace the default warn-logger by something that
418logs to a file, or to attach additional logging targets.
419
420=head2 CREATING/FINDING/DESTROYING CONTEXTS
135 421
136=over 4 422=over 4
137 423
424=item $ctx = AnyEvent::Log::ctx [$pkg]
425
426This function creates or returns a logging context (which is an object).
427
428If a package name is given, then the context for that packlage is
429returned. If it is called without any arguments, then the context for the
430callers package is returned (i.e. the same context as a C<AE::log> call
431would use).
432
433If C<undef> is given, then it creates a new anonymous context that is not
434tied to any package and is destroyed when no longer referenced.
435
138=cut 436=cut
437
438sub ctx(;$) {
439 my $pkg = @_ ? shift : (caller)[0];
440
441 ref $pkg
442 ? $pkg
443 : defined $pkg
444 ? $CTX{$pkg} ||= AnyEvent::Log::_pkg_ctx $pkg
445 : bless [undef, (1 << 10) - 1 - 1], "AnyEvent::Log::Ctx"
446}
447
448=item AnyEvent::Log::reset
449
450Resets all package contexts and recreates the default hierarchy if
451necessary, i.e. resets the logging subsystem to defaults, as much as
452possible. This process keeps references to contexts held by other parts of
453the program intact.
454
455This can be used to implement config-file (re-)loading: before loading a
456configuration, reset all contexts.
457
458=cut
459
460sub reset {
461 # hard to kill complex data structures
462 # we recreate all package loggers and reset the hierarchy
463 while (my ($k, $v) = each %CTX) {
464 @$v = ($k, (1 << 10) - 1 - 1, { });
465
466 my $pkg = $k =~ /^(.+)::/ ? $1 : "AE::Log::Top";
467 $v->attach ($CTX{$pkg});
468 }
469
470 $AnyEvent::Log::Default->parents;
471 $AnyEvent::Log::Default->title ("AnyEvent::Log::Default");
472 $AnyEvent::Log::Default->log_cb (sub {
473 warn shift;
474 0
475 });
476 $CTX{"AnyEvent::Log::Default"} = $CTX{"AE::Log::Default"} = $AnyEvent::Log::Default;
477
478 $AnyEvent::Log::Root->parents ($AnyEvent::Log::Default);
479 $AnyEvent::Log::Root->title ("AnyEvent::Log::Root");
480 $AnyEvent::Log::Root->level ($AnyEvent::VERBOSE);
481 $CTX{"AnyEvent::Log::Root"} = $CTX{"AE::Log::Root"} = $AnyEvent::Log::Root;
482
483 $AnyEvent::Log::Top->parents ($AnyEvent::Log::Root);
484 $AnyEvent::Log::Top->title ("AnyEvent::Log::Top");
485 $CTX{"AnyEvent::Log::Top"} = $CTX{"AE::Log::Top"} = $AnyEvent::Log::Top;
486
487 _reassess;
488}
489
490# create the default logger contexts
491$AnyEvent::Log::Default = ctx undef;
492$AnyEvent::Log::Root = ctx undef;
493$AnyEvent::Log::Top = ctx undef;
494
495AnyEvent::Log::reset;
496
497# hello, CPAN, please catch me
498package AnyEvent::Log::Default;
499package AE::Log::Default;
500package AnyEvent::Log::Root;
501package AE::Log::Root;
502package AnyEvent::Log::Top;
503package AE::Log::Top;
504
505package AnyEvent::Log::Ctx;
506
507# 0 1 2 3 4
508# [$title, $level, %$parents, &$logcb, &$fmtcb]
509
510=item $ctx = new AnyEvent::Log::Ctx methodname => param...
511
512This is a convenience constructor that makes it simpler to construct
513anonymous logging contexts.
514
515Each key-value pair results in an invocation of the method of the same
516name as the key with the value as parameter, unless the value is an
517arrayref, in which case it calls the method with the contents of the
518array. The methods are called in the same order as specified.
519
520Example: create a new logging context and set both the default logging
521level, some parent contexts and a logging callback.
522
523 $ctx = new AnyEvent::Log::Ctx
524 title => "dubious messages",
525 level => "error",
526 log_cb => sub { print STDOUT shift; 0 },
527 parents => [$ctx1, $ctx, $ctx2],
528 ;
529
530=back
531
532=cut
533
534sub new {
535 my $class = shift;
536
537 my $ctx = AnyEvent::Log::ctx undef;
538
539 while (@_) {
540 my ($k, $v) = splice @_, 0, 2;
541 $ctx->$k (ref $v eq "ARRAY" ? @$v : $v);
542 }
543
544 bless $ctx, $class # do we really support subclassing, hmm?
545}
546
547
548=head2 CONFIGURING A LOG CONTEXT
549
550The following methods can be used to configure the logging context.
551
552=over 4
553
554=item $ctx->title ([$new_title])
555
556Returns the title of the logging context - this is the package name, for
557package contexts, and a user defined string for all others.
558
559If C<$new_title> is given, then it replaces the package name or title.
560
561=cut
562
563sub title {
564 $_[0][0] = $_[1] if @_ > 1;
565 $_[0][0]
566}
567
568=back
569
570=head3 LOGGING LEVELS
571
572The following methods deal with the logging level set associated with the
573log context.
574
575The most common method to use is probably C<< $ctx->level ($level) >>,
576which configures the specified and any higher priority levels.
577
578All functions which accept a list of levels also accept the special string
579C<all> which expands to all logging levels.
580
581=over 4
582
583=item $ctx->levels ($level[, $level...)
584
585Enables logging for the given levels and disables it for all others.
586
587=item $ctx->level ($level)
588
589Enables logging for the given level and all lower level (higher priority)
590ones. In addition to normal logging levels, specifying a level of C<0> or
591C<off> disables all logging for this level.
592
593Example: log warnings, errors and higher priority messages.
594
595 $ctx->level ("warn");
596 $ctx->level (5); # same thing, just numeric
597
598=item $ctx->enable ($level[, $level...])
599
600Enables logging for the given levels, leaving all others unchanged.
601
602=item $ctx->disable ($level[, $level...])
603
604Disables logging for the given levels, leaving all others unchanged.
605
606=cut
607
608sub _lvl_lst {
609 map {
610 $_ > 0 && $_ <= 9 ? $_+0
611 : $_ eq "all" ? (1 .. 9)
612 : $STR2LEVEL{$_} || Carp::croak "$_: not a valid logging level, caught"
613 } @_
614}
615
616our $NOP_CB = sub { 0 };
617
618sub levels {
619 my $ctx = shift;
620 $ctx->[1] = 0;
621 $ctx->[1] |= 1 << $_
622 for &_lvl_lst;
623 AnyEvent::Log::_reassess;
624}
625
626sub level {
627 my $ctx = shift;
628 my $lvl = $_[0] =~ /^(?:0|off|none)$/ ? 0 : (_lvl_lst $_[0])[-1];
629
630 $ctx->[1] = ((1 << $lvl) - 1) << 1;
631 AnyEvent::Log::_reassess;
632}
633
634sub enable {
635 my $ctx = shift;
636 $ctx->[1] |= 1 << $_
637 for &_lvl_lst;
638 AnyEvent::Log::_reassess;
639}
640
641sub disable {
642 my $ctx = shift;
643 $ctx->[1] &= ~(1 << $_)
644 for &_lvl_lst;
645 AnyEvent::Log::_reassess;
646}
647
648=back
649
650=head3 PARENT CONTEXTS
651
652The following methods attach and detach another logging context to a
653logging context.
654
655Log messages are propagated to all parent contexts, unless the logging
656callback consumes the message.
657
658=over 4
659
660=item $ctx->attach ($ctx2[, $ctx3...])
661
662Attaches the given contexts as parents to this context. It is not an error
663to add a context twice (the second add will be ignored).
664
665A context can be specified either as package name or as a context object.
666
667=item $ctx->detach ($ctx2[, $ctx3...])
668
669Removes the given parents from this context - it's not an error to attempt
670to remove a context that hasn't been added.
671
672A context can be specified either as package name or as a context object.
673
674=item $ctx->parents ($ctx2[, $ctx3...])
675
676Replaces all parents attached to this context by the ones given.
677
678=cut
679
680sub attach {
681 my $ctx = shift;
682
683 $ctx->[2]{$_+0} = $_
684 for map { AnyEvent::Log::ctx $_ } @_;
685}
686
687sub detach {
688 my $ctx = shift;
689
690 delete $ctx->[2]{$_+0}
691 for map { AnyEvent::Log::ctx $_ } @_;
692}
693
694sub parents {
695 undef $_[0][2];
696 &attach;
697}
698
699=back
700
701=head3 MESSAGE LOGGING
702
703The following methods configure how the logging context actually does
704the logging (which consists of formatting the message and printing it or
705whatever it wants to do with it) and also allows you to log messages
706directly to a context, without going via your package context.
707
708=over 4
709
710=item $ctx->log_cb ($cb->($str))
711
712Replaces the logging callback on the context (C<undef> disables the
713logging callback).
714
715The logging callback is responsible for handling formatted log messages
716(see C<fmt_cb> below) - normally simple text strings that end with a
717newline (and are possibly multiline themselves).
718
719It also has to return true iff it has consumed the log message, and false
720if it hasn't. Consuming a message means that it will not be sent to any
721parent context. When in doubt, return C<0> from your logging callback.
722
723Example: a very simple logging callback, simply dump the message to STDOUT
724and do not consume it.
725
726 $ctx->log_cb (sub { print STDERR shift; 0 });
727
728You can filter messages by having a log callback that simply returns C<1>
729and does not do anything with the message, but this counts as "message
730being logged" and might not be very efficient.
731
732Example: propagate all messages except for log levels "debug" and
733"trace". The messages will still be generated, though, which can slow down
734your program.
735
736 $ctx->levels ("debug", "trace");
737 $ctx->log_cb (sub { 1 }); # do not log, but eat debug and trace messages
738
739=item $ctx->fmt_cb ($fmt_cb->($timestamp, $ctx, $level, $message))
740
741Replaces the formatting callback on the context (C<undef> restores the
742default formatter).
743
744The callback is passed the (possibly fractional) timestamp, the original
745logging context, the (numeric) logging level and the raw message string and needs to
746return a formatted log message. In most cases this will be a string, but
747it could just as well be an array reference that just stores the values.
748
749Example: format just the raw message, with numeric log level in angle
750brackets.
751
752 $ctx->fmt_cb (sub {
753 my ($time, $ctx, $lvl, $msg) = @_;
754
755 "<$lvl>$msg\n"
756 });
757
758Example: return an array reference with just the log values, and use
759C<PApp::SQL::sql_exec> to store the emssage in a database.
760
761 $ctx->fmt_cb (sub { \@_ });
762 $ctx->log_cb (sub {
763 my ($msg) = @_;
764
765 sql_exec "insert into log (when, subsys, prio, msg) values (?, ?, ?, ?)",
766 $msg->[0] + 0,
767 "$msg->[1]",
768 $msg->[2] + 0,
769 "$msg->[3]";
770
771 0
772 });
773
774=cut
775
776sub log_cb {
777 my ($ctx, $cb) = @_;
778
779 $ctx->[3] = $cb;
780}
781
782sub fmt_cb {
783 my ($ctx, $cb) = @_;
784
785 $ctx->[4] = $cb;
786}
787
788=item $ctx->log ($level, $msg[, @params])
789
790Same as C<AnyEvent::Log::log>, but uses the given context as log context.
791
792=item $logger = $ctx->logger ($level[, \$enabled])
793
794Same as C<AnyEvent::Log::logger>, but uses the given context as log
795context.
796
797=cut
798
799*log = \&AnyEvent::Log::_log;
800*logger = \&AnyEvent::Log::_logger;
139 801
1401; 8021;
803
804=back
805
806=head1 EXAMPLES
807
808This section shows some common configurations.
809
810=over 4
811
812=item Setting the global logging level.
813
814Either put PERL_ANYEVENT_VERBOSE=<number> into your environment before
815running your program, or modify the log level of the root context:
816
817 PERL_ANYEVENT_VERBOSE=5 ./myprog
818
819 $AnyEvent::Log::Root->level ("warn");
820
821=item Append all messages to a file instead of sending them to STDERR.
822
823This is affected by the global logging level.
824
825 open my $fh, ">>", $path
826 or die "$path: $!";
827
828 $AnyEvent::Log::Default->log_cb (sub {
829 syswrite $fh, shift;
830 0
831 });
832
833=item Write all messages with priority C<error> and higher to a file.
834
835This writes them only when the global logging level allows it, because
836it is attached to the default context which is invoked I<after> global
837filtering.
838
839 open my $fh, ">>", $path
840 or die "$path: $!";
841
842 $AnyEvent::Log::Default->attach (new AnyEvent::Log::Ctx
843 log_cb => sub { syswrite $fh, shift; 0 });
844
845This writes them regardless of the global logging level, because it is
846attached to the toplevel context, which receives all messages I<before>
847the global filtering.
848
849 $AnyEvent::Log::Top->attach (new AnyEvent::Log::Ctx
850 log_cb => sub { syswrite $fh, shift; 0 });
851
852In both cases, messages are still written to STDOUT.
853
854=item Write trace messages (only) from L<AnyEvent::Debug> to the default logging target(s).
855
856Attach the CyAnyEvent::Log::Default> context to the C<AnyEvent::Debug>
857context and increase the C<AnyEvent::Debug> logging level - this simply
858circumvents the global filtering for trace messages.
859
860 my $debug = AnyEvent::Debug->AnyEvent::Log::ctx;
861 $debug->attach ($AnyEvent::Log::Default);
862 $debug->levels ("trace"); # not "level"!
863
864This of course works for any package.
141 865
142=back 866=back
143 867
144=head1 AUTHOR 868=head1 AUTHOR
145 869

Diff Legend

Removed lines
+ Added lines
< Changed lines
> Changed lines