2021-07-18 12:44:05,144 utils.prepare_workspace(123) INFO Writing log messages to F:/InVEST/Workspace/0717tj\InVEST-Sediment-Delivery-Ratio-Model-(SDR)-log-2021-07-18--12_44_05.txt
2021-07-18 12:44:05,145 model._logged_target(1646) Level 100 Starting model with parameters: 
Arguments for InVEST natcap.invest.sdr.sdr 3.9.0:
biophysical_table_path      F:/ArcGis上机材料/天津/SDR模型/模型数据/biophysical_table_tianjin.csv
dem_path                    F:/ArcGis上机材料/天津/SDR模型/模型数据/tj_dem1.tif
drainage_path               
erodibility_path            F:/ArcGis上机材料/天津/SDR模型/模型数据/erodibility_tianjin.tif
erosivity_path              F:/ArcGis上机材料/天津/SDR模型/模型数据/erosivity_tj_krig.tif
ic_0_param                  0.5
k_param                     2
lulc_path                   F:/ArcGis上机材料/天津/SDR模型/模型数据/landuse/tj_land13.tif
n_workers                   -1
results_suffix              
sdr_max                     0.8
threshold_flow_accumulation 3000
watersheds_path             F:/ArcGis上机材料/天津/SDR模型/模型数据/watershed (1)/tj_watshed35000.shp
workspace_dir               F:/InVEST/Workspace/0717tj

