2023-11-28 21:47:14,836 (natcap.invest.utils) utils.prepare_workspace(161) Level 100 Writing log messages to [D:\NEW-INvest shuju\water yield\resultZ22.5\InVEST-natcap.invest.annual_water_yield-log-2023-11-28--21_47_14.txt] 2023-11-28 21:47:14,839 (__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 22.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\resultZ22.5 2023-11-28 21:47:20,364 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3601) INFO Warp 51.0% complete D:\NEW-INvest shuju\water yield\resultZ22.5\intermediate\eto.tif 2023-11-28 21:47:25,382 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3601) INFO Warp 100.0% complete D:\NEW-INvest shuju\water yield\resultZ22.5\intermediate\eto.tif 2023-11-28 21:47:36,810 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(996) INFO 1 of 5 aligned: eto.tif 2023-11-28 21:47:41,846 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3601) INFO Warp 49.0% complete D:\NEW-INvest shuju\water yield\resultZ22.5\intermediate\precip.tif 2023-11-28 21:47:46,863 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3601) INFO Warp 95.0% complete D:\NEW-INvest shuju\water yield\resultZ22.5\intermediate\precip.tif 2023-11-28 21:47:47,200 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3601) INFO Warp 100.0% complete D:\NEW-INvest shuju\water yield\resultZ22.5\intermediate\precip.tif 2023-11-28 21:47:52,009 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(996) INFO 2 of 5 aligned: precip.tif 2023-11-28 21:47:57,034 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3601) INFO Warp 50.0% complete D:\NEW-INvest shuju\water yield\resultZ22.5\intermediate\depth_to_root_rest_layer.tif 2023-11-28 21:48:02,086 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3601) INFO Warp 97.0% complete D:\NEW-INvest shuju\water yield\resultZ22.5\intermediate\depth_to_root_rest_layer.tif 2023-11-28 21:48:02,295 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3601) INFO Warp 100.0% complete D:\NEW-INvest shuju\water yield\resultZ22.5\intermediate\depth_to_root_rest_layer.tif 2023-11-28 21:48:06,111 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(996) INFO 3 of 5 aligned: depth_to_root_rest_layer.tif 2023-11-28 21:48:11,193 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3601) INFO Warp 49.0% complete D:\NEW-INvest shuju\water yield\resultZ22.5\intermediate\pawc.tif 2023-11-28 21:48:16,253 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3601) INFO Warp 95.0% complete D:\NEW-INvest shuju\water yield\resultZ22.5\intermediate\pawc.tif 2023-11-28 21:48:16,629 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3601) INFO Warp 100.0% complete D:\NEW-INvest shuju\water yield\resultZ22.5\intermediate\pawc.tif 2023-11-28 21:48:20,271 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(996) INFO 4 of 5 aligned: pawc.tif 2023-11-28 21:48:25,342 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3601) INFO Warp 37.0% complete D:\NEW-INvest shuju\water yield\resultZ22.5\intermediate\clipped_lulc.tif 2023-11-28 21:48:30,374 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3601) INFO Warp 72.0% complete D:\NEW-INvest shuju\water yield\resultZ22.5\intermediate\clipped_lulc.tif 2023-11-28 21:48:33,982 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3601) INFO Warp 100.0% complete D:\NEW-INvest shuju\water yield\resultZ22.5\intermediate\clipped_lulc.tif 2023-11-28 21:48:36,881 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(996) INFO 5 of 5 aligned: clipped_lulc.tif 2023-11-28 21:48:36,881 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(1000) INFO aligned all 5 rasters. 2023-11-28 21:48:36,950 (natcap.invest.annual_water_yield) annual_water_yield.execute(695) INFO Reclassifying temp_Kc raster 2023-11-28 21:48:36,987 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(470) INFO starting stats_worker 2023-11-28 21:48:36,989 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(476) INFO started stats_worker 2023-11-28 21:48:41,981 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO kc_raster.tif 31.9% complete 2023-11-28 21:48:46,985 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO kc_raster.tif 53.5% complete 2023-11-28 21:48:51,992 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO kc_raster.tif 73.3% complete 2023-11-28 21:48:56,994 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO kc_raster.tif 95.3% complete 2023-11-28 21:48:57,750 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(555) INFO 100.0% complete 2023-11-28 21:48:57,750 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(558) INFO Waiting for raster stats worker result. 2023-11-28 21:49:06,356 (natcap.invest.annual_water_yield) annual_water_yield.execute(707) INFO Reclassifying tmp_root raster 2023-11-28 21:49:06,388 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(470) INFO starting stats_worker 2023-11-28 21:49:06,389 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(476) INFO started stats_worker 2023-11-28 21:49:11,386 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO root_depth.tif 31.3% complete 2023-11-28 21:49:16,387 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO root_depth.tif 53.1% complete 2023-11-28 21:49:21,392 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO root_depth.tif 73.0% complete 2023-11-28 21:49:26,396 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO root_depth.tif 97.7% complete 2023-11-28 21:49:26,712 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(555) INFO 100.0% complete 2023-11-28 21:49:26,712 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(558) INFO Waiting for raster stats worker result. 2023-11-28 21:49:34,350 (natcap.invest.annual_water_yield) annual_water_yield.execute(721) INFO Reclassifying tmp_veg raster 2023-11-28 21:49:34,380 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(470) INFO starting stats_worker 2023-11-28 21:49:34,381 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(476) INFO started stats_worker 2023-11-28 21:49:39,384 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO veg.tif 31.7% complete 2023-11-28 21:49:44,388 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO veg.tif 53.2% complete 2023-11-28 21:49:49,392 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO veg.tif 73.1% complete 2023-11-28 21:49:54,392 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO veg.tif 95.6% complete 2023-11-28 21:49:55,057 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(555) INFO 100.0% complete 2023-11-28 21:49:55,058 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(558) INFO Waiting for raster stats worker result. 2023-11-28 21:50:02,420 (natcap.invest.annual_water_yield) annual_water_yield.execute(734) INFO Calculate PET from Ref Evap times Kc 2023-11-28 21:50:02,454 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(470) INFO starting stats_worker 2023-11-28 21:50:02,458 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(476) INFO started stats_worker 2023-11-28 21:50:07,452 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO pet.tif 28.1% complete 2023-11-28 21:50:12,453 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO pet.tif 48.9% complete 2023-11-28 21:50:17,459 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO pet.tif 64.7% complete 2023-11-28 21:50:22,465 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO pet.tif 78.0% complete 2023-11-28 21:50:27,477 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO pet.tif 91.6% complete 2023-11-28 21:50:30,598 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(555) INFO 100.0% complete 2023-11-28 21:50:30,598 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(558) INFO Waiting for raster stats worker result. 2023-11-28 21:50:38,341 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(470) INFO starting stats_worker 2023-11-28 21:50:38,346 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(476) INFO started stats_worker 2023-11-28 21:50:43,353 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO fractp.tif 10.5% complete 2023-11-28 21:50:48,353 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO fractp.tif 17.0% complete 2023-11-28 21:50:53,378 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO fractp.tif 22.1% complete 2023-11-28 21:50:58,383 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO fractp.tif 26.3% complete 2023-11-28 21:51:03,408 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO fractp.tif 30.3% complete 2023-11-28 21:51:08,428 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO fractp.tif 33.9% complete 2023-11-28 21:51:13,441 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO fractp.tif 37.8% complete 2023-11-28 21:51:18,449 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO fractp.tif 41.4% complete 2023-11-28 21:51:23,457 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO fractp.tif 44.7% complete 2023-11-28 21:51:28,465 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO fractp.tif 48.0% complete 2023-11-28 21:51:33,509 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO fractp.tif 51.4% complete 2023-11-28 21:51:38,527 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO fractp.tif 55.0% complete 2023-11-28 21:51:43,549 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO fractp.tif 58.6% complete 2023-11-28 21:51:48,552 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO fractp.tif 62.1% complete 2023-11-28 21:51:53,563 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO fractp.tif 65.7% complete 2023-11-28 21:51:58,593 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO fractp.tif 69.3% complete 2023-11-28 21:52:03,638 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO fractp.tif 72.8% complete 2023-11-28 21:52:08,644 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO fractp.tif 76.5% complete 2023-11-28 21:52:13,673 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO fractp.tif 80.1% complete 2023-11-28 21:52:18,705 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO fractp.tif 84.1% complete 2023-11-28 21:52:23,709 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO fractp.tif 88.3% complete 2023-11-28 21:52:28,730 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO fractp.tif 93.4% complete 2023-11-28 21:52:33,733 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO fractp.tif 99.0% complete 2023-11-28 21:52:34,658 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(555) INFO 100.0% complete 2023-11-28 21:52:34,659 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(558) INFO Waiting for raster stats worker result. 2023-11-28 21:52:38,559 (natcap.invest.annual_water_yield) annual_water_yield.execute(765) INFO Performing wyield operation 2023-11-28 21:52:38,592 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(470) INFO starting stats_worker 2023-11-28 21:52:38,596 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(476) INFO started stats_worker 2023-11-28 21:52:43,596 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO wyield.tif 32.8% complete 2023-11-28 21:52:48,602 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO wyield.tif 57.3% complete 2023-11-28 21:52:53,605 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO wyield.tif 74.2% complete 2023-11-28 21:52:58,611 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO wyield.tif 87.1% complete 2023-11-28 21:53:03,369 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(555) INFO 100.0% complete 2023-11-28 21:53:03,369 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(558) INFO Waiting for raster stats worker result. 2023-11-28 21:53:14,350 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(470) INFO starting stats_worker 2023-11-28 21:53:14,352 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(476) INFO started stats_worker 2023-11-28 21:53:19,351 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO aet.tif 35.8% complete 2023-11-28 21:53:24,354 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO aet.tif 61.6% complete 2023-11-28 21:53:29,359 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO aet.tif 78.8% complete 2023-11-28 21:53:34,369 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(550) INFO aet.tif 93.7% complete 2023-11-28 21:53:36,362 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(555) INFO 100.0% complete 2023-11-28 21:53:36,362 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(558) INFO Waiting for raster stats worker result. 2023-11-28 21:53:52,640 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3601) INFO Warp 33.0% complete C:\Users\fjyl\AppData\Local\Temp\tmprxtax11u\clipped_raster.tif 2023-11-28 21:53:57,655 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3601) INFO Warp 64.0% complete C:\Users\fjyl\AppData\Local\Temp\tmprxtax11u\clipped_raster.tif 2023-11-28 21:54:02,751 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3601) INFO Warp 97.0% complete C:\Users\fjyl\AppData\Local\Temp\tmprxtax11u\clipped_raster.tif 2023-11-28 21:54:03,041 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3601) INFO Warp 100.0% complete C:\Users\fjyl\AppData\Local\Temp\tmprxtax11u\clipped_raster.tif 2023-11-28 21:54:08,161 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(996) INFO 1 of 1 aligned: clipped_raster.tif 2023-11-28 21:54:08,161 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(1000) INFO aligned all 1 rasters. 2023-11-28 21:54:08,417 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1524) INFO build a lookup of aggregate field value to FID 2023-11-28 21:54:08,419 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1531) INFO creating disjoint polygon set 2023-11-28 21:54:08,420 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2554) INFO build shapely polygon list 2023-11-28 21:54:08,684 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2580) INFO build shapely rtree index 2023-11-28 21:54:08,690 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2593) INFO poly feature lookup 100.0% complete on watershed_results_wyield.shp 2023-11-28 21:54:08,690 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2597) INFO build poly intersection lookup 2023-11-28 21:54:08,725 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2623) INFO poly intersection feature lookup 100.0% complete on watershed_results_wyield.shp 2023-11-28 21:54:08,725 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2655) INFO maximal subset build 100.0% complete on watershed_results_wyield.shp 2023-11-28 21:54:08,755 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1551) INFO processing 4 disjoint polygon sets 2023-11-28 21:54:08,761 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1581) INFO disjoint polygon set 1 of 4 100.0% processed on watershed_results_wyield.shp 2023-11-28 21:54:09,249 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1589) INFO rasterizing disjoint polygon set 1 of 4 watershed_results_wyield.shp 2023-11-28 21:54:17,115 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1607) INFO summarizing rasterized disjoint polygon set 1 of 4 watershed_results_wyield.shp 2023-11-28 21:54:24,164 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1553) INFO zonal stats approximately 50.0% complete on watershed_results_wyield.shp 2023-11-28 21:54:24,165 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1581) INFO disjoint polygon set 2 of 4 100.0% processed on watershed_results_wyield.shp 2023-11-28 21:54:24,291 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1589) INFO rasterizing disjoint polygon set 2 of 4 watershed_results_wyield.shp 2023-11-28 21:54:32,999 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1607) INFO summarizing rasterized disjoint polygon set 2 of 4 watershed_results_wyield.shp 2023-11-28 21:54:40,848 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1553) INFO zonal stats approximately 75.0% complete on watershed_results_wyield.shp 2023-11-28 21:54:40,853 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1581) INFO disjoint polygon set 3 of 4 100.0% processed on watershed_results_wyield.shp 2023-11-28 21:54:40,973 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1589) INFO rasterizing disjoint polygon set 3 of 4 watershed_results_wyield.shp 2023-11-28 21:54:49,220 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1607) INFO summarizing rasterized disjoint polygon set 3 of 4 watershed_results_wyield.shp 2023-11-28 21:54:56,284 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1553) INFO zonal stats approximately 100.0% complete on watershed_results_wyield.shp 2023-11-28 21:54:56,288 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1581) INFO disjoint polygon set 4 of 4 100.0% processed on watershed_results_wyield.shp 2023-11-28 21:54:56,413 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1589) INFO rasterizing disjoint polygon set 4 of 4 watershed_results_wyield.shp 2023-11-28 21:55:05,558 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1607) INFO summarizing rasterized disjoint polygon set 4 of 4 watershed_results_wyield.shp 2023-11-28 21:55:15,583 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1756) INFO all done processing polygon sets for watershed_results_wyield.shp 2023-11-28 21:55:22,028 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3601) INFO Warp 27.0% complete C:\Users\fjyl\AppData\Local\Temp\tmpdz_6qqqn\clipped_raster.tif 2023-11-28 21:55:27,158 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3601) INFO Warp 54.0% complete C:\Users\fjyl\AppData\Local\Temp\tmpdz_6qqqn\clipped_raster.tif 2023-11-28 21:55:32,369 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3601) INFO Warp 80.0% complete C:\Users\fjyl\AppData\Local\Temp\tmpdz_6qqqn\clipped_raster.tif 2023-11-28 21:55:37,350 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3601) INFO Warp 100.0% complete C:\Users\fjyl\AppData\Local\Temp\tmpdz_6qqqn\clipped_raster.tif 2023-11-28 21:55:48,915 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(996) INFO 1 of 1 aligned: clipped_raster.tif 2023-11-28 21:55:48,915 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(1000) INFO aligned all 1 rasters. 2023-11-28 21:55:49,189 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1524) INFO build a lookup of aggregate field value to FID 2023-11-28 21:55:49,192 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1531) INFO creating disjoint polygon set 2023-11-28 21:55:49,193 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2554) INFO build shapely polygon list 2023-11-28 21:55:49,468 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2580) INFO build shapely rtree index 2023-11-28 21:55:49,471 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2593) INFO poly feature lookup 100.0% complete on watershed_results_wyield.shp 2023-11-28 21:55:49,471 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2597) INFO build poly intersection lookup 2023-11-28 21:55:49,518 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2623) INFO poly intersection feature lookup 100.0% complete on watershed_results_wyield.shp 2023-11-28 21:55:49,519 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2655) INFO maximal subset build 100.0% complete on watershed_results_wyield.shp 2023-11-28 21:55:49,542 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1551) INFO processing 4 disjoint polygon sets 2023-11-28 21:55:49,543 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1581) INFO disjoint polygon set 1 of 4 100.0% processed on watershed_results_wyield.shp 2023-11-28 21:55:50,429 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1589) INFO rasterizing disjoint polygon set 1 of 4 watershed_results_wyield.shp 2023-11-28 21:55:58,238 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1607) INFO summarizing rasterized disjoint polygon set 1 of 4 watershed_results_wyield.shp 2023-11-28 21:56:06,944 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1553) INFO zonal stats approximately 50.0% complete on watershed_results_wyield.shp 2023-11-28 21:56:06,948 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1581) INFO disjoint polygon set 2 of 4 100.0% processed on watershed_results_wyield.shp 2023-11-28 21:56:07,085 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1589) INFO rasterizing disjoint polygon set 2 of 4 watershed_results_wyield.shp 2023-11-28 21:56:15,335 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1607) INFO summarizing rasterized disjoint polygon set 2 of 4 watershed_results_wyield.shp 2023-11-28 21:56:23,153 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1553) INFO zonal stats approximately 75.0% complete on watershed_results_wyield.shp 2023-11-28 21:56:23,155 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1581) INFO disjoint polygon set 3 of 4 100.0% processed on watershed_results_wyield.shp 2023-11-28 21:56:23,265 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1589) INFO rasterizing disjoint polygon set 3 of 4 watershed_results_wyield.shp 2023-11-28 21:56:30,996 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1607) INFO summarizing rasterized disjoint polygon set 3 of 4 watershed_results_wyield.shp 2023-11-28 21:56:38,412 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1553) INFO zonal stats approximately 100.0% complete on watershed_results_wyield.shp 2023-11-28 21:56:38,416 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1581) INFO disjoint polygon set 4 of 4 100.0% processed on watershed_results_wyield.shp 2023-11-28 21:56:38,545 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1589) INFO rasterizing disjoint polygon set 4 of 4 watershed_results_wyield.shp 2023-11-28 21:56:47,442 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1607) INFO summarizing rasterized disjoint polygon set 4 of 4 watershed_results_wyield.shp 2023-11-28 21:56:57,271 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1756) INFO all done processing polygon sets for watershed_results_wyield.shp 2023-11-28 21:57:03,376 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3601) INFO Warp 28.0% complete C:\Users\fjyl\AppData\Local\Temp\tmpsds9blb1\clipped_raster.tif 2023-11-28 21:57:08,440 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3601) INFO Warp 54.0% complete C:\Users\fjyl\AppData\Local\Temp\tmpsds9blb1\clipped_raster.tif 2023-11-28 21:57:13,448 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3601) INFO Warp 79.0% complete C:\Users\fjyl\AppData\Local\Temp\tmpsds9blb1\clipped_raster.tif 2023-11-28 21:57:18,573 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3601) INFO Warp 97.0% complete C:\Users\fjyl\AppData\Local\Temp\tmpsds9blb1\clipped_raster.tif 2023-11-28 21:57:19,071 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3601) INFO Warp 100.0% complete C:\Users\fjyl\AppData\Local\Temp\tmpsds9blb1\clipped_raster.tif 2023-11-28 21:57:31,891 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(996) INFO 1 of 1 aligned: clipped_raster.tif 2023-11-28 21:57:31,891 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(1000) INFO aligned all 1 rasters. 2023-11-28 21:57:32,202 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1524) INFO build a lookup of aggregate field value to FID 2023-11-28 21:57:32,204 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1531) INFO creating disjoint polygon set 2023-11-28 21:57:32,205 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2554) INFO build shapely polygon list 2023-11-28 21:57:32,482 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2580) INFO build shapely rtree index 2023-11-28 21:57:32,485 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2593) INFO poly feature lookup 100.0% complete on watershed_results_wyield.shp 2023-11-28 21:57:32,485 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2597) INFO build poly intersection lookup 2023-11-28 21:57:32,524 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2623) INFO poly intersection feature lookup 100.0% complete on watershed_results_wyield.shp 2023-11-28 21:57:32,524 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2655) INFO maximal subset build 100.0% complete on watershed_results_wyield.shp 2023-11-28 21:57:32,556 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1551) INFO processing 4 disjoint polygon sets 2023-11-28 21:57:32,558 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1581) INFO disjoint polygon set 1 of 4 100.0% processed on watershed_results_wyield.shp 2023-11-28 21:57:32,987 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1589) INFO rasterizing disjoint polygon set 1 of 4 watershed_results_wyield.shp 2023-11-28 21:57:40,855 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1607) INFO summarizing rasterized disjoint polygon set 1 of 4 watershed_results_wyield.shp 2023-11-28 21:57:49,302 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1553) INFO zonal stats approximately 50.0% complete on watershed_results_wyield.shp 2023-11-28 21:57:49,303 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1581) INFO disjoint polygon set 2 of 4 100.0% processed on watershed_results_wyield.shp 2023-11-28 21:57:49,443 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1589) INFO rasterizing disjoint polygon set 2 of 4 watershed_results_wyield.shp 2023-11-28 21:57:57,318 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1607) INFO summarizing rasterized disjoint polygon set 2 of 4 watershed_results_wyield.shp 2023-11-28 21:58:05,148 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1553) INFO zonal stats approximately 75.0% complete on watershed_results_wyield.shp 2023-11-28 21:58:05,149 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1581) INFO disjoint polygon set 3 of 4 100.0% processed on watershed_results_wyield.shp 2023-11-28 21:58:05,294 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1589) INFO rasterizing disjoint polygon set 3 of 4 watershed_results_wyield.shp 2023-11-28 21:58:13,111 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1607) INFO summarizing rasterized disjoint polygon set 3 of 4 watershed_results_wyield.shp 2023-11-28 21:58:21,985 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1553) INFO zonal stats approximately 100.0% complete on watershed_results_wyield.shp 2023-11-28 21:58:21,987 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1581) INFO disjoint polygon set 4 of 4 100.0% processed on watershed_results_wyield.shp 2023-11-28 21:58:22,095 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1589) INFO rasterizing disjoint polygon set 4 of 4 watershed_results_wyield.shp 2023-11-28 21:58:30,685 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1607) INFO summarizing rasterized disjoint polygon set 4 of 4 watershed_results_wyield.shp 2023-11-28 21:58:42,071 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1756) INFO all done processing polygon sets for watershed_results_wyield.shp 2023-11-28 21:58:48,193 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3601) INFO Warp 27.0% complete C:\Users\fjyl\AppData\Local\Temp\tmpxcavcplo\clipped_raster.tif 2023-11-28 21:58:53,333 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3601) INFO Warp 52.0% complete C:\Users\fjyl\AppData\Local\Temp\tmpxcavcplo\clipped_raster.tif 2023-11-28 21:58:58,388 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3601) INFO Warp 77.0% complete C:\Users\fjyl\AppData\Local\Temp\tmpxcavcplo\clipped_raster.tif 2023-11-28 21:59:03,584 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3601) INFO Warp 96.0% complete C:\Users\fjyl\AppData\Local\Temp\tmpxcavcplo\clipped_raster.tif 2023-11-28 21:59:04,565 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3601) INFO Warp 100.0% complete C:\Users\fjyl\AppData\Local\Temp\tmpxcavcplo\clipped_raster.tif 2023-11-28 21:59:18,161 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(996) INFO 1 of 1 aligned: clipped_raster.tif 2023-11-28 21:59:18,161 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(1000) INFO aligned all 1 rasters. 2023-11-28 21:59:18,426 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1524) INFO build a lookup of aggregate field value to FID 2023-11-28 21:59:18,429 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1531) INFO creating disjoint polygon set 2023-11-28 21:59:18,431 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2554) INFO build shapely polygon list 2023-11-28 21:59:18,708 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2580) INFO build shapely rtree index 2023-11-28 21:59:18,710 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2593) INFO poly feature lookup 100.0% complete on watershed_results_wyield.shp 2023-11-28 21:59:18,711 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2597) INFO build poly intersection lookup 2023-11-28 21:59:18,746 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2623) INFO poly intersection feature lookup 100.0% complete on watershed_results_wyield.shp 2023-11-28 21:59:18,746 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2655) INFO maximal subset build 100.0% complete on watershed_results_wyield.shp 2023-11-28 21:59:18,771 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1551) INFO processing 4 disjoint polygon sets 2023-11-28 21:59:18,774 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1581) INFO disjoint polygon set 1 of 4 100.0% processed on watershed_results_wyield.shp 2023-11-28 21:59:19,241 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1589) INFO rasterizing disjoint polygon set 1 of 4 watershed_results_wyield.shp 2023-11-28 21:59:27,546 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1607) INFO summarizing rasterized disjoint polygon set 1 of 4 watershed_results_wyield.shp 2023-11-28 21:59:38,633 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1553) INFO zonal stats approximately 50.0% complete on watershed_results_wyield.shp 2023-11-28 21:59:38,638 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1581) INFO disjoint polygon set 2 of 4 100.0% processed on watershed_results_wyield.shp 2023-11-28 21:59:38,746 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1589) INFO rasterizing disjoint polygon set 2 of 4 watershed_results_wyield.shp 2023-11-28 21:59:47,248 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1607) INFO summarizing rasterized disjoint polygon set 2 of 4 watershed_results_wyield.shp 2023-11-28 21:59:57,161 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1553) INFO zonal stats approximately 75.0% complete on watershed_results_wyield.shp 2023-11-28 21:59:57,163 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1581) INFO disjoint polygon set 3 of 4 100.0% processed on watershed_results_wyield.shp 2023-11-28 21:59:57,297 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1589) INFO rasterizing disjoint polygon set 3 of 4 watershed_results_wyield.shp 2023-11-28 22:00:05,449 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1607) INFO summarizing rasterized disjoint polygon set 3 of 4 watershed_results_wyield.shp 2023-11-28 22:00:15,613 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1553) INFO zonal stats approximately 100.0% complete on watershed_results_wyield.shp 2023-11-28 22:00:15,618 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1581) INFO disjoint polygon set 4 of 4 100.0% processed on watershed_results_wyield.shp 2023-11-28 22:00:15,739 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1589) INFO rasterizing disjoint polygon set 4 of 4 watershed_results_wyield.shp 2023-11-28 22:00:24,517 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1607) INFO summarizing rasterized disjoint polygon set 4 of 4 watershed_results_wyield.shp 2023-11-28 22:00:37,470 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1756) INFO all done processing polygon sets for watershed_results_wyield.shp 2023-11-28 22:00:40,175 (natcap.invest.utils) utils.prepare_workspace(169) INFO Elapsed time: 13m 25.340000000000032s 2023-11-28 22:00:40,175 (natcap.invest.utils) utils.prepare_workspace(172) INFO Execution finished