[2022-01-12 09:31:15.528992] INFO: moduleinvoker: input_features.v1 开始运行..
[2022-01-12 09:31:15.608466] INFO: moduleinvoker: input_features.v1 运行完成[0.079518s].
[2022-01-12 09:31:15.627050] INFO: moduleinvoker: factorlens.v2 开始运行..
[2022-01-12 09:31:15.780651] INFO: 因子分析: batch_process start
[2022-01-12 09:31:15.783303] INFO: 因子分析: load_instruments 2021-01-01, 2022-01-10
[2022-01-12 09:31:16.549989] INFO: 因子分析: load_instruments, 4711 rows.
[2022-01-12 09:31:16.552820] INFO: 因子分析: load_benchmark_data 2021-01-01, 2022-01-10
[2022-01-12 09:31:16.661891] INFO: 因子分析: load_benchmark_data, 744 rows.
[2022-01-12 09:31:16.662995] INFO: 因子分析: StockPool.before_load_general_feature_data
[2022-01-12 09:31:16.663671] INFO: 因子分析: UserDataMerge.before_load_general_feature_data
[2022-01-12 09:31:16.665216] INFO: 因子分析: DropSTStocks.before_load_general_feature_data
[2022-01-12 09:31:16.666460] INFO: 因子分析: DropNewStocks.before_load_general_feature_data
[2022-01-12 09:31:16.667209] INFO: 因子分析: Neutralization.before_load_general_feature_data
[2022-01-12 09:31:16.668845] INFO: 因子分析: DelayRebalanceDays.before_load_general_feature_data
[2022-01-12 09:31:16.670411] INFO: 因子分析: RebalancePeriod.before_load_general_feature_data
[2022-01-12 09:31:16.671545] INFO: 因子分析: RebalancePrice.before_load_general_feature_data
[2022-01-12 09:31:16.672608] INFO: 因子分析: FactorCoverage.before_load_general_feature_data
[2022-01-12 09:31:16.673224] INFO: 因子分析: Industry.before_load_general_feature_data
[2022-01-12 09:31:16.674573] INFO: 因子分析: PBRatio.before_load_general_feature_data
[2022-01-12 09:31:16.675972] INFO: 因子分析: Turnover.before_load_general_feature_data
[2022-01-12 09:31:16.676909] INFO: 因子分析: MarketCap.before_load_general_feature_data
[2022-01-12 09:31:16.678363] INFO: 因子分析: load_general_feature_data, load data
[2022-01-12 09:32:06.581572] INFO: 因子分析: RebalancePeriod.after_load_general_feature_data
[2022-01-12 09:32:06.676391] INFO: 因子分析: RebalancePeriodsReturns.after_load_general_feature_data
[2022-01-12 09:32:39.570769] INFO: 因子分析: RebalancePrice.after_load_general_feature_data
[2022-01-12 09:32:39.573233] INFO: 因子分析: load_general_feature_data, 2029665 rows.
[2022-01-12 09:32:39.576100] INFO: 因子分析: load_derived_feature_data, 2029665 rows, 24 columns.
[2022-01-12 09:32:39.577695] INFO: 因子分析: process, pe_ttm_0
[2022-01-12 09:32:39.579496] INFO: 因子分析: calculate_factor, pe_ttm_0
[2022-01-12 09:32:39.882482] INFO: 因子分析: calculate_factor, done
[2022-01-12 09:32:40.022554] INFO: 因子分析: QuantileReturns.before_process
[2022-01-12 09:32:40.025008] INFO: 因子分析: IC.before_process
[2022-01-12 09:32:40.027015] INFO: 因子分析: BasicDescription.before_process
[2022-01-12 09:32:40.028730] INFO: 因子分析: Industry.before_process
[2022-01-12 09:32:40.030727] INFO: 因子分析: RebalanceOverlap.before_process
[2022-01-12 09:32:40.032306] INFO: 因子分析: PBRatio.before_process
[2022-01-12 09:32:40.034183] INFO: 因子分析: Turnover.before_process
[2022-01-12 09:32:40.036617] INFO: 因子分析: Stocks.before_process
[2022-01-12 09:32:40.038237] INFO: 因子分析: MarketCap.before_process
[2022-01-12 09:32:40.040151] INFO: 因子分析: FactorValue.before_process
[2022-01-12 09:32:40.041745] INFO: 因子分析: FactorPairwiseCorrelationMerged.before_process
[2022-01-12 09:32:40.064293] INFO: 因子分析: process metrics, start ..
[2022-01-12 09:32:40.276564] INFO: 因子分析: process, 1014169/1084895 rows ..
[2022-01-12 09:32:40.278145] INFO: 因子分析: BacktestInterval.process, 0.000s
[2022-01-12 09:32:40.279401] INFO: 因子分析: Benchmark.process, 0.000s
[2022-01-12 09:32:40.280611] INFO: 因子分析: StockPool.process, 0.000s
[2022-01-12 09:32:40.281762] INFO: 因子分析: UserDataMerge.process, 0.000s
[2022-01-12 09:32:40.282924] INFO: 因子分析: DropSTStocks.process, 0.000s
[2022-01-12 09:32:40.284085] INFO: 因子分析: DropPriceLimitStocks.process, 0.000s
[2022-01-12 09:32:40.285243] INFO: 因子分析: DropNewStocks.process, 0.000s
[2022-01-12 09:32:40.286399] INFO: 因子分析: DropSuspendedStocks.process, 0.000s
[2022-01-12 09:32:40.287405] INFO: 因子分析: QuantileCount.process, 0.000s
[2022-01-12 09:32:40.288671] INFO: 因子分析: CommissionRates.process, 0.000s
[2022-01-12 09:32:40.885695] INFO: 因子分析: Cutoutliers.process, 0.596s
[2022-01-12 09:32:41.279758] INFO: 因子分析: Normalization.process, 0.393s
[2022-01-12 09:32:41.901584] INFO: 因子分析: Neutralization.process, 0.620s
[2022-01-12 09:32:41.903144] INFO: 因子分析: DelayRebalanceDays.process, 0.000s
[2022-01-12 09:33:21.585721] INFO: 因子分析: RebalancePeriod.process, 39.681s
[2022-01-12 09:33:21.587361] INFO: 因子分析: RebalancePeriodsReturns.process, 0.000s
[2022-01-12 09:33:21.588399] INFO: 因子分析: RebalancePrice.process, 0.000s
[2022-01-12 09:33:21.589404] INFO: 因子分析: ReturnsCalculationMethod.process, 0.000s
[2022-01-12 09:33:21.590345] INFO: 因子分析: FactorCoverage.process, 0.000s
[2022-01-12 09:33:21.697444] INFO: 因子分析: QuantileReturns.process, 0.106s
[2022-01-12 09:33:23.321579] INFO: 因子分析: IC.process, 1.621s
[2022-01-12 09:33:23.434415] INFO: 因子分析: BasicDescription.process, 0.111s
[2022-01-12 09:33:23.976354] INFO: 因子分析: Industry.process, 0.540s
[2022-01-12 09:33:24.295047] INFO: 因子分析: RebalanceOverlap.process, 0.317s
[2022-01-12 09:33:24.411892] INFO: 因子分析: PBRatio.process, 0.115s
[2022-01-12 09:33:24.483598] INFO: 因子分析: Turnover.process, 0.069s
[2022-01-12 09:33:24.512582] INFO: 因子分析: Stocks.process, 0.028s
[2022-01-12 09:33:24.788985] INFO: 因子分析: MarketCap.process, 0.274s
[2022-01-12 09:33:24.935141] INFO: 因子分析: FactorValue.process, 0.144s
[2022-01-12 09:33:25.018321] INFO: 因子分析: process metrics, 44.954s
[2022-01-12 09:33:25.033962] INFO: 因子分析: QuantileReturns.after_process
[2022-01-12 09:33:25.035493] INFO: 因子分析: IC.after_process
[2022-01-12 09:33:25.037032] INFO: 因子分析: BasicDescription.after_process
[2022-01-12 09:33:25.039024] INFO: 因子分析: Industry.after_process
[2022-01-12 09:33:25.040576] INFO: 因子分析: RebalanceOverlap.after_process
[2022-01-12 09:33:25.042621] INFO: 因子分析: PBRatio.after_process
[2022-01-12 09:33:25.044301] INFO: 因子分析: Turnover.after_process
[2022-01-12 09:33:25.046109] INFO: 因子分析: Stocks.after_process
[2022-01-12 09:33:25.047698] INFO: 因子分析: MarketCap.after_process
[2022-01-12 09:33:25.049390] INFO: 因子分析: FactorValue.after_process
[2022-01-12 09:33:25.050869] INFO: 因子分析: FactorPairwiseCorrelationMerged.after_process
[2022-01-12 09:33:25.052826] INFO: 因子分析: process, (pe_ttm_0-all_quantile(pe_ttm_0, 0))/(all_quantile(pe_ttm_0, 1)-all_quantile(pe_ttm_0, 0))
[2022-01-12 09:33:25.054371] INFO: 因子分析: calculate_factor, (pe_ttm_0-all_quantile(pe_ttm_0, 0))/(all_quantile(pe_ttm_0, 1)-all_quantile(pe_ttm_0, 0))
[2022-01-12 09:33:25.292759] INFO: 因子分析: calculate_factor, done
[2022-01-12 09:33:25.437421] INFO: 因子分析: QuantileReturns.before_process
[2022-01-12 09:33:25.439745] INFO: 因子分析: IC.before_process
[2022-01-12 09:33:25.440955] INFO: 因子分析: BasicDescription.before_process
[2022-01-12 09:33:25.441946] INFO: 因子分析: Industry.before_process
[2022-01-12 09:33:25.443151] INFO: 因子分析: RebalanceOverlap.before_process
[2022-01-12 09:33:25.444199] INFO: 因子分析: PBRatio.before_process
[2022-01-12 09:33:25.445203] INFO: 因子分析: Turnover.before_process
[2022-01-12 09:33:25.446321] INFO: 因子分析: Stocks.before_process
[2022-01-12 09:33:25.449251] INFO: 因子分析: MarketCap.before_process
[2022-01-12 09:33:25.450938] INFO: 因子分析: FactorValue.before_process
[2022-01-12 09:33:25.452816] INFO: 因子分析: FactorPairwiseCorrelationMerged.before_process
[2022-01-12 09:33:25.477676] INFO: 因子分析: process metrics, start ..
[2022-01-12 09:33:25.667313] INFO: 因子分析: process, 1014169/1084895 rows ..
[2022-01-12 09:33:25.669253] INFO: 因子分析: BacktestInterval.process, 0.000s
[2022-01-12 09:33:25.670761] INFO: 因子分析: Benchmark.process, 0.000s
[2022-01-12 09:33:25.672132] INFO: 因子分析: StockPool.process, 0.000s
[2022-01-12 09:33:25.673518] INFO: 因子分析: UserDataMerge.process, 0.000s
[2022-01-12 09:33:25.674883] INFO: 因子分析: DropSTStocks.process, 0.000s
[2022-01-12 09:33:25.676256] INFO: 因子分析: DropPriceLimitStocks.process, 0.000s
[2022-01-12 09:33:25.677524] INFO: 因子分析: DropNewStocks.process, 0.000s
[2022-01-12 09:33:25.678774] INFO: 因子分析: DropSuspendedStocks.process, 0.000s
[2022-01-12 09:33:25.680177] INFO: 因子分析: QuantileCount.process, 0.000s
[2022-01-12 09:33:25.681556] INFO: 因子分析: CommissionRates.process, 0.000s
[2022-01-12 09:33:26.224912] INFO: 因子分析: Cutoutliers.process, 0.542s
[2022-01-12 09:33:26.593834] INFO: 因子分析: Normalization.process, 0.367s
[2022-01-12 09:33:27.230548] INFO: 因子分析: Neutralization.process, 0.634s
[2022-01-12 09:33:27.232791] INFO: 因子分析: DelayRebalanceDays.process, 0.000s
[2022-01-12 09:34:04.897250] INFO: 因子分析: RebalancePeriod.process, 37.662s
[2022-01-12 09:34:04.899496] INFO: 因子分析: RebalancePeriodsReturns.process, 0.000s
[2022-01-12 09:34:04.901207] INFO: 因子分析: RebalancePrice.process, 0.000s
[2022-01-12 09:34:04.903398] INFO: 因子分析: ReturnsCalculationMethod.process, 0.000s
[2022-01-12 09:34:04.905462] INFO: 因子分析: FactorCoverage.process, 0.000s
[2022-01-12 09:34:04.982701] ERROR: moduleinvoker: module name: factorlens, module version: v2, trackeback: KeyError: "['ADJUSTED_BENCHMARK_RETURN_0'] not in index"