bench.cpp 4.92 KB
Newer Older
gabime's avatar
gabime committed
1 2 3 4
//
// Copyright(c) 2015 Gabi Melman.
// Distributed under the MIT License (http://opensource.org/licenses/MIT)
//
gabime's avatar
gabime committed
5

gabi's avatar
gabi committed
6
//
gabime's avatar
gabime committed
7 8
// bench.cpp : spdlog benchmarks
//
9
#include "spdlog/async.h"
gabime's avatar
gabime committed
10
#include "spdlog/sinks/basic_file_sink.h"
gabime's avatar
gabime committed
11
#include "spdlog/sinks/daily_file_sink.h"
gabime's avatar
gabime committed
12
#include "spdlog/sinks/null_sink.h"
gabime's avatar
gabime committed
13
#include "spdlog/sinks/rotating_file_sink.h"
gabime's avatar
gabime committed
14 15
#include "spdlog/spdlog.h"
#include "utils.h"
16 17
#include <atomic>
#include <cstdlib> // EXIT_FAILURE
gabime's avatar
gabime committed
18 19 20 21
#include <iostream>
#include <memory>
#include <string>
#include <thread>
22 23

using namespace std;
gabi's avatar
gabi committed
24
using namespace std::chrono;
25
using namespace spdlog;
gabime's avatar
gabime committed
26
using namespace spdlog::sinks;
gabi's avatar
gabi committed
27 28
using namespace utils;

gabi's avatar
gabi committed
29 30
void bench(int howmany, std::shared_ptr<spdlog::logger> log);
void bench_mt(int howmany, std::shared_ptr<spdlog::logger> log, int thread_count);
gabi's avatar
gabi committed
31

gabime's avatar
gabime committed
32
int main(int argc, char *argv[])
gabi's avatar
gabi committed
33
{
gabi's avatar
gabi committed
34

35
    int howmany = 1000000;
gabime's avatar
gabime committed
36
    int queue_size = howmany + 2;
37
    int threads = 10;
gabime's avatar
gabime committed
38 39 40 41 42 43
    int file_size = 30 * 1024 * 1024;
    int rotating_files = 5;

    try
    {

gabime's avatar
gabime committed
44
        if (argc > 1)
gabime's avatar
gabime committed
45 46
            howmany = atoi(argv[1]);
        if (argc > 2)
gabime's avatar
gabime committed
47
            threads = atoi(argv[2]);
48 49
        if (argc > 3)
            queue_size = atoi(argv[3]);
gabime's avatar
gabime committed
50

gabime's avatar
gabime committed
51 52
        cout << "******************************************************************"
                "*************\n";
gabime's avatar
gabime committed
53
        cout << "Single thread, " << format(howmany) << " iterations" << endl;
gabime's avatar
gabime committed
54 55
        cout << "******************************************************************"
                "*************\n";
gabime's avatar
gabime committed
56

gabime's avatar
gabime committed
57 58 59
        auto basic_st = spdlog::basic_logger_mt("basic_st", "logs/basic_st.log", true);
        bench(howmany, basic_st);

60
        auto rotating_st = spdlog::rotating_logger_st("rotating_st", "logs/rotating_st.log", file_size, rotating_files);
gabime's avatar
gabime committed
61
        bench(howmany, rotating_st);
gabime's avatar
gabime committed
62

63
        auto daily_st = spdlog::daily_logger_st("daily_st", "logs/daily_st.log");
gabime's avatar
gabime committed
64
        bench(howmany, daily_st);
gabime's avatar
gabime committed
65

gabime's avatar
gabime committed
66 67
        bench(howmany, spdlog::create<null_sink_st>("null_st"));

gabime's avatar
gabime committed
68 69
        cout << "\n****************************************************************"
                "***************\n";
gabime's avatar
gabime committed
70
        cout << threads << " threads sharing same logger, " << format(howmany) << " iterations" << endl;
gabime's avatar
gabime committed
71 72
        cout << "******************************************************************"
                "*************\n";
gabime's avatar
gabime committed
73

gabime's avatar
gabime committed
74 75 76
        auto basic_mt = spdlog::basic_logger_mt("basic_mt", "logs/basic_mt.log", true);
        bench_mt(howmany, basic_mt, threads);

77
        auto rotating_mt = spdlog::rotating_logger_mt("rotating_mt", "logs/rotating_mt.log", file_size, rotating_files);
gabime's avatar
gabime committed
78 79
        bench_mt(howmany, rotating_mt, threads);

80
        auto daily_mt = spdlog::daily_logger_mt("daily_mt", "logs/daily_mt.log");
gabime's avatar
gabime committed
81
        bench_mt(howmany, daily_mt, threads);
gabime's avatar
gabime committed
82
        bench_mt(howmany, spdlog::create<null_sink_mt>("null_mt"), threads);
83

gabime's avatar
gabime committed
84 85
        cout << "\n****************************************************************"
                "***************\n";
gabime's avatar
gabime committed
86
        cout << "async logging.. " << threads << " threads sharing same logger, " << format(howmany) << " iterations " << endl;
gabime's avatar
gabime committed
87 88
        cout << "******************************************************************"
                "*************\n";
gabime's avatar
gabime committed
89

90
        for (int i = 0; i < 3; ++i)
gabime's avatar
gabime committed
91
        {
gabime's avatar
gabime committed
92
            spdlog::init_thread_pool(queue_size, 1);
gabime's avatar
gabime committed
93
            auto as = spdlog::basic_logger_mt<spdlog::async_factory>("async", "logs/basic_async.log", true);
gabime's avatar
gabime committed
94
            bench_mt(howmany, as, threads);
gabime's avatar
gabime committed
95
            spdlog::drop("async");
gabime's avatar
gabime committed
96 97 98 99 100 101
        }
    }
    catch (std::exception &ex)
    {
        std::cerr << "Error: " << ex.what() << std::endl;
        perror("Last error");
102
        return EXIT_FAILURE;
gabime's avatar
gabime committed
103
    }
104
    return EXIT_SUCCESS;
gabi's avatar
gabi committed
105 106
}

