2024-04-04 10:31:18,482 (natcap.invest.utils) utils.prepare_workspace(161) Level 100 Writing log messages to [C:\Creating_Watersheds_data\Creating_Watersheds_data\InVEST-natcap.invest.urban_flood_risk_mitigation-log-2024-04-04--10_31_18.txt] 2024-04-04 10:31:18,482 (__main__) cli.main(458) Level 100 Starting model with parameters: Arguments for InVEST natcap.invest.urban_flood_risk_mitigation 3.13.0: aoi_watersheds_path C:\Watersheds\study_area1.shp built_infrastructure_vector_path C:\Built infrastructure\city_polig_nuev_copia.shp curve_number_table_path C:\Users\dagc8\OneDrive\Escritorio\c_curve_number_table_path_csv_without_nodata_row.csv infrastructure_damage_loss_table_path C:\Users\dagc8\Downloads\Damage_table_cost_per_m2.csv lulc_path C:\ESA SOILS\ESA_LULC_10m1_sty_area.tif n_workers -1 rainfall_depth 1382 results_suffix urb soils_hydrological_group_raster_path C:\Watersheds\soil_10_new.tif workspace_dir C:\Creating_Watersheds_data\Creating_Watersheds_data 2024-04-04 10:31:18,482 (natcap.invest.validation) validation._wrapped_validate_func(1030) INFO Starting whole-model validation with MODEL_SPEC 2024-04-04 10:31:18,829 (taskgraph.Task) Task.is_precalculated(1252) INFO not precalculated (align raster stack (0)), Task hash exists, but there are these mismatches: Modified times don't match cached: (1704830670960432640.000000) actual: (1712217480833747456.000000) Modified times don't match cached: (1704830673275865344.000000) actual: (1712217483704460544.000000) 2024-04-04 10:31:19,500 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(996) INFO 1 of 2 aligned: aligned_lulc_urb.tif 2024-04-04 10:31:22,322 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(996) INFO 2 of 2 aligned: aligned_soils_hydrological_group_urb.tif 2024-04-04 10:31:22,322 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(1000) INFO aligned all 2 rasters. 2024-04-04 10:31:22,378 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(470) INFO starting stats_worker 2024-04-04 10:31:22,378 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(476) INFO started stats_worker 2024-04-04 10:31:24,727 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(555) INFO 100.0% complete 2024-04-04 10:31:24,727 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(558) INFO Waiting for raster stats worker result. 2024-04-04 10:31:25,308 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(470) INFO starting stats_worker 2024-04-04 10:31:25,316 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(476) INFO started stats_worker 2024-04-04 10:31:25,882 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(555) INFO 100.0% complete 2024-04-04 10:31:25,882 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(558) INFO Waiting for raster stats worker result. 2024-04-04 10:31:26,422 (osgeo) utils._log_gdal_errors(97) ERROR [errno 1] Deleting C:\Creating_Watersheds_data\Creating_Watersheds_data\Q_mm_urb.tif failed:Permission denied 2024-04-04 10:31:26,430 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(470) INFO starting stats_worker 2024-04-04 10:31:26,437 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(476) INFO started stats_worker 2024-04-04 10:31:27,036 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(555) INFO 100.0% complete 2024-04-04 10:31:27,044 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(558) INFO Waiting for raster stats worker result. 2024-04-04 10:31:27,561 (osgeo) utils._log_gdal_errors(97) ERROR [errno 1] Deleting C:\Creating_Watersheds_data\Creating_Watersheds_data\Runoff_retention_urb.tif failed:Permission denied 2024-04-04 10:31:27,569 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(470) INFO starting stats_worker 2024-04-04 10:31:27,569 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(476) INFO started stats_worker 2024-04-04 10:31:28,102 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(555) INFO 100.0% complete 2024-04-04 10:31:28,102 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(558) INFO Waiting for raster stats worker result. 2024-04-04 10:31:28,609 (osgeo) utils._log_gdal_errors(97) ERROR [errno 1] Deleting C:\Creating_Watersheds_data\Creating_Watersheds_data\Runoff_retention_m3_urb.tif failed:Permission denied 2024-04-04 10:31:28,621 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(470) INFO starting stats_worker 2024-04-04 10:31:28,621 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(476) INFO started stats_worker 2024-04-04 10:31:29,193 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(555) INFO 100.0% complete 2024-04-04 10:31:29,193 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(558) INFO Waiting for raster stats worker result. 2024-04-04 10:31:29,709 (osgeo) utils._log_gdal_errors(97) ERROR [errno 1] Deleting C:\Creating_Watersheds_data\Creating_Watersheds_data\intermediate_files\Q_m3_urb.tif failed:Permission denied 2024-04-04 10:31:29,722 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(470) INFO starting stats_worker 2024-04-04 10:31:29,722 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(476) INFO started stats_worker 2024-04-04 10:31:30,186 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(555) INFO 100.0% complete 2024-04-04 10:31:30,186 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(558) INFO Waiting for raster stats worker result. 2024-04-04 10:31:30,604 (taskgraph.Task) Task.is_precalculated(1252) INFO not precalculated (reproject aoi/watersheds (7)), Task hash exists, but there are these mismatches: Modified times don't match cached: (1687264711712483840.000000) actual: (1712217492335813376.000000) 2024-04-04 10:31:30,604 (pygeoprocessing.geoprocessing) geoprocessing.reproject_vector(1975) WARNING C:\Creating_Watersheds_data\Creating_Watersheds_data\intermediate_files\reprojected_aoi.gpkg already exists, removing and overwriting 2024-04-04 10:31:30,710 (pygeoprocessing.geoprocessing) geoprocessing.reproject_vector(2037) INFO starting reprojection 2024-04-04 10:31:30,710 (pygeoprocessing.geoprocessing) geoprocessing.reproject_vector(2077) INFO reprojection 100.0% complete on reprojected_aoi.gpkg 2024-04-04 10:31:32,291 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(996) INFO 1 of 1 aligned: clipped_raster.tif 2024-04-04 10:31:32,291 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(1000) INFO aligned all 1 rasters. 2024-04-04 10:31:32,299 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1524) INFO build a lookup of aggregate field value to FID 2024-04-04 10:31:32,299 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1531) INFO creating disjoint polygon set 2024-04-04 10:31:32,307 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2554) INFO build shapely polygon list 2024-04-04 10:31:32,315 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2580) INFO build shapely rtree index 2024-04-04 10:31:32,320 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2593) INFO poly feature lookup 100.0% complete on reprojected_aoi.gpkg 2024-04-04 10:31:32,320 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2597) INFO build poly intersection lookup 2024-04-04 10:31:32,323 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2623) INFO poly intersection feature lookup 100.0% complete on reprojected_aoi.gpkg 2024-04-04 10:31:32,323 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2655) INFO maximal subset build 100.0% complete on reprojected_aoi.gpkg 2024-04-04 10:31:32,356 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1551) INFO processing 4 disjoint polygon sets 2024-04-04 10:31:32,356 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1581) INFO disjoint polygon set 1 of 4 100.0% processed on reprojected_aoi.gpkg 2024-04-04 10:31:32,421 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1589) INFO rasterizing disjoint polygon set 1 of 4 reprojected_aoi.gpkg 2024-04-04 10:31:32,905 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1607) INFO summarizing rasterized disjoint polygon set 1 of 4 reprojected_aoi.gpkg 2024-04-04 10:31:33,445 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1581) INFO disjoint polygon set 2 of 4 100.0% processed on reprojected_aoi.gpkg 2024-04-04 10:31:33,453 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1589) INFO rasterizing disjoint polygon set 2 of 4 reprojected_aoi.gpkg 2024-04-04 10:31:33,957 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1607) INFO summarizing rasterized disjoint polygon set 2 of 4 reprojected_aoi.gpkg 2024-04-04 10:31:34,338 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1581) INFO disjoint polygon set 3 of 4 100.0% processed on reprojected_aoi.gpkg 2024-04-04 10:31:34,338 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1589) INFO rasterizing disjoint polygon set 3 of 4 reprojected_aoi.gpkg 2024-04-04 10:31:34,880 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1607) INFO summarizing rasterized disjoint polygon set 3 of 4 reprojected_aoi.gpkg 2024-04-04 10:31:35,066 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1581) INFO disjoint polygon set 4 of 4 100.0% processed on reprojected_aoi.gpkg 2024-04-04 10:31:35,074 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1589) INFO rasterizing disjoint polygon set 4 of 4 reprojected_aoi.gpkg 2024-04-04 10:31:35,560 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1607) INFO summarizing rasterized disjoint polygon set 4 of 4 reprojected_aoi.gpkg 2024-04-04 10:31:35,754 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1756) INFO all done processing polygon sets for reprojected_aoi.gpkg 2024-04-04 10:31:37,306 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(996) INFO 1 of 1 aligned: clipped_raster.tif 2024-04-04 10:31:37,306 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(1000) INFO aligned all 1 rasters. 2024-04-04 10:31:37,306 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1524) INFO build a lookup of aggregate field value to FID 2024-04-04 10:31:37,306 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1531) INFO creating disjoint polygon set 2024-04-04 10:31:37,313 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2554) INFO build shapely polygon list 2024-04-04 10:31:37,313 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2580) INFO build shapely rtree index 2024-04-04 10:31:37,316 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2593) INFO poly feature lookup 100.0% complete on reprojected_aoi.gpkg 2024-04-04 10:31:37,316 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2597) INFO build poly intersection lookup 2024-04-04 10:31:37,316 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2623) INFO poly intersection feature lookup 100.0% complete on reprojected_aoi.gpkg 2024-04-04 10:31:37,316 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2655) INFO maximal subset build 100.0% complete on reprojected_aoi.gpkg 2024-04-04 10:31:37,346 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1551) INFO processing 4 disjoint polygon sets 2024-04-04 10:31:37,354 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1581) INFO disjoint polygon set 1 of 4 100.0% processed on reprojected_aoi.gpkg 2024-04-04 10:31:37,419 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1589) INFO rasterizing disjoint polygon set 1 of 4 reprojected_aoi.gpkg 2024-04-04 10:31:37,942 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1607) INFO summarizing rasterized disjoint polygon set 1 of 4 reprojected_aoi.gpkg 2024-04-04 10:31:38,435 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1581) INFO disjoint polygon set 2 of 4 100.0% processed on reprojected_aoi.gpkg 2024-04-04 10:31:38,444 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1589) INFO rasterizing disjoint polygon set 2 of 4 reprojected_aoi.gpkg 2024-04-04 10:31:39,002 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1607) INFO summarizing rasterized disjoint polygon set 2 of 4 reprojected_aoi.gpkg 2024-04-04 10:31:39,302 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1581) INFO disjoint polygon set 3 of 4 100.0% processed on reprojected_aoi.gpkg 2024-04-04 10:31:39,310 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1589) INFO rasterizing disjoint polygon set 3 of 4 reprojected_aoi.gpkg 2024-04-04 10:31:39,810 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1607) INFO summarizing rasterized disjoint polygon set 3 of 4 reprojected_aoi.gpkg 2024-04-04 10:31:39,988 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1581) INFO disjoint polygon set 4 of 4 100.0% processed on reprojected_aoi.gpkg 2024-04-04 10:31:39,999 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1589) INFO rasterizing disjoint polygon set 4 of 4 reprojected_aoi.gpkg 2024-04-04 10:31:40,515 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1607) INFO summarizing rasterized disjoint polygon set 4 of 4 reprojected_aoi.gpkg 2024-04-04 10:31:40,683 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1756) INFO all done processing polygon sets for reprojected_aoi.gpkg 2024-04-04 10:31:42,107 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(996) INFO 1 of 1 aligned: clipped_raster.tif 2024-04-04 10:31:42,107 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(1000) INFO aligned all 1 rasters. 2024-04-04 10:31:42,116 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1524) INFO build a lookup of aggregate field value to FID 2024-04-04 10:31:42,116 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1531) INFO creating disjoint polygon set 2024-04-04 10:31:42,118 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2554) INFO build shapely polygon list 2024-04-04 10:31:42,118 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2580) INFO build shapely rtree index 2024-04-04 10:31:42,124 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2593) INFO poly feature lookup 100.0% complete on reprojected_aoi.gpkg 2024-04-04 10:31:42,124 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2597) INFO build poly intersection lookup 2024-04-04 10:31:42,124 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2623) INFO poly intersection feature lookup 100.0% complete on reprojected_aoi.gpkg 2024-04-04 10:31:42,124 (pygeoprocessing.geoprocessing) geoprocessing.calculate_disjoint_polygon_set(2655) INFO maximal subset build 100.0% complete on reprojected_aoi.gpkg 2024-04-04 10:31:42,157 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1551) INFO processing 4 disjoint polygon sets 2024-04-04 10:31:42,157 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1581) INFO disjoint polygon set 1 of 4 100.0% processed on reprojected_aoi.gpkg 2024-04-04 10:31:42,165 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1589) INFO rasterizing disjoint polygon set 1 of 4 reprojected_aoi.gpkg 2024-04-04 10:31:42,628 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1607) INFO summarizing rasterized disjoint polygon set 1 of 4 reprojected_aoi.gpkg 2024-04-04 10:31:43,152 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1581) INFO disjoint polygon set 2 of 4 100.0% processed on reprojected_aoi.gpkg 2024-04-04 10:31:43,160 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1589) INFO rasterizing disjoint polygon set 2 of 4 reprojected_aoi.gpkg 2024-04-04 10:31:43,637 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1607) INFO summarizing rasterized disjoint polygon set 2 of 4 reprojected_aoi.gpkg 2024-04-04 10:31:43,887 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1581) INFO disjoint polygon set 3 of 4 100.0% processed on reprojected_aoi.gpkg 2024-04-04 10:31:43,895 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1589) INFO rasterizing disjoint polygon set 3 of 4 reprojected_aoi.gpkg 2024-04-04 10:31:44,348 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1607) INFO summarizing rasterized disjoint polygon set 3 of 4 reprojected_aoi.gpkg 2024-04-04 10:31:44,502 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1581) INFO disjoint polygon set 4 of 4 100.0% processed on reprojected_aoi.gpkg 2024-04-04 10:31:44,514 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1589) INFO rasterizing disjoint polygon set 4 of 4 reprojected_aoi.gpkg 2024-04-04 10:31:45,052 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1607) INFO summarizing rasterized disjoint polygon set 4 of 4 reprojected_aoi.gpkg 2024-04-04 10:31:45,173 (pygeoprocessing.geoprocessing) geoprocessing.zonal_statistics(1756) INFO all done processing polygon sets for reprojected_aoi.gpkg 2024-04-04 10:31:45,200 (taskgraph.Task) Task.is_precalculated(1252) INFO not precalculated (reproject built infrastructure to target SRS (11)), Task hash exists, but there are these mismatches: Modified times don't match cached: (1684345983177311232.000000) actual: (1712217508881662976.000000) 2024-04-04 10:31:45,200 (pygeoprocessing.geoprocessing) geoprocessing.reproject_vector(1975) WARNING C:\Creating_Watersheds_data\Creating_Watersheds_data\intermediate_files\structures_reprojected.gpkg already exists, removing and overwriting 2024-04-04 10:31:45,222 (pygeoprocessing.geoprocessing) geoprocessing.reproject_vector(2037) INFO starting reprojection 2024-04-04 10:31:45,247 (pygeoprocessing.geoprocessing) geoprocessing.reproject_vector(2077) INFO reprojection 100.0% complete on structures_reprojected.gpkg 2024-04-04 10:31:45,431 (natcap.invest.utils) utils.prepare_workspace(169) INFO Elapsed time: 26.95s 2024-04-04 10:31:45,433 (natcap.invest.utils) utils.prepare_workspace(172) INFO Execution finished