Class: Logging::Layouts::Pattern

Inherits:
Logging::Layout show all
Defined in:
lib/logging/layouts/pattern.rb

Overview

A flexible layout configurable with pattern string.

The goal of this class is to format a LogEvent and return the results as a String. The results depend on the conversion pattern.

The conversion pattern is closely related to the conversion pattern of the sprintf function. A conversion pattern is composed of literal text and format control expressions called conversion specifiers.

You are free to insert any literal text within the conversion pattern.

Each conversion specifier starts with a percent sign (%) and is followed by optional format modifiers and a conversion character. The conversion character specifies the type of data, e.g. logger, level, date, thread ID. The format modifiers control such things as field width, padding, left and right justification. The following is a simple example.

Let the conversion pattern be “%-5l [%c]: %mn” and assume that the logging environment was set to use a Pattern layout. Then the statements

root = Logging.logger[:root]
root.debug("Message 1")
root.warn("Message 2")

would yield the output

DEBUG [root]: Message 1
WARN  [root]: Message 2

Note that there is no explicit separator between text and conversion specifiers. The pattern parser knows when it has reached the end of a conversion specifier when it reads a conversion character. In the example above the conversion specifier %-5l means the level of the logging event should be left justified to a width of five characters. The recognized conversion characters are

[c]  Used to output the name of the logger that generated the log
     event. Supports an optional "precision" described further below.
[d]  Used to output the date of the log event. The format of the
     date is specified using the :date_pattern option when the Layout
     is created. ISO8601 format is assumed if not date pattern is given.
[F]  Used to output the file name where the logging request was issued.
[l]  Used to output the level of the log event.
[L]  Used to output the line number where the logging request was
     issued.
[m]  Used to output the application supplied message associated with
     the log event.
[M]  Used to output the method name where the logging request was
     issued.
[p]  Used to output the process ID of the currently running program.
[r]  Used to output the number of milliseconds elapsed from the
     construction of the Layout until creation of the log event.
[t]  Used to output the object ID of the thread that generated the
     log event.
[T]  Used to output the name of the thread that generated the log event.
     Name can be specified using Thread.current[:name] notation. Output
     empty string if name not specified. This option helps to create
     more human readable output for multithread application logs.
[%]  The sequence '%%' outputs a single percent sign.

The logger name directive ‘c’ accepts an optional precision that will only print the rightmost number of namespace identifiers for the logger. By default the logger name is printed in full. For example, for the logger name “Foo::Bar::Baz” the pattern %c2 will output “Bar::Baz”.

The directives F, L, and M will only work if the Logger generating the events is configured to generate tracing information. If this is not the case these fields will always be empty.

By default the relevant information is output as is. However, with the aid of format modifiers it is possible to change the minimum field width, the maximum field width and justification.

The optional format modifier is placed between the percent sign and the conversion character.

The first optional format modifier is the left justification flag which is just the minus (-) character. Then comes the optional minimum field width modifier. This is a decimal constant that represents the minimum number of characters to output. If the data item requires fewer characters, it is padded on either the left or the right until the minimum width is reached. The default is to pad on the left (right justify) but you can specify right padding with the left justification flag. The padding character is space. If the data item is larger than the minimum field width, the field is expanded to accommodate the data. The value is never truncated.

This behavior can be changed using the maximum field width modifier which is designated by a period followed by a decimal constant. If the data item is longer than the maximum field, then the extra characters are removed from the end of the data item.

Below are various format modifier examples for the category conversion specifier.

[%20c]      Left pad with spaces if the logger name is less than 20
            characters long
[%-20c]     Right pad with spaces if the logger name is less than 20
            characters long
[%.30c]     Truncates the logger name if it is longer than 30 characters
[%20.30c]   Left pad with spaces if the logger name is shorter than
            20 characters. However, if the logger name is longer than
            30 characters, then truncate the name.
[%-20.30c]  Right pad with spaces if the logger name is shorter than
            20 characters. However, if the logger name is longer than
            30 characters, then truncate the name.

Below are examples of some conversion patterns.

%.1l, [%d] %5l -- %c: %m\n

This is how the Logger class in the Ruby standard library formats messages. The main difference will be in the date format (the Pattern Layout uses the ISO8601 date format). Set the :date_method on the Pattern Layout to be ‘to_s’ and then the date formats will agree.

Constant Summary collapse

DIRECTIVE_TABLE =

Arguments to sprintf keyed to directive letters

