2022-03-01 17:58:13,491 (natcap.invest.utils) utils.prepare_workspace(162) Level 100 Writing log messages to D:/SWY_workspace\InVEST-Seasonal-Water-Yield-log-2022-03-01--17_58_13.txt 2022-03-01 17:58:13,518 (natcap.invest.ui.model) model._logged_target(1643) Level 100 Starting model with parameters: Arguments for InVEST natcap.invest.seasonal_water_yield.seasonal_water_yield 3.10.2: alpha_m 1/12 aoi_path D:/SWY_espinhaco/Dados InVest/watershed_espinhaco.shp beta_i 1 biophysical_table_path D:/SWY_espinhaco/Dados InVest/biophysical_table_espinhaco.csv dem_raster_path D:/SWY_espinhaco/Dados InVest/DEM_espinhaco.tiff et0_dir D:/SWY_espinhaco/Dados InVest/ET0_monthly gamma 1 lulc_raster_path D:/SWY_espinhaco/Dados InVest/lulc_INT2S.tif monthly_alpha False n_workers -1 precip_dir D:/SWY_espinhaco/Dados InVest/Precipitation_monthly rain_events_table_path D:/SWY_espinhaco/Dados InVest/rain_events_espinhaco.csv results_suffix soil_group_path D:/SWY_espinhaco/Dados InVest/soil_group_INT2S.tif threshold_flow_accumulation 1000 user_defined_climate_zones False user_defined_local_recharge False workspace_dir D:/SWY_workspace 2022-03-01 17:58:13,520 (natcap.invest.seasonal_water_yield.seasonal_water_yield) seasonal_water_yield._execute(418) INFO prepare and test inputs for common errors 2022-03-01 17:58:13,990 (natcap.invest.seasonal_water_yield.seasonal_water_yield) seasonal_water_yield._execute(484) INFO Building file registry 2022-03-01 17:58:13,995 (natcap.invest.seasonal_water_yield.seasonal_water_yield) seasonal_water_yield._execute(490) INFO Checking that the AOI is not the output aggregate vector 2022-03-01 17:58:13,996 (natcap.invest.seasonal_water_yield.seasonal_water_yield) seasonal_water_yield._execute(499) INFO Aligning and clipping dataset list 2022-03-01 17:58:16,098 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(824) INFO 1 of 27 aligned: prcp_a0.tif 2022-03-01 17:58:16,560 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(824) INFO 2 of 27 aligned: prcp_a1.tif 2022-03-01 17:58:17,120 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(824) INFO 3 of 27 aligned: prcp_a2.tif 2022-03-01 17:58:17,704 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(824) INFO 4 of 27 aligned: prcp_a3.tif 2022-03-01 17:58:18,165 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(824) INFO 5 of 27 aligned: prcp_a4.tif 2022-03-01 17:58:18,670 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(824) INFO 6 of 27 aligned: prcp_a5.tif 2022-03-01 17:58:19,002 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(824) INFO 7 of 27 aligned: prcp_a6.tif 2022-03-01 17:58:19,421 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(824) INFO 8 of 27 aligned: prcp_a7.tif 2022-03-01 17:58:19,855 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(824) INFO 9 of 27 aligned: prcp_a8.tif 2022-03-01 17:58:20,293 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(824) INFO 10 of 27 aligned: prcp_a9.tif 2022-03-01 17:58:20,719 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(824) INFO 11 of 27 aligned: prcp_a10.tif 2022-03-01 17:58:21,113 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(824) INFO 12 of 27 aligned: prcp_a11.tif 2022-03-01 17:58:21,402 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(824) INFO 13 of 27 aligned: soil_group_aligned.tif 2022-03-01 17:58:21,878 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(824) INFO 14 of 27 aligned: et0_a0.tif 2022-03-01 17:58:22,336 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(824) INFO 15 of 27 aligned: et0_a1.tif 2022-03-01 17:58:22,862 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(824) INFO 16 of 27 aligned: et0_a2.tif 2022-03-01 17:58:23,376 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(824) INFO 17 of 27 aligned: et0_a3.tif 2022-03-01 17:58:24,160 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(824) INFO 18 of 27 aligned: et0_a4.tif 2022-03-01 17:58:24,590 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(824) INFO 19 of 27 aligned: et0_a5.tif 2022-03-01 17:58:25,154 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(824) INFO 20 of 27 aligned: et0_a6.tif 2022-03-01 17:58:25,726 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(824) INFO 21 of 27 aligned: et0_a7.tif 2022-03-01 17:58:26,382 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(824) INFO 22 of 27 aligned: et0_a8.tif 2022-03-01 17:58:26,860 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(824) INFO 23 of 27 aligned: et0_a9.tif 2022-03-01 17:58:27,414 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(824) INFO 24 of 27 aligned: et0_a10.tif 2022-03-01 17:58:27,821 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(824) INFO 25 of 27 aligned: et0_a11.tif 2022-03-01 17:58:28,092 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(824) INFO 26 of 27 aligned: lulc_aligned.tif 2022-03-01 17:58:28,639 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(824) INFO 27 of 27 aligned: dem_aligned.tif 2022-03-01 17:58:28,639 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(828) INFO aligned all 27 rasters. 2022-03-01 18:01:52,032 (pygeoprocessing.routing.routing) Task._call(1093) INFO (fill pits): 256 of 2240124 pixels complete 2022-03-01 18:04:22,034 (pygeoprocessing.routing.routing) Task._call(1093) INFO (fill pits): 512 of 2240124 pixels complete 2022-03-01 18:06:07,137 (pygeoprocessing.routing.routing) Task._call(1093) INFO (fill pits): 768 of 2240124 pixels complete 2022-03-01 18:07:00,345 (pygeoprocessing.routing.routing) Task._call(1093) INFO (fill pits): 1024 of 2240124 pixels complete 2022-03-01 18:08:17,993 (pygeoprocessing.routing.routing) Task._call(1093) INFO (fill pits): 1280 of 2240124 pixels complete 2022-03-01 18:10:22,770 (pygeoprocessing.routing.routing) Task._call(1093) INFO (fill pits): 1536 of 2240124 pixels complete 2022-03-01 18:11:37,615 (pygeoprocessing.routing.routing) Task._call(1093) INFO (fill pits): 1792 of 2240124 pixels complete 2022-03-01 18:12:25,799 (pygeoprocessing.routing.routing) Task._call(1093) INFO (fill pits): 2048 of 2240124 pixels complete 2022-03-01 18:13:05,557 (pygeoprocessing.routing.routing) Task._call(1093) INFO (fill pits): 2304 of 2240124 pixels complete 2022-03-01 18:14:55,332 (pygeoprocessing.routing.routing) Task._call(1093) INFO (fill pits): 605184 of 2240124 pixels complete 2022-03-01 18:16:06,193 (pygeoprocessing.routing.routing) Task._call(1093) INFO (fill pits): 605440 of 2240124 pixels complete 2022-03-01 18:18:43,524 (pygeoprocessing.routing.routing) Task._call(1093) INFO (fill pits): 605696 of 2240124 pixels complete 2022-03-01 18:20:10,551 (pygeoprocessing.routing.routing) Task._call(1093) INFO (fill pits): 605952 of 2240124 pixels complete 2022-03-01 18:20:46,499 (pygeoprocessing.routing.routing) Task._call(1093) INFO (fill pits): 606208 of 2240124 pixels complete 2022-03-01 18:22:10,213 (pygeoprocessing.routing.routing) Task._call(1093) INFO (fill pits): 606720 of 2240124 pixels complete 2022-03-01 18:23:22,999 (pygeoprocessing.routing.routing) Task._call(1093) INFO (fill pits): 606976 of 2240124 pixels complete 2022-03-01 18:24:20,238 (pygeoprocessing.routing.routing) Task._call(1093) INFO (fill pits): 607232 of 2240124 pixels complete 2022-03-01 18:25:23,691 (pygeoprocessing.routing.routing) Task._call(1093) INFO (fill pits): 1210112 of 2240124 pixels complete 2022-03-01 18:26:22,410 (pygeoprocessing.routing.routing) Task._call(1093) INFO (fill pits): 1210368 of 2240124 pixels complete 2022-03-01 18:27:07,152 (pygeoprocessing.routing.routing) Task._call(1093) INFO (fill pits): 1210624 of 2240124 pixels complete 2022-03-01 18:27:38,636 (pygeoprocessing.routing.routing) Task._call(1093) INFO (fill pits): 1210880 of 2240124 pixels complete 2022-03-01 18:28:37,606 (pygeoprocessing.routing.routing) Task._call(1093) INFO (fill pits): 1211136 of 2240124 pixels complete 2022-03-01 18:29:59,521 (pygeoprocessing.routing.routing) Task._call(1093) INFO (fill pits): 1211392 of 2240124 pixels complete 2022-03-01 18:31:34,126 (pygeoprocessing.routing.routing) Task._call(1093) INFO (fill pits): 1211648 of 2240124 pixels complete 2022-03-01 18:33:28,245 (pygeoprocessing.routing.routing) Task._call(1093) INFO (fill pits): 1211904 of 2240124 pixels complete 2022-03-01 18:34:34,007 (pygeoprocessing.routing.routing) Task._call(1093) INFO (fill pits): 1212160 of 2240124 pixels complete 2022-03-01 18:34:52,671 (pygeoprocessing.routing.routing) Task._call(1093) INFO (fill pits): 1815040 of 2240124 pixels complete 2022-03-01 18:35:10,659 (pygeoprocessing.routing.routing) Task._call(1093) INFO (fill pits): 1815808 of 2240124 pixels complete 2022-03-01 18:35:29,729 (pygeoprocessing.routing.routing) Task._call(1093) INFO (fill pits): 1816064 of 2240124 pixels complete 2022-03-01 18:35:51,065 (pygeoprocessing.routing.routing) Task._call(1093) INFO (fill pits): 1816320 of 2240124 pixels complete 2022-03-01 18:36:13,531 (pygeoprocessing.routing.routing) Task._call(1093) INFO (fill pits): 1816576 of 2240124 pixels complete 2022-03-01 18:36:35,043 (pygeoprocessing.routing.routing) Task._call(1093) INFO (fill pits): 1816832 of 2240124 pixels complete 2022-03-01 18:36:54,263 (pygeoprocessing.routing.routing) Task._call(1093) INFO (fill pits): 1817088 of 2240124 pixels complete 2022-03-01 18:36:55,871 (pygeoprocessing.routing.routing) Task._call(1093) INFO (fill pits): complete 2022-03-01 18:37:02,217 (pygeoprocessing.routing.routing) Task._call(1093) INFO 100.0% complete 2022-03-01 18:37:02,298 (pygeoprocessing.routing.routing) Task._call(1093) DEBUG creating target flow accum raster layer 2022-03-01 18:37:02,393 (pygeoprocessing.routing.routing) Task._call(1093) DEBUG creating visited raster layer 2022-03-01 18:37:02,472 (pygeoprocessing.routing.routing) Task._call(1093) DEBUG starting search 2022-03-01 18:37:04,832 (pygeoprocessing.routing.routing) Task._call(1093) INFO 100.0% complete 2022-03-01 18:37:05,938 (pygeoprocessing.routing.routing) Task._call(1093) INFO filter out incomplete divergent streams 2022-03-01 18:37:05,976 (pygeoprocessing.routing.routing) Task._call(1093) INFO 100.0% complete 2022-03-01 18:37:06,014 (natcap.invest.seasonal_water_yield.seasonal_water_yield) seasonal_water_yield._execute(601) INFO quick flow 2022-03-01 18:37:06,014 (natcap.invest.seasonal_water_yield.seasonal_water_yield) seasonal_water_yield._execute(615) INFO loading number of monthly events 2022-03-01 18:37:07,965 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2022-03-01 18:37:07,981 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 7216 2022-03-01 18:37:07,981 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2022-03-01 18:37:08,142 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2022-03-01 18:37:08,143 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2022-03-01 18:37:08,334 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2022-03-01 18:37:08,335 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 7216 2022-03-01 18:37:08,335 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2022-03-01 18:37:08,415 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2022-03-01 18:37:08,415 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2022-03-01 18:37:08,534 (natcap.invest.seasonal_water_yield.seasonal_water_yield) seasonal_water_yield._execute(681) INFO calculate quick flow for month 1 2022-03-01 18:37:08,723 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2022-03-01 18:37:08,725 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 7216 2022-03-01 18:37:08,725 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2022-03-01 18:37:09,241 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2022-03-01 18:37:09,242 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2022-03-01 18:37:09,443 (natcap.invest.seasonal_water_yield.seasonal_water_yield) seasonal_water_yield._execute(681) INFO calculate quick flow for month 2 2022-03-01 18:37:09,632 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2022-03-01 18:37:09,633 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 7216 2022-03-01 18:37:09,634 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2022-03-01 18:37:10,096 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2022-03-01 18:37:10,096 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2022-03-01 18:37:10,274 (natcap.invest.seasonal_water_yield.seasonal_water_yield) seasonal_water_yield._execute(681) INFO calculate quick flow for month 3 2022-03-01 18:37:10,464 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2022-03-01 18:37:10,465 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 7216 2022-03-01 18:37:10,466 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2022-03-01 18:37:10,936 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2022-03-01 18:37:10,936 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2022-03-01 18:37:11,144 (natcap.invest.seasonal_water_yield.seasonal_water_yield) seasonal_water_yield._execute(681) INFO calculate quick flow for month 4 2022-03-01 18:37:11,333 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2022-03-01 18:37:11,334 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 7216 2022-03-01 18:37:11,335 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2022-03-01 18:37:11,759 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2022-03-01 18:37:11,760 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2022-03-01 18:37:11,991 (natcap.invest.seasonal_water_yield.seasonal_water_yield) seasonal_water_yield._execute(681) INFO calculate quick flow for month 5 2022-03-01 18:37:12,179 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2022-03-01 18:37:12,180 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 7216 2022-03-01 18:37:12,181 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2022-03-01 18:37:12,565 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2022-03-01 18:37:12,566 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2022-03-01 18:37:12,735 (natcap.invest.seasonal_water_yield.seasonal_water_yield) seasonal_water_yield._execute(681) INFO calculate quick flow for month 6 2022-03-01 18:37:12,923 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2022-03-01 18:37:12,924 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 7216 2022-03-01 18:37:12,924 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2022-03-01 18:37:13,285 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2022-03-01 18:37:13,285 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2022-03-01 18:37:13,445 (natcap.invest.seasonal_water_yield.seasonal_water_yield) seasonal_water_yield._execute(681) INFO calculate quick flow for month 7 2022-03-01 18:37:13,632 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2022-03-01 18:37:13,633 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 7216 2022-03-01 18:37:13,633 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2022-03-01 18:37:13,986 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2022-03-01 18:37:13,986 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2022-03-01 18:37:14,143 (natcap.invest.seasonal_water_yield.seasonal_water_yield) seasonal_water_yield._execute(681) INFO calculate quick flow for month 8 2022-03-01 18:37:14,331 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2022-03-01 18:37:14,332 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 7216 2022-03-01 18:37:14,332 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2022-03-01 18:37:14,686 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2022-03-01 18:37:14,686 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2022-03-01 18:37:14,848 (natcap.invest.seasonal_water_yield.seasonal_water_yield) seasonal_water_yield._execute(681) INFO calculate quick flow for month 9 2022-03-01 18:37:15,034 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2022-03-01 18:37:15,035 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 7216 2022-03-01 18:37:15,036 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2022-03-01 18:37:15,440 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2022-03-01 18:37:15,440 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2022-03-01 18:37:15,611 (natcap.invest.seasonal_water_yield.seasonal_water_yield) seasonal_water_yield._execute(681) INFO calculate quick flow for month 10 2022-03-01 18:37:15,798 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2022-03-01 18:37:15,799 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 7216 2022-03-01 18:37:15,799 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2022-03-01 18:37:16,240 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2022-03-01 18:37:16,240 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2022-03-01 18:37:16,420 (natcap.invest.seasonal_water_yield.seasonal_water_yield) seasonal_water_yield._execute(681) INFO calculate quick flow for month 11 2022-03-01 18:37:16,607 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2022-03-01 18:37:16,608 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 7216 2022-03-01 18:37:16,609 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2022-03-01 18:37:17,090 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2022-03-01 18:37:17,091 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2022-03-01 18:37:17,299 (natcap.invest.seasonal_water_yield.seasonal_water_yield) seasonal_water_yield._execute(681) INFO calculate quick flow for month 12 2022-03-01 18:37:17,486 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2022-03-01 18:37:17,487 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 7216 2022-03-01 18:37:17,487 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2022-03-01 18:37:17,999 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2022-03-01 18:37:18,000 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2022-03-01 18:37:18,546 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2022-03-01 18:37:18,549 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 7216 2022-03-01 18:37:18,549 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2022-03-01 18:37:19,147 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2022-03-01 18:37:19,148 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2022-03-01 18:37:19,342 (natcap.invest.seasonal_water_yield.seasonal_water_yield) seasonal_water_yield._execute(708) INFO calculate local recharge 2022-03-01 18:37:19,393 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2022-03-01 18:37:19,394 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 7216 2022-03-01 18:37:19,394 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2022-03-01 18:37:19,483 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2022-03-01 18:37:19,484 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2022-03-01 18:37:19,642 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2022-03-01 18:37:19,643 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 7216 2022-03-01 18:37:19,643 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2022-03-01 18:37:19,721 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2022-03-01 18:37:19,722 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2022-03-01 18:37:19,882 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2022-03-01 18:37:19,883 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 7216 2022-03-01 18:37:19,883 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2022-03-01 18:37:19,964 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2022-03-01 18:37:19,965 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2022-03-01 18:37:20,122 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2022-03-01 18:37:20,123 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 7216 2022-03-01 18:37:20,123 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2022-03-01 18:37:20,204 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2022-03-01 18:37:20,205 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2022-03-01 18:37:20,366 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2022-03-01 18:37:20,367 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 7216 2022-03-01 18:37:20,368 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2022-03-01 18:37:20,449 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2022-03-01 18:37:20,450 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2022-03-01 18:37:20,610 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2022-03-01 18:37:20,612 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 7216 2022-03-01 18:37:20,612 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2022-03-01 18:37:20,693 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2022-03-01 18:37:20,693 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2022-03-01 18:37:20,852 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2022-03-01 18:37:20,854 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 7216 2022-03-01 18:37:20,854 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2022-03-01 18:37:20,935 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2022-03-01 18:37:20,935 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2022-03-01 18:37:21,093 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2022-03-01 18:37:21,094 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 7216 2022-03-01 18:37:21,094 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2022-03-01 18:37:21,175 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2022-03-01 18:37:21,176 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2022-03-01 18:37:21,331 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2022-03-01 18:37:21,332 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 7216 2022-03-01 18:37:21,333 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2022-03-01 18:37:21,413 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2022-03-01 18:37:21,413 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2022-03-01 18:37:21,570 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2022-03-01 18:37:21,571 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 7216 2022-03-01 18:37:21,571 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2022-03-01 18:37:21,651 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2022-03-01 18:37:21,651 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2022-03-01 18:37:21,810 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2022-03-01 18:37:21,811 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 7216 2022-03-01 18:37:21,811 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2022-03-01 18:37:21,891 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2022-03-01 18:37:21,892 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2022-03-01 18:37:22,048 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2022-03-01 18:37:22,049 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 7216 2022-03-01 18:37:22,049 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2022-03-01 18:37:22,128 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2022-03-01 18:37:22,129 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2022-03-01 18:37:28,276 (natcap.invest.seasonal_water_yield.seasonal_water_yield_core) Task._call(1093) INFO peak point detection 0.07% complete 2022-03-01 18:37:35,290 (natcap.invest.seasonal_water_yield.seasonal_water_yield_core) Task._call(1093) INFO peak point detection 54.01% complete 2022-03-01 18:37:41,208 (natcap.invest.seasonal_water_yield.seasonal_water_yield_core) Task._call(1093) INFO peak point detection 54.09% complete 2022-03-01 18:37:47,074 (natcap.invest.seasonal_water_yield.seasonal_water_yield_core) Task._call(1093) INFO peak point detection 81.07% complete 2022-03-01 18:37:47,770 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2022-03-01 18:37:47,771 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 7216 2022-03-01 18:37:47,771 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2022-03-01 18:37:47,830 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2022-03-01 18:37:47,830 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2022-03-01 18:37:47,831 (pygeoprocessing.geoprocessing_core) threading.run(870) WARNING No valid pixels were received, sending None. 2022-03-01 18:37:53,753 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(824) INFO 1 of 1 aligned: clipped_raster.tif 2022-03-01 18:37:53,753 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(828) INFO aligned all 1 rasters. 2022-03-01 18:37:54,021 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1275) INFO build a lookup of aggregate field value to FID 2022-03-01 18:37:54,227 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1282) INFO creating disjoint polygon set 2022-03-01 18:37:54,233 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2257) INFO build shapely polygon list 2022-03-01 18:37:54,784 (taskgraph.Task) Task.add_task(706) ERROR Something went wrong when adding task aggregate recharge (42), terminating taskgraph. Traceback (most recent call last): File "taskgraph\Task.py", line 674, in add_task File "taskgraph\Task.py", line 1093, in _call File "natcap\invest\seasonal_water_yield\seasonal_water_yield.py", line 1179, in _aggregate_recharge File "pygeoprocessing\geoprocessing.py", line 1283, in zonal_statistics File "pygeoprocessing\geoprocessing.py", line 2270, in calculate_disjoint_polygon_set File "logging\__init__.py", line 1461, in warn DeprecationWarning: The 'warn' method is deprecated, use 'warning' instead 2022-03-01 18:37:54,791 (natcap.invest.utils) utils.prepare_workspace(167) ERROR Exception while executing Seasonal-Water-Yield Traceback (most recent call last): File "natcap\invest\utils.py", line 165, in prepare_workspace File "natcap\invest\ui\model.py", line 1649, in _logged_target File "natcap\invest\seasonal_water_yield\seasonal_water_yield.py", line 403, in execute File "natcap\invest\seasonal_water_yield\seasonal_water_yield.py", line 768, in _execute File "taskgraph\Task.py", line 674, in add_task File "taskgraph\Task.py", line 1093, in _call File "natcap\invest\seasonal_water_yield\seasonal_water_yield.py", line 1179, in _aggregate_recharge File "pygeoprocessing\geoprocessing.py", line 1283, in zonal_statistics File "pygeoprocessing\geoprocessing.py", line 2270, in calculate_disjoint_polygon_set File "logging\__init__.py", line 1461, in warn DeprecationWarning: The 'warn' method is deprecated, use 'warning' instead 2022-03-01 18:37:54,793 (natcap.invest.utils) utils.prepare_workspace(170) INFO Elapsed time: 39m 41.289999999999964s 2022-03-01 18:37:54,794 (natcap.invest.utils) utils.prepare_workspace(173) INFO Execution finished