cProfile 输出上的 tottime 和 cumtime 有什么区别？

Question

我正在使用 cProfile 和以下命令分析一个 python 脚本main.py：

python -m cProfile -s tottime main.py

我得到的输出是（仅复制粘贴输出的顶行）：

10184337 function calls (10181667 primitive calls) in 13.597 seconds

Ordered by: internal time

ncalls  tottime  percall  cumtime  percall filename:lineno(function)
    1    4.674    4.674   13.598   13.598 main.py:2(<module>)
 2142    2.964    0.001    4.663    0.002 load_aerdat3.py:61(getPacket)
  459    2.381    0.005    2.381    0.005 {waitKey}
1667989    1.170    0.000    1.170    0.000 {numpy.core.multiarray.array}

...

tottime (4.674) 与 cumtime (13.598) 的 main.py 有何不同，因为这个函数（即整个脚本）只调用一次？

Answer 1

tottime 是仅在函数中花费的总时间。 cumtime 是函数花费的总时间加上这个函数调用的所有函数。

如果一个函数从不调用其他任何东西，这两个值将是相同的。例如，{waitKey} 似乎没有调用其他任何东西：

  459    2.381    0.005    2.381    0.005 {waitKey}

但是getPacket() 调用了其他函数，所以它的cumtime 列包含了这些调用的时间：

 2142    2.964    0.001    4.663    0.002 load_aerdat3.py:61(getPacket)

main.py 行涵盖了在函数之外运行的所有代码，即全局代码；只是该级别的语句运行时间为 4.674 秒，但由于这些语句调用了其他函数，所以 main.py 代码的总累积时间加上所有函数调用为 13.598 秒。

来自documentation：

tottime
在给定函数中花费的总时间（不包括调用子函数的时间）

[...]

业余时间
是在这个和所有子函数中花费的累积时间（从调用到退出）。这个数字即使对于递归函数也是准确的。