[2022-05-17 09:57:00.431434] INFO: cached.v2.979c6faa: [2022-05-17 09:56:54.176391] INFO derived_feature_extractor: 提取完成 bm_0 = where(close/shift(close,5)-1[2022-05-17 09:57:00.434906] INFO: cached.v2.979c6faa: [2022-05-17 09:56:54.228947] INFO derived_feature_extractor: /data, 311
[2022-05-17 09:57:00.433880] INFO: cached.v2.9785fad6: [2022-05-17 09:56:55.744796] INFO moduleinvoker: dropnan.v1 开始运行..
[2022-05-17 09:57:00.438262] INFO: cached.v2.979c6faa: [2022-05-17 09:56:54.308918] INFO moduleinvoker: derived_feature_extractor.v3 运行完成[0.17888s].
[2022-05-17 09:57:00.437341] INFO: cached.v2.9785fad6: [2022-05-17 09:56:55.751733] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:00.441901] INFO: cached.v2.9785fad6: [2022-05-17 09:56:55.752131] INFO moduleinvoker: dropnan.v1 运行完成[0.007406s].
[2022-05-17 09:57:00.440849] INFO: cached.v2.979c6faa: [2022-05-17 09:56:54.639500] INFO moduleinvoker: index_feature_extract.v3 运行完成[0.650734s].
[2022-05-17 09:57:00.444259] INFO: cached.v2.9785fad6: [2022-05-17 09:56:55.771664] INFO moduleinvoker: join.v3 开始运行..
[2022-05-17 09:57:00.445101] INFO: cached.v2.979c6faa: [2022-05-17 09:56:54.656479] INFO moduleinvoker: general_feature_extractor.v7 开始运行..
[2022-05-17 09:57:00.446922] INFO: cached.v2.9785fad6: [2022-05-17 09:56:55.800149] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:00.447953] INFO: cached.v2.979c6faa: [2022-05-17 09:56:54.665726] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:00.450345] INFO: cached.v2.9785fad6: [2022-05-17 09:56:55.800571] INFO moduleinvoker: join.v3 运行完成[0.028975s].
[2022-05-17 09:57:00.451521] INFO: cached.v2.979c6faa: [2022-05-17 09:56:54.666111] INFO moduleinvoker: general_feature_extractor.v7 运行完成[0.009776s].
[2022-05-17 09:57:00.453830] INFO: cached.v2.9785fad6: [2022-05-17 09:56:55.818530] INFO moduleinvoker: chinaa_stock_filter.v1 开始运行..
[2022-05-17 09:57:00.455441] INFO: cached.v2.979c6faa: [2022-05-17 09:56:54.681556] INFO moduleinvoker: general_feature_extractor.v7 开始运行..
[2022-05-17 09:57:00.457083] INFO: cached.v2.9785fad6: [2022-05-17 09:56:55.835859] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:00.458835] INFO: cached.v2.979c6faa: [2022-05-17 09:56:57.391343] INFO 基础特征抽取: 年份 2015, 特征行数=108655
[2022-05-17 09:57:00.460422] INFO: cached.v2.9785fad6: [2022-05-17 09:56:55.836518] INFO moduleinvoker: chinaa_stock_filter.v1 运行完成[0.018376s].
[2022-05-17 09:57:00.462553] INFO: cached.v2.9785fad6: [2022-05-17 09:56:55.853724] INFO moduleinvoker: dropnan.v1 开始运行..
[2022-05-17 09:57:00.463918] INFO: cached.v2.9785fad6: [2022-05-17 09:56:55.864253] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:00.465314] INFO: cached.v2.9785fad6: [2022-05-17 09:56:55.864710] INFO moduleinvoker: dropnan.v1 运行完成[0.011028s].
[2022-05-17 09:57:00.466757] INFO: cached.v2.9785fad6: [2022-05-17 09:56:55.894546] INFO moduleinvoker: select_columns.v3 开始运行..
[2022-05-17 09:57:00.468097] INFO: cached.v2.9785fad6: [2022-05-17 09:56:55.905307] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:00.469420] INFO: cached.v2.9785fad6: [2022-05-17 09:56:55.905716] INFO moduleinvoker: select_columns.v3 运行完成[0.01126s].
[2022-05-17 09:57:00.470517] INFO: cached.v2.9785fad6: [2022-05-17 09:56:55.920966] INFO moduleinvoker: chinaa_stock_filter.v1 开始运行..
[2022-05-17 09:57:00.471660] INFO: cached.v2.9785fad6: [2022-05-17 09:56:55.935105] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:00.472848] INFO: cached.v2.9785fad6: [2022-05-17 09:56:55.935686] INFO moduleinvoker: chinaa_stock_filter.v1 运行完成[0.014805s].
[2022-05-17 09:57:00.474056] INFO: cached.v2.9785fad6: [2022-05-17 09:56:55.952929] INFO moduleinvoker: stock_ranker_train.v6 开始运行..
[2022-05-17 09:57:00.475387] INFO: cached.v2.9785fad6: [2022-05-17 09:56:55.965160] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:00.476788] INFO: cached.v2.9785fad6:
[2022-05-17 09:57:00.478153] INFO: cached.v2.9785fad6: [2022-05-17 09:56:56.123534] INFO moduleinvoker: stock_ranker_train.v6 运行完成[0.170588s].
[2022-05-17 09:57:00.479536] INFO: cached.v2.9785fad6: [2022-05-17 09:56:56.139032] INFO moduleinvoker: stock_ranker_predict.v5 开始运行..
[2022-05-17 09:57:00.481129] INFO: cached.v2.9785fad6: [2022-05-17 09:56:56.148908] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:00.482649] INFO: cached.v2.9785fad6: [2022-05-17 09:56:56.149959] INFO moduleinvoker: stock_ranker_predict.v5 运行完成[0.010966s].
[2022-05-17 09:57:00.484142] INFO: cached.v2.9785fad6: [2022-05-17 09:56:56.160578] INFO moduleinvoker: join.v3 开始运行..
[2022-05-17 09:57:00.485636] INFO: cached.v2.9785fad6: [2022-05-17 09:56:56.170813] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:00.487119] INFO: cached.v2.9785fad6: [2022-05-17 09:56:56.171188] INFO moduleinvoker: join.v3 运行完成[0.010723s].
[2022-05-17 09:57:00.488619] INFO: cached.v2.9785fad6: [2022-05-17 09:56:56.182931] INFO moduleinvoker: join.v3 开始运行..
[2022-05-17 09:57:00.490117] INFO: cached.v2.9785fad6: [2022-05-17 09:56:56.199418] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:00.491619] INFO: cached.v2.9785fad6: [2022-05-17 09:56:56.199793] INFO moduleinvoker: join.v3 运行完成[0.01698s].
[2022-05-17 09:57:00.493107] INFO: cached.v2.9785fad6: [2022-05-17 09:56:56.207126] INFO moduleinvoker: sort.v4 开始运行..
[2022-05-17 09:57:00.494593] INFO: cached.v2.9785fad6: [2022-05-17 09:56:56.214010] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:00.496071] INFO: cached.v2.9785fad6: [2022-05-17 09:56:56.214402] INFO moduleinvoker: sort.v4 运行完成[0.007337s].
[2022-05-17 09:57:00.497652] INFO: cached.v2.9785fad6: [2022-05-17 09:56:58.157537] INFO moduleinvoker: backtest.v8 开始运行..
[2022-05-17 09:57:00.498964] INFO: cached.v2.9785fad6: [2022-05-17 09:56:58.161878] INFO backtest: biglearning backtest:V8.6.2
[2022-05-17 09:57:00.500759] INFO: cached.v2.9785fad6: [2022-05-17 09:56:58.161988] INFO backtest: product_type:stock by specified
[2022-05-17 09:57:00.502555] INFO: cached.v2.9785fad6: [2022-05-17 09:56:58.265029] INFO moduleinvoker: cached.v2 开始运行..
[2022-05-17 09:57:00.504188] INFO: cached.v2.9785fad6: [2022-05-17 09:56:58.274552] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:00.505875] INFO: cached.v2.9785fad6: [2022-05-17 09:56:58.274944] INFO moduleinvoker: cached.v2 运行完成[0.010034s].
[2022-05-17 09:57:00.507700] INFO: cached.v2.9785fad6: [2022-05-17 09:57:00.160400] INFO algo: TradingAlgorithm V1.8.7
[2022-05-17 09:57:09.802104] INFO: cached.v2.9776956e: {'m1.start_date': '2018-01-01', 'm1.end_date': '2020-12-31', 'm9.start_date': '2021-01-01', 'm9.end_date': '2021-12-31'}
[2022-05-17 09:57:09.804525] INFO: cached.v2.9776956e: [2022-05-17 09:57:05.672025] INFO moduleinvoker: instruments.v2 开始运行..
[2022-05-17 09:57:09.807497] INFO: cached.v2.9776956e: [2022-05-17 09:57:05.680162] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:09.809159] INFO: cached.v2.9776956e: [2022-05-17 09:57:05.680585] INFO moduleinvoker: instruments.v2 运行完成[0.008709s].
[2022-05-17 09:57:09.811060] INFO: cached.v2.9776956e: [2022-05-17 09:57:05.685145] INFO moduleinvoker: input_features.v1 开始运行..
[2022-05-17 09:57:09.813601] INFO: cached.v2.9776956e: [2022-05-17 09:57:05.691299] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:09.815545] INFO: cached.v2.9776956e: [2022-05-17 09:57:05.691671] INFO moduleinvoker: input_features.v1 运行完成[0.00662s].
[2022-05-17 09:57:09.817053] INFO: cached.v2.9776956e: [2022-05-17 09:57:05.696298] INFO moduleinvoker: instruments.v2 开始运行..
[2022-05-17 09:57:09.818555] INFO: cached.v2.9776956e: [2022-05-17 09:57:05.704333] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:09.821477] INFO: cached.v2.9776956e: [2022-05-17 09:57:05.704841] INFO moduleinvoker: instruments.v2 运行完成[0.008629s].
[2022-05-17 09:57:09.826572] INFO: cached.v2.9776956e: [2022-05-17 09:57:05.709632] INFO moduleinvoker: input_features.v1 开始运行..
[2022-05-17 09:57:09.828701] INFO: cached.v2.9776956e: [2022-05-17 09:57:05.716388] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:09.829899] INFO: cached.v2.9776956e: [2022-05-17 09:57:05.717061] INFO moduleinvoker: input_features.v1 运行完成[0.007612s].
[2022-05-17 09:57:09.831659] INFO: cached.v2.9776956e: [2022-05-17 09:57:05.721685] INFO moduleinvoker: input_features.v1 开始运行..
[2022-05-17 09:57:09.833609] INFO: cached.v2.9776956e: [2022-05-17 09:57:05.727668] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:09.835085] INFO: cached.v2.9776956e: [2022-05-17 09:57:05.728439] INFO moduleinvoker: input_features.v1 运行完成[0.006742s].
[2022-05-17 09:57:09.836099] INFO: cached.v2.9776956e: [2022-05-17 09:57:05.742324] INFO moduleinvoker: advanced_auto_labeler.v2 开始运行..
[2022-05-17 09:57:09.837094] INFO: cached.v2.9776956e: [2022-05-17 09:57:05.753054] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:09.838105] INFO: cached.v2.9776956e: [2022-05-17 09:57:05.754927] INFO moduleinvoker: advanced_auto_labeler.v2 运行完成[0.012579s].
[2022-05-17 09:57:09.839117] INFO: cached.v2.9776956e: [2022-05-17 09:57:05.759557] INFO moduleinvoker: input_features.v1 开始运行..
[2022-05-17 09:57:09.840269] INFO: cached.v2.9776956e: [2022-05-17 09:57:05.765995] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:09.841345] INFO: cached.v2.9776956e: [2022-05-17 09:57:05.766782] INFO moduleinvoker: input_features.v1 运行完成[0.007261s].
[2022-05-17 09:57:09.842452] INFO: cached.v2.9776956e: [2022-05-17 09:57:05.775825] INFO moduleinvoker: use_datasource.v1 开始运行..
[2022-05-17 09:57:09.843615] INFO: cached.v2.9776956e: [2022-05-17 09:57:05.788198] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:09.844698] INFO: cached.v2.9776956e: [2022-05-17 09:57:05.789022] INFO moduleinvoker: use_datasource.v1 运行完成[0.013252s].
[2022-05-17 09:57:09.845754] INFO: cached.v2.9776956e: [2022-05-17 09:57:05.831757] INFO moduleinvoker: index_feature_extract.v3 开始运行..
[2022-05-17 09:57:09.847112] INFO: cached.v2.9776956e: [2022-05-17 09:57:05.844979] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:09.848224] INFO: cached.v2.9776956e: [2022-05-17 09:57:05.845356] INFO moduleinvoker: index_feature_extract.v3 运行完成[0.013687s].
[2022-05-17 09:57:09.849294] INFO: cached.v2.9776956e: [2022-05-17 09:57:05.885207] INFO moduleinvoker: general_feature_extractor.v7 开始运行..
[2022-05-17 09:57:09.850459] INFO: cached.v2.9776956e: [2022-05-17 09:57:05.938205] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:09.851641] INFO: cached.v2.9776956e: [2022-05-17 09:57:05.938726] INFO moduleinvoker: general_feature_extractor.v7 运行完成[0.053639s].
[2022-05-17 09:57:09.852756] INFO: cached.v2.9776956e: [2022-05-17 09:57:05.949890] INFO moduleinvoker: general_feature_extractor.v7 开始运行..
[2022-05-17 09:57:09.853940] INFO: cached.v2.9776956e: [2022-05-17 09:57:05.957006] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:09.854964] INFO: cached.v2.9776956e: [2022-05-17 09:57:05.957637] INFO moduleinvoker: general_feature_extractor.v7 运行完成[0.007742s].
[2022-05-17 09:57:09.855995] INFO: cached.v2.9776956e: [2022-05-17 09:57:05.980523] INFO moduleinvoker: select_columns.v3 开始运行..
[2022-05-17 09:57:09.857112] INFO: cached.v2.9776956e: [2022-05-17 09:57:05.988574] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:09.858128] INFO: cached.v2.9776956e: [2022-05-17 09:57:05.989273] INFO moduleinvoker: select_columns.v3 运行完成[0.008838s].
[2022-05-17 09:57:09.859298] INFO: cached.v2.9776956e: [2022-05-17 09:57:06.001189] INFO moduleinvoker: derived_feature_extractor.v3 开始运行..
[2022-05-17 09:57:09.860359] INFO: cached.v2.9776956e: [2022-05-17 09:57:06.009137] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:09.861458] INFO: cached.v2.9776956e: [2022-05-17 09:57:06.009592] INFO moduleinvoker: derived_feature_extractor.v3 运行完成[0.008476s].
[2022-05-17 09:57:09.862476] INFO: cached.v2.9776956e: [2022-05-17 09:57:06.016358] INFO moduleinvoker: derived_feature_extractor.v3 开始运行..
[2022-05-17 09:57:09.863648] INFO: cached.v2.9776956e: [2022-05-17 09:57:06.025189] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:09.864914] INFO: cached.v2.9776956e: [2022-05-17 09:57:06.025655] INFO moduleinvoker: derived_feature_extractor.v3 运行完成[0.009411s].
[2022-05-17 09:57:09.866048] INFO: cached.v2.9776956e: [2022-05-17 09:57:06.036184] INFO moduleinvoker: join.v3 开始运行..
[2022-05-17 09:57:09.867066] INFO: cached.v2.9776956e: [2022-05-17 09:57:06.045442] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:09.869112] INFO: cached.v2.9776956e: [2022-05-17 09:57:06.045896] INFO moduleinvoker: join.v3 运行完成[0.009784s].
[2022-05-17 09:57:09.870159] INFO: cached.v2.9776956e: [2022-05-17 09:57:06.055146] INFO moduleinvoker: filter.v3 开始运行..
[2022-05-17 09:57:09.871131] INFO: cached.v2.9776956e: [2022-05-17 09:57:06.063343] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:09.872683] INFO: cached.v2.9776956e: [2022-05-17 09:57:06.063843] INFO moduleinvoker: filter.v3 运行完成[0.008775s].
[2022-05-17 09:57:09.874332] INFO: cached.v2.9776956e: [2022-05-17 09:57:06.079202] INFO moduleinvoker: filter.v3 开始运行..
[2022-05-17 09:57:09.876845] INFO: cached.v2.9776956e: [2022-05-17 09:57:06.088131] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:09.879322] INFO: cached.v2.9776956e: [2022-05-17 09:57:06.088561] INFO moduleinvoker: filter.v3 运行完成[0.009422s].
[2022-05-17 09:57:09.881897] INFO: cached.v2.9776956e: [2022-05-17 09:57:06.099939] INFO moduleinvoker: join.v3 开始运行..
[2022-05-17 09:57:09.884786] INFO: cached.v2.9776956e: [2022-05-17 09:57:06.108071] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:09.886696] INFO: cached.v2.9776956e: [2022-05-17 09:57:06.108738] INFO moduleinvoker: join.v3 运行完成[0.008795s].
[2022-05-17 09:57:09.888313] INFO: cached.v2.9776956e: [2022-05-17 09:57:06.119814] INFO moduleinvoker: dropnan.v1 开始运行..
[2022-05-17 09:57:09.890384] INFO: cached.v2.9776956e: [2022-05-17 09:57:06.126626] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:09.892399] INFO: cached.v2.9776956e: [2022-05-17 09:57:06.127017] INFO moduleinvoker: dropnan.v1 运行完成[0.007285s].
[2022-05-17 09:57:09.894101] INFO: cached.v2.9776956e: [2022-05-17 09:57:06.136362] INFO moduleinvoker: dropnan.v1 开始运行..
[2022-05-17 09:57:09.895508] INFO: cached.v2.9776956e: [2022-05-17 09:57:06.146168] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:09.897363] INFO: cached.v2.9776956e: [2022-05-17 09:57:06.146595] INFO moduleinvoker: dropnan.v1 运行完成[0.01033s].
[2022-05-17 09:57:09.899958] INFO: cached.v2.9776956e: [2022-05-17 09:57:06.161052] INFO moduleinvoker: chinaa_stock_filter.v1 开始运行..
[2022-05-17 09:57:09.902933] INFO: cached.v2.9776956e: [2022-05-17 09:57:06.169624] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:09.904891] INFO: cached.v2.9776956e: [2022-05-17 09:57:06.170310] INFO moduleinvoker: chinaa_stock_filter.v1 运行完成[0.009292s].
[2022-05-17 09:57:09.906644] INFO: cached.v2.9776956e: [2022-05-17 09:57:06.183809] INFO moduleinvoker: chinaa_stock_filter.v1 开始运行..
[2022-05-17 09:57:09.907924] INFO: cached.v2.9776956e: [2022-05-17 09:57:06.190698] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:09.909904] INFO: cached.v2.9776956e: [2022-05-17 09:57:06.191301] INFO moduleinvoker: chinaa_stock_filter.v1 运行完成[0.007524s].
[2022-05-17 09:57:09.911664] INFO: cached.v2.9776956e: [2022-05-17 09:57:06.199936] INFO moduleinvoker: select_columns.v3 开始运行..
[2022-05-17 09:57:09.913459] INFO: cached.v2.9776956e: [2022-05-17 09:57:06.207995] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:09.915115] INFO: cached.v2.9776956e: [2022-05-17 09:57:06.208737] INFO moduleinvoker: select_columns.v3 运行完成[0.008836s].
[2022-05-17 09:57:09.917737] INFO: cached.v2.9776956e: [2022-05-17 09:57:06.222190] INFO moduleinvoker: stock_ranker_train.v6 开始运行..
[2022-05-17 09:57:09.920267] INFO: cached.v2.9776956e: [2022-05-17 09:57:06.235157] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:09.922926] INFO: cached.v2.9776956e:
[2022-05-17 09:57:09.925404] INFO: cached.v2.9776956e: [2022-05-17 09:57:06.444283] INFO moduleinvoker: stock_ranker_train.v6 运行完成[0.222111s].
[2022-05-17 09:57:09.926996] INFO: cached.v2.9776956e: [2022-05-17 09:57:06.455587] INFO moduleinvoker: stock_ranker_predict.v5 开始运行..
[2022-05-17 09:57:09.928354] INFO: cached.v2.9776956e: [2022-05-17 09:57:06.466440] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:09.931034] INFO: cached.v2.9776956e: [2022-05-17 09:57:06.467635] INFO moduleinvoker: stock_ranker_predict.v5 运行完成[0.01209s].
[2022-05-17 09:57:09.932947] INFO: cached.v2.9776956e: [2022-05-17 09:57:06.478663] INFO moduleinvoker: join.v3 开始运行..
[2022-05-17 09:57:09.934457] INFO: cached.v2.9776956e: [2022-05-17 09:57:06.487386] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:09.935470] INFO: cached.v2.9776956e: [2022-05-17 09:57:06.488054] INFO moduleinvoker: join.v3 运行完成[0.00936s].
[2022-05-17 09:57:09.936484] INFO: cached.v2.9776956e: [2022-05-17 09:57:06.505309] INFO moduleinvoker: join.v3 开始运行..
[2022-05-17 09:57:09.937571] INFO: cached.v2.9776956e: [2022-05-17 09:57:06.512244] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:09.938638] INFO: cached.v2.9776956e: [2022-05-17 09:57:06.512659] INFO moduleinvoker: join.v3 运行完成[0.007461s].
[2022-05-17 09:57:09.939642] INFO: cached.v2.9776956e: [2022-05-17 09:57:06.519728] INFO moduleinvoker: sort.v4 开始运行..
[2022-05-17 09:57:09.940592] INFO: cached.v2.9776956e: [2022-05-17 09:57:06.527411] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:09.941679] INFO: cached.v2.9776956e: [2022-05-17 09:57:06.528194] INFO moduleinvoker: sort.v4 运行完成[0.008454s].
[2022-05-17 09:57:09.953547] INFO: cached.v2.97820ac0: {'m1.start_date': '2016-01-01', 'm1.end_date': '2018-12-31', 'm9.start_date': '2019-01-01', 'm9.end_date': '2019-12-31'}
[2022-05-17 09:57:09.954768] INFO: cached.v2.97820ac0: [2022-05-17 09:57:06.966838] INFO moduleinvoker: instruments.v2 开始运行..
[2022-05-17 09:57:09.955852] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.037936] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:09.956871] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.038688] INFO moduleinvoker: instruments.v2 运行完成[0.072062s].
[2022-05-17 09:57:09.957881] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.043898] INFO moduleinvoker: input_features.v1 开始运行..
[2022-05-17 09:57:09.958846] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.050621] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:09.959814] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.050965] INFO moduleinvoker: input_features.v1 运行完成[0.007154s].
[2022-05-17 09:57:09.960776] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.055915] INFO moduleinvoker: instruments.v2 开始运行..
[2022-05-17 09:57:09.961826] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.067123] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:09.962785] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.067914] INFO moduleinvoker: instruments.v2 运行完成[0.012036s].
[2022-05-17 09:57:09.963954] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.074830] INFO moduleinvoker: input_features.v1 开始运行..
[2022-05-17 09:57:09.965009] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.080274] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:09.965982] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.081218] INFO moduleinvoker: input_features.v1 运行完成[0.006445s].
[2022-05-17 09:57:09.967013] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.086017] INFO moduleinvoker: input_features.v1 开始运行..
[2022-05-17 09:57:09.968010] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.091422] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:09.968976] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.092160] INFO moduleinvoker: input_features.v1 运行完成[0.00613s].
[2022-05-17 09:57:09.969924] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.106791] INFO moduleinvoker: advanced_auto_labeler.v2 开始运行..
[2022-05-17 09:57:09.970936] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.117112] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:09.972043] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.119009] INFO moduleinvoker: advanced_auto_labeler.v2 运行完成[0.012217s].
[2022-05-17 09:57:09.973133] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.125058] INFO moduleinvoker: input_features.v1 开始运行..
[2022-05-17 09:57:09.974999] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.130149] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:09.977614] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.130610] INFO moduleinvoker: input_features.v1 运行完成[0.005619s].
[2022-05-17 09:57:09.980635] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.136850] INFO moduleinvoker: use_datasource.v1 开始运行..
[2022-05-17 09:57:09.982714] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.144301] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:09.984749] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.144969] INFO moduleinvoker: use_datasource.v1 运行完成[0.008123s].
[2022-05-17 09:57:09.986738] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.181964] INFO moduleinvoker: index_feature_extract.v3 开始运行..
[2022-05-17 09:57:09.989096] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.197390] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:09.991125] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.197947] INFO moduleinvoker: index_feature_extract.v3 运行完成[0.016071s].
[2022-05-17 09:57:09.993537] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.333585] INFO moduleinvoker: general_feature_extractor.v7 开始运行..
[2022-05-17 09:57:09.995264] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.353782] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:09.998003] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.354306] INFO moduleinvoker: general_feature_extractor.v7 运行完成[0.020813s].
[2022-05-17 09:57:10.001475] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.367682] INFO moduleinvoker: general_feature_extractor.v7 开始运行..
[2022-05-17 09:57:10.004508] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.381946] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:10.006288] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.382302] INFO moduleinvoker: general_feature_extractor.v7 运行完成[0.014722s].
[2022-05-17 09:57:10.007612] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.408802] INFO moduleinvoker: select_columns.v3 开始运行..
[2022-05-17 09:57:10.010163] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.418530] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:10.012143] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.418877] INFO moduleinvoker: select_columns.v3 运行完成[0.010146s].
[2022-05-17 09:57:10.013905] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.430757] INFO moduleinvoker: derived_feature_extractor.v3 开始运行..
[2022-05-17 09:57:10.016649] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.440781] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:10.019063] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.441732] INFO moduleinvoker: derived_feature_extractor.v3 运行完成[0.011142s].
[2022-05-17 09:57:10.021605] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.450800] INFO moduleinvoker: derived_feature_extractor.v3 开始运行..
[2022-05-17 09:57:10.024612] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.461426] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:10.026119] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.462192] INFO moduleinvoker: derived_feature_extractor.v3 运行完成[0.01144s].
[2022-05-17 09:57:10.027291] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.478529] INFO moduleinvoker: join.v3 开始运行..
[2022-05-17 09:57:10.029379] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.486025] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:10.031482] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.486419] INFO moduleinvoker: join.v3 运行完成[0.008027s].
[2022-05-17 09:57:10.033356] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.497038] INFO moduleinvoker: filter.v3 开始运行..
[2022-05-17 09:57:10.034693] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.506527] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:10.036018] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.507372] INFO moduleinvoker: filter.v3 运行完成[0.010402s].
[2022-05-17 09:57:10.037344] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.517296] INFO moduleinvoker: filter.v3 开始运行..
[2022-05-17 09:57:10.038696] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.525802] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:10.040037] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.526573] INFO moduleinvoker: filter.v3 运行完成[0.009215s].
[2022-05-17 09:57:10.041648] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.538529] INFO moduleinvoker: dropnan.v1 开始运行..
[2022-05-17 09:57:10.043273] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.546407] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:10.044912] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.547155] INFO moduleinvoker: dropnan.v1 运行完成[0.008741s].
[2022-05-17 09:57:10.046264] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.557302] INFO moduleinvoker: join.v3 开始运行..
[2022-05-17 09:57:10.047428] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.563764] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:10.048974] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.564524] INFO moduleinvoker: join.v3 运行完成[0.0073s].
[2022-05-17 09:57:10.050675] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.580182] INFO moduleinvoker: chinaa_stock_filter.v1 开始运行..
[2022-05-17 09:57:10.052462] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.589347] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:10.054186] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.590058] INFO moduleinvoker: chinaa_stock_filter.v1 运行完成[0.010015s].
[2022-05-17 09:57:10.055454] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.600318] INFO moduleinvoker: dropnan.v1 开始运行..
[2022-05-17 09:57:10.056570] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.715270] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:10.057683] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.716068] INFO moduleinvoker: dropnan.v1 运行完成[0.115734s].
[2022-05-17 09:57:10.058942] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.725746] INFO moduleinvoker: select_columns.v3 开始运行..
[2022-05-17 09:57:10.060068] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.734309] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:10.061227] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.734689] INFO moduleinvoker: select_columns.v3 运行完成[0.009069s].
[2022-05-17 09:57:10.062369] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.745243] INFO moduleinvoker: chinaa_stock_filter.v1 开始运行..
[2022-05-17 09:57:10.063450] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.754961] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:10.064559] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.755711] INFO moduleinvoker: chinaa_stock_filter.v1 运行完成[0.010557s].
[2022-05-17 09:57:10.065676] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.772226] INFO moduleinvoker: stock_ranker_train.v6 开始运行..
[2022-05-17 09:57:10.066786] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.788059] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:10.068184] INFO: cached.v2.97820ac0:
[2022-05-17 09:57:10.069492] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.962816] INFO moduleinvoker: stock_ranker_train.v6 运行完成[0.19066s].
[2022-05-17 09:57:10.070568] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.978875] INFO moduleinvoker: stock_ranker_predict.v5 开始运行..
[2022-05-17 09:57:10.071865] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.993844] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:10.073469] INFO: cached.v2.97820ac0: [2022-05-17 09:57:07.995049] INFO moduleinvoker: stock_ranker_predict.v5 运行完成[0.016179s].
[2022-05-17 09:57:10.075765] INFO: cached.v2.97820ac0: [2022-05-17 09:57:08.008291] INFO moduleinvoker: join.v3 开始运行..
[2022-05-17 09:57:10.078370] INFO: cached.v2.97820ac0: [2022-05-17 09:57:08.020610] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:10.081696] INFO: cached.v2.97820ac0: [2022-05-17 09:57:08.021452] INFO moduleinvoker: join.v3 运行完成[0.013218s].
[2022-05-17 09:57:10.084317] INFO: cached.v2.97820ac0: [2022-05-17 09:57:08.034841] INFO moduleinvoker: join.v3 开始运行..
[2022-05-17 09:57:10.086132] INFO: cached.v2.97820ac0: [2022-05-17 09:57:08.044518] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:10.087525] INFO: cached.v2.97820ac0: [2022-05-17 09:57:08.045244] INFO moduleinvoker: join.v3 运行完成[0.010539s].
[2022-05-17 09:57:10.090451] INFO: cached.v2.97820ac0: [2022-05-17 09:57:08.054803] INFO moduleinvoker: sort.v4 开始运行..
[2022-05-17 09:57:10.092410] INFO: cached.v2.97820ac0: [2022-05-17 09:57:08.071791] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:10.094316] INFO: cached.v2.97820ac0: [2022-05-17 09:57:08.072757] INFO moduleinvoker: sort.v4 运行完成[0.018006s].
[2022-05-17 09:57:10.279571] INFO: cached.v2.9781f3b4: [2022-05-17 09:57:01.144119] INFO backtest: 读取股票行情完成:1352832
[2022-05-17 09:57:10.281960] INFO: cached.v2.9781f3b4: [2022-05-17 09:57:02.634472] INFO moduleinvoker: cached.v2 运行完成[4.893273s].
[2022-05-17 09:57:10.285079] INFO: cached.v2.9781f3b4: [2022-05-17 09:57:04.279088] INFO algo: TradingAlgorithm V1.8.7
[2022-05-17 09:57:10.287167] INFO: cached.v2.9781f3b4: [2022-05-17 09:57:05.016717] INFO algo: trading transform...
[2022-05-17 09:57:10.505730] INFO: cached.v2.979c6faa: [2022-05-17 09:57:01.044493] INFO 基础特征抽取: 年份 2016, 特征行数=641546
[2022-05-17 09:57:10.508464] INFO: cached.v2.979c6faa: [2022-05-17 09:57:01.145737] INFO 基础特征抽取: 总行数: 750201
[2022-05-17 09:57:10.510820] INFO: cached.v2.979c6faa: [2022-05-17 09:57:01.153315] INFO moduleinvoker: general_feature_extractor.v7 运行完成[6.471965s].
[2022-05-17 09:57:10.513086] INFO: cached.v2.979c6faa: [2022-05-17 09:57:01.188137] INFO moduleinvoker: select_columns.v3 开始运行..
[2022-05-17 09:57:10.515045] INFO: cached.v2.979c6faa: 列: ['date', 'bm_0']
[2022-05-17 09:57:10.516858] INFO: cached.v2.979c6faa: /data: 311
[2022-05-17 09:57:10.518414] INFO: cached.v2.979c6faa: [2022-05-17 09:57:01.288473] INFO moduleinvoker: select_columns.v3 运行完成[0.100242s].
[2022-05-17 09:57:10.521107] INFO: cached.v2.979c6faa: [2022-05-17 09:57:01.298516] INFO moduleinvoker: derived_feature_extractor.v3 开始运行..
[2022-05-17 09:57:10.523692] INFO: cached.v2.979c6faa: [2022-05-17 09:57:01.307822] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:10.526136] INFO: cached.v2.979c6faa: [2022-05-17 09:57:01.308220] INFO moduleinvoker: derived_feature_extractor.v3 运行完成[0.009782s].
[2022-05-17 09:57:10.528957] INFO: cached.v2.979c6faa: [2022-05-17 09:57:01.316839] INFO moduleinvoker: derived_feature_extractor.v3 开始运行..
[2022-05-17 09:57:10.530353] INFO: cached.v2.979c6faa: [2022-05-17 09:57:03.184907] INFO derived_feature_extractor: 提取完成 avg_amount_0/avg_amount_5, 0.004s
[2022-05-17 09:57:10.531459] INFO: cached.v2.979c6faa: [2022-05-17 09:57:03.188261] INFO derived_feature_extractor: 提取完成 avg_amount_5/avg_amount_20, 0.003s
[2022-05-17 09:57:10.532718] INFO: cached.v2.979c6faa: [2022-05-17 09:57:03.190808] INFO derived_feature_extractor: 提取完成 rank_avg_amount_0/rank_avg_amount_5, 0.002s
[2022-05-17 09:57:10.534342] INFO: cached.v2.979c6faa: [2022-05-17 09:57:03.193315] INFO derived_feature_extractor: 提取完成 rank_avg_amount_5/rank_avg_amount_10, 0.002s
[2022-05-17 09:57:10.536107] INFO: cached.v2.979c6faa: [2022-05-17 09:57:03.195896] INFO derived_feature_extractor: 提取完成 rank_return_0/rank_return_5, 0.002s
[2022-05-17 09:57:10.537181] INFO: cached.v2.979c6faa: [2022-05-17 09:57:03.198240] INFO derived_feature_extractor: 提取完成 rank_return_5/rank_return_10, 0.002s
[2022-05-17 09:57:10.538235] INFO: cached.v2.979c6faa: [2022-05-17 09:57:03.633496] INFO derived_feature_extractor: /y_2015, 108655
[2022-05-17 09:57:10.539248] INFO: cached.v2.979c6faa: [2022-05-17 09:57:05.116513] INFO derived_feature_extractor: /y_2016, 641546
[2022-05-17 09:57:10.540274] INFO: cached.v2.979c6faa: [2022-05-17 09:57:06.059120] INFO moduleinvoker: derived_feature_extractor.v3 运行完成[4.742246s].
[2022-05-17 09:57:10.541389] INFO: cached.v2.979c6faa: [2022-05-17 09:57:06.076319] INFO moduleinvoker: join.v3 开始运行..
[2022-05-17 09:57:10.542820] INFO: cached.v2.979c6faa: [2022-05-17 09:57:08.569487] INFO join: /data, 行数=704145/704145, 耗时=2.426207s
[2022-05-17 09:57:10.544106] INFO: cached.v2.979c6faa: [2022-05-17 09:57:08.640624] INFO join: 最终行数: 704145
[2022-05-17 09:57:10.545389] INFO: cached.v2.979c6faa: [2022-05-17 09:57:08.646347] INFO moduleinvoker: join.v3 运行完成[2.570026s].
[2022-05-17 09:57:10.546919] INFO: cached.v2.979c6faa: [2022-05-17 09:57:08.658395] INFO moduleinvoker: filter.v3 开始运行..
[2022-05-17 09:57:10.548124] INFO: cached.v2.979c6faa: [2022-05-17 09:57:08.668441] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:10.549271] INFO: cached.v2.979c6faa: [2022-05-17 09:57:08.669159] INFO moduleinvoker: filter.v3 运行完成[0.010844s].
[2022-05-17 09:57:10.550683] INFO: cached.v2.979c6faa: [2022-05-17 09:57:08.679977] INFO moduleinvoker: filter.v3 开始运行..
[2022-05-17 09:57:10.551453] INFO: cached.v2.9785fad6: [2022-05-17 09:57:00.788500] INFO algo: trading transform...
[2022-05-17 09:57:10.553274] INFO: cached.v2.979c6faa: [2022-05-17 09:57:08.697768] INFO filter: 使用表达式 market_cap_float_0<5000000000 过滤
[2022-05-17 09:57:10.554590] INFO: cached.v2.979c6faa: [2022-05-17 09:57:09.051674] INFO filter: 过滤 /y_2015, 38864/0/108655
[2022-05-17 09:57:10.555602] INFO: cached.v2.979c6faa: [2022-05-17 09:57:10.197336] INFO filter: 过滤 /y_2016, 270329/0/641546
[2022-05-17 09:57:10.556872] INFO: cached.v2.979c6faa: [2022-05-17 09:57:10.241663] INFO moduleinvoker: filter.v3 运行完成[1.56169s].
[2022-05-17 09:57:10.558026] INFO: cached.v2.979c6faa: [2022-05-17 09:57:10.257655] INFO moduleinvoker: join.v3 开始运行..
[2022-05-17 09:57:10.559180] INFO: cached.v2.979c6faa: [2022-05-17 09:57:10.277412] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:10.560195] INFO: cached.v2.979c6faa: [2022-05-17 09:57:10.277782] INFO moduleinvoker: join.v3 运行完成[0.020199s].
[2022-05-17 09:57:10.561356] INFO: cached.v2.979c6faa: [2022-05-17 09:57:10.291018] INFO moduleinvoker: dropnan.v1 开始运行..
[2022-05-17 09:57:10.562603] INFO: cached.v2.979c6faa: [2022-05-17 09:57:10.463905] INFO dropnan: /y_2015, 38269/38864
[2022-05-17 09:57:20.101250] INFO: cached.v2.9776956e: [2022-05-17 09:57:12.974112] INFO moduleinvoker: backtest.v8 开始运行..
[2022-05-17 09:57:20.103109] INFO: cached.v2.9776956e: [2022-05-17 09:57:12.978833] INFO backtest: biglearning backtest:V8.6.2
[2022-05-17 09:57:20.105564] INFO: cached.v2.9776956e: [2022-05-17 09:57:12.978974] INFO backtest: product_type:stock by specified
[2022-05-17 09:57:20.107992] INFO: cached.v2.9776956e: [2022-05-17 09:57:13.054918] INFO moduleinvoker: cached.v2 开始运行..
[2022-05-17 09:57:20.139673] INFO: cached.v2.97820ac0: [2022-05-17 09:57:14.711266] INFO moduleinvoker: backtest.v8 开始运行..
[2022-05-17 09:57:20.141489] INFO: cached.v2.97820ac0: [2022-05-17 09:57:14.715748] INFO backtest: biglearning backtest:V8.6.2
[2022-05-17 09:57:20.142782] INFO: cached.v2.97820ac0: [2022-05-17 09:57:14.715879] INFO backtest: product_type:stock by specified
[2022-05-17 09:57:20.143969] INFO: cached.v2.97820ac0: [2022-05-17 09:57:14.835523] INFO moduleinvoker: cached.v2 开始运行..
[2022-05-17 09:57:20.145854] INFO: cached.v2.97820ac0: [2022-05-17 09:57:14.848121] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:20.149255] INFO: cached.v2.97820ac0: [2022-05-17 09:57:14.848710] INFO moduleinvoker: cached.v2 运行完成[0.013304s].
[2022-05-17 09:57:20.295322] INFO: cached.v2.9781d88e: [2022-05-17 09:57:15.568166] INFO algo: handle_splits get splits [dt:2018-04-18 00:00:00+00:00] [asset:Equity(1430 [002796.SZA]), ratio:0.9923399686813354]
[2022-05-17 09:57:20.297421] INFO: cached.v2.9781d88e: [2022-05-17 09:57:15.568484] INFO Position: position stock handle split[sid:1430, orig_amount:8300, new_amount:8364.0, orig_cost:24.92110560789605, new_cost:24.7302, ratio:0.9923399686813354, last_sale_price:25.909997940063477]
[2022-05-17 09:57:20.299618] INFO: cached.v2.9781d88e: [2022-05-17 09:57:15.568579] INFO Position: after split: PositionStock(asset:Equity(1430 [002796.SZA]), amount:8364.0, cost_basis:24.7302, last_sale_price:26.110000610351562)
[2022-05-17 09:57:20.301481] INFO: cached.v2.9781d88e: [2022-05-17 09:57:15.568626] INFO Position: returning cash: 1.7886
[2022-05-17 09:57:20.734341] INFO: cached.v2.979c6faa: [2022-05-17 09:57:11.030702] INFO dropnan: /y_2016, 258618/270329
[2022-05-17 09:57:20.736403] INFO: cached.v2.979c6faa: [2022-05-17 09:57:11.112195] INFO dropnan: 行数: 296887/309193
[2022-05-17 09:57:20.737862] INFO: cached.v2.979c6faa: [2022-05-17 09:57:11.118350] INFO moduleinvoker: dropnan.v1 运行完成[0.82691s].
[2022-05-17 09:57:20.738977] INFO: cached.v2.979c6faa: [2022-05-17 09:57:11.129874] INFO moduleinvoker: dropnan.v1 开始运行..
[2022-05-17 09:57:20.740056] INFO: cached.v2.979c6faa: [2022-05-17 09:57:11.139101] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:20.741102] INFO: cached.v2.979c6faa: [2022-05-17 09:57:11.139448] INFO moduleinvoker: dropnan.v1 运行完成[0.009652s].
[2022-05-17 09:57:20.742246] INFO: cached.v2.979c6faa: [2022-05-17 09:57:11.152355] INFO moduleinvoker: chinaa_stock_filter.v1 开始运行..
[2022-05-17 09:57:20.743411] INFO: cached.v2.979c6faa: [2022-05-17 09:57:11.698032] INFO A股股票过滤: 过滤 /y_2015, 37338/0/38269
[2022-05-17 09:57:20.744544] INFO: cached.v2.979c6faa: [2022-05-17 09:57:13.369714] INFO A股股票过滤: 过滤 /y_2016, 252605/0/258618
[2022-05-17 09:57:20.745625] INFO: cached.v2.979c6faa: [2022-05-17 09:57:13.371955] INFO A股股票过滤: 过滤完成, 289943 + 0
[2022-05-17 09:57:20.746665] INFO: cached.v2.979c6faa: [2022-05-17 09:57:13.391163] INFO moduleinvoker: chinaa_stock_filter.v1 运行完成[2.238752s].
[2022-05-17 09:57:20.747813] INFO: cached.v2.979c6faa: [2022-05-17 09:57:13.400574] INFO moduleinvoker: chinaa_stock_filter.v1 开始运行..
[2022-05-17 09:57:20.748892] INFO: cached.v2.979c6faa: [2022-05-17 09:57:13.410408] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:20.749956] INFO: cached.v2.979c6faa: [2022-05-17 09:57:13.410794] INFO moduleinvoker: chinaa_stock_filter.v1 运行完成[0.010306s].
[2022-05-17 09:57:20.751069] INFO: cached.v2.979c6faa: [2022-05-17 09:57:13.418703] INFO moduleinvoker: select_columns.v3 开始运行..
[2022-05-17 09:57:20.752089] INFO: cached.v2.979c6faa: 列: ['date', 'instrument', 'price_limit_status_0']
[2022-05-17 09:57:20.753247] INFO: cached.v2.979c6faa: /y_2015: 37338
[2022-05-17 09:57:20.754459] INFO: cached.v2.979c6faa: /y_2016: 252605
[2022-05-17 09:57:20.755778] INFO: cached.v2.979c6faa: [2022-05-17 09:57:14.017598] INFO moduleinvoker: select_columns.v3 运行完成[0.598355s].
[2022-05-17 09:57:20.757214] INFO: cached.v2.979c6faa: [2022-05-17 09:57:14.033370] INFO moduleinvoker: stock_ranker_train.v6 开始运行..
[2022-05-17 09:57:20.758309] INFO: cached.v2.979c6faa: [2022-05-17 09:57:14.050080] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:20.759404] INFO: cached.v2.979c6faa:
[2022-05-17 09:57:20.760592] INFO: cached.v2.979c6faa: [2022-05-17 09:57:14.238441] INFO moduleinvoker: stock_ranker_train.v6 运行完成[0.205122s].
[2022-05-17 09:57:20.761780] INFO: cached.v2.979c6faa: [2022-05-17 09:57:14.260245] INFO moduleinvoker: stock_ranker_predict.v5 开始运行..
[2022-05-17 09:57:20.762868] INFO: cached.v2.979c6faa: [2022-05-17 09:57:14.462822] INFO StockRanker预测: /y_2015 ..
[2022-05-17 09:57:20.764082] INFO: cached.v2.979c6faa: [2022-05-17 09:57:14.644956] INFO StockRanker预测: /y_2016 ..
[2022-05-17 09:57:20.765433] INFO: cached.v2.979c6faa: [2022-05-17 09:57:15.462925] INFO moduleinvoker: stock_ranker_predict.v5 运行完成[1.202826s].
[2022-05-17 09:57:20.766675] INFO: cached.v2.979c6faa: [2022-05-17 09:57:15.472426] INFO moduleinvoker: join.v3 开始运行..
[2022-05-17 09:57:20.767817] INFO: cached.v2.979c6faa: [2022-05-17 09:57:16.340696] INFO join: /data, 行数=289943/289943, 耗时=0.700023s
[2022-05-17 09:57:20.769023] INFO: cached.v2.979c6faa: [2022-05-17 09:57:16.522133] INFO join: 最终行数: 289943
[2022-05-17 09:57:20.770231] INFO: cached.v2.979c6faa: [2022-05-17 09:57:16.530685] INFO moduleinvoker: join.v3 运行完成[1.058214s].
[2022-05-17 09:57:20.771370] INFO: cached.v2.979c6faa: [2022-05-17 09:57:16.543112] INFO moduleinvoker: join.v3 开始运行..
[2022-05-17 09:57:20.773241] INFO: cached.v2.979c6faa: [2022-05-17 09:57:17.900193] INFO join: /data, 行数=289943/289943, 耗时=1.058087s
[2022-05-17 09:57:20.774674] INFO: cached.v2.979c6faa: [2022-05-17 09:57:17.968030] INFO join: 最终行数: 289943
[2022-05-17 09:57:20.775962] INFO: cached.v2.979c6faa: [2022-05-17 09:57:17.978365] INFO moduleinvoker: join.v3 运行完成[1.435181s].
[2022-05-17 09:57:20.778055] INFO: cached.v2.979c6faa: [2022-05-17 09:57:17.985812] INFO moduleinvoker: sort.v4 开始运行..
[2022-05-17 09:57:20.780354] INFO: cached.v2.979c6faa: [2022-05-17 09:57:19.813313] INFO moduleinvoker: sort.v4 运行完成[1.827466s].
[2022-05-17 09:57:30.351080] INFO: cached.v2.9781d88e: [2022-05-17 09:57:21.507761] INFO algo: handle_splits get splits [dt:2018-05-24 00:00:00+00:00] [asset:Equity(1554 [002452.SZA]), ratio:0.9941291809082031]
[2022-05-17 09:57:30.352982] INFO: cached.v2.9781d88e: [2022-05-17 09:57:22.245389] INFO algo: handle_splits get splits [dt:2018-05-28 00:00:00+00:00] [asset:Equity(2805 [300515.SZA]), ratio:0.9945313930511475]
[2022-05-17 09:57:30.354480] INFO: cached.v2.9781d88e: [2022-05-17 09:57:22.245582] INFO Position: position stock handle split[sid:2805, orig_amount:6900, new_amount:6937.0, orig_cost:13.552173407582552, new_cost:13.4781, ratio:0.9945313930511475, last_sale_price:12.730001449584961]
[2022-05-17 09:57:30.355911] INFO: cached.v2.9781d88e: [2022-05-17 09:57:22.245660] INFO Position: after split: PositionStock(asset:Equity(2805 [300515.SZA]), amount:6937.0, cost_basis:13.4781, last_sale_price:12.799999237060547)
[2022-05-17 09:57:30.357381] INFO: cached.v2.9781d88e: [2022-05-17 09:57:22.245705] INFO Position: returning cash: 11.9773
[2022-05-17 09:57:30.358843] INFO: cached.v2.9781d88e: [2022-05-17 09:57:22.848178] INFO algo: handle_splits get splits [dt:2018-05-31 00:00:00+00:00] [asset:Equity(122 [002755.SZA]), ratio:0.5871057510375977]
[2022-05-17 09:57:30.360214] INFO: cached.v2.9781d88e: [2022-05-17 09:57:28.695181] INFO algo: handle_splits get splits [dt:2018-07-13 00:00:00+00:00] [asset:Equity(3535 [002721.SZA]), ratio:0.9961880445480347]
[2022-05-17 09:57:30.533313] INFO: cached.v2.9781b4f8: [2022-05-17 09:57:23.104142] INFO algo: handle_splits get splits [dt:2020-06-02 00:00:00+00:00] [asset:Equity(3579 [002833.SZA]), ratio:0.6157271265983582]
[2022-05-17 09:57:30.535139] INFO: cached.v2.9781b4f8: [2022-05-17 09:57:23.104325] INFO Position: position stock handle split[sid:3579, orig_amount:1400, new_amount:2273.0, orig_cost:39.890002725538295, new_cost:24.5614, ratio:0.6157271265983582, last_sale_price:24.90000343322754]
[2022-05-17 09:57:30.536366] INFO: cached.v2.9781b4f8: [2022-05-17 09:57:23.104404] INFO Position: after split: PositionStock(asset:Equity(3579 [002833.SZA]), amount:2273.0, cost_basis:24.5614, last_sale_price:40.439998626708984)
[2022-05-17 09:57:30.537806] INFO: cached.v2.9781b4f8: [2022-05-17 09:57:23.104452] INFO Position: returning cash: 18.2886
[2022-05-17 09:57:30.539555] INFO: cached.v2.9781b4f8: [2022-05-17 09:57:24.086750] INFO algo: handle_splits get splits [dt:2020-06-05 00:00:00+00:00] [asset:Equity(2657 [600173.SHA]), ratio:0.9679487347602844]
[2022-05-17 09:57:30.541819] INFO: cached.v2.9781b4f8: [2022-05-17 09:57:24.086859] INFO algo: handle_splits get splits [dt:2020-06-05 00:00:00+00:00] [asset:Equity(2367 [603109.SHA]), ratio:0.9926040768623352]
[2022-05-17 09:57:30.542787] INFO: cached.v2.9781b4f8: [2022-05-17 09:57:24.087015] INFO Position: position stock handle split[sid:2657, orig_amount:12400, new_amount:12810.0, orig_cost:4.730008340686317, new_cost:4.5784, ratio:0.9679487347602844, last_sale_price:4.529999732971191]
[2022-05-17 09:57:30.543703] INFO: cached.v2.9781b4f8: [2022-05-17 09:57:24.087089] INFO Position: after split: PositionStock(asset:Equity(2657 [600173.SHA]), amount:12810.0, cost_basis:4.5784, last_sale_price:4.679999828338623)
[2022-05-17 09:57:30.544780] INFO: cached.v2.9781b4f8: [2022-05-17 09:57:24.087134] INFO Position: returning cash: 2.699
[2022-05-17 09:57:30.545758] INFO: cached.v2.9781b4f8: [2022-05-17 09:57:24.874359] INFO algo: handle_splits get splits [dt:2020-06-09 00:00:00+00:00] [asset:Equity(396 [603311.SHA]), ratio:0.9864288568496704]
[2022-05-17 09:57:30.546909] INFO: cached.v2.9781b4f8: [2022-05-17 09:57:24.874568] INFO Position: position stock handle split[sid:396, orig_amount:4700, new_amount:4764.0, orig_cost:11.830006837215812, new_cost:11.6695, ratio:0.9864288568496704, last_sale_price:11.629996299743652]
[2022-05-17 09:57:30.547910] INFO: cached.v2.9781b4f8: [2022-05-17 09:57:24.874786] INFO Position: after split: PositionStock(asset:Equity(396 [603311.SHA]), amount:4764.0, cost_basis:11.6695, last_sale_price:11.789999961853027)
[2022-05-17 09:57:30.548846] INFO: cached.v2.9781b4f8: [2022-05-17 09:57:24.875113] INFO Position: returning cash: 7.698
[2022-05-17 09:57:30.549736] INFO: cached.v2.9781b4f8: [2022-05-17 09:57:26.872067] INFO algo: handle_splits get splits [dt:2020-06-19 00:00:00+00:00] [asset:Equity(638 [300789.SZA]), ratio:0.9939152598381042]
[2022-05-17 09:57:30.550625] INFO: cached.v2.9781b4f8: [2022-05-17 09:57:28.385844] INFO algo: handle_splits get splits [dt:2020-06-29 00:00:00+00:00] [asset:Equity(3945 [002046.SZA]), ratio:0.9980315566062927]
[2022-05-17 09:57:30.551525] INFO: cached.v2.9781b4f8: [2022-05-17 09:57:29.616536] INFO algo: handle_splits get splits [dt:2020-07-03 00:00:00+00:00] [asset:Equity(5106 [603726.SHA]), ratio:0.9751243591308594]
[2022-05-17 09:57:30.552549] INFO: cached.v2.9781b4f8: [2022-05-17 09:57:29.616691] INFO Position: position stock handle split[sid:5106, orig_amount:4500, new_amount:4614.0, orig_cost:13.890001943444274, new_cost:13.5445, ratio:0.9751243591308594, last_sale_price:13.720000267028809]
[2022-05-17 09:57:30.553660] INFO: cached.v2.9781b4f8: [2022-05-17 09:57:29.616765] INFO Position: after split: PositionStock(asset:Equity(5106 [603726.SHA]), amount:4614.0, cost_basis:13.5445, last_sale_price:14.070000648498535)
[2022-05-17 09:57:30.554689] INFO: cached.v2.9781b4f8: [2022-05-17 09:57:29.616824] INFO Position: returning cash: 10.9212
[2022-05-17 09:57:30.829805] INFO: cached.v2.979c6faa: [2022-05-17 09:57:21.583370] INFO moduleinvoker: backtest.v8 开始运行..
[2022-05-17 09:57:30.831989] INFO: cached.v2.979c6faa: [2022-05-17 09:57:21.587650] INFO backtest: biglearning backtest:V8.6.2
[2022-05-17 09:57:30.833741] INFO: cached.v2.979c6faa: [2022-05-17 09:57:21.587761] INFO backtest: product_type:stock by specified
[2022-05-17 09:57:30.835471] INFO: cached.v2.979c6faa: [2022-05-17 09:57:21.684186] INFO moduleinvoker: cached.v2 开始运行..
[2022-05-17 09:57:30.836947] INFO: cached.v2.979c6faa: [2022-05-17 09:57:21.712366] INFO moduleinvoker: 命中缓存
[2022-05-17 09:57:30.838243] INFO: cached.v2.979c6faa: [2022-05-17 09:57:21.713178] INFO moduleinvoker: cached.v2 运行完成[0.028813s].
[2022-05-17 09:57:30.839660] INFO: cached.v2.979c6faa: [2022-05-17 09:57:23.147732] INFO algo: TradingAlgorithm V1.8.7
[2022-05-17 09:57:30.840977] INFO: cached.v2.979c6faa: [2022-05-17 09:57:23.820749] INFO algo: trading transform...
[2022-05-17 09:57:40.412701] INFO: cached.v2.9781d88e: [2022-05-17 09:57:35.276840] INFO algo: handle_splits get splits [dt:2018-08-29 00:00:00+00:00] [asset:Equity(12 [600687.SHA]), ratio:0.9910112619400024]
[2022-05-17 09:57:40.415685] INFO: cached.v2.9781d88e: [2022-05-17 09:57:38.387874] INFO algo: handle_splits get splits [dt:2018-09-13 00:00:00+00:00] [asset:Equity(1068 [002733.SZA]), ratio:0.9946523904800415]
[2022-05-17 09:57:40.419223] INFO: cached.v2.9781d88e: [2022-05-17 09:57:38.388035] INFO Position: position stock handle split[sid:1068, orig_amount:4200, new_amount:4222.0, orig_cost:9.220003144108757, new_cost:9.1707, ratio:0.9946523904800415, last_sale_price:9.300000190734863]
[2022-05-17 09:57:40.421813] INFO: cached.v2.9781d88e: [2022-05-17 09:57:38.388183] INFO Position: after split: PositionStock(asset:Equity(1068 [002733.SZA]), amount:4222.0, cost_basis:9.1707, last_sale_price:9.350000381469727)
[2022-05-17 09:57:40.423838] INFO: cached.v2.9781d88e: [2022-05-17 09:57:38.388311] INFO Position: returning cash: 5.4006
[2022-05-17 09:57:40.603510] INFO: cached.v2.9781b4f8: [2022-05-17 09:57:30.859792] INFO algo: handle_splits get splits [dt:2020-07-08 00:00:00+00:00] [asset:Equity(713 [603703.SHA]), ratio:0.9992663264274597]
[2022-05-17 09:57:40.605220] INFO: cached.v2.9781b4f8: [2022-05-17 09:57:30.860080] INFO Position: position stock handle split[sid:713, orig_amount:4400, new_amount:4403.0, orig_cost:13.839999272354412, new_cost:13.8298, ratio:0.9992663264274597, last_sale_price:13.619999885559082]
[2022-05-17 09:57:40.608737] INFO: cached.v2.9781b4f8: [2022-05-17 09:57:30.860315] INFO Position: after split: PositionStock(asset:Equity(713 [603703.SHA]), amount:4403.0, cost_basis:13.8298, last_sale_price:13.630000114440918)
[2022-05-17 09:57:40.611909] INFO: cached.v2.9781b4f8: [2022-05-17 09:57:30.860402] INFO Position: returning cash: 3.1399
[2022-05-17 09:57:40.614042] INFO: cached.v2.9781b4f8: [2022-05-17 09:57:31.575377] INFO algo: handle_splits get splits [dt:2020-07-10 00:00:00+00:00] [asset:Equity(4098 [603879.SHA]), ratio:0.716994047164917]
[2022-05-17 09:57:40.616719] INFO: cached.v2.9781b4f8: [2022-05-17 09:57:31.575551] INFO Position: position stock handle split[sid:4098, orig_amount:12300, new_amount:17154.0, orig_cost:13.33390215075278, new_cost:9.5603, ratio:0.716994047164917, last_sale_price:10.590002059936523]
[2022-05-17 09:57:40.619191] INFO: cached.v2.9781b4f8: [2022-05-17 09:57:31.575626] INFO Position: after split: PositionStock(asset:Equity(4098 [603879.SHA]), amount:17154.0, cost_basis:9.5603, last_sale_price:14.769999504089355)
[2022-05-17 09:57:40.620991] INFO: cached.v2.9781b4f8: [2022-05-17 09:57:31.575670] INFO Position: returning cash: 10.1044
[2022-05-17 09:57:40.623544] INFO: cached.v2.9781b4f8: [2022-05-17 09:57:34.225976] INFO algo: handle_splits get splits [dt:2020-07-23 00:00:00+00:00] [asset:Equity(591 [600077.SHA]), ratio:0.9876161813735962]
[2022-05-17 09:57:40.625305] INFO: cached.v2.9781b4f8: [2022-05-17 09:57:34.226087] INFO algo: handle_splits get splits [dt:2020-07-23 00:00:00+00:00] [asset:Equity(4537 [603689.SHA]), ratio:0.980857253074646]
[2022-05-17 09:57:40.627607] INFO: cached.v2.9781b4f8: [2022-05-17 09:57:34.226232] INFO Position: position stock handle split[sid:591, orig_amount:22100, new_amount:22377.0, orig_cost:3.2400007041980996, new_cost:3.1999, ratio:0.9876161813735962, last_sale_price:3.190000057220459]
[2022-05-17 09:57:40.630317] INFO: cached.v2.9781b4f8: [2022-05-17 09:57:34.226305] INFO Position: after split: PositionStock(asset:Equity(591 [600077.SHA]), amount:22377.0, cost_basis:3.1999, last_sale_price:3.2299997806549072)
[2022-05-17 09:57:40.637968] INFO: cached.v2.9781b4f8: [2022-05-17 09:57:34.226363] INFO Position: returning cash: 0.3641
[2022-05-17 09:57:40.639981] INFO: cached.v2.9781b4f8: [2022-05-17 09:57:34.226437] INFO Position: position stock handle split[sid:4537, orig_amount:6500, new_amount:6626.0, orig_cost:10.980002874568402, new_cost:10.7698, ratio:0.980857253074646, last_sale_price:10.760003089904785]
[2022-05-17 09:57:40.642353] INFO: cached.v2.9781b4f8: [2022-05-17 09:57:34.226494] INFO Position: after split: PositionStock(asset:Equity(4537 [603689.SHA]), amount:6626.0, cost_basis:10.7698, last_sale_price:10.969999313354492)
[2022-05-17 09:57:40.643874] INFO: cached.v2.9781b4f8: [2022-05-17 09:57:34.226534] INFO Position: returning cash: 9.2131
[2022-05-17 09:57:40.644986] INFO: cached.v2.9781b4f8: [2022-05-17 09:57:37.890821] INFO algo: handle_splits get splits [dt:2020-08-06 00:00:00+00:00] [asset:Equity(1204 [300799.SZA]), ratio:0.6652452945709229]
[2022-05-17 09:57:40.648315] INFO: cached.v2.9781b4f8: [2022-05-17 09:57:37.891022] INFO Position: position stock handle split[sid:1204, orig_amount:500, new_amount:751.0, orig_cost:94.01000541385766, new_cost:62.5397, ratio:0.6652452945709229, last_sale_price:62.40000915527344]
[2022-05-17 09:57:40.650151] INFO: cached.v2.9781b4f8: [2022-05-17 09:57:37.891099] INFO Position: after split: PositionStock(asset:Equity(1204 [300799.SZA]), amount:751.0, cost_basis:62.5397, last_sale_price:93.80000305175781)
[2022-05-17 09:57:40.651360] INFO: cached.v2.9781b4f8: [2022-05-17 09:57:37.891145] INFO Position: returning cash: 37.5935
[2022-05-17 09:57:50.262264] INFO: cached.v2.977b4bc2: [2022-05-17 09:57:47.302735] INFO 自动标注(股票): 加载历史数据: 1699791 行
[2022-05-17 09:57:50.263873] INFO: cached.v2.977b4bc2: [2022-05-17 09:57:47.302876] INFO 自动标注(股票): 开始标注 ..
[2022-05-17 09:57:50.389172] INFO: cached.v2.9785eda2: [2022-05-17 09:57:48.597152] INFO 自动标注(股票): 加载历史数据: 1781192 行
[2022-05-17 09:57:50.392081] INFO: cached.v2.9785eda2: [2022-05-17 09:57:48.597263] INFO 自动标注(股票): 开始标注 ..
[2022-05-17 09:57:50.951563] INFO: cached.v2.979c6faa: [2022-05-17 09:57:47.824049] INFO algo: handle_splits get splits [dt:2016-05-05 00:00:00+00:00] [asset:Equity(417 [300430.SZA]), ratio:0.9976655840873718]
[2022-05-17 09:57:50.953176] INFO: cached.v2.979c6faa: [2022-05-17 09:57:47.824232] INFO Position: position stock handle split[sid:417, orig_amount:1100, new_amount:1102.0, orig_cost:45.69000736293706, new_cost:45.5833, ratio:0.9976655840873718, last_sale_price:47.010005950927734]
[2022-05-17 09:57:50.954285] INFO: cached.v2.979c6faa: [2022-05-17 09:57:47.824309] INFO Position: after split: PositionStock(asset:Equity(417 [300430.SZA]), amount:1102.0, cost_basis:45.5833, last_sale_price:47.12000274658203)
[2022-05-17 09:57:50.955452] INFO: cached.v2.979c6faa: [2022-05-17 09:57:47.824355] INFO Position: returning cash: 26.9774
[2022-05-17 09:58:00.336458] INFO: cached.v2.977b4bc2: [2022-05-17 09:57:51.175619] INFO moduleinvoker: advanced_auto_labeler.v2 运行完成[55.527637s].
[2022-05-17 09:58:00.337957] INFO: cached.v2.977b4bc2: [2022-05-17 09:57:51.178794] INFO moduleinvoker: input_features.v1 开始运行..
[2022-05-17 09:58:00.339018] INFO: cached.v2.977b4bc2: [2022-05-17 09:57:51.183919] INFO moduleinvoker: 命中缓存
[2022-05-17 09:58:00.340155] INFO: cached.v2.977b4bc2: [2022-05-17 09:57:51.184262] INFO moduleinvoker: input_features.v1 运行完成[0.00554s].
[2022-05-17 09:58:00.341354] INFO: cached.v2.977b4bc2: [2022-05-17 09:57:51.194021] INFO moduleinvoker: use_datasource.v1 开始运行..
[2022-05-17 09:58:00.342452] INFO: cached.v2.977b4bc2: [2022-05-17 09:57:51.209895] INFO moduleinvoker: 命中缓存
[2022-05-17 09:58:00.343461] INFO: cached.v2.977b4bc2: [2022-05-17 09:57:51.210262] INFO moduleinvoker: use_datasource.v1 运行完成[0.016315s].
[2022-05-17 09:58:00.344592] INFO: cached.v2.977b4bc2: [2022-05-17 09:57:51.248628] INFO moduleinvoker: index_feature_extract.v3 开始运行..
[2022-05-17 09:58:00.345722] INFO: cached.v2.977b4bc2: [2022-05-17 09:57:51.259204] INFO moduleinvoker: 命中缓存
[2022-05-17 09:58:00.346770] INFO: cached.v2.977b4bc2: [2022-05-17 09:57:51.259588] INFO moduleinvoker: index_feature_extract.v3 运行完成[0.011093s].
[2022-05-17 09:58:00.347788] INFO: cached.v2.977b4bc2: [2022-05-17 09:57:51.280763] INFO moduleinvoker: general_feature_extractor.v7 开始运行..
[2022-05-17 09:58:00.348802] INFO: cached.v2.977b4bc2: [2022-05-17 09:57:53.404962] INFO 基础特征抽取: 年份 2011, 特征行数=94658
[2022-05-17 09:58:00.444567] INFO: cached.v2.9785eda2: [2022-05-17 09:57:51.048631] INFO moduleinvoker: advanced_auto_labeler.v2 运行完成[54.856023s].
[2022-05-17 09:58:00.446034] INFO: cached.v2.9785eda2: [2022-05-17 09:57:51.052730] INFO moduleinvoker: input_features.v1 开始运行..
[2022-05-17 09:58:00.447263] INFO: cached.v2.9785eda2: [2022-05-17 09:57:51.058336] INFO moduleinvoker: 命中缓存
[2022-05-17 09:58:00.448258] INFO: cached.v2.9785eda2: [2022-05-17 09:57:51.058666] INFO moduleinvoker: input_features.v1 运行完成[0.006027s].
[2022-05-17 09:58:00.449221] INFO: cached.v2.9785eda2: [2022-05-17 09:57:51.063712] INFO moduleinvoker: use_datasource.v1 开始运行..
[2022-05-17 09:58:00.450193] INFO: cached.v2.9785eda2: [2022-05-17 09:57:51.590072] INFO moduleinvoker: use_datasource.v1 运行完成[0.526307s].
[2022-05-17 09:58:00.451156] INFO: cached.v2.9785eda2: [2022-05-17 09:57:51.630284] INFO moduleinvoker: index_feature_extract.v3 开始运行..
[2022-05-17 09:58:00.452130] INFO: cached.v2.9785eda2: [2022-05-17 09:57:51.825177] INFO moduleinvoker: derived_feature_extractor.v3 开始运行..
[2022-05-17 09:58:00.453085] INFO: cached.v2.9785eda2: [2022-05-17 09:57:51.889563] INFO derived_feature_extractor: 提取完成 bm_0 = where(close/shift(close,5)-1[2022-05-17 09:58:00.454070] INFO: cached.v2.9785eda2: [2022-05-17 09:57:51.996563] INFO derived_feature_extractor: /data, 310
[2022-05-17 09:58:00.455002] INFO: cached.v2.9785eda2: [2022-05-17 09:57:52.213562] INFO moduleinvoker: derived_feature_extractor.v3 运行完成[0.388359s].
[2022-05-17 09:58:00.455914] INFO: cached.v2.9785eda2: [2022-05-17 09:57:52.660535] INFO moduleinvoker: index_feature_extract.v3 运行完成[1.03024s].
[2022-05-17 09:58:00.456876] INFO: cached.v2.9785eda2: [2022-05-17 09:57:52.694400] INFO moduleinvoker: general_feature_extractor.v7 开始运行..
[2022-05-17 09:58:00.457930] INFO: cached.v2.9785eda2: [2022-05-17 09:57:56.279110] INFO 基础特征抽取: 年份 2016, 特征行数=119373
[2022-05-17 09:58:00.512139] INFO: cached.v2.9781d88e: [2022-05-17 09:57:57.942840] INFO Performance: Simulated 243 trading days out of 243.
[2022-05-17 09:58:00.514649] INFO: cached.v2.9781d88e: [2022-05-17 09:57:57.942940] INFO Performance: first open: 2018-01-02 09:30:00+00:00
[2022-05-17 09:58:00.517009] INFO: cached.v2.9781d88e: [2022-05-17 09:57:57.942995] INFO Performance: last close: 2018-12-28 15:00:00+00:00
[2022-05-17 09:58:00.518689] INFO: cached.v2.9781d88e: [2022-05-17 09:57:59.638336] INFO moduleinvoker: backtest.v8 运行完成[64.58873s].
[2022-05-17 09:58:00.519833] INFO: cached.v2.9781d88e: [2022-05-17 09:57:59.638483] INFO moduleinvoker: trade.v4 运行完成[66.465081s].
[2022-05-17 09:58:00.998006] INFO: cached.v2.979c6faa: [2022-05-17 09:57:55.673025] INFO algo: handle_splits get splits [dt:2016-06-03 00:00:00+00:00] [asset:Equity(1042 [300240.SZA]), ratio:0.6664659380912781]
[2022-05-17 09:58:01.000025] INFO: cached.v2.979c6faa: [2022-05-17 09:57:55.673192] INFO Position: position stock handle split[sid:1042, orig_amount:6700, new_amount:10053.0, orig_cost:16.334179832535405, new_cost:10.8862, ratio:0.6664659380912781, last_sale_price:11.069998741149902]
[2022-05-17 09:58:01.002010] INFO: cached.v2.979c6faa: [2022-05-17 09:57:55.673266] INFO Position: after split: PositionStock(asset:Equity(1042 [300240.SZA]), amount:10053.0, cost_basis:10.8862, last_sale_price:16.60999870300293)
[2022-05-17 09:58:01.004063] INFO: cached.v2.979c6faa: [2022-05-17 09:57:55.673311] INFO Position: returning cash: 0.2977
[2022-05-17 09:58:01.007122] INFO: cached.v2.979c6faa: [2022-05-17 09:57:56.288621] INFO algo: handle_splits get splits [dt:2016-06-07 00:00:00+00:00] [asset:Equity(581 [300063.SZA]), ratio:0.9993624091148376]
[2022-05-17 09:58:01.009439] INFO: cached.v2.979c6faa: [2022-05-17 09:57:56.288776] INFO Position: position stock handle split[sid:581, orig_amount:1900, new_amount:1901.0, orig_cost:31.290001363286372, new_cost:31.2701, ratio:0.9993624091148376, last_sale_price:31.349998474121094]
[2022-05-17 09:58:01.011063] INFO: cached.v2.979c6faa: [2022-05-17 09:57:56.288850] INFO Position: after split: PositionStock(asset:Equity(581 [300063.SZA]), amount:1901.0, cost_basis:31.2701, last_sale_price:31.369998931884766)
[2022-05-17 09:58:01.012864] INFO: cached.v2.979c6faa: [2022-05-17 09:57:56.288896] INFO Position: returning cash: 6.6523
[2022-05-17 09:58:01.014877] INFO: cached.v2.979c6faa: [2022-05-17 09:57:58.907144] INFO algo: handle_splits get splits [dt:2016-06-17 00:00:00+00:00] [asset:Equity(1299 [300007.SZA]), ratio:0.9990098476409912]
[2022-05-17 09:58:01.016569] INFO: cached.v2.979c6faa: [2022-05-17 09:57:58.907477] INFO Position: position stock handle split[sid:1299, orig_amount:2600, new_amount:2602.0, orig_cost:18.350000593588952, new_cost:18.3318, ratio:0.9990098476409912, last_sale_price:20.18000030517578]
[2022-05-17 09:58:01.018095] INFO: cached.v2.979c6faa: [2022-05-17 09:57:58.907625] INFO Position: after split: PositionStock(asset:Equity(1299 [300007.SZA]), amount:2602.0, cost_basis:18.3318, last_sale_price:20.200000762939453)
[2022-05-17 09:58:01.019499] INFO: cached.v2.979c6faa: [2022-05-17 09:57:58.907730] INFO Position: returning cash: 11.6428
[2022-05-17 09:58:01.021111] INFO: cached.v2.979c6faa: [2022-05-17 09:57:59.773241] INFO algo: handle_splits get splits [dt:2016-06-21 00:00:00+00:00] [asset:Equity(702 [600605.SHA]), ratio:0.9989201426506042]
[2022-05-17 09:58:01.023152] INFO: cached.v2.979c6faa: [2022-05-17 09:57:59.773412] INFO Position: position stock handle split[sid:702, orig_amount:2700, new_amount:2702.0, orig_cost:19.060003995992755, new_cost:19.0394, ratio:0.9989201426506042, last_sale_price:18.5]
[2022-05-17 09:58:01.025248] INFO: cached.v2.979c6faa: [2022-05-17 09:57:59.773496] INFO Position: after split: PositionStock(asset:Equity(702 [600605.SHA]), amount:2702.0, cost_basis:19.0394, last_sale_price:18.51999855041504)
[2022-05-17 09:58:01.026861] INFO: cached.v2.979c6faa: [2022-05-17 09:57:59.773542] INFO Position: returning cash: 16.9972
[2022-05-17 09:58:10.422815] INFO: cached.v2.977b4bc2: [2022-05-17 09:58:05.659496] INFO 基础特征抽取: 年份 2012, 特征行数=565675
[2022-05-17 09:58:10.562971] INFO: cached.v2.9781d88e: 任务状态: Succeeded
[2022-05-17 09:58:10.839354] INFO: cached.v2.9781b4f8: [2022-05-17 09:58:04.359792] INFO algo: handle_splits get splits [dt:2020-12-03 00:00:00+00:00] [asset:Equity(4875 [600853.SHA]), ratio:0.8299121260643005]
[2022-05-17 09:58:10.932461] INFO: moduleinvoker: cached.v2 运行完成[91.420527s].
[2022-05-17 09:58:10.934611] INFO: AI: [ParallelEx(n_jobs=30)]: Done 1 tasks | elapsed: 1.5min
[2022-05-17 09:58:10.952351] INFO: cached.v2.9785fad6: [2022-05-17 09:58:01.086478] INFO Performance: Simulated 82 trading days out of 82.
[2022-05-17 09:58:10.954304] INFO: cached.v2.9785fad6: [2022-05-17 09:58:01.086620] INFO Performance: first open: 2022-01-04 09:30:00+00:00
[2022-05-17 09:58:10.955908] INFO: cached.v2.9785fad6: [2022-05-17 09:58:01.086717] INFO Performance: last close: 2022-05-11 15:00:00+00:00
[2022-05-17 09:58:10.957078] INFO: cached.v2.9785fad6: [2022-05-17 09:58:02.945857] INFO moduleinvoker: backtest.v8 运行完成[64.788348s].
[2022-05-17 09:58:10.958034] INFO: cached.v2.9785fad6: [2022-05-17 09:58:02.945982] INFO moduleinvoker: trade.v4 运行完成[66.721193s].
[2022-05-17 09:58:10.958944] INFO: cached.v2.9785fad6: 任务状态: Succeeded
[2022-05-17 09:58:10.965456] INFO: moduleinvoker: cached.v2 运行完成[91.445517s].
[2022-05-17 09:58:10.966946] INFO: AI: [ParallelEx(n_jobs=30)]: Done 2 out of 9 | elapsed: 1.5min remaining: 5.3min
[2022-05-17 09:58:20.883776] INFO: cached.v2.9781b4f8: [2022-05-17 09:58:11.282697] INFO Performance: Simulated 243 trading days out of 243.
[2022-05-17 09:58:20.886921] INFO: cached.v2.9781b4f8: [2022-05-17 09:58:11.282803] INFO Performance: first open: 2020-01-02 09:30:00+00:00
[2022-05-17 09:58:20.888842] INFO: cached.v2.9781b4f8: [2022-05-17 09:58:11.282859] INFO Performance: last close: 2020-12-31 15:00:00+00:00
[2022-05-17 09:58:20.890415] INFO: cached.v2.9781b4f8: [2022-05-17 09:58:14.505970] INFO moduleinvoker: backtest.v8 运行完成[77.991804s].
[2022-05-17 09:58:20.892706] INFO: cached.v2.9781b4f8: [2022-05-17 09:58:14.506099] INFO moduleinvoker: trade.v4 运行完成[79.949139s].
[2022-05-17 09:58:20.894174] INFO: cached.v2.9781b4f8: 任务状态: Succeeded
[2022-05-17 09:58:20.903729] INFO: moduleinvoker: cached.v2 运行完成[101.400836s].
[2022-05-17 09:58:20.907181] INFO: AI: [ParallelEx(n_jobs=30)]: Done 3 out of 9 | elapsed: 1.7min remaining: 3.4min
[2022-05-17 09:58:30.564866] INFO: cached.v2.977b4bc2: [2022-05-17 09:58:25.315007] INFO 基础特征抽取: 年份 2013, 特征行数=564168
[2022-05-17 09:58:30.723870] INFO: cached.v2.9781f3b4: [2022-05-17 09:58:24.367680] INFO algo: handle_splits get splits [dt:2014-06-11 00:00:00+00:00] [asset:Equity(2795 [300211.SZA]), ratio:0.7654380202293396]
[2022-05-17 09:58:30.726427] INFO: cached.v2.9781f3b4: [2022-05-17 09:58:24.367892] INFO Position: position stock handle split[sid:2795, orig_amount:3100, new_amount:4049.0, orig_cost:20.43003743422957, new_cost:15.6379, ratio:0.7654380202293396, last_sale_price:15.989999771118164]
[2022-05-17 09:58:30.728015] INFO: cached.v2.9781f3b4: [2022-05-17 09:58:24.367976] INFO Position: after split: PositionStock(asset:Equity(2795 [300211.SZA]), amount:4049.0, cost_basis:15.6379, last_sale_price:20.889999389648438)
[2022-05-17 09:58:30.729042] INFO: cached.v2.9781f3b4: [2022-05-17 09:58:24.368026] INFO Position: returning cash: 15.489
[2022-05-17 09:58:30.730334] INFO: cached.v2.9781f3b4: [2022-05-17 09:58:24.954710] INFO algo: handle_splits get splits [dt:2014-06-12 00:00:00+00:00] [asset:Equity(160 [000890.SZA]), ratio:0.9951220154762268]
[2022-05-17 09:58:31.182998] INFO: cached.v2.979c6faa: [2022-05-17 09:58:23.697318] INFO algo: handle_splits get splits [dt:2016-09-29 00:00:00+00:00] [asset:Equity(3278 [603909.SHA]), ratio:0.9993883371353149]
[2022-05-17 09:58:31.185052] INFO: cached.v2.979c6faa: [2022-05-17 09:58:23.697503] INFO Position: position stock handle split[sid:3278, orig_amount:2500, new_amount:2501.0, orig_cost:49.62960334935748, new_cost:49.5992, ratio:0.9993883371353149, last_sale_price:49.03998565673828]
[2022-05-17 09:58:31.186712] INFO: cached.v2.979c6faa: [2022-05-17 09:58:23.697591] INFO Position: after split: PositionStock(asset:Equity(3278 [603909.SHA]), amount:2501.0, cost_basis:49.5992, last_sale_price:49.06999969482422)
[2022-05-17 09:58:31.188137] INFO: cached.v2.979c6faa: [2022-05-17 09:58:23.697639] INFO Position: returning cash: 25.9958
[2022-05-17 09:58:40.727319] INFO: cached.v2.9785eda2: [2022-05-17 09:58:37.931132] INFO 基础特征抽取: 年份 2017, 特征行数=743233
[2022-05-17 09:58:40.729038] INFO: cached.v2.9785eda2: [2022-05-17 09:58:38.263269] INFO 基础特征抽取: 总行数: 862606
[2022-05-17 09:58:40.730057] INFO: cached.v2.9785eda2: [2022-05-17 09:58:38.276134] INFO moduleinvoker: general_feature_extractor.v7 运行完成[45.581709s].
[2022-05-17 09:58:40.731006] INFO: cached.v2.9785eda2: [2022-05-17 09:58:38.290166] INFO moduleinvoker: general_feature_extractor.v7 开始运行..
[2022-05-17 09:58:40.775317] INFO: cached.v2.9781f3b4: [2022-05-17 09:58:40.387488] INFO algo: handle_splits get splits [dt:2014-07-09 00:00:00+00:00] [asset:Equity(106 [002599.SZA]), ratio:0.9979183673858643]
[2022-05-17 09:58:40.777364] INFO: cached.v2.9781f3b4: [2022-05-17 09:58:40.387644] INFO Position: position stock handle split[sid:106, orig_amount:4300, new_amount:4308.0, orig_cost:14.200007990038257, new_cost:14.1704, ratio:0.9979183673858643, last_sale_price:14.3800048828125]
[2022-05-17 09:58:40.779663] INFO: cached.v2.9781f3b4: [2022-05-17 09:58:40.387718] INFO Position: after split: PositionStock(asset:Equity(106 [002599.SZA]), amount:4308.0, cost_basis:14.1704, last_sale_price:14.410000801086426)
[2022-05-17 09:58:40.781865] INFO: cached.v2.9781f3b4: [2022-05-17 09:58:40.387761] INFO Position: returning cash: 13.9442
[2022-05-17 09:58:41.240140] INFO: cached.v2.979c6faa: [2022-05-17 09:58:39.202967] INFO algo: handle_splits get splits [dt:2016-12-15 00:00:00+00:00] [asset:Equity(2140 [002810.SZA]), ratio:0.9969483017921448]
[2022-05-17 09:58:50.786271] INFO: cached.v2.9785eda2: [2022-05-17 09:58:40.778719] INFO 基础特征抽取: 年份 2013, 特征行数=98486
[2022-05-17 09:58:51.291675] INFO: cached.v2.979c6faa: [2022-05-17 09:58:42.980347] INFO Performance: Simulated 244 trading days out of 244.
[2022-05-17 09:58:51.294453] INFO: cached.v2.979c6faa: [2022-05-17 09:58:42.980450] INFO Performance: first open: 2016-01-04 09:30:00+00:00
[2022-05-17 09:58:51.297082] INFO: cached.v2.979c6faa: [2022-05-17 09:58:42.980515] INFO Performance: last close: 2016-12-30 15:00:00+00:00
[2022-05-17 09:58:51.299347] INFO: cached.v2.979c6faa: [2022-05-17 09:58:44.228996] INFO moduleinvoker: backtest.v8 运行完成[82.645642s].
[2022-05-17 09:58:51.300849] INFO: cached.v2.979c6faa: [2022-05-17 09:58:44.229128] INFO moduleinvoker: trade.v4 运行完成[84.405694s].
[2022-05-17 09:58:51.302915] INFO: cached.v2.979c6faa: 任务状态: Succeeded
[2022-05-17 09:58:51.308656] INFO: moduleinvoker: cached.v2 运行完成[131.824017s].
[2022-05-17 09:58:51.311164] INFO: AI: [ParallelEx(n_jobs=30)]: Done 4 out of 9 | elapsed: 2.2min remaining: 2.7min
[2022-05-17 09:59:00.882831] INFO: cached.v2.977b4bc2: [2022-05-17 09:58:52.386167] INFO 基础特征抽取: 年份 2014, 特征行数=569948
[2022-05-17 09:59:00.884366] INFO: cached.v2.977b4bc2: [2022-05-17 09:58:52.509069] INFO 基础特征抽取: 总行数: 1794449
[2022-05-17 09:59:00.885498] INFO: cached.v2.977b4bc2: [2022-05-17 09:58:52.513917] INFO moduleinvoker: general_feature_extractor.v7 运行完成[61.233212s].
[2022-05-17 09:59:00.886593] INFO: cached.v2.977b4bc2: [2022-05-17 09:58:52.526026] INFO moduleinvoker: general_feature_extractor.v7 开始运行..
[2022-05-17 09:59:00.889129] INFO: cached.v2.977b4bc2: [2022-05-17 09:58:52.532286] INFO moduleinvoker: 命中缓存
[2022-05-17 09:59:00.891332] INFO: cached.v2.977b4bc2: [2022-05-17 09:58:52.532643] INFO moduleinvoker: general_feature_extractor.v7 运行完成[0.006647s].
[2022-05-17 09:59:00.892884] INFO: cached.v2.977b4bc2: [2022-05-17 09:58:52.555074] INFO moduleinvoker: select_columns.v3 开始运行..
[2022-05-17 09:59:00.894466] INFO: cached.v2.977b4bc2: [2022-05-17 09:58:52.605658] INFO moduleinvoker: 命中缓存
[2022-05-17 09:59:00.895810] INFO: cached.v2.977b4bc2: [2022-05-17 09:58:52.606044] INFO moduleinvoker: select_columns.v3 运行完成[0.051024s].
[2022-05-17 09:59:00.897478] INFO: cached.v2.977b4bc2: [2022-05-17 09:58:52.621199] INFO moduleinvoker: derived_feature_extractor.v3 开始运行..
[2022-05-17 09:59:10.960792] INFO: cached.v2.9785eda2: [2022-05-17 09:59:08.992885] INFO 基础特征抽取: 年份 2014, 特征行数=569948
[2022-05-17 09:59:11.030904] INFO: cached.v2.97820ac0: [2022-05-17 09:59:03.210127] INFO algo: TradingAlgorithm V1.8.7
[2022-05-17 09:59:41.198899] INFO: cached.v2.9785eda2: [2022-05-17 09:59:31.469984] INFO 基础特征抽取: 年份 2015, 特征行数=569698
[2022-05-17 09:59:41.201047] INFO: cached.v2.9785eda2: [2022-05-17 09:59:34.982803] INFO 基础特征抽取: 年份 2016, 特征行数=641546
[2022-05-17 09:59:41.203291] INFO: cached.v2.9785eda2: [2022-05-17 09:59:35.161181] INFO 基础特征抽取: 总行数: 1879678
[2022-05-17 09:59:41.205392] INFO: cached.v2.9785eda2: [2022-05-17 09:59:35.181963] INFO moduleinvoker: general_feature_extractor.v7 运行完成[56.891792s].
[2022-05-17 09:59:41.207235] INFO: cached.v2.9785eda2: [2022-05-17 09:59:35.200942] INFO moduleinvoker: select_columns.v3 开始运行..
[2022-05-17 09:59:41.208679] INFO: cached.v2.9785eda2: 列: ['date', 'bm_0']
[2022-05-17 09:59:41.210331] INFO: cached.v2.9785eda2: /data: 310
[2022-05-17 09:59:41.212479] INFO: cached.v2.9785eda2: [2022-05-17 09:59:35.568455] INFO moduleinvoker: select_columns.v3 运行完成[0.367496s].
[2022-05-17 09:59:41.215013] INFO: cached.v2.9785eda2: [2022-05-17 09:59:35.577448] INFO moduleinvoker: derived_feature_extractor.v3 开始运行..
[2022-05-17 09:59:41.216747] INFO: cached.v2.9785eda2: [2022-05-17 09:59:37.403018] INFO derived_feature_extractor: 提取完成 avg_amount_0/avg_amount_5, 0.004s
[2022-05-17 09:59:41.218479] INFO: cached.v2.9785eda2: [2022-05-17 09:59:37.407199] INFO derived_feature_extractor: 提取完成 avg_amount_5/avg_amount_20, 0.004s
[2022-05-17 09:59:41.219539] INFO: cached.v2.9785eda2: [2022-05-17 09:59:37.409944] INFO derived_feature_extractor: 提取完成 rank_avg_amount_0/rank_avg_amount_5, 0.003s
[2022-05-17 09:59:41.221363] INFO: cached.v2.9785eda2: [2022-05-17 09:59:37.412966] INFO derived_feature_extractor: 提取完成 rank_avg_amount_5/rank_avg_amount_10, 0.003s
[2022-05-17 09:59:41.223006] INFO: cached.v2.9785eda2: [2022-05-17 09:59:37.416225] INFO derived_feature_extractor: 提取完成 rank_return_0/rank_return_5, 0.003s
[2022-05-17 09:59:41.224412] INFO: cached.v2.9785eda2: [2022-05-17 09:59:37.419165] INFO derived_feature_extractor: 提取完成 rank_return_5/rank_return_10, 0.003s
[2022-05-17 09:59:41.226011] INFO: cached.v2.9785eda2: [2022-05-17 09:59:38.215483] INFO derived_feature_extractor: /y_2016, 119373
[2022-05-17 09:59:41.228762] INFO: cached.v2.9785eda2: [2022-05-17 09:59:39.693267] INFO derived_feature_extractor: /y_2017, 743233
[2022-05-17 09:59:41.230453] INFO: cached.v2.9785eda2: [2022-05-17 09:59:40.492019] INFO moduleinvoker: derived_feature_extractor.v3 运行完成[4.914604s].
[2022-05-17 09:59:41.231837] INFO: cached.v2.977b4bc2: [2022-05-17 09:59:31.357868] INFO derived_feature_extractor: 提取完成 avg_amount_0/avg_amount_5, 0.006s
[2022-05-17 09:59:41.232349] INFO: cached.v2.9785eda2: [2022-05-17 09:59:40.500673] INFO moduleinvoker: derived_feature_extractor.v3 开始运行..
[2022-05-17 09:59:41.233679] INFO: cached.v2.977b4bc2: [2022-05-17 09:59:31.363324] INFO derived_feature_extractor: 提取完成 avg_amount_5/avg_amount_20, 0.005s
[2022-05-17 09:59:41.235062] INFO: cached.v2.977b4bc2: [2022-05-17 09:59:31.366729] INFO derived_feature_extractor: 提取完成 rank_avg_amount_0/rank_avg_amount_5, 0.003s
[2022-05-17 09:59:41.236032] INFO: cached.v2.977b4bc2: [2022-05-17 09:59:31.370066] INFO derived_feature_extractor: 提取完成 rank_avg_amount_5/rank_avg_amount_10, 0.003s
[2022-05-17 09:59:41.237244] INFO: cached.v2.977b4bc2: [2022-05-17 09:59:31.373328] INFO derived_feature_extractor: 提取完成 rank_return_0/rank_return_5, 0.003s
[2022-05-17 09:59:41.238175] INFO: cached.v2.977b4bc2: [2022-05-17 09:59:31.376496] INFO derived_feature_extractor: 提取完成 rank_return_5/rank_return_10, 0.003s
[2022-05-17 09:59:41.239149] INFO: cached.v2.977b4bc2: [2022-05-17 09:59:32.449901] INFO derived_feature_extractor: /y_2011, 94658
[2022-05-17 09:59:41.240096] INFO: cached.v2.977b4bc2: [2022-05-17 09:59:33.622012] INFO derived_feature_extractor: /y_2012, 565675
[2022-05-17 09:59:41.241038] INFO: cached.v2.977b4bc2: [2022-05-17 09:59:35.166973] INFO derived_feature_extractor: /y_2013, 564168
[2022-05-17 09:59:41.241979] INFO: cached.v2.977b4bc2: [2022-05-17 09:59:36.955520] INFO derived_feature_extractor: /y_2014, 569948
[2022-05-17 09:59:41.242984] INFO: cached.v2.977b4bc2: [2022-05-17 09:59:37.613701] INFO moduleinvoker: derived_feature_extractor.v3 运行完成[44.992431s].
[2022-05-17 09:59:41.243950] INFO: cached.v2.977b4bc2: [2022-05-17 09:59:37.621439] INFO moduleinvoker: derived_feature_extractor.v3 开始运行..
[2022-05-17 09:59:41.244900] INFO: cached.v2.977b4bc2: [2022-05-17 09:59:37.629616] INFO moduleinvoker: 命中缓存
[2022-05-17 09:59:41.245867] INFO: cached.v2.977b4bc2: [2022-05-17 09:59:37.630026] INFO moduleinvoker: derived_feature_extractor.v3 运行完成[0.008635s].
[2022-05-17 09:59:41.246809] INFO: cached.v2.977b4bc2: [2022-05-17 09:59:37.639978] INFO moduleinvoker: join.v3 开始运行..
[2022-05-17 09:59:41.247750] INFO: cached.v2.977b4bc2: [2022-05-17 09:59:37.647615] INFO moduleinvoker: 命中缓存
[2022-05-17 09:59:41.248780] INFO: cached.v2.977b4bc2: [2022-05-17 09:59:37.648233] INFO moduleinvoker: join.v3 运行完成[0.0083s].
[2022-05-17 09:59:41.249765] INFO: cached.v2.977b4bc2: [2022-05-17 09:59:37.658401] INFO moduleinvoker: filter.v3 开始运行..
[2022-05-17 09:59:41.250708] INFO: cached.v2.977b4bc2: [2022-05-17 09:59:37.889873] INFO filter: 使用表达式 market_cap_float_0<5000000000 过滤
[2022-05-17 09:59:41.251668] INFO: cached.v2.977b4bc2: [2022-05-17 09:59:38.108237] INFO filter: 过滤 /y_2011, 72307/0/94658
[2022-05-17 09:59:41.252679] INFO: cached.v2.977b4bc2: [2022-05-17 09:59:38.907324] INFO filter: 过滤 /y_2012, 445737/0/565675
[2022-05-17 09:59:41.253778] INFO: cached.v2.977b4bc2: [2022-05-17 09:59:39.651424] INFO filter: 过滤 /y_2013, 423329/0/564168
[2022-05-17 09:59:41.254768] INFO: cached.v2.977b4bc2: [2022-05-17 09:59:40.407977] INFO filter: 过滤 /y_2014, 376173/0/569948
[2022-05-17 09:59:41.255724] INFO: cached.v2.977b4bc2: [2022-05-17 09:59:40.436951] INFO moduleinvoker: filter.v3 运行完成[2.778515s].
[2022-05-17 09:59:41.256686] INFO: cached.v2.977b4bc2: [2022-05-17 09:59:40.445178] INFO moduleinvoker: filter.v3 开始运行..
[2022-05-17 09:59:41.257636] INFO: cached.v2.977b4bc2: [2022-05-17 09:59:40.453424] INFO moduleinvoker: 命中缓存
[2022-05-17 09:59:41.258606] INFO: cached.v2.977b4bc2: [2022-05-17 09:59:40.453858] INFO moduleinvoker: filter.v3 运行完成[0.008775s].
[2022-05-17 09:59:41.259591] INFO: cached.v2.977b4bc2: [2022-05-17 09:59:40.461048] INFO moduleinvoker: join.v3 开始运行..
[2022-05-17 09:59:51.313993] INFO: cached.v2.9785eda2: [2022-05-17 09:59:44.311639] INFO derived_feature_extractor: 提取完成 avg_amount_0/avg_amount_5, 0.005s
[2022-05-17 09:59:51.317099] INFO: cached.v2.9785eda2: [2022-05-17 09:59:44.316619] INFO derived_feature_extractor: 提取完成 avg_amount_5/avg_amount_20, 0.005s
[2022-05-17 09:59:51.319180] INFO: cached.v2.9785eda2: [2022-05-17 09:59:44.319713] INFO derived_feature_extractor: 提取完成 rank_avg_amount_0/rank_avg_amount_5, 0.003s
[2022-05-17 09:59:51.320708] INFO: cached.v2.9785eda2: [2022-05-17 09:59:44.322658] INFO derived_feature_extractor: 提取完成 rank_avg_amount_5/rank_avg_amount_10, 0.003s
[2022-05-17 09:59:51.321916] INFO: cached.v2.9785eda2: [2022-05-17 09:59:44.325768] INFO derived_feature_extractor: 提取完成 rank_return_0/rank_return_5, 0.003s
[2022-05-17 09:59:51.324620] INFO: cached.v2.9785eda2: [2022-05-17 09:59:44.328643] INFO derived_feature_extractor: 提取完成 rank_return_5/rank_return_10, 0.003s
[2022-05-17 09:59:51.323712] INFO: cached.v2.977b4bc2: [2022-05-17 09:59:43.972738] INFO join: /y_2011, 行数=0/72307, 耗时=0.524136s
[2022-05-17 09:59:51.327667] INFO: cached.v2.977b4bc2: [2022-05-17 09:59:47.278334] INFO join: /y_2012, 行数=444709/445737, 耗时=3.304757s
[2022-05-17 09:59:51.326707] INFO: cached.v2.9785eda2: [2022-05-17 09:59:45.097642] INFO derived_feature_extractor: /y_2013, 98486
[2022-05-17 09:59:51.330390] INFO: cached.v2.9785eda2: [2022-05-17 09:59:47.081108] INFO derived_feature_extractor: /y_2014, 569948
[2022-05-17 09:59:51.329238] INFO: cached.v2.977b4bc2: [2022-05-17 09:59:49.234427] INFO join: /y_2013, 行数=422442/423329, 耗时=1.953193s
[2022-05-17 09:59:51.332893] INFO: cached.v2.9785eda2: [2022-05-17 09:59:48.672880] INFO derived_feature_extractor: /y_2015, 569698
[2022-05-17 09:59:51.335950] INFO: cached.v2.9785eda2: [2022-05-17 09:59:50.416479] INFO derived_feature_extractor: /y_2016, 641546
[2022-05-17 09:59:51.335298] INFO: cached.v2.977b4bc2: [2022-05-17 09:59:50.950128] INFO join: /y_2014, 行数=366809/376173, 耗时=1.712165s
[2022-05-17 09:59:51.339053] INFO: cached.v2.977b4bc2: [2022-05-17 09:59:51.151154] INFO join: 最终行数: 1233960
[2022-05-17 09:59:51.340133] INFO: cached.v2.977b4bc2: [2022-05-17 09:59:51.167979] INFO moduleinvoker: join.v3 运行完成[10.706851s].
[2022-05-17 09:59:51.341071] INFO: cached.v2.977b4bc2: [2022-05-17 09:59:51.196180] INFO moduleinvoker: dropnan.v1 开始运行..
[2022-05-17 09:59:51.341983] INFO: cached.v2.977b4bc2: [2022-05-17 09:59:51.204598] INFO moduleinvoker: 命中缓存
[2022-05-17 09:59:51.342889] INFO: cached.v2.977b4bc2: [2022-05-17 09:59:51.205185] INFO moduleinvoker: dropnan.v1 运行完成[0.009066s].
[2022-05-17 09:59:51.343789] INFO: cached.v2.977b4bc2: [2022-05-17 09:59:51.263105] INFO moduleinvoker: dropnan.v1 开始运行..
[2022-05-17 09:59:51.358486] INFO: cached.v2.97820ac0: [2022-05-17 09:59:44.168587] INFO algo: trading transform...
[2022-05-17 10:00:01.459656] INFO: cached.v2.977b4bc2: [2022-05-17 09:59:51.425138] INFO dropnan: /y_2011, 0/0
[2022-05-17 10:00:01.460538] INFO: cached.v2.9785eda2: [2022-05-17 09:59:51.577375] INFO moduleinvoker: derived_feature_extractor.v3 运行完成[11.076683s].
[2022-05-17 10:00:01.462695] INFO: cached.v2.977b4bc2: [2022-05-17 09:59:52.662506] INFO dropnan: /y_2012, 428117/444709
[2022-05-17 10:00:01.463326] INFO: cached.v2.9785eda2: [2022-05-17 09:59:51.586159] INFO moduleinvoker: join.v3 开始运行..
[2022-05-17 10:00:01.465167] INFO: cached.v2.9785eda2: [2022-05-17 09:59:53.992153] INFO join: /data, 行数=799063/799063, 耗时=2.31013s
[2022-05-17 10:00:01.466377] INFO: cached.v2.9785eda2: [2022-05-17 09:59:54.035044] INFO join: 最终行数: 799063
[2022-05-17 10:00:01.467516] INFO: cached.v2.9785eda2: [2022-05-17 09:59:54.040416] INFO moduleinvoker: join.v3 运行完成[2.454234s].
[2022-05-17 10:00:01.468659] INFO: cached.v2.9785eda2: [2022-05-17 09:59:54.049449] INFO moduleinvoker: filter.v3 开始运行..
[2022-05-17 10:00:01.470039] INFO: cached.v2.9785eda2: [2022-05-17 09:59:54.061556] INFO filter: 使用表达式 market_cap_float_0<5000000000 过滤
[2022-05-17 10:00:01.471451] INFO: cached.v2.9785eda2: [2022-05-17 09:59:54.904823] INFO filter: 过滤 /y_2016, 46478/0/119373
[2022-05-17 10:00:11.539626] INFO: cached.v2.9785eda2: [2022-05-17 10:00:11.157400] INFO filter: 过滤 /y_2017, 365578/0/743233
[2022-05-17 10:00:11.541138] INFO: cached.v2.9785eda2: [2022-05-17 10:00:11.191018] INFO moduleinvoker: filter.v3 运行完成[17.141509s].
[2022-05-17 10:00:11.542182] INFO: cached.v2.9785eda2: [2022-05-17 10:00:11.198167] INFO moduleinvoker: filter.v3 开始运行..
[2022-05-17 10:00:11.543161] INFO: cached.v2.9785eda2: [2022-05-17 10:00:11.213618] INFO filter: 使用表达式 market_cap_float_0<5000000000 过滤
[2022-05-17 10:00:11.544258] INFO: cached.v2.9785eda2: [2022-05-17 10:00:11.506381] INFO filter: 过滤 /y_2013, 70984/0/98486
[2022-05-17 10:00:11.584229] INFO: cached.v2.9776956e: [2022-05-17 10:00:09.215965] INFO backtest: 读取股票行情完成:2160246
[2022-05-17 10:00:21.626766] INFO: cached.v2.977b4bc2: [2022-05-17 10:00:11.576421] INFO dropnan: /y_2013, 417853/422442
[2022-05-17 10:00:21.628020] INFO: cached.v2.9785eda2: [2022-05-17 10:00:12.564511] INFO filter: 过滤 /y_2014, 376173/0/569948
[2022-05-17 10:00:21.629482] INFO: cached.v2.977b4bc2: [2022-05-17 10:00:13.128020] INFO dropnan: /y_2014, 360098/366809
[2022-05-17 10:00:21.630659] INFO: cached.v2.9785eda2: [2022-05-17 10:00:13.367511] INFO filter: 过滤 /y_2015, 238316/0/569698
[2022-05-17 10:00:21.631718] INFO: cached.v2.977b4bc2: [2022-05-17 10:00:13.253037] INFO dropnan: 行数: 1206068/1233960
[2022-05-17 10:00:21.632843] INFO: cached.v2.9785eda2: [2022-05-17 10:00:14.216460] INFO filter: 过滤 /y_2016, 270329/0/641546
[2022-05-17 10:00:21.633998] INFO: cached.v2.977b4bc2: [2022-05-17 10:00:13.264943] INFO moduleinvoker: dropnan.v1 运行完成[22.001834s].
[2022-05-17 10:00:21.635216] INFO: cached.v2.9785eda2: [2022-05-17 10:00:14.248537] INFO moduleinvoker: filter.v3 运行完成[3.05032s].
[2022-05-17 10:00:21.636348] INFO: cached.v2.977b4bc2: [2022-05-17 10:00:13.273694] INFO moduleinvoker: chinaa_stock_filter.v1 开始运行..
[2022-05-17 10:00:21.637631] INFO: cached.v2.9785eda2: [2022-05-17 10:00:14.257531] INFO moduleinvoker: dropnan.v1 开始运行..
[2022-05-17 10:00:21.639073] INFO: cached.v2.977b4bc2: [2022-05-17 10:00:13.287602] INFO moduleinvoker: 命中缓存
[2022-05-17 10:00:21.640146] INFO: cached.v2.9785eda2: [2022-05-17 10:00:14.388229] INFO dropnan: /y_2016, 43852/46478
[2022-05-17 10:00:21.641151] INFO: cached.v2.977b4bc2: [2022-05-17 10:00:13.288008] INFO moduleinvoker: chinaa_stock_filter.v1 运行完成[0.014375s].
[2022-05-17 10:00:21.642266] INFO: cached.v2.9785eda2: [2022-05-17 10:00:14.904083] INFO dropnan: /y_2017, 336770/365578
[2022-05-17 10:00:21.643256] INFO: cached.v2.977b4bc2: [2022-05-17 10:00:13.294612] INFO moduleinvoker: chinaa_stock_filter.v1 开始运行..
[2022-05-17 10:00:21.644315] INFO: cached.v2.9785eda2: [2022-05-17 10:00:14.968674] INFO dropnan: 行数: 380622/412056
[2022-05-17 10:00:21.645352] INFO: cached.v2.977b4bc2: [2022-05-17 10:00:15.599022] INFO A股股票过滤: 过滤 /y_2012, 414859/0/428117
[2022-05-17 10:00:21.646512] INFO: cached.v2.9785eda2: [2022-05-17 10:00:14.974143] INFO moduleinvoker: dropnan.v1 运行完成[0.716586s].
[2022-05-17 10:00:21.647757] INFO: cached.v2.977b4bc2: [2022-05-17 10:00:17.948247] INFO A股股票过滤: 过滤 /y_2013, 405011/0/417853
[2022-05-17 10:00:21.648827] INFO: cached.v2.9785eda2: [2022-05-17 10:00:14.981672] INFO moduleinvoker: join.v3 开始运行..
[2022-05-17 10:00:21.649853] INFO: cached.v2.977b4bc2: [2022-05-17 10:00:19.737572] INFO A股股票过滤: 过滤 /y_2014, 348355/0/360098
[2022-05-17 10:00:21.650902] INFO: cached.v2.9785eda2: [2022-05-17 10:00:18.437390] INFO join: /y_2013, 行数=0/70984, 耗时=0.652989s
[2022-05-17 10:00:21.651913] INFO: cached.v2.977b4bc2: [2022-05-17 10:00:19.740571] INFO A股股票过滤: 过滤完成, 1168225 + 0
[2022-05-17 10:00:21.653041] INFO: cached.v2.9785eda2: [2022-05-17 10:00:20.068826] INFO join: /y_2014, 行数=374391/376173, 耗时=1.630852s
[2022-05-17 10:00:21.654214] INFO: cached.v2.977b4bc2: [2022-05-17 10:00:19.769923] INFO moduleinvoker: chinaa_stock_filter.v1 运行完成[6.475266s].
[2022-05-17 10:00:21.655278] INFO: cached.v2.9785eda2: [2022-05-17 10:00:21.217023] INFO join: /y_2015, 行数=232499/238316, 耗时=1.145243s
[2022-05-17 10:00:21.656096] INFO: cached.v2.97820ac0: [2022-05-17 10:00:12.113391] INFO algo: handle_splits get splits [dt:2019-05-15 00:00:00+00:00] [asset:Equity(2525 [300416.SZA]), ratio:0.9945356845855713]
[2022-05-17 10:00:21.657312] INFO: cached.v2.977b4bc2: [2022-05-17 10:00:19.780172] INFO moduleinvoker: select_columns.v3 开始运行..
[2022-05-17 10:00:21.659900] INFO: cached.v2.97820ac0: [2022-05-17 10:00:12.113713] INFO Position: position stock handle split[sid:2525, orig_amount:4100, new_amount:4122.0, orig_cost:18.70001298550958, new_cost:18.5978, ratio:0.9945356845855713, last_sale_price:18.200002670288086]
[2022-05-17 10:00:21.659366] INFO: cached.v2.977b4bc2: [2022-05-17 10:00:19.790932] INFO moduleinvoker: 命中缓存
[2022-05-17 10:00:21.662038] INFO: cached.v2.97820ac0: [2022-05-17 10:00:12.113874] INFO Position: after split: PositionStock(asset:Equity(2525 [300416.SZA]), amount:4122.0, cost_basis:18.5978, last_sale_price:18.299999237060547)
[2022-05-17 10:00:21.661522] INFO: cached.v2.977b4bc2: [2022-05-17 10:00:19.791288] INFO moduleinvoker: select_columns.v3 运行完成[0.0112s].
[2022-05-17 10:00:21.663947] INFO: cached.v2.97820ac0: [2022-05-17 10:00:12.113932] INFO Position: returning cash: 9.5875
[2022-05-17 10:00:21.663459] INFO: cached.v2.977b4bc2: [2022-05-17 10:00:19.801815] INFO moduleinvoker: stock_ranker_train.v6 开始运行..
[2022-05-17 10:00:21.665481] INFO: cached.v2.97820ac0: [2022-05-17 10:00:12.616345] INFO algo: handle_splits get splits [dt:2019-05-16 00:00:00+00:00] [asset:Equity(2306 [603383.SHA]), ratio:0.993841826915741]
[2022-05-17 10:00:21.666525] INFO: cached.v2.97820ac0: [2022-05-17 10:00:12.616669] INFO Position: position stock handle split[sid:2306, orig_amount:2700, new_amount:2716.0, orig_cost:81.33667029132285, new_cost:80.8358, ratio:0.993841826915741, last_sale_price:80.69001770019531]
[2022-05-17 10:00:21.667472] INFO: cached.v2.97820ac0: [2022-05-17 10:00:12.616811] INFO Position: after split: PositionStock(asset:Equity(2306 [603383.SHA]), amount:2716.0, cost_basis:80.8358, last_sale_price:81.19000244140625)
[2022-05-17 10:00:21.668506] INFO: cached.v2.97820ac0: [2022-05-17 10:00:12.616880] INFO Position: returning cash: 58.9113
[2022-05-17 10:00:21.669598] INFO: cached.v2.97820ac0: [2022-05-17 10:00:14.491545] INFO algo: handle_splits get splits [dt:2019-05-21 00:00:00+00:00] [asset:Equity(291 [603990.SHA]), ratio:0.710599422454834]
[2022-05-17 10:00:21.670592] INFO: cached.v2.97820ac0: [2022-05-17 10:00:14.491733] INFO Position: position stock handle split[sid:291, orig_amount:1400, new_amount:1970.0, orig_cost:43.80007376027164, new_cost:31.1243, ratio:0.710599422454834, last_sale_price:28.089996337890625]
[2022-05-17 10:00:21.671911] INFO: cached.v2.97820ac0: [2022-05-17 10:00:14.491814] INFO Position: after split: PositionStock(asset:Equity(291 [603990.SHA]), amount:1970.0, cost_basis:31.1243, last_sale_price:39.53000259399414)
[2022-05-17 10:00:21.673336] INFO: cached.v2.97820ac0: [2022-05-17 10:00:14.491875] INFO Position: returning cash: 4.7095
[2022-05-17 10:00:21.675429] INFO: cached.v2.97820ac0: [2022-05-17 10:00:17.083379] INFO algo: handle_splits get splits [dt:2019-05-29 00:00:00+00:00] [asset:Equity(316 [000610.SZA]), ratio:0.9982684254646301]
[2022-05-17 10:00:21.677955] INFO: cached.v2.97820ac0: [2022-05-17 10:00:17.083594] INFO Position: position stock handle split[sid:316, orig_amount:9800, new_amount:9816.0, orig_cost:11.137142221065941, new_cost:11.1179, ratio:0.9982684254646301, last_sale_price:11.530000686645508]
[2022-05-17 10:00:21.679723] INFO: cached.v2.97820ac0: [2022-05-17 10:00:17.083679] INFO Position: after split: PositionStock(asset:Equity(316 [000610.SZA]), amount:9816.0, cost_basis:11.1179, last_sale_price:11.550000190734863)
[2022-05-17 10:00:21.680830] INFO: cached.v2.97820ac0: [2022-05-17 10:00:17.083725] INFO Position: returning cash: 11.5169
[2022-05-17 10:00:31.857228] INFO: cached.v2.97820ac0: [2022-05-17 10:00:28.566070] INFO algo: handle_splits get splits [dt:2019-07-04 00:00:00+00:00] [asset:Equity(2416 [002849.SZA]), ratio:0.996829628944397]
[2022-05-17 10:00:31.858756] INFO: cached.v2.97820ac0: [2022-05-17 10:00:28.566338] INFO Position: position stock handle split[sid:2416, orig_amount:4300, new_amount:4313.0, orig_cost:16.060035682363246, new_cost:16.0091, ratio:0.996829628944397, last_sale_price:15.720003128051758]
[2022-05-17 10:00:31.859996] INFO: cached.v2.97820ac0: [2022-05-17 10:00:28.566481] INFO Position: after split: PositionStock(asset:Equity(2416 [002849.SZA]), amount:4313.0, cost_basis:16.0091, last_sale_price:15.769999504089355)
[2022-05-17 10:00:31.861285] INFO: cached.v2.97820ac0: [2022-05-17 10:00:28.566599] INFO Position: returning cash: 10.626
[2022-05-17 10:00:31.862238] INFO: cached.v2.97820ac0: [2022-05-17 10:00:28.957812] INFO algo: handle_splits get splits [dt:2019-07-05 00:00:00+00:00] [asset:Equity(4044 [000701.SZA]), ratio:0.9984053373336792]
[2022-05-17 10:00:31.863123] INFO: cached.v2.97820ac0: [2022-05-17 10:00:28.957971] INFO Position: position stock handle split[sid:4044, orig_amount:9000, new_amount:9014.0, orig_cost:6.350003049392333, new_cost:6.3399, ratio:0.9984053373336792, last_sale_price:6.2600016593933105]
[2022-05-17 10:00:31.864058] INFO: cached.v2.97820ac0: [2022-05-17 10:00:28.958048] INFO Position: after split: PositionStock(asset:Equity(4044 [000701.SZA]), amount:9014.0, cost_basis:6.3399, last_sale_price:6.269999980926514)
[2022-05-17 10:00:31.865400] INFO: cached.v2.97820ac0: [2022-05-17 10:00:28.958092] INFO Position: returning cash: 2.3468
[2022-05-17 10:00:31.866354] INFO: cached.v2.97820ac0: [2022-05-17 10:00:31.757979] INFO algo: handle_splits get splits [dt:2019-07-12 00:00:00+00:00] [asset:Equity(1160 [002341.SZA]), ratio:0.9943073391914368]
[2022-05-17 10:00:31.867374] INFO: cached.v2.97820ac0: [2022-05-17 10:00:31.758278] INFO Position: position stock handle split[sid:1160, orig_amount:12200, new_amount:12269.0, orig_cost:5.300000311085033, new_cost:5.2698, ratio:0.9943073391914368, last_sale_price:5.239999771118164]
[2022-05-17 10:00:31.868603] INFO: cached.v2.97820ac0: [2022-05-17 10:00:31.758364] INFO Position: after split: PositionStock(asset:Equity(1160 [002341.SZA]), amount:12269.0, cost_basis:5.2698, last_sale_price:5.269999980926514)
[2022-05-17 10:00:31.869573] INFO: cached.v2.97820ac0: [2022-05-17 10:00:31.758424] INFO Position: returning cash: 4.444
[2022-05-17 10:00:31.875123] INFO: cached.v2.9785eda2: [2022-05-17 10:00:23.388906] INFO join: /y_2016, 行数=260844/270329, 耗时=2.170428s
[2022-05-17 10:00:31.876115] INFO: cached.v2.9785eda2: [2022-05-17 10:00:23.565863] INFO join: 最终行数: 867734
[2022-05-17 10:00:31.877067] INFO: cached.v2.9785eda2: [2022-05-17 10:00:23.586350] INFO moduleinvoker: join.v3 运行完成[8.604631s].
[2022-05-17 10:00:31.878053] INFO: cached.v2.9785eda2: [2022-05-17 10:00:23.598135] INFO moduleinvoker: chinaa_stock_filter.v1 开始运行..
[2022-05-17 10:00:31.879584] INFO: cached.v2.977b4bc2: [2022-05-17 10:00:23.570325] INFO StockRanker: 特征预处理 ..
[2022-05-17 10:00:31.882722] INFO: cached.v2.9785eda2: [2022-05-17 10:00:24.236803] INFO A股股票过滤: 过滤 /y_2016, 42857/0/43852
[2022-05-17 10:00:31.884091] INFO: cached.v2.977b4bc2: [2022-05-17 10:00:25.521296] INFO StockRanker: prepare data: training ..
[2022-05-17 10:00:31.886126] INFO: cached.v2.9785eda2: [2022-05-17 10:00:26.155027] INFO A股股票过滤: 过滤 /y_2017, 329231/0/336770
[2022-05-17 10:00:31.887555] INFO: cached.v2.977b4bc2: [2022-05-17 10:00:27.482104] INFO StockRanker: sort ..
[2022-05-17 10:00:31.889303] INFO: cached.v2.9785eda2: [2022-05-17 10:00:26.157467] INFO A股股票过滤: 过滤完成, 372088 + 0
[2022-05-17 10:00:31.891124] INFO: cached.v2.9785eda2: [2022-05-17 10:00:26.178145] INFO moduleinvoker: chinaa_stock_filter.v1 运行完成[2.580032s].
[2022-05-17 10:00:31.892620] INFO: cached.v2.9785eda2: [2022-05-17 10:00:26.191126] INFO moduleinvoker: dropnan.v1 开始运行..
[2022-05-17 10:00:31.893726] INFO: cached.v2.9785eda2: [2022-05-17 10:00:26.318769] INFO dropnan: /y_2013, 0/0
[2022-05-17 10:00:31.895209] INFO: cached.v2.9785eda2: [2022-05-17 10:00:27.064883] INFO dropnan: /y_2014, 367462/374391
[2022-05-17 10:00:31.896935] INFO: cached.v2.9785eda2: [2022-05-17 10:00:27.502914] INFO dropnan: /y_2015, 220780/232499
[2022-05-17 10:00:31.897868] INFO: cached.v2.9785eda2: [2022-05-17 10:00:28.134192] INFO dropnan: /y_2016, 252328/260844
[2022-05-17 10:00:31.900090] INFO: cached.v2.9785eda2: [2022-05-17 10:00:28.234801] INFO dropnan: 行数: 840570/867734
[2022-05-17 10:00:31.902180] INFO: cached.v2.9785eda2: [2022-05-17 10:00:28.239662] INFO moduleinvoker: dropnan.v1 运行完成[2.048532s].
[2022-05-17 10:00:31.903811] INFO: cached.v2.9785eda2: [2022-05-17 10:00:28.248427] INFO moduleinvoker: select_columns.v3 开始运行..
[2022-05-17 10:00:31.905018] INFO: cached.v2.9785eda2: 列: ['date', 'instrument', 'price_limit_status_0']
[2022-05-17 10:00:31.906554] INFO: cached.v2.9785eda2: /y_2016: 42857
[2022-05-17 10:00:31.908436] INFO: cached.v2.9785eda2: /y_2017: 329231
[2022-05-17 10:00:31.910106] INFO: cached.v2.9785eda2: [2022-05-17 10:00:28.811996] INFO moduleinvoker: select_columns.v3 运行完成[0.563529s].
[2022-05-17 10:00:31.911758] INFO: cached.v2.9785eda2: [2022-05-17 10:00:28.819067] INFO moduleinvoker: chinaa_stock_filter.v1 开始运行..
[2022-05-17 10:00:31.913836] INFO: cached.v2.9785eda2: [2022-05-17 10:00:30.881299] INFO A股股票过滤: 过滤 /y_2014, 355464/0/367462
[2022-05-17 10:00:41.459792] INFO: cached.v2.9781f3b4: [2022-05-17 10:00:37.436936] INFO Performance: Simulated 245 trading days out of 245.
[2022-05-17 10:00:41.461224] INFO: cached.v2.9781f3b4: [2022-05-17 10:00:37.437075] INFO Performance: first open: 2014-01-02 09:30:00+00:00
[2022-05-17 10:00:41.462210] INFO: cached.v2.9781f3b4: [2022-05-17 10:00:37.437132] INFO Performance: last close: 2014-12-31 15:00:00+00:00
[2022-05-17 10:00:41.463113] INFO: cached.v2.9781f3b4: [2022-05-17 10:00:38.865676] INFO moduleinvoker: backtest.v8 运行完成[221.245991s].
[2022-05-17 10:00:41.464026] INFO: cached.v2.9781f3b4: [2022-05-17 10:00:38.865806] INFO moduleinvoker: trade.v4 运行完成[223.304935s].
[2022-05-17 10:00:41.464982] INFO: cached.v2.9781f3b4: 任务状态: Succeeded
[2022-05-17 10:00:41.470177] INFO: moduleinvoker: cached.v2 运行完成[241.997589s].
[2022-05-17 10:00:41.471323] INFO: AI: [ParallelEx(n_jobs=30)]: Done 5 out of 9 | elapsed: 4.0min remaining: 3.2min
[2022-05-17 10:00:42.226059] INFO: cached.v2.9785eda2: [2022-05-17 10:00:32.478155] INFO A股股票过滤: 过滤 /y_2015, 214457/0/220780
[2022-05-17 10:00:42.227983] INFO: cached.v2.9785eda2: [2022-05-17 10:00:34.144245] INFO A股股票过滤: 过滤 /y_2016, 246558/0/252328
[2022-05-17 10:00:42.229108] INFO: cached.v2.9785eda2: [2022-05-17 10:00:34.174608] INFO A股股票过滤: 过滤完成, 816479 + 0
[2022-05-17 10:00:42.230416] INFO: cached.v2.9785eda2: [2022-05-17 10:00:34.196565] INFO moduleinvoker: chinaa_stock_filter.v1 运行完成[5.377473s].
[2022-05-17 10:00:42.231746] INFO: cached.v2.9785eda2: [2022-05-17 10:00:34.207298] INFO moduleinvoker: stock_ranker_train.v6 开始运行..
[2022-05-17 10:00:52.320423] INFO: cached.v2.9785eda2: [2022-05-17 10:00:43.909656] INFO StockRanker: 特征预处理 ..
[2022-05-17 10:00:52.319326] INFO: cached.v2.977b4bc2: [2022-05-17 10:00:43.566067] INFO StockRanker训练: 1ac57c6e 准备训练: 1168225 行数
[2022-05-17 10:00:52.324578] INFO: cached.v2.977b4bc2: [2022-05-17 10:00:43.566185] INFO StockRanker训练: AI模型训练,将在1168225*16=1869.16万数据上对模型训练进行20轮迭代训练。预计将需要6~13分钟。请耐心等待。
[2022-05-17 10:00:52.323865] INFO: cached.v2.9785eda2: [2022-05-17 10:00:45.235622] INFO StockRanker: prepare data: training ..
[2022-05-17 10:00:52.326962] INFO: cached.v2.977b4bc2: [2022-05-17 10:00:43.793240] INFO StockRanker训练: 正在训练 ..
[2022-05-17 10:00:52.328454] INFO: cached.v2.9785eda2: [2022-05-17 10:00:46.586122] INFO StockRanker: sort ..
[2022-05-17 10:00:52.329563] INFO: cached.v2.977b4bc2: [2022-05-17 10:00:43.887750] INFO StockRanker训练: 任务状态: Pending
[2022-05-17 10:01:02.075523] INFO: cached.v2.9776956e: [2022-05-17 10:00:58.807848] INFO moduleinvoker: cached.v2 运行完成[225.752918s].
[2022-05-17 10:01:02.425986] INFO: cached.v2.9785eda2: [2022-05-17 10:00:56.769565] INFO StockRanker训练: 235b69ce 准备训练: 816479 行数
[2022-05-17 10:01:02.428994] INFO: cached.v2.9785eda2: [2022-05-17 10:00:56.769671] INFO StockRanker训练: AI模型训练,将在816479*16=1306.37万数据上对模型训练进行20轮迭代训练。预计将需要5~9分钟。请耐心等待。
[2022-05-17 10:01:02.430362] INFO: cached.v2.9785eda2: [2022-05-17 10:00:57.023419] INFO StockRanker训练: 正在训练 ..
[2022-05-17 10:01:02.431483] INFO: cached.v2.9785eda2: [2022-05-17 10:00:57.070244] INFO StockRanker训练: 任务状态: Pending
[2022-05-17 10:01:02.481869] INFO: cached.v2.977b4bc2: [2022-05-17 10:00:53.940760] INFO StockRanker训练: 任务状态: Running
[2022-05-17 10:01:12.473810] INFO: cached.v2.9785eda2: [2022-05-17 10:01:07.118506] INFO StockRanker训练: 任务状态: Running
[2022-05-17 10:01:22.249888] INFO: cached.v2.97820ac0: [2022-05-17 10:01:16.981781] INFO Performance: Simulated 244 trading days out of 244.
[2022-05-17 10:01:22.251724] INFO: cached.v2.97820ac0: [2022-05-17 10:01:16.981950] INFO Performance: first open: 2019-01-02 09:30:00+00:00
[2022-05-17 10:01:22.253285] INFO: cached.v2.97820ac0: [2022-05-17 10:01:16.982043] INFO Performance: last close: 2019-12-31 15:00:00+00:00
[2022-05-17 10:02:03.197485] INFO: cached.v2.97820ac0: [2022-05-17 10:02:00.571769] INFO moduleinvoker: backtest.v8 运行完成[285.860518s].
[2022-05-17 10:02:03.199492] INFO: cached.v2.97820ac0: [2022-05-17 10:02:00.571941] INFO moduleinvoker: trade.v4 运行完成[292.486525s].
[2022-05-17 10:02:12.733506] INFO: cached.v2.9785eda2: [2022-05-17 10:02:07.400788] INFO StockRanker训练: 00:01:05.9967107, finished iteration 1
[2022-05-17 10:02:12.829130] INFO: cached.v2.977b4bc2: [2022-05-17 10:02:04.264555] INFO StockRanker训练: 00:01:08.4134373, finished iteration 1
[2022-05-17 10:02:12.830819] INFO: cached.v2.977b4bc2: [2022-05-17 10:02:04.264646] INFO StockRanker训练: 00:01:13.0205537, finished iteration 2
[2022-05-17 10:02:13.254827] INFO: cached.v2.97820ac0: 任务状态: Succeeded
[2022-05-17 10:02:13.260498] INFO: moduleinvoker: cached.v2 运行完成[333.733167s].
[2022-05-17 10:02:13.261716] INFO: AI: [ParallelEx(n_jobs=30)]: Done 6 out of 9 | elapsed: 5.6min remaining: 2.8min
[2022-05-17 10:02:22.783852] INFO: cached.v2.9785eda2: [2022-05-17 10:02:17.443542] INFO StockRanker训练: 00:01:09.0492299, finished iteration 2
[2022-05-17 10:02:22.786143] INFO: cached.v2.9785eda2: [2022-05-17 10:02:17.443638] INFO StockRanker训练: 00:01:11.9757556, finished iteration 3
[2022-05-17 10:02:22.787843] INFO: cached.v2.9785eda2: [2022-05-17 10:02:17.443687] INFO StockRanker训练: 00:01:15.2256069, finished iteration 4
[2022-05-17 10:02:22.894635] INFO: cached.v2.977b4bc2: [2022-05-17 10:02:14.310174] INFO StockRanker训练: 00:01:19.0295294, finished iteration 3
[2022-05-17 10:02:32.834833] INFO: cached.v2.9785eda2: [2022-05-17 10:02:27.479450] INFO StockRanker训练: 00:01:18.2852046, finished iteration 5
[2022-05-17 10:02:32.836974] INFO: cached.v2.9785eda2: [2022-05-17 10:02:27.479592] INFO StockRanker训练: 00:01:21.6997179, finished iteration 6
[2022-05-17 10:02:32.838665] INFO: cached.v2.9785eda2: [2022-05-17 10:02:27.479676] INFO StockRanker训练: 00:01:25.8966265, finished iteration 7
[2022-05-17 10:02:32.957811] INFO: cached.v2.977b4bc2: [2022-05-17 10:02:24.354914] INFO StockRanker训练: 00:01:26.2040957, finished iteration 4
[2022-05-17 10:02:32.959282] INFO: cached.v2.977b4bc2: [2022-05-17 10:02:24.355053] INFO StockRanker训练: 00:01:34.0301123, finished iteration 5
[2022-05-17 10:02:42.923748] INFO: cached.v2.9785eda2: [2022-05-17 10:02:37.521463] INFO StockRanker训练: 00:01:30.1426047, finished iteration 8
[2022-05-17 10:02:42.925177] INFO: cached.v2.9785eda2: [2022-05-17 10:02:37.521561] INFO StockRanker训练: 00:01:34.1428326, finished iteration 9
[2022-05-17 10:02:43.020925] INFO: cached.v2.977b4bc2: [2022-05-17 10:02:34.401812] INFO StockRanker训练: 00:01:41.9678515, finished iteration 6
[2022-05-17 10:02:53.008922] INFO: cached.v2.9785eda2: [2022-05-17 10:02:47.570989] INFO StockRanker训练: 00:01:38.2554263, finished iteration 10
[2022-05-17 10:02:53.011040] INFO: cached.v2.9785eda2: [2022-05-17 10:02:47.571088] INFO StockRanker训练: 00:01:42.2792835, finished iteration 11
[2022-05-17 10:02:53.079811] INFO: cached.v2.977b4bc2: [2022-05-17 10:02:44.436964] INFO StockRanker训练: 00:01:49.8007948, finished iteration 7
[2022-05-17 10:03:03.065324] INFO: cached.v2.9785eda2: [2022-05-17 10:02:57.708572] INFO StockRanker训练: 00:01:46.4000320, finished iteration 12
[2022-05-17 10:03:03.066758] INFO: cached.v2.9785eda2: [2022-05-17 10:02:57.708676] INFO StockRanker训练: 00:01:50.7577427, finished iteration 13
[2022-05-17 10:03:03.067772] INFO: cached.v2.9785eda2: [2022-05-17 10:02:57.708742] INFO StockRanker训练: 00:01:55.0484114, finished iteration 14
[2022-05-17 10:03:03.132627] INFO: cached.v2.977b4bc2: [2022-05-17 10:02:54.482166] INFO StockRanker训练: 00:01:58.4309829, finished iteration 8
[2022-05-17 10:03:03.176302] INFO: cached.v2.9776956e: [2022-05-17 10:02:58.191087] INFO algo: TradingAlgorithm V1.8.7
[2022-05-17 10:03:13.118791] INFO: cached.v2.9785eda2: [2022-05-17 10:03:07.764451] INFO StockRanker训练: 00:01:59.5575371, finished iteration 15
[2022-05-17 10:03:13.122478] INFO: cached.v2.9785eda2: [2022-05-17 10:03:07.764581] INFO StockRanker训练: 00:02:04.1584789, finished iteration 16
[2022-05-17 10:03:13.177261] INFO: cached.v2.977b4bc2: [2022-05-17 10:03:04.531906] INFO StockRanker训练: 00:02:07.3973191, finished iteration 9
[2022-05-17 10:03:23.170542] INFO: cached.v2.9785eda2: [2022-05-17 10:03:17.820200] INFO StockRanker训练: 00:02:08.6779275, finished iteration 17
[2022-05-17 10:03:23.172504] INFO: cached.v2.9785eda2: [2022-05-17 10:03:17.820302] INFO StockRanker训练: 00:02:12.9030251, finished iteration 18
[2022-05-17 10:03:23.224378] INFO: cached.v2.977b4bc2: [2022-05-17 10:03:14.583524] INFO StockRanker训练: 00:02:16.3285334, finished iteration 10
[2022-05-17 10:03:23.226448] INFO: cached.v2.977b4bc2: [2022-05-17 10:03:14.583624] INFO StockRanker训练: 00:02:25.5088884, finished iteration 11
[2022-05-17 10:03:33.229988] INFO: cached.v2.9785eda2: [2022-05-17 10:03:27.867505] INFO StockRanker训练: 00:02:17.0330644, finished iteration 19
[2022-05-17 10:03:33.231548] INFO: cached.v2.9785eda2: [2022-05-17 10:03:27.867659] INFO StockRanker训练: 00:02:21.0639379, finished iteration 20
[2022-05-17 10:03:33.232693] INFO: cached.v2.9785eda2: [2022-05-17 10:03:27.867771] INFO StockRanker训练: 任务状态: Succeeded
[2022-05-17 10:03:33.233760] INFO: cached.v2.9785eda2:
[2022-05-17 10:03:33.234997] INFO: cached.v2.9785eda2: [2022-05-17 10:03:28.186212] INFO moduleinvoker: stock_ranker_train.v6 运行完成[173.978848s].
[2022-05-17 10:03:33.236001] INFO: cached.v2.9785eda2: [2022-05-17 10:03:28.210132] INFO moduleinvoker: stock_ranker_predict.v5 开始运行..
[2022-05-17 10:03:33.237136] INFO: cached.v2.9785eda2: [2022-05-17 10:03:28.474694] INFO StockRanker预测: /y_2016 ..
[2022-05-17 10:03:33.238490] INFO: cached.v2.9785eda2: [2022-05-17 10:03:28.783129] INFO StockRanker预测: /y_2017 ..
[2022-05-17 10:03:33.239504] INFO: cached.v2.9785eda2: [2022-05-17 10:03:29.760556] INFO moduleinvoker: stock_ranker_predict.v5 运行完成[1.550424s].
[2022-05-17 10:03:33.240499] INFO: cached.v2.9785eda2: [2022-05-17 10:03:29.769981] INFO moduleinvoker: join.v3 开始运行..
[2022-05-17 10:03:33.241519] INFO: cached.v2.9785eda2: [2022-05-17 10:03:30.877466] INFO join: /data, 行数=372088/372088, 耗时=0.944293s
[2022-05-17 10:03:33.242525] INFO: cached.v2.9785eda2: [2022-05-17 10:03:30.991189] INFO join: 最终行数: 372088
[2022-05-17 10:03:33.243491] INFO: cached.v2.9785eda2: [2022-05-17 10:03:31.003909] INFO moduleinvoker: join.v3 运行完成[1.233912s].
[2022-05-17 10:03:33.244477] INFO: cached.v2.9785eda2: [2022-05-17 10:03:31.011690] INFO moduleinvoker: join.v3 开始运行..
[2022-05-17 10:03:33.245549] INFO: cached.v2.9785eda2: [2022-05-17 10:03:32.430296] INFO join: /data, 行数=372088/372088, 耗时=1.161316s
[2022-05-17 10:03:33.246616] INFO: cached.v2.9785eda2: [2022-05-17 10:03:32.474243] INFO join: 最终行数: 372088
[2022-05-17 10:03:33.247664] INFO: cached.v2.9785eda2: [2022-05-17 10:03:32.501477] INFO moduleinvoker: join.v3 运行完成[1.489728s].
[2022-05-17 10:03:33.248679] INFO: cached.v2.9785eda2: [2022-05-17 10:03:32.509055] INFO moduleinvoker: sort.v4 开始运行..
[2022-05-17 10:03:33.269065] INFO: cached.v2.977b4bc2: [2022-05-17 10:03:24.637359] INFO StockRanker训练: 00:02:34.4665931, finished iteration 12
[2022-05-17 10:03:33.388946] INFO: cached.v2.9776956e: [2022-05-17 10:03:23.328178] INFO algo: trading transform...
[2022-05-17 10:03:43.342980] INFO: cached.v2.977b4bc2: [2022-05-17 10:03:34.692770] INFO StockRanker训练: 00:02:42.9126243, finished iteration 13
[2022-05-17 10:03:43.344092] INFO: cached.v2.9785eda2: [2022-05-17 10:03:34.345185] INFO moduleinvoker: sort.v4 运行完成[1.83612s].
[2022-05-17 10:03:43.346359] INFO: cached.v2.9785eda2: [2022-05-17 10:03:36.432361] INFO moduleinvoker: backtest.v8 开始运行..
[2022-05-17 10:03:43.347595] INFO: cached.v2.9785eda2: [2022-05-17 10:03:36.437400] INFO backtest: biglearning backtest:V8.6.2
[2022-05-17 10:03:43.348734] INFO: cached.v2.9785eda2: [2022-05-17 10:03:36.437504] INFO backtest: product_type:stock by specified
[2022-05-17 10:03:43.349755] INFO: cached.v2.9785eda2: [2022-05-17 10:03:36.517573] INFO moduleinvoker: cached.v2 开始运行..
[2022-05-17 10:03:43.350719] INFO: cached.v2.9785eda2: [2022-05-17 10:03:36.525276] INFO moduleinvoker: 命中缓存
[2022-05-17 10:03:43.351790] INFO: cached.v2.9785eda2: [2022-05-17 10:03:36.525648] INFO moduleinvoker: cached.v2 运行完成[0.008173s].
[2022-05-17 10:03:43.352785] INFO: cached.v2.9785eda2: [2022-05-17 10:03:40.012840] INFO algo: TradingAlgorithm V1.8.7
[2022-05-17 10:03:43.353846] INFO: cached.v2.9785eda2: [2022-05-17 10:03:40.803231] INFO algo: trading transform...
[2022-05-17 10:03:53.409388] INFO: cached.v2.977b4bc2: [2022-05-17 10:03:44.750418] INFO StockRanker训练: 00:02:51.2999229, finished iteration 14
[2022-05-17 10:04:03.466110] INFO: cached.v2.977b4bc2: [2022-05-17 10:03:54.801649] INFO StockRanker训练: 00:03:00.0224823, finished iteration 15
[2022-05-17 10:04:03.477464] INFO: cached.v2.9785eda2: [2022-05-17 10:04:03.094051] INFO algo: handle_splits get splits [dt:2017-05-11 00:00:00+00:00] [asset:Equity(223 [300181.SZA]), ratio:0.9971346855163574]
[2022-05-17 10:04:03.480531] INFO: cached.v2.9785eda2: [2022-05-17 10:04:03.094225] INFO Position: position stock handle split[sid:223, orig_amount:6800, new_amount:6819.0, orig_cost:7.080002006690001, new_cost:7.0597, ratio:0.9971346855163574, last_sale_price:6.960000038146973]
[2022-05-17 10:04:03.482337] INFO: cached.v2.9785eda2: [2022-05-17 10:04:03.094303] INFO Position: after split: PositionStock(asset:Equity(223 [300181.SZA]), amount:6819.0, cost_basis:7.0597, last_sale_price:6.980000019073486)
[2022-05-17 10:04:03.484064] INFO: cached.v2.9785eda2: [2022-05-17 10:04:03.094349] INFO Position: returning cash: 3.7593
[2022-05-17 10:04:13.508890] INFO: cached.v2.977b4bc2: [2022-05-17 10:04:04.848070] INFO StockRanker训练: 00:03:07.8397007, finished iteration 16
[2022-05-17 10:04:13.512477] INFO: cached.v2.977b4bc2: [2022-05-17 10:04:04.848174] INFO StockRanker训练: 00:03:16.0901060, finished iteration 17
[2022-05-17 10:04:13.532674] INFO: cached.v2.9785eda2: [2022-05-17 10:04:05.528592] INFO algo: handle_splits get splits [dt:2017-05-24 00:00:00+00:00] [asset:Equity(1088 [603887.SHA]), ratio:0.9966362714767456]
[2022-05-17 10:04:13.534096] INFO: cached.v2.9785eda2: [2022-05-17 10:04:05.528778] INFO Position: position stock handle split[sid:1088, orig_amount:1200, new_amount:1204.0, orig_cost:36.93002328023536, new_cost:36.8058, ratio:0.9966362714767456, last_sale_price:32.59000778198242]
[2022-05-17 10:04:13.535165] INFO: cached.v2.9785eda2: [2022-05-17 10:04:05.528855] INFO Position: after split: PositionStock(asset:Equity(1088 [603887.SHA]), amount:1204.0, cost_basis:36.8058, last_sale_price:32.70000076293945)
[2022-05-17 10:04:13.536137] INFO: cached.v2.9785eda2: [2022-05-17 10:04:05.528900] INFO Position: returning cash: 1.6327
[2022-05-17 10:04:13.537049] INFO: cached.v2.9785eda2: [2022-05-17 10:04:06.833629] INFO algo: handle_splits get splits [dt:2017-06-05 00:00:00+00:00] [asset:Equity(3389 [300089.SZA]), ratio:0.9986621737480164]
[2022-05-17 10:04:13.538031] INFO: cached.v2.9785eda2: [2022-05-17 10:04:06.833816] INFO Position: position stock handle split[sid:3389, orig_amount:2300, new_amount:2303.0, orig_cost:15.890000859130293, new_cost:15.8687, ratio:0.9986621737480164, last_sale_price:14.930000305175781]
[2022-05-17 10:04:13.539178] INFO: cached.v2.9785eda2: [2022-05-17 10:04:06.833894] INFO Position: after split: PositionStock(asset:Equity(3389 [300089.SZA]), amount:2303.0, cost_basis:15.8687, last_sale_price:14.950000762939453)
[2022-05-17 10:04:13.540128] INFO: cached.v2.9785eda2: [2022-05-17 10:04:06.833944] INFO Position: returning cash: 1.2112
[2022-05-17 10:04:13.541025] INFO: cached.v2.9785eda2: [2022-05-17 10:04:08.418124] INFO algo: handle_splits get splits [dt:2017-06-12 00:00:00+00:00] [asset:Equity(2655 [300163.SZA]), ratio:0.9934640526771545]
[2022-05-17 10:04:13.541968] INFO: cached.v2.9785eda2: [2022-05-17 10:04:08.418283] INFO Position: position stock handle split[sid:2655, orig_amount:6200, new_amount:6240.0, orig_cost:8.080004098918636, new_cost:8.0272, ratio:0.9934640526771545, last_sale_price:7.59999942779541]
[2022-05-17 10:04:13.542937] INFO: cached.v2.9785eda2: [2022-05-17 10:04:08.418355] INFO Position: after split: PositionStock(asset:Equity(2655 [300163.SZA]), amount:6240.0, cost_basis:8.0272, last_sale_price:7.649999618530273)
[2022-05-17 10:04:13.543896] INFO: cached.v2.9785eda2: [2022-05-17 10:04:08.418399] INFO Position: returning cash: 6.0
[2022-05-17 10:04:13.544790] INFO: cached.v2.9785eda2: [2022-05-17 10:04:11.051319] INFO algo: handle_splits get splits [dt:2017-06-23 00:00:00+00:00] [asset:Equity(3113 [300261.SZA]), ratio:0.9955899715423584]
[2022-05-17 10:04:13.545772] INFO: cached.v2.9785eda2: [2022-05-17 10:04:11.051482] INFO Position: position stock handle split[sid:3113, orig_amount:8900, new_amount:8939.0, orig_cost:8.999890991666666, new_cost:8.9602, ratio:0.9955899715423584, last_sale_price:9.030000686645508]
[2022-05-17 10:04:13.546702] INFO: cached.v2.9785eda2: [2022-05-17 10:04:11.051557] INFO Position: after split: PositionStock(asset:Equity(3113 [300261.SZA]), amount:8939.0, cost_basis:8.9602, last_sale_price:9.069999694824219)
[2022-05-17 10:04:13.547605] INFO: cached.v2.9785eda2: [2022-05-17 10:04:11.051610] INFO Position: returning cash: 3.8207
[2022-05-17 10:04:13.748360] INFO: cached.v2.9776956e: [2022-05-17 10:04:08.481998] INFO algo: handle_splits get splits [dt:2021-05-18 00:00:00+00:00] [asset:Equity(1741 [300508.SZA]), ratio:0.9986541867256165]
[2022-05-17 10:04:13.749926] INFO: cached.v2.9776956e: [2022-05-17 10:04:08.482303] INFO Position: position stock handle split[sid:1741, orig_amount:2000, new_amount:2002.0, orig_cost:23.18001622597969, new_cost:23.1488, ratio:0.9986541867256165, last_sale_price:22.260000228881836]
[2022-05-17 10:04:13.750933] INFO: cached.v2.9776956e: [2022-05-17 10:04:08.482412] INFO Position: after split: PositionStock(asset:Equity(1741 [300508.SZA]), amount:2002.0, cost_basis:23.1488, last_sale_price:22.28999900817871)
[2022-05-17 10:04:13.752346] INFO: cached.v2.9776956e: [2022-05-17 10:04:08.482470] INFO Position: returning cash: 15.4764
[2022-05-17 10:04:13.753312] INFO: cached.v2.9776956e: [2022-05-17 10:04:10.257590] INFO algo: handle_splits get splits [dt:2021-05-24 00:00:00+00:00] [asset:Equity(2595 [300386.SZA]), ratio:0.9987797737121582]
[2022-05-17 10:04:13.754484] INFO: cached.v2.9776956e: [2022-05-17 10:04:10.257756] INFO Position: position stock handle split[sid:2595, orig_amount:3400, new_amount:3404.0, orig_cost:16.250000494270903, new_cost:16.2302, ratio:0.9987797737121582, last_sale_price:16.369998931884766]
[2022-05-17 10:04:13.755673] INFO: cached.v2.9776956e: [2022-05-17 10:04:10.257864] INFO Position: after split: PositionStock(asset:Equity(2595 [300386.SZA]), amount:3404.0, cost_basis:16.2302, last_sale_price:16.389999389648438)
[2022-05-17 10:04:13.756711] INFO: cached.v2.9776956e: [2022-05-17 10:04:10.257932] INFO Position: returning cash: 2.5183
[2022-05-17 10:04:13.757687] INFO: cached.v2.9776956e: [2022-05-17 10:04:11.869450] INFO algo: handle_splits get splits [dt:2021-05-28 00:00:00+00:00] [asset:Equity(3925 [300462.SZA]), ratio:0.9876540899276733]
[2022-05-17 10:04:13.758774] INFO: cached.v2.9776956e: [2022-05-17 10:04:11.869674] INFO Position: position stock handle split[sid:3925, orig_amount:8500, new_amount:8606.0, orig_cost:11.54141698817523, new_cost:11.3989, ratio:0.9876540899276733, last_sale_price:11.999998092651367]
[2022-05-17 10:04:13.759688] INFO: cached.v2.9776956e: [2022-05-17 10:04:11.869777] INFO Position: after split: PositionStock(asset:Equity(3925 [300462.SZA]), amount:8606.0, cost_basis:11.3989, last_sale_price:12.15000057220459)
[2022-05-17 10:04:13.760714] INFO: cached.v2.9776956e: [2022-05-17 10:04:11.869880] INFO Position: returning cash: 3.0242
[2022-05-17 10:04:13.761801] INFO: cached.v2.9776956e: [2022-05-17 10:04:12.312676] INFO algo: handle_splits get splits [dt:2021-05-31 00:00:00+00:00] [asset:Equity(4978 [002760.SZA]), ratio:0.9934821724891663]
[2022-05-17 10:04:13.762770] INFO: cached.v2.9776956e: [2022-05-17 10:04:12.312936] INFO Position: position stock handle split[sid:4978, orig_amount:2300, new_amount:2315.0, orig_cost:18.540024147955585, new_cost:18.4192, ratio:0.9934821724891663, last_sale_price:18.290006637573242]
[2022-05-17 10:04:13.763782] INFO: cached.v2.9776956e: [2022-05-17 10:04:12.313041] INFO Position: after split: PositionStock(asset:Equity(4978 [002760.SZA]), amount:2315.0, cost_basis:18.4192, last_sale_price:18.40999984741211)
[2022-05-17 10:04:13.764768] INFO: cached.v2.9776956e: [2022-05-17 10:04:12.313105] INFO Position: returning cash: 1.6343
[2022-05-17 10:04:23.564539] INFO: cached.v2.977b4bc2: [2022-05-17 10:04:14.892734] INFO StockRanker训练: 00:03:24.8221311, finished iteration 18
[2022-05-17 10:04:23.833254] INFO: cached.v2.9776956e: [2022-05-17 10:04:13.809285] INFO algo: handle_splits get splits [dt:2021-06-03 00:00:00+00:00] [asset:Equity(2747 [603908.SHA]), ratio:0.9677836298942566]
[2022-05-17 10:04:23.836422] INFO: cached.v2.9776956e: [2022-05-17 10:04:13.809571] INFO Position: position stock handle split[sid:2747, orig_amount:5200, new_amount:5373.0, orig_cost:22.75506472869357, new_cost:22.022, ratio:0.9677836298942566, last_sale_price:22.53000259399414]
[2022-05-17 10:04:23.838825] INFO: cached.v2.9776956e: [2022-05-17 10:04:13.809660] INFO Position: after split: PositionStock(asset:Equity(2747 [603908.SHA]), amount:5373.0, cost_basis:22.022, last_sale_price:23.279998779296875)
[2022-05-17 10:04:23.840090] INFO: cached.v2.9776956e: [2022-05-17 10:04:13.809725] INFO Position: returning cash: 2.2944
[2022-05-17 10:04:23.841147] INFO: cached.v2.9776956e: [2022-05-17 10:04:14.885895] INFO algo: handle_splits get splits [dt:2021-06-07 00:00:00+00:00] [asset:Equity(551 [603909.SHA]), ratio:0.7116126418113708]
[2022-05-17 10:04:23.842288] INFO: cached.v2.9776956e: [2022-05-17 10:04:14.886212] INFO Position: position stock handle split[sid:551, orig_amount:2800, new_amount:3934.0, orig_cost:18.3800022343816, new_cost:13.0794, ratio:0.7116126418113708, last_sale_price:12.930002212524414]
[2022-05-17 10:04:23.843324] INFO: cached.v2.9776956e: [2022-05-17 10:04:14.886321] INFO Position: after split: PositionStock(asset:Equity(551 [603909.SHA]), amount:3934.0, cost_basis:13.0794, last_sale_price:18.170000076293945)
[2022-05-17 10:04:23.844589] INFO: cached.v2.9776956e: [2022-05-17 10:04:14.886468] INFO Position: returning cash: 9.3733
[2022-05-17 10:04:23.846055] INFO: cached.v2.9776956e: [2022-05-17 10:04:16.439895] INFO algo: handle_splits get splits [dt:2021-06-10 00:00:00+00:00] [asset:Equity(3563 [603798.SHA]), ratio:0.9887533783912659]
[2022-05-17 10:04:23.847136] INFO: cached.v2.9776956e: [2022-05-17 10:04:16.440220] INFO Position: position stock handle split[sid:3563, orig_amount:6100, new_amount:6169.0, orig_cost:10.540005236360633, new_cost:10.4215, ratio:0.9887533783912659, last_sale_price:10.549997329711914]
[2022-05-17 10:04:23.848253] INFO: cached.v2.9776956e: [2022-05-17 10:04:16.440446] INFO Position: after split: PositionStock(asset:Equity(3563 [603798.SHA]), amount:6169.0, cost_basis:10.4215, last_sale_price:10.669999122619629)
[2022-05-17 10:04:23.849277] INFO: cached.v2.9776956e: [2022-05-17 10:04:16.440519] INFO Position: returning cash: 4.059
[2022-05-17 10:04:23.850310] INFO: cached.v2.9776956e: [2022-05-17 10:04:17.846869] INFO algo: handle_splits get splits [dt:2021-06-16 00:00:00+00:00] [asset:Equity(1564 [600302.SHA]), ratio:0.9883989095687866]
[2022-05-17 10:04:23.851347] INFO: cached.v2.9776956e: [2022-05-17 10:04:17.847075] INFO Position: position stock handle split[sid:1564, orig_amount:10800, new_amount:10926.0, orig_cost:4.360012791505682, new_cost:4.3094, ratio:0.9883989095687866, last_sale_price:4.259999752044678]
[2022-05-17 10:04:23.852648] INFO: cached.v2.9776956e: [2022-05-17 10:04:17.847184] INFO Position: after split: PositionStock(asset:Equity(1564 [600302.SHA]), amount:10926.0, cost_basis:4.3094, last_sale_price:4.310000419616699)
[2022-05-17 10:04:23.853673] INFO: cached.v2.9776956e: [2022-05-17 10:04:17.847256] INFO Position: returning cash: 3.2476
[2022-05-17 10:04:23.854670] INFO: cached.v2.9776956e: [2022-05-17 10:04:20.870873] INFO algo: handle_splits get splits [dt:2021-06-25 00:00:00+00:00] [asset:Equity(1542 [002827.SZA]), ratio:0.9858224391937256]
[2022-05-17 10:04:23.855920] INFO: cached.v2.9776956e: [2022-05-17 10:04:20.871107] INFO Position: position stock handle split[sid:1542, orig_amount:5900, new_amount:5984.0, orig_cost:10.580076589180091, new_cost:10.4301, ratio:0.9858224391937256, last_sale_price:10.430002212524414]
[2022-05-17 10:04:23.856997] INFO: cached.v2.9776956e: [2022-05-17 10:04:20.871219] INFO Position: after split: PositionStock(asset:Equity(1542 [002827.SZA]), amount:5984.0, cost_basis:10.4301, last_sale_price:10.580000877380371)
[2022-05-17 10:04:23.858111] INFO: cached.v2.9776956e: [2022-05-17 10:04:20.871272] INFO Position: returning cash: 8.8716
[2022-05-17 10:04:23.859126] INFO: cached.v2.9776956e: [2022-05-17 10:04:21.777856] INFO algo: handle_splits get splits [dt:2021-06-29 00:00:00+00:00] [asset:Equity(4824 [002981.SZA]), ratio:0.9980751872062683]
[2022-05-17 10:04:23.860142] INFO: cached.v2.9776956e: [2022-05-17 10:04:21.778034] INFO Position: position stock handle split[sid:4824, orig_amount:1900, new_amount:1903.0, orig_cost:25.70003908573405, new_cost:25.6506, ratio:0.9980751872062683, last_sale_price:25.929994583129883]
[2022-05-17 10:04:23.861128] INFO: cached.v2.9776956e: [2022-05-17 10:04:21.778114] INFO Position: after split: PositionStock(asset:Equity(4824 [002981.SZA]), amount:1903.0, cost_basis:25.6506, last_sale_price:25.98000144958496)
[2022-05-17 10:04:23.862065] INFO: cached.v2.9776956e: [2022-05-17 10:04:21.778160] INFO Position: returning cash: 17.2226
[2022-05-17 10:04:33.618908] INFO: cached.v2.977b4bc2: [2022-05-17 10:04:24.940184] INFO StockRanker训练: 00:03:33.3508202, finished iteration 19
[2022-05-17 10:04:33.647358] INFO: cached.v2.9785eda2: [2022-05-17 10:04:23.632660] INFO algo: handle_splits get splits [dt:2017-08-16 00:00:00+00:00] [asset:Equity(3148 [600561.SHA]), ratio:0.9967461228370667]
[2022-05-17 10:04:33.943439] INFO: cached.v2.9776956e: [2022-05-17 10:04:26.948292] INFO algo: handle_splits get splits [dt:2021-07-15 00:00:00+00:00] [asset:Equity(2947 [603045.SHA]), ratio:0.9935061931610107]
[2022-05-17 10:04:33.945815] INFO: cached.v2.9776956e: [2022-05-17 10:04:26.948658] INFO Position: position stock handle split[sid:2947, orig_amount:5400, new_amount:5435.0, orig_cost:12.41001247690318, new_cost:12.3294, ratio:0.9935061931610107, last_sale_price:12.239996910095215]
[2022-05-17 10:04:33.947353] INFO: cached.v2.9776956e: [2022-05-17 10:04:26.948875] INFO Position: after split: PositionStock(asset:Equity(2947 [603045.SHA]), amount:5435.0, cost_basis:12.3294, last_sale_price:12.320000648498535)
[2022-05-17 10:04:33.948685] INFO: cached.v2.9776956e: [2022-05-17 10:04:26.948969] INFO Position: returning cash: 3.6201
[2022-05-17 10:04:43.667822] INFO: cached.v2.977b4bc2: [2022-05-17 10:04:34.978111] INFO StockRanker训练: 00:03:41.2793242, finished iteration 20
[2022-05-17 10:04:43.670000] INFO: cached.v2.977b4bc2: [2022-05-17 10:04:34.978214] INFO StockRanker训练: 任务状态: Succeeded
[2022-05-17 10:04:43.671491] INFO: cached.v2.977b4bc2:
[2022-05-17 10:04:43.675573] INFO: cached.v2.977b4bc2: [2022-05-17 10:04:35.138844] INFO moduleinvoker: stock_ranker_train.v6 运行完成[255.336925s].
[2022-05-17 10:04:43.679340] INFO: cached.v2.977b4bc2: [2022-05-17 10:04:35.150224] INFO moduleinvoker: stock_ranker_predict.v5 开始运行..
[2022-05-17 10:04:43.681159] INFO: cached.v2.977b4bc2: [2022-05-17 10:04:35.350577] INFO StockRanker预测: /y_2014 ..
[2022-05-17 10:04:43.682463] INFO: cached.v2.977b4bc2: [2022-05-17 10:04:35.561156] INFO StockRanker预测: /y_2015 ..
[2022-05-17 10:04:43.684491] INFO: cached.v2.977b4bc2: [2022-05-17 10:04:36.257273] INFO moduleinvoker: stock_ranker_predict.v5 运行完成[1.107053s].
[2022-05-17 10:04:43.687032] INFO: cached.v2.977b4bc2: [2022-05-17 10:04:36.271258] INFO moduleinvoker: join.v3 开始运行..
[2022-05-17 10:04:43.688567] INFO: cached.v2.977b4bc2: [2022-05-17 10:04:37.116026] INFO join: /data, 行数=272161/272161, 耗时=0.640483s
[2022-05-17 10:04:43.689982] INFO: cached.v2.977b4bc2: [2022-05-17 10:04:37.153939] INFO join: 最终行数: 272161
[2022-05-17 10:04:43.692347] INFO: cached.v2.977b4bc2: [2022-05-17 10:04:37.160878] INFO moduleinvoker: join.v3 运行完成[0.889605s].
[2022-05-17 10:04:43.694998] INFO: cached.v2.977b4bc2: [2022-05-17 10:04:37.167697] INFO moduleinvoker: join.v3 开始运行..
[2022-05-17 10:04:43.698298] INFO: cached.v2.977b4bc2: [2022-05-17 10:04:38.633894] INFO join: /data, 行数=272161/272161, 耗时=0.923355s
[2022-05-17 10:04:43.701143] INFO: cached.v2.977b4bc2: [2022-05-17 10:04:38.683742] INFO join: 最终行数: 272161
[2022-05-17 10:04:43.703259] INFO: cached.v2.977b4bc2: [2022-05-17 10:04:38.693947] INFO moduleinvoker: join.v3 运行完成[1.526219s].
[2022-05-17 10:04:43.705007] INFO: cached.v2.977b4bc2: [2022-05-17 10:04:38.699875] INFO moduleinvoker: sort.v4 开始运行..
[2022-05-17 10:04:43.706705] INFO: cached.v2.977b4bc2: [2022-05-17 10:04:40.001315] INFO moduleinvoker: sort.v4 运行完成[1.301356s].
[2022-05-17 10:04:43.708057] INFO: cached.v2.977b4bc2: [2022-05-17 10:04:41.640125] INFO moduleinvoker: backtest.v8 开始运行..
[2022-05-17 10:04:43.709773] INFO: cached.v2.977b4bc2: [2022-05-17 10:04:41.644509] INFO backtest: biglearning backtest:V8.6.2
[2022-05-17 10:04:43.711535] INFO: cached.v2.977b4bc2: [2022-05-17 10:04:41.644610] INFO backtest: product_type:stock by specified
[2022-05-17 10:04:43.713886] INFO: cached.v2.977b4bc2: [2022-05-17 10:04:41.723465] INFO moduleinvoker: cached.v2 开始运行..
[2022-05-17 10:04:43.716582] INFO: cached.v2.977b4bc2: [2022-05-17 10:04:41.729850] INFO moduleinvoker: 命中缓存
[2022-05-17 10:04:43.720092] INFO: cached.v2.977b4bc2: [2022-05-17 10:04:41.730191] INFO moduleinvoker: cached.v2 运行完成[0.006829s].
[2022-05-17 10:04:43.723454] INFO: cached.v2.977b4bc2: [2022-05-17 10:04:43.036203] INFO algo: TradingAlgorithm V1.8.7
[2022-05-17 10:04:43.724966] INFO: cached.v2.977b4bc2: [2022-05-17 10:04:43.586014] INFO algo: trading transform...
[2022-05-17 10:04:53.744165] INFO: cached.v2.9785eda2: [2022-05-17 10:04:52.873380] INFO Performance: Simulated 244 trading days out of 244.
[2022-05-17 10:04:53.746250] INFO: cached.v2.9785eda2: [2022-05-17 10:04:52.873501] INFO Performance: first open: 2017-01-03 09:30:00+00:00
[2022-05-17 10:04:53.747779] INFO: cached.v2.9785eda2: [2022-05-17 10:04:52.873557] INFO Performance: last close: 2017-12-29 15:00:00+00:00
[2022-05-17 10:05:04.023175] INFO: cached.v2.9785eda2: [2022-05-17 10:04:54.411186] INFO moduleinvoker: backtest.v8 运行完成[77.978844s].
[2022-05-17 10:05:04.025859] INFO: cached.v2.9785eda2: [2022-05-17 10:04:54.411302] INFO moduleinvoker: trade.v4 运行完成[80.05755s].
[2022-05-17 10:05:04.028785] INFO: cached.v2.9785eda2: 任务状态: Succeeded
[2022-05-17 10:05:04.038677] INFO: moduleinvoker: cached.v2 运行完成[504.505816s].
[2022-05-17 10:05:04.040541] INFO: AI: [ParallelEx(n_jobs=30)]: Done 7 out of 9 | elapsed: 8.4min remaining: 2.4min
[2022-05-17 10:05:14.059745] INFO: cached.v2.977b4bc2: [2022-05-17 10:05:07.267133] INFO algo: handle_splits get splits [dt:2015-04-22 00:00:00+00:00] [asset:Equity(544 [300365.SZA]), ratio:0.49916666746139526]
[2022-05-17 10:05:14.061233] INFO: cached.v2.977b4bc2: [2022-05-17 10:05:11.330958] INFO algo: handle_splits get splits [dt:2015-05-14 00:00:00+00:00] [asset:Equity(81 [300138.SZA]), ratio:0.9994153380393982]
[2022-05-17 10:05:14.062623] INFO: cached.v2.977b4bc2: [2022-05-17 10:05:11.331132] INFO Position: position stock handle split[sid:81, orig_amount:7800, new_amount:7804.0, orig_cost:16.650001288694323, new_cost:16.6403, ratio:0.9994153380393982, last_sale_price:17.099994659423828]
[2022-05-17 10:05:14.063666] INFO: cached.v2.977b4bc2: [2022-05-17 10:05:11.331208] INFO Position: after split: PositionStock(asset:Equity(81 [300138.SZA]), amount:7804.0, cost_basis:16.6403, last_sale_price:17.10999870300293)
[2022-05-17 10:05:14.064724] INFO: cached.v2.977b4bc2: [2022-05-17 10:05:11.331254] INFO Position: returning cash: 9.6278
[2022-05-17 10:05:14.065714] INFO: cached.v2.977b4bc2: [2022-05-17 10:05:11.590847] INFO algo: handle_splits get splits [dt:2015-05-15 00:00:00+00:00] [asset:Equity(568 [000736.SZA]), ratio:0.9987077116966248]
[2022-05-17 10:05:14.066784] INFO: cached.v2.977b4bc2: [2022-05-17 10:05:11.590994] INFO Position: position stock handle split[sid:568, orig_amount:7400, new_amount:7409.0, orig_cost:15.350004547155757, new_cost:15.3302, ratio:0.9987077116966248, last_sale_price:15.459996223449707]
[2022-05-17 10:05:14.067772] INFO: cached.v2.977b4bc2: [2022-05-17 10:05:11.591068] INFO Position: after split: PositionStock(asset:Equity(568 [000736.SZA]), amount:7409.0, cost_basis:15.3302, last_sale_price:15.480000495910645)
[2022-05-17 10:05:14.068724] INFO: cached.v2.977b4bc2: [2022-05-17 10:05:11.591112] INFO Position: returning cash: 8.8943
[2022-05-17 10:05:24.123802] INFO: cached.v2.977b4bc2: [2022-05-17 10:05:15.293007] INFO algo: handle_splits get splits [dt:2015-05-29 00:00:00+00:00] [asset:Equity(1807 [002639.SZA]), ratio:0.9994773268699646]
[2022-05-17 10:05:24.126093] INFO: cached.v2.977b4bc2: [2022-05-17 10:05:18.484948] INFO algo: handle_splits get splits [dt:2015-06-10 00:00:00+00:00] [asset:Equity(3091 [300429.SZA]), ratio:0.9975002408027649]
[2022-05-17 10:05:24.127771] INFO: cached.v2.977b4bc2: [2022-05-17 10:05:18.485295] INFO Position: position stock handle split[sid:3091, orig_amount:1500, new_amount:1503.0, orig_cost:110.00000542756881, new_cost:109.725, ratio:0.9975002408027649, last_sale_price:103.74002838134766]
[2022-05-17 10:05:24.129571] INFO: cached.v2.977b4bc2: [2022-05-17 10:05:18.485383] INFO Position: after split: PositionStock(asset:Equity(3091 [300429.SZA]), amount:1503.0, cost_basis:109.725, last_sale_price:104.0)
[2022-05-17 10:05:24.131352] INFO: cached.v2.977b4bc2: [2022-05-17 10:05:18.485429] INFO Position: returning cash: 78.7424
[2022-05-17 10:05:24.133186] INFO: cached.v2.977b4bc2: [2022-05-17 10:05:18.822908] INFO algo: handle_splits get splits [dt:2015-06-11 00:00:00+00:00] [asset:Equity(3063 [300290.SZA]), ratio:0.99847811460495]
[2022-05-17 10:05:24.135031] INFO: cached.v2.977b4bc2: [2022-05-17 10:05:20.522144] INFO algo: handle_splits get splits [dt:2015-06-17 00:00:00+00:00] [asset:Equity(1007 [002680.SZA]), ratio:0.5871148109436035]
[2022-05-17 10:05:24.136482] INFO: cached.v2.977b4bc2: [2022-05-17 10:05:20.522299] INFO Position: position stock handle split[sid:1007, orig_amount:6100, new_amount:10389.0, orig_cost:33.99189881118793, new_cost:19.9571, ratio:0.5871148109436035, last_sale_price:20.959999084472656]
[2022-05-17 10:05:24.137825] INFO: cached.v2.977b4bc2: [2022-05-17 10:05:20.522373] INFO Position: after split: PositionStock(asset:Equity(1007 [002680.SZA]), amount:10389.0, cost_basis:19.9571, last_sale_price:35.70000076293945)
[2022-05-17 10:05:24.139191] INFO: cached.v2.977b4bc2: [2022-05-17 10:05:20.522418] INFO Position: returning cash: 16.573
[2022-05-17 10:05:24.142971] INFO: cached.v2.977b4bc2: [2022-05-17 10:05:21.003141] INFO algo: handle_splits get splits [dt:2015-06-26 00:00:00+00:00] [asset:Equity(2019 [600573.SHA]), ratio:0.9975095391273499]
[2022-05-17 10:05:24.144589] INFO: cached.v2.977b4bc2: [2022-05-17 10:05:21.003297] INFO Position: position stock handle split[sid:2019, orig_amount:11000, new_amount:11027.0, orig_cost:17.20000584256562, new_cost:17.1572, ratio:0.9975095391273499, last_sale_price:16.020002365112305]
[2022-05-17 10:05:24.146125] INFO: cached.v2.977b4bc2: [2022-05-17 10:05:21.003371] INFO Position: after split: PositionStock(asset:Equity(2019 [600573.SHA]), amount:11027.0, cost_basis:17.1572, last_sale_price:16.059999465942383)
[2022-05-17 10:05:24.147412] INFO: cached.v2.977b4bc2: [2022-05-17 10:05:21.003416] INFO Position: returning cash: 7.4247
[2022-05-17 10:05:24.148528] INFO: cached.v2.977b4bc2: [2022-05-17 10:05:21.045301] INFO algo: handle_splits get splits [dt:2015-07-03 00:00:00+00:00] [asset:Equity(1600 [300163.SZA]), ratio:0.9966577291488647]
[2022-05-17 10:05:24.149558] INFO: cached.v2.977b4bc2: [2022-05-17 10:05:21.045457] INFO Position: position stock handle split[sid:1600, orig_amount:4600, new_amount:4615.0, orig_cost:40.99999758084258, new_cost:40.863, ratio:0.9966577291488647, last_sale_price:29.819997787475586]
[2022-05-17 10:05:24.150617] INFO: cached.v2.977b4bc2: [2022-05-17 10:05:21.045531] INFO Position: after split: PositionStock(asset:Equity(1600 [300163.SZA]), amount:4615.0, cost_basis:40.863, last_sale_price:29.919998168945312)
[2022-05-17 10:05:24.151690] INFO: cached.v2.977b4bc2: [2022-05-17 10:05:21.045577] INFO Position: returning cash: 12.7034
[2022-05-17 10:05:24.152823] INFO: cached.v2.977b4bc2: [2022-05-17 10:05:23.683939] INFO algo: handle_splits get splits [dt:2015-07-22 00:00:00+00:00] [asset:Equity(2280 [300422.SZA]), ratio:0.9993225336074829]
[2022-05-17 10:05:24.153993] INFO: cached.v2.977b4bc2: [2022-05-17 10:05:23.684187] INFO Position: position stock handle split[sid:2280, orig_amount:4400, new_amount:4402.0, orig_cost:76.55001403175373, new_cost:76.4982, ratio:0.9993225336074829, last_sale_price:88.51998901367188]
[2022-05-17 10:05:24.155083] INFO: cached.v2.977b4bc2: [2022-05-17 10:05:23.684341] INFO Position: after split: PositionStock(asset:Equity(2280 [300422.SZA]), amount:4402.0, cost_basis:76.4982, last_sale_price:88.58000183105469)
[2022-05-17 10:05:24.156254] INFO: cached.v2.977b4bc2: [2022-05-17 10:05:23.684411] INFO Position: returning cash: 87.0039
[2022-05-17 10:05:34.203004] INFO: cached.v2.977b4bc2: [2022-05-17 10:05:24.800266] INFO algo: handle_splits get splits [dt:2015-07-24 00:00:00+00:00] [asset:Equity(137 [002169.SZA]), ratio:0.9983178973197937]
[2022-05-17 10:05:34.206015] INFO: cached.v2.977b4bc2: [2022-05-17 10:05:24.800409] INFO Position: position stock handle split[sid:137, orig_amount:9500, new_amount:9516.0, orig_cost:17.700001848739202, new_cost:17.6702, ratio:0.9983178973197937, last_sale_price:23.73999786376953]
[2022-05-17 10:05:34.208676] INFO: cached.v2.977b4bc2: [2022-05-17 10:05:24.800482] INFO Position: after split: PositionStock(asset:Equity(137 [002169.SZA]), amount:9516.0, cost_basis:17.6702, last_sale_price:23.779998779296875)
[2022-05-17 10:05:34.210197] INFO: cached.v2.977b4bc2: [2022-05-17 10:05:24.800527] INFO Position: returning cash: 0.1638
[2022-05-17 10:05:34.424020] INFO: cached.v2.9776956e: [2022-05-17 10:05:26.873288] INFO Performance: Simulated 243 trading days out of 243.
[2022-05-17 10:05:34.426939] INFO: cached.v2.9776956e: [2022-05-17 10:05:26.873632] INFO Performance: first open: 2021-01-04 09:30:00+00:00
[2022-05-17 10:05:34.430025] INFO: cached.v2.9776956e: [2022-05-17 10:05:26.873796] INFO Performance: last close: 2021-12-31 15:00:00+00:00
[2022-05-17 10:05:44.252728] INFO: cached.v2.977b4bc2: [2022-05-17 10:05:34.273897] INFO algo: handle_splits get splits [dt:2015-09-25 00:00:00+00:00] [asset:Equity(1600 [300163.SZA]), ratio:0.3333333134651184]
[2022-05-17 10:05:44.254224] INFO: cached.v2.977b4bc2: [2022-05-17 10:05:34.274042] INFO Position: position stock handle split[sid:1600, orig_amount:4615.0, new_amount:13845.0, orig_cost:40.863, new_cost:13.621, ratio:0.3333333134651184, last_sale_price:9.9399995803833]
[2022-05-17 10:05:44.255380] INFO: cached.v2.977b4bc2: [2022-05-17 10:05:34.274114] INFO Position: after split: PositionStock(asset:Equity(1600 [300163.SZA]), amount:13845.0, cost_basis:13.621, last_sale_price:29.82000160217285)
[2022-05-17 10:05:44.256381] INFO: cached.v2.977b4bc2: [2022-05-17 10:05:34.274160] INFO Position: returning cash: 0.0082
[2022-05-17 10:06:04.344160] INFO: cached.v2.977b4bc2: [2022-05-17 10:05:55.701103] INFO Performance: Simulated 244 trading days out of 244.
[2022-05-17 10:06:04.345856] INFO: cached.v2.977b4bc2: [2022-05-17 10:05:55.701206] INFO Performance: first open: 2015-01-05 09:30:00+00:00
[2022-05-17 10:06:04.347144] INFO: cached.v2.977b4bc2: [2022-05-17 10:05:55.701261] INFO Performance: last close: 2015-12-31 15:00:00+00:00
[2022-05-17 10:06:04.348368] INFO: cached.v2.977b4bc2: [2022-05-17 10:05:57.581779] INFO moduleinvoker: backtest.v8 运行完成[75.941644s].
[2022-05-17 10:06:04.349562] INFO: cached.v2.977b4bc2: [2022-05-17 10:05:57.581898] INFO moduleinvoker: trade.v4 运行完成[77.572246s].
[2022-05-17 10:06:04.350784] INFO: cached.v2.977b4bc2: 任务状态: Succeeded
[2022-05-17 10:06:04.358356] INFO: moduleinvoker: cached.v2 运行完成[564.864883s].
[2022-05-17 10:06:34.857366] INFO: cached.v2.9776956e: [2022-05-17 10:06:31.829374] INFO moduleinvoker: backtest.v8 运行完成[558.855253s].
[2022-05-17 10:06:34.858969] INFO: cached.v2.9776956e: [2022-05-17 10:06:31.829641] INFO moduleinvoker: trade.v4 运行完成[565.290935s].
[2022-05-17 10:06:44.932175] INFO: cached.v2.9776956e: 任务状态: Succeeded
[2022-05-17 10:06:44.938098] INFO: moduleinvoker: cached.v2 运行完成[605.476144s].
[2022-05-17 10:06:44.939696] INFO: AI: [ParallelEx(n_jobs=30)]: Done 9 out of 9 | elapsed: 10.1min remaining: 0.0s
[2022-05-17 10:06:44.941098] INFO: AI: [ParallelEx(n_jobs=30)]: Done 9 out of 9 | elapsed: 10.1min finished
[2022-05-17 10:06:44.943481] INFO: moduleinvoker: hyper_run.v1 运行完成[605.602489s].