Python cProfile 结果：ncalls 的两个数字答案

【问题标题】：Python cProfile results: two numbers for ncallsPython cProfile 结果：ncalls 的两个数字
【发布时间】：2014-05-25 23:40:31
【问题描述】：

我最近才开始分析我一直在研究的服务器应用程序，试图找出一些多余的处理器时间被花在了哪里，并寻找使事情变得更顺畅的方法。

总的来说，我认为我已经很好地使用了 cProfile 和 pstats，但我不明白某些函数如何在 ncalls 列中列出两个数字。

例如，在下面的结果中，为什么所有 copy.deepcopy 的东西都列出了两个数字？

         2892482 function calls (2476782 primitive calls) in 5.952 seconds

   Ordered by: cumulative time

   ncalls  tottime  percall  cumtime  percall filename:lineno(function)
       27    0.015    0.001    5.229    0.194 /usr/local/lib/python2.7/twisted/internet/base.py:762(runUntilCurrent)
        7    0.000    0.000    3.109    0.444 /usr/local/lib/python2.7/twisted/internet/task.py:201(__call__)
        7    0.000    0.000    3.109    0.444 /usr/local/lib/python2.7/twisted/internet/defer.py:113(maybeDeferred)
        5    0.000    0.000    2.885    0.577 defs/1sec.def:3690(onesec)
        5    2.100    0.420    2.885    0.577 defs/1sec.def:87(loop)
     1523    0.579    0.000    2.105    0.001 defs/cactions.def:2(cActions)
384463/1724    0.474    0.000    1.039    0.001 /usr/local/lib/python2.7/copy.py:145(deepcopy)
33208/1804    0.147    0.000    1.018    0.001 /usr/local/lib/python2.7/copy.py:226(_deepcopy_list)
17328/15780    0.105    0.000    0.959    0.000 /usr/local/lib/python2.7/copy.py:253(_deepcopy_dict)

【问题讨论】：

标签： python cprofile

【解决方案1】：

较小的数字是“原始”或非递归调用的数量。较大的数字是调用的总数，包括递归调用。由于 deepcopy 是递归实现的，这意味着您直接调用 deepcopy 1724 次，但它最终调用自身约 383k 次来复制子对象。

【讨论】：

谢谢。这与我在docs.python.org/2/library/profile.html#instant-user-s-manual 找到的内容相符……当您提出问题然后在几分钟后通过进一步挖掘找到答案时，那令人沮丧的时刻。我无法回复我自己的帖子，因为我之前从未在此网站上发过帖子，并且代表人数不足 10 人。