2020-11-18 17:31:09,177 utils.prepare_workspace(111) INFO Writing log messages to D:/SAO_PAULO/InVEST_SWY/teste_bauru8\InVEST-Seasonal-Water-Yield-log-2020-11-18--17_31_09.txt 2020-11-18 17:31:09,178 model._logged_target(1626) Level 100 Starting model with parameters: Arguments for InVEST natcap.invest.seasonal_water_yield.seasonal_water_yield 3.8.9: alpha_m 1/12 aoi_path D:/SAO_PAULO/sub_bacias_bauru/sb_teste.shp beta_i 0.2 biophysical_table_path D:\SAO_PAULO\InVEST_SWY\tabelas_SWY\biophysical_table_season_water_yield_sao_paulo_v1b.csv dem_raster_path D:\SAO_PAULO\ALOS_PALSAR\Mosaico_AP_RTC_HI-RES_12m\Mosaico_AP_RTC_HI-RES.tif et0_dir D:\SAO_PAULO\evapotransp_bauru_utm gamma 1 lulc_raster_path D:\SAO_PAULO\uso_terra_bauru\Uso_Bauru_MB2019_utm.tif monthly_alpha True monthly_alpha_path D:\SAO_PAULO\InVEST_SWY\tabelas_SWY\alpha_Medio_Tiete.csv n_workers -1 precip_dir D:\SAO_PAULO\chuva_bauru_utm rain_events_table_path D:\SAO_PAULO\InVEST_SWY\tabelas_SWY\rain_events_table_bauru.csv results_suffix b8 soil_group_path D:\SAO_PAULO\solos_bauru\GHS_Solos_Bauru.tif threshold_flow_accumulation 1000 user_defined_climate_zones False user_defined_local_recharge False workspace_dir D:/SAO_PAULO/InVEST_SWY/teste_bauru8 2020-11-18 17:31:09,196 seasonal_water_yield._execute(391) INFO prepare and test inputs for common errors 2020-11-18 17:31:09,659 seasonal_water_yield._execute(457) INFO Building file registry 2020-11-18 17:31:09,660 seasonal_water_yield._execute(463) INFO Checking that the AOI is not the output aggregate vector 2020-11-18 17:31:09,660 seasonal_water_yield._execute(472) INFO Aligning and clipping dataset list 2020-11-18 17:31:10,050 geoprocessing.align_and_resize_raster_stack(752) INFO 1 of 27 aligned: prcp_a0_b8.tif 2020-11-18 17:31:10,352 geoprocessing.align_and_resize_raster_stack(752) INFO 2 of 27 aligned: prcp_a1_b8.tif 2020-11-18 17:31:10,651 geoprocessing.align_and_resize_raster_stack(752) INFO 3 of 27 aligned: prcp_a2_b8.tif 2020-11-18 17:31:10,948 geoprocessing.align_and_resize_raster_stack(752) INFO 4 of 27 aligned: prcp_a3_b8.tif 2020-11-18 17:31:11,250 geoprocessing.align_and_resize_raster_stack(752) INFO 5 of 27 aligned: prcp_a4_b8.tif 2020-11-18 17:31:11,547 geoprocessing.align_and_resize_raster_stack(752) INFO 6 of 27 aligned: prcp_a5_b8.tif 2020-11-18 17:31:11,851 geoprocessing.align_and_resize_raster_stack(752) INFO 7 of 27 aligned: prcp_a6_b8.tif 2020-11-18 17:31:12,153 geoprocessing.align_and_resize_raster_stack(752) INFO 8 of 27 aligned: prcp_a7_b8.tif 2020-11-18 17:31:12,454 geoprocessing.align_and_resize_raster_stack(752) INFO 9 of 27 aligned: prcp_a8_b8.tif 2020-11-18 17:31:12,753 geoprocessing.align_and_resize_raster_stack(752) INFO 10 of 27 aligned: prcp_a9_b8.tif 2020-11-18 17:31:13,054 geoprocessing.align_and_resize_raster_stack(752) INFO 11 of 27 aligned: prcp_a10_b8.tif 2020-11-18 17:31:13,353 geoprocessing.align_and_resize_raster_stack(752) INFO 12 of 27 aligned: prcp_a11_b8.tif 2020-11-18 17:31:13,552 geoprocessing.align_and_resize_raster_stack(752) INFO 13 of 27 aligned: soil_group_aligned_b8.tif 2020-11-18 17:31:13,773 geoprocessing.align_and_resize_raster_stack(752) INFO 14 of 27 aligned: et0_a0_b8.tif 2020-11-18 17:31:14,000 geoprocessing.align_and_resize_raster_stack(752) INFO 15 of 27 aligned: et0_a1_b8.tif 2020-11-18 17:31:14,218 geoprocessing.align_and_resize_raster_stack(752) INFO 16 of 27 aligned: et0_a2_b8.tif 2020-11-18 17:31:14,439 geoprocessing.align_and_resize_raster_stack(752) INFO 17 of 27 aligned: et0_a3_b8.tif 2020-11-18 17:31:14,658 geoprocessing.align_and_resize_raster_stack(752) INFO 18 of 27 aligned: et0_a4_b8.tif 2020-11-18 17:31:14,876 geoprocessing.align_and_resize_raster_stack(752) INFO 19 of 27 aligned: et0_a5_b8.tif 2020-11-18 17:31:15,107 geoprocessing.align_and_resize_raster_stack(752) INFO 20 of 27 aligned: et0_a6_b8.tif 2020-11-18 17:31:15,327 geoprocessing.align_and_resize_raster_stack(752) INFO 21 of 27 aligned: et0_a7_b8.tif 2020-11-18 17:31:15,550 geoprocessing.align_and_resize_raster_stack(752) INFO 22 of 27 aligned: et0_a8_b8.tif 2020-11-18 17:31:15,771 geoprocessing.align_and_resize_raster_stack(752) INFO 23 of 27 aligned: et0_a9_b8.tif 2020-11-18 17:31:15,996 geoprocessing.align_and_resize_raster_stack(752) INFO 24 of 27 aligned: et0_a10_b8.tif 2020-11-18 17:31:16,219 geoprocessing.align_and_resize_raster_stack(752) INFO 25 of 27 aligned: et0_a11_b8.tif 2020-11-18 17:31:16,431 geoprocessing.align_and_resize_raster_stack(752) INFO 26 of 27 aligned: lulc_aligned_b8.tif 2020-11-18 17:31:16,858 geoprocessing.align_and_resize_raster_stack(752) INFO 27 of 27 aligned: dem_aligned_b8.tif 2020-11-18 17:31:16,858 geoprocessing.align_and_resize_raster_stack(754) INFO aligned all 27 rasters. 2020-11-18 17:31:23,019 Task._call(1174) INFO 47.0% complete 2020-11-18 17:31:28,572 Task._call(1174) INFO 100.0% complete 2020-11-18 17:31:34,078 Task._call(1174) INFO 31.4% complete 2020-11-18 17:31:40,030 Task._call(1174) INFO 78.4% complete 2020-11-18 17:31:42,802 Task._call(1174) INFO 100.0% complete 2020-11-18 17:31:42,953 Task._call(1174) DEBUG creating target flow accum raster layer 2020-11-18 17:31:43,328 Task._call(1174) DEBUG creating visited raster layer 2020-11-18 17:31:43,337 Task._call(1174) DEBUG starting search 2020-11-18 17:31:48,004 Task._call(1174) INFO mfd flow accum 53.1% complete 2020-11-18 17:31:53,737 Task._call(1174) INFO 100.0% complete 2020-11-18 17:31:58,984 Task._call(1174) INFO filter out incomplete divergent streams 2020-11-18 17:31:59,050 Task._call(1174) INFO 100.0% complete 2020-11-18 17:31:59,208 seasonal_water_yield._execute(574) INFO quick flow 2020-11-18 17:31:59,208 seasonal_water_yield._execute(588) INFO loading number of monthly events 2020-11-18 17:32:02,596 geoprocessing.raster_calculator(375) INFO starting stats_worker 2020-11-18 17:32:02,597 geoprocessing.raster_calculator(381) INFO started stats_worker 2020-11-18 17:32:02,989 geoprocessing.raster_calculator(454) INFO 100.0%% complete 2020-11-18 17:32:02,989 geoprocessing.raster_calculator(457) INFO signaling stats worker to terminate 2020-11-18 17:32:02,989 geoprocessing.raster_calculator(459) INFO Waiting for raster stats worker result. 2020-11-18 17:32:02,991 threading.run(870) DEBUG payload is None, terminating 2020-11-18 17:32:03,299 geoprocessing.raster_calculator(375) INFO starting stats_worker 2020-11-18 17:32:03,300 geoprocessing.raster_calculator(381) INFO started stats_worker 2020-11-18 17:32:03,560 geoprocessing.raster_calculator(454) INFO 100.0%% complete 2020-11-18 17:32:03,561 geoprocessing.raster_calculator(457) INFO signaling stats worker to terminate 2020-11-18 17:32:03,561 geoprocessing.raster_calculator(459) INFO Waiting for raster stats worker result. 2020-11-18 17:32:03,562 threading.run(870) DEBUG payload is None, terminating 2020-11-18 17:32:03,914 seasonal_water_yield._execute(653) INFO calculate quick flow for month 1 2020-11-18 17:32:03,959 geoprocessing.raster_calculator(375) INFO starting stats_worker 2020-11-18 17:32:03,960 geoprocessing.raster_calculator(381) INFO started stats_worker 2020-11-18 17:32:06,111 geoprocessing.raster_calculator(454) INFO 100.0%% complete 2020-11-18 17:32:06,112 geoprocessing.raster_calculator(457) INFO signaling stats worker to terminate 2020-11-18 17:32:06,112 geoprocessing.raster_calculator(459) INFO Waiting for raster stats worker result. 2020-11-18 17:32:06,113 threading.run(870) DEBUG payload is None, terminating 2020-11-18 17:32:06,405 seasonal_water_yield._execute(653) INFO calculate quick flow for month 2 2020-11-18 17:32:06,433 geoprocessing.raster_calculator(375) INFO starting stats_worker 2020-11-18 17:32:06,433 geoprocessing.raster_calculator(381) INFO started stats_worker 2020-11-18 17:32:08,453 geoprocessing.raster_calculator(454) INFO 100.0%% complete 2020-11-18 17:32:08,453 geoprocessing.raster_calculator(457) INFO signaling stats worker to terminate 2020-11-18 17:32:08,453 geoprocessing.raster_calculator(459) INFO Waiting for raster stats worker result. 2020-11-18 17:32:08,454 threading.run(870) DEBUG payload is None, terminating 2020-11-18 17:32:08,757 seasonal_water_yield._execute(653) INFO calculate quick flow for month 3 2020-11-18 17:32:08,789 geoprocessing.raster_calculator(375) INFO starting stats_worker 2020-11-18 17:32:08,789 geoprocessing.raster_calculator(381) INFO started stats_worker 2020-11-18 17:32:10,916 geoprocessing.raster_calculator(454) INFO 100.0%% complete 2020-11-18 17:32:10,917 geoprocessing.raster_calculator(457) INFO signaling stats worker to terminate 2020-11-18 17:32:10,917 geoprocessing.raster_calculator(459) INFO Waiting for raster stats worker result. 2020-11-18 17:32:10,917 threading.run(870) DEBUG payload is None, terminating 2020-11-18 17:32:11,197 seasonal_water_yield._execute(653) INFO calculate quick flow for month 4 2020-11-18 17:32:11,228 geoprocessing.raster_calculator(375) INFO starting stats_worker 2020-11-18 17:32:11,229 geoprocessing.raster_calculator(381) INFO started stats_worker 2020-11-18 17:32:13,193 geoprocessing.raster_calculator(454) INFO 100.0%% complete 2020-11-18 17:32:13,193 geoprocessing.raster_calculator(457) INFO signaling stats worker to terminate 2020-11-18 17:32:13,193 geoprocessing.raster_calculator(459) INFO Waiting for raster stats worker result. 2020-11-18 17:32:13,193 threading.run(870) DEBUG payload is None, terminating 2020-11-18 17:32:13,460 seasonal_water_yield._execute(653) INFO calculate quick flow for month 5 2020-11-18 17:32:13,489 geoprocessing.raster_calculator(375) INFO starting stats_worker 2020-11-18 17:32:13,489 geoprocessing.raster_calculator(381) INFO started stats_worker 2020-11-18 17:32:15,373 geoprocessing.raster_calculator(454) INFO 100.0%% complete 2020-11-18 17:32:15,373 geoprocessing.raster_calculator(457) INFO signaling stats worker to terminate 2020-11-18 17:32:15,373 geoprocessing.raster_calculator(459) INFO Waiting for raster stats worker result. 2020-11-18 17:32:15,374 threading.run(870) DEBUG payload is None, terminating 2020-11-18 17:32:15,660 seasonal_water_yield._execute(653) INFO calculate quick flow for month 6 2020-11-18 17:32:15,688 geoprocessing.raster_calculator(375) INFO starting stats_worker 2020-11-18 17:32:15,688 geoprocessing.raster_calculator(381) INFO started stats_worker 2020-11-18 17:32:17,854 geoprocessing.raster_calculator(454) INFO 100.0%% complete 2020-11-18 17:32:17,854 geoprocessing.raster_calculator(457) INFO signaling stats worker to terminate 2020-11-18 17:32:17,854 geoprocessing.raster_calculator(459) INFO Waiting for raster stats worker result. 2020-11-18 17:32:17,856 threading.run(870) DEBUG payload is None, terminating 2020-11-18 17:32:18,143 seasonal_water_yield._execute(653) INFO calculate quick flow for month 7 2020-11-18 17:32:18,171 geoprocessing.raster_calculator(375) INFO starting stats_worker 2020-11-18 17:32:18,172 geoprocessing.raster_calculator(381) INFO started stats_worker 2020-11-18 17:32:20,204 geoprocessing.raster_calculator(454) INFO 100.0%% complete 2020-11-18 17:32:20,205 geoprocessing.raster_calculator(457) INFO signaling stats worker to terminate 2020-11-18 17:32:20,205 threading.run(870) DEBUG payload is None, terminating 2020-11-18 17:32:20,205 geoprocessing.raster_calculator(459) INFO Waiting for raster stats worker result. 2020-11-18 17:32:20,523 seasonal_water_yield._execute(653) INFO calculate quick flow for month 8 2020-11-18 17:32:20,551 geoprocessing.raster_calculator(375) INFO starting stats_worker 2020-11-18 17:32:20,552 geoprocessing.raster_calculator(381) INFO started stats_worker 2020-11-18 17:32:22,439 geoprocessing.raster_calculator(454) INFO 100.0%% complete 2020-11-18 17:32:22,440 geoprocessing.raster_calculator(457) INFO signaling stats worker to terminate 2020-11-18 17:32:22,440 geoprocessing.raster_calculator(459) INFO Waiting for raster stats worker result. 2020-11-18 17:32:22,440 threading.run(870) DEBUG payload is None, terminating 2020-11-18 17:32:22,738 seasonal_water_yield._execute(653) INFO calculate quick flow for month 9 2020-11-18 17:32:22,774 geoprocessing.raster_calculator(375) INFO starting stats_worker 2020-11-18 17:32:22,775 geoprocessing.raster_calculator(381) INFO started stats_worker 2020-11-18 17:32:24,668 geoprocessing.raster_calculator(454) INFO 100.0%% complete 2020-11-18 17:32:24,668 geoprocessing.raster_calculator(457) INFO signaling stats worker to terminate 2020-11-18 17:32:24,669 geoprocessing.raster_calculator(459) INFO Waiting for raster stats worker result. 2020-11-18 17:32:24,669 threading.run(870) DEBUG payload is None, terminating 2020-11-18 17:32:24,930 seasonal_water_yield._execute(653) INFO calculate quick flow for month 10 2020-11-18 17:32:24,958 geoprocessing.raster_calculator(375) INFO starting stats_worker 2020-11-18 17:32:24,959 geoprocessing.raster_calculator(381) INFO started stats_worker 2020-11-18 17:32:27,162 geoprocessing.raster_calculator(454) INFO 100.0%% complete 2020-11-18 17:32:27,162 geoprocessing.raster_calculator(457) INFO signaling stats worker to terminate 2020-11-18 17:32:27,162 geoprocessing.raster_calculator(459) INFO Waiting for raster stats worker result. 2020-11-18 17:32:27,163 threading.run(870) DEBUG payload is None, terminating 2020-11-18 17:32:27,453 seasonal_water_yield._execute(653) INFO calculate quick flow for month 11 2020-11-18 17:32:27,496 geoprocessing.raster_calculator(375) INFO starting stats_worker 2020-11-18 17:32:27,497 geoprocessing.raster_calculator(381) INFO started stats_worker 2020-11-18 17:32:29,466 geoprocessing.raster_calculator(454) INFO 100.0%% complete 2020-11-18 17:32:29,467 geoprocessing.raster_calculator(457) INFO signaling stats worker to terminate 2020-11-18 17:32:29,467 geoprocessing.raster_calculator(459) INFO Waiting for raster stats worker result. 2020-11-18 17:32:29,468 threading.run(870) DEBUG payload is None, terminating 2020-11-18 17:32:29,762 seasonal_water_yield._execute(653) INFO calculate quick flow for month 12 2020-11-18 17:32:29,806 geoprocessing.raster_calculator(375) INFO starting stats_worker 2020-11-18 17:32:29,806 geoprocessing.raster_calculator(381) INFO started stats_worker 2020-11-18 17:32:31,860 geoprocessing.raster_calculator(454) INFO 100.0%% complete 2020-11-18 17:32:31,860 geoprocessing.raster_calculator(457) INFO signaling stats worker to terminate 2020-11-18 17:32:31,860 geoprocessing.raster_calculator(459) INFO Waiting for raster stats worker result. 2020-11-18 17:32:31,861 threading.run(870) DEBUG payload is None, terminating 2020-11-18 17:32:32,173 geoprocessing.raster_calculator(375) INFO starting stats_worker 2020-11-18 17:32:32,174 geoprocessing.raster_calculator(381) INFO started stats_worker 2020-11-18 17:32:33,488 geoprocessing.raster_calculator(454) INFO 100.0%% complete 2020-11-18 17:32:33,488 geoprocessing.raster_calculator(457) INFO signaling stats worker to terminate 2020-11-18 17:32:33,489 geoprocessing.raster_calculator(459) INFO Waiting for raster stats worker result. 2020-11-18 17:32:33,489 threading.run(870) DEBUG payload is None, terminating 2020-11-18 17:32:33,716 seasonal_water_yield._execute(681) INFO calculate local recharge 2020-11-18 17:32:33,726 geoprocessing.raster_calculator(375) INFO starting stats_worker 2020-11-18 17:32:33,726 geoprocessing.raster_calculator(381) INFO started stats_worker 2020-11-18 17:32:33,989 geoprocessing.raster_calculator(454) INFO 100.0%% complete 2020-11-18 17:32:33,989 geoprocessing.raster_calculator(457) INFO signaling stats worker to terminate 2020-11-18 17:32:33,990 geoprocessing.raster_calculator(459) INFO Waiting for raster stats worker result. 2020-11-18 17:32:33,991 threading.run(870) DEBUG payload is None, terminating 2020-11-18 17:32:34,311 geoprocessing.raster_calculator(375) INFO starting stats_worker 2020-11-18 17:32:34,312 geoprocessing.raster_calculator(381) INFO started stats_worker 2020-11-18 17:32:34,573 geoprocessing.raster_calculator(454) INFO 100.0%% complete 2020-11-18 17:32:34,573 geoprocessing.raster_calculator(457) INFO signaling stats worker to terminate 2020-11-18 17:32:34,573 geoprocessing.raster_calculator(459) INFO Waiting for raster stats worker result. 2020-11-18 17:32:34,574 threading.run(870) DEBUG payload is None, terminating 2020-11-18 17:32:34,937 geoprocessing.raster_calculator(375) INFO starting stats_worker 2020-11-18 17:32:34,937 geoprocessing.raster_calculator(381) INFO started stats_worker 2020-11-18 17:32:35,218 geoprocessing.raster_calculator(454) INFO 100.0%% complete 2020-11-18 17:32:35,219 geoprocessing.raster_calculator(457) INFO signaling stats worker to terminate 2020-11-18 17:32:35,219 geoprocessing.raster_calculator(459) INFO Waiting for raster stats worker result. 2020-11-18 17:32:35,219 threading.run(870) DEBUG payload is None, terminating 2020-11-18 17:32:35,647 geoprocessing.raster_calculator(375) INFO starting stats_worker 2020-11-18 17:32:35,647 geoprocessing.raster_calculator(381) INFO started stats_worker 2020-11-18 17:32:35,910 geoprocessing.raster_calculator(454) INFO 100.0%% complete 2020-11-18 17:32:35,910 geoprocessing.raster_calculator(457) INFO signaling stats worker to terminate 2020-11-18 17:32:35,910 geoprocessing.raster_calculator(459) INFO Waiting for raster stats worker result. 2020-11-18 17:32:35,912 threading.run(870) DEBUG payload is None, terminating 2020-11-18 17:32:36,310 geoprocessing.raster_calculator(375) INFO starting stats_worker 2020-11-18 17:32:36,312 geoprocessing.raster_calculator(381) INFO started stats_worker 2020-11-18 17:32:36,579 geoprocessing.raster_calculator(454) INFO 100.0%% complete 2020-11-18 17:32:36,579 geoprocessing.raster_calculator(457) INFO signaling stats worker to terminate 2020-11-18 17:32:36,579 geoprocessing.raster_calculator(459) INFO Waiting for raster stats worker result. 2020-11-18 17:32:36,579 threading.run(870) DEBUG payload is None, terminating 2020-11-18 17:32:36,946 geoprocessing.raster_calculator(375) INFO starting stats_worker 2020-11-18 17:32:36,946 geoprocessing.raster_calculator(381) INFO started stats_worker 2020-11-18 17:32:37,209 geoprocessing.raster_calculator(454) INFO 100.0%% complete 2020-11-18 17:32:37,209 geoprocessing.raster_calculator(457) INFO signaling stats worker to terminate 2020-11-18 17:32:37,210 geoprocessing.raster_calculator(459) INFO Waiting for raster stats worker result. 2020-11-18 17:32:37,211 threading.run(870) DEBUG payload is None, terminating 2020-11-18 17:32:37,591 geoprocessing.raster_calculator(375) INFO starting stats_worker 2020-11-18 17:32:37,591 geoprocessing.raster_calculator(381) INFO started stats_worker 2020-11-18 17:32:37,853 geoprocessing.raster_calculator(454) INFO 100.0%% complete 2020-11-18 17:32:37,853 geoprocessing.raster_calculator(457) INFO signaling stats worker to terminate 2020-11-18 17:32:37,854 geoprocessing.raster_calculator(459) INFO Waiting for raster stats worker result. 2020-11-18 17:32:37,854 threading.run(870) DEBUG payload is None, terminating 2020-11-18 17:32:38,229 geoprocessing.raster_calculator(375) INFO starting stats_worker 2020-11-18 17:32:38,230 geoprocessing.raster_calculator(381) INFO started stats_worker 2020-11-18 17:32:38,493 geoprocessing.raster_calculator(454) INFO 100.0%% complete 2020-11-18 17:32:38,493 geoprocessing.raster_calculator(457) INFO signaling stats worker to terminate 2020-11-18 17:32:38,493 geoprocessing.raster_calculator(459) INFO Waiting for raster stats worker result. 2020-11-18 17:32:38,493 threading.run(870) DEBUG payload is None, terminating 2020-11-18 17:32:38,871 geoprocessing.raster_calculator(375) INFO starting stats_worker 2020-11-18 17:32:38,872 geoprocessing.raster_calculator(381) INFO started stats_worker 2020-11-18 17:32:39,139 geoprocessing.raster_calculator(454) INFO 100.0%% complete 2020-11-18 17:32:39,139 geoprocessing.raster_calculator(457) INFO signaling stats worker to terminate 2020-11-18 17:32:39,139 geoprocessing.raster_calculator(459) INFO Waiting for raster stats worker result. 2020-11-18 17:32:39,140 threading.run(870) DEBUG payload is None, terminating 2020-11-18 17:32:39,485 geoprocessing.raster_calculator(375) INFO starting stats_worker 2020-11-18 17:32:39,485 geoprocessing.raster_calculator(381) INFO started stats_worker 2020-11-18 17:32:39,746 geoprocessing.raster_calculator(454) INFO 100.0%% complete 2020-11-18 17:32:39,747 geoprocessing.raster_calculator(457) INFO signaling stats worker to terminate 2020-11-18 17:32:39,747 geoprocessing.raster_calculator(459) INFO Waiting for raster stats worker result. 2020-11-18 17:32:39,748 threading.run(870) DEBUG payload is None, terminating 2020-11-18 17:32:40,153 geoprocessing.raster_calculator(375) INFO starting stats_worker 2020-11-18 17:32:40,154 geoprocessing.raster_calculator(381) INFO started stats_worker 2020-11-18 17:32:40,418 geoprocessing.raster_calculator(454) INFO 100.0%% complete 2020-11-18 17:32:40,418 geoprocessing.raster_calculator(457) INFO signaling stats worker to terminate 2020-11-18 17:32:40,418 geoprocessing.raster_calculator(459) INFO Waiting for raster stats worker result. 2020-11-18 17:32:40,419 threading.run(870) DEBUG payload is None, terminating 2020-11-18 17:32:40,827 geoprocessing.raster_calculator(375) INFO starting stats_worker 2020-11-18 17:32:40,828 geoprocessing.raster_calculator(381) INFO started stats_worker 2020-11-18 17:32:41,091 geoprocessing.raster_calculator(454) INFO 100.0%% complete 2020-11-18 17:32:41,091 geoprocessing.raster_calculator(457) INFO signaling stats worker to terminate 2020-11-18 17:32:41,091 geoprocessing.raster_calculator(459) INFO Waiting for raster stats worker result. 2020-11-18 17:32:41,092 threading.run(870) DEBUG payload is None, terminating 2020-11-18 17:32:47,149 Task._call(1174) INFO peak point detection 7.84% complete 2020-11-18 17:32:53,495 Task._call(1174) INFO peak point detection 15.68% complete 2020-11-18 17:32:59,047 Task._call(1174) INFO peak point detection 23.52% complete 2020-11-18 17:33:05,365 Task._call(1174) INFO peak point detection 31.35% complete 2020-11-18 17:33:11,006 Task._call(1174) INFO peak point detection 39.18% complete 2020-11-18 17:33:17,031 Task._call(1174) INFO peak point detection 47.02% complete 2020-11-18 17:33:23,504 Task._call(1174) INFO peak point detection 54.85% complete 2020-11-18 17:33:29,606 Task._call(1174) INFO peak point detection 62.69% complete 2020-11-18 17:33:35,016 Task._call(1174) INFO peak point detection 62.72% complete 2020-11-18 17:33:41,295 Task._call(1174) INFO peak point detection 70.55% complete 2020-11-18 17:33:47,111 Task._call(1174) INFO peak point detection 78.38% complete 2020-11-18 17:33:53,439 Task._call(1174) INFO peak point detection 86.22% complete 2020-11-18 17:33:59,041 Task._call(1174) INFO peak point detection 94.05% complete 2020-11-18 17:34:05,362 Task._call(1174) INFO peak point detection 94.06% complete 2020-11-18 17:34:07,245 geoprocessing.raster_calculator(375) INFO starting stats_worker 2020-11-18 17:34:07,246 geoprocessing.raster_calculator(381) INFO started stats_worker 2020-11-18 17:34:07,632 geoprocessing.raster_calculator(454) INFO 100.0%% complete 2020-11-18 17:34:07,632 geoprocessing.raster_calculator(457) INFO signaling stats worker to terminate 2020-11-18 17:34:07,632 geoprocessing.raster_calculator(459) INFO Waiting for raster stats worker result. 2020-11-18 17:34:07,633 threading.run(870) DEBUG payload is None, terminating 2020-11-18 17:34:08,516 geoprocessing.zonal_statistics(1129) DEBUG > 2020-11-18 17:34:09,531 geoprocessing.align_and_resize_raster_stack(752) INFO 1 of 1 aligned: clipped_rasterf_d7bky7.tif 2020-11-18 17:34:09,531 geoprocessing.align_and_resize_raster_stack(754) INFO aligned all 1 rasters. 2020-11-18 17:34:09,545 geoprocessing.zonal_statistics(1189) INFO build a lookup of aggregate field value to FID 2020-11-18 17:34:09,545 geoprocessing.zonal_statistics(1196) INFO creating disjoint polygon set 2020-11-18 17:34:09,546 geoprocessing.calculate_disjoint_polygon_set(2082) INFO build shapely polygon list 2020-11-18 17:34:09,564 geoprocessing.calculate_disjoint_polygon_set(2096) INFO build shapely rtree index 2020-11-18 17:34:09,565 geoprocessing.calculate_disjoint_polygon_set(2111) INFO poly feature lookup 100.0% complete on aggregated_results_swy_b8.shp 2020-11-18 17:34:09,565 geoprocessing.calculate_disjoint_polygon_set(2113) INFO build poly intersection lookup 2020-11-18 17:34:09,578 geoprocessing.calculate_disjoint_polygon_set(2137) INFO poly intersection feature lookup 100.0% complete on aggregated_results_swy_b8.shp 2020-11-18 17:34:09,578 geoprocessing.calculate_disjoint_polygon_set(2171) INFO maximal subset build 100.0% complete on aggregated_results_swy_b8.shp 2020-11-18 17:34:09,592 geoprocessing.zonal_statistics(1219) INFO processing 3 disjoint polygon sets 2020-11-18 17:34:09,592 geoprocessing.zonal_statistics(1253) INFO disjoint polygon set 1 of 3 100.0% processed on aggregated_results_swy_b8.shp 2020-11-18 17:34:09,595 geoprocessing.zonal_statistics(1261) INFO rasterizing disjoint polygon set 1 of 3 aggregated_results_swy_b8.shp 2020-11-18 17:34:09,785 geoprocessing.zonal_statistics(1279) INFO summarizing rasterized disjoint polygon set 1 of 3 aggregated_results_swy_b8.shp 2020-11-18 17:34:10,091 geoprocessing.zonal_statistics(1253) INFO disjoint polygon set 2 of 3 100.0% processed on aggregated_results_swy_b8.shp 2020-11-18 17:34:10,093 geoprocessing.zonal_statistics(1261) INFO rasterizing disjoint polygon set 2 of 3 aggregated_results_swy_b8.shp 2020-11-18 17:34:10,351 geoprocessing.zonal_statistics(1279) INFO summarizing rasterized disjoint polygon set 2 of 3 aggregated_results_swy_b8.shp 2020-11-18 17:34:10,614 geoprocessing.zonal_statistics(1253) INFO disjoint polygon set 3 of 3 100.0% processed on aggregated_results_swy_b8.shp 2020-11-18 17:34:10,617 geoprocessing.zonal_statistics(1261) INFO rasterizing disjoint polygon set 3 of 3 aggregated_results_swy_b8.shp 2020-11-18 17:34:10,850 geoprocessing.zonal_statistics(1279) INFO summarizing rasterized disjoint polygon set 3 of 3 aggregated_results_swy_b8.shp 2020-11-18 17:34:11,108 geoprocessing.zonal_statistics(1322) DEBUG unset_fids: 0 of 3 2020-11-18 17:34:11,110 geoprocessing.zonal_statistics(1325) DEBUG gt [ 7.6836975e+05 1.2500000e+01 0.0000000e+00 7.4947370e+06 0.0000000e+00 -1.2500000e+01] for ('D:/SAO_PAULO/InVEST_SWY/teste_bauru8\\L_b8.tif', 1) 2020-11-18 17:34:11,110 geoprocessing.zonal_statistics(1399) DEBUG remaining unset_fids: 0 of 3 2020-11-18 17:34:11,110 geoprocessing.zonal_statistics(1407) INFO all done processing polygon sets for aggregated_results_swy_b8.shp 2020-11-18 17:34:11,140 geoprocessing.zonal_statistics(1129) DEBUG > 2020-11-18 17:34:12,106 geoprocessing.align_and_resize_raster_stack(752) INFO 1 of 1 aligned: clipped_rasterlrtvr55h.tif 2020-11-18 17:34:12,106 geoprocessing.align_and_resize_raster_stack(754) INFO aligned all 1 rasters. 2020-11-18 17:34:12,120 geoprocessing.zonal_statistics(1189) INFO build a lookup of aggregate field value to FID 2020-11-18 17:34:12,120 geoprocessing.zonal_statistics(1196) INFO creating disjoint polygon set 2020-11-18 17:34:12,120 geoprocessing.calculate_disjoint_polygon_set(2082) INFO build shapely polygon list 2020-11-18 17:34:12,138 geoprocessing.calculate_disjoint_polygon_set(2096) INFO build shapely rtree index 2020-11-18 17:34:12,139 geoprocessing.calculate_disjoint_polygon_set(2111) INFO poly feature lookup 100.0% complete on aggregated_results_swy_b8.shp 2020-11-18 17:34:12,139 geoprocessing.calculate_disjoint_polygon_set(2113) INFO build poly intersection lookup 2020-11-18 17:34:12,152 geoprocessing.calculate_disjoint_polygon_set(2137) INFO poly intersection feature lookup 100.0% complete on aggregated_results_swy_b8.shp 2020-11-18 17:34:12,152 geoprocessing.calculate_disjoint_polygon_set(2171) INFO maximal subset build 100.0% complete on aggregated_results_swy_b8.shp 2020-11-18 17:34:12,165 geoprocessing.zonal_statistics(1219) INFO processing 3 disjoint polygon sets 2020-11-18 17:34:12,165 geoprocessing.zonal_statistics(1253) INFO disjoint polygon set 1 of 3 100.0% processed on aggregated_results_swy_b8.shp 2020-11-18 17:34:12,169 geoprocessing.zonal_statistics(1261) INFO rasterizing disjoint polygon set 1 of 3 aggregated_results_swy_b8.shp 2020-11-18 17:34:12,360 geoprocessing.zonal_statistics(1279) INFO summarizing rasterized disjoint polygon set 1 of 3 aggregated_results_swy_b8.shp 2020-11-18 17:34:12,669 geoprocessing.zonal_statistics(1253) INFO disjoint polygon set 2 of 3 100.0% processed on aggregated_results_swy_b8.shp 2020-11-18 17:34:12,672 geoprocessing.zonal_statistics(1261) INFO rasterizing disjoint polygon set 2 of 3 aggregated_results_swy_b8.shp 2020-11-18 17:34:12,926 geoprocessing.zonal_statistics(1279) INFO summarizing rasterized disjoint polygon set 2 of 3 aggregated_results_swy_b8.shp 2020-11-18 17:34:13,184 geoprocessing.zonal_statistics(1253) INFO disjoint polygon set 3 of 3 100.0% processed on aggregated_results_swy_b8.shp 2020-11-18 17:34:13,187 geoprocessing.zonal_statistics(1261) INFO rasterizing disjoint polygon set 3 of 3 aggregated_results_swy_b8.shp 2020-11-18 17:34:13,420 geoprocessing.zonal_statistics(1279) INFO summarizing rasterized disjoint polygon set 3 of 3 aggregated_results_swy_b8.shp 2020-11-18 17:34:13,679 geoprocessing.zonal_statistics(1322) DEBUG unset_fids: 0 of 3 2020-11-18 17:34:13,681 geoprocessing.zonal_statistics(1325) DEBUG gt [ 7.6836975e+05 1.2500000e+01 0.0000000e+00 7.4947370e+06 0.0000000e+00 -1.2500000e+01] for ('D:/SAO_PAULO/InVEST_SWY/teste_bauru8\\Vri_b8.tif', 1) 2020-11-18 17:34:13,682 geoprocessing.zonal_statistics(1399) DEBUG remaining unset_fids: 0 of 3 2020-11-18 17:34:13,682 geoprocessing.zonal_statistics(1407) INFO all done processing polygon sets for aggregated_results_swy_b8.shp 2020-11-18 17:34:13,848 seasonal_water_yield._execute(751) INFO calculate L_sum 2020-11-18 17:34:13,850 Task._call(1174) DEBUG creating target flow accum raster layer 2020-11-18 17:34:14,225 Task._call(1174) DEBUG creating visited raster layer 2020-11-18 17:34:14,234 Task._call(1174) DEBUG starting search 2020-11-18 17:34:19,000 Task._call(1174) INFO mfd flow accum 50.0% complete 2020-11-18 17:34:25,442 Task._call(1174) INFO 100.0% complete 2020-11-18 17:34:31,000 Task._call(1174) INFO route base flow 19.15% complete 2020-11-18 17:34:37,000 Task._call(1174) INFO route base flow 41.75% complete 2020-11-18 17:34:43,000 Task._call(1174) INFO route base flow 65.41% complete 2020-11-18 17:34:49,000 Task._call(1174) INFO route base flow 87.82% complete 2020-11-18 17:34:53,268 seasonal_water_yield._execute(787) INFO (\w/) SWY Complete! 2020-11-18 17:34:53,268 seasonal_water_yield._execute(788) INFO (.. \ 2020-11-18 17:34:53,268 seasonal_water_yield._execute(789) INFO _/ ) \______ 2020-11-18 17:34:53,268 seasonal_water_yield._execute(790) INFO (oo /'\ )`, 2020-11-18 17:34:53,268 seasonal_water_yield._execute(791) INFO `--' (v __( / || 2020-11-18 17:34:53,268 seasonal_water_yield._execute(792) INFO ||| ||| || 2020-11-18 17:34:53,268 seasonal_water_yield._execute(793) INFO //_| //_| 2020-11-18 17:34:53,269 model._logged_target(1635) INFO Execution finished 2020-11-18 17:34:53,271 utils.prepare_workspace(117) INFO Elapsed time: 3m 44.09s