2022-04-13 16:05:47,265 (natcap.invest.utils) utils.prepare_workspace(162) Level 100 Writing log messages to E:/2018年粮食产能/百分位结果（2022.4.13）\InVEST-Crop-Production-Percentile-log-2022-04-13--16_05_47.txt
2022-04-13 16:05:47,280 (natcap.invest.ui.model) model._logged_target(1643) Level 100 Starting model with parameters: 
Arguments for InVEST natcap.invest.crop_production_percentile 3.10.2:
aggregate_polygon_path       
landcover_raster_path        E:/2018年粮食产能/tiff/yulin2018_tif111.tif
landcover_to_crop_table_path E:/2018年粮食产能/landcover_to_crop_table.csv
model_data_path              E:/2018年粮食产能/model_data
n_workers                    -1
results_suffix               
workspace_dir                E:/2018年粮食产能/百分位结果（2022.4.13）

2022-04-13 16:05:47,526 (natcap.invest.crop_production_percentile) crop_production_percentile.execute(374) INFO Processing crop rice
2022-04-13 16:05:47,527 (natcap.invest.crop_production_percentile) crop_production_percentile.execute(379) INFO Clipping global climate bin raster to landcover bounding box.
2022-04-13 16:05:47,563 (natcap.invest.crop_production_percentile) crop_production_percentile.execute(410) INFO Map yield_25th to climate bins.
2022-04-13 16:05:47,578 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker
2022-04-13 16:05:47,579 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 58924
2022-04-13 16:05:47,580 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker <Thread(Thread-40, started daemon 47548)>
2022-04-13 16:05:47,587 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete
2022-04-13 16:05:47,588 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result.
2022-04-13 16:05:47,595 (natcap.invest.crop_production_percentile) crop_production_percentile.execute(441) INFO Interpolate rice yield_25th yield raster to landcover resolution.
2022-04-13 16:05:52,695 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3320) INFO Warp 26.0% complete E:/2018年粮食产能/百分位结果（2022.4.13）\intermediate_output\rice_yield_25th_interpolated_yield.tif
2022-04-13 16:05:57,712 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3320) INFO Warp 53.0% complete E:/2018年粮食产能/百分位结果（2022.4.13）\intermediate_output\rice_yield_25th_interpolated_yield.tif
2022-04-13 16:06:02,860 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3320) INFO Warp 81.0% complete E:/2018年粮食产能/百分位结果（2022.4.13）\intermediate_output\rice_yield_25th_interpolated_yield.tif
2022-04-13 16:06:06,330 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3320) INFO Warp 100.0% complete E:/2018年粮食产能/百分位结果（2022.4.13）\intermediate_output\rice_yield_25th_interpolated_yield.tif
2022-04-13 16:06:08,697 (natcap.invest.crop_production_percentile) crop_production_percentile.execute(458) INFO Calculate yield for rice at yield_25th
2022-04-13 16:06:08,838 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker
2022-04-13 16:06:08,839 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 58924
2022-04-13 16:06:08,840 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker <Thread(Thread-41, started daemon 48808)>
2022-04-13 16:06:13,837 (pygeoprocessing.geoprocessing) geoprocessing.<lambda>(477) INFO 85.9% complete
2022-04-13 16:06:14,743 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete
2022-04-13 16:06:14,743 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result.
2022-04-13 16:06:15,816 (natcap.invest.crop_production_percentile) crop_production_percentile.execute(410) INFO Map yield_50th to climate bins.
2022-04-13 16:06:15,832 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker
2022-04-13 16:06:15,834 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 58924
2022-04-13 16:06:15,835 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker <Thread(Thread-42, started daemon 29036)>
2022-04-13 16:06:15,836 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete
2022-04-13 16:06:15,837 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result.
2022-04-13 16:06:15,844 (natcap.invest.crop_production_percentile) crop_production_percentile.execute(441) INFO Interpolate rice yield_50th yield raster to landcover resolution.
2022-04-13 16:06:20,895 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3320) INFO Warp 26.0% complete E:/2018年粮食产能/百分位结果（2022.4.13）\intermediate_output\rice_yield_50th_interpolated_yield.tif
2022-04-13 16:06:25,907 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3320) INFO Warp 52.0% complete E:/2018年粮食产能/百分位结果（2022.4.13）\intermediate_output\rice_yield_50th_interpolated_yield.tif
2022-04-13 16:06:31,091 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3320) INFO Warp 79.0% complete E:/2018年粮食产能/百分位结果（2022.4.13）\intermediate_output\rice_yield_50th_interpolated_yield.tif
2022-04-13 16:06:35,079 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3320) INFO Warp 100.0% complete E:/2018年粮食产能/百分位结果（2022.4.13）\intermediate_output\rice_yield_50th_interpolated_yield.tif
2022-04-13 16:06:37,537 (natcap.invest.crop_production_percentile) crop_production_percentile.execute(458) INFO Calculate yield for rice at yield_50th
2022-04-13 16:06:37,673 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker
2022-04-13 16:06:37,674 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 58924
2022-04-13 16:06:37,675 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker <Thread(Thread-43, started daemon 54076)>
2022-04-13 16:06:40,938 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete
2022-04-13 16:06:40,938 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result.
2022-04-13 16:06:42,002 (natcap.invest.crop_production_percentile) crop_production_percentile.execute(410) INFO Map yield_75th to climate bins.
2022-04-13 16:06:42,017 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker
2022-04-13 16:06:42,018 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 58924
2022-04-13 16:06:42,019 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker <Thread(Thread-44, started daemon 41244)>
2022-04-13 16:06:42,020 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete
2022-04-13 16:06:42,020 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result.
2022-04-13 16:06:42,028 (natcap.invest.crop_production_percentile) crop_production_percentile.execute(441) INFO Interpolate rice yield_75th yield raster to landcover resolution.
2022-04-13 16:06:47,041 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3320) INFO Warp 26.0% complete E:/2018年粮食产能/百分位结果（2022.4.13）\intermediate_output\rice_yield_75th_interpolated_yield.tif
2022-04-13 16:06:52,190 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3320) INFO Warp 53.0% complete E:/2018年粮食产能/百分位结果（2022.4.13）\intermediate_output\rice_yield_75th_interpolated_yield.tif
2022-04-13 16:06:57,320 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3320) INFO Warp 80.0% complete E:/2018年粮食产能/百分位结果（2022.4.13）\intermediate_output\rice_yield_75th_interpolated_yield.tif
2022-04-13 16:07:01,078 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3320) INFO Warp 100.0% complete E:/2018年粮食产能/百分位结果（2022.4.13）\intermediate_output\rice_yield_75th_interpolated_yield.tif
2022-04-13 16:07:03,312 (natcap.invest.crop_production_percentile) crop_production_percentile.execute(458) INFO Calculate yield for rice at yield_75th
2022-04-13 16:07:03,454 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker
2022-04-13 16:07:03,456 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 58924
2022-04-13 16:07:03,457 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker <Thread(Thread-45, started daemon 59944)>
2022-04-13 16:07:06,924 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete
2022-04-13 16:07:06,925 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result.
2022-04-13 16:07:07,989 (natcap.invest.crop_production_percentile) crop_production_percentile.execute(410) INFO Map yield_95th to climate bins.
2022-04-13 16:07:08,005 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker
2022-04-13 16:07:08,007 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 58924
2022-04-13 16:07:08,007 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker <Thread(Thread-46, started daemon 52392)>
2022-04-13 16:07:08,008 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete
2022-04-13 16:07:08,009 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result.
2022-04-13 16:07:08,015 (natcap.invest.crop_production_percentile) crop_production_percentile.execute(441) INFO Interpolate rice yield_95th yield raster to landcover resolution.
2022-04-13 16:07:13,061 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3320) INFO Warp 25.0% complete E:/2018年粮食产能/百分位结果（2022.4.13）\intermediate_output\rice_yield_95th_interpolated_yield.tif
2022-04-13 16:07:18,145 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3320) INFO Warp 52.0% complete E:/2018年粮食产能/百分位结果（2022.4.13）\intermediate_output\rice_yield_95th_interpolated_yield.tif
2022-04-13 16:07:23,315 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3320) INFO Warp 80.0% complete E:/2018年粮食产能/百分位结果（2022.4.13）\intermediate_output\rice_yield_95th_interpolated_yield.tif
2022-04-13 16:07:27,052 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3320) INFO Warp 100.0% complete E:/2018年粮食产能/百分位结果（2022.4.13）\intermediate_output\rice_yield_95th_interpolated_yield.tif
2022-04-13 16:07:29,520 (natcap.invest.crop_production_percentile) crop_production_percentile.execute(458) INFO Calculate yield for rice at yield_95th
2022-04-13 16:07:29,699 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker
2022-04-13 16:07:29,702 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 58924
2022-04-13 16:07:29,702 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker <Thread(Thread-47, started daemon 60096)>
2022-04-13 16:07:32,937 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete
2022-04-13 16:07:32,938 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result.
2022-04-13 16:07:34,009 (natcap.invest.crop_production_percentile) crop_production_percentile.execute(481) INFO Calculate observed yield for rice
2022-04-13 16:07:34,041 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker
2022-04-13 16:07:34,042 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 58924
2022-04-13 16:07:34,042 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker <Thread(Thread-48, started daemon 47828)>
2022-04-13 16:07:34,044 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete
2022-04-13 16:07:34,044 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result.
2022-04-13 16:07:34,052 (natcap.invest.crop_production_percentile) crop_production_percentile.execute(524) INFO Interpolating observed rice raster to landcover.
2022-04-13 16:07:39,137 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3320) INFO Warp 25.0% complete E:/2018年粮食产能/百分位结果（2022.4.13）\intermediate_output\rice_interpolated_observed_yield.tif
2022-04-13 16:07:44,233 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3320) INFO Warp 52.0% complete E:/2018年粮食产能/百分位结果（2022.4.13）\intermediate_output\rice_interpolated_observed_yield.tif
2022-04-13 16:07:49,392 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3320) INFO Warp 79.0% complete E:/2018年粮食产能/百分位结果（2022.4.13）\intermediate_output\rice_interpolated_observed_yield.tif
2022-04-13 16:07:53,346 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3320) INFO Warp 100.0% complete E:/2018年粮食产能/百分位结果（2022.4.13）\intermediate_output\rice_interpolated_observed_yield.tif
2022-04-13 16:07:57,193 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker
2022-04-13 16:07:57,194 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 58924
2022-04-13 16:07:57,195 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker <Thread(Thread-49, started daemon 59088)>
2022-04-13 16:08:00,841 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete
2022-04-13 16:08:00,841 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result.
2022-04-13 16:08:02,000 (natcap.invest.crop_production_percentile) crop_production_percentile.execute(374) INFO Processing crop maize
2022-04-13 16:08:02,001 (natcap.invest.crop_production_percentile) crop_production_percentile.execute(379) INFO Clipping global climate bin raster to landcover bounding box.
2022-04-13 16:08:02,033 (natcap.invest.crop_production_percentile) crop_production_percentile.execute(410) INFO Map yield_25th to climate bins.
2022-04-13 16:08:02,049 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker
2022-04-13 16:08:02,050 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 58924
2022-04-13 16:08:02,051 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker <Thread(Thread-50, started daemon 7296)>
2022-04-13 16:08:02,052 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete
2022-04-13 16:08:02,052 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result.
2022-04-13 16:08:02,061 (natcap.invest.crop_production_percentile) crop_production_percentile.execute(441) INFO Interpolate maize yield_25th yield raster to landcover resolution.
2022-04-13 16:08:07,165 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3320) INFO Warp 27.0% complete E:/2018年粮食产能/百分位结果（2022.4.13）\intermediate_output\maize_yield_25th_interpolated_yield.tif
2022-04-13 16:08:12,214 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3320) INFO Warp 54.0% complete E:/2018年粮食产能/百分位结果（2022.4.13）\intermediate_output\maize_yield_25th_interpolated_yield.tif
2022-04-13 16:08:17,247 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3320) INFO Warp 81.0% complete E:/2018年粮食产能/百分位结果（2022.4.13）\intermediate_output\maize_yield_25th_interpolated_yield.tif
2022-04-13 16:08:20,728 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3320) INFO Warp 100.0% complete E:/2018年粮食产能/百分位结果（2022.4.13）\intermediate_output\maize_yield_25th_interpolated_yield.tif
2022-04-13 16:08:25,917 (natcap.invest.crop_production_percentile) crop_production_percentile.execute(458) INFO Calculate yield for maize at yield_25th
2022-04-13 16:08:26,054 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker
2022-04-13 16:08:26,056 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 58924
2022-04-13 16:08:26,056 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker <Thread(Thread-51, started daemon 56284)>
2022-04-13 16:08:30,746 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete
2022-04-13 16:08:30,747 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result.
2022-04-13 16:08:32,378 (natcap.invest.crop_production_percentile) crop_production_percentile.execute(410) INFO Map yield_50th to climate bins.
2022-04-13 16:08:32,392 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker
2022-04-13 16:08:32,394 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 58924
2022-04-13 16:08:32,394 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker <Thread(Thread-52, started daemon 21332)>
2022-04-13 16:08:32,396 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete
2022-04-13 16:08:32,397 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result.
2022-04-13 16:08:32,404 (natcap.invest.crop_production_percentile) crop_production_percentile.execute(441) INFO Interpolate maize yield_50th yield raster to landcover resolution.
2022-04-13 16:08:37,451 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3320) INFO Warp 27.0% complete E:/2018年粮食产能/百分位结果（2022.4.13）\intermediate_output\maize_yield_50th_interpolated_yield.tif
2022-04-13 16:08:42,476 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3320) INFO Warp 54.0% complete E:/2018年粮食产能/百分位结果（2022.4.13）\intermediate_output\maize_yield_50th_interpolated_yield.tif
2022-04-13 16:08:47,623 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3320) INFO Warp 82.0% complete E:/2018年粮食产能/百分位结果（2022.4.13）\intermediate_output\maize_yield_50th_interpolated_yield.tif
2022-04-13 16:08:50,876 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3320) INFO Warp 100.0% complete E:/2018年粮食产能/百分位结果（2022.4.13）\intermediate_output\maize_yield_50th_interpolated_yield.tif
2022-04-13 16:08:55,880 (natcap.invest.crop_production_percentile) crop_production_percentile.execute(458) INFO Calculate yield for maize at yield_50th
2022-04-13 16:08:56,013 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker
2022-04-13 16:08:56,014 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 58924
2022-04-13 16:08:56,014 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker <Thread(Thread-53, started daemon 61168)>
2022-04-13 16:09:00,610 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete
2022-04-13 16:09:00,610 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result.
2022-04-13 16:09:02,241 (natcap.invest.crop_production_percentile) crop_production_percentile.execute(410) INFO Map yield_75th to climate bins.
2022-04-13 16:09:02,254 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker
2022-04-13 16:09:02,255 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 58924
2022-04-13 16:09:02,255 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker <Thread(Thread-54, started daemon 41020)>
2022-04-13 16:09:02,257 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete
2022-04-13 16:09:02,258 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result.
2022-04-13 16:09:02,265 (natcap.invest.crop_production_percentile) crop_production_percentile.execute(441) INFO Interpolate maize yield_75th yield raster to landcover resolution.
2022-04-13 16:09:07,430 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3320) INFO Warp 28.0% complete E:/2018年粮食产能/百分位结果（2022.4.13）\intermediate_output\maize_yield_75th_interpolated_yield.tif
2022-04-13 16:09:12,565 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3320) INFO Warp 56.0% complete E:/2018年粮食产能/百分位结果（2022.4.13）\intermediate_output\maize_yield_75th_interpolated_yield.tif
2022-04-13 16:09:17,674 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3320) INFO Warp 84.0% complete E:/2018年粮食产能/百分位结果（2022.4.13）\intermediate_output\maize_yield_75th_interpolated_yield.tif
2022-04-13 16:09:20,545 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3320) INFO Warp 100.0% complete E:/2018年粮食产能/百分位结果（2022.4.13）\intermediate_output\maize_yield_75th_interpolated_yield.tif
2022-04-13 16:09:25,734 (natcap.invest.crop_production_percentile) crop_production_percentile.execute(458) INFO Calculate yield for maize at yield_75th
2022-04-13 16:09:25,865 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker
2022-04-13 16:09:25,867 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 58924
2022-04-13 16:09:25,867 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker <Thread(Thread-55, started daemon 50636)>
2022-04-13 16:09:30,528 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete
2022-04-13 16:09:30,529 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result.
2022-04-13 16:09:32,187 (natcap.invest.crop_production_percentile) crop_production_percentile.execute(410) INFO Map yield_95th to climate bins.
2022-04-13 16:09:32,200 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker
2022-04-13 16:09:32,202 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 58924
2022-04-13 16:09:32,202 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker <Thread(Thread-56, started daemon 55500)>
2022-04-13 16:09:32,203 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete
2022-04-13 16:09:32,204 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result.
2022-04-13 16:09:32,212 (natcap.invest.crop_production_percentile) crop_production_percentile.execute(441) INFO Interpolate maize yield_95th yield raster to landcover resolution.
2022-04-13 16:09:37,384 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3320) INFO Warp 28.0% complete E:/2018年粮食产能/百分位结果（2022.4.13）\intermediate_output\maize_yield_95th_interpolated_yield.tif
2022-04-13 16:09:42,548 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3320) INFO Warp 56.0% complete E:/2018年粮食产能/百分位结果（2022.4.13）\intermediate_output\maize_yield_95th_interpolated_yield.tif
2022-04-13 16:09:47,687 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3320) INFO Warp 84.0% complete E:/2018年粮食产能/百分位结果（2022.4.13）\intermediate_output\maize_yield_95th_interpolated_yield.tif
2022-04-13 16:09:50,558 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3320) INFO Warp 100.0% complete E:/2018年粮食产能/百分位结果（2022.4.13）\intermediate_output\maize_yield_95th_interpolated_yield.tif
2022-04-13 16:09:55,700 (natcap.invest.crop_production_percentile) crop_production_percentile.execute(458) INFO Calculate yield for maize at yield_95th
2022-04-13 16:09:55,865 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker
2022-04-13 16:09:55,866 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 58924
2022-04-13 16:09:55,866 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker <Thread(Thread-57, started daemon 18276)>
2022-04-13 16:10:00,443 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete
2022-04-13 16:10:00,443 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result.
2022-04-13 16:10:02,061 (natcap.invest.crop_production_percentile) crop_production_percentile.execute(481) INFO Calculate observed yield for maize
2022-04-13 16:10:02,090 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker
2022-04-13 16:10:02,091 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 58924
2022-04-13 16:10:02,091 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker <Thread(Thread-58, started daemon 59292)>
2022-04-13 16:10:02,093 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete
2022-04-13 16:10:02,093 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result.
2022-04-13 16:10:02,100 (natcap.invest.crop_production_percentile) crop_production_percentile.execute(524) INFO Interpolating observed maize raster to landcover.
2022-04-13 16:10:07,169 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3320) INFO Warp 27.0% complete E:/2018年粮食产能/百分位结果（2022.4.13）\intermediate_output\maize_interpolated_observed_yield.tif
2022-04-13 16:10:12,201 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3320) INFO Warp 54.0% complete E:/2018年粮食产能/百分位结果（2022.4.13）\intermediate_output\maize_interpolated_observed_yield.tif
2022-04-13 16:10:17,330 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3320) INFO Warp 82.0% complete E:/2018年粮食产能/百分位结果（2022.4.13）\intermediate_output\maize_interpolated_observed_yield.tif
2022-04-13 16:10:20,558 (pygeoprocessing.geoprocessing) geoprocessing.logger_callback(3320) INFO Warp 100.0% complete E:/2018年粮食产能/百分位结果（2022.4.13）\intermediate_output\maize_interpolated_observed_yield.tif
2022-04-13 16:10:26,928 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(396) INFO starting stats_worker
2022-04-13 16:10:26,930 (pygeoprocessing.geoprocessing_core) threading.run(870) DEBUG stats worker PID: 58924
2022-04-13 16:10:26,930 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(402) INFO started stats_worker <Thread(Thread-59, started daemon 47664)>
2022-04-13 16:10:31,731 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(482) INFO 100.0% complete
2022-04-13 16:10:31,732 (pygeoprocessing.geoprocessing) geoprocessing.raster_calculator(485) INFO Waiting for raster stats worker result.
2022-04-13 16:10:33,610 (natcap.invest.crop_production_percentile) crop_production_percentile.tabulate_results(734) INFO Generating report table
2022-04-13 16:10:33,611 (natcap.invest.crop_production_percentile) crop_production_percentile.tabulate_results(762) INFO Calculating production area and summing observed yield.
2022-04-13 16:10:43,793 (natcap.invest.crop_production_percentile) crop_production_percentile.tabulate_results(762) INFO Calculating production area and summing observed yield.
2022-04-13 16:10:52,281 (natcap.invest.utils) utils.prepare_workspace(170) INFO Elapsed time: 5m 5.009999999999991s
2022-04-13 16:10:52,282 (natcap.invest.utils) utils.prepare_workspace(173) INFO Execution finished