Home | History | Annotate | Download | only in base
      1 /*
      2  *  Copyright 2004 The WebRTC Project Authors. All rights reserved.
      3  *
      4  *  Use of this source code is governed by a BSD-style license
      5  *  that can be found in the LICENSE file in the root of the source
      6  *  tree. An additional intellectual property rights grant can be found
      7  *  in the file PATENTS.  All contributing project authors may
      8  *  be found in the AUTHORS file in the root of the source tree.
      9  */
     10 
     11 //   LOG(...) an ostream target that can be used to send formatted
     12 // output to a variety of logging targets, such as debugger console, stderr,
     13 // or any LogSink.
     14 //   The severity level passed as the first argument to the LOGging
     15 // functions is used as a filter, to limit the verbosity of the logging.
     16 //   Static members of LogMessage documented below are used to control the
     17 // verbosity and target of the output.
     18 //   There are several variations on the LOG macro which facilitate logging
     19 // of common error conditions, detailed below.
     20 
     21 // LOG(sev) logs the given stream at severity "sev", which must be a
     22 //     compile-time constant of the LoggingSeverity type, without the namespace
     23 //     prefix.
     24 // LOG_V(sev) Like LOG(), but sev is a run-time variable of the LoggingSeverity
     25 //     type (basically, it just doesn't prepend the namespace).
     26 // LOG_F(sev) Like LOG(), but includes the name of the current function.
     27 // LOG_T(sev) Like LOG(), but includes the this pointer.
     28 // LOG_T_F(sev) Like LOG_F(), but includes the this pointer.
     29 // LOG_GLE(M)(sev [, mod]) attempt to add a string description of the
     30 //     HRESULT returned by GetLastError.  The "M" variant allows searching of a
     31 //     DLL's string table for the error description.
     32 // LOG_ERRNO(sev) attempts to add a string description of an errno-derived
     33 //     error. errno and associated facilities exist on both Windows and POSIX,
     34 //     but on Windows they only apply to the C/C++ runtime.
     35 // LOG_ERR(sev) is an alias for the platform's normal error system, i.e. _GLE on
     36 //     Windows and _ERRNO on POSIX.
     37 // (The above three also all have _EX versions that let you specify the error
     38 // code, rather than using the last one.)
     39 // LOG_E(sev, ctx, err, ...) logs a detailed error interpreted using the
     40 //     specified context.
     41 // LOG_CHECK_LEVEL(sev) (and LOG_CHECK_LEVEL_V(sev)) can be used as a test
     42 //     before performing expensive or sensitive operations whose sole purpose is
     43 //     to output logging data at the desired level.
     44 // Lastly, PLOG(sev, err) is an alias for LOG_ERR_EX.
     45 
     46 #ifndef WEBRTC_BASE_LOGGING_H_
     47 #define WEBRTC_BASE_LOGGING_H_
     48 
     49 #ifdef HAVE_CONFIG_H
     50 #include "config.h"  // NOLINT
     51 #endif
     52 
     53 #include <list>
     54 #include <sstream>
     55 #include <string>
     56 #include <utility>
     57 
     58 #include "webrtc/base/basictypes.h"
     59 #include "webrtc/base/constructormagic.h"
     60 #include "webrtc/base/thread_annotations.h"
     61 
     62 namespace rtc {
     63 
     64 ///////////////////////////////////////////////////////////////////////////////
     65 // ConstantLabel can be used to easily generate string names from constant
     66 // values.  This can be useful for logging descriptive names of error messages.
     67 // Usage:
     68 //   const ConstantLabel LIBRARY_ERRORS[] = {
     69 //     KLABEL(SOME_ERROR),
     70 //     KLABEL(SOME_OTHER_ERROR),
     71 //     ...
     72 //     LASTLABEL
     73 //   }
     74 //
     75 //   int err = LibraryFunc();
     76 //   LOG(LS_ERROR) << "LibraryFunc returned: "
     77 //                 << ErrorName(err, LIBRARY_ERRORS);
     78 
     79 struct ConstantLabel { int value; const char * label; };
     80 #define KLABEL(x) { x, #x }
     81 #define TLABEL(x, y) { x, y }
     82 #define LASTLABEL { 0, 0 }
     83 
     84 const char* FindLabel(int value, const ConstantLabel entries[]);
     85 std::string ErrorName(int err, const ConstantLabel* err_table);
     86 
     87 //////////////////////////////////////////////////////////////////////
     88 
     89 // Note that the non-standard LoggingSeverity aliases exist because they are
     90 // still in broad use.  The meanings of the levels are:
     91 //  LS_SENSITIVE: Information which should only be logged with the consent
     92 //   of the user, due to privacy concerns.
     93 //  LS_VERBOSE: This level is for data which we do not want to appear in the
     94 //   normal debug log, but should appear in diagnostic logs.
     95 //  LS_INFO: Chatty level used in debugging for all sorts of things, the default
     96 //   in debug builds.
     97 //  LS_WARNING: Something that may warrant investigation.
     98 //  LS_ERROR: Something that should not have occurred.
     99 //  LS_NONE: Don't log.
    100 enum LoggingSeverity {
    101   LS_SENSITIVE,
    102   LS_VERBOSE,
    103   LS_INFO,
    104   LS_WARNING,
    105   LS_ERROR,
    106   LS_NONE,
    107   INFO = LS_INFO,
    108   WARNING = LS_WARNING,
    109   LERROR = LS_ERROR
    110 };
    111 
    112 // LogErrorContext assists in interpreting the meaning of an error value.
    113 enum LogErrorContext {
    114   ERRCTX_NONE,
    115   ERRCTX_ERRNO,     // System-local errno
    116   ERRCTX_HRESULT,   // Windows HRESULT
    117   ERRCTX_OSSTATUS,  // MacOS OSStatus
    118 
    119   // Abbreviations for LOG_E macro
    120   ERRCTX_EN = ERRCTX_ERRNO,     // LOG_E(sev, EN, x)
    121   ERRCTX_HR = ERRCTX_HRESULT,   // LOG_E(sev, HR, x)
    122   ERRCTX_OS = ERRCTX_OSSTATUS,  // LOG_E(sev, OS, x)
    123 };
    124 
    125 // Virtual sink interface that can receive log messages.
    126 class LogSink {
    127  public:
    128   LogSink() {}
    129   virtual ~LogSink() {}
    130   virtual void OnLogMessage(const std::string& message) = 0;
    131 };
    132 
    133 class LogMessage {
    134  public:
    135   LogMessage(const char* file, int line, LoggingSeverity sev,
    136              LogErrorContext err_ctx = ERRCTX_NONE, int err = 0,
    137              const char* module = NULL);
    138 
    139   LogMessage(const char* file,
    140              int line,
    141              LoggingSeverity sev,
    142              const std::string& tag);
    143 
    144   ~LogMessage();
    145 
    146   static inline bool Loggable(LoggingSeverity sev) { return (sev >= min_sev_); }
    147   std::ostream& stream() { return print_stream_; }
    148 
    149   // Returns the time at which this function was called for the first time.
    150   // The time will be used as the logging start time.
    151   // If this is not called externally, the LogMessage ctor also calls it, in
    152   // which case the logging start time will be the time of the first LogMessage
    153   // instance is created.
    154   static uint32_t LogStartTime();
    155 
    156   // Returns the wall clock equivalent of |LogStartTime|, in seconds from the
    157   // epoch.
    158   static uint32_t WallClockStartTime();
    159 
    160   //  LogThreads: Display the thread identifier of the current thread
    161   static void LogThreads(bool on = true);
    162 
    163   //  LogTimestamps: Display the elapsed time of the program
    164   static void LogTimestamps(bool on = true);
    165 
    166   // These are the available logging channels
    167   //  Debug: Debug console on Windows, otherwise stderr
    168   static void LogToDebug(LoggingSeverity min_sev);
    169   static LoggingSeverity GetLogToDebug() { return dbg_sev_; }
    170 
    171   // Sets whether logs will be directed to stderr in debug mode.
    172   static void SetLogToStderr(bool log_to_stderr);
    173 
    174   //  Stream: Any non-blocking stream interface.  LogMessage takes ownership of
    175   //   the stream. Multiple streams may be specified by using AddLogToStream.
    176   //   LogToStream is retained for backwards compatibility; when invoked, it
    177   //   will discard any previously set streams and install the specified stream.
    178   //   GetLogToStream gets the severity for the specified stream, of if none
    179   //   is specified, the minimum stream severity.
    180   //   RemoveLogToStream removes the specified stream, without destroying it.
    181   static int GetLogToStream(LogSink* stream = NULL);
    182   static void AddLogToStream(LogSink* stream, LoggingSeverity min_sev);
    183   static void RemoveLogToStream(LogSink* stream);
    184 
    185   // Testing against MinLogSeverity allows code to avoid potentially expensive
    186   // logging operations by pre-checking the logging level.
    187   static int GetMinLogSeverity() { return min_sev_; }
    188 
    189   // Parses the provided parameter stream to configure the options above.
    190   // Useful for configuring logging from the command line.
    191   static void ConfigureLogging(const char* params);
    192 
    193  private:
    194   typedef std::pair<LogSink*, LoggingSeverity> StreamAndSeverity;
    195   typedef std::list<StreamAndSeverity> StreamList;
    196 
    197   // Updates min_sev_ appropriately when debug sinks change.
    198   static void UpdateMinLogSeverity();
    199 
    200   // These write out the actual log messages.
    201   static void OutputToDebug(const std::string& msg,
    202                             LoggingSeverity severity,
    203                             const std::string& tag);
    204 
    205   // The ostream that buffers the formatted message before output
    206   std::ostringstream print_stream_;
    207 
    208   // The severity level of this message
    209   LoggingSeverity severity_;
    210 
    211   // The Android debug output tag.
    212   std::string tag_;
    213 
    214   // String data generated in the constructor, that should be appended to
    215   // the message before output.
    216   std::string extra_;
    217 
    218   // dbg_sev_ is the thresholds for those output targets
    219   // min_sev_ is the minimum (most verbose) of those levels, and is used
    220   //  as a short-circuit in the logging macros to identify messages that won't
    221   //  be logged.
    222   // ctx_sev_ is the minimum level at which file context is displayed
    223   static LoggingSeverity min_sev_, dbg_sev_, ctx_sev_;
    224 
    225   // The output streams and their associated severities
    226   static StreamList streams_;
    227 
    228   // Flags for formatting options
    229   static bool thread_, timestamp_;
    230 
    231   // Determines if logs will be directed to stderr in debug mode.
    232   static bool log_to_stderr_;
    233 
    234   RTC_DISALLOW_COPY_AND_ASSIGN(LogMessage);
    235 };
    236 
    237 //////////////////////////////////////////////////////////////////////
    238 // Logging Helpers
    239 //////////////////////////////////////////////////////////////////////
    240 
    241 class LogMultilineState {
    242  public:
    243   size_t unprintable_count_[2];
    244   LogMultilineState() {
    245     unprintable_count_[0] = unprintable_count_[1] = 0;
    246   }
    247 };
    248 
    249 // When possible, pass optional state variable to track various data across
    250 // multiple calls to LogMultiline.  Otherwise, pass NULL.
    251 void LogMultiline(LoggingSeverity level, const char* label, bool input,
    252                   const void* data, size_t len, bool hex_mode,
    253                   LogMultilineState* state);
    254 
    255 #ifndef LOG
    256 
    257 // The following non-obvious technique for implementation of a
    258 // conditional log stream was stolen from google3/base/logging.h.
    259 
    260 // This class is used to explicitly ignore values in the conditional
    261 // logging macros.  This avoids compiler warnings like "value computed
    262 // is not used" and "statement has no effect".
    263 
    264 class LogMessageVoidify {
    265  public:
    266   LogMessageVoidify() { }
    267   // This has to be an operator with a precedence lower than << but
    268   // higher than ?:
    269   void operator&(std::ostream&) { }
    270 };
    271 
    272 #define LOG_SEVERITY_PRECONDITION(sev) \
    273   !(rtc::LogMessage::Loggable(sev)) \
    274     ? (void) 0 \
    275     : rtc::LogMessageVoidify() &
    276 
    277 #define LOG(sev) \
    278   LOG_SEVERITY_PRECONDITION(rtc::sev) \
    279     rtc::LogMessage(__FILE__, __LINE__, rtc::sev).stream()
    280 
    281 // The _V version is for when a variable is passed in.  It doesn't do the
    282 // namespace concatination.
    283 #define LOG_V(sev) \
    284   LOG_SEVERITY_PRECONDITION(sev) \
    285     rtc::LogMessage(__FILE__, __LINE__, sev).stream()
    286 
    287 // The _F version prefixes the message with the current function name.
    288 #if (defined(__GNUC__) && !defined(NDEBUG)) || defined(WANT_PRETTY_LOG_F)
    289 #define LOG_F(sev) LOG(sev) << __PRETTY_FUNCTION__ << ": "
    290 #define LOG_T_F(sev) LOG(sev) << this << ": " << __PRETTY_FUNCTION__ << ": "
    291 #else
    292 #define LOG_F(sev) LOG(sev) << __FUNCTION__ << ": "
    293 #define LOG_T_F(sev) LOG(sev) << this << ": " << __FUNCTION__ << ": "
    294 #endif
    295 
    296 #define LOG_CHECK_LEVEL(sev) \
    297   rtc::LogCheckLevel(rtc::sev)
    298 #define LOG_CHECK_LEVEL_V(sev) \
    299   rtc::LogCheckLevel(sev)
    300 
    301 inline bool LogCheckLevel(LoggingSeverity sev) {
    302   return (LogMessage::GetMinLogSeverity() <= sev);
    303 }
    304 
    305 #define LOG_E(sev, ctx, err, ...) \
    306   LOG_SEVERITY_PRECONDITION(rtc::sev) \
    307     rtc::LogMessage(__FILE__, __LINE__, rtc::sev, \
    308                           rtc::ERRCTX_ ## ctx, err , ##__VA_ARGS__) \
    309         .stream()
    310 
    311 #define LOG_T(sev) LOG(sev) << this << ": "
    312 
    313 #define LOG_ERRNO_EX(sev, err) \
    314   LOG_E(sev, ERRNO, err)
    315 #define LOG_ERRNO(sev) \
    316   LOG_ERRNO_EX(sev, errno)
    317 
    318 #if defined(WEBRTC_WIN)
    319 #define LOG_GLE_EX(sev, err) \
    320   LOG_E(sev, HRESULT, err)
    321 #define LOG_GLE(sev) \
    322   LOG_GLE_EX(sev, GetLastError())
    323 #define LOG_GLEM(sev, mod) \
    324   LOG_E(sev, HRESULT, GetLastError(), mod)
    325 #define LOG_ERR_EX(sev, err) \
    326   LOG_GLE_EX(sev, err)
    327 #define LOG_ERR(sev) \
    328   LOG_GLE(sev)
    329 #define LAST_SYSTEM_ERROR \
    330   (::GetLastError())
    331 #elif __native_client__
    332 #define LOG_ERR_EX(sev, err) \
    333   LOG(sev)
    334 #define LOG_ERR(sev) \
    335   LOG(sev)
    336 #define LAST_SYSTEM_ERROR \
    337   (0)
    338 #elif defined(WEBRTC_POSIX)
    339 #define LOG_ERR_EX(sev, err) \
    340   LOG_ERRNO_EX(sev, err)
    341 #define LOG_ERR(sev) \
    342   LOG_ERRNO(sev)
    343 #define LAST_SYSTEM_ERROR \
    344   (errno)
    345 #endif  // WEBRTC_WIN
    346 
    347 #define LOG_TAG(sev, tag) \
    348   LOG_SEVERITY_PRECONDITION(sev) \
    349     rtc::LogMessage(NULL, 0, sev, tag).stream()
    350 
    351 #define PLOG(sev, err) \
    352   LOG_ERR_EX(sev, err)
    353 
    354 // TODO(?): Add an "assert" wrapper that logs in the same manner.
    355 
    356 #endif  // LOG
    357 
    358 }  // namespace rtc
    359 
    360 #endif  // WEBRTC_BASE_LOGGING_H_
    361