{
  'c' => 'event.logger'.freeze,
  'd' => 'format_date(event.time)'.freeze,
  'F' => 'event.file'.freeze,
  'l' => '::Logging::LNAMES[event.level]'.freeze,
  'L' => 'event.line'.freeze,
  'm' => 'format_obj(event.data)'.freeze,
  'M' => 'event.method'.freeze,
  'p' => 'Process.pid'.freeze,
  'r' => 'Integer((event.time-@created_at)*1000).to_s'.freeze,
  't' => 'Thread.current.object_id.to_s'.freeze,
  'T' => 'Thread.current[:name]'.freeze,
  '%' => :placeholder
}.freeze
DIRECTIVE_RGXP =

Matches the first directive encountered and the stuff around it.

  • $1 is the stuff before directive or “” if not applicable

  • $2 is the %#.# match within directive group

  • $3 is the directive letter

  • $4 is the precision specifier for the logger name

  • $5 is the stuff after the directive or “” if not applicable

%r/([^%]*)(?:(%-?\d*(?:\.\d+)?)([a-zA-Z%])(?:\{(\d+)\})?)?(.*)/m
ISO8601 =

default date format

"%Y-%m-%d %H:%M:%S".freeze
COLOR_ALIAS_TABLE =

Human name aliases for directives - used for colorization of tokens

{
  'c' => :logger,
  'd' => :date,
  'm' => :message,
  'p' => :pid,
  'r' => :time,
  'T' => :thread,
  't' => :thread_id,
  'F' => :file,
  'L' => :line,
  'M' => :method
}.freeze

Instance Attribute Summary collapse

Class Method Summary collapse

Instance Method Summary collapse

Methods inherited from Logging::Layout

#footer, #format, #format_obj, #header, #try_yaml

Constructor Details

#initialize(opts = {}) ⇒ Pattern

call-seq:

Pattern.new( opts )

Creates a new Pattern layout using the following options.

:pattern       =>  "[%d] %-5l -- %c : %m\n"
:date_pattern  =>  "%Y-%m-%d %H:%M:%S"
:date_method   =>  'usec' or 'to_s'
:color_scheme  =>  :default

If used, :date_method will supersede :date_pattern.

The :color_scheme is used to apply color formatting to the log messages. Individual tokens can be colorized witch the level token [%l] receiving distinct colors based on the level of the log event. The entire generated log message can also be colorized based on the level of the log event. See the ColorScheme documentation for more details.



296
297
298
299
300
301
302
303
304
305
306
307
308
309
310
311
312
313
314
315
316
# File 'lib/logging/layouts/pattern.rb', line 296

def initialize( opts = {} )
  super
  @created_at = Time.now

  @date_pattern = opts.getopt(:date_pattern)
  @date_method = opts.getopt(:date_method)
  @date_pattern = ISO8601 if @date_pattern.nil? and @date_method.nil?

  @pattern = opts.getopt(:pattern,
      "[%d] %-#{::Logging::MAX_LEVEL_LENGTH}l -- %c : %m\n")

  cs_name = opts.getopt(:color_scheme)
  @color_scheme =
      case cs_name
      when false, nil; nil
      when true; ::Logging::ColorScheme[:default]
      else ::Logging::ColorScheme[cs_name] end

  Pattern.create_date_format_methods(self)
  Pattern.create_format_method(self)
end

Instance Attribute Details

#color_schemeObject (readonly)

Returns the value of attribute color_scheme.



318
319
320
# File 'lib/logging/layouts/pattern.rb', line 318

def color_scheme
  @color_scheme
end

#date_methodObject

Returns the value of attribute date_method.



318
319
320
# File 'lib/logging/layouts/pattern.rb', line 318

def date_method
  @date_method
end

#date_patternObject

Returns the value of attribute date_pattern.



318
319
320
# File 'lib/logging/layouts/pattern.rb', line 318

def date_pattern
  @date_pattern
end

#patternObject

Returns the value of attribute pattern.



318
319
320
# File 'lib/logging/layouts/pattern.rb', line 318

def pattern
  @pattern
end

Class Method Details

.create_date_format_methods(pf) ⇒ Object

call-seq:

Pattern.create_date_format_methods( pf )

This method will create the date_format method in the given Pattern Layout pf based on the configured date patten and/or date method specified by the user.



173
174
175
176
177
178
179
180
181
182
183
184
185
186
187
188
189
190
191
192
# File 'lib/logging/layouts/pattern.rb', line 173

