【Caffe】计时功能

Caffe 计时功能

编译好的Caffe可以通过运行caffe time命令，对当前平台上网络各层前向后向计算进行计时：

./build/tools/caffe.bin time -model examples/mnist/lenet_train_test.prototxt

命令行输出

I1209 23:44:11.358758  4576 caffe.cpp:347] Use CPU.
I1209 23:44:11.368690  4576 net.cpp:322] The NetState phase (0) differed from the phase (1) specified by a rule in layer mnist
I1209 23:44:11.368777  4576 net.cpp:322] The NetState phase (0) differed from the phase (1) specified by a rule in layer accuracy
I1209 23:44:11.369525  4576 net.cpp:58] Initializing net from parameters: 
name: "LeNet"
……
I1209 23:44:11.469251  4576 caffe.cpp:369] *** Benchmark begins ***
I1209 23:44:11.469281  4576 caffe.cpp:370] Testing for 50 iterations.
I1209 23:44:11.525790  4576 caffe.cpp:398] Iteration: 1 forward-backward time: 56 ms.
I1209 23:44:11.581557  4576 caffe.cpp:398] Iteration: 2 forward-backward time: 55 ms.
I1209 23:44:11.638115  4576 caffe.cpp:398] Iteration: 3 forward-backward time: 56 ms.
I1209 23:44:11.693204  4576 caffe.cpp:398] Iteration: 4 forward-backward time: 55 ms.
I1209 23:44:11.749596  4576 caffe.cpp:398] Iteration: 5 forward-backward time: 56 ms.
I1209 23:44:11.805759  4576 caffe.cpp:398] Iteration: 6 forward-backward time: 56 ms.
I1209 23:44:11.861937  4576 caffe.cpp:398] Iteration: 7 forward-backward time: 56 ms.
I1209 23:44:11.918020  4576 caffe.cpp:398] Iteration: 8 forward-backward time: 56 ms.
I1209 23:44:11.974223  4576 caffe.cpp:398] Iteration: 9 forward-backward time: 56 ms.
I1209 23:44:12.029626  4576 caffe.cpp:398] Iteration: 10 forward-backward time: 55 ms.
I1209 23:44:12.084966  4576 caffe.cpp:398] Iteration: 11 forward-backward time: 55 ms.
I1209 23:44:12.141054  4576 caffe.cpp:398] Iteration: 12 forward-backward time: 56 ms.
I1209 23:44:12.197083  4576 caffe.cpp:398] Iteration: 13 forward-backward time: 55 ms.
I1209 23:44:12.253545  4576 caffe.cpp:398] Iteration: 14 forward-backward time: 56 ms.
I1209 23:44:12.309272  4576 caffe.cpp:398] Iteration: 15 forward-backward time: 55 ms.
I1209 23:44:12.365005  4576 caffe.cpp:398] Iteration: 16 forward-backward time: 55 ms.
I1209 23:44:12.421028  4576 caffe.cpp:398] Iteration: 17 forward-backward time: 55 ms.
I1209 23:44:12.476764  4576 caffe.cpp:398] Iteration: 18 forward-backward time: 55 ms.
I1209 23:44:12.533208  4576 caffe.cpp:398] Iteration: 19 forward-backward time: 56 ms.
I1209 23:44:12.588999  4576 caffe.cpp:398] Iteration: 20 forward-backward time: 55 ms.
I1209 23:44:12.644711  4576 caffe.cpp:398] Iteration: 21 forward-backward time: 55 ms.
I1209 23:44:12.700495  4576 caffe.cpp:398] Iteration: 22 forward-backward time: 55 ms.
I1209 23:44:12.756886  4576 caffe.cpp:398] Iteration: 23 forward-backward time: 56 ms.
I1209 23:44:12.812835  4576 caffe.cpp:398] Iteration: 24 forward-backward time: 55 ms.
I1209 23:44:12.868307  4576 caffe.cpp:398] Iteration: 25 forward-backward time: 55 ms.
I1209 23:44:12.923676  4576 caffe.cpp:398] Iteration: 26 forward-backward time: 55 ms.
I1209 23:44:12.979461  4576 caffe.cpp:398] Iteration: 27 forward-backward time: 55 ms.
I1209 23:44:13.034879  4576 caffe.cpp:398] Iteration: 28 forward-backward time: 55 ms.
I1209 23:44:13.090430  4576 caffe.cpp:398] Iteration: 29 forward-backward time: 55 ms.
I1209 23:44:13.146570  4576 caffe.cpp:398] Iteration: 30 forward-backward time: 56 ms.
I1209 23:44:13.202101  4576 caffe.cpp:398] Iteration: 31 forward-backward time: 55 ms.
……
I1209 23:44:13.934849  4576 caffe.cpp:398] Iteration: 44 forward-backward time: 55 ms.
I1209 23:44:13.991219  4576 caffe.cpp:398] Iteration: 45 forward-backward time: 56 ms.
I1209 23:44:14.046798  4576 caffe.cpp:398] Iteration: 46 forward-backward time: 55 ms.
I1209 23:44:14.103252  4576 caffe.cpp:398] Iteration: 47 forward-backward time: 56 ms.
I1209 23:44:14.158833  4576 caffe.cpp:398] Iteration: 48 forward-backward time: 55 ms.
I1209 23:44:14.214740  4576 caffe.cpp:398] Iteration: 49 forward-backward time: 55 ms.
I1209 23:44:14.270826  4576 caffe.cpp:398] Iteration: 50 forward-backward time: 56 ms.
I1209 23:44:14.270865  4576 caffe.cpp:401] Average time per layer: 
I1209 23:44:14.270869  4576 caffe.cpp:404]      mnist   forward: 0.03342 ms.
I1209 23:44:14.270905  4576 caffe.cpp:407]      mnist   backward: 0.00064 ms.
I1209 23:44:14.270910  4576 caffe.cpp:404]      conv1   forward: 5.98672 ms.
I1209 23:44:14.270915  4576 caffe.cpp:407]      conv1   backward: 6.3359 ms.
I1209 23:44:14.270916  4576 caffe.cpp:404]      pool1   forward: 2.99406 ms.
I1209 23:44:14.270920  4576 caffe.cpp:407]      pool1   backward: 1.56492 ms.
I1209 23:44:14.270921  4576 caffe.cpp:404]      conv2   forward: 10.2996 ms.
I1209 23:44:14.270925  4576 caffe.cpp:407]      conv2   backward: 19.924 ms.
I1209 23:44:14.270928  4576 caffe.cpp:404]      pool2   forward: 1.55468 ms.
I1209 23:44:14.270931  4576 caffe.cpp:407]      pool2   backward: 0.88818 ms.
I1209 23:44:14.270932  4576 caffe.cpp:404]        ip1   forward: 2.0615 ms.
I1209 23:44:14.270936  4576 caffe.cpp:407]        ip1   backward: 3.96228 ms.
I1209 23:44:14.270938  4576 caffe.cpp:404]      relu1   forward: 0.02668 ms.
I1209 23:44:14.270941  4576 caffe.cpp:407]      relu1   backward: 0.02438 ms.
I1209 23:44:14.270943  4576 caffe.cpp:404]        ip2   forward: 0.119 ms.
I1209 23:44:14.270946  4576 caffe.cpp:407]        ip2   backward: 0.1537 ms.
I1209 23:44:14.270949  4576 caffe.cpp:404]       loss   forward: 0.03528 ms.
I1209 23:44:14.270951  4576 caffe.cpp:407]       loss   backward: 0.0016 ms.
I1209 23:44:14.270956  4576 caffe.cpp:412] Average Forward pass: 23.1205 ms.
I1209 23:44:14.270967  4576 caffe.cpp:414] Average Backward pass: 32.8634 ms.
I1209 23:44:14.270972  4576 caffe.cpp:416] Average Forward-Backward: 56.02 ms.
I1209 23:44:14.270974  4576 caffe.cpp:418] Total Time: 2801 ms.