Merge branch 'jk/output-prefix-cleanup'
[git/gitster.git] / trace2.h
blob901f39253a65931226b93f8f4986c93ac0e4df69
1 #ifndef TRACE2_H
2 #define TRACE2_H
4 /**
5 * The Trace2 API can be used to print debug, performance, and telemetry
6 * information to stderr or a file. The Trace2 feature is inactive unless
7 * explicitly enabled by enabling one or more Trace2 Targets.
9 * The Trace2 API is intended to replace the existing (Trace1)
10 * printf-style tracing provided by the existing `GIT_TRACE` and
11 * `GIT_TRACE_PERFORMANCE` facilities. During initial implementation,
12 * Trace2 and Trace1 may operate in parallel.
14 * The Trace2 API defines a set of high-level messages with known fields,
15 * such as (`start`: `argv`) and (`exit`: {`exit-code`, `elapsed-time`}).
17 * Trace2 instrumentation throughout the Git code base sends Trace2
18 * messages to the enabled Trace2 Targets. Targets transform these
19 * messages content into purpose-specific formats and write events to
20 * their data streams. In this manner, the Trace2 API can drive
21 * many different types of analysis.
23 * Targets are defined using a VTable allowing easy extension to other
24 * formats in the future. This might be used to define a binary format,
25 * for example.
27 * Trace2 is controlled using `trace2.*` config values in the system and
28 * global config files and `GIT_TRACE2*` environment variables. Trace2 does
29 * not read from repo local or worktree config files or respect `-c`
30 * command line config settings.
32 * For more info about: trace2 targets, conventions for public functions and
33 * macros, trace2 target formats and examples on trace2 API usage refer to
34 * Documentation/technical/api-trace2.txt
38 struct child_process;
39 struct repository;
40 struct json_writer;
43 * The public TRACE2 routines are grouped into the following groups:
45 * [] trace2_initialize -- initialization.
46 * [] trace2_cmd_* -- emit command/control messages.
47 * [] trace2_child* -- emit child start/stop messages.
48 * [] trace2_exec* -- emit exec start/stop messages.
49 * [] trace2_thread* -- emit thread start/stop messages.
50 * [] trace2_def* -- emit definition/parameter mesasges.
51 * [] trace2_region* -- emit region nesting messages.
52 * [] trace2_data* -- emit region/thread/repo data messages.
53 * [] trace2_printf* -- legacy trace[1] messages.
54 * [] trace2_timer* -- stopwatch timers (messages are deferred).
55 * [] trace2_counter* -- global counters (messages are deferred).
59 * Initialize the TRACE2 clock and do nothing else, in particular
60 * no mallocs, no system inspection, and no environment inspection.
62 * This should be called at the very top of main() to capture the
63 * process start time. This is intended to reduce chicken-n-egg
64 * bootstrap pressure.
66 * It is safe to call this more than once. This allows capturing
67 * absolute startup costs on Windows which uses a little trickery
68 * to do setup work before common-main.c:main() is called.
70 * The main trace2_initialize_fl() may be called a little later
71 * after more infrastructure is established.
73 void trace2_initialize_clock(void);
76 * Initialize TRACE2 tracing facility if any of the builtin TRACE2
77 * targets are enabled in the system config or the environment.
78 * This emits a 'version' message containing the version of git
79 * and the Trace2 protocol.
81 * This function should be called from `main()` as early as possible in
82 * the life of the process after essential process initialization.
84 * Cleanup/Termination is handled automatically by a registered
85 * atexit() routine.
87 void trace2_initialize_fl(const char *file, int line);
89 #define trace2_initialize() trace2_initialize_fl(__FILE__, __LINE__)
92 * Return 1 if trace2 is enabled (at least one target is active).
94 int trace2_is_enabled(void);
97 * Emit a 'start' event with the original (unmodified) argv.
99 void trace2_cmd_start_fl(const char *file, int line, const char **argv);
101 #define trace2_cmd_start(argv) trace2_cmd_start_fl(__FILE__, __LINE__, (argv))
104 * Emit an 'exit' event.
106 void trace2_cmd_exit_fl(const char *file, int line, int code);
108 #define trace2_cmd_exit(code) (trace2_cmd_exit_fl(__FILE__, __LINE__, (code)))
111 * Emit an 'error' event.
113 * Write an error message to the TRACE2 targets.
115 void trace2_cmd_error_va_fl(const char *file, int line, const char *fmt,
116 va_list ap);
118 #define trace2_cmd_error_va(fmt, ap) \
119 trace2_cmd_error_va_fl(__FILE__, __LINE__, (fmt), (ap))
122 * Emit a 'pathname' event with the canonical pathname of the current process
123 * This gives post-processors a simple field to identify the command without
124 * having to parse the argv. For example, to distinguish invocations from
125 * installed versus debug executables.
127 void trace2_cmd_path_fl(const char *file, int line, const char *pathname);
129 #define trace2_cmd_path(p) trace2_cmd_path_fl(__FILE__, __LINE__, (p))
132 * Emit an 'ancestry' event with the process name of the current process's
133 * parent process.
134 * This gives post-processors a way to determine what invoked the command and
135 * learn more about usage patterns.
137 void trace2_cmd_ancestry_fl(const char *file, int line, const char **parent_names);
139 #define trace2_cmd_ancestry(v) trace2_cmd_ancestry_fl(__FILE__, __LINE__, (v))
142 * Emit a 'cmd_name' event with the canonical name of the command.
143 * This gives post-processors a simple field to identify the command
144 * without having to parse the argv.
146 void trace2_cmd_name_fl(const char *file, int line, const char *name);
148 #define trace2_cmd_name(v) trace2_cmd_name_fl(__FILE__, __LINE__, (v))
151 * Emit a 'cmd_mode' event to further describe the command being run.
152 * For example, "checkout" can checkout a single file or can checkout a
153 * different branch. This gives post-processors a simple field to compare
154 * equivalent commands without having to parse the argv.
156 void trace2_cmd_mode_fl(const char *file, int line, const char *mode);
158 #define trace2_cmd_mode(sv) trace2_cmd_mode_fl(__FILE__, __LINE__, (sv))
161 * Emits an "alias" message containing the alias used and the argument
162 * expansion.
164 void trace2_cmd_alias_fl(const char *file, int line, const char *alias,
165 const char **argv);
167 #define trace2_cmd_alias(alias, argv) \
168 trace2_cmd_alias_fl(__FILE__, __LINE__, (alias), (argv))
171 * Emit one or more 'def_param' events for "important" configuration
172 * settings.
174 * Use the TR2_SYSENV_CFG_PARAM setting to register a comma-separated
175 * list of patterns configured important. For example:
176 * git config --system trace2.configParams 'core.*,remote.*.url'
177 * or:
178 * GIT_TRACE2_CONFIG_PARAMS=core.*,remote.*.url"
180 * Note: this routine does a read-only iteration on the config data
181 * (using read_early_config()), so it must not be called until enough
182 * of the process environment has been established. This includes the
183 * location of the git and worktree directories, expansion of any "-c"
184 * and "-C" command line options, and etc.
186 void trace2_cmd_list_config_fl(const char *file, int line);
188 #define trace2_cmd_list_config() trace2_cmd_list_config_fl(__FILE__, __LINE__)
191 * Emit one or more 'def_param' events for "important" environment variables.
193 * Use the TR2_SYSENV_ENV_VARS setting to register a comma-separated list of
194 * environment variables considered important. For example:
195 * git config --system trace2.envVars 'GIT_HTTP_USER_AGENT,GIT_CONFIG'
196 * or:
197 * GIT_TRACE2_ENV_VARS="GIT_HTTP_USER_AGENT,GIT_CONFIG"
199 void trace2_cmd_list_env_vars_fl(const char *file, int line);
201 #define trace2_cmd_list_env_vars() trace2_cmd_list_env_vars_fl(__FILE__, __LINE__)
204 * Emit a "def_param" event for the given config key/value pair IF
205 * we consider the key to be "important".
207 * Use this for new/updated config settings created/updated after
208 * trace2_cmd_list_config() is called.
210 void trace2_cmd_set_config_fl(const char *file, int line, const char *key,
211 const char *value);
213 #define trace2_cmd_set_config(k, v) \
214 trace2_cmd_set_config_fl(__FILE__, __LINE__, (k), (v))
217 * Emits a "child_start" message containing the "child-id",
218 * "child-argv", and "child-classification".
220 * Before calling optionally set "cmd->trace2_child_class" to a string
221 * describing the type of the child process. For example, "editor" or
222 * "pager".
224 * This function assigns a unique "child-id" to `cmd->trace2_child_id`.
225 * This field is used later during the "child_exit" message to associate
226 * it with the "child_start" message.
228 * This function should be called before spawning the child process.
230 void trace2_child_start_fl(const char *file, int line,
231 struct child_process *cmd);
233 #define trace2_child_start(cmd) trace2_child_start_fl(__FILE__, __LINE__, (cmd))
236 * Emits a "child_exit" message containing the "child-id",
237 * the child's elapsed time and exit-code.
239 * The reported elapsed time includes the process creation overhead and
240 * time spend waiting for it to exit, so it may be slightly longer than
241 * the time reported by the child itself.
243 * This function should be called after reaping the child process.
245 void trace2_child_exit_fl(const char *file, int line, struct child_process *cmd,
246 int child_exit_code);
248 #define trace2_child_exit(cmd, code) \
249 trace2_child_exit_fl(__FILE__, __LINE__, (cmd), (code))
252 * Emits a "child_ready" message containing the "child-id" and a flag
253 * indicating whether the child was considered "ready" when we
254 * released it.
256 * This function should be called after starting a daemon process in
257 * the background (and after giving it sufficient time to boot
258 * up) to indicate that we no longer control or own it.
260 * The "ready" argument should contain one of { "ready", "timeout",
261 * "error" } to indicate the state of the running daemon when we
262 * released it.
264 * If the daemon process fails to start or it exits or is terminated
265 * while we are still waiting for it, the caller should emit a
266 * regular "child_exit" to report the normal process exit information.
269 void trace2_child_ready_fl(const char *file, int line,
270 struct child_process *cmd,
271 const char *ready);
273 #define trace2_child_ready(cmd, ready) \
274 trace2_child_ready_fl(__FILE__, __LINE__, (cmd), (ready))
277 * Emit an 'exec' event prior to calling one of exec(), execv(),
278 * execvp(), and etc. On Unix-derived systems, this will be the
279 * last event emitted for the current process, unless the exec
280 * fails. On Windows, exec() behaves like 'child_start' and a
281 * waitpid(), so additional events may be emitted.
283 * Returns a unique "exec-id". This value is used later
284 * if the exec() fails and a "exec-result" message is necessary.
286 int trace2_exec_fl(const char *file, int line, const char *exe,
287 const char **argv);
289 #define trace2_exec(exe, argv) trace2_exec_fl(__FILE__, __LINE__, (exe), (argv))
292 * Emit an 'exec_result' when possible. On Unix-derived systems,
293 * this should be called after exec() returns (which only happens
294 * when there is an error starting the new process). On Windows,
295 * this should be called after the waitpid().
297 * The "exec_id" should be the value returned from trace2_exec().
299 void trace2_exec_result_fl(const char *file, int line, int exec_id, int code);
301 #define trace2_exec_result(id, code) \
302 trace2_exec_result_fl(__FILE__, __LINE__, (id), (code))
305 * Emit a 'thread_start' event. This must be called from inside the
306 * thread-proc to allow the thread to create its own thread-local
307 * storage.
309 * The thread base name should be descriptive, like "preload_index" or
310 * taken from the thread-proc function. A unique thread name will be
311 * created from the given base name and the thread id automatically.
313 void trace2_thread_start_fl(const char *file, int line,
314 const char *thread_base_name);
316 #define trace2_thread_start(thread_base_name) \
317 trace2_thread_start_fl(__FILE__, __LINE__, (thread_base_name))
320 * Emit a 'thread_exit' event. This must be called from inside the
321 * thread-proc so that the thread can access and clean up its
322 * thread-local storage.
324 void trace2_thread_exit_fl(const char *file, int line);
326 #define trace2_thread_exit() trace2_thread_exit_fl(__FILE__, __LINE__)
328 struct key_value_info;
330 * Emits a "def_param" message containing a key/value pair.
332 * This message is intended to report some global aspect of the current
333 * command, such as a configuration setting or command line switch that
334 * significantly affects program performance or behavior, such as
335 * `core.abbrev`, `status.showUntrackedFiles`, or `--no-ahead-behind`.
337 void trace2_def_param_fl(const char *file, int line, const char *param,
338 const char *value, const struct key_value_info *kvi);
340 #define trace2_def_param(param, value, kvi) \
341 trace2_def_param_fl(__FILE__, __LINE__, (param), (value), (kvi))
344 * Tell trace2 about a newly instantiated repo object and assign
345 * a trace2-repo-id to be used in subsequent activity events.
347 * Emits a 'worktree' event for this repo instance.
349 * Region and data messages may refer to this repo-id.
351 * The main/top-level repository will have repo-id value 1 (aka "r1").
353 * The repo-id field is in anticipation of future in-proc submodule
354 * repositories.
356 void trace2_def_repo_fl(const char *file, int line, struct repository *repo);
358 #define trace2_def_repo(repo) trace2_def_repo_fl(__FILE__, __LINE__, repo)
361 * Emit a 'region_enter' event for <category>.<label> with optional
362 * repo-id and printf message.
364 * This function pushes a new region nesting stack level on the current
365 * thread and starts a clock for the new stack frame.
367 * The `category` field is an arbitrary category name used to classify
368 * regions by feature area, such as "status" or "index". At this time
369 * it is only just printed along with the rest of the message. It may
370 * be used in the future to filter messages.
372 * The `label` field is an arbitrary label used to describe the activity
373 * being started, such as "read_recursive" or "do_read_index".
375 * The `repo` field, if set, will be used to get the "repo-id", so that
376 * recursive operations can be attributed to the correct repository.
378 void trace2_region_enter_fl(const char *file, int line, const char *category,
379 const char *label, const struct repository *repo, ...);
381 #define trace2_region_enter(category, label, repo) \
382 trace2_region_enter_fl(__FILE__, __LINE__, (category), (label), (repo))
384 void trace2_region_enter_printf_va_fl(const char *file, int line,
385 const char *category, const char *label,
386 const struct repository *repo,
387 const char *fmt, va_list ap);
389 #define trace2_region_enter_printf_va(category, label, repo, fmt, ap) \
390 trace2_region_enter_printf_va_fl(__FILE__, __LINE__, (category), \
391 (label), (repo), (fmt), (ap))
393 __attribute__((format (printf, 6, 7)))
394 void trace2_region_enter_printf_fl(const char *file, int line,
395 const char *category, const char *label,
396 const struct repository *repo,
397 const char *fmt, ...);
399 #define trace2_region_enter_printf(category, label, repo, ...) \
400 trace2_region_enter_printf_fl(__FILE__, __LINE__, (category), (label), \
401 (repo), __VA_ARGS__)
404 * Emit a 'region_leave' event for <category>.<label> with optional
405 * repo-id and printf message.
407 * Leave current nesting level and report the elapsed time spent
408 * in this nesting level.
410 * The `category`, `label`, and `repo` fields are the same as
411 * trace2_region_enter_fl. The `category` and `label` do not
412 * need to match the corresponding "region_enter" message,
413 * but it makes the data stream easier to understand.
415 void trace2_region_leave_fl(const char *file, int line, const char *category,
416 const char *label, const struct repository *repo, ...);
418 #define trace2_region_leave(category, label, repo) \
419 trace2_region_leave_fl(__FILE__, __LINE__, (category), (label), (repo))
421 void trace2_region_leave_printf_va_fl(const char *file, int line,
422 const char *category, const char *label,
423 const struct repository *repo,
424 const char *fmt, va_list ap);
426 #define trace2_region_leave_printf_va(category, label, repo, fmt, ap) \
427 trace2_region_leave_printf_va_fl(__FILE__, __LINE__, (category), \
428 (label), (repo), (fmt), (ap))
430 void trace2_region_leave_printf_fl(const char *file, int line,
431 const char *category, const char *label,
432 const struct repository *repo,
433 const char *fmt, ...);
435 #define trace2_region_leave_printf(category, label, repo, ...) \
436 trace2_region_leave_printf_fl(__FILE__, __LINE__, (category), (label), \
437 (repo), __VA_ARGS__)
440 * Emit a key-value pair 'data' event of the form <category>.<key> = <value>.
441 * This event implicitly contains information about thread, nesting region,
442 * and optional repo-id.
443 * This could be used to print the number of files in a directory during
444 * a multi-threaded recursive tree walk.
446 * On event-based TRACE2 targets, this generates a 'data' event suitable
447 * for post-processing. On printf-based TRACE2 targets, this is converted
448 * into a fixed-format printf message.
450 void trace2_data_string_fl(const char *file, int line, const char *category,
451 const struct repository *repo, const char *key,
452 const char *value);
454 #define trace2_data_string(category, repo, key, value) \
455 trace2_data_string_fl(__FILE__, __LINE__, (category), (repo), (key), \
456 (value))
458 void trace2_data_intmax_fl(const char *file, int line, const char *category,
459 const struct repository *repo, const char *key,
460 intmax_t value);
462 #define trace2_data_intmax(category, repo, key, value) \
463 trace2_data_intmax_fl(__FILE__, __LINE__, (category), (repo), (key), \
464 (value))
466 void trace2_data_json_fl(const char *file, int line, const char *category,
467 const struct repository *repo, const char *key,
468 const struct json_writer *jw);
470 #define trace2_data_json(category, repo, key, value) \
471 trace2_data_json_fl(__FILE__, __LINE__, (category), (repo), (key), \
472 (value))
475 * Emit a 'printf' event.
477 * Write an arbitrary formatted message to the TRACE2 targets. These
478 * text messages should be considered as human-readable strings without
479 * any formatting guidelines. Post-processors may choose to ignore
480 * them.
482 void trace2_printf_va_fl(const char *file, int line, const char *fmt,
483 va_list ap);
485 #define trace2_printf_va(fmt, ap) \
486 trace2_printf_va_fl(__FILE__, __LINE__, (fmt), (ap))
488 void trace2_printf_fl(const char *file, int line, const char *fmt, ...);
490 #define trace2_printf(...) trace2_printf_fl(__FILE__, __LINE__, __VA_ARGS__)
493 * Define the set of stopwatch timers.
495 * We can add more at any time, but they must be defined at compile
496 * time (to avoid the need to dynamically allocate and synchronize
497 * them between different threads).
499 * These must start at 0 and be contiguous (because we use them
500 * elsewhere as array indexes).
502 * Any values added to this enum must also be added to the
503 * `tr2_timer_metadata[]` in `trace2/tr2_tmr.c`.
505 enum trace2_timer_id {
507 * Define two timers for testing. See `t/helper/test-trace2.c`.
508 * These can be used for ad hoc testing, but should not be used
509 * for permanent analysis code.
511 TRACE2_TIMER_ID_TEST1 = 0, /* emits summary event only */
512 TRACE2_TIMER_ID_TEST2, /* emits summary and thread events */
514 /* Add additional timer definitions before here. */
515 TRACE2_NUMBER_OF_TIMERS
519 * Start/Stop the indicated stopwatch timer in the current thread.
521 * The time spent by the current thread between the _start and _stop
522 * calls will be added to the thread's partial sum for this timer.
524 * Timer events are emitted at thread and program exit.
526 * Note: Since the stopwatch API routines do not generate individual
527 * events, they do not take (file, line) arguments. Similarly, the
528 * category and timer name values are defined at compile-time in the
529 * timer definitions array, so they are not needed here in the API.
531 void trace2_timer_start(enum trace2_timer_id tid);
532 void trace2_timer_stop(enum trace2_timer_id tid);
535 * Define the set of global counters.
537 * We can add more at any time, but they must be defined at compile
538 * time (to avoid the need to dynamically allocate and synchronize
539 * them between different threads).
541 * These must start at 0 and be contiguous (because we use them
542 * elsewhere as array indexes).
544 * Any values added to this enum be also be added to the
545 * `tr2_counter_metadata[]` in `trace2/tr2_ctr.c`.
547 enum trace2_counter_id {
549 * Define two counters for testing. See `t/helper/test-trace2.c`.
550 * These can be used for ad hoc testing, but should not be used
551 * for permanent analysis code.
553 TRACE2_COUNTER_ID_TEST1 = 0, /* emits summary event only */
554 TRACE2_COUNTER_ID_TEST2, /* emits summary and thread events */
556 TRACE2_COUNTER_ID_PACKED_REFS_JUMPS, /* counts number of jumps */
557 TRACE2_COUNTER_ID_REFTABLE_RESEEKS, /* counts number of re-seeks */
559 /* counts number of fsyncs */
560 TRACE2_COUNTER_ID_FSYNC_WRITEOUT_ONLY,
561 TRACE2_COUNTER_ID_FSYNC_HARDWARE_FLUSH,
563 /* Add additional counter definitions before here. */
564 TRACE2_NUMBER_OF_COUNTERS
568 * Increase the named global counter by value.
570 * Note that this adds `value` to the current thread's partial sum for
571 * this counter (without locking) and that the complete sum is not
572 * available until all threads have exited, so it does not return the
573 * new value of the counter.
575 void trace2_counter_add(enum trace2_counter_id cid, uint64_t value);
578 * Optional platform-specific code to dump information about the
579 * current and any parent process(es). This is intended to allow
580 * post-processors to know who spawned this git instance and anything
581 * else that the platform may be able to tell us about the current process.
584 enum trace2_process_info_reason {
585 TRACE2_PROCESS_INFO_STARTUP,
586 TRACE2_PROCESS_INFO_EXIT,
589 void trace2_collect_process_info(enum trace2_process_info_reason reason);
591 const char *trace2_session_id(void);
593 #endif /* TRACE2_H */