2021-10-21 11:06:56,632 (natcap.invest.utils) utils.prepare_workspace(158) INFO Writing log messages to ...qf_clipped/WP_18\InVEST-Seasonal-Water-Yield-log-2021-10-21--11_06_56.txt 2021-10-21 11:06:56,648 (natcap.invest.ui.model) model._logged_target(1644) Level 100 Starting model with parameters: Arguments for InVEST natcap.invest.seasonal_water_yield.seasonal_water_yield 3.9.1.post464+gb05dea2e: alpha_m 1/12 aoi_path .../AreaOfIntered_Catchment_Watershed/AOI_alpine_region_UIC_3035_ws_id0.shp beta_i 0 biophysical_table_path .../BiophysicalTable/BioPhysTable_use_no_names_Kc_0_01.csv climate_zone_raster_path .../ClimateZone_spec_RE/Beck_KG_V1_present_0p0083_clipped_3035.tif climate_zone_table_path .../ClimateZone_spec_RE/ClimZone_RainEvents_Beck_float_pt_SWY.csv dem_raster_path .../DEM/Filled_XXL_DEM_UIC_buffered_alpine_region_3035.tif et0_dir .../Evapotranspiration gamma 0 lulc_raster_path .../LULC/clc_2018_buffered_aoi_UIC.tif monthly_alpha True monthly_alpha_path .../MonthlyAlphaTable_RE/MonthlyAlphaTable.csv n_workers -1 precip_dir .../Precipitation rain_events_table_path .../RainEvents/RainEvents_2018_with_GPKG.csv results_suffix _2018_18 soil_group_path .../SoilGroup/soil_groups_buffered_study_area_3_4_epsg3035_2.tif threshold_flow_accumulation 1000 user_defined_climate_zones True user_defined_local_recharge False workspace_dir ...qf_clipped/WP_18 2021-10-21 11:06:56,664 (natcap.invest.seasonal_water_yield.seasonal_water_yield) seasonal_water_yield._execute(401) INFO prepare and test inputs for common errors 2021-10-21 11:06:57,121 (natcap.invest.seasonal_water_yield.seasonal_water_yield) seasonal_water_yield._execute(467) INFO Building file registry 2021-10-21 11:06:57,131 (natcap.invest.seasonal_water_yield.seasonal_water_yield) seasonal_water_yield._execute(473) INFO Checking that the AOI is not the output aggregate vector 2021-10-21 11:06:57,133 (natcap.invest.seasonal_water_yield.seasonal_water_yield) seasonal_water_yield._execute(482) INFO Aligning and clipping dataset list 2021-10-21 11:06:59,059 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(824) INFO 1 of 28 aligned: prcp_a0_2018_18.tif 2021-10-21 11:07:00,271 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(824) INFO 2 of 28 aligned: prcp_a1_2018_18.tif 2021-10-21 11:07:01,018 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(824) INFO 3 of 28 aligned: prcp_a2_2018_18.tif 2021-10-21 11:07:01,912 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(824) INFO 4 of 28 aligned: prcp_a3_2018_18.tif 2021-10-21 11:07:02,703 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(824) INFO 5 of 28 aligned: prcp_a4_2018_18.tif 2021-10-21 11:07:03,585 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(824) INFO 6 of 28 aligned: prcp_a5_2018_18.tif 2021-10-21 11:07:04,461 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(824) INFO 7 of 28 aligned: prcp_a6_2018_18.tif 2021-10-21 11:07:05,294 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(824) INFO 8 of 28 aligned: prcp_a7_2018_18.tif 2021-10-21 11:07:06,104 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(824) INFO 9 of 28 aligned: prcp_a8_2018_18.tif 2021-10-21 11:07:06,962 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(824) INFO 10 of 28 aligned: prcp_a9_2018_18.tif 2021-10-21 11:07:07,742 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(824) INFO 11 of 28 aligned: prcp_a10_2018_18.tif 2021-10-21 11:07:08,565 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(824) INFO 12 of 28 aligned: prcp_a11_2018_18.tif 2021-10-21 11:07:09,550 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(824) INFO 13 of 28 aligned: soil_group_aligned_2018_18.tif 2021-10-21 11:07:11,357 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(824) INFO 14 of 28 aligned: et0_a0_2018_18.tif 2021-10-21 11:07:13,201 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(824) INFO 15 of 28 aligned: et0_a1_2018_18.tif 2021-10-21 11:07:15,034 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(824) INFO 16 of 28 aligned: et0_a2_2018_18.tif 2021-10-21 11:07:17,392 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(824) INFO 17 of 28 aligned: et0_a3_2018_18.tif 2021-10-21 11:07:19,284 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(824) INFO 18 of 28 aligned: et0_a4_2018_18.tif 2021-10-21 11:07:21,578 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(824) INFO 19 of 28 aligned: et0_a5_2018_18.tif 2021-10-21 11:07:23,636 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(824) INFO 20 of 28 aligned: et0_a6_2018_18.tif 2021-10-21 11:07:26,020 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(824) INFO 21 of 28 aligned: et0_a7_2018_18.tif 2021-10-21 11:07:28,388 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(824) INFO 22 of 28 aligned: et0_a8_2018_18.tif 2021-10-21 11:07:30,552 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(824) INFO 23 of 28 aligned: et0_a9_2018_18.tif 2021-10-21 11:07:33,190 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(824) INFO 24 of 28 aligned: et0_a10_2018_18.tif 2021-10-21 11:07:35,777 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(824) INFO 25 of 28 aligned: et0_a11_2018_18.tif 2021-10-21 11:07:36,890 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(824) INFO 26 of 28 aligned: lulc_aligned_2018_18.tif 2021-10-21 11:07:39,181 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(824) INFO 27 of 28 aligned: dem_aligned_2018_18.tif 2021-10-21 11:07:39,909 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(824) INFO 28 of 28 aligned: cz_aligned_2018_18.tif 2021-10-21 11:07:39,911 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(828) INFO aligned all 28 rasters. 2021-10-21 11:07:50,032 (pygeoprocessing.routing.routing) Task._call(1093) INFO (fill pits): 8350208 of 8969125 pixels complete 2021-10-21 11:07:50,330 (pygeoprocessing.routing.routing) Task._call(1093) INFO (fill pits): complete 2021-10-21 11:08:01,043 (pygeoprocessing.routing.routing) Task._call(1093) INFO 84.6% complete 2021-10-21 11:08:04,753 (pygeoprocessing.routing.routing) Task._call(1093) INFO 100.0% complete 2021-10-21 11:08:04,798 (pygeoprocessing.routing.routing) Task._call(1093) DEBUG creating target flow accum raster layer 2021-10-21 11:08:04,879 (pygeoprocessing.routing.routing) Task._call(1093) DEBUG creating visited raster layer 2021-10-21 11:08:04,945 (pygeoprocessing.routing.routing) Task._call(1093) DEBUG starting search 2021-10-21 11:08:15,016 (pygeoprocessing.routing.routing) Task._call(1093) INFO mfd flow accum 28.2% complete 2021-10-21 11:08:26,001 (pygeoprocessing.routing.routing) Task._call(1093) INFO mfd flow accum 61.0% complete 2021-10-21 11:08:31,981 (pygeoprocessing.routing.routing) Task._call(1093) INFO 100.0% complete 2021-10-21 11:08:43,013 (pygeoprocessing.routing.routing) Task._call(1093) INFO 67.7% complete 2021-10-21 11:08:46,398 (pygeoprocessing.routing.routing) Task._call(1093) INFO filter out incomplete divergent streams 2021-10-21 11:08:46,710 (pygeoprocessing.routing.routing) Task._call(1093) INFO 100.0% complete 2021-10-21 11:08:46,738 (natcap.invest.seasonal_water_yield.seasonal_water_yield) seasonal_water_yield._execute(584) INFO quick flow 2021-10-21 11:08:46,740 (natcap.invest.seasonal_water_yield.seasonal_water_yield) seasonal_water_yield._execute(598) INFO loading number of monthly events 2021-10-21 11:08:46,853 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2021-10-21 11:08:46,856 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 12476 2021-10-21 11:08:46,856 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2021-10-21 11:08:47,758 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2021-10-21 11:08:47,760 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2021-10-21 11:08:48,286 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2021-10-21 11:08:48,289 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 12476 2021-10-21 11:08:48,289 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2021-10-21 11:08:49,190 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2021-10-21 11:08:49,191 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2021-10-21 11:08:49,747 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2021-10-21 11:08:49,749 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 12476 2021-10-21 11:08:49,750 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2021-10-21 11:08:52,671 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2021-10-21 11:08:52,673 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2021-10-21 11:08:53,447 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2021-10-21 11:08:53,450 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 12476 2021-10-21 11:08:53,451 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2021-10-21 11:08:54,209 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2021-10-21 11:08:54,210 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2021-10-21 11:08:54,724 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2021-10-21 11:08:54,726 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 12476 2021-10-21 11:08:54,726 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2021-10-21 11:08:55,479 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2021-10-21 11:08:55,480 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2021-10-21 11:08:55,917 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2021-10-21 11:08:55,932 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 12476 2021-10-21 11:08:55,933 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2021-10-21 11:08:56,803 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2021-10-21 11:08:56,804 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2021-10-21 11:08:57,250 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2021-10-21 11:08:57,252 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 12476 2021-10-21 11:08:57,252 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2021-10-21 11:08:58,181 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2021-10-21 11:08:58,182 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2021-10-21 11:08:58,551 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2021-10-21 11:08:58,554 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 12476 2021-10-21 11:08:58,554 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2021-10-21 11:08:59,114 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2021-10-21 11:08:59,115 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2021-10-21 11:08:59,458 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2021-10-21 11:08:59,468 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 12476 2021-10-21 11:08:59,468 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2021-10-21 11:09:00,069 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2021-10-21 11:09:00,070 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2021-10-21 11:09:00,419 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2021-10-21 11:09:00,421 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 12476 2021-10-21 11:09:00,421 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2021-10-21 11:09:00,998 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2021-10-21 11:09:00,999 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2021-10-21 11:09:01,502 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2021-10-21 11:09:01,505 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 12476 2021-10-21 11:09:01,505 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2021-10-21 11:09:02,096 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2021-10-21 11:09:02,097 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2021-10-21 11:09:02,434 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2021-10-21 11:09:02,435 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 12476 2021-10-21 11:09:02,436 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2021-10-21 11:09:03,265 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2021-10-21 11:09:03,266 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2021-10-21 11:09:03,591 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2021-10-21 11:09:03,593 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 12476 2021-10-21 11:09:03,593 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2021-10-21 11:09:04,705 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2021-10-21 11:09:04,706 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2021-10-21 11:09:05,047 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2021-10-21 11:09:05,049 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 12476 2021-10-21 11:09:05,049 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2021-10-21 11:09:05,548 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2021-10-21 11:09:05,549 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2021-10-21 11:09:05,815 (natcap.invest.seasonal_water_yield.seasonal_water_yield) seasonal_water_yield._execute(664) INFO calculate quick flow for month 1 2021-10-21 11:09:05,899 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2021-10-21 11:09:05,901 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 12476 2021-10-21 11:09:05,902 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2021-10-21 11:09:10,250 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2021-10-21 11:09:10,251 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2021-10-21 11:09:10,458 (natcap.invest.seasonal_water_yield.seasonal_water_yield) seasonal_water_yield._execute(664) INFO calculate quick flow for month 2 2021-10-21 11:09:10,529 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2021-10-21 11:09:10,531 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 12476 2021-10-21 11:09:10,531 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2021-10-21 11:09:13,145 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2021-10-21 11:09:13,146 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2021-10-21 11:09:13,348 (natcap.invest.seasonal_water_yield.seasonal_water_yield) seasonal_water_yield._execute(664) INFO calculate quick flow for month 3 2021-10-21 11:09:13,434 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2021-10-21 11:09:13,436 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 12476 2021-10-21 11:09:13,437 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2021-10-21 11:09:16,040 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2021-10-21 11:09:16,042 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2021-10-21 11:09:16,233 (natcap.invest.seasonal_water_yield.seasonal_water_yield) seasonal_water_yield._execute(664) INFO calculate quick flow for month 4 2021-10-21 11:09:16,309 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2021-10-21 11:09:16,310 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 12476 2021-10-21 11:09:16,310 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2021-10-21 11:09:21,314 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 97.9% complete 2021-10-21 11:09:21,414 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2021-10-21 11:09:21,416 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2021-10-21 11:09:21,933 (natcap.invest.seasonal_water_yield.seasonal_water_yield) seasonal_water_yield._execute(664) INFO calculate quick flow for month 5 2021-10-21 11:09:22,112 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2021-10-21 11:09:22,114 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 12476 2021-10-21 11:09:22,115 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2021-10-21 11:09:27,149 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 83.5% complete 2021-10-21 11:09:28,659 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2021-10-21 11:09:28,661 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2021-10-21 11:09:29,195 (natcap.invest.seasonal_water_yield.seasonal_water_yield) seasonal_water_yield._execute(664) INFO calculate quick flow for month 6 2021-10-21 11:09:29,692 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2021-10-21 11:09:29,699 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 12476 2021-10-21 11:09:29,700 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2021-10-21 11:09:34,717 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 65.1% complete 2021-10-21 11:09:38,197 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2021-10-21 11:09:38,200 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2021-10-21 11:09:38,847 (natcap.invest.seasonal_water_yield.seasonal_water_yield) seasonal_water_yield._execute(664) INFO calculate quick flow for month 7 2021-10-21 11:09:39,045 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2021-10-21 11:09:39,049 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 12476 2021-10-21 11:09:39,049 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2021-10-21 11:09:44,047 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 91.9% complete 2021-10-21 11:09:44,498 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2021-10-21 11:09:44,500 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2021-10-21 11:09:44,910 (natcap.invest.seasonal_water_yield.seasonal_water_yield) seasonal_water_yield._execute(664) INFO calculate quick flow for month 8 2021-10-21 11:09:45,136 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2021-10-21 11:09:45,143 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 12476 2021-10-21 11:09:45,143 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2021-10-21 11:09:50,190 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 71.4% complete 2021-10-21 11:09:53,139 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2021-10-21 11:09:53,142 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2021-10-21 11:09:53,689 (natcap.invest.seasonal_water_yield.seasonal_water_yield) seasonal_water_yield._execute(664) INFO calculate quick flow for month 9 2021-10-21 11:09:53,879 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2021-10-21 11:09:53,883 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 12476 2021-10-21 11:09:53,884 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2021-10-21 11:09:58,920 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 79.8% complete 2021-10-21 11:10:00,817 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2021-10-21 11:10:00,818 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2021-10-21 11:10:01,419 (natcap.invest.seasonal_water_yield.seasonal_water_yield) seasonal_water_yield._execute(664) INFO calculate quick flow for month 10 2021-10-21 11:10:01,641 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2021-10-21 11:10:01,644 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 12476 2021-10-21 11:10:01,645 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2021-10-21 11:10:06,685 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 80.5% complete 2021-10-21 11:10:09,869 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2021-10-21 11:10:09,872 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2021-10-21 11:10:11,693 (natcap.invest.seasonal_water_yield.seasonal_water_yield) seasonal_water_yield._execute(664) INFO calculate quick flow for month 11 2021-10-21 11:10:11,963 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2021-10-21 11:10:11,968 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 12476 2021-10-21 11:10:11,969 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2021-10-21 11:10:16,985 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 77.6% complete 2021-10-21 11:10:18,643 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2021-10-21 11:10:18,646 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2021-10-21 11:10:19,138 (natcap.invest.seasonal_water_yield.seasonal_water_yield) seasonal_water_yield._execute(664) INFO calculate quick flow for month 12 2021-10-21 11:10:19,337 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2021-10-21 11:10:19,340 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 12476 2021-10-21 11:10:19,341 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2021-10-21 11:10:24,393 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 61.4% complete 2021-10-21 11:10:28,467 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2021-10-21 11:10:28,469 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2021-10-21 11:10:29,250 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2021-10-21 11:10:29,253 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 12476 2021-10-21 11:10:29,253 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2021-10-21 11:10:34,253 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 75.7% complete 2021-10-21 11:10:36,078 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2021-10-21 11:10:36,080 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2021-10-21 11:10:36,242 (natcap.invest.seasonal_water_yield.seasonal_water_yield) seasonal_water_yield._execute(691) INFO calculate local recharge 2021-10-21 11:10:36,322 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2021-10-21 11:10:36,325 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 12476 2021-10-21 11:10:36,326 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2021-10-21 11:10:38,044 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2021-10-21 11:10:38,046 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2021-10-21 11:10:38,801 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2021-10-21 11:10:38,803 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 12476 2021-10-21 11:10:38,804 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2021-10-21 11:10:40,302 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2021-10-21 11:10:40,305 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2021-10-21 11:10:42,119 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2021-10-21 11:10:42,122 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 12476 2021-10-21 11:10:42,122 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2021-10-21 11:10:43,897 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2021-10-21 11:10:43,900 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2021-10-21 11:10:44,619 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2021-10-21 11:10:44,623 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 12476 2021-10-21 11:10:44,623 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2021-10-21 11:10:46,416 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2021-10-21 11:10:46,421 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2021-10-21 11:10:48,220 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2021-10-21 11:10:48,225 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 12476 2021-10-21 11:10:48,226 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2021-10-21 11:10:50,336 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2021-10-21 11:10:50,339 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2021-10-21 11:10:50,970 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2021-10-21 11:10:50,972 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 12476 2021-10-21 11:10:50,973 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2021-10-21 11:10:53,569 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2021-10-21 11:10:53,576 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2021-10-21 11:10:54,503 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2021-10-21 11:10:54,506 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 12476 2021-10-21 11:10:54,506 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2021-10-21 11:10:56,194 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2021-10-21 11:10:56,196 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2021-10-21 11:10:56,929 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2021-10-21 11:10:56,932 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 12476 2021-10-21 11:10:56,932 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2021-10-21 11:10:58,426 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2021-10-21 11:10:58,427 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2021-10-21 11:10:59,999 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2021-10-21 11:11:00,003 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 12476 2021-10-21 11:11:00,004 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2021-10-21 11:11:03,187 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2021-10-21 11:11:03,188 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2021-10-21 11:11:04,909 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2021-10-21 11:11:04,925 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 12476 2021-10-21 11:11:04,926 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2021-10-21 11:11:06,702 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2021-10-21 11:11:06,704 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2021-10-21 11:11:07,260 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2021-10-21 11:11:07,263 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 12476 2021-10-21 11:11:07,263 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2021-10-21 11:11:08,487 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2021-10-21 11:11:08,489 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2021-10-21 11:11:10,052 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2021-10-21 11:11:10,062 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 12476 2021-10-21 11:11:10,063 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2021-10-21 11:11:12,369 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2021-10-21 11:11:12,371 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2021-10-21 11:11:18,385 (natcap.invest.seasonal_water_yield.seasonal_water_yield_core) Task._call(1093) INFO peak point detection 0.02% complete 2021-10-21 11:11:24,414 (natcap.invest.seasonal_water_yield.seasonal_water_yield_core) Task._call(1093) INFO peak point detection 0.03% complete 2021-10-21 11:11:30,424 (natcap.invest.seasonal_water_yield.seasonal_water_yield_core) Task._call(1093) INFO peak point detection 8.49% complete 2021-10-21 11:11:37,454 (natcap.invest.seasonal_water_yield.seasonal_water_yield_core) Task._call(1093) INFO peak point detection 16.94% complete 2021-10-21 11:11:45,845 (natcap.invest.seasonal_water_yield.seasonal_water_yield_core) Task._call(1093) INFO peak point detection 16.95% complete 2021-10-21 11:11:51,476 (natcap.invest.seasonal_water_yield.seasonal_water_yield_core) Task._call(1093) INFO peak point detection 16.95% complete 2021-10-21 11:11:58,720 (natcap.invest.seasonal_water_yield.seasonal_water_yield_core) Task._call(1093) INFO peak point detection 25.40% complete 2021-10-21 11:12:04,149 (natcap.invest.seasonal_water_yield.seasonal_water_yield_core) Task._call(1093) INFO peak point detection 25.41% complete 2021-10-21 11:12:11,501 (natcap.invest.seasonal_water_yield.seasonal_water_yield_core) Task._call(1093) INFO peak point detection 25.41% complete 2021-10-21 11:12:17,439 (natcap.invest.seasonal_water_yield.seasonal_water_yield_core) Task._call(1093) INFO peak point detection 25.42% complete 2021-10-21 11:12:23,007 (natcap.invest.seasonal_water_yield.seasonal_water_yield_core) Task._call(1093) INFO peak point detection 33.86% complete 2021-10-21 11:12:30,328 (natcap.invest.seasonal_water_yield.seasonal_water_yield_core) Task._call(1093) INFO peak point detection 33.87% complete 2021-10-21 11:12:36,215 (natcap.invest.seasonal_water_yield.seasonal_water_yield_core) Task._call(1093) INFO peak point detection 33.87% complete 2021-10-21 11:12:43,846 (natcap.invest.seasonal_water_yield.seasonal_water_yield_core) Task._call(1093) INFO peak point detection 33.88% complete 2021-10-21 11:12:50,654 (natcap.invest.seasonal_water_yield.seasonal_water_yield_core) Task._call(1093) INFO peak point detection 42.32% complete 2021-10-21 11:12:56,161 (natcap.invest.seasonal_water_yield.seasonal_water_yield_core) Task._call(1093) INFO peak point detection 42.33% complete 2021-10-21 11:13:04,018 (natcap.invest.seasonal_water_yield.seasonal_water_yield_core) Task._call(1093) INFO peak point detection 42.34% complete 2021-10-21 11:13:12,635 (natcap.invest.seasonal_water_yield.seasonal_water_yield_core) Task._call(1093) INFO peak point detection 50.79% complete 2021-10-21 11:13:19,272 (natcap.invest.seasonal_water_yield.seasonal_water_yield_core) Task._call(1093) INFO peak point detection 50.79% complete 2021-10-21 11:13:26,215 (natcap.invest.seasonal_water_yield.seasonal_water_yield_core) Task._call(1093) INFO peak point detection 50.80% complete 2021-10-21 11:13:32,664 (natcap.invest.seasonal_water_yield.seasonal_water_yield_core) Task._call(1093) INFO peak point detection 50.80% complete 2021-10-21 11:13:40,332 (natcap.invest.seasonal_water_yield.seasonal_water_yield_core) Task._call(1093) INFO peak point detection 50.81% complete 2021-10-21 11:13:46,162 (natcap.invest.seasonal_water_yield.seasonal_water_yield_core) Task._call(1093) INFO peak point detection 59.25% complete 2021-10-21 11:13:56,329 (natcap.invest.seasonal_water_yield.seasonal_water_yield_core) Task._call(1093) INFO peak point detection 59.26% complete 2021-10-21 11:14:02,027 (natcap.invest.seasonal_water_yield.seasonal_water_yield_core) Task._call(1093) INFO peak point detection 59.27% complete 2021-10-21 11:14:10,014 (natcap.invest.seasonal_water_yield.seasonal_water_yield_core) Task._call(1093) INFO peak point detection 59.27% complete 2021-10-21 11:14:17,325 (natcap.invest.seasonal_water_yield.seasonal_water_yield_core) Task._call(1093) INFO peak point detection 67.71% complete 2021-10-21 11:14:24,691 (natcap.invest.seasonal_water_yield.seasonal_water_yield_core) Task._call(1093) INFO peak point detection 67.72% complete 2021-10-21 11:14:32,762 (natcap.invest.seasonal_water_yield.seasonal_water_yield_core) Task._call(1093) INFO peak point detection 67.72% complete 2021-10-21 11:14:40,093 (natcap.invest.seasonal_water_yield.seasonal_water_yield_core) Task._call(1093) INFO peak point detection 67.73% complete 2021-10-21 11:14:48,567 (natcap.invest.seasonal_water_yield.seasonal_water_yield_core) Task._call(1093) INFO peak point detection 76.17% complete 2021-10-21 11:14:55,260 (natcap.invest.seasonal_water_yield.seasonal_water_yield_core) Task._call(1093) INFO peak point detection 76.17% complete 2021-10-21 11:15:01,042 (natcap.invest.seasonal_water_yield.seasonal_water_yield_core) Task._call(1093) INFO peak point detection 76.18% complete 2021-10-21 11:15:09,562 (natcap.invest.seasonal_water_yield.seasonal_water_yield_core) Task._call(1093) INFO peak point detection 76.19% complete 2021-10-21 11:15:16,293 (natcap.invest.seasonal_water_yield.seasonal_water_yield_core) Task._call(1093) INFO peak point detection 76.19% complete 2021-10-21 11:15:22,139 (natcap.invest.seasonal_water_yield.seasonal_water_yield_core) Task._call(1093) INFO peak point detection 84.63% complete 2021-10-21 11:15:31,415 (natcap.invest.seasonal_water_yield.seasonal_water_yield_core) Task._call(1093) INFO peak point detection 84.64% complete 2021-10-21 11:15:40,031 (natcap.invest.seasonal_water_yield.seasonal_water_yield_core) Task._call(1093) INFO peak point detection 84.65% complete 2021-10-21 11:15:46,984 (natcap.invest.seasonal_water_yield.seasonal_water_yield_core) Task._call(1093) INFO peak point detection 84.66% complete 2021-10-21 11:15:53,952 (natcap.invest.seasonal_water_yield.seasonal_water_yield_core) Task._call(1093) INFO peak point detection 93.09% complete 2021-10-21 11:16:17,330 (natcap.invest.seasonal_water_yield.seasonal_water_yield_core) Task._call(1093) INFO peak point detection 93.10% complete 2021-10-21 11:16:24,327 (natcap.invest.seasonal_water_yield.seasonal_water_yield_core) Task._call(1093) INFO peak point detection 93.10% complete 2021-10-21 11:16:30,115 (natcap.invest.seasonal_water_yield.seasonal_water_yield_core) Task._call(1093) INFO peak point detection 93.11% complete 2021-10-21 11:16:39,964 (natcap.invest.seasonal_water_yield.seasonal_water_yield_core) Task._call(1093) INFO peak point detection 93.11% complete 2021-10-21 11:16:44,140 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2021-10-21 11:16:44,145 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 12476 2021-10-21 11:16:44,146 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2021-10-21 11:16:45,010 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2021-10-21 11:16:45,011 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2021-10-21 11:16:50,094 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(824) INFO 1 of 1 aligned: clipped_raster.tif 2021-10-21 11:16:50,096 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(828) INFO aligned all 1 rasters. 2021-10-21 11:16:50,151 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1275) INFO build a lookup of aggregate field value to FID 2021-10-21 11:16:50,153 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1282) INFO creating disjoint polygon set 2021-10-21 11:16:50,156 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2257) INFO build shapely polygon list 2021-10-21 11:16:50,204 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2280) INFO build shapely rtree index 2021-10-21 11:16:50,212 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2293) INFO poly feature lookup 100.0% complete on aggregated_results_swy_2018_18.shp 2021-10-21 11:16:50,213 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2297) INFO build poly intersection lookup 2021-10-21 11:16:50,214 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2319) INFO poly intersection feature lookup 100.0% complete on aggregated_results_swy_2018_18.shp 2021-10-21 11:16:50,215 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2353) INFO maximal subset build 100.0% complete on aggregated_results_swy_2018_18.shp 2021-10-21 11:16:50,267 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1303) INFO processing 1 disjoint polygon sets 2021-10-21 11:16:50,270 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1337) INFO disjoint polygon set 1 of 1 100.0% processed on aggregated_results_swy_2018_18.shp 2021-10-21 11:16:50,287 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1345) INFO rasterizing disjoint polygon set 1 of 1 aggregated_results_swy_2018_18.shp 2021-10-21 11:16:50,912 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1363) INFO summarizing rasterized disjoint polygon set 1 of 1 aggregated_results_swy_2018_18.shp 2021-10-21 11:16:51,919 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1407) DEBUG unset_fids: 0 of 1 2021-10-21 11:16:51,920 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1412) DEBUG gt [ 4.3826980e+06 2.4997896e+01 0.0000000e+00 2.7638522e+06 0.0000000e+00 -2.4997896e+01] for ('...qf_clipped/WP_18\\L_2018_18.tif', 1) 2021-10-21 11:16:51,922 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1491) DEBUG remaining unset_fids: 0 of 1 2021-10-21 11:16:51,923 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1499) INFO all done processing polygon sets for aggregated_results_swy_2018_18.shp 2021-10-21 11:16:56,654 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(824) INFO 1 of 1 aligned: clipped_raster.tif 2021-10-21 11:16:56,656 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(828) INFO aligned all 1 rasters. 2021-10-21 11:16:56,831 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1275) INFO build a lookup of aggregate field value to FID 2021-10-21 11:16:56,835 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1282) INFO creating disjoint polygon set 2021-10-21 11:16:56,839 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2257) INFO build shapely polygon list 2021-10-21 11:16:56,969 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2280) INFO build shapely rtree index 2021-10-21 11:16:56,974 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2293) INFO poly feature lookup 100.0% complete on aggregated_results_swy_2018_18.shp 2021-10-21 11:16:56,975 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2297) INFO build poly intersection lookup 2021-10-21 11:16:56,977 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2319) INFO poly intersection feature lookup 100.0% complete on aggregated_results_swy_2018_18.shp 2021-10-21 11:16:56,980 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2353) INFO maximal subset build 100.0% complete on aggregated_results_swy_2018_18.shp 2021-10-21 11:16:57,083 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1303) INFO processing 1 disjoint polygon sets 2021-10-21 11:16:57,086 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1337) INFO disjoint polygon set 1 of 1 100.0% processed on aggregated_results_swy_2018_18.shp 2021-10-21 11:16:57,110 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1345) INFO rasterizing disjoint polygon set 1 of 1 aggregated_results_swy_2018_18.shp 2021-10-21 11:16:57,982 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1363) INFO summarizing rasterized disjoint polygon set 1 of 1 aggregated_results_swy_2018_18.shp 2021-10-21 11:16:58,946 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1407) DEBUG unset_fids: 0 of 1 2021-10-21 11:16:58,947 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1412) DEBUG gt [ 4.3826980e+06 2.4997896e+01 0.0000000e+00 2.7638522e+06 0.0000000e+00 -2.4997896e+01] for ('...qf_clipped/WP_18\\Vri_2018_18.tif', 1) 2021-10-21 11:16:58,949 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1491) DEBUG remaining unset_fids: 0 of 1 2021-10-21 11:16:58,949 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1499) INFO all done processing polygon sets for aggregated_results_swy_2018_18.shp 2021-10-21 11:16:59,035 (natcap.invest.seasonal_water_yield.seasonal_water_yield) seasonal_water_yield._execute(761) INFO calculate L_sum 2021-10-21 11:16:59,048 (pygeoprocessing.routing.routing) Task._call(1093) DEBUG creating target flow accum raster layer 2021-10-21 11:16:59,111 (pygeoprocessing.routing.routing) Task._call(1093) DEBUG creating visited raster layer 2021-10-21 11:16:59,190 (pygeoprocessing.routing.routing) Task._call(1093) DEBUG starting search 2021-10-21 11:17:10,042 (pygeoprocessing.routing.routing) Task._call(1093) INFO mfd flow accum 33.5% complete 2021-10-21 11:17:21,000 (pygeoprocessing.routing.routing) Task._call(1093) INFO mfd flow accum 60.4% complete 2021-10-21 11:17:32,000 (pygeoprocessing.routing.routing) Task._call(1093) INFO mfd flow accum 72.7% complete 2021-10-21 11:17:35,118 (pygeoprocessing.routing.routing) Task._call(1093) INFO 100.0% complete 2021-10-21 11:17:41,000 (natcap.invest.seasonal_water_yield.seasonal_water_yield_core) Task._call(1093) INFO route base flow 7.57% complete 2021-10-21 11:17:47,003 (natcap.invest.seasonal_water_yield.seasonal_water_yield_core) Task._call(1093) INFO route base flow 10.24% complete 2021-10-21 11:17:53,000 (natcap.invest.seasonal_water_yield.seasonal_water_yield_core) Task._call(1093) INFO route base flow 17.62% complete 2021-10-21 11:17:59,000 (natcap.invest.seasonal_water_yield.seasonal_water_yield_core) Task._call(1093) INFO route base flow 23.48% complete 2021-10-21 11:18:05,000 (natcap.invest.seasonal_water_yield.seasonal_water_yield_core) Task._call(1093) INFO route base flow 28.85% complete 2021-10-21 11:18:11,033 (natcap.invest.seasonal_water_yield.seasonal_water_yield_core) Task._call(1093) INFO route base flow 34.31% complete 2021-10-21 11:18:17,045 (natcap.invest.seasonal_water_yield.seasonal_water_yield_core) Task._call(1093) INFO route base flow 37.01% complete 2021-10-21 11:18:23,000 (natcap.invest.seasonal_water_yield.seasonal_water_yield_core) Task._call(1093) INFO route base flow 39.98% complete 2021-10-21 11:18:29,000 (natcap.invest.seasonal_water_yield.seasonal_water_yield_core) Task._call(1093) INFO route base flow 46.93% complete 2021-10-21 11:18:35,005 (natcap.invest.seasonal_water_yield.seasonal_water_yield_core) Task._call(1093) INFO route base flow 51.92% complete 2021-10-21 11:18:41,014 (natcap.invest.seasonal_water_yield.seasonal_water_yield_core) Task._call(1093) INFO route base flow 66.29% complete 2021-10-21 11:18:47,000 (natcap.invest.seasonal_water_yield.seasonal_water_yield_core) Task._call(1093) INFO route base flow 75.61% complete 2021-10-21 11:18:53,000 (natcap.invest.seasonal_water_yield.seasonal_water_yield_core) Task._call(1093) INFO route base flow 84.86% complete 2021-10-21 11:18:59,000 (natcap.invest.seasonal_water_yield.seasonal_water_yield_core) Task._call(1093) INFO route base flow 91.15% complete 2021-10-21 11:19:05,033 (natcap.invest.seasonal_water_yield.seasonal_water_yield_core) Task._call(1093) INFO route base flow 95.87% complete 2021-10-21 11:19:09,245 (natcap.invest.seasonal_water_yield.seasonal_water_yield) seasonal_water_yield._execute(797) INFO (\w/) SWY Complete! 2021-10-21 11:19:09,247 (natcap.invest.seasonal_water_yield.seasonal_water_yield) seasonal_water_yield._execute(798) INFO (.. \ 2021-10-21 11:19:09,248 (natcap.invest.seasonal_water_yield.seasonal_water_yield) seasonal_water_yield._execute(799) INFO _/ ) \______ 2021-10-21 11:19:09,249 (natcap.invest.seasonal_water_yield.seasonal_water_yield) seasonal_water_yield._execute(800) INFO (oo /'\ )`, 2021-10-21 11:19:09,250 (natcap.invest.seasonal_water_yield.seasonal_water_yield) seasonal_water_yield._execute(801) INFO `--' (v __( / || 2021-10-21 11:19:09,251 (natcap.invest.seasonal_water_yield.seasonal_water_yield) seasonal_water_yield._execute(802) INFO ||| ||| || 2021-10-21 11:19:09,252 (natcap.invest.seasonal_water_yield.seasonal_water_yield) seasonal_water_yield._execute(803) INFO //_| //_| 2021-10-21 11:19:09,259 (natcap.invest.utils) utils.prepare_workspace(166) INFO Elapsed time: 12m 12.629999999999995s 2021-10-21 11:19:09,263 (natcap.invest.utils) utils.prepare_workspace(169) INFO Execution finished