2022-02-28 10:25:36,139 utils.prepare_workspace(123) INFO Writing log messages to C:/Users/AKIR SAID/Documents/forage_workspace/Nouveau dossier (2)\Rangeland-Production-Model-log-2022-02-28--10_25_36.txt
2022-02-28 10:25:36,140 model._logged_target(1635) Level 100 Starting model with parameters: 
Arguments for InVEST rangeland_production.forage 0.2.1:
animal_grazing_areas_path            D:/aaaaaaaaaaaPROJET DE FIN D ETUDE/fiche tfe/modele de parcours/les inputs/sfu per soum/greazing_area.shp
animal_trait_path                    D:/aaaaaaaaaaaPROJET DE FIN D ETUDE/fiche tfe/modele de parcours/les inputs/table csv/table/Nouveau dossier/animale trait table SS1 CSV.csv
aoi_path                             D:/aaaaaaaaaaaPROJET DE FIN D ETUDE/fiche tfe/modele de parcours/les inputs/shefield de souss/Souss Massa/Souss Massa.shp
bulk_density_path                    D:/aaaaaaaaaaaPROJET DE FIN D ETUDE/fiche tfe/modele de parcours/les inputs/masse volumique/masse_vol_echelle.tif
clay_proportion_path                 D:/aaaaaaaaaaaPROJET DE FIN D ETUDE/fiche tfe/modele de parcours/les inputs/proportionn de limon/limon_souss 01.tif
initial_conditions_dir               D:\aaaaaaaaaaaPROJET DE FIN D ETUDE\fiche tfe\modele de parcours\les inputs\table csv\table\Nouveau dossier\Nouveau dossier\Nouveau dossier\diro total
management_threshold                 100
max_temp_dir                         D:\aaaaaaaaaaaPROJET DE FIN D ETUDE\fiche tfe\modele de parcours\les inputs\tmax
min_temp_dir                         D:\aaaaaaaaaaaPROJET DE FIN D ETUDE\fiche tfe\modele de parcours\les inputs\tmin
n_months                             12
n_workers                            -1
pft_initial_table                    D:/aaaaaaaaaaaPROJET DE FIN D ETUDE/fiche tfe/modele de parcours/les inputs/table csv/table/Nouveau dossier/Nouveau dossier/Nouveau dossier/pft initial table CSV SS de.csv
ph_path                              D:/aaaaaaaaaaaPROJET DE FIN D ETUDE/fiche tfe/modele de parcours/les inputs/ph  de sol/ph_souss_echelle.tif
precip_dir                           D:\aaaaaaaaaaaPROJET DE FIN D ETUDE\fiche tfe\modele de parcours\les inputs\precipitation
proportion_legume_path               D:/aaaaaaaaaaaPROJET DE FIN D ETUDE/fiche tfe/modele de parcours/les inputs/table csv/table/Nouveau dossier/Nouveau dossier/Nouveau dossier/DIR2/aglivc.tif
results_suffix                       
sand_proportion_path                 D:/aaaaaaaaaaaPROJET DE FIN D ETUDE/fiche tfe/modele de parcours/les inputs/proportion de sable/sable_souss 01.tif
save_sv_rasters                      True
silt_proportion_path                 D:/aaaaaaaaaaaPROJET DE FIN D ETUDE/fiche tfe/modele de parcours/les inputs/proportion d argile/argile_souss 01.tif
site_initial_table                   D:/aaaaaaaaaaaPROJET DE FIN D ETUDE/fiche tfe/modele de parcours/les inputs/table csv/table/Nouveau dossier/Nouveau dossier/site_initial_table.csv
site_param_spatial_index_path        D:/aaaaaaaaaaaPROJET DE FIN D ETUDE/fiche tfe/modele de parcours/les inputs/pft_/Nouveau dossier/greazing_area_PolygonToRaste361.tif
site_param_table                     D:/aaaaaaaaaaaPROJET DE FIN D ETUDE/fiche tfe/modele de parcours/les inputs/table csv/table/Nouveau dossier/site parametres ESSAI SS.csv
starting_month                       1
starting_year                        2020
veg_spatial_composition_path_pattern D:\aaaaaaaaaaaPROJET DE FIN D ETUDE\fiche tfe\modele de parcours\les inputs\Nouveau dossier\pft <PFT>.tif
veg_trait_path                       D:/aaaaaaaaaaaPROJET DE FIN D ETUDE/fiche tfe/modele de parcours/les inputs/table csv/pft trait CSV.csv
workspace_dir                        C:/Users/AKIR SAID/Documents/forage_workspace/Nouveau dossier (2)

