2021-09-02 10:22:24,723 utils.prepare_workspace(123) INFO Writing log messages to F:/INVEST/wy/9.2zhang29.6\InVEST-Hydropower-Water-Yield-log-2021-09-02--10_22_24.txt 2021-09-02 10:22:24,725 model._logged_target(1646) Level 100 Starting model with parameters: Arguments for InVEST natcap.invest.hydropower.hydropower_water_yield 3.9.0: biophysical_table_path F:/北洛河研究区资料/表格数据/wy_biophysical table.csv depth_to_root_rest_layer_path F:/北洛河研究区资料/水源涵养数据8.17/depth1.tif do_scarcity_and_valuation False eto_path F:/北洛河研究区资料/水源涵养数据8.17/pet1.tif lulc_path F:/北洛河研究区资料/水源涵养数据8.17/lulc1.tif n_workers -1 pawc_path F:/北洛河研究区资料/水源涵养数据8.17/awc1.tif precipitation_path F:/北洛河研究区资料/Climate data (5)/1982-2015年逐年年降水-8km/res2000_clipclip1.tif results_suffix seasonality_constant 29.6 sub_watersheds_path watersheds_path F:/ziliuyu/watersheds_pro1.shp workspace_dir F:/INVEST/wy/9.2zhang29.6 2021-09-02 10:22:24,739 hydropower_water_yield.execute(269) INFO Validating arguments 2021-09-02 10:22:24,740 validation._wrapped_validate_func(911) DEBUG Using ARG_SPEC for validation 2021-09-02 10:22:24,740 validation._wrapped_validate_func(915) INFO Starting whole-model validation with ARGS_SPEC 2021-09-02 10:22:24,741 validation.timeout(625) DEBUG Starting file checking thread with timeout=5 2021-09-02 10:22:24,756 validation.timeout(637) DEBUG File checking thread completed. 2021-09-02 10:22:24,756 validation.validate(794) DEBUG Provided key do_scarcity_and_valuation does not exist in ARGS_SPEC 2021-09-02 10:22:24,757 validation.timeout(625) DEBUG Starting file checking thread with timeout=5 2021-09-02 10:22:24,817 validation.timeout(637) DEBUG File checking thread completed. 2021-09-02 10:22:24,818 validation.timeout(625) DEBUG Starting file checking thread with timeout=5 2021-09-02 10:22:24,895 validation.timeout(637) DEBUG File checking thread completed. 2021-09-02 10:22:24,896 validation.timeout(625) DEBUG Starting file checking thread with timeout=5 2021-09-02 10:22:24,941 validation.timeout(637) DEBUG File checking thread completed. 2021-09-02 10:22:24,941 validation.timeout(625) DEBUG Starting file checking thread with timeout=5 2021-09-02 10:22:24,993 validation.timeout(637) DEBUG File checking thread completed. 2021-09-02 10:22:24,993 validation.timeout(625) DEBUG Starting file checking thread with timeout=5 2021-09-02 10:22:24,999 validation.timeout(637) DEBUG File checking thread completed. 2021-09-02 10:22:24,999 validation.timeout(625) DEBUG Starting file checking thread with timeout=5 2021-09-02 10:22:25,046 validation.timeout(637) DEBUG File checking thread completed. 2021-09-02 10:22:25,046 validation.timeout(625) DEBUG Starting file checking thread with timeout=5 2021-09-02 10:22:25,259 validation.timeout(637) DEBUG File checking thread completed. 2021-09-02 10:22:25,687 validation._wrapped_validate_func(962) DEBUG Validation warnings: [] 2021-09-02 10:22:33,177 geoprocessing.align_and_resize_raster_stack(795) INFO 1 of 5 aligned: eto.tif 2021-09-02 10:22:38,321 geoprocessing.logger_callback(3400) INFO Warp 60.0% complete F:/INVEST/wy/9.2zhang29.6\intermediate\precip.tif 2021-09-02 10:22:42,027 geoprocessing.logger_callback(3400) INFO Warp 100.0% complete F:/INVEST/wy/9.2zhang29.6\intermediate\precip.tif 2021-09-02 10:22:44,636 geoprocessing.align_and_resize_raster_stack(795) INFO 2 of 5 aligned: precip.tif 2021-09-02 10:22:49,964 geoprocessing.logger_callback(3400) INFO Warp 72.0% complete F:/INVEST/wy/9.2zhang29.6\intermediate\depth_to_root_rest_layer.tif 2021-09-02 10:22:52,346 geoprocessing.logger_callback(3400) INFO Warp 100.0% complete F:/INVEST/wy/9.2zhang29.6\intermediate\depth_to_root_rest_layer.tif 2021-09-02 10:22:54,619 geoprocessing.align_and_resize_raster_stack(795) INFO 3 of 5 aligned: depth_to_root_rest_layer.tif 2021-09-02 10:23:00,272 geoprocessing.logger_callback(3400) INFO Warp 75.0% complete F:/INVEST/wy/9.2zhang29.6\intermediate\pawc.tif 2021-09-02 10:23:02,092 geoprocessing.logger_callback(3400) INFO Warp 100.0% complete F:/INVEST/wy/9.2zhang29.6\intermediate\pawc.tif 2021-09-02 10:23:05,053 geoprocessing.align_and_resize_raster_stack(795) INFO 4 of 5 aligned: pawc.tif 2021-09-02 10:23:10,249 geoprocessing.align_and_resize_raster_stack(795) INFO 5 of 5 aligned: clipped_lulc.tif 2021-09-02 10:23:10,250 geoprocessing.align_and_resize_raster_stack(797) INFO aligned all 5 rasters. 2021-09-02 10:23:10,547 hydropower_water_yield.execute(405) DEBUG bio_lucodes {1, 2, 3, 4, 5, 6, 7, 255.0} 2021-09-02 10:23:10,548 hydropower_water_yield.execute(453) INFO Reclassifying temp_Kc raster 2021-09-02 10:23:10,600 geoprocessing.raster_calculator(391) INFO starting stats_worker 2021-09-02 10:23:10,606 threading.run(870) DEBUG stats worker PID: 7840 2021-09-02 10:23:10,606 geoprocessing.raster_calculator(397) INFO started stats_worker 2021-09-02 10:23:15,603 geoprocessing.(474) INFO 59.9% complete 2021-09-02 10:23:18,919 geoprocessing.raster_calculator(477) INFO 100.0% complete 2021-09-02 10:23:18,921 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result. 2021-09-02 10:23:22,604 hydropower_water_yield.execute(465) INFO Reclassifying tmp_root raster 2021-09-02 10:23:22,658 geoprocessing.raster_calculator(391) INFO starting stats_worker 2021-09-02 10:23:22,664 threading.run(870) DEBUG stats worker PID: 7840 2021-09-02 10:23:22,664 geoprocessing.raster_calculator(397) INFO started stats_worker 2021-09-02 10:23:27,663 geoprocessing.(474) INFO 67.2% complete 2021-09-02 10:23:30,216 geoprocessing.raster_calculator(477) INFO 100.0% complete 2021-09-02 10:23:30,217 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result. 2021-09-02 10:23:33,950 hydropower_water_yield.execute(479) INFO Reclassifying tmp_veg raster 2021-09-02 10:23:34,005 geoprocessing.raster_calculator(391) INFO starting stats_worker 2021-09-02 10:23:34,009 threading.run(870) DEBUG stats worker PID: 7840 2021-09-02 10:23:34,009 geoprocessing.raster_calculator(397) INFO started stats_worker 2021-09-02 10:23:39,005 geoprocessing.(474) INFO 61.0% complete 2021-09-02 10:23:42,386 geoprocessing.raster_calculator(477) INFO 100.0% complete 2021-09-02 10:23:42,387 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result. 2021-09-02 10:23:45,872 hydropower_water_yield.execute(492) INFO Calculate PET from Ref Evap times Kc 2021-09-02 10:23:45,926 geoprocessing.raster_calculator(391) INFO starting stats_worker 2021-09-02 10:23:45,930 threading.run(870) DEBUG stats worker PID: 7840 2021-09-02 10:23:45,930 geoprocessing.raster_calculator(397) INFO started stats_worker 2021-09-02 10:23:50,928 geoprocessing.(474) INFO 58.5% complete 2021-09-02 10:23:55,568 geoprocessing.raster_calculator(477) INFO 100.0% complete 2021-09-02 10:23:55,569 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result. 2021-09-02 10:23:57,706 hydropower_water_yield.execute(510) DEBUG Performing fractp operation 2021-09-02 10:23:57,899 geoprocessing.raster_calculator(391) INFO starting stats_worker 2021-09-02 10:23:57,901 threading.run(870) DEBUG stats worker PID: 7840 2021-09-02 10:23:57,901 geoprocessing.raster_calculator(397) INFO started stats_worker 2021-09-02 10:24:02,913 geoprocessing.(474) INFO 14.4% complete 2021-09-02 10:24:07,918 geoprocessing.(474) INFO 27.9% complete 2021-09-02 10:24:12,926 geoprocessing.(474) INFO 40.6% complete 2021-09-02 10:24:17,969 geoprocessing.(474) INFO 52.0% complete 2021-09-02 10:24:23,028 geoprocessing.(474) INFO 63.0% complete 2021-09-02 10:24:28,036 geoprocessing.(474) INFO 73.9% complete 2021-09-02 10:24:33,037 geoprocessing.(474) INFO 86.6% complete 2021-09-02 10:24:37,499 geoprocessing.raster_calculator(477) INFO 100.0% complete 2021-09-02 10:24:37,499 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result. 2021-09-02 10:24:38,386 hydropower_water_yield.execute(523) INFO Performing wyield operation 2021-09-02 10:24:38,447 geoprocessing.raster_calculator(391) INFO starting stats_worker 2021-09-02 10:24:38,450 threading.run(870) DEBUG stats worker PID: 7840 2021-09-02 10:24:38,450 geoprocessing.raster_calculator(397) INFO started stats_worker 2021-09-02 10:24:43,444 geoprocessing.(474) INFO 52.1% complete 2021-09-02 10:24:48,448 geoprocessing.(474) INFO 92.6% complete 2021-09-02 10:24:49,378 geoprocessing.raster_calculator(477) INFO 100.0% complete 2021-09-02 10:24:49,380 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result. 2021-09-02 10:24:51,390 hydropower_water_yield.execute(536) DEBUG Performing aet operation 2021-09-02 10:24:51,522 geoprocessing.raster_calculator(391) INFO starting stats_worker 2021-09-02 10:24:51,540 threading.run(870) DEBUG stats worker PID: 7840 2021-09-02 10:24:51,541 geoprocessing.raster_calculator(397) INFO started stats_worker 2021-09-02 10:24:56,509 geoprocessing.(474) INFO 56.5% complete 2021-09-02 10:25:01,516 geoprocessing.(474) INFO 98.9% complete 2021-09-02 10:25:01,663 geoprocessing.raster_calculator(477) INFO 100.0% complete 2021-09-02 10:25:01,664 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result. 2021-09-02 10:25:03,495 geoprocessing.zonal_statistics(1184) DEBUG > 2021-09-02 10:25:09,165 geoprocessing.logger_callback(3400) INFO Warp 63.0% complete C:\Users\zhaoxin\AppData\Local\Temp\clipped_rasterla9rf4ea.tif 2021-09-02 10:25:12,791 geoprocessing.logger_callback(3400) INFO Warp 100.0% complete C:\Users\zhaoxin\AppData\Local\Temp\clipped_rasterla9rf4ea.tif 2021-09-02 10:25:15,059 geoprocessing.align_and_resize_raster_stack(795) INFO 1 of 1 aligned: clipped_rasterla9rf4ea.tif 2021-09-02 10:25:15,060 geoprocessing.align_and_resize_raster_stack(797) INFO aligned all 1 rasters. 2021-09-02 10:25:15,517 geoprocessing.zonal_statistics(1244) INFO build a lookup of aggregate field value to FID 2021-09-02 10:25:15,530 geoprocessing.zonal_statistics(1251) INFO creating disjoint polygon set 2021-09-02 10:25:15,532 geoprocessing.calculate_disjoint_polygon_set(2183) INFO build shapely polygon list 2021-09-02 10:25:15,964 geoprocessing.calculate_disjoint_polygon_set(2204) INFO build shapely rtree index 2021-09-02 10:25:15,993 geoprocessing.calculate_disjoint_polygon_set(2219) INFO poly feature lookup 100.0% complete on watersheds_pro1.shp 2021-09-02 10:25:15,995 geoprocessing.calculate_disjoint_polygon_set(2221) INFO build poly intersection lookup 2021-09-02 10:25:16,108 geoprocessing.calculate_disjoint_polygon_set(2245) INFO poly intersection feature lookup 100.0% complete on watersheds_pro1.shp 2021-09-02 10:25:16,110 geoprocessing.calculate_disjoint_polygon_set(2279) INFO maximal subset build 100.0% complete on watersheds_pro1.shp 2021-09-02 10:25:16,147 geoprocessing.zonal_statistics(1274) INFO processing 6 disjoint polygon sets 2021-09-02 10:25:16,155 geoprocessing.zonal_statistics(1309) INFO disjoint polygon set 1 of 6 100.0% processed on watersheds_pro1.shp 2021-09-02 10:25:16,259 geoprocessing.zonal_statistics(1317) INFO rasterizing disjoint polygon set 1 of 6 watersheds_pro1.shp 2021-09-02 10:25:19,508 geoprocessing.zonal_statistics(1335) INFO summarizing rasterized disjoint polygon set 1 of 6 watersheds_pro1.shp 2021-09-02 10:25:23,602 geoprocessing.(1280) INFO zonal stats approximately 33.3% complete on watersheds_pro1.shp 2021-09-02 10:25:23,607 geoprocessing.zonal_statistics(1309) INFO disjoint polygon set 2 of 6 100.0% processed on watersheds_pro1.shp 2021-09-02 10:25:23,662 geoprocessing.zonal_statistics(1317) INFO rasterizing disjoint polygon set 2 of 6 watersheds_pro1.shp 2021-09-02 10:25:26,956 geoprocessing.zonal_statistics(1335) INFO summarizing rasterized disjoint polygon set 2 of 6 watersheds_pro1.shp 2021-09-02 10:25:31,252 geoprocessing.(1280) INFO zonal stats approximately 50.0% complete on watersheds_pro1.shp 2021-09-02 10:25:31,259 geoprocessing.zonal_statistics(1309) INFO disjoint polygon set 3 of 6 100.0% processed on watersheds_pro1.shp 2021-09-02 10:25:31,319 geoprocessing.zonal_statistics(1317) INFO rasterizing disjoint polygon set 3 of 6 watersheds_pro1.shp 2021-09-02 10:25:34,666 geoprocessing.zonal_statistics(1335) INFO summarizing rasterized disjoint polygon set 3 of 6 watersheds_pro1.shp 2021-09-02 10:25:39,246 geoprocessing.(1280) INFO zonal stats approximately 66.7% complete on watersheds_pro1.shp 2021-09-02 10:25:39,251 geoprocessing.zonal_statistics(1309) INFO disjoint polygon set 4 of 6 100.0% processed on watersheds_pro1.shp 2021-09-02 10:25:39,305 geoprocessing.zonal_statistics(1317) INFO rasterizing disjoint polygon set 4 of 6 watersheds_pro1.shp 2021-09-02 10:25:42,681 geoprocessing.zonal_statistics(1335) INFO summarizing rasterized disjoint polygon set 4 of 6 watersheds_pro1.shp 2021-09-02 10:25:46,807 geoprocessing.(1280) INFO zonal stats approximately 83.3% complete on watersheds_pro1.shp 2021-09-02 10:25:46,811 geoprocessing.zonal_statistics(1309) INFO disjoint polygon set 5 of 6 100.0% processed on watersheds_pro1.shp 2021-09-02 10:25:46,856 geoprocessing.zonal_statistics(1317) INFO rasterizing disjoint polygon set 5 of 6 watersheds_pro1.shp 2021-09-02 10:25:50,587 geoprocessing.zonal_statistics(1335) INFO summarizing rasterized disjoint polygon set 5 of 6 watersheds_pro1.shp 2021-09-02 10:25:54,953 geoprocessing.(1280) INFO zonal stats approximately 100.0% complete on watersheds_pro1.shp 2021-09-02 10:25:54,956 geoprocessing.zonal_statistics(1309) INFO disjoint polygon set 6 of 6 100.0% processed on watersheds_pro1.shp 2021-09-02 10:25:55,012 geoprocessing.zonal_statistics(1317) INFO rasterizing disjoint polygon set 6 of 6 watersheds_pro1.shp 2021-09-02 10:25:58,225 geoprocessing.zonal_statistics(1335) INFO summarizing rasterized disjoint polygon set 6 of 6 watersheds_pro1.shp 2021-09-02 10:26:01,941 geoprocessing.zonal_statistics(1378) DEBUG unset_fids: 0 of 119 2021-09-02 10:26:01,945 geoprocessing.zonal_statistics(1381) DEBUG gt [ 4.2215765e+06 3.0000000e+01 0.0000000e+00 4.0009348e+06 0.0000000e+00 -3.0000000e+01] for ('F:/INVEST/wy/9.2zhang29.6\\intermediate\\precip.tif', 1) 2021-09-02 10:26:01,946 geoprocessing.zonal_statistics(1460) DEBUG remaining unset_fids: 0 of 119 2021-09-02 10:26:01,947 geoprocessing.zonal_statistics(1468) INFO all done processing polygon sets for watersheds_pro1.shp 2021-09-02 10:26:02,318 geoprocessing.zonal_statistics(1184) DEBUG > 2021-09-02 10:26:08,029 geoprocessing.logger_callback(3400) INFO Warp 75.0% complete C:\Users\zhaoxin\AppData\Local\Temp\clipped_rasterumx5yagj.tif 2021-09-02 10:26:09,428 geoprocessing.logger_callback(3400) INFO Warp 100.0% complete C:\Users\zhaoxin\AppData\Local\Temp\clipped_rasterumx5yagj.tif 2021-09-02 10:26:12,182 geoprocessing.align_and_resize_raster_stack(795) INFO 1 of 1 aligned: clipped_rasterumx5yagj.tif 2021-09-02 10:26:12,182 geoprocessing.align_and_resize_raster_stack(797) INFO aligned all 1 rasters. 2021-09-02 10:26:12,565 geoprocessing.zonal_statistics(1244) INFO build a lookup of aggregate field value to FID 2021-09-02 10:26:12,572 geoprocessing.zonal_statistics(1251) INFO creating disjoint polygon set 2021-09-02 10:26:12,575 geoprocessing.calculate_disjoint_polygon_set(2183) INFO build shapely polygon list 2021-09-02 10:26:13,027 geoprocessing.calculate_disjoint_polygon_set(2204) INFO build shapely rtree index 2021-09-02 10:26:13,053 geoprocessing.calculate_disjoint_polygon_set(2219) INFO poly feature lookup 100.0% complete on watersheds_pro1.shp 2021-09-02 10:26:13,054 geoprocessing.calculate_disjoint_polygon_set(2221) INFO build poly intersection lookup 2021-09-02 10:26:13,164 geoprocessing.calculate_disjoint_polygon_set(2245) INFO poly intersection feature lookup 100.0% complete on watersheds_pro1.shp 2021-09-02 10:26:13,167 geoprocessing.calculate_disjoint_polygon_set(2279) INFO maximal subset build 100.0% complete on watersheds_pro1.shp 2021-09-02 10:26:13,203 geoprocessing.zonal_statistics(1274) INFO processing 6 disjoint polygon sets 2021-09-02 10:26:13,215 geoprocessing.zonal_statistics(1309) INFO disjoint polygon set 1 of 6 100.0% processed on watersheds_pro1.shp 2021-09-02 10:26:13,314 geoprocessing.zonal_statistics(1317) INFO rasterizing disjoint polygon set 1 of 6 watersheds_pro1.shp 2021-09-02 10:26:16,486 geoprocessing.zonal_statistics(1335) INFO summarizing rasterized disjoint polygon set 1 of 6 watersheds_pro1.shp 2021-09-02 10:26:20,701 geoprocessing.(1280) INFO zonal stats approximately 33.3% complete on watersheds_pro1.shp 2021-09-02 10:26:20,706 geoprocessing.zonal_statistics(1309) INFO disjoint polygon set 2 of 6 100.0% processed on watersheds_pro1.shp 2021-09-02 10:26:20,743 geoprocessing.zonal_statistics(1317) INFO rasterizing disjoint polygon set 2 of 6 watersheds_pro1.shp 2021-09-02 10:26:23,864 geoprocessing.zonal_statistics(1335) INFO summarizing rasterized disjoint polygon set 2 of 6 watersheds_pro1.shp 2021-09-02 10:26:28,353 geoprocessing.(1280) INFO zonal stats approximately 50.0% complete on watersheds_pro1.shp 2021-09-02 10:26:28,359 geoprocessing.zonal_statistics(1309) INFO disjoint polygon set 3 of 6 100.0% processed on watersheds_pro1.shp 2021-09-02 10:26:28,407 geoprocessing.zonal_statistics(1317) INFO rasterizing disjoint polygon set 3 of 6 watersheds_pro1.shp 2021-09-02 10:26:31,892 geoprocessing.zonal_statistics(1335) INFO summarizing rasterized disjoint polygon set 3 of 6 watersheds_pro1.shp 2021-09-02 10:26:36,561 geoprocessing.(1280) INFO zonal stats approximately 66.7% complete on watersheds_pro1.shp 2021-09-02 10:26:36,565 geoprocessing.zonal_statistics(1309) INFO disjoint polygon set 4 of 6 100.0% processed on watersheds_pro1.shp 2021-09-02 10:26:36,615 geoprocessing.zonal_statistics(1317) INFO rasterizing disjoint polygon set 4 of 6 watersheds_pro1.shp 2021-09-02 10:26:40,052 geoprocessing.zonal_statistics(1335) INFO summarizing rasterized disjoint polygon set 4 of 6 watersheds_pro1.shp 2021-09-02 10:26:44,364 geoprocessing.(1280) INFO zonal stats approximately 83.3% complete on watersheds_pro1.shp 2021-09-02 10:26:44,368 geoprocessing.zonal_statistics(1309) INFO disjoint polygon set 5 of 6 100.0% processed on watersheds_pro1.shp 2021-09-02 10:26:44,423 geoprocessing.zonal_statistics(1317) INFO rasterizing disjoint polygon set 5 of 6 watersheds_pro1.shp 2021-09-02 10:26:47,600 geoprocessing.zonal_statistics(1335) INFO summarizing rasterized disjoint polygon set 5 of 6 watersheds_pro1.shp 2021-09-02 10:26:51,557 geoprocessing.(1280) INFO zonal stats approximately 100.0% complete on watersheds_pro1.shp 2021-09-02 10:26:51,560 geoprocessing.zonal_statistics(1309) INFO disjoint polygon set 6 of 6 100.0% processed on watersheds_pro1.shp 2021-09-02 10:26:51,608 geoprocessing.zonal_statistics(1317) INFO rasterizing disjoint polygon set 6 of 6 watersheds_pro1.shp 2021-09-02 10:26:54,832 geoprocessing.zonal_statistics(1335) INFO summarizing rasterized disjoint polygon set 6 of 6 watersheds_pro1.shp 2021-09-02 10:26:58,397 geoprocessing.zonal_statistics(1378) DEBUG unset_fids: 0 of 119 2021-09-02 10:26:58,403 geoprocessing.zonal_statistics(1381) DEBUG gt [ 4.2215765e+06 3.0000000e+01 0.0000000e+00 4.0009348e+06 0.0000000e+00 -3.0000000e+01] for ('F:/INVEST/wy/9.2zhang29.6\\intermediate\\pet.tif', 1) 2021-09-02 10:26:58,404 geoprocessing.zonal_statistics(1460) DEBUG remaining unset_fids: 0 of 119 2021-09-02 10:26:58,405 geoprocessing.zonal_statistics(1468) INFO all done processing polygon sets for watersheds_pro1.shp 2021-09-02 10:26:58,784 geoprocessing.zonal_statistics(1184) DEBUG > 2021-09-02 10:27:04,477 geoprocessing.logger_callback(3400) INFO Warp 69.0% complete C:\Users\zhaoxin\AppData\Local\Temp\clipped_rasterbtrboq5n.tif 2021-09-02 10:27:06,803 geoprocessing.logger_callback(3400) INFO Warp 100.0% complete C:\Users\zhaoxin\AppData\Local\Temp\clipped_rasterbtrboq5n.tif 2021-09-02 10:27:09,380 geoprocessing.align_and_resize_raster_stack(795) INFO 1 of 1 aligned: clipped_rasterbtrboq5n.tif 2021-09-02 10:27:09,381 geoprocessing.align_and_resize_raster_stack(797) INFO aligned all 1 rasters. 2021-09-02 10:27:09,853 geoprocessing.zonal_statistics(1244) INFO build a lookup of aggregate field value to FID 2021-09-02 10:27:09,865 geoprocessing.zonal_statistics(1251) INFO creating disjoint polygon set 2021-09-02 10:27:09,867 geoprocessing.calculate_disjoint_polygon_set(2183) INFO build shapely polygon list 2021-09-02 10:27:10,375 geoprocessing.calculate_disjoint_polygon_set(2204) INFO build shapely rtree index 2021-09-02 10:27:10,404 geoprocessing.calculate_disjoint_polygon_set(2219) INFO poly feature lookup 100.0% complete on watersheds_pro1.shp 2021-09-02 10:27:10,405 geoprocessing.calculate_disjoint_polygon_set(2221) INFO build poly intersection lookup 2021-09-02 10:27:10,504 geoprocessing.calculate_disjoint_polygon_set(2245) INFO poly intersection feature lookup 100.0% complete on watersheds_pro1.shp 2021-09-02 10:27:10,507 geoprocessing.calculate_disjoint_polygon_set(2279) INFO maximal subset build 100.0% complete on watersheds_pro1.shp 2021-09-02 10:27:10,543 geoprocessing.zonal_statistics(1274) INFO processing 6 disjoint polygon sets 2021-09-02 10:27:10,549 geoprocessing.zonal_statistics(1309) INFO disjoint polygon set 1 of 6 100.0% processed on watersheds_pro1.shp 2021-09-02 10:27:10,650 geoprocessing.zonal_statistics(1317) INFO rasterizing disjoint polygon set 1 of 6 watersheds_pro1.shp 2021-09-02 10:27:13,855 geoprocessing.zonal_statistics(1335) INFO summarizing rasterized disjoint polygon set 1 of 6 watersheds_pro1.shp 2021-09-02 10:27:18,151 geoprocessing.(1280) INFO zonal stats approximately 33.3% complete on watersheds_pro1.shp 2021-09-02 10:27:18,158 geoprocessing.zonal_statistics(1309) INFO disjoint polygon set 2 of 6 100.0% processed on watersheds_pro1.shp 2021-09-02 10:27:18,220 geoprocessing.zonal_statistics(1317) INFO rasterizing disjoint polygon set 2 of 6 watersheds_pro1.shp 2021-09-02 10:27:21,733 geoprocessing.zonal_statistics(1335) INFO summarizing rasterized disjoint polygon set 2 of 6 watersheds_pro1.shp 2021-09-02 10:27:26,116 geoprocessing.(1280) INFO zonal stats approximately 50.0% complete on watersheds_pro1.shp 2021-09-02 10:27:26,128 geoprocessing.zonal_statistics(1309) INFO disjoint polygon set 3 of 6 100.0% processed on watersheds_pro1.shp 2021-09-02 10:27:26,204 geoprocessing.zonal_statistics(1317) INFO rasterizing disjoint polygon set 3 of 6 watersheds_pro1.shp 2021-09-02 10:27:29,497 geoprocessing.zonal_statistics(1335) INFO summarizing rasterized disjoint polygon set 3 of 6 watersheds_pro1.shp 2021-09-02 10:27:34,193 geoprocessing.(1280) INFO zonal stats approximately 66.7% complete on watersheds_pro1.shp 2021-09-02 10:27:34,197 geoprocessing.zonal_statistics(1309) INFO disjoint polygon set 4 of 6 100.0% processed on watersheds_pro1.shp 2021-09-02 10:27:34,249 geoprocessing.zonal_statistics(1317) INFO rasterizing disjoint polygon set 4 of 6 watersheds_pro1.shp 2021-09-02 10:27:37,720 geoprocessing.zonal_statistics(1335) INFO summarizing rasterized disjoint polygon set 4 of 6 watersheds_pro1.shp 2021-09-02 10:27:42,063 geoprocessing.(1280) INFO zonal stats approximately 83.3% complete on watersheds_pro1.shp 2021-09-02 10:27:42,067 geoprocessing.zonal_statistics(1309) INFO disjoint polygon set 5 of 6 100.0% processed on watersheds_pro1.shp 2021-09-02 10:27:42,121 geoprocessing.zonal_statistics(1317) INFO rasterizing disjoint polygon set 5 of 6 watersheds_pro1.shp 2021-09-02 10:27:44,078 geoprocessing.zonal_statistics(1335) INFO summarizing rasterized disjoint polygon set 5 of 6 watersheds_pro1.shp 2021-09-02 10:27:47,905 geoprocessing.(1280) INFO zonal stats approximately 100.0% complete on watersheds_pro1.shp 2021-09-02 10:27:47,906 geoprocessing.zonal_statistics(1309) INFO disjoint polygon set 6 of 6 100.0% processed on watersheds_pro1.shp 2021-09-02 10:27:47,943 geoprocessing.zonal_statistics(1317) INFO rasterizing disjoint polygon set 6 of 6 watersheds_pro1.shp 2021-09-02 10:27:49,879 geoprocessing.zonal_statistics(1335) INFO summarizing rasterized disjoint polygon set 6 of 6 watersheds_pro1.shp 2021-09-02 10:27:53,099 geoprocessing.zonal_statistics(1378) DEBUG unset_fids: 0 of 119 2021-09-02 10:27:53,105 geoprocessing.zonal_statistics(1381) DEBUG gt [ 4.2215765e+06 3.0000000e+01 0.0000000e+00 4.0009348e+06 0.0000000e+00 -3.0000000e+01] for ('F:/INVEST/wy/9.2zhang29.6\\output\\per_pixel\\aet.tif', 1) 2021-09-02 10:27:53,105 geoprocessing.zonal_statistics(1460) DEBUG remaining unset_fids: 0 of 119 2021-09-02 10:27:53,106 geoprocessing.zonal_statistics(1468) INFO all done processing polygon sets for watersheds_pro1.shp 2021-09-02 10:27:53,469 geoprocessing.zonal_statistics(1184) DEBUG > 2021-09-02 10:27:58,959 geoprocessing.logger_callback(3400) INFO Warp 75.0% complete C:\Users\zhaoxin\AppData\Local\Temp\clipped_rasterp2lzm2pt.tif 2021-09-02 10:28:00,139 geoprocessing.logger_callback(3400) INFO Warp 100.0% complete C:\Users\zhaoxin\AppData\Local\Temp\clipped_rasterp2lzm2pt.tif 2021-09-02 10:28:02,683 geoprocessing.align_and_resize_raster_stack(795) INFO 1 of 1 aligned: clipped_rasterp2lzm2pt.tif 2021-09-02 10:28:02,683 geoprocessing.align_and_resize_raster_stack(797) INFO aligned all 1 rasters. 2021-09-02 10:28:03,068 geoprocessing.zonal_statistics(1244) INFO build a lookup of aggregate field value to FID 2021-09-02 10:28:03,079 geoprocessing.zonal_statistics(1251) INFO creating disjoint polygon set 2021-09-02 10:28:03,082 geoprocessing.calculate_disjoint_polygon_set(2183) INFO build shapely polygon list 2021-09-02 10:28:03,511 geoprocessing.calculate_disjoint_polygon_set(2204) INFO build shapely rtree index 2021-09-02 10:28:03,534 geoprocessing.calculate_disjoint_polygon_set(2219) INFO poly feature lookup 100.0% complete on watersheds_pro1.shp 2021-09-02 10:28:03,535 geoprocessing.calculate_disjoint_polygon_set(2221) INFO build poly intersection lookup 2021-09-02 10:28:03,636 geoprocessing.calculate_disjoint_polygon_set(2245) INFO poly intersection feature lookup 100.0% complete on watersheds_pro1.shp 2021-09-02 10:28:03,639 geoprocessing.calculate_disjoint_polygon_set(2279) INFO maximal subset build 100.0% complete on watersheds_pro1.shp 2021-09-02 10:28:03,672 geoprocessing.zonal_statistics(1274) INFO processing 6 disjoint polygon sets 2021-09-02 10:28:03,681 geoprocessing.zonal_statistics(1309) INFO disjoint polygon set 1 of 6 100.0% processed on watersheds_pro1.shp 2021-09-02 10:28:03,781 geoprocessing.zonal_statistics(1317) INFO rasterizing disjoint polygon set 1 of 6 watersheds_pro1.shp 2021-09-02 10:28:06,003 geoprocessing.zonal_statistics(1335) INFO summarizing rasterized disjoint polygon set 1 of 6 watersheds_pro1.shp 2021-09-02 10:28:08,915 geoprocessing.(1280) INFO zonal stats approximately 33.3% complete on watersheds_pro1.shp 2021-09-02 10:28:08,919 geoprocessing.zonal_statistics(1309) INFO disjoint polygon set 2 of 6 100.0% processed on watersheds_pro1.shp 2021-09-02 10:28:08,962 geoprocessing.zonal_statistics(1317) INFO rasterizing disjoint polygon set 2 of 6 watersheds_pro1.shp 2021-09-02 10:28:12,191 geoprocessing.zonal_statistics(1335) INFO summarizing rasterized disjoint polygon set 2 of 6 watersheds_pro1.shp 2021-09-02 10:28:16,359 geoprocessing.(1280) INFO zonal stats approximately 50.0% complete on watersheds_pro1.shp 2021-09-02 10:28:16,366 geoprocessing.zonal_statistics(1309) INFO disjoint polygon set 3 of 6 100.0% processed on watersheds_pro1.shp 2021-09-02 10:28:16,416 geoprocessing.zonal_statistics(1317) INFO rasterizing disjoint polygon set 3 of 6 watersheds_pro1.shp 2021-09-02 10:28:19,563 geoprocessing.zonal_statistics(1335) INFO summarizing rasterized disjoint polygon set 3 of 6 watersheds_pro1.shp 2021-09-02 10:28:23,883 geoprocessing.(1280) INFO zonal stats approximately 66.7% complete on watersheds_pro1.shp 2021-09-02 10:28:23,889 geoprocessing.zonal_statistics(1309) INFO disjoint polygon set 4 of 6 100.0% processed on watersheds_pro1.shp 2021-09-02 10:28:23,941 geoprocessing.zonal_statistics(1317) INFO rasterizing disjoint polygon set 4 of 6 watersheds_pro1.shp 2021-09-02 10:28:27,315 geoprocessing.zonal_statistics(1335) INFO summarizing rasterized disjoint polygon set 4 of 6 watersheds_pro1.shp 2021-09-02 10:28:31,175 geoprocessing.(1280) INFO zonal stats approximately 83.3% complete on watersheds_pro1.shp 2021-09-02 10:28:31,180 geoprocessing.zonal_statistics(1309) INFO disjoint polygon set 5 of 6 100.0% processed on watersheds_pro1.shp 2021-09-02 10:28:31,231 geoprocessing.zonal_statistics(1317) INFO rasterizing disjoint polygon set 5 of 6 watersheds_pro1.shp 2021-09-02 10:28:34,350 geoprocessing.zonal_statistics(1335) INFO summarizing rasterized disjoint polygon set 5 of 6 watersheds_pro1.shp 2021-09-02 10:28:38,023 geoprocessing.(1280) INFO zonal stats approximately 100.0% complete on watersheds_pro1.shp 2021-09-02 10:28:38,025 geoprocessing.zonal_statistics(1309) INFO disjoint polygon set 6 of 6 100.0% processed on watersheds_pro1.shp 2021-09-02 10:28:38,077 geoprocessing.zonal_statistics(1317) INFO rasterizing disjoint polygon set 6 of 6 watersheds_pro1.shp 2021-09-02 10:28:41,136 geoprocessing.zonal_statistics(1335) INFO summarizing rasterized disjoint polygon set 6 of 6 watersheds_pro1.shp 2021-09-02 10:28:44,704 geoprocessing.zonal_statistics(1378) DEBUG unset_fids: 0 of 119 2021-09-02 10:28:44,711 geoprocessing.zonal_statistics(1381) DEBUG gt [ 4.2215765e+06 3.0000000e+01 0.0000000e+00 4.0009348e+06 0.0000000e+00 -3.0000000e+01] for ('F:/INVEST/wy/9.2zhang29.6\\output\\per_pixel\\wyield.tif', 1) 2021-09-02 10:28:44,712 geoprocessing.zonal_statistics(1460) DEBUG remaining unset_fids: 0 of 119 2021-09-02 10:28:44,712 geoprocessing.zonal_statistics(1468) INFO all done processing polygon sets for watersheds_pro1.shp 2021-09-02 10:28:48,918 model._logged_target(1655) INFO Execution finished 2021-09-02 10:28:48,920 utils.prepare_workspace(129) INFO Elapsed time: 6m 24.19999999999999s