NAME
Log::Log4perl::Tiny - mimic Log::Log4perl in one single module
VERSION
This document describes Log::Log4perl::Tiny version 1.8.0.
SYNOPSIS
use Log::Log4perl::Tiny qw( :easy );
Log::Log4perl->easy_init({
file => '/var/log/something.log',
layout => '[%d] [%-5P:%-5p] %m%n',
level => $INFO,
});
WARN 'something weird happened';
INFO 'just doing it';
DEBUG 'this does not get printed at $INFO level';
# LOGLEVEL isn't in Log::Log4perl, but might come handy
LOGLEVEL($DEBUG); # enable debugging for small section
# otherwise, "get_logger()->level($DEBUG)", see below
DEBUG 'now this gets printed';
LOGLEVEL($INFO); # disable debugging again
DEBUG 'skipped, again';
DEBUG 'complex evaluation value:', sub {
# evaluation skipped if log level filters DEBUG out
};
# Object-oriented interface is available as well
my $logger = get_logger();
$logger->level($DEBUG); # enable debugging for small section
$logger->debug('whatever you want');
$logger->level($INFO); # disable debugging again
# All stealth loggers are available
LOGCONFESS 'I cannot accept this, for a whole stack of reasons!';
# Want to change layout?
$logger->layout('[%d %p] %m%n');
# or, equivalently
$logger->format('[%d %p] %m%n');
# Want to send the output somewhere else?
use IO::Handle;
open my $fh, '>>', '/path/to/new.log';
$fh->autoflush();
$logger->fh($fh);
# Want to multiplex output to different channels?
$logger->fh(
build_channels(
fh => \*STDERR,
file_create => '/var/log/lastrun.log',
file_append => '/var/log/overall.log',
)
);
# Want to handle the output message by yourself?
my @queue; # e.g. all log messages will be put here
$logger->fh(sub { push @queue, $_[0] });
# As of 1.4.0, you can set key-value pairs in the logger
$logger->loglocal(foo => 'bar');
LOGLOCAL(baz => 100);
# You can later retrieve the value in the format with %{key}e
$logger->format("[%{foo}e] [%{baz}e] %m%n");
# You are not limited to scalars, you can use references too
LOGLOCAL(baz => sub {
my ($data, $op, $ekey) = @_;
return join '.', @{$data->{tod}}; # epoch from gettimeofday
});
LOGLOCAL(foo => sub { return rand 100 });
DESCRIPTION
Yes... yet another logging module. Nothing particularly fancy nor original, too, but a single-module implementation of the features I use most from Log::Log4perl for quick things, namely:
easy mode and stealth loggers (aka log functions
INFO
,WARN
, etc.);debug message filtering by log level;
line formatting customisation;
quick sending of messages to a log file.
There are many, many things that are not included; probably the most notable one is the ability to provide a configuration file.
Why?
I have really nothing against Log::Log4perl, to the point that one of the import options is to check whether Log::Log4perl is installed and use it if possible. I just needed to crunch the plethora of modules down to a single-file module, so that I can embed it easily in scripts I use in machines where I want to reduce my impact as much as possible.
Log Levels
Log::Log4perl::Tiny implements all standard Log::Log4perl's log levels, without the possibility to change them. The correspondent values are available in the following variables (in order of increasing severity or importance):
The default log level is $INFO
. In addition to the above, the following levels are defined as well:
$OFF
-
also in Log::Log4perl, useful to turn off all logging except for
ALWAYS
$DEAD
-
not in Log::Log4perl, when the threshold log level is set to this value every log is blocked (even when called from the
ALWAYS
stealth logger).
You can import these variables using the :levels
import facility, or you can use the directly from the Log::Log4perl::Tiny namespace. They are imported automatically if the :easy
import option is specified.
Default Log Level
As of version 1.1.0 the default logging level is still $INFO
like any previous version, but it is possible to modify this value to $DEAD
through the :dead_if_first
import key.
This import key is useful to load Log::Log4perl in modules that you want to publish but where you don't want to force the end user to actually use it. In other terms, if you do this:
package My::Module;
use Log::Log4perl::Tiny qw( :easy :dead_if_first );
you will import all the functionalities associated to :easy
but will silence the logger off unless somewhere else the module is loaded (and imported) without this option. In this way:
if the user of your module does not import Log::Log4perl::Tiny, all log messages will be dropped (thanks to the log level set to
$DEAD
)otherwise, if the user imports Log::Log4perl::Tiny without the option, the log level will be set to the default value (unless it has already been explicitly set somewhere else).
Easy Mode Overview
I love Log::Log4perl's easy mode because it lets you set up a sophisticated logging infrastructure with just a few keystrokes:
use Log::Log4perl qw( :easy );
Log::Log4perl->easy_init({
file => '>>/var/log/something.log',
layout => '[%d] [%-5P:%-5p] %m%n',
level => $INFO,
});
INFO 'program started, yay!';
use Data::Dumper;
DEBUG 'Some stuff in main package', sub { Dumper(\%main::) };
If you want, you can replicate it with just a change in the first line:
use Log::Log4perl::Tiny qw( :easy );
Log::Log4perl->easy_init({
file => '>>/var/log/something.log',
layout => '[%d] [%-5P:%-5p] %m%n',
level => $INFO,
});
INFO 'program started, yay!';
use Data::Dumper;
DEBUG 'Some stuff in main package', sub { Dumper(\%main::) };
Well... yes, I'm invading the Log::Log4perl namespace in order to reduce the needed changes as mush as possible. This is useful when I begin using Log::Log4perl and then realise I want to make a single script with all modules embedded. There is also another reason why I put easy_init()
in Log::Log4perl namespace:
use Log::Log4perl::Tiny qw( :full_or_fake :easy );
Log::Log4perl->easy_init({
file => '>>/var/log/something.log',
layout => '[%d] [%-5P:%-5p] %m%n',
level => $INFO,
});
INFO 'program started, yay!';
use Data::Dumper;
DEBUG 'Some stuff in main package', sub { Dumper(\%main::) };
With import option full_or_fake
, in fact, the module first tries to load Log::Log4perl in the caller's namespace with the provided options (except full_or_fake
, of course), returning immediately if it is successful; otherwise, it tries to "fake" Log::Log4perl and installs its own logging functions. In this way, if Log::Log4perl is available it will be used, but you don't have to change anything if it isn't.
Easy mode tries to mimic what Log::Log4perl does, or at least the things that (from a purely subjective point of view) are most useful: easy_init()
and stealth loggers.
easy_init()
Log::Log4perl::Tiny only supports three options from the big brother, plus its own:
level
-
the log level threshold. Logs sent at a higher or equal priority (i.e. at a more important level, or equal) will be printed out, the others will be ignored. The default value is
$INFO
; file
-
a file name where to send the log lines. For compatibility with Log::Log4perl, a 2-arguments
open()
will be performed, which means you can easily set the opening mode, e.g.>>filename
.Note that the 2-arguments
open()
is intrinsically insecure and will trigger the following error when running setuid:Insecure dependency in open while running setuid
so be sure to use either
file_create
orfile_append
instead if you're running setuid. These are extensions added by Log::Log4perl::Tiny to cope with this specific case (and also to allow you avoid the 2-argsopen()
anyway).Another Log::Log4perl::Tiny extension added as of version 1.3.0 is the key
channels
where you can pass an array reference with channels descriptions (see "build_channels" for details).The default is to send logging messages to
STDERR
; filter
-
(Not in Log::Log4perl) (As of 1.8.0)
a filter function to be applied onto every message before it is emitted. This can be useful for multi-line log messages, when a specific start-of-line is needed (e.g. a hash character).
By default nothing is done.
layout
-
the log line layout (it can also be spelled
format
, they are synonims). The default value is the following:[%d] [%5p] %m%n
which means date in brackets, then log level in brackets always using five chars, left-aligned, the log message and a newline.
If you call easy_init()
with a single unblessed scalar, it is considered to be the level
and it will be set accordingly. Otherwise, you have to pass a hash ref with the keys above.
In addition to the above keys, the easy_init()
method installed by Log::Log4perl::Tiny also accepts all keys defined for "new", e.g. format
(an alias for layout
) and the different alternatives to file
(file_insecure
, file_create
and file_append
).
Stealth Loggers
Stealth loggers are functions that emit a log message at a given severity; they are installed when :easy
mode is turned on (see "Easy Mode Overview").
They are named after the corresponding level:
TRACE
DEBUG
INFO
WARN
ERROR
FATAL
Additionally, you get the following logger functions (again, these are in line with Log::Log4perl):
ALWAYS
-
emit log whatever the configured logging level, apart from
$DEAD
that disables all logging; LOGWARN
-
emit log at
WARN
level and thenwarn()
it; LOGDIE
-
emit log at
FATAL
level,die()
and then exit (ifdie()
didn't already exit); LOGEXIT
-
emit log at
FATAL
level and then exit; LOGCARP
-
emit log at
WARN
level and then callCarp::carp()
; LOGCLUCK
-
emit log at
WARN
level and then callCarp::cluck()
; LOGCROAK
-
emit log at
FATAL
level and then callCarp::croak()
; LOGCONFESS
-
emit log at
FATAL
level and then callCarp::confess()
;
If you want to set the exit code for LOGEXIT
above (and LOGDIE
as well, in case die()
does not exit by itself), you can go "the Log::Log4perl way" and set $Log::Log4perl::LOGEXIT_CODE
, or set a code with logexit_code()
- but you have to wait to read something about the object-oriented interface before doing this!
As indicated, functions "LOGWARN", "LOGDIE", "LOGCARP", "LOGCLUCK", "LOGCROAK", and "LOGCONFESS" (as well as their lowercase counterparts called as object methods) both emit the log message on the normal output channel for Log::Log4perl::Tiny and call the respective function. This might not be what you want in the default case where the output channel is standard error, because you will end up with duplicate error messages. You can avoid the call to the canonical function setting import option :no_extra_logdie_message
, in line with what Log::Log4perl provides.
There is also one additional stealth function that Log::Log4perl misses but that I think is of the outmoste importance: LOGLEVEL
, to set the log level threshold for printing. If you want to be 100% compatible with Log::Log4perl, anyway, you should rather do the following:
get_logger()->level(...); # instead of LOGLEVEL(...)
This function does not get imported when you specify :easy
, anyway, so you have to import it explicitly. This will help you remembering that you are deviating from Log::Log4perl.
Emitting Logs
To emit a log, you can call any of the stealth logger functions or any of the corresponding log methods. All the parameters that you pass are sent to the output stream as they are, except code references that are first evaluated. This lets you embed costly evaluations (e.g. generate heavy dumps of variabls) inside subroutines, and avoid the cost of evaluation in case the log is filtered out:
use Data::Dumper;
LOGLEVEL($INFO); # cut DEBUG and TRACE out
TRACE 'costly evaluation: ', sub { Dumper($heavy_object) };
# Dumper() is not actually called because DEBUG level is
# filtered out
If you use the log()
method, the first parameter is the log level, then the others are interpreted as described above.
Log Line Layout
The log line layout sets the contents of a log line. The layout is configured as a printf
-like string, with placeholder identifiers that are modeled (with simplifications) after Log::Log4perl's ones:
%c Category of the logging event.
%C Fully qualified package (or class) name of the caller
%d Current date in yyyy/MM/dd hh:mm:ss format
%D Current date in strftime's "%Y-%m-%d %H:%M:%S.$u%z" (localtime)
%{type}D Current date as strftime's "%Y-%m-%d %H:%M:%S.$u%z"
(type can be utc or local)
%{key}e Evaluate or substitute (extension WRT Log::Log4perl)
%F File where the logging event occurred
%H Hostname
%l Fully qualified name of the calling method followed by the
callers source the file name and line number between
parentheses.
%L Line number within the file where the log statement was issued
%m The message to be logged
%M Method or function where the logging request was issued
%n Newline (OS-independent)
%p Priority of the logging event
%P pid of the current process
%r Number of milliseconds elapsed from program start to logging
event
%R Number of milliseconds elapsed from last logging event including
a %R to current logging event
%T A stack trace of functions called
%% A literal percent (%) sign
Notably, both %x
(NDC) and %X
(MDC) are missing. The functionality for the latter is partially covered by the extension %e
explained below. Moreover, the extended specifier feature with additional info in braces (like %d{HH:mm}
) is missing, i.e. the structure of each specifier above is fixed. (Thanks to Log::Tiny
for the cool trick of how to handle the printf
-like string, which is probably mutuated from Log::Log4perl
itself according to the comments).
There are also two extensions with respect to Log::Log4perl, that help partially cover the missing items explained above, as of release 1.4.0:
%D
%{type}D
-
expanded to a timestamp according to "strftime" in POSIX specifier
%Y-%m-%d %H:%M:%S.$u%z
, i.e. a timestamp that includes up to the microsecond (on platform where this is available, otherwise zeros will be used for sub-second values). By default the local time is used, but you can also pass atype
specifier set to the stringutc
, in which case the UTC time will be used (viagmtime
). %{key}e
-
expanded according to what set via "loglocal"/"LOGLOCAL". These two functions allow setting key-value pairs; the
key
is used to find the associated value, then the value is returned as-is if it's a simple defined scalar, otherwise if it is a sub reference it is invoked, otherwise the empty string is returned.In case a subroutine reference is set, it is called with the following parameters:
$sub->($data, $op, $options);
where
$data
is a reference to a hash that contains at least thetod
key, associated to an array with the output ofgettimeofday
(if Time::HiRes is available) or its equivalent (if Time::HiRes is not available),$op
is the lettere
and$options
is the string containing thekey
in braces (e.g.{this-is-the-key}
).
As of release 1.4.0 all time-expansions in a single log refer to the same time, i.e. if you specify the format string %D %D
and you have microsecond-level resolution, the two values in output will be the same (as opposed to show two slightly different times, related to the different expansion times of the %D
specifier).
Wrapping Log::Log4perl::Tiny
As of release 1.4.0, all expansion sequences that imply using caller
(namely %C
, %F
, %l
, %L
, %M
, and %T
) will honor whatever you set for $Log::Log4perl::caller_depth
or $Log::Log4perl::Tiny::caller_depth
(they're aliased), defaulting to value 0
. You can basically increase this value by 1 for each wrapper function that you don't want to appear from the real caller's point of view. In the following example, we have two nested wrappers, each of which takes care to increase the value by 1 to be hidden:
sub my_wrapper_logger {
local $Log::Log4perl::Tiny::caller_depth =
$Log::Log4perl::Tiny::caller_depth + 1; # ignore my_wrapper_logger
INFO(@_);
}
# ... somewhere else...
sub wrap_wrapper {
local $Log::Log4perl::Tiny::caller_depth =
$Log::Log4perl::Tiny::caller_depth + 1; # ignore wrap_wrapper
my_wrapper_logger(@_);
}
The control variable is either $Log::Log4perl::Tiny::caller_depth
or $Log::Log4perl::caller_depth
, as a matter of fact they are aliased (i.e. changing either one will also change the other). This is intentional to let you switch towards Log::Log4perl should you need to upgrade to it.
See "Using Log::Log4perl with wrapper functions and classes" in Log::Log4perl for further information.
INTERFACE
You have two interfaces at your disposal, the functional one (with all the stealth logger functions) and the object-oriented one (with explicit actions upon a logger object). Choose your preferred option.
Functional Interface
The functional interface sports the following functions (imported automatically when :easy
is passed as import option except for LEVELID_FOR
, LEVELNAME_FOR
and LOGLEVEL
):
TRACE
DEBUG
INFO
WARN
ERROR
FATAL
-
stealth logger functions, each emits a log at the corresponding level;
ALWAYS
-
emit log whatever the configured logging level (except
$DEAD
); LEVELID_FOR
-
returns the identifier related to a certain level. The input level can be either a name or an identifier itself. Returns
undef
if it is neither.It can be used e.g. if you want to use "log" but you only have the level name, not its identifier;
LEVELNAME_FOR
-
returns the name related to a certain level. The input level can be either a name or an identifier itself. Returns
undef
if it is neither. LOGWARN
-
emit log at
WARN
level and thenwarn()
it; LOGDIE
-
emit log at
FATAL
level,die()
and then exit (ifdie()
didn't already exit); LOGEXIT
-
emit log at
FATAL
level and then exit; LOGCARP
-
emit log at
WARN
level and then callCarp::carp()
; LOGCLUCK
-
emit log at
WARN
level and then callCarp::cluck()
; LOGCROAK
-
emit log at
FATAL
level and then callCarp::croak()
; LOGCONFESS
-
emit log at
FATAL
level and then callCarp::confess()
; LOGLEVEL
-
(Not in Log::Log4perl) (Not imported with
:easy
)set the minimum log level for sending a log message to the output;
LOGLOCAL
-
(Not in Log::Log4perl) (Not imported with
:easy
) (As of 1.4.0)set a key-value pair useful for later expansion via code
%{key}e
. See "loglocal" below; FILTER
-
(Not in Log::Log4perl) (Not imported with
:easy
) (As of 1.8.0)set a filter function to apply to every expanded message before it is printed. See "filter" below;
build_channels
-
(Not in Log::Log4perl) (Not imported with
:easy
)build multiple channels for emitting logs.
my $channels = build_channels(@key_value_pairs); # OR my $channels = build_channels(\@key_value_pairs);
The input is a sequence of key-value pairs, provided either as a list or through a reference to an array containing them. They are not forced into a hash because the same key can appear multiple times to initialize multiple channels.
The key specifies the type of the channel, while the value is specific to the key:
- fh
-
value is a filehandle (or anything that can be passed to the
print
function) - sub
- code
-
value is a reference to a subroutine. This will be called with two positional parameters: the message (already properly formatted) and a reference to the logger message
- channel
-
whatever can be passed to keys
fh
or tosub
/code
above - file
- file_insecure
- file_create
- file_append
-
value is the file where log data should be sent.
The first one is kept for compliance with Log::Log4perl::easy_init's way of accepting a file. It eventually results in a two-arguments
open()
call, so that you can quickly set how you want to open the file:file => '>>/path/to/appended', # append mode file => '>/path/to/new-file', # create mode
You should avoid doing this, because it is intrinsically insecure and will yield an error message when running setuid:
Insecure dependency in open while running setuid
file_insecure
is an alias tofile
, so that you can explicitly signal to the maintainer that you know what you're doing.file_create
andfile_append
will use the three-argumentsopen()
call and thus they don't trigger the error above when running setuid. As the respective names suggest the former creates the file from scratch (possibly deleting any previous file with the same path) while the latter opens the file in append mode.
Object-Oriented Interface
The functional interface is actually based upon actions on a pre-defined fixed instance of a Log::Log4perl::Tiny
object, so you can do the same with a logger object as well:
get_logger
-
this function gives you the pre-defined logger instance (i.e. the same used by the stealth logger functions described above).
new
-
if for obscure reasons the default logger isn't what you want, you can get a brand new object! The constructor accepts either a list of key-values or a reference to a hash, supporting the following keys:
- channels
-
set a list (through an array reference) of channels. See "build_channels" for additional information.
- fh
-
see method
fh
below - file
- file_insecure
- file_create
- file_append
-
set the file where the log data will be sent.
The first one is kept for compliance with Log::Log4perl::easy_init's way of accepting a file. It eventually results in a two-arguments
open()
, so you might want to take care when running in taint mode.See also "build_channels" for additional information. This option takes precedence over
fh
described below. - filter
- format
- layout
- level
-
see
easy_init()
and the methods below with the same name - loglocal
-
pass a reference to a hash with key-value pairs to be set via "loglocal";
The methods you can call upon the object mimic the functional interface, but with lowercase method names:
trace
debug
info
warn
error
fatal
-
logging functions, each emits a log at the corresponding level;
is_trace
is_debug
is_info
is_warn
is_error
is_fatal
isTraceEnabled
isDebugEnabled
isInfoEnabled
isWarnEnabled
isErrorEnabled
isFatalEnabled
-
log level test functions, each returns the status of the corresponding level;
always
-
emit log whatever the configured logging level;
logwarn
-
emit log at
WARN
level (if allowed) andwarn()
(always); logdie
-
emit log at
FATAL
level,die()
and then exit (ifdie()
didn't already exit); logexit
-
emit log at
FATAL
level and then exit; logcarp
-
emit log at
WARN
level and then callCarp::carp()
; logcluck
-
emit log at
WARN
level and then callCarp::cluck()
; logcroak
-
emit log at
FATAL
level and then callCarp::croak()
; logconfess
-
emit log at
FATAL
level and then callCarp::confess()
;
The main logging function is actually the following:
log
-
the first parameter is the log level, the rest is the message to log apart from references to subroutines that are first evaluated
emit_log
-
emit the message in the first positional parameter to all logging channels
Additionally, you have the following accessors:
level
-
get/set the minimum level for sending messages to the output stream. By default the level is set to
$INFO
. fh
-
get/set the output channel.
As an extention over Log::Log4perl, you can also pass a reference to a subroutine or to an array.
If you set a reference to a sub, it will be called with two parameters: the message that would be print and a reference to the logger object that is calling the sub. For example, if you simply want to collect the log messages without actually outputting them anywhere, you can do this:
my @messages; get_logger()->fh(sub { my ($message, $logger) = @_; push @messages, $message; return; });
If you set a reference to an array, each item inside will be used for log output; its elements can be either filehandles or sub references, used as described above. This is a handy way to set multiple output channels (it might be implemented externally through a proper subroutine reference of course).
By default this parameter is set to be equal to
STDERR
. filter
-
(Not in Log::Log4perl) (As of 1.8.0)
get/set a filter CODE reference to be applied to every expanded message. The filter function is passed the message as its only argument.
This can be e.g. useful in case a specific start-of-line character sequence is needed for multi-line messages:
get_logger()->filter(sub { my $message = shift; $message =~ s{^}{# }gmxs; # pre-pend "# " to each line return $message; });
Another use case might be taming some sensitive data:
get_logger()->filter(sub { my $message = shift; $message =~ s{password<.*?>}{password<***>}gmxs; return $message; });
It is anyway suggested to deal with these cases explicitly at the source and not as an afterthought (only). As an example, the regular expression in the example above will leak parts of passwords that contain the
>
character, and there might be other ways passwords are written too. format
layout
-
get/set the line formatting;
logexit_code
-
get/set the exit code to be used with
logexit()
(andlogdie()
as well ifdie()
doesn't exit). loglocal
-
get/set a local key-value pair for expansion with
%{key}e
.Always returns the previous value associated to the provided key, removing it:
my $value = $logger->loglocal('some-key'); # now, 'some-key' does not exist any more and has no value associated
If you pass a value too, it will be set:
$logger->loglocal(foo => 'bar'); my $old = $logger->loglocal(foo => 'whatever'); # $old is 'bar' # current value associated to foo is 'whatever'
DEPENDENCIES
Runs on perl 5.8.0 on with no additional runtime requirements.
See cpanfile for additional requirements when testing and/or developing. In particular, developing will require Log::Log4perl to perform a comparison between the expansions of a few items related to caller()
.
BUGS AND LIMITATIONS
Please view/report any bugs or feature requests through Github at https://github.com/polettix/Log-Log4perl-Tiny/issues.
SEE ALSO
Log::Log4perl is one of the most useful modules I ever used, go check it!
AUTHOR
Flavio Poletti <polettix@cpan.org>
COPYRIGHT AND LICENSE
Copyright (C) 2010-2022 by Flavio Poletti <polettix@cpan.org>.
This module is free software. You can redistribute it and/or modify it under the terms of the Artistic License 2.0.
This program is distributed in the hope that it will be useful, but without any warranty; without even the implied warranty of merchantability or fitness for a particular purpose.