Boost.log: как предотвратить дублирование вывода во все добавленные потоки при использовании функции add_file_log()?

Я использую функцию add_file_log() для инициализации приемника журналов, который сохраняет записи журнала в текстовый файл. Когда я определяю несколько раковин, я заметил:

  • файл создается для каждого приемника.
  • вывод копируется во все файлы.

Это мой регистратор:

class logger
{
public:
  logger(const logger&) =delete;
  logger(logger&&) =delete;
  logger& operator=(const logger&) =delete;
  logger& operator=(logger&&) =delete;

  static logger& get_instance(
    const std::string& file,
    bool console
  )
  {
      boost::log::register_simple_formatter_factory<
                                                    boost::log::trivial::severity_level,
                                                    char
                                                   >("Severity");

      std::string the_format = "[%TimeStamp%] (%LineID%) [%Severity%]: %Message%";

      if(!file.empty()) {
        boost::log::add_file_log(
          boost::log::keywords::file_name = file + "_%N.log",
          boost::log::keywords::rotation_size = 10 * 1024 * 1024,
          boost::log::keywords::time_based_rotation =
            boost::log::sinks::file::rotation_at_time_point(0, 0, 0),
          boost::log::keywords::auto_flush = true,
          //boost::log::keywords::open_mode = (std::ios::out | std::ios::app),
          boost::log::keywords::format = the_format
        );
      }

      boost::log::add_common_attributes();
      static logger instance{ the_format, console };
      return instance;
  }

  void log(
    const std::string& msg
  )
  {
      BOOST_LOG_SEV ( m_log_, boost::log::trivial::info ) << msg;
  }

private:
  boost::log::sources::severity_logger<
                                       boost::log::trivial::severity_level
                                      > m_log_;

  logger(
    const std::string& format,
    bool console
  )
  {
      if(console) {
        boost::log::add_console_log(
          std::clog,
          boost::log::keywords::format = format
        );
      }
  }
}; // logger

Это моя функция main():

void test(
  const std::string& file
)
{
  logger& lg1 = logger::get_instance( file, false );
  lg1.log( "Hello" );
  lg1.log( "World" );
  lg1.log( "Bye" );
} // test

int main()
{
  unsigned char result = EXIT_SUCCESS;

  try
  {
    std::string file1 = "a.txt",
                file2 = "b.txt";
    logger& lg = logger::get_instance( file1, false );

    for(int i = 1; i<=10; i++) {
       lg.log( std::to_string(i) );
       if(i == 5) {
         test( file2 );
       }
    }
  }
  catch ( std::exception& e )
  {
    std::cerr << "Error: " << e.what() << std::endl;
    result = EXIT_FAILURE;
  }
  return result;
}

После запуска примера файлы содержат:

a.txt_0.log

[2016-Aug-31 11:49:48.584353] (1) [info]: 1
[2016-Aug-31 11:49:48.585376] (2) [info]: 2
[2016-Aug-31 11:49:48.585418] (3) [info]: 3
[2016-Aug-31 11:49:48.585442] (4) [info]: 4
[2016-Aug-31 11:49:48.585462] (5) [info]: 5
[2016-Aug-31 11:49:48.585505] (6) [info]: Hello  <-- 
[2016-Aug-31 11:49:48.585610] (7) [info]: World  <-- Generated by second logger
[2016-Aug-31 11:49:48.585672] (8) [info]: Bye    <--
[2016-Aug-31 11:49:48.585709] (9) [info]: 6
[2016-Aug-31 11:49:48.585744] (10) [info]: 7
[2016-Aug-31 11:49:48.585777] (11) [info]: 8
[2016-Aug-31 11:49:48.585813] (12) [info]: 9
[2016-Aug-31 11:49:48.585842] (13) [info]: 10

b.txt_0.log

[2016-Aug-31 11:49:48.585505] (6) [info]: Hello
[2016-Aug-31 11:49:48.585610] (7) [info]: World
[2016-Aug-31 11:49:48.585672] (8) [info]: Bye
[2016-Aug-31 11:49:48.585709] (9) [info]: 6    <--
[2016-Aug-31 11:49:48.585744] (10) [info]: 7   <--
[2016-Aug-31 11:49:48.585777] (11) [info]: 8   <-- Generated by the first logger
[2016-Aug-31 11:49:48.585813] (12) [info]: 9   <--
[2016-Aug-31 11:49:48.585842] (13) [info]: 10  <--

Как я могу предотвратить такое поведение? Я хочу, чтобы каждый файл хранил только информацию, сгенерированную связанным с ним регистратором.


person Juan Solo    schedule 31.08.2016    source источник
comment
может каналы правильные настроить? (см. stackoverflow.com/a/34372526/819272)   -  person TemplateRex    schedule 31.08.2016


Ответы (1)


Похоже, вы неправильно понимаете, как работает Boost.Log.

Существуют источники и приемники. Источник берет данные, например строку, и создает с ними запись. Затем запись передается ядру, которое отправляет ее всем приемникам. Затем приемники могут фильтровать, форматировать и выводить записи в любое место, например stdout или в файл.

Примером источника может быть severity_logger, который вы используете. Возможно, вы привыкли к термину «логгер» вместо «источник», но «логгер» не очень точен, потому что логирование — это многоэтапный процесс.

Обычно вам не нужно создавать несколько источников ("регистраторов"). Вместо этого вы можете добавить несколько глобальных приемников. В вашем случае вам понадобится отфильтрованный приемник для каждого файла.

                                  +--------------+
                            +---> | console sink | ----> stdout
                            |     +--------------+
                            |
