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

Diff Legend

Removed lines
+ Added lines
< Changed lines
> Changed lines