Too slow unit test #5342

wangkuiyi · 2017-11-03T03:26:43Z

 72/252 Test  #72: test_CompareTwoNets .........................   Passed   80.78 sec

The text was updated successfully, but these errors were encountered:

chengduoZH · 2017-11-10T06:34:42Z

The time consumed by all single measurements is as follows：

parameter_optimizer_test ....................        0.01 sec
cudnn_helper_test ...........................        0.40 sec
op_proto_maker_test .........................        0.40 sec
prune_test ..................................        0.40 sec
scope_test ..................................        0.40 sec
stringprintf_test ...........................        0.40 sec
test_config_parser ..........................        0.40 sec
var_type_inference_test .....................        0.40 sec
enforce_test ................................        0.41 sec
op_registry_test ............................        0.41 sec
scatter_test ................................        0.41 sec
test_reset_hook .............................        0.41 sec
cpu_info_test ...............................        0.46 sec
save_load_op_test ...........................        0.47 sec
dim_test ....................................        0.50 sec
stringpiece_test ............................        0.50 sec
to_string_test ..............................        0.50 sec
place_test ..................................        0.51 sec
nccl_test ...................................        0.56 sec
math_function_test ..........................        0.58 sec
backward_test ...............................        0.60 sec
ddim_test ...................................        0.60 sec
net_op_test .................................        0.60 sec
operator_test ...............................        0.60 sec
program_desc_test ...........................        0.60 sec
serialization_test ..........................        0.61 sec
testArguments ...............................        0.63 sec
nccl_op_test ................................        0.67 sec
eigen_test ..................................        0.70 sec
lod_tensor_test .............................        0.70 sec
variable_test ...............................        0.70 sec
gather_test .................................        0.71 sec
layers_test .................................        0.72 sec
selected_rows_functor_test ..................        0.83 sec
test_auc_op .................................        0.92 sec
test_rnn_memory_helper_op ...................        0.92 sec
test_image_classification_layer .............        0.96 sec
network_helper_test .........................        1.01 sec
test_program ................................        1.01 sec
test_variable ...............................        1.04 sec
testVector ..................................        1.05 sec
test_infer_shape ............................        1.11 sec
test_seq_concat_op ..........................        1.11 sec
selected_rows_test ..........................        1.12 sec
test_dynamic_recurrent_op ...................        1.12 sec
test_scope ..................................        1.14 sec
test_inference_model_io .....................        1.16 sec
memory_test .................................        1.20 sec
test_regularizer ............................        1.20 sec
dynamic_recurrent_op_test ...................        1.21 sec
test_layers .................................        1.21 sec
test_op_support_gpu .........................        1.22 sec
test_protobuf_descs .........................        1.22 sec
test_positive_negative_pair_op ..............        1.25 sec
test_lod_rank_table .........................        1.26 sec
test_framework_debug_str ....................        1.27 sec
system_allocator_test .......................        1.30 sec
test_exception ..............................        1.30 sec
tensor_array_test ...........................        1.31 sec
testMatrix ..................................        1.31 sec
test_Trainer ................................        1.31 sec
test_cond_op ................................        1.31 sec
test_lod_tensor_array_ops ...................        1.31 sec
test_image ..................................        1.32 sec
test_topology ...............................        1.32 sec
test_executor_and_mul .......................        1.37 sec
test_net ....................................        1.37 sec
test_parameters .............................        1.37 sec
test_rnn_layer ..............................        1.37 sec
creator_test ................................        1.40 sec
test_data_feeder ............................        1.40 sec
test_optimizer ..............................        1.43 sec
test_lod_tensor_array .......................        1.46 sec
lod_tensor_gpu_test .........................        1.50 sec
test_lrn_op .................................        1.50 sec
test_modified_huber_loss_op .................        1.52 sec
test_op .....................................        1.52 sec
test_operator_desc ..........................        1.52 sec
test_default_scope_funcs ....................        1.53 sec
test_precision_recall_op ....................        1.56 sec
test_operator ...............................        1.60 sec
test_nccl_init_op ...........................        1.64 sec
test_parameter ..............................        1.64 sec
test_tensor .................................        1.72 sec
test_accuracy_op ............................        1.73 sec
test_crf_decoding_op ........................        1.75 sec
FunctionTest ................................        1.81 sec
testGradientMachine .........................        1.83 sec
test_sigmoid_cross_entropy_with_logits_op ...        1.91 sec
test_layer ..................................        1.92 sec
transform_test ..............................        1.96 sec
test_feed_fetch_method ......................        2.01 sec
test_selected_rows ..........................        2.02 sec
test_initializer ............................        2.03 sec
test_array_read_write_op ....................        2.06 sec
test_PyDataProviderWrapper ..................        2.11 sec
test_lstm_unit_op ...........................        2.13 sec
strided_memcpy_test .........................        2.15 sec
test_gru_unit_op ............................        2.21 sec
test_ploter .................................        2.21 sec
test_protobuf ...............................        2.21 sec
test_recurrent_op ...........................        2.22 sec
test_tensor_array ...........................        2.22 sec
test_squared_l2_norm_op .....................        2.27 sec
selected_rows_functor_gpu_test ..............        2.31 sec
TensorTypeTest ..............................        2.32 sec
pserver_test ................................        2.32 sec
test_evaluator ..............................        2.42 sec
test_CompareTwoOpts .........................        2.61 sec
test_Thread .................................        2.62 sec
test_compare_op .............................        2.62 sec
test_recognize_digits_mlp ...................        2.69 sec
math_function_gpu_test ......................        2.70 sec
BufferArgTest ...............................        2.72 sec
test_softmax_op .............................        2.73 sec
test_cast_op ................................        2.76 sec
device_context_test .........................        2.81 sec
test_prelu_op ...............................        2.81 sec
test_Compare ................................        2.83 sec
test_sgd_op .................................        2.83 sec
testTrain ...................................        2.84 sec
test_proximal_adagrad_op ....................        2.87 sec
test_scatter_op .............................        2.93 sec
test_linear_chain_crf_op ....................        2.94 sec
test_fill_constant_batch_size_like_op .......        2.95 sec
decorator_test ..............................        3.01 sec
test_ThreadBarrier ..........................        3.01 sec
test_scale_op ...............................        3.02 sec
test_fill_zeros_like_op .....................        3.05 sec
test_proximal_gd_op .........................        3.10 sec
BlockExpandOpTest ...........................        3.11 sec
test_huber_loss_op ..........................        3.11 sec
TensorShapeTest .............................        3.12 sec
test_increment_op ...........................        3.12 sec
test_Expand .................................        3.14 sec
test_sequence_softmax_op ....................        3.14 sec
test_l1_norm_op .............................        3.17 sec
MulOpTest ...................................        3.21 sec
test_multiplex_op ...........................        3.21 sec
test_clip_op ................................        3.22 sec
test_common .................................        3.23 sec
test_pad_op .................................        3.25 sec
test_recurrent_machine_generation ...........        3.32 sec
test_split_op ...............................        3.33 sec
test_lookup_table_op ........................        3.39 sec
tensor_test .................................        3.41 sec
test_argument ...............................        3.42 sec
test_mean_op ................................        3.44 sec
test_conv_shift_op ..........................        3.46 sec
test_adadelta_op ............................        3.49 sec
vol2col_test ................................        3.51 sec
test_adam_op ................................        3.54 sec
im2col_test .................................        3.61 sec
test_word2vec ...............................        3.64 sec
CosSimOpTest ................................        3.71 sec
test_SeqSliceLayerGrad ......................        3.74 sec
test_batch_norm_op ..........................        3.74 sec
test_KmaxSeqScore ...........................        3.75 sec
test_uniform_random_op ......................        3.77 sec
test_sum_op .................................        3.78 sec
CrossMapNormalOpTest ........................        3.83 sec
test_rmsprop_op .............................        3.87 sec
test_elementwise_mul_op .....................        3.90 sec
test_ConvUnify ..............................        3.92 sec
test_ActivationGrad .........................        3.93 sec
test_WarpCTCLayer ...........................        3.93 sec
test_SpinLock ...............................        3.95 sec
test_BatchNorm ..............................        4.02 sec
test_StringUtils ............................        4.03 sec
SwitchOpTest ................................        4.12 sec
test_sign_op ................................        4.13 sec
test_softmax_with_cross_entropy_op ..........        4.15 sec
test_SparseMatrix ...........................        4.21 sec
test_fit_a_line .............................        4.24 sec
test_smooth_l1_loss_op ......................        4.24 sec
test_SIMDFlags ..............................        4.35 sec
test_gaussian_random_op .....................        4.35 sec
test_decayed_adagrad_op .....................        4.36 sec
test_SIMDFunctions ..........................        4.41 sec
test_momentum_op ............................        4.41 sec
test_top_k_op ...............................        4.43 sec
test_rank_loss_op ...........................        4.51 sec
test_CrossEntropyOverBeamGrad ...............        4.52 sec
test_RowBuffer ..............................        4.61 sec
test_CustomStackTracePrint ..................        4.65 sec
test_LinearChainCRF .........................        4.65 sec
test_elementwise_sub_op .....................        4.66 sec
test_seq_expand .............................        4.69 sec
test_gather_op ..............................        4.70 sec
test_ExecViaCpu .............................        4.74 sec
test_PyDataProvider .........................        4.74 sec
test_conv2d_transpose_op ....................        4.77 sec
test_PriorBox ...............................        4.78 sec
test_transpose_op ...........................        4.81 sec
test_Error ..................................        4.85 sec
test_DetectionOutput ........................        4.88 sec
test_concat_op ..............................        4.91 sec
test_adagrad_op .............................        4.96 sec
test_pool2d_op ..............................        5.03 sec
test_reshape_op .............................        5.05 sec
test_reduce_op ..............................        5.06 sec
CropOpTest ..................................        5.14 sec
test_fill_constant_op .......................        5.15 sec
test_minus_op ...............................        5.15 sec
test_squared_l2_distance_op .................        5.15 sec
test_adamax_op ..............................        5.21 sec
test_paramconf_order ........................        5.23 sec
test_margin_rank_loss_op ....................        5.29 sec
GemmConvOpTest ..............................        5.44 sec
test_MultinomialSampler .....................        5.44 sec
test_Evaluator ..............................        5.50 sec
test_CRFLayerGrad ...........................        5.52 sec
test_pool_max_op ............................        5.55 sec
test_NetworkCompare .........................        5.69 sec
test_CpuGpuVector ...........................        5.73 sec
test_GpuProfiler ............................        5.78 sec
test_gru_op .................................        5.82 sec
test_conv3d_transpose_op ....................        5.88 sec
test_activation_op ..........................        5.91 sec
test_elementwise_add_op .....................        6.10 sec
test_cross_entropy_op .......................        6.12 sec
test_crop_op ................................        6.40 sec
test_matmul_op ..............................        6.42 sec
test_pool3d_op ..............................        6.53 sec
test_cos_sim_op .............................        6.63 sec
test_perturbation ...........................        6.63 sec
test_elementwise_div_op .....................        6.94 sec
test_FPException ............................        7.07 sec
RowConvOpTest ...............................        7.52 sec
testTrainer .................................        7.69 sec
test_Allocator ..............................        7.98 sec
PadOpTest ...................................        8.43 sec
pserver_client_test .........................        8.75 sec
test_dropout_op .............................        8.80 sec
ContextProjectionOpTest .....................        8.83 sec
test_MKLDNN .................................        8.88 sec
socket_test .................................        9.17 sec
test_RecurrentGradientMachine ...............        9.75 sec
test_seq_pool ...............................       10.46 sec
test_conv2d_op ..............................       11.85 sec
test_ProtoDataProvider ......................       13.54 sec
test_lstm_op ................................       14.14 sec
test_conv3d_op ..............................       14.21 sec
test_sparseMatrixCompare ....................       15.37 sec
test_ConvTrans ..............................       15.65 sec
master_test .................................       18.41 sec
test_image_classification_train .............       20.18 sec
test_PyDataProvider2 ........................       20.27 sec
test_recognize_digits_conv ..................       22.81 sec
test_CustomStackTrace .......................       24.03 sec
test_layerHelpers ...........................       26.00 sec
DepthwiseConvOpTest .........................       26.77 sec
test_Matrix .................................       27.46 sec
test_TrainerOnePass .........................       32.17 sec
test_TrainingAlgorithm ......................       32.81 sec
Im2ColTest ..................................       33.02 sec
test_seq_conv ...............................       33.14 sec
test_ParameterServer2 .......................       37.81 sec
test_BaseMatrix .............................       41.53 sec
test_RecurrentLayer .........................       49.66 sec
test_matrixCompare ..........................       51.42 sec
test_understand_sentiment_conv ..............       52.29 sec
test_CompareTwoNets .........................       54.21 sec
test_mul_op .................................       55.60 sec
test_recommender_system .....................       63.55 sec
test_ProtoServer ............................       72.85 sec
test_CompareSparse ..........................       80.51 sec
test_LayerGrad ..............................      130.69 sec