gabi's avatar
gabi committed
107 108
void bench(int howmany, std::shared_ptr<spdlog::logger> log)
{
gabime's avatar
gabime committed
109
    using std::chrono::high_resolution_clock;
gabime's avatar
gabime committed
110
    cout << log->name() << "...\t\t" << flush;
gabime's avatar
gabime committed
111
    auto start = high_resolution_clock::now();
gabime's avatar
gabime committed
112 113 114 115
    for (auto i = 0; i < howmany; ++i)
    {
        log->info("Hello logger: msg number {}", i);
    }
gabi's avatar
gabi committed
116

gabime's avatar
gabime committed
117
    auto delta = high_resolution_clock::now() - start;
gabime's avatar
gabime committed
118
    auto delta_d = duration_cast<duration<double>>(delta).count();
119

120
    cout << "Elapsed: " << delta_d << "\t" << format(int(howmany / delta_d)) << "/sec" << endl;
gabime's avatar
gabime committed
121
    spdlog::drop(log->name());
gabi's avatar
gabi committed
122 123 124 125
}

void bench_mt(int howmany, std::shared_ptr<spdlog::logger> log, int thread_count)
{
gabime's avatar
gabime committed
126
    using std::chrono::high_resolution_clock;
gabime's avatar
gabime committed
127 128
    cout << log->name() << "...\t\t" << flush;
    vector<thread> threads;
gabime's avatar
gabime committed
129
    auto start = high_resolution_clock::now();
gabime's avatar
gabime committed
130 131
    for (int t = 0; t < thread_count; ++t)
    {
gabime's avatar
gabime committed
132
        threads.push_back(std::thread([&]() {
gabime's avatar
gabime committed
133
            for (int j = 0; j < howmany / thread_count; j++)
gabime's avatar
gabime committed
134
            {
gabime's avatar
gabime committed
135
                log->info("Hello logger: msg number {}", j);
gabime's avatar
gabime committed
136 137 138 139
            }
        }));
    }

gabime's avatar
gabime committed
140
    for (auto &t : threads)
gabime's avatar
gabime committed
141 142 143 144
    {
        t.join();
    };

gabime's avatar
gabime committed
145
    auto delta = high_resolution_clock::now() - start;
gabime's avatar
gabime committed
146
    auto delta_d = duration_cast<duration<double>>(delta).count();
147
    cout << "Elapsed: " << delta_d << "\t" << format(int(howmany / delta_d)) << "/sec" << endl;
gabi's avatar
gabi committed
148
}