2023-11-22 10:01:41,595 (natcap.invest.utils) utils.prepare_workspace(161) Level 100 Writing log messages to [D:\NEW-INvest shuju\water yield\result\InVEST-natcap.invest.annual_water_yield-log-2023-11-22--10_01_41.txt] 2023-11-22 10:01:41,595 (__main__) cli.main(459) Level 100 Starting model with parameters: Arguments for InVEST natcap.invest.annual_water_yield 3.14.0: biophysical_table_path D:\invest shuju\water yield-SX\biophysical table2.0.csv demand_table_path depth_to_root_rest_layer_path D:\NEW-INvest shuju\water yield\HWSD-SX.tif eto_path D:\NEW-INvest shuju\water yield\Evapotranspiration\Evapotranspiration.tif lulc_path D:\NEW-INvest shuju\TDLY\TDLY-SX.tif n_workers -1 pawc_path D:\NEW-INvest shuju\water yield\HWSD-SX.tif precipitation_path D:\NEW-INvest shuju\water yield\precipitation\Precipitation.tif results_suffix seasonality_constant 1.5 sub_watersheds_path valuation_table_path watersheds_path D:\NEW-INvest shuju\water yield\LIUYU.shp workspace_dir D:\NEW-INvest shuju\water yield\result 2023-11-22 10:01:47,046 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3601) INFO Warp 47.0% complete D:\NEW-INvest shuju\water yield\result\intermediate\eto.tif 2023-11-22 10:01:52,112 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3601) INFO Warp 92.0% complete D:\NEW-INvest shuju\water yield\result\intermediate\eto.tif 2023-11-22 10:01:52,829 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3601) INFO Warp 100.0% complete D:\NEW-INvest shuju\water yield\result\intermediate\eto.tif 2023-11-22 10:02:04,380 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(996) INFO 1 of 5 aligned: eto.tif 2023-11-22 10:02:09,447 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3601) INFO Warp 50.0% complete D:\NEW-INvest shuju\water yield\result\intermediate\precip.tif 2023-11-22 10:02:14,513 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3601) INFO Warp 96.0% complete D:\NEW-INvest shuju\water yield\result\intermediate\precip.tif 2023-11-22 10:02:14,763 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3601) INFO Warp 100.0% complete D:\NEW-INvest shuju\water yield\result\intermediate\precip.tif 2023-11-22 10:02:19,497 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(996) INFO 2 of 5 aligned: precip.tif 2023-11-22 10:02:24,582 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3601) INFO Warp 48.0% complete D:\NEW-INvest shuju\water yield\result\intermediate\depth_to_root_rest_layer.tif 2023-11-22 10:02:29,665 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3601) INFO Warp 94.0% complete D:\NEW-INvest shuju\water yield\result\intermediate\depth_to_root_rest_layer.tif 2023-11-22 10:02:30,065 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3601) INFO Warp 100.0% complete D:\NEW-INvest shuju\water yield\result\intermediate\depth_to_root_rest_layer.tif 2023-11-22 10:02:33,732 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(996) INFO 3 of 5 aligned: depth_to_root_rest_layer.tif 2023-11-22 10:02:38,808 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3601) INFO Warp 49.0% complete D:\NEW-INvest shuju\water yield\result\intermediate\pawc.tif 2023-11-22 10:02:43,848 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3601) INFO Warp 95.0% complete D:\NEW-INvest shuju\water yield\result\intermediate\pawc.tif 2023-11-22 10:02:44,214 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3601) INFO Warp 100.0% complete D:\NEW-INvest shuju\water yield\result\intermediate\pawc.tif 2023-11-22 10:02:47,988 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(996) INFO 4 of 5 aligned: pawc.tif 2023-11-22 10:02:53,031 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3601) INFO Warp 37.0% complete D:\NEW-INvest shuju\water yield\result\intermediate\clipped_lulc.tif 2023-11-22 10:02:58,149 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3601) INFO Warp 73.0% complete D:\NEW-INvest shuju\water yield\result\intermediate\clipped_lulc.tif 2023-11-22 10:03:01,731 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3601) INFO Warp 100.0% complete D:\NEW-INvest shuju\water yield\result\intermediate\clipped_lulc.tif 2023-11-22 10:03:04,465 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(996) INFO 5 of 5 aligned: clipped_lulc.tif 2023-11-22 10:03:04,465 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(1000) INFO aligned all 5 rasters. 2023-11-22 10:03:04,515 (natcap.invest.annual_water_yield) annual_water_yield.execute(695) INFO Reclassifying temp_Kc raster 2023-11-22 10:03:04,550 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(470) INFO starting stats_worker 2023-11-22 10:03:04,561 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(476) INFO started stats_worker 2023-11-22 10:03:09,565 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO kc_raster.tif 31.7% complete 2023-11-22 10:03:14,570 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO kc_raster.tif 53.8% complete 2023-11-22 10:03:19,581 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO kc_raster.tif 73.6% complete 2023-11-22 10:03:24,582 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO kc_raster.tif 95.6% complete 2023-11-22 10:03:25,282 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(555) INFO 100.0% complete 2023-11-22 10:03:25,282 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(558) INFO Waiting for raster stats worker result. 2023-11-22 10:03:33,828 (natcap.invest.annual_water_yield) annual_water_yield.execute(707) INFO Reclassifying tmp_root raster 2023-11-22 10:03:33,855 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(470) INFO starting stats_worker 2023-11-22 10:03:33,865 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(476) INFO started stats_worker 2023-11-22 10:03:38,869 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO root_depth.tif 31.4% complete 2023-11-22 10:03:43,883 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO root_depth.tif 53.2% complete 2023-11-22 10:03:48,883 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO root_depth.tif 73.7% complete 2023-11-22 10:03:53,899 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO root_depth.tif 98.6% complete 2023-11-22 10:03:54,117 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(555) INFO 100.0% complete 2023-11-22 10:03:54,117 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(558) INFO Waiting for raster stats worker result. 2023-11-22 10:04:02,516 (natcap.invest.annual_water_yield) annual_water_yield.execute(721) INFO Reclassifying tmp_veg raster 2023-11-22 10:04:02,555 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(470) INFO starting stats_worker 2023-11-22 10:04:02,560 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(476) INFO started stats_worker 2023-11-22 10:04:07,567 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO veg.tif 31.0% complete 2023-11-22 10:04:12,567 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO veg.tif 52.7% complete 2023-11-22 10:04:17,584 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO veg.tif 71.7% complete 2023-11-22 10:04:22,584 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO veg.tif 93.6% complete 2023-11-22 10:04:23,650 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(555) INFO 100.0% complete 2023-11-22 10:04:23,650 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(558) INFO Waiting for raster stats worker result. 2023-11-22 10:04:31,001 (natcap.invest.annual_water_yield) annual_water_yield.execute(734) INFO Calculate PET from Ref Evap times Kc 2023-11-22 10:04:31,035 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(470) INFO starting stats_worker 2023-11-22 10:04:31,036 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(476) INFO started stats_worker 2023-11-22 10:04:36,019 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO pet.tif 27.8% complete 2023-11-22 10:04:41,034 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO pet.tif 48.8% complete 2023-11-22 10:04:46,036 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO pet.tif 65.3% complete 2023-11-22 10:04:51,050 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO pet.tif 78.7% complete 2023-11-22 10:04:56,060 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO pet.tif 92.6% complete 2023-11-22 10:04:58,697 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(555) INFO 100.0% complete 2023-11-22 10:04:58,697 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(558) INFO Waiting for raster stats worker result. 2023-11-22 10:05:06,579 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(470) INFO starting stats_worker 2023-11-22 10:05:06,587 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(476) INFO started stats_worker 2023-11-22 10:05:11,589 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO fractp.tif 10.5% complete 2023-11-22 10:05:16,602 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO fractp.tif 17.1% complete 2023-11-22 10:05:21,607 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO fractp.tif 22.3% complete 2023-11-22 10:05:26,641 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO fractp.tif 26.4% complete 2023-11-22 10:05:31,667 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO fractp.tif 30.4% complete 2023-11-22 10:05:36,679 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO fractp.tif 34.1% complete 2023-11-22 10:05:41,706 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO fractp.tif 38.0% complete 2023-11-22 10:05:46,724 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO fractp.tif 41.6% complete 2023-11-22 10:05:51,736 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO fractp.tif 45.0% complete 2023-11-22 10:05:56,775 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO fractp.tif 48.4% complete 2023-11-22 10:06:01,808 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO fractp.tif 51.8% complete 2023-11-22 10:06:06,828 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO fractp.tif 55.4% complete 2023-11-22 10:06:11,840 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO fractp.tif 59.0% complete 2023-11-22 10:06:16,845 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO fractp.tif 62.5% complete 2023-11-22 10:06:21,876 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO fractp.tif 66.1% complete 2023-11-22 10:06:26,888 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO fractp.tif 69.7% complete 2023-11-22 10:06:31,922 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO fractp.tif 73.3% complete 2023-11-22 10:06:36,943 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO fractp.tif 76.9% complete 2023-11-22 10:06:41,976 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO fractp.tif 80.7% complete 2023-11-22 10:06:46,984 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO fractp.tif 84.5% complete 2023-11-22 10:06:51,984 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO fractp.tif 88.5% complete 2023-11-22 10:06:56,989 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO fractp.tif 93.6% complete 2023-11-22 10:07:02,005 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO fractp.tif 99.2% complete 2023-11-22 10:07:02,719 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(555) INFO 100.0% complete 2023-11-22 10:07:02,719 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(558) INFO Waiting for raster stats worker result. 2023-11-22 10:07:06,530 (natcap.invest.annual_water_yield) annual_water_yield.execute(765) INFO Performing wyield operation 2023-11-22 10:07:06,560 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(470) INFO starting stats_worker 2023-11-22 10:07:06,573 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(476) INFO started stats_worker 2023-11-22 10:07:11,575 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO wyield.tif 32.9% complete 2023-11-22 10:07:16,589 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO wyield.tif 57.8% complete 2023-11-22 10:07:21,599 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO wyield.tif 74.6% complete 2023-11-22 10:07:26,606 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO wyield.tif 87.6% complete 2023-11-22 10:07:30,998 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(555) INFO 100.0% complete 2023-11-22 10:07:30,998 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(558) INFO Waiting for raster stats worker result. 2023-11-22 10:07:41,850 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(470) INFO starting stats_worker 2023-11-22 10:07:41,851 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(476) INFO started stats_worker 2023-11-22 10:07:46,857 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO aet.tif 36.0% complete 2023-11-22 10:07:51,857 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO aet.tif 61.3% complete 2023-11-22 10:07:56,869 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO aet.tif 77.9% complete 2023-11-22 10:08:01,874 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO aet.tif 92.3% complete 2023-11-22 10:08:04,321 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(555) INFO 100.0% complete 2023-11-22 10:08:04,321 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(558) INFO Waiting for raster stats worker result. 2023-11-22 10:08:20,468 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3601) INFO Warp 35.0% complete C:\Users\fjyl\AppData\Local\Temp\tmp2ir6zl6l\clipped_raster.tif 2023-11-22 10:08:25,524 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3601) INFO Warp 68.0% complete C:\Users\fjyl\AppData\Local\Temp\tmp2ir6zl6l\clipped_raster.tif 2023-11-22 10:08:30,191 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3601) INFO Warp 100.0% complete C:\Users\fjyl\AppData\Local\Temp\tmp2ir6zl6l\clipped_raster.tif 2023-11-22 10:08:35,034 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(996) INFO 1 of 1 aligned: clipped_raster.tif 2023-11-22 10:08:35,034 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(1000) INFO aligned all 1 rasters. 2023-11-22 10:08:35,281 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1524) INFO build a lookup of aggregate field value to FID 2023-11-22 10:08:35,287 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1531) INFO creating disjoint polygon set 2023-11-22 10:08:35,288 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2554) INFO build shapely polygon list 2023-11-22 10:08:35,539 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2580) INFO build shapely rtree index 2023-11-22 10:08:35,557 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2593) INFO poly feature lookup 100.0% complete on watershed_results_wyield.shp 2023-11-22 10:08:35,557 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2597) INFO build poly intersection lookup 2023-11-22 10:08:35,596 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2623) INFO poly intersection feature lookup 100.0% complete on watershed_results_wyield.shp 2023-11-22 10:08:35,596 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2655) INFO maximal subset build 100.0% complete on watershed_results_wyield.shp 2023-11-22 10:08:35,628 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1551) INFO processing 4 disjoint polygon sets 2023-11-22 10:08:35,632 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1581) INFO disjoint polygon set 1 of 4 100.0% processed on watershed_results_wyield.shp 2023-11-22 10:08:36,095 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1589) INFO rasterizing disjoint polygon set 1 of 4 watershed_results_wyield.shp 2023-11-22 10:08:43,522 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1607) INFO summarizing rasterized disjoint polygon set 1 of 4 watershed_results_wyield.shp 2023-11-22 10:08:50,276 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1553) INFO zonal stats approximately 50.0% complete on watershed_results_wyield.shp 2023-11-22 10:08:50,287 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1581) INFO disjoint polygon set 2 of 4 100.0% processed on watershed_results_wyield.shp 2023-11-22 10:08:50,392 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1589) INFO rasterizing disjoint polygon set 2 of 4 watershed_results_wyield.shp 2023-11-22 10:08:58,882 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1607) INFO summarizing rasterized disjoint polygon set 2 of 4 watershed_results_wyield.shp 2023-11-22 10:09:06,799 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1553) INFO zonal stats approximately 75.0% complete on watershed_results_wyield.shp 2023-11-22 10:09:06,808 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1581) INFO disjoint polygon set 3 of 4 100.0% processed on watershed_results_wyield.shp 2023-11-22 10:09:06,908 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1589) INFO rasterizing disjoint polygon set 3 of 4 watershed_results_wyield.shp 2023-11-22 10:09:15,210 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1607) INFO summarizing rasterized disjoint polygon set 3 of 4 watershed_results_wyield.shp 2023-11-22 10:09:22,540 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1553) INFO zonal stats approximately 100.0% complete on watershed_results_wyield.shp 2023-11-22 10:09:22,557 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1581) INFO disjoint polygon set 4 of 4 100.0% processed on watershed_results_wyield.shp 2023-11-22 10:09:22,659 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1589) INFO rasterizing disjoint polygon set 4 of 4 watershed_results_wyield.shp 2023-11-22 10:09:31,845 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1607) INFO summarizing rasterized disjoint polygon set 4 of 4 watershed_results_wyield.shp 2023-11-22 10:09:41,816 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1756) INFO all done processing polygon sets for watershed_results_wyield.shp 2023-11-22 10:09:48,409 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3601) INFO Warp 29.0% complete C:\Users\fjyl\AppData\Local\Temp\tmpluk7n2om\clipped_raster.tif 2023-11-22 10:09:53,522 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3601) INFO Warp 55.0% complete C:\Users\fjyl\AppData\Local\Temp\tmpluk7n2om\clipped_raster.tif 2023-11-22 10:09:58,661 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3601) INFO Warp 82.0% complete C:\Users\fjyl\AppData\Local\Temp\tmpluk7n2om\clipped_raster.tif 2023-11-22 10:10:03,371 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3601) INFO Warp 100.0% complete C:\Users\fjyl\AppData\Local\Temp\tmpluk7n2om\clipped_raster.tif 2023-11-22 10:10:15,190 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(996) INFO 1 of 1 aligned: clipped_raster.tif 2023-11-22 10:10:15,190 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(1000) INFO aligned all 1 rasters. 2023-11-22 10:10:15,496 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1524) INFO build a lookup of aggregate field value to FID 2023-11-22 10:10:15,498 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1531) INFO creating disjoint polygon set 2023-11-22 10:10:15,500 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2554) INFO build shapely polygon list 2023-11-22 10:10:15,760 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2580) INFO build shapely rtree index 2023-11-22 10:10:15,777 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2593) INFO poly feature lookup 100.0% complete on watershed_results_wyield.shp 2023-11-22 10:10:15,777 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2597) INFO build poly intersection lookup 2023-11-22 10:10:15,813 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2623) INFO poly intersection feature lookup 100.0% complete on watershed_results_wyield.shp 2023-11-22 10:10:15,813 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2655) INFO maximal subset build 100.0% complete on watershed_results_wyield.shp 2023-11-22 10:10:15,842 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1551) INFO processing 4 disjoint polygon sets 2023-11-22 10:10:15,845 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1581) INFO disjoint polygon set 1 of 4 100.0% processed on watershed_results_wyield.shp 2023-11-22 10:10:16,690 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1589) INFO rasterizing disjoint polygon set 1 of 4 watershed_results_wyield.shp 2023-11-22 10:10:24,394 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1607) INFO summarizing rasterized disjoint polygon set 1 of 4 watershed_results_wyield.shp 2023-11-22 10:10:33,046 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1553) INFO zonal stats approximately 50.0% complete on watershed_results_wyield.shp 2023-11-22 10:10:33,057 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1581) INFO disjoint polygon set 2 of 4 100.0% processed on watershed_results_wyield.shp 2023-11-22 10:10:33,146 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1589) INFO rasterizing disjoint polygon set 2 of 4 watershed_results_wyield.shp 2023-11-22 10:10:41,444 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1607) INFO summarizing rasterized disjoint polygon set 2 of 4 watershed_results_wyield.shp 2023-11-22 10:10:49,395 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1553) INFO zonal stats approximately 75.0% complete on watershed_results_wyield.shp 2023-11-22 10:10:49,397 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1581) INFO disjoint polygon set 3 of 4 100.0% processed on watershed_results_wyield.shp 2023-11-22 10:10:49,525 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1589) INFO rasterizing disjoint polygon set 3 of 4 watershed_results_wyield.shp 2023-11-22 10:10:57,379 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1607) INFO summarizing rasterized disjoint polygon set 3 of 4 watershed_results_wyield.shp 2023-11-22 10:11:04,914 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1553) INFO zonal stats approximately 100.0% complete on watershed_results_wyield.shp 2023-11-22 10:11:04,916 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1581) INFO disjoint polygon set 4 of 4 100.0% processed on watershed_results_wyield.shp 2023-11-22 10:11:05,016 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1589) INFO rasterizing disjoint polygon set 4 of 4 watershed_results_wyield.shp 2023-11-22 10:11:13,363 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1607) INFO summarizing rasterized disjoint polygon set 4 of 4 watershed_results_wyield.shp 2023-11-22 10:11:23,964 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1756) INFO all done processing polygon sets for watershed_results_wyield.shp 2023-11-22 10:11:30,130 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3601) INFO Warp 27.0% complete C:\Users\fjyl\AppData\Local\Temp\tmpxxxokmkt\clipped_raster.tif 2023-11-22 10:11:35,411 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3601) INFO Warp 54.0% complete C:\Users\fjyl\AppData\Local\Temp\tmpxxxokmkt\clipped_raster.tif 2023-11-22 10:11:40,463 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3601) INFO Warp 79.0% complete C:\Users\fjyl\AppData\Local\Temp\tmpxxxokmkt\clipped_raster.tif 2023-11-22 10:11:45,477 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3601) INFO Warp 98.0% complete C:\Users\fjyl\AppData\Local\Temp\tmpxxxokmkt\clipped_raster.tif 2023-11-22 10:11:45,864 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3601) INFO Warp 100.0% complete C:\Users\fjyl\AppData\Local\Temp\tmpxxxokmkt\clipped_raster.tif 2023-11-22 10:11:58,456 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(996) INFO 1 of 1 aligned: clipped_raster.tif 2023-11-22 10:11:58,456 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(1000) INFO aligned all 1 rasters. 2023-11-22 10:11:58,707 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1524) INFO build a lookup of aggregate field value to FID 2023-11-22 10:11:58,721 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1531) INFO creating disjoint polygon set 2023-11-22 10:11:58,723 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2554) INFO build shapely polygon list 2023-11-22 10:11:58,980 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2580) INFO build shapely rtree index 2023-11-22 10:11:58,989 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2593) INFO poly feature lookup 100.0% complete on watershed_results_wyield.shp 2023-11-22 10:11:58,989 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2597) INFO build poly intersection lookup 2023-11-22 10:11:59,034 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2623) INFO poly intersection feature lookup 100.0% complete on watershed_results_wyield.shp 2023-11-22 10:11:59,034 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2655) INFO maximal subset build 100.0% complete on watershed_results_wyield.shp 2023-11-22 10:11:59,052 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1551) INFO processing 4 disjoint polygon sets 2023-11-22 10:11:59,061 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1581) INFO disjoint polygon set 1 of 4 100.0% processed on watershed_results_wyield.shp 2023-11-22 10:11:59,522 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1589) INFO rasterizing disjoint polygon set 1 of 4 watershed_results_wyield.shp 2023-11-22 10:12:07,329 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1607) INFO summarizing rasterized disjoint polygon set 1 of 4 watershed_results_wyield.shp 2023-11-22 10:12:16,263 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1553) INFO zonal stats approximately 50.0% complete on watershed_results_wyield.shp 2023-11-22 10:12:16,280 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1581) INFO disjoint polygon set 2 of 4 100.0% processed on watershed_results_wyield.shp 2023-11-22 10:12:16,380 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1589) INFO rasterizing disjoint polygon set 2 of 4 watershed_results_wyield.shp 2023-11-22 10:12:24,399 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1607) INFO summarizing rasterized disjoint polygon set 2 of 4 watershed_results_wyield.shp 2023-11-22 10:12:32,553 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1553) INFO zonal stats approximately 75.0% complete on watershed_results_wyield.shp 2023-11-22 10:12:32,566 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1581) INFO disjoint polygon set 3 of 4 100.0% processed on watershed_results_wyield.shp 2023-11-22 10:12:32,682 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1589) INFO rasterizing disjoint polygon set 3 of 4 watershed_results_wyield.shp 2023-11-22 10:12:40,549 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1607) INFO summarizing rasterized disjoint polygon set 3 of 4 watershed_results_wyield.shp 2023-11-22 10:12:49,526 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1553) INFO zonal stats approximately 100.0% complete on watershed_results_wyield.shp 2023-11-22 10:12:49,532 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1581) INFO disjoint polygon set 4 of 4 100.0% processed on watershed_results_wyield.shp 2023-11-22 10:12:49,632 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1589) INFO rasterizing disjoint polygon set 4 of 4 watershed_results_wyield.shp 2023-11-22 10:12:58,726 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1607) INFO summarizing rasterized disjoint polygon set 4 of 4 watershed_results_wyield.shp 2023-11-22 10:13:09,980 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1756) INFO all done processing polygon sets for watershed_results_wyield.shp 2023-11-22 10:13:16,264 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3601) INFO Warp 27.0% complete C:\Users\fjyl\AppData\Local\Temp\tmpx5bgj5wp\clipped_raster.tif 2023-11-22 10:13:21,265 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3601) INFO Warp 52.0% complete C:\Users\fjyl\AppData\Local\Temp\tmpx5bgj5wp\clipped_raster.tif 2023-11-22 10:13:26,477 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3601) INFO Warp 77.0% complete C:\Users\fjyl\AppData\Local\Temp\tmpx5bgj5wp\clipped_raster.tif 2023-11-22 10:13:31,916 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3601) INFO Warp 97.0% complete C:\Users\fjyl\AppData\Local\Temp\tmpx5bgj5wp\clipped_raster.tif 2023-11-22 10:13:32,366 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3601) INFO Warp 100.0% complete C:\Users\fjyl\AppData\Local\Temp\tmpx5bgj5wp\clipped_raster.tif 2023-11-22 10:13:45,815 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(996) INFO 1 of 1 aligned: clipped_raster.tif 2023-11-22 10:13:45,815 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(1000) INFO aligned all 1 rasters. 2023-11-22 10:13:46,082 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1524) INFO build a lookup of aggregate field value to FID 2023-11-22 10:13:46,094 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1531) INFO creating disjoint polygon set 2023-11-22 10:13:46,095 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2554) INFO build shapely polygon list 2023-11-22 10:13:46,365 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2580) INFO build shapely rtree index 2023-11-22 10:13:46,375 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2593) INFO poly feature lookup 100.0% complete on watershed_results_wyield.shp 2023-11-22 10:13:46,376 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2597) INFO build poly intersection lookup 2023-11-22 10:13:46,415 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2623) INFO poly intersection feature lookup 100.0% complete on watershed_results_wyield.shp 2023-11-22 10:13:46,419 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2655) INFO maximal subset build 100.0% complete on watershed_results_wyield.shp 2023-11-22 10:13:46,454 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1551) INFO processing 4 disjoint polygon sets 2023-11-22 10:13:46,460 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1581) INFO disjoint polygon set 1 of 4 100.0% processed on watershed_results_wyield.shp 2023-11-22 10:13:46,916 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1589) INFO rasterizing disjoint polygon set 1 of 4 watershed_results_wyield.shp 2023-11-22 10:13:54,849 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1607) INFO summarizing rasterized disjoint polygon set 1 of 4 watershed_results_wyield.shp 2023-11-22 10:14:04,506 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1553) INFO zonal stats approximately 50.0% complete on watershed_results_wyield.shp 2023-11-22 10:14:04,519 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1581) INFO disjoint polygon set 2 of 4 100.0% processed on watershed_results_wyield.shp 2023-11-22 10:14:04,634 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1589) INFO rasterizing disjoint polygon set 2 of 4 watershed_results_wyield.shp 2023-11-22 10:14:12,614 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1607) INFO summarizing rasterized disjoint polygon set 2 of 4 watershed_results_wyield.shp 2023-11-22 10:14:21,307 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1553) INFO zonal stats approximately 75.0% complete on watershed_results_wyield.shp 2023-11-22 10:14:21,314 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1581) INFO disjoint polygon set 3 of 4 100.0% processed on watershed_results_wyield.shp 2023-11-22 10:14:21,434 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1589) INFO rasterizing disjoint polygon set 3 of 4 watershed_results_wyield.shp 2023-11-22 10:14:29,602 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1607) INFO summarizing rasterized disjoint polygon set 3 of 4 watershed_results_wyield.shp 2023-11-22 10:14:38,967 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1553) INFO zonal stats approximately 100.0% complete on watershed_results_wyield.shp 2023-11-22 10:14:38,977 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1581) INFO disjoint polygon set 4 of 4 100.0% processed on watershed_results_wyield.shp 2023-11-22 10:14:39,101 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1589) INFO rasterizing disjoint polygon set 4 of 4 watershed_results_wyield.shp 2023-11-22 10:14:48,150 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1607) INFO summarizing rasterized disjoint polygon set 4 of 4 watershed_results_wyield.shp 2023-11-22 10:15:00,806 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1756) INFO all done processing polygon sets for watershed_results_wyield.shp 2023-11-22 10:15:03,400 (natcap.invest.utils) utils.prepare_workspace(169) INFO Elapsed time: 13m 21.799999999999955s 2023-11-22 10:15:03,400 (natcap.invest.utils) utils.prepare_workspace(172) INFO Execution finished