2021-07-18 12:44:18,254 geoprocessing.raster_calculator(391) INFO starting stats_worker
2021-07-18 12:44:18,268 threading.run(870) DEBUG stats worker PID: 10420
2021-07-18 12:44:18,268 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-149, started daemon 5256)>
2021-07-18 12:44:18,535 geoprocessing.raster_calculator(477) INFO 100.0% complete
2021-07-18 12:44:18,536 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2021-07-18 12:44:21,017 geoprocessing.align_and_resize_raster_stack(795) INFO 1 of 4 aligned: aligned_dem.tif
2021-07-18 12:44:22,806 geoprocessing.raster_calculator(391) INFO starting stats_worker
2021-07-18 12:44:22,808 threading.run(870) DEBUG stats worker PID: 10420
2021-07-18 12:44:22,808 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-150, started daemon 12456)>
2021-07-18 12:44:23,106 geoprocessing.raster_calculator(477) INFO 100.0% complete
2021-07-18 12:44:23,107 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2021-07-18 12:44:24,229 geoprocessing.align_and_resize_raster_stack(795) INFO 2 of 4 aligned: aligned_lulc.tif
2021-07-18 12:44:26,251 geoprocessing.raster_calculator(391) INFO starting stats_worker
2021-07-18 12:44:26,251 threading.run(870) DEBUG stats worker PID: 10420
2021-07-18 12:44:26,251 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-151, started daemon 4176)>
2021-07-18 12:44:26,715 geoprocessing.raster_calculator(477) INFO 100.0% complete
2021-07-18 12:44:26,815 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2021-07-18 12:44:40,490 geoprocessing.align_and_resize_raster_stack(795) INFO 3 of 4 aligned: aligned_erosivity.tif
2021-07-18 12:44:42,152 geoprocessing.raster_calculator(391) INFO starting stats_worker
2021-07-18 12:44:42,153 threading.run(870) DEBUG stats worker PID: 10420
2021-07-18 12:44:42,153 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-152, started daemon 2464)>
2021-07-18 12:44:42,477 geoprocessing.raster_calculator(477) INFO 100.0% complete
2021-07-18 12:44:42,477 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2021-07-18 12:44:43,424 geoprocessing.align_and_resize_raster_stack(795) INFO 4 of 4 aligned: aligned_erodibility.tif
2021-07-18 12:44:43,430 geoprocessing.align_and_resize_raster_stack(797) INFO aligned all 4 rasters.
2021-07-18 12:44:49,064 Task._call(1234) INFO 12.2% complete
2021-07-18 12:44:55,052 Task._call(1234) INFO 32.6% complete
2021-07-18 12:45:01,032 Task._call(1234) INFO 44.9% complete
2021-07-18 12:45:07,232 Task._call(1234) INFO 53.0% complete
2021-07-18 12:45:13,018 Task._call(1234) INFO 65.2% complete
2021-07-18 12:45:19,009 Task._call(1234) INFO 73.4% complete
2021-07-18 12:45:25,115 Task._call(1234) INFO 85.6% complete
2021-07-18 12:45:29,204 Task._call(1234) INFO 100.0% complete
2021-07-18 12:45:35,231 geoprocessing.raster_calculator(391) INFO starting stats_worker
2021-07-18 12:45:35,232 threading.run(870) DEBUG stats worker PID: 10420
2021-07-18 12:45:35,232 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-153, started daemon 4620)>
2021-07-18 12:45:35,637 geoprocessing.raster_calculator(477) INFO 100.0% complete
2021-07-18 12:45:35,661 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2021-07-18 12:45:46,086 Task._call(1234) INFO 24.5% complete
2021-07-18 12:45:53,514 Task._call(1234) INFO 36.7% complete
2021-07-18 12:45:59,036 Task._call(1234) INFO 44.9% complete
2021-07-18 12:46:05,092 Task._call(1234) INFO 53.0% complete
2021-07-18 12:46:11,314 Task._call(1234) INFO 61.2% complete
2021-07-18 12:46:19,984 Task._call(1234) INFO 69.3% complete
2021-07-18 12:46:25,010 Task._call(1234) INFO 77.5% complete
2021-07-18 12:46:31,677 Task._call(1234) INFO 100.0% complete
2021-07-18 12:46:31,855 Task._call(1234) INFO Calculating average aspect
2021-07-18 12:46:32,586 Task._call(1234) INFO Average aspect 0.00% complete
2021-07-18 12:46:32,588 Task._call(1234) INFO Average aspect 0.27% complete
2021-07-18 12:46:32,592 Task._call(1234) INFO Average aspect 0.53% complete
2021-07-18 12:46:32,605 Task._call(1234) INFO Average aspect 0.80% complete
2021-07-18 12:46:32,607 Task._call(1234) INFO Average aspect 1.07% complete
2021-07-18 12:46:32,617 Task._call(1234) INFO Average aspect 1.34% complete
2021-07-18 12:46:32,619 Task._call(1234) INFO Average aspect 1.60% complete
2021-07-18 12:46:32,620 Task._call(1234) INFO Average aspect 1.87% complete
2021-07-18 12:46:32,627 Task._call(1234) INFO Average aspect 2.14% complete
2021-07-18 12:46:32,651 Task._call(1234) INFO Average aspect 2.40% complete
2021-07-18 12:46:32,663 Task._call(1234) INFO Average aspect 2.67% complete
2021-07-18 12:46:32,665 Task._call(1234) INFO Average aspect 2.94% complete
2021-07-18 12:46:32,700 Task._call(1234) INFO Average aspect 3.20% complete
2021-07-18 12:46:32,702 Task._call(1234) INFO Average aspect 3.47% complete
2021-07-18 12:46:32,729 Task._call(1234) INFO Average aspect 3.74% complete
2021-07-18 12:46:32,736 Task._call(1234) INFO Average aspect 4.01% complete
2021-07-18 12:46:32,753 Task._call(1234) INFO Average aspect 4.08% complete
2021-07-18 12:46:32,761 Task._call(1234) INFO Average aspect 4.34% complete
2021-07-18 12:46:32,764 Task._call(1234) INFO Average aspect 4.61% complete
2021-07-18 12:46:32,766 Task._call(1234) INFO Average aspect 4.88% complete
2021-07-18 12:46:32,768 Task._call(1234) INFO Average aspect 5.15% complete
2021-07-18 12:46:32,770 Task._call(1234) INFO Average aspect 5.41% complete
2021-07-18 12:46:32,772 Task._call(1234) INFO Average aspect 5.68% complete
2021-07-18 12:46:32,818 Task._call(1234) INFO Average aspect 5.95% complete
2021-07-18 12:46:32,847 Task._call(1234) INFO Average aspect 6.21% complete
2021-07-18 12:46:32,897 Task._call(1234) INFO Average aspect 6.48% complete
2021-07-18 12:46:32,933 Task._call(1234) INFO Average aspect 6.75% complete
2021-07-18 12:46:32,950 Task._call(1234) INFO Average aspect 7.01% complete
2021-07-18 12:46:32,968 Task._call(1234) INFO Average aspect 7.28% complete
2021-07-18 12:46:32,970 Task._call(1234) INFO Average aspect 7.55% complete
2021-07-18 12:46:32,973 Task._call(1234) INFO Average aspect 7.82% complete
2021-07-18 12:46:32,976 Task._call(1234) INFO Average aspect 8.08% complete
2021-07-18 12:46:32,977 Task._call(1234) INFO Average aspect 8.15% complete
2021-07-18 12:46:32,980 Task._call(1234) INFO Average aspect 8.42% complete
2021-07-18 12:46:32,982 Task._call(1234) INFO Average aspect 8.69% complete
2021-07-18 12:46:32,985 Task._call(1234) INFO Average aspect 8.96% complete
2021-07-18 12:46:32,987 Task._call(1234) INFO Average aspect 9.22% complete
2021-07-18 12:46:32,989 Task._call(1234) INFO Average aspect 9.49% complete
2021-07-18 12:46:33,000 Task._call(1234) INFO Average aspect 9.76% complete
2021-07-18 12:46:33,066 Task._call(1234) INFO Average aspect 10.02% complete
2021-07-18 12:46:33,108 Task._call(1234) INFO Average aspect 10.29% complete
2021-07-18 12:46:33,118 Task._call(1234) INFO Average aspect 10.56% complete
2021-07-18 12:46:33,158 Task._call(1234) INFO Average aspect 10.82% complete
2021-07-18 12:46:33,180 Task._call(1234) INFO Average aspect 11.09% complete
2021-07-18 12:46:33,213 Task._call(1234) INFO Average aspect 11.36% complete
2021-07-18 12:46:33,220 Task._call(1234) INFO Average aspect 11.63% complete
2021-07-18 12:46:33,226 Task._call(1234) INFO Average aspect 11.89% complete
2021-07-18 12:46:33,230 Task._call(1234) INFO Average aspect 12.16% complete
2021-07-18 12:46:33,234 Task._call(1234) INFO Average aspect 12.23% complete
2021-07-18 12:46:33,236 Task._call(1234) INFO Average aspect 12.50% complete
2021-07-18 12:46:33,239 Task._call(1234) INFO Average aspect 12.77% complete
2021-07-18 12:46:33,241 Task._call(1234) INFO Average aspect 13.03% complete
2021-07-18 12:46:33,243 Task._call(1234) INFO Average aspect 13.30% complete
2021-07-18 12:46:33,246 Task._call(1234) INFO Average aspect 13.57% complete
2021-07-18 12:46:33,342 Task._call(1234) INFO Average aspect 13.83% complete
2021-07-18 12:46:33,365 Task._call(1234) INFO Average aspect 14.10% complete
2021-07-18 12:46:33,402 Task._call(1234) INFO Average aspect 14.37% complete
2021-07-18 12:46:33,469 Task._call(1234) INFO Average aspect 14.63% complete
2021-07-18 12:46:33,491 Task._call(1234) INFO Average aspect 14.90% complete
2021-07-18 12:46:33,517 Task._call(1234) INFO Average aspect 15.17% complete
2021-07-18 12:46:33,532 Task._call(1234) INFO Average aspect 15.44% complete
2021-07-18 12:46:33,562 Task._call(1234) INFO Average aspect 15.70% complete
2021-07-18 12:46:33,570 Task._call(1234) INFO Average aspect 15.97% complete
2021-07-18 12:46:33,572 Task._call(1234) INFO Average aspect 16.24% complete
2021-07-18 12:46:33,574 Task._call(1234) INFO Average aspect 16.31% complete
2021-07-18 12:46:33,576 Task._call(1234) INFO Average aspect 16.58% complete
2021-07-18 12:46:33,579 Task._call(1234) INFO Average aspect 16.84% complete
2021-07-18 12:46:33,594 Task._call(1234) INFO Average aspect 17.11% complete
2021-07-18 12:46:33,600 Task._call(1234) INFO Average aspect 17.38% complete
2021-07-18 12:46:33,620 Task._call(1234) INFO Average aspect 17.64% complete
2021-07-18 12:46:33,662 Task._call(1234) INFO Average aspect 17.91% complete
2021-07-18 12:46:33,684 Task._call(1234) INFO Average aspect 18.18% complete
2021-07-18 12:46:33,732 Task._call(1234) INFO Average aspect 18.44% complete
2021-07-18 12:46:33,742 Task._call(1234) INFO Average aspect 18.71% complete
2021-07-18 12:46:33,759 Task._call(1234) INFO Average aspect 18.98% complete
2021-07-18 12:46:33,790 Task._call(1234) INFO Average aspect 19.25% complete
2021-07-18 12:46:33,830 Task._call(1234) INFO Average aspect 19.51% complete
2021-07-18 12:46:33,873 Task._call(1234) INFO Average aspect 19.78% complete
2021-07-18 12:46:33,881 Task._call(1234) INFO Average aspect 20.05% complete
2021-07-18 12:46:33,883 Task._call(1234) INFO Average aspect 20.31% complete
2021-07-18 12:46:33,885 Task._call(1234) INFO Average aspect 20.39% complete
2021-07-18 12:46:33,887 Task._call(1234) INFO Average aspect 20.65% complete
2021-07-18 12:46:33,890 Task._call(1234) INFO Average aspect 20.92% complete
2021-07-18 12:46:33,892 Task._call(1234) INFO Average aspect 21.19% complete
2021-07-18 12:46:33,894 Task._call(1234) INFO Average aspect 21.45% complete
2021-07-18 12:46:33,899 Task._call(1234) INFO Average aspect 21.72% complete
2021-07-18 12:46:33,927 Task._call(1234) INFO Average aspect 21.99% complete
2021-07-18 12:46:33,944 Task._call(1234) INFO Average aspect 22.25% complete
2021-07-18 12:46:33,994 Task._call(1234) INFO Average aspect 22.52% complete
2021-07-18 12:46:34,012 Task._call(1234) INFO Average aspect 22.79% complete
2021-07-18 12:46:34,085 Task._call(1234) INFO Average aspect 23.06% complete
2021-07-18 12:46:34,094 Task._call(1234) INFO Average aspect 23.32% complete
2021-07-18 12:46:34,096 Task._call(1234) INFO Average aspect 23.59% complete
2021-07-18 12:46:34,099 Task._call(1234) INFO Average aspect 23.86% complete
2021-07-18 12:46:34,102 Task._call(1234) INFO Average aspect 24.12% complete
2021-07-18 12:46:34,104 Task._call(1234) INFO Average aspect 24.39% complete
2021-07-18 12:46:34,106 Task._call(1234) INFO Average aspect 24.46% complete
2021-07-18 12:46:34,109 Task._call(1234) INFO Average aspect 24.73% complete
2021-07-18 12:46:34,111 Task._call(1234) INFO Average aspect 25.00% complete
2021-07-18 12:46:34,114 Task._call(1234) INFO Average aspect 25.26% complete
2021-07-18 12:46:34,116 Task._call(1234) INFO Average aspect 25.53% complete
2021-07-18 12:46:34,119 Task._call(1234) INFO Average aspect 25.80% complete
2021-07-18 12:46:34,150 Task._call(1234) INFO Average aspect 26.06% complete
2021-07-18 12:46:34,163 Task._call(1234) INFO Average aspect 26.33% complete
2021-07-18 12:46:34,181 Task._call(1234) INFO Average aspect 26.60% complete
2021-07-18 12:46:34,192 Task._call(1234) INFO Average aspect 26.87% complete
2021-07-18 12:46:34,216 Task._call(1234) INFO Average aspect 27.13% complete
2021-07-18 12:46:34,218 Task._call(1234) INFO Average aspect 27.40% complete
2021-07-18 12:46:34,313 Task._call(1234) INFO Average aspect 27.67% complete
2021-07-18 12:46:34,317 Task._call(1234) INFO Average aspect 27.93% complete
2021-07-18 12:46:34,319 Task._call(1234) INFO Average aspect 28.20% complete
2021-07-18 12:46:34,322 Task._call(1234) INFO Average aspect 28.47% complete
2021-07-18 12:46:34,323 Task._call(1234) INFO Average aspect 28.54% complete
2021-07-18 12:46:34,326 Task._call(1234) INFO Average aspect 28.81% complete
2021-07-18 12:46:34,328 Task._call(1234) INFO Average aspect 29.07% complete
2021-07-18 12:46:34,333 Task._call(1234) INFO Average aspect 29.34% complete
2021-07-18 12:46:34,335 Task._call(1234) INFO Average aspect 29.61% complete
2021-07-18 12:46:34,338 Task._call(1234) INFO Average aspect 29.87% complete
2021-07-18 12:46:34,404 Task._call(1234) INFO Average aspect 30.14% complete
2021-07-18 12:46:34,467 Task._call(1234) INFO Average aspect 30.41% complete
2021-07-18 12:46:34,479 Task._call(1234) INFO Average aspect 30.68% complete
2021-07-18 12:46:34,516 Task._call(1234) INFO Average aspect 30.94% complete
2021-07-18 12:46:34,543 Task._call(1234) INFO Average aspect 31.21% complete
2021-07-18 12:46:34,551 Task._call(1234) INFO Average aspect 31.48% complete
2021-07-18 12:46:34,553 Task._call(1234) INFO Average aspect 31.74% complete
2021-07-18 12:46:34,579 Task._call(1234) INFO Average aspect 32.01% complete
2021-07-18 12:46:34,590 Task._call(1234) INFO Average aspect 32.28% complete
2021-07-18 12:46:34,597 Task._call(1234) INFO Average aspect 32.55% complete
2021-07-18 12:46:34,598 Task._call(1234) INFO Average aspect 32.62% complete
2021-07-18 12:46:34,614 Task._call(1234) INFO Average aspect 32.88% complete
2021-07-18 12:46:34,643 Task._call(1234) INFO Average aspect 33.15% complete
2021-07-18 12:46:34,668 Task._call(1234) INFO Average aspect 33.42% complete
2021-07-18 12:46:34,684 Task._call(1234) INFO Average aspect 33.68% complete
2021-07-18 12:46:34,696 Task._call(1234) INFO Average aspect 33.95% complete
2021-07-18 12:46:34,727 Task._call(1234) INFO Average aspect 34.22% complete
2021-07-18 12:46:34,791 Task._call(1234) INFO Average aspect 34.49% complete
2021-07-18 12:46:34,820 Task._call(1234) INFO Average aspect 34.75% complete
2021-07-18 12:46:34,869 Task._call(1234) INFO Average aspect 35.02% complete
2021-07-18 12:46:34,912 Task._call(1234) INFO Average aspect 35.29% complete
2021-07-18 12:46:34,936 Task._call(1234) INFO Average aspect 35.55% complete
2021-07-18 12:46:34,939 Task._call(1234) INFO Average aspect 35.82% complete
2021-07-18 12:46:34,941 Task._call(1234) INFO Average aspect 36.09% complete
2021-07-18 12:46:34,958 Task._call(1234) INFO Average aspect 36.36% complete
2021-07-18 12:46:34,961 Task._call(1234) INFO Average aspect 36.62% complete
2021-07-18 12:46:34,968 Task._call(1234) INFO Average aspect 36.69% complete
2021-07-18 12:46:35,080 Task._call(1234) INFO Average aspect 36.96% complete
2021-07-18 12:46:35,132 Task._call(1234) INFO Average aspect 37.23% complete
2021-07-18 12:46:35,169 Task._call(1234) INFO Average aspect 37.49% complete
2021-07-18 12:46:35,201 Task._call(1234) INFO Average aspect 37.76% complete
2021-07-18 12:46:35,290 Task._call(1234) INFO Average aspect 38.03% complete
2021-07-18 12:46:35,357 Task._call(1234) INFO Average aspect 38.30% complete
2021-07-18 12:46:35,458 Task._call(1234) INFO Average aspect 38.56% complete
2021-07-18 12:46:35,531 Task._call(1234) INFO Average aspect 38.83% complete
2021-07-18 12:46:35,570 Task._call(1234) INFO Average aspect 39.10% complete
2021-07-18 12:46:35,704 Task._call(1234) INFO Average aspect 39.36% complete
2021-07-18 12:46:35,770 Task._call(1234) INFO Average aspect 39.63% complete
2021-07-18 12:46:35,827 Task._call(1234) INFO Average aspect 39.90% complete
2021-07-18 12:46:35,906 Task._call(1234) INFO Average aspect 40.17% complete
2021-07-18 12:46:35,980 Task._call(1234) INFO Average aspect 40.43% complete
2021-07-18 12:46:35,987 Task._call(1234) INFO Average aspect 40.70% complete
2021-07-18 12:46:35,989 Task._call(1234) INFO Average aspect 40.77% complete
2021-07-18 12:46:36,063 Task._call(1234) INFO Average aspect 41.04% complete
2021-07-18 12:46:36,114 Task._call(1234) INFO Average aspect 41.30% complete
2021-07-18 12:46:36,216 Task._call(1234) INFO Average aspect 41.57% complete
2021-07-18 12:46:36,292 Task._call(1234) INFO Average aspect 41.84% complete
2021-07-18 12:46:36,416 Task._call(1234) INFO Average aspect 42.11% complete
2021-07-18 12:46:36,518 Task._call(1234) INFO Average aspect 42.37% complete
2021-07-18 12:46:36,637 Task._call(1234) INFO Average aspect 42.64% complete
2021-07-18 12:46:36,685 Task._call(1234) INFO Average aspect 42.91% complete
2021-07-18 12:46:36,750 Task._call(1234) INFO Average aspect 43.17% complete
2021-07-18 12:46:36,862 Task._call(1234) INFO Average aspect 43.44% complete
2021-07-18 12:46:36,926 Task._call(1234) INFO Average aspect 43.71% complete
2021-07-18 12:46:37,014 Task._call(1234) INFO Average aspect 43.98% complete
2021-07-18 12:46:37,068 Task._call(1234) INFO Average aspect 44.24% complete
2021-07-18 12:46:37,097 Task._call(1234) INFO Average aspect 44.51% complete
2021-07-18 12:46:37,102 Task._call(1234) INFO Average aspect 44.78% complete
2021-07-18 12:46:37,107 Task._call(1234) INFO Average aspect 44.85% complete
2021-07-18 12:46:37,168 Task._call(1234) INFO Average aspect 45.11% complete
2021-07-18 12:46:37,300 Task._call(1234) INFO Average aspect 45.38% complete
2021-07-18 12:46:37,370 Task._call(1234) INFO Average aspect 45.65% complete
2021-07-18 12:46:37,441 Task._call(1234) INFO Average aspect 45.92% complete
2021-07-18 12:46:37,492 Task._call(1234) INFO Average aspect 46.18% complete
2021-07-18 12:46:37,596 Task._call(1234) INFO Average aspect 46.45% complete
2021-07-18 12:46:37,658 Task._call(1234) INFO Average aspect 46.72% complete
2021-07-18 12:46:37,743 Task._call(1234) INFO Average aspect 46.98% complete
2021-07-18 12:46:37,852 Task._call(1234) INFO Average aspect 47.25% complete
2021-07-18 12:46:37,986 Task._call(1234) INFO Average aspect 47.52% complete
2021-07-18 12:46:38,068 Task._call(1234) INFO Average aspect 47.79% complete
2021-07-18 12:46:38,155 Task._call(1234) INFO Average aspect 48.05% complete
2021-07-18 12:46:38,202 Task._call(1234) INFO Average aspect 48.32% complete
2021-07-18 12:46:38,262 Task._call(1234) INFO Average aspect 48.59% complete
2021-07-18 12:46:38,266 Task._call(1234) INFO Average aspect 48.85% complete
2021-07-18 12:46:38,271 Task._call(1234) INFO Average aspect 48.92% complete
2021-07-18 12:46:38,274 Task._call(1234) INFO Average aspect 49.19% complete
2021-07-18 12:46:38,324 Task._call(1234) INFO Average aspect 49.46% complete
2021-07-18 12:46:38,373 Task._call(1234) INFO Average aspect 49.73% complete
2021-07-18 12:46:38,461 Task._call(1234) INFO Average aspect 49.99% complete
2021-07-18 12:46:38,498 Task._call(1234) INFO Average aspect 50.26% complete
2021-07-18 12:46:38,570 Task._call(1234) INFO Average aspect 50.53% complete
2021-07-18 12:46:38,633 Task._call(1234) INFO Average aspect 50.79% complete
2021-07-18 12:46:38,727 Task._call(1234) INFO Average aspect 51.06% complete
2021-07-18 12:46:38,812 Task._call(1234) INFO Average aspect 51.33% complete
2021-07-18 12:46:38,882 Task._call(1234) INFO Average aspect 51.60% complete
2021-07-18 12:46:38,942 Task._call(1234) INFO Average aspect 51.86% complete
2021-07-18 12:46:39,033 Task._call(1234) INFO Average aspect 52.13% complete
2021-07-18 12:46:39,094 Task._call(1234) INFO Average aspect 52.40% complete
2021-07-18 12:46:39,154 Task._call(1234) INFO Average aspect 52.66% complete
2021-07-18 12:46:39,166 Task._call(1234) INFO Average aspect 52.93% complete
2021-07-18 12:46:39,171 Task._call(1234) INFO Average aspect 53.00% complete
2021-07-18 12:46:39,176 Task._call(1234) INFO Average aspect 53.27% complete
2021-07-18 12:46:39,213 Task._call(1234) INFO Average aspect 53.54% complete
2021-07-18 12:46:39,309 Task._call(1234) INFO Average aspect 53.80% complete
2021-07-18 12:46:39,393 Task._call(1234) INFO Average aspect 54.07% complete
2021-07-18 12:46:39,503 Task._call(1234) INFO Average aspect 54.34% complete
2021-07-18 12:46:39,634 Task._call(1234) INFO Average aspect 54.60% complete
2021-07-18 12:46:39,700 Task._call(1234) INFO Average aspect 54.87% complete
2021-07-18 12:46:39,755 Task._call(1234) INFO Average aspect 55.14% complete
2021-07-18 12:46:39,841 Task._call(1234) INFO Average aspect 55.41% complete
2021-07-18 12:46:39,896 Task._call(1234) INFO Average aspect 55.67% complete
2021-07-18 12:46:39,972 Task._call(1234) INFO Average aspect 55.94% complete
2021-07-18 12:46:40,036 Task._call(1234) INFO Average aspect 56.21% complete
2021-07-18 12:46:40,144 Task._call(1234) INFO Average aspect 56.47% complete
2021-07-18 12:46:40,230 Task._call(1234) INFO Average aspect 56.74% complete
2021-07-18 12:46:40,311 Task._call(1234) INFO Average aspect 57.01% complete
2021-07-18 12:46:40,316 Task._call(1234) INFO Average aspect 57.08% complete
2021-07-18 12:46:40,322 Task._call(1234) INFO Average aspect 57.35% complete
2021-07-18 12:46:40,389 Task._call(1234) INFO Average aspect 57.61% complete
2021-07-18 12:46:40,453 Task._call(1234) INFO Average aspect 57.88% complete
2021-07-18 12:46:40,544 Task._call(1234) INFO Average aspect 58.15% complete
2021-07-18 12:46:40,673 Task._call(1234) INFO Average aspect 58.41% complete
2021-07-18 12:46:40,747 Task._call(1234) INFO Average aspect 58.68% complete
2021-07-18 12:46:40,808 Task._call(1234) INFO Average aspect 58.95% complete
2021-07-18 12:46:40,888 Task._call(1234) INFO Average aspect 59.22% complete
2021-07-18 12:46:40,932 Task._call(1234) INFO Average aspect 59.48% complete
2021-07-18 12:46:40,985 Task._call(1234) INFO Average aspect 59.75% complete
2021-07-18 12:46:41,073 Task._call(1234) INFO Average aspect 60.02% complete
2021-07-18 12:46:41,191 Task._call(1234) INFO Average aspect 60.28% complete
2021-07-18 12:46:41,262 Task._call(1234) INFO Average aspect 60.55% complete
2021-07-18 12:46:41,331 Task._call(1234) INFO Average aspect 60.82% complete
2021-07-18 12:46:41,517 Task._call(1234) INFO Average aspect 61.09% complete
2021-07-18 12:46:41,564 Task._call(1234) INFO Average aspect 61.16% complete
2021-07-18 12:46:41,571 Task._call(1234) INFO Average aspect 61.42% complete
2021-07-18 12:46:41,619 Task._call(1234) INFO Average aspect 61.69% complete
2021-07-18 12:46:41,737 Task._call(1234) INFO Average aspect 61.96% complete
2021-07-18 12:46:41,815 Task._call(1234) INFO Average aspect 62.22% complete
2021-07-18 12:46:41,868 Task._call(1234) INFO Average aspect 62.49% complete
2021-07-18 12:46:41,927 Task._call(1234) INFO Average aspect 62.76% complete
2021-07-18 12:46:42,037 Task._call(1234) INFO Average aspect 63.03% complete
2021-07-18 12:46:42,128 Task._call(1234) INFO Average aspect 63.29% complete
2021-07-18 12:46:42,195 Task._call(1234) INFO Average aspect 63.56% complete
2021-07-18 12:46:42,248 Task._call(1234) INFO Average aspect 63.83% complete
2021-07-18 12:46:42,344 Task._call(1234) INFO Average aspect 64.09% complete
2021-07-18 12:46:42,443 Task._call(1234) INFO Average aspect 64.36% complete
2021-07-18 12:46:42,503 Task._call(1234) INFO Average aspect 64.63% complete
2021-07-18 12:46:42,558 Task._call(1234) INFO Average aspect 64.90% complete
2021-07-18 12:46:42,674 Task._call(1234) INFO Average aspect 65.16% complete
2021-07-18 12:46:42,680 Task._call(1234) INFO Average aspect 65.23% complete
2021-07-18 12:46:42,683 Task._call(1234) INFO Average aspect 65.50% complete
2021-07-18 12:46:42,729 Task._call(1234) INFO Average aspect 65.77% complete
2021-07-18 12:46:42,790 Task._call(1234) INFO Average aspect 66.03% complete
2021-07-18 12:46:42,862 Task._call(1234) INFO Average aspect 66.30% complete
2021-07-18 12:46:42,931 Task._call(1234) INFO Average aspect 66.57% complete
2021-07-18 12:46:42,982 Task._call(1234) INFO Average aspect 66.84% complete
2021-07-18 12:46:43,053 Task._call(1234) INFO Average aspect 67.10% complete
2021-07-18 12:46:43,142 Task._call(1234) INFO Average aspect 67.37% complete
2021-07-18 12:46:43,196 Task._call(1234) INFO Average aspect 67.64% complete
2021-07-18 12:46:43,252 Task._call(1234) INFO Average aspect 67.90% complete
2021-07-18 12:46:43,329 Task._call(1234) INFO Average aspect 68.17% complete
2021-07-18 12:46:43,376 Task._call(1234) INFO Average aspect 68.44% complete
2021-07-18 12:46:43,448 Task._call(1234) INFO Average aspect 68.71% complete
2021-07-18 12:46:43,455 Task._call(1234) INFO Average aspect 68.97% complete
2021-07-18 12:46:43,458 Task._call(1234) INFO Average aspect 69.24% complete
2021-07-18 12:46:43,470 Task._call(1234) INFO Average aspect 69.31% complete
2021-07-18 12:46:43,542 Task._call(1234) INFO Average aspect 69.58% complete
2021-07-18 12:46:43,615 Task._call(1234) INFO Average aspect 69.84% complete
2021-07-18 12:46:43,705 Task._call(1234) INFO Average aspect 70.11% complete
2021-07-18 12:46:43,778 Task._call(1234) INFO Average aspect 70.38% complete
2021-07-18 12:46:43,875 Task._call(1234) INFO Average aspect 70.65% complete
2021-07-18 12:46:44,003 Task._call(1234) INFO Average aspect 70.91% complete
2021-07-18 12:46:44,060 Task._call(1234) INFO Average aspect 71.18% complete
2021-07-18 12:46:44,131 Task._call(1234) INFO Average aspect 71.45% complete
2021-07-18 12:46:44,176 Task._call(1234) INFO Average aspect 71.71% complete
2021-07-18 12:46:44,218 Task._call(1234) INFO Average aspect 71.98% complete
2021-07-18 12:46:44,250 Task._call(1234) INFO Average aspect 72.25% complete
2021-07-18 12:46:44,326 Task._call(1234) INFO Average aspect 72.52% complete
2021-07-18 12:46:44,387 Task._call(1234) INFO Average aspect 72.78% complete
2021-07-18 12:46:44,392 Task._call(1234) INFO Average aspect 73.05% complete
2021-07-18 12:46:44,516 Task._call(1234) INFO Average aspect 73.32% complete
2021-07-18 12:46:44,524 Task._call(1234) INFO Average aspect 73.39% complete
2021-07-18 12:46:44,619 Task._call(1234) INFO Average aspect 73.65% complete
2021-07-18 12:46:44,706 Task._call(1234) INFO Average aspect 73.92% complete
2021-07-18 12:46:44,767 Task._call(1234) INFO Average aspect 74.19% complete
2021-07-18 12:46:44,821 Task._call(1234) INFO Average aspect 74.46% complete
2021-07-18 12:46:44,869 Task._call(1234) INFO Average aspect 74.72% complete
2021-07-18 12:46:44,925 Task._call(1234) INFO Average aspect 74.99% complete
2021-07-18 12:46:45,022 Task._call(1234) INFO Average aspect 75.26% complete
2021-07-18 12:46:45,069 Task._call(1234) INFO Average aspect 75.52% complete
2021-07-18 12:46:45,138 Task._call(1234) INFO Average aspect 75.79% complete
2021-07-18 12:46:45,194 Task._call(1234) INFO Average aspect 76.06% complete
2021-07-18 12:46:45,273 Task._call(1234) INFO Average aspect 76.33% complete
2021-07-18 12:46:45,355 Task._call(1234) INFO Average aspect 76.59% complete
2021-07-18 12:46:45,396 Task._call(1234) INFO Average aspect 76.86% complete
2021-07-18 12:46:45,442 Task._call(1234) INFO Average aspect 77.13% complete
2021-07-18 12:46:45,449 Task._call(1234) INFO Average aspect 77.39% complete
2021-07-18 12:46:45,450 Task._call(1234) INFO Average aspect 77.46% complete
2021-07-18 12:46:45,497 Task._call(1234) INFO Average aspect 77.73% complete
2021-07-18 12:46:45,601 Task._call(1234) INFO Average aspect 78.00% complete
2021-07-18 12:46:45,691 Task._call(1234) INFO Average aspect 78.27% complete
2021-07-18 12:46:45,785 Task._call(1234) INFO Average aspect 78.53% complete
2021-07-18 12:46:45,894 Task._call(1234) INFO Average aspect 78.80% complete
2021-07-18 12:46:45,972 Task._call(1234) INFO Average aspect 79.07% complete
2021-07-18 12:46:46,069 Task._call(1234) INFO Average aspect 79.33% complete
2021-07-18 12:46:46,157 Task._call(1234) INFO Average aspect 79.60% complete
2021-07-18 12:46:46,221 Task._call(1234) INFO Average aspect 79.87% complete
2021-07-18 12:46:46,351 Task._call(1234) INFO Average aspect 80.14% complete
2021-07-18 12:46:46,458 Task._call(1234) INFO Average aspect 80.40% complete
2021-07-18 12:46:46,527 Task._call(1234) INFO Average aspect 80.67% complete
2021-07-18 12:46:46,607 Task._call(1234) INFO Average aspect 80.94% complete
2021-07-18 12:46:46,684 Task._call(1234) INFO Average aspect 81.20% complete
2021-07-18 12:46:46,697 Task._call(1234) INFO Average aspect 81.47% complete
2021-07-18 12:46:46,699 Task._call(1234) INFO Average aspect 81.54% complete
2021-07-18 12:46:46,783 Task._call(1234) INFO Average aspect 81.81% complete
2021-07-18 12:46:46,870 Task._call(1234) INFO Average aspect 82.08% complete
2021-07-18 12:46:46,986 Task._call(1234) INFO Average aspect 82.34% complete
2021-07-18 12:46:47,052 Task._call(1234) INFO Average aspect 82.61% complete
2021-07-18 12:46:47,174 Task._call(1234) INFO Average aspect 82.88% complete
2021-07-18 12:46:47,251 Task._call(1234) INFO Average aspect 83.14% complete
2021-07-18 12:46:47,362 Task._call(1234) INFO Average aspect 83.41% complete
2021-07-18 12:46:47,399 Task._call(1234) INFO Average aspect 83.68% complete
2021-07-18 12:46:47,493 Task._call(1234) INFO Average aspect 83.95% complete
2021-07-18 12:46:47,543 Task._call(1234) INFO Average aspect 84.21% complete
2021-07-18 12:46:47,692 Task._call(1234) INFO Average aspect 84.48% complete
2021-07-18 12:46:47,724 Task._call(1234) INFO Average aspect 84.75% complete
2021-07-18 12:46:47,776 Task._call(1234) INFO Average aspect 85.01% complete
2021-07-18 12:46:47,779 Task._call(1234) INFO Average aspect 85.28% complete
2021-07-18 12:46:47,798 Task._call(1234) INFO Average aspect 85.55% complete
2021-07-18 12:46:47,803 Task._call(1234) INFO Average aspect 85.62% complete
2021-07-18 12:46:47,873 Task._call(1234) INFO Average aspect 85.89% complete
2021-07-18 12:46:47,965 Task._call(1234) INFO Average aspect 86.15% complete
2021-07-18 12:46:48,044 Task._call(1234) INFO Average aspect 86.42% complete
2021-07-18 12:46:48,182 Task._call(1234) INFO Average aspect 86.69% complete
2021-07-18 12:46:48,277 Task._call(1234) INFO Average aspect 86.95% complete
2021-07-18 12:46:48,369 Task._call(1234) INFO Average aspect 87.22% complete
2021-07-18 12:46:48,436 Task._call(1234) INFO Average aspect 87.49% complete
2021-07-18 12:46:48,517 Task._call(1234) INFO Average aspect 87.76% complete
2021-07-18 12:46:48,568 Task._call(1234) INFO Average aspect 88.02% complete
2021-07-18 12:46:48,640 Task._call(1234) INFO Average aspect 88.29% complete
2021-07-18 12:46:48,686 Task._call(1234) INFO Average aspect 88.56% complete
2021-07-18 12:46:48,735 Task._call(1234) INFO Average aspect 88.82% complete
2021-07-18 12:46:48,747 Task._call(1234) INFO Average aspect 89.09% complete
2021-07-18 12:46:48,755 Task._call(1234) INFO Average aspect 89.36% complete
2021-07-18 12:46:48,760 Task._call(1234) INFO Average aspect 89.62% complete
2021-07-18 12:46:48,764 Task._call(1234) INFO Average aspect 89.70% complete
2021-07-18 12:46:48,766 Task._call(1234) INFO Average aspect 89.96% complete
2021-07-18 12:46:48,875 Task._call(1234) INFO Average aspect 90.23% complete
2021-07-18 12:46:48,944 Task._call(1234) INFO Average aspect 90.50% complete
2021-07-18 12:46:49,011 Task._call(1234) INFO Average aspect 90.76% complete
2021-07-18 12:46:49,054 Task._call(1234) INFO Average aspect 91.03% complete
2021-07-18 12:46:49,175 Task._call(1234) INFO Average aspect 91.30% complete
2021-07-18 12:46:49,262 Task._call(1234) INFO Average aspect 91.57% complete
2021-07-18 12:46:49,351 Task._call(1234) INFO Average aspect 91.83% complete
2021-07-18 12:46:49,429 Task._call(1234) INFO Average aspect 92.10% complete
2021-07-18 12:46:49,461 Task._call(1234) INFO Average aspect 92.37% complete
2021-07-18 12:46:49,561 Task._call(1234) INFO Average aspect 92.63% complete
2021-07-18 12:46:49,608 Task._call(1234) INFO Average aspect 92.90% complete
2021-07-18 12:46:49,614 Task._call(1234) INFO Average aspect 93.17% complete
2021-07-18 12:46:49,619 Task._call(1234) INFO Average aspect 93.43% complete
2021-07-18 12:46:49,623 Task._call(1234) INFO Average aspect 93.70% complete
2021-07-18 12:46:49,625 Task._call(1234) INFO Average aspect 93.77% complete
2021-07-18 12:46:49,629 Task._call(1234) INFO Average aspect 94.04% complete
2021-07-18 12:46:49,632 Task._call(1234) INFO Average aspect 94.31% complete
2021-07-18 12:46:49,635 Task._call(1234) INFO Average aspect 94.57% complete
2021-07-18 12:46:49,677 Task._call(1234) INFO Average aspect 94.84% complete
2021-07-18 12:46:49,731 Task._call(1234) INFO Average aspect 95.11% complete
2021-07-18 12:46:49,797 Task._call(1234) INFO Average aspect 95.38% complete
2021-07-18 12:46:49,896 Task._call(1234) INFO Average aspect 95.64% complete
2021-07-18 12:46:49,988 Task._call(1234) INFO Average aspect 95.91% complete
2021-07-18 12:46:50,036 Task._call(1234) INFO Average aspect 96.18% complete
2021-07-18 12:46:50,089 Task._call(1234) INFO Average aspect 96.44% complete
2021-07-18 12:46:50,128 Task._call(1234) INFO Average aspect 96.71% complete
2021-07-18 12:46:50,131 Task._call(1234) INFO Average aspect 96.98% complete
2021-07-18 12:46:50,134 Task._call(1234) INFO Average aspect 97.24% complete
2021-07-18 12:46:50,136 Task._call(1234) INFO Average aspect 97.51% complete
2021-07-18 12:46:50,152 Task._call(1234) INFO Average aspect 97.78% complete
2021-07-18 12:46:50,158 Task._call(1234) INFO Average aspect 97.85% complete
2021-07-18 12:46:50,161 Task._call(1234) INFO Average aspect 97.99% complete
2021-07-18 12:46:50,164 Task._call(1234) INFO Average aspect 98.13% complete
2021-07-18 12:46:50,166 Task._call(1234) INFO Average aspect 98.27% complete
2021-07-18 12:46:50,169 Task._call(1234) INFO Average aspect 98.41% complete
2021-07-18 12:46:50,220 Task._call(1234) INFO Average aspect 98.55% complete
2021-07-18 12:46:50,300 Task._call(1234) INFO Average aspect 98.70% complete
2021-07-18 12:46:50,373 Task._call(1234) INFO Average aspect 98.84% complete
2021-07-18 12:46:50,451 Task._call(1234) INFO Average aspect 98.98% complete
2021-07-18 12:46:50,528 Task._call(1234) INFO Average aspect 99.12% complete
2021-07-18 12:46:50,538 Task._call(1234) INFO Average aspect 99.26% complete
2021-07-18 12:46:50,547 Task._call(1234) INFO Average aspect 99.40% complete
2021-07-18 12:46:50,553 Task._call(1234) INFO Average aspect 99.54% complete
2021-07-18 12:46:50,558 Task._call(1234) INFO Average aspect 99.68% complete
2021-07-18 12:46:50,562 Task._call(1234) INFO Average aspect 99.82% complete
2021-07-18 12:46:50,565 Task._call(1234) INFO Average aspect 99.96% complete
2021-07-18 12:46:50,567 Task._call(1234) INFO Average aspect 100.00% complete
2021-07-18 12:46:51,568 Task._call(1234) DEBUG creating target flow accum raster layer
2021-07-18 12:46:52,898 Task._call(1234) DEBUG creating visited raster layer
2021-07-18 12:46:52,943 Task._call(1234) DEBUG starting search
2021-07-18 12:46:57,000 Task._call(1234) INFO mfd flow accum 10.7% complete
2021-07-18 12:47:03,000 Task._call(1234) INFO mfd flow accum 16.3% complete
2021-07-18 12:47:09,012 Task._call(1234) INFO mfd flow accum 20.0% complete
2021-07-18 12:47:15,071 Task._call(1234) INFO mfd flow accum 23.7% complete
2021-07-18 12:47:21,064 Task._call(1234) INFO mfd flow accum 27.7% complete
2021-07-18 12:47:27,079 Task._call(1234) INFO mfd flow accum 34.1% complete
2021-07-18 12:47:33,000 Task._call(1234) INFO mfd flow accum 39.2% complete
2021-07-18 12:47:39,043 Task._call(1234) INFO mfd flow accum 42.6% complete
2021-07-18 12:47:45,200 Task._call(1234) INFO mfd flow accum 44.5% complete
2021-07-18 12:47:51,000 Task._call(1234) INFO mfd flow accum 50.3% complete
2021-07-18 12:48:01,565 Task._call(1234) INFO 100.0% complete
2021-07-18 12:48:03,443 geoprocessing.raster_calculator(391) INFO starting stats_worker
2021-07-18 12:48:03,447 threading.run(870) DEBUG stats worker PID: 10420
2021-07-18 12:48:03,447 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-154, started daemon 17644)>
2021-07-18 12:48:06,738 geoprocessing.raster_calculator(477) INFO 100.0% complete
2021-07-18 12:48:06,739 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2021-07-18 12:48:28,001 Task._call(1234) INFO 48.9% complete
2021-07-18 12:48:34,000 Task._call(1234) INFO 73.4% complete
2021-07-18 12:48:38,495 Task._call(1234) INFO filter out incomplete divergent streams
2021-07-18 12:48:38,749 Task._call(1234) INFO 100.0% complete
2021-07-18 12:48:39,272 geoprocessing.raster_calculator(391) INFO starting stats_worker
2021-07-18 12:48:39,276 threading.run(870) DEBUG stats worker PID: 10420
2021-07-18 12:48:39,276 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-155, started daemon 15764)>
2021-07-18 12:48:39,807 geoprocessing.raster_calculator(477) INFO 100.0% complete
2021-07-18 12:48:39,827 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2021-07-18 12:48:40,963 geoprocessing.raster_calculator(391) INFO starting stats_worker
2021-07-18 12:48:40,964 threading.run(870) DEBUG stats worker PID: 10420
2021-07-18 12:48:40,964 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-156, started daemon 8376)>
2021-07-18 12:48:41,191 geoprocessing.raster_calculator(477) INFO 100.0% complete
2021-07-18 12:48:41,192 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2021-07-18 12:48:42,313 geoprocessing.raster_calculator(391) INFO starting stats_worker
2021-07-18 12:48:42,317 threading.run(870) DEBUG stats worker PID: 10420
2021-07-18 12:48:42,317 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-157, started daemon 3908)>
2021-07-18 12:48:42,877 geoprocessing.raster_calculator(477) INFO 100.0% complete
2021-07-18 12:48:42,877 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2021-07-18 12:48:46,357 geoprocessing.raster_calculator(391) INFO starting stats_worker
2021-07-18 12:48:46,358 threading.run(870) DEBUG stats worker PID: 10420
2021-07-18 12:48:46,358 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-158, started daemon 16128)>
2021-07-18 12:48:47,508 geoprocessing.raster_calculator(477) INFO 100.0% complete
2021-07-18 12:48:47,523 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2021-07-18 12:49:03,776 geoprocessing.raster_calculator(391) INFO starting stats_worker
2021-07-18 12:49:03,778 threading.run(870) DEBUG stats worker PID: 10420
2021-07-18 12:49:03,778 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-159, started daemon 6220)>
2021-07-18 12:49:04,403 geoprocessing.raster_calculator(477) INFO 100.0% complete
2021-07-18 12:49:04,404 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2021-07-18 12:49:20,240 sdr._calculate_bar_factor(1088) DEBUG doing flow accumulation mfd on F:/InVEST/Workspace/0717tj\intermediate_outputs\w_threshold.tif
2021-07-18 12:49:20,254 sdr._calculate_bar_factor(1096) DEBUG creating target flow accum raster layer
2021-07-18 12:49:21,703 sdr._calculate_bar_factor(1096) DEBUG creating visited raster layer
2021-07-18 12:49:21,805 sdr._calculate_bar_factor(1096) DEBUG starting search
2021-07-18 12:49:26,068 sdr._calculate_bar_factor(1096) INFO mfd flow accum 10.8% complete
2021-07-18 12:49:32,121 sdr._calculate_bar_factor(1096) INFO mfd flow accum 16.6% complete
2021-07-18 12:49:38,152 sdr._calculate_bar_factor(1096) INFO mfd flow accum 21.0% complete
2021-07-18 12:49:44,011 sdr._calculate_bar_factor(1096) INFO mfd flow accum 24.6% complete
2021-07-18 12:49:50,108 sdr._calculate_bar_factor(1096) INFO mfd flow accum 28.4% complete
2021-07-18 12:49:56,025 sdr._calculate_bar_factor(1096) INFO mfd flow accum 35.8% complete
2021-07-18 12:50:02,070 sdr._calculate_bar_factor(1096) INFO mfd flow accum 40.3% complete
2021-07-18 12:50:08,102 sdr._calculate_bar_factor(1096) INFO mfd flow accum 43.9% complete
2021-07-18 12:50:14,268 sdr._calculate_bar_factor(1096) INFO mfd flow accum 48.2% complete
2021-07-18 12:50:26,177 sdr._calculate_bar_factor(1096) INFO 100.0% complete
2021-07-18 12:50:26,298 geoprocessing.raster_calculator(391) INFO starting stats_worker
2021-07-18 12:50:26,302 threading.run(870) DEBUG stats worker PID: 10420
2021-07-18 12:50:26,302 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-160, started daemon 1820)>
2021-07-18 12:50:28,147 geoprocessing.raster_calculator(477) INFO 100.0% complete
2021-07-18 12:50:28,182 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2021-07-18 12:50:40,094 sdr._calculate_bar_factor(1088) DEBUG doing flow accumulation mfd on F:/InVEST/Workspace/0717tj\intermediate_outputs\slope_threshold.tif
2021-07-18 12:50:40,095 sdr._calculate_bar_factor(1096) DEBUG creating target flow accum raster layer
2021-07-18 12:50:41,954 sdr._calculate_bar_factor(1096) DEBUG creating visited raster layer
2021-07-18 12:50:42,062 sdr._calculate_bar_factor(1096) DEBUG starting search
2021-07-18 12:50:46,165 sdr._calculate_bar_factor(1096) INFO mfd flow accum 10.8% complete
2021-07-18 12:50:52,090 sdr._calculate_bar_factor(1096) INFO mfd flow accum 16.5% complete
2021-07-18 12:50:58,000 sdr._calculate_bar_factor(1096) INFO mfd flow accum 20.6% complete
2021-07-18 12:51:04,000 sdr._calculate_bar_factor(1096) INFO mfd flow accum 24.2% complete
2021-07-18 12:51:10,161 sdr._calculate_bar_factor(1096) INFO mfd flow accum 27.7% complete
2021-07-18 12:51:16,000 sdr._calculate_bar_factor(1096) INFO mfd flow accum 33.1% complete
2021-07-18 12:51:22,205 sdr._calculate_bar_factor(1096) INFO mfd flow accum 39.3% complete
2021-07-18 12:51:28,157 sdr._calculate_bar_factor(1096) INFO mfd flow accum 43.1% complete
2021-07-18 12:51:34,096 sdr._calculate_bar_factor(1096) INFO mfd flow accum 44.6% complete
2021-07-18 12:51:40,061 sdr._calculate_bar_factor(1096) INFO mfd flow accum 52.3% complete
2021-07-18 12:51:48,176 sdr._calculate_bar_factor(1096) INFO 100.0% complete
2021-07-18 12:51:48,246 geoprocessing.raster_calculator(391) INFO starting stats_worker
2021-07-18 12:51:48,247 threading.run(870) DEBUG stats worker PID: 10420
2021-07-18 12:51:48,247 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-161, started daemon 11680)>
2021-07-18 12:51:50,061 geoprocessing.raster_calculator(477) INFO 100.0% complete
2021-07-18 12:51:50,062 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2021-07-18 12:52:07,779 geoprocessing.raster_calculator(391) INFO starting stats_worker
2021-07-18 12:52:07,782 threading.run(870) DEBUG stats worker PID: 10420
2021-07-18 12:52:07,782 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-162, started daemon 2600)>
2021-07-18 12:52:09,179 geoprocessing.raster_calculator(477) INFO 100.0% complete
2021-07-18 12:52:09,194 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2021-07-18 12:52:28,381 geoprocessing.raster_calculator(391) INFO starting stats_worker
2021-07-18 12:52:28,385 threading.run(870) DEBUG stats worker PID: 10420
2021-07-18 12:52:28,386 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-163, started daemon 14916)>
2021-07-18 12:52:28,887 geoprocessing.raster_calculator(477) INFO 100.0% complete
2021-07-18 12:52:28,888 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2021-07-18 12:52:42,043 Task._call(1234) INFO 36.7% complete
2021-07-18 12:52:48,222 Task._call(1234) INFO 44.9% complete
2021-07-18 12:52:54,175 Task._call(1234) INFO 53.0% complete
2021-07-18 12:53:00,203 Task._call(1234) INFO 61.2% complete
2021-07-18 12:53:06,255 Task._call(1234) INFO 69.3% complete
2021-07-18 12:53:12,003 Task._call(1234) INFO 77.5% complete
2021-07-18 12:53:18,172 Task._call(1234) INFO 85.6% complete
2021-07-18 12:53:29,638 Task._call(1234) INFO 100.0% complete
2021-07-18 12:53:30,314 geoprocessing.raster_calculator(391) INFO starting stats_worker
2021-07-18 12:53:30,317 threading.run(870) DEBUG stats worker PID: 10420
2021-07-18 12:53:30,317 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-164, started daemon 10568)>
2021-07-18 12:53:31,530 geoprocessing.raster_calculator(477) INFO 100.0% complete
2021-07-18 12:53:31,548 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2021-07-18 12:53:49,082 geoprocessing.raster_calculator(391) INFO starting stats_worker
2021-07-18 12:53:49,085 threading.run(870) DEBUG stats worker PID: 10420
2021-07-18 12:53:49,086 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-165, started daemon 13352)>
2021-07-18 12:53:49,597 geoprocessing.raster_calculator(477) INFO 100.0% complete
2021-07-18 12:53:49,598 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2021-07-18 12:54:12,809 geoprocessing.raster_calculator(391) INFO starting stats_worker
2021-07-18 12:54:12,813 threading.run(870) DEBUG stats worker PID: 10420
2021-07-18 12:54:12,813 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-166, started daemon 14244)>
2021-07-18 12:54:13,498 geoprocessing.raster_calculator(477) INFO 100.0% complete
2021-07-18 12:54:13,519 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2021-07-18 12:54:30,342 geoprocessing.raster_calculator(391) INFO starting stats_worker
2021-07-18 12:54:30,346 threading.run(870) DEBUG stats worker PID: 10420
2021-07-18 12:54:30,346 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-167, started daemon 17460)>
2021-07-18 12:54:31,024 geoprocessing.raster_calculator(477) INFO 100.0% complete
2021-07-18 12:54:31,025 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2021-07-18 12:54:50,073 Task._call(1234) INFO Calculate sediment deposition
2021-07-18 12:54:50,612 Task._call(1234) INFO Sediment deposition 0.00% complete
2021-07-18 12:54:50,614 Task._call(1234) INFO Sediment deposition 0.00% complete
2021-07-18 12:54:50,615 Task._call(1234) INFO Sediment deposition 0.00% complete
2021-07-18 12:54:50,624 Task._call(1234) INFO Sediment deposition 0.00% complete
2021-07-18 12:54:50,630 Task._call(1234) INFO Sediment deposition 0.00% complete
2021-07-18 12:54:50,656 Task._call(1234) INFO Sediment deposition 0.00% complete
2021-07-18 12:54:50,658 Task._call(1234) INFO Sediment deposition 0.00% complete
2021-07-18 12:54:50,674 Task._call(1234) INFO Sediment deposition 0.00% complete
2021-07-18 12:54:50,877 Task._call(1234) INFO Sediment deposition 0.00% complete
2021-07-18 12:54:51,065 Task._call(1234) INFO Sediment deposition 0.00% complete
2021-07-18 12:54:51,169 Task._call(1234) INFO Sediment deposition 0.00% complete
2021-07-18 12:54:51,173 Task._call(1234) INFO Sediment deposition 0.00% complete
2021-07-18 12:54:51,176 Task._call(1234) INFO Sediment deposition 0.00% complete
2021-07-18 12:54:51,179 Task._call(1234) INFO Sediment deposition 0.00% complete
2021-07-18 12:54:51,181 Task._call(1234) INFO Sediment deposition 0.00% complete
2021-07-18 12:54:51,184 Task._call(1234) INFO Sediment deposition 0.00% complete
2021-07-18 12:54:51,185 Task._call(1234) INFO Sediment deposition 0.00% complete
2021-07-18 12:54:51,188 Task._call(1234) INFO Sediment deposition 0.27% complete
2021-07-18 12:54:51,190 Task._call(1234) INFO Sediment deposition 0.53% complete
2021-07-18 12:54:51,197 Task._call(1234) INFO Sediment deposition 0.80% complete
2021-07-18 12:54:51,199 Task._call(1234) INFO Sediment deposition 1.07% complete
2021-07-18 12:54:51,201 Task._call(1234) INFO Sediment deposition 1.34% complete
2021-07-18 12:54:51,203 Task._call(1234) INFO Sediment deposition 1.60% complete
2021-07-18 12:54:51,313 Task._call(1234) INFO Sediment deposition 1.87% complete
2021-07-18 12:54:51,378 Task._call(1234) INFO Sediment deposition 2.14% complete
2021-07-18 12:54:51,527 Task._call(1234) INFO Sediment deposition 2.40% complete
2021-07-18 12:54:51,662 Task._call(1234) INFO Sediment deposition 2.67% complete
2021-07-18 12:54:51,699 Task._call(1234) INFO Sediment deposition 2.94% complete
2021-07-18 12:54:51,703 Task._call(1234) INFO Sediment deposition 3.20% complete
2021-07-18 12:54:51,707 Task._call(1234) INFO Sediment deposition 3.47% complete
2021-07-18 12:54:51,711 Task._call(1234) INFO Sediment deposition 3.74% complete
2021-07-18 12:54:51,714 Task._call(1234) INFO Sediment deposition 4.01% complete
2021-07-18 12:54:51,716 Task._call(1234) INFO Sediment deposition 0.00% complete
2021-07-18 12:54:51,718 Task._call(1234) INFO Sediment deposition 0.53% complete
2021-07-18 12:54:51,721 Task._call(1234) INFO Sediment deposition 1.07% complete
2021-07-18 12:54:51,724 Task._call(1234) INFO Sediment deposition 1.60% complete
2021-07-18 12:54:51,726 Task._call(1234) INFO Sediment deposition 2.14% complete
2021-07-18 12:54:51,728 Task._call(1234) INFO Sediment deposition 2.67% complete
2021-07-18 12:54:51,905 Task._call(1234) INFO Sediment deposition 3.20% complete
2021-07-18 12:54:51,988 Task._call(1234) INFO Sediment deposition 3.74% complete
2021-07-18 12:54:52,089 Task._call(1234) INFO Sediment deposition 4.27% complete
2021-07-18 12:54:52,203 Task._call(1234) INFO Sediment deposition 4.81% complete
2021-07-18 12:54:52,336 Task._call(1234) INFO Sediment deposition 5.34% complete
2021-07-18 12:54:52,591 Task._call(1234) INFO Sediment deposition 5.88% complete
2021-07-18 12:54:52,710 Task._call(1234) INFO Sediment deposition 6.41% complete
2021-07-18 12:54:52,714 Task._call(1234) INFO Sediment deposition 6.94% complete
2021-07-18 12:54:52,717 Task._call(1234) INFO Sediment deposition 7.48% complete
2021-07-18 12:54:52,721 Task._call(1234) INFO Sediment deposition 8.01% complete
2021-07-18 12:54:52,756 Task._call(1234) INFO Sediment deposition 0.00% complete
2021-07-18 12:54:52,764 Task._call(1234) INFO Sediment deposition 0.80% complete
2021-07-18 12:54:52,766 Task._call(1234) INFO Sediment deposition 1.60% complete
2021-07-18 12:54:52,769 Task._call(1234) INFO Sediment deposition 2.40% complete
2021-07-18 12:54:52,772 Task._call(1234) INFO Sediment deposition 3.20% complete
2021-07-18 12:54:52,775 Task._call(1234) INFO Sediment deposition 4.01% complete
2021-07-18 12:54:52,856 Task._call(1234) INFO Sediment deposition 4.81% complete
2021-07-18 12:54:52,952 Task._call(1234) INFO Sediment deposition 5.61% complete
2021-07-18 12:54:53,078 Task._call(1234) INFO Sediment deposition 6.41% complete
2021-07-18 12:54:53,217 Task._call(1234) INFO Sediment deposition 7.21% complete
2021-07-18 12:54:53,256 Task._call(1234) INFO Sediment deposition 8.01% complete
2021-07-18 12:54:53,417 Task._call(1234) INFO Sediment deposition 8.81% complete
2021-07-18 12:54:53,532 Task._call(1234) INFO Sediment deposition 9.61% complete
2021-07-18 12:54:53,547 Task._call(1234) INFO Sediment deposition 10.42% complete
2021-07-18 12:54:53,555 Task._call(1234) INFO Sediment deposition 11.22% complete
2021-07-18 12:54:53,574 Task._call(1234) INFO Sediment deposition 12.02% complete
2021-07-18 12:54:53,575 Task._call(1234) INFO Sediment deposition 0.00% complete
2021-07-18 12:54:53,599 Task._call(1234) INFO Sediment deposition 1.07% complete
2021-07-18 12:54:53,607 Task._call(1234) INFO Sediment deposition 2.14% complete
2021-07-18 12:54:53,613 Task._call(1234) INFO Sediment deposition 3.20% complete
2021-07-18 12:54:53,617 Task._call(1234) INFO Sediment deposition 4.27% complete
2021-07-18 12:54:53,658 Task._call(1234) INFO Sediment deposition 5.34% complete
2021-07-18 12:54:53,776 Task._call(1234) INFO Sediment deposition 6.41% complete
2021-07-18 12:54:53,913 Task._call(1234) INFO Sediment deposition 7.48% complete
2021-07-18 12:54:54,008 Task._call(1234) INFO Sediment deposition 8.55% complete
2021-07-18 12:54:54,105 Task._call(1234) INFO Sediment deposition 9.61% complete
2021-07-18 12:54:54,121 Task._call(1234) INFO Sediment deposition 10.68% complete
2021-07-18 12:54:54,137 Task._call(1234) INFO Sediment deposition 11.75% complete
2021-07-18 12:54:54,280 Task._call(1234) INFO Sediment deposition 12.82% complete
2021-07-18 12:54:54,282 Task._call(1234) INFO Sediment deposition 13.89% complete
2021-07-18 12:54:54,285 Task._call(1234) INFO Sediment deposition 14.96% complete
2021-07-18 12:54:54,288 Task._call(1234) INFO Sediment deposition 16.02% complete
2021-07-18 12:54:54,319 Task._call(1234) INFO Sediment deposition 0.00% complete
2021-07-18 12:54:54,331 Task._call(1234) INFO Sediment deposition 1.34% complete
2021-07-18 12:54:54,338 Task._call(1234) INFO Sediment deposition 2.67% complete
2021-07-18 12:54:54,344 Task._call(1234) INFO Sediment deposition 4.01% complete
2021-07-18 12:54:54,370 Task._call(1234) INFO Sediment deposition 5.34% complete
2021-07-18 12:54:54,405 Task._call(1234) INFO Sediment deposition 6.68% complete
2021-07-18 12:54:54,444 Task._call(1234) INFO Sediment deposition 8.01% complete
2021-07-18 12:54:54,562 Task._call(1234) INFO Sediment deposition 9.35% complete
2021-07-18 12:54:54,676 Task._call(1234) INFO Sediment deposition 10.68% complete
2021-07-18 12:54:54,823 Task._call(1234) INFO Sediment deposition 12.02% complete
2021-07-18 12:54:54,854 Task._call(1234) INFO Sediment deposition 13.35% complete
2021-07-18 12:54:54,868 Task._call(1234) INFO Sediment deposition 14.69% complete
2021-07-18 12:54:54,876 Task._call(1234) INFO Sediment deposition 16.02% complete
2021-07-18 12:54:54,882 Task._call(1234) INFO Sediment deposition 17.36% complete
2021-07-18 12:54:54,887 Task._call(1234) INFO Sediment deposition 18.70% complete
2021-07-18 12:54:54,898 Task._call(1234) INFO Sediment deposition 20.03% complete
2021-07-18 12:54:54,900 Task._call(1234) INFO Sediment deposition 0.00% complete
2021-07-18 12:54:54,906 Task._call(1234) INFO Sediment deposition 1.60% complete
2021-07-18 12:54:54,919 Task._call(1234) INFO Sediment deposition 3.20% complete
2021-07-18 12:54:54,921 Task._call(1234) INFO Sediment deposition 4.81% complete
2021-07-18 12:54:54,926 Task._call(1234) INFO Sediment deposition 6.41% complete
2021-07-18 12:54:54,963 Task._call(1234) INFO Sediment deposition 8.01% complete
2021-07-18 12:54:55,081 Task._call(1234) INFO Sediment deposition 9.61% complete
2021-07-18 12:54:55,167 Task._call(1234) INFO Sediment deposition 11.22% complete
2021-07-18 12:54:55,288 Task._call(1234) INFO Sediment deposition 12.82% complete
2021-07-18 12:54:55,437 Task._call(1234) INFO Sediment deposition 14.42% complete
2021-07-18 12:54:55,517 Task._call(1234) INFO Sediment deposition 16.02% complete
2021-07-18 12:54:55,522 Task._call(1234) INFO Sediment deposition 17.63% complete
2021-07-18 12:54:55,526 Task._call(1234) INFO Sediment deposition 19.23% complete
2021-07-18 12:54:55,528 Task._call(1234) INFO Sediment deposition 20.83% complete
2021-07-18 12:54:55,531 Task._call(1234) INFO Sediment deposition 22.43% complete
2021-07-18 12:54:55,534 Task._call(1234) INFO Sediment deposition 24.04% complete
2021-07-18 12:54:55,549 Task._call(1234) INFO Sediment deposition 0.00% complete
2021-07-18 12:54:55,568 Task._call(1234) INFO Sediment deposition 1.87% complete
2021-07-18 12:54:55,576 Task._call(1234) INFO Sediment deposition 3.74% complete
2021-07-18 12:54:55,703 Task._call(1234) INFO Sediment deposition 5.61% complete
2021-07-18 12:54:55,711 Task._call(1234) INFO Sediment deposition 7.48% complete
2021-07-18 12:54:55,717 Task._call(1234) INFO Sediment deposition 9.35% complete
2021-07-18 12:54:55,865 Task._call(1234) INFO Sediment deposition 11.22% complete
2021-07-18 12:54:55,998 Task._call(1234) INFO Sediment deposition 13.09% complete
2021-07-18 12:54:56,111 Task._call(1234) INFO Sediment deposition 14.96% complete
2021-07-18 12:54:56,221 Task._call(1234) INFO Sediment deposition 16.83% complete
2021-07-18 12:54:56,310 Task._call(1234) INFO Sediment deposition 18.70% complete
2021-07-18 12:54:56,367 Task._call(1234) INFO Sediment deposition 20.56% complete
2021-07-18 12:54:56,373 Task._call(1234) INFO Sediment deposition 22.43% complete
2021-07-18 12:54:56,378 Task._call(1234) INFO Sediment deposition 24.30% complete
2021-07-18 12:54:56,382 Task._call(1234) INFO Sediment deposition 26.17% complete
2021-07-18 12:54:56,385 Task._call(1234) INFO Sediment deposition 28.04% complete
2021-07-18 12:54:56,386 Task._call(1234) INFO Sediment deposition 0.00% complete
2021-07-18 12:54:56,389 Task._call(1234) INFO Sediment deposition 2.14% complete
2021-07-18 12:54:56,489 Task._call(1234) INFO Sediment deposition 4.27% complete
2021-07-18 12:54:56,711 Task._call(1234) INFO Sediment deposition 6.41% complete
2021-07-18 12:54:56,755 Task._call(1234) INFO Sediment deposition 8.55% complete
2021-07-18 12:54:56,830 Task._call(1234) INFO Sediment deposition 10.68% complete
2021-07-18 12:54:57,063 Task._call(1234) INFO Sediment deposition 12.82% complete
2021-07-18 12:54:57,329 Task._call(1234) INFO Sediment deposition 14.96% complete
2021-07-18 12:54:57,713 Task._call(1234) INFO Sediment deposition 17.09% complete
2021-07-18 12:54:57,830 Task._call(1234) INFO Sediment deposition 19.23% complete
2021-07-18 12:54:58,319 Task._call(1234) INFO Sediment deposition 21.37% complete
2021-07-18 12:54:58,364 Task._call(1234) INFO Sediment deposition 23.50% complete
2021-07-18 12:54:58,367 Task._call(1234) INFO Sediment deposition 25.64% complete
2021-07-18 12:54:58,392 Task._call(1234) INFO Sediment deposition 27.78% complete
2021-07-18 12:54:58,399 Task._call(1234) INFO Sediment deposition 29.91% complete
2021-07-18 12:54:58,404 Task._call(1234) INFO Sediment deposition 32.05% complete
2021-07-18 12:54:58,406 Task._call(1234) INFO Sediment deposition 0.00% complete
2021-07-18 12:54:58,427 Task._call(1234) INFO Sediment deposition 2.40% complete
2021-07-18 12:54:58,767 Task._call(1234) INFO Sediment deposition 4.81% complete
2021-07-18 12:54:59,101 Task._call(1234) INFO Sediment deposition 7.21% complete
2021-07-18 12:54:59,322 Task._call(1234) INFO Sediment deposition 9.61% complete
2021-07-18 12:54:59,568 Task._call(1234) INFO Sediment deposition 12.02% complete
2021-07-18 12:54:59,916 Task._call(1234) INFO Sediment deposition 14.42% complete
2021-07-18 12:55:00,230 Task._call(1234) INFO Sediment deposition 16.83% complete
2021-07-18 12:55:00,753 Task._call(1234) INFO Sediment deposition 19.23% complete
2021-07-18 12:55:01,139 Task._call(1234) INFO Sediment deposition 21.63% complete
2021-07-18 12:55:01,403 Task._call(1234) INFO Sediment deposition 24.04% complete
2021-07-18 12:55:01,862 Task._call(1234) INFO Sediment deposition 26.44% complete
2021-07-18 12:55:02,527 Task._call(1234) INFO Sediment deposition 28.84% complete
2021-07-18 12:55:02,972 Task._call(1234) INFO Sediment deposition 31.25% complete
2021-07-18 12:55:03,126 Task._call(1234) INFO Sediment deposition 33.65% complete
2021-07-18 12:55:03,140 Task._call(1234) INFO Sediment deposition 36.06% complete
2021-07-18 12:55:03,146 Task._call(1234) INFO Sediment deposition 0.00% complete
2021-07-18 12:55:03,361 Task._call(1234) INFO Sediment deposition 2.67% complete
2021-07-18 12:55:03,708 Task._call(1234) INFO Sediment deposition 5.34% complete
2021-07-18 12:55:03,913 Task._call(1234) INFO Sediment deposition 8.01% complete
2021-07-18 12:55:04,229 Task._call(1234) INFO Sediment deposition 10.68% complete
2021-07-18 12:55:04,486 Task._call(1234) INFO Sediment deposition 13.35% complete
2021-07-18 12:55:04,654 Task._call(1234) INFO Sediment deposition 16.02% complete
2021-07-18 12:55:04,927 Task._call(1234) INFO Sediment deposition 18.70% complete
2021-07-18 12:55:05,145 Task._call(1234) INFO Sediment deposition 21.37% complete
2021-07-18 12:55:05,573 Task._call(1234) INFO Sediment deposition 24.04% complete
2021-07-18 12:55:05,944 Task._call(1234) INFO Sediment deposition 26.71% complete
2021-07-18 12:55:06,257 Task._call(1234) INFO Sediment deposition 29.38% complete
2021-07-18 12:55:06,636 Task._call(1234) INFO Sediment deposition 32.05% complete
2021-07-18 12:55:07,019 Task._call(1234) INFO Sediment deposition 34.72% complete
2021-07-18 12:55:07,395 Task._call(1234) INFO Sediment deposition 37.39% complete
2021-07-18 12:55:07,408 Task._call(1234) INFO Sediment deposition 40.06% complete
2021-07-18 12:55:07,413 Task._call(1234) INFO Sediment deposition 0.00% complete
2021-07-18 12:55:07,645 Task._call(1234) INFO Sediment deposition 2.94% complete
2021-07-18 12:55:07,790 Task._call(1234) INFO Sediment deposition 5.88% complete
2021-07-18 12:55:08,135 Task._call(1234) INFO Sediment deposition 8.81% complete
2021-07-18 12:55:08,417 Task._call(1234) INFO Sediment deposition 11.75% complete
2021-07-18 12:55:08,642 Task._call(1234) INFO Sediment deposition 14.69% complete
2021-07-18 12:55:08,956 Task._call(1234) INFO Sediment deposition 17.63% complete
2021-07-18 12:55:09,173 Task._call(1234) INFO Sediment deposition 20.56% complete
2021-07-18 12:55:09,436 Task._call(1234) INFO Sediment deposition 23.50% complete
2021-07-18 12:55:09,788 Task._call(1234) INFO Sediment deposition 26.44% complete
2021-07-18 12:55:10,104 Task._call(1234) INFO Sediment deposition 29.38% complete
2021-07-18 12:55:10,471 Task._call(1234) INFO Sediment deposition 32.32% complete
2021-07-18 12:55:10,581 Task._call(1234) INFO Sediment deposition 35.25% complete
2021-07-18 12:55:10,845 Task._call(1234) INFO Sediment deposition 38.19% complete
2021-07-18 12:55:11,095 Task._call(1234) INFO Sediment deposition 41.13% complete
2021-07-18 12:55:11,107 Task._call(1234) INFO Sediment deposition 44.07% complete
2021-07-18 12:55:11,108 Task._call(1234) INFO Sediment deposition 0.00% complete
2021-07-18 12:55:11,129 Task._call(1234) INFO Sediment deposition 3.20% complete
2021-07-18 12:55:11,417 Task._call(1234) INFO Sediment deposition 6.41% complete
2021-07-18 12:55:11,755 Task._call(1234) INFO Sediment deposition 9.61% complete
2021-07-18 12:55:11,907 Task._call(1234) INFO Sediment deposition 12.82% complete
2021-07-18 12:55:12,056 Task._call(1234) INFO Sediment deposition 16.02% complete
2021-07-18 12:55:12,395 Task._call(1234) INFO Sediment deposition 19.23% complete
2021-07-18 12:55:12,726 Task._call(1234) INFO Sediment deposition 22.43% complete
2021-07-18 12:55:13,048 Task._call(1234) INFO Sediment deposition 25.64% complete
2021-07-18 12:55:13,462 Task._call(1234) INFO Sediment deposition 28.84% complete
2021-07-18 12:55:13,799 Task._call(1234) INFO Sediment deposition 32.05% complete
2021-07-18 12:55:14,117 Task._call(1234) INFO Sediment deposition 35.25% complete
2021-07-18 12:55:14,404 Task._call(1234) INFO Sediment deposition 38.46% complete
2021-07-18 12:55:14,603 Task._call(1234) INFO Sediment deposition 41.66% complete
2021-07-18 12:55:14,610 Task._call(1234) INFO Sediment deposition 44.87% complete
2021-07-18 12:55:14,615 Task._call(1234) INFO Sediment deposition 48.07% complete
2021-07-18 12:55:14,617 Task._call(1234) INFO Sediment deposition 0.00% complete
2021-07-18 12:55:14,641 Task._call(1234) INFO Sediment deposition 3.47% complete
2021-07-18 12:55:15,084 Task._call(1234) INFO Sediment deposition 6.94% complete
2021-07-18 12:55:15,632 Task._call(1234) INFO Sediment deposition 10.42% complete
2021-07-18 12:55:15,688 Task._call(1234) INFO Sediment deposition 13.89% complete
2021-07-18 12:55:15,905 Task._call(1234) INFO Sediment deposition 17.36% complete
2021-07-18 12:55:16,251 Task._call(1234) INFO Sediment deposition 20.83% complete
2021-07-18 12:55:16,626 Task._call(1234) INFO Sediment deposition 24.30% complete
2021-07-18 12:55:16,783 Task._call(1234) INFO Sediment deposition 27.78% complete
2021-07-18 12:55:17,435 Task._call(1234) INFO Sediment deposition 31.25% complete
2021-07-18 12:55:17,835 Task._call(1234) INFO Sediment deposition 34.72% complete
2021-07-18 12:55:18,258 Task._call(1234) INFO Sediment deposition 38.19% complete
2021-07-18 12:55:18,788 Task._call(1234) INFO Sediment deposition 41.66% complete
2021-07-18 12:55:19,350 Task._call(1234) INFO Sediment deposition 45.14% complete
2021-07-18 12:55:19,821 Task._call(1234) INFO Sediment deposition 48.61% complete
2021-07-18 12:55:20,083 Task._call(1234) INFO Sediment deposition 52.08% complete
2021-07-18 12:55:20,091 Task._call(1234) INFO Sediment deposition 0.00% complete
2021-07-18 12:55:20,100 Task._call(1234) INFO Sediment deposition 3.74% complete
2021-07-18 12:55:20,540 Task._call(1234) INFO Sediment deposition 7.48% complete
2021-07-18 12:55:20,773 Task._call(1234) INFO Sediment deposition 11.22% complete
2021-07-18 12:55:21,081 Task._call(1234) INFO Sediment deposition 14.96% complete
2021-07-18 12:55:21,414 Task._call(1234) INFO Sediment deposition 18.70% complete
2021-07-18 12:55:21,788 Task._call(1234) INFO Sediment deposition 22.43% complete
2021-07-18 12:55:22,265 Task._call(1234) INFO Sediment deposition 26.17% complete
2021-07-18 12:55:22,577 Task._call(1234) INFO Sediment deposition 29.91% complete
2021-07-18 12:55:22,903 Task._call(1234) INFO Sediment deposition 33.65% complete
2021-07-18 12:55:23,141 Task._call(1234) INFO Sediment deposition 37.39% complete
2021-07-18 12:55:23,500 Task._call(1234) INFO Sediment deposition 41.13% complete
2021-07-18 12:55:24,120 Task._call(1234) INFO Sediment deposition 44.87% complete
2021-07-18 12:55:24,185 Task._call(1234) INFO Sediment deposition 48.61% complete
2021-07-18 12:55:24,554 Task._call(1234) INFO Sediment deposition 52.35% complete
2021-07-18 12:55:24,882 Task._call(1234) INFO Sediment deposition 56.09% complete
2021-07-18 12:55:24,960 Task._call(1234) INFO Sediment deposition 0.00% complete
2021-07-18 12:55:24,964 Task._call(1234) INFO Sediment deposition 4.01% complete
2021-07-18 12:55:24,979 Task._call(1234) INFO Sediment deposition 8.01% complete
2021-07-18 12:55:25,226 Task._call(1234) INFO Sediment deposition 12.02% complete
2021-07-18 12:55:25,323 Task._call(1234) INFO Sediment deposition 16.02% complete
2021-07-18 12:55:25,647 Task._call(1234) INFO Sediment deposition 20.03% complete
2021-07-18 12:55:26,303 Task._call(1234) INFO Sediment deposition 24.04% complete
2021-07-18 12:55:26,342 Task._call(1234) INFO Sediment deposition 28.04% complete
2021-07-18 12:55:26,717 Task._call(1234) INFO Sediment deposition 32.05% complete
2021-07-18 12:55:27,041 Task._call(1234) INFO Sediment deposition 36.06% complete
2021-07-18 12:55:27,642 Task._call(1234) INFO Sediment deposition 40.06% complete
2021-07-18 12:55:27,936 Task._call(1234) INFO Sediment deposition 44.07% complete
2021-07-18 12:55:28,312 Task._call(1234) INFO Sediment deposition 48.07% complete
2021-07-18 12:55:28,585 Task._call(1234) INFO Sediment deposition 52.08% complete
2021-07-18 12:55:28,904 Task._call(1234) INFO Sediment deposition 56.09% complete
2021-07-18 12:55:28,907 Task._call(1234) INFO Sediment deposition 60.09% complete
2021-07-18 12:55:28,913 Task._call(1234) INFO Sediment deposition 0.00% complete
2021-07-18 12:55:28,917 Task._call(1234) INFO Sediment deposition 4.27% complete
2021-07-18 12:55:29,314 Task._call(1234) INFO Sediment deposition 8.55% complete
2021-07-18 12:55:29,623 Task._call(1234) INFO Sediment deposition 12.82% complete
2021-07-18 12:55:30,109 Task._call(1234) INFO Sediment deposition 17.09% complete
2021-07-18 12:55:30,277 Task._call(1234) INFO Sediment deposition 21.37% complete
2021-07-18 12:55:30,837 Task._call(1234) INFO Sediment deposition 25.64% complete
2021-07-18 12:55:31,045 Task._call(1234) INFO Sediment deposition 29.91% complete
2021-07-18 12:55:31,277 Task._call(1234) INFO Sediment deposition 34.19% complete
2021-07-18 12:55:31,508 Task._call(1234) INFO Sediment deposition 38.46% complete
2021-07-18 12:55:31,698 Task._call(1234) INFO Sediment deposition 42.73% complete
2021-07-18 12:55:32,108 Task._call(1234) INFO Sediment deposition 47.01% complete
2021-07-18 12:55:32,326 Task._call(1234) INFO Sediment deposition 51.28% complete
2021-07-18 12:55:32,608 Task._call(1234) INFO Sediment deposition 55.55% complete
2021-07-18 12:55:32,629 Task._call(1234) INFO Sediment deposition 59.83% complete
2021-07-18 12:55:32,632 Task._call(1234) INFO Sediment deposition 64.10% complete
2021-07-18 12:55:32,637 Task._call(1234) INFO Sediment deposition 0.00% complete
2021-07-18 12:55:33,377 Task._call(1234) INFO Sediment deposition 4.54% complete
2021-07-18 12:55:33,751 Task._call(1234) INFO Sediment deposition 9.08% complete
2021-07-18 12:55:34,070 Task._call(1234) INFO Sediment deposition 13.62% complete
2021-07-18 12:55:34,307 Task._call(1234) INFO Sediment deposition 18.16% complete
2021-07-18 12:55:34,493 Task._call(1234) INFO Sediment deposition 22.70% complete
2021-07-18 12:55:34,698 Task._call(1234) INFO Sediment deposition 27.24% complete
2021-07-18 12:55:34,820 Task._call(1234) INFO Sediment deposition 31.78% complete
2021-07-18 12:55:35,016 Task._call(1234) INFO Sediment deposition 36.32% complete
2021-07-18 12:55:35,397 Task._call(1234) INFO Sediment deposition 40.86% complete
2021-07-18 12:55:35,584 Task._call(1234) INFO Sediment deposition 45.40% complete
2021-07-18 12:55:36,175 Task._call(1234) INFO Sediment deposition 49.94% complete
2021-07-18 12:55:36,493 Task._call(1234) INFO Sediment deposition 54.48% complete
2021-07-18 12:55:36,673 Task._call(1234) INFO Sediment deposition 59.02% complete
2021-07-18 12:55:36,686 Task._call(1234) INFO Sediment deposition 63.56% complete
2021-07-18 12:55:36,694 Task._call(1234) INFO Sediment deposition 68.10% complete
2021-07-18 12:55:36,698 Task._call(1234) INFO Sediment deposition 0.00% complete
2021-07-18 12:55:36,959 Task._call(1234) INFO Sediment deposition 4.81% complete
2021-07-18 12:55:37,291 Task._call(1234) INFO Sediment deposition 9.61% complete
2021-07-18 12:55:37,655 Task._call(1234) INFO Sediment deposition 14.42% complete
2021-07-18 12:55:38,048 Task._call(1234) INFO Sediment deposition 19.23% complete
2021-07-18 12:55:38,377 Task._call(1234) INFO Sediment deposition 24.04% complete
2021-07-18 12:55:38,765 Task._call(1234) INFO Sediment deposition 28.84% complete
2021-07-18 12:55:39,110 Task._call(1234) INFO Sediment deposition 33.65% complete
2021-07-18 12:55:39,444 Task._call(1234) INFO Sediment deposition 38.46% complete
2021-07-18 12:55:39,638 Task._call(1234) INFO Sediment deposition 43.27% complete
2021-07-18 12:55:39,862 Task._call(1234) INFO Sediment deposition 48.07% complete
2021-07-18 12:55:40,162 Task._call(1234) INFO Sediment deposition 52.88% complete
2021-07-18 12:55:40,699 Task._call(1234) INFO Sediment deposition 57.69% complete
2021-07-18 12:55:40,860 Task._call(1234) INFO Sediment deposition 62.50% complete
2021-07-18 12:55:41,579 Task._call(1234) INFO Sediment deposition 67.30% complete
2021-07-18 12:55:41,582 Task._call(1234) INFO Sediment deposition 72.11% complete
2021-07-18 12:55:41,583 Task._call(1234) INFO Sediment deposition 0.00% complete
2021-07-18 12:55:41,908 Task._call(1234) INFO Sediment deposition 5.07% complete
2021-07-18 12:55:42,314 Task._call(1234) INFO Sediment deposition 10.15% complete
2021-07-18 12:55:42,736 Task._call(1234) INFO Sediment deposition 15.22% complete
2021-07-18 12:55:43,142 Task._call(1234) INFO Sediment deposition 20.30% complete
2021-07-18 12:55:43,425 Task._call(1234) INFO Sediment deposition 25.37% complete
2021-07-18 12:55:44,123 Task._call(1234) INFO Sediment deposition 30.45% complete
2021-07-18 12:55:44,366 Task._call(1234) INFO Sediment deposition 35.52% complete
2021-07-18 12:55:44,715 Task._call(1234) INFO Sediment deposition 40.60% complete
2021-07-18 12:55:47,117 Task._call(1234) INFO Sediment deposition 45.67% complete
2021-07-18 12:55:47,217 Task._call(1234) INFO Sediment deposition 50.74% complete
2021-07-18 12:55:48,037 Task._call(1234) INFO Sediment deposition 55.82% complete
2021-07-18 12:55:48,110 Task._call(1234) INFO Sediment deposition 60.89% complete
2021-07-18 12:55:48,477 Task._call(1234) INFO Sediment deposition 65.97% complete
2021-07-18 12:55:48,485 Task._call(1234) INFO Sediment deposition 71.04% complete
2021-07-18 12:55:48,493 Task._call(1234) INFO Sediment deposition 76.12% complete
2021-07-18 12:55:48,508 Task._call(1234) INFO Sediment deposition 0.00% complete
2021-07-18 12:55:48,621 Task._call(1234) INFO Sediment deposition 5.34% complete
2021-07-18 12:55:49,034 Task._call(1234) INFO Sediment deposition 10.68% complete
2021-07-18 12:55:49,335 Task._call(1234) INFO Sediment deposition 16.02% complete
2021-07-18 12:55:49,564 Task._call(1234) INFO Sediment deposition 21.37% complete
2021-07-18 12:55:49,916 Task._call(1234) INFO Sediment deposition 26.71% complete
2021-07-18 12:55:50,197 Task._call(1234) INFO Sediment deposition 32.05% complete
2021-07-18 12:55:50,512 Task._call(1234) INFO Sediment deposition 37.39% complete
2021-07-18 12:55:51,044 Task._call(1234) INFO Sediment deposition 42.73% complete
2021-07-18 12:55:51,417 Task._call(1234) INFO Sediment deposition 48.07% complete
2021-07-18 12:55:51,638 Task._call(1234) INFO Sediment deposition 53.42% complete
2021-07-18 12:55:51,987 Task._call(1234) INFO Sediment deposition 58.76% complete
2021-07-18 12:55:52,015 Task._call(1234) INFO Sediment deposition 64.10% complete
2021-07-18 12:55:52,017 Task._call(1234) INFO Sediment deposition 69.44% complete
2021-07-18 12:55:52,031 Task._call(1234) INFO Sediment deposition 74.78% complete
2021-07-18 12:55:52,036 Task._call(1234) INFO Sediment deposition 80.12% complete
2021-07-18 12:55:52,039 Task._call(1234) INFO Sediment deposition 0.00% complete
2021-07-18 12:55:52,110 Task._call(1234) INFO Sediment deposition 5.61% complete
2021-07-18 12:55:52,325 Task._call(1234) INFO Sediment deposition 11.22% complete
2021-07-18 12:55:52,576 Task._call(1234) INFO Sediment deposition 16.83% complete
2021-07-18 12:55:52,874 Task._call(1234) INFO Sediment deposition 22.43% complete
2021-07-18 12:55:53,290 Task._call(1234) INFO Sediment deposition 28.04% complete
2021-07-18 12:55:53,481 Task._call(1234) INFO Sediment deposition 33.65% complete
2021-07-18 12:55:53,796 Task._call(1234) INFO Sediment deposition 39.26% complete
2021-07-18 12:55:54,148 Task._call(1234) INFO Sediment deposition 44.87% complete
2021-07-18 12:55:54,592 Task._call(1234) INFO Sediment deposition 50.48% complete
2021-07-18 12:55:54,783 Task._call(1234) INFO Sediment deposition 56.09% complete
2021-07-18 12:55:55,207 Task._call(1234) INFO Sediment deposition 61.69% complete
2021-07-18 12:55:55,393 Task._call(1234) INFO Sediment deposition 67.30% complete
2021-07-18 12:55:55,396 Task._call(1234) INFO Sediment deposition 72.91% complete
2021-07-18 12:55:55,414 Task._call(1234) INFO Sediment deposition 78.52% complete
2021-07-18 12:55:55,425 Task._call(1234) INFO Sediment deposition 84.13% complete
2021-07-18 12:55:55,429 Task._call(1234) INFO Sediment deposition 0.00% complete
2021-07-18 12:55:55,444 Task._call(1234) INFO Sediment deposition 5.88% complete
2021-07-18 12:55:55,634 Task._call(1234) INFO Sediment deposition 11.75% complete
2021-07-18 12:55:55,688 Task._call(1234) INFO Sediment deposition 17.63% complete
2021-07-18 12:55:55,812 Task._call(1234) INFO Sediment deposition 23.50% complete
2021-07-18 12:55:56,132 Task._call(1234) INFO Sediment deposition 29.38% complete
2021-07-18 12:55:56,425 Task._call(1234) INFO Sediment deposition 35.25% complete
2021-07-18 12:55:56,752 Task._call(1234) INFO Sediment deposition 41.13% complete
2021-07-18 12:55:57,064 Task._call(1234) INFO Sediment deposition 47.01% complete
2021-07-18 12:55:57,388 Task._call(1234) INFO Sediment deposition 52.88% complete
2021-07-18 12:55:57,884 Task._call(1234) INFO Sediment deposition 58.76% complete
2021-07-18 12:55:58,087 Task._call(1234) INFO Sediment deposition 64.63% complete
2021-07-18 12:55:58,128 Task._call(1234) INFO Sediment deposition 70.51% complete
2021-07-18 12:55:58,147 Task._call(1234) INFO Sediment deposition 76.38% complete
2021-07-18 12:55:58,150 Task._call(1234) INFO Sediment deposition 82.26% complete
2021-07-18 12:55:58,165 Task._call(1234) INFO Sediment deposition 88.14% complete
2021-07-18 12:55:58,173 Task._call(1234) INFO Sediment deposition 0.00% complete
2021-07-18 12:55:58,180 Task._call(1234) INFO Sediment deposition 6.14% complete
2021-07-18 12:55:58,187 Task._call(1234) INFO Sediment deposition 12.29% complete
2021-07-18 12:55:58,193 Task._call(1234) INFO Sediment deposition 18.43% complete
2021-07-18 12:55:58,378 Task._call(1234) INFO Sediment deposition 24.57% complete
2021-07-18 12:55:58,804 Task._call(1234) INFO Sediment deposition 30.71% complete
2021-07-18 12:55:58,835 Task._call(1234) INFO Sediment deposition 36.86% complete
2021-07-18 12:55:58,980 Task._call(1234) INFO Sediment deposition 43.00% complete
2021-07-18 12:55:59,349 Task._call(1234) INFO Sediment deposition 49.14% complete
2021-07-18 12:55:59,413 Task._call(1234) INFO Sediment deposition 55.28% complete
2021-07-18 12:55:59,760 Task._call(1234) INFO Sediment deposition 61.43% complete
2021-07-18 12:55:59,768 Task._call(1234) INFO Sediment deposition 67.57% complete
2021-07-18 12:55:59,782 Task._call(1234) INFO Sediment deposition 73.71% complete
2021-07-18 12:55:59,785 Task._call(1234) INFO Sediment deposition 79.86% complete
2021-07-18 12:55:59,787 Task._call(1234) INFO Sediment deposition 86.00% complete
2021-07-18 12:55:59,804 Task._call(1234) INFO Sediment deposition 92.14% complete
2021-07-18 12:55:59,807 Task._call(1234) INFO Sediment deposition 0.00% complete
2021-07-18 12:55:59,824 Task._call(1234) INFO Sediment deposition 6.41% complete
2021-07-18 12:55:59,826 Task._call(1234) INFO Sediment deposition 12.82% complete
2021-07-18 12:55:59,836 Task._call(1234) INFO Sediment deposition 19.23% complete
2021-07-18 12:55:59,856 Task._call(1234) INFO Sediment deposition 25.64% complete
2021-07-18 12:55:59,866 Task._call(1234) INFO Sediment deposition 32.05% complete
2021-07-18 12:56:00,030 Task._call(1234) INFO Sediment deposition 38.46% complete
2021-07-18 12:56:00,063 Task._call(1234) INFO Sediment deposition 44.87% complete
2021-07-18 12:56:00,088 Task._call(1234) INFO Sediment deposition 51.28% complete
2021-07-18 12:56:00,184 Task._call(1234) INFO Sediment deposition 57.69% complete
2021-07-18 12:56:00,187 Task._call(1234) INFO Sediment deposition 64.10% complete
2021-07-18 12:56:00,189 Task._call(1234) INFO Sediment deposition 70.51% complete
2021-07-18 12:56:00,194 Task._call(1234) INFO Sediment deposition 76.92% complete
2021-07-18 12:56:00,250 Task._call(1234) INFO Sediment deposition 83.33% complete
2021-07-18 12:56:00,259 Task._call(1234) INFO Sediment deposition 89.74% complete
2021-07-18 12:56:00,266 Task._call(1234) INFO Sediment deposition 96.15% complete
2021-07-18 12:56:00,270 Task._call(1234) INFO Sediment deposition 100% complete
2021-07-18 12:56:13,694 geoprocessing.raster_calculator(391) INFO starting stats_worker
2021-07-18 12:56:13,696 threading.run(870) DEBUG stats worker PID: 10420
2021-07-18 12:56:13,696 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-168, started daemon 17848)>
2021-07-18 12:56:14,747 geoprocessing.raster_calculator(477) INFO 100.0% complete
2021-07-18 12:56:14,748 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2021-07-18 12:56:33,891 geoprocessing.raster_calculator(391) INFO starting stats_worker
2021-07-18 12:56:33,892 threading.run(870) DEBUG stats worker PID: 10420
2021-07-18 12:56:33,892 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-169, started daemon 11488)>
2021-07-18 12:56:34,207 geoprocessing.raster_calculator(477) INFO 100.0% complete
2021-07-18 12:56:34,231 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2021-07-18 12:56:46,158 Task._call(1234) INFO 36.7% complete
2021-07-18 12:56:52,047 Task._call(1234) INFO 40.8% complete
2021-07-18 12:56:58,100 Task._call(1234) INFO 53.0% complete
2021-07-18 12:57:04,351 Task._call(1234) INFO 61.2% complete
2021-07-18 12:57:10,104 Task._call(1234) INFO 69.3% complete
2021-07-18 12:57:16,541 Task._call(1234) INFO 77.5% complete
2021-07-18 12:57:22,117 Task._call(1234) INFO 85.6% complete
2021-07-18 12:57:35,645 Task._call(1234) INFO 100.0% complete
2021-07-18 12:57:57,386 geoprocessing.raster_calculator(391) INFO starting stats_worker
2021-07-18 12:57:57,391 threading.run(870) DEBUG stats worker PID: 10420
2021-07-18 12:57:57,391 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-170, started daemon 18288)>
2021-07-18 12:57:58,558 geoprocessing.raster_calculator(477) INFO 100.0% complete
2021-07-18 12:57:58,558 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2021-07-18 12:58:17,039 geoprocessing.raster_calculator(391) INFO starting stats_worker
2021-07-18 12:58:17,040 threading.run(870) DEBUG stats worker PID: 10420
2021-07-18 12:58:17,040 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-171, started daemon 10388)>
2021-07-18 12:58:18,192 geoprocessing.raster_calculator(477) INFO 100.0% complete
2021-07-18 12:58:18,193 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2021-07-18 12:58:36,306 geoprocessing.raster_calculator(391) INFO starting stats_worker
2021-07-18 12:58:36,307 threading.run(870) DEBUG stats worker PID: 10420
2021-07-18 12:58:36,307 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-172, started daemon 7752)>
2021-07-18 12:58:36,813 geoprocessing.raster_calculator(477) INFO 100.0% complete
2021-07-18 12:58:36,827 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2021-07-18 12:59:13,594 geoprocessing.raster_calculator(391) INFO starting stats_worker
2021-07-18 12:59:13,595 threading.run(870) DEBUG stats worker PID: 10420
2021-07-18 12:59:13,596 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-173, started daemon 16948)>
2021-07-18 12:59:15,017 geoprocessing.raster_calculator(477) INFO 100.0% complete
2021-07-18 12:59:15,018 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2021-07-18 12:59:33,007 utils._log_gdal_errors(80) WARNING [errno 1] Value 564430 of field area_ha of feature 0 not successfully written. Possibly due to too larger number with respect to field width
2021-07-18 12:59:33,144 utils._log_gdal_errors(80) WARNING [errno 1] Value 613859 of field area_ha of feature 1 not successfully written. Possibly due to too larger number with respect to field width
2021-07-18 12:59:33,163 geoprocessing.zonal_statistics(1184) DEBUG <osgeo.gdal.Dataset; proxy of <Swig Object of type 'GDALDatasetShadow *' at 0x0000020D64F08870> >
2021-07-18 12:59:34,430 geoprocessing.align_and_resize_raster_stack(795) INFO 1 of 1 aligned: clipped_raster6vjys5k4.tif
2021-07-18 12:59:34,431 geoprocessing.align_and_resize_raster_stack(797) INFO aligned all 1 rasters.
2021-07-18 12:59:34,441 geoprocessing.zonal_statistics(1244) INFO build a lookup of aggregate field value to FID
2021-07-18 12:59:34,454 geoprocessing.zonal_statistics(1251) INFO creating disjoint polygon set
2021-07-18 12:59:34,454 geoprocessing.calculate_disjoint_polygon_set(2183) INFO build shapely polygon list
2021-07-18 12:59:34,479 geoprocessing.calculate_disjoint_polygon_set(2204) INFO build shapely rtree index
2021-07-18 12:59:34,515 geoprocessing.calculate_disjoint_polygon_set(2219) INFO poly feature lookup 100.0% complete on watershed_results_sdr.shp
2021-07-18 12:59:34,516 geoprocessing.calculate_disjoint_polygon_set(2221) INFO build poly intersection lookup
2021-07-18 12:59:34,525 geoprocessing.calculate_disjoint_polygon_set(2245) INFO poly intersection feature lookup 100.0% complete on watershed_results_sdr.shp
2021-07-18 12:59:34,545 geoprocessing.calculate_disjoint_polygon_set(2279) INFO maximal subset build 100.0% complete on watershed_results_sdr.shp
2021-07-18 12:59:34,586 geoprocessing.zonal_statistics(1274) INFO processing 2 disjoint polygon sets
2021-07-18 12:59:34,588 geoprocessing.zonal_statistics(1309) INFO disjoint polygon set 1 of 2 100.0% processed on watershed_results_sdr.shp
2021-07-18 12:59:34,602 geoprocessing.zonal_statistics(1317) INFO rasterizing disjoint polygon set 1 of 2 watershed_results_sdr.shp
2021-07-18 12:59:34,980 geoprocessing.zonal_statistics(1335) INFO summarizing rasterized disjoint polygon set 1 of 2 watershed_results_sdr.shp
2021-07-18 12:59:35,456 geoprocessing.zonal_statistics(1309) INFO disjoint polygon set 2 of 2 100.0% processed on watershed_results_sdr.shp
2021-07-18 12:59:35,480 geoprocessing.zonal_statistics(1317) INFO rasterizing disjoint polygon set 2 of 2 watershed_results_sdr.shp
2021-07-18 12:59:35,822 geoprocessing.zonal_statistics(1335) INFO summarizing rasterized disjoint polygon set 2 of 2 watershed_results_sdr.shp
2021-07-18 12:59:36,057 geoprocessing.zonal_statistics(1378) DEBUG unset_fids: 0 of 2 
2021-07-18 12:59:36,069 geoprocessing.zonal_statistics(1381) DEBUG gt [ 4.7416428e+05  3.0000000e+01  0.0000000e+00  4.4557900e+06
  0.0000000e+00 -3.0000000e+01] for ('F:/InVEST/Workspace/0717tj\\usle.tif', 1)
