2023-05-30 12:59:42,734 UTC [362217] 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 12:59:42,734 UTC [362217] INFO esmvalcore._main:496 Package versions 2023-05-30 12:59:42,734 UTC [362217] INFO esmvalcore._main:497 ---------------- 2023-05-30 12:59:42,734 UTC [362217] INFO esmvalcore._main:498 ESMValCore: 2.8.0 2023-05-30 12:59:42,734 UTC [362217] INFO esmvalcore._main:500 ESMValTool: 2.8.0 2023-05-30 12:59:42,734 UTC [362217] INFO esmvalcore._main:501 ---------------- 2023-05-30 12:59:42,734 UTC [362217] INFO esmvalcore._main:502 Using config file /nird/home/adagj/.esmvaltool/config-user.yml 2023-05-30 12:59:42,735 UTC [362217] INFO esmvalcore._main:503 Writing program log files to: /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/run/main_log.txt /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/run/main_log_debug.txt 2023-05-30 12:59:42,853 UTC [362217] INFO esmvalcore.config._esgf_pyclient:116 Using default ESGF configuration, configuration file /nird/home/adagj/.esmvaltool/esgf-pyclient.yml not present. 2023-05-30 12:59:42,854 UTC [362217] 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 12:59:43,417 UTC [362217] INFO esmvalcore._main:85 Starting the Earth System Model Evaluation Tool at time: 2023-05-30 12:59:43 UTC 2023-05-30 12:59:43,417 UTC [362217] INFO esmvalcore._main:89 ---------------------------------------------------------------------- 2023-05-30 12:59:43,417 UTC [362217] INFO esmvalcore._main:90 RECIPE = /nird/home/adagj/esmvaltool_workshop/recipe_runoff_et.yml 2023-05-30 12:59:43,417 UTC [362217] INFO esmvalcore._main:91 RUNDIR = /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/run 2023-05-30 12:59:43,417 UTC [362217] INFO esmvalcore._main:92 WORKDIR = /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/work 2023-05-30 12:59:43,417 UTC [362217] INFO esmvalcore._main:93 PREPROCDIR = /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/preproc 2023-05-30 12:59:43,418 UTC [362217] INFO esmvalcore._main:94 PLOTDIR = /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/plots 2023-05-30 12:59:43,418 UTC [362217] INFO esmvalcore._main:95 ---------------------------------------------------------------------- 2023-05-30 12:59:43,418 UTC [362217] INFO esmvalcore._main:98 Running tasks using at most 2 processes 2023-05-30 12:59:43,418 UTC [362217] 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 12:59:43,418 UTC [362217] INFO esmvalcore._main:103 If you experience memory problems, try reducing 'max_parallel_tasks' in your user configuration file. 2023-05-30 12:59:43,419 UTC [362217] 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 12:59:43,435 UTC [362217] DEBUG esmvalcore._recipe.to_datasets:344 Populating list of datasets for variable evspsbl in diagnostic catchment_analysis 2023-05-30 12:59:43,436 UTC [362217] DEBUG esmvalcore._recipe.to_datasets:368 Found Dataset: evspsbl, Amon, CMIP5, MPI-ESM-LR, historical, r1i1p1 2023-05-30 12:59:43,436 UTC [362217] DEBUG esmvalcore._recipe.to_datasets:368 Found Dataset: evspsbl, Amon, CMIP5, IPSL-CM5B-LR, historical, r1i1p1 2023-05-30 12:59:43,436 UTC [362217] DEBUG esmvalcore._recipe.to_datasets:344 Populating list of datasets for variable mrro in diagnostic catchment_analysis 2023-05-30 12:59:43,436 UTC [362217] DEBUG esmvalcore._recipe.to_datasets:368 Found Dataset: mrro, Lmon, CMIP5, MPI-ESM-LR, historical, r1i1p1 2023-05-30 12:59:43,436 UTC [362217] DEBUG esmvalcore._recipe.to_datasets:368 Found Dataset: mrro, Lmon, CMIP5, IPSL-CM5B-LR, historical, r1i1p1 2023-05-30 12:59:43,436 UTC [362217] DEBUG esmvalcore._recipe.to_datasets:344 Populating list of datasets for variable pr in diagnostic catchment_analysis 2023-05-30 12:59:43,437 UTC [362217] DEBUG esmvalcore._recipe.to_datasets:368 Found Dataset: pr, Amon, CMIP5, MPI-ESM-LR, historical, r1i1p1 2023-05-30 12:59:43,437 UTC [362217] DEBUG esmvalcore._recipe.to_datasets:368 Found Dataset: pr, Amon, CMIP5, IPSL-CM5B-LR, historical, r1i1p1 2023-05-30 12:59:43,437 UTC [362217] DEBUG esmvalcore._recipe.recipe:1014 Retrieving diagnostics from recipe 2023-05-30 12:59:43,437 UTC [362217] DEBUG esmvalcore._recipe.recipe:1042 Setting script for diagnostic catchment_analysis 2023-05-30 12:59:43,438 UTC [362217] INFO esmvalcore._recipe.recipe:1232 Creating tasks from recipe 2023-05-30 12:59:43,438 UTC [362217] INFO esmvalcore._recipe.recipe:1241 Creating tasks for diagnostic catchment_analysis 2023-05-30 12:59:43,438 UTC [362217] INFO esmvalcore._recipe.recipe:1163 Creating diagnostic task catchment_analysis/catchment_analysis 2023-05-30 12:59:43,438 UTC [362217] INFO esmvalcore._recipe.recipe:1216 Creating preprocessor task catchment_analysis/evspsbl 2023-05-30 12:59:43,438 UTC [362217] INFO esmvalcore._recipe.recipe:849 Creating preprocessor 'default' task for variable 'evspsbl' 2023-05-30 12:59:43,439 UTC [362217] 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 12:59:43,439 UTC [362217] 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 12:59:43,468 UTC [362217] 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 12:59:43,474 UTC [362217] WARNING esmvalcore.local:426 'CMIP5' rootpaths '/scratch/adagj/ESGF/cmip5/output1' set in config-user.yml do not exist 2023-05-30 12:59:43,474 UTC [362217] 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 12:59:43,480 UTC [362217] 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 12:59:43,480 UTC [362217] INFO esmvalcore._recipe.recipe:717 Found input files for Dataset: evspsbl, Amon, CMIP5, MPI-ESM-LR, historical, r1i1p1, v20120315 2023-05-30 12:59:43,480 UTC [362217] 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 12:59:43,483 UTC [362217] 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 12:59:43,483 UTC [362217] INFO esmvalcore._recipe.recipe:717 Found input files for Dataset: evspsbl, Amon, CMIP5, IPSL-CM5B-LR, historical, r1i1p1, v20120114 2023-05-30 12:59:43,484 UTC [362217] INFO esmvalcore._recipe.recipe:873 PreprocessingTask catchment_analysis/evspsbl created. 2023-05-30 12:59:43,484 UTC [362217] DEBUG esmvalcore._recipe.recipe:874 PreprocessingTask catchment_analysis/evspsbl will create the files: /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/preproc/catchment_analysis/evspsbl/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_evspsbl_1970-2000.nc /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/preproc/catchment_analysis/evspsbl/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_evspsbl_1970-2000.nc 2023-05-30 12:59:43,484 UTC [362217] INFO esmvalcore._recipe.recipe:1216 Creating preprocessor task catchment_analysis/mrro 2023-05-30 12:59:43,484 UTC [362217] INFO esmvalcore._recipe.recipe:849 Creating preprocessor 'default' task for variable 'mrro' 2023-05-30 12:59:43,485 UTC [362217] 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 12:59:43,487 UTC [362217] 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 12:59:43,487 UTC [362217] INFO esmvalcore._recipe.recipe:717 Found input files for Dataset: mrro, Lmon, CMIP5, MPI-ESM-LR, historical, r1i1p1, v20120625 2023-05-30 12:59:43,487 UTC [362217] 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 12:59:43,490 UTC [362217] 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 12:59:43,490 UTC [362217] INFO esmvalcore._recipe.recipe:717 Found input files for Dataset: mrro, Lmon, CMIP5, IPSL-CM5B-LR, historical, r1i1p1, v20130506 2023-05-30 12:59:43,491 UTC [362217] INFO esmvalcore._recipe.recipe:873 PreprocessingTask catchment_analysis/mrro created. 2023-05-30 12:59:43,491 UTC [362217] DEBUG esmvalcore._recipe.recipe:874 PreprocessingTask catchment_analysis/mrro will create the files: /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/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_125942/preproc/catchment_analysis/mrro/CMIP5_IPSL-CM5B-LR_Lmon_historical_r1i1p1_mrro_1970-2000.nc 2023-05-30 12:59:43,491 UTC [362217] INFO esmvalcore._recipe.recipe:1216 Creating preprocessor task catchment_analysis/pr 2023-05-30 12:59:43,491 UTC [362217] INFO esmvalcore._recipe.recipe:849 Creating preprocessor 'default' task for variable 'pr' 2023-05-30 12:59:43,492 UTC [362217] 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 12:59:43,493 UTC [362217] 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 12:59:43,493 UTC [362217] INFO esmvalcore._recipe.recipe:717 Found input files for Dataset: pr, Amon, CMIP5, MPI-ESM-LR, historical, r1i1p1, v20120315 2023-05-30 12:59:43,494 UTC [362217] 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 12:59:43,495 UTC [362217] 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 12:59:43,496 UTC [362217] INFO esmvalcore._recipe.recipe:717 Found input files for Dataset: pr, Amon, CMIP5, IPSL-CM5B-LR, historical, r1i1p1, v20120114 2023-05-30 12:59:43,497 UTC [362217] INFO esmvalcore._recipe.recipe:873 PreprocessingTask catchment_analysis/pr created. 2023-05-30 12:59:43,497 UTC [362217] DEBUG esmvalcore._recipe.recipe:874 PreprocessingTask catchment_analysis/pr will create the files: /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/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_125942/preproc/catchment_analysis/pr/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_pr_1970-2000.nc 2023-05-30 12:59:43,497 UTC [362217] DEBUG esmvalcore._recipe.recipe:1091 Linking tasks for diagnostic catchment_analysis script catchment_analysis 2023-05-30 12:59:43,497 UTC [362217] DEBUG esmvalcore._recipe.recipe:1100 Pattern catchment_analysis/evspsbl matches ['catchment_analysis/evspsbl'] 2023-05-30 12:59:43,497 UTC [362217] DEBUG esmvalcore._recipe.recipe:1100 Pattern catchment_analysis/mrro matches ['catchment_analysis/mrro'] 2023-05-30 12:59:43,497 UTC [362217] DEBUG esmvalcore._recipe.recipe:1100 Pattern catchment_analysis/pr matches ['catchment_analysis/pr'] 2023-05-30 12:59:43,497 UTC [362217] INFO esmvalcore._recipe.recipe:1281 These tasks will be executed: catchment_analysis/evspsbl, catchment_analysis/catchment_analysis, catchment_analysis/pr, catchment_analysis/mrro 2023-05-30 12:59:43,500 UTC [362217] 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_125942/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_125942/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_125942/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_125942/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_125942/preproc/catchment_analysis/evspsbl/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_evspsbl_1970-2000.nc')}} PreprocessorFile: /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/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_125942/preproc/catchment_analysis/evspsbl/CMIP5_IPSL-CM5B-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_125942/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_125942/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_125942/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_125942/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_125942/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_125942/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_125942/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_125942/preproc/catchment_analysis/pr/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_pr_1970-2000.nc')}} ancestors: None 2023-05-30 12:59:43,506 UTC [362217] 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_125942/run/recipe_runoff_et_filled.yml 2023-05-30 12:59:43,506 UTC [362217] DEBUG esmvalcore.esgf._download:535 All required data is available locally, not downloading anything. 2023-05-30 12:59:43,506 UTC [362217] INFO esmvalcore._task:746 Running 4 tasks using 2 processes 2023-05-30 12:59:43,546 UTC [362361] INFO esmvalcore._task:259 Starting task catchment_analysis/evspsbl in process [362361] 2023-05-30 12:59:43,547 UTC [362362] INFO esmvalcore._task:259 Starting task catchment_analysis/mrro in process [362362] 2023-05-30 12:59:43,643 UTC [362217] INFO esmvalcore._task:778 Progress: 2 tasks running, 2 tasks waiting for ancestors, 0/4 done 2023-05-30 12:59:43,659 UTC [362361] DEBUG esmvalcore.esgf._download:535 All required data is available locally, not downloading anything. 2023-05-30 12:59:43,660 UTC [362361] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_file 2023-05-30 12:59:43,660 UTC [362361] 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_125942/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 12:59:43,662 UTC [362361] 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 12:59:43,662 UTC [362361] DEBUG esmvalcore.preprocessor:369 Running preprocessor step load 2023-05-30 12:59:43,662 UTC [362361] 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 12:59:43,662 UTC [362361] 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 12:59:43,688 UTC [362362] DEBUG esmvalcore.esgf._download:535 All required data is available locally, not downloading anything. 2023-05-30 12:59:43,688 UTC [362362] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_file 2023-05-30 12:59:43,689 UTC [362362] 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_125942/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 12:59:43,691 UTC [362362] 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 12:59:43,691 UTC [362362] DEBUG esmvalcore.preprocessor:369 Running preprocessor step load 2023-05-30 12:59:43,691 UTC [362362] 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 12:59:43,691 UTC [362362] 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 12:59:44,033 UTC [362361] 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 12:59:44,033 UTC [362361] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 12:59:44,037 UTC [362361] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/preproc/catchment_analysis/evspsbl/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_evspsbl_1970-2000/00_load.nc 2023-05-30 12:59:44,060 UTC [362362] 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 12:59:44,060 UTC [362362] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 12:59:44,063 UTC [362362] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/preproc/catchment_analysis/mrro/CMIP5_MPI-ESM-LR_Lmon_historical_r1i1p1_mrro_1970-2000/00_load.nc 2023-05-30 12:59:44,598 UTC [362361] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_metadata 2023-05-30 12:59:44,600 UTC [362361] 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 12:59:44,606 UTC [362362] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_metadata 2023-05-30 12:59:44,607 UTC [362361] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 12:59:44,608 UTC [362362] 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 12:59:44,608 UTC [362361] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/preproc/catchment_analysis/evspsbl/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_evspsbl_1970-2000/01_fix_metadata.nc 2023-05-30 12:59:44,615 UTC [362362] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 12:59:44,616 UTC [362362] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/preproc/catchment_analysis/mrro/CMIP5_MPI-ESM-LR_Lmon_historical_r1i1p1_mrro_1970-2000/01_fix_metadata.nc 2023-05-30 12:59:44,967 UTC [362361] DEBUG esmvalcore.preprocessor:369 Running preprocessor step concatenate 2023-05-30 12:59:44,969 UTC [362361] 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 12:59:44,969 UTC [362361] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 12:59:44,969 UTC [362361] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/preproc/catchment_analysis/evspsbl/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_evspsbl_1970-2000/02_concatenate.nc 2023-05-30 12:59:44,991 UTC [362362] DEBUG esmvalcore.preprocessor:369 Running preprocessor step concatenate 2023-05-30 12:59:44,993 UTC [362362] 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 12:59:44,993 UTC [362362] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 12:59:44,994 UTC [362362] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/preproc/catchment_analysis/mrro/CMIP5_MPI-ESM-LR_Lmon_historical_r1i1p1_mrro_1970-2000/02_concatenate.nc 2023-05-30 12:59:45,325 UTC [362361] DEBUG esmvalcore.preprocessor:369 Running preprocessor step cmor_check_metadata 2023-05-30 12:59:45,326 UTC [362361] 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 12:59:45,333 UTC [362361] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 12:59:45,334 UTC [362361] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/preproc/catchment_analysis/evspsbl/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_evspsbl_1970-2000/03_cmor_check_metadata.nc 2023-05-30 12:59:45,386 UTC [362362] DEBUG esmvalcore.preprocessor:369 Running preprocessor step cmor_check_metadata 2023-05-30 12:59:45,387 UTC [362362] 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 12:59:45,394 UTC [362362] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 12:59:45,394 UTC [362362] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/preproc/catchment_analysis/mrro/CMIP5_MPI-ESM-LR_Lmon_historical_r1i1p1_mrro_1970-2000/03_cmor_check_metadata.nc 2023-05-30 12:59:45,702 UTC [362361] DEBUG esmvalcore.preprocessor:369 Running preprocessor step clip_timerange 2023-05-30 12:59:45,703 UTC [362361] 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 12:59:45,717 UTC [362361] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 12:59:45,717 UTC [362361] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/preproc/catchment_analysis/evspsbl/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_evspsbl_1970-2000/04_clip_timerange.nc 2023-05-30 12:59:45,769 UTC [362362] DEBUG esmvalcore.preprocessor:369 Running preprocessor step clip_timerange 2023-05-30 12:59:45,770 UTC [362362] 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 12:59:45,783 UTC [362362] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 12:59:45,784 UTC [362362] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/preproc/catchment_analysis/mrro/CMIP5_MPI-ESM-LR_Lmon_historical_r1i1p1_mrro_1970-2000/04_clip_timerange.nc 2023-05-30 12:59:45,923 UTC [362361] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_data 2023-05-30 12:59:45,924 UTC [362361] 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 12:59:45,925 UTC [362361] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 12:59:45,925 UTC [362361] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/preproc/catchment_analysis/evspsbl/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_evspsbl_1970-2000/05_fix_data.nc 2023-05-30 12:59:45,984 UTC [362362] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_data 2023-05-30 12:59:45,985 UTC [362362] 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 12:59:45,986 UTC [362362] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 12:59:45,986 UTC [362362] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/preproc/catchment_analysis/mrro/CMIP5_MPI-ESM-LR_Lmon_historical_r1i1p1_mrro_1970-2000/05_fix_data.nc 2023-05-30 12:59:46,137 UTC [362361] DEBUG esmvalcore.preprocessor:369 Running preprocessor step cmor_check_data 2023-05-30 12:59:46,138 UTC [362361] 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 12:59:46,138 UTC [362361] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 12:59:46,139 UTC [362361] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/preproc/catchment_analysis/evspsbl/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_evspsbl_1970-2000/06_cmor_check_data.nc 2023-05-30 12:59:46,200 UTC [362362] DEBUG esmvalcore.preprocessor:369 Running preprocessor step cmor_check_data 2023-05-30 12:59:46,201 UTC [362362] 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 12:59:46,201 UTC [362362] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 12:59:46,202 UTC [362362] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/preproc/catchment_analysis/mrro/CMIP5_MPI-ESM-LR_Lmon_historical_r1i1p1_mrro_1970-2000/06_cmor_check_data.nc 2023-05-30 12:59:46,361 UTC [362361] DEBUG esmvalcore.preprocessor:369 Running preprocessor step add_supplementary_variables 2023-05-30 12:59:46,362 UTC [362361] 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 12:59:46,362 UTC [362361] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 12:59:46,363 UTC [362361] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/preproc/catchment_analysis/evspsbl/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_evspsbl_1970-2000/07_add_supplementary_variables.nc 2023-05-30 12:59:46,404 UTC [362362] DEBUG esmvalcore.preprocessor:369 Running preprocessor step add_supplementary_variables 2023-05-30 12:59:46,405 UTC [362362] 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 12:59:46,405 UTC [362362] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 12:59:46,406 UTC [362362] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/preproc/catchment_analysis/mrro/CMIP5_MPI-ESM-LR_Lmon_historical_r1i1p1_mrro_1970-2000/07_add_supplementary_variables.nc 2023-05-30 12:59:46,563 UTC [362361] DEBUG esmvalcore.preprocessor:369 Running preprocessor step save 2023-05-30 12:59:46,565 UTC [362361] 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_125942/preproc/catchment_analysis/evspsbl/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_evspsbl_1970-2000.nc') 2023-05-30 12:59:46,565 UTC [362361] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/preproc/catchment_analysis/evspsbl/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_evspsbl_1970-2000.nc 2023-05-30 12:59:46,598 UTC [362362] DEBUG esmvalcore.preprocessor:369 Running preprocessor step save 2023-05-30 12:59:46,600 UTC [362362] 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_125942/preproc/catchment_analysis/mrro/CMIP5_MPI-ESM-LR_Lmon_historical_r1i1p1_mrro_1970-2000.nc') 2023-05-30 12:59:46,600 UTC [362362] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/preproc/catchment_analysis/mrro/CMIP5_MPI-ESM-LR_Lmon_historical_r1i1p1_mrro_1970-2000.nc 2023-05-30 12:59:46,822 UTC [362361] DEBUG esmvalcore.esgf._download:535 All required data is available locally, not downloading anything. 2023-05-30 12:59:46,822 UTC [362361] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_file 2023-05-30 12:59:46,823 UTC [362361] 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_125942/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 12:59:46,823 UTC [362361] 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 12:59:46,824 UTC [362361] DEBUG esmvalcore.preprocessor:369 Running preprocessor step load 2023-05-30 12:59:46,824 UTC [362361] 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 12:59:46,824 UTC [362361] 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 12:59:46,850 UTC [362362] DEBUG esmvalcore.esgf._download:535 All required data is available locally, not downloading anything. 2023-05-30 12:59:46,850 UTC [362362] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_file 2023-05-30 12:59:46,851 UTC [362362] 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_125942/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 12:59:46,851 UTC [362362] 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 12:59:46,852 UTC [362362] DEBUG esmvalcore.preprocessor:369 Running preprocessor step load 2023-05-30 12:59:46,852 UTC [362362] 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 12:59:46,852 UTC [362362] 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 12:59:47,023 UTC [362361] 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 12:59:47,023 UTC [362362] 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 12:59:47,023 UTC [362361] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 12:59:47,024 UTC [362362] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 12:59:47,025 UTC [362361] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/preproc/catchment_analysis/evspsbl/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_evspsbl_1970-2000/00_load.nc 2023-05-30 12:59:47,025 UTC [362362] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/preproc/catchment_analysis/mrro/CMIP5_IPSL-CM5B-LR_Lmon_historical_r1i1p1_mrro_1970-2000/00_load.nc 2023-05-30 12:59:47,238 UTC [362361] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_metadata 2023-05-30 12:59:47,240 UTC [362361] 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 12:59:47,246 UTC [362361] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 12:59:47,247 UTC [362361] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/preproc/catchment_analysis/evspsbl/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_evspsbl_1970-2000/01_fix_metadata.nc 2023-05-30 12:59:47,288 UTC [362362] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_metadata 2023-05-30 12:59:47,290 UTC [362362] 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 12:59:47,296 UTC [362362] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 12:59:47,297 UTC [362362] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/preproc/catchment_analysis/mrro/CMIP5_IPSL-CM5B-LR_Lmon_historical_r1i1p1_mrro_1970-2000/01_fix_metadata.nc 2023-05-30 12:59:47,454 UTC [362361] DEBUG esmvalcore.preprocessor:369 Running preprocessor step concatenate 2023-05-30 12:59:47,456 UTC [362361] 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 12:59:47,456 UTC [362361] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 12:59:47,457 UTC [362361] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/preproc/catchment_analysis/evspsbl/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_evspsbl_1970-2000/02_concatenate.nc 2023-05-30 12:59:47,515 UTC [362362] DEBUG esmvalcore.preprocessor:369 Running preprocessor step concatenate 2023-05-30 12:59:47,517 UTC [362362] 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 12:59:47,517 UTC [362362] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 12:59:47,518 UTC [362362] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/preproc/catchment_analysis/mrro/CMIP5_IPSL-CM5B-LR_Lmon_historical_r1i1p1_mrro_1970-2000/02_concatenate.nc 2023-05-30 12:59:47,660 UTC [362361] DEBUG esmvalcore.preprocessor:369 Running preprocessor step cmor_check_metadata 2023-05-30 12:59:47,661 UTC [362361] 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 12:59:47,668 UTC [362361] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 12:59:47,669 UTC [362361] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/preproc/catchment_analysis/evspsbl/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_evspsbl_1970-2000/03_cmor_check_metadata.nc 2023-05-30 12:59:47,739 UTC [362362] DEBUG esmvalcore.preprocessor:369 Running preprocessor step cmor_check_metadata 2023-05-30 12:59:47,740 UTC [362362] 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 12:59:47,748 UTC [362362] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 12:59:47,749 UTC [362362] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/preproc/catchment_analysis/mrro/CMIP5_IPSL-CM5B-LR_Lmon_historical_r1i1p1_mrro_1970-2000/03_cmor_check_metadata.nc 2023-05-30 12:59:47,855 UTC [362361] DEBUG esmvalcore.preprocessor:369 Running preprocessor step clip_timerange 2023-05-30 12:59:47,856 UTC [362361] 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 12:59:47,867 UTC [362361] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 12:59:47,868 UTC [362361] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/preproc/catchment_analysis/evspsbl/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_evspsbl_1970-2000/04_clip_timerange.nc 2023-05-30 12:59:47,973 UTC [362362] DEBUG esmvalcore.preprocessor:369 Running preprocessor step clip_timerange 2023-05-30 12:59:47,974 UTC [362362] 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 12:59:47,987 UTC [362362] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 12:59:47,988 UTC [362362] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/preproc/catchment_analysis/mrro/CMIP5_IPSL-CM5B-LR_Lmon_historical_r1i1p1_mrro_1970-2000/04_clip_timerange.nc 2023-05-30 12:59:48,014 UTC [362361] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_data 2023-05-30 12:59:48,016 UTC [362361] 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 12:59:48,016 UTC [362361] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 12:59:48,017 UTC [362361] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/preproc/catchment_analysis/evspsbl/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_evspsbl_1970-2000/05_fix_data.nc 2023-05-30 12:59:48,158 UTC [362362] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_data 2023-05-30 12:59:48,159 UTC [362362] 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 12:59:48,159 UTC [362362] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 12:59:48,160 UTC [362362] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/preproc/catchment_analysis/mrro/CMIP5_IPSL-CM5B-LR_Lmon_historical_r1i1p1_mrro_1970-2000/05_fix_data.nc 2023-05-30 12:59:48,178 UTC [362361] DEBUG esmvalcore.preprocessor:369 Running preprocessor step cmor_check_data 2023-05-30 12:59:48,180 UTC [362361] 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 12:59:48,180 UTC [362361] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 12:59:48,181 UTC [362361] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/preproc/catchment_analysis/evspsbl/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_evspsbl_1970-2000/06_cmor_check_data.nc 2023-05-30 12:59:48,334 UTC [362362] DEBUG esmvalcore.preprocessor:369 Running preprocessor step cmor_check_data 2023-05-30 12:59:48,335 UTC [362362] 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 12:59:48,336 UTC [362362] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 12:59:48,337 UTC [362362] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/preproc/catchment_analysis/mrro/CMIP5_IPSL-CM5B-LR_Lmon_historical_r1i1p1_mrro_1970-2000/06_cmor_check_data.nc 2023-05-30 12:59:48,340 UTC [362361] DEBUG esmvalcore.preprocessor:369 Running preprocessor step add_supplementary_variables 2023-05-30 12:59:48,342 UTC [362361] 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 12:59:48,342 UTC [362361] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 12:59:48,342 UTC [362361] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/preproc/catchment_analysis/evspsbl/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_evspsbl_1970-2000/07_add_supplementary_variables.nc 2023-05-30 12:59:48,513 UTC [362362] DEBUG esmvalcore.preprocessor:369 Running preprocessor step add_supplementary_variables 2023-05-30 12:59:48,514 UTC [362362] 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 12:59:48,514 UTC [362362] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 12:59:48,515 UTC [362361] DEBUG esmvalcore.preprocessor:369 Running preprocessor step save 2023-05-30 12:59:48,515 UTC [362362] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/preproc/catchment_analysis/mrro/CMIP5_IPSL-CM5B-LR_Lmon_historical_r1i1p1_mrro_1970-2000/07_add_supplementary_variables.nc 2023-05-30 12:59:48,517 UTC [362361] 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_125942/preproc/catchment_analysis/evspsbl/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_evspsbl_1970-2000.nc') 2023-05-30 12:59:48,518 UTC [362361] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/preproc/catchment_analysis/evspsbl/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_evspsbl_1970-2000.nc 2023-05-30 12:59:48,701 UTC [362362] DEBUG esmvalcore.preprocessor:369 Running preprocessor step save 2023-05-30 12:59:48,703 UTC [362362] 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_125942/preproc/catchment_analysis/mrro/CMIP5_IPSL-CM5B-LR_Lmon_historical_r1i1p1_mrro_1970-2000.nc') 2023-05-30 12:59:48,703 UTC [362362] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/preproc/catchment_analysis/mrro/CMIP5_IPSL-CM5B-LR_Lmon_historical_r1i1p1_mrro_1970-2000.nc 2023-05-30 12:59:48,711 UTC [362361] INFO esmvalcore._task:264 Successfully completed task catchment_analysis/evspsbl (priority 1) in 0:00:05.163852 2023-05-30 12:59:48,851 UTC [362217] INFO esmvalcore._task:778 Progress: 1 tasks running, 2 tasks waiting for ancestors, 1/4 done 2023-05-30 12:59:48,853 UTC [362361] INFO esmvalcore._task:259 Starting task catchment_analysis/pr in process [362361] 2023-05-30 12:59:48,872 UTC [362362] INFO esmvalcore._task:264 Successfully completed task catchment_analysis/mrro (priority 2) in 0:00:05.325520 2023-05-30 12:59:48,951 UTC [362217] INFO esmvalcore._task:778 Progress: 2 tasks running, 1 tasks waiting for ancestors, 1/4 done 2023-05-30 12:59:48,967 UTC [362361] DEBUG esmvalcore.esgf._download:535 All required data is available locally, not downloading anything. 2023-05-30 12:59:48,967 UTC [362361] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_file 2023-05-30 12:59:48,967 UTC [362361] 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_125942/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 12:59:48,967 UTC [362361] 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 12:59:48,968 UTC [362361] DEBUG esmvalcore.preprocessor:369 Running preprocessor step load 2023-05-30 12:59:48,968 UTC [362361] 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 12:59:48,968 UTC [362361] 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 12:59:49,052 UTC [362217] INFO esmvalcore._task:778 Progress: 1 tasks running, 1 tasks waiting for ancestors, 2/4 done 2023-05-30 12:59:49,311 UTC [362361] 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 12:59:49,311 UTC [362361] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 12:59:49,312 UTC [362361] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/preproc/catchment_analysis/pr/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_pr_1970-2000/00_load.nc 2023-05-30 12:59:49,673 UTC [362361] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_metadata 2023-05-30 12:59:49,675 UTC [362361] 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 12:59:49,685 UTC [362361] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 12:59:49,686 UTC [362361] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/preproc/catchment_analysis/pr/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_pr_1970-2000/01_fix_metadata.nc 2023-05-30 12:59:50,022 UTC [362361] DEBUG esmvalcore.preprocessor:369 Running preprocessor step concatenate 2023-05-30 12:59:50,024 UTC [362361] 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 12:59:50,024 UTC [362361] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 12:59:50,025 UTC [362361] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/preproc/catchment_analysis/pr/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_pr_1970-2000/02_concatenate.nc 2023-05-30 12:59:50,345 UTC [362361] DEBUG esmvalcore.preprocessor:369 Running preprocessor step cmor_check_metadata 2023-05-30 12:59:50,346 UTC [362361] 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 12:59:50,355 UTC [362361] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 12:59:50,356 UTC [362361] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/preproc/catchment_analysis/pr/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_pr_1970-2000/03_cmor_check_metadata.nc 2023-05-30 12:59:50,715 UTC [362361] DEBUG esmvalcore.preprocessor:369 Running preprocessor step clip_timerange 2023-05-30 12:59:50,716 UTC [362361] 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 12:59:50,729 UTC [362361] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 12:59:50,730 UTC [362361] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/preproc/catchment_analysis/pr/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_pr_1970-2000/04_clip_timerange.nc 2023-05-30 12:59:50,924 UTC [362361] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_data 2023-05-30 12:59:50,925 UTC [362361] 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 12:59:50,926 UTC [362361] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 12:59:50,927 UTC [362361] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/preproc/catchment_analysis/pr/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_pr_1970-2000/05_fix_data.nc 2023-05-30 12:59:51,133 UTC [362361] DEBUG esmvalcore.preprocessor:369 Running preprocessor step cmor_check_data 2023-05-30 12:59:51,135 UTC [362361] 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 12:59:51,135 UTC [362361] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 12:59:51,136 UTC [362361] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/preproc/catchment_analysis/pr/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_pr_1970-2000/06_cmor_check_data.nc 2023-05-30 12:59:51,341 UTC [362361] DEBUG esmvalcore.preprocessor:369 Running preprocessor step add_supplementary_variables 2023-05-30 12:59:51,342 UTC [362361] 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 12:59:51,342 UTC [362361] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 12:59:51,343 UTC [362361] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/preproc/catchment_analysis/pr/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_pr_1970-2000/07_add_supplementary_variables.nc 2023-05-30 12:59:51,549 UTC [362361] DEBUG esmvalcore.preprocessor:369 Running preprocessor step save 2023-05-30 12:59:51,551 UTC [362361] 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_125942/preproc/catchment_analysis/pr/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_pr_1970-2000.nc') 2023-05-30 12:59:51,551 UTC [362361] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/preproc/catchment_analysis/pr/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_pr_1970-2000.nc 2023-05-30 12:59:51,782 UTC [362361] DEBUG esmvalcore.esgf._download:535 All required data is available locally, not downloading anything. 2023-05-30 12:59:51,782 UTC [362361] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_file 2023-05-30 12:59:51,782 UTC [362361] 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_125942/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 12:59:51,782 UTC [362361] 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 12:59:51,782 UTC [362361] DEBUG esmvalcore.preprocessor:369 Running preprocessor step load 2023-05-30 12:59:51,783 UTC [362361] 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 12:59:51,783 UTC [362361] 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 12:59:51,944 UTC [362361] 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 12:59:51,944 UTC [362361] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 12:59:51,945 UTC [362361] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/preproc/catchment_analysis/pr/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_pr_1970-2000/00_load.nc 2023-05-30 12:59:52,161 UTC [362361] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_metadata 2023-05-30 12:59:52,163 UTC [362361] 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 12:59:52,170 UTC [362361] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 12:59:52,172 UTC [362361] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/preproc/catchment_analysis/pr/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_pr_1970-2000/01_fix_metadata.nc 2023-05-30 12:59:52,379 UTC [362361] DEBUG esmvalcore.preprocessor:369 Running preprocessor step concatenate 2023-05-30 12:59:52,381 UTC [362361] 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 12:59:52,381 UTC [362361] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 12:59:52,382 UTC [362361] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/preproc/catchment_analysis/pr/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_pr_1970-2000/02_concatenate.nc 2023-05-30 12:59:52,572 UTC [362361] DEBUG esmvalcore.preprocessor:369 Running preprocessor step cmor_check_metadata 2023-05-30 12:59:52,574 UTC [362361] 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 12:59:52,581 UTC [362361] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 12:59:52,582 UTC [362361] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/preproc/catchment_analysis/pr/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_pr_1970-2000/03_cmor_check_metadata.nc 2023-05-30 12:59:52,771 UTC [362361] DEBUG esmvalcore.preprocessor:369 Running preprocessor step clip_timerange 2023-05-30 12:59:52,773 UTC [362361] 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 12:59:52,785 UTC [362361] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 12:59:52,786 UTC [362361] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/preproc/catchment_analysis/pr/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_pr_1970-2000/04_clip_timerange.nc 2023-05-30 12:59:52,933 UTC [362361] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_data 2023-05-30 12:59:52,934 UTC [362361] 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 12:59:52,934 UTC [362361] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 12:59:52,935 UTC [362361] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/preproc/catchment_analysis/pr/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_pr_1970-2000/05_fix_data.nc 2023-05-30 12:59:53,081 UTC [362361] DEBUG esmvalcore.preprocessor:369 Running preprocessor step cmor_check_data 2023-05-30 12:59:53,083 UTC [362361] 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 12:59:53,083 UTC [362361] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 12:59:53,084 UTC [362361] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/preproc/catchment_analysis/pr/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_pr_1970-2000/06_cmor_check_data.nc 2023-05-30 12:59:53,232 UTC [362361] DEBUG esmvalcore.preprocessor:369 Running preprocessor step add_supplementary_variables 2023-05-30 12:59:53,233 UTC [362361] 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 12:59:53,233 UTC [362361] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 12:59:53,234 UTC [362361] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/preproc/catchment_analysis/pr/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_pr_1970-2000/07_add_supplementary_variables.nc 2023-05-30 12:59:53,377 UTC [362361] DEBUG esmvalcore.preprocessor:369 Running preprocessor step save 2023-05-30 12:59:53,379 UTC [362361] 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_125942/preproc/catchment_analysis/pr/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_pr_1970-2000.nc') 2023-05-30 12:59:53,379 UTC [362361] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/preproc/catchment_analysis/pr/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_pr_1970-2000.nc 2023-05-30 12:59:53,531 UTC [362361] INFO esmvalcore._task:264 Successfully completed task catchment_analysis/pr (priority 3) in 0:00:04.678148 2023-05-30 12:59:53,559 UTC [362217] INFO esmvalcore._task:778 Progress: 0 tasks running, 1 tasks waiting for ancestors, 3/4 done 2023-05-30 12:59:53,569 UTC [362362] INFO esmvalcore._task:259 Starting task catchment_analysis/catchment_analysis in process [362362] 2023-05-30 12:59:53,573 UTC [362362] 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_125942/run/catchment_analysis/catchment_analysis/settings.yml'] 2023-05-30 12:59:53,574 UTC [362362] DEBUG esmvalcore._task:501 in environment {'MPLBACKEND': 'Agg'} 2023-05-30 12:59:53,574 UTC [362362] DEBUG esmvalcore._task:503 in current working directory: /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/run/catchment_analysis/catchment_analysis 2023-05-30 12:59:53,574 UTC [362362] INFO esmvalcore._task:504 Writing output to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/work/catchment_analysis/catchment_analysis 2023-05-30 12:59:53,574 UTC [362362] INFO esmvalcore._task:505 Writing plots to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/plots/catchment_analysis/catchment_analysis 2023-05-30 12:59:53,574 UTC [362362] INFO esmvalcore._task:506 Writing log to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/run/catchment_analysis/catchment_analysis/log.txt 2023-05-30 12:59:53,574 UTC [362362] INFO esmvalcore._task:516 To re-run this diagnostic script, run: cd /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/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_125942/run/catchment_analysis/catchment_analysis/settings.yml 2023-05-30 12:59:53,660 UTC [362217] INFO esmvalcore._task:778 Progress: 1 tasks running, 0 tasks waiting for ancestors, 3/4 done 2023-05-30 13:00:28,691 UTC [362362] DEBUG esmvalcore._task:589 Script runoff_et/catchment_analysis.py completed successfully 2023-05-30 13:00:28,691 UTC [362362] WARNING esmvalcore._task:602 No provenance information was written to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/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:00:28,691 UTC [362362] INFO esmvalcore._task:264 Successfully completed task catchment_analysis/catchment_analysis (priority 0) in 0:00:35.121945 2023-05-30 13:00:28,709 UTC [362217] INFO esmvalcore._task:778 Progress: 0 tasks running, 0 tasks waiting for ancestors, 4/4 done 2023-05-30 13:00:28,710 UTC [362217] INFO esmvalcore._task:783 Successfully completed all tasks. 2023-05-30 13:00:28,771 UTC [362217] 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_125942/run/recipe_runoff_et_filled.yml 2023-05-30 13:00:28,844 UTC [362217] INFO esmvalcore.experimental.recipe_output:205 Wrote recipe output to: file:///projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_125942/index.html 2023-05-30 13:00:28,844 UTC [362217] INFO esmvalcore._main:125 Ending the Earth System Model Evaluation Tool at time: 2023-05-30 13:00:28 UTC 2023-05-30 13:00:28,844 UTC [362217] INFO esmvalcore._main:128 Time for running the recipe was: 0:00:45.427622 2023-05-30 13:00:29,019 UTC [362217] INFO esmvalcore._task:126 Maximum memory used (estimate): 2.6 GB 2023-05-30 13:00:29,019 UTC [362217] INFO esmvalcore._task:128 Sampled every second. It may be inaccurate if short but high spikes in memory consumption occur. 2023-05-30 13:00:29,020 UTC [362217] INFO esmvalcore._main:453 Run was successful