Logging

dhood edited this page Jun 28, 2018 · 6 revisions

Logging and logger configuration

The logging functionality currently supported is:

  • Client libraries (rclcpp and rclpy) using a common logging library to provide:
    • Log calls with a variety of filters.
    • Hierarchy of loggers.
    • Loggers associated with nodes that automatically use the node's name and namespace.
  • Console output.
    • File output and functionality akin to rosout for remote consumption of messages is forthcoming.
  • Programmatic configuration of logger levels.
    • Launch-time configuration of the default logger level is supported; config files and external configuration at run-time is forthcoming.

Logger concepts

Log messages have a severity level associated with them: DEBUG, INFO, WARN, ERROR or FATAL, in ascending order.

A logger will only process log messages with severity at or higher than a specified level chosen for the logger.

Each node (in rclcpp and rclpy) has a logger associated with it that automatically includes the node's name and namespace. If the node's name is externally remapped to something other than what is defined in the source code, it will be reflected in the logger name. Non-node loggers can also be created that use a specific name.

Logger names represent a hierarchy. If the level of a logger named "abc.def" is unset, it will defer to the level of its parent named "abc", and if that level is also unset, the default logger level will be used. When the level of logger "abc" is changed, all of its descendants (e.g. "abc.def", "abc.ghi.jkl") will have their level impacted unless their level has been explicitly set.

Logging usage

In C++:

In Python:

  • See the rclpy examples for example usage of a node's logger.
  • See the rclpy tests for example usage of keyword arguments (e.g. skip_first, once).

Logger configuration

Command line configuration of the default severity level

As of the Bouncy ROS 2 release, the default severity level for loggers can be configured from the command line with the following, for example (the level string is not case sensitive):

ros2 run demo_nodes_cpp listener __log_level:=debug

This will affect all loggers that have not explicitly been configured to use a particular severity level. Configuration of specific loggers from the command line is forthcoming.

Programmatic configuration of individual loggers

Logger configuration is still under development. For now, the severity level of individual loggers can be configured programmatically with, e.g.:

In C++:

rcutils_logging_set_logger_level("logger_name", RCUTILS_LOG_SEVERITY_DEBUG);

In Python:

logger.set_level(rclpy.logging.LoggingSeverity.DEBUG)
rclpy.logging.set_logger_level('logger_name', rclpy.logging.LoggingSeverity.DEBUG)

The logging demo provides an example of manually exposing a service so that loggers can be configured externally; in the future we expect runtime configuration capabilities of loggers to be exposed automatically.

Console output configuration

By default, console output will be formatted to include the message severity, logger name, and the message. Information such as the file name, function name and line number of the log call are also available. Custom console output format can be configured with the RCUTILS_CONSOLE_OUTPUT_FORMAT environment variable: see the rcutils documentation for details. As rclpy and rclcpp both use rcutils for logging, this will effect all Python and C++ nodes.

Clone this wiki locally
You can’t perform that action at this time.
You signed in with another tab or window. Reload to refresh your session. You signed out in another tab or window. Reload to refresh your session.
Press h to open a hovercard with more details.