2021-08-25 10:10:49,025 utils.prepare_workspace(123) INFO Writing log messages to C:/sinfill\InVEST-Scenic-Quality-log-2021-08-25--10_10_49.txt
2021-08-25 10:10:49,026 model._validation_finished(1793) INFO Whole-model validation returned: []
2021-08-25 10:10:49,028 inputs._validation_finished(1341) INFO Cleaning up validation for <natcap.invest.ui.inputs.Folder(0x26050d8cd60) at 0x000002604F2E2A08>.  Warnings: [].  Valid: True
2021-08-25 10:10:49,031 inputs._validation_finished(1341) INFO Cleaning up validation for <natcap.invest.ui.inputs.Text(0x26050d8d840) at 0x000002604F25C648>.  Warnings: [].  Valid: True
2021-08-25 10:10:49,030 model._logged_target(1646) Level 100 Starting model with parameters: 
Arguments for InVEST natcap.invest.scenic_quality.scenic_quality 3.9.0:
a_coef               0
aoi_path             C:/sinfill/sinfill/AOI_bet.shp
b_coef               1
dem_path             C:/sinfill/sinfill/clip_conp.tif
do_valuation         True
max_valuation_radius 8000
n_workers            -1
refraction           0.8
results_suffix       sinf
structure_path       C:/sinfill/sinfill/bet_points.shp
valuation_function   linear: a + bx
workspace_dir        C:/sinfill

2021-08-25 10:10:49,034 inputs._validation_finished(1341) INFO Cleaning up validation for <natcap.invest.ui.inputs.Text(0x26050d82340) at 0x000002604F53A048>.  Warnings: [].  Valid: True
2021-08-25 10:10:49,035 scenic_quality.execute(207) INFO Starting Scenic Quality Model
2021-08-25 10:10:49,036 inputs._validation_finished(1341) INFO Cleaning up validation for <natcap.invest.ui.inputs.Dropdown(0x26050d8fce0) at 0x000002604F2E1D88>.  Warnings: [].  Valid: True
2021-08-25 10:10:49,038 inputs._validation_finished(1341) INFO Cleaning up validation for <natcap.invest.ui.inputs.File(0x26050d8eb80) at 0x000002604F2CE188>.  Warnings: [].  Valid: True
2021-08-25 10:10:49,040 inputs.run(680) INFO Starting validation thread with target=<function invest_validator.<locals>._wrapped_validate_func at 0x000002604F23DDC8>, args={'workspace_dir': 'C:/sinfill', 'results_suffix': 'sinf', 'aoi_path': 'C:/sinfill/sinfill/AOI_bet.shp', 'structure_path': 'C:/sinfill/sinfill/bet_points.shp', 'dem_path': 'C:/sinfill/sinfill/clip_conp.tif', 'refraction': '0.8', 'do_valuation': True, 'valuation_function': 'linear: a + bx', 'a_coef': '0', 'b_coef': '1', 'max_valuation_radius': '8000'}, limit_to=None
2021-08-25 10:10:49,041 validation._wrapped_validate_func(911) DEBUG Using ARG_SPEC for validation
2021-08-25 10:10:49,042 validation._wrapped_validate_func(915) INFO Starting whole-model validation with ARGS_SPEC
2021-08-25 10:10:49,043 validation.timeout(625) DEBUG Starting file checking thread with timeout=5
2021-08-25 10:10:49,045 validation.timeout(637) DEBUG File checking thread completed.
2021-08-25 10:10:49,046 validation.timeout(625) DEBUG Starting file checking thread with timeout=5
2021-08-25 10:10:49,129 validation.timeout(637) DEBUG File checking thread completed.
2021-08-25 10:10:49,129 validation.timeout(625) DEBUG Starting file checking thread with timeout=5
2021-08-25 10:10:49,147 scenic_quality.execute(240) INFO Building file registry
2021-08-25 10:10:49,200 validation.timeout(637) DEBUG File checking thread completed.
2021-08-25 10:10:49,200 validation.timeout(625) DEBUG Starting file checking thread with timeout=5
2021-08-25 10:10:49,218 geoprocessing.reproject_vector(1711) INFO starting reprojection
2021-08-25 10:10:49,220 geoprocessing.reproject_vector(1754) INFO reprojection 100.0% complete on aoi_reprojected_sinf.shp
2021-08-25 10:10:49,242 geoprocessing.reproject_vector(1711) INFO starting reprojection
2021-08-25 10:10:49,244 geoprocessing.reproject_vector(1754) INFO reprojection 100.0% complete on structures_reprojected_sinf.shp
2021-08-25 10:10:49,255 validation.timeout(637) DEBUG File checking thread completed.
2021-08-25 10:10:49,285 validation._wrapped_validate_func(962) DEBUG Validation warnings: []
2021-08-25 10:10:49,285 inputs.run(685) INFO Validation thread returned warnings: []
2021-08-25 10:10:49,302 utils._log_gdal_errors(80) ERROR [errno 1] TopologyException: Input geom 1 is invalid: Ring Self-intersection at or near point 398342.5625 919206.875 at 398342.5625 919206.875
2021-08-25 10:10:49,303 Task.add_task(781) ERROR Something went wrong when adding task clip_reprojected_structures_to_aoi (2), terminating taskgraph.
Traceback (most recent call last):
  File "site-packages\taskgraph\Task.py", line 747, in add_task
  File "site-packages\taskgraph\Task.py", line 1234, in _call
  File "site-packages\natcap\invest\scenic_quality\scenic_quality.py", line 626, in _clip_vector
ValueError: Intersection ERROR: _clip_vector found no intersection between: file - C:/sinfill\intermediate\structures_reprojected_sinf.shp and file - C:/sinfill\intermediate\aoi_reprojected_sinf.shp.
2021-08-25 10:10:49,304 model._logged_target(1652) ERROR Exception while executing <function execute at 0x000002604F1534C8>
Traceback (most recent call last):
  File "site-packages\natcap\invest\ui\model.py", line 1649, in _logged_target
  File "site-packages\natcap\invest\scenic_quality\scenic_quality.py", line 280, in execute
  File "site-packages\taskgraph\Task.py", line 747, in add_task
  File "site-packages\taskgraph\Task.py", line 1234, in _call
  File "site-packages\natcap\invest\scenic_quality\scenic_quality.py", line 626, in _clip_vector
ValueError: Intersection ERROR: _clip_vector found no intersection between: file - C:/sinfill\intermediate\structures_reprojected_sinf.shp and file - C:/sinfill\intermediate\aoi_reprojected_sinf.shp.
2021-08-25 10:10:49,306 model._logged_target(1655) INFO Execution finished
2021-08-25 10:10:49,308 utils.prepare_workspace(129) INFO Elapsed time: 0.28s