# `profiling.tracing` --- 确定型性能分析器

Added in version 3.15.

源代码: Lib/profiling/tracing/

The `profiling.tracing` module provides deterministic profiling of Python programs. It monitors every function call, function return, and exception event, recording precise timing for each. This approach provides exact call counts and complete visibility into program execution, making it ideal for development and testing scenarios.

备注

This module is also available as `cProfile` for backward compatibility. The `cProfile` name will continue to work in all future Python versions. Use whichever import style suits your codebase:

    # Preferred (new style)
    import profiling.tracing
    profiling.tracing.run('my_function()')

    # Also works (backward compatible)
    import cProfile
    cProfile.run('my_function()')

## What is deterministic profiling?

Deterministic profiling captures every function call, function return, and exception event during program execution. The profiler measures the precise time intervals between these events, providing exact statistics about how the program behaves.

In contrast to statistical profiling, which samples the call stack periodically to estimate where time is spent, deterministic profiling records every event. This means you get exact call counts rather than statistical approximations. The trade-off is that instrumenting every event introduces overhead that can slow down program execution.

Python's interpreted nature makes deterministic profiling practical. The interpreter already dispatches events for function calls and returns, so the profiler can hook into this mechanism without requiring code modification. The overhead tends to be moderate relative to the inherent cost of interpretation, making deterministic profiling suitable for most development workflows.

Deterministic profiling helps answer questions like:

- How many times was this function called?

- What is the complete call graph of my program?

- Which functions are called by a particular function?

- Are there unexpected function calls happening?

Call count statistics can identify bugs (surprising counts) and inline expansion opportunities (high call counts). Internal time statistics reveal "hot loops" that warrant optimization. Cumulative time statistics help identify algorithmic inefficiencies. The handling of cumulative times in this profiler allows direct comparison of recursive and iterative implementations.

## 命令行接口

`profiling.tracing` 模块可以作为脚本被唤起以分析另一个脚本或模块：

    python -m profiling.tracing [-o output_file] [-s sort_order] (-m module | script.py)

这将在性能分析器中运行指定的脚本或模块并将结果打印到标准输出（或将其保存到文件）。

-o <output_file>

  将性能分析结果写入文件而不是标准输出。 输出文件可由 `pstats` 模块读取供后续分析。

-s <sort_order>

  Sort the output by the specified key. This accepts any of the sort keys recognized by `pstats.Stats.sort_stats()`, such as `cumulative`, `time`, `calls`, or `name`. This option only applies when `-o` is not specified.

-m <module>

  Profile a module instead of a script. The module is located using the standard import mechanism.

  Added in version 3.7: The `-m` option for `cProfile`.

  Added in version 3.8: The `-m` option for `profile`.

## Programmatic usage examples

For more control over profiling, use the module's functions and classes directly.

### Basic profiling

The simplest approach uses the `run()` function:

    import profiling.tracing
    profiling.tracing.run('my_function()')

This profiles the given code string and prints a summary to standard output. To save results for later analysis:

    profiling.tracing.run('my_function()', 'output.prof')

### 使用 `Profile` 类

`Profile` 类提供了细粒度的控制:

    import profiling.tracing
    import pstats
    from io import StringIO

    pr = profiling.tracing.Profile()
    pr.enable()
    # ... 要分析的代码 ...
    pr.disable()

    # 打印结果
    s = StringIO()
    ps = pstats.Stats(pr, stream=s).sort_stats(pstats.SortKey.CUMULATIVE)
    ps.print_stats()
    print(s.getvalue())

`Profile` 类还可作为上下文管理器:

    import profiling.tracing

    with profiling.tracing.Profile() as pr:
        # ... 要分析的代码 ...

    pr.print_stats()

## 模块参考