2021-07-18 12:59:36,070 geoprocessing.zonal_statistics(1460) DEBUG remaining unset_fids: 0 of 2 
2021-07-18 12:59:36,070 geoprocessing.zonal_statistics(1468) INFO all done processing polygon sets for watershed_results_sdr.shp
2021-07-18 12:59:36,080 geoprocessing.zonal_statistics(1184) DEBUG <osgeo.gdal.Dataset; proxy of <Swig Object of type 'GDALDatasetShadow *' at 0x0000020D64ED8E40> >
2021-07-18 12:59:42,111 geoprocessing.logger_callback(3400) INFO Warp 25.0% complete C:\Users\22694\AppData\Local\Temp\clipped_rasterlxslh4_j.tif
2021-07-18 12:59:48,599 geoprocessing.logger_callback(3400) INFO Warp 75.0% complete C:\Users\22694\AppData\Local\Temp\clipped_rasterlxslh4_j.tif
2021-07-18 12:59:48,653 geoprocessing.logger_callback(3400) INFO Warp 100.0% complete C:\Users\22694\AppData\Local\Temp\clipped_rasterlxslh4_j.tif
2021-07-18 12:59:49,236 geoprocessing.align_and_resize_raster_stack(795) INFO 1 of 1 aligned: clipped_rasterlxslh4_j.tif
2021-07-18 12:59:49,237 geoprocessing.align_and_resize_raster_stack(797) INFO aligned all 1 rasters.
2021-07-18 12:59:49,239 geoprocessing.zonal_statistics(1244) INFO build a lookup of aggregate field value to FID
2021-07-18 12:59:49,248 geoprocessing.zonal_statistics(1251) INFO creating disjoint polygon set
2021-07-18 12:59:49,249 geoprocessing.calculate_disjoint_polygon_set(2183) INFO build shapely polygon list
2021-07-18 12:59:49,256 geoprocessing.calculate_disjoint_polygon_set(2204) INFO build shapely rtree index
2021-07-18 12:59:49,257 geoprocessing.calculate_disjoint_polygon_set(2219) INFO poly feature lookup 100.0% complete on watershed_results_sdr.shp
2021-07-18 12:59:49,257 geoprocessing.calculate_disjoint_polygon_set(2221) INFO build poly intersection lookup
2021-07-18 12:59:49,262 geoprocessing.calculate_disjoint_polygon_set(2245) INFO poly intersection feature lookup 100.0% complete on watershed_results_sdr.shp
2021-07-18 12:59:49,267 geoprocessing.calculate_disjoint_polygon_set(2279) INFO maximal subset build 100.0% complete on watershed_results_sdr.shp
2021-07-18 12:59:49,303 geoprocessing.zonal_statistics(1274) INFO processing 2 disjoint polygon sets
2021-07-18 12:59:49,304 geoprocessing.zonal_statistics(1309) INFO disjoint polygon set 1 of 2 100.0% processed on watershed_results_sdr.shp
2021-07-18 12:59:49,320 geoprocessing.zonal_statistics(1317) INFO rasterizing disjoint polygon set 1 of 2 watershed_results_sdr.shp
2021-07-18 12:59:49,694 geoprocessing.zonal_statistics(1335) INFO summarizing rasterized disjoint polygon set 1 of 2 watershed_results_sdr.shp
2021-07-18 12:59:50,166 geoprocessing.zonal_statistics(1309) INFO disjoint polygon set 2 of 2 100.0% processed on watershed_results_sdr.shp
2021-07-18 12:59:50,175 geoprocessing.zonal_statistics(1317) INFO rasterizing disjoint polygon set 2 of 2 watershed_results_sdr.shp
2021-07-18 12:59:50,550 geoprocessing.zonal_statistics(1335) INFO summarizing rasterized disjoint polygon set 2 of 2 watershed_results_sdr.shp
2021-07-18 12:59:50,784 geoprocessing.zonal_statistics(1378) DEBUG unset_fids: 0 of 2 
2021-07-18 12:59:50,786 geoprocessing.zonal_statistics(1381) DEBUG gt [ 4.7416428e+05  3.0000000e+01  0.0000000e+00  4.4557900e+06
  0.0000000e+00 -3.0000000e+01] for ('F:/InVEST/Workspace/0717tj\\sed_export.tif', 1)