luotao1 · 2017-11-10T06:52:04Z

@chengduoZH 能否按照时间从大到小进行排列。另外，请问这个数据是从哪儿获得的呢？从teamcity的log来看，并不是这样的。https://paddleci.ngrok.io/viewLog.html?buildId=18018&buildTypeId=Paddle_PrCi

luotao1 · 2017-11-10T07:04:25Z

[04:39:43] :	 [Step 1/1]   1/272 Test   #2: parameter_optimizer_test ....................   Passed    0.21 sec
[04:39:43] :	 [Step 1/1]   2/272 Test   #1: serialization_test ..........................   Passed    0.61 sec
[04:39:43] :	 [Step 1/1]         Start   9: TensorTypeTest
[04:39:43] :	 [Step 1/1]         Start  10: BufferArgTest
[04:39:45] :	 [Step 1/1]   3/272 Test   #6: network_helper_test .........................   Passed    1.71 sec
[04:39:45] :	 [Step 1/1]   4/272 Test   #9: TensorTypeTest ..............................   Passed    1.50 sec
[04:39:45] :	 [Step 1/1]         Start  11: FunctionTest
[04:39:45] :	 [Step 1/1]         Start  12: ContextProjectionOpTest
[04:39:45] :	 [Step 1/1]   5/272 Test   #4: pserver_test ................................   Passed    2.21 sec
[04:39:45] :	 [Step 1/1]   6/272 Test   #7: CrossMapNormalOpTest ........................   Passed    2.40 sec
[04:39:45] :	 [Step 1/1]   7/272 Test   #8: TensorShapeTest .............................   Passed    2.60 sec
[04:39:45] :	 [Step 1/1]         Start  13: PadOpTest
[04:39:45] :	 [Step 1/1]         Start  14: MulOpTest
[04:39:45] :	 [Step 1/1]         Start  15: CosSimOpTest
[04:39:46] :	 [Step 1/1]   8/272 Test  #10: BufferArgTest ...............................   Passed    2.30 sec
[04:39:46] :	 [Step 1/1]         Start  16: RowConvOpTest
[04:39:47] :	 [Step 1/1]   9/272 Test  #11: FunctionTest ................................   Passed    1.61 sec
[04:39:47] :	 [Step 1/1]         Start  17: BlockExpandOpTest
[04:39:47] :	 [Step 1/1]  10/272 Test  #15: CosSimOpTest ................................   Passed    2.01 sec
[04:39:47] :	 [Step 1/1]  11/272 Test  #14: MulOpTest ...................................   Passed    2.01 sec
[04:39:47] :	 [Step 1/1]         Start  18: CropOpTest
[04:39:47] :	 [Step 1/1]         Start  19: SwitchOpTest
[04:39:48] :	 [Step 1/1]  12/272 Test  #12: ContextProjectionOpTest .....................   Passed    2.82 sec
[04:39:48] :	 [Step 1/1]         Start  20: ScaleSubRegionOpTest
[04:39:49] :	 [Step 1/1]  13/272 Test  #17: BlockExpandOpTest ...........................   Passed    1.81 sec
[04:39:49] :	 [Step 1/1]  14/272 Test  #13: PadOpTest ...................................   Passed    3.31 sec
[04:39:49] :	 [Step 1/1]         Start  21: Im2ColTest
[04:39:49] :	 [Step 1/1]         Start  22: GemmConvOpTest
[04:39:50] :	 [Step 1/1]  15/272 Test  #19: SwitchOpTest ................................   Passed    1.50 sec
[04:39:50] :	 [Step 1/1]  16/272 Test  #16: RowConvOpTest ...............................   Passed    3.01 sec
[04:39:50] :	 [Step 1/1]         Start  23: DepthwiseConvOpTest
[04:39:50] :	 [Step 1/1]         Start  24: test_Thread
[04:39:50] :	 [Step 1/1]  17/272 Test  #18: CropOpTest ..................................   Passed    2.61 sec
[04:39:50] :	 [Step 1/1]         Start  25: test_StringUtils
[04:39:51] :	 [Step 1/1]  18/272 Test  #20: ScaleSubRegionOpTest ........................   Passed    2.31 sec
[04:39:51] :	 [Step 1/1]         Start  26: test_CustomStackTrace
[04:39:52] :	 [Step 1/1]  19/272 Test   #5: pserver_client_test .........................   Passed    8.24 sec
[04:39:52] :	 [Step 1/1]  20/272 Test  #24: test_Thread .................................   Passed    1.71 sec
[04:39:52] :	 [Step 1/1]         Start  27: test_ThreadBarrier
[04:39:52] :	 [Step 1/1]         Start  28: test_SpinLock
[04:39:52] :	 [Step 1/1]  21/272 Test  #22: GemmConvOpTest ..............................   Passed    3.34 sec
[04:39:52] :	 [Step 1/1]         Start  29: test_SIMDFlags
[04:39:54] :	 [Step 1/1]  22/272 Test  #28: test_SpinLock ...............................   Passed    2.03 sec
[04:39:54] :	 [Step 1/1]  23/272 Test  #29: test_SIMDFlags ..............................   Passed    1.41 sec
[04:39:54] :	 [Step 1/1]         Start  30: test_Error
[04:39:54] :	 [Step 1/1]         Start  31: test_CustomStackTracePrint
[04:39:54] :	 [Step 1/1]  24/272 Test  #27: test_ThreadBarrier ..........................   Passed    2.44 sec
[04:39:54] :	 [Step 1/1]         Start  32: test_ExecViaCpu
[04:39:55] :	 [Step 1/1]  25/272 Test  #30: test_Error ..................................   Passed    1.20 sec
[04:39:55] :	 [Step 1/1]         Start  33: test_SIMDFunctions
[04:39:56] :	 [Step 1/1]  26/272 Test  #32: test_ExecViaCpu .............................   Passed    1.80 sec
[04:39:56] :	 [Step 1/1]  27/272 Test  #33: test_SIMDFunctions ..........................   Passed    1.20 sec
[04:39:56] :	 [Step 1/1]         Start  34: test_TrainingAlgorithm
[04:39:56] :	 [Step 1/1]         Start  35: test_SparseMatrix
[04:39:57] :	 [Step 1/1]  28/272 Test  #21: Im2ColTest ..................................   Passed    7.97 sec
[04:39:57] :	 [Step 1/1]         Start  36: test_RowBuffer
[04:39:58] :	 [Step 1/1]  29/272 Test  #23: DepthwiseConvOpTest .........................   Passed    7.77 sec
[04:39:58] :	 [Step 1/1]  30/272 Test  #35: test_SparseMatrix ...........................   Passed    1.11 sec
[04:39:58] :	 [Step 1/1]         Start  37: test_matrixCompare
[04:39:58] :	 [Step 1/1]         Start  38: test_sparseMatrixCompare
[04:40:01] :	 [Step 1/1]  31/272 Test  #38: test_sparseMatrixCompare ....................   Passed    3.04 sec
[04:40:01] :	 [Step 1/1]         Start  39: test_perturbation
[04:40:02] :	 [Step 1/1]  32/272 Test  #39: test_perturbation ...........................   Passed    1.40 sec
[04:40:02] :	 [Step 1/1]         Start  40: test_CpuGpuVector
[04:40:04] :	 [Step 1/1]  33/272 Test  #40: test_CpuGpuVector ...........................   Passed    1.40 sec
[04:40:04] :	 [Step 1/1]         Start  41: test_Allocator
[04:40:05] :	 [Step 1/1]  34/272 Test  #37: test_matrixCompare ..........................   Passed    7.36 sec
[04:40:05] :	 [Step 1/1]  35/272 Test  #41: test_Allocator ..............................   Passed    1.30 sec
[04:40:05] :	 [Step 1/1]         Start  42: test_FPException
[04:40:05] :	 [Step 1/1]         Start  43: test_GpuProfiler
[04:40:07] :	 [Step 1/1]  36/272 Test  #34: test_TrainingAlgorithm ......................   Passed    9.77 sec
[04:40:07] :	 [Step 1/1]  37/272 Test  #42: test_FPException ............................   Passed    1.30 sec
[04:40:07] :	 [Step 1/1]         Start  44: test_BaseMatrix
[04:40:07] :	 [Step 1/1]         Start  45: test_Matrix
[04:40:07] :	 [Step 1/1]  38/272 Test  #43: test_GpuProfiler ............................   Passed    1.81 sec
[04:40:07] :	 [Step 1/1]         Start  46: test_LinearChainCRF
[04:40:09] :	 [Step 1/1]  39/272 Test  #46: test_LinearChainCRF .........................   Passed    1.21 sec
[04:40:09] :	 [Step 1/1]         Start  47: test_MultinomialSampler
[04:40:10] :	 [Step 1/1]  40/272 Test  #31: test_CustomStackTracePrint ..................   Passed   16.80 sec
[04:40:10] :	 [Step 1/1]         Start  48: test_RecurrentLayer
[04:40:11] :	 [Step 1/1]  41/272 Test  #36: test_RowBuffer ..............................   Passed   13.59 sec
[04:40:11] :	 [Step 1/1]  42/272 Test  #47: test_MultinomialSampler .....................   Passed    1.82 sec
[04:40:11] :	 [Step 1/1]         Start  49: test_LayerGrad
[04:40:11] :	 [Step 1/1]         Start  50: test_CRFLayerGrad
[04:40:12] :	 [Step 1/1]  43/272 Test  #25: test_StringUtils ............................   Passed   21.38 sec
[04:40:12] :	 [Step 1/1]         Start  51: test_CrossEntropyOverBeamGrad
[04:40:14] :	 [Step 1/1]  44/272 Test  #26: test_CustomStackTrace .......................   Passed   22.69 sec
[04:40:14] :	 [Step 1/1]  45/272 Test  #50: test_CRFLayerGrad ...........................   Passed    2.52 sec
[04:40:14] :	 [Step 1/1]  46/272 Test  #51: test_CrossEntropyOverBeamGrad ...............   Passed    1.81 sec
[04:40:14] :	 [Step 1/1]         Start  52: test_SeqSliceLayerGrad
[04:40:14] :	 [Step 1/1]         Start  53: test_ActivationGrad
[04:40:14] :	 [Step 1/1]         Start  54: test_ConvTrans
[04:40:15] :	 [Step 1/1]  47/272 Test  #45: test_Matrix .................................   Passed    8.08 sec
[04:40:15] :	 [Step 1/1]  48/272 Test  #44: test_BaseMatrix .............................   Passed    8.38 sec
[04:40:15] :	 [Step 1/1]         Start  55: test_PriorBox
[04:40:15] :	 [Step 1/1]         Start  56: test_DetectionOutput
[04:40:16] :	 [Step 1/1]  49/272 Test  #53: test_ActivationGrad .........................   Passed    1.83 sec
[04:40:16] :	 [Step 1/1]         Start  57: test_ConvUnify
[04:40:17] :	 [Step 1/1]  50/272 Test  #52: test_SeqSliceLayerGrad ......................   Passed    2.25 sec
[04:40:17] :	 [Step 1/1]  51/272 Test  #54: test_ConvTrans ..............................   Passed    2.65 sec
[04:40:17] :	 [Step 1/1]         Start  58: test_BatchNorm
[04:40:17] :	 [Step 1/1]         Start  59: test_KmaxSeqScore
[04:40:17] :	 [Step 1/1]  52/272 Test   #3: master_test .................................   Passed   33.79 sec
[04:40:17] :	 [Step 1/1]  53/272 Test  #55: test_PriorBox ...............................   Passed    1.75 sec
[04:40:17] :	 [Step 1/1]         Start  60: test_Expand
[04:40:17] :	 [Step 1/1]         Start  61: test_MKLDNN
[04:40:18] :	 [Step 1/1]  54/272 Test  #56: test_DetectionOutput ........................   Passed    2.27 sec
[04:40:18] :	 [Step 1/1]         Start  62: test_PyDataProvider
[04:40:19] :	 [Step 1/1]  55/272 Test  #57: test_ConvUnify ..............................   Passed    2.36 sec
[04:40:19] :	 [Step 1/1]         Start  63: test_WarpCTCLayer
[04:40:20] :	 [Step 1/1]  56/272 Test  #59: test_KmaxSeqScore ...........................   Passed    3.36 sec
[04:40:20] :	 [Step 1/1]  57/272 Test  #60: test_Expand .................................   Passed    2.87 sec
[04:40:20] :	 [Step 1/1]         Start  64: test_ProtoDataProvider
[04:40:20] :	 [Step 1/1]         Start  65: test_Evaluator
[04:40:21] :	 [Step 1/1]  58/272 Test  #58: test_BatchNorm ..............................   Passed    3.52 sec
[04:40:21] :	 [Step 1/1]         Start  66: test_RecurrentGradientMachine
[04:40:22] :	 [Step 1/1]  59/272 Test  #62: test_PyDataProvider .........................   Passed    3.19 sec
[04:40:22] :	 [Step 1/1]         Start  67: test_NetworkCompare
[04:40:22] :	 [Step 1/1]  60/272 Test  #63: test_WarpCTCLayer ...........................   Passed    3.30 sec
[04:40:22] :	 [Step 1/1]         Start  68: test_PyDataProvider2
[04:40:25] :	 [Step 1/1]  61/272 Test  #67: test_NetworkCompare .........................   Passed    3.57 sec
[04:40:25] :	 [Step 1/1]  62/272 Test  #65: test_Evaluator ..............................   Passed    4.98 sec
[04:40:25] :	 [Step 1/1]         Start  69: test_common
[04:40:25] :	 [Step 1/1]         Start  70: test_argument
[04:40:28] :	 [Step 1/1]  63/272 Test  #70: test_argument ...............................   Passed    2.13 sec
[04:40:28] :	 [Step 1/1]  64/272 Test  #64: test_ProtoDataProvider ......................   Passed    7.46 sec
[04:40:28] :	 [Step 1/1]         Start  71: socket_test
[04:40:28] :	 [Step 1/1]         Start  72: test_ProtoServer
[04:40:29] :	 [Step 1/1]  65/272 Test  #61: test_MKLDNN .................................   Passed   11.33 sec
[04:40:29] :	 [Step 1/1]  66/272 Test  #69: test_common .................................   Passed    3.35 sec
[04:40:29] :	 [Step 1/1]         Start  73: test_ParameterServer2
[04:40:29] :	 [Step 1/1]         Start  74: test_Compare
[04:40:31] :	 [Step 1/1]  67/272 Test  #74: test_Compare ................................   Passed    1.81 sec
[04:40:31] :	 [Step 1/1]         Start  75: test_Trainer
[04:40:32] :	 [Step 1/1]  68/272 Test  #66: test_RecurrentGradientMachine ...............   Passed   10.46 sec
[04:40:32] :	 [Step 1/1]  69/272 Test  #49: test_LayerGrad ..............................   Passed   20.45 sec
[04:40:32] :	 [Step 1/1]         Start  76: test_TrainerOnePass
[04:40:32] :	 [Step 1/1]         Start  77: test_CompareTwoNets
[04:40:33] :	 [Step 1/1]  70/272 Test  #71: socket_test .................................   Passed    4.94 sec
[04:40:33] :	 [Step 1/1]         Start  78: test_CompareTwoOpts
[04:40:33] :	 [Step 1/1]  71/272 Test  #75: test_Trainer ................................   Passed    1.61 sec
[04:40:33] :	 [Step 1/1]         Start  79: test_CompareSparse
[04:40:36] :	 [Step 1/1]  72/272 Test  #78: test_CompareTwoOpts .........................   Passed    2.42 sec
[04:40:36] :	 [Step 1/1]         Start  80: test_recurrent_machine_generation
[04:40:37] :	 [Step 1/1]  73/272 Test  #48: test_RecurrentLayer .........................   Passed   26.72 sec
[04:40:37] :	 [Step 1/1]         Start  81: test_PyDataProviderWrapper
[04:40:39] :	 [Step 1/1]  74/272 Test  #80: test_recurrent_machine_generation ...........   Passed    2.41 sec
[04:40:39] :	 [Step 1/1]         Start  82: test_config_parser
[04:40:39] :	 [Step 1/1]  75/272 Test  #82: test_config_parser ..........................   Passed    0.17 sec
[04:40:39] :	 [Step 1/1]  76/272 Test  #81: test_PyDataProviderWrapper ..................   Passed    2.17 sec
[04:40:39] :	 [Step 1/1]         Start  83: stringpiece_test
[04:40:39] :	 [Step 1/1]         Start  84: stringprintf_test
[04:40:40] :	 [Step 1/1]  77/272 Test  #84: stringprintf_test ...........................   Passed    0.30 sec
[04:40:40] :	 [Step 1/1]  78/272 Test  #83: stringpiece_test ............................   Passed    0.60 sec
[04:40:40] :	 [Step 1/1]         Start  85: to_string_test
[04:40:40] :	 [Step 1/1]         Start  86: memory_test
[04:40:41] :	 [Step 1/1]  79/272 Test  #85: to_string_test ..............................   Passed    0.70 sec
[04:40:41] :	 [Step 1/1]         Start  87: system_allocator_test
[04:40:41] :	 [Step 1/1]  80/272 Test  #86: memory_test .................................   Passed    0.80 sec
[04:40:41] :	 [Step 1/1]  81/272 Test  #87: system_allocator_test .......................   Passed    0.60 sec
[04:40:41] :	 [Step 1/1]         Start  88: cpu_info_test
[04:40:41] :	 [Step 1/1]         Start  89: place_test
[04:40:42] :	 [Step 1/1]  82/272 Test  #88: cpu_info_test ...............................   Passed    0.30 sec
[04:40:42] :	 [Step 1/1]  83/272 Test  #89: place_test ..................................   Passed    0.60 sec
[04:40:42] :	 [Step 1/1]         Start  90: enforce_test
[04:40:42] :	 [Step 1/1]         Start  91: device_context_test
[04:40:43] :	 [Step 1/1]  84/272 Test  #90: enforce_test ................................   Passed    0.31 sec
[04:40:43] :	 [Step 1/1]         Start  92: cudnn_helper_test
[04:40:43] :	 [Step 1/1]  85/272 Test  #68: test_PyDataProvider2 ........................   Passed   20.42 sec
[04:40:43] :	 [Step 1/1]  86/272 Test  #92: cudnn_helper_test ...........................   Passed    0.23 sec
[04:40:43] :	 [Step 1/1]         Start  93: transform_test
[04:40:43] :	 [Step 1/1]         Start  94: nccl_test
[04:40:44] :	 [Step 1/1]  87/272 Test  #94: nccl_test ...................................   Passed    0.12 sec
[04:40:44] :	 [Step 1/1]         Start  95: ddim_test
[04:40:45] :	 [Step 1/1]  88/272 Test  #95: ddim_test ...................................   Passed    0.10 sec
[04:40:45] :	 [Step 1/1]  89/272 Test  #91: device_context_test .........................   Passed    2.69 sec
[04:40:45] :	 [Step 1/1]         Start  96: dim_test
[04:40:45] :	 [Step 1/1]         Start  97: tensor_test
[04:40:45] :	 [Step 1/1]  90/272 Test  #96: dim_test ....................................   Passed    0.71 sec
[04:40:45] :	 [Step 1/1]         Start  98: eigen_test
[04:40:46] :	 [Step 1/1]  91/272 Test  #93: transform_test ..............................   Passed    2.34 sec
[04:40:46] :	 [Step 1/1]  92/272 Test  #98: eigen_test ..................................   Passed    0.60 sec
[04:40:46] :	 [Step 1/1]         Start  99: lod_tensor_test
[04:40:46] :	 [Step 1/1]         Start 100: lod_tensor_gpu_test
[04:40:47] :	 [Step 1/1]  93/272 Test #100: lod_tensor_gpu_test .........................   Passed    0.71 sec
[04:40:47] :	 [Step 1/1]         Start 101: variable_test
[04:40:47] :	 [Step 1/1]  94/272 Test  #97: tensor_test .................................   Passed    2.13 sec
[04:40:47] :	 [Step 1/1]  95/272 Test  #99: lod_tensor_test .............................   Passed    0.92 sec
[04:40:47] :	 [Step 1/1]  96/272 Test #101: variable_test ...............................   Passed    0.50 sec
[04:40:47] :	 [Step 1/1]         Start 102: scope_test
[04:40:47] :	 [Step 1/1]         Start 103: program_desc_test
[04:40:47] :	 [Step 1/1]         Start 104: op_proto_maker_test
[04:40:48] :	 [Step 1/1]  97/272 Test #104: op_proto_maker_test .........................   Passed    0.20 sec
[04:40:48] :	 [Step 1/1]  98/272 Test #102: scope_test ..................................   Passed    0.50 sec
[04:40:48] :	 [Step 1/1]  99/272 Test #103: program_desc_test ...........................   Passed    0.50 sec
[04:40:48] :	 [Step 1/1]         Start 105: operator_test
[04:40:48] :	 [Step 1/1]         Start 106: op_registry_test
[04:40:48] :	 [Step 1/1]         Start 107: backward_test
[04:40:48] :	 [Step 1/1] 100/272 Test #105: operator_test ...............................   Passed    0.20 sec
[04:40:48] :	 [Step 1/1] 101/272 Test #107: backward_test ...............................   Passed    0.50 sec
[04:40:48] :	 [Step 1/1] 102/272 Test #106: op_registry_test ............................   Passed    0.50 sec
[04:40:48] :	 [Step 1/1]         Start 108: prune_test
[04:40:48] :	 [Step 1/1]         Start 109: tensor_array_test
[04:40:48] :	 [Step 1/1]         Start 110: var_type_inference_test
[04:40:49] :	 [Step 1/1] 103/272 Test #108: prune_test ..................................   Passed    0.20 sec
[04:40:49] :	 [Step 1/1] 104/272 Test #110: var_type_inference_test .....................   Passed    0.50 sec
[04:40:49] :	 [Step 1/1] 105/272 Test #109: tensor_array_test ...........................   Passed    0.50 sec
[04:40:49] :	 [Step 1/1]         Start 111: selected_rows_test
[04:40:49] :	 [Step 1/1]         Start 112: gather_test
[04:40:49] :	 [Step 1/1]         Start 113: net_op_test
[04:40:49] :	 [Step 1/1] 106/272 Test #111: selected_rows_test ..........................   Passed    0.26 sec
[04:40:49] :	 [Step 1/1] 107/272 Test #113: net_op_test .................................   Passed    0.56 sec
[04:40:49] :	 [Step 1/1] 108/272 Test #112: gather_test .................................   Passed    0.56 sec
[04:40:49] :	 [Step 1/1]         Start 114: scatter_test
[04:40:49] :	 [Step 1/1]         Start 115: strided_memcpy_test
[04:40:49] :	 [Step 1/1]         Start 116: dynamic_recurrent_op_test
[04:40:50] :	 [Step 1/1] 109/272 Test #114: scatter_test ................................   Passed    0.20 sec
[04:40:50] :	 [Step 1/1] 110/272 Test #116: dynamic_recurrent_op_test ...................   Passed    0.50 sec
[04:40:50] :	 [Step 1/1]         Start 117: nccl_op_test
[04:40:50] :	 [Step 1/1]         Start 118: save_load_op_test
[04:40:50] :	 [Step 1/1] 111/272 Test #117: nccl_op_test ................................   Passed    0.21 sec
[04:40:50] :	 [Step 1/1]         Start 119: math_function_gpu_test
[04:40:51] :	 [Step 1/1] 112/272 Test #118: save_load_op_test ...........................   Passed    1.31 sec
[04:40:51] :	 [Step 1/1] 113/272 Test #115: strided_memcpy_test .........................   Passed    1.91 sec
[04:40:51] :	 [Step 1/1]         Start 120: selected_rows_functor_gpu_test
[04:40:51] :	 [Step 1/1]         Start 121: math_function_test
[04:40:52] :	 [Step 1/1] 114/272 Test #121: math_function_test ..........................   Passed    0.60 sec
[04:40:52] :	 [Step 1/1]         Start 122: selected_rows_functor_test
[04:40:53] :	 [Step 1/1] 115/272 Test #122: selected_rows_functor_test ..................   Passed    0.66 sec
[04:40:53] :	 [Step 1/1]         Start 123: im2col_test
[04:40:53] :	 [Step 1/1] 116/272 Test #120: selected_rows_functor_gpu_test ..............   Passed    2.16 sec
[04:40:53] :	 [Step 1/1]         Start 124: vol2col_test
[04:40:54] :	 [Step 1/1] 117/272 Test  #72: test_ProtoServer ............................   Passed   26.15 sec
[04:40:54] :	 [Step 1/1] 118/272 Test #123: im2col_test .................................   Passed    1.20 sec
[04:40:54] :	 [Step 1/1]         Start 125: testTrain
[04:40:54] :	 [Step 1/1]         Start 126: testMatrix
[04:40:55] :	 [Step 1/1] 119/272 Test #124: vol2col_test ................................   Passed    1.31 sec
[04:40:55] :	 [Step 1/1]         Start 127: testVector
[04:40:56] :	 [Step 1/1] 120/272 Test #126: testMatrix ..................................   Passed    2.02 sec
[04:40:56] :	 [Step 1/1] 121/272 Test #127: testVector ..................................   Passed    1.49 sec
[04:40:56] :	 [Step 1/1]         Start 128: testTrainer
[04:40:56] :	 [Step 1/1]         Start 129: testArguments
[04:40:57] :	 [Step 1/1] 122/272 Test #129: testArguments ...............................   Passed    0.72 sec
[04:40:57] :	 [Step 1/1]         Start 130: testGradientMachine
[04:40:59] :	 [Step 1/1] 123/272 Test #130: testGradientMachine .........................   Passed    2.32 sec
[04:40:59] :	 [Step 1/1]         Start 131: layers_test
[04:41:00] :	 [Step 1/1] 124/272 Test #125: testTrain ...................................   Passed    5.86 sec
[04:41:00] :	 [Step 1/1] 125/272 Test #131: layers_test .................................   Passed    0.61 sec
[04:41:00] :	 [Step 1/1]         Start 132: test_reset_hook
[04:41:00] :	 [Step 1/1]         Start 133: test_layerHelpers
[04:41:00] :	 [Step 1/1] 126/272 Test #119: math_function_gpu_test ......................   Passed    9.43 sec
[04:41:00] :	 [Step 1/1] 127/272 Test #132: test_reset_hook .............................   Passed    0.50 sec
[04:41:00] :	 [Step 1/1]         Start 134: test_op
[04:41:00] :	 [Step 1/1]         Start 135: test_image
[04:41:02] :	 [Step 1/1] 128/272 Test  #76: test_TrainerOnePass .........................   Passed   29.48 sec
[04:41:02] :	 [Step 1/1]         Start 136: test_layer
[04:41:03] :	 [Step 1/1] 129/272 Test #134: test_op .....................................   Passed    2.52 sec
[04:41:03] :	 [Step 1/1] 130/272 Test #135: test_image ..................................   Passed    2.82 sec
[04:41:03] :	 [Step 1/1]         Start 137: test_topology
[04:41:03] :	 [Step 1/1]         Start 138: test_rnn_layer
[04:41:04] :	 [Step 1/1] 131/272 Test #136: test_layer ..................................   Passed    1.72 sec
[04:41:04] :	 [Step 1/1] 132/272 Test #128: testTrainer .................................   Passed    7.59 sec
[04:41:04] :	 [Step 1/1]         Start 139: test_parameters
[04:41:04] :	 [Step 1/1]         Start 140: test_data_feeder
[04:41:05] :	 [Step 1/1] 133/272 Test #137: test_topology ...............................   Passed    1.63 sec
[04:41:05] :	 [Step 1/1] 134/272 Test #138: test_rnn_layer ..............................   Passed    1.83 sec
[04:41:05] :	 [Step 1/1]         Start 141: test_paramconf_order
[04:41:05] :	 [Step 1/1]         Start 142: creator_test
[04:41:06] :	 [Step 1/1] 135/272 Test #139: test_parameters .............................   Passed    2.18 sec
[04:41:06] :	 [Step 1/1]         Start 143: decorator_test
[04:41:07] :	 [Step 1/1] 136/272 Test #140: test_data_feeder ............................   Passed    2.59 sec
[04:41:07] :	 [Step 1/1]         Start 144: test_ploter
[04:41:08] :	 [Step 1/1] 137/272 Test #142: creator_test ................................   Passed    1.93 sec
[04:41:08] :	 [Step 1/1]         Start 145: test_word2vec
[04:41:09] :	 [Step 1/1] 138/272 Test #143: decorator_test ..............................   Passed    3.01 sec
[04:41:09] :	 [Step 1/1]         Start 146: test_cos_sim_op
[04:41:10] :	 [Step 1/1] 139/272 Test #144: test_ploter .................................   Passed    2.51 sec
[04:41:10] :	 [Step 1/1] 140/272 Test  #73: test_ParameterServer2 .......................   Passed   40.33 sec
[04:41:10] :	 [Step 1/1]         Start 147: test_program
[04:41:10] :	 [Step 1/1]         Start 148: test_exception
[04:41:10] :	 [Step 1/1] 141/272 Test #145: test_word2vec ...............................   Passed    2.34 sec
[04:41:10] :	 [Step 1/1]         Start 149: test_auc_op
[04:41:11] :	 [Step 1/1] 142/272 Test #148: test_exception ..............................   Passed    1.04 sec
[04:41:11] :	 [Step 1/1] 143/272 Test #147: test_program ................................   Passed    1.08 sec
[04:41:11] :	 [Step 1/1] 144/272 Test #141: test_paramconf_order ........................   Passed    5.45 sec
[04:41:11] :	 [Step 1/1]         Start 150: test_pool3d_op
[04:41:11] :	 [Step 1/1]         Start 151: test_selected_rows
[04:41:11] :	 [Step 1/1]         Start 152: test_pool2d_op
[04:41:12] :	 [Step 1/1] 145/272 Test #149: test_auc_op .................................   Passed    1.57 sec
[04:41:12] :	 [Step 1/1] 146/272 Test #146: test_cos_sim_op .............................   Passed    3.37 sec
[04:41:12] :	 [Step 1/1]         Start 153: test_image_classification_train
[04:41:12] :	 [Step 1/1]         Start 154: test_matmul_op
[04:41:13] :	 [Step 1/1] 147/272 Test #151: test_selected_rows ..........................   Passed    2.00 sec
[04:41:13] :	 [Step 1/1]         Start 155: test_crop_op
[04:41:15] :	 [Step 1/1] 148/272 Test #152: test_pool2d_op ..............................   Passed    4.10 sec
[04:41:15] :	 [Step 1/1]         Start 156: test_executor_and_mul
[04:41:16] :	 [Step 1/1] 149/272 Test #150: test_pool3d_op ..............................   Passed    4.82 sec
[04:41:16] :	 [Step 1/1]         Start 157: test_modified_huber_loss_op
[04:41:17] :	 [Step 1/1] 150/272 Test #155: test_crop_op ................................   Passed    3.45 sec
[04:41:17] :	 [Step 1/1] 151/272 Test #156: test_executor_and_mul .......................   Passed    1.33 sec
[04:41:17] :	 [Step 1/1]         Start 158: test_adamax_op
[04:41:17] :	 [Step 1/1]         Start 159: test_operator_desc
[04:41:18] :	 [Step 1/1] 152/272 Test #157: test_modified_huber_loss_op .................   Passed    1.74 sec
[04:41:18] :	 [Step 1/1]         Start 160: test_seq_conv
[04:41:19] :	 [Step 1/1] 153/272 Test #159: test_operator_desc ..........................   Passed    2.01 sec
[04:41:19] :	 [Step 1/1]         Start 161: test_scope
[04:41:21] :	 [Step 1/1] 154/272 Test #154: test_matmul_op ..............................   Passed    8.47 sec
[04:41:21] :	 [Step 1/1] 155/272 Test #161: test_scope ..................................   Passed    2.10 sec
[04:41:21] :	 [Step 1/1] 156/272 Test #158: test_adamax_op ..............................   Passed    4.41 sec
[04:41:21] :	 [Step 1/1]         Start 162: test_regularizer
[04:41:21] :	 [Step 1/1]         Start 163: test_top_k_op
[04:41:21] :	 [Step 1/1]         Start 164: test_accuracy_op
[04:41:23] :	 [Step 1/1] 157/272 Test #162: test_regularizer ............................   Passed    1.13 sec
[04:41:23] :	 [Step 1/1]         Start 165: test_gaussian_random_op
[04:41:24] :	 [Step 1/1] 158/272 Test #163: test_top_k_op ...............................   Passed    2.58 sec
[04:41:24] :	 [Step 1/1] 159/272 Test #164: test_accuracy_op ............................   Passed    2.86 sec
[04:41:24] :	 [Step 1/1]         Start 166: test_gather_op
[04:41:24] :	 [Step 1/1]         Start 167: test_prelu_op
[04:41:26] :	 [Step 1/1] 160/272 Test #165: test_gaussian_random_op .....................   Passed    3.56 sec
[04:41:26] :	 [Step 1/1]         Start 168: test_default_scope_funcs
[04:41:28] :	 [Step 1/1] 161/272 Test #168: test_default_scope_funcs ....................   Passed    1.52 sec
[04:41:28] :	 [Step 1/1]         Start 169: test_l1_norm_op
[04:41:29] :	 [Step 1/1] 162/272 Test #166: test_gather_op ..............................   Passed    4.16 sec
[04:41:29] :	 [Step 1/1]         Start 170: test_sum_op
[04:41:29] :	 [Step 1/1] 163/272 Test  #77: test_CompareTwoNets .........................   Passed   56.80 sec
[04:41:29] :	 [Step 1/1] 164/272 Test #167: test_prelu_op ...............................   Passed    4.66 sec
[04:41:29] :	 [Step 1/1]         Start 171: test_pool_max_op
[04:41:29] :	 [Step 1/1]         Start 172: test_rmsprop_op
[04:41:32] :	 [Step 1/1] 165/272 Test #169: test_l1_norm_op .............................   Passed    3.36 sec
[04:41:32] :	 [Step 1/1]         Start 173: test_activation_op
[04:41:33] :	 [Step 1/1] 166/272 Test #170: test_sum_op .................................   Passed    4.44 sec
[04:41:33] :	 [Step 1/1]         Start 174: test_mean_op
[04:41:34] :	 [Step 1/1] 167/272 Test #172: test_rmsprop_op .............................   Passed    3.93 sec
[04:41:34] :	 [Step 1/1] 168/272 Test #171: test_pool_max_op ............................   Passed    3.95 sec
[04:41:34] :	 [Step 1/1]         Start 175: test_minus_op
[04:41:34] :	 [Step 1/1]         Start 176: test_gru_unit_op
[04:41:35] :	 [Step 1/1] 169/272 Test  #79: test_CompareSparse ..........................   Passed   61.38 sec
[04:41:35] :	 [Step 1/1]         Start 177: test_infer_shape
[04:41:36] :	 [Step 1/1] 170/272 Test #176: test_gru_unit_op ............................   Passed    1.85 sec
[04:41:36] :	 [Step 1/1] 171/272 Test #173: test_activation_op ..........................   Passed    4.29 sec
[04:41:36] :	 [Step 1/1]         Start 178: test_lrn_op
[04:41:36] :	 [Step 1/1]         Start 179: test_recognize_digits_mlp
[04:41:37] :	 [Step 1/1] 172/272 Test #174: test_mean_op ................................   Passed    3.22 sec
[04:41:37] :	 [Step 1/1] 173/272 Test #133: test_layerHelpers ...........................   Passed   36.68 sec
[04:41:37] :	 [Step 1/1]         Start 180: test_smooth_l1_loss_op
[04:41:37] :	 [Step 1/1]         Start 181: test_variable
[04:41:37] :	 [Step 1/1] 174/272 Test #177: test_infer_shape ............................   Passed    1.29 sec
[04:41:37] :	 [Step 1/1]         Start 182: test_pad_op
[04:41:38] :	 [Step 1/1] 175/272 Test #178: test_lrn_op .................................   Passed    1.78 sec
[04:41:38] :	 [Step 1/1] 176/272 Test #181: test_variable ...............................   Passed    1.34 sec
[04:41:38] :	 [Step 1/1]         Start 183: test_adadelta_op
[04:41:38] :	 [Step 1/1]         Start 184: test_optimizer
[04:41:39] :	 [Step 1/1] 177/272 Test #179: test_recognize_digits_mlp ...................   Passed    2.70 sec
[04:41:39] :	 [Step 1/1]         Start 185: test_clip_op
[04:41:39] :	 [Step 1/1] 178/272 Test #175: test_minus_op ...............................   Passed    5.10 sec
[04:41:39] :	 [Step 1/1]         Start 186: test_momentum_op
[04:41:40] :	 [Step 1/1] 179/272 Test #184: test_optimizer ..............................   Passed    1.84 sec
[04:41:40] :	 [Step 1/1]         Start 187: test_sequence_softmax_op
[04:41:41] :	 [Step 1/1] 180/272 Test #180: test_smooth_l1_loss_op ......................   Passed    3.81 sec
[04:41:41] :	 [Step 1/1]         Start 188: test_protobuf
[04:41:42] :	 [Step 1/1] 181/272 Test #183: test_adadelta_op ............................   Passed    3.36 sec
[04:41:42] :	 [Step 1/1]         Start 189: test_feed_fetch_method
[04:41:42] :	 [Step 1/1] 182/272 Test #182: test_pad_op .................................   Passed    4.18 sec
[04:41:42] :	 [Step 1/1] 183/272 Test #188: test_protobuf ...............................   Passed    0.94 sec
[04:41:42] :	 [Step 1/1] 184/272 Test #185: test_clip_op ................................   Passed    3.38 sec
[04:41:42] :	 [Step 1/1]         Start 190: test_rank_loss_op
[04:41:42] :	 [Step 1/1]         Start 191: test_reduce_op
[04:41:42] :	 [Step 1/1]         Start 192: test_seq_expand
[04:41:43] :	 [Step 1/1] 185/272 Test #186: test_momentum_op ............................   Passed    2.79 sec
[04:41:43] :	 [Step 1/1]         Start 193: test_reshape_op
[04:41:44] :	 [Step 1/1] 186/272 Test #187: test_sequence_softmax_op ....................   Passed    3.01 sec
[04:41:44] :	 [Step 1/1] 187/272 Test #189: test_feed_fetch_method ......................   Passed    1.59 sec
[04:41:44] :	 [Step 1/1]         Start 194: test_sign_op
[04:41:44] :	 [Step 1/1]         Start 195: test_scale_op
[04:41:44] :	 [Step 1/1] 188/272 Test #153: test_image_classification_train .............   Passed   31.60 sec
[04:41:44] :	 [Step 1/1]         Start 196: test_scatter_op
[04:41:45] :	 [Step 1/1] 189/272 Test #190: test_rank_loss_op ...........................   Passed    2.76 sec
[04:41:45] :	 [Step 1/1]         Start 197: test_elementwise_add_op
[04:41:45] :	 [Step 1/1] 190/272 Test #191: test_reduce_op ..............................   Passed    2.77 sec
[04:41:45] :	 [Step 1/1] 191/272 Test #192: test_seq_expand .............................   Passed    2.96 sec
[04:41:45] :	 [Step 1/1] 192/272 Test #193: test_reshape_op .............................   Passed    2.55 sec
[04:41:45] :	 [Step 1/1]         Start 198: test_multiplex_op
[04:41:45] :	 [Step 1/1]         Start 199: test_lstm_unit_op
[04:41:45] :	 [Step 1/1]         Start 200: test_nccl_init_op
[04:41:46] :	 [Step 1/1] 193/272 Test #194: test_sign_op ................................   Passed    2.04 sec
[04:41:46] :	 [Step 1/1] 194/272 Test #195: test_scale_op ...............................   Passed    2.24 sec
[04:41:46] :	 [Step 1/1]         Start 201: test_parameter
[04:41:46] :	 [Step 1/1]         Start 202: test_protobuf_descs
[04:41:47] :	 [Step 1/1] 195/272 Test #200: test_nccl_init_op ...........................   Passed    0.86 sec
[04:41:47] :	 [Step 1/1] 196/272 Test #196: test_scatter_op .............................   Passed    2.20 sec
[04:41:47] :	 [Step 1/1]         Start 203: test_uniform_random_op
[04:41:47] :	 [Step 1/1]         Start 204: test_gru_op
[04:41:47] :	 [Step 1/1] 197/272 Test #199: test_lstm_unit_op ...........................   Passed    1.27 sec
[04:41:47] :	 [Step 1/1] 198/272 Test #201: test_parameter ..............................   Passed    0.86 sec
[04:41:47] :	 [Step 1/1] 199/272 Test #202: test_protobuf_descs .........................   Passed    1.16 sec
[04:41:47] :	 [Step 1/1]         Start 205: test_squared_l2_distance_op
[04:41:47] :	 [Step 1/1]         Start 206: test_tensor_array
[04:41:47] :	 [Step 1/1]         Start 207: test_batch_norm_op
[04:41:48] :	 [Step 1/1] 200/272 Test #160: test_seq_conv ...............................   Passed   29.13 sec
[04:41:48] :	 [Step 1/1] 201/272 Test #197: test_elementwise_add_op .....................   Passed    2.71 sec
[04:41:48] :	 [Step 1/1] 202/272 Test #198: test_multiplex_op ...........................   Passed    2.18 sec
[04:41:48] :	 [Step 1/1]         Start 208: test_conv2d_op
[04:41:48] :	 [Step 1/1]         Start 209: test_transpose_op
[04:41:48] :	 [Step 1/1]         Start 210: test_initializer
[04:41:49] :	 [Step 1/1] 203/272 Test #206: test_tensor_array ...........................   Passed    1.63 sec
[04:41:49] :	 [Step 1/1] 204/272 Test #203: test_uniform_random_op ......................   Passed    2.13 sec
[04:41:49] :	 [Step 1/1] 205/272 Test #210: test_initializer ............................   Passed    1.32 sec
[04:41:49] :	 [Step 1/1]         Start 211: test_fill_constant_op
[04:41:49] :	 [Step 1/1]         Start 212: test_adam_op
[04:41:49] :	 [Step 1/1]         Start 213: test_recurrent_op
[04:41:50] :	 [Step 1/1] 206/272 Test #205: test_squared_l2_distance_op .................   Passed    2.64 sec
[04:41:50] :	 [Step 1/1] 207/272 Test #207: test_batch_norm_op ..........................   Passed    3.13 sec
[04:41:50] :	 [Step 1/1]         Start 214: test_adagrad_op
[04:41:50] :	 [Step 1/1]         Start 215: test_cross_entropy_op
[04:41:51] :	 [Step 1/1] 208/272 Test #204: test_gru_op .................................   Passed    3.74 sec
[04:41:51] :	 [Step 1/1] 209/272 Test #213: test_recurrent_op ...........................   Passed    1.61 sec
[04:41:51] :	 [Step 1/1] 210/272 Test #209: test_transpose_op ...........................   Passed    3.01 sec
[04:41:51] :	 [Step 1/1]         Start 216: test_lookup_table_op
[04:41:51] :	 [Step 1/1]         Start 217: test_compare_op
[04:41:51] :	 [Step 1/1]         Start 218: test_lod_rank_table
[04:41:52] :	 [Step 1/1] 211/272 Test #211: test_fill_constant_op .......................   Passed    2.19 sec
[04:41:52] :	 [Step 1/1] 212/272 Test #212: test_adam_op ................................   Passed    2.59 sec
[04:41:52] :	 [Step 1/1]         Start 219: test_net
[04:41:52] :	 [Step 1/1]         Start 220: test_operator
[04:41:53] :	 [Step 1/1] 213/272 Test #208: test_conv2d_op ..............................   Passed    4.83 sec
[04:41:53] :	 [Step 1/1] 214/272 Test #218: test_lod_rank_table .........................   Passed    1.62 sec
[04:41:53] :	 [Step 1/1] 215/272 Test #214: test_adagrad_op .............................   Passed    2.30 sec
[04:41:53] :	 [Step 1/1] 216/272 Test #220: test_operator ...............................   Passed    1.11 sec
[04:41:53] :	 [Step 1/1] 217/272 Test #215: test_cross_entropy_op .......................   Passed    2.35 sec
[04:41:53] :	 [Step 1/1]         Start 221: test_layers
[04:41:53] :	 [Step 1/1]         Start 222: test_decayed_adagrad_op
[04:41:53] :	 [Step 1/1]         Start 223: test_seq_pool
[04:41:53] :	 [Step 1/1]         Start 224: test_concat_op
[04:41:53] :	 [Step 1/1]         Start 225: test_sgd_op
[04:41:54] :	 [Step 1/1] 218/272 Test #219: test_net ....................................   Passed    1.37 sec
[04:41:54] :	 [Step 1/1]         Start 226: test_fit_a_line
[04:41:54] :	 [Step 1/1] 219/272 Test #216: test_lookup_table_op ........................   Passed    2.48 sec
[04:41:54] :	 [Step 1/1] 220/272 Test #217: test_compare_op .............................   Passed    2.68 sec
[04:41:54] :	 [Step 1/1] 221/272 Test #221: test_layers .................................   Passed    1.01 sec
[04:41:54] :	 [Step 1/1]         Start 227: test_tensor
[04:41:54] :	 [Step 1/1]         Start 228: test_array_read_write_op
[04:41:54] :	 [Step 1/1]         Start 229: test_sigmoid_cross_entropy_with_logits_op
[04:41:55] :	 [Step 1/1] 222/272 Test #228: test_array_read_write_op ....................   Passed    0.91 sec
[04:41:55] :	 [Step 1/1] 223/272 Test #222: test_decayed_adagrad_op .....................   Passed    2.13 sec
[04:41:55] :	 [Step 1/1] 224/272 Test #229: test_sigmoid_cross_entropy_with_logits_op ...   Passed    1.11 sec
[04:41:55] :	 [Step 1/1] 225/272 Test #224: test_concat_op ..............................   Passed    2.42 sec
[04:41:55] :	 [Step 1/1] 226/272 Test #225: test_sgd_op .................................   Passed    2.42 sec
[04:41:55] :	 [Step 1/1]         Start 230: test_elementwise_div_op
[04:41:55] :	 [Step 1/1]         Start 231: test_elementwise_mul_op
[04:41:55] :	 [Step 1/1]         Start 232: test_elementwise_sub_op
[04:41:55] :	 [Step 1/1]         Start 233: test_lstm_op
[04:41:55] :	 [Step 1/1]         Start 234: test_margin_rank_loss_op
[04:41:56] :	 [Step 1/1] 227/272 Test #227: test_tensor .................................   Passed    1.64 sec
[04:41:56] :	 [Step 1/1]         Start 235: test_cast_op
[04:41:57] :	 [Step 1/1] 228/272 Test #226: test_fit_a_line .............................   Passed    2.55 sec
[04:41:57] :	 [Step 1/1]         Start 236: test_fill_zeros_like_op
[04:41:57] :	 [Step 1/1] 229/272 Test #234: test_margin_rank_loss_op ....................   Passed    2.18 sec
[04:41:57] :	 [Step 1/1]         Start 237: test_softmax_with_cross_entropy_op
[04:41:59] :	 [Step 1/1] 230/272 Test #235: test_cast_op ................................   Passed    2.68 sec
[04:41:59] :	 [Step 1/1] 231/272 Test #230: test_elementwise_div_op .....................   Passed    3.41 sec
[04:41:59] :	 [Step 1/1]         Start 238: test_dropout_op
[04:41:59] :	 [Step 1/1]         Start 239: test_softmax_op
[04:41:59] :	 [Step 1/1] 232/272 Test #232: test_elementwise_sub_op .....................   Passed    3.61 sec
[04:41:59] :	 [Step 1/1] 233/272 Test #231: test_elementwise_mul_op .....................   Passed    3.71 sec
[04:41:59] :	 [Step 1/1] 234/272 Test #223: test_seq_pool ...............................   Passed    6.34 sec
[04:41:59] :	 [Step 1/1]         Start 240: test_split_op
[04:41:59] :	 [Step 1/1]         Start 241: test_mul_op
[04:41:59] :	 [Step 1/1]         Start 242: test_conv_shift_op
[04:42:00] :	 [Step 1/1] 235/272 Test #236: test_fill_zeros_like_op .....................   Passed    2.79 sec
[04:42:00] :	 [Step 1/1] 236/272 Test #237: test_softmax_with_cross_entropy_op ..........   Passed    2.42 sec
[04:42:00] :	 [Step 1/1]         Start 243: test_dynamic_recurrent_op
[04:42:00] :	 [Step 1/1]         Start 244: test_cond_op
[04:42:01] :	 [Step 1/1] 237/272 Test #239: test_softmax_op .............................   Passed    2.21 sec
[04:42:01] :	 [Step 1/1] 238/272 Test #244: test_cond_op ................................   Passed    1.19 sec
[04:42:01] :	 [Step 1/1] 239/272 Test #243: test_dynamic_recurrent_op ...................   Passed    1.33 sec
[04:42:01] :	 [Step 1/1]         Start 245: test_op_support_gpu
[04:42:01] :	 [Step 1/1]         Start 246: test_proximal_gd_op
[04:42:01] :	 [Step 1/1]         Start 247: test_positive_negative_pair_op
[04:42:02] :	 [Step 1/1] 240/272 Test #240: test_split_op ...............................   Passed    2.57 sec
[04:42:02] :	 [Step 1/1]         Start 248: test_lod_array_length_op
[04:42:03] :	 [Step 1/1] 241/272 Test #242: test_conv_shift_op ..........................   Passed    2.88 sec
[04:42:03] :	 [Step 1/1] 242/272 Test #245: test_op_support_gpu .........................   Passed    1.24 sec
[04:42:03] :	 [Step 1/1]         Start 249: test_seq_concat_op
[04:42:03] :	 [Step 1/1]         Start 250: test_proximal_adagrad_op
[04:42:03] :	 [Step 1/1] 243/272 Test #247: test_positive_negative_pair_op ..............   Passed    1.74 sec
[04:42:03] :	 [Step 1/1] 244/272 Test #248: test_lod_array_length_op ....................   Passed    1.12 sec
[04:42:03] :	 [Step 1/1]         Start 251: test_squared_l2_norm_op
[04:42:03] :	 [Step 1/1]         Start 252: test_understand_sentiment_conv
[04:42:04] :	 [Step 1/1] 245/272 Test #246: test_proximal_gd_op .........................   Passed    2.26 sec
[04:42:04] :	 [Step 1/1] 246/272 Test #238: test_dropout_op .............................   Passed    5.11 sec
[04:42:04] :	 [Step 1/1]         Start 253: test_conv3d_transpose_op
[04:42:04] :	 [Step 1/1]         Start 254: test_framework_debug_str
[04:42:05] :	 [Step 1/1] 247/272 Test #249: test_seq_concat_op ..........................   Passed    1.73 sec
[04:42:05] :	 [Step 1/1]         Start 255: test_inference_model_io
[04:42:05] :	 [Step 1/1] 248/272 Test #254: test_framework_debug_str ....................   Passed    1.01 sec
[04:42:05] :	 [Step 1/1]         Start 256: test_recognize_digits_conv
[04:42:06] :	 [Step 1/1] 249/272 Test #250: test_proximal_adagrad_op ....................   Passed    2.76 sec
[04:42:06] :	 [Step 1/1] 250/272 Test #251: test_squared_l2_norm_op .....................   Passed    2.65 sec
[04:42:06] :	 [Step 1/1]         Start 257: test_conv2d_transpose_op
[04:42:06] :	 [Step 1/1]         Start 258: test_understand_sentiment_lstm
[04:42:07] :	 [Step 1/1] 251/272 Test #255: test_inference_model_io .....................   Passed    1.93 sec
[04:42:07] :	 [Step 1/1]         Start 259: test_crf_decoding_op
[04:42:10] :	 [Step 1/1] 252/272 Test #253: test_conv3d_transpose_op ....................   Passed    5.69 sec
[04:42:10] :	 [Step 1/1] 253/272 Test #259: test_crf_decoding_op ........................   Passed    2.95 sec
[04:42:10] :	 [Step 1/1]         Start 260: test_huber_loss_op
[04:42:10] :	 [Step 1/1]         Start 261: test_image_classification_layer
[04:42:12] :	 [Step 1/1] 254/272 Test #257: test_conv2d_transpose_op ....................   Passed    5.58 sec
[04:42:12] :	 [Step 1/1] 255/272 Test #261: test_image_classification_layer .............   Passed    2.12 sec
[04:42:12] :	 [Step 1/1]         Start 262: test_linear_chain_crf_op
[04:42:12] :	 [Step 1/1]         Start 263: test_lod_tensor_array
[04:42:14] :	 [Step 1/1] 256/272 Test #260: test_huber_loss_op ..........................   Passed    3.62 sec
[04:42:14] :	 [Step 1/1]         Start 264: test_precision_recall_op
[04:42:15] :	 [Step 1/1] 257/272 Test #263: test_lod_tensor_array .......................   Passed    2.61 sec
[04:42:15] :	 [Step 1/1] 258/272 Test #264: test_precision_recall_op ....................   Passed    1.22 sec
[04:42:15] :	 [Step 1/1]         Start 265: test_rnn_memory_helper_op
[04:42:15] :	 [Step 1/1]         Start 266: test_evaluator
[04:42:16] :	 [Step 1/1] 259/272 Test #265: test_rnn_memory_helper_op ...................   Passed    1.38 sec
[04:42:16] :	 [Step 1/1] 260/272 Test #262: test_linear_chain_crf_op ....................   Passed    4.40 sec
[04:42:16] :	 [Step 1/1]         Start 267: test_recommender_system
[04:42:16] :	 [Step 1/1]         Start 268: test_conv3d_op
[04:42:18] :	 [Step 1/1] 261/272 Test #266: test_evaluator ..............................   Passed    2.49 sec
[04:42:18] :	 [Step 1/1]         Start 269: test_fill_constant_batch_size_like_op
[04:42:23] :	 [Step 1/1] 262/272 Test #269: test_fill_constant_batch_size_like_op .......   Passed    4.25 sec
[04:42:23] :	 [Step 1/1]         Start 270: test_clip_by_norm_op
[04:42:28] :	 [Step 1/1] 263/272 Test #270: test_clip_by_norm_op ........................   Passed    5.21 sec
[04:42:28] :	 [Step 1/1]         Start 271: test_lod_tensor_array_ops
[04:42:30] :	 [Step 1/1] 264/272 Test #268: test_conv3d_op ..............................   Passed   13.19 sec
[04:42:30] :	 [Step 1/1]         Start 272: test_shrink_rnn_memory
[04:42:31] :	 [Step 1/1] 265/272 Test #271: test_lod_tensor_array_ops ...................   Passed    2.82 sec
[04:42:33] :	 [Step 1/1] 266/272 Test #272: test_shrink_rnn_memory ......................   Passed    2.49 sec
[04:42:37] :	 [Step 1/1] 267/272 Test #256: test_recognize_digits_conv ..................   Passed   31.34 sec
[04:42:49] :	 [Step 1/1] 268/272 Test #233: test_lstm_op ................................   Passed   53.56 sec
[04:43:25] :	 [Step 1/1] 269/272 Test #252: test_understand_sentiment_conv ..............   Passed   81.26 sec
[04:43:25] :	 [Step 1/1] 270/272 Test #258: test_understand_sentiment_lstm ..............   Passed   79.02 sec
[04:43:28] :	 [Step 1/1] 271/272 Test #241: test_mul_op .................................   Passed   88.67 sec
[04:43:38] :	 [Step 1/1] 272/272 Test #267: test_recommender_system .....................   Passed   81.77 sec
[04:43:38] :	 [Step 1/1] 
[04:43:38] :	 [Step 1/1] 100% tests passed, 0 tests failed out of 272
[04:43:38] :	 [Step 1/1] 
[04:43:38] :	 [Step 1/1] Total Test time (real) = 235.37 sec