profiling.tracing.run(command, filename=None, sort=-1)

  执行一条命令分析性能并打印或保存结果。

  此函数会在 `__main__` 模块的命名空间中使用 `exec()` 执行 command 字符串:

      exec(command, __main__.__dict__, __main__.__dict__)

  If filename is not provided, the function creates a `pstats.Stats` instance and prints a summary to standard output. If filename is provided, the raw profile data is saved to that file for later analysis with `pstats`.

  The sort argument specifies the sort order for printed output, accepting any value recognized by `pstats.Stats.sort_stats()`.

profiling.tracing.runctx(command, globals, locals, filename=None, sort=-1)

  Profile execution of a command with explicit namespaces.

  Like `run()`, but executes the command with the specified globals and locals mappings instead of using the `__main__` module's namespace:

      exec(command, globals, locals)

class profiling.tracing.Profile(timer=None, timeunit=0.0, subcalls=True, builtins=True)

  负责收集执行统计信息的性能分析对象。

  The optional timer argument specifies a custom timing function. If not provided, the profiler uses a platform-appropriate default timer. When supplying a custom timer, it must return a single number representing the current time. If the timer returns integers, use timeunit to specify the duration of one time unit (for example, `0.001` for milliseconds).

  The subcalls argument controls whether the profiler tracks call relationships between functions. The builtins argument controls whether built-in functions are profiled.

  在 3.8 版本发生变更: 添加了上下文管理器支持。

  enable()

    开始收集性能分析数据。

  disable()

    Stop collecting profiling data.

  create_stats()

    Stop collecting data and record the results internally as the current profile.

  print_stats(sort=-1)

    Create a `pstats.Stats` object from the current profile and print the results to standard output.

    The sort argument specifies the sorting order. It accepts a single key or a tuple of keys for multi-level sorting, using the same values as `pstats.Stats.sort_stats()`.

    Added in version 3.13: Support for a tuple of sort keys.

  dump_stats(filename)

    Write the current profile data to filename. The file can be read by `pstats.Stats` for later analysis.

  run(cmd)

    Profile the command string via `exec()`.

  runctx(cmd, globals, locals)

    Profile the command string via `exec()` with the specified namespaces.

  runcall(func, /, *args, **kwargs)

    Profile a function call. Returns whatever func returns:

        result = pr.runcall(my_function, arg1, arg2, keyword=value)

备注

Profiling requires that the profiled code returns normally. If the interpreter terminates (for example, via `sys.exit()`) during profiling, no results will be available.

## 使用自定义计时器

The `Profile` class accepts a custom timing function, allowing you to measure different aspects of execution such as wall-clock time or CPU time. Pass the timing function to the constructor:

    pr = profiling.tracing.Profile(my_timer_function)

The timer function must return a single number representing the current time. If it returns integers, also specify timeunit to indicate the duration of one unit:

    # Timer returns time in milliseconds
    pr = profiling.tracing.Profile(my_ms_timer, 0.001)

For best performance, the timer function should be as fast as possible. The profiler calls it frequently, so timer overhead directly affects profiling overhead.

The `time` module provides several functions suitable for use as custom timers:

- `time.perf_counter()` for high-resolution wall-clock time

- `time.process_time()` for CPU time (excluding sleep)

- `time.monotonic()` for monotonic clock time

## 局限性

Deterministic profiling has inherent limitations related to timing accuracy.

The underlying timer typically has a resolution of about one millisecond. Measurements cannot be more accurate than this resolution. With enough measurements, timing errors tend to average out, but individual measurements may be imprecise.

There is also latency between when an event occurs and when the profiler captures the timestamp. Similarly, there is latency after reading the timestamp before user code resumes. Functions called frequently accumulate this latency, which can make them appear slower than they actually are. This error is typically less than one clock tick per call but can become significant for functions called many times.

The `profiling.tracing` module (and its `cProfile` alias) is implemented as a C extension with low overhead, so these timing issues are less pronounced than with the deprecated pure Python `profile` module.

参见

`profiling`

  Overview of Python profiling tools and guidance on choosing a profiler.

`profiling.sampling`

  Statistical sampling profiler for production use.

`pstats`

  Statistics analysis and formatting for profile data.

`profile`

  Deprecated pure Python profiler (includes calibration documentation).