2021-01-11 09:14:42,221 utils.prepare_workspace(111) INFO Writing log messages to /Users/nicholasmetherall/Documents/1. SPC/Consultancy R2R SPC/Fiji/InVEST-DelineateIt-Watershed-Delineation-log-2021-01-11--09_14_42.txt 2021-01-11 09:14:42,223 model._logged_target(1626) Level 100 Starting model with parameters: Arguments for InVEST natcap.invest.delineateit 3.8.9: dem_path /Users/nicholasmetherall/Documents/1. SPC/Consultancy R2R SPC/Fiji/Viti_DEM_3.tif flow_threshold n_workers -1 outlet_vector_path /Users/nicholasmetherall/Documents/1. SPC/Consultancy R2R SPC/Fiji/Delineated/Ba_RiverDissolved1.1.shp results_suffix delineated skip_invalid_geometry True snap_distance snap_points False workspace_dir /Users/nicholasmetherall/Documents/1. SPC/Consultancy R2R SPC/Fiji 2021-01-11 09:14:58,923 Task._call(1174) INFO 0.1% complete 2021-01-11 09:15:04,004 Task._call(1174) INFO 14.1% complete 2021-01-11 09:15:10,001 Task._call(1174) INFO 23.9% complete 2021-01-11 09:15:16,004 Task._call(1174) INFO 31.6% complete 2021-01-11 09:15:22,009 Task._call(1174) INFO 38.0% complete 2021-01-11 09:15:28,021 Task._call(1174) INFO 44.3% complete 2021-01-11 09:15:34,003 Task._call(1174) INFO 51.0% complete 2021-01-11 09:15:40,005 Task._call(1174) INFO 57.0% complete 2021-01-11 09:15:46,006 Task._call(1174) INFO 63.4% complete 2021-01-11 09:15:52,010 Task._call(1174) INFO 69.5% complete 2021-01-11 09:15:58,001 Task._call(1174) INFO 75.9% complete 2021-01-11 09:16:04,017 Task._call(1174) INFO 82.0% complete 2021-01-11 09:16:10,001 Task._call(1174) INFO 91.1% complete 2021-01-11 09:16:13,901 Task._call(1174) INFO 100.0% complete 2021-01-11 09:30:11,611 Task._call(1174) INFO 0.0% complete 2021-01-11 09:30:17,009 Task._call(1174) INFO 0.0% complete 2021-01-11 09:30:25,010 Task._call(1174) INFO 0.0% complete 2021-01-11 09:30:49,112 Task._call(1174) INFO 6.8% complete 2021-01-11 09:30:55,758 Task._call(1174) INFO 6.8% complete 2021-01-11 09:31:27,563 Task._call(1174) INFO 6.8% complete 2021-01-11 09:31:51,665 Task._call(1174) INFO 6.8% complete 2021-01-11 09:32:00,309 Task._call(1174) INFO 6.8% complete 2021-01-11 09:32:07,668 Task._call(1174) INFO 13.6% complete 2021-01-11 09:32:13,758 Task._call(1174) INFO 13.6% complete 2021-01-11 09:32:22,514 Task._call(1174) INFO 13.6% complete 2021-01-11 09:32:28,317 Task._call(1174) INFO 13.6% complete 2021-01-11 09:32:34,715 Task._call(1174) INFO 20.4% complete 2021-01-11 09:32:46,769 Task._call(1174) INFO 20.4% complete 2021-01-11 09:32:52,220 Task._call(1174) INFO 20.4% complete 2021-01-11 09:33:00,315 Task._call(1174) INFO 20.4% complete 2021-01-11 09:33:06,960 Task._call(1174) INFO 20.4% complete 2021-01-11 09:33:12,113 Task._call(1174) INFO 27.2% complete 2021-01-11 09:33:18,166 Task._call(1174) INFO 27.2% complete 2021-01-11 09:33:24,065 Task._call(1174) INFO 27.2% complete 2021-01-11 09:33:31,671 Task._call(1174) INFO 27.2% complete 2021-01-11 09:33:38,117 Task._call(1174) INFO 27.2% complete 2021-01-11 09:33:44,666 Task._call(1174) INFO 27.2% complete 2021-01-11 09:33:50,013 Task._call(1174) INFO 33.9% complete 2021-01-11 09:34:01,860 Task._call(1174) INFO 33.9% complete 2021-01-11 09:34:07,171 Task._call(1174) INFO 34.0% complete 2021-01-11 09:34:13,858 Task._call(1174) INFO 34.0% complete 2021-01-11 09:34:20,618 Task._call(1174) INFO 34.0% complete 2021-01-11 09:34:27,521 Task._call(1174) INFO 40.7% complete 2021-01-11 09:34:33,764 Task._call(1174) INFO 40.7% complete 2021-01-11 09:34:40,271 Task._call(1174) INFO 40.7% complete 2021-01-11 09:34:48,158 Task._call(1174) INFO 40.7% complete 2021-01-11 09:34:56,063 Task._call(1174) INFO 40.7% complete 2021-01-11 09:35:02,662 Task._call(1174) INFO 40.8% complete 2021-01-11 09:35:11,621 Task._call(1174) INFO 40.8% complete 2021-01-11 09:35:17,461 Task._call(1174) INFO 47.5% complete 2021-01-11 09:35:23,411 Task._call(1174) INFO 47.5% complete 2021-01-11 09:35:30,271 Task._call(1174) INFO 47.5% complete 2021-01-11 09:35:39,113 Task._call(1174) INFO 47.5% complete 2021-01-11 09:35:46,014 Task._call(1174) INFO 47.5% complete 2021-01-11 09:35:52,272 Task._call(1174) INFO 47.5% complete 2021-01-11 09:35:59,673 Task._call(1174) INFO 54.3% complete 2021-01-11 09:36:05,114 Task._call(1174) INFO 54.3% complete 2021-01-11 09:36:11,676 Task._call(1174) INFO 54.3% complete 2021-01-11 09:36:30,015 Task._call(1174) INFO 54.3% complete 2021-01-11 09:36:36,523 Task._call(1174) INFO 54.3% complete 2021-01-11 09:36:42,963 Task._call(1174) INFO 54.3% complete 2021-01-11 09:36:50,873 Task._call(1174) INFO 54.3% complete 2021-01-11 09:36:57,378 Task._call(1174) INFO 61.1% complete 2021-01-11 09:37:04,220 Task._call(1174) INFO 61.1% complete 2021-01-11 09:37:11,267 Task._call(1174) INFO 61.1% complete 2021-01-11 09:37:17,865 Task._call(1174) INFO 61.1% complete 2021-01-11 09:38:00,079 Task._call(1174) INFO 61.1% complete 2021-01-11 09:39:01,832 Task._call(1174) INFO 61.1% complete 2021-01-11 09:39:16,481 Task._call(1174) INFO 61.1% complete 2021-01-11 09:39:32,928 Task._call(1174) INFO 61.1% complete 2021-01-11 09:39:39,629 Task._call(1174) INFO 67.9% complete 2021-01-11 09:39:49,081 Task._call(1174) INFO 67.9% complete 2021-01-11 09:39:57,580 Task._call(1174) INFO 67.9% complete 2021-01-11 09:40:03,629 Task._call(1174) INFO 67.9% complete 2021-01-11 09:40:10,180 Task._call(1174) INFO 67.9% complete 2021-01-11 09:40:19,584 Task._call(1174) INFO 67.9% complete 2021-01-11 09:40:26,872 Task._call(1174) INFO 67.9% complete 2021-01-11 09:40:34,571 Task._call(1174) INFO 74.7% complete 2021-01-11 09:40:40,076 Task._call(1174) INFO 74.7% complete 2021-01-11 09:40:46,231 Task._call(1174) INFO 74.7% complete 2021-01-11 09:40:52,981 Task._call(1174) INFO 74.7% complete 2021-01-11 09:40:58,829 Task._call(1174) INFO 74.7% complete 2021-01-11 09:41:04,277 Task._call(1174) INFO 74.7% complete 2021-01-11 09:41:10,129 Task._call(1174) INFO 74.7% complete 2021-01-11 09:41:16,635 Task._call(1174) INFO 81.5% complete 2021-01-11 09:41:23,682 Task._call(1174) INFO 81.5% complete 2021-01-11 09:41:30,183 Task._call(1174) INFO 81.5% complete 2021-01-11 09:41:37,437 Task._call(1174) INFO 88.3% complete 2021-01-11 09:41:44,336 Task._call(1174) INFO 88.3% complete 2021-01-11 09:41:57,773 Task._call(1174) INFO 100.0% complete 2021-01-11 09:42:03,573 delineateit.check_geometries(400) INFO Checking 1 geometries from source vector 2021-01-11 09:42:04,025 delineateit.check_geometries(440) WARNING Feature 0 does not intersect the DEM. Skipping. 2021-01-11 09:42:04,078 delineateit.check_geometries(457) INFO 0 features copied to preprocessed_geometries_delineated.gpkg from the original 1 features 2021-01-11 09:42:06,073 Task._call(1174) INFO Delineating watersheds 2021-01-11 09:42:06,084 Task._call(1174) INFO Finished delineating 0 watersheds 2021-01-11 09:42:06,226 Task._call(1174) INFO Consolidating 0 fragments and copying field values to watersheds layer. 2021-01-11 09:42:06,583 Task._call(1174) INFO Finished vector consolidation 2021-01-11 09:42:06,724 Task._call(1174) INFO Watershed delineation complete 2021-01-11 09:42:06,775 model._logged_target(1635) INFO Execution finished 2021-01-11 09:42:06,787 utils.prepare_workspace(117) INFO Elapsed time: 27m 24.559999999999945s