chengduoZH · 2017-11-10T07:09:45Z

@luotao1
1、可以将时间从大到小排序，命令：

cat ~/Downloads/Paddle_PR_CI_7559.log | awk '{split($0,a,"Passed");split(a[1],b,": "); if(match(b[2],".") && match(a[2]," "))  print b[2],a[2]} ' | sort -k 3 -r

2、数据是从teamcity上得到的，我是把log下载了下来，在命令里面有的Paddle_PR_CI_7559.log

luotao1 · 2017-11-10T07:29:14Z

两个log的差异特别大。

chengduoZH · 2017-11-10T07:44:44Z

我运行代码不是最新的。下面这个应该是最新的：

test_mul_op .................................       88.67 sec
test_recommender_system .....................       81.77 sec
test_understand_sentiment_conv ..............       81.26 sec
test_understand_sentiment_lstm ..............       79.02 sec
test_CompareSparse ..........................       61.38 sec
test_CompareTwoNets .........................       56.80 sec
test_lstm_op ................................       53.56 sec
test_ParameterServer2 .......................       40.33 sec
test_layerHelpers ...........................       36.68 sec
master_test .................................       33.79 sec
test_image_classification_train .............       31.60 sec
test_recognize_digits_conv ..................       31.34 sec
test_TrainerOnePass .........................       29.48 sec
test_seq_conv ...............................       29.13 sec
test_RecurrentLayer .........................       26.72 sec
test_ProtoServer ............................       26.15 sec
test_CustomStackTrace .......................       22.69 sec
test_StringUtils ............................       21.38 sec
test_LayerGrad ..............................       20.45 sec
test_PyDataProvider2 ........................       20.42 sec
test_CustomStackTracePrint ..................       16.80 sec
test_RowBuffer ..............................       13.59 sec
test_conv3d_op ..............................       13.19 sec
test_MKLDNN .................................       11.33 sec
test_RecurrentGradientMachine ...............       10.46 sec
test_TrainingAlgorithm ......................        9.77 sec
math_function_gpu_test ......................        9.43 sec
test_matmul_op ..............................        8.47 sec
test_BaseMatrix .............................        8.38 sec
pserver_client_test .........................        8.24 sec
test_Matrix .................................        8.08 sec
Im2ColTest ..................................        7.97 sec
DepthwiseConvOpTest .........................        7.77 sec
testTrainer .................................        7.59 sec
test_ProtoDataProvider ......................        7.46 sec
test_matrixCompare ..........................        7.36 sec
test_seq_pool ...............................        6.34 sec
testTrain ...................................        5.86 sec
test_conv3d_transpose_op ....................        5.69 sec
test_conv2d_transpose_op ....................        5.58 sec
test_paramconf_order ........................        5.45 sec
test_clip_by_norm_op ........................        5.21 sec
test_dropout_op .............................        5.11 sec
test_minus_op ...............................        5.10 sec
test_Evaluator ..............................        4.98 sec
socket_test .................................        4.94 sec
test_conv2d_op ..............................        4.83 sec
test_pool3d_op ..............................        4.82 sec
test_prelu_op ...............................        4.66 sec
test_sum_op .................................        4.44 sec
test_adamax_op ..............................        4.41 sec
test_linear_chain_crf_op ....................        4.40 sec
test_activation_op ..........................        4.29 sec
test_fill_constant_batch_size_like_op .......        4.25 sec
test_pad_op .................................        4.18 sec
test_gather_op ..............................        4.16 sec
test_pool2d_op ..............................        4.10 sec
test_pool_max_op ............................        3.95 sec
test_rmsprop_op .............................        3.93 sec
test_smooth_l1_loss_op ......................        3.81 sec
test_gru_op .................................        3.74 sec
test_elementwise_mul_op .....................        3.71 sec
test_huber_loss_op ..........................        3.62 sec
test_elementwise_sub_op .....................        3.61 sec
test_NetworkCompare .........................        3.57 sec
test_gaussian_random_op .....................        3.56 sec
test_BatchNorm ..............................        3.52 sec
test_crop_op ................................        3.45 sec
test_elementwise_div_op .....................        3.41 sec
test_clip_op ................................        3.38 sec
test_cos_sim_op .............................        3.37 sec
test_l1_norm_op .............................        3.36 sec
test_adadelta_op ............................        3.36 sec
test_KmaxSeqScore ...........................        3.36 sec
test_common .................................        3.35 sec
GemmConvOpTest ..............................        3.34 sec
PadOpTest ...................................        3.31 sec
test_WarpCTCLayer ...........................        3.30 sec
test_mean_op ................................        3.22 sec
test_PyDataProvider .........................        3.19 sec
test_batch_norm_op ..........................        3.13 sec
test_sparseMatrixCompare ....................        3.04 sec
test_transpose_op ...........................        3.01 sec
test_sequence_softmax_op ....................        3.01 sec
decorator_test ..............................        3.01 sec
RowConvOpTest ...............................        3.01 sec
test_seq_expand .............................        2.96 sec
test_crf_decoding_op ........................        2.95 sec
test_conv_shift_op ..........................        2.88 sec
test_Expand .................................        2.87 sec
test_accuracy_op ............................        2.86 sec
test_lod_tensor_array_ops ...................        2.82 sec
test_image ..................................        2.82 sec
ContextProjectionOpTest .....................        2.82 sec
test_momentum_op ............................        2.79 sec
test_fill_zeros_like_op .....................        2.79 sec
test_reduce_op ..............................        2.77 sec
test_rank_loss_op ...........................        2.76 sec
test_proximal_adagrad_op ....................        2.76 sec
test_elementwise_add_op .....................        2.71 sec
test_recognize_digits_mlp ...................        2.70 sec
device_context_test .........................        2.69 sec
test_compare_op .............................        2.68 sec
test_cast_op ................................        2.68 sec
test_squared_l2_norm_op .....................        2.65 sec
test_ConvTrans ..............................        2.65 sec
test_squared_l2_distance_op .................        2.64 sec
test_lod_tensor_array .......................        2.61 sec
CropOpTest ..................................        2.61 sec
TensorShapeTest .............................        2.60 sec
test_data_feeder ............................        2.59 sec
test_adam_op ................................        2.59 sec
test_top_k_op ...............................        2.58 sec
test_split_op ...............................        2.57 sec
test_reshape_op .............................        2.55 sec
test_fit_a_line .............................        2.55 sec
test_op .....................................        2.52 sec
test_CRFLayerGrad ...........................        2.52 sec
test_ploter .................................        2.51 sec
test_shrink_rnn_memory ......................        2.49 sec
test_evaluator ..............................        2.49 sec
test_lookup_table_op ........................        2.48 sec
test_ThreadBarrier ..........................        2.44 sec
test_softmax_with_cross_entropy_op ..........        2.42 sec
test_sgd_op .................................        2.42 sec
test_concat_op ..............................        2.42 sec
test_CompareTwoOpts .........................        2.42 sec
test_recurrent_machine_generation ...........        2.41 sec
CrossMapNormalOpTest ........................        2.40 sec
test_ConvUnify ..............................        2.36 sec
test_cross_entropy_op .......................        2.35 sec
transform_test ..............................        2.34 sec
test_word2vec ...............................        2.34 sec
testGradientMachine .........................        2.32 sec
ScaleSubRegionOpTest ........................        2.31 sec
test_adagrad_op .............................        2.30 sec
BufferArgTest ...............................        2.30 sec
test_DetectionOutput ........................        2.27 sec
test_proximal_gd_op .........................        2.26 sec
test_SeqSliceLayerGrad ......................        2.25 sec
test_scale_op ...............................        2.24 sec
test_softmax_op .............................        2.21 sec
pserver_test ................................        2.21 sec
test_scatter_op .............................        2.20 sec
test_fill_constant_op .......................        2.19 sec
test_parameters .............................        2.18 sec
test_multiplex_op ...........................        2.18 sec
test_margin_rank_loss_op ....................        2.18 sec
test_PyDataProviderWrapper ..................        2.17 sec
selected_rows_functor_gpu_test ..............        2.16 sec
test_uniform_random_op ......................        2.13 sec
test_decayed_adagrad_op .....................        2.13 sec
test_argument ...............................        2.13 sec
tensor_test .................................        2.13 sec
test_image_classification_layer .............        2.12 sec
test_scope ..................................        2.10 sec
test_sign_op ................................        2.04 sec
test_SpinLock ...............................        2.03 sec
testMatrix ..................................        2.02 sec
test_operator_desc ..........................        2.01 sec
MulOpTest ...................................        2.01 sec
CosSimOpTest ................................        2.01 sec
test_selected_rows ..........................        2.00 sec
test_inference_model_io .....................        1.93 sec
creator_test ................................        1.93 sec
strided_memcpy_test .........................        1.91 sec
test_gru_unit_op ............................        1.85 sec
test_optimizer ..............................        1.84 sec
test_rnn_layer ..............................        1.83 sec
test_ActivationGrad .........................        1.83 sec
test_MultinomialSampler .....................        1.82 sec
test_GpuProfiler ............................        1.81 sec
test_CrossEntropyOverBeamGrad ...............        1.81 sec
test_Compare ................................        1.81 sec
BlockExpandOpTest ...........................        1.81 sec
test_ExecViaCpu .............................        1.80 sec
test_lrn_op .................................        1.78 sec
test_PriorBox ...............................        1.75 sec
test_positive_negative_pair_op ..............        1.74 sec
test_modified_huber_loss_op .................        1.74 sec
test_seq_concat_op ..........................        1.73 sec
test_layer ..................................        1.72 sec
test_Thread .................................        1.71 sec
network_helper_test .........................        1.71 sec
test_tensor .................................        1.64 sec
test_topology ...............................        1.63 sec
test_tensor_array ...........................        1.63 sec
test_lod_rank_table .........................        1.62 sec
test_recurrent_op ...........................        1.61 sec
test_Trainer ................................        1.61 sec
FunctionTest ................................        1.61 sec
test_feed_fetch_method ......................        1.59 sec
test_auc_op .................................        1.57 sec
test_default_scope_funcs ....................        1.52 sec
TensorTypeTest ..............................        1.50 sec
SwitchOpTest ................................        1.50 sec
testVector ..................................        1.49 sec
test_SIMDFlags ..............................        1.41 sec
test_perturbation ...........................        1.40 sec
test_CpuGpuVector ...........................        1.40 sec
test_rnn_memory_helper_op ...................        1.38 sec
test_net ....................................        1.37 sec
test_variable ...............................        1.34 sec
test_executor_and_mul .......................        1.33 sec
test_dynamic_recurrent_op ...................        1.33 sec
test_initializer ............................        1.32 sec
vol2col_test ................................        1.31 sec
save_load_op_test ...........................        1.31 sec
test_FPException ............................        1.30 sec
test_Allocator ..............................        1.30 sec
test_infer_shape ............................        1.29 sec
test_lstm_unit_op ...........................        1.27 sec
test_op_support_gpu .........................        1.24 sec
test_precision_recall_op ....................        1.22 sec
test_LinearChainCRF .........................        1.21 sec
test_SIMDFunctions ..........................        1.20 sec
test_Error ..................................        1.20 sec
im2col_test .................................        1.20 sec
test_cond_op ................................        1.19 sec
test_protobuf_descs .........................        1.16 sec
test_regularizer ............................        1.13 sec
test_lod_array_length_op ....................        1.12 sec
test_sigmoid_cross_entropy_with_logits_op ...        1.11 sec
test_operator ...............................        1.11 sec
test_SparseMatrix ...........................        1.11 sec
test_program ................................        1.08 sec
test_exception ..............................        1.04 sec
test_layers .................................        1.01 sec
test_framework_debug_str ....................        1.01 sec
test_protobuf ...............................        0.94 sec
lod_tensor_test .............................        0.92 sec
test_array_read_write_op ....................        0.91 sec
test_parameter ..............................        0.86 sec
test_nccl_init_op ...........................        0.86 sec
memory_test .................................        0.80 sec
testArguments ...............................        0.72 sec
lod_tensor_gpu_test .........................        0.71 sec
dim_test ....................................        0.71 sec
to_string_test ..............................        0.70 sec
selected_rows_functor_test ..................        0.66 sec
serialization_test ..........................        0.61 sec
layers_test .................................        0.61 sec
system_allocator_test .......................        0.60 sec
stringpiece_test ............................        0.60 sec
place_test ..................................        0.60 sec
math_function_test ..........................        0.60 sec
eigen_test ..................................        0.60 sec
net_op_test .................................        0.56 sec
gather_test .................................        0.56 sec
variable_test ...............................        0.50 sec
var_type_inference_test .....................        0.50 sec
test_reset_hook .............................        0.50 sec
tensor_array_test ...........................        0.50 sec
scope_test ..................................        0.50 sec
program_desc_test ...........................        0.50 sec
op_registry_test ............................        0.50 sec
dynamic_recurrent_op_test ...................        0.50 sec
backward_test ...............................        0.50 sec
enforce_test ................................        0.31 sec
stringprintf_test ...........................        0.30 sec
cpu_info_test ...............................        0.30 sec
selected_rows_test ..........................        0.26 sec
cudnn_helper_test ...........................        0.23 sec
parameter_optimizer_test ....................        0.21 sec
nccl_op_test ................................        0.21 sec
scatter_test ................................        0.20 sec
prune_test ..................................        0.20 sec
operator_test ...............................        0.20 sec
op_proto_maker_test .........................        0.20 sec
test_config_parser ..........................        0.17 sec
nccl_test ...................................        0.12 sec
ddim_test ...................................        0.10 sec

chengduoZH · 2018-04-27T11:11:44Z

该问题已暂时得以缓解，该issue可以先关闭了

chengduoZH closed this as completed Apr 27, 2018

Provide feedback

Saved searches

Use saved searches to filter your results more quickly

Too slow unit test #5342

Too slow unit test #5342

wangkuiyi commented Nov 3, 2017

chengduoZH commented Nov 10, 2017

luotao1 commented Nov 10, 2017

luotao1 commented Nov 10, 2017

chengduoZH commented Nov 10, 2017

luotao1 commented Nov 10, 2017

chengduoZH commented Nov 10, 2017

chengduoZH commented Apr 27, 2018

Too slow unit test #5342

Too slow unit test #5342

Comments

wangkuiyi commented Nov 3, 2017

chengduoZH commented Nov 10, 2017

luotao1 commented Nov 10, 2017

luotao1 commented Nov 10, 2017

chengduoZH commented Nov 10, 2017

luotao1 commented Nov 10, 2017

chengduoZH commented Nov 10, 2017

chengduoZH commented Apr 27, 2018