// Copyright (c) 2009-2010 Satoshi Nakamoto // Copyright (c) 2009-2019 The Bitcoin Core developers // Distributed under the MIT software license, see the accompanying // file COPYING or http://www.opensource.org/licenses/mit-license.php. #ifndef BITCOIN_LOGGING_TIMER_H #define BITCOIN_LOGGING_TIMER_H #include #include #include #include #include namespace BCLog { //! RAII-style object that outputs timing information to logs. template class Timer { public: //! If log_category is left as the default, end_msg will log unconditionally //! (instead of being filtered by category). Timer( std::string prefix, std::string end_msg, BCLog::LogFlags log_category = BCLog::LogFlags::ALL) : m_prefix(std::move(prefix)), m_title(std::move(end_msg)), m_log_category(log_category) { this->Log(strprintf("%s started", m_title)); m_start_t = GetTime(); } ~Timer() { this->Log(strprintf("%s completed", m_title)); } void Log(const std::string& msg) { const std::string full_msg = this->LogMsg(msg); if (m_log_category == BCLog::LogFlags::ALL) { LogPrintf("%s\n", full_msg); } else { LogPrint(m_log_category, "%s\n", full_msg); } } std::string LogMsg(const std::string& msg) { const auto end_time = GetTime() - m_start_t; if (m_start_t.count() <= 0) { return strprintf("%s: %s", m_prefix, msg); } std::string units = ""; float divisor = 1; if (std::is_same::value) { units = "μs"; } else if (std::is_same::value) { units = "ms"; divisor = 1000.; } else if (std::is_same::value) { units = "s"; divisor = 1000. * 1000.; } const float time_ms = end_time.count() / divisor; return strprintf("%s: %s (%.2f%s)", m_prefix, msg, time_ms, units); } private: std::chrono::microseconds m_start_t{}; //! Log prefix; usually the name of the function this was created in. const std::string m_prefix{}; //! A descriptive message of what is being timed. const std::string m_title{}; //! Forwarded on to LogPrint if specified - has the effect of only //! outputting the timing log when a particular debug= category is specified. const BCLog::LogFlags m_log_category{}; }; } // namespace BCLog #define LOG_TIME_MICROS(end_msg, ...) \ BCLog::Timer PASTE2(logging_timer, __COUNTER__)(__func__, end_msg, ## __VA_ARGS__) #define LOG_TIME_MILLIS(end_msg, ...) \ BCLog::Timer PASTE2(logging_timer, __COUNTER__)(__func__, end_msg, ## __VA_ARGS__) #define LOG_TIME_SECONDS(end_msg, ...) \ BCLog::Timer PASTE2(logging_timer, __COUNTER__)(__func__, end_msg, ## __VA_ARGS__) #endif // BITCOIN_LOGGING_TIMER_H