ct2rs 0.8.2

Rust bindings for OpenNMT/CTranslate2
Documentation 
1
2
3
4
5
6
7
8
9
10
11
12
13
14
15
16
17
18
19
20
21
22
23
24
25
26
27
28
29
30
31
32
33
34
35
36
37
38
39
40
41
42
43
44
45
46
47
48
49
50
51
52
53
54
55
56
57
58
59
60
61
62
63
64
65
66
67
68
69
70
71
72
73
74
75
76
77
78
79
80
81
82
83
84
85
86
87
88
89
90
91
92
93
94
95
96
97
98
99
100
101
102
103
104
105
106
107
108
109
110
111
112
113
114
115
116
117
118
119
120
121
122
123
124
125
126
127
128
129
130
131
132
133
134
135
136
137
138
139
140
141
142
143
144
145
146
147
148
149
150
151
152
153
154
155
156
157
158
159
160
161
162
163
164
165
166
167
168

#include "ctranslate2/profiler.h"

#ifndef CT2_ENABLE_PROFILING

#include <stdexcept>

namespace ctranslate2 {

  void init_profiling(Device, size_t) {
    throw std::runtime_error("CTranslate2 was not compiled with profiling support, "
                             "enable it with -DENABLE_PROFILING=ON during cmake configuration.");
  }

  void dump_profiling(std::ostream&) {
  }

}

#else

#include <algorithm>
#include <iomanip>
#include <memory>
#include <mutex>
#include <vector>
#include <unordered_map>

namespace ctranslate2 {

  static void print_as_percentage(std::ostream& os, double ratio) {
    os << std::right << std::setw(6) << std::fixed << std::setprecision(2)
       << ratio * 100 << '%';
  }


  class ScopeProfile {
  public:
    std::chrono::microseconds time_in_scope;
    std::chrono::microseconds time_in_scope_and_callees;
  };

  class Profiler {
  private:
    Device _device;
    size_t _num_threads;
    std::chrono::high_resolution_clock::time_point _global_start;
    std::unordered_map<std::string, ScopeProfile> _cumulated;
    std::mutex _mutex;

    ScopeProfile& get_scope_profile(const std::string& name) {
      auto it = _cumulated.find(name);
      if (it == _cumulated.end())
        it = _cumulated.emplace(name, ScopeProfile()).first;
      return it->second;
    }

  public:
    Profiler(Device device, size_t num_threads)
      : _device(device)
      , _num_threads(num_threads)
      , _global_start(std::chrono::high_resolution_clock::now()) {
    }

    Device device() const {
      return _device;
    }

    void add_scope_time(const std::string& name,
                        const std::chrono::microseconds& elapsed,
                        const std::string* parent_name) {
      std::lock_guard<std::mutex> lock(_mutex);
      auto& scope_profile = get_scope_profile(name);
      scope_profile.time_in_scope += elapsed;
      scope_profile.time_in_scope_and_callees += elapsed;
      if (parent_name) {
        auto& parent_scope_profile = get_scope_profile(*parent_name);
        parent_scope_profile.time_in_scope -= elapsed;
      }
    }

    void dump(std::ostream& os) const {
      if (_cumulated.empty())
        return;

      auto total_time = std::chrono::duration_cast<std::chrono::microseconds>(
        std::chrono::high_resolution_clock::now() - _global_start);
      total_time *= _num_threads;

      // Sort from largest to smallest accumulated time.
      std::vector<std::pair<std::string, ScopeProfile>> sorted_cumulated(_cumulated.begin(),
                                                                         _cumulated.end());
      std::sort(sorted_cumulated.begin(), sorted_cumulated.end(),
                [] (const std::pair<std::string, ScopeProfile>& a,
                    const std::pair<std::string, ScopeProfile>& b) {
                  return a.second.time_in_scope > b.second.time_in_scope;
                });

      // Get the longest profiler name to pretty print the output.
      size_t longest_name = 0;
      for (const auto& pair : sorted_cumulated)
        longest_name = std::max(longest_name, pair.first.length());

      double total_time_us = total_time.count();
      double ratio_printed_so_far = 0;
      for (const auto& pair : sorted_cumulated) {
        const auto& name = pair.first;
        const auto& result = pair.second;

        double time_in_scope_us = result.time_in_scope.count();
        double time_in_scope_and_callees_us = result.time_in_scope_and_callees.count();
        double time_in_scope_ratio = time_in_scope_us / total_time_us;
        double time_in_scope_and_callees_ratio = time_in_scope_and_callees_us / total_time_us;
        ratio_printed_so_far += time_in_scope_ratio;

        print_as_percentage(os, time_in_scope_ratio);
        os << ' ';
        print_as_percentage(os, time_in_scope_and_callees_ratio);
        os << ' ';
        print_as_percentage(os, ratio_printed_so_far);
        os << ' ' << std::left << std::setw(longest_name) << name
           << ' ' << (time_in_scope_us / 1000) << "ms"
           << std::endl;
      }
    }
  };


  static std::unique_ptr<Profiler> profiler;


  void init_profiling(Device device, size_t num_threads) {
    profiler = std::make_unique<Profiler>(device, num_threads);
  }

  void dump_profiling(std::ostream& os) {
    if (profiler) {
      profiler->dump(os);
      profiler.reset();
    }
  }


  // Track active scope in the current thread.
  static thread_local ScopeProfiler* current_scope = nullptr;

  ScopeProfiler::ScopeProfiler(const std::string& name) {
    if (!profiler)
      return;
    _parent = current_scope;
    _name = name;
    synchronize_stream(profiler->device());
    _start = std::chrono::high_resolution_clock::now();
    current_scope = this;
  }

  ScopeProfiler::~ScopeProfiler() {
    if (!profiler)
      return;
    synchronize_stream(profiler->device());
    auto diff = std::chrono::high_resolution_clock::now() - _start;
    auto elapsed = std::chrono::duration_cast<std::chrono::microseconds>(diff);
    profiler->add_scope_time(_name, elapsed, _parent ? &_parent->_name : nullptr);
    current_scope = _parent;
  }

}

#endif