2023-05-30 13:08:39,330 UTC [368562] INFO esmvalcore._main:495 ______________________________________________________________________ _____ ____ __ ____ __ _ _____ _ | ____/ ___|| \/ \ \ / /_ _| |_ _|__ ___ | | | _| \___ \| |\/| |\ \ / / _` | | | |/ _ \ / _ \| | | |___ ___) | | | | \ V / (_| | | | | (_) | (_) | | |_____|____/|_| |_| \_/ \__,_|_| |_|\___/ \___/|_| ______________________________________________________________________ ESMValTool - Earth System Model Evaluation Tool. http://www.esmvaltool.org CORE DEVELOPMENT TEAM AND CONTACTS: Birgit Hassler (Co-PI; DLR, Germany - birgit.hassler@dlr.de) Alistair Sellar (Co-PI; Met Office, UK - alistair.sellar@metoffice.gov.uk) Bouwe Andela (Netherlands eScience Center, The Netherlands - b.andela@esciencecenter.nl) Lee de Mora (PML, UK - ledm@pml.ac.uk) Niels Drost (Netherlands eScience Center, The Netherlands - n.drost@esciencecenter.nl) Veronika Eyring (DLR, Germany - veronika.eyring@dlr.de) Bettina Gier (UBremen, Germany - gier@uni-bremen.de) Remi Kazeroni (DLR, Germany - remi.kazeroni@dlr.de) Nikolay Koldunov (AWI, Germany - nikolay.koldunov@awi.de) Axel Lauer (DLR, Germany - axel.lauer@dlr.de) Saskia Loosveldt-Tomas (BSC, Spain - saskia.loosveldt@bsc.es) Ruth Lorenz (ETH Zurich, Switzerland - ruth.lorenz@env.ethz.ch) Benjamin Mueller (LMU, Germany - b.mueller@iggf.geo.uni-muenchen.de) Valeriu Predoi (URead, UK - valeriu.predoi@ncas.ac.uk) Mattia Righi (DLR, Germany - mattia.righi@dlr.de) Manuel Schlund (DLR, Germany - manuel.schlund@dlr.de) Breixo Solino Fernandez (DLR, Germany - breixo.solinofernandez@dlr.de) Javier Vegas-Regidor (BSC, Spain - javier.vegas@bsc.es) Klaus Zimmermann (SMHI, Sweden - klaus.zimmermann@smhi.se) For further help, please read the documentation at http://docs.esmvaltool.org. Have fun! 2023-05-30 13:08:39,331 UTC [368562] INFO esmvalcore._main:496 Package versions 2023-05-30 13:08:39,331 UTC [368562] INFO esmvalcore._main:497 ---------------- 2023-05-30 13:08:39,331 UTC [368562] INFO esmvalcore._main:498 ESMValCore: 2.8.0 2023-05-30 13:08:39,331 UTC [368562] INFO esmvalcore._main:500 ESMValTool: 2.8.0 2023-05-30 13:08:39,331 UTC [368562] INFO esmvalcore._main:501 ---------------- 2023-05-30 13:08:39,331 UTC [368562] INFO esmvalcore._main:502 Using config file /nird/home/adagj/.esmvaltool/config-user.yml 2023-05-30 13:08:39,331 UTC [368562] INFO esmvalcore._main:503 Writing program log files to: /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/run/main_log.txt /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/run/main_log_debug.txt 2023-05-30 13:08:39,443 UTC [368562] INFO esmvalcore.config._esgf_pyclient:116 Using default ESGF configuration, configuration file /nird/home/adagj/.esmvaltool/esgf-pyclient.yml not present. 2023-05-30 13:08:39,443 UTC [368562] WARNING esmvalcore.config._esgf_pyclient:181 ESGF credentials missing, only data that is accessible without logging in will be available. See https://esgf.github.io/esgf-user-support/user_guide.html for instructions on how to create an account if you do not have one yet. Next, configure your system so esmvaltool can use your credentials. This can be done using the keyring package, or you can just enter them in /nird/home/adagj/.esmvaltool/esgf-pyclient.yml. keyring ======= First install the keyring package (requires a supported backend, see https://pypi.org/project/keyring/): $ pip install keyring Next, set your username and password by running the commands: $ keyring set ESGF hostname $ keyring set ESGF username $ keyring set ESGF password To check that you entered your credentials correctly, run: $ keyring get ESGF hostname $ keyring get ESGF username $ keyring get ESGF password configuration file ================== You can store the hostname, username, and password or your OpenID account in a plain text in the file /nird/home/adagj/.esmvaltool/esgf-pyclient.yml like this: logon: hostname: "your-hostname" username: "your-username" password: "your-password" or your can configure an interactive log in: logon: interactive: true Note that storing your password in plain text in the configuration file is less secure. On shared systems, make sure the permissions of the file are set so only you can read it, i.e. $ ls -l /nird/home/adagj/.esmvaltool/esgf-pyclient.yml shows permissions -rw-------. 2023-05-30 13:08:40,009 UTC [368562] INFO esmvalcore._main:85 Starting the Earth System Model Evaluation Tool at time: 2023-05-30 13:08:40 UTC 2023-05-30 13:08:40,010 UTC [368562] INFO esmvalcore._main:89 ---------------------------------------------------------------------- 2023-05-30 13:08:40,010 UTC [368562] INFO esmvalcore._main:90 RECIPE = /nird/home/adagj/esmvaltool_workshop/recipe_runoff_et.yml 2023-05-30 13:08:40,010 UTC [368562] INFO esmvalcore._main:91 RUNDIR = /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/run 2023-05-30 13:08:40,010 UTC [368562] INFO esmvalcore._main:92 WORKDIR = /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/work 2023-05-30 13:08:40,010 UTC [368562] INFO esmvalcore._main:93 PREPROCDIR = /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc 2023-05-30 13:08:40,010 UTC [368562] INFO esmvalcore._main:94 PLOTDIR = /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/plots 2023-05-30 13:08:40,010 UTC [368562] INFO esmvalcore._main:95 ---------------------------------------------------------------------- 2023-05-30 13:08:40,010 UTC [368562] INFO esmvalcore._main:98 Running tasks using at most 2 processes 2023-05-30 13:08:40,010 UTC [368562] INFO esmvalcore._main:100 If your system hangs during execution, it may not have enough memory for keeping this number of tasks in memory. 2023-05-30 13:08:40,011 UTC [368562] INFO esmvalcore._main:103 If you experience memory problems, try reducing 'max_parallel_tasks' in your user configuration file. 2023-05-30 13:08:40,012 UTC [368562] DEBUG esmvalcore._recipe.check:52 Checking recipe against schema /diagnostics/esmvaltool/2.8.0/lib/python3.10/site-packages/esmvalcore/_recipe/recipe_schema.yml 2023-05-30 13:08:40,030 UTC [368562] DEBUG esmvalcore._recipe.to_datasets:344 Populating list of datasets for variable evspsbl in diagnostic catchment_analysis 2023-05-30 13:08:40,030 UTC [368562] DEBUG esmvalcore._recipe.to_datasets:368 Found Dataset: evspsbl, Amon, CMIP5, MPI-ESM-LR, historical, r1i1p1 2023-05-30 13:08:40,030 UTC [368562] DEBUG esmvalcore._recipe.to_datasets:368 Found Dataset: evspsbl, Amon, CMIP5, IPSL-CM5B-LR, historical, r1i1p1 2023-05-30 13:08:40,031 UTC [368562] DEBUG esmvalcore._recipe.to_datasets:368 Found Dataset: evspsbl, Amon, CMIP5, NorESM1-ME, historical, r1i1p1 2023-05-30 13:08:40,031 UTC [368562] DEBUG esmvalcore._recipe.to_datasets:344 Populating list of datasets for variable mrro in diagnostic catchment_analysis 2023-05-30 13:08:40,031 UTC [368562] DEBUG esmvalcore._recipe.to_datasets:368 Found Dataset: mrro, Lmon, CMIP5, MPI-ESM-LR, historical, r1i1p1 2023-05-30 13:08:40,031 UTC [368562] DEBUG esmvalcore._recipe.to_datasets:368 Found Dataset: mrro, Lmon, CMIP5, IPSL-CM5B-LR, historical, r1i1p1 2023-05-30 13:08:40,031 UTC [368562] DEBUG esmvalcore._recipe.to_datasets:368 Found Dataset: mrro, Lmon, CMIP5, NorESM1-ME, historical, r1i1p1 2023-05-30 13:08:40,031 UTC [368562] DEBUG esmvalcore._recipe.to_datasets:344 Populating list of datasets for variable pr in diagnostic catchment_analysis 2023-05-30 13:08:40,031 UTC [368562] DEBUG esmvalcore._recipe.to_datasets:368 Found Dataset: pr, Amon, CMIP5, MPI-ESM-LR, historical, r1i1p1 2023-05-30 13:08:40,031 UTC [368562] DEBUG esmvalcore._recipe.to_datasets:368 Found Dataset: pr, Amon, CMIP5, IPSL-CM5B-LR, historical, r1i1p1 2023-05-30 13:08:40,032 UTC [368562] DEBUG esmvalcore._recipe.to_datasets:368 Found Dataset: pr, Amon, CMIP5, NorESM1-ME, historical, r1i1p1 2023-05-30 13:08:40,032 UTC [368562] DEBUG esmvalcore._recipe.recipe:1014 Retrieving diagnostics from recipe 2023-05-30 13:08:40,032 UTC [368562] DEBUG esmvalcore._recipe.recipe:1042 Setting script for diagnostic catchment_analysis 2023-05-30 13:08:40,033 UTC [368562] INFO esmvalcore._recipe.recipe:1232 Creating tasks from recipe 2023-05-30 13:08:40,033 UTC [368562] INFO esmvalcore._recipe.recipe:1241 Creating tasks for diagnostic catchment_analysis 2023-05-30 13:08:40,033 UTC [368562] INFO esmvalcore._recipe.recipe:1163 Creating diagnostic task catchment_analysis/catchment_analysis 2023-05-30 13:08:40,033 UTC [368562] INFO esmvalcore._recipe.recipe:1216 Creating preprocessor task catchment_analysis/evspsbl 2023-05-30 13:08:40,033 UTC [368562] INFO esmvalcore._recipe.recipe:849 Creating preprocessor 'default' task for variable 'evspsbl' 2023-05-30 13:08:40,033 UTC [368562] DEBUG esmvalcore.config._config:48 Loading extra facets from /diagnostics/esmvaltool/2.8.0/lib/python3.10/site-packages/esmvalcore/config/extra_facets/cmip5-fx.yml 2023-05-30 13:08:40,034 UTC [368562] DEBUG esmvalcore.config._config:48 Loading extra facets from /diagnostics/esmvaltool/2.8.0/lib/python3.10/site-packages/esmvalcore/config/extra_facets/cmip5-institutes.yml 2023-05-30 13:08:40,065 UTC [368562] DEBUG esmvalcore.config._config:48 Loading extra facets from /diagnostics/esmvaltool/2.8.0/lib/python3.10/site-packages/esmvalcore/config/extra_facets/cmip5-product.yml 2023-05-30 13:08:40,073 UTC [368562] WARNING esmvalcore.local:426 'CMIP5' rootpaths '/scratch/adagj/ESGF/cmip5/output1' set in config-user.yml do not exist 2023-05-30 13:08:40,074 UTC [368562] DEBUG esmvalcore.local:458 Looking for files matching: /projects/NS9034K/CMIP5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/*/evspsbl/evspsbl_Amon_MPI-ESM-LR_historical_r1i1p1*.nc /projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/*/evspsbl/evspsbl_Amon_MPI-ESM-LR_historical_r1i1p1*.nc /scratch/adagj/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/*/evspsbl/evspsbl_Amon_MPI-ESM-LR_historical_r1i1p1*.nc 2023-05-30 13:08:40,078 UTC [368562] DEBUG esmvalcore._recipe.recipe:446 Using input files for variable evspsbl of dataset MPI-ESM-LR: /projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/v20120315/evspsbl/evspsbl_Amon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc 2023-05-30 13:08:40,078 UTC [368562] INFO esmvalcore._recipe.recipe:717 Found input files for Dataset: evspsbl, Amon, CMIP5, MPI-ESM-LR, historical, r1i1p1, v20120315 2023-05-30 13:08:40,079 UTC [368562] DEBUG esmvalcore.local:458 Looking for files matching: /projects/NS9034K/CMIP5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/*/evspsbl/evspsbl_Amon_IPSL-CM5B-LR_historical_r1i1p1*.nc /projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/*/evspsbl/evspsbl_Amon_IPSL-CM5B-LR_historical_r1i1p1*.nc /scratch/adagj/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/*/evspsbl/evspsbl_Amon_IPSL-CM5B-LR_historical_r1i1p1*.nc 2023-05-30 13:08:40,081 UTC [368562] DEBUG esmvalcore._recipe.recipe:446 Using input files for variable evspsbl of dataset IPSL-CM5B-LR: /projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/v20120114/evspsbl/evspsbl_Amon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc 2023-05-30 13:08:40,081 UTC [368562] INFO esmvalcore._recipe.recipe:717 Found input files for Dataset: evspsbl, Amon, CMIP5, IPSL-CM5B-LR, historical, r1i1p1, v20120114 2023-05-30 13:08:40,081 UTC [368562] DEBUG esmvalcore.local:458 Looking for files matching: /projects/NS9034K/CMIP5/output1/NCC/NorESM1-ME/historical/mon/atmos/Amon/r1i1p1/*/evspsbl/evspsbl_Amon_NorESM1-ME_historical_r1i1p1*.nc /projects/NS9560K-datalake/ESGF/cmip5/output1/NCC/NorESM1-ME/historical/mon/atmos/Amon/r1i1p1/*/evspsbl/evspsbl_Amon_NorESM1-ME_historical_r1i1p1*.nc /scratch/adagj/ESGF/cmip5/output1/NCC/NorESM1-ME/historical/mon/atmos/Amon/r1i1p1/*/evspsbl/evspsbl_Amon_NorESM1-ME_historical_r1i1p1*.nc 2023-05-30 13:08:40,092 UTC [368562] DEBUG esmvalcore._recipe.recipe:446 Using input files for variable evspsbl of dataset NorESM1-ME: /projects/NS9034K/CMIP5/output1/NCC/NorESM1-ME/historical/mon/atmos/Amon/r1i1p1/v20140327/evspsbl/evspsbl_Amon_NorESM1-ME_historical_r1i1p1_185001-200512.nc 2023-05-30 13:08:40,092 UTC [368562] INFO esmvalcore._recipe.recipe:717 Found input files for Dataset: evspsbl, Amon, CMIP5, NorESM1-ME, historical, r1i1p1, v20140327 2023-05-30 13:08:40,093 UTC [368562] INFO esmvalcore._recipe.recipe:873 PreprocessingTask catchment_analysis/evspsbl created. 2023-05-30 13:08:40,093 UTC [368562] DEBUG esmvalcore._recipe.recipe:874 PreprocessingTask catchment_analysis/evspsbl will create the files: /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/evspsbl/CMIP5_NorESM1-ME_Amon_historical_r1i1p1_evspsbl_1970-2000.nc /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/evspsbl/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_evspsbl_1970-2000.nc /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/evspsbl/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_evspsbl_1970-2000.nc 2023-05-30 13:08:40,093 UTC [368562] INFO esmvalcore._recipe.recipe:1216 Creating preprocessor task catchment_analysis/mrro 2023-05-30 13:08:40,093 UTC [368562] INFO esmvalcore._recipe.recipe:849 Creating preprocessor 'default' task for variable 'mrro' 2023-05-30 13:08:40,094 UTC [368562] DEBUG esmvalcore.local:458 Looking for files matching: /projects/NS9034K/CMIP5/output1/MPI-M/MPI-ESM-LR/historical/mon/land/Lmon/r1i1p1/*/mrro/mrro_Lmon_MPI-ESM-LR_historical_r1i1p1*.nc /projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/land/Lmon/r1i1p1/*/mrro/mrro_Lmon_MPI-ESM-LR_historical_r1i1p1*.nc /scratch/adagj/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/land/Lmon/r1i1p1/*/mrro/mrro_Lmon_MPI-ESM-LR_historical_r1i1p1*.nc 2023-05-30 13:08:40,095 UTC [368562] DEBUG esmvalcore._recipe.recipe:446 Using input files for variable mrro of dataset MPI-ESM-LR: /projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/land/Lmon/r1i1p1/v20120625/mrro/mrro_Lmon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc 2023-05-30 13:08:40,095 UTC [368562] INFO esmvalcore._recipe.recipe:717 Found input files for Dataset: mrro, Lmon, CMIP5, MPI-ESM-LR, historical, r1i1p1, v20120625 2023-05-30 13:08:40,096 UTC [368562] DEBUG esmvalcore.local:458 Looking for files matching: /projects/NS9034K/CMIP5/output1/IPSL/IPSL-CM5B-LR/historical/mon/land/Lmon/r1i1p1/*/mrro/mrro_Lmon_IPSL-CM5B-LR_historical_r1i1p1*.nc /projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/land/Lmon/r1i1p1/*/mrro/mrro_Lmon_IPSL-CM5B-LR_historical_r1i1p1*.nc /scratch/adagj/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/land/Lmon/r1i1p1/*/mrro/mrro_Lmon_IPSL-CM5B-LR_historical_r1i1p1*.nc 2023-05-30 13:08:40,097 UTC [368562] DEBUG esmvalcore._recipe.recipe:446 Using input files for variable mrro of dataset IPSL-CM5B-LR: /projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/land/Lmon/r1i1p1/v20130506/mrro/mrro_Lmon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc 2023-05-30 13:08:40,097 UTC [368562] INFO esmvalcore._recipe.recipe:717 Found input files for Dataset: mrro, Lmon, CMIP5, IPSL-CM5B-LR, historical, r1i1p1, v20130506 2023-05-30 13:08:40,098 UTC [368562] DEBUG esmvalcore.local:458 Looking for files matching: /projects/NS9034K/CMIP5/output1/NCC/NorESM1-ME/historical/mon/land/Lmon/r1i1p1/*/mrro/mrro_Lmon_NorESM1-ME_historical_r1i1p1*.nc /projects/NS9560K-datalake/ESGF/cmip5/output1/NCC/NorESM1-ME/historical/mon/land/Lmon/r1i1p1/*/mrro/mrro_Lmon_NorESM1-ME_historical_r1i1p1*.nc /scratch/adagj/ESGF/cmip5/output1/NCC/NorESM1-ME/historical/mon/land/Lmon/r1i1p1/*/mrro/mrro_Lmon_NorESM1-ME_historical_r1i1p1*.nc 2023-05-30 13:08:40,103 UTC [368562] DEBUG esmvalcore._recipe.recipe:446 Using input files for variable mrro of dataset NorESM1-ME: /projects/NS9034K/CMIP5/output1/NCC/NorESM1-ME/historical/mon/land/Lmon/r1i1p1/v20120920/mrro/mrro_Lmon_NorESM1-ME_historical_r1i1p1_185001-200512.nc 2023-05-30 13:08:40,103 UTC [368562] INFO esmvalcore._recipe.recipe:717 Found input files for Dataset: mrro, Lmon, CMIP5, NorESM1-ME, historical, r1i1p1, v20120920 2023-05-30 13:08:40,105 UTC [368562] INFO esmvalcore._recipe.recipe:873 PreprocessingTask catchment_analysis/mrro created. 2023-05-30 13:08:40,105 UTC [368562] DEBUG esmvalcore._recipe.recipe:874 PreprocessingTask catchment_analysis/mrro will create the files: /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/mrro/CMIP5_NorESM1-ME_Lmon_historical_r1i1p1_mrro_1970-2000.nc /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/mrro/CMIP5_MPI-ESM-LR_Lmon_historical_r1i1p1_mrro_1970-2000.nc /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/mrro/CMIP5_IPSL-CM5B-LR_Lmon_historical_r1i1p1_mrro_1970-2000.nc 2023-05-30 13:08:40,105 UTC [368562] INFO esmvalcore._recipe.recipe:1216 Creating preprocessor task catchment_analysis/pr 2023-05-30 13:08:40,105 UTC [368562] INFO esmvalcore._recipe.recipe:849 Creating preprocessor 'default' task for variable 'pr' 2023-05-30 13:08:40,105 UTC [368562] DEBUG esmvalcore.local:458 Looking for files matching: /projects/NS9034K/CMIP5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/*/pr/pr_Amon_MPI-ESM-LR_historical_r1i1p1*.nc /projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/*/pr/pr_Amon_MPI-ESM-LR_historical_r1i1p1*.nc /scratch/adagj/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/*/pr/pr_Amon_MPI-ESM-LR_historical_r1i1p1*.nc 2023-05-30 13:08:40,107 UTC [368562] DEBUG esmvalcore._recipe.recipe:446 Using input files for variable pr of dataset MPI-ESM-LR: /projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/v20120315/pr/pr_Amon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc 2023-05-30 13:08:40,107 UTC [368562] INFO esmvalcore._recipe.recipe:717 Found input files for Dataset: pr, Amon, CMIP5, MPI-ESM-LR, historical, r1i1p1, v20120315 2023-05-30 13:08:40,107 UTC [368562] DEBUG esmvalcore.local:458 Looking for files matching: /projects/NS9034K/CMIP5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/*/pr/pr_Amon_IPSL-CM5B-LR_historical_r1i1p1*.nc /projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/*/pr/pr_Amon_IPSL-CM5B-LR_historical_r1i1p1*.nc /scratch/adagj/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/*/pr/pr_Amon_IPSL-CM5B-LR_historical_r1i1p1*.nc 2023-05-30 13:08:40,108 UTC [368562] DEBUG esmvalcore._recipe.recipe:446 Using input files for variable pr of dataset IPSL-CM5B-LR: /projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/v20120114/pr/pr_Amon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc 2023-05-30 13:08:40,109 UTC [368562] INFO esmvalcore._recipe.recipe:717 Found input files for Dataset: pr, Amon, CMIP5, IPSL-CM5B-LR, historical, r1i1p1, v20120114 2023-05-30 13:08:40,109 UTC [368562] DEBUG esmvalcore.local:458 Looking for files matching: /projects/NS9034K/CMIP5/output1/NCC/NorESM1-ME/historical/mon/atmos/Amon/r1i1p1/*/pr/pr_Amon_NorESM1-ME_historical_r1i1p1*.nc /projects/NS9560K-datalake/ESGF/cmip5/output1/NCC/NorESM1-ME/historical/mon/atmos/Amon/r1i1p1/*/pr/pr_Amon_NorESM1-ME_historical_r1i1p1*.nc /scratch/adagj/ESGF/cmip5/output1/NCC/NorESM1-ME/historical/mon/atmos/Amon/r1i1p1/*/pr/pr_Amon_NorESM1-ME_historical_r1i1p1*.nc 2023-05-30 13:08:40,113 UTC [368562] DEBUG esmvalcore._recipe.recipe:446 Using input files for variable pr of dataset NorESM1-ME: /projects/NS9034K/CMIP5/output1/NCC/NorESM1-ME/historical/mon/atmos/Amon/r1i1p1/v20140327/pr/pr_Amon_NorESM1-ME_historical_r1i1p1_185001-200512.nc 2023-05-30 13:08:40,113 UTC [368562] INFO esmvalcore._recipe.recipe:717 Found input files for Dataset: pr, Amon, CMIP5, NorESM1-ME, historical, r1i1p1, v20140327 2023-05-30 13:08:40,114 UTC [368562] INFO esmvalcore._recipe.recipe:873 PreprocessingTask catchment_analysis/pr created. 2023-05-30 13:08:40,114 UTC [368562] DEBUG esmvalcore._recipe.recipe:874 PreprocessingTask catchment_analysis/pr will create the files: /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/pr/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_pr_1970-2000.nc /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/pr/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_pr_1970-2000.nc /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/pr/CMIP5_NorESM1-ME_Amon_historical_r1i1p1_pr_1970-2000.nc 2023-05-30 13:08:40,114 UTC [368562] DEBUG esmvalcore._recipe.recipe:1091 Linking tasks for diagnostic catchment_analysis script catchment_analysis 2023-05-30 13:08:40,115 UTC [368562] DEBUG esmvalcore._recipe.recipe:1100 Pattern catchment_analysis/evspsbl matches ['catchment_analysis/evspsbl'] 2023-05-30 13:08:40,115 UTC [368562] DEBUG esmvalcore._recipe.recipe:1100 Pattern catchment_analysis/mrro matches ['catchment_analysis/mrro'] 2023-05-30 13:08:40,115 UTC [368562] DEBUG esmvalcore._recipe.recipe:1100 Pattern catchment_analysis/pr matches ['catchment_analysis/pr'] 2023-05-30 13:08:40,115 UTC [368562] INFO esmvalcore._recipe.recipe:1281 These tasks will be executed: catchment_analysis/evspsbl, catchment_analysis/mrro, catchment_analysis/pr, catchment_analysis/catchment_analysis 2023-05-30 13:08:40,117 UTC [368562] DEBUG esmvalcore._main:120 Recipe summary: DiagnosticTask: catchment_analysis/catchment_analysis script: runoff_et/catchment_analysis.py settings: {'auxiliary_data_dir': PosixPath('/projects/NS9560K-datalake/ESGF/auxiliary_data'), 'catchmentmask': 'catchmentmask_v1.nc', 'log_level': 'info', 'output_file_type': 'png', 'plot_dir': '/projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/plots/catchment_analysis/catchment_analysis', 'profile_diagnostic': False, 'recipe': PosixPath('recipe_runoff_et.yml'), 'run_dir': '/projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/run/catchment_analysis/catchment_analysis', 'script': 'catchment_analysis', 'version': '2.8.0', 'work_dir': '/projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/work/catchment_analysis/catchment_analysis'} ancestors: PreprocessingTask: catchment_analysis/evspsbl order: ['load', 'remove_supplementary_variables', 'save'] PreprocessorFile: /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/evspsbl/CMIP5_NorESM1-ME_Amon_historical_r1i1p1_evspsbl_1970-2000.nc input files: [LocalFile('/projects/NS9034K/CMIP5/output1/NCC/NorESM1-ME/historical/mon/atmos/Amon/r1i1p1/v20140327/evspsbl/evspsbl_Amon_NorESM1-ME_historical_r1i1p1_185001-200512.nc')] settings: {'load': {'callback': 'default'}, 'remove_supplementary_variables': {}, 'save': {'compress': False, 'filename': PosixPath('/projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/evspsbl/CMIP5_NorESM1-ME_Amon_historical_r1i1p1_evspsbl_1970-2000.nc')}} PreprocessorFile: /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/evspsbl/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_evspsbl_1970-2000.nc input files: [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/v20120114/evspsbl/evspsbl_Amon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc')] settings: {'load': {'callback': 'default'}, 'remove_supplementary_variables': {}, 'save': {'compress': False, 'filename': PosixPath('/projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/evspsbl/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_evspsbl_1970-2000.nc')}} PreprocessorFile: /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/evspsbl/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_evspsbl_1970-2000.nc input files: [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/v20120315/evspsbl/evspsbl_Amon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc')] settings: {'load': {'callback': 'default'}, 'remove_supplementary_variables': {}, 'save': {'compress': False, 'filename': PosixPath('/projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/evspsbl/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_evspsbl_1970-2000.nc')}} ancestors: None PreprocessingTask: catchment_analysis/mrro order: ['load', 'remove_supplementary_variables', 'save'] PreprocessorFile: /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/mrro/CMIP5_NorESM1-ME_Lmon_historical_r1i1p1_mrro_1970-2000.nc input files: [LocalFile('/projects/NS9034K/CMIP5/output1/NCC/NorESM1-ME/historical/mon/land/Lmon/r1i1p1/v20120920/mrro/mrro_Lmon_NorESM1-ME_historical_r1i1p1_185001-200512.nc')] settings: {'load': {'callback': 'default'}, 'remove_supplementary_variables': {}, 'save': {'compress': False, 'filename': PosixPath('/projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/mrro/CMIP5_NorESM1-ME_Lmon_historical_r1i1p1_mrro_1970-2000.nc')}} PreprocessorFile: /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/mrro/CMIP5_MPI-ESM-LR_Lmon_historical_r1i1p1_mrro_1970-2000.nc input files: [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/land/Lmon/r1i1p1/v20120625/mrro/mrro_Lmon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc')] settings: {'load': {'callback': 'default'}, 'remove_supplementary_variables': {}, 'save': {'compress': False, 'filename': PosixPath('/projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/mrro/CMIP5_MPI-ESM-LR_Lmon_historical_r1i1p1_mrro_1970-2000.nc')}} PreprocessorFile: /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/mrro/CMIP5_IPSL-CM5B-LR_Lmon_historical_r1i1p1_mrro_1970-2000.nc input files: [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/land/Lmon/r1i1p1/v20130506/mrro/mrro_Lmon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc')] settings: {'load': {'callback': 'default'}, 'remove_supplementary_variables': {}, 'save': {'compress': False, 'filename': PosixPath('/projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/mrro/CMIP5_IPSL-CM5B-LR_Lmon_historical_r1i1p1_mrro_1970-2000.nc')}} ancestors: None PreprocessingTask: catchment_analysis/pr order: ['load', 'remove_supplementary_variables', 'save'] PreprocessorFile: /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/pr/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_pr_1970-2000.nc input files: [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/v20120315/pr/pr_Amon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc')] settings: {'load': {'callback': 'default'}, 'remove_supplementary_variables': {}, 'save': {'compress': False, 'filename': PosixPath('/projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/pr/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_pr_1970-2000.nc')}} PreprocessorFile: /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/pr/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_pr_1970-2000.nc input files: [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/v20120114/pr/pr_Amon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc')] settings: {'load': {'callback': 'default'}, 'remove_supplementary_variables': {}, 'save': {'compress': False, 'filename': PosixPath('/projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/pr/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_pr_1970-2000.nc')}} PreprocessorFile: /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/pr/CMIP5_NorESM1-ME_Amon_historical_r1i1p1_pr_1970-2000.nc input files: [LocalFile('/projects/NS9034K/CMIP5/output1/NCC/NorESM1-ME/historical/mon/atmos/Amon/r1i1p1/v20140327/pr/pr_Amon_NorESM1-ME_historical_r1i1p1_185001-200512.nc')] settings: {'load': {'callback': 'default'}, 'remove_supplementary_variables': {}, 'save': {'compress': False, 'filename': PosixPath('/projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/pr/CMIP5_NorESM1-ME_Amon_historical_r1i1p1_pr_1970-2000.nc')}} ancestors: None 2023-05-30 13:08:40,125 UTC [368562] INFO esmvalcore._recipe.recipe:1344 Wrote recipe with version numbers and wildcards to: file:///projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/run/recipe_runoff_et_filled.yml 2023-05-30 13:08:40,125 UTC [368562] DEBUG esmvalcore.esgf._download:535 All required data is available locally, not downloading anything. 2023-05-30 13:08:40,125 UTC [368562] INFO esmvalcore._task:746 Running 4 tasks using 2 processes 2023-05-30 13:08:40,178 UTC [368832] INFO esmvalcore._task:259 Starting task catchment_analysis/evspsbl in process [368832] 2023-05-30 13:08:40,178 UTC [368833] INFO esmvalcore._task:259 Starting task catchment_analysis/mrro in process [368833] 2023-05-30 13:08:40,274 UTC [368562] INFO esmvalcore._task:778 Progress: 2 tasks running, 2 tasks waiting for ancestors, 0/4 done 2023-05-30 13:08:40,346 UTC [368833] DEBUG esmvalcore.esgf._download:535 All required data is available locally, not downloading anything. 2023-05-30 13:08:40,347 UTC [368833] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_file 2023-05-30 13:08:40,347 UTC [368833] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'fix_file' on the data LocalFile('/projects/NS9034K/CMIP5/output1/NCC/NorESM1-ME/historical/mon/land/Lmon/r1i1p1/v20120920/mrro/mrro_Lmon_NorESM1-ME_historical_r1i1p1_185001-200512.nc') loaded from original input file(s) [LocalFile('/projects/NS9034K/CMIP5/output1/NCC/NorESM1-ME/historical/mon/land/Lmon/r1i1p1/v20120920/mrro/mrro_Lmon_NorESM1-ME_historical_r1i1p1_185001-200512.nc')] with function argument(s) output_dir = PosixPath('/projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/fixed_files/mrro_Lmon_CMIP5_NorESM1-ME_historical_r1i1p1_v20120920_'), add_unique_suffix = True, mip = 'Lmon', dataset = 'NorESM1-ME', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', short_name = 'mrro', timerange = '1970/2000', variable_group = 'mrro', diagnostic = 'catchment_analysis', recipe_dataset_index = 2, alias = 'NorESM1-ME', product = ['output1', 'output2'], institute = ['NCC'], original_short_name = 'mrro', standard_name = 'runoff_flux', long_name = 'Total Runoff', units = 'kg m-2 s-1', modeling_realm = ['land'], frequency = 'mon', version = 'v20120920' 2023-05-30 13:08:40,348 UTC [368833] DEBUG esmvalcore.preprocessor:390 Result [LocalFile('/projects/NS9034K/CMIP5/output1/NCC/NorESM1-ME/historical/mon/land/Lmon/r1i1p1/v20120920/mrro/mrro_Lmon_NorESM1-ME_historical_r1i1p1_185001-200512.nc')] 2023-05-30 13:08:40,349 UTC [368833] DEBUG esmvalcore.preprocessor:369 Running preprocessor step load 2023-05-30 13:08:40,349 UTC [368833] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'load' on the data LocalFile('/projects/NS9034K/CMIP5/output1/NCC/NorESM1-ME/historical/mon/land/Lmon/r1i1p1/v20120920/mrro/mrro_Lmon_NorESM1-ME_historical_r1i1p1_185001-200512.nc') loaded from original input file(s) [LocalFile('/projects/NS9034K/CMIP5/output1/NCC/NorESM1-ME/historical/mon/land/Lmon/r1i1p1/v20120920/mrro/mrro_Lmon_NorESM1-ME_historical_r1i1p1_185001-200512.nc')] with function argument(s) callback = 'default' 2023-05-30 13:08:40,349 UTC [368833] DEBUG esmvalcore.preprocessor._io:152 Loading: /projects/NS9034K/CMIP5/output1/NCC/NorESM1-ME/historical/mon/land/Lmon/r1i1p1/v20120920/mrro/mrro_Lmon_NorESM1-ME_historical_r1i1p1_185001-200512.nc 2023-05-30 13:08:40,355 UTC [368832] DEBUG esmvalcore.esgf._download:535 All required data is available locally, not downloading anything. 2023-05-30 13:08:40,355 UTC [368832] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_file 2023-05-30 13:08:40,356 UTC [368832] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'fix_file' on the data LocalFile('/projects/NS9034K/CMIP5/output1/NCC/NorESM1-ME/historical/mon/atmos/Amon/r1i1p1/v20140327/evspsbl/evspsbl_Amon_NorESM1-ME_historical_r1i1p1_185001-200512.nc') loaded from original input file(s) [LocalFile('/projects/NS9034K/CMIP5/output1/NCC/NorESM1-ME/historical/mon/atmos/Amon/r1i1p1/v20140327/evspsbl/evspsbl_Amon_NorESM1-ME_historical_r1i1p1_185001-200512.nc')] with function argument(s) output_dir = PosixPath('/projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/fixed_files/evspsbl_Amon_CMIP5_NorESM1-ME_historical_r1i1p1_v20140327_'), add_unique_suffix = True, mip = 'Amon', dataset = 'NorESM1-ME', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', short_name = 'evspsbl', timerange = '1970/2000', variable_group = 'evspsbl', diagnostic = 'catchment_analysis', recipe_dataset_index = 2, alias = 'NorESM1-ME', product = ['output1', 'output2'], institute = ['NCC'], original_short_name = 'evspsbl', standard_name = 'water_evaporation_flux', long_name = 'Evaporation', units = 'kg m-2 s-1', modeling_realm = ['atmos'], frequency = 'mon', version = 'v20140327' 2023-05-30 13:08:40,357 UTC [368832] DEBUG esmvalcore.preprocessor:390 Result [LocalFile('/projects/NS9034K/CMIP5/output1/NCC/NorESM1-ME/historical/mon/atmos/Amon/r1i1p1/v20140327/evspsbl/evspsbl_Amon_NorESM1-ME_historical_r1i1p1_185001-200512.nc')] 2023-05-30 13:08:40,357 UTC [368832] DEBUG esmvalcore.preprocessor:369 Running preprocessor step load 2023-05-30 13:08:40,357 UTC [368832] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'load' on the data LocalFile('/projects/NS9034K/CMIP5/output1/NCC/NorESM1-ME/historical/mon/atmos/Amon/r1i1p1/v20140327/evspsbl/evspsbl_Amon_NorESM1-ME_historical_r1i1p1_185001-200512.nc') loaded from original input file(s) [LocalFile('/projects/NS9034K/CMIP5/output1/NCC/NorESM1-ME/historical/mon/atmos/Amon/r1i1p1/v20140327/evspsbl/evspsbl_Amon_NorESM1-ME_historical_r1i1p1_185001-200512.nc')] with function argument(s) callback = 'default' 2023-05-30 13:08:40,357 UTC [368832] DEBUG esmvalcore.preprocessor._io:152 Loading: /projects/NS9034K/CMIP5/output1/NCC/NorESM1-ME/historical/mon/atmos/Amon/r1i1p1/v20140327/evspsbl/evspsbl_Amon_NorESM1-ME_historical_r1i1p1_185001-200512.nc 2023-05-30 13:08:40,606 UTC [368833] DEBUG esmvalcore.preprocessor._io:182 Done with loading /projects/NS9034K/CMIP5/output1/NCC/NorESM1-ME/historical/mon/land/Lmon/r1i1p1/v20120920/mrro/mrro_Lmon_NorESM1-ME_historical_r1i1p1_185001-200512.nc 2023-05-30 13:08:40,606 UTC [368833] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:40,610 UTC [368833] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/mrro/CMIP5_NorESM1-ME_Lmon_historical_r1i1p1_mrro_1970-2000/00_load.nc 2023-05-30 13:08:40,664 UTC [368832] DEBUG esmvalcore.preprocessor._io:182 Done with loading /projects/NS9034K/CMIP5/output1/NCC/NorESM1-ME/historical/mon/atmos/Amon/r1i1p1/v20140327/evspsbl/evspsbl_Amon_NorESM1-ME_historical_r1i1p1_185001-200512.nc 2023-05-30 13:08:40,664 UTC [368832] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:40,667 UTC [368832] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/evspsbl/CMIP5_NorESM1-ME_Amon_historical_r1i1p1_evspsbl_1970-2000/00_load.nc 2023-05-30 13:08:41,131 UTC [368833] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_metadata 2023-05-30 13:08:41,133 UTC [368833] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'fix_metadata' on the data [] loaded from original input file(s) [LocalFile('/projects/NS9034K/CMIP5/output1/NCC/NorESM1-ME/historical/mon/land/Lmon/r1i1p1/v20120920/mrro/mrro_Lmon_NorESM1-ME_historical_r1i1p1_185001-200512.nc')] with function argument(s) check_level = , mip = 'Lmon', dataset = 'NorESM1-ME', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', short_name = 'mrro', timerange = '1970/2000', variable_group = 'mrro', diagnostic = 'catchment_analysis', recipe_dataset_index = 2, alias = 'NorESM1-ME', product = ['output1', 'output2'], institute = ['NCC'], original_short_name = 'mrro', standard_name = 'runoff_flux', long_name = 'Total Runoff', units = 'kg m-2 s-1', modeling_realm = ['land'], frequency = 'mon', version = 'v20120920' 2023-05-30 13:08:41,139 UTC [368833] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:41,139 UTC [368833] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/mrro/CMIP5_NorESM1-ME_Lmon_historical_r1i1p1_mrro_1970-2000/01_fix_metadata.nc 2023-05-30 13:08:41,174 UTC [368832] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_metadata 2023-05-30 13:08:41,175 UTC [368832] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'fix_metadata' on the data [] loaded from original input file(s) [LocalFile('/projects/NS9034K/CMIP5/output1/NCC/NorESM1-ME/historical/mon/atmos/Amon/r1i1p1/v20140327/evspsbl/evspsbl_Amon_NorESM1-ME_historical_r1i1p1_185001-200512.nc')] with function argument(s) check_level = , mip = 'Amon', dataset = 'NorESM1-ME', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', short_name = 'evspsbl', timerange = '1970/2000', variable_group = 'evspsbl', diagnostic = 'catchment_analysis', recipe_dataset_index = 2, alias = 'NorESM1-ME', product = ['output1', 'output2'], institute = ['NCC'], original_short_name = 'evspsbl', standard_name = 'water_evaporation_flux', long_name = 'Evaporation', units = 'kg m-2 s-1', modeling_realm = ['atmos'], frequency = 'mon', version = 'v20140327' 2023-05-30 13:08:41,182 UTC [368832] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:41,183 UTC [368832] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/evspsbl/CMIP5_NorESM1-ME_Amon_historical_r1i1p1_evspsbl_1970-2000/01_fix_metadata.nc 2023-05-30 13:08:41,373 UTC [368833] DEBUG esmvalcore.preprocessor:369 Running preprocessor step concatenate 2023-05-30 13:08:41,375 UTC [368833] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'concatenate' on the data [] loaded from original input file(s) [LocalFile('/projects/NS9034K/CMIP5/output1/NCC/NorESM1-ME/historical/mon/land/Lmon/r1i1p1/v20120920/mrro/mrro_Lmon_NorESM1-ME_historical_r1i1p1_185001-200512.nc')] with function argument(s) 2023-05-30 13:08:41,375 UTC [368833] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:41,375 UTC [368833] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/mrro/CMIP5_NorESM1-ME_Lmon_historical_r1i1p1_mrro_1970-2000/02_concatenate.nc 2023-05-30 13:08:41,418 UTC [368832] DEBUG esmvalcore.preprocessor:369 Running preprocessor step concatenate 2023-05-30 13:08:41,419 UTC [368832] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'concatenate' on the data [] loaded from original input file(s) [LocalFile('/projects/NS9034K/CMIP5/output1/NCC/NorESM1-ME/historical/mon/atmos/Amon/r1i1p1/v20140327/evspsbl/evspsbl_Amon_NorESM1-ME_historical_r1i1p1_185001-200512.nc')] with function argument(s) 2023-05-30 13:08:41,420 UTC [368832] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:41,420 UTC [368832] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/evspsbl/CMIP5_NorESM1-ME_Amon_historical_r1i1p1_evspsbl_1970-2000/02_concatenate.nc 2023-05-30 13:08:41,604 UTC [368833] DEBUG esmvalcore.preprocessor:369 Running preprocessor step cmor_check_metadata 2023-05-30 13:08:41,605 UTC [368833] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'cmor_check_metadata' on the data loaded from original input file(s) [LocalFile('/projects/NS9034K/CMIP5/output1/NCC/NorESM1-ME/historical/mon/land/Lmon/r1i1p1/v20120920/mrro/mrro_Lmon_NorESM1-ME_historical_r1i1p1_185001-200512.nc')] with function argument(s) check_level = , cmor_table = 'CMIP5', mip = 'Lmon', frequency = 'mon', short_name = 'mrro' 2023-05-30 13:08:41,610 UTC [368833] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:41,611 UTC [368833] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/mrro/CMIP5_NorESM1-ME_Lmon_historical_r1i1p1_mrro_1970-2000/03_cmor_check_metadata.nc 2023-05-30 13:08:41,650 UTC [368832] DEBUG esmvalcore.preprocessor:369 Running preprocessor step cmor_check_metadata 2023-05-30 13:08:41,651 UTC [368832] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'cmor_check_metadata' on the data loaded from original input file(s) [LocalFile('/projects/NS9034K/CMIP5/output1/NCC/NorESM1-ME/historical/mon/atmos/Amon/r1i1p1/v20140327/evspsbl/evspsbl_Amon_NorESM1-ME_historical_r1i1p1_185001-200512.nc')] with function argument(s) check_level = , cmor_table = 'CMIP5', mip = 'Amon', frequency = 'mon', short_name = 'evspsbl' 2023-05-30 13:08:41,657 UTC [368832] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:41,658 UTC [368832] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/evspsbl/CMIP5_NorESM1-ME_Amon_historical_r1i1p1_evspsbl_1970-2000/03_cmor_check_metadata.nc 2023-05-30 13:08:41,876 UTC [368833] DEBUG esmvalcore.preprocessor:369 Running preprocessor step clip_timerange 2023-05-30 13:08:41,877 UTC [368833] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'clip_timerange' on the data loaded from original input file(s) [LocalFile('/projects/NS9034K/CMIP5/output1/NCC/NorESM1-ME/historical/mon/land/Lmon/r1i1p1/v20120920/mrro/mrro_Lmon_NorESM1-ME_historical_r1i1p1_185001-200512.nc')] with function argument(s) timerange = '1970/2000' 2023-05-30 13:08:41,887 UTC [368832] DEBUG esmvalcore.preprocessor:369 Running preprocessor step clip_timerange 2023-05-30 13:08:41,888 UTC [368832] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'clip_timerange' on the data loaded from original input file(s) [LocalFile('/projects/NS9034K/CMIP5/output1/NCC/NorESM1-ME/historical/mon/atmos/Amon/r1i1p1/v20140327/evspsbl/evspsbl_Amon_NorESM1-ME_historical_r1i1p1_185001-200512.nc')] with function argument(s) timerange = '1970/2000' 2023-05-30 13:08:41,889 UTC [368833] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:41,890 UTC [368833] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/mrro/CMIP5_NorESM1-ME_Lmon_historical_r1i1p1_mrro_1970-2000/04_clip_timerange.nc 2023-05-30 13:08:41,901 UTC [368832] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:41,902 UTC [368832] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/evspsbl/CMIP5_NorESM1-ME_Amon_historical_r1i1p1_evspsbl_1970-2000/04_clip_timerange.nc 2023-05-30 13:08:42,154 UTC [368833] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_data 2023-05-30 13:08:42,156 UTC [368833] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'fix_data' on the data loaded from original input file(s) [LocalFile('/projects/NS9034K/CMIP5/output1/NCC/NorESM1-ME/historical/mon/land/Lmon/r1i1p1/v20120920/mrro/mrro_Lmon_NorESM1-ME_historical_r1i1p1_185001-200512.nc')] with function argument(s) check_level = , mip = 'Lmon', dataset = 'NorESM1-ME', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', short_name = 'mrro', timerange = '1970/2000', variable_group = 'mrro', diagnostic = 'catchment_analysis', recipe_dataset_index = 2, alias = 'NorESM1-ME', product = ['output1', 'output2'], institute = ['NCC'], original_short_name = 'mrro', standard_name = 'runoff_flux', long_name = 'Total Runoff', units = 'kg m-2 s-1', modeling_realm = ['land'], frequency = 'mon', version = 'v20120920' 2023-05-30 13:08:42,156 UTC [368833] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:42,157 UTC [368833] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/mrro/CMIP5_NorESM1-ME_Lmon_historical_r1i1p1_mrro_1970-2000/05_fix_data.nc 2023-05-30 13:08:42,176 UTC [368832] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_data 2023-05-30 13:08:42,177 UTC [368832] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'fix_data' on the data loaded from original input file(s) [LocalFile('/projects/NS9034K/CMIP5/output1/NCC/NorESM1-ME/historical/mon/atmos/Amon/r1i1p1/v20140327/evspsbl/evspsbl_Amon_NorESM1-ME_historical_r1i1p1_185001-200512.nc')] with function argument(s) check_level = , mip = 'Amon', dataset = 'NorESM1-ME', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', short_name = 'evspsbl', timerange = '1970/2000', variable_group = 'evspsbl', diagnostic = 'catchment_analysis', recipe_dataset_index = 2, alias = 'NorESM1-ME', product = ['output1', 'output2'], institute = ['NCC'], original_short_name = 'evspsbl', standard_name = 'water_evaporation_flux', long_name = 'Evaporation', units = 'kg m-2 s-1', modeling_realm = ['atmos'], frequency = 'mon', version = 'v20140327' 2023-05-30 13:08:42,177 UTC [368832] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:42,178 UTC [368832] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/evspsbl/CMIP5_NorESM1-ME_Amon_historical_r1i1p1_evspsbl_1970-2000/05_fix_data.nc 2023-05-30 13:08:42,407 UTC [368833] DEBUG esmvalcore.preprocessor:369 Running preprocessor step cmor_check_data 2023-05-30 13:08:42,408 UTC [368833] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'cmor_check_data' on the data loaded from original input file(s) [LocalFile('/projects/NS9034K/CMIP5/output1/NCC/NorESM1-ME/historical/mon/land/Lmon/r1i1p1/v20120920/mrro/mrro_Lmon_NorESM1-ME_historical_r1i1p1_185001-200512.nc')] with function argument(s) check_level = , cmor_table = 'CMIP5', mip = 'Lmon', frequency = 'mon', short_name = 'mrro' 2023-05-30 13:08:42,409 UTC [368833] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:42,409 UTC [368833] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/mrro/CMIP5_NorESM1-ME_Lmon_historical_r1i1p1_mrro_1970-2000/06_cmor_check_data.nc 2023-05-30 13:08:42,437 UTC [368832] DEBUG esmvalcore.preprocessor:369 Running preprocessor step cmor_check_data 2023-05-30 13:08:42,438 UTC [368832] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'cmor_check_data' on the data loaded from original input file(s) [LocalFile('/projects/NS9034K/CMIP5/output1/NCC/NorESM1-ME/historical/mon/atmos/Amon/r1i1p1/v20140327/evspsbl/evspsbl_Amon_NorESM1-ME_historical_r1i1p1_185001-200512.nc')] with function argument(s) check_level = , cmor_table = 'CMIP5', mip = 'Amon', frequency = 'mon', short_name = 'evspsbl' 2023-05-30 13:08:42,439 UTC [368832] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:42,439 UTC [368832] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/evspsbl/CMIP5_NorESM1-ME_Amon_historical_r1i1p1_evspsbl_1970-2000/06_cmor_check_data.nc 2023-05-30 13:08:42,663 UTC [368833] DEBUG esmvalcore.preprocessor:369 Running preprocessor step add_supplementary_variables 2023-05-30 13:08:42,664 UTC [368833] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'add_supplementary_variables' on the data loaded from original input file(s) [LocalFile('/projects/NS9034K/CMIP5/output1/NCC/NorESM1-ME/historical/mon/land/Lmon/r1i1p1/v20120920/mrro/mrro_Lmon_NorESM1-ME_historical_r1i1p1_185001-200512.nc')] with function argument(s) supplementary_cubes = [] 2023-05-30 13:08:42,664 UTC [368833] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:42,665 UTC [368833] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/mrro/CMIP5_NorESM1-ME_Lmon_historical_r1i1p1_mrro_1970-2000/07_add_supplementary_variables.nc 2023-05-30 13:08:42,705 UTC [368832] DEBUG esmvalcore.preprocessor:369 Running preprocessor step add_supplementary_variables 2023-05-30 13:08:42,706 UTC [368832] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'add_supplementary_variables' on the data loaded from original input file(s) [LocalFile('/projects/NS9034K/CMIP5/output1/NCC/NorESM1-ME/historical/mon/atmos/Amon/r1i1p1/v20140327/evspsbl/evspsbl_Amon_NorESM1-ME_historical_r1i1p1_185001-200512.nc')] with function argument(s) supplementary_cubes = [] 2023-05-30 13:08:42,706 UTC [368832] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:42,707 UTC [368832] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/evspsbl/CMIP5_NorESM1-ME_Amon_historical_r1i1p1_evspsbl_1970-2000/07_add_supplementary_variables.nc 2023-05-30 13:08:42,919 UTC [368833] DEBUG esmvalcore.preprocessor:369 Running preprocessor step save 2023-05-30 13:08:42,921 UTC [368833] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'save' on the data [] loaded from original input file(s) [LocalFile('/projects/NS9034K/CMIP5/output1/NCC/NorESM1-ME/historical/mon/land/Lmon/r1i1p1/v20120920/mrro/mrro_Lmon_NorESM1-ME_historical_r1i1p1_185001-200512.nc')] with function argument(s) compress = False, filename = PosixPath('/projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/mrro/CMIP5_NorESM1-ME_Lmon_historical_r1i1p1_mrro_1970-2000.nc') 2023-05-30 13:08:42,921 UTC [368833] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/mrro/CMIP5_NorESM1-ME_Lmon_historical_r1i1p1_mrro_1970-2000.nc 2023-05-30 13:08:42,966 UTC [368832] DEBUG esmvalcore.preprocessor:369 Running preprocessor step save 2023-05-30 13:08:42,968 UTC [368832] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'save' on the data [] loaded from original input file(s) [LocalFile('/projects/NS9034K/CMIP5/output1/NCC/NorESM1-ME/historical/mon/atmos/Amon/r1i1p1/v20140327/evspsbl/evspsbl_Amon_NorESM1-ME_historical_r1i1p1_185001-200512.nc')] with function argument(s) compress = False, filename = PosixPath('/projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/evspsbl/CMIP5_NorESM1-ME_Amon_historical_r1i1p1_evspsbl_1970-2000.nc') 2023-05-30 13:08:42,969 UTC [368832] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/evspsbl/CMIP5_NorESM1-ME_Amon_historical_r1i1p1_evspsbl_1970-2000.nc 2023-05-30 13:08:43,218 UTC [368833] DEBUG esmvalcore.esgf._download:535 All required data is available locally, not downloading anything. 2023-05-30 13:08:43,219 UTC [368833] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_file 2023-05-30 13:08:43,219 UTC [368833] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'fix_file' on the data LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/land/Lmon/r1i1p1/v20120625/mrro/mrro_Lmon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc') loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/land/Lmon/r1i1p1/v20120625/mrro/mrro_Lmon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) output_dir = PosixPath('/projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/fixed_files/mrro_Lmon_CMIP5_MPI-ESM-LR_historical_r1i1p1_v20120625_'), add_unique_suffix = True, mip = 'Lmon', dataset = 'MPI-ESM-LR', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', short_name = 'mrro', timerange = '1970/2000', variable_group = 'mrro', diagnostic = 'catchment_analysis', recipe_dataset_index = 0, alias = 'MPI-ESM-LR', product = ['output1', 'output2'], institute = ['MPI-M'], original_short_name = 'mrro', standard_name = 'runoff_flux', long_name = 'Total Runoff', units = 'kg m-2 s-1', modeling_realm = ['land'], frequency = 'mon', version = 'v20120625' 2023-05-30 13:08:43,220 UTC [368833] DEBUG esmvalcore.preprocessor:390 Result [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/land/Lmon/r1i1p1/v20120625/mrro/mrro_Lmon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc')] 2023-05-30 13:08:43,220 UTC [368833] DEBUG esmvalcore.preprocessor:369 Running preprocessor step load 2023-05-30 13:08:43,221 UTC [368833] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'load' on the data LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/land/Lmon/r1i1p1/v20120625/mrro/mrro_Lmon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc') loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/land/Lmon/r1i1p1/v20120625/mrro/mrro_Lmon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) callback = 'default' 2023-05-30 13:08:43,221 UTC [368833] DEBUG esmvalcore.preprocessor._io:152 Loading: /projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/land/Lmon/r1i1p1/v20120625/mrro/mrro_Lmon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc 2023-05-30 13:08:43,311 UTC [368832] DEBUG esmvalcore.esgf._download:535 All required data is available locally, not downloading anything. 2023-05-30 13:08:43,311 UTC [368832] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_file 2023-05-30 13:08:43,312 UTC [368832] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'fix_file' on the data LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/v20120114/evspsbl/evspsbl_Amon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc') loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/v20120114/evspsbl/evspsbl_Amon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) output_dir = PosixPath('/projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/fixed_files/evspsbl_Amon_CMIP5_IPSL-CM5B-LR_historical_r1i1p1_v20120114_'), add_unique_suffix = True, mip = 'Amon', dataset = 'IPSL-CM5B-LR', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', short_name = 'evspsbl', timerange = '1970/2000', variable_group = 'evspsbl', diagnostic = 'catchment_analysis', recipe_dataset_index = 1, alias = 'IPSL-CM5B-LR', product = ['output1', 'output2'], institute = ['IPSL'], original_short_name = 'evspsbl', standard_name = 'water_evaporation_flux', long_name = 'Evaporation', units = 'kg m-2 s-1', modeling_realm = ['atmos'], frequency = 'mon', version = 'v20120114' 2023-05-30 13:08:43,313 UTC [368832] DEBUG esmvalcore.preprocessor:390 Result [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/v20120114/evspsbl/evspsbl_Amon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc')] 2023-05-30 13:08:43,313 UTC [368832] DEBUG esmvalcore.preprocessor:369 Running preprocessor step load 2023-05-30 13:08:43,313 UTC [368832] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'load' on the data LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/v20120114/evspsbl/evspsbl_Amon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc') loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/v20120114/evspsbl/evspsbl_Amon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) callback = 'default' 2023-05-30 13:08:43,313 UTC [368832] DEBUG esmvalcore.preprocessor._io:152 Loading: /projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/v20120114/evspsbl/evspsbl_Amon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc 2023-05-30 13:08:43,415 UTC [368832] DEBUG esmvalcore.preprocessor._io:182 Done with loading /projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/v20120114/evspsbl/evspsbl_Amon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc 2023-05-30 13:08:43,415 UTC [368832] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:43,417 UTC [368832] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/evspsbl/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_evspsbl_1970-2000/00_load.nc 2023-05-30 13:08:43,542 UTC [368833] DEBUG esmvalcore.preprocessor._io:182 Done with loading /projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/land/Lmon/r1i1p1/v20120625/mrro/mrro_Lmon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc 2023-05-30 13:08:43,542 UTC [368833] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:43,543 UTC [368833] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/mrro/CMIP5_MPI-ESM-LR_Lmon_historical_r1i1p1_mrro_1970-2000/00_load.nc 2023-05-30 13:08:43,632 UTC [368832] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_metadata 2023-05-30 13:08:43,634 UTC [368832] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'fix_metadata' on the data [] loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/v20120114/evspsbl/evspsbl_Amon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) check_level = , mip = 'Amon', dataset = 'IPSL-CM5B-LR', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', short_name = 'evspsbl', timerange = '1970/2000', variable_group = 'evspsbl', diagnostic = 'catchment_analysis', recipe_dataset_index = 1, alias = 'IPSL-CM5B-LR', product = ['output1', 'output2'], institute = ['IPSL'], original_short_name = 'evspsbl', standard_name = 'water_evaporation_flux', long_name = 'Evaporation', units = 'kg m-2 s-1', modeling_realm = ['atmos'], frequency = 'mon', version = 'v20120114' 2023-05-30 13:08:43,640 UTC [368832] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:43,641 UTC [368832] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/evspsbl/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_evspsbl_1970-2000/01_fix_metadata.nc 2023-05-30 13:08:43,825 UTC [368832] DEBUG esmvalcore.preprocessor:369 Running preprocessor step concatenate 2023-05-30 13:08:43,827 UTC [368832] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'concatenate' on the data [] loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/v20120114/evspsbl/evspsbl_Amon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) 2023-05-30 13:08:43,827 UTC [368832] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:43,827 UTC [368832] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/evspsbl/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_evspsbl_1970-2000/02_concatenate.nc 2023-05-30 13:08:43,888 UTC [368833] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_metadata 2023-05-30 13:08:43,890 UTC [368833] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'fix_metadata' on the data [] loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/land/Lmon/r1i1p1/v20120625/mrro/mrro_Lmon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) check_level = , mip = 'Lmon', dataset = 'MPI-ESM-LR', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', short_name = 'mrro', timerange = '1970/2000', variable_group = 'mrro', diagnostic = 'catchment_analysis', recipe_dataset_index = 0, alias = 'MPI-ESM-LR', product = ['output1', 'output2'], institute = ['MPI-M'], original_short_name = 'mrro', standard_name = 'runoff_flux', long_name = 'Total Runoff', units = 'kg m-2 s-1', modeling_realm = ['land'], frequency = 'mon', version = 'v20120625' 2023-05-30 13:08:43,896 UTC [368833] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:43,897 UTC [368833] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/mrro/CMIP5_MPI-ESM-LR_Lmon_historical_r1i1p1_mrro_1970-2000/01_fix_metadata.nc 2023-05-30 13:08:44,004 UTC [368832] DEBUG esmvalcore.preprocessor:369 Running preprocessor step cmor_check_metadata 2023-05-30 13:08:44,005 UTC [368832] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'cmor_check_metadata' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/v20120114/evspsbl/evspsbl_Amon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) check_level = , cmor_table = 'CMIP5', mip = 'Amon', frequency = 'mon', short_name = 'evspsbl' 2023-05-30 13:08:44,012 UTC [368832] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:44,013 UTC [368832] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/evspsbl/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_evspsbl_1970-2000/03_cmor_check_metadata.nc 2023-05-30 13:08:44,212 UTC [368833] DEBUG esmvalcore.preprocessor:369 Running preprocessor step concatenate 2023-05-30 13:08:44,213 UTC [368833] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'concatenate' on the data [] loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/land/Lmon/r1i1p1/v20120625/mrro/mrro_Lmon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) 2023-05-30 13:08:44,214 UTC [368833] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:44,214 UTC [368833] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/mrro/CMIP5_MPI-ESM-LR_Lmon_historical_r1i1p1_mrro_1970-2000/02_concatenate.nc 2023-05-30 13:08:44,225 UTC [368832] DEBUG esmvalcore.preprocessor:369 Running preprocessor step clip_timerange 2023-05-30 13:08:44,227 UTC [368832] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'clip_timerange' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/v20120114/evspsbl/evspsbl_Amon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) timerange = '1970/2000' 2023-05-30 13:08:44,237 UTC [368832] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:44,237 UTC [368832] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/evspsbl/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_evspsbl_1970-2000/04_clip_timerange.nc 2023-05-30 13:08:44,390 UTC [368832] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_data 2023-05-30 13:08:44,391 UTC [368832] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'fix_data' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/v20120114/evspsbl/evspsbl_Amon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) check_level = , mip = 'Amon', dataset = 'IPSL-CM5B-LR', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', short_name = 'evspsbl', timerange = '1970/2000', variable_group = 'evspsbl', diagnostic = 'catchment_analysis', recipe_dataset_index = 1, alias = 'IPSL-CM5B-LR', product = ['output1', 'output2'], institute = ['IPSL'], original_short_name = 'evspsbl', standard_name = 'water_evaporation_flux', long_name = 'Evaporation', units = 'kg m-2 s-1', modeling_realm = ['atmos'], frequency = 'mon', version = 'v20120114' 2023-05-30 13:08:44,392 UTC [368832] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:44,393 UTC [368832] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/evspsbl/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_evspsbl_1970-2000/05_fix_data.nc 2023-05-30 13:08:44,533 UTC [368832] DEBUG esmvalcore.preprocessor:369 Running preprocessor step cmor_check_data 2023-05-30 13:08:44,534 UTC [368832] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'cmor_check_data' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/v20120114/evspsbl/evspsbl_Amon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) check_level = , cmor_table = 'CMIP5', mip = 'Amon', frequency = 'mon', short_name = 'evspsbl' 2023-05-30 13:08:44,534 UTC [368832] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:44,535 UTC [368832] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/evspsbl/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_evspsbl_1970-2000/06_cmor_check_data.nc 2023-05-30 13:08:44,555 UTC [368833] DEBUG esmvalcore.preprocessor:369 Running preprocessor step cmor_check_metadata 2023-05-30 13:08:44,556 UTC [368833] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'cmor_check_metadata' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/land/Lmon/r1i1p1/v20120625/mrro/mrro_Lmon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) check_level = , cmor_table = 'CMIP5', mip = 'Lmon', frequency = 'mon', short_name = 'mrro' 2023-05-30 13:08:44,563 UTC [368833] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:44,563 UTC [368833] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/mrro/CMIP5_MPI-ESM-LR_Lmon_historical_r1i1p1_mrro_1970-2000/03_cmor_check_metadata.nc 2023-05-30 13:08:44,685 UTC [368832] DEBUG esmvalcore.preprocessor:369 Running preprocessor step add_supplementary_variables 2023-05-30 13:08:44,686 UTC [368832] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'add_supplementary_variables' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/v20120114/evspsbl/evspsbl_Amon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) supplementary_cubes = [] 2023-05-30 13:08:44,686 UTC [368832] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:44,687 UTC [368832] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/evspsbl/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_evspsbl_1970-2000/07_add_supplementary_variables.nc 2023-05-30 13:08:44,829 UTC [368832] DEBUG esmvalcore.preprocessor:369 Running preprocessor step save 2023-05-30 13:08:44,831 UTC [368832] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'save' on the data [] loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/v20120114/evspsbl/evspsbl_Amon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) compress = False, filename = PosixPath('/projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/evspsbl/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_evspsbl_1970-2000.nc') 2023-05-30 13:08:44,831 UTC [368832] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/evspsbl/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_evspsbl_1970-2000.nc 2023-05-30 13:08:44,949 UTC [368833] DEBUG esmvalcore.preprocessor:369 Running preprocessor step clip_timerange 2023-05-30 13:08:44,950 UTC [368833] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'clip_timerange' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/land/Lmon/r1i1p1/v20120625/mrro/mrro_Lmon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) timerange = '1970/2000' 2023-05-30 13:08:44,960 UTC [368833] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:44,961 UTC [368833] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/mrro/CMIP5_MPI-ESM-LR_Lmon_historical_r1i1p1_mrro_1970-2000/04_clip_timerange.nc 2023-05-30 13:08:44,974 UTC [368832] DEBUG esmvalcore.esgf._download:535 All required data is available locally, not downloading anything. 2023-05-30 13:08:44,974 UTC [368832] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_file 2023-05-30 13:08:44,975 UTC [368832] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'fix_file' on the data LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/v20120315/evspsbl/evspsbl_Amon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc') loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/v20120315/evspsbl/evspsbl_Amon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) output_dir = PosixPath('/projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/fixed_files/evspsbl_Amon_CMIP5_MPI-ESM-LR_historical_r1i1p1_v20120315_'), add_unique_suffix = True, mip = 'Amon', dataset = 'MPI-ESM-LR', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', short_name = 'evspsbl', timerange = '1970/2000', variable_group = 'evspsbl', diagnostic = 'catchment_analysis', recipe_dataset_index = 0, alias = 'MPI-ESM-LR', product = ['output1', 'output2'], institute = ['MPI-M'], original_short_name = 'evspsbl', standard_name = 'water_evaporation_flux', long_name = 'Evaporation', units = 'kg m-2 s-1', modeling_realm = ['atmos'], frequency = 'mon', version = 'v20120315' 2023-05-30 13:08:44,975 UTC [368832] DEBUG esmvalcore.preprocessor:390 Result [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/v20120315/evspsbl/evspsbl_Amon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc')] 2023-05-30 13:08:44,975 UTC [368832] DEBUG esmvalcore.preprocessor:369 Running preprocessor step load 2023-05-30 13:08:44,975 UTC [368832] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'load' on the data LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/v20120315/evspsbl/evspsbl_Amon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc') loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/v20120315/evspsbl/evspsbl_Amon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) callback = 'default' 2023-05-30 13:08:44,975 UTC [368832] DEBUG esmvalcore.preprocessor._io:152 Loading: /projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/v20120315/evspsbl/evspsbl_Amon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc 2023-05-30 13:08:45,157 UTC [368833] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_data 2023-05-30 13:08:45,158 UTC [368833] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'fix_data' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/land/Lmon/r1i1p1/v20120625/mrro/mrro_Lmon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) check_level = , mip = 'Lmon', dataset = 'MPI-ESM-LR', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', short_name = 'mrro', timerange = '1970/2000', variable_group = 'mrro', diagnostic = 'catchment_analysis', recipe_dataset_index = 0, alias = 'MPI-ESM-LR', product = ['output1', 'output2'], institute = ['MPI-M'], original_short_name = 'mrro', standard_name = 'runoff_flux', long_name = 'Total Runoff', units = 'kg m-2 s-1', modeling_realm = ['land'], frequency = 'mon', version = 'v20120625' 2023-05-30 13:08:45,158 UTC [368833] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:45,159 UTC [368833] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/mrro/CMIP5_MPI-ESM-LR_Lmon_historical_r1i1p1_mrro_1970-2000/05_fix_data.nc 2023-05-30 13:08:45,194 UTC [368832] DEBUG esmvalcore.preprocessor._io:182 Done with loading /projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/v20120315/evspsbl/evspsbl_Amon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc 2023-05-30 13:08:45,194 UTC [368832] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:45,195 UTC [368832] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/evspsbl/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_evspsbl_1970-2000/00_load.nc 2023-05-30 13:08:45,369 UTC [368833] DEBUG esmvalcore.preprocessor:369 Running preprocessor step cmor_check_data 2023-05-30 13:08:45,370 UTC [368833] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'cmor_check_data' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/land/Lmon/r1i1p1/v20120625/mrro/mrro_Lmon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) check_level = , cmor_table = 'CMIP5', mip = 'Lmon', frequency = 'mon', short_name = 'mrro' 2023-05-30 13:08:45,370 UTC [368833] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:45,371 UTC [368833] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/mrro/CMIP5_MPI-ESM-LR_Lmon_historical_r1i1p1_mrro_1970-2000/06_cmor_check_data.nc 2023-05-30 13:08:45,508 UTC [368832] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_metadata 2023-05-30 13:08:45,510 UTC [368832] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'fix_metadata' on the data [] loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/v20120315/evspsbl/evspsbl_Amon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) check_level = , mip = 'Amon', dataset = 'MPI-ESM-LR', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', short_name = 'evspsbl', timerange = '1970/2000', variable_group = 'evspsbl', diagnostic = 'catchment_analysis', recipe_dataset_index = 0, alias = 'MPI-ESM-LR', product = ['output1', 'output2'], institute = ['MPI-M'], original_short_name = 'evspsbl', standard_name = 'water_evaporation_flux', long_name = 'Evaporation', units = 'kg m-2 s-1', modeling_realm = ['atmos'], frequency = 'mon', version = 'v20120315' 2023-05-30 13:08:45,517 UTC [368832] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:45,517 UTC [368832] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/evspsbl/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_evspsbl_1970-2000/01_fix_metadata.nc 2023-05-30 13:08:45,561 UTC [368833] DEBUG esmvalcore.preprocessor:369 Running preprocessor step add_supplementary_variables 2023-05-30 13:08:45,562 UTC [368833] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'add_supplementary_variables' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/land/Lmon/r1i1p1/v20120625/mrro/mrro_Lmon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) supplementary_cubes = [] 2023-05-30 13:08:45,562 UTC [368833] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:45,563 UTC [368833] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/mrro/CMIP5_MPI-ESM-LR_Lmon_historical_r1i1p1_mrro_1970-2000/07_add_supplementary_variables.nc 2023-05-30 13:08:45,770 UTC [368833] DEBUG esmvalcore.preprocessor:369 Running preprocessor step save 2023-05-30 13:08:45,772 UTC [368833] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'save' on the data [] loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/land/Lmon/r1i1p1/v20120625/mrro/mrro_Lmon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) compress = False, filename = PosixPath('/projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/mrro/CMIP5_MPI-ESM-LR_Lmon_historical_r1i1p1_mrro_1970-2000.nc') 2023-05-30 13:08:45,772 UTC [368833] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/mrro/CMIP5_MPI-ESM-LR_Lmon_historical_r1i1p1_mrro_1970-2000.nc 2023-05-30 13:08:45,822 UTC [368832] DEBUG esmvalcore.preprocessor:369 Running preprocessor step concatenate 2023-05-30 13:08:45,824 UTC [368832] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'concatenate' on the data [] loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/v20120315/evspsbl/evspsbl_Amon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) 2023-05-30 13:08:45,824 UTC [368832] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:45,825 UTC [368832] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/evspsbl/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_evspsbl_1970-2000/02_concatenate.nc 2023-05-30 13:08:45,964 UTC [368833] DEBUG esmvalcore.esgf._download:535 All required data is available locally, not downloading anything. 2023-05-30 13:08:45,964 UTC [368833] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_file 2023-05-30 13:08:45,964 UTC [368833] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'fix_file' on the data LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/land/Lmon/r1i1p1/v20130506/mrro/mrro_Lmon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc') loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/land/Lmon/r1i1p1/v20130506/mrro/mrro_Lmon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) output_dir = PosixPath('/projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/fixed_files/mrro_Lmon_CMIP5_IPSL-CM5B-LR_historical_r1i1p1_v20130506_'), add_unique_suffix = True, mip = 'Lmon', dataset = 'IPSL-CM5B-LR', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', short_name = 'mrro', timerange = '1970/2000', variable_group = 'mrro', diagnostic = 'catchment_analysis', recipe_dataset_index = 1, alias = 'IPSL-CM5B-LR', product = ['output1', 'output2'], institute = ['IPSL'], original_short_name = 'mrro', standard_name = 'runoff_flux', long_name = 'Total Runoff', units = 'kg m-2 s-1', modeling_realm = ['land'], frequency = 'mon', version = 'v20130506' 2023-05-30 13:08:45,965 UTC [368833] DEBUG esmvalcore.preprocessor:390 Result [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/land/Lmon/r1i1p1/v20130506/mrro/mrro_Lmon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc')] 2023-05-30 13:08:45,965 UTC [368833] DEBUG esmvalcore.preprocessor:369 Running preprocessor step load 2023-05-30 13:08:45,965 UTC [368833] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'load' on the data LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/land/Lmon/r1i1p1/v20130506/mrro/mrro_Lmon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc') loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/land/Lmon/r1i1p1/v20130506/mrro/mrro_Lmon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) callback = 'default' 2023-05-30 13:08:45,965 UTC [368833] DEBUG esmvalcore.preprocessor._io:152 Loading: /projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/land/Lmon/r1i1p1/v20130506/mrro/mrro_Lmon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc 2023-05-30 13:08:46,084 UTC [368833] DEBUG esmvalcore.preprocessor._io:182 Done with loading /projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/land/Lmon/r1i1p1/v20130506/mrro/mrro_Lmon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc 2023-05-30 13:08:46,084 UTC [368833] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:46,085 UTC [368833] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/mrro/CMIP5_IPSL-CM5B-LR_Lmon_historical_r1i1p1_mrro_1970-2000/00_load.nc 2023-05-30 13:08:46,195 UTC [368832] DEBUG esmvalcore.preprocessor:369 Running preprocessor step cmor_check_metadata 2023-05-30 13:08:46,196 UTC [368832] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'cmor_check_metadata' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/v20120315/evspsbl/evspsbl_Amon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) check_level = , cmor_table = 'CMIP5', mip = 'Amon', frequency = 'mon', short_name = 'evspsbl' 2023-05-30 13:08:46,203 UTC [368832] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:46,204 UTC [368832] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/evspsbl/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_evspsbl_1970-2000/03_cmor_check_metadata.nc 2023-05-30 13:08:46,324 UTC [368833] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_metadata 2023-05-30 13:08:46,326 UTC [368833] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'fix_metadata' on the data [] loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/land/Lmon/r1i1p1/v20130506/mrro/mrro_Lmon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) check_level = , mip = 'Lmon', dataset = 'IPSL-CM5B-LR', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', short_name = 'mrro', timerange = '1970/2000', variable_group = 'mrro', diagnostic = 'catchment_analysis', recipe_dataset_index = 1, alias = 'IPSL-CM5B-LR', product = ['output1', 'output2'], institute = ['IPSL'], original_short_name = 'mrro', standard_name = 'runoff_flux', long_name = 'Total Runoff', units = 'kg m-2 s-1', modeling_realm = ['land'], frequency = 'mon', version = 'v20130506' 2023-05-30 13:08:46,331 UTC [368833] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:46,332 UTC [368833] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/mrro/CMIP5_IPSL-CM5B-LR_Lmon_historical_r1i1p1_mrro_1970-2000/01_fix_metadata.nc 2023-05-30 13:08:46,526 UTC [368832] DEBUG esmvalcore.preprocessor:369 Running preprocessor step clip_timerange 2023-05-30 13:08:46,528 UTC [368832] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'clip_timerange' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/v20120315/evspsbl/evspsbl_Amon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) timerange = '1970/2000' 2023-05-30 13:08:46,539 UTC [368832] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:46,540 UTC [368832] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/evspsbl/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_evspsbl_1970-2000/04_clip_timerange.nc 2023-05-30 13:08:46,559 UTC [368833] DEBUG esmvalcore.preprocessor:369 Running preprocessor step concatenate 2023-05-30 13:08:46,560 UTC [368833] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'concatenate' on the data [] loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/land/Lmon/r1i1p1/v20130506/mrro/mrro_Lmon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) 2023-05-30 13:08:46,560 UTC [368833] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:46,561 UTC [368833] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/mrro/CMIP5_IPSL-CM5B-LR_Lmon_historical_r1i1p1_mrro_1970-2000/02_concatenate.nc 2023-05-30 13:08:46,738 UTC [368832] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_data 2023-05-30 13:08:46,739 UTC [368832] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'fix_data' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/v20120315/evspsbl/evspsbl_Amon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) check_level = , mip = 'Amon', dataset = 'MPI-ESM-LR', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', short_name = 'evspsbl', timerange = '1970/2000', variable_group = 'evspsbl', diagnostic = 'catchment_analysis', recipe_dataset_index = 0, alias = 'MPI-ESM-LR', product = ['output1', 'output2'], institute = ['MPI-M'], original_short_name = 'evspsbl', standard_name = 'water_evaporation_flux', long_name = 'Evaporation', units = 'kg m-2 s-1', modeling_realm = ['atmos'], frequency = 'mon', version = 'v20120315' 2023-05-30 13:08:46,740 UTC [368832] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:46,740 UTC [368832] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/evspsbl/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_evspsbl_1970-2000/05_fix_data.nc 2023-05-30 13:08:46,774 UTC [368833] DEBUG esmvalcore.preprocessor:369 Running preprocessor step cmor_check_metadata 2023-05-30 13:08:46,775 UTC [368833] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'cmor_check_metadata' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/land/Lmon/r1i1p1/v20130506/mrro/mrro_Lmon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) check_level = , cmor_table = 'CMIP5', mip = 'Lmon', frequency = 'mon', short_name = 'mrro' 2023-05-30 13:08:46,780 UTC [368833] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:46,781 UTC [368833] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/mrro/CMIP5_IPSL-CM5B-LR_Lmon_historical_r1i1p1_mrro_1970-2000/03_cmor_check_metadata.nc 2023-05-30 13:08:46,933 UTC [368832] DEBUG esmvalcore.preprocessor:369 Running preprocessor step cmor_check_data 2023-05-30 13:08:46,934 UTC [368832] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'cmor_check_data' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/v20120315/evspsbl/evspsbl_Amon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) check_level = , cmor_table = 'CMIP5', mip = 'Amon', frequency = 'mon', short_name = 'evspsbl' 2023-05-30 13:08:46,934 UTC [368832] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:46,935 UTC [368832] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/evspsbl/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_evspsbl_1970-2000/06_cmor_check_data.nc 2023-05-30 13:08:46,988 UTC [368833] DEBUG esmvalcore.preprocessor:369 Running preprocessor step clip_timerange 2023-05-30 13:08:46,989 UTC [368833] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'clip_timerange' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/land/Lmon/r1i1p1/v20130506/mrro/mrro_Lmon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) timerange = '1970/2000' 2023-05-30 13:08:46,999 UTC [368833] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:47,000 UTC [368833] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/mrro/CMIP5_IPSL-CM5B-LR_Lmon_historical_r1i1p1_mrro_1970-2000/04_clip_timerange.nc 2023-05-30 13:08:47,117 UTC [368832] DEBUG esmvalcore.preprocessor:369 Running preprocessor step add_supplementary_variables 2023-05-30 13:08:47,118 UTC [368832] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'add_supplementary_variables' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/v20120315/evspsbl/evspsbl_Amon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) supplementary_cubes = [] 2023-05-30 13:08:47,118 UTC [368832] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:47,119 UTC [368832] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/evspsbl/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_evspsbl_1970-2000/07_add_supplementary_variables.nc 2023-05-30 13:08:47,149 UTC [368833] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_data 2023-05-30 13:08:47,150 UTC [368833] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'fix_data' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/land/Lmon/r1i1p1/v20130506/mrro/mrro_Lmon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) check_level = , mip = 'Lmon', dataset = 'IPSL-CM5B-LR', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', short_name = 'mrro', timerange = '1970/2000', variable_group = 'mrro', diagnostic = 'catchment_analysis', recipe_dataset_index = 1, alias = 'IPSL-CM5B-LR', product = ['output1', 'output2'], institute = ['IPSL'], original_short_name = 'mrro', standard_name = 'runoff_flux', long_name = 'Total Runoff', units = 'kg m-2 s-1', modeling_realm = ['land'], frequency = 'mon', version = 'v20130506' 2023-05-30 13:08:47,151 UTC [368833] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:47,151 UTC [368833] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/mrro/CMIP5_IPSL-CM5B-LR_Lmon_historical_r1i1p1_mrro_1970-2000/05_fix_data.nc 2023-05-30 13:08:47,299 UTC [368833] DEBUG esmvalcore.preprocessor:369 Running preprocessor step cmor_check_data 2023-05-30 13:08:47,300 UTC [368833] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'cmor_check_data' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/land/Lmon/r1i1p1/v20130506/mrro/mrro_Lmon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) check_level = , cmor_table = 'CMIP5', mip = 'Lmon', frequency = 'mon', short_name = 'mrro' 2023-05-30 13:08:47,300 UTC [368833] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:47,301 UTC [368833] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/mrro/CMIP5_IPSL-CM5B-LR_Lmon_historical_r1i1p1_mrro_1970-2000/06_cmor_check_data.nc 2023-05-30 13:08:47,311 UTC [368832] DEBUG esmvalcore.preprocessor:369 Running preprocessor step save 2023-05-30 13:08:47,313 UTC [368832] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'save' on the data [] loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/v20120315/evspsbl/evspsbl_Amon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) compress = False, filename = PosixPath('/projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/evspsbl/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_evspsbl_1970-2000.nc') 2023-05-30 13:08:47,313 UTC [368832] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/evspsbl/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_evspsbl_1970-2000.nc 2023-05-30 13:08:47,455 UTC [368833] DEBUG esmvalcore.preprocessor:369 Running preprocessor step add_supplementary_variables 2023-05-30 13:08:47,456 UTC [368833] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'add_supplementary_variables' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/land/Lmon/r1i1p1/v20130506/mrro/mrro_Lmon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) supplementary_cubes = [] 2023-05-30 13:08:47,457 UTC [368833] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:47,457 UTC [368833] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/mrro/CMIP5_IPSL-CM5B-LR_Lmon_historical_r1i1p1_mrro_1970-2000/07_add_supplementary_variables.nc 2023-05-30 13:08:47,529 UTC [368832] INFO esmvalcore._task:264 Successfully completed task catchment_analysis/evspsbl (priority 1) in 0:00:07.350610 2023-05-30 13:08:47,604 UTC [368833] DEBUG esmvalcore.preprocessor:369 Running preprocessor step save 2023-05-30 13:08:47,606 UTC [368833] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'save' on the data [] loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/land/Lmon/r1i1p1/v20130506/mrro/mrro_Lmon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) compress = False, filename = PosixPath('/projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/mrro/CMIP5_IPSL-CM5B-LR_Lmon_historical_r1i1p1_mrro_1970-2000.nc') 2023-05-30 13:08:47,606 UTC [368833] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/mrro/CMIP5_IPSL-CM5B-LR_Lmon_historical_r1i1p1_mrro_1970-2000.nc 2023-05-30 13:08:47,684 UTC [368562] INFO esmvalcore._task:778 Progress: 1 tasks running, 2 tasks waiting for ancestors, 1/4 done 2023-05-30 13:08:47,686 UTC [368832] INFO esmvalcore._task:259 Starting task catchment_analysis/pr in process [368832] 2023-05-30 13:08:47,783 UTC [368832] DEBUG esmvalcore.esgf._download:535 All required data is available locally, not downloading anything. 2023-05-30 13:08:47,783 UTC [368832] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_file 2023-05-30 13:08:47,783 UTC [368832] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'fix_file' on the data LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/v20120315/pr/pr_Amon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc') loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/v20120315/pr/pr_Amon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) output_dir = PosixPath('/projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/fixed_files/pr_Amon_CMIP5_MPI-ESM-LR_historical_r1i1p1_v20120315_'), add_unique_suffix = True, mip = 'Amon', dataset = 'MPI-ESM-LR', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', short_name = 'pr', timerange = '1970/2000', variable_group = 'pr', diagnostic = 'catchment_analysis', recipe_dataset_index = 0, alias = 'MPI-ESM-LR', product = ['output1', 'output2'], institute = ['MPI-M'], original_short_name = 'pr', standard_name = 'precipitation_flux', long_name = 'Precipitation', units = 'kg m-2 s-1', modeling_realm = ['atmos'], frequency = 'mon', version = 'v20120315' 2023-05-30 13:08:47,784 UTC [368832] DEBUG esmvalcore.preprocessor:390 Result [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/v20120315/pr/pr_Amon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc')] 2023-05-30 13:08:47,784 UTC [368832] DEBUG esmvalcore.preprocessor:369 Running preprocessor step load 2023-05-30 13:08:47,784 UTC [368832] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'load' on the data LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/v20120315/pr/pr_Amon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc') loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/v20120315/pr/pr_Amon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) callback = 'default' 2023-05-30 13:08:47,784 UTC [368832] DEBUG esmvalcore.preprocessor._io:152 Loading: /projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/v20120315/pr/pr_Amon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc 2023-05-30 13:08:47,784 UTC [368562] INFO esmvalcore._task:778 Progress: 2 tasks running, 1 tasks waiting for ancestors, 1/4 done 2023-05-30 13:08:47,788 UTC [368833] INFO esmvalcore._task:264 Successfully completed task catchment_analysis/mrro (priority 2) in 0:00:07.609406 2023-05-30 13:08:47,985 UTC [368562] INFO esmvalcore._task:778 Progress: 1 tasks running, 1 tasks waiting for ancestors, 2/4 done 2023-05-30 13:08:48,073 UTC [368832] DEBUG esmvalcore.preprocessor._io:182 Done with loading /projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/v20120315/pr/pr_Amon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc 2023-05-30 13:08:48,073 UTC [368832] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:48,074 UTC [368832] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/pr/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_pr_1970-2000/00_load.nc 2023-05-30 13:08:48,444 UTC [368832] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_metadata 2023-05-30 13:08:48,446 UTC [368832] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'fix_metadata' on the data [] loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/v20120315/pr/pr_Amon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) check_level = , mip = 'Amon', dataset = 'MPI-ESM-LR', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', short_name = 'pr', timerange = '1970/2000', variable_group = 'pr', diagnostic = 'catchment_analysis', recipe_dataset_index = 0, alias = 'MPI-ESM-LR', product = ['output1', 'output2'], institute = ['MPI-M'], original_short_name = 'pr', standard_name = 'precipitation_flux', long_name = 'Precipitation', units = 'kg m-2 s-1', modeling_realm = ['atmos'], frequency = 'mon', version = 'v20120315' 2023-05-30 13:08:48,453 UTC [368832] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:48,453 UTC [368832] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/pr/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_pr_1970-2000/01_fix_metadata.nc 2023-05-30 13:08:48,812 UTC [368832] DEBUG esmvalcore.preprocessor:369 Running preprocessor step concatenate 2023-05-30 13:08:48,814 UTC [368832] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'concatenate' on the data [] loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/v20120315/pr/pr_Amon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) 2023-05-30 13:08:48,814 UTC [368832] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:48,815 UTC [368832] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/pr/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_pr_1970-2000/02_concatenate.nc 2023-05-30 13:08:49,191 UTC [368832] DEBUG esmvalcore.preprocessor:369 Running preprocessor step cmor_check_metadata 2023-05-30 13:08:49,192 UTC [368832] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'cmor_check_metadata' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/v20120315/pr/pr_Amon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) check_level = , cmor_table = 'CMIP5', mip = 'Amon', frequency = 'mon', short_name = 'pr' 2023-05-30 13:08:49,198 UTC [368832] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:49,199 UTC [368832] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/pr/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_pr_1970-2000/03_cmor_check_metadata.nc 2023-05-30 13:08:49,571 UTC [368832] DEBUG esmvalcore.preprocessor:369 Running preprocessor step clip_timerange 2023-05-30 13:08:49,572 UTC [368832] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'clip_timerange' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/v20120315/pr/pr_Amon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) timerange = '1970/2000' 2023-05-30 13:08:49,583 UTC [368832] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:49,584 UTC [368832] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/pr/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_pr_1970-2000/04_clip_timerange.nc 2023-05-30 13:08:49,759 UTC [368832] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_data 2023-05-30 13:08:49,761 UTC [368832] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'fix_data' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/v20120315/pr/pr_Amon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) check_level = , mip = 'Amon', dataset = 'MPI-ESM-LR', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', short_name = 'pr', timerange = '1970/2000', variable_group = 'pr', diagnostic = 'catchment_analysis', recipe_dataset_index = 0, alias = 'MPI-ESM-LR', product = ['output1', 'output2'], institute = ['MPI-M'], original_short_name = 'pr', standard_name = 'precipitation_flux', long_name = 'Precipitation', units = 'kg m-2 s-1', modeling_realm = ['atmos'], frequency = 'mon', version = 'v20120315' 2023-05-30 13:08:49,761 UTC [368832] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:49,762 UTC [368832] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/pr/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_pr_1970-2000/05_fix_data.nc 2023-05-30 13:08:49,946 UTC [368832] DEBUG esmvalcore.preprocessor:369 Running preprocessor step cmor_check_data 2023-05-30 13:08:49,947 UTC [368832] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'cmor_check_data' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/v20120315/pr/pr_Amon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) check_level = , cmor_table = 'CMIP5', mip = 'Amon', frequency = 'mon', short_name = 'pr' 2023-05-30 13:08:49,947 UTC [368832] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:49,948 UTC [368832] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/pr/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_pr_1970-2000/06_cmor_check_data.nc 2023-05-30 13:08:50,132 UTC [368832] DEBUG esmvalcore.preprocessor:369 Running preprocessor step add_supplementary_variables 2023-05-30 13:08:50,133 UTC [368832] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'add_supplementary_variables' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/v20120315/pr/pr_Amon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) supplementary_cubes = [] 2023-05-30 13:08:50,133 UTC [368832] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:50,133 UTC [368832] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/pr/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_pr_1970-2000/07_add_supplementary_variables.nc 2023-05-30 13:08:50,309 UTC [368832] DEBUG esmvalcore.preprocessor:369 Running preprocessor step save 2023-05-30 13:08:50,311 UTC [368832] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'save' on the data [] loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/v20120315/pr/pr_Amon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) compress = False, filename = PosixPath('/projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/pr/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_pr_1970-2000.nc') 2023-05-30 13:08:50,311 UTC [368832] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/pr/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_pr_1970-2000.nc 2023-05-30 13:08:50,491 UTC [368832] DEBUG esmvalcore.esgf._download:535 All required data is available locally, not downloading anything. 2023-05-30 13:08:50,491 UTC [368832] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_file 2023-05-30 13:08:50,491 UTC [368832] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'fix_file' on the data LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/v20120114/pr/pr_Amon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc') loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/v20120114/pr/pr_Amon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) output_dir = PosixPath('/projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/fixed_files/pr_Amon_CMIP5_IPSL-CM5B-LR_historical_r1i1p1_v20120114_'), add_unique_suffix = True, mip = 'Amon', dataset = 'IPSL-CM5B-LR', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', short_name = 'pr', timerange = '1970/2000', variable_group = 'pr', diagnostic = 'catchment_analysis', recipe_dataset_index = 1, alias = 'IPSL-CM5B-LR', product = ['output1', 'output2'], institute = ['IPSL'], original_short_name = 'pr', standard_name = 'precipitation_flux', long_name = 'Precipitation', units = 'kg m-2 s-1', modeling_realm = ['atmos'], frequency = 'mon', version = 'v20120114' 2023-05-30 13:08:50,491 UTC [368832] DEBUG esmvalcore.preprocessor:390 Result [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/v20120114/pr/pr_Amon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc')] 2023-05-30 13:08:50,491 UTC [368832] DEBUG esmvalcore.preprocessor:369 Running preprocessor step load 2023-05-30 13:08:50,492 UTC [368832] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'load' on the data LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/v20120114/pr/pr_Amon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc') loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/v20120114/pr/pr_Amon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) callback = 'default' 2023-05-30 13:08:50,492 UTC [368832] DEBUG esmvalcore.preprocessor._io:152 Loading: /projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/v20120114/pr/pr_Amon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc 2023-05-30 13:08:50,586 UTC [368832] DEBUG esmvalcore.preprocessor._io:182 Done with loading /projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/v20120114/pr/pr_Amon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc 2023-05-30 13:08:50,586 UTC [368832] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:50,587 UTC [368832] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/pr/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_pr_1970-2000/00_load.nc 2023-05-30 13:08:50,792 UTC [368832] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_metadata 2023-05-30 13:08:50,794 UTC [368832] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'fix_metadata' on the data [] loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/v20120114/pr/pr_Amon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) check_level = , mip = 'Amon', dataset = 'IPSL-CM5B-LR', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', short_name = 'pr', timerange = '1970/2000', variable_group = 'pr', diagnostic = 'catchment_analysis', recipe_dataset_index = 1, alias = 'IPSL-CM5B-LR', product = ['output1', 'output2'], institute = ['IPSL'], original_short_name = 'pr', standard_name = 'precipitation_flux', long_name = 'Precipitation', units = 'kg m-2 s-1', modeling_realm = ['atmos'], frequency = 'mon', version = 'v20120114' 2023-05-30 13:08:50,799 UTC [368832] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:50,800 UTC [368832] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/pr/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_pr_1970-2000/01_fix_metadata.nc 2023-05-30 13:08:50,978 UTC [368832] DEBUG esmvalcore.preprocessor:369 Running preprocessor step concatenate 2023-05-30 13:08:50,979 UTC [368832] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'concatenate' on the data [] loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/v20120114/pr/pr_Amon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) 2023-05-30 13:08:50,979 UTC [368832] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:50,980 UTC [368832] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/pr/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_pr_1970-2000/02_concatenate.nc 2023-05-30 13:08:51,160 UTC [368832] DEBUG esmvalcore.preprocessor:369 Running preprocessor step cmor_check_metadata 2023-05-30 13:08:51,161 UTC [368832] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'cmor_check_metadata' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/v20120114/pr/pr_Amon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) check_level = , cmor_table = 'CMIP5', mip = 'Amon', frequency = 'mon', short_name = 'pr' 2023-05-30 13:08:51,166 UTC [368832] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:51,167 UTC [368832] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/pr/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_pr_1970-2000/03_cmor_check_metadata.nc 2023-05-30 13:08:51,362 UTC [368832] DEBUG esmvalcore.preprocessor:369 Running preprocessor step clip_timerange 2023-05-30 13:08:51,363 UTC [368832] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'clip_timerange' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/v20120114/pr/pr_Amon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) timerange = '1970/2000' 2023-05-30 13:08:51,375 UTC [368832] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:51,376 UTC [368832] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/pr/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_pr_1970-2000/04_clip_timerange.nc 2023-05-30 13:08:51,521 UTC [368832] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_data 2023-05-30 13:08:51,522 UTC [368832] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'fix_data' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/v20120114/pr/pr_Amon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) check_level = , mip = 'Amon', dataset = 'IPSL-CM5B-LR', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', short_name = 'pr', timerange = '1970/2000', variable_group = 'pr', diagnostic = 'catchment_analysis', recipe_dataset_index = 1, alias = 'IPSL-CM5B-LR', product = ['output1', 'output2'], institute = ['IPSL'], original_short_name = 'pr', standard_name = 'precipitation_flux', long_name = 'Precipitation', units = 'kg m-2 s-1', modeling_realm = ['atmos'], frequency = 'mon', version = 'v20120114' 2023-05-30 13:08:51,522 UTC [368832] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:51,523 UTC [368832] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/pr/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_pr_1970-2000/05_fix_data.nc 2023-05-30 13:08:51,658 UTC [368832] DEBUG esmvalcore.preprocessor:369 Running preprocessor step cmor_check_data 2023-05-30 13:08:51,659 UTC [368832] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'cmor_check_data' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/v20120114/pr/pr_Amon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) check_level = , cmor_table = 'CMIP5', mip = 'Amon', frequency = 'mon', short_name = 'pr' 2023-05-30 13:08:51,659 UTC [368832] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:51,660 UTC [368832] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/pr/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_pr_1970-2000/06_cmor_check_data.nc 2023-05-30 13:08:51,803 UTC [368832] DEBUG esmvalcore.preprocessor:369 Running preprocessor step add_supplementary_variables 2023-05-30 13:08:51,804 UTC [368832] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'add_supplementary_variables' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/v20120114/pr/pr_Amon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) supplementary_cubes = [] 2023-05-30 13:08:51,804 UTC [368832] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:51,805 UTC [368832] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/pr/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_pr_1970-2000/07_add_supplementary_variables.nc 2023-05-30 13:08:51,939 UTC [368832] DEBUG esmvalcore.preprocessor:369 Running preprocessor step save 2023-05-30 13:08:51,941 UTC [368832] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'save' on the data [] loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/v20120114/pr/pr_Amon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) compress = False, filename = PosixPath('/projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/pr/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_pr_1970-2000.nc') 2023-05-30 13:08:51,941 UTC [368832] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/pr/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_pr_1970-2000.nc 2023-05-30 13:08:52,090 UTC [368832] DEBUG esmvalcore.esgf._download:535 All required data is available locally, not downloading anything. 2023-05-30 13:08:52,091 UTC [368832] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_file 2023-05-30 13:08:52,091 UTC [368832] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'fix_file' on the data LocalFile('/projects/NS9034K/CMIP5/output1/NCC/NorESM1-ME/historical/mon/atmos/Amon/r1i1p1/v20140327/pr/pr_Amon_NorESM1-ME_historical_r1i1p1_185001-200512.nc') loaded from original input file(s) [LocalFile('/projects/NS9034K/CMIP5/output1/NCC/NorESM1-ME/historical/mon/atmos/Amon/r1i1p1/v20140327/pr/pr_Amon_NorESM1-ME_historical_r1i1p1_185001-200512.nc')] with function argument(s) output_dir = PosixPath('/projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/fixed_files/pr_Amon_CMIP5_NorESM1-ME_historical_r1i1p1_v20140327_'), add_unique_suffix = True, mip = 'Amon', dataset = 'NorESM1-ME', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', short_name = 'pr', timerange = '1970/2000', variable_group = 'pr', diagnostic = 'catchment_analysis', recipe_dataset_index = 2, alias = 'NorESM1-ME', product = ['output1', 'output2'], institute = ['NCC'], original_short_name = 'pr', standard_name = 'precipitation_flux', long_name = 'Precipitation', units = 'kg m-2 s-1', modeling_realm = ['atmos'], frequency = 'mon', version = 'v20140327' 2023-05-30 13:08:52,091 UTC [368832] DEBUG esmvalcore.preprocessor:390 Result [LocalFile('/projects/NS9034K/CMIP5/output1/NCC/NorESM1-ME/historical/mon/atmos/Amon/r1i1p1/v20140327/pr/pr_Amon_NorESM1-ME_historical_r1i1p1_185001-200512.nc')] 2023-05-30 13:08:52,091 UTC [368832] DEBUG esmvalcore.preprocessor:369 Running preprocessor step load 2023-05-30 13:08:52,091 UTC [368832] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'load' on the data LocalFile('/projects/NS9034K/CMIP5/output1/NCC/NorESM1-ME/historical/mon/atmos/Amon/r1i1p1/v20140327/pr/pr_Amon_NorESM1-ME_historical_r1i1p1_185001-200512.nc') loaded from original input file(s) [LocalFile('/projects/NS9034K/CMIP5/output1/NCC/NorESM1-ME/historical/mon/atmos/Amon/r1i1p1/v20140327/pr/pr_Amon_NorESM1-ME_historical_r1i1p1_185001-200512.nc')] with function argument(s) callback = 'default' 2023-05-30 13:08:52,091 UTC [368832] DEBUG esmvalcore.preprocessor._io:152 Loading: /projects/NS9034K/CMIP5/output1/NCC/NorESM1-ME/historical/mon/atmos/Amon/r1i1p1/v20140327/pr/pr_Amon_NorESM1-ME_historical_r1i1p1_185001-200512.nc 2023-05-30 13:08:52,337 UTC [368832] DEBUG esmvalcore.preprocessor._io:182 Done with loading /projects/NS9034K/CMIP5/output1/NCC/NorESM1-ME/historical/mon/atmos/Amon/r1i1p1/v20140327/pr/pr_Amon_NorESM1-ME_historical_r1i1p1_185001-200512.nc 2023-05-30 13:08:52,337 UTC [368832] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:52,338 UTC [368832] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/pr/CMIP5_NorESM1-ME_Amon_historical_r1i1p1_pr_1970-2000/00_load.nc 2023-05-30 13:08:52,587 UTC [368832] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_metadata 2023-05-30 13:08:52,589 UTC [368832] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'fix_metadata' on the data [] loaded from original input file(s) [LocalFile('/projects/NS9034K/CMIP5/output1/NCC/NorESM1-ME/historical/mon/atmos/Amon/r1i1p1/v20140327/pr/pr_Amon_NorESM1-ME_historical_r1i1p1_185001-200512.nc')] with function argument(s) check_level = , mip = 'Amon', dataset = 'NorESM1-ME', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', short_name = 'pr', timerange = '1970/2000', variable_group = 'pr', diagnostic = 'catchment_analysis', recipe_dataset_index = 2, alias = 'NorESM1-ME', product = ['output1', 'output2'], institute = ['NCC'], original_short_name = 'pr', standard_name = 'precipitation_flux', long_name = 'Precipitation', units = 'kg m-2 s-1', modeling_realm = ['atmos'], frequency = 'mon', version = 'v20140327' 2023-05-30 13:08:52,598 UTC [368832] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:52,599 UTC [368832] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/pr/CMIP5_NorESM1-ME_Amon_historical_r1i1p1_pr_1970-2000/01_fix_metadata.nc 2023-05-30 13:08:52,799 UTC [368832] DEBUG esmvalcore.preprocessor:369 Running preprocessor step concatenate 2023-05-30 13:08:52,801 UTC [368832] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'concatenate' on the data [] loaded from original input file(s) [LocalFile('/projects/NS9034K/CMIP5/output1/NCC/NorESM1-ME/historical/mon/atmos/Amon/r1i1p1/v20140327/pr/pr_Amon_NorESM1-ME_historical_r1i1p1_185001-200512.nc')] with function argument(s) 2023-05-30 13:08:52,801 UTC [368832] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:52,802 UTC [368832] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/pr/CMIP5_NorESM1-ME_Amon_historical_r1i1p1_pr_1970-2000/02_concatenate.nc 2023-05-30 13:08:53,016 UTC [368832] DEBUG esmvalcore.preprocessor:369 Running preprocessor step cmor_check_metadata 2023-05-30 13:08:53,017 UTC [368832] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'cmor_check_metadata' on the data loaded from original input file(s) [LocalFile('/projects/NS9034K/CMIP5/output1/NCC/NorESM1-ME/historical/mon/atmos/Amon/r1i1p1/v20140327/pr/pr_Amon_NorESM1-ME_historical_r1i1p1_185001-200512.nc')] with function argument(s) check_level = , cmor_table = 'CMIP5', mip = 'Amon', frequency = 'mon', short_name = 'pr' 2023-05-30 13:08:53,023 UTC [368832] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:53,024 UTC [368832] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/pr/CMIP5_NorESM1-ME_Amon_historical_r1i1p1_pr_1970-2000/03_cmor_check_metadata.nc 2023-05-30 13:08:53,241 UTC [368832] DEBUG esmvalcore.preprocessor:369 Running preprocessor step clip_timerange 2023-05-30 13:08:53,242 UTC [368832] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'clip_timerange' on the data loaded from original input file(s) [LocalFile('/projects/NS9034K/CMIP5/output1/NCC/NorESM1-ME/historical/mon/atmos/Amon/r1i1p1/v20140327/pr/pr_Amon_NorESM1-ME_historical_r1i1p1_185001-200512.nc')] with function argument(s) timerange = '1970/2000' 2023-05-30 13:08:53,251 UTC [368832] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:53,252 UTC [368832] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/pr/CMIP5_NorESM1-ME_Amon_historical_r1i1p1_pr_1970-2000/04_clip_timerange.nc 2023-05-30 13:08:53,482 UTC [368832] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_data 2023-05-30 13:08:53,483 UTC [368832] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'fix_data' on the data loaded from original input file(s) [LocalFile('/projects/NS9034K/CMIP5/output1/NCC/NorESM1-ME/historical/mon/atmos/Amon/r1i1p1/v20140327/pr/pr_Amon_NorESM1-ME_historical_r1i1p1_185001-200512.nc')] with function argument(s) check_level = , mip = 'Amon', dataset = 'NorESM1-ME', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', short_name = 'pr', timerange = '1970/2000', variable_group = 'pr', diagnostic = 'catchment_analysis', recipe_dataset_index = 2, alias = 'NorESM1-ME', product = ['output1', 'output2'], institute = ['NCC'], original_short_name = 'pr', standard_name = 'precipitation_flux', long_name = 'Precipitation', units = 'kg m-2 s-1', modeling_realm = ['atmos'], frequency = 'mon', version = 'v20140327' 2023-05-30 13:08:53,484 UTC [368832] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:53,484 UTC [368832] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/pr/CMIP5_NorESM1-ME_Amon_historical_r1i1p1_pr_1970-2000/05_fix_data.nc 2023-05-30 13:08:53,741 UTC [368832] DEBUG esmvalcore.preprocessor:369 Running preprocessor step cmor_check_data 2023-05-30 13:08:53,743 UTC [368832] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'cmor_check_data' on the data loaded from original input file(s) [LocalFile('/projects/NS9034K/CMIP5/output1/NCC/NorESM1-ME/historical/mon/atmos/Amon/r1i1p1/v20140327/pr/pr_Amon_NorESM1-ME_historical_r1i1p1_185001-200512.nc')] with function argument(s) check_level = , cmor_table = 'CMIP5', mip = 'Amon', frequency = 'mon', short_name = 'pr' 2023-05-30 13:08:53,744 UTC [368832] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:53,745 UTC [368832] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/pr/CMIP5_NorESM1-ME_Amon_historical_r1i1p1_pr_1970-2000/06_cmor_check_data.nc 2023-05-30 13:08:53,979 UTC [368832] DEBUG esmvalcore.preprocessor:369 Running preprocessor step add_supplementary_variables 2023-05-30 13:08:53,980 UTC [368832] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'add_supplementary_variables' on the data loaded from original input file(s) [LocalFile('/projects/NS9034K/CMIP5/output1/NCC/NorESM1-ME/historical/mon/atmos/Amon/r1i1p1/v20140327/pr/pr_Amon_NorESM1-ME_historical_r1i1p1_185001-200512.nc')] with function argument(s) supplementary_cubes = [] 2023-05-30 13:08:53,980 UTC [368832] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:08:53,981 UTC [368832] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/pr/CMIP5_NorESM1-ME_Amon_historical_r1i1p1_pr_1970-2000/07_add_supplementary_variables.nc 2023-05-30 13:08:54,224 UTC [368832] DEBUG esmvalcore.preprocessor:369 Running preprocessor step save 2023-05-30 13:08:54,226 UTC [368832] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'save' on the data [] loaded from original input file(s) [LocalFile('/projects/NS9034K/CMIP5/output1/NCC/NorESM1-ME/historical/mon/atmos/Amon/r1i1p1/v20140327/pr/pr_Amon_NorESM1-ME_historical_r1i1p1_185001-200512.nc')] with function argument(s) compress = False, filename = PosixPath('/projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/pr/CMIP5_NorESM1-ME_Amon_historical_r1i1p1_pr_1970-2000.nc') 2023-05-30 13:08:54,226 UTC [368832] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/preproc/catchment_analysis/pr/CMIP5_NorESM1-ME_Amon_historical_r1i1p1_pr_1970-2000.nc 2023-05-30 13:08:54,465 UTC [368832] INFO esmvalcore._task:264 Successfully completed task catchment_analysis/pr (priority 3) in 0:00:06.778816 2023-05-30 13:08:54,493 UTC [368562] INFO esmvalcore._task:778 Progress: 0 tasks running, 1 tasks waiting for ancestors, 3/4 done 2023-05-30 13:08:54,504 UTC [368833] INFO esmvalcore._task:259 Starting task catchment_analysis/catchment_analysis in process [368833] 2023-05-30 13:08:54,507 UTC [368833] INFO esmvalcore._task:500 Running command ['/diagnostics/esmvaltool/2.8.0/bin/python', '/diagnostics/esmvaltool/2.8.0/lib/python3.10/site-packages/esmvaltool/diag_scripts/runoff_et/catchment_analysis.py', '/projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/run/catchment_analysis/catchment_analysis/settings.yml'] 2023-05-30 13:08:54,507 UTC [368833] DEBUG esmvalcore._task:501 in environment {'MPLBACKEND': 'Agg'} 2023-05-30 13:08:54,507 UTC [368833] DEBUG esmvalcore._task:503 in current working directory: /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/run/catchment_analysis/catchment_analysis 2023-05-30 13:08:54,507 UTC [368833] INFO esmvalcore._task:504 Writing output to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/work/catchment_analysis/catchment_analysis 2023-05-30 13:08:54,507 UTC [368833] INFO esmvalcore._task:505 Writing plots to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/plots/catchment_analysis/catchment_analysis 2023-05-30 13:08:54,507 UTC [368833] INFO esmvalcore._task:506 Writing log to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/run/catchment_analysis/catchment_analysis/log.txt 2023-05-30 13:08:54,507 UTC [368833] INFO esmvalcore._task:516 To re-run this diagnostic script, run: cd /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/run/catchment_analysis/catchment_analysis; MPLBACKEND="Agg" /diagnostics/esmvaltool/2.8.0/bin/python /diagnostics/esmvaltool/2.8.0/lib/python3.10/site-packages/esmvaltool/diag_scripts/runoff_et/catchment_analysis.py /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/run/catchment_analysis/catchment_analysis/settings.yml 2023-05-30 13:08:54,594 UTC [368562] INFO esmvalcore._task:778 Progress: 1 tasks running, 0 tasks waiting for ancestors, 3/4 done 2023-05-30 13:09:53,680 UTC [368833] INFO esmvalcore._task:126 Maximum memory used (estimate): 0.7 GB 2023-05-30 13:09:59,269 UTC [368833] INFO esmvalcore._task:128 Sampled every second. It may be inaccurate if short but high spikes in memory consumption occur. 2023-05-30 13:09:59,269 UTC [368833] DEBUG esmvalcore._task:589 Script runoff_et/catchment_analysis.py completed successfully 2023-05-30 13:09:59,270 UTC [368833] WARNING esmvalcore._task:602 No provenance information was written to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/run/catchment_analysis/catchment_analysis/diagnostic_provenance.yml. Unable to record provenance for files created by diagnostic script runoff_et/catchment_analysis.py in task catchment_analysis/catchment_analysis 2023-05-30 13:09:59,270 UTC [368833] INFO esmvalcore._task:264 Successfully completed task catchment_analysis/catchment_analysis (priority 0) in 0:01:04.766024 2023-05-30 13:09:59,370 UTC [368562] INFO esmvalcore._task:778 Progress: 0 tasks running, 0 tasks waiting for ancestors, 4/4 done 2023-05-30 13:10:02,365 UTC [368562] INFO esmvalcore._task:783 Successfully completed all tasks. 2023-05-30 13:10:02,393 UTC [368562] INFO esmvalcore._recipe.recipe:1309 Wrote recipe with version numbers and wildcards to: file:///projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/run/recipe_runoff_et_filled.yml 2023-05-30 13:10:02,469 UTC [368562] INFO esmvalcore.experimental.recipe_output:205 Wrote recipe output to: file:///projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130839/index.html 2023-05-30 13:10:02,470 UTC [368562] INFO esmvalcore._main:125 Ending the Earth System Model Evaluation Tool at time: 2023-05-30 13:10:02 UTC 2023-05-30 13:10:02,470 UTC [368562] INFO esmvalcore._main:128 Time for running the recipe was: 0:01:22.460368 2023-05-30 13:10:02,731 UTC [368562] INFO esmvalcore._task:126 Maximum memory used (estimate): 2.3 GB 2023-05-30 13:10:02,731 UTC [368562] INFO esmvalcore._task:128 Sampled every second. It may be inaccurate if short but high spikes in memory consumption occur. 2023-05-30 13:10:02,732 UTC [368562] INFO esmvalcore._main:453 Run was successful