def self.create_date_format_methods( pf )
  code = "undef :format_date if method_defined? :format_date\n"
  code << "def format_date( time )\n"
  if pf.date_method.nil?
    if pf.date_pattern =~ %r/%s/
      code << <<-CODE
        dp = '#{pf.date_pattern}'.gsub('%s','%06d' % time.usec)
        time.strftime dp
      CODE
    else
      code << "time.strftime '#{pf.date_pattern}'\n"
    end
  else
    code << "time.#{pf.date_method}\n"
  end
  code << "end\n"
  ::Logging.log_internal(0) {code}

  pf._meta_eval(code, __FILE__, __LINE__)
end

.create_format_method(pf) ⇒ Object

call-seq:

Pattern.create_format_method( pf )

This method will create the format method in the given Pattern Layout pf based on the configured format pattern specified by the user.



201
202
203
204
205
206
207
208
209
210
211
212
213
214
215
216
217
218
219
220
221
222
223
224
225
226
227
228
229
230
231
232
233
234
235
236
237
238
239
240
241
242
243
244
245
246
247
248
249
250
251
252
253
254
255
256
257
258
259
260
261
262
263
264
265
266
267
268
269
270
271
272
273
274
275
# File 'lib/logging/layouts/pattern.rb', line 201

def self.create_format_method( pf )
  # Create the format(event) method
  format_string = '"'
  pattern = pf.pattern.dup
  color_scheme = pf.color_scheme
  args = []
  name_map_count = 0

  while true
    m = DIRECTIVE_RGXP.match(pattern)
    format_string << m[1] unless m[1].empty?

    case m[3]
    when '%'; format_string << '%%'
    when 'c'
      fmt = m[2] + 's'
      fmt = color_scheme.color(fmt, COLOR_ALIAS_TABLE[m[3]]) if color_scheme and !color_scheme.lines?

      format_string << fmt
      args << DIRECTIVE_TABLE[m[3]].dup
      if m[4]
        raise ArgumentError, "logger name precision must be an integer greater than zero: #{m[4]}" unless Integer(m[4]) > 0
        args.last <<
            ".split(::Logging::Repository::PATH_DELIMITER)" \
            ".last(#{m[4]}).join(::Logging::Repository::PATH_DELIMITER)"
      end
    when 'l'
      if color_scheme and color_scheme.levels?
        name_map = ::Logging::LNAMES.map { |name| color_scheme.color(("#{m[2]}s" % name), name) }
        var = "@name_map_#{name_map_count}"
        pf.instance_variable_set(var.to_sym, name_map)
        name_map_count += 1

        format_string << '%s'
        format_string << "{#{m[4]}}" if m[4]
        args << "#{var}[event.level]"
      else
        format_string << m[2] + 's'
        format_string << "{#{m[4]}}" if m[4]
        args << DIRECTIVE_TABLE[m[3]]
      end

    when *DIRECTIVE_TABLE.keys
      fmt = m[2] + 's'
      fmt = color_scheme.color(fmt, COLOR_ALIAS_TABLE[m[3]]) if color_scheme and !color_scheme.lines?

      format_string << fmt
      format_string << "{#{m[4]}}" if m[4]
      args << DIRECTIVE_TABLE[m[3]]
    when nil; break
    else
      raise ArgumentError, "illegal format character - '#{m[3]}'"
    end

    break if m[5].empty?
    pattern = m[5]
  end

  format_string << '"'

  sprintf = "sprintf("
  sprintf << format_string
  sprintf << ', ' + args.join(', ') unless args.empty?
  sprintf << ")"

  if color_scheme and color_scheme.lines?
    sprintf = "color_scheme.color(#{sprintf}, ::Logging::LNAMES[event.level])"
  end

  code = "undef :format if method_defined? :format\n"
  code << "def format( event )\n#{sprintf}\nend\n"
  ::Logging.log_internal(0) {code}

  pf._meta_eval(code, __FILE__, __LINE__)
end

Instance Method Details

#_meta_eval(code, file = nil, line = nil) ⇒ Object

call-seq:

_meta_eval( code )

Evaluates the given string of code if the singleton class of this Pattern Layout object.



362
363
364
365
# File 'lib/logging/layouts/pattern.rb', line 362

def _meta_eval( code, file = nil, line = nil )
  meta = class << self; self end
  meta.class_eval code, file, line
end