Profiler示例(GNU Octave(版本9.1.0))

13.7性能剖析器示例¶

下面,我们将给出一个探查器会话的简短示例。详见分析,用于探查器函数indetail的文档。考虑代码:

全球N A;N=300;A=兰特(N,N);函数xt=时间步长(步长,x0,expM)全局N;如果(步骤==0)xt=NA(N,0);否则xt=NA(N,步长);x1=expM*x0;xt(:,1)=x1;xt(:,2:end)=时间步长(步长-1,x1,expM);endifendfunction函数foo()全局N A;初始=@(x)sin(x);x0=(初始(林空间(0,2*pi,N))';expA=expm(A);xt=时间步长(100,x0,expA);如果(N＜=2)fib=1,则endfunctionfunction fib=bar(N);否则fib=巴(N-1)+巴(N-2);endifend函数

如果我们执行两个主要函数,我们得到:

抽搐;foo;toc;⇒ 经过时间为2.37338秒;条(20);toc;⇒ 运行时间为2.04952秒。

但这并没有提供太多关于这段时间花在这里的的信息;例如,是否对的单个调用矩阵指数函数比递归时间步进本身更昂贵。为了获得更详细的图片,我们可以使用探查器。

简介;foo;剖面关闭;data=配置文件(“信息”);profshow(数据,10);

这将打印一张表格,如下所示:

#函数属性时间调用---------------------------------------------7 expm 1.034 1 3 binary*0.823 117 41 binary \0.188 1 38 binary ^0.126 2 43时间步长R 0.111 101 44 NA 0.029 101 39 binary+0.024 8 34 norm 0.011 1 40 binary-0.004 101 33 balance 0.003 1

条目是已经执行的单个函数(只有10个最重要的函数),以及每个函数的一些信息。条目类似于二进制的表示运算符,而其他条目是普通函数。它们包括两个内置组件,如矩阵指数函数以及我们自己的日常生活(例如时间步length). 从这个侧面,我们可以立即推断出矩阵指数函数占用了最大比例的处理时间,即使它只是调用。第二个代价高昂的运算是子程序中的矩阵向量积时间步length. ⁶

然而,时间并不是个人资料中唯一可用的信息。属性列向我们显示时间步length递归地调用它自己。这在这个例子中可能并不显著(因为无论如何都很清楚),但在更复杂的环境中可能会有所帮助。至于为什么会有一个二进制的在输出中,我们也可以很容易地阐明这一点。请注意data是一个结构体数组(结构体数组)其中包含字段函数表。这存储了所示配置文件的原始数据。表第一列中的数字给出了索引,在该索引下可以找到所示的函数。正在查找数据函数表(41)给予:

包含字段的标量结构体:FunctionName=binary \ TotalTime=0.18765 NumCalls=1 IsRecursive=0 Parents=7 Children=[](1x0)

在这里,我们再次看到表中的信息,但有其他字段父级对象和儿童这两个数组都包含已直接调用所讨论函数的函数的索引(其为条目7,矩阵指数函数,在这种情况下)或被它调用(没有函数)。因此,反斜杠运算符已从内部使用矩阵指数函数.

现在让我们来看看bar。为此,我们启动一个刷新配置文件会话(上的配置文件这样做;在重新启动探查器之前删除旧数据):

简介;条(20);剖面关闭;profshow(个人资料(“信息”));

这提供了:

#函数属性时间调用------------------------------------------------------1 bar R 2.091 13529 2 binary<=0.062 13529 3 binary-0.042 13528 4 binary+0.023 6764 5 profile 0.000 1 8 false 0.000 1 6 nargin 0.000 1 7 binary！=0.000 1 9 __profiler_enable__0.000 1

不出所料,bar也是递归的。在以最佳方式递归计算斐波那契数的过程中,它被调用了13529次,大部分时间都花在bar它本身

最后,假设我们想评测两者的执行情况foo和bar在一起从于我们已经为收集了运行时数据bar,我们可以在不清除现有数据的情况下重新启动探查器,并收集有关的丢失统计信息foo。这是通过以下方式完成的:

档案简历;foo;剖面关闭;profshow(个人资料(“信息”),10);

正如您在下表中看到的,现在我们将两个配置文件混合在一起。

#函数属性时间调用---------------------------------------------1 bar R 2.091 13529 16 expm 1.122 1 12 binary*0.798 117 46 binary \0.185 1 45 binary ^0.124 2 48时间步长R 0.115 101 2 binary<=0.062 13529 3 binary-0.045 13629 4 binary+0.41 6772 49 NA 0.036 101

脚注

6.

我们只知道它是二进制乘法运算符,但幸运的是,这个运算符只出现在代码中的一个位置,因此我们知道哪种情况需要很长时间。如果有多个位置,我们将不得不使用层次结构体配置文件来找出占用时间的确切位置,这在本例中没有涵盖。