2021-07-18 12:59:50,820 geoprocessing.zonal_statistics(1460) DEBUG remaining unset_fids: 0 of 2 
2021-07-18 12:59:50,824 geoprocessing.zonal_statistics(1468) INFO all done processing polygon sets for watershed_results_sdr.shp
2021-07-18 12:59:50,835 geoprocessing.zonal_statistics(1184) DEBUG <osgeo.gdal.Dataset; proxy of <Swig Object of type 'GDALDatasetShadow *' at 0x0000020D64ED8C00> >
2021-07-18 12:59:52,089 geoprocessing.align_and_resize_raster_stack(795) INFO 1 of 1 aligned: clipped_rasterys434ew5.tif
2021-07-18 12:59:52,090 geoprocessing.align_and_resize_raster_stack(797) INFO aligned all 1 rasters.
2021-07-18 12:59:52,091 geoprocessing.zonal_statistics(1244) INFO build a lookup of aggregate field value to FID
2021-07-18 12:59:52,099 geoprocessing.zonal_statistics(1251) INFO creating disjoint polygon set
2021-07-18 12:59:52,099 geoprocessing.calculate_disjoint_polygon_set(2183) INFO build shapely polygon list
2021-07-18 12:59:52,101 geoprocessing.calculate_disjoint_polygon_set(2204) INFO build shapely rtree index
2021-07-18 12:59:52,101 geoprocessing.calculate_disjoint_polygon_set(2219) INFO poly feature lookup 100.0% complete on watershed_results_sdr.shp
2021-07-18 12:59:52,111 geoprocessing.calculate_disjoint_polygon_set(2221) INFO build poly intersection lookup
2021-07-18 12:59:52,115 geoprocessing.calculate_disjoint_polygon_set(2245) INFO poly intersection feature lookup 100.0% complete on watershed_results_sdr.shp
2021-07-18 12:59:52,125 geoprocessing.calculate_disjoint_polygon_set(2279) INFO maximal subset build 100.0% complete on watershed_results_sdr.shp
2021-07-18 12:59:52,161 geoprocessing.zonal_statistics(1274) INFO processing 2 disjoint polygon sets
2021-07-18 12:59:52,162 geoprocessing.zonal_statistics(1309) INFO disjoint polygon set 1 of 2 100.0% processed on watershed_results_sdr.shp
2021-07-18 12:59:52,169 geoprocessing.zonal_statistics(1317) INFO rasterizing disjoint polygon set 1 of 2 watershed_results_sdr.shp
2021-07-18 12:59:52,538 geoprocessing.zonal_statistics(1335) INFO summarizing rasterized disjoint polygon set 1 of 2 watershed_results_sdr.shp
2021-07-18 12:59:53,022 geoprocessing.zonal_statistics(1309) INFO disjoint polygon set 2 of 2 100.0% processed on watershed_results_sdr.shp
2021-07-18 12:59:53,030 geoprocessing.zonal_statistics(1317) INFO rasterizing disjoint polygon set 2 of 2 watershed_results_sdr.shp
2021-07-18 12:59:53,371 geoprocessing.zonal_statistics(1335) INFO summarizing rasterized disjoint polygon set 2 of 2 watershed_results_sdr.shp
2021-07-18 12:59:53,605 geoprocessing.zonal_statistics(1378) DEBUG unset_fids: 0 of 2 
2021-07-18 12:59:53,607 geoprocessing.zonal_statistics(1381) DEBUG gt [ 4.7416428e+05  3.0000000e+01  0.0000000e+00  4.4557900e+06
  0.0000000e+00 -3.0000000e+01] for ('F:/InVEST/Workspace/0717tj\\sed_retention.tif', 1)
