2022-06-09 10:00:52,587 (natcap.invest.utils) utils.prepare_workspace(162) Level 100 Writing log messages to F:/UNITN4/0609\InVEST-Habitat-Quality-log-2022-06-09--10_00_52.txt 2022-06-09 10:00:52,608 (natcap.invest.ui.model) model._logged_target(1643) Level 100 Starting model with parameters: Arguments for InVEST natcap.invest.habitat_quality 3.10.2: half_saturation_constant 0.5 lulc_cur_path F:/ESnew/ALL OUT/HHQQ/lulc.tif n_workers -1 results_suffix HHH sensitivity_table_path F:/ESnew/ALL OUT/HHQQ/senss3.csv threats_table_path F:/ESnew/ALL OUT/HHQQ/threats2.csv workspace_dir F:/UNITN4/0609 2022-06-09 10:00:52,624 (natcap.invest.habitat_quality) habitat_quality.execute(259) INFO Starting execute of Habitat Quality model. 2022-06-09 10:00:52,624 (natcap.invest.habitat_quality) habitat_quality.execute(265) INFO Creating workspace 2022-06-09 10:00:53,535 (natcap.invest.habitat_quality) habitat_quality.execute(278) INFO Checking Threat and Sensitivity tables for compliance 2022-06-09 10:00:53,557 (natcap.invest.habitat_quality) habitat_quality.execute(305) INFO Validate threat rasters and collect unique LULC codes 2022-06-09 10:00:53,558 (natcap.invest.habitat_quality) habitat_quality.execute(323) DEBUG Validating path for threat: crop_c 2022-06-09 10:00:58,131 (natcap.invest.habitat_quality) habitat_quality.execute(323) DEBUG Validating path for threat: urban_c 2022-06-09 10:01:00,414 (natcap.invest.habitat_quality) habitat_quality.execute(323) DEBUG Validating path for threat: rural_c 2022-06-09 10:01:02,721 (natcap.invest.habitat_quality) habitat_quality.execute(323) DEBUG Validating path for threat: mine_c 2022-06-09 10:01:04,614 (natcap.invest.habitat_quality) habitat_quality.execute(323) DEBUG Validating path for threat: tielu_c 2022-06-09 10:01:07,489 (natcap.invest.habitat_quality) habitat_quality.execute(323) DEBUG Validating path for threat: daolu_c 2022-06-09 10:01:10,581 (natcap.invest.habitat_quality) habitat_quality.execute(367) INFO Checking threat raster values are valid ( 0 <= x <= 1 ). 2022-06-09 10:01:10,582 (natcap.invest.habitat_quality) habitat_quality.execute(378) INFO Aligning and resizing land cover and threat rasters 2022-06-09 10:01:10,591 (natcap.invest.habitat_quality) habitat_quality.execute(401) DEBUG Raster paths for aligning: ['F:/UNITN4/0609\\intermediate\\lulc_aligned_HHH.tif', 'F:/UNITN4/0609\\intermediate\\crop_c_aligned_HHH.tif', 'F:/UNITN4/0609\\intermediate\\urban_c_aligned_HHH.tif', 'F:/UNITN4/0609\\intermediate\\rural_c_aligned_HHH.tif', 'F:/UNITN4/0609\\intermediate\\mine_c_aligned_HHH.tif', 'F:/UNITN4/0609\\intermediate\\tielu_c_aligned_HHH.tif', 'F:/UNITN4/0609\\intermediate\\daolu_c_aligned_HHH.tif'] 2022-06-09 10:01:10,653 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(697) DEBUG assuming manual bounding box mode of [-46379.941196465006, 4282793.149343989, 73530.058803535, 4470603.149343989] 2022-06-09 10:01:16,294 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3320) INFO Warp 50.0% complete F:/UNITN4/0609\intermediate\lulc_aligned_HHH.tif 2022-06-09 10:01:21,294 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3320) INFO Warp 87.0% complete F:/UNITN4/0609\intermediate\lulc_aligned_HHH.tif 2022-06-09 10:01:22,724 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3320) INFO Warp 100.0% complete F:/UNITN4/0609\intermediate\lulc_aligned_HHH.tif 2022-06-09 10:01:23,746 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(824) INFO 1 of 7 aligned: lulc_aligned_HHH.tif 2022-06-09 10:01:28,995 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3320) INFO Warp 75.0% complete F:/UNITN4/0609\intermediate\crop_c_aligned_HHH.tif 2022-06-09 10:01:30,583 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3320) INFO Warp 100.0% complete F:/UNITN4/0609\intermediate\crop_c_aligned_HHH.tif 2022-06-09 10:01:31,589 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(824) INFO 2 of 7 aligned: crop_c_aligned_HHH.tif 2022-06-09 10:01:36,609 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3320) INFO Warp 100.0% complete F:/UNITN4/0609\intermediate\urban_c_aligned_HHH.tif 2022-06-09 10:01:37,448 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(824) INFO 3 of 7 aligned: urban_c_aligned_HHH.tif 2022-06-09 10:01:43,217 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(824) INFO 4 of 7 aligned: rural_c_aligned_HHH.tif 2022-06-09 10:01:48,678 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(824) INFO 5 of 7 aligned: mine_c_aligned_HHH.tif 2022-06-09 10:01:53,712 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3320) INFO Warp 91.0% complete F:/UNITN4/0609\intermediate\tielu_c_aligned_HHH.tif 2022-06-09 10:01:53,923 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3320) INFO Warp 100.0% complete F:/UNITN4/0609\intermediate\tielu_c_aligned_HHH.tif 2022-06-09 10:01:54,663 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(824) INFO 6 of 7 aligned: tielu_c_aligned_HHH.tif 2022-06-09 10:01:59,687 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3320) INFO Warp 99.0% complete F:/UNITN4/0609\intermediate\daolu_c_aligned_HHH.tif 2022-06-09 10:01:59,711 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3320) INFO Warp 100.0% complete F:/UNITN4/0609\intermediate\daolu_c_aligned_HHH.tif 2022-06-09 10:02:00,493 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(824) INFO 7 of 7 aligned: daolu_c_aligned_HHH.tif 2022-06-09 10:02:00,493 (pygeoprocessing.geoprocessing) geoprocessing.align_and_resize_raster_stack(828) INFO aligned all 7 rasters. 2022-06-09 10:02:00,589 (natcap.invest.habitat_quality) habitat_quality.execute(413) DEBUG Updating dict raster paths to reflect aligned paths 2022-06-09 10:02:00,590 (natcap.invest.habitat_quality) habitat_quality.execute(431) INFO Starting habitat_quality biophysical calculations 2022-06-09 10:02:04,415 (natcap.invest.habitat_quality) habitat_quality.execute(475) INFO Calculating habitat quality for landuse: F:/UNITN4/0609\intermediate\lulc_aligned_HHH.tif 2022-06-09 10:02:04,474 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker 2022-06-09 10:02:04,490 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker 2022-06-09 10:02:04,490 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 11692 2022-06-09 10:02:09,435 (pygeoprocessing.geoprocessing) geoprocessing.(477) INFO 59.5% complete 2022-06-09 10:02:14,002 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete 2022-06-09 10:02:14,003 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result. 2022-06-09 10:02:15,289 (natcap.invest.habitat_quality) habitat_quality.execute(509) DEBUG Calculating threat: crop_c. Threat data: {'threat': 'crop_c', 'max_dist': 4, 'weight': 0.4, 'decay': 'exponential', 'cur_path': 'crop_c.tif'} 2022-06-09 10:02:15,306 (natcap.invest.habitat_quality) habitat_quality._create_decay_kernel(881) DEBUG Max distance in pixels: 400.0 2022-06-09 10:02:16,104 (pygeoprocessing.geoprocessing) geoprocessing.convolve_2d(2678) INFO starting convolve 2022-06-09 10:02:16,153 (pygeoprocessing.geoprocessing) geoprocessing.convolve_2d(2696) DEBUG start fill work queue thread 2022-06-09 10:02:16,154 (pygeoprocessing.geoprocessing) geoprocessing._fill_work_queue(2700) DEBUG fill work queue 2022-06-09 10:02:16,154 (pygeoprocessing.geoprocessing) geoprocessing.convolve_2d(2714) DEBUG start worker thread 2022-06-09 10:02:16,155 (pygeoprocessing.geoprocessing) geoprocessing.convolve_2d(2726) INFO 890368 sent to workers, wait for worker results 2022-06-09 10:02:21,118 (pygeoprocessing.geoprocessing) geoprocessing.(2786) INFO convolution worker approximately 0.0% complete on filtered_crop_c_c_HHH.tif 2022-06-09 10:02:26,136 (pygeoprocessing.geoprocessing) geoprocessing.(2786) INFO convolution worker approximately 0.1% complete on filtered_crop_c_c_HHH.tif 2022-06-09 10:02:31,145 (pygeoprocessing.geoprocessing) geoprocessing.(2786) INFO convolution worker approximately 0.1% complete on filtered_crop_c_c_HHH.tif 2022-06-09 10:02:36,161 (pygeoprocessing.geoprocessing) geoprocessing.(2786) INFO convolution worker approximately 0.1% complete on filtered_crop_c_c_HHH.tif 2022-06-09 10:02:41,171 (pygeoprocessing.geoprocessing) geoprocessing.(2786) INFO convolution worker approximately 0.1% complete on filtered_crop_c_c_HHH.tif 2022-06-09 10:02:46,182 (pygeoprocessing.geoprocessing) geoprocessing.(2786) INFO convolution worker approximately 0.2% complete on filtered_crop_c_c_HHH.tif 2022-06-09 10:02:51,189 (pygeoprocessing.geoprocessing) geoprocessing.(2786) INFO convolution worker approximately 0.2% complete on filtered_crop_c_c_HHH.tif 2022-06-09 10:02:56,195 (pygeoprocessing.geoprocessing) geoprocessing.(2786) INFO convolution worker approximately 0.2% complete on filtered_crop_c_c_HHH.tif 2022-06-09 10:03:01,197 (pygeoprocessing.geoprocessing) geoprocessing.(2786) INFO convolution worker approximately 0.2% complete on filtered_crop_c_c_HHH.tif 2022-06-09 10:03:06,208 (pygeoprocessing.geoprocessing) geoprocessing.(2786) INFO convolution worker approximately 0.3% complete on filtered_crop_c_c_HHH.tif 2022-06-09 10:03:11,228 (pygeoprocessing.geoprocessing) geoprocessing.(2786) INFO convolution worker approximately 0.3% complete on filtered_crop_c_c_HHH.tif 2022-06-09 10:03:16,240 (pygeoprocessing.geoprocessing) geoprocessing.(2786) INFO convolution worker approximately 0.3% complete on filtered_crop_c_c_HHH.tif 2022-06-09 10:03:21,251 (pygeoprocessing.geoprocessing) geoprocessing.(2786) INFO convolution worker approximately 0.3% complete on filtered_crop_c_c_HHH.tif 2022-06-09 10:03:26,252 (pygeoprocessing.geoprocessing) geoprocessing.(2786) INFO convolution worker approximately 0.4% complete on filtered_crop_c_c_HHH.tif 2022-06-09 10:03:31,267 (pygeoprocessing.geoprocessing) geoprocessing.(2786) INFO convolution worker approximately 0.4% complete on filtered_crop_c_c_HHH.tif 2022-06-09 10:03:36,275 (pygeoprocessing.geoprocessing) geoprocessing.(2786) INFO convolution worker approximately 0.4% complete on filtered_crop_c_c_HHH.tif 2022-06-09 10:03:41,279 (pygeoprocessing.geoprocessing) geoprocessing.(2786) INFO convolution worker approximately 0.4% complete on filtered_crop_c_c_HHH.tif 2022-06-09 10:03:46,292 (pygeoprocessing.geoprocessing) geoprocessing.(2786) INFO convolution worker approximately 0.5% complete on filtered_crop_c_c_HHH.tif 2022-06-09 10:03:51,295 (pygeoprocessing.geoprocessing) geoprocessing.(2786) INFO convolution worker approximately 0.5% complete on filtered_crop_c_c_HHH.tif 2022-06-09 10:03:56,301 (pygeoprocessing.geoprocessing) geoprocessing.(2786) INFO convolution worker approximately 0.5% complete on filtered_crop_c_c_HHH.tif 2022-06-09 10:04:01,312 (pygeoprocessing.geoprocessing) geoprocessing.(2786) INFO convolution worker approximately 0.5% complete on filtered_crop_c_c_HHH.tif