Arguments: biophysical_table_path D:/Data/SDR_China/input/biophysical_table_china.csv dem_path D:/Data/SDR_China/input/fill.tif drainage_path erodibility_path D:/Data/SDR_China/input/ch_RUSLE_KFactor_25km_pro_100m.tif erosivity_path D:/Data/SDR_China/input/ch_RUSLE_RFactor_25km_pro_100m.tif ic_0_param 0.5 k_param 2 lulc_path D:/Data/SDR_China/input/ch_ESACCI_pro_w_roads_100m.tif sdr_max 0.8 threshold_flow_accumulation 1000 watersheds_path D:/Data/SDR_China/input/Ch_Basin_design_report_2.shp workspace_dir D:\Data\SDR_China\output 11/06/2019 13:19:13 root INFO Logging will be saved to natcap.invest.sdr-log-2019-11-06--13_19_13.txt 11/06/2019 13:19:13 root DEBUG Loaded the model from natcap.invest.sdr 11/06/2019 13:19:13 root INFO Executing the loaded model 11/06/2019 13:19:13 root INFO Running InVEST version "3.3.3" 11/06/2019 13:19:13 root INFO Python architecture: ('32bit', 'WindowsPE') 11/06/2019 13:19:13 root INFO Disk space remaining for workspace: 763.59 GB 11/06/2019 13:19:13 root INFO Pointing temporary directory at the workspace at D:\Data\SDR_China\output 11/06/2019 13:19:13 root INFO Starting natcap.invest.sdr 11/06/2019 13:19:13 root INFO Setting tempfile.tempdir to D:\Data\SDR_China\output\tmp 11/06/2019 13:19:18 pygeoprocessing.geoprocessing INFO ReprojectImage 17.0% complete D:\Data\SDR_China\output\aligned_lulc.tif, psz_message 11/06/2019 13:19:24 pygeoprocessing.geoprocessing INFO ReprojectImage 32.0% complete D:\Data\SDR_China\output\aligned_lulc.tif, psz_message 11/06/2019 13:19:29 pygeoprocessing.geoprocessing INFO ReprojectImage 44.0% complete D:\Data\SDR_China\output\aligned_lulc.tif, psz_message 11/06/2019 13:19:34 pygeoprocessing.geoprocessing INFO ReprojectImage 57.0% complete D:\Data\SDR_China\output\aligned_lulc.tif, psz_message 11/06/2019 13:19:39 pygeoprocessing.geoprocessing INFO ReprojectImage 70.0% complete D:\Data\SDR_China\output\aligned_lulc.tif, psz_message 11/06/2019 13:19:44 pygeoprocessing.geoprocessing INFO ReprojectImage 83.0% complete D:\Data\SDR_China\output\aligned_lulc.tif, psz_message 11/06/2019 13:19:50 pygeoprocessing.geoprocessing INFO ReprojectImage 97.0% complete D:\Data\SDR_China\output\aligned_lulc.tif, psz_message 11/06/2019 13:19:51 pygeoprocessing.geoprocessing INFO ReprojectImage 100.0% complete D:\Data\SDR_China\output\aligned_lulc.tif, psz_message 11/06/2019 13:19:55 pygeoprocessing.geoprocessing INFO align_dataset_list aligning dataset 1 of 4 11/06/2019 13:19:55 natcap.invest.iui._log_model WARNING an exception encountered when logging cannot connect: [Errno 10061] No connection could be made because the target machine actively refused it 11/06/2019 13:20:00 pygeoprocessing.geoprocessing INFO ReprojectImage 16.0% complete D:\Data\SDR_China\output\aligned_dem.tif, psz_message 11/06/2019 13:20:06 pygeoprocessing.geoprocessing INFO ReprojectImage 30.0% complete D:\Data\SDR_China\output\aligned_dem.tif, psz_message 11/06/2019 13:20:11 pygeoprocessing.geoprocessing INFO ReprojectImage 42.0% complete D:\Data\SDR_China\output\aligned_dem.tif, psz_message 11/06/2019 13:20:16 pygeoprocessing.geoprocessing INFO ReprojectImage 54.0% complete D:\Data\SDR_China\output\aligned_dem.tif, psz_message 11/06/2019 13:20:21 pygeoprocessing.geoprocessing INFO ReprojectImage 66.0% complete D:\Data\SDR_China\output\aligned_dem.tif, psz_message 11/06/2019 13:20:26 pygeoprocessing.geoprocessing INFO ReprojectImage 77.0% complete D:\Data\SDR_China\output\aligned_dem.tif, psz_message 11/06/2019 13:20:31 pygeoprocessing.geoprocessing INFO ReprojectImage 88.0% complete D:\Data\SDR_China\output\aligned_dem.tif, psz_message 11/06/2019 13:20:36 pygeoprocessing.geoprocessing INFO ReprojectImage 100.0% complete D:\Data\SDR_China\output\aligned_dem.tif, psz_message 11/06/2019 13:20:40 pygeoprocessing.geoprocessing INFO align_dataset_list aligning dataset 2 of 4 11/06/2019 13:20:45 pygeoprocessing.geoprocessing INFO ReprojectImage 11.0% complete D:\Data\SDR_China\output\aligned_erosivity.tif, psz_message 11/06/2019 13:20:51 pygeoprocessing.geoprocessing INFO ReprojectImage 22.0% complete D:\Data\SDR_China\output\aligned_erosivity.tif, psz_message 11/06/2019 13:20:57 pygeoprocessing.geoprocessing INFO ReprojectImage 33.0% complete D:\Data\SDR_China\output\aligned_erosivity.tif, psz_message 11/06/2019 13:21:02 pygeoprocessing.geoprocessing INFO ReprojectImage 43.0% complete D:\Data\SDR_China\output\aligned_erosivity.tif, psz_message 11/06/2019 13:21:07 pygeoprocessing.geoprocessing INFO ReprojectImage 54.0% complete D:\Data\SDR_China\output\aligned_erosivity.tif, psz_message 11/06/2019 13:21:13 pygeoprocessing.geoprocessing INFO ReprojectImage 65.0% complete D:\Data\SDR_China\output\aligned_erosivity.tif, psz_message 11/06/2019 13:21:18 pygeoprocessing.geoprocessing INFO ReprojectImage 75.0% complete D:\Data\SDR_China\output\aligned_erosivity.tif, psz_message 11/06/2019 13:21:23 pygeoprocessing.geoprocessing INFO ReprojectImage 85.0% complete D:\Data\SDR_China\output\aligned_erosivity.tif, psz_message 11/06/2019 13:21:28 pygeoprocessing.geoprocessing INFO ReprojectImage 95.0% complete D:\Data\SDR_China\output\aligned_erosivity.tif, psz_message 11/06/2019 13:21:31 pygeoprocessing.geoprocessing INFO ReprojectImage 100.0% complete D:\Data\SDR_China\output\aligned_erosivity.tif, psz_message 11/06/2019 13:21:42 pygeoprocessing.geoprocessing INFO align_dataset_list aligning dataset 3 of 4 11/06/2019 13:21:47 pygeoprocessing.geoprocessing INFO ReprojectImage 17.0% complete D:\Data\SDR_China\output\aligned_erodibility.tif, psz_message 11/06/2019 13:21:53 pygeoprocessing.geoprocessing INFO ReprojectImage 34.0% complete D:\Data\SDR_China\output\aligned_erodibility.tif, psz_message 11/06/2019 13:21:58 pygeoprocessing.geoprocessing INFO ReprojectImage 50.0% complete D:\Data\SDR_China\output\aligned_erodibility.tif, psz_message 11/06/2019 13:22:03 pygeoprocessing.geoprocessing INFO ReprojectImage 66.0% complete D:\Data\SDR_China\output\aligned_erodibility.tif, psz_message 11/06/2019 13:22:09 pygeoprocessing.geoprocessing INFO ReprojectImage 82.0% complete D:\Data\SDR_China\output\aligned_erodibility.tif, psz_message 11/06/2019 13:22:14 pygeoprocessing.geoprocessing INFO ReprojectImage 98.0% complete D:\Data\SDR_China\output\aligned_erodibility.tif, psz_message 11/06/2019 13:22:14 pygeoprocessing.geoprocessing INFO ReprojectImage 100.0% complete D:\Data\SDR_China\output\aligned_erodibility.tif, psz_message 11/06/2019 14:35:17 natcap.invest.sdr INFO calculating slope 11/06/2019 14:35:22 pygeoprocessing.geoprocessing INFO ReprojectImage 16.0% complete D:\Data\SDR_China\output\tmp\tmpbqm4bw.tif, psz_message 11/06/2019 14:35:27 pygeoprocessing.geoprocessing INFO ReprojectImage 33.0% complete D:\Data\SDR_China\output\tmp\tmpbqm4bw.tif, psz_message 11/06/2019 14:35:33 pygeoprocessing.geoprocessing INFO ReprojectImage 49.0% complete D:\Data\SDR_China\output\tmp\tmpbqm4bw.tif, psz_message 11/06/2019 14:35:38 pygeoprocessing.geoprocessing INFO ReprojectImage 65.0% complete D:\Data\SDR_China\output\tmp\tmpbqm4bw.tif, psz_message 11/06/2019 14:35:43 pygeoprocessing.geoprocessing INFO ReprojectImage 80.0% complete D:\Data\SDR_China\output\tmp\tmpbqm4bw.tif, psz_message 11/06/2019 14:35:48 pygeoprocessing.geoprocessing INFO ReprojectImage 97.0% complete D:\Data\SDR_China\output\tmp\tmpbqm4bw.tif, psz_message 11/06/2019 14:35:49 pygeoprocessing.geoprocessing INFO ReprojectImage 100.0% complete D:\Data\SDR_China\output\tmp\tmpbqm4bw.tif, psz_message 11/06/2019 14:50:48 pygeoprocessing.geoprocessing INFO ReprojectImage 21.0% complete D:\Data\SDR_China\output\tmp\tmpoitzsq.tif, psz_message 11/06/2019 14:50:53 pygeoprocessing.geoprocessing INFO ReprojectImage 40.0% complete D:\Data\SDR_China\output\tmp\tmpoitzsq.tif, psz_message 11/06/2019 14:50:58 pygeoprocessing.geoprocessing INFO ReprojectImage 59.0% complete D:\Data\SDR_China\output\tmp\tmpoitzsq.tif, psz_message 11/06/2019 14:51:03 pygeoprocessing.geoprocessing INFO ReprojectImage 78.0% complete D:\Data\SDR_China\output\tmp\tmpoitzsq.tif, psz_message 11/06/2019 14:51:08 pygeoprocessing.geoprocessing INFO ReprojectImage 97.0% complete D:\Data\SDR_China\output\tmp\tmpoitzsq.tif, psz_message 11/06/2019 14:51:09 pygeoprocessing.geoprocessing INFO ReprojectImage 100.0% complete D:\Data\SDR_China\output\tmp\tmpoitzsq.tif, psz_message 11/06/2019 14:51:27 pygeoprocessing.geoprocessing INFO raster stack calculation approx. 35.71% complete 11/06/2019 14:51:32 pygeoprocessing.geoprocessing INFO raster stack calculation approx. 68.56% complete 11/06/2019 14:51:49 natcap.invest.sdr INFO calculating flow direction 11/06/2019 14:51:57 pygeoprocessing.routing.routing_core INFO flow_direction_inf 8.4% complete 11/06/2019 14:52:04 pygeoprocessing.routing.routing_core INFO flow_direction_inf 12.6% complete 11/06/2019 14:52:10 pygeoprocessing.routing.routing_core INFO flow_direction_inf 18.2% complete 11/06/2019 14:52:17 pygeoprocessing.routing.routing_core INFO flow_direction_inf 22.4% complete 11/06/2019 14:52:25 pygeoprocessing.routing.routing_core INFO flow_direction_inf 25.2% complete 11/06/2019 14:52:33 pygeoprocessing.routing.routing_core INFO flow_direction_inf 28.0% complete 11/06/2019 14:52:44 pygeoprocessing.routing.routing_core INFO flow_direction_inf 30.9% complete 11/06/2019 14:52:51 pygeoprocessing.routing.routing_core INFO flow_direction_inf 32.3% complete 11/06/2019 14:52:59 pygeoprocessing.routing.routing_core INFO flow_direction_inf 33.7% complete 11/06/2019 14:53:09 pygeoprocessing.routing.routing_core INFO flow_direction_inf 35.1% complete 11/06/2019 14:53:19 pygeoprocessing.routing.routing_core INFO flow_direction_inf 36.5% complete 11/06/2019 14:53:29 pygeoprocessing.routing.routing_core INFO flow_direction_inf 37.9% complete 11/06/2019 14:53:39 pygeoprocessing.routing.routing_core INFO flow_direction_inf 39.3% complete 11/06/2019 14:53:49 pygeoprocessing.routing.routing_core INFO flow_direction_inf 40.7% complete 11/06/2019 14:54:00 pygeoprocessing.routing.routing_core INFO flow_direction_inf 42.1% complete 11/06/2019 14:54:10 pygeoprocessing.routing.routing_core INFO flow_direction_inf 43.5% complete 11/06/2019 14:54:20 pygeoprocessing.routing.routing_core INFO flow_direction_inf 44.9% complete 11/06/2019 14:54:30 pygeoprocessing.routing.routing_core INFO flow_direction_inf 46.3% complete 11/06/2019 14:54:40 pygeoprocessing.routing.routing_core INFO flow_direction_inf 47.7% complete 11/06/2019 14:54:50 pygeoprocessing.routing.routing_core INFO flow_direction_inf 49.1% complete 11/06/2019 14:55:00 pygeoprocessing.routing.routing_core INFO flow_direction_inf 50.5% complete 11/06/2019 14:55:10 pygeoprocessing.routing.routing_core INFO flow_direction_inf 51.9% complete 11/06/2019 14:55:20 pygeoprocessing.routing.routing_core INFO flow_direction_inf 53.3% complete 11/06/2019 14:55:30 pygeoprocessing.routing.routing_core INFO flow_direction_inf 54.7% complete 11/06/2019 14:55:40 pygeoprocessing.routing.routing_core INFO flow_direction_inf 56.1% complete 11/06/2019 14:55:50 pygeoprocessing.routing.routing_core INFO flow_direction_inf 57.5% complete 11/06/2019 14:55:59 pygeoprocessing.routing.routing_core INFO flow_direction_inf 58.9% complete 11/06/2019 14:56:09 pygeoprocessing.routing.routing_core INFO flow_direction_inf 60.3% complete 11/06/2019 14:56:18 pygeoprocessing.routing.routing_core INFO flow_direction_inf 61.7% complete 11/06/2019 14:56:28 pygeoprocessing.routing.routing_core INFO flow_direction_inf 63.1% complete 11/06/2019 14:56:38 pygeoprocessing.routing.routing_core INFO flow_direction_inf 64.5% complete 11/06/2019 14:56:48 pygeoprocessing.routing.routing_core INFO flow_direction_inf 65.9% complete 11/06/2019 14:56:58 pygeoprocessing.routing.routing_core INFO flow_direction_inf 67.3% complete 11/06/2019 14:57:08 pygeoprocessing.routing.routing_core INFO flow_direction_inf 68.7% complete 11/06/2019 14:57:18 pygeoprocessing.routing.routing_core INFO flow_direction_inf 70.1% complete 11/06/2019 14:57:28 pygeoprocessing.routing.routing_core INFO flow_direction_inf 71.5% complete 11/06/2019 14:57:37 pygeoprocessing.routing.routing_core INFO flow_direction_inf 72.9% complete 11/06/2019 14:57:47 pygeoprocessing.routing.routing_core INFO flow_direction_inf 74.3% complete 11/06/2019 14:57:57 pygeoprocessing.routing.routing_core INFO flow_direction_inf 75.7% complete 11/06/2019 14:58:06 pygeoprocessing.routing.routing_core INFO flow_direction_inf 77.1% complete 11/06/2019 14:58:16 pygeoprocessing.routing.routing_core INFO flow_direction_inf 78.5% complete 11/06/2019 14:58:25 pygeoprocessing.routing.routing_core INFO flow_direction_inf 79.9% complete 11/06/2019 14:58:34 pygeoprocessing.routing.routing_core INFO flow_direction_inf 81.3% complete 11/06/2019 14:58:43 pygeoprocessing.routing.routing_core INFO flow_direction_inf 82.7% complete 11/06/2019 14:58:52 pygeoprocessing.routing.routing_core INFO flow_direction_inf 84.1% complete 11/06/2019 14:59:01 pygeoprocessing.routing.routing_core INFO flow_direction_inf 85.5% complete 11/06/2019 14:59:09 pygeoprocessing.routing.routing_core INFO flow_direction_inf 86.9% complete 11/06/2019 14:59:17 pygeoprocessing.routing.routing_core INFO flow_direction_inf 88.3% complete 11/06/2019 14:59:23 pygeoprocessing.routing.routing_core INFO flow_direction_inf 89.8% complete 11/06/2019 14:59:29 pygeoprocessing.routing.routing_core INFO flow_direction_inf 91.2% complete 11/06/2019 14:59:38 pygeoprocessing.routing.routing_core INFO flow_direction_inf 94.0% complete 11/06/2019 14:59:44 pygeoprocessing.routing.routing_core INFO flow_direction_inf 98.2% complete 11/06/2019 14:59:59 pygeoprocessing.routing.routing_core INFO flat_edges 14.0% complete 11/06/2019 15:00:05 pygeoprocessing.routing.routing_core INFO flat_edges 25.2% complete 11/06/2019 15:00:12 pygeoprocessing.routing.routing_core INFO flat_edges 32.3% complete 11/06/2019 15:00:19 pygeoprocessing.routing.routing_core INFO flat_edges 36.5% complete 11/06/2019 15:00:26 pygeoprocessing.routing.routing_core INFO flat_edges 40.7% complete 11/06/2019 15:00:32 pygeoprocessing.routing.routing_core INFO flat_edges 43.5% complete 11/06/2019 15:00:39 pygeoprocessing.routing.routing_core INFO flat_edges 47.7% complete 11/06/2019 15:00:46 pygeoprocessing.routing.routing_core INFO flat_edges 51.9% complete 11/06/2019 15:00:54 pygeoprocessing.routing.routing_core INFO flat_edges 56.1% complete 11/06/2019 15:01:01 pygeoprocessing.routing.routing_core INFO flat_edges 60.3% complete 11/06/2019 15:01:09 pygeoprocessing.routing.routing_core INFO flat_edges 64.5% complete 11/06/2019 15:01:16 pygeoprocessing.routing.routing_core INFO flat_edges 68.7% complete 11/06/2019 15:01:23 pygeoprocessing.routing.routing_core INFO flat_edges 72.9% complete 11/06/2019 15:01:30 pygeoprocessing.routing.routing_core INFO flat_edges 77.1% complete 11/06/2019 15:01:37 pygeoprocessing.routing.routing_core INFO flat_edges 81.3% complete 11/06/2019 15:01:44 pygeoprocessing.routing.routing_core INFO flat_edges 85.5% complete 11/06/2019 15:01:51 pygeoprocessing.routing.routing_core INFO flat_edges 91.2% complete 11/06/2019 15:01:56 pygeoprocessing.routing.routing_core INFO labeling flats 11/06/2019 15:02:03 pygeoprocessing.routing.routing_core INFO label_flats 15.0% complete 11/06/2019 15:02:09 pygeoprocessing.routing.routing_core INFO label_flats 29.9% complete 11/06/2019 15:02:15 pygeoprocessing.routing.routing_core INFO label_flats 43.6% complete 11/06/2019 15:02:21 pygeoprocessing.routing.routing_core INFO label_flats 57.8% complete 11/06/2019 15:02:27 pygeoprocessing.routing.routing_core INFO label_flats 70.3% complete 11/06/2019 15:02:33 pygeoprocessing.routing.routing_core INFO label_flats 82.3% complete 11/06/2019 15:02:39 pygeoprocessing.routing.routing_core INFO label_flats 93.4% complete 11/06/2019 15:02:43 pygeoprocessing.routing.routing_core INFO draining away from higher 11/06/2019 15:02:51 pygeoprocessing.routing.routing_core INFO away_from_higher, work queue size: 42860623 complete 11/06/2019 15:02:57 pygeoprocessing.routing.routing_core INFO away_from_higher, work queue size: 60404761 complete