2022-08-18 08:46:59,910 utils.prepare_workspace(123) INFO Writing log messages to I:/03_phd_graduate/01_data/05_Habitat quality/02_result/results\InVEST-Habitat-Quality-log-2022-08-18--08_46_59.txt
2022-08-18 08:46:59,912 model._logged_target(1646) Level 100 Starting model with parameters: 
Arguments for InVEST natcap.invest.habitat_quality 3.9.0:
half_saturation_constant 0.5
lulc_cur_path            I:/03_phd_graduate/01_data/06_lucc_clcd30m_1985_2020/reclassify_lucc/2010_ROI_LandCover_CLCD.tif
n_workers                -1
results_suffix           Hq2010
sensitivity_table_path   I:/03_phd_graduate/01_data/05_Habitat quality/01_input/sensitivity1.csv
threats_table_path       I:/03_phd_graduate/01_data/05_Habitat quality/01_input/threats_2010.csv
workspace_dir            I:/03_phd_graduate/01_data/05_Habitat quality/02_result/results

2022-08-18 08:46:59,913 habitat_quality.execute(246) INFO Starting execute of Habitat Quality model.
2022-08-18 08:46:59,913 habitat_quality.execute(252) INFO Creating workspace
2022-08-18 08:46:59,919 habitat_quality.execute(265) INFO Checking Threat and Sensitivity tables for compliance
2022-08-18 08:46:59,929 utils.build_lookup_from_csv(528) WARNING Empty or NaN values were found in the table: I:/03_phd_graduate/01_data/05_Habitat quality/01_input/threats_2010.csv.
2022-08-18 08:46:59,940 habitat_quality.execute(292) INFO Validate threat rasters and collect unique LULC codes
2022-08-18 08:46:59,940 habitat_quality.execute(310) DEBUG Validating path for threat: cropland
2022-08-18 08:47:03,488 habitat_quality.execute(310) DEBUG Validating path for threat: urban area
2022-08-18 08:47:06,751 habitat_quality.execute(310) DEBUG Validating path for threat: bareland
2022-08-18 08:47:09,941 habitat_quality.execute(310) DEBUG Validating path for threat: railway
2022-08-18 08:47:13,582 habitat_quality.execute(310) DEBUG Validating path for threat: trunkroad
2022-08-18 08:47:15,062 habitat_quality.execute(310) DEBUG Validating path for threat: primaryroad
2022-08-18 08:47:32,819 habitat_quality.execute(356) INFO Checking threat raster values are valid ( 0 <= x <= 1 ).
2022-08-18 08:47:32,820 habitat_quality.execute(367) INFO Aligning and resizing land cover and threat rasters
2022-08-18 08:47:32,827 habitat_quality.execute(390) DEBUG Raster paths for aligning: ['I:/03_phd_graduate/01_data/05_Habitat quality/02_result/results\\intermediate\\2010_ROI_LandCover_CLCD_aligned_Hq2010.tif', 'I:/03_phd_graduate/01_data/05_Habitat quality/02_result/results\\intermediate\\farmland10_aligned_Hq2010.tif', 'I:/03_phd_graduate/01_data/05_Habitat quality/02_result/results\\intermediate\\consturc10_aligned_Hq2010.tif', 'I:/03_phd_graduate/01_data/05_Habitat quality/02_result/results\\intermediate\\otherland10_aligned_Hq2010.tif', 'I:/03_phd_graduate/01_data/05_Habitat quality/02_result/results\\intermediate\\rail2010_aligned_Hq2010.tif', 'I:/03_phd_graduate/01_data/05_Habitat quality/02_result/results\\intermediate\\gaosu2010_aligned_Hq2010.tif', 'I:/03_phd_graduate/01_data/05_Habitat quality/02_result/results\\intermediate\\guodao2010_aligned_Hq2010.tif']
2022-08-18 08:47:32,854 geoprocessing.align_and_resize_raster_stack(686) DEBUG assuming manual bounding box mode of [12383719.764639013, 2434290.0329492046, 12859926.365568275, 2807893.057038671]
2022-08-18 08:47:38,155 geoprocessing.logger_callback(3400) INFO Warp 88.0% complete I:/03_phd_graduate/01_data/05_Habitat quality/02_result/results\intermediate\2010_ROI_LandCover_CLCD_aligned_Hq2010.tif
2022-08-18 08:47:38,450 geoprocessing.logger_callback(3400) INFO Warp 100.0% complete I:/03_phd_graduate/01_data/05_Habitat quality/02_result/results\intermediate\2010_ROI_LandCover_CLCD_aligned_Hq2010.tif
2022-08-18 08:47:39,884 geoprocessing.align_and_resize_raster_stack(795) INFO 1 of 7 aligned: 2010_ROI_LandCover_CLCD_aligned_Hq2010.tif
2022-08-18 08:47:45,178 geoprocessing.logger_callback(3400) INFO Warp 88.0% complete I:/03_phd_graduate/01_data/05_Habitat quality/02_result/results\intermediate\farmland10_aligned_Hq2010.tif
2022-08-18 08:47:45,488 geoprocessing.logger_callback(3400) INFO Warp 100.0% complete I:/03_phd_graduate/01_data/05_Habitat quality/02_result/results\intermediate\farmland10_aligned_Hq2010.tif
2022-08-18 08:47:46,954 geoprocessing.align_and_resize_raster_stack(795) INFO 2 of 7 aligned: farmland10_aligned_Hq2010.tif
2022-08-18 08:47:52,024 geoprocessing.logger_callback(3400) INFO Warp 88.0% complete I:/03_phd_graduate/01_data/05_Habitat quality/02_result/results\intermediate\consturc10_aligned_Hq2010.tif
2022-08-18 08:47:52,329 geoprocessing.logger_callback(3400) INFO Warp 100.0% complete I:/03_phd_graduate/01_data/05_Habitat quality/02_result/results\intermediate\consturc10_aligned_Hq2010.tif
2022-08-18 08:47:53,577 geoprocessing.align_and_resize_raster_stack(795) INFO 3 of 7 aligned: consturc10_aligned_Hq2010.tif
2022-08-18 08:47:58,728 geoprocessing.logger_callback(3400) INFO Warp 88.0% complete I:/03_phd_graduate/01_data/05_Habitat quality/02_result/results\intermediate\otherland10_aligned_Hq2010.tif
2022-08-18 08:47:59,032 geoprocessing.logger_callback(3400) INFO Warp 100.0% complete I:/03_phd_graduate/01_data/05_Habitat quality/02_result/results\intermediate\otherland10_aligned_Hq2010.tif
2022-08-18 08:47:59,891 geoprocessing.align_and_resize_raster_stack(795) INFO 4 of 7 aligned: otherland10_aligned_Hq2010.tif
2022-08-18 08:47:59,941 geoprocessing.align_and_resize_raster_stack(795) INFO 5 of 7 aligned: rail2010_aligned_Hq2010.tif
2022-08-18 08:47:59,971 geoprocessing.align_and_resize_raster_stack(795) INFO 6 of 7 aligned: gaosu2010_aligned_Hq2010.tif
2022-08-18 08:48:00,024 geoprocessing.align_and_resize_raster_stack(795) INFO 7 of 7 aligned: guodao2010_aligned_Hq2010.tif
2022-08-18 08:48:00,025 geoprocessing.align_and_resize_raster_stack(797) INFO aligned all 7 rasters.
2022-08-18 08:48:00,030 habitat_quality.execute(402) DEBUG Updating dict raster paths to reflect aligned paths
2022-08-18 08:48:00,031 habitat_quality.execute(420) INFO Starting habitat_quality biophysical calculations
2022-08-18 08:48:04,505 habitat_quality.execute(464) INFO Calculating habitat quality for landuse: I:/03_phd_graduate/01_data/05_Habitat quality/02_result/results\intermediate\2010_ROI_LandCover_CLCD_aligned_Hq2010.tif
2022-08-18 08:48:04,520 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-08-18 08:48:04,522 threading.run(870) DEBUG stats worker PID: 12152
2022-08-18 08:48:04,522 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-140, started daemon 29128)>
2022-08-18 08:48:09,519 geoprocessing.<lambda>(474) INFO 68.6% complete
2022-08-18 08:48:12,217 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-08-18 08:48:12,218 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-08-18 08:48:16,763 habitat_quality.execute(499) DEBUG Calculating threat: cropland.
Threat data: {'max_dist': 8, 'weight': 0.68, 'threat': 'cropland', 'decay': 'linear', 'descrip': 'agricultural lands', 'base_path': '', 'cur_path': 'i:\\03_phd_graduate\\01_data\\05_habitat quality\\01_input\\01_threat_data\\farmland10.tif', 'fut_path': ''}
2022-08-18 08:48:16,773 habitat_quality._create_decay_kernel(859) DEBUG Max distance in pixels: 266.65737046106756
2022-08-18 08:48:16,887 geoprocessing.convolve_2d(2562) INFO starting convolve
2022-08-18 08:48:16,892 geoprocessing.convolve_2d(2580) DEBUG start fill work queue thread
2022-08-18 08:48:16,893 geoprocessing._fill_work_queue(2584) DEBUG fill work queue
2022-08-18 08:48:16,894 geoprocessing.convolve_2d(2598) DEBUG start worker thread
2022-08-18 08:48:16,895 geoprocessing.convolve_2d(2610) INFO 15435 sent to workers, wait for worker results
2022-08-18 08:48:21,899 geoprocessing.<lambda>(2671) INFO convolution worker approximately 1.2% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:48:26,908 geoprocessing.<lambda>(2671) INFO convolution worker approximately 2.4% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:48:31,916 geoprocessing.<lambda>(2671) INFO convolution worker approximately 3.6% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:48:36,922 geoprocessing.<lambda>(2671) INFO convolution worker approximately 4.8% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:48:41,950 geoprocessing.<lambda>(2671) INFO convolution worker approximately 6.1% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:48:46,952 geoprocessing.<lambda>(2671) INFO convolution worker approximately 7.3% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:48:51,973 geoprocessing.<lambda>(2671) INFO convolution worker approximately 8.5% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:48:56,975 geoprocessing.<lambda>(2671) INFO convolution worker approximately 9.7% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:49:01,994 geoprocessing.<lambda>(2671) INFO convolution worker approximately 10.9% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:49:06,998 geoprocessing.<lambda>(2671) INFO convolution worker approximately 12.1% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:49:12,026 geoprocessing.<lambda>(2671) INFO convolution worker approximately 13.4% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:49:17,038 geoprocessing.<lambda>(2671) INFO convolution worker approximately 14.5% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:49:22,063 geoprocessing.<lambda>(2671) INFO convolution worker approximately 15.7% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:49:27,074 geoprocessing.<lambda>(2671) INFO convolution worker approximately 17.0% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:49:32,104 geoprocessing.<lambda>(2671) INFO convolution worker approximately 18.1% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:49:37,121 geoprocessing.<lambda>(2671) INFO convolution worker approximately 19.3% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:49:42,138 geoprocessing.<lambda>(2671) INFO convolution worker approximately 20.5% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:49:47,148 geoprocessing.<lambda>(2671) INFO convolution worker approximately 21.7% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:49:52,151 geoprocessing.<lambda>(2671) INFO convolution worker approximately 22.9% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:49:57,193 geoprocessing.<lambda>(2671) INFO convolution worker approximately 24.0% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:50:02,202 geoprocessing.<lambda>(2671) INFO convolution worker approximately 25.2% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:50:07,205 geoprocessing.<lambda>(2671) INFO convolution worker approximately 26.3% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:50:12,217 geoprocessing.<lambda>(2671) INFO convolution worker approximately 27.5% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:50:17,228 geoprocessing.<lambda>(2671) INFO convolution worker approximately 28.6% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:50:22,240 geoprocessing.<lambda>(2671) INFO convolution worker approximately 29.8% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:50:27,258 geoprocessing.<lambda>(2671) INFO convolution worker approximately 30.9% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:50:32,266 geoprocessing.<lambda>(2671) INFO convolution worker approximately 32.0% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:50:37,291 geoprocessing.<lambda>(2671) INFO convolution worker approximately 33.1% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:50:42,320 geoprocessing.<lambda>(2671) INFO convolution worker approximately 34.3% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:50:47,343 geoprocessing.<lambda>(2671) INFO convolution worker approximately 35.5% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:50:52,353 geoprocessing.<lambda>(2671) INFO convolution worker approximately 36.6% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:50:57,393 geoprocessing.<lambda>(2671) INFO convolution worker approximately 37.7% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:51:02,403 geoprocessing.<lambda>(2671) INFO convolution worker approximately 38.8% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:51:07,415 geoprocessing.<lambda>(2671) INFO convolution worker approximately 39.9% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:51:12,428 geoprocessing.<lambda>(2671) INFO convolution worker approximately 41.1% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:51:17,437 geoprocessing.<lambda>(2671) INFO convolution worker approximately 42.2% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:51:22,444 geoprocessing.<lambda>(2671) INFO convolution worker approximately 43.2% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:51:27,458 geoprocessing.<lambda>(2671) INFO convolution worker approximately 44.3% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:51:32,483 geoprocessing.<lambda>(2671) INFO convolution worker approximately 45.4% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:51:37,484 geoprocessing.<lambda>(2671) INFO convolution worker approximately 46.5% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:51:42,505 geoprocessing.<lambda>(2671) INFO convolution worker approximately 47.7% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:51:47,505 geoprocessing.<lambda>(2671) INFO convolution worker approximately 48.8% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:51:52,521 geoprocessing.<lambda>(2671) INFO convolution worker approximately 49.8% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:51:57,524 geoprocessing.<lambda>(2671) INFO convolution worker approximately 50.9% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:52:02,551 geoprocessing.<lambda>(2671) INFO convolution worker approximately 52.0% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:52:07,562 geoprocessing.<lambda>(2671) INFO convolution worker approximately 53.2% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:52:12,574 geoprocessing.<lambda>(2671) INFO convolution worker approximately 54.2% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:52:17,598 geoprocessing.<lambda>(2671) INFO convolution worker approximately 55.3% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:52:22,612 geoprocessing.<lambda>(2671) INFO convolution worker approximately 56.3% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:52:27,630 geoprocessing.<lambda>(2671) INFO convolution worker approximately 57.4% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:52:32,633 geoprocessing.<lambda>(2671) INFO convolution worker approximately 58.6% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:52:37,644 geoprocessing.<lambda>(2671) INFO convolution worker approximately 59.6% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:52:42,658 geoprocessing.<lambda>(2671) INFO convolution worker approximately 60.7% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:52:47,670 geoprocessing.<lambda>(2671) INFO convolution worker approximately 61.7% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:52:52,699 geoprocessing.<lambda>(2671) INFO convolution worker approximately 62.8% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:52:57,723 geoprocessing.<lambda>(2671) INFO convolution worker approximately 63.9% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:53:02,738 geoprocessing.<lambda>(2671) INFO convolution worker approximately 65.0% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:53:07,769 geoprocessing.<lambda>(2671) INFO convolution worker approximately 66.0% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:53:12,803 geoprocessing.<lambda>(2671) INFO convolution worker approximately 67.1% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:53:17,828 geoprocessing.<lambda>(2671) INFO convolution worker approximately 68.1% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:53:22,833 geoprocessing.<lambda>(2671) INFO convolution worker approximately 69.2% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:53:27,862 geoprocessing.<lambda>(2671) INFO convolution worker approximately 70.2% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:53:32,878 geoprocessing.<lambda>(2671) INFO convolution worker approximately 71.2% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:53:37,900 geoprocessing.<lambda>(2671) INFO convolution worker approximately 72.2% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:53:42,915 geoprocessing.<lambda>(2671) INFO convolution worker approximately 73.2% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:53:47,917 geoprocessing.<lambda>(2671) INFO convolution worker approximately 74.2% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:53:52,929 geoprocessing.<lambda>(2671) INFO convolution worker approximately 75.3% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:53:57,938 geoprocessing.<lambda>(2671) INFO convolution worker approximately 76.3% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:54:02,953 geoprocessing.<lambda>(2671) INFO convolution worker approximately 77.4% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:54:07,982 geoprocessing.<lambda>(2671) INFO convolution worker approximately 78.4% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:54:12,990 geoprocessing.<lambda>(2671) INFO convolution worker approximately 79.4% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:54:18,013 geoprocessing.<lambda>(2671) INFO convolution worker approximately 80.5% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:54:23,021 geoprocessing.<lambda>(2671) INFO convolution worker approximately 81.5% complete on filtered_cropland_c_Hq2010.tif
2022-08-18 08:54:28,033 geoprocessing.<lambda>(2671) INFO convolution worker approximately 82.5% complete on filtered_cropland_c_Hq2010.tif