2022-02-28 10:25:36,152 forage.execute(617) INFO model execute: {'workspace_dir': 'C:/Users/AKIR SAID/Documents/forage_workspace/Nouveau dossier (2)', 'results_suffix': '', 'n_months': '12', 'starting_year': '2020', 'starting_month': '1', 'aoi_path': 'D:/aaaaaaaaaaaPROJET DE FIN D ETUDE/fiche tfe/modele de parcours/les inputs/shefield de souss/Souss Massa/Souss Massa.shp', 'management_threshold': '100', 'proportion_legume_path': 'D:/aaaaaaaaaaaPROJET DE FIN D ETUDE/fiche tfe/modele de parcours/les inputs/table csv/table/Nouveau dossier/Nouveau dossier/Nouveau dossier/DIR2/aglivc.tif', 'clay_proportion_path': 'D:/aaaaaaaaaaaPROJET DE FIN D ETUDE/fiche tfe/modele de parcours/les inputs/proportionn de limon/limon_souss 01.tif', 'silt_proportion_path': 'D:/aaaaaaaaaaaPROJET DE FIN D ETUDE/fiche tfe/modele de parcours/les inputs/proportion d argile/argile_souss 01.tif', 'sand_proportion_path': 'D:/aaaaaaaaaaaPROJET DE FIN D ETUDE/fiche tfe/modele de parcours/les inputs/proportion de sable/sable_souss 01.tif', 'bulk_density_path': 'D:/aaaaaaaaaaaPROJET DE FIN D ETUDE/fiche tfe/modele de parcours/les inputs/masse volumique/masse_vol_echelle.tif', 'ph_path': 'D:/aaaaaaaaaaaPROJET DE FIN D ETUDE/fiche tfe/modele de parcours/les inputs/ph  de sol/ph_souss_echelle.tif', 'precip_dir': 'D:\\aaaaaaaaaaaPROJET DE FIN D ETUDE\\fiche tfe\\modele de parcours\\les inputs\\precipitation', 'min_temp_dir': 'D:\\aaaaaaaaaaaPROJET DE FIN D ETUDE\\fiche tfe\\modele de parcours\\les inputs\\tmin', 'max_temp_dir': 'D:\\aaaaaaaaaaaPROJET DE FIN D ETUDE\\fiche tfe\\modele de parcours\\les inputs\\tmax', 'site_param_spatial_index_path': 'D:/aaaaaaaaaaaPROJET DE FIN D ETUDE/fiche tfe/modele de parcours/les inputs/pft_/Nouveau dossier/greazing_area_PolygonToRaste361.tif', 'veg_spatial_composition_path_pattern': 'D:\\aaaaaaaaaaaPROJET DE FIN D ETUDE\\fiche tfe\\modele de parcours\\les inputs\\Nouveau dossier\\pft <PFT>.tif', 'animal_grazing_areas_path': 'D:/aaaaaaaaaaaPROJET DE FIN D ETUDE/fiche tfe/modele de parcours/les inputs/sfu per soum/greazing_area.shp', 'site_param_table': 'D:/aaaaaaaaaaaPROJET DE FIN D ETUDE/fiche tfe/modele de parcours/les inputs/table csv/table/Nouveau dossier/site parametres ESSAI SS.csv', 'veg_trait_path': 'D:/aaaaaaaaaaaPROJET DE FIN D ETUDE/fiche tfe/modele de parcours/les inputs/table csv/pft trait CSV.csv', 'animal_trait_path': 'D:/aaaaaaaaaaaPROJET DE FIN D ETUDE/fiche tfe/modele de parcours/les inputs/table csv/table/Nouveau dossier/animale trait table SS1 CSV.csv', 'initial_conditions_dir': 'D:\\aaaaaaaaaaaPROJET DE FIN D ETUDE\\fiche tfe\\modele de parcours\\les inputs\\table csv\\table\\Nouveau dossier\\Nouveau dossier\\Nouveau dossier\\diro total', 'site_initial_table': 'D:/aaaaaaaaaaaPROJET DE FIN D ETUDE/fiche tfe/modele de parcours/les inputs/table csv/table/Nouveau dossier/Nouveau dossier/site_initial_table.csv', 'pft_initial_table': 'D:/aaaaaaaaaaaPROJET DE FIN D ETUDE/fiche tfe/modele de parcours/les inputs/table csv/table/Nouveau dossier/Nouveau dossier/Nouveau dossier/pft initial table CSV SS de.csv', 'save_sv_rasters': True, 'n_workers': '-1'}
2022-02-28 10:25:36,356 forage.execute(840) INFO pixel size of aligned inputs: (0.011999999999999995, -0.011999999999999993)
2022-02-28 10:25:37,804 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:37,812 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:37,812 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4774, started daemon 7112)>
2022-02-28 10:25:37,816 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:37,817 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:37,824 geoprocessing.align_and_resize_raster_stack(795) INFO 1 of 43 aligned: aligned_masse_vol_echelle.tif
2022-02-28 10:25:38,135 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:38,137 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:38,137 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4775, started daemon 4768)>
2022-02-28 10:25:38,141 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:38,142 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:38,150 geoprocessing.align_and_resize_raster_stack(795) INFO 2 of 43 aligned: aligned_limon_souss 01.tif
2022-02-28 10:25:38,466 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:38,467 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:38,467 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4776, started daemon 1676)>
2022-02-28 10:25:38,472 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:38,472 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:38,481 geoprocessing.align_and_resize_raster_stack(795) INFO 3 of 43 aligned: aligned_max_temperature_1.tif
2022-02-28 10:25:38,757 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:38,758 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:38,759 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4777, started daemon 7136)>
2022-02-28 10:25:38,763 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:38,764 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:38,774 geoprocessing.align_and_resize_raster_stack(795) INFO 4 of 43 aligned: aligned_max_temperature_10.tif
2022-02-28 10:25:39,063 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:39,064 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:39,064 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4778, started daemon 1736)>
2022-02-28 10:25:39,069 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:39,070 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:39,078 geoprocessing.align_and_resize_raster_stack(795) INFO 5 of 43 aligned: aligned_max_temperature_11.tif
2022-02-28 10:25:39,358 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:39,359 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:39,359 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4779, started daemon 2788)>
2022-02-28 10:25:39,363 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:39,364 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:39,373 geoprocessing.align_and_resize_raster_stack(795) INFO 6 of 43 aligned: aligned_max_temperature_12.tif
2022-02-28 10:25:39,661 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:39,663 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:39,663 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4780, started daemon 3892)>
2022-02-28 10:25:39,668 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:39,671 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:39,678 geoprocessing.align_and_resize_raster_stack(795) INFO 7 of 43 aligned: aligned_max_temperature_2.tif
2022-02-28 10:25:39,999 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:39,999 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:40,000 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4781, started daemon 2368)>
2022-02-28 10:25:40,004 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:40,005 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:40,014 geoprocessing.align_and_resize_raster_stack(795) INFO 8 of 43 aligned: aligned_max_temperature_3.tif
2022-02-28 10:25:40,300 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:40,301 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:40,301 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4782, started daemon 3556)>
2022-02-28 10:25:40,306 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:40,306 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:40,315 geoprocessing.align_and_resize_raster_stack(795) INFO 9 of 43 aligned: aligned_max_temperature_4.tif
2022-02-28 10:25:40,593 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:40,594 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:40,594 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4783, started daemon 4992)>
2022-02-28 10:25:40,599 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:40,600 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:40,609 geoprocessing.align_and_resize_raster_stack(795) INFO 10 of 43 aligned: aligned_max_temperature_5.tif
2022-02-28 10:25:40,891 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:40,892 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:40,892 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4784, started daemon 3940)>
2022-02-28 10:25:40,897 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:40,897 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:40,906 geoprocessing.align_and_resize_raster_stack(795) INFO 11 of 43 aligned: aligned_max_temperature_6.tif
2022-02-28 10:25:41,181 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:41,181 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:41,182 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4785, started daemon 3316)>
2022-02-28 10:25:41,186 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:41,187 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:41,196 geoprocessing.align_and_resize_raster_stack(795) INFO 12 of 43 aligned: aligned_max_temperature_7.tif
2022-02-28 10:25:41,483 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:41,484 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:41,484 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4786, started daemon 7164)>
2022-02-28 10:25:41,489 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:41,490 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:41,499 geoprocessing.align_and_resize_raster_stack(795) INFO 13 of 43 aligned: aligned_max_temperature_8.tif
2022-02-28 10:25:41,779 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:41,780 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:41,780 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4787, started daemon 6292)>
2022-02-28 10:25:41,785 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:41,785 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:41,794 geoprocessing.align_and_resize_raster_stack(795) INFO 14 of 43 aligned: aligned_max_temperature_9.tif
2022-02-28 10:25:42,077 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:42,077 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:42,078 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4788, started daemon 1148)>
2022-02-28 10:25:42,082 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:42,083 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:42,092 geoprocessing.align_and_resize_raster_stack(795) INFO 15 of 43 aligned: aligned_min_temperature_1.tif
2022-02-28 10:25:42,372 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:42,373 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:42,373 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4789, started daemon 3916)>
2022-02-28 10:25:42,380 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:42,380 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:42,397 geoprocessing.align_and_resize_raster_stack(795) INFO 16 of 43 aligned: aligned_min_temperature_10.tif
2022-02-28 10:25:42,680 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:42,681 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:42,682 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4790, started daemon 5564)>
2022-02-28 10:25:42,687 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:42,687 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:42,696 geoprocessing.align_and_resize_raster_stack(795) INFO 17 of 43 aligned: aligned_min_temperature_11.tif
2022-02-28 10:25:42,976 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:42,983 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:42,983 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4791, started daemon 708)>
2022-02-28 10:25:42,988 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:42,988 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:42,997 geoprocessing.align_and_resize_raster_stack(795) INFO 18 of 43 aligned: aligned_min_temperature_12.tif
2022-02-28 10:25:43,279 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:43,281 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:43,281 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4792, started daemon 3988)>
2022-02-28 10:25:43,286 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:43,286 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:43,294 geoprocessing.align_and_resize_raster_stack(795) INFO 19 of 43 aligned: aligned_min_temperature_2.tif
2022-02-28 10:25:43,703 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:43,704 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:43,704 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4793, started daemon 4180)>
2022-02-28 10:25:43,709 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:43,709 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:43,719 geoprocessing.align_and_resize_raster_stack(795) INFO 20 of 43 aligned: aligned_min_temperature_3.tif
2022-02-28 10:25:43,997 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:43,998 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:43,998 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4794, started daemon 4252)>
2022-02-28 10:25:44,003 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:44,003 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:44,012 geoprocessing.align_and_resize_raster_stack(795) INFO 21 of 43 aligned: aligned_min_temperature_4.tif
2022-02-28 10:25:44,294 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:44,297 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:44,297 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4795, started daemon 6044)>
2022-02-28 10:25:44,302 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:44,302 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:44,312 geoprocessing.align_and_resize_raster_stack(795) INFO 22 of 43 aligned: aligned_min_temperature_5.tif
2022-02-28 10:25:44,595 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:44,596 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:44,596 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4796, started daemon 4164)>
2022-02-28 10:25:44,601 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:44,601 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:44,610 geoprocessing.align_and_resize_raster_stack(795) INFO 23 of 43 aligned: aligned_min_temperature_6.tif
2022-02-28 10:25:44,893 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:44,895 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:44,895 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4797, started daemon 6744)>
2022-02-28 10:25:44,901 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:44,902 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:44,909 geoprocessing.align_and_resize_raster_stack(795) INFO 24 of 43 aligned: aligned_min_temperature_7.tif
2022-02-28 10:25:45,187 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:45,188 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:45,188 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4798, started daemon 6696)>
2022-02-28 10:25:45,193 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:45,193 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:45,202 geoprocessing.align_and_resize_raster_stack(795) INFO 25 of 43 aligned: aligned_min_temperature_8.tif
2022-02-28 10:25:45,486 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:45,487 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:45,487 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4799, started daemon 3404)>
2022-02-28 10:25:45,492 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:45,492 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:45,501 geoprocessing.align_and_resize_raster_stack(795) INFO 26 of 43 aligned: aligned_min_temperature_9.tif
2022-02-28 10:25:45,814 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:45,815 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:45,815 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4800, started daemon 6448)>
2022-02-28 10:25:45,819 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:45,819 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:45,825 geoprocessing.align_and_resize_raster_stack(795) INFO 27 of 43 aligned: aligned_ph_souss_echelle.tif
2022-02-28 10:25:46,110 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:46,111 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:46,111 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4801, started daemon 6964)>
2022-02-28 10:25:46,116 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:46,117 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:46,126 geoprocessing.align_and_resize_raster_stack(795) INFO 28 of 43 aligned: aligned_precipitaion_2020_1.tif
2022-02-28 10:25:46,405 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:46,406 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:46,406 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4802, started daemon 3168)>
2022-02-28 10:25:46,411 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:46,411 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:46,420 geoprocessing.align_and_resize_raster_stack(795) INFO 29 of 43 aligned: aligned_precipitaion_2020_2.tif
2022-02-28 10:25:46,702 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:46,703 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:46,703 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4803, started daemon 3196)>
2022-02-28 10:25:46,708 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:46,709 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:46,717 geoprocessing.align_and_resize_raster_stack(795) INFO 30 of 43 aligned: aligned_precipitaion_2020_11.tif
2022-02-28 10:25:47,011 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:47,012 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:47,012 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4804, started daemon 1828)>
2022-02-28 10:25:47,016 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:47,017 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:47,026 geoprocessing.align_and_resize_raster_stack(795) INFO 31 of 43 aligned: aligned_precipitaion_2020_12.tif
2022-02-28 10:25:47,311 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:47,312 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:47,312 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4805, started daemon 5604)>
2022-02-28 10:25:47,317 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:47,317 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:47,327 geoprocessing.align_and_resize_raster_stack(795) INFO 32 of 43 aligned: aligned_precipitaion_2020_3.tif
2022-02-28 10:25:47,609 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:47,612 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:47,612 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4806, started daemon 5692)>
2022-02-28 10:25:47,618 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:47,618 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:47,627 geoprocessing.align_and_resize_raster_stack(795) INFO 33 of 43 aligned: aligned_precipitaion_2020_4.tif
2022-02-28 10:25:47,914 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:47,915 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:47,915 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4807, started daemon 5356)>
2022-02-28 10:25:47,920 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:47,920 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:47,930 geoprocessing.align_and_resize_raster_stack(795) INFO 34 of 43 aligned: aligned_precipitaion_2020_5.tif
2022-02-28 10:25:48,207 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:48,208 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:48,208 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4808, started daemon 6888)>
2022-02-28 10:25:48,212 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:48,213 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:48,222 geoprocessing.align_and_resize_raster_stack(795) INFO 35 of 43 aligned: aligned_precipitaion_2020_6.tif
2022-02-28 10:25:48,506 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:48,507 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:48,507 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4809, started daemon 4472)>
2022-02-28 10:25:48,512 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:48,512 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:48,521 geoprocessing.align_and_resize_raster_stack(795) INFO 36 of 43 aligned: aligned_precipitaion_2020_7.tif
2022-02-28 10:25:48,803 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:48,804 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:48,804 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4810, started daemon 5824)>
2022-02-28 10:25:48,809 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:48,809 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:48,819 geoprocessing.align_and_resize_raster_stack(795) INFO 37 of 43 aligned: aligned_precipitaion_2020_8.tif
2022-02-28 10:25:49,101 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:49,102 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:49,102 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4811, started daemon 6748)>
2022-02-28 10:25:49,107 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:49,107 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:49,116 geoprocessing.align_and_resize_raster_stack(795) INFO 38 of 43 aligned: aligned_precipitaion_2020_9.tif
2022-02-28 10:25:49,401 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:49,408 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:49,409 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4812, started daemon 7004)>
2022-02-28 10:25:49,414 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:49,414 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:49,430 geoprocessing.align_and_resize_raster_stack(795) INFO 39 of 43 aligned: aligned_precipitaion_2020_10.tif
2022-02-28 10:25:49,488 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:49,489 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:49,489 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4813, started daemon 5364)>
2022-02-28 10:25:49,495 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:49,495 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:49,505 geoprocessing.align_and_resize_raster_stack(795) INFO 40 of 43 aligned: aligned_aglivc.tif
2022-02-28 10:25:49,818 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:49,820 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:49,820 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4814, started daemon 5432)>
2022-02-28 10:25:49,824 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:49,824 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:49,833 geoprocessing.align_and_resize_raster_stack(795) INFO 41 of 43 aligned: aligned_sable_souss 01.tif
2022-02-28 10:25:50,149 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:50,150 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:50,150 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4815, started daemon 5256)>
2022-02-28 10:25:50,156 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:50,157 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:50,165 geoprocessing.align_and_resize_raster_stack(795) INFO 42 of 43 aligned: aligned_argile_souss 01.tif
2022-02-28 10:25:50,204 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:50,206 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:50,206 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4816, started daemon 6168)>
2022-02-28 10:25:50,208 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:50,208 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:50,212 geoprocessing.align_and_resize_raster_stack(795) INFO 43 of 43 aligned: aligned_greazing_area_PolygonToRaste361.tif
2022-02-28 10:25:50,212 geoprocessing.align_and_resize_raster_stack(797) INFO aligned all 43 rasters.
2022-02-28 10:25:50,262 utils._log_gdal_errors(81) WARNING [errno 1] One or several characters couldn't be converted correctly from UTF-8 to ISO-8859-1.  This warning will not be emitted anymore.
2022-02-28 10:25:50,281 geoprocessing.zonal_statistics(1184) DEBUG <osgeo.gdal.Dataset; proxy of <Swig Object of type 'GDALDatasetShadow *' at 0x00000000116C2AE0> >
2022-02-28 10:25:50,313 geoprocessing.align_and_resize_raster_stack(795) INFO 1 of 1 aligned: clipped_rasteroxoq2znq.tif
2022-02-28 10:25:50,313 geoprocessing.align_and_resize_raster_stack(797) INFO aligned all 1 rasters.
2022-02-28 10:25:50,314 geoprocessing.zonal_statistics(1244) INFO build a lookup of aggregate field value to FID
2022-02-28 10:25:50,315 geoprocessing.zonal_statistics(1251) INFO creating disjoint polygon set
2022-02-28 10:25:50,315 geoprocessing.calculate_disjoint_polygon_set(2183) INFO build shapely polygon list
2022-02-28 10:25:50,320 geoprocessing.calculate_disjoint_polygon_set(2204) INFO build shapely rtree index
2022-02-28 10:25:50,322 geoprocessing.calculate_disjoint_polygon_set(2219) INFO poly feature lookup 100.0% complete on animal_mgmt_copy.shp
2022-02-28 10:25:50,322 geoprocessing.calculate_disjoint_polygon_set(2221) INFO build poly intersection lookup
2022-02-28 10:25:50,329 geoprocessing.calculate_disjoint_polygon_set(2245) INFO poly intersection feature lookup 100.0% complete on animal_mgmt_copy.shp
2022-02-28 10:25:50,329 geoprocessing.calculate_disjoint_polygon_set(2279) INFO maximal subset build 100.0% complete on animal_mgmt_copy.shp
2022-02-28 10:25:50,345 geoprocessing.zonal_statistics(1274) INFO processing 3 disjoint polygon sets
2022-02-28 10:25:50,346 geoprocessing.zonal_statistics(1309) INFO disjoint polygon set 1 of 3 100.0% processed on animal_mgmt_copy.shp
2022-02-28 10:25:50,346 geoprocessing.zonal_statistics(1317) INFO rasterizing disjoint polygon set 1 of 3 animal_mgmt_copy.shp
2022-02-28 10:25:50,357 geoprocessing.zonal_statistics(1335) INFO summarizing rasterized disjoint polygon set 1 of 3 animal_mgmt_copy.shp
2022-02-28 10:25:50,362 geoprocessing.zonal_statistics(1309) INFO disjoint polygon set 2 of 3 100.0% processed on animal_mgmt_copy.shp
2022-02-28 10:25:50,363 geoprocessing.zonal_statistics(1317) INFO rasterizing disjoint polygon set 2 of 3 animal_mgmt_copy.shp
2022-02-28 10:25:50,366 geoprocessing.zonal_statistics(1335) INFO summarizing rasterized disjoint polygon set 2 of 3 animal_mgmt_copy.shp
2022-02-28 10:25:50,369 geoprocessing.zonal_statistics(1309) INFO disjoint polygon set 3 of 3 100.0% processed on animal_mgmt_copy.shp
2022-02-28 10:25:50,370 geoprocessing.zonal_statistics(1317) INFO rasterizing disjoint polygon set 3 of 3 animal_mgmt_copy.shp
2022-02-28 10:25:50,374 geoprocessing.zonal_statistics(1335) INFO summarizing rasterized disjoint polygon set 3 of 3 animal_mgmt_copy.shp
2022-02-28 10:25:50,376 geoprocessing.zonal_statistics(1378) DEBUG unset_fids: 0 of 6 
2022-02-28 10:25:50,382 geoprocessing.zonal_statistics(1381) DEBUG gt [-1.0010382e+01  1.2000000e-02  0.0000000e+00  3.1167864e+01
  0.0000000e+00 -1.2000000e-02] for ('C:/Users/AKIR SAID/Documents/forage_workspace/Nouveau dossier (2)\\aligned_inputs\\animal_spatial_index.tif', 1)