+--------+      +------+    |     +--------------+
| source | ---> | core | ---+---> | file sink    | ----> log1.txt
+--------+      +------+    |     +--------------+
                            |
                            |     +--------------+
                            +---> | file sink    | ----> log2.txt
                                  +--------------+

Теперь у вас может быть несколько источников, каждый со своей собственной моделью потоков, атрибутами, типом символов и т. д., но все они все равно будут генерировать записи и передавать их ядру. В вашем случае это было бы не очень полезно.

Давайте избавимся от заголовков:

#include <string>
#include <fstream>
#include <boost/log/sinks.hpp>
#include <boost/log/utility/setup/formatter_parser.hpp>
#include <boost/log/sources/severity_channel_logger.hpp>
#include <boost/log/trivial.hpp>
#include <boost/log/utility/setup/file.hpp>
#include <boost/log/utility/setup/common_attributes.hpp>
#include <boost/log/utility/setup/console.hpp>
#include <boost/log/expressions.hpp>
#include <boost/log/attributes/scoped_attribute.hpp>

namespace bl = boost::log;

Давайте начнем:

BOOST_LOG_ATTRIBUTE_KEYWORD(tag_attr, "Tag", std::string);

Запись в журнале имеет атрибуты, которые можно устанавливать каждый раз, когда что-то регистрируется. Эти атрибуты обычно используются при форматировании (например, "[%TimeStamp%] [%Message%]"), но мы добавим новый атрибут, позволяющий различать разные файлы. Я назвал атрибут «Тег».

using logger_type = bl::sources::severity_logger<bl::trivial::severity_level>;
static logger_type g_logger;

const std::string g_format = "[%TimeStamp%] (%LineID%) [%Severity%] [%Tag%]: %Message%";

Теперь, в этом примере, фактический буст-логгер является глобальным объектом (g_logger). Вы можете захотеть ограничить его область действия и передать его своим собственным объектам logger. Я также сделал формат глобальной константой. YMMV.

Это класс logger:

class logger
{
public:
    logger(std::string file)
        : tag_(file)
    {
        using backend_type = bl::sinks::text_file_backend;
        using sink_type = bl::sinks::synchronous_sink<backend_type>;
        namespace kw = bl::keywords;

        auto backend = boost::make_shared<backend_type>(
            kw::file_name = file + "_%N.log",
            kw::rotation_size = 10 * 1024 * 1024,
            kw::time_based_rotation = bl::sinks::file::rotation_at_time_point(0, 0, 0),
            kw::auto_flush = true);

        auto sink = boost::make_shared<sink_type>(backend);
        sink->set_formatter(bl::parse_formatter(g_format));
        sink->set_filter(tag_attr == tag_);

        bl::core::get()->add_sink(sink);
    }

    void log(const std::string& s)
    {
        BOOST_LOG_SCOPED_THREAD_TAG("Tag", tag_);
        BOOST_LOG_SEV(g_logger, bl::trivial::info) << s;
    }

private:
    const std::string tag_;
};

Я использовал имя файла в качестве тега, но это может быть что угодно, лишь бы оно было уникальным. Каждая запись журнала будет иметь этот тег в качестве атрибута, который будет использоваться в фильтре приемника.

Сначала создается text_file_backend и передается новому приемнику, который затем добавляется к ядру. На самом деле это происходит, когда вы вызываете add_file_log(), это просто вспомогательная функция. Я повторно использовал те же параметры, что и в вашем примере (шаблон имени файла, поворот и т. д.).

Интересная строчка вот такая:

sink->set_filter(tag_attr == tag_);

Здесь tag_attr было определено выше как ключевое слово атрибута. Ключевые слова немного необычны в Boost.Log: их можно использовать для создания выражений, которые будут оцениваться во время выполнения. В этом случае приемник будет принимать только записи, где tag_attr == tag_. Поэтому, когда логгер что-то записывает, он устанавливает свой собственный тег в качестве атрибута, и приемник будет игнорировать все, что не имеет этого тега. В log() вы можете увидеть установленный атрибут "Tag".

Вот main():

int main()
{
    bl::register_simple_formatter_factory<bl::trivial::severity_level, char>("Severity");
    boost::log::add_common_attributes();

    bl::add_console_log(std::clog, bl::keywords::format=g_format);

    logger lg1("1");
    logger lg2("2");

    lg1.log("a");
    lg1.log("b");
    lg1.log("c");

    lg2.log("d");
    lg2.log("e");
    lg2.log("f");
}

Вы увидите, что я переместил обычные вещи за пределы logger, так как на самом деле они там неуместны. Записи "a", "b" и "c" будут записаны в "1_0.txt", а "d", "e" и "f" в "2_0.txt". Все шесть записей будут записаны в консоль.

     +--------------+
     | lg1.log("a") |
     +--------------+
            |
            v
+-------------------------+
| Entry:                  |
|   Timestamp: 1472660811 |
|   Message:   "a"        |
|   LineID:    1          |
|   Severity:  info       |
|   Tag:       "1"        |
+-------------------------+
            |            
            v                 +----------------------+
         +------+             | console sink         |
         | core | -----+----> |   file: stdout       |  --> written
         +------+      |      |   filter: none       |
                       |      +----------------------+
                       |      
                       |      +----------------------+
                       |      | file sink            |
                       +----> |   file: "1_0.txt"    |  --> written
                       |      |   filter: tag == "1" |
                       |      +----------------------+
                       |      
                       |      +----------------------+
                       |      | file sink            |
                       +----> |   file: "2_0.txt"    |  --> discarded
                              |   filter: tag == "2" |
                              +----------------------+
person isanae    schedule 31.08.2016