Using the ROCm Systems Profiler API#
The following example shows how a program can use the ROCm Systems Profiler API for run-time analysis.
ROCm Systems Profiler user API example program#
You can use the ROCm Systems Profiler API to define custom regions to profile and trace.
The following C++ program demonstrates this technique by calling several functions from the
ROCm Systems Profiler API, such as rocprofsys_user_push_region
and
rocprofsys_user_stop_thread_trace
.
Note
By default, when ROCm Systems Profiler detects any rocprofsys_user_start_*
or
rocprofsys_user_stop_*
function, instrumentation
is disabled at start up, which means rocprofsys_user_stop_trace()
is not
required at the beginning of main
. This behavior
can be manually controlled by using the ROCPROFSYS_INIT_ENABLED
environment variable.
User-defined regions are always
recorded, regardless of whether rocprofsys_user_start_*
or
rocprofsys_user_stop_*
has been called.
#include <rocprofiler-systems/categories.h>
#include <rocprofiler-systems/types.h>
#include <rocprofiler-systems/user.h>
#include <atomic>
#include <cassert>
#include <cerrno>
#include <cstdio>
#include <cstdlib>
#include <cstring>
#include <sstream>
#include <thread>
#include <vector>
std::atomic<long> total{ 0 };
long
fib(long n) __attribute__((noinline));
void
run(size_t nitr, long) __attribute__((noinline));
int
custom_push_region(const char* name);
namespace
{
rocprofsys_user_callbacks_t custom_callbacks = ROCPROFSYS_USER_CALLBACKS_INIT;
rocprofsys_user_callbacks_t original_callbacks = ROCPROFSYS_USER_CALLBACKS_INIT;
} // namespace
int
main(int argc, char** argv)
{
custom_callbacks.push_region = &custom_push_region;
rocprofsys_user_configure(ROCPROFSYS_USER_UNION_CONFIG, custom_callbacks,
&original_callbacks);
rocprofsys_user_push_region(argv[0]);
rocprofsys_user_push_region("initialization");
size_t nthread = std::min<size_t>(16, std::thread::hardware_concurrency());
size_t nitr = 50000;
long nfib = 10;
if(argc > 1) nfib = atol(argv[1]);
if(argc > 2) nthread = atol(argv[2]);
if(argc > 3) nitr = atol(argv[3]);
rocprofsys_user_pop_region("initialization");
printf("[%s] Threads: %zu\n[%s] Iterations: %zu\n[%s] fibonacci(%li)...\n", argv[0],
nthread, argv[0], nitr, argv[0], nfib);
rocprofsys_user_push_region("thread_creation");
std::vector<std::thread> threads{};
threads.reserve(nthread);
// disable instrumentation for child threads
rocprofsys_user_stop_thread_trace();
for(size_t i = 0; i < nthread; ++i)
{
threads.emplace_back(&run, nitr, nfib);
}
// re-enable instrumentation
rocprofsys_user_start_thread_trace();
rocprofsys_user_pop_region("thread_creation");
rocprofsys_user_push_region("thread_wait");
for(auto& itr : threads)
itr.join();
rocprofsys_user_pop_region("thread_wait");
run(nitr, nfib);
printf("[%s] fibonacci(%li) x %lu = %li\n", argv[0], nfib, nthread, total.load());
rocprofsys_user_pop_region(argv[0]);
return 0;
}
long
fib(long n)
{
return (n < 2) ? n : fib(n - 1) + fib(n - 2);
}
#define RUN_LABEL \
std::string{ std::string{ __FUNCTION__ } + "(" + std::to_string(n) + ") x " + \
std::to_string(nitr) } \
.c_str()
void
run(size_t nitr, long n)
{
rocprofsys_user_push_region(RUN_LABEL);
long local = 0;
for(size_t i = 0; i < nitr; ++i)
local += fib(n);
total += local;
rocprofsys_user_pop_region(RUN_LABEL);
}
int
custom_push_region(const char* name)
{
if(!original_callbacks.push_region || !original_callbacks.push_annotated_region)
return ROCPROFSYS_USER_ERROR_NO_BINDING;
printf("Pushing custom region :: %s\n", name);
if(original_callbacks.push_annotated_region)
{
int32_t _err = errno;
char* _msg = nullptr;
char _buff[1024];
if(_err != 0) _msg = strerror_r(_err, _buff, sizeof(_buff));
rocprofsys_annotation_t _annotations[] = {
{ "errno", ROCPROFSYS_INT32, &_err }, { "strerror", ROCPROFSYS_STRING, _msg }
};
errno = 0; // reset errno
return (*original_callbacks.push_annotated_region)(
name, _annotations, sizeof(_annotations) / sizeof(rocprofsys_annotation_t));
}
return (*original_callbacks.push_region)(name);
}
Linking the ROCm Systems Profiler libraries to another program#
To link the rocprofiler-systems-user-library
to another program,
use the following CMake and g++
directives.
CMake#
find_package(rocprofiler-systems REQUIRED COMPONENTS user)
add_executable(foo foo.cpp)
target_link_libraries(foo PRIVATE rocprofiler-systems::rocprofiler-systems-user-library)
g++ compilation#
Assuming ROCm Systems Profiler is installed in /opt/rocprofsys
, use the g++
compiler
to build the application.
g++ -g -I/opt/rocprofsys/include -L/opt/rocprofsys/lib foo.cpp -o foo -lrocprof-sys-user
Output from the API example program#
First, instrument and run the program.
$ rocprof-sys-instrument -l --min-instructions=8 -E custom_push_region -o user-api.inst -- ./user-api
...
$ rocprof-sys-run --profile --trace -- ./user-api.inst 10 12 1000
ROCPROFSYS: HSA_TOOLS_LIB=/opt/rocm-6.3.1/lib/librocprof-sys-dl.so.0.1.0
ROCPROFSYS: HSA_TOOLS_REPORT_LOAD_FAILURE=1
ROCPROFSYS: LD_PRELOAD=/opt/rocm-6.3.1/lib/librocprof-sys-dl.so.0.1.0
ROCPROFSYS: OMP_TOOL_LIBRARIES=/opt/rocm-6.3.1/lib/librocprof-sys-dl.so.0.1.0
ROCPROFSYS: ROCPROFSYS_PROFILE=true
ROCPROFSYS: ROCPROFSYS_TRACE=true
ROCPROFSYS: ROCPROFSYS_VERBOSE=0
ROCPROFSYS: ROCP_HSA_INTERCEPT=1
ROCPROFSYS: ROCP_TOOL_LIB=/opt/rocm-6.3.1/lib/librocprof-sys.so.0.1.0
[rocprof-sys][dl][297646] rocprofsys_main
[rocprof-sys][297646][rocprofsys_init_tooling] Instrumentation mode: Trace
____ ___ ____ __ __ ______ ______ _____ _____ __ __ ____ ____ ____ ___ _____ ___ _ _____ ____
| _ \ / _ \ / ___| \/ | / ___\ \ / / ___|_ _| ____| \/ / ___| | _ \| _ \ / _ \| ___|_ _| | | ____| _ \
| |_) | | | | | | |\/| | \___ \\ V /\___ \ | | | _| | |\/| \___ \ | |_) | |_) | | | | |_ | || | | _| | |_) |
| _ <| |_| | |___| | | | ___) || | ___) || | | |___| | | |___) | | __/| _ <| |_| | _| | || |___| |___| _ <
|_| \_\\___/ \____|_| |_| |____/ |_| |____/ |_| |_____|_| |_|____/ |_| |_| \_\\___/|_| |___|_____|_____|_| \_\
rocprof-sys v0.1.0 (rev: b569c837e455f71dd76d06392d0b901ae927deca, x86_64-linux-gnu, compiler: GNU v11.4.0, rocm: v6.3.x)
[105.947] perfetto.cc:47606 Configured tracing session 1, #sources:1, duration:0 ms, #buffers:1, total buffer size:1024000 KB, total sessions:1, uid:0 session name: ""
Pushing custom region :: ./user-api.inst
Pushing custom region :: initialization
[./user-api.inst] Threads: 12
[./user-api.inst] Iterations: 1000
[./user-api.inst] fibonacci(10)...
Pushing custom region :: thread_creation
Pushing custom region :: run(10) x 1000
Pushing custom region :: run(10) x 1000
Pushing custom region :: run(10) x 1000
Pushing custom region :: run(10) x 1000
Pushing custom region :: run(10) x 1000
Pushing custom region :: run(10) x 1000
Pushing custom region :: run(10) x 1000
Pushing custom region :: run(10) x 1000
Pushing custom region :: run(10) x 1000
Pushing custom region :: run(10) x 1000
Pushing custom region :: run(10) x 1000
Pushing custom region :: run(10) x 1000
Pushing custom region :: thread_wait
Pushing custom region :: run(10) x 1000
[./user-api.inst] fibonacci(10) x 12 = 715000
[rocprof-sys][297646][0][rocprofsys_finalize] finalizing...
[rocprof-sys][297646][0][rocprofsys_finalize]
[rocprof-sys][297646][0][rocprofsys_finalize] rocprofsys/process/297646 : 0.978014 sec wall_clock, 26.752 MB peak_rss, 27.394 MB page_rss, 1.520000 sec cpu_clock, 155.4 % cpu_util [laps: 1]
[rocprof-sys][297646][0][rocprofsys_finalize] rocprofsys/process/297646/thread/0 : 0.976068 sec wall_clock, 0.789948 sec thread_cpu_clock, 80.9 % thread_cpu_util, 26.112 MB peak_rss [laps: 1]
[rocprof-sys][297646][0][rocprofsys_finalize] rocprofsys/process/297646/thread/1 : 0.027517 sec wall_clock, 0.027510 sec thread_cpu_clock, 100.0 % thread_cpu_util, 0.768 MB peak_rss [laps: 1]
[rocprof-sys][297646][0][rocprofsys_finalize] rocprofsys/process/297646/thread/2 : 0.027828 sec wall_clock, 0.027811 sec thread_cpu_clock, 99.9 % thread_cpu_util, 3.584 MB peak_rss [laps: 1]
[rocprof-sys][297646][0][rocprofsys_finalize] rocprofsys/process/297646/thread/3 : 0.027585 sec wall_clock, 0.027585 sec thread_cpu_clock, 100.0 % thread_cpu_util, 3.584 MB peak_rss [laps: 1]
[rocprof-sys][297646][0][rocprofsys_finalize] rocprofsys/process/297646/thread/4 : 0.033449 sec wall_clock, 0.033443 sec thread_cpu_clock, 100.0 % thread_cpu_util, 3.584 MB peak_rss [laps: 1]
[rocprof-sys][297646][0][rocprofsys_finalize] rocprofsys/process/297646/thread/5 : 0.027727 sec wall_clock, 0.027726 sec thread_cpu_clock, 100.0 % thread_cpu_util, 3.328 MB peak_rss [laps: 1]
[rocprof-sys][297646][0][rocprofsys_finalize] rocprofsys/process/297646/thread/6 : 0.032228 sec wall_clock, 0.032220 sec thread_cpu_clock, 100.0 % thread_cpu_util, 3.712 MB peak_rss [laps: 1]
[rocprof-sys][297646][0][rocprofsys_finalize] rocprofsys/process/297646/thread/7 : 0.030201 sec wall_clock, 0.030202 sec thread_cpu_clock, 100.0 % thread_cpu_util, 0.768 MB peak_rss [laps: 1]
[rocprof-sys][297646][0][rocprofsys_finalize] rocprofsys/process/297646/thread/8 : 0.027960 sec wall_clock, 0.027951 sec thread_cpu_clock, 100.0 % thread_cpu_util, 0.640 MB peak_rss [laps: 1]
[rocprof-sys][297646][0][rocprofsys_finalize] rocprofsys/process/297646/thread/9 : 0.034698 sec wall_clock, 0.034699 sec thread_cpu_clock, 100.0 % thread_cpu_util, 0.640 MB peak_rss [laps: 1]
[rocprof-sys][297646][0][rocprofsys_finalize] rocprofsys/process/297646/thread/10 : 0.033414 sec wall_clock, 0.033399 sec thread_cpu_clock, 100.0 % thread_cpu_util, 0.512 MB peak_rss [laps: 1]
[rocprof-sys][297646][0][rocprofsys_finalize] rocprofsys/process/297646/thread/11 : 0.028161 sec wall_clock, 0.028149 sec thread_cpu_clock, 100.0 % thread_cpu_util, 0.384 MB peak_rss [laps: 1]
[rocprof-sys][297646][0][rocprofsys_finalize] rocprofsys/process/297646/thread/12 : 0.027791 sec wall_clock, 0.027767 sec thread_cpu_clock, 99.9 % thread_cpu_util, 0.256 MB peak_rss [laps: 1]
[rocprof-sys][297646][0][rocprofsys_finalize]
[rocprof-sys][297646][0][rocprofsys_finalize] Finalizing perfetto...
[rocprofiler-systems][297646][perfetto]> Outputting '/home/gliff/opt/user-api-test/rocprofsys-user-api.inst-output/2025-01-02_19.29/perfetto-trace-297646.proto' (16728.58 KB / 16.73 MB / 0.02 GB)... Done
[rocprofiler-systems][297646][wall_clock]> Outputting 'rocprofsys-user-api.inst-output/2025-01-02_19.29/wall_clock-297646.json'
[rocprofiler-systems][297646][wall_clock]> Outputting 'rocprofsys-user-api.inst-output/2025-01-02_19.29/wall_clock-297646.txt'
[rocprofiler-systems][297646][roctracer]> Outputting 'rocprofsys-user-api.inst-output/2025-01-02_19.29/roctracer-297646.json'
[rocprofiler-systems][297646][roctracer]> Outputting 'rocprofsys-user-api.inst-output/2025-01-02_19.29/roctracer-297646.txt'
[rocprofiler-systems][297646][metadata]> Outputting 'rocprofsys-user-api.inst-output/2025-01-02_19.29/metadata-297646.json' and 'rocprofsys-user-api.inst-output/2025-01-02_19.29/functions-297646.json'
[rocprof-sys][297646][0][rocprofsys_finalize] Finalized: 0.314368 sec wall_clock, 19.040 MB peak_rss, 3.498 MB page_rss, 0.280000 sec cpu_clock, 89.1 % cpu_util
[107.243] perfetto.cc:49204 Tracing session 1 ended, total sessions:0
Then review the output.
$ cat rocprof-sys-example-output/wall_clock.txt
|----------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------|
| REAL-CLOCK TIMER (I.E. WALL-CLOCK TIMER) |
|----------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------|
| LABEL | COUNT | DEPTH | METRIC | UNITS | SUM | MEAN | MIN | MAX | VAR | STDDEV | % SELF |
|---------------------------------------------------------------------------------------------------------|--------|--------|------------|--------|----------|----------|----------|----------|----------|----------|--------|
| |00>>> ./user-api.inst | 1 | 0 | wall_clock | sec | 0.874293 | 0.874293 | 0.874293 | 0.874293 | 0.000000 | 0.000000 | 0.0 |
| |00>>> |_initialization | 1 | 1 | wall_clock | sec | 0.000015 | 0.000015 | 0.000015 | 0.000015 | 0.000000 | 0.000000 | 100.0 |
| |00>>> |_thread_creation | 1 | 1 | wall_clock | sec | 0.059934 | 0.059934 | 0.059934 | 0.059934 | 0.000000 | 0.000000 | 1.0 |
| |00>>> |_pthread_create | 12 | 2 | wall_clock | sec | 0.059338 | 0.004945 | 0.004455 | 0.005743 | 0.000000 | 0.000479 | 0.0 |
| |01>>> |_start_thread | 1 | 3 | wall_clock | sec | 0.027499 | 0.027499 | 0.027499 | 0.027499 | 0.000000 | 0.000000 | 0.1 |
| |01>>> |_run(10) x 1000 | 1 | 4 | wall_clock | sec | 0.027463 | 0.027463 | 0.027463 | 0.027463 | 0.000000 | 0.000000 | 100.0 |
| |02>>> |_start_thread | 1 | 3 | wall_clock | sec | 0.027804 | 0.027804 | 0.027804 | 0.027804 | 0.000000 | 0.000000 | 0.2 |
| |02>>> |_run(10) x 1000 | 1 | 4 | wall_clock | sec | 0.027752 | 0.027752 | 0.027752 | 0.027752 | 0.000000 | 0.000000 | 100.0 |
| |03>>> |_start_thread | 1 | 3 | wall_clock | sec | 0.027567 | 0.027567 | 0.027567 | 0.027567 | 0.000000 | 0.000000 | 0.1 |
| |03>>> |_run(10) x 1000 | 1 | 4 | wall_clock | sec | 0.027529 | 0.027529 | 0.027529 | 0.027529 | 0.000000 | 0.000000 | 100.0 |
| |05>>> |_start_thread | 1 | 3 | wall_clock | sec | 0.027699 | 0.027699 | 0.027699 | 0.027699 | 0.000000 | 0.000000 | 0.2 |
| |05>>> |_run(10) x 1000 | 1 | 4 | wall_clock | sec | 0.027651 | 0.027651 | 0.027651 | 0.027651 | 0.000000 | 0.000000 | 100.0 |
| |04>>> |_start_thread | 1 | 3 | wall_clock | sec | 0.033427 | 0.033427 | 0.033427 | 0.033427 | 0.000000 | 0.000000 | 0.2 |
| |04>>> |_run(10) x 1000 | 1 | 4 | wall_clock | sec | 0.033376 | 0.033376 | 0.033376 | 0.033376 | 0.000000 | 0.000000 | 100.0 |
| |06>>> |_start_thread | 1 | 3 | wall_clock | sec | 0.032210 | 0.032210 | 0.032210 | 0.032210 | 0.000000 | 0.000000 | 0.1 |
| |06>>> |_run(10) x 1000 | 1 | 4 | wall_clock | sec | 0.032168 | 0.032168 | 0.032168 | 0.032168 | 0.000000 | 0.000000 | 100.0 |
| |07>>> |_start_thread | 1 | 3 | wall_clock | sec | 0.030176 | 0.030176 | 0.030176 | 0.030176 | 0.000000 | 0.000000 | 0.2 |
| |07>>> |_run(10) x 1000 | 1 | 4 | wall_clock | sec | 0.030122 | 0.030122 | 0.030122 | 0.030122 | 0.000000 | 0.000000 | 100.0 |
| |08>>> |_start_thread | 1 | 3 | wall_clock | sec | 0.027941 | 0.027941 | 0.027941 | 0.027941 | 0.000000 | 0.000000 | 0.1 |
| |08>>> |_run(10) x 1000 | 1 | 4 | wall_clock | sec | 0.027899 | 0.027899 | 0.027899 | 0.027899 | 0.000000 | 0.000000 | 100.0 |
| |09>>> |_start_thread | 1 | 3 | wall_clock | sec | 0.034679 | 0.034679 | 0.034679 | 0.034679 | 0.000000 | 0.000000 | 0.1 |
| |09>>> |_run(10) x 1000 | 1 | 4 | wall_clock | sec | 0.034636 | 0.034636 | 0.034636 | 0.034636 | 0.000000 | 0.000000 | 100.0 |
| |11>>> |_start_thread | 1 | 3 | wall_clock | sec | 0.028143 | 0.028143 | 0.028143 | 0.028143 | 0.000000 | 0.000000 | 0.1 |
| |11>>> |_run(10) x 1000 | 1 | 4 | wall_clock | sec | 0.028103 | 0.028103 | 0.028103 | 0.028103 | 0.000000 | 0.000000 | 100.0 |
| |10>>> |_start_thread | 1 | 3 | wall_clock | sec | 0.033393 | 0.033393 | 0.033393 | 0.033393 | 0.000000 | 0.000000 | 0.1 |
| |10>>> |_run(10) x 1000 | 1 | 4 | wall_clock | sec | 0.033354 | 0.033354 | 0.033354 | 0.033354 | 0.000000 | 0.000000 | 100.0 |
| |12>>> |_start_thread | 1 | 3 | wall_clock | sec | 0.027765 | 0.027765 | 0.027765 | 0.027765 | 0.000000 | 0.000000 | 0.2 |
| |12>>> |_run(10) x 1000 | 1 | 4 | wall_clock | sec | 0.027710 | 0.027710 | 0.027710 | 0.027710 | 0.000000 | 0.000000 | 100.0 |
| |00>>> |_thread_wait | 1 | 1 | wall_clock | sec | 0.027971 | 0.027971 | 0.027971 | 0.027971 | 0.000000 | 0.000000 | 1.3 |
| |00>>> |_std::vector<std::thread, std::allocator<std::thread> >::begin | 1 | 2 | wall_clock | sec | 0.000003 | 0.000003 | 0.000003 | 0.000003 | 0.000000 | 0.000000 | 100.0 |
| |00>>> |_std::vector<std::thread, std::allocator<std::thread> >::end | 1 | 2 | wall_clock | sec | 0.000002 | 0.000002 | 0.000002 | 0.000002 | 0.000000 | 0.000000 | 100.0 |
| |00>>> |___gnu_cxx::operator!=<std::thread*, std::vector<std::thread, std::allocator<std::thread> > > | 13 | 2 | wall_clock | sec | 0.000024 | 0.000002 | 0.000001 | 0.000003 | 0.000000 | 0.000000 | 100.0 |
| |00>>> |_pthread_join | 12 | 2 | wall_clock | sec | 0.027583 | 0.002299 | 0.000003 | 0.011250 | 0.000011 | 0.003289 | 100.0 |
| |00>>> |_run | 1 | 1 | wall_clock | sec | 0.786236 | 0.786236 | 0.786236 | 0.786236 | 0.000000 | 0.000000 | 0.0 |
| |00>>> |_std::char_traits<char>::length | 1 | 2 | wall_clock | sec | 0.000002 | 0.000002 | 0.000002 | 0.000002 | 0.000000 | 0.000000 | 100.0 |
| |00>>> |_std::distance<char const*> | 1 | 2 | wall_clock | sec | 0.000002 | 0.000002 | 0.000002 | 0.000002 | 0.000000 | 0.000000 | 100.0 |
| |00>>> |_std::operator+<char, std::char_traits<char>, std::allocator<char> > | 4 | 2 | wall_clock | sec | 0.000006 | 0.000002 | 0.000001 | 0.000002 | 0.000000 | 0.000000 | 100.0 |
| |00>>> |_run(10) x 1000 | 1 | 2 | wall_clock | sec | 0.786184 | 0.786184 | 0.786184 | 0.786184 | 0.000000 | 0.000000 | 0.0 |
| |00>>> |_run [{95,25}-{97,25}] | 1 | 3 | wall_clock | sec | 0.786141 | 0.786141 | 0.786141 | 0.786141 | 0.000000 | 0.000000 | 0.4 |
| |00>>> |_fib | 1000 | 4 | wall_clock | sec | 0.782692 | 0.000783 | 0.000757 | 0.001397 | 0.000000 | 0.000026 | 1.0 |
| |00>>> |_fib | 2000 | 5 | wall_clock | sec | 0.774875 | 0.000387 | 0.000282 | 0.000863 | 0.000000 | 0.000095 | 2.0 |
| |00>>> |_fib | 4000 | 6 | wall_clock | sec | 0.759351 | 0.000190 | 0.000101 | 0.000570 | 0.000000 | 0.000068 | 4.0 |
| |00>>> |_fib | 8000 | 7 | wall_clock | sec | 0.728911 | 0.000091 | 0.000034 | 0.000350 | 0.000000 | 0.000042 | 8.5 |
| |00>>> |_fib | 16000 | 8 | wall_clock | sec | 0.666793 | 0.000042 | 0.000009 | 0.000206 | 0.000000 | 0.000025 | 18.5 |
| |00>>> |_fib | 32000 | 9 | wall_clock | sec | 0.543524 | 0.000017 | 0.000001 | 0.000121 | 0.000000 | 0.000014 | 38.3 |
| |00>>> |_fib | 52000 | 10 | wall_clock | sec | 0.335118 | 0.000006 | 0.000001 | 0.000070 | 0.000000 | 0.000008 | 61.0 |
| |00>>> |_fib | 44000 | 11 | wall_clock | sec | 0.130629 | 0.000003 | 0.000001 | 0.000036 | 0.000000 | 0.000004 | 79.4 |
| |00>>> |_fib | 16000 | 12 | wall_clock | sec | 0.026893 | 0.000002 | 0.000001 | 0.000026 | 0.000000 | 0.000002 | 91.5 |
| |00>>> |_fib | 2000 | 13 | wall_clock | sec | 0.002279 | 0.000001 | 0.000001 | 0.000014 | 0.000000 | 0.000001 | 100.0 |
| |00>>> |_std::char_traits<char>::length | 1 | 3 | wall_clock | sec | 0.000001 | 0.000001 | 0.000001 | 0.000001 | 0.000000 | 0.000000 | 100.0 |
| |00>>> |_std::distance<char const*> | 1 | 3 | wall_clock | sec | 0.000001 | 0.000001 | 0.000001 | 0.000001 | 0.000000 | 0.000000 | 100.0 |
| |00>>> |_std::operator+<char, std::char_traits<char>, std::allocator<char> > | 4 | 3 | wall_clock | sec | 0.000005 | 0.000001 | 0.000001 | 0.000002 | 0.000000 | 0.000000 | 100.0 |
| |00>>> |_std::operator& | 1 | 1 | wall_clock | sec | 0.000003 | 0.000003 | 0.000003 | 0.000003 | 0.000000 | 0.000000 | 100.0 |
| |00>>> std::vector<std::thread, std::allocator<std::thread> >::~vector | 1 | 0 | wall_clock | sec | 0.000256 | 0.000256 | 0.000256 | 0.000256 | 0.000000 | 0.000000 | 20.9 |
| |00>>> |_std::thread::~thread | 12 | 1 | wall_clock | sec | 0.000193 | 0.000016 | 0.000014 | 0.000025 | 0.000000 | 0.000004 | 31.9 |
| |00>>> |_std::thread::joinable | 12 | 2 | wall_clock | sec | 0.000131 | 0.000011 | 0.000010 | 0.000017 | 0.000000 | 0.000003 | 77.6 |
| |00>>> |_std::thread::id::id | 12 | 3 | wall_clock | sec | 0.000016 | 0.000001 | 0.000001 | 0.000004 | 0.000000 | 0.000001 | 100.0 |
| |00>>> |_std::operator== | 12 | 3 | wall_clock | sec | 0.000014 | 0.000001 | 0.000001 | 0.000002 | 0.000000 | 0.000000 | 100.0 |
| |00>>> |_std::allocator_traits<std::allocator<std::thread> >::deallocate | 1 | 1 | wall_clock | sec | 0.000008 | 0.000008 | 0.000008 | 0.000008 | 0.000000 | 0.000000 | 70.8 |
| |00>>> |___gnu_cxx::new_allocator<std::thread>::deallocate | 1 | 2 | wall_clock | sec | 0.000002 | 0.000002 | 0.000002 | 0.000002 | 0.000000 | 0.000000 | 100.0 |
| |00>>> |_std::allocator<std::thread>::~allocator | 1 | 1 | wall_clock | sec | 0.000001 | 0.000001 | 0.000001 | 0.000001 | 0.000000 | 0.000000 | 100.0 |
|----------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------|