2019-06-03 20:35:08,644 utils.prepare_workspace(109) INFO Writing log messages to E:\InVEST\SDR\TRIAL RUN\June 2_Trial10_TFA5000\InVEST-Sediment-Delivery-Ratio-Model-(SDR)-log-2019-06-03--20_35_08.txt 2019-06-03 20:35:08,644 model._logged_target(1633) Level 100 Starting model with parameters: Arguments for InVEST natcap.invest.sdr 3.7.0: biophysical_table_path E:/InVEST/SDR/Biophysical table/GODAVARI_SDR_June1.csv dem_path E:/InVEST/SDR/DEM/godavaribasin_dem_20KM_nodata_projected_int_fill.tif drainage_path erodibility_path E:/InVEST/SDR/Soil Erodibility/Trial_Float_SoilErodibility_20KM_44N_resample30m.tif erosivity_path E:/InVEST/SDR/Rainfall Erosivity_IR/IR_20KM_ProjectRaster_44N_Resample_30m.tif ic_0_param 0.5 k_param 2 lulc_path E:/InVEST/SDR/LULC/FINAL_godavaribasin_lulc_resamp30m.tif n_workers -1 results_suffix sdr_max 0.8 threshold_flow_accumulation 5000 watersheds_path E:/InVEST/SDR/WATERSHED/godavari_watershed_44N_new.shp workspace_dir E:\InVEST\SDR\TRIAL RUN\June 2_Trial10_TFA5000 2019-06-03 20:35:29,907 geoprocessing.align_and_resize_raster_stack(729) INFO n_workers > 1 (2) so starting a processes pool. 2019-06-03 20:38:48,822 geoprocessing.align_and_resize_raster_stack(779) INFO 1 of 4 aligned: aligned_dem.tif 2019-06-03 20:38:48,822 geoprocessing.align_and_resize_raster_stack(779) INFO 2 of 4 aligned: aligned_lulc.tif 2019-06-03 20:40:34,846 geoprocessing.align_and_resize_raster_stack(779) INFO 3 of 4 aligned: aligned_erosivity.tif 2019-06-03 20:40:57,489 geoprocessing.align_and_resize_raster_stack(779) INFO 4 of 4 aligned: aligned_erodibility.tif 2019-06-03 20:40:57,644 geoprocessing.align_and_resize_raster_stack(788) INFO aligned all 4 rasters. 2019-06-03 20:41:05,582 geoprocessing.(918) INFO 21.0% complete 2019-06-03 20:41:10,596 geoprocessing.(918) INFO 39.9% complete 2019-06-03 20:41:15,612 geoprocessing.(918) INFO 61.4% complete 2019-06-03 20:41:20,628 geoprocessing.(918) INFO 83.2% complete 2019-06-03 20:41:30,377 geoprocessing.(918) INFO 13.4% complete 2019-06-03 20:41:35,392 geoprocessing.(918) INFO 24.9% complete 2019-06-03 20:41:40,407 geoprocessing.(918) INFO 36.6% complete 2019-06-03 20:41:45,423 geoprocessing.(918) INFO 48.2% complete 2019-06-03 20:41:50,438 geoprocessing.(918) INFO 59.7% complete 2019-06-03 20:41:55,453 geoprocessing.(918) INFO 71.3% complete 2019-06-03 20:42:00,469 geoprocessing.(918) INFO 83.0% complete 2019-06-03 20:42:05,484 geoprocessing.(918) INFO 94.6% complete 2019-06-03 20:43:48,063 Task._call(1068) INFO 0.0% complete 2019-06-03 20:43:54,079 Task._call(1068) INFO 3.3% complete 2019-06-03 20:44:00,095 Task._call(1068) INFO 4.5% complete 2019-06-03 20:44:06,157 Task._call(1068) INFO 6.7% complete 2019-06-03 20:44:12,078 Task._call(1068) INFO 7.8% complete 2019-06-03 20:44:18,030 Task._call(1068) INFO 8.9% complete 2019-06-03 20:44:24,046 Task._call(1068) INFO 10.0% complete 2019-06-03 20:44:30,006 Task._call(1068) INFO 11.2% complete 2019-06-03 20:44:36,003 Task._call(1068) INFO 12.3% complete 2019-06-03 20:44:42,017 Task._call(1068) INFO 13.4% complete 2019-06-03 20:44:48,079 Task._call(1068) INFO 13.4% complete 2019-06-03 20:44:54,157 Task._call(1068) INFO 14.5% complete 2019-06-03 20:45:00,032 Task._call(1068) INFO 15.6% complete 2019-06-03 20:45:06,000 Task._call(1068) INFO 16.7% complete 2019-06-03 20:45:12,062 Task._call(1068) INFO 17.9% complete 2019-06-03 20:45:18,030 Task._call(1068) INFO 17.9% complete 2019-06-03 20:45:24,078 Task._call(1068) INFO 19.0% complete 2019-06-03 20:45:30,030 Task._call(1068) INFO 20.1% complete 2019-06-03 20:45:36,015 Task._call(1068) INFO 21.2% complete 2019-06-03 20:45:42,061 Task._call(1068) INFO 22.3% complete 2019-06-03 20:45:48,029 Task._call(1068) INFO 22.3% complete 2019-06-03 20:45:54,013 Task._call(1068) INFO 23.4% complete 2019-06-03 20:46:00,045 Task._call(1068) INFO 24.6% complete 2019-06-03 20:46:06,091 Task._call(1068) INFO 24.6% complete 2019-06-03 20:46:12,168 Task._call(1068) INFO 25.7% complete 2019-06-03 20:46:18,059 Task._call(1068) INFO 26.8% complete 2019-06-03 20:46:24,184 Task._call(1068) INFO 27.9% complete 2019-06-03 20:46:30,151 Task._call(1068) INFO 27.9% complete 2019-06-03 20:46:36,151 Task._call(1068) INFO 29.0% complete 2019-06-03 20:46:42,135 Task._call(1068) INFO 30.1% complete 2019-06-03 20:46:48,134 Task._call(1068) INFO 30.1% complete 2019-06-03 20:46:54,026 Task._call(1068) INFO 31.2% complete 2019-06-03 20:47:00,072 Task._call(1068) INFO 31.2% complete 2019-06-03 20:47:06,040 Task._call(1068) INFO 32.4% complete 2019-06-03 20:47:12,025 Task._call(1068) INFO 32.4% complete 2019-06-03 20:47:18,086 Task._call(1068) INFO 33.5% complete 2019-06-03 20:47:24,085 Task._call(1068) INFO 33.5% complete 2019-06-03 20:47:30,164 Task._call(1068) INFO 33.5% complete 2019-06-03 20:47:36,007 Task._call(1068) INFO 34.6% complete 2019-06-03 20:47:42,117 Task._call(1068) INFO 34.6% complete 2019-06-03 20:47:48,101 Task._call(1068) INFO 34.6% complete 2019-06-03 20:47:54,006 Task._call(1068) INFO 35.7% complete 2019-06-03 20:48:00,022 Task._call(1068) INFO 35.7% complete 2019-06-03 20:48:06,115 Task._call(1068) INFO 35.7% complete 2019-06-03 20:48:12,052 Task._call(1068) INFO 36.8% complete 2019-06-03 20:48:18,068 Task._call(1068) INFO 36.8% complete 2019-06-03 20:48:24,114 Task._call(1068) INFO 36.8% complete 2019-06-03 20:48:30,019 Task._call(1068) INFO 37.9% complete 2019-06-03 20:48:58,721 Task._call(1068) INFO 37.9% complete 2019-06-03 20:49:06,095 Task._call(1068) INFO 37.9% complete 2019-06-03 20:49:21,049 Task._call(1068) INFO 37.9% complete 2019-06-03 20:49:28,391 Task._call(1068) INFO 37.9% complete 2019-06-03 20:49:47,203 Task._call(1068) INFO 37.9% complete 2019-06-03 20:49:54,953 Task._call(1068) INFO 37.9% complete 2019-06-03 20:50:13,154 Task._call(1068) INFO 37.9% complete 2019-06-03 20:50:27,957 Task._call(1068) INFO 37.9% complete 2019-06-03 20:50:35,128 Task._call(1068) INFO 37.9% complete 2019-06-03 20:50:47,315 Task._call(1068) INFO 37.9% complete 2019-06-03 20:50:58,081 Task._call(1068) INFO 37.9% complete 2019-06-03 20:51:10,829 Task._call(1068) INFO 37.9% complete 2019-06-03 20:51:40,734 Task._call(1068) INFO 37.9% complete 2019-06-03 20:51:52,842 Task._call(1068) INFO 37.9% complete 2019-06-03 20:52:01,890 Task._call(1068) INFO 37.9% complete 2019-06-03 20:52:16,779 Task._call(1068) INFO 37.9% complete 2019-06-03 20:52:37,184 Task._call(1068) INFO 37.9% complete 2019-06-03 20:52:43,079 Task._call(1068) INFO 37.9% complete 2019-06-03 20:52:49,111 Task._call(1068) INFO 39.1% complete 2019-06-03 20:52:55,203 Task._call(1068) INFO 39.1% complete 2019-06-03 20:53:01,157 Task._call(1068) INFO 39.1% complete 2019-06-03 20:53:07,032 Task._call(1068) INFO 39.1% complete 2019-06-03 20:53:13,109 Task._call(1068) INFO 40.2% complete 2019-06-03 20:53:19,155 Task._call(1068) INFO 40.2% complete 2019-06-03 20:53:25,062 Task._call(1068) INFO 40.2% complete 2019-06-03 20:53:31,140 Task._call(1068) INFO 41.3% complete 2019-06-03 20:53:37,029 Task._call(1068) INFO 41.3% complete 2019-06-03 20:53:43,124 Task._call(1068) INFO 41.3% complete 2019-06-03 20:53:49,092 Task._call(1068) INFO 42.4% complete 2019-06-03 20:53:55,075 Task._call(1068) INFO 42.4% complete 2019-06-03 20:54:01,075 Task._call(1068) INFO 42.4% complete 2019-06-03 20:54:07,091 Task._call(1068) INFO 42.4% complete 2019-06-03 20:54:13,075 Task._call(1068) INFO 43.5% complete 2019-06-03 20:54:19,153 Task._call(1068) INFO 43.5% complete 2019-06-03 20:54:25,184 Task._call(1068) INFO 43.5% complete 2019-06-03 20:54:31,088 Task._call(1068) INFO 44.6% complete 2019-06-03 20:54:37,042 Task._call(1068) INFO 44.6% complete 2019-06-03 20:54:43,042 Task._call(1068) INFO 44.6% complete 2019-06-03 20:54:49,072 Task._call(1068) INFO 44.6% complete 2019-06-03 20:54:55,197 Task._call(1068) INFO 45.7% complete 2019-06-03 20:55:01,107 Task._call(1068) INFO 45.8% complete 2019-06-03 20:55:07,153 Task._call(1068) INFO 45.8% complete 2019-06-03 20:55:13,028 Task._call(1068) INFO 46.9% complete 2019-06-03 20:55:19,121 Task._call(1068) INFO 46.9% complete 2019-06-03 20:55:25,026 Task._call(1068) INFO 46.9% complete 2019-06-03 20:55:31,167 Task._call(1068) INFO 46.9% complete 2019-06-03 20:55:37,151 Task._call(1068) INFO 48.0% complete 2019-06-03 20:55:43,026 Task._call(1068) INFO 48.0% complete 2019-06-03 20:55:49,822 Task._call(1068) INFO 48.0% complete 2019-06-03 20:55:55,088 Task._call(1068) INFO 48.0% complete 2019-06-03 20:56:01,134 Task._call(1068) INFO 49.1% complete 2019-06-03 20:56:07,134 Task._call(1068) INFO 49.1% complete 2019-06-03 20:56:13,055 Task._call(1068) INFO 49.1% complete 2019-06-03 20:56:19,007 Task._call(1068) INFO 50.2% complete 2019-06-03 20:56:25,007 Task._call(1068) INFO 50.2% complete 2019-06-03 20:56:31,023 Task._call(1068) INFO 50.2% complete 2019-06-03 20:56:37,131 Task._call(1068) INFO 50.2% complete 2019-06-03 20:56:43,006 Task._call(1068) INFO 51.3% complete 2019-06-03 20:56:49,177 Task._call(1068) INFO 51.3% complete 2019-06-03 20:56:55,084 Task._call(1068) INFO 51.3% complete 2019-06-03 20:57:01,052 Task._call(1068) INFO 52.4% complete 2019-06-03 20:57:07,115 Task._call(1068) INFO 52.4% complete 2019-06-03 20:57:13,223 Task._call(1068) INFO 52.4% complete 2019-06-03 20:57:19,114 Task._call(1068) INFO 52.4% complete 2019-06-03 20:57:25,503 Task._call(1068) INFO 53.6% complete 2019-06-03 20:57:31,032 Task._call(1068) INFO 53.6% complete 2019-06-03 20:57:37,032 Task._call(1068) INFO 53.6% complete 2019-06-03 20:57:43,032 Task._call(1068) INFO 54.7% complete 2019-06-03 20:57:49,141 Task._call(1068) INFO 54.7% complete 2019-06-03 20:57:55,134 Task._call(1068) INFO 54.7% complete 2019-06-03 20:58:01,086 Task._call(1068) INFO 54.7% complete 2019-06-03 20:58:07,132 Task._call(1068) INFO 55.8% complete 2019-06-03 20:58:13,164 Task._call(1068) INFO 55.8% complete 2019-06-03 20:58:19,023 Task._call(1068) INFO 55.8% complete 2019-06-03 20:58:25,085 Task._call(1068) INFO 56.9% complete 2019-06-03 20:58:31,101 Task._call(1068) INFO 56.9% complete 2019-06-03 20:58:37,272 Task._call(1068) INFO 56.9% complete 2019-06-03 20:58:43,022 Task._call(1068) INFO 56.9% complete 2019-06-03 20:58:49,177 Task._call(1068) INFO 58.0% complete 2019-06-03 20:58:55,068 Task._call(1068) INFO 58.0% complete 2019-06-03 20:59:01,098 Task._call(1068) INFO 58.0% complete 2019-06-03 20:59:07,130 Task._call(1068) INFO 59.1% complete 2019-06-03 20:59:13,036 Task._call(1068) INFO 59.1% complete 2019-06-03 20:59:19,003 Task._call(1068) INFO 60.3% complete 2019-06-03 20:59:25,065 Task._call(1068) INFO 60.3% complete 2019-06-03 20:59:31,394 Task._call(1068) INFO 60.3% complete 2019-06-03 20:59:37,190 Task._call(1068) INFO 60.3% complete 2019-06-03 20:59:43,142 Task._call(1068) INFO 61.4% complete 2019-06-03 20:59:49,142 Task._call(1068) INFO 61.4% complete 2019-06-03 20:59:55,032 Task._call(1068) INFO 61.4% complete 2019-06-03 21:00:01,002 Task._call(1068) INFO 62.5% complete 2019-06-03 21:00:07,078 Task._call(1068) INFO 62.5% complete 2019-06-03 21:00:13,109 Task._call(1068) INFO 62.5% complete 2019-06-03 21:00:19,109 Task._call(1068) INFO 63.6% complete 2019-06-03 21:00:25,078 Task._call(1068) INFO 63.6% complete 2019-06-03 21:00:31,030 Task._call(1068) INFO 63.6% complete 2019-06-03 21:00:37,092 Task._call(1068) INFO 64.7% complete 2019-06-03 21:00:43,124 Task._call(1068) INFO 64.7% complete 2019-06-03 21:00:49,076 Task._call(1068) INFO 64.7% complete 2019-06-03 21:00:55,201 Task._call(1068) INFO 65.8% complete 2019-06-03 21:01:01,107 Task._call(1068) INFO 65.8% complete 2019-06-03 21:01:07,059 Task._call(1068) INFO 65.8% complete 2019-06-03 21:01:13,059 Task._call(1068) INFO 67.0% complete 2019-06-03 21:01:19,043 Task._call(1068) INFO 67.0% complete 2019-06-03 21:01:25,012 Task._call(1068) INFO 68.1% complete 2019-06-03 21:01:31,137 Task._call(1068) INFO 68.1% complete 2019-06-03 21:01:37,026 Task._call(1068) INFO 68.1% complete 2019-06-03 21:01:43,198 Task._call(1068) INFO 69.2% complete 2019-06-03 21:01:49,088 Task._call(1068) INFO 69.2% complete 2019-06-03 21:01:55,026 Task._call(1068) INFO 69.2% complete 2019-06-03 21:02:01,056 Task._call(1068) INFO 70.3% complete 2019-06-03 21:02:07,118 Task._call(1068) INFO 70.3% complete 2019-06-03 21:02:13,088 Task._call(1068) INFO 70.3% complete 2019-06-03 21:02:19,102 Task._call(1068) INFO 71.4% complete 2019-06-03 21:02:25,055 Task._call(1068) INFO 71.4% complete 2019-06-03 21:02:31,059 Task._call(1068) INFO 71.4% complete 2019-06-03 21:02:37,137 Task._call(1068) INFO 72.5% complete 2019-06-03 21:02:43,167 Task._call(1068) INFO 72.5% complete 2019-06-03 21:02:49,042 Task._call(1068) INFO 73.6% complete 2019-06-03 21:02:55,026 Task._call(1068) INFO 73.6% complete 2019-06-03 21:03:01,042 Task._call(1068) INFO 73.6% complete 2019-06-03 21:03:07,058 Task._call(1068) INFO 74.8% complete 2019-06-03 21:03:13,042 Task._call(1068) INFO 74.8% complete 2019-06-03 21:03:19,056 Task._call(1068) INFO 75.9% complete 2019-06-03 21:03:25,040 Task._call(1068) INFO 75.9% complete 2019-06-03 21:03:31,009 Task._call(1068) INFO 75.9% complete 2019-06-03 21:03:37,118 Task._call(1068) INFO 77.0% complete 2019-06-03 21:03:43,148 Task._call(1068) INFO 77.0% complete 2019-06-03 21:03:49,039 Task._call(1068) INFO 78.1% complete 2019-06-03 21:03:55,085 Task._call(1068) INFO 78.1% complete 2019-06-03 21:04:01,101 Task._call(1068) INFO 79.2% complete 2019-06-03 21:04:07,101 Task._call(1068) INFO 79.2% complete 2019-06-03 21:04:13,069 Task._call(1068) INFO 80.3% complete 2019-06-03 21:04:19,038 Task._call(1068) INFO 80.3% complete 2019-06-03 21:04:25,131 Task._call(1068) INFO 81.5% complete 2019-06-03 21:04:31,084 Task._call(1068) INFO 82.6% complete 2019-06-03 21:04:37,145 Task._call(1068) INFO 83.7% complete 2019-06-03 21:04:43,036 Task._call(1068) INFO 83.7% complete 2019-06-03 21:04:49,114 Task._call(1068) INFO 84.8% complete 2019-06-03 21:04:55,144 Task._call(1068) INFO 85.9% complete 2019-06-03 21:05:01,003 Task._call(1068) INFO 88.2% complete 2019-06-03 21:05:11,565 Task._call(1068) INFO 88.2% complete 2019-06-03 21:05:17,003 Task._call(1068) INFO 92.6% complete 2019-06-03 21:05:23,033 Task._call(1068) INFO 98.2% complete 2019-06-03 21:05:24,065 Task._call(1068) INFO 100.0% complete 2019-06-03 21:05:31,315 geoprocessing.(918) INFO 16.8% complete 2019-06-03 21:05:36,329 geoprocessing.(918) INFO 31.2% complete 2019-06-03 21:05:41,345 geoprocessing.(918) INFO 45.6% complete 2019-06-03 21:05:46,361 geoprocessing.(918) INFO 59.9% complete 2019-06-03 21:05:51,375 geoprocessing.(918) INFO 74.4% complete 2019-06-03 21:05:56,391 geoprocessing.(918) INFO 88.8% complete 2019-06-03 21:10:55,357 geoprocessing.raster_calculator(366) INFO starting stats_worker 2019-06-03 21:10:56,825 geoprocessing.raster_calculator(372) INFO started stats_worker 2019-06-03 21:11:00,372 geoprocessing.(442) INFO 4.7% complete 2019-06-03 21:11:05,388 geoprocessing.(442) INFO 8.4% complete 2019-06-03 21:11:10,403 geoprocessing.(442) INFO 11.7% complete 2019-06-03 21:11:15,418 geoprocessing.(442) INFO 14.7% complete 2019-06-03 21:11:20,434 geoprocessing.(442) INFO 17.2% complete 2019-06-03 21:11:25,448 geoprocessing.(442) INFO 20.2% complete 2019-06-03 21:11:30,480 geoprocessing.(442) INFO 22.6% complete 2019-06-03 21:11:35,496 geoprocessing.(442) INFO 25.2% complete 2019-06-03 21:11:40,526 geoprocessing.(442) INFO 28.0% complete 2019-06-03 21:11:45,558 geoprocessing.(442) INFO 30.5% complete 2019-06-03 21:11:50,604 geoprocessing.(442) INFO 32.7% complete 2019-06-03 21:11:55,634 geoprocessing.(442) INFO 34.6% complete 2019-06-03 21:12:00,650 geoprocessing.(442) INFO 35.9% complete 2019-06-03 21:12:05,665 geoprocessing.(442) INFO 37.3% complete 2019-06-03 21:12:10,711 geoprocessing.(442) INFO 38.7% complete 2019-06-03 21:12:15,743 geoprocessing.(442) INFO 39.9% complete 2019-06-03 21:12:20,789 geoprocessing.(442) INFO 41.0% complete 2019-06-03 21:12:25,805 geoprocessing.(442) INFO 42.1% complete 2019-06-03 21:12:30,821 geoprocessing.(442) INFO 43.3% complete 2019-06-03 21:12:35,835 geoprocessing.(442) INFO 44.5% complete 2019-06-03 21:12:40,867 geoprocessing.(442) INFO 45.6% complete 2019-06-03 21:12:45,881 geoprocessing.(442) INFO 46.7% complete 2019-06-03 21:12:50,928 geoprocessing.(442) INFO 47.9% complete 2019-06-03 21:12:55,960 geoprocessing.(442) INFO 49.0% complete 2019-06-03 21:13:00,974 geoprocessing.(442) INFO 50.1% complete 2019-06-03 21:13:06,022 geoprocessing.(442) INFO 51.2% complete 2019-06-03 21:13:11,068 geoprocessing.(442) INFO 52.1% complete 2019-06-03 21:13:16,098 geoprocessing.(442) INFO 53.2% complete 2019-06-03 21:13:21,114 geoprocessing.(442) INFO 54.3% complete 2019-06-03 21:13:26,122 geoprocessing.(442) INFO 55.6% complete 2019-06-03 21:13:31,168 geoprocessing.(442) INFO 56.7% complete 2019-06-03 21:13:36,200 geoprocessing.(442) INFO 57.9% complete 2019-06-03 21:13:41,216 geoprocessing.(442) INFO 59.1% complete 2019-06-03 21:13:46,262 geoprocessing.(442) INFO 60.3% complete 2019-06-03 21:13:51,292 geoprocessing.(442) INFO 61.6% complete 2019-06-03 21:13:56,323 geoprocessing.(442) INFO 62.8% complete 2019-06-03 21:14:01,355 geoprocessing.(442) INFO 64.2% complete 2019-06-03 21:14:06,385 geoprocessing.(442) INFO 65.6% complete 2019-06-03 21:14:11,417 geoprocessing.(442) INFO 66.9% complete 2019-06-03 21:14:16,447 geoprocessing.(442) INFO 68.2% complete 2019-06-03 21:14:21,494 geoprocessing.(442) INFO 69.5% complete 2019-06-03 21:14:26,509 geoprocessing.(442) INFO 70.9% complete 2019-06-03 21:14:31,540 geoprocessing.(442) INFO 72.5% complete 2019-06-03 21:14:36,572 geoprocessing.(442) INFO 73.8% complete 2019-06-03 21:14:41,618 geoprocessing.(442) INFO 75.2% complete 2019-06-03 21:14:46,634 geoprocessing.(442) INFO 76.7% complete 2019-06-03 21:14:51,664 geoprocessing.(442) INFO 78.2% complete 2019-06-03 21:14:56,696 geoprocessing.(442) INFO 79.6% complete 2019-06-03 21:15:01,742 geoprocessing.(442) INFO 81.6% complete 2019-06-03 21:15:06,757 geoprocessing.(442) INFO 84.0% complete 2019-06-03 21:15:11,773 geoprocessing.(442) INFO 86.9% complete 2019-06-03 21:15:16,788 geoprocessing.(442) INFO 90.4% complete 2019-06-03 21:15:21,803 geoprocessing.(442) INFO 95.9% complete 2019-06-03 21:15:25,365 geoprocessing.raster_calculator(445) INFO 100.0%% complete 2019-06-03 21:15:25,381 geoprocessing.raster_calculator(448) INFO signaling stats worker to terminate 2019-06-03 21:15:25,381 geoprocessing.raster_calculator(450) INFO Waiting for raster stats worker result. 2019-06-03 21:15:25,381 threading.run(754) DEBUG payload is None, terminating 2019-06-03 21:15:35,724 geoprocessing.(918) INFO 24.7% complete 2019-06-03 21:15:40,740 geoprocessing.(918) INFO 46.7% complete 2019-06-03 21:15:45,755 geoprocessing.(918) INFO 68.4% complete 2019-06-03 21:15:50,770 geoprocessing.(918) INFO 90.5% complete 2019-06-03 21:15:58,786 geoprocessing.(918) INFO 11.5% complete 2019-06-03 21:16:03,801 geoprocessing.(918) INFO 21.0% complete 2019-06-03 21:16:08,815 geoprocessing.(918) INFO 30.5% complete 2019-06-03 21:16:13,832 geoprocessing.(918) INFO 40.0% complete 2019-06-03 21:16:18,846 geoprocessing.(918) INFO 49.3% complete 2019-06-03 21:16:23,861 geoprocessing.(918) INFO 58.8% complete 2019-06-03 21:16:28,878 geoprocessing.(918) INFO 68.3% complete 2019-06-03 21:16:33,892 geoprocessing.(918) INFO 77.7% complete 2019-06-03 21:16:38,907 geoprocessing.(918) INFO 87.2% complete 2019-06-03 21:16:43,924 geoprocessing.(918) INFO 96.7% complete 2019-06-03 21:16:51,782 geoprocessing.(918) INFO 25.2% complete 2019-06-03 21:16:56,798 geoprocessing.(918) INFO 47.1% complete 2019-06-03 21:17:01,812 geoprocessing.(918) INFO 69.0% complete 2019-06-03 21:17:06,828 geoprocessing.(918) INFO 90.6% complete 2019-06-03 21:17:14,875 geoprocessing.(918) INFO 9.1% complete 2019-06-03 21:17:19,890 geoprocessing.(918) INFO 16.7% complete 2019-06-03 21:17:24,905 geoprocessing.(918) INFO 24.4% complete 2019-06-03 21:17:29,921 geoprocessing.(918) INFO 31.9% complete 2019-06-03 21:17:34,936 geoprocessing.(918) INFO 39.6% complete 2019-06-03 21:17:39,951 geoprocessing.(918) INFO 47.4% complete 2019-06-03 21:17:44,967 geoprocessing.(918) INFO 55.0% complete 2019-06-03 21:17:49,982 geoprocessing.(918) INFO 62.7% complete 2019-06-03 21:17:54,997 geoprocessing.(918) INFO 69.7% complete 2019-06-03 21:18:00,013 geoprocessing.(918) INFO 75.9% complete 2019-06-03 21:18:05,028 geoprocessing.(918) INFO 82.2% complete 2019-06-03 21:18:10,043 geoprocessing.(918) INFO 88.5% complete 2019-06-03 21:18:15,059 geoprocessing.(918) INFO 94.7% complete 2019-06-03 21:18:20,839 Task._call(1068) INFO 0.0% complete 2019-06-03 21:18:26,078 Task._call(1068) INFO 1.1% complete 2019-06-03 21:18:32,486 Task._call(1068) INFO 2.2% complete 2019-06-03 21:18:38,002 Task._call(1068) INFO 2.2% complete 2019-06-03 21:18:44,049 Task._call(1068) INFO 3.4% complete 2019-06-03 21:18:50,079 Task._call(1068) INFO 3.4% complete 2019-06-03 21:18:56,016 Task._call(1068) INFO 4.5% complete 2019-06-03 21:19:02,187 Task._call(1068) INFO 4.5% complete 2019-06-03 21:19:08,157 Task._call(1068) INFO 4.5% complete 2019-06-03 21:19:14,328 Task._call(1068) INFO 5.6% complete 2019-06-03 21:19:20,187 Task._call(1068) INFO 5.6% complete 2019-06-03 21:19:26,536 Task._call(1068) INFO 5.6% complete 2019-06-03 21:19:32,098 Task._call(1068) INFO 6.7% complete 2019-06-03 21:19:38,660 Task._call(1068) INFO 6.7% complete 2019-06-03 21:19:44,394 Task._call(1068) INFO 6.7% complete 2019-06-03 21:19:50,457 Task._call(1068) INFO 7.8% complete 2019-06-03 21:19:56,112 Task._call(1068) INFO 7.8% complete 2019-06-03 21:20:02,253 Task._call(1068) INFO 7.8% complete 2019-06-03 21:20:08,049 Task._call(1068) INFO 7.8% complete 2019-06-03 21:20:14,032 Task._call(1068) INFO 8.9% complete 2019-06-03 21:20:20,111 Task._call(1068) INFO 8.9% complete 2019-06-03 21:20:26,345 Task._call(1068) INFO 8.9% complete 2019-06-03 21:20:32,000 Task._call(1068) INFO 10.0% complete 2019-06-03 21:20:38,312 Task._call(1068) INFO 10.0% complete 2019-06-03 21:20:44,000 Task._call(1068) INFO 10.0% complete 2019-06-03 21:20:50,530 Task._call(1068) INFO 10.0% complete 2019-06-03 21:20:56,390 Task._call(1068) INFO 10.0% complete 2019-06-03 21:21:02,046 Task._call(1068) INFO 11.2% complete 2019-06-03 21:21:08,467 Task._call(1068) INFO 11.2% complete 2019-06-03 21:21:14,421 Task._call(1068) INFO 11.2% complete 2019-06-03 21:21:20,138 Task._call(1068) INFO 11.2% complete 2019-06-03 21:21:26,529 Task._call(1068) INFO 12.3% complete 2019-06-03 21:21:32,091 Task._call(1068) INFO 12.3% complete 2019-06-03 21:21:38,246 Task._call(1068) INFO 12.3% complete 2019-06-03 21:21:44,200 Task._call(1068) INFO 12.3% complete 2019-06-03 21:21:50,121 Task._call(1068) INFO 12.3% complete 2019-06-03 21:21:56,934 Task._call(1068) INFO 13.4% complete 2019-06-03 21:22:02,105 Task._call(1068) INFO 13.4% complete 2019-06-03 21:22:08,901 Task._call(1068) INFO 13.4% complete 2019-06-03 21:22:16,244 Task._call(1068) INFO 13.4% complete 2019-06-03 21:23:10,523 Task._call(1068) INFO 13.4% complete 2019-06-03 21:24:32,946 Task._call(1068) INFO 13.4% complete 2019-06-03 21:24:51,538 Task._call(1068) INFO 13.4% complete 2019-06-03 21:25:37,746 Task._call(1068) INFO 13.4% complete 2019-06-03 21:26:27,930 Task._call(1068) INFO 13.4% complete 2019-06-03 21:26:33,352 Task._call(1068) INFO 14.5% complete 2019-06-03 21:26:39,243 Task._call(1068) INFO 14.5% complete 2019-06-03 21:26:45,039 Task._call(1068) INFO 14.5% complete 2019-06-03 21:26:51,210 Task._call(1068) INFO 14.5% complete 2019-06-03 21:26:57,226 Task._call(1068) INFO 15.6% complete 2019-06-03 21:27:03,413 Task._call(1068) INFO 15.6% complete 2019-06-03 21:27:09,022 Task._call(1068) INFO 15.6% complete 2019-06-03 21:27:15,427 Task._call(1068) INFO 15.6% complete 2019-06-03 21:27:21,177 Task._call(1068) INFO 16.7% complete 2019-06-03 21:27:27,082 Task._call(1068) INFO 16.7% complete 2019-06-03 21:27:33,207 Task._call(1068) INFO 16.7% complete 2019-06-03 21:27:39,269 Task._call(1068) INFO 16.7% complete 2019-06-03 21:27:45,019 Task._call(1068) INFO 16.7% complete 2019-06-03 21:27:51,107 Task._call(1068) INFO 17.9% complete 2019-06-03 21:27:57,184 Task._call(1068) INFO 17.9% complete 2019-06-03 21:28:03,184 Task._call(1068) INFO 17.9% complete 2019-06-03 21:28:09,089 Task._call(1068) INFO 17.9% complete 2019-06-03 21:28:15,667 Task._call(1068) INFO 17.9% complete 2019-06-03 21:28:21,433 Task._call(1068) INFO 17.9% complete 2019-06-03 21:28:27,713 Task._call(1068) INFO 19.0% complete 2019-06-03 21:28:33,431 Task._call(1068) INFO 19.0% complete 2019-06-03 21:28:39,104 Task._call(1068) INFO 19.0% complete 2019-06-03 21:28:45,368 Task._call(1068) INFO 19.0% complete 2019-06-03 21:28:51,025 Task._call(1068) INFO 19.0% complete 2019-06-03 21:28:57,961 Task._call(1068) INFO 20.1% complete 2019-06-03 21:29:04,211 Task._call(1068) INFO 20.1% complete 2019-06-03 21:29:18,944 Task._call(1068) INFO 20.1% complete 2019-06-03 21:31:06,934 Task._call(1068) INFO 20.1% complete 2019-06-03 21:31:59,979 Task._call(1068) INFO 20.1% complete 2019-06-03 21:32:41,460 Task._call(1068) INFO 20.1% complete 2019-06-03 21:33:06,663 Task._call(1068) INFO 20.1% complete 2019-06-03 21:33:12,875 Task._call(1068) INFO 20.1% complete 2019-06-03 21:33:18,125 Task._call(1068) INFO 20.1% complete 2019-06-03 21:33:24,625 Task._call(1068) INFO 21.2% complete 2019-06-03 21:33:30,171 Task._call(1068) INFO 21.2% complete 2019-06-03 21:33:36,608 Task._call(1068) INFO 21.2% complete 2019-06-03 21:33:42,467 Task._call(1068) INFO 21.2% complete 2019-06-03 21:33:48,062 Task._call(1068) INFO 21.2% complete 2019-06-03 21:33:54,138 Task._call(1068) INFO 22.3% complete 2019-06-03 21:34:00,326 Task._call(1068) INFO 22.3% complete 2019-06-03 21:34:06,295 Task._call(1068) INFO 22.3% complete 2019-06-03 21:34:12,295 Task._call(1068) INFO 22.3% complete 2019-06-03 21:34:18,357 Task._call(1068) INFO 22.3% complete 2019-06-03 21:34:24,043 Task._call(1068) INFO 23.4% complete 2019-06-03 21:34:30,043 Task._call(1068) INFO 23.4% complete 2019-06-03 21:34:36,355 Task._call(1068) INFO 23.4% complete 2019-06-03 21:36:02,038 Task._call(1068) INFO 23.4% complete 2019-06-03 21:37:20,440 Task._call(1068) INFO 23.4% complete 2019-06-03 21:38:09,938 Task._call(1068) INFO 23.4% complete 2019-06-03 21:38:35,407 Task._call(1068) INFO 23.4% complete 2019-06-03 21:38:41,250 Task._call(1068) INFO 23.4% complete 2019-06-03 21:38:47,298 Task._call(1068) INFO 24.5% complete 2019-06-03 21:38:53,000 Task._call(1068) INFO 24.6% complete 2019-06-03 21:38:59,437 Task._call(1068) INFO 24.6% complete 2019-06-03 21:39:05,812 Task._call(1068) INFO 24.6% complete 2019-06-03 21:39:11,265 Task._call(1068) INFO 24.6% complete 2019-06-03 21:39:17,765 Task._call(1068) INFO 25.7% complete 2019-06-03 21:39:23,358 Task._call(1068) INFO 25.7% complete 2019-06-03 21:39:29,342 Task._call(1068) INFO 25.7% complete 2019-06-03 21:39:35,029 Task._call(1068) INFO 25.7% complete 2019-06-03 21:39:41,638 Task._call(1068) INFO 25.7% complete 2019-06-03 21:39:47,184 Task._call(1068) INFO 26.8% complete 2019-06-03 21:39:53,700 Task._call(1068) INFO 26.8% complete 2019-06-03 21:39:59,450 Task._call(1068) INFO 26.8% complete 2019-06-03 21:40:05,417 Task._call(1068) INFO 26.8% complete 2019-06-03 21:40:11,496 Task._call(1068) INFO 26.8% complete 2019-06-03 21:40:17,369 Task._call(1068) INFO 27.9% complete 2019-06-03 21:40:23,713 Task._call(1068) INFO 27.9% complete 2019-06-03 21:40:41,993 Task._call(1068) INFO 27.9% complete 2019-06-03 21:42:11,691 Task._call(1068) INFO 27.9% complete 2019-06-03 21:43:31,875 Task._call(1068) INFO 27.9% complete 2019-06-03 21:44:00,500 Task._call(1068) INFO 27.9% complete 2019-06-03 21:44:29,170 Task._call(1068) INFO 27.9% complete 2019-06-03 21:44:35,559 Task._call(1068) INFO 27.9% complete 2019-06-03 21:44:41,325 Task._call(1068) INFO 27.9% complete 2019-06-03 21:44:47,246 Task._call(1068) INFO 29.0% complete 2019-06-03 21:44:53,403 Task._call(1068) INFO 29.0% complete 2019-06-03 21:44:59,262 Task._call(1068) INFO 29.0% complete 2019-06-03 21:45:05,496 Task._call(1068) INFO 29.0% complete 2019-06-03 21:45:11,417 Task._call(1068) INFO 29.0% complete 2019-06-03 21:45:17,292 Task._call(1068) INFO 30.1% complete 2019-06-03 21:45:23,354 Task._call(1068) INFO 30.1% complete 2019-06-03 21:46:01,368 Task._call(1068) INFO 30.1% complete 2019-06-03 21:46:35,240 Task._call(1068) INFO 30.1% complete 2019-06-03 21:47:54,877 Task._call(1068) INFO 30.1% complete 2019-06-03 21:48:35,140 Task._call(1068) INFO 30.1% complete 2019-06-03 21:49:26,114 Task._call(1068) INFO 30.1% complete 2019-06-03 21:49:32,286 Task._call(1068) INFO 30.1% complete 2019-06-03 21:49:38,207 Task._call(1068) INFO 30.1% complete 2019-06-03 21:49:44,471 Task._call(1068) INFO 30.1% complete 2019-06-03 21:49:50,190 Task._call(1068) INFO 30.1% complete 2019-06-03 21:49:56,065 Task._call(1068) INFO 31.2% complete 2019-06-03 21:50:02,486 Task._call(1068) INFO 31.2% complete 2019-06-03 21:50:08,299 Task._call(1068) INFO 31.2% complete 2019-06-03 21:50:43,687 Task._call(1068) INFO 31.2% complete 2019-06-03 21:51:06,092 Task._call(1068) INFO 31.2% complete 2019-06-03 21:51:55,184 Task._call(1068) INFO 31.2% complete 2019-06-03 21:53:12,085 Task._call(1068) INFO 31.2% complete 2019-06-03 21:53:43,645 Task._call(1068) INFO 31.2% complete 2019-06-03 21:54:11,723 Task._call(1068) INFO 31.2% complete 2019-06-03 21:54:17,552 Task._call(1068) INFO 31.2% complete 2019-06-03 21:54:23,253 Task._call(1068) INFO 31.2% complete 2019-06-03 21:54:29,035 Task._call(1068) INFO 31.2% complete 2019-06-03 21:54:35,299 Task._call(1068) INFO 32.4% complete 2019-06-03 21:54:41,362 Task._call(1068) INFO 32.4% complete 2019-06-03 21:54:47,378 Task._call(1068) INFO 32.4% complete 2019-06-03 21:54:53,033 Task._call(1068) INFO 32.4% complete 2019-06-03 21:54:59,177 Task._call(1068) INFO 32.4% complete 2019-06-03 21:55:05,069 Task._call(1068) INFO 32.4% complete 2019-06-03 21:55:11,036 Task._call(1068) INFO 32.4% complete 2019-06-03 21:55:17,865 Task._call(1068) INFO 32.4% complete 2019-06-03 21:55:23,318 Task._call(1068) INFO 32.4% complete 2019-06-03 21:55:29,394 Task._call(1068) INFO 33.5% complete 2019-06-03 21:55:35,003 Task._call(1068) INFO 33.5% complete 2019-06-03 21:55:41,191 Task._call(1068) INFO 33.5% complete 2019-06-03 21:55:47,269 Task._call(1068) INFO 33.5% complete 2019-06-03 21:55:53,160 Task._call(1068) INFO 33.5% complete 2019-06-03 21:55:59,408 Task._call(1068) INFO 33.5% complete 2019-06-03 21:56:05,470 Task._call(1068) INFO 33.5% complete 2019-06-03 21:56:11,549 Task._call(1068) INFO 33.5% complete 2019-06-03 21:56:17,142 Task._call(1068) INFO 33.5% complete 2019-06-03 21:56:23,454 Task._call(1068) INFO 33.5% complete 2019-06-03 21:56:29,048 Task._call(1068) INFO 34.6% complete 2019-06-03 21:56:35,048 Task._call(1068) INFO 34.6% complete 2019-06-03 21:56:41,266 Task._call(1068) INFO 34.6% complete 2019-06-03 21:56:47,484 Task._call(1068) INFO 34.6% complete 2019-06-03 21:56:53,140 Task._call(1068) INFO 34.6% complete 2019-06-03 21:56:59,140 Task._call(1068) INFO 34.6% complete 2019-06-03 21:57:05,154 Task._call(1068) INFO 34.6% complete 2019-06-03 21:57:11,561 Task._call(1068) INFO 34.6% complete 2019-06-03 21:57:17,342 Task._call(1068) INFO 34.6% complete 2019-06-03 21:57:23,118 Task._call(1068) INFO 34.6% complete 2019-06-03 21:57:29,032 Task._call(1068) INFO 34.6% complete 2019-06-03 21:57:35,187 Task._call(1068) INFO 35.7% complete 2019-06-03 21:57:41,391 Task._call(1068) INFO 35.7% complete 2019-06-03 21:57:47,687 Task._call(1068) INFO 35.7% complete 2019-06-03 21:57:53,391 Task._call(1068) INFO 35.7% complete 2019-06-03 21:57:59,233 Task._call(1068) INFO 35.7% complete 2019-06-03 21:58:05,171 Task._call(1068) INFO 35.7% complete 2019-06-03 21:58:11,140 Task._call(1068) INFO 35.7% complete 2019-06-03 21:58:17,404 Task._call(1068) INFO 35.7% complete 2019-06-03 21:58:23,045 Task._call(1068) INFO 35.7% complete 2019-06-03 21:58:29,059 Task._call(1068) INFO 35.7% complete 2019-06-03 21:58:35,293 Task._call(1068) INFO 35.7% complete 2019-06-03 21:58:41,575 Task._call(1068) INFO 36.8% complete 2019-06-03 21:58:47,371 Task._call(1068) INFO 36.8% complete 2019-06-03 21:58:53,528 Task._call(1068) INFO 36.8% complete 2019-06-03 21:58:59,762 Task._call(1068) INFO 36.8% complete 2019-06-03 21:59:05,496 Task._call(1068) INFO 36.8% complete 2019-06-03 21:59:11,730 Task._call(1068) INFO 36.8% complete 2019-06-03 21:59:17,135 Task._call(1068) INFO 36.8% complete 2019-06-03 21:59:23,479 Task._call(1068) INFO 36.8% complete 2019-06-03 21:59:29,431 Task._call(1068) INFO 36.8% complete 2019-06-03 21:59:35,384 Task._call(1068) INFO 36.8% complete 2019-06-03 21:59:41,289 Task._call(1068) INFO 36.8% complete 2019-06-03 21:59:47,868 Task._call(1068) INFO 36.8% complete 2019-06-03 21:59:53,696 Task._call(1068) INFO 37.9% complete 2019-06-03 21:59:59,523 Task._call(1068) INFO 37.9% complete 2019-06-03 22:00:05,055 Task._call(1068) INFO 37.9% complete 2019-06-03 22:00:11,303 Task._call(1068) INFO 37.9% complete 2019-06-03 22:00:17,460 Task._call(1068) INFO 37.9% complete 2019-06-03 22:00:23,272 Task._call(1068) INFO 37.9% complete 2019-06-03 22:00:29,506 Task._call(1068) INFO 37.9% complete 2019-06-03 22:00:35,411 Task._call(1068) INFO 37.9% complete 2019-06-03 22:00:41,911 Task._call(1068) INFO 37.9% complete 2019-06-03 22:00:47,693 Task._call(1068) INFO 37.9% complete 2019-06-03 22:00:53,130 Task._call(1068) INFO 37.9% complete 2019-06-03 22:00:59,894 Task._call(1068) INFO 37.9% complete 2019-06-03 22:01:05,348 Task._call(1068) INFO 37.9% complete 2019-06-03 22:01:11,003 Task._call(1068) INFO 39.1% complete 2019-06-03 22:01:17,253 Task._call(1068) INFO 39.1% complete 2019-06-03 22:01:23,112 Task._call(1068) INFO 39.1% complete 2019-06-03 22:01:29,081 Task._call(1068) INFO 39.1% complete 2019-06-03 22:01:35,440 Task._call(1068) INFO 39.1% complete 2019-06-03 22:01:41,627 Task._call(1068) INFO 39.1% complete 2019-06-03 22:01:47,299 Task._call(1068) INFO 39.1% complete 2019-06-03 22:01:53,095 Task._call(1068) INFO 39.1% complete 2019-06-03 22:01:59,703 Task._call(1068) INFO 39.1% complete 2019-06-03 22:02:05,625 Task._call(1068) INFO 39.1% complete 2019-06-03 22:02:11,546 Task._call(1068) INFO 39.1% complete 2019-06-03 22:02:17,030 Task._call(1068) INFO 39.1% complete 2019-06-03 22:02:23,062 Task._call(1068) INFO 39.1% complete 2019-06-03 22:02:29,332 Task._call(1068) INFO 40.2% complete 2019-06-03 22:02:35,456 Task._call(1068) INFO 40.2% complete 2019-06-03 22:02:41,283 Task._call(1068) INFO 40.2% complete 2019-06-03 22:02:47,079 Task._call(1068) INFO 40.2% complete 2019-06-03 22:02:53,065 Task._call(1068) INFO 40.2% complete 2019-06-03 22:02:59,516 Task._call(1068) INFO 40.2% complete 2019-06-03 22:03:05,953 Task._call(1068) INFO 40.2% complete 2019-06-03 22:03:11,282 Task._call(1068) INFO 40.2% complete 2019-06-03 22:03:17,344 Task._call(1068) INFO 40.2% complete 2019-06-03 22:03:23,578 Task._call(1068) INFO 40.2% complete 2019-06-03 22:03:30,125 Task._call(1068) INFO 40.2% complete 2019-06-03 22:03:36,374 Task._call(1068) INFO 40.2% complete 2019-06-03 22:03:42,296 Task._call(1068) INFO 40.2% complete 2019-06-03 22:03:48,154 Task._call(1068) INFO 41.3% complete 2019-06-03 22:03:54,108 Task._call(1068) INFO 41.3% complete 2019-06-03 22:04:00,497 Task._call(1068) INFO 41.3% complete 2019-06-03 22:04:06,825 Task._call(1068) INFO 41.3% complete 2019-06-03 22:04:12,279 Task._call(1068) INFO 41.3% complete 2019-06-03 22:04:18,325 Task._call(1068) INFO 41.3% complete 2019-06-03 22:04:24,730 Task._call(1068) INFO 41.3% complete 2019-06-03 22:04:30,184 Task._call(1068) INFO 41.3% complete 2019-06-03 22:04:36,339 Task._call(1068) INFO 41.3% complete 2019-06-03 22:04:42,355 Task._call(1068) INFO 41.3% complete 2019-06-03 22:04:48,588 Task._call(1068) INFO 41.3% complete 2019-06-03 22:04:54,244 Task._call(1068) INFO 41.3% complete 2019-06-03 22:05:00,104 Task._call(1068) INFO 41.3% complete 2019-06-03 22:05:06,213 Task._call(1068) INFO 42.4% complete 2019-06-03 22:05:12,165 Task._call(1068) INFO 42.4% complete 2019-06-03 22:05:18,555 Task._call(1068) INFO 42.4% complete 2019-06-03 22:05:24,414 Task._call(1068) INFO 42.4% complete 2019-06-03 22:05:30,336 Task._call(1068) INFO 42.4% complete 2019-06-03 22:05:36,773 Task._call(1068) INFO 42.4% complete 2019-06-03 22:05:42,319 Task._call(1068) INFO 42.4% complete 2019-06-03 22:05:48,381 Task._call(1068) INFO 42.4% complete 2019-06-03 22:05:54,773 Task._call(1068) INFO 42.4% complete 2019-06-03 22:06:00,460 Task._call(1068) INFO 42.4% complete 2019-06-03 22:06:06,099 Task._call(1068) INFO 42.4% complete 2019-06-03 22:06:12,286 Task._call(1068) INFO 42.4% complete 2019-06-03 22:06:18,256 Task._call(1068) INFO 43.5% complete 2019-06-03 22:06:24,020 Task._call(1068) INFO 43.5% complete 2019-06-03 22:06:30,427 Task._call(1068) INFO 43.5% complete 2019-06-03 22:06:36,582 Task._call(1068) INFO 43.5% complete 2019-06-03 22:06:42,191 Task._call(1068) INFO 43.5% complete 2019-06-03 22:06:48,535 Task._call(1068) INFO 43.5% complete 2019-06-03 22:06:54,035 Task._call(1068) INFO 43.5% complete 2019-06-03 22:07:00,299 Task._call(1068) INFO 43.5% complete 2019-06-03 22:07:06,956 Task._call(1068) INFO 43.5% complete 2019-06-03 22:07:13,924 Task._call(1068) INFO 43.5% complete 2019-06-03 22:07:19,049 Task._call(1068) INFO 43.5% complete 2019-06-03 22:07:25,188 Task._call(1068) INFO 43.5% complete 2019-06-03 22:07:31,096 Task._call(1068) INFO 43.5% complete 2019-06-03 22:07:37,581 Task._call(1068) INFO 43.5% complete 2019-06-03 22:07:43,361 Task._call(1068) INFO 44.6% complete 2019-06-03 22:07:49,111 Task._call(1068) INFO 44.6% complete 2019-06-03 22:07:55,236 Task._call(1068) INFO 44.6% complete 2019-06-03 22:08:01,063 Task._call(1068) INFO 44.6% complete 2019-06-03 22:08:07,720 Task._call(1068) INFO 44.6% complete 2019-06-03 22:08:13,578 Task._call(1068) INFO 44.6% complete 2019-06-03 22:08:19,046 Task._call(1068) INFO 44.6% complete 2019-06-03 22:08:25,469 Task._call(1068) INFO 44.6% complete 2019-06-03 22:08:31,000 Task._call(1068) INFO 44.6% complete 2019-06-03 22:08:37,453 Task._call(1068) INFO 44.6% complete 2019-06-03 22:08:43,279 Task._call(1068) INFO 44.6% complete 2019-06-03 22:08:49,061 Task._call(1068) INFO 44.6% complete 2019-06-03 22:08:55,733 Task._call(1068) INFO 44.6% complete 2019-06-03 22:09:01,154 Task._call(1068) INFO 45.7% complete 2019-06-03 22:09:07,700 Task._call(1068) INFO 45.7% complete 2019-06-03 22:09:13,029 Task._call(1068) INFO 45.7% complete 2019-06-03 22:09:19,028 Task._call(1068) INFO 45.7% complete 2019-06-03 22:09:25,293 Task._call(1068) INFO 45.7% complete 2019-06-03 22:09:31,434 Task._call(1068) INFO 45.7% complete 2019-06-03 22:09:37,512 Task._call(1068) INFO 45.7% complete 2019-06-03 22:09:43,885 Task._call(1068) INFO 45.8% complete 2019-06-03 22:09:49,619 Task._call(1068) INFO 45.8% complete 2019-06-03 22:09:55,072 Task._call(1068) INFO 45.8% complete 2019-06-03 22:10:01,556 Task._call(1068) INFO 45.8% complete 2019-06-03 22:10:07,275 Task._call(1068) INFO 45.8% complete 2019-06-03 22:10:13,290 Task._call(1068) INFO 45.8% complete 2019-06-03 22:10:19,180 Task._call(1068) INFO 45.8% complete 2019-06-03 22:10:25,289 Task._call(1068) INFO 46.9% complete 2019-06-03 22:10:31,164 Task._call(1068) INFO 46.9% complete 2019-06-03 22:10:37,367 Task._call(1068) INFO 46.9% complete 2019-06-03 22:10:43,117 Task._call(1068) INFO 46.9% complete 2019-06-03 22:10:49,242 Task._call(1068) INFO 46.9% complete 2019-06-03 22:10:55,381 Task._call(1068) INFO 46.9% complete 2019-06-03 22:11:01,147 Task._call(1068) INFO 46.9% complete 2019-06-03 22:11:07,334 Task._call(1068) INFO 46.9% complete 2019-06-03 22:11:13,459 Task._call(1068) INFO 46.9% complete 2019-06-03 22:11:19,145 Task._call(1068) INFO 46.9% complete 2019-06-03 22:11:25,286 Task._call(1068) INFO 46.9% complete 2019-06-03 22:11:31,582 Task._call(1068) INFO 46.9% complete 2019-06-03 22:11:37,082 Task._call(1068) INFO 46.9% complete 2019-06-03 22:11:43,426 Task._call(1068) INFO 48.0% complete 2019-06-03 22:11:49,065 Task._call(1068) INFO 48.0% complete 2019-06-03 22:11:55,237 Task._call(1068) INFO 48.0% complete 2019-06-03 22:12:01,049 Task._call(1068) INFO 48.0% complete 2019-06-03 22:12:07,706 Task._call(1068) INFO 48.0% complete 2019-06-03 22:12:13,361 Task._call(1068) INFO 48.0% complete 2019-06-03 22:12:19,174 Task._call(1068) INFO 48.0% complete 2019-06-03 22:12:25,127 Task._call(1068) INFO 48.0% complete 2019-06-03 22:12:31,144 Task._call(1068) INFO 48.0% complete 2019-06-03 22:12:39,253 Task._call(1068) INFO 48.0% complete 2019-06-03 22:12:45,237 Task._call(1068) INFO 48.0% complete 2019-06-03 22:12:51,642 Task._call(1068) INFO 48.0% complete 2019-06-03 22:12:57,392 Task._call(1068) INFO 48.0% complete 2019-06-03 22:13:03,329 Task._call(1068) INFO 48.0% complete 2019-06-03 22:13:09,095 Task._call(1068) INFO 49.1% complete 2019-06-03 22:13:15,313 Task._call(1068) INFO 49.1% complete 2019-06-03 22:13:22,875 Task._call(1068) INFO 49.1% complete 2019-06-03 22:13:28,266 Task._call(1068) INFO 49.1% complete 2019-06-03 22:13:34,719 Task._call(1068) INFO 49.1% complete 2019-06-03 22:13:40,250 Task._call(1068) INFO 49.1% complete 2019-06-03 22:13:46,342 Task._call(1068) INFO 49.1% complete 2019-06-03 22:13:52,015 Task._call(1068) INFO 49.1% complete 2019-06-03 22:13:58,201 Task._call(1068) INFO 49.1% complete 2019-06-03 22:14:04,045 Task._call(1068) INFO 49.1% complete 2019-06-03 22:14:10,545 Task._call(1068) INFO 49.1% complete 2019-06-03 22:14:16,497 Task._call(1068) INFO 49.1% complete 2019-06-03 22:14:22,138 Task._call(1068) INFO 49.1% complete 2019-06-03 22:14:28,216 Task._call(1068) INFO 50.2% complete 2019-06-03 22:14:34,637 Task._call(1068) INFO 50.2% complete 2019-06-03 22:14:40,559 Task._call(1068) INFO 50.2% complete 2019-06-03 22:14:47,059 Task._call(1068) INFO 50.2% complete 2019-06-03 22:14:53,213 Task._call(1068) INFO 50.2% complete 2019-06-03 22:14:59,697 Task._call(1068) INFO 50.2% complete 2019-06-03 22:15:05,042 Task._call(1068) INFO 50.2% complete 2019-06-03 22:15:11,119 Task._call(1068) INFO 50.2% complete 2019-06-03 22:15:17,213 Task._call(1068) INFO 50.2% complete 2019-06-03 22:15:23,338 Task._call(1068) INFO 50.2% complete 2019-06-03 22:15:29,055 Task._call(1068) INFO 50.2% complete 2019-06-03 22:15:35,180 Task._call(1068) INFO 50.2% complete 2019-06-03 22:15:41,305 Task._call(1068) INFO 50.2% complete 2019-06-03 22:15:47,460 Task._call(1068) INFO 50.2% complete 2019-06-03 22:15:53,539 Task._call(1068) INFO 51.3% complete 2019-06-03 22:15:59,523 Task._call(1068) INFO 51.3% complete 2019-06-03 22:16:05,788 Task._call(1068) INFO 51.3% complete 2019-06-03 22:16:11,226 Task._call(1068) INFO 51.3% complete 2019-06-03 22:16:17,427 Task._call(1068) INFO 51.3% complete 2019-06-03 22:16:23,522 Task._call(1068) INFO 51.3% complete 2019-06-03 22:16:30,115 Task._call(1068) INFO 51.3% complete 2019-06-03 22:16:36,193 Task._call(1068) INFO 51.3% complete 2019-06-03 22:16:42,411 Task._call(1068) INFO 51.3% complete 2019-06-03 22:16:48,177 Task._call(1068) INFO 51.3% complete 2019-06-03 22:16:54,176 Task._call(1068) INFO 51.3% complete 2019-06-03 22:17:00,160 Task._call(1068) INFO 51.3% complete 2019-06-03 22:17:06,112 Task._call(1068) INFO 51.3% complete 2019-06-03 22:17:12,503 Task._call(1068) INFO 52.4% complete 2019-06-03 22:17:18,424 Task._call(1068) INFO 52.4% complete 2019-06-03 22:17:24,424 Task._call(1068) INFO 52.4% complete 2019-06-03 22:17:30,355 Task._call(1068) INFO 52.4% complete 2019-06-03 22:17:36,119 Task._call(1068) INFO 52.4% complete 2019-06-03 22:17:42,479 Task._call(1068) INFO 52.4% complete 2019-06-03 22:17:48,026 Task._call(1068) INFO 52.4% complete 2019-06-03 22:17:54,540 Task._call(1068) INFO 52.4% complete 2019-06-03 22:18:00,118 Task._call(1068) INFO 52.4% complete 2019-06-03 22:18:06,461 Task._call(1068) INFO 52.4% complete 2019-06-03 22:18:12,414 Task._call(1068) INFO 52.4% complete 2019-06-03 22:18:18,821 Task._call(1068) INFO 52.4% complete 2019-06-03 22:18:24,117 Task._call(1068) INFO 52.4% complete 2019-06-03 22:18:30,197 Task._call(1068) INFO 52.4% complete 2019-06-03 22:18:36,336 Task._call(1068) INFO 53.6% complete 2019-06-03 22:18:42,727 Task._call(1068) INFO 53.6% complete 2019-06-03 22:18:48,211 Task._call(1068) INFO 53.6% complete 2019-06-03 22:18:54,085 Task._call(1068) INFO 53.6% complete 2019-06-03 22:19:00,757 Task._call(1068) INFO 53.6% complete 2019-06-03 22:19:06,242 Task._call(1068) INFO 53.6% complete 2019-06-03 22:19:12,210 Task._call(1068) INFO 53.6% complete 2019-06-03 22:19:18,428 Task._call(1068) INFO 53.6% complete 2019-06-03 22:19:24,413 Task._call(1068) INFO 53.6% complete 2019-06-03 22:19:31,209 Task._call(1068) INFO 53.6% complete 2019-06-03 22:19:37,256 Task._call(1068) INFO 53.6% complete 2019-06-03 22:19:43,645 Task._call(1068) INFO 53.6% complete 2019-06-03 22:19:49,395 Task._call(1068) INFO 53.6% complete 2019-06-03 22:19:55,286 Task._call(1068) INFO 53.6% complete 2019-06-03 22:20:01,614 Task._call(1068) INFO 54.7% complete 2019-06-03 22:20:07,082 Task._call(1068) INFO 54.7% complete 2019-06-03 22:20:13,207 Task._call(1068) INFO 54.7% complete 2019-06-03 22:20:19,346 Task._call(1068) INFO 54.7% complete 2019-06-03 22:20:25,596 Task._call(1068) INFO 54.7% complete 2019-06-03 22:20:31,017 Task._call(1068) INFO 54.7% complete 2019-06-03 22:20:37,065 Task._call(1068) INFO 54.7% complete 2019-06-03 22:20:43,532 Task._call(1068) INFO 54.7% complete 2019-06-03 22:20:49,111 Task._call(1068) INFO 54.7% complete 2019-06-03 22:20:55,484 Task._call(1068) INFO 54.7% complete 2019-06-03 22:21:01,094 Task._call(1068) INFO 54.7% complete 2019-06-03 22:21:07,032 Task._call(1068) INFO 54.7% complete 2019-06-03 22:21:13,233 Task._call(1068) INFO 54.7% complete 2019-06-03 22:21:19,687 Task._call(1068) INFO 55.8% complete 2019-06-03 22:21:25,437 Task._call(1068) INFO 55.8% complete 2019-06-03 22:21:31,374 Task._call(1068) INFO 55.8% complete 2019-06-03 22:21:37,108 Task._call(1068) INFO 55.8% complete 2019-06-03 22:21:43,029 Task._call(1068) INFO 55.8% complete 2019-06-03 22:21:49,404 Task._call(1068) INFO 55.8% complete 2019-06-03 22:21:55,247 Task._call(1068) INFO 55.8% complete 2019-06-03 22:22:01,184 Task._call(1068) INFO 55.8% complete 2019-06-03 22:22:07,512 Task._call(1068) INFO 55.8% complete 2019-06-03 22:22:13,262 Task._call(1068) INFO 55.8% complete 2019-06-03 22:22:19,012 Task._call(1068) INFO 55.8% complete 2019-06-03 22:22:25,579 Task._call(1068) INFO 55.8% complete 2019-06-03 22:22:31,088 Task._call(1068) INFO 55.8% complete 2019-06-03 22:22:37,604 Task._call(1068) INFO 56.9% complete 2019-06-03 22:22:43,667 Task._call(1068) INFO 56.9% complete 2019-06-03 22:22:49,618 Task._call(1068) INFO 56.9% complete 2019-06-03 22:22:55,884 Task._call(1068) INFO 56.9% complete 2019-06-03 22:23:01,789 Task._call(1068) INFO 56.9% complete 2019-06-03 22:23:07,150 Task._call(1068) INFO 56.9% complete 2019-06-03 22:23:13,071 Task._call(1068) INFO 56.9% complete 2019-06-03 22:23:19,023 Task._call(1068) INFO 56.9% complete 2019-06-03 22:23:25,085 Task._call(1068) INFO 56.9% complete 2019-06-03 22:23:31,053 Task._call(1068) INFO 56.9% complete 2019-06-03 22:23:37,694 Task._call(1068) INFO 56.9% complete 2019-06-03 22:23:43,085 Task._call(1068) INFO 56.9% complete 2019-06-03 22:23:49,147 Task._call(1068) INFO 56.9% complete 2019-06-03 22:23:55,272 Task._call(1068) INFO 58.0% complete 2019-06-03 22:24:01,115 Task._call(1068) INFO 58.0% complete 2019-06-03 22:24:07,005 Task._call(1068) INFO 58.0% complete 2019-06-03 22:24:13,411 Task._call(1068) INFO 58.0% complete 2019-06-03 22:24:19,098 Task._call(1068) INFO 58.0% complete 2019-06-03 22:24:25,941 Task._call(1068) INFO 58.0% complete 2019-06-03 22:24:31,440 Task._call(1068) INFO 58.0% complete 2019-06-03 22:24:37,721 Task._call(1068) INFO 58.0% complete 2019-06-03 22:24:43,549 Task._call(1068) INFO 58.0% complete 2019-06-03 22:24:49,158 Task._call(1068) INFO 58.0% complete 2019-06-03 22:24:55,299 Task._call(1068) INFO 58.0% complete 2019-06-03 22:25:01,227 Task._call(1068) INFO 58.0% complete 2019-06-03 22:25:07,711 Task._call(1068) INFO 59.1% complete 2019-06-03 22:25:13,023 Task._call(1068) INFO 59.1% complete 2019-06-03 22:25:19,586 Task._call(1068) INFO 59.1% complete 2019-06-03 22:25:25,664 Task._call(1068) INFO 59.1% complete 2019-06-03 22:25:31,476 Task._call(1068) INFO 59.1% complete 2019-06-03 22:25:37,351 Task._call(1068) INFO 59.1% complete 2019-06-03 22:25:43,101 Task._call(1068) INFO 59.1% complete 2019-06-03 22:25:49,460 Task._call(1068) INFO 59.1% complete 2019-06-03 22:25:55,506 Task._call(1068) INFO 59.1% complete 2019-06-03 22:26:01,147 Task._call(1068) INFO 59.1% complete 2019-06-03 22:26:07,177 Task._call(1068) INFO 59.1% complete 2019-06-03 22:26:13,145 Task._call(1068) INFO 59.1% complete 2019-06-03 22:26:19,177 Task._call(1068) INFO 60.3% complete 2019-06-03 22:26:25,598 Task._call(1068) INFO 60.3% complete 2019-06-03 22:26:31,003 Task._call(1068) INFO 60.3% complete 2019-06-03 22:26:37,128 Task._call(1068) INFO 60.3% complete 2019-06-03 22:26:43,035 Task._call(1068) INFO 60.3% complete 2019-06-03 22:26:49,644 Task._call(1068) INFO 60.3% complete 2019-06-03 22:26:55,549 Task._call(1068) INFO 60.3% complete 2019-06-03 22:27:01,736 Task._call(1068) INFO 60.3% complete 2019-06-03 22:27:07,095 Task._call(1068) INFO 60.3% complete 2019-06-03 22:27:13,206 Task._call(1068) INFO 60.3% complete 2019-06-03 22:27:19,267 Task._call(1068) INFO 60.3% complete 2019-06-03 22:27:25,016 Task._call(1068) INFO 61.4% complete 2019-06-03 22:27:31,345 Task._call(1068) INFO 61.4% complete 2019-06-03 22:27:37,026 Task._call(1068) INFO 61.4% complete 2019-06-03 22:27:43,072 Task._call(1068) INFO 61.4% complete 2019-06-03 22:27:49,290 Task._call(1068) INFO 61.4% complete 2019-06-03 22:27:55,259 Task._call(1068) INFO 61.4% complete 2019-06-03 22:28:01,164 Task._call(1068) INFO 61.4% complete 2019-06-03 22:28:07,321 Task._call(1068) INFO 61.4% complete 2019-06-03 22:28:13,398 Task._call(1068) INFO 61.4% complete 2019-06-03 22:28:19,039 Task._call(1068) INFO 61.4% complete 2019-06-03 22:28:25,444 Task._call(1068) INFO 61.4% complete 2019-06-03 22:28:31,053 Task._call(1068) INFO 61.4% complete 2019-06-03 22:28:37,006 Task._call(1068) INFO 62.5% complete 2019-06-03 22:28:43,052 Task._call(1068) INFO 62.5% complete 2019-06-03 22:28:49,536 Task._call(1068) INFO 62.5% complete 2019-06-03 22:28:55,052 Task._call(1068) INFO 62.5% complete 2019-06-03 22:29:01,161 Task._call(1068) INFO 62.5% complete 2019-06-03 22:29:07,411 Task._call(1068) INFO 62.5% complete 2019-06-03 22:29:13,441 Task._call(1068) INFO 62.5% complete 2019-06-03 22:29:19,957 Task._call(1068) INFO 62.5% complete 2019-06-03 22:29:25,019 Task._call(1068) INFO 62.5% complete 2019-06-03 22:29:31,051 Task._call(1068) INFO 62.5% complete 2019-06-03 22:29:37,082 Task._call(1068) INFO 62.5% complete 2019-06-03 22:29:43,065 Task._call(1068) INFO 63.6% complete 2019-06-03 22:29:49,111 Task._call(1068) INFO 63.6% complete 2019-06-03 22:29:55,408 Task._call(1068) INFO 63.6% complete 2019-06-03 22:30:01,063 Task._call(1068) INFO 63.6% complete 2019-06-03 22:30:07,486 Task._call(1068) INFO 63.6% complete 2019-06-03 22:30:13,282 Task._call(1068) INFO 63.6% complete 2019-06-03 22:30:19,157 Task._call(1068) INFO 63.6% complete 2019-06-03 22:30:25,250 Task._call(1068) INFO 63.6% complete 2019-06-03 22:30:31,155 Task._call(1068) INFO 63.6% complete 2019-06-03 22:30:37,046 Task._call(1068) INFO 63.6% complete 2019-06-03 22:30:43,562 Task._call(1068) INFO 63.6% complete 2019-06-03 22:30:49,576 Task._call(1068) INFO 64.7% complete 2019-06-03 22:30:55,529 Task._call(1068) INFO 64.7% complete 2019-06-03 22:31:01,561 Task._call(1068) INFO 64.7% complete 2019-06-03 22:31:07,279 Task._call(1068) INFO 64.7% complete 2019-06-03 22:31:13,497 Task._call(1068) INFO 64.7% complete 2019-06-03 22:31:19,279 Task._call(1068) INFO 64.7% complete 2019-06-03 22:31:25,513 Task._call(1068) INFO 64.7% complete 2019-06-03 22:31:31,325 Task._call(1068) INFO 64.7% complete 2019-06-03 22:31:37,559 Task._call(1068) INFO 64.7% complete 2019-06-03 22:31:43,292 Task._call(1068) INFO 64.7% complete 2019-06-03 22:31:49,308 Task._call(1068) INFO 64.7% complete 2019-06-03 22:31:55,197 Task._call(1068) INFO 65.8% complete 2019-06-03 22:32:01,588 Task._call(1068) INFO 65.8% complete 2019-06-03 22:32:07,153 Task._call(1068) INFO 65.8% complete 2019-06-03 22:32:13,325 Task._call(1068) INFO 65.8% complete 2019-06-03 22:32:19,105 Task._call(1068) INFO 65.8% complete 2019-06-03 22:32:25,058 Task._call(1068) INFO 65.8% complete 2019-06-03 22:32:31,549 Task._call(1068) INFO 65.8% complete 2019-06-03 22:32:37,331 Task._call(1068) INFO 65.8% complete 2019-06-03 22:32:43,032 Task._call(1068) INFO 65.8% complete 2019-06-03 22:32:49,220 Task._call(1068) INFO 65.8% complete 2019-06-03 22:32:55,063 Task._call(1068) INFO 65.8% complete 2019-06-03 22:33:01,673 Task._call(1068) INFO 66.9% complete 2019-06-03 22:33:07,298 Task._call(1068) INFO 66.9% complete 2019-06-03 22:33:13,234 Task._call(1068) INFO 67.0% complete 2019-06-03 22:33:19,421 Task._call(1068) INFO 67.0% complete 2019-06-03 22:33:25,328 Task._call(1068) INFO 67.0% complete 2019-06-03 22:33:31,089 Task._call(1068) INFO 67.0% complete 2019-06-03 22:33:37,542 Task._call(1068) INFO 67.0% complete 2019-06-03 22:33:43,230 Task._call(1068) INFO 67.0% complete 2019-06-03 22:33:49,526 Task._call(1068) INFO 67.0% complete 2019-06-03 22:33:55,401 Task._call(1068) INFO 67.0% complete 2019-06-03 22:34:01,026 Task._call(1068) INFO 67.0% complete 2019-06-03 22:34:07,588 Task._call(1068) INFO 68.1% complete 2019-06-03 22:34:13,336 Task._call(1068) INFO 68.1% complete 2019-06-03 22:34:19,555 Task._call(1068) INFO 68.1% complete 2019-06-03 22:34:25,086 Task._call(1068) INFO 68.1% complete 2019-06-03 22:34:31,153 Task._call(1068) INFO 68.1% complete 2019-06-03 22:34:37,684 Task._call(1068) INFO 68.1% complete 2019-06-03 22:34:43,292 Task._call(1068) INFO 68.1% complete 2019-06-03 22:34:49,667 Task._call(1068) INFO 68.1% complete 2019-06-03 22:34:55,588 Task._call(1068) INFO 68.1% complete 2019-06-03 22:35:01,509 Task._call(1068) INFO 68.1% complete 2019-06-03 22:35:07,572 Task._call(1068) INFO 68.1% complete 2019-06-03 22:35:13,322 Task._call(1068) INFO 69.2% complete 2019-06-03 22:35:19,447 Task._call(1068) INFO 69.2% complete 2019-06-03 22:35:25,086 Task._call(1068) INFO 69.2% complete 2019-06-03 22:35:31,509 Task._call(1068) INFO 69.2% complete 2019-06-03 22:35:37,071 Task._call(1068) INFO 69.2% complete 2019-06-03 22:35:43,305 Task._call(1068) INFO 69.2% complete 2019-06-03 22:35:49,226 Task._call(1068) INFO 69.2% complete 2019-06-03 22:35:55,585 Task._call(1068) INFO 69.2% complete 2019-06-03 22:36:01,006 Task._call(1068) INFO 69.2% complete 2019-06-03 22:36:07,163 Task._call(1068) INFO 69.2% complete 2019-06-03 22:36:13,272 Task._call(1068) INFO 69.2% complete 2019-06-03 22:36:19,161 Task._call(1068) INFO 70.3% complete 2019-06-03 22:36:25,490 Task._call(1068) INFO 70.3% complete 2019-06-03 22:36:31,677 Task._call(1068) INFO 70.3% complete 2019-06-03 22:36:37,473 Task._call(1068) INFO 70.3% complete 2019-06-03 22:36:43,348 Task._call(1068) INFO 70.3% complete 2019-06-03 22:36:49,660 Task._call(1068) INFO 70.3% complete 2019-06-03 22:36:55,176 Task._call(1068) INFO 70.3% complete 2019-06-03 22:37:01,174 Task._call(1068) INFO 70.3% complete 2019-06-03 22:37:07,206 Task._call(1068) INFO 70.3% complete 2019-06-03 22:37:13,190 Task._call(1068) INFO 70.3% complete 2019-06-03 22:37:19,095 Task._call(1068) INFO 71.4% complete 2019-06-03 22:37:25,032 Task._call(1068) INFO 71.4% complete 2019-06-03 22:37:31,457 Task._call(1068) INFO 71.4% complete 2019-06-03 22:37:37,237 Task._call(1068) INFO 71.4% complete 2019-06-03 22:37:43,190 Task._call(1068) INFO 71.4% complete 2019-06-03 22:37:49,081 Task._call(1068) INFO 71.4% complete 2019-06-03 22:37:55,674 Task._call(1068) INFO 71.4% complete 2019-06-03 22:38:01,220 Task._call(1068) INFO 71.4% complete 2019-06-03 22:38:07,407 Task._call(1068) INFO 71.4% complete 2019-06-03 22:38:13,095 Task._call(1068) INFO 71.4% complete 2019-06-03 22:38:19,391 Task._call(1068) INFO 71.4% complete 2019-06-03 22:38:25,250 Task._call(1068) INFO 72.5% complete 2019-06-03 22:38:31,282 Task._call(1068) INFO 72.5% complete 2019-06-03 22:38:37,375 Task._call(1068) INFO 72.5% complete 2019-06-03 22:38:43,375 Task._call(1068) INFO 72.5% complete 2019-06-03 22:38:49,280 Task._call(1068) INFO 72.5% complete 2019-06-03 22:38:55,279 Task._call(1068) INFO 72.5% complete 2019-06-03 22:39:01,311 Task._call(1068) INFO 72.5% complete 2019-06-03 22:39:07,295 Task._call(1068) INFO 72.5% complete 2019-06-03 22:39:13,309 Task._call(1068) INFO 72.5% complete 2019-06-03 22:39:19,263 Task._call(1068) INFO 72.5% complete 2019-06-03 22:39:25,528 Task._call(1068) INFO 73.6% complete 2019-06-03 22:39:31,012 Task._call(1068) INFO 73.6% complete 2019-06-03 22:39:39,714 Task._call(1068) INFO 73.6% complete 2019-06-03 22:39:45,730 Task._call(1068) INFO 73.6% complete 2019-06-03 22:39:51,480 Task._call(1068) INFO 73.6% complete 2019-06-03 22:39:57,433 Task._call(1068) INFO 73.6% complete 2019-06-03 22:40:03,369 Task._call(1068) INFO 73.6% complete 2019-06-03 22:40:09,479 Task._call(1068) INFO 73.6% complete 2019-06-03 22:40:15,213 Task._call(1068) INFO 73.6% complete 2019-06-03 22:40:21,055 Task._call(1068) INFO 73.6% complete 2019-06-03 22:40:27,102 Task._call(1068) INFO 74.8% complete 2019-06-03 22:40:33,461 Task._call(1068) INFO 74.8% complete 2019-06-03 22:40:39,118 Task._call(1068) INFO 74.8% complete 2019-06-03 22:40:45,273 Task._call(1068) INFO 74.8% complete 2019-06-03 22:40:51,444 Task._call(1068) INFO 74.8% complete 2019-06-03 22:40:57,553 Task._call(1068) INFO 74.8% complete 2019-06-03 22:41:03,615 Task._call(1068) INFO 74.8% complete 2019-06-03 22:41:09,631 Task._call(1068) INFO 74.8% complete 2019-06-03 22:41:15,460 Task._call(1068) INFO 74.8% complete 2019-06-03 22:41:21,131 Task._call(1068) INFO 74.8% complete 2019-06-03 22:41:27,584 Task._call(1068) INFO 75.9% complete 2019-06-03 22:41:33,161 Task._call(1068) INFO 75.9% complete 2019-06-03 22:41:39,098 Task._call(1068) INFO 75.9% complete 2019-06-03 22:41:45,536 Task._call(1068) INFO 75.9% complete 2019-06-03 22:41:51,536 Task._call(1068) INFO 75.9% complete 2019-06-03 22:41:57,440 Task._call(1068) INFO 75.9% complete 2019-06-03 22:42:03,332 Task._call(1068) INFO 75.9% complete 2019-06-03 22:42:09,424 Task._call(1068) INFO 75.9% complete 2019-06-03 22:42:15,486 Task._call(1068) INFO 75.9% complete 2019-06-03 22:42:21,095 Task._call(1068) INFO 77.0% complete 2019-06-03 22:42:27,407 Task._call(1068) INFO 77.0% complete 2019-06-03 22:42:33,296 Task._call(1068) INFO 77.0% complete 2019-06-03 22:42:39,260 Task._call(1068) INFO 77.0% complete 2019-06-03 22:42:45,292 Task._call(1068) INFO 77.0% complete 2019-06-03 22:42:51,401 Task._call(1068) INFO 77.0% complete 2019-06-03 22:42:57,572 Task._call(1068) INFO 77.0% complete 2019-06-03 22:43:03,493 Task._call(1068) INFO 77.0% complete 2019-06-03 22:43:09,072 Task._call(1068) INFO 77.0% complete 2019-06-03 22:43:15,211 Task._call(1068) INFO 78.1% complete 2019-06-03 22:43:21,289 Task._call(1068) INFO 78.1% complete 2019-06-03 22:43:27,430 Task._call(1068) INFO 78.1% complete 2019-06-03 22:43:33,617 Task._call(1068) INFO 78.1% complete 2019-06-03 22:43:39,180 Task._call(1068) INFO 78.1% complete 2019-06-03 22:43:45,617 Task._call(1068) INFO 78.1% complete 2019-06-03 22:43:51,569 Task._call(1068) INFO 78.1% complete 2019-06-03 22:43:57,772 Task._call(1068) INFO 78.1% complete 2019-06-03 22:44:03,427 Task._call(1068) INFO 78.1% complete 2019-06-03 22:44:09,115 Task._call(1068) INFO 79.2% complete 2019-06-03 22:44:15,427 Task._call(1068) INFO 79.2% complete 2019-06-03 22:44:21,098 Task._call(1068) INFO 79.2% complete 2019-06-03 22:44:27,520 Task._call(1068) INFO 79.2% complete 2019-06-03 22:44:33,411 Task._call(1068) INFO 79.2% complete 2019-06-03 22:44:39,144 Task._call(1068) INFO 79.2% complete 2019-06-03 22:44:45,519 Task._call(1068) INFO 80.3% complete 2019-06-03 22:44:51,003 Task._call(1068) INFO 80.3% complete 2019-06-03 22:44:57,658 Task._call(1068) INFO 80.3% complete 2019-06-03 22:45:03,471 Task._call(1068) INFO 80.3% complete 2019-06-03 22:45:09,236 Task._call(1068) INFO 80.3% complete 2019-06-03 22:45:15,079 Task._call(1068) INFO 80.3% complete 2019-06-03 22:45:21,377 Task._call(1068) INFO 81.5% complete 2019-06-03 22:45:27,391 Task._call(1068) INFO 81.5% complete 2019-06-03 22:45:33,703 Task._call(1068) INFO 81.5% complete 2019-06-03 22:45:39,375 Task._call(1068) INFO 81.5% complete 2019-06-03 22:45:45,266 Task._call(1068) INFO 81.5% complete 2019-06-03 22:45:51,016 Task._call(1068) INFO 82.6% complete 2019-06-03 22:45:57,562 Task._call(1068) INFO 82.6% complete 2019-06-03 22:46:03,046 Task._call(1068) INFO 82.6% complete 2019-06-03 22:46:09,358 Task._call(1068) INFO 82.6% complete 2019-06-03 22:46:15,467 Task._call(1068) INFO 82.6% complete 2019-06-03 22:46:21,200 Task._call(1068) INFO 83.7% complete 2019-06-03 22:46:27,700 Task._call(1068) INFO 83.7% complete 2019-06-03 22:46:33,029 Task._call(1068) INFO 83.7% complete 2019-06-03 22:46:40,918 Task._call(1068) INFO 83.7% complete 2019-06-03 22:46:46,278 Task._call(1068) INFO 83.7% complete 2019-06-03 22:46:52,012 Task._call(1068) INFO 84.8% complete 2019-06-03 22:46:58,464 Task._call(1068) INFO 84.8% complete 2019-06-03 22:47:04,167 Task._call(1068) INFO 84.8% complete 2019-06-03 22:47:10,010 Task._call(1068) INFO 84.8% complete 2019-06-03 22:47:16,463 Task._call(1068) INFO 85.9% complete 2019-06-03 22:47:22,604 Task._call(1068) INFO 85.9% complete 2019-06-03 22:47:28,500 Task._call(1068) INFO 85.9% complete 2019-06-03 22:47:34,000 Task._call(1068) INFO 87.0% complete 2019-06-03 22:47:40,282 Task._call(1068) INFO 87.0% complete 2019-06-03 22:47:46,687 Task._call(1068) INFO 87.0% complete 2019-06-03 22:47:52,125 Task._call(1068) INFO 88.2% complete 2019-06-03 22:48:47,546 Task._call(1068) INFO 88.2% complete 2019-06-03 22:48:53,030 Task._call(1068) INFO 90.4% complete 2019-06-03 22:48:59,828 Task._call(1068) INFO 90.4% complete 2019-06-03 22:49:07,187 Task._call(1068) INFO 92.6% complete 2019-06-03 22:49:13,015 Task._call(1068) INFO 93.7% complete 2019-06-03 22:49:19,342 Task._call(1068) INFO 96.0% complete 2019-06-03 22:49:29,131 Task._call(1068) INFO 100.0% complete 2019-06-03 22:49:39,865 geoprocessing.(918) INFO 9.5% complete 2019-06-03 22:49:44,881 geoprocessing.(918) INFO 17.8% complete 2019-06-03 22:49:49,895 geoprocessing.(918) INFO 26.1% complete 2019-06-03 22:49:54,911 geoprocessing.(918) INFO 34.3% complete 2019-06-03 22:49:59,927 geoprocessing.(918) INFO 42.6% complete 2019-06-03 22:50:04,941 geoprocessing.(918) INFO 50.9% complete 2019-06-03 22:50:09,957 geoprocessing.(918) INFO 59.2% complete 2019-06-03 22:50:14,973 geoprocessing.(918) INFO 67.5% complete 2019-06-03 22:50:19,987 geoprocessing.(918) INFO 75.8% complete 2019-06-03 22:50:25,003 geoprocessing.(918) INFO 84.1% complete 2019-06-03 22:50:30,019 geoprocessing.(918) INFO 92.0% complete 2019-06-03 22:50:35,971 Task._call(1068) INFO 0.0% complete 2019-06-03 22:50:41,471 Task._call(1068) INFO 2.2% complete 2019-06-03 22:50:47,674 Task._call(1068) INFO 7.8% complete 2019-06-03 22:50:53,002 Task._call(1068) INFO 8.9% complete 2019-06-03 22:51:00,516 Task._call(1068) INFO 14.5% complete 2019-06-03 22:52:11,966 Task._call(1068) INFO 19.0% complete 2019-06-03 22:52:17,028 Task._call(1068) INFO 21.2% complete 2019-06-03 22:52:23,091 Task._call(1068) INFO 23.4% complete 2019-06-03 22:52:29,112 Task._call(1068) INFO 26.8% complete 2019-06-03 22:52:35,003 Task._call(1068) INFO 29.0% complete 2019-06-03 22:52:41,424 Task._call(1068) INFO 30.1% complete 2019-06-03 22:52:47,002 Task._call(1068) INFO 30.1% complete 2019-06-03 22:52:53,674 Task._call(1068) INFO 31.2% complete 2019-06-03 22:52:59,127 Task._call(1068) INFO 32.4% complete 2019-06-03 22:53:07,923 Task._call(1068) INFO 33.5% complete 2019-06-03 22:53:13,000 Task._call(1068) INFO 34.6% complete 2019-06-03 22:53:19,391 Task._call(1068) INFO 35.7% complete 2019-06-03 22:53:25,469 Task._call(1068) INFO 36.8% complete 2019-06-03 22:53:31,000 Task._call(1068) INFO 39.1% complete 2019-06-03 22:53:37,108 Task._call(1068) INFO 42.4% complete 2019-06-03 22:53:43,265 Task._call(1068) INFO 44.6% complete 2019-06-03 22:53:49,217 Task._call(1068) INFO 44.6% complete 2019-06-03 22:53:55,497 Task._call(1068) INFO 46.9% complete 2019-06-03 22:55:51,943 Task._call(1068) INFO 48.0% complete 2019-06-03 22:55:57,005 Task._call(1068) INFO 49.1% complete 2019-06-03 22:56:03,005 Task._call(1068) INFO 54.7% complete 2019-06-03 22:56:09,003 Task._call(1068) INFO 56.9% complete 2019-06-03 22:56:15,019 Task._call(1068) INFO 58.0% complete 2019-06-03 22:56:21,003 Task._call(1068) INFO 58.0% complete 2019-06-03 22:56:27,003 Task._call(1068) INFO 59.1% complete 2019-06-03 22:56:33,003 Task._call(1068) INFO 61.4% complete 2019-06-03 22:56:39,940 Task._call(1068) INFO 63.6% complete 2019-06-03 22:56:45,381 Task._call(1068) INFO 65.8% complete 2019-06-03 22:56:51,099 Task._call(1068) INFO 69.2% complete 2019-06-03 22:56:57,131 Task._call(1068) INFO 71.4% complete 2019-06-03 22:57:04,865 Task._call(1068) INFO 74.8% complete 2019-06-03 22:57:11,223 Task._call(1068) INFO 77.0% complete 2019-06-03 22:57:17,441 Task._call(1068) INFO 77.0% complete 2019-06-03 22:57:24,832 Task._call(1068) INFO 78.1% complete 2019-06-03 22:57:30,009 Task._call(1068) INFO 78.1% complete 2019-06-03 22:57:38,398 Task._call(1068) INFO 79.2% complete 2019-06-03 22:57:45,118 Task._call(1068) INFO 79.2% complete 2019-06-03 22:57:51,039 Task._call(1068) INFO 81.5% complete 2019-06-03 22:57:57,023 Task._call(1068) INFO 81.5% complete 2019-06-03 22:58:04,256 Task._call(1068) INFO 82.6% complete 2019-06-03 22:58:11,506 Task._call(1068) INFO 82.6% complete 2019-06-03 22:58:18,740 Task._call(1068) INFO 84.8% complete 2019-06-03 22:58:30,131 Task._call(1068) INFO 85.9% complete 2019-06-03 22:58:36,036 Task._call(1068) INFO 87.0% complete 2019-06-03 22:58:44,364 Task._call(1068) INFO 88.2% complete 2019-06-03 22:58:52,160 Task._call(1068) INFO 89.3% complete 2019-06-03 22:58:58,082 Task._call(1068) INFO 91.5% complete 2019-06-03 22:59:04,128 Task._call(1068) INFO 98.2% complete 2019-06-03 23:15:28,256 Task._call(1068) INFO 99.3% complete 2019-06-03 23:15:36,052 Task._call(1068) INFO 100.0% complete 2019-06-03 23:16:09,565 geoprocessing.raster_calculator(366) INFO starting stats_worker 2019-06-03 23:16:09,565 geoprocessing.raster_calculator(372) INFO started stats_worker 2019-06-03 23:16:14,582 geoprocessing.(442) INFO 2.7% complete 2019-06-03 23:16:19,628 geoprocessing.(442) INFO 4.1% complete 2019-06-03 23:16:24,644 geoprocessing.(442) INFO 5.9% complete 2019-06-03 23:16:29,658 geoprocessing.(442) INFO 7.3% complete 2019-06-03 23:16:34,736 geoprocessing.(442) INFO 8.5% complete 2019-06-03 23:16:39,799 geoprocessing.(442) INFO 9.7% complete 2019-06-03 23:16:44,845 geoprocessing.(442) INFO 10.9% complete 2019-06-03 23:16:49,861 geoprocessing.(442) INFO 12.0% complete 2019-06-03 23:16:54,907 geoprocessing.(442) INFO 13.1% complete 2019-06-03 23:17:00,000 geoprocessing.(442) INFO 14.2% complete 2019-06-03 23:17:05,016 geoprocessing.(442) INFO 15.3% complete 2019-06-03 23:17:10,062 geoprocessing.(442) INFO 16.4% complete 2019-06-03 23:17:15,094 geoprocessing.(442) INFO 17.4% complete 2019-06-03 23:17:20,187 geoprocessing.(442) INFO 18.5% complete 2019-06-03 23:17:25,265 geoprocessing.(442) INFO 19.6% complete 2019-06-03 23:17:30,282 geoprocessing.(442) INFO 20.6% complete 2019-06-03 23:17:35,298 geoprocessing.(442) INFO 21.7% complete 2019-06-03 23:17:40,312 geoprocessing.(442) INFO 22.8% complete 2019-06-03 23:17:45,344 geoprocessing.(442) INFO 23.8% complete 2019-06-03 23:17:50,405 geoprocessing.(442) INFO 25.1% complete 2019-06-03 23:17:55,483 geoprocessing.(442) INFO 26.3% complete 2019-06-03 23:18:00,515 geoprocessing.(442) INFO 27.6% complete 2019-06-03 23:18:05,529 geoprocessing.(442) INFO 28.7% complete 2019-06-03 23:18:10,561 geoprocessing.(442) INFO 29.8% complete 2019-06-03 23:18:15,608 geoprocessing.(442) INFO 30.8% complete 2019-06-03 23:18:20,717 geoprocessing.(442) INFO 31.6% complete 2019-06-03 23:18:25,732 geoprocessing.(442) INFO 32.1% complete 2019-06-03 23:18:30,746 geoprocessing.(442) INFO 32.9% complete 2019-06-03 23:18:35,825 geoprocessing.(442) INFO 33.5% complete 2019-06-03 23:18:40,841 geoprocessing.(442) INFO 34.0% complete 2019-06-03 23:18:45,855 geoprocessing.(442) INFO 34.7% complete 2019-06-03 23:18:50,948 geoprocessing.(442) INFO 35.1% complete 2019-06-03 23:18:55,980 geoprocessing.(442) INFO 35.8% complete 2019-06-03 23:19:00,996 geoprocessing.(442) INFO 36.2% complete 2019-06-03 23:19:06,026 geoprocessing.(442) INFO 36.6% complete 2019-06-03 23:19:11,058 geoprocessing.(442) INFO 37.2% complete 2019-06-03 23:19:16,151 geoprocessing.(442) INFO 37.6% complete 2019-06-03 23:19:21,213 geoprocessing.(442) INFO 38.2% complete 2019-06-03 23:19:26,290 geoprocessing.(442) INFO 38.6% complete 2019-06-03 23:19:31,352 geoprocessing.(442) INFO 39.1% complete 2019-06-03 23:19:36,384 geoprocessing.(442) INFO 39.6% complete 2019-06-03 23:19:41,461 geoprocessing.(442) INFO 40.0% complete 2019-06-03 23:19:46,555 geoprocessing.(442) INFO 40.5% complete 2019-06-03 23:19:51,585 geoprocessing.(442) INFO 40.9% complete 2019-06-03 23:19:56,632 geoprocessing.(442) INFO 41.4% complete 2019-06-03 23:20:01,742 geoprocessing.(442) INFO 41.8% complete 2019-06-03 23:20:06,756 geoprocessing.(442) INFO 42.3% complete 2019-06-03 23:20:11,773 geoprocessing.(442) INFO 42.7% complete 2019-06-03 23:20:16,835 geoprocessing.(442) INFO 43.2% complete 2019-06-03 23:20:21,944 geoprocessing.(442) INFO 43.6% complete 2019-06-03 23:20:26,959 geoprocessing.(442) INFO 44.1% complete 2019-06-03 23:20:32,052 geoprocessing.(442) INFO 44.5% complete 2019-06-03 23:20:37,068 geoprocessing.(442) INFO 45.0% complete 2019-06-03 23:20:42,082 geoprocessing.(442) INFO 45.4% complete 2019-06-03 23:20:47,098 geoprocessing.(442) INFO 45.8% complete 2019-06-03 23:20:52,114 geoprocessing.(442) INFO 46.2% complete 2019-06-03 23:20:57,223 geoprocessing.(442) INFO 46.6% complete 2019-06-03 23:21:02,285 geoprocessing.(442) INFO 47.1% complete 2019-06-03 23:21:07,348 geoprocessing.(442) INFO 47.5% complete 2019-06-03 23:21:12,410 geoprocessing.(442) INFO 47.9% complete 2019-06-03 23:21:17,519 geoprocessing.(442) INFO 48.3% complete 2019-06-03 23:21:22,611 geoprocessing.(442) INFO 48.7% complete 2019-06-03 23:21:27,720 geoprocessing.(442) INFO 49.1% complete 2019-06-03 23:21:32,815 geoprocessing.(442) INFO 49.5% complete 2019-06-03 23:21:37,877 geoprocessing.(442) INFO 50.0% complete 2019-06-03 23:21:42,924 geoprocessing.(442) INFO 50.4% complete 2019-06-03 23:21:47,986 geoprocessing.(442) INFO 50.8% complete 2019-06-03 23:21:53,063 geoprocessing.(442) INFO 51.2% complete 2019-06-03 23:21:58,173 geoprocessing.(442) INFO 51.6% complete 2019-06-03 23:22:03,250 geoprocessing.(442) INFO 52.1% complete 2019-06-03 23:22:08,359 geoprocessing.(442) INFO 52.6% complete 2019-06-03 23:22:13,453 geoprocessing.(442) INFO 53.0% complete 2019-06-03 23:22:18,515 geoprocessing.(442) INFO 53.4% complete 2019-06-03 23:22:23,624 geoprocessing.(442) INFO 53.9% complete 2019-06-03 23:22:28,690 geoprocessing.(442) INFO 54.3% complete 2019-06-03 23:22:33,737 geoprocessing.(442) INFO 54.7% complete 2019-06-03 23:22:38,783 geoprocessing.(442) INFO 55.1% complete 2019-06-03 23:22:43,799 geoprocessing.(442) INFO 55.5% complete 2019-06-03 23:22:48,831 geoprocessing.(442) INFO 56.0% complete 2019-06-03 23:22:53,877 geoprocessing.(442) INFO 56.4% complete 2019-06-03 23:22:58,954 geoprocessing.(442) INFO 56.8% complete 2019-06-03 23:23:04,016 geoprocessing.(442) INFO 57.3% complete 2019-06-03 23:23:09,095 geoprocessing.(442) INFO 57.7% complete 2019-06-03 23:23:14,157 geoprocessing.(442) INFO 58.2% complete 2019-06-03 23:23:19,219 geoprocessing.(442) INFO 58.7% complete 2019-06-03 23:23:24,282 geoprocessing.(442) INFO 59.1% complete 2019-06-03 23:23:29,299 geoprocessing.(442) INFO 59.6% complete 2019-06-03 23:23:34,361 geoprocessing.(442) INFO 60.1% complete 2019-06-03 23:23:39,438 geoprocessing.(442) INFO 60.6% complete 2019-06-03 23:23:44,470 geoprocessing.(442) INFO 61.0% complete 2019-06-03 23:23:49,562 geoprocessing.(442) INFO 61.6% complete 2019-06-03 23:23:54,594 geoprocessing.(442) INFO 62.0% complete 2019-06-03 23:23:59,703 geoprocessing.(442) INFO 62.4% complete 2019-06-03 23:24:04,733 geoprocessing.(442) INFO 63.0% complete 2019-06-03 23:24:09,842 geoprocessing.(442) INFO 63.4% complete 2019-06-03 23:24:14,937 geoprocessing.(442) INFO 64.0% complete 2019-06-03 23:24:20,015 geoprocessing.(442) INFO 64.5% complete 2019-06-03 23:24:25,108 geoprocessing.(442) INFO 65.0% complete 2019-06-03 23:24:30,124 geoprocessing.(442) INFO 65.4% complete 2019-06-03 23:24:35,138 geoprocessing.(442) INFO 66.0% complete 2019-06-03 23:24:40,200 geoprocessing.(442) INFO 66.4% complete 2019-06-03 23:24:45,309 geoprocessing.(442) INFO 66.9% complete 2019-06-03 23:24:50,357 geoprocessing.(442) INFO 67.5% complete 2019-06-03 23:24:55,418 geoprocessing.(442) INFO 67.9% complete 2019-06-03 23:25:00,492 geoprocessing.(442) INFO 68.5% complete 2019-06-03 23:25:05,539 geoprocessing.(442) INFO 69.0% complete 2019-06-03 23:25:10,585 geoprocessing.(442) INFO 69.6% complete 2019-06-03 23:25:15,615 geoprocessing.(442) INFO 70.0% complete 2019-06-03 23:25:20,647 geoprocessing.(442) INFO 70.6% complete 2019-06-03 23:25:25,694 geoprocessing.(442) INFO 71.0% complete 2019-06-03 23:25:30,709 geoprocessing.(442) INFO 71.6% complete 2019-06-03 23:25:35,756 geoprocessing.(442) INFO 72.1% complete 2019-06-03 23:25:40,818 geoprocessing.(442) INFO 72.5% complete 2019-06-03 23:25:45,880 geoprocessing.(442) INFO 73.1% complete 2019-06-03 23:25:50,989 geoprocessing.(442) INFO 73.6% complete 2019-06-03 23:25:56,098 geoprocessing.(442) INFO 74.2% complete 2019-06-03 23:26:01,128 geoprocessing.(442) INFO 74.7% complete 2019-06-03 23:26:06,176 geoprocessing.(442) INFO 75.3% complete 2019-06-03 23:26:11,269 geoprocessing.(442) INFO 75.7% complete 2019-06-03 23:26:16,285 geoprocessing.(442) INFO 76.4% complete 2019-06-03 23:26:21,299 geoprocessing.(442) INFO 76.8% complete 2019-06-03 23:26:26,378 geoprocessing.(442) INFO 77.6% complete 2019-06-03 23:26:31,392 geoprocessing.(442) INFO 78.4% complete 2019-06-03 23:26:36,440 geoprocessing.(442) INFO 79.1% complete 2019-06-03 23:26:41,502 geoprocessing.(442) INFO 80.0% complete 2019-06-03 23:26:46,516 geoprocessing.(442) INFO 80.9% complete 2019-06-03 23:26:51,578 geoprocessing.(442) INFO 82.0% complete 2019-06-03 23:26:56,657 geoprocessing.(442) INFO 83.4% complete 2019-06-03 23:27:01,719 geoprocessing.(442) INFO 84.6% complete 2019-06-03 23:27:06,726 geoprocessing.(442) INFO 86.3% complete 2019-06-03 23:27:11,742 geoprocessing.(442) INFO 88.0% complete 2019-06-03 23:27:16,773 geoprocessing.(442) INFO 91.0% complete 2019-06-03 23:27:21,835 geoprocessing.(442) INFO 93.6% complete 2019-06-03 23:27:26,841 geoprocessing.(442) INFO 96.7% complete 2019-06-03 23:27:31,854 geoprocessing.(442) INFO 99.4% complete 2019-06-03 23:27:33,040 geoprocessing.raster_calculator(445) INFO 100.0%% complete 2019-06-03 23:27:33,040 geoprocessing.raster_calculator(448) INFO signaling stats worker to terminate 2019-06-03 23:27:33,040 geoprocessing.raster_calculator(450) INFO Waiting for raster stats worker result. 2019-06-03 23:27:33,040 threading.run(754) DEBUG payload is None, terminating 2019-06-03 23:28:01,898 geoprocessing.(918) INFO 25.8% complete 2019-06-03 23:28:06,914 geoprocessing.(918) INFO 47.9% complete 2019-06-03 23:28:11,928 geoprocessing.(918) INFO 69.4% complete 2019-06-03 23:28:16,944 geoprocessing.(918) INFO 91.3% complete 2019-06-03 23:28:25,006 Task._call(1068) INFO 2.2% complete 2019-06-03 23:28:31,006 Task._call(1068) INFO 4.5% complete 2019-06-03 23:28:37,661 Task._call(1068) INFO 5.6% complete 2019-06-03 23:28:43,006 Task._call(1068) INFO 7.8% complete 2019-06-03 23:28:49,005 Task._call(1068) INFO 8.9% complete 2019-06-03 23:28:55,005 Task._call(1068) INFO 10.0% complete 2019-06-03 23:29:01,005 Task._call(1068) INFO 12.3% complete 2019-06-03 23:29:07,019 Task._call(1068) INFO 13.4% complete 2019-06-03 23:29:13,003 Task._call(1068) INFO 14.5% complete 2019-06-03 23:29:19,035 Task._call(1068) INFO 16.7% complete 2019-06-03 23:29:25,003 Task._call(1068) INFO 17.9% complete 2019-06-03 23:29:42,704 Task._call(1068) INFO 19.0% complete 2019-06-03 23:29:48,002 Task._call(1068) INFO 20.1% complete 2019-06-03 23:29:54,002 Task._call(1068) INFO 22.3% complete 2019-06-03 23:30:00,000 Task._call(1068) INFO 23.4% complete 2019-06-03 23:30:06,000 Task._call(1068) INFO 24.6% complete 2019-06-03 23:30:12,000 Task._call(1068) INFO 26.8% complete 2019-06-03 23:30:18,016 Task._call(1068) INFO 27.9% complete 2019-06-03 23:30:24,233 Task._call(1068) INFO 29.0% complete 2019-06-03 23:30:30,015 Task._call(1068) INFO 30.1% complete 2019-06-03 23:30:36,015 Task._call(1068) INFO 31.2% complete 2019-06-03 23:30:42,013 Task._call(1068) INFO 32.4% complete 2019-06-03 23:30:48,013 Task._call(1068) INFO 32.4% complete 2019-06-03 23:30:54,013 Task._call(1068) INFO 33.5% complete 2019-06-03 23:31:00,075 Task._call(1068) INFO 34.6% complete 2019-06-03 23:31:06,043 Task._call(1068) INFO 35.7% complete 2019-06-03 23:31:12,075 Task._call(1068) INFO 35.7% complete 2019-06-03 23:31:18,012 Task._call(1068) INFO 36.8% complete 2019-06-03 23:31:24,012 Task._call(1068) INFO 37.9% complete 2019-06-03 23:31:30,012 Task._call(1068) INFO 39.1% complete 2019-06-03 23:31:36,010 Task._call(1068) INFO 39.1% complete 2019-06-03 23:31:42,010 Task._call(1068) INFO 40.2% complete 2019-06-03 23:31:48,026 Task._call(1068) INFO 41.3% complete 2019-06-03 23:31:54,009 Task._call(1068) INFO 41.3% complete 2019-06-03 23:32:00,009 Task._call(1068) INFO 42.4% complete 2019-06-03 23:32:06,009 Task._call(1068) INFO 43.5% complete 2019-06-03 23:32:12,009 Task._call(1068) INFO 43.5% complete 2019-06-03 23:32:18,009 Task._call(1068) INFO 44.6% complete 2019-06-03 23:32:24,007 Task._call(1068) INFO 45.7% complete 2019-06-03 23:32:30,040 Task._call(1068) INFO 45.8% complete 2019-06-03 23:32:36,025 Task._call(1068) INFO 46.9% complete 2019-06-03 23:32:42,900 Task._call(1068) INFO 46.9% complete 2019-06-03 23:32:48,009 Task._call(1068) INFO 48.0% complete 2019-06-03 23:33:10,039 Task._call(1068) INFO 48.0% complete 2019-06-03 23:33:16,006 Task._call(1068) INFO 49.1% complete 2019-06-03 23:33:22,006 Task._call(1068) INFO 49.1% complete 2019-06-03 23:33:28,006 Task._call(1068) INFO 50.2% complete 2019-06-03 23:33:34,131 Task._call(1068) INFO 51.3% complete 2019-06-03 23:33:40,020 Task._call(1068) INFO 51.3% complete 2019-06-03 23:33:46,005 Task._call(1068) INFO 52.4% complete 2019-06-03 23:33:52,020 Task._call(1068) INFO 52.4% complete 2019-06-03 23:33:58,005 Task._call(1068) INFO 53.6% complete 2019-06-03 23:34:04,019 Task._call(1068) INFO 54.7% complete 2019-06-03 23:34:10,003 Task._call(1068) INFO 54.7% complete 2019-06-03 23:34:16,003 Task._call(1068) INFO 55.8% complete 2019-06-03 23:34:22,003 Task._call(1068) INFO 56.9% complete 2019-06-03 23:34:28,033 Task._call(1068) INFO 56.9% complete 2019-06-03 23:34:34,002 Task._call(1068) INFO 58.0% complete 2019-06-03 23:34:40,002 Task._call(1068) INFO 59.1% complete 2019-06-03 23:34:46,002 Task._call(1068) INFO 59.1% complete 2019-06-03 23:34:52,000 Task._call(1068) INFO 60.3% complete 2019-06-03 23:34:58,141 Task._call(1068) INFO 60.3% complete 2019-06-03 23:35:04,000 Task._call(1068) INFO 61.4% complete 2019-06-03 23:35:10,000 Task._call(1068) INFO 62.5% complete 2019-06-03 23:35:16,000 Task._call(1068) INFO 63.6% complete 2019-06-03 23:35:28,015 Task._call(1068) INFO 63.6% complete 2019-06-03 23:35:34,029 Task._call(1068) INFO 64.7% complete 2019-06-03 23:35:40,013 Task._call(1068) INFO 65.8% complete 2019-06-03 23:35:46,029 Task._call(1068) INFO 65.8% complete 2019-06-03 23:35:52,000 Task._call(1068) INFO 67.0% complete 2019-06-03 23:36:00,828 Task._call(1068) INFO 68.1% complete 2019-06-03 23:36:06,000 Task._call(1068) INFO 68.1% complete 2019-06-03 23:36:12,000 Task._call(1068) INFO 69.2% complete 2019-06-03 23:36:18,015 Task._call(1068) INFO 70.3% complete 2019-06-03 23:36:24,013 Task._call(1068) INFO 71.4% complete 2019-06-03 23:36:30,013 Task._call(1068) INFO 72.5% complete 2019-06-03 23:36:36,013 Task._call(1068) INFO 73.6% complete 2019-06-03 23:36:42,013 Task._call(1068) INFO 73.6% complete 2019-06-03 23:36:48,029 Task._call(1068) INFO 74.8% complete 2019-06-03 23:36:54,013 Task._call(1068) INFO 75.9% complete 2019-06-03 23:37:00,028 Task._call(1068) INFO 77.0% complete 2019-06-03 23:37:06,012 Task._call(1068) INFO 77.0% complete 2019-06-03 23:37:12,589 Task._call(1068) INFO 78.1% complete 2019-06-03 23:37:18,010 Task._call(1068) INFO 79.2% complete 2019-06-03 23:37:24,260 Task._call(1068) INFO 80.3% complete 2019-06-03 23:37:30,005 Task._call(1068) INFO 81.5% complete 2019-06-03 23:37:36,598 Task._call(1068) INFO 82.6% complete 2019-06-03 23:37:42,003 Task._call(1068) INFO 83.7% complete 2019-06-03 23:37:48,003 Task._call(1068) INFO 84.8% complete 2019-06-03 23:37:55,237 Task._call(1068) INFO 85.9% complete 2019-06-03 23:38:01,065 Task._call(1068) INFO 88.2% complete 2019-06-03 23:38:07,003 Task._call(1068) INFO 89.3% complete 2019-06-03 23:38:13,003 Task._call(1068) INFO 92.6% complete 2019-06-03 23:38:19,002 Task._call(1068) INFO 94.8% complete 2019-06-03 23:38:25,002 Task._call(1068) INFO 97.1% complete 2019-06-03 23:42:07,872 Task._call(1068) INFO 99.3% complete 2019-06-03 23:42:08,543 Task._call(1068) INFO filter out incomplete divergent streams 2019-06-03 23:42:22,512 Task._call(1068) INFO 100.0% complete 2019-06-03 23:42:22,700 Task._scrub_task_args(1406) WARNING C:\INVEST~2.0_X\INVEST~1\taskgraph\Task.py:1406: UnicodeWarning: Unicode equal comparison failed to convert both arguments to Unicode - interpreting them as being unequal 2019-06-03 23:42:22,700 Task._get_file_stats(1281) WARNING C:\INVEST~2.0_X\INVEST~1\taskgraph\Task.py:1281: UnicodeWarning: Unicode equal comparison failed to convert both arguments to Unicode - interpreting them as being unequal 2019-06-03 23:42:22,746 Task._filter_non_files(1329) WARNING C:\INVEST~2.0_X\INVEST~1\taskgraph\Task.py:1329: UnicodeWarning: Unicode equal comparison failed to convert both arguments to Unicode - interpreting them as being unequal 2019-06-03 23:42:22,778 geoprocessing.raster_calculator(366) INFO starting stats_worker 2019-06-03 23:42:22,778 geoprocessing.raster_calculator(372) INFO started stats_worker 2019-06-03 23:42:27,786 geoprocessing.(442) INFO 6.6% complete 2019-06-03 23:42:32,802 geoprocessing.(442) INFO 13.2% complete 2019-06-03 23:42:37,816 geoprocessing.(442) INFO 19.9% complete 2019-06-03 23:42:42,832 geoprocessing.(442) INFO 26.6% complete 2019-06-03 23:42:47,848 geoprocessing.(442) INFO 33.4% complete 2019-06-03 23:42:52,862 geoprocessing.(442) INFO 39.9% complete 2019-06-03 23:42:57,878 geoprocessing.(442) INFO 45.9% complete 2019-06-03 23:43:02,894 geoprocessing.(442) INFO 51.8% complete 2019-06-03 23:43:07,908 geoprocessing.(442) INFO 57.1% complete 2019-06-03 23:43:12,924 geoprocessing.(442) INFO 62.0% complete 2019-06-03 23:43:17,940 geoprocessing.(442) INFO 66.9% complete 2019-06-03 23:43:22,954 geoprocessing.(442) INFO 71.9% complete 2019-06-03 23:43:27,963 geoprocessing.(442) INFO 77.1% complete 2019-06-03 23:43:32,979 geoprocessing.(442) INFO 82.5% complete 2019-06-03 23:43:37,993 geoprocessing.(442) INFO 88.1% complete 2019-06-03 23:43:43,009 geoprocessing.(442) INFO 93.8% complete 2019-06-03 23:43:48,025 geoprocessing.(442) INFO 99.5% complete 2019-06-03 23:43:48,555 geoprocessing.raster_calculator(445) INFO 100.0%% complete 2019-06-03 23:43:48,555 geoprocessing.raster_calculator(448) INFO signaling stats worker to terminate 2019-06-03 23:43:48,555 threading.run(754) DEBUG payload is None, terminating 2019-06-03 23:43:48,555 geoprocessing.raster_calculator(450) INFO Waiting for raster stats worker result. 2019-06-03 23:43:49,461 geoprocessing.raster_calculator(366) INFO starting stats_worker 2019-06-03 23:43:49,461 geoprocessing.raster_calculator(372) INFO started stats_worker 2019-06-03 23:43:54,477 geoprocessing.(442) INFO 13.9% complete 2019-06-03 23:43:59,493 geoprocessing.(442) INFO 26.2% complete 2019-06-03 23:44:04,507 geoprocessing.(442) INFO 38.2% complete 2019-06-03 23:44:09,523 geoprocessing.(442) INFO 49.0% complete 2019-06-03 23:44:14,539 geoprocessing.(442) INFO 59.5% complete 2019-06-03 23:44:19,553 geoprocessing.(442) INFO 70.2% complete 2019-06-03 23:44:24,569 geoprocessing.(442) INFO 81.4% complete 2019-06-03 23:44:29,585 geoprocessing.(442) INFO 94.5% complete 2019-06-03 23:44:31,740 geoprocessing.raster_calculator(445) INFO 100.0%% complete 2019-06-03 23:44:31,740 geoprocessing.raster_calculator(448) INFO signaling stats worker to terminate 2019-06-03 23:44:31,740 threading.run(754) DEBUG payload is None, terminating 2019-06-03 23:44:31,740 geoprocessing.raster_calculator(450) INFO Waiting for raster stats worker result. 2019-06-03 23:44:32,710 geoprocessing.raster_calculator(366) INFO starting stats_worker 2019-06-03 23:44:32,710 geoprocessing.raster_calculator(372) INFO started stats_worker 2019-06-03 23:44:37,724 geoprocessing.(442) INFO 6.7% complete 2019-06-03 23:44:42,740 geoprocessing.(442) INFO 12.3% complete 2019-06-03 23:44:47,756 geoprocessing.(442) INFO 17.8% complete 2019-06-03 23:44:52,770 geoprocessing.(442) INFO 23.3% complete 2019-06-03 23:44:57,786 geoprocessing.(442) INFO 28.9% complete 2019-06-03 23:45:02,802 geoprocessing.(442) INFO 34.4% complete 2019-06-03 23:45:07,816 geoprocessing.(442) INFO 39.7% complete 2019-06-03 23:45:12,832 geoprocessing.(442) INFO 44.5% complete 2019-06-03 23:45:17,848 geoprocessing.(442) INFO 49.4% complete 2019-06-03 23:45:22,862 geoprocessing.(442) INFO 54.3% complete 2019-06-03 23:45:27,878 geoprocessing.(442) INFO 59.2% complete 2019-06-03 23:45:32,894 geoprocessing.(442) INFO 64.1% complete 2019-06-03 23:45:37,908 geoprocessing.(442) INFO 69.1% complete 2019-06-03 23:45:42,924 geoprocessing.(442) INFO 74.1% complete 2019-06-03 23:45:47,940 geoprocessing.(442) INFO 79.4% complete 2019-06-03 23:45:52,954 geoprocessing.(442) INFO 85.0% complete 2019-06-03 23:45:57,970 geoprocessing.(442) INFO 90.7% complete 2019-06-03 23:46:02,986 geoprocessing.(442) INFO 96.5% complete 2019-06-03 23:46:06,111 geoprocessing.raster_calculator(445) INFO 100.0%% complete 2019-06-03 23:46:06,111 geoprocessing.raster_calculator(448) INFO signaling stats worker to terminate 2019-06-03 23:46:06,111 geoprocessing.raster_calculator(450) INFO Waiting for raster stats worker result. 2019-06-03 23:46:06,111 threading.run(754) DEBUG payload is None, terminating 2019-06-03 23:46:13,953 geoprocessing.raster_calculator(366) INFO starting stats_worker 2019-06-03 23:46:13,953 geoprocessing.raster_calculator(372) INFO started stats_worker 2019-06-03 23:46:18,984 geoprocessing.(442) INFO 3.9% complete 2019-06-03 23:46:24,000 geoprocessing.(442) INFO 7.1% complete 2019-06-03 23:46:29,016 geoprocessing.(442) INFO 10.1% complete 2019-06-03 23:46:34,046 geoprocessing.(442) INFO 12.7% complete 2019-06-03 23:46:39,062 geoprocessing.(442) INFO 15.2% complete 2019-06-03 23:46:44,076 geoprocessing.(442) INFO 17.9% complete 2019-06-03 23:46:49,124 geoprocessing.(442) INFO 20.6% complete 2019-06-03 23:46:54,138 geoprocessing.(442) INFO 23.8% complete 2019-06-03 23:46:59,154 geoprocessing.(442) INFO 26.7% complete 2019-06-03 23:47:04,170 geoprocessing.(442) INFO 29.7% complete 2019-06-03 23:47:09,184 geoprocessing.(442) INFO 32.4% complete 2019-06-03 23:47:14,216 geoprocessing.(442) INFO 34.6% complete 2019-06-03 23:47:19,230 geoprocessing.(442) INFO 36.5% complete 2019-06-03 23:47:24,246 geoprocessing.(442) INFO 38.3% complete 2019-06-03 23:47:29,266 geoprocessing.(442) INFO 39.9% complete 2019-06-03 23:47:34,298 geoprocessing.(442) INFO 41.3% complete 2019-06-03 23:47:39,328 geoprocessing.(442) INFO 42.7% complete 2019-06-03 23:47:44,344 geoprocessing.(442) INFO 44.0% complete 2019-06-03 23:47:49,359 geoprocessing.(442) INFO 45.4% complete 2019-06-03 23:47:54,391 geoprocessing.(442) INFO 46.8% complete 2019-06-03 23:47:59,405 geoprocessing.(442) INFO 48.0% complete 2019-06-03 23:48:04,421 geoprocessing.(442) INFO 49.3% complete 2019-06-03 23:48:09,467 geoprocessing.(442) INFO 50.5% complete 2019-06-03 23:48:14,483 geoprocessing.(442) INFO 51.8% complete 2019-06-03 23:48:19,513 geoprocessing.(442) INFO 53.1% complete 2019-06-03 23:48:24,529 geoprocessing.(442) INFO 54.4% complete 2019-06-03 23:48:29,556 geoprocessing.(442) INFO 55.8% complete 2019-06-03 23:48:34,588 geoprocessing.(442) INFO 57.1% complete 2019-06-03 23:48:39,618 geoprocessing.(442) INFO 58.5% complete 2019-06-03 23:48:44,650 geoprocessing.(442) INFO 59.8% complete 2019-06-03 23:48:49,664 geoprocessing.(442) INFO 61.4% complete 2019-06-03 23:48:54,680 geoprocessing.(442) INFO 62.8% complete 2019-06-03 23:48:59,711 geoprocessing.(442) INFO 64.2% complete 2019-06-03 23:49:04,726 geoprocessing.(442) INFO 65.8% complete 2019-06-03 23:49:09,757 geoprocessing.(442) INFO 67.3% complete 2019-06-03 23:49:14,773 geoprocessing.(442) INFO 68.7% complete 2019-06-03 23:49:19,803 geoprocessing.(442) INFO 70.3% complete 2019-06-03 23:49:24,835 geoprocessing.(442) INFO 71.8% complete 2019-06-03 23:49:29,881 geoprocessing.(442) INFO 73.3% complete 2019-06-03 23:49:34,913 geoprocessing.(442) INFO 75.0% complete 2019-06-03 23:49:39,944 geoprocessing.(442) INFO 76.5% complete 2019-06-03 23:49:44,974 geoprocessing.(442) INFO 78.2% complete 2019-06-03 23:49:49,990 geoprocessing.(442) INFO 80.0% complete 2019-06-03 23:49:55,005 geoprocessing.(442) INFO 82.8% complete 2019-06-03 23:50:00,020 geoprocessing.(442) INFO 85.6% complete 2019-06-03 23:50:05,036 geoprocessing.(442) INFO 89.3% complete 2019-06-03 23:50:10,051 geoprocessing.(442) INFO 93.8% complete 2019-06-03 23:50:15,066 geoprocessing.(442) INFO 98.2% complete 2019-06-03 23:50:17,285 geoprocessing.raster_calculator(445) INFO 100.0%% complete 2019-06-03 23:50:17,285 geoprocessing.raster_calculator(448) INFO signaling stats worker to terminate 2019-06-03 23:50:17,285 threading.run(754) DEBUG payload is None, terminating 2019-06-03 23:50:17,285 geoprocessing.raster_calculator(450) INFO Waiting for raster stats worker result. 2019-06-03 23:50:30,456 geoprocessing.raster_calculator(366) INFO starting stats_worker 2019-06-03 23:50:30,456 geoprocessing.raster_calculator(372) INFO started stats_worker 2019-06-03 23:50:35,471 geoprocessing.(442) INFO 6.3% complete 2019-06-03 23:50:40,486 geoprocessing.(442) INFO 10.5% complete 2019-06-03 23:50:45,502 geoprocessing.(442) INFO 14.0% complete 2019-06-03 23:50:50,517 geoprocessing.(442) INFO 17.3% complete 2019-06-03 23:50:55,549 geoprocessing.(442) INFO 20.6% complete 2019-06-03 23:51:00,563 geoprocessing.(442) INFO 23.5% complete 2019-06-03 23:51:05,578 geoprocessing.(442) INFO 26.7% complete 2019-06-03 23:51:10,595 geoprocessing.(442) INFO 30.0% complete 2019-06-03 23:51:15,625 geoprocessing.(442) INFO 33.0% complete 2019-06-03 23:51:20,655 geoprocessing.(442) INFO 35.3% complete 2019-06-03 23:51:25,687 geoprocessing.(442) INFO 37.3% complete 2019-06-03 23:51:30,703 geoprocessing.(442) INFO 39.1% complete 2019-06-03 23:51:35,733 geoprocessing.(442) INFO 40.6% complete 2019-06-03 23:51:40,765 geoprocessing.(442) INFO 42.1% complete 2019-06-03 23:51:45,779 geoprocessing.(442) INFO 43.7% complete 2019-06-03 23:51:50,795 geoprocessing.(442) INFO 45.2% complete 2019-06-03 23:51:55,811 geoprocessing.(442) INFO 46.6% complete 2019-06-03 23:52:00,857 geoprocessing.(442) INFO 48.1% complete 2019-06-03 23:52:05,888 geoprocessing.(442) INFO 49.5% complete 2019-06-03 23:52:10,903 geoprocessing.(442) INFO 50.9% complete 2019-06-03 23:52:15,918 geoprocessing.(442) INFO 52.3% complete 2019-06-03 23:52:20,964 geoprocessing.(442) INFO 53.9% complete 2019-06-03 23:52:25,996 geoprocessing.(442) INFO 55.3% complete 2019-06-03 23:52:31,007 geoprocessing.(442) INFO 56.8% complete 2019-06-03 23:52:36,023 geoprocessing.(442) INFO 58.5% complete 2019-06-03 23:52:41,039 geoprocessing.(442) INFO 60.0% complete 2019-06-03 23:52:46,069 geoprocessing.(442) INFO 61.8% complete 2019-06-03 23:52:51,101 geoprocessing.(442) INFO 63.4% complete 2019-06-03 23:52:56,115 geoprocessing.(442) INFO 65.1% complete 2019-06-03 23:53:01,131 geoprocessing.(442) INFO 66.7% complete 2019-06-03 23:53:06,161 geoprocessing.(442) INFO 68.5% complete 2019-06-03 23:53:11,193 geoprocessing.(442) INFO 70.1% complete 2019-06-03 23:53:16,209 geoprocessing.(442) INFO 72.0% complete 2019-06-03 23:53:21,223 geoprocessing.(442) INFO 73.9% complete 2019-06-03 23:53:26,255 geoprocessing.(442) INFO 75.7% complete 2019-06-03 23:53:31,286 geoprocessing.(442) INFO 78.5% complete 2019-06-03 23:53:36,301 geoprocessing.(442) INFO 81.8% complete 2019-06-03 23:53:41,315 geoprocessing.(442) INFO 86.1% complete 2019-06-03 23:53:46,332 geoprocessing.(442) INFO 92.4% complete 2019-06-03 23:53:51,346 geoprocessing.(442) INFO 98.2% complete 2019-06-03 23:53:52,799 geoprocessing.raster_calculator(445) INFO 100.0%% complete 2019-06-03 23:53:52,799 geoprocessing.raster_calculator(448) INFO signaling stats worker to terminate 2019-06-03 23:53:52,799 geoprocessing.raster_calculator(450) INFO Waiting for raster stats worker result. 2019-06-03 23:53:52,799 threading.run(754) DEBUG payload is None, terminating 2019-06-03 23:54:14,252 sdr._calculate_bar_factor(858) DEBUG doing flow accumulation mfd on E:\InVEST\SDR\TRIAL RUN\June 2_Trial10_TFA5000\intermediate_outputs\w_threshold.tif 2019-06-03 23:54:19,282 geoprocessing.(918) INFO 6.9% complete 2019-06-03 23:54:24,298 geoprocessing.(918) INFO 11.3% complete 2019-06-03 23:54:29,313 geoprocessing.(918) INFO 15.7% complete 2019-06-03 23:54:34,328 geoprocessing.(918) INFO 20.4% complete 2019-06-03 23:54:39,344 geoprocessing.(918) INFO 25.0% complete 2019-06-03 23:54:44,359 geoprocessing.(918) INFO 29.7% complete 2019-06-03 23:54:49,375 geoprocessing.(918) INFO 34.4% complete 2019-06-03 23:54:54,390 geoprocessing.(918) INFO 39.0% complete 2019-06-03 23:54:59,398 geoprocessing.(918) INFO 44.5% complete 2019-06-03 23:55:04,414 geoprocessing.(918) INFO 50.2% complete 2019-06-03 23:55:09,428 geoprocessing.(918) INFO 56.0% complete 2019-06-03 23:55:14,444 geoprocessing.(918) INFO 61.8% complete 2019-06-03 23:55:19,460 geoprocessing.(918) INFO 67.6% complete 2019-06-03 23:55:24,474 geoprocessing.(918) INFO 73.3% complete 2019-06-03 23:55:29,490 geoprocessing.(918) INFO 79.0% complete 2019-06-03 23:55:34,506 geoprocessing.(918) INFO 84.6% complete 2019-06-03 23:55:39,520 geoprocessing.(918) INFO 90.3% complete 2019-06-03 23:55:44,536 geoprocessing.(918) INFO 96.1% complete 2019-06-03 23:55:50,536 sdr._calculate_bar_factor(866) INFO 0.0% complete 2019-06-03 23:55:56,661 sdr._calculate_bar_factor(866) INFO 2.2% complete 2019-06-03 23:56:02,003 sdr._calculate_bar_factor(866) INFO 7.8% complete 2019-06-03 23:56:09,862 sdr._calculate_bar_factor(866) INFO 7.8% complete 2019-06-03 23:56:18,706 sdr._calculate_bar_factor(866) INFO 14.5% complete 2019-06-03 23:57:30,648 sdr._calculate_bar_factor(866) INFO 19.0% complete 2019-06-03 23:57:36,242 sdr._calculate_bar_factor(866) INFO 21.2% complete 2019-06-03 23:57:42,101 sdr._calculate_bar_factor(866) INFO 23.4% complete 2019-06-03 23:57:48,006 sdr._calculate_bar_factor(866) INFO 26.8% complete 2019-06-03 23:57:56,115 sdr._calculate_bar_factor(866) INFO 29.0% complete 2019-06-03 23:58:02,068 sdr._calculate_bar_factor(866) INFO 30.1% complete 2019-06-03 23:58:08,302 sdr._calculate_bar_factor(866) INFO 31.2% complete 2019-06-03 23:58:14,614 sdr._calculate_bar_factor(866) INFO 32.4% complete 2019-06-03 23:58:21,644 sdr._calculate_bar_factor(866) INFO 33.5% complete 2019-06-03 23:58:27,003 sdr._calculate_bar_factor(866) INFO 34.6% complete 2019-06-03 23:58:33,003 sdr._calculate_bar_factor(866) INFO 36.8% complete 2019-06-03 23:58:39,612 sdr._calculate_bar_factor(866) INFO 39.1% complete 2019-06-03 23:58:45,003 sdr._calculate_bar_factor(866) INFO 42.4% complete 2019-06-03 23:58:51,158 sdr._calculate_bar_factor(866) INFO 43.5% complete 2019-06-03 23:58:57,892 sdr._calculate_bar_factor(866) INFO 44.6% complete 2019-06-03 23:59:03,157 sdr._calculate_bar_factor(866) INFO 48.0% complete 2019-06-04 00:01:11,134 sdr._calculate_bar_factor(866) INFO 48.0% complete 2019-06-04 00:01:17,009 sdr._calculate_bar_factor(866) INFO 49.1% complete 2019-06-04 00:01:23,259 sdr._calculate_bar_factor(866) INFO 54.7% complete 2019-06-04 00:01:29,275 sdr._calculate_bar_factor(866) INFO 56.9% complete 2019-06-04 00:01:35,118 sdr._calculate_bar_factor(866) INFO 58.0% complete 2019-06-04 00:01:41,009 sdr._calculate_bar_factor(866) INFO 59.1% complete 2019-06-04 00:01:49,960 sdr._calculate_bar_factor(866) INFO 60.3% complete 2019-06-04 00:01:55,007 sdr._calculate_bar_factor(866) INFO 62.5% complete 2019-06-04 00:02:01,039 sdr._calculate_bar_factor(866) INFO 64.7% complete 2019-06-04 00:02:07,006 sdr._calculate_bar_factor(866) INFO 68.1% complete 2019-06-04 00:02:13,819 sdr._calculate_bar_factor(866) INFO 71.4% complete 2019-06-04 00:02:20,052 sdr._calculate_bar_factor(866) INFO 74.8% complete 2019-06-04 00:02:26,844 sdr._calculate_bar_factor(866) INFO 77.0% complete 2019-06-04 00:02:32,750 sdr._calculate_bar_factor(866) INFO 77.0% complete 2019-06-04 00:02:39,625 sdr._calculate_bar_factor(866) INFO 78.1% complete 2019-06-04 00:02:45,030 sdr._calculate_bar_factor(866) INFO 79.2% complete 2019-06-04 00:02:51,733 sdr._calculate_bar_factor(866) INFO 79.2% complete 2019-06-04 00:02:57,451 sdr._calculate_bar_factor(866) INFO 80.3% complete 2019-06-04 00:03:03,076 sdr._calculate_bar_factor(866) INFO 81.5% complete 2019-06-04 00:03:10,186 sdr._calculate_bar_factor(866) INFO 82.6% complete 2019-06-04 00:03:16,934 sdr._calculate_bar_factor(866) INFO 82.6% complete 2019-06-04 00:03:22,466 sdr._calculate_bar_factor(866) INFO 84.8% complete 2019-06-04 00:03:32,293 sdr._calculate_bar_factor(866) INFO 85.9% complete 2019-06-04 00:03:41,262 sdr._calculate_bar_factor(866) INFO 88.2% complete 2019-06-04 00:03:51,823 sdr._calculate_bar_factor(866) INFO 89.3% complete 2019-06-04 00:03:57,730 sdr._calculate_bar_factor(866) INFO 92.6% complete 2019-06-04 00:04:03,056 sdr._calculate_bar_factor(866) INFO 98.2% complete 2019-06-04 00:21:24,262 sdr._calculate_bar_factor(866) INFO 99.3% complete 2019-06-04 00:21:31,917 sdr._calculate_bar_factor(866) INFO 100.0% complete 2019-06-04 00:21:31,948 geoprocessing.raster_calculator(366) INFO starting stats_worker 2019-06-04 00:21:31,948 geoprocessing.raster_calculator(372) INFO started stats_worker 2019-06-04 00:21:36,963 geoprocessing.(442) INFO 3.5% complete 2019-06-04 00:21:41,994 geoprocessing.(442) INFO 6.4% complete 2019-06-04 00:21:47,009 geoprocessing.(442) INFO 9.3% complete 2019-06-04 00:21:52,026 geoprocessing.(442) INFO 12.0% complete 2019-06-04 00:21:57,040 geoprocessing.(442) INFO 14.7% complete 2019-06-04 00:22:02,055 geoprocessing.(442) INFO 17.4% complete 2019-06-04 00:22:07,072 geoprocessing.(442) INFO 19.8% complete 2019-06-04 00:22:12,086 geoprocessing.(442) INFO 22.6% complete 2019-06-04 00:22:17,101 geoprocessing.(442) INFO 25.2% complete 2019-06-04 00:22:22,118 geoprocessing.(442) INFO 27.8% complete 2019-06-04 00:22:27,125 geoprocessing.(442) INFO 30.3% complete 2019-06-04 00:22:32,138 geoprocessing.(442) INFO 32.2% complete 2019-06-04 00:22:37,154 geoprocessing.(442) INFO 34.0% complete 2019-06-04 00:22:42,170 geoprocessing.(442) INFO 35.6% complete 2019-06-04 00:22:47,184 geoprocessing.(442) INFO 37.1% complete 2019-06-04 00:22:52,200 geoprocessing.(442) INFO 38.6% complete 2019-06-04 00:22:57,230 geoprocessing.(442) INFO 40.0% complete 2019-06-04 00:23:02,262 geoprocessing.(442) INFO 41.4% complete 2019-06-04 00:23:07,276 geoprocessing.(442) INFO 42.7% complete 2019-06-04 00:23:12,308 geoprocessing.(442) INFO 44.0% complete 2019-06-04 00:23:17,323 geoprocessing.(442) INFO 45.3% complete 2019-06-04 00:23:22,338 geoprocessing.(442) INFO 46.6% complete 2019-06-04 00:23:27,354 geoprocessing.(442) INFO 47.9% complete 2019-06-04 00:23:32,384 geoprocessing.(442) INFO 49.2% complete 2019-06-04 00:23:37,415 geoprocessing.(442) INFO 50.5% complete 2019-06-04 00:23:42,447 geoprocessing.(442) INFO 51.8% complete 2019-06-04 00:23:47,493 geoprocessing.(442) INFO 53.1% complete 2019-06-04 00:23:52,509 geoprocessing.(442) INFO 54.4% complete 2019-06-04 00:23:57,539 geoprocessing.(442) INFO 55.7% complete 2019-06-04 00:24:02,571 geoprocessing.(442) INFO 57.1% complete 2019-06-04 00:24:07,585 geoprocessing.(442) INFO 58.4% complete 2019-06-04 00:24:12,601 geoprocessing.(442) INFO 59.7% complete 2019-06-04 00:24:17,632 geoprocessing.(442) INFO 61.1% complete 2019-06-04 00:24:22,664 geoprocessing.(442) INFO 62.5% complete 2019-06-04 00:24:27,694 geoprocessing.(442) INFO 64.0% complete 2019-06-04 00:24:32,726 geoprocessing.(442) INFO 65.4% complete 2019-06-04 00:24:37,740 geoprocessing.(442) INFO 66.8% complete 2019-06-04 00:24:42,772 geoprocessing.(442) INFO 68.3% complete 2019-06-04 00:24:47,786 geoprocessing.(442) INFO 69.8% complete 2019-06-04 00:24:52,818 geoprocessing.(442) INFO 71.2% complete 2019-06-04 00:24:57,842 geoprocessing.(442) INFO 72.7% complete 2019-06-04 00:25:02,858 geoprocessing.(442) INFO 74.2% complete 2019-06-04 00:25:07,872 geoprocessing.(442) INFO 75.7% complete 2019-06-04 00:25:12,888 geoprocessing.(442) INFO 77.5% complete 2019-06-04 00:25:17,904 geoprocessing.(442) INFO 79.3% complete 2019-06-04 00:25:22,918 geoprocessing.(442) INFO 81.3% complete 2019-06-04 00:25:27,950 geoprocessing.(442) INFO 83.5% complete 2019-06-04 00:25:32,980 geoprocessing.(442) INFO 85.8% complete 2019-06-04 00:25:37,996 geoprocessing.(442) INFO 88.3% complete 2019-06-04 00:25:43,012 geoprocessing.(442) INFO 90.9% complete 2019-06-04 00:25:48,026 geoprocessing.(442) INFO 93.3% complete 2019-06-04 00:25:53,058 geoprocessing.(442) INFO 95.8% complete 2019-06-04 00:25:58,072 geoprocessing.(442) INFO 98.2% complete 2019-06-04 00:26:01,683 geoprocessing.raster_calculator(445) INFO 100.0%% complete 2019-06-04 00:26:01,683 geoprocessing.raster_calculator(448) INFO signaling stats worker to terminate 2019-06-04 00:26:01,683 threading.run(754) DEBUG payload is None, terminating 2019-06-04 00:26:01,683 geoprocessing.raster_calculator(450) INFO Waiting for raster stats worker result. 2019-06-04 00:26:37,946 sdr._calculate_bar_factor(858) DEBUG doing flow accumulation mfd on E:\InVEST\SDR\TRIAL RUN\June 2_Trial10_TFA5000\intermediate_outputs\slope_threshold.tif 2019-06-04 00:26:42,960 geoprocessing.(918) INFO 6.7% complete 2019-06-04 00:26:47,976 geoprocessing.(918) INFO 12.5% complete 2019-06-04 00:26:52,992 geoprocessing.(918) INFO 17.8% complete 2019-06-04 00:26:58,006 geoprocessing.(918) INFO 23.7% complete 2019-06-04 00:27:03,023 geoprocessing.(918) INFO 29.6% complete 2019-06-04 00:27:08,038 geoprocessing.(918) INFO 35.5% complete 2019-06-04 00:27:13,052 geoprocessing.(918) INFO 41.4% complete 2019-06-04 00:27:18,069 geoprocessing.(918) INFO 47.3% complete 2019-06-04 00:27:23,084 geoprocessing.(918) INFO 53.2% complete 2019-06-04 00:27:28,099 geoprocessing.(918) INFO 59.0% complete 2019-06-04 00:27:33,115 geoprocessing.(918) INFO 63.4% complete 2019-06-04 00:27:38,130 geoprocessing.(918) INFO 68.1% complete 2019-06-04 00:27:43,145 geoprocessing.(918) INFO 72.8% complete 2019-06-04 00:27:48,161 geoprocessing.(918) INFO 77.1% complete 2019-06-04 00:27:53,176 geoprocessing.(918) INFO 81.9% complete 2019-06-04 00:27:58,191 geoprocessing.(918) INFO 86.7% complete 2019-06-04 00:28:03,207 geoprocessing.(918) INFO 91.5% complete 2019-06-04 00:28:08,221 geoprocessing.(918) INFO 96.2% complete 2019-06-04 00:28:13,986 sdr._calculate_bar_factor(866) INFO 0.0% complete 2019-06-04 00:28:20,331 sdr._calculate_bar_factor(866) INFO 2.2% complete 2019-06-04 00:28:26,002 sdr._calculate_bar_factor(866) INFO 6.7% complete 2019-06-04 00:28:32,954 sdr._calculate_bar_factor(866) INFO 7.8% complete 2019-06-04 00:28:38,157 sdr._calculate_bar_factor(866) INFO 11.2% complete 2019-06-04 00:28:45,078 sdr._calculate_bar_factor(866) INFO 14.5% complete 2019-06-04 00:30:03,996 sdr._calculate_bar_factor(866) INFO 19.0% complete 2019-06-04 00:30:09,012 sdr._calculate_bar_factor(866) INFO 21.2% complete 2019-06-04 00:30:15,496 sdr._calculate_bar_factor(866) INFO 23.4% complete 2019-06-04 00:30:21,385 sdr._calculate_bar_factor(866) INFO 25.7% complete 2019-06-04 00:30:27,072 sdr._calculate_bar_factor(866) INFO 29.0% complete 2019-06-04 00:30:34,556 sdr._calculate_bar_factor(866) INFO 30.1% complete 2019-06-04 00:30:40,276 sdr._calculate_bar_factor(866) INFO 30.1% complete 2019-06-04 00:30:48,368 sdr._calculate_bar_factor(866) INFO 31.2% complete 2019-06-04 00:30:54,961 sdr._calculate_bar_factor(866) INFO 32.4% complete 2019-06-04 00:31:00,055 sdr._calculate_bar_factor(866) INFO 33.5% complete 2019-06-04 00:31:07,039 sdr._calculate_bar_factor(866) INFO 33.5% complete 2019-06-04 00:31:13,101 sdr._calculate_bar_factor(866) INFO 34.6% complete 2019-06-04 00:31:19,460 sdr._calculate_bar_factor(866) INFO 35.7% complete 2019-06-04 00:31:25,007 sdr._calculate_bar_factor(866) INFO 37.9% complete 2019-06-04 00:31:31,710 sdr._calculate_bar_factor(866) INFO 39.1% complete 2019-06-04 00:31:37,085 sdr._calculate_bar_factor(866) INFO 43.5% complete 2019-06-04 00:31:43,240 sdr._calculate_bar_factor(866) INFO 44.6% complete 2019-06-04 00:31:49,819 sdr._calculate_bar_factor(866) INFO 44.6% complete 2019-06-04 00:31:55,381 sdr._calculate_bar_factor(866) INFO 46.9% complete 2019-06-04 00:34:06,154 sdr._calculate_bar_factor(866) INFO 48.0% complete 2019-06-04 00:34:12,013 sdr._calculate_bar_factor(866) INFO 49.1% complete 2019-06-04 00:34:18,279 sdr._calculate_bar_factor(866) INFO 54.7% complete 2019-06-04 00:34:24,621 sdr._calculate_bar_factor(866) INFO 56.9% complete 2019-06-04 00:34:31,278 sdr._calculate_bar_factor(866) INFO 58.0% complete 2019-06-04 00:34:38,371 sdr._calculate_bar_factor(866) INFO 58.0% complete 2019-06-04 00:34:45,573 sdr._calculate_bar_factor(866) INFO 59.1% complete 2019-06-04 00:34:51,105 sdr._calculate_bar_factor(866) INFO 60.3% complete 2019-06-04 00:34:57,260 sdr._calculate_bar_factor(866) INFO 62.5% complete 2019-06-04 00:35:04,447 sdr._calculate_bar_factor(866) INFO 64.7% complete 2019-06-04 00:35:10,009 sdr._calculate_bar_factor(866) INFO 66.9% complete 2019-06-04 00:35:17,322 sdr._calculate_bar_factor(866) INFO 70.3% complete 2019-06-04 00:35:23,009 sdr._calculate_bar_factor(866) INFO 74.8% complete 2019-06-04 00:35:29,025 sdr._calculate_bar_factor(866) INFO 74.8% complete 2019-06-04 00:35:36,039 sdr._calculate_bar_factor(866) INFO 77.0% complete 2019-06-04 00:35:43,257 sdr._calculate_bar_factor(866) INFO 77.0% complete 2019-06-04 00:35:51,257 sdr._calculate_bar_factor(866) INFO 78.1% complete 2019-06-04 00:35:57,148 sdr._calculate_bar_factor(866) INFO 78.1% complete 2019-06-04 00:36:03,053 sdr._calculate_bar_factor(866) INFO 79.2% complete 2019-06-04 00:36:10,788 sdr._calculate_bar_factor(866) INFO 79.2% complete 2019-06-04 00:36:16,006 sdr._calculate_bar_factor(866) INFO 80.3% complete 2019-06-04 00:36:24,349 sdr._calculate_bar_factor(866) INFO 81.5% complete 2019-06-04 00:36:33,709 sdr._calculate_bar_factor(866) INFO 82.6% complete 2019-06-04 00:36:43,786 sdr._calculate_bar_factor(866) INFO 82.6% complete 2019-06-04 00:36:49,003 sdr._calculate_bar_factor(866) INFO 83.7% complete 2019-06-04 00:36:55,128 sdr._calculate_bar_factor(866) INFO 85.9% complete 2019-06-04 00:37:04,535 sdr._calculate_bar_factor(866) INFO 85.9% complete 2019-06-04 00:37:10,003 sdr._calculate_bar_factor(866) INFO 88.2% complete 2019-06-04 00:37:16,003 sdr._calculate_bar_factor(866) INFO 88.2% complete 2019-06-04 00:37:22,017 sdr._calculate_bar_factor(866) INFO 89.3% complete 2019-06-04 00:37:28,177 sdr._calculate_bar_factor(866) INFO 89.3% complete 2019-06-04 00:37:34,973 sdr._calculate_bar_factor(866) INFO 92.6% complete 2019-06-04 00:55:42,805 sdr._calculate_bar_factor(866) INFO 99.3% complete 2019-06-04 00:55:48,150 sdr._calculate_bar_factor(866) INFO 99.3% complete 2019-06-04 00:55:51,211 sdr._calculate_bar_factor(866) INFO 100.0% complete 2019-06-04 00:55:51,259 geoprocessing.raster_calculator(366) INFO starting stats_worker 2019-06-04 00:55:51,259 geoprocessing.raster_calculator(372) INFO started stats_worker 2019-06-04 00:55:56,289 geoprocessing.(442) INFO 3.0% complete 2019-06-04 00:56:01,321 geoprocessing.(442) INFO 5.8% complete 2019-06-04 00:56:06,335 geoprocessing.(442) INFO 8.1% complete 2019-06-04 00:56:11,351 geoprocessing.(442) INFO 10.4% complete 2019-06-04 00:56:16,381 geoprocessing.(442) INFO 12.5% complete 2019-06-04 00:56:21,398 geoprocessing.(442) INFO 14.6% complete 2019-06-04 00:56:26,428 geoprocessing.(442) INFO 16.5% complete 2019-06-04 00:56:31,474 geoprocessing.(442) INFO 18.1% complete 2019-06-04 00:56:36,490 geoprocessing.(442) INFO 19.7% complete 2019-06-04 00:56:41,520 geoprocessing.(442) INFO 21.4% complete 2019-06-04 00:56:46,552 geoprocessing.(442) INFO 22.9% complete 2019-06-04 00:56:51,582 geoprocessing.(442) INFO 24.6% complete 2019-06-04 00:56:56,614 geoprocessing.(442) INFO 26.1% complete 2019-06-04 00:57:01,630 geoprocessing.(442) INFO 27.9% complete 2019-06-04 00:57:06,644 geoprocessing.(442) INFO 29.4% complete 2019-06-04 00:57:11,660 geoprocessing.(442) INFO 30.9% complete 2019-06-04 00:57:16,676 geoprocessing.(442) INFO 32.3% complete 2019-06-04 00:57:21,690 geoprocessing.(442) INFO 33.5% complete 2019-06-04 00:57:26,733 geoprocessing.(442) INFO 34.6% complete 2019-06-04 00:57:31,750 geoprocessing.(442) INFO 35.6% complete 2019-06-04 00:57:36,765 geoprocessing.(442) INFO 36.6% complete 2019-06-04 00:57:41,796 geoprocessing.(442) INFO 37.6% complete 2019-06-04 00:57:46,812 geoprocessing.(442) INFO 38.5% complete 2019-06-04 00:57:51,858 geoprocessing.(442) INFO 39.5% complete 2019-06-04 00:57:56,874 geoprocessing.(442) INFO 40.4% complete 2019-06-04 00:58:01,888 geoprocessing.(442) INFO 41.3% complete 2019-06-04 00:58:06,904 geoprocessing.(442) INFO 42.2% complete 2019-06-04 00:58:11,920 geoprocessing.(442) INFO 43.1% complete 2019-06-04 00:58:16,966 geoprocessing.(442) INFO 43.9% complete 2019-06-04 00:58:21,996 geoprocessing.(442) INFO 44.8% complete 2019-06-04 00:58:27,012 geoprocessing.(442) INFO 45.7% complete 2019-06-04 00:58:32,059 geoprocessing.(442) INFO 46.6% complete 2019-06-04 00:58:37,105 geoprocessing.(442) INFO 47.4% complete 2019-06-04 00:58:42,151 geoprocessing.(442) INFO 48.2% complete 2019-06-04 00:58:47,198 geoprocessing.(442) INFO 49.0% complete 2019-06-04 00:58:52,260 geoprocessing.(442) INFO 49.9% complete 2019-06-04 00:58:57,276 geoprocessing.(442) INFO 50.7% complete 2019-06-04 00:59:02,338 geoprocessing.(442) INFO 51.5% complete 2019-06-04 00:59:07,354 geoprocessing.(442) INFO 52.4% complete 2019-06-04 00:59:12,368 geoprocessing.(442) INFO 53.2% complete 2019-06-04 00:59:17,400 geoprocessing.(442) INFO 54.0% complete 2019-06-04 00:59:22,414 geoprocessing.(442) INFO 54.9% complete 2019-06-04 00:59:27,461 geoprocessing.(442) INFO 55.7% complete 2019-06-04 00:59:32,493 geoprocessing.(442) INFO 56.6% complete 2019-06-04 00:59:37,507 geoprocessing.(442) INFO 57.5% complete 2019-06-04 00:59:42,523 geoprocessing.(442) INFO 58.4% complete 2019-06-04 00:59:47,539 geoprocessing.(442) INFO 59.3% complete 2019-06-04 00:59:52,569 geoprocessing.(442) INFO 60.3% complete 2019-06-04 00:59:57,601 geoprocessing.(442) INFO 61.2% complete 2019-06-04 01:00:02,615 geoprocessing.(442) INFO 62.1% complete 2019-06-04 01:00:07,677 geoprocessing.(442) INFO 63.1% complete 2019-06-04 01:00:12,694 geoprocessing.(442) INFO 64.1% complete 2019-06-04 01:00:17,709 geoprocessing.(442) INFO 65.0% complete 2019-06-04 01:00:22,723 geoprocessing.(442) INFO 66.0% complete 2019-06-04 01:00:27,755 geoprocessing.(442) INFO 66.9% complete 2019-06-04 01:00:32,770 geoprocessing.(442) INFO 67.9% complete 2019-06-04 01:00:37,786 geoprocessing.(442) INFO 68.9% complete 2019-06-04 01:00:42,832 geoprocessing.(442) INFO 69.8% complete 2019-06-04 01:00:47,848 geoprocessing.(442) INFO 70.9% complete 2019-06-04 01:00:52,894 geoprocessing.(442) INFO 71.9% complete 2019-06-04 01:00:57,940 geoprocessing.(442) INFO 72.9% complete 2019-06-04 01:01:02,971 geoprocessing.(442) INFO 73.9% complete 2019-06-04 01:01:07,986 geoprocessing.(442) INFO 74.9% complete 2019-06-04 01:01:13,017 geoprocessing.(442) INFO 75.9% complete 2019-06-04 01:01:18,049 geoprocessing.(442) INFO 77.0% complete 2019-06-04 01:01:23,065 geoprocessing.(442) INFO 78.1% complete 2019-06-04 01:01:28,079 geoprocessing.(442) INFO 79.3% complete 2019-06-04 01:01:33,095 geoprocessing.(442) INFO 80.5% complete 2019-06-04 01:01:38,125 geoprocessing.(442) INFO 81.9% complete 2019-06-04 01:01:43,141 geoprocessing.(442) INFO 83.5% complete 2019-06-04 01:01:48,173 geoprocessing.(442) INFO 85.2% complete 2019-06-04 01:01:53,187 geoprocessing.(442) INFO 86.9% complete 2019-06-04 01:01:58,203 geoprocessing.(442) INFO 89.0% complete 2019-06-04 01:02:03,219 geoprocessing.(442) INFO 91.3% complete 2019-06-04 01:02:08,233 geoprocessing.(442) INFO 94.0% complete 2019-06-04 01:02:13,249 geoprocessing.(442) INFO 97.0% complete 2019-06-04 01:02:17,967 geoprocessing.raster_calculator(445) INFO 100.0%% complete 2019-06-04 01:02:17,967 geoprocessing.raster_calculator(448) INFO signaling stats worker to terminate 2019-06-04 01:02:17,967 geoprocessing.raster_calculator(450) INFO Waiting for raster stats worker result. 2019-06-04 01:02:17,967 threading.run(754) DEBUG payload is None, terminating 2019-06-04 01:03:01,948 geoprocessing.raster_calculator(366) INFO starting stats_worker 2019-06-04 01:03:01,948 geoprocessing.raster_calculator(372) INFO started stats_worker 2019-06-04 01:03:06,963 geoprocessing.(442) INFO 4.2% complete 2019-06-04 01:03:11,979 geoprocessing.(442) INFO 7.4% complete 2019-06-04 01:03:17,009 geoprocessing.(442) INFO 10.3% complete 2019-06-04 01:03:22,026 geoprocessing.(442) INFO 12.8% complete 2019-06-04 01:03:27,040 geoprocessing.(442) INFO 15.3% complete 2019-06-04 01:03:32,045 geoprocessing.(442) INFO 17.9% complete 2019-06-04 01:03:37,075 geoprocessing.(442) INFO 20.3% complete 2019-06-04 01:03:42,107 geoprocessing.(442) INFO 22.6% complete 2019-06-04 01:03:47,121 geoprocessing.(442) INFO 25.0% complete 2019-06-04 01:03:52,137 geoprocessing.(442) INFO 27.4% complete 2019-06-04 01:03:57,153 geoprocessing.(442) INFO 29.9% complete 2019-06-04 01:04:02,167 geoprocessing.(442) INFO 32.0% complete 2019-06-04 01:04:07,183 geoprocessing.(442) INFO 33.8% complete 2019-06-04 01:04:12,246 geoprocessing.(442) INFO 35.4% complete 2019-06-04 01:04:17,260 geoprocessing.(442) INFO 36.8% complete 2019-06-04 01:04:22,276 geoprocessing.(442) INFO 38.1% complete 2019-06-04 01:04:27,306 geoprocessing.(442) INFO 39.3% complete 2019-06-04 01:04:32,354 geoprocessing.(442) INFO 40.5% complete 2019-06-04 01:04:37,415 geoprocessing.(442) INFO 41.6% complete 2019-06-04 01:04:42,447 geoprocessing.(442) INFO 42.8% complete 2019-06-04 01:04:47,461 geoprocessing.(442) INFO 43.9% complete 2019-06-04 01:04:52,509 geoprocessing.(442) INFO 45.0% complete 2019-06-04 01:04:57,523 geoprocessing.(442) INFO 46.1% complete 2019-06-04 01:05:02,585 geoprocessing.(442) INFO 47.2% complete 2019-06-04 01:05:07,617 geoprocessing.(442) INFO 48.3% complete 2019-06-04 01:05:12,664 geoprocessing.(442) INFO 49.4% complete 2019-06-04 01:05:17,710 geoprocessing.(442) INFO 50.4% complete 2019-06-04 01:05:22,740 geoprocessing.(442) INFO 51.5% complete 2019-06-04 01:05:27,788 geoprocessing.(442) INFO 52.6% complete 2019-06-04 01:05:32,819 geoprocessing.(442) INFO 53.7% complete 2019-06-04 01:05:37,849 geoprocessing.(442) INFO 54.8% complete 2019-06-04 01:05:42,897 geoprocessing.(442) INFO 55.9% complete 2019-06-04 01:05:47,943 geoprocessing.(442) INFO 57.1% complete 2019-06-04 01:05:52,990 geoprocessing.(442) INFO 58.3% complete 2019-06-04 01:05:58,020 geoprocessing.(442) INFO 59.5% complete 2019-06-04 01:06:03,066 geoprocessing.(442) INFO 60.7% complete 2019-06-04 01:06:08,098 geoprocessing.(442) INFO 61.9% complete 2019-06-04 01:06:13,114 geoprocessing.(442) INFO 63.1% complete 2019-06-04 01:06:18,144 geoprocessing.(442) INFO 64.4% complete 2019-06-04 01:06:23,190 geoprocessing.(442) INFO 65.7% complete 2019-06-04 01:06:28,221 geoprocessing.(442) INFO 67.0% complete 2019-06-04 01:06:33,253 geoprocessing.(442) INFO 68.3% complete 2019-06-04 01:06:38,267 geoprocessing.(442) INFO 69.5% complete 2019-06-04 01:06:43,283 geoprocessing.(442) INFO 70.8% complete 2019-06-04 01:06:48,315 geoprocessing.(442) INFO 72.1% complete 2019-06-04 01:06:53,345 geoprocessing.(442) INFO 73.5% complete 2019-06-04 01:06:58,377 geoprocessing.(442) INFO 75.0% complete 2019-06-04 01:07:03,391 geoprocessing.(442) INFO 76.4% complete 2019-06-04 01:07:08,407 geoprocessing.(442) INFO 78.2% complete 2019-06-04 01:07:13,423 geoprocessing.(442) INFO 80.2% complete 2019-06-04 01:07:18,437 geoprocessing.(442) INFO 82.9% complete 2019-06-04 01:07:23,453 geoprocessing.(442) INFO 85.8% complete 2019-06-04 01:07:28,460 geoprocessing.(442) INFO 89.6% complete 2019-06-04 01:07:33,492 geoprocessing.(442) INFO 93.7% complete 2019-06-04 01:07:38,507 geoprocessing.(442) INFO 97.7% complete 2019-06-04 01:07:41,694 geoprocessing.raster_calculator(445) INFO 100.0%% complete 2019-06-04 01:07:41,694 geoprocessing.raster_calculator(448) INFO signaling stats worker to terminate 2019-06-04 01:07:41,694 threading.run(754) DEBUG payload is None, terminating 2019-06-04 01:07:41,694 geoprocessing.raster_calculator(450) INFO Waiting for raster stats worker result. 2019-06-04 01:07:50,678 geoprocessing.raster_calculator(366) INFO starting stats_worker 2019-06-04 01:07:50,678 geoprocessing.raster_calculator(372) INFO started stats_worker 2019-06-04 01:07:55,694 geoprocessing.(442) INFO 6.9% complete 2019-06-04 01:08:00,724 geoprocessing.(442) INFO 10.9% complete 2019-06-04 01:08:05,740 geoprocessing.(442) INFO 14.4% complete 2019-06-04 01:08:10,756 geoprocessing.(442) INFO 18.0% complete 2019-06-04 01:08:15,770 geoprocessing.(442) INFO 21.0% complete 2019-06-04 01:08:20,818 geoprocessing.(442) INFO 24.2% complete 2019-06-04 01:08:25,832 geoprocessing.(442) INFO 27.4% complete 2019-06-04 01:08:30,880 geoprocessing.(442) INFO 30.7% complete 2019-06-04 01:08:35,911 geoprocessing.(442) INFO 33.2% complete 2019-06-04 01:08:40,926 geoprocessing.(442) INFO 35.4% complete 2019-06-04 01:08:45,957 geoprocessing.(442) INFO 37.2% complete 2019-06-04 01:08:50,971 geoprocessing.(442) INFO 38.7% complete 2019-06-04 01:08:56,003 geoprocessing.(442) INFO 40.3% complete 2019-06-04 01:09:01,017 geoprocessing.(442) INFO 41.6% complete 2019-06-04 01:09:06,065 geoprocessing.(442) INFO 42.9% complete 2019-06-04 01:09:11,095 geoprocessing.(442) INFO 44.2% complete 2019-06-04 01:09:16,142 geoprocessing.(442) INFO 45.5% complete 2019-06-04 01:09:21,157 geoprocessing.(442) INFO 46.8% complete 2019-06-04 01:09:26,188 geoprocessing.(442) INFO 48.2% complete 2019-06-04 01:09:31,220 geoprocessing.(442) INFO 49.4% complete 2019-06-04 01:09:36,250 geoprocessing.(442) INFO 50.7% complete 2019-06-04 01:09:41,296 geoprocessing.(442) INFO 51.9% complete 2019-06-04 01:09:46,312 geoprocessing.(442) INFO 53.2% complete 2019-06-04 01:09:51,328 geoprocessing.(442) INFO 54.5% complete 2019-06-04 01:09:56,342 geoprocessing.(442) INFO 55.8% complete 2019-06-04 01:10:01,390 geoprocessing.(442) INFO 57.3% complete 2019-06-04 01:10:06,437 geoprocessing.(442) INFO 58.7% complete 2019-06-04 01:10:11,451 geoprocessing.(442) INFO 60.1% complete 2019-06-04 01:10:16,467 geoprocessing.(442) INFO 61.7% complete 2019-06-04 01:10:21,513 geoprocessing.(442) INFO 63.1% complete 2019-06-04 01:10:26,529 geoprocessing.(442) INFO 64.5% complete 2019-06-04 01:10:31,575 geoprocessing.(442) INFO 66.2% complete 2019-06-04 01:10:36,591 geoprocessing.(442) INFO 67.6% complete 2019-06-04 01:10:41,605 geoprocessing.(442) INFO 69.0% complete 2019-06-04 01:10:46,621 geoprocessing.(442) INFO 70.8% complete 2019-06-04 01:10:51,653 geoprocessing.(442) INFO 72.2% complete 2019-06-04 01:10:56,667 geoprocessing.(442) INFO 74.0% complete 2019-06-04 01:11:01,683 geoprocessing.(442) INFO 75.6% complete 2019-06-04 01:11:06,713 geoprocessing.(442) INFO 77.9% complete 2019-06-04 01:11:11,730 geoprocessing.(442) INFO 81.1% complete 2019-06-04 01:11:16,744 geoprocessing.(442) INFO 85.8% complete 2019-06-04 01:11:21,759 geoprocessing.(442) INFO 93.1% complete 2019-06-04 01:11:26,776 geoprocessing.(442) INFO 99.9% complete 2019-06-04 01:11:26,838 geoprocessing.raster_calculator(445) INFO 100.0%% complete 2019-06-04 01:11:26,838 geoprocessing.raster_calculator(448) INFO signaling stats worker to terminate 2019-06-04 01:11:26,854 threading.run(754) DEBUG payload is None, terminating 2019-06-04 01:11:26,838 geoprocessing.raster_calculator(450) INFO Waiting for raster stats worker result. 2019-06-04 01:11:40,977 geoprocessing.(918) INFO 8.0% complete 2019-06-04 01:11:45,993 geoprocessing.(918) INFO 14.6% complete 2019-06-04 01:11:51,009 geoprocessing.(918) INFO 22.2% complete 2019-06-04 01:11:56,023 geoprocessing.(918) INFO 30.4% complete 2019-06-04 01:12:01,039 geoprocessing.(918) INFO 38.6% complete 2019-06-04 01:12:06,055 geoprocessing.(918) INFO 46.8% complete 2019-06-04 01:12:11,069 geoprocessing.(918) INFO 54.9% complete 2019-06-04 01:12:16,085 geoprocessing.(918) INFO 63.2% complete 2019-06-04 01:12:21,099 geoprocessing.(918) INFO 71.6% complete 2019-06-04 01:12:26,115 geoprocessing.(918) INFO 79.2% complete 2019-06-04 01:12:31,130 geoprocessing.(918) INFO 86.8% complete 2019-06-04 01:12:36,144 geoprocessing.(918) INFO 94.9% complete 2019-06-04 01:12:40,426 Task._call(1068) INFO 0.0% complete 2019-06-04 01:12:46,035 Task._call(1068) INFO 2.2% complete 2019-06-04 01:12:52,035 Task._call(1068) INFO 3.3% complete 2019-06-04 01:12:58,003 Task._call(1068) INFO 4.5% complete 2019-06-04 01:13:04,065 Task._call(1068) INFO 4.5% complete 2019-06-04 01:13:10,190 Task._call(1068) INFO 5.6% complete 2019-06-04 01:13:16,329 Task._call(1068) INFO 6.7% complete 2019-06-04 01:13:22,002 Task._call(1068) INFO 6.7% complete 2019-06-04 01:13:28,016 Task._call(1068) INFO 7.8% complete 2019-06-04 01:13:34,157 Task._call(1068) INFO 8.9% complete 2019-06-04 01:13:40,250 Task._call(1068) INFO 8.9% complete 2019-06-04 01:13:46,187 Task._call(1068) INFO 10.0% complete 2019-06-04 01:13:52,187 Task._call(1068) INFO 10.0% complete 2019-06-04 01:13:58,217 Task._call(1068) INFO 11.2% complete 2019-06-04 01:14:04,062 Task._call(1068) INFO 11.2% complete 2019-06-04 01:14:10,296 Task._call(1068) INFO 12.3% complete 2019-06-04 01:14:16,170 Task._call(1068) INFO 12.3% complete 2019-06-04 01:14:22,075 Task._call(1068) INFO 13.4% complete 2019-06-04 01:14:28,279 Task._call(1068) INFO 13.4% complete 2019-06-04 01:14:34,121 Task._call(1068) INFO 14.5% complete 2019-06-04 01:14:40,230 Task._call(1068) INFO 14.5% complete 2019-06-04 01:14:46,059 Task._call(1068) INFO 15.6% complete 2019-06-04 01:14:52,105 Task._call(1068) INFO 15.6% complete 2019-06-04 01:14:58,276 Task._call(1068) INFO 16.7% complete 2019-06-04 01:15:04,198 Task._call(1068) INFO 16.7% complete 2019-06-04 01:15:10,308 Task._call(1068) INFO 17.9% complete 2019-06-04 01:15:16,151 Task._call(1068) INFO 17.9% complete 2019-06-04 01:15:22,276 Task._call(1068) INFO 17.9% complete 2019-06-04 01:15:28,181 Task._call(1068) INFO 19.0% complete 2019-06-04 01:15:34,055 Task._call(1068) INFO 19.0% complete 2019-06-04 01:15:40,305 Task._call(1068) INFO 20.1% complete 2019-06-04 01:15:46,071 Task._call(1068) INFO 20.1% complete 2019-06-04 01:15:52,007 Task._call(1068) INFO 21.2% complete 2019-06-04 01:15:58,164 Task._call(1068) INFO 21.2% complete 2019-06-04 01:16:04,069 Task._call(1068) INFO 22.3% complete 2019-06-04 01:16:10,039 Task._call(1068) INFO 22.3% complete 2019-06-04 01:16:16,006 Task._call(1068) INFO 23.4% complete 2019-06-04 01:16:22,038 Task._call(1068) INFO 23.4% complete 2019-06-04 01:16:28,006 Task._call(1068) INFO 24.5% complete 2019-06-04 01:16:34,161 Task._call(1068) INFO 24.6% complete 2019-06-04 01:16:40,068 Task._call(1068) INFO 24.6% complete 2019-06-04 01:16:46,161 Task._call(1068) INFO 25.7% complete 2019-06-04 01:16:52,005 Task._call(1068) INFO 25.7% complete 2019-06-04 01:16:58,161 Task._call(1068) INFO 26.8% complete 2019-06-04 01:17:04,144 Task._call(1068) INFO 26.8% complete 2019-06-04 01:17:10,176 Task._call(1068) INFO 27.9% complete 2019-06-04 01:17:16,003 Task._call(1068) INFO 27.9% complete 2019-06-04 01:17:22,065 Task._call(1068) INFO 29.0% complete 2019-06-04 01:17:28,391 Task._call(1068) INFO 29.0% complete 2019-06-04 01:17:34,016 Task._call(1068) INFO 30.1% complete 2019-06-04 01:17:40,062 Task._call(1068) INFO 30.1% complete 2019-06-04 01:17:46,078 Task._call(1068) INFO 30.1% complete 2019-06-04 01:17:52,046 Task._call(1068) INFO 31.2% complete 2019-06-04 01:17:58,125 Task._call(1068) INFO 31.2% complete 2019-06-04 01:18:04,279 Task._call(1068) INFO 31.2% complete 2019-06-04 01:18:10,233 Task._call(1068) INFO 31.2% complete 2019-06-04 01:18:16,092 Task._call(1068) INFO 32.4% complete 2019-06-04 01:18:22,200 Task._call(1068) INFO 32.4% complete 2019-06-04 01:18:28,420 Task._call(1068) INFO 32.4% complete 2019-06-04 01:18:34,184 Task._call(1068) INFO 32.4% complete 2019-06-04 01:18:40,638 Task._call(1068) INFO 33.5% complete 2019-06-04 01:18:46,121 Task._call(1068) INFO 33.5% complete 2019-06-04 01:18:52,089 Task._call(1068) INFO 33.5% complete 2019-06-04 01:18:58,089 Task._call(1068) INFO 33.5% complete 2019-06-04 01:19:04,135 Task._call(1068) INFO 34.6% complete 2019-06-04 01:19:10,276 Task._call(1068) INFO 34.6% complete 2019-06-04 01:19:16,229 Task._call(1068) INFO 34.6% complete 2019-06-04 01:19:22,276 Task._call(1068) INFO 34.6% complete 2019-06-04 01:19:28,009 Task._call(1068) INFO 34.6% complete 2019-06-04 01:19:34,118 Task._call(1068) INFO 35.7% complete 2019-06-04 01:19:40,150 Task._call(1068) INFO 35.7% complete 2019-06-04 01:19:46,259 Task._call(1068) INFO 35.7% complete 2019-06-04 01:19:52,134 Task._call(1068) INFO 35.7% complete 2019-06-04 01:19:58,007 Task._call(1068) INFO 35.7% complete 2019-06-04 01:20:04,007 Task._call(1068) INFO 36.8% complete 2019-06-04 01:20:10,053 Task._call(1068) INFO 36.8% complete 2019-06-04 01:20:16,085 Task._call(1068) INFO 36.8% complete 2019-06-04 01:20:22,101 Task._call(1068) INFO 36.8% complete 2019-06-04 01:20:28,038 Task._call(1068) INFO 36.8% complete 2019-06-04 01:20:34,194 Task._call(1068) INFO 37.9% complete 2019-06-04 01:20:40,131 Task._call(1068) INFO 37.9% complete 2019-06-04 01:20:46,145 Task._call(1068) INFO 37.9% complete 2019-06-04 01:20:52,145 Task._call(1068) INFO 37.9% complete 2019-06-04 01:20:58,177 Task._call(1068) INFO 37.9% complete 2019-06-04 01:21:04,176 Task._call(1068) INFO 39.1% complete 2019-06-04 01:21:10,269 Task._call(1068) INFO 39.1% complete 2019-06-04 01:21:16,190 Task._call(1068) INFO 39.1% complete 2019-06-04 01:21:22,096 Task._call(1068) INFO 39.1% complete 2019-06-04 01:21:28,128 Task._call(1068) INFO 39.1% complete 2019-06-04 01:21:34,220 Task._call(1068) INFO 40.2% complete 2019-06-04 01:21:40,282 Task._call(1068) INFO 40.2% complete 2019-06-04 01:21:46,032 Task._call(1068) INFO 40.2% complete 2019-06-04 01:21:52,079 Task._call(1068) INFO 40.2% complete 2019-06-04 01:21:58,048 Task._call(1068) INFO 40.2% complete 2019-06-04 01:22:04,048 Task._call(1068) INFO 40.2% complete 2019-06-04 01:22:10,125 Task._call(1068) INFO 41.3% complete 2019-06-04 01:22:16,078 Task._call(1068) INFO 41.3% complete 2019-06-04 01:22:22,390 Task._call(1068) INFO 41.3% complete 2019-06-04 01:22:28,111 Task._call(1068) INFO 41.3% complete 2019-06-04 01:22:34,078 Task._call(1068) INFO 41.3% complete 2019-06-04 01:22:40,171 Task._call(1068) INFO 41.3% complete 2019-06-04 01:22:46,109 Task._call(1068) INFO 42.4% complete 2019-06-04 01:22:52,046 Task._call(1068) INFO 42.4% complete 2019-06-04 01:22:58,249 Task._call(1068) INFO 42.4% complete 2019-06-04 01:23:04,249 Task._call(1068) INFO 42.4% complete 2019-06-04 01:23:10,671 Task._call(1068) INFO 42.4% complete 2019-06-04 01:23:16,326 Task._call(1068) INFO 43.5% complete 2019-06-04 01:23:22,092 Task._call(1068) INFO 43.5% complete 2019-06-04 01:23:28,059 Task._call(1068) INFO 43.5% complete 2019-06-04 01:23:34,043 Task._call(1068) INFO 43.5% complete 2019-06-04 01:23:40,121 Task._call(1068) INFO 43.5% complete 2019-06-04 01:23:46,246 Task._call(1068) INFO 43.5% complete 2019-06-04 01:23:52,059 Task._call(1068) INFO 44.6% complete 2019-06-04 01:23:58,121 Task._call(1068) INFO 44.6% complete 2019-06-04 01:24:04,198 Task._call(1068) INFO 44.6% complete 2019-06-04 01:24:10,244 Task._call(1068) INFO 44.6% complete 2019-06-04 01:24:16,026 Task._call(1068) INFO 44.6% complete 2019-06-04 01:24:22,322 Task._call(1068) INFO 44.6% complete 2019-06-04 01:24:28,072 Task._call(1068) INFO 44.6% complete 2019-06-04 01:24:34,150 Task._call(1068) INFO 45.7% complete 2019-06-04 01:24:40,134 Task._call(1068) INFO 45.7% complete 2019-06-04 01:24:46,039 Task._call(1068) INFO 45.8% complete 2019-06-04 01:24:52,336 Task._call(1068) INFO 45.8% complete 2019-06-04 01:24:58,005 Task._call(1068) INFO 45.8% complete 2019-06-04 01:25:04,052 Task._call(1068) INFO 45.8% complete 2019-06-04 01:25:10,176 Task._call(1068) INFO 46.9% complete 2019-06-04 01:25:16,019 Task._call(1068) INFO 46.9% complete 2019-06-04 01:25:22,082 Task._call(1068) INFO 46.9% complete 2019-06-04 01:25:28,128 Task._call(1068) INFO 46.9% complete 2019-06-04 01:25:34,253 Task._call(1068) INFO 46.9% complete 2019-06-04 01:25:40,049 Task._call(1068) INFO 46.9% complete 2019-06-04 01:25:46,174 Task._call(1068) INFO 48.0% complete 2019-06-04 01:25:52,111 Task._call(1068) INFO 48.0% complete 2019-06-04 01:25:58,032 Task._call(1068) INFO 48.0% complete 2019-06-04 01:26:04,048 Task._call(1068) INFO 48.0% complete 2019-06-04 01:26:10,000 Task._call(1068) INFO 48.0% complete 2019-06-04 01:26:16,062 Task._call(1068) INFO 48.0% complete 2019-06-04 01:26:22,344 Task._call(1068) INFO 49.1% complete 2019-06-04 01:26:28,125 Task._call(1068) INFO 49.1% complete 2019-06-04 01:26:34,171 Task._call(1068) INFO 49.1% complete 2019-06-04 01:26:40,187 Task._call(1068) INFO 49.1% complete 2019-06-04 01:26:46,171 Task._call(1068) INFO 49.1% complete 2019-06-04 01:26:52,124 Task._call(1068) INFO 49.1% complete 2019-06-04 01:26:58,217 Task._call(1068) INFO 50.2% complete 2019-06-04 01:27:04,107 Task._call(1068) INFO 50.2% complete 2019-06-04 01:27:10,122 Task._call(1068) INFO 50.2% complete 2019-06-04 01:27:16,138 Task._call(1068) INFO 50.2% complete 2019-06-04 01:27:22,168 Task._call(1068) INFO 50.2% complete 2019-06-04 01:27:28,200 Task._call(1068) INFO 50.2% complete 2019-06-04 01:27:34,089 Task._call(1068) INFO 51.3% complete 2019-06-04 01:27:40,058 Task._call(1068) INFO 51.3% complete 2019-06-04 01:27:46,260 Task._call(1068) INFO 51.3% complete 2019-06-04 01:27:52,260 Task._call(1068) INFO 51.3% complete 2019-06-04 01:27:58,197 Task._call(1068) INFO 51.3% complete 2019-06-04 01:28:04,009 Task._call(1068) INFO 52.4% complete 2019-06-04 01:28:10,040 Task._call(1068) INFO 52.4% complete 2019-06-04 01:28:16,165 Task._call(1068) INFO 52.4% complete 2019-06-04 01:28:22,164 Task._call(1068) INFO 52.4% complete 2019-06-04 01:28:28,134 Task._call(1068) INFO 52.4% complete 2019-06-04 01:28:34,039 Task._call(1068) INFO 52.4% complete 2019-06-04 01:28:40,210 Task._call(1068) INFO 53.6% complete 2019-06-04 01:28:46,187 Task._call(1068) INFO 53.6% complete 2019-06-04 01:28:52,265 Task._call(1068) INFO 53.6% complete 2019-06-04 01:28:58,046 Task._call(1068) INFO 53.6% complete 2019-06-04 01:29:04,029 Task._call(1068) INFO 53.6% complete 2019-06-04 01:29:10,124 Task._call(1068) INFO 53.6% complete 2019-06-04 01:29:16,358 Task._call(1068) INFO 54.7% complete 2019-06-04 01:29:22,170 Task._call(1068) INFO 54.7% complete 2019-06-04 01:29:28,216 Task._call(1068) INFO 54.7% complete 2019-06-04 01:29:34,200 Task._call(1068) INFO 54.7% complete 2019-06-04 01:29:40,075 Task._call(1068) INFO 54.7% complete 2019-06-04 01:29:46,137 Task._call(1068) INFO 54.7% complete 2019-06-04 01:29:52,151 Task._call(1068) INFO 55.8% complete 2019-06-04 01:29:58,135 Task._call(1068) INFO 55.8% complete 2019-06-04 01:30:04,198 Task._call(1068) INFO 55.8% complete 2019-06-04 01:30:10,058 Task._call(1068) INFO 55.8% complete 2019-06-04 01:30:16,259 Task._call(1068) INFO 55.8% complete 2019-06-04 01:30:22,040 Task._call(1068) INFO 55.8% complete 2019-06-04 01:30:28,072 Task._call(1068) INFO 56.9% complete 2019-06-04 01:30:34,165 Task._call(1068) INFO 56.9% complete 2019-06-04 01:30:40,321 Task._call(1068) INFO 56.9% complete 2019-06-04 01:30:46,461 Task._call(1068) INFO 56.9% complete 2019-06-04 01:30:52,180 Task._call(1068) INFO 56.9% complete 2019-06-04 01:30:58,069 Task._call(1068) INFO 56.9% complete 2019-06-04 01:31:04,164 Task._call(1068) INFO 58.0% complete 2019-06-04 01:31:10,148 Task._call(1068) INFO 58.0% complete 2019-06-04 01:31:16,147 Task._call(1068) INFO 58.0% complete 2019-06-04 01:31:22,240 Task._call(1068) INFO 58.0% complete 2019-06-04 01:31:28,240 Task._call(1068) INFO 58.0% complete 2019-06-04 01:31:34,052 Task._call(1068) INFO 59.1% complete 2019-06-04 01:31:40,193 Task._call(1068) INFO 59.1% complete 2019-06-04 01:31:46,193 Task._call(1068) INFO 59.1% complete 2019-06-04 01:31:52,177 Task._call(1068) INFO 59.1% complete 2019-06-04 01:31:58,223 Task._call(1068) INFO 59.1% complete 2019-06-04 01:32:04,035 Task._call(1068) INFO 60.3% complete 2019-06-04 01:32:10,144 Task._call(1068) INFO 60.3% complete 2019-06-04 01:32:16,128 Task._call(1068) INFO 60.3% complete 2019-06-04 01:32:22,174 Task._call(1068) INFO 60.3% complete 2019-06-04 01:32:28,190 Task._call(1068) INFO 60.3% complete 2019-06-04 01:32:34,118 Task._call(1068) INFO 60.3% complete 2019-06-04 01:32:40,273 Task._call(1068) INFO 61.4% complete 2019-06-04 01:32:46,007 Task._call(1068) INFO 61.4% complete 2019-06-04 01:32:52,148 Task._call(1068) INFO 61.4% complete 2019-06-04 01:32:58,210 Task._call(1068) INFO 61.4% complete 2019-06-04 01:33:04,131 Task._call(1068) INFO 61.4% complete 2019-06-04 01:33:10,131 Task._call(1068) INFO 62.5% complete 2019-06-04 01:33:16,038 Task._call(1068) INFO 62.5% complete 2019-06-04 01:33:22,036 Task._call(1068) INFO 62.5% complete 2019-06-04 01:33:28,115 Task._call(1068) INFO 62.5% complete 2019-06-04 01:33:34,130 Task._call(1068) INFO 62.5% complete 2019-06-04 01:33:40,036 Task._call(1068) INFO 63.6% complete 2019-06-04 01:33:46,207 Task._call(1068) INFO 63.6% complete 2019-06-04 01:33:52,269 Task._call(1068) INFO 63.6% complete 2019-06-04 01:33:58,098 Task._call(1068) INFO 63.6% complete 2019-06-04 01:34:04,160 Task._call(1068) INFO 63.6% complete 2019-06-04 01:34:10,144 Task._call(1068) INFO 64.7% complete 2019-06-04 01:34:16,549 Task._call(1068) INFO 64.7% complete 2019-06-04 01:34:22,253 Task._call(1068) INFO 64.7% complete 2019-06-04 01:34:28,174 Task._call(1068) INFO 64.7% complete 2019-06-04 01:34:34,174 Task._call(1068) INFO 64.7% complete 2019-06-04 01:34:40,127 Task._call(1068) INFO 65.8% complete 2019-06-04 01:34:46,016 Task._call(1068) INFO 65.8% complete 2019-06-04 01:34:52,157 Task._call(1068) INFO 65.8% complete 2019-06-04 01:34:58,266 Task._call(1068) INFO 65.8% complete 2019-06-04 01:35:04,328 Task._call(1068) INFO 65.8% complete 2019-06-04 01:35:10,015 Task._call(1068) INFO 66.9% complete 2019-06-04 01:35:16,015 Task._call(1068) INFO 67.0% complete 2019-06-04 01:35:22,029 Task._call(1068) INFO 67.0% complete 2019-06-04 01:35:28,154 Task._call(1068) INFO 67.0% complete 2019-06-04 01:35:34,201 Task._call(1068) INFO 67.0% complete 2019-06-04 01:35:40,029 Task._call(1068) INFO 68.1% complete 2019-06-04 01:35:46,013 Task._call(1068) INFO 68.1% complete 2019-06-04 01:35:52,043 Task._call(1068) INFO 68.1% complete 2019-06-04 01:35:58,121 Task._call(1068) INFO 68.1% complete 2019-06-04 01:36:04,184 Task._call(1068) INFO 68.1% complete 2019-06-04 01:36:10,184 Task._call(1068) INFO 69.2% complete 2019-06-04 01:36:16,230 Task._call(1068) INFO 69.2% complete 2019-06-04 01:36:22,135 Task._call(1068) INFO 69.2% complete 2019-06-04 01:36:28,010 Task._call(1068) INFO 69.2% complete 2019-06-04 01:36:34,088 Task._call(1068) INFO 70.3% complete 2019-06-04 01:36:40,181 Task._call(1068) INFO 70.3% complete 2019-06-04 01:36:46,040 Task._call(1068) INFO 70.3% complete 2019-06-04 01:36:52,134 Task._call(1068) INFO 70.3% complete 2019-06-04 01:36:58,150 Task._call(1068) INFO 70.3% complete 2019-06-04 01:37:04,023 Task._call(1068) INFO 71.4% complete 2019-06-04 01:37:10,148 Task._call(1068) INFO 71.4% complete 2019-06-04 01:37:16,196 Task._call(1068) INFO 71.4% complete 2019-06-04 01:37:22,117 Task._call(1068) INFO 71.4% complete 2019-06-04 01:37:28,165 Task._call(1068) INFO 71.4% complete 2019-06-04 01:37:34,259 Task._call(1068) INFO 72.5% complete 2019-06-04 01:37:40,196 Task._call(1068) INFO 72.5% complete 2019-06-04 01:37:46,289 Task._call(1068) INFO 72.5% complete 2019-06-04 01:37:52,023 Task._call(1068) INFO 72.5% complete 2019-06-04 01:37:58,335 Task._call(1068) INFO 73.6% complete 2019-06-04 01:38:04,178 Task._call(1068) INFO 73.6% complete 2019-06-04 01:38:10,069 Task._call(1068) INFO 73.6% complete 2019-06-04 01:38:16,210 Task._call(1068) INFO 73.6% complete 2019-06-04 01:38:22,022 Task._call(1068) INFO 73.6% complete 2019-06-04 01:38:28,256 Task._call(1068) INFO 74.8% complete 2019-06-04 01:38:34,223 Task._call(1068) INFO 74.8% complete 2019-06-04 01:38:40,082 Task._call(1068) INFO 74.8% complete 2019-06-04 01:38:46,177 Task._call(1068) INFO 74.8% complete 2019-06-04 01:38:52,286 Task._call(1068) INFO 75.9% complete 2019-06-04 01:38:58,051 Task._call(1068) INFO 75.9% complete 2019-06-04 01:39:04,207 Task._call(1068) INFO 75.9% complete 2019-06-04 01:39:10,206 Task._call(1068) INFO 75.9% complete 2019-06-04 01:39:16,206 Task._call(1068) INFO 77.0% complete 2019-06-04 01:39:22,081 Task._call(1068) INFO 77.0% complete 2019-06-04 01:39:28,049 Task._call(1068) INFO 77.0% complete 2019-06-04 01:39:34,111 Task._call(1068) INFO 77.0% complete 2019-06-04 01:39:40,141 Task._call(1068) INFO 78.1% complete 2019-06-04 01:39:46,157 Task._call(1068) INFO 78.1% complete 2019-06-04 01:39:52,062 Task._call(1068) INFO 78.1% complete 2019-06-04 01:39:58,032 Task._call(1068) INFO 78.1% complete 2019-06-04 01:40:04,203 Task._call(1068) INFO 79.2% complete 2019-06-04 01:40:10,171 Task._call(1068) INFO 79.2% complete 2019-06-04 01:40:16,108 Task._call(1068) INFO 80.3% complete 2019-06-04 01:40:22,062 Task._call(1068) INFO 80.3% complete 2019-06-04 01:40:28,154 Task._call(1068) INFO 80.3% complete 2019-06-04 01:40:34,092 Task._call(1068) INFO 81.5% complete 2019-06-04 01:40:40,232 Task._call(1068) INFO 81.5% complete 2019-06-04 01:40:46,154 Task._call(1068) INFO 82.6% complete 2019-06-04 01:40:52,200 Task._call(1068) INFO 82.6% complete 2019-06-04 01:40:58,091 Task._call(1068) INFO 83.7% complete 2019-06-04 01:41:04,043 Task._call(1068) INFO 83.7% complete 2019-06-04 01:41:10,105 Task._call(1068) INFO 84.8% complete 2019-06-04 01:41:16,026 Task._call(1068) INFO 85.9% complete 2019-06-04 01:41:22,198 Task._call(1068) INFO 85.9% complete 2019-06-04 01:41:28,230 Task._call(1068) INFO 87.0% complete 2019-06-04 01:41:34,119 Task._call(1068) INFO 89.3% complete 2019-06-04 01:41:40,119 Task._call(1068) INFO 91.5% complete 2019-06-04 01:41:47,368 Task._call(1068) INFO 92.6% complete 2019-06-04 01:41:53,025 Task._call(1068) INFO 96.0% complete 2019-06-04 01:41:59,118 Task._call(1068) INFO 100.0% complete 2019-06-04 01:42:21,617 geoprocessing.raster_calculator(366) INFO starting stats_worker 2019-06-04 01:42:21,617 geoprocessing.raster_calculator(372) INFO started stats_worker 2019-06-04 01:42:26,631 geoprocessing.(442) INFO 6.0% complete 2019-06-04 01:42:27,282 sdr.ic_op(996) WARNING C:\INVEST~2.0_X\INVEST~1\natcap\invest\sdr.py:996: RuntimeWarning: invalid value encountered in log10 2019-06-04 01:42:31,645 geoprocessing.(442) INFO 9.5% complete 2019-06-04 01:42:36,661 geoprocessing.(442) INFO 13.1% complete 2019-06-04 01:42:41,677 geoprocessing.(442) INFO 16.5% complete 2019-06-04 01:42:46,691 geoprocessing.(442) INFO 19.7% complete 2019-06-04 01:42:51,723 geoprocessing.(442) INFO 22.9% complete 2019-06-04 01:42:56,753 geoprocessing.(442) INFO 26.2% complete 2019-06-04 01:43:01,769 geoprocessing.(442) INFO 29.5% complete 2019-06-04 01:43:06,785 geoprocessing.(442) INFO 32.7% complete 2019-06-04 01:43:11,815 geoprocessing.(442) INFO 35.0% complete 2019-06-04 01:43:16,831 geoprocessing.(442) INFO 36.9% complete 2019-06-04 01:43:21,861 geoprocessing.(442) INFO 38.6% complete 2019-06-04 01:43:26,878 geoprocessing.(442) INFO 40.3% complete 2019-06-04 01:43:31,907 geoprocessing.(442) INFO 41.8% complete 2019-06-04 01:43:36,924 geoprocessing.(442) INFO 43.3% complete 2019-06-04 01:43:41,938 geoprocessing.(442) INFO 44.8% complete 2019-06-04 01:43:46,953 geoprocessing.(442) INFO 46.2% complete 2019-06-04 01:43:51,970 geoprocessing.(442) INFO 47.7% complete 2019-06-04 01:43:57,000 geoprocessing.(442) INFO 49.1% complete 2019-06-04 01:44:02,032 geoprocessing.(442) INFO 50.5% complete 2019-06-04 01:44:07,046 geoprocessing.(442) INFO 51.9% complete 2019-06-04 01:44:12,078 geoprocessing.(442) INFO 53.3% complete 2019-06-04 01:44:17,108 geoprocessing.(442) INFO 54.8% complete 2019-06-04 01:44:22,140 geoprocessing.(442) INFO 56.3% complete 2019-06-04 01:44:27,171 geoprocessing.(442) INFO 57.8% complete 2019-06-04 01:44:32,186 geoprocessing.(442) INFO 59.4% complete 2019-06-04 01:44:37,217 geoprocessing.(442) INFO 60.9% complete 2019-06-04 01:44:42,247 geoprocessing.(442) INFO 62.6% complete 2019-06-04 01:44:47,279 geoprocessing.(442) INFO 64.2% complete 2019-06-04 01:44:52,293 geoprocessing.(442) INFO 65.9% complete 2019-06-04 01:44:57,309 geoprocessing.(442) INFO 67.5% complete 2019-06-04 01:45:02,325 geoprocessing.(442) INFO 69.2% complete 2019-06-04 01:45:07,355 geoprocessing.(442) INFO 70.8% complete 2019-06-04 01:45:12,371 geoprocessing.(442) INFO 72.6% complete 2019-06-04 01:45:17,387 geoprocessing.(442) INFO 74.3% complete 2019-06-04 01:45:22,401 geoprocessing.(442) INFO 76.5% complete 2019-06-04 01:45:27,417 geoprocessing.(442) INFO 79.4% complete 2019-06-04 01:45:32,447 geoprocessing.(442) INFO 83.2% complete 2019-06-04 01:45:37,463 geoprocessing.(442) INFO 88.4% complete 2019-06-04 01:45:42,479 geoprocessing.(442) INFO 94.6% complete 2019-06-04 01:45:42,619 sdr.ic_op(996) WARNING C:\INVEST~2.0_X\INVEST~1\natcap\invest\sdr.py:996: RuntimeWarning: overflow encountered in divide 2019-06-04 01:45:46,931 geoprocessing.raster_calculator(445) INFO 100.0%% complete 2019-06-04 01:45:46,931 geoprocessing.raster_calculator(448) INFO signaling stats worker to terminate 2019-06-04 01:45:46,931 geoprocessing.raster_calculator(450) INFO Waiting for raster stats worker result. 2019-06-04 01:46:47,210 geoprocessing.raster_calculator(477) INFO Waiting for raster stats worker result. 2019-06-04 01:47:47,216 Task.add_task(636) ERROR Something went wrong when adding task calculate ic (17), terminating taskgraph. Traceback (most recent call last): File "Z:\opt\atlassian\pipelines\agent\build\env\lib\site-packages\taskgraph\Task.py", line 602, in add_task File "Z:\opt\atlassian\pipelines\agent\build\env\lib\site-packages\taskgraph\Task.py", line 1068, in _call File "Z:\opt\atlassian\pipelines\agent\build\env\lib\site-packages\natcap\invest\sdr.py", line 1001, in _calculate_ic File "Z:\opt\atlassian\pipelines\agent\build\env\lib\site-packages\pygeoprocessing\geoprocessing.py", line 480, in raster_calculator RuntimeError: stats_worker_thread.join() timed out 2019-06-04 01:47:47,216 model._logged_target(1639) ERROR Exception while executing Traceback (most recent call last): File "Z:\opt\atlassian\pipelines\agent\build\env\lib\site-packages\natcap\invest\ui\model.py", line 1636, in _logged_target File "Z:\opt\atlassian\pipelines\agent\build\env\lib\site-packages\natcap\invest\sdr.py", line 408, in execute File "Z:\opt\atlassian\pipelines\agent\build\env\lib\site-packages\taskgraph\Task.py", line 602, in add_task File "Z:\opt\atlassian\pipelines\agent\build\env\lib\site-packages\taskgraph\Task.py", line 1068, in _call File "Z:\opt\atlassian\pipelines\agent\build\env\lib\site-packages\natcap\invest\sdr.py", line 1001, in _calculate_ic File "Z:\opt\atlassian\pipelines\agent\build\env\lib\site-packages\pygeoprocessing\geoprocessing.py", line 480, in raster_calculator RuntimeError: stats_worker_thread.join() timed out 2019-06-04 01:47:47,216 model._logged_target(1642) INFO Execution finished 2019-06-04 01:47:47,216 utils.prepare_workspace(115) INFO Elapsed time: 5h 12m 38.57s