2022-11-20 01:04:35,159 (natcap.invest.utils) utils.prepare_workspace(162) Level 100 Writing log messages to [C:\Users\vicke\Documents\rencap\invest\carbon_output\model_out\InVEST-natcap.invest.carbon-log-2022-11-20--01_04_35.txt] 2022-11-20 01:04:35,159 (__main__) cli.main(475) Level 100 Starting model with parameters: Arguments for InVEST natcap.invest.carbon 3.11.0: calc_sequestration False carbon_pools_path C:\Users\vicke\Documents\rencap\aries\spatial_data\npws_files_i_model\nsw_carbon\carbonpools.csv discount_rate do_redd False do_valuation False lulc_cur_path C:\Users\vicke\Documents\rencap\aries\spatial_data\npws_files_i_model\nsw_carbon\2013_LULC.tif lulc_cur_year lulc_fut_path lulc_fut_year lulc_redd_path n_workers -1 price_per_metric_ton_of_c rate_change results_suffix test_run_two_ workspace_dir C:\Users\vicke\Documents\rencap\invest\carbon_output\model_out 2022-11-20 01:04:35,161 (natcap.invest.carbon) carbon.execute(281) INFO Building file registry 2022-11-20 01:05:17,286 (natcap.invest.carbon) carbon.execute(327) INFO Map all carbon pools to carbon storage rasters. 2022-11-20 01:05:18,370 (natcap.invest.carbon) carbon.execute(340) INFO Mapping carbon from 'lulc_cur_path' to 'c_above_cur' scenario. 2022-11-20 01:08:21,036 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2022-11-20 01:08:21,038 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2022-11-20 01:08:26,323 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 3.2% complete 2022-11-20 01:08:31,518 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 6.2% complete 2022-11-20 01:08:36,679 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 9.2% complete 2022-11-20 01:08:42,131 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 12.2% complete 2022-11-20 01:08:47,441 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 15.2% complete 2022-11-20 01:08:52,729 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 18.7% complete 2022-11-20 01:08:58,019 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 22.0% complete 2022-11-20 01:09:03,267 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 25.3% complete 2022-11-20 01:09:08,565 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 28.6% complete 2022-11-20 01:09:13,968 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 31.8% complete 2022-11-20 01:09:18,989 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 34.8% complete 2022-11-20 01:09:24,214 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 38.1% complete 2022-11-20 01:09:29,497 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 41.6% complete 2022-11-20 01:09:34,728 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 44.9% complete 2022-11-20 01:09:39,973 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 48.2% complete 2022-11-20 01:09:45,174 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 51.4% complete 2022-11-20 01:09:50,457 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 54.7% complete 2022-11-20 01:09:55,628 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 58.0% complete 2022-11-20 01:10:00,855 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 61.3% complete 2022-11-20 01:10:06,086 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 64.8% complete 2022-11-20 01:10:11,379 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 68.0% complete 2022-11-20 01:10:16,391 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 71.0% complete 2022-11-20 01:10:21,695 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 74.3% complete 2022-11-20 01:10:26,957 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 77.6% complete 2022-11-20 01:10:32,164 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 80.9% complete 2022-11-20 01:10:37,406 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 84.1% complete 2022-11-20 01:10:42,635 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 87.6% complete 2022-11-20 01:10:47,880 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 90.9% complete 2022-11-20 01:10:53,096 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 94.2% complete 2022-11-20 01:10:58,252 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 97.5% complete 2022-11-20 01:11:03,342 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 99.5% complete 2022-11-20 01:11:06,806 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2022-11-20 01:11:06,808 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2022-11-20 01:11:08,972 (natcap.invest.carbon) carbon.execute(340) INFO Mapping carbon from 'lulc_cur_path' to 'c_below_cur' scenario. 2022-11-20 01:14:13,206 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2022-11-20 01:14:13,207 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2022-11-20 01:14:18,311 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 3.2% complete 2022-11-20 01:14:23,597 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 6.5% complete 2022-11-20 01:14:28,826 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 9.8% complete 2022-11-20 01:14:34,103 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 13.0% complete 2022-11-20 01:14:39,421 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 16.3% complete 2022-11-20 01:14:44,645 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 19.6% complete 2022-11-20 01:14:49,875 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 22.9% complete 2022-11-20 01:14:55,131 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 26.4% complete 2022-11-20 01:15:00,435 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 29.6% complete 2022-11-20 01:15:05,675 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 32.9% complete 2022-11-20 01:15:10,951 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 36.2% complete 2022-11-20 01:15:16,070 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 39.2% complete 2022-11-20 01:15:21,329 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 42.5% complete 2022-11-20 01:15:26,557 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 45.7% complete 2022-11-20 01:15:31,883 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 49.2% complete 2022-11-20 01:15:37,150 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 52.5% complete 2022-11-20 01:15:42,387 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 55.8% complete 2022-11-20 01:15:47,605 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 59.1% complete 2022-11-20 01:15:52,827 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 62.3% complete 2022-11-20 01:15:58,058 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 65.6% complete 2022-11-20 01:16:03,317 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 68.9% complete 2022-11-20 01:16:08,553 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 72.4% complete 2022-11-20 01:16:13,896 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 75.7% complete 2022-11-20 01:16:19,256 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 78.9% complete 2022-11-20 01:16:24,491 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 82.2% complete 2022-11-20 01:16:29,788 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 85.5% complete 2022-11-20 01:16:35,080 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 88.8% complete 2022-11-20 01:16:40,221 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 91.8% complete 2022-11-20 01:16:45,663 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 94.7% complete 2022-11-20 01:16:51,131 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 97.5% complete 2022-11-20 01:16:56,352 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 99.3% complete 2022-11-20 01:17:01,654 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 100.0% complete 2022-11-20 01:17:02,102 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2022-11-20 01:17:02,103 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2022-11-20 01:17:03,289 (natcap.invest.utils) utils.prepare_workspace(167) ERROR Exception while executing natcap.invest.carbon Traceback (most recent call last): File "natcap\invest\utils.py", line 165, in prepare_workspace File "natcap\invest\cli.py", line 486, in main File "natcap\invest\carbon.py", line 334, in execute File "natcap\invest\carbon.py", line 335, in KeyError: 'c_soil' 2022-11-20 01:17:03,290 (natcap.invest.utils) utils.prepare_workspace(170) INFO Elapsed time: 12m 28.129999999999995s 2022-11-20 01:17:03,290 (natcap.invest.utils) utils.prepare_workspace(173) INFO Execution finished