2022-02-28 10:25:50,382 geoprocessing.zonal_statistics(1460) DEBUG remaining unset_fids: 0 of 6 
2022-02-28 10:25:50,383 geoprocessing.zonal_statistics(1468) INFO all done processing polygon sets for animal_mgmt_copy.shp
2022-02-28 10:25:50,391 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:50,398 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:50,398 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4817, started daemon 6844)>
2022-02-28 10:25:50,406 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:50,407 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:50,421 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:50,425 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:50,425 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4818, started daemon 6612)>
2022-02-28 10:25:50,431 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:50,432 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:51,001 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:51,002 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:51,003 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4819, started daemon 3580)>
2022-02-28 10:25:51,008 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:51,008 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:51,017 geoprocessing.align_and_resize_raster_stack(795) INFO 1 of 66 aligned: aligned_input_template.tif
2022-02-28 10:25:51,071 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:51,072 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:51,073 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4820, started daemon 5424)>
2022-02-28 10:25:51,077 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:51,078 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:51,089 geoprocessing.align_and_resize_raster_stack(795) INFO 2 of 66 aligned: asmos_1.tif
2022-02-28 10:25:51,141 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:51,148 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:51,148 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4821, started daemon 3672)>
2022-02-28 10:25:51,153 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:51,153 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:51,164 geoprocessing.align_and_resize_raster_stack(795) INFO 3 of 66 aligned: asmos_2.tif
2022-02-28 10:25:51,217 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:51,218 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:51,218 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4822, started daemon 3164)>
2022-02-28 10:25:51,223 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:51,223 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:51,240 geoprocessing.align_and_resize_raster_stack(795) INFO 4 of 66 aligned: asmos_3.tif
2022-02-28 10:25:51,292 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:51,294 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:51,294 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4823, started daemon 2516)>
2022-02-28 10:25:51,299 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:51,299 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:51,310 geoprocessing.align_and_resize_raster_stack(795) INFO 5 of 66 aligned: asmos_4.tif
2022-02-28 10:25:51,365 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:51,367 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:51,367 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4824, started daemon 6104)>
2022-02-28 10:25:51,371 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:51,373 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:51,382 geoprocessing.align_and_resize_raster_stack(795) INFO 6 of 66 aligned: asmos_5.tif
2022-02-28 10:25:51,433 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:51,435 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:51,435 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4825, started daemon 7016)>
2022-02-28 10:25:51,440 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:51,440 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:51,450 geoprocessing.align_and_resize_raster_stack(795) INFO 7 of 66 aligned: asmos_6.tif
2022-02-28 10:25:51,500 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:51,501 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:51,501 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4826, started daemon 5884)>
2022-02-28 10:25:51,506 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:51,506 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:51,517 geoprocessing.align_and_resize_raster_stack(795) INFO 8 of 66 aligned: asmos_7.tif
2022-02-28 10:25:51,567 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:51,568 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:51,568 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4827, started daemon 1992)>
2022-02-28 10:25:51,573 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:51,573 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:51,583 geoprocessing.align_and_resize_raster_stack(795) INFO 9 of 66 aligned: asmos_8.tif
2022-02-28 10:25:51,634 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:51,635 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:51,635 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4828, started daemon 6580)>
2022-02-28 10:25:51,640 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:51,640 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:51,652 geoprocessing.align_and_resize_raster_stack(795) INFO 10 of 66 aligned: asmos_9.tif
2022-02-28 10:25:51,701 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:51,703 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:51,703 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4829, started daemon 5864)>
2022-02-28 10:25:51,707 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:51,708 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:51,719 geoprocessing.align_and_resize_raster_stack(795) INFO 11 of 66 aligned: avh2o_3.tif
2022-02-28 10:25:51,768 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:51,770 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:51,770 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4830, started daemon 6740)>
2022-02-28 10:25:51,774 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:51,775 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:51,785 geoprocessing.align_and_resize_raster_stack(795) INFO 12 of 66 aligned: metabc_1.tif
2022-02-28 10:25:51,834 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:51,836 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:51,836 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4831, started daemon 6924)>
2022-02-28 10:25:51,841 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:51,842 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:51,852 geoprocessing.align_and_resize_raster_stack(795) INFO 13 of 66 aligned: metabc_2.tif
2022-02-28 10:25:51,902 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:51,903 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:51,903 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4832, started daemon 5276)>
2022-02-28 10:25:51,908 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:51,908 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:51,919 geoprocessing.align_and_resize_raster_stack(795) INFO 14 of 66 aligned: metabe_1_1.tif
2022-02-28 10:25:51,968 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:51,971 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:51,971 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4833, started daemon 6548)>
2022-02-28 10:25:51,976 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:51,976 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:51,985 geoprocessing.align_and_resize_raster_stack(795) INFO 15 of 66 aligned: metabe_1_2.tif
2022-02-28 10:25:52,039 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:52,046 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:52,046 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4834, started daemon 5220)>
2022-02-28 10:25:52,053 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:52,054 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:52,063 geoprocessing.align_and_resize_raster_stack(795) INFO 16 of 66 aligned: metabe_2_1.tif
2022-02-28 10:25:52,113 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:52,114 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:52,114 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4835, started daemon 2656)>
2022-02-28 10:25:52,119 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:52,119 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:52,129 geoprocessing.align_and_resize_raster_stack(795) INFO 17 of 66 aligned: metabe_2_2.tif
2022-02-28 10:25:52,334 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:52,342 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:52,342 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4836, started daemon 6504)>
2022-02-28 10:25:52,349 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:52,349 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:52,365 geoprocessing.align_and_resize_raster_stack(795) INFO 18 of 66 aligned: minerl_10_1.tif
2022-02-28 10:25:52,415 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:52,416 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:52,416 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4837, started daemon 6936)>
2022-02-28 10:25:52,421 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:52,421 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:52,431 geoprocessing.align_and_resize_raster_stack(795) INFO 19 of 66 aligned: minerl_10_2.tif
2022-02-28 10:25:52,481 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:52,482 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:52,483 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4838, started daemon 3344)>
2022-02-28 10:25:52,487 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:52,488 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:52,498 geoprocessing.align_and_resize_raster_stack(795) INFO 20 of 66 aligned: minerl_1_1.tif
2022-02-28 10:25:52,549 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:52,550 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:52,550 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4839, started daemon 5656)>
2022-02-28 10:25:52,555 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:52,555 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:52,567 geoprocessing.align_and_resize_raster_stack(795) INFO 21 of 66 aligned: minerl_1_2.tif
2022-02-28 10:25:52,623 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:52,624 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:52,624 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4840, started daemon 3772)>
2022-02-28 10:25:52,629 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:52,629 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:52,640 geoprocessing.align_and_resize_raster_stack(795) INFO 22 of 66 aligned: minerl_2_1.tif
2022-02-28 10:25:52,690 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:52,691 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:52,691 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4841, started daemon 5636)>
2022-02-28 10:25:52,695 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:52,696 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:52,706 geoprocessing.align_and_resize_raster_stack(795) INFO 23 of 66 aligned: minerl_2_2.tif
2022-02-28 10:25:52,757 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:52,758 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:52,758 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4842, started daemon 2020)>
2022-02-28 10:25:52,763 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:52,763 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:52,774 geoprocessing.align_and_resize_raster_stack(795) INFO 24 of 66 aligned: minerl_3_1.tif
2022-02-28 10:25:52,824 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:52,825 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:52,825 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4843, started daemon 856)>
2022-02-28 10:25:52,830 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:52,831 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:52,841 geoprocessing.align_and_resize_raster_stack(795) INFO 25 of 66 aligned: minerl_3_2.tif
2022-02-28 10:25:52,891 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:52,893 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:52,893 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4844, started daemon 1252)>
2022-02-28 10:25:52,897 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:52,898 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:52,908 geoprocessing.align_and_resize_raster_stack(795) INFO 26 of 66 aligned: minerl_4_1.tif
2022-02-28 10:25:52,959 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:52,961 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:52,961 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4845, started daemon 1436)>
2022-02-28 10:25:52,965 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:52,966 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:52,977 geoprocessing.align_and_resize_raster_stack(795) INFO 27 of 66 aligned: minerl_4_2.tif
2022-02-28 10:25:53,028 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:53,029 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:53,029 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4846, started daemon 5004)>
2022-02-28 10:25:53,034 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:53,035 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:53,046 geoprocessing.align_and_resize_raster_stack(795) INFO 28 of 66 aligned: minerl_5_1.tif
2022-02-28 10:25:53,096 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:53,097 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:53,097 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4847, started daemon 3816)>
2022-02-28 10:25:53,102 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:53,102 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:53,113 geoprocessing.align_and_resize_raster_stack(795) INFO 29 of 66 aligned: minerl_5_2.tif
2022-02-28 10:25:53,164 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:53,166 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:53,166 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4848, started daemon 2564)>
2022-02-28 10:25:53,170 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:53,171 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:53,182 geoprocessing.align_and_resize_raster_stack(795) INFO 30 of 66 aligned: minerl_6_1.tif
2022-02-28 10:25:53,232 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:53,233 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:53,233 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4849, started daemon 5368)>
2022-02-28 10:25:53,238 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:53,238 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:53,248 geoprocessing.align_and_resize_raster_stack(795) INFO 31 of 66 aligned: minerl_6_2.tif
2022-02-28 10:25:53,298 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:53,299 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:53,299 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4850, started daemon 2720)>
2022-02-28 10:25:53,303 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:53,304 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:53,317 geoprocessing.align_and_resize_raster_stack(795) INFO 32 of 66 aligned: minerl_7_1.tif
2022-02-28 10:25:53,369 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:53,370 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:53,371 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4851, started daemon 5112)>
2022-02-28 10:25:53,375 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:53,375 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:53,386 geoprocessing.align_and_resize_raster_stack(795) INFO 33 of 66 aligned: minerl_7_2.tif
2022-02-28 10:25:53,436 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:53,437 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:53,437 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4852, started daemon 2112)>
2022-02-28 10:25:53,442 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:53,442 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:53,453 geoprocessing.align_and_resize_raster_stack(795) INFO 34 of 66 aligned: minerl_8_1.tif
2022-02-28 10:25:53,503 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:53,505 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:53,505 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4853, started daemon 2200)>
2022-02-28 10:25:53,510 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:53,511 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:53,521 geoprocessing.align_and_resize_raster_stack(795) INFO 35 of 66 aligned: minerl_8_2.tif
2022-02-28 10:25:53,572 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:53,574 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:53,574 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4854, started daemon 3820)>
2022-02-28 10:25:53,578 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:53,578 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:53,589 geoprocessing.align_and_resize_raster_stack(795) INFO 36 of 66 aligned: minerl_9_1.tif
2022-02-28 10:25:53,640 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:53,643 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:53,644 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4855, started daemon 3336)>
2022-02-28 10:25:53,648 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:53,649 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:53,658 geoprocessing.align_and_resize_raster_stack(795) INFO 37 of 66 aligned: minerl_9_2.tif
2022-02-28 10:25:53,712 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:53,719 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:53,719 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4856, started daemon 4204)>
2022-02-28 10:25:53,724 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:53,725 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:53,739 geoprocessing.align_and_resize_raster_stack(795) INFO 38 of 66 aligned: occlud.tif
2022-02-28 10:25:53,796 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:53,802 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:53,803 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4857, started daemon 5092)>
2022-02-28 10:25:53,807 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:53,808 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:53,819 geoprocessing.align_and_resize_raster_stack(795) INFO 39 of 66 aligned: parent_2.tif
2022-02-28 10:25:53,876 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:53,883 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:53,883 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4858, started daemon 152)>
2022-02-28 10:25:53,888 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:53,888 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:53,904 geoprocessing.align_and_resize_raster_stack(795) INFO 40 of 66 aligned: plabil.tif
2022-02-28 10:25:53,957 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:53,961 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:53,961 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4859, started daemon 5160)>
2022-02-28 10:25:53,966 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:53,966 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:53,977 geoprocessing.align_and_resize_raster_stack(795) INFO 41 of 66 aligned: secndy_2.tif
2022-02-28 10:25:54,032 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:54,038 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:54,038 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4860, started daemon 3948)>
2022-02-28 10:25:54,044 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:54,045 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:54,055 geoprocessing.align_and_resize_raster_stack(795) INFO 42 of 66 aligned: snlq.tif
2022-02-28 10:25:54,109 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:54,114 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:54,114 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4861, started daemon 5000)>
2022-02-28 10:25:54,119 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:54,119 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:54,129 geoprocessing.align_and_resize_raster_stack(795) INFO 43 of 66 aligned: snow.tif
2022-02-28 10:25:54,180 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:54,181 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:54,181 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4862, started daemon 3716)>
2022-02-28 10:25:54,186 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:54,186 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:54,196 geoprocessing.align_and_resize_raster_stack(795) INFO 44 of 66 aligned: som1c_1.tif
2022-02-28 10:25:54,246 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:54,247 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:54,248 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4863, started daemon 4308)>
2022-02-28 10:25:54,252 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:54,252 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:54,263 geoprocessing.align_and_resize_raster_stack(795) INFO 45 of 66 aligned: som1c_2.tif
2022-02-28 10:25:54,314 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:54,315 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:54,315 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4864, started daemon 6108)>
2022-02-28 10:25:54,320 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:54,322 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:54,331 geoprocessing.align_and_resize_raster_stack(795) INFO 46 of 66 aligned: som1e_1_1.tif
2022-02-28 10:25:54,486 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:54,487 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:54,487 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4865, started daemon 2824)>
2022-02-28 10:25:54,494 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:54,494 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:54,506 geoprocessing.align_and_resize_raster_stack(795) INFO 47 of 66 aligned: som1e_1_2.tif
2022-02-28 10:25:54,557 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:54,558 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:54,558 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4866, started daemon 5228)>
2022-02-28 10:25:54,563 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:54,565 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:54,574 geoprocessing.align_and_resize_raster_stack(795) INFO 48 of 66 aligned: som1e_2_1.tif
2022-02-28 10:25:54,625 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:54,626 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:54,626 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4867, started daemon 4456)>
2022-02-28 10:25:54,631 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:54,631 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:54,642 geoprocessing.align_and_resize_raster_stack(795) INFO 49 of 66 aligned: som1e_2_2.tif
2022-02-28 10:25:54,693 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:54,694 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:54,695 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4868, started daemon 4832)>
2022-02-28 10:25:54,699 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:54,700 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:54,710 geoprocessing.align_and_resize_raster_stack(795) INFO 50 of 66 aligned: som2c_1.tif
2022-02-28 10:25:54,761 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:54,762 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:54,762 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4869, started daemon 6296)>
2022-02-28 10:25:54,767 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:54,767 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:54,778 geoprocessing.align_and_resize_raster_stack(795) INFO 51 of 66 aligned: som2c_2.tif
2022-02-28 10:25:54,828 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:54,829 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:54,829 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4870, started daemon 4912)>
2022-02-28 10:25:54,834 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:54,834 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:54,845 geoprocessing.align_and_resize_raster_stack(795) INFO 52 of 66 aligned: som2e_1_1.tif
2022-02-28 10:25:54,897 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:54,900 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:54,900 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4871, started daemon 3280)>
2022-02-28 10:25:54,905 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:54,905 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:54,914 geoprocessing.align_and_resize_raster_stack(795) INFO 53 of 66 aligned: som2e_1_2.tif
2022-02-28 10:25:55,008 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:55,009 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:55,010 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4872, started daemon 6312)>
2022-02-28 10:25:55,024 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:55,025 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:55,044 geoprocessing.align_and_resize_raster_stack(795) INFO 54 of 66 aligned: som2e_2_1.tif
2022-02-28 10:25:55,094 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:55,095 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:55,095 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4873, started daemon 5828)>
2022-02-28 10:25:55,100 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:55,100 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:55,110 geoprocessing.align_and_resize_raster_stack(795) INFO 55 of 66 aligned: som2e_2_2.tif
2022-02-28 10:25:55,161 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:55,162 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:55,162 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4874, started daemon 3192)>
2022-02-28 10:25:55,167 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:55,167 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:55,178 geoprocessing.align_and_resize_raster_stack(795) INFO 56 of 66 aligned: som3c.tif
2022-02-28 10:25:55,227 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:55,228 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:55,229 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4875, started daemon 2680)>
2022-02-28 10:25:55,233 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:55,234 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:55,244 geoprocessing.align_and_resize_raster_stack(795) INFO 57 of 66 aligned: som3e_1.tif
2022-02-28 10:25:55,300 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:55,301 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:55,302 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4876, started daemon 3944)>
2022-02-28 10:25:55,306 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:55,307 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:55,317 geoprocessing.align_and_resize_raster_stack(795) INFO 58 of 66 aligned: som3e_2.tif
2022-02-28 10:25:55,369 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:55,370 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:55,371 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4877, started daemon 3852)>
2022-02-28 10:25:55,376 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:55,377 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:55,387 geoprocessing.align_and_resize_raster_stack(795) INFO 59 of 66 aligned: strlig_1.tif
2022-02-28 10:25:55,436 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:55,437 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:55,437 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4878, started daemon 5168)>
2022-02-28 10:25:55,442 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:55,442 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:55,452 geoprocessing.align_and_resize_raster_stack(795) INFO 60 of 66 aligned: strlig_2.tif
2022-02-28 10:25:55,502 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:55,503 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:55,503 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4879, started daemon 7052)>
2022-02-28 10:25:55,508 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:55,508 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:55,518 geoprocessing.align_and_resize_raster_stack(795) INFO 61 of 66 aligned: strucc_1.tif
2022-02-28 10:25:55,570 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:55,571 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:55,571 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4880, started daemon 4276)>
2022-02-28 10:25:55,576 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:55,576 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:55,586 geoprocessing.align_and_resize_raster_stack(795) INFO 62 of 66 aligned: strucc_2.tif
2022-02-28 10:25:55,636 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:55,638 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:55,639 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4881, started daemon 2396)>
2022-02-28 10:25:55,643 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:55,644 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:55,654 geoprocessing.align_and_resize_raster_stack(795) INFO 63 of 66 aligned: struce_1_1.tif
2022-02-28 10:25:55,704 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:55,705 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:55,705 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4882, started daemon 6684)>
2022-02-28 10:25:55,709 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:55,710 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:55,720 geoprocessing.align_and_resize_raster_stack(795) INFO 64 of 66 aligned: struce_1_2.tif
2022-02-28 10:25:55,770 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:55,771 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:55,771 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4883, started daemon 4396)>
2022-02-28 10:25:55,777 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:55,777 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:55,788 geoprocessing.align_and_resize_raster_stack(795) INFO 65 of 66 aligned: struce_2_1.tif
2022-02-28 10:25:55,838 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:55,839 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:55,839 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4884, started daemon 3652)>
2022-02-28 10:25:55,844 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:55,844 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:55,855 geoprocessing.align_and_resize_raster_stack(795) INFO 66 of 66 aligned: struce_2_2.tif
2022-02-28 10:25:55,855 geoprocessing.align_and_resize_raster_stack(797) INFO aligned all 66 rasters.
2022-02-28 10:25:55,934 forage.execute(1010) INFO Calculating field capacity and wilting point
2022-02-28 10:25:55,944 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:55,944 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:55,945 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4885, started daemon 6604)>
2022-02-28 10:25:55,949 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:55,949 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:56,022 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:56,023 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:56,023 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4886, started daemon 2292)>
2022-02-28 10:25:56,041 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:56,042 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:56,290 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:56,291 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:56,292 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4887, started daemon 2436)>
2022-02-28 10:25:56,308 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:56,309 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:56,562 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:56,563 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:56,563 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4888, started daemon 7024)>
2022-02-28 10:25:56,579 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:56,579 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:56,593 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:56,594 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:56,594 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4889, started daemon 5476)>
2022-02-28 10:25:56,597 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:56,598 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:56,869 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:56,875 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:56,875 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4890, started daemon 7140)>
2022-02-28 10:25:56,892 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:56,893 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:57,151 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:57,152 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:57,152 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4891, started daemon 4680)>
2022-02-28 10:25:57,168 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:57,168 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:57,182 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:57,183 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:57,183 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4892, started daemon 4852)>
2022-02-28 10:25:57,186 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:57,187 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:57,435 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:57,436 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:57,436 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4893, started daemon 5940)>
2022-02-28 10:25:57,452 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:57,452 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:57,704 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:57,711 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:57,711 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4894, started daemon 5216)>
2022-02-28 10:25:57,728 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:57,729 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:57,743 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:57,744 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:57,744 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4895, started daemon 2716)>
2022-02-28 10:25:57,748 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:57,749 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:57,999 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:58,000 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:58,000 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4896, started daemon 6864)>
2022-02-28 10:25:58,016 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:58,018 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:58,377 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:58,379 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:58,379 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4897, started daemon 1216)>
2022-02-28 10:25:58,401 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:58,403 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:58,416 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:58,417 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:58,417 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4898, started daemon 3504)>
2022-02-28 10:25:58,420 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:58,421 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:58,672 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:58,673 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:58,673 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4899, started daemon 3216)>
2022-02-28 10:25:58,689 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:58,690 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:58,943 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:58,944 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:58,944 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4900, started daemon 1732)>
2022-02-28 10:25:58,959 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:58,960 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:59,072 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:59,075 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:59,075 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4901, started daemon 5796)>
2022-02-28 10:25:59,084 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:59,085 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:59,348 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:59,349 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:59,349 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4902, started daemon 6200)>
2022-02-28 10:25:59,365 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:59,366 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:59,615 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:59,616 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:59,616 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4903, started daemon 5488)>
2022-02-28 10:25:59,631 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:59,632 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:59,645 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:59,653 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:59,653 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4904, started daemon 3592)>
2022-02-28 10:25:59,662 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:59,669 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:25:59,925 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:25:59,927 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:25:59,927 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4905, started daemon 2932)>
2022-02-28 10:25:59,945 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:25:59,946 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:00,195 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:00,196 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:00,196 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4906, started daemon 4156)>
2022-02-28 10:26:00,212 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:00,212 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:00,225 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:00,226 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:00,226 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4907, started daemon 6868)>
2022-02-28 10:26:00,230 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:00,230 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:00,487 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:00,493 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:00,493 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4908, started daemon 5548)>
2022-02-28 10:26:00,509 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:00,510 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:00,776 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:00,777 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:00,777 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4909, started daemon 3220)>
2022-02-28 10:26:00,793 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:00,794 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:00,806 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:00,811 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:00,812 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4910, started daemon 3636)>
2022-02-28 10:26:00,815 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:00,815 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:01,064 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:01,065 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:01,065 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4911, started daemon 3808)>
2022-02-28 10:26:01,081 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:01,081 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:01,342 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:01,349 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:01,349 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4912, started daemon 4000)>
2022-02-28 10:26:01,365 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:01,367 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:01,380 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:01,381 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:01,381 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4913, started daemon 3800)>
2022-02-28 10:26:01,384 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:01,385 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:01,394 forage.execute(1018) INFO Calculating persistent parameters
2022-02-28 10:26:01,457 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:01,458 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:01,458 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4914, started daemon 5552)>
2022-02-28 10:26:01,462 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:01,463 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:01,476 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:01,478 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:01,478 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4915, started daemon 4828)>
2022-02-28 10:26:01,482 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:01,482 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:01,496 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:01,498 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:01,498 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4916, started daemon 4932)>
2022-02-28 10:26:01,502 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:01,502 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:01,516 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:01,517 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:01,518 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4917, started daemon 2496)>
2022-02-28 10:26:01,523 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:01,523 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:01,538 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:01,539 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:01,540 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4918, started daemon 6012)>
2022-02-28 10:26:01,544 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:01,544 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:01,560 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:01,561 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:01,561 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4919, started daemon 5292)>
2022-02-28 10:26:01,565 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:01,565 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:01,580 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:01,581 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:01,581 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4920, started daemon 6256)>
2022-02-28 10:26:01,586 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:01,587 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:01,600 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:01,602 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:01,602 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4921, started daemon 3456)>
2022-02-28 10:26:01,606 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:01,606 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:01,621 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:01,622 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:01,622 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4922, started daemon 4260)>
2022-02-28 10:26:01,626 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:01,627 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:01,641 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:01,642 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:01,642 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4923, started daemon 4816)>
2022-02-28 10:26:01,646 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:01,647 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:01,660 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:01,661 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:01,661 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4924, started daemon 6348)>
2022-02-28 10:26:01,666 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:01,666 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:01,752 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:01,753 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:01,753 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4925, started daemon 6544)>
2022-02-28 10:26:01,760 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:01,761 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:01,807 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:01,809 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:01,809 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4926, started daemon 1844)>
2022-02-28 10:26:01,817 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:01,817 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:01,863 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:01,869 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:01,869 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4927, started daemon 3212)>
2022-02-28 10:26:01,878 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:01,879 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:01,925 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:01,931 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:01,932 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4928, started daemon 5404)>
2022-02-28 10:26:01,940 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:01,941 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:01,993 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:01,994 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:01,994 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4929, started daemon 2240)>
2022-02-28 10:26:02,003 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:02,003 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:02,049 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:02,057 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:02,057 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4930, started daemon 6908)>
2022-02-28 10:26:02,066 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:02,066 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:02,109 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:02,110 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:02,110 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4931, started daemon 1136)>
2022-02-28 10:26:02,118 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:02,118 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:02,200 forage.execute(1024) INFO Calculating required ratios for structural decomposition
2022-02-28 10:26:02,215 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:02,223 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:02,223 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4932, started daemon 6196)>
2022-02-28 10:26:02,228 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:02,228 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:02,247 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:02,254 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:02,255 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4933, started daemon 6848)>
2022-02-28 10:26:02,259 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:02,260 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:02,274 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:02,284 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:02,284 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4934, started daemon 5816)>
2022-02-28 10:26:02,289 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:02,290 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:02,304 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:02,305 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:02,305 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4935, started daemon 6420)>
2022-02-28 10:26:02,310 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:02,310 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:02,324 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:02,325 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:02,325 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4936, started daemon 5384)>
2022-02-28 10:26:02,330 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:02,331 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:02,344 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:02,345 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:02,345 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4937, started daemon 4344)>
2022-02-28 10:26:02,351 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:02,351 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:02,365 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:02,366 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:02,366 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4938, started daemon 880)>
2022-02-28 10:26:02,370 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:02,371 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:02,385 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:02,389 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:02,389 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4939, started daemon 4200)>
2022-02-28 10:26:02,394 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:02,394 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:02,408 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:02,413 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:02,413 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4940, started daemon 5716)>
2022-02-28 10:26:02,418 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:02,418 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:02,432 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:02,433 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:02,433 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4941, started daemon 1728)>
2022-02-28 10:26:02,437 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:02,437 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:02,451 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:02,453 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:02,453 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4942, started daemon 6052)>
2022-02-28 10:26:02,457 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:02,457 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:02,471 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:02,472 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:02,472 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4943, started daemon 6340)>
2022-02-28 10:26:02,477 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:02,478 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:02,491 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:02,493 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:02,493 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4944, started daemon 6624)>
2022-02-28 10:26:02,497 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:02,497 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:02,510 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:02,511 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:02,512 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4945, started daemon 2328)>
2022-02-28 10:26:02,516 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:02,516 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:02,546 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:02,547 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:02,547 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4946, started daemon 2016)>
2022-02-28 10:26:02,553 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:02,553 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:02,566 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:02,568 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:02,568 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4947, started daemon 3252)>
2022-02-28 10:26:02,572 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:02,572 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:02,586 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:02,587 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:02,588 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4948, started daemon 3100)>
2022-02-28 10:26:02,592 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:02,592 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:02,607 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:02,608 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:02,608 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4949, started daemon 6692)>
2022-02-28 10:26:02,613 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:02,613 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:02,627 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:02,628 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:02,628 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4950, started daemon 3536)>
2022-02-28 10:26:02,632 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:02,633 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:02,646 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:02,647 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:02,647 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4951, started daemon 6840)>
2022-02-28 10:26:02,652 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:02,653 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:02,666 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:02,667 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:02,667 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4952, started daemon 2820)>
2022-02-28 10:26:02,672 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:02,672 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:02,686 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:02,688 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:02,688 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4953, started daemon 936)>
2022-02-28 10:26:02,692 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:02,693 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:02,713 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:02,715 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:02,715 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4954, started daemon 6264)>
2022-02-28 10:26:02,731 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:02,732 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:02,764 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:02,765 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:02,765 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4955, started daemon 7056)>
2022-02-28 10:26:02,792 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:02,793 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:02,809 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:02,810 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:02,810 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4956, started daemon 5048)>
2022-02-28 10:26:02,815 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:02,816 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:02,831 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:02,832 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:02,832 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4957, started daemon 6408)>
2022-02-28 10:26:02,836 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:02,837 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:02,857 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:02,858 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:02,858 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4958, started daemon 4408)>
2022-02-28 10:26:02,876 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:02,877 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:02,911 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:02,913 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:02,913 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4959, started daemon 5496)>
2022-02-28 10:26:02,942 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:02,942 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:02,959 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:02,960 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:02,961 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4960, started daemon 2992)>
2022-02-28 10:26:02,966 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:02,966 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:02,981 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:02,982 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:02,983 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4961, started daemon 4220)>
2022-02-28 10:26:02,987 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:02,988 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:03,671 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:03,672 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:03,672 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4962, started daemon 7108)>
2022-02-28 10:26:03,749 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:03,750 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:03,769 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:03,770 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:03,770 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4963, started daemon 4944)>
2022-02-28 10:26:03,775 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:03,776 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:03,790 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:03,791 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:03,791 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4964, started daemon 4116)>
2022-02-28 10:26:03,795 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:03,796 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:03,835 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:03,836 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:03,836 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4965, started daemon 3980)>
2022-02-28 10:26:03,845 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:03,845 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:03,913 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:03,915 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:03,915 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4966, started daemon 6332)>
2022-02-28 10:26:03,919 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:03,919 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:03,933 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:03,934 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:03,934 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4967, started daemon 7008)>
2022-02-28 10:26:03,939 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:03,939 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:03,953 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:03,954 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:03,954 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4968, started daemon 6616)>
2022-02-28 10:26:03,959 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:03,959 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:03,973 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:03,975 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:03,975 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4969, started daemon 2848)>
2022-02-28 10:26:03,979 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:03,980 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:03,993 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:03,995 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:03,995 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4970, started daemon 4948)>
2022-02-28 10:26:03,999 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:03,999 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:04,015 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:04,016 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:04,016 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4971, started daemon 3640)>
2022-02-28 10:26:04,021 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:04,021 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:04,035 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:04,036 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:04,036 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4972, started daemon 6072)>
2022-02-28 10:26:04,041 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:04,041 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:04,055 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:04,056 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:04,056 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4973, started daemon 2260)>
2022-02-28 10:26:04,061 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:04,061 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:04,075 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:04,076 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:04,076 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4974, started daemon 5480)>
2022-02-28 10:26:04,081 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:04,081 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:04,095 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:04,096 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:04,096 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4975, started daemon 2520)>
2022-02-28 10:26:04,101 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:04,101 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:04,115 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:04,116 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:04,116 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4976, started daemon 2724)>
2022-02-28 10:26:04,121 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:04,121 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:04,136 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:04,137 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:04,137 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4977, started daemon 1224)>
2022-02-28 10:26:04,141 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:04,141 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:04,155 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:04,156 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:04,156 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4978, started daemon 6060)>
2022-02-28 10:26:04,161 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:04,161 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:04,174 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:04,176 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:04,176 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4979, started daemon 4640)>
2022-02-28 10:26:04,180 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:04,181 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:04,194 geoprocessing.raster_calculator(391) INFO starting stats_worker
2022-02-28 10:26:04,195 threading.run(870) DEBUG stats worker PID: 5232
2022-02-28 10:26:04,195 geoprocessing.raster_calculator(397) INFO started stats_worker <Thread(Thread-4980, started daemon 3116)>
2022-02-28 10:26:04,205 geoprocessing.raster_calculator(477) INFO 100.0% complete
2022-02-28 10:26:04,206 geoprocessing.raster_calculator(480) INFO Waiting for raster stats worker result.
2022-02-28 10:26:04,211 model._logged_target(1641) ERROR Exception while executing <function execute at 0x000000000DB1EA68>
Traceback (most recent call last):
  File "src\rangeland_production\ui\model.py", line 1638, in _logged_target
  File "src\rangeland_production\forage.py", line 1109, in execute
  File "src\rangeland_production\forage.py", line 5553, in _soil_water
  File "src\rangeland_production\forage.py", line 1542, in weighted_state_variable_sum
  File "src\rangeland_production\forage.py", line 1340, in raster_list_sum
  File "env\lib\site-packages\pygeoprocessing\geoprocessing.py", line 159, in raster_calculator
ValueError: `base_raster_path_band_const_list` is empty and should have at least one value.
2022-02-28 10:26:04,212 model._logged_target(1644) INFO Execution finished
2022-02-28 10:26:04,212 utils.prepare_workspace(129) INFO Elapsed time: 28.07s