2021-07-18 12:59:53,620 geoprocessing.zonal_statistics(1460) DEBUG remaining unset_fids: 0 of 2 
2021-07-18 12:59:53,620 geoprocessing.zonal_statistics(1468) INFO all done processing polygon sets for watershed_results_sdr.shp
2021-07-18 12:59:53,634 geoprocessing.zonal_statistics(1184) DEBUG <osgeo.gdal.Dataset; proxy of <Swig Object of type 'GDALDatasetShadow *' at 0x0000020D64ED8060> >
2021-07-18 13:00:01,637 geoprocessing.logger_callback(3400) INFO Warp 25.0% complete C:\Users\22694\AppData\Local\Temp\clipped_rasterbwk1yk2o.tif
2021-07-18 13:00:08,531 geoprocessing.logger_callback(3400) INFO Warp 75.0% complete C:\Users\22694\AppData\Local\Temp\clipped_rasterbwk1yk2o.tif
2021-07-18 13:00:08,585 geoprocessing.logger_callback(3400) INFO Warp 100.0% complete C:\Users\22694\AppData\Local\Temp\clipped_rasterbwk1yk2o.tif
2021-07-18 13:00:09,254 geoprocessing.align_and_resize_raster_stack(795) INFO 1 of 1 aligned: clipped_rasterbwk1yk2o.tif
2021-07-18 13:00:09,268 geoprocessing.align_and_resize_raster_stack(797) INFO aligned all 1 rasters.
2021-07-18 13:00:09,268 geoprocessing.zonal_statistics(1244) INFO build a lookup of aggregate field value to FID
2021-07-18 13:00:09,269 geoprocessing.zonal_statistics(1251) INFO creating disjoint polygon set
2021-07-18 13:00:09,269 geoprocessing.calculate_disjoint_polygon_set(2183) INFO build shapely polygon list
2021-07-18 13:00:09,271 geoprocessing.calculate_disjoint_polygon_set(2204) INFO build shapely rtree index
2021-07-18 13:00:09,272 geoprocessing.calculate_disjoint_polygon_set(2219) INFO poly feature lookup 100.0% complete on watershed_results_sdr.shp
2021-07-18 13:00:09,280 geoprocessing.calculate_disjoint_polygon_set(2221) INFO build poly intersection lookup
2021-07-18 13:00:09,284 geoprocessing.calculate_disjoint_polygon_set(2245) INFO poly intersection feature lookup 100.0% complete on watershed_results_sdr.shp
2021-07-18 13:00:09,400 geoprocessing.calculate_disjoint_polygon_set(2279) INFO maximal subset build 100.0% complete on watershed_results_sdr.shp
2021-07-18 13:00:09,444 geoprocessing.zonal_statistics(1274) INFO processing 2 disjoint polygon sets
2021-07-18 13:00:09,445 geoprocessing.zonal_statistics(1309) INFO disjoint polygon set 1 of 2 100.0% processed on watershed_results_sdr.shp
2021-07-18 13:00:09,452 geoprocessing.zonal_statistics(1317) INFO rasterizing disjoint polygon set 1 of 2 watershed_results_sdr.shp
2021-07-18 13:00:09,822 geoprocessing.zonal_statistics(1335) INFO summarizing rasterized disjoint polygon set 1 of 2 watershed_results_sdr.shp
2021-07-18 13:00:10,298 geoprocessing.zonal_statistics(1309) INFO disjoint polygon set 2 of 2 100.0% processed on watershed_results_sdr.shp
2021-07-18 13:00:10,307 geoprocessing.zonal_statistics(1317) INFO rasterizing disjoint polygon set 2 of 2 watershed_results_sdr.shp
2021-07-18 13:00:10,647 geoprocessing.zonal_statistics(1335) INFO summarizing rasterized disjoint polygon set 2 of 2 watershed_results_sdr.shp
2021-07-18 13:00:10,879 geoprocessing.zonal_statistics(1378) DEBUG unset_fids: 0 of 2 
2021-07-18 13:00:10,881 geoprocessing.zonal_statistics(1381) DEBUG gt [ 4.7416428e+05  3.0000000e+01  0.0000000e+00  4.4557900e+06
  0.0000000e+00 -3.0000000e+01] for ('F:/InVEST/Workspace/0717tj\\sed_deposition.tif', 1)
2021-07-18 13:00:10,884 geoprocessing.zonal_statistics(1460) DEBUG remaining unset_fids: 0 of 2 
2021-07-18 13:00:10,884 geoprocessing.zonal_statistics(1468) INFO all done processing polygon sets for watershed_results_sdr.shp
2021-07-18 13:00:10,921 utils._log_gdal_errors(80) WARNING [errno 1] Value 564430 of field area_ha of feature 0 not successfully written. Possibly due to too larger number with respect to field width
2021-07-18 13:00:10,934 utils._log_gdal_errors(80) WARNING [errno 1] Value 613859 of field area_ha of feature 1 not successfully written. Possibly due to too larger number with respect to field width
2021-07-18 13:00:11,259 model._logged_target(1655) INFO Execution finished
2021-07-18 13:00:11,262 utils.prepare_workspace(129) INFO Elapsed time: 16m 6.1200000000000045s