2023-05-30 13:02:33,006 UTC [364917] INFO esmvalcore._main:495 ______________________________________________________________________ _____ ____ __ ____ __ _ _____ _ | ____/ ___|| \/ \ \ / /_ _| |_ _|__ ___ | | | _| \___ \| |\/| |\ \ / / _` | | | |/ _ \ / _ \| | | |___ ___) | | | | \ V / (_| | | | | (_) | (_) | | |_____|____/|_| |_| \_/ \__,_|_| |_|\___/ \___/|_| ______________________________________________________________________ ESMValTool - Earth System Model Evaluation Tool. http://www.esmvaltool.org CORE DEVELOPMENT TEAM AND CONTACTS: Birgit Hassler (Co-PI; DLR, Germany - birgit.hassler@dlr.de) Alistair Sellar (Co-PI; Met Office, UK - alistair.sellar@metoffice.gov.uk) Bouwe Andela (Netherlands eScience Center, The Netherlands - b.andela@esciencecenter.nl) Lee de Mora (PML, UK - ledm@pml.ac.uk) Niels Drost (Netherlands eScience Center, The Netherlands - n.drost@esciencecenter.nl) Veronika Eyring (DLR, Germany - veronika.eyring@dlr.de) Bettina Gier (UBremen, Germany - gier@uni-bremen.de) Remi Kazeroni (DLR, Germany - remi.kazeroni@dlr.de) Nikolay Koldunov (AWI, Germany - nikolay.koldunov@awi.de) Axel Lauer (DLR, Germany - axel.lauer@dlr.de) Saskia Loosveldt-Tomas (BSC, Spain - saskia.loosveldt@bsc.es) Ruth Lorenz (ETH Zurich, Switzerland - ruth.lorenz@env.ethz.ch) Benjamin Mueller (LMU, Germany - b.mueller@iggf.geo.uni-muenchen.de) Valeriu Predoi (URead, UK - valeriu.predoi@ncas.ac.uk) Mattia Righi (DLR, Germany - mattia.righi@dlr.de) Manuel Schlund (DLR, Germany - manuel.schlund@dlr.de) Breixo Solino Fernandez (DLR, Germany - breixo.solinofernandez@dlr.de) Javier Vegas-Regidor (BSC, Spain - javier.vegas@bsc.es) Klaus Zimmermann (SMHI, Sweden - klaus.zimmermann@smhi.se) For further help, please read the documentation at http://docs.esmvaltool.org. Have fun! 2023-05-30 13:02:33,006 UTC [364917] INFO esmvalcore._main:496 Package versions 2023-05-30 13:02:33,007 UTC [364917] INFO esmvalcore._main:497 ---------------- 2023-05-30 13:02:33,007 UTC [364917] INFO esmvalcore._main:498 ESMValCore: 2.8.0 2023-05-30 13:02:33,007 UTC [364917] INFO esmvalcore._main:500 ESMValTool: 2.8.0 2023-05-30 13:02:33,007 UTC [364917] INFO esmvalcore._main:501 ---------------- 2023-05-30 13:02:33,007 UTC [364917] INFO esmvalcore._main:502 Using config file /nird/home/adagj/.esmvaltool/config-user.yml 2023-05-30 13:02:33,007 UTC [364917] INFO esmvalcore._main:503 Writing program log files to: /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/run/main_log.txt /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/run/main_log_debug.txt 2023-05-30 13:02:33,124 UTC [364917] INFO esmvalcore.config._esgf_pyclient:116 Using default ESGF configuration, configuration file /nird/home/adagj/.esmvaltool/esgf-pyclient.yml not present. 2023-05-30 13:02:33,125 UTC [364917] WARNING esmvalcore.config._esgf_pyclient:181 ESGF credentials missing, only data that is accessible without logging in will be available. See https://esgf.github.io/esgf-user-support/user_guide.html for instructions on how to create an account if you do not have one yet. Next, configure your system so esmvaltool can use your credentials. This can be done using the keyring package, or you can just enter them in /nird/home/adagj/.esmvaltool/esgf-pyclient.yml. keyring ======= First install the keyring package (requires a supported backend, see https://pypi.org/project/keyring/): $ pip install keyring Next, set your username and password by running the commands: $ keyring set ESGF hostname $ keyring set ESGF username $ keyring set ESGF password To check that you entered your credentials correctly, run: $ keyring get ESGF hostname $ keyring get ESGF username $ keyring get ESGF password configuration file ================== You can store the hostname, username, and password or your OpenID account in a plain text in the file /nird/home/adagj/.esmvaltool/esgf-pyclient.yml like this: logon: hostname: "your-hostname" username: "your-username" password: "your-password" or your can configure an interactive log in: logon: interactive: true Note that storing your password in plain text in the configuration file is less secure. On shared systems, make sure the permissions of the file are set so only you can read it, i.e. $ ls -l /nird/home/adagj/.esmvaltool/esgf-pyclient.yml shows permissions -rw-------. 2023-05-30 13:02:33,666 UTC [364917] INFO esmvalcore._main:85 Starting the Earth System Model Evaluation Tool at time: 2023-05-30 13:02:33 UTC 2023-05-30 13:02:33,667 UTC [364917] INFO esmvalcore._main:89 ---------------------------------------------------------------------- 2023-05-30 13:02:33,667 UTC [364917] INFO esmvalcore._main:90 RECIPE = /nird/home/adagj/esmvaltool_workshop/recipe_runoff_et.yml 2023-05-30 13:02:33,667 UTC [364917] INFO esmvalcore._main:91 RUNDIR = /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/run 2023-05-30 13:02:33,667 UTC [364917] INFO esmvalcore._main:92 WORKDIR = /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/work 2023-05-30 13:02:33,667 UTC [364917] INFO esmvalcore._main:93 PREPROCDIR = /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/preproc 2023-05-30 13:02:33,667 UTC [364917] INFO esmvalcore._main:94 PLOTDIR = /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/plots 2023-05-30 13:02:33,667 UTC [364917] INFO esmvalcore._main:95 ---------------------------------------------------------------------- 2023-05-30 13:02:33,667 UTC [364917] INFO esmvalcore._main:98 Running tasks using at most 2 processes 2023-05-30 13:02:33,667 UTC [364917] INFO esmvalcore._main:100 If your system hangs during execution, it may not have enough memory for keeping this number of tasks in memory. 2023-05-30 13:02:33,668 UTC [364917] INFO esmvalcore._main:103 If you experience memory problems, try reducing 'max_parallel_tasks' in your user configuration file. 2023-05-30 13:02:33,668 UTC [364917] DEBUG esmvalcore._recipe.check:52 Checking recipe against schema /diagnostics/esmvaltool/2.8.0/lib/python3.10/site-packages/esmvalcore/_recipe/recipe_schema.yml 2023-05-30 13:02:33,685 UTC [364917] DEBUG esmvalcore._recipe.to_datasets:344 Populating list of datasets for variable evspsbl in diagnostic catchment_analysis 2023-05-30 13:02:33,685 UTC [364917] DEBUG esmvalcore._recipe.to_datasets:368 Found Dataset: evspsbl, Amon, CMIP5, MPI-ESM-LR, historical, r1i1p1 2023-05-30 13:02:33,686 UTC [364917] DEBUG esmvalcore._recipe.to_datasets:368 Found Dataset: evspsbl, Amon, CMIP5, IPSL-CM5B-LR, historical, r1i1p1 2023-05-30 13:02:33,686 UTC [364917] DEBUG esmvalcore._recipe.to_datasets:344 Populating list of datasets for variable mrro in diagnostic catchment_analysis 2023-05-30 13:02:33,686 UTC [364917] DEBUG esmvalcore._recipe.to_datasets:368 Found Dataset: mrro, Lmon, CMIP5, MPI-ESM-LR, historical, r1i1p1 2023-05-30 13:02:33,686 UTC [364917] DEBUG esmvalcore._recipe.to_datasets:368 Found Dataset: mrro, Lmon, CMIP5, IPSL-CM5B-LR, historical, r1i1p1 2023-05-30 13:02:33,686 UTC [364917] DEBUG esmvalcore._recipe.to_datasets:344 Populating list of datasets for variable pr in diagnostic catchment_analysis 2023-05-30 13:02:33,686 UTC [364917] DEBUG esmvalcore._recipe.to_datasets:368 Found Dataset: pr, Amon, CMIP5, MPI-ESM-LR, historical, r1i1p1 2023-05-30 13:02:33,686 UTC [364917] DEBUG esmvalcore._recipe.to_datasets:368 Found Dataset: pr, Amon, CMIP5, IPSL-CM5B-LR, historical, r1i1p1 2023-05-30 13:02:33,687 UTC [364917] DEBUG esmvalcore._recipe.recipe:1014 Retrieving diagnostics from recipe 2023-05-30 13:02:33,687 UTC [364917] DEBUG esmvalcore._recipe.recipe:1042 Setting script for diagnostic catchment_analysis 2023-05-30 13:02:33,687 UTC [364917] INFO esmvalcore._recipe.recipe:1232 Creating tasks from recipe 2023-05-30 13:02:33,687 UTC [364917] INFO esmvalcore._recipe.recipe:1241 Creating tasks for diagnostic catchment_analysis 2023-05-30 13:02:33,687 UTC [364917] INFO esmvalcore._recipe.recipe:1163 Creating diagnostic task catchment_analysis/catchment_analysis 2023-05-30 13:02:33,688 UTC [364917] INFO esmvalcore._recipe.recipe:1216 Creating preprocessor task catchment_analysis/evspsbl 2023-05-30 13:02:33,688 UTC [364917] INFO esmvalcore._recipe.recipe:849 Creating preprocessor 'default' task for variable 'evspsbl' 2023-05-30 13:02:33,688 UTC [364917] DEBUG esmvalcore.config._config:48 Loading extra facets from /diagnostics/esmvaltool/2.8.0/lib/python3.10/site-packages/esmvalcore/config/extra_facets/cmip5-fx.yml 2023-05-30 13:02:33,689 UTC [364917] DEBUG esmvalcore.config._config:48 Loading extra facets from /diagnostics/esmvaltool/2.8.0/lib/python3.10/site-packages/esmvalcore/config/extra_facets/cmip5-institutes.yml 2023-05-30 13:02:33,718 UTC [364917] DEBUG esmvalcore.config._config:48 Loading extra facets from /diagnostics/esmvaltool/2.8.0/lib/python3.10/site-packages/esmvalcore/config/extra_facets/cmip5-product.yml 2023-05-30 13:02:33,724 UTC [364917] WARNING esmvalcore.local:426 'CMIP5' rootpaths '/scratch/adagj/ESGF/cmip5/output1' set in config-user.yml do not exist 2023-05-30 13:02:33,724 UTC [364917] DEBUG esmvalcore.local:458 Looking for files matching: /projects/NS9034K/CMIP5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/*/evspsbl/evspsbl_Amon_MPI-ESM-LR_historical_r1i1p1*.nc /projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/*/evspsbl/evspsbl_Amon_MPI-ESM-LR_historical_r1i1p1*.nc /scratch/adagj/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/*/evspsbl/evspsbl_Amon_MPI-ESM-LR_historical_r1i1p1*.nc 2023-05-30 13:02:33,727 UTC [364917] DEBUG esmvalcore._recipe.recipe:446 Using input files for variable evspsbl of dataset MPI-ESM-LR: /projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/v20120315/evspsbl/evspsbl_Amon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc 2023-05-30 13:02:33,727 UTC [364917] INFO esmvalcore._recipe.recipe:717 Found input files for Dataset: evspsbl, Amon, CMIP5, MPI-ESM-LR, historical, r1i1p1, v20120315 2023-05-30 13:02:33,728 UTC [364917] DEBUG esmvalcore.local:458 Looking for files matching: /projects/NS9034K/CMIP5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/*/evspsbl/evspsbl_Amon_IPSL-CM5B-LR_historical_r1i1p1*.nc /projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/*/evspsbl/evspsbl_Amon_IPSL-CM5B-LR_historical_r1i1p1*.nc /scratch/adagj/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/*/evspsbl/evspsbl_Amon_IPSL-CM5B-LR_historical_r1i1p1*.nc 2023-05-30 13:02:33,729 UTC [364917] DEBUG esmvalcore._recipe.recipe:446 Using input files for variable evspsbl of dataset IPSL-CM5B-LR: /projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/v20120114/evspsbl/evspsbl_Amon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc 2023-05-30 13:02:33,730 UTC [364917] INFO esmvalcore._recipe.recipe:717 Found input files for Dataset: evspsbl, Amon, CMIP5, IPSL-CM5B-LR, historical, r1i1p1, v20120114 2023-05-30 13:02:33,731 UTC [364917] INFO esmvalcore._recipe.recipe:873 PreprocessingTask catchment_analysis/evspsbl created. 2023-05-30 13:02:33,731 UTC [364917] DEBUG esmvalcore._recipe.recipe:874 PreprocessingTask catchment_analysis/evspsbl will create the files: /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/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_130233/preproc/catchment_analysis/evspsbl/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_evspsbl_1970-2000.nc 2023-05-30 13:02:33,731 UTC [364917] INFO esmvalcore._recipe.recipe:1216 Creating preprocessor task catchment_analysis/mrro 2023-05-30 13:02:33,731 UTC [364917] INFO esmvalcore._recipe.recipe:849 Creating preprocessor 'default' task for variable 'mrro' 2023-05-30 13:02:33,731 UTC [364917] DEBUG esmvalcore.local:458 Looking for files matching: /projects/NS9034K/CMIP5/output1/MPI-M/MPI-ESM-LR/historical/mon/land/Lmon/r1i1p1/*/mrro/mrro_Lmon_MPI-ESM-LR_historical_r1i1p1*.nc /projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/land/Lmon/r1i1p1/*/mrro/mrro_Lmon_MPI-ESM-LR_historical_r1i1p1*.nc /scratch/adagj/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/land/Lmon/r1i1p1/*/mrro/mrro_Lmon_MPI-ESM-LR_historical_r1i1p1*.nc 2023-05-30 13:02:33,733 UTC [364917] DEBUG esmvalcore._recipe.recipe:446 Using input files for variable mrro of dataset MPI-ESM-LR: /projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/land/Lmon/r1i1p1/v20120625/mrro/mrro_Lmon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc 2023-05-30 13:02:33,733 UTC [364917] INFO esmvalcore._recipe.recipe:717 Found input files for Dataset: mrro, Lmon, CMIP5, MPI-ESM-LR, historical, r1i1p1, v20120625 2023-05-30 13:02:33,733 UTC [364917] DEBUG esmvalcore.local:458 Looking for files matching: /projects/NS9034K/CMIP5/output1/IPSL/IPSL-CM5B-LR/historical/mon/land/Lmon/r1i1p1/*/mrro/mrro_Lmon_IPSL-CM5B-LR_historical_r1i1p1*.nc /projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/land/Lmon/r1i1p1/*/mrro/mrro_Lmon_IPSL-CM5B-LR_historical_r1i1p1*.nc /scratch/adagj/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/land/Lmon/r1i1p1/*/mrro/mrro_Lmon_IPSL-CM5B-LR_historical_r1i1p1*.nc 2023-05-30 13:02:33,735 UTC [364917] DEBUG esmvalcore._recipe.recipe:446 Using input files for variable mrro of dataset IPSL-CM5B-LR: /projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/land/Lmon/r1i1p1/v20130506/mrro/mrro_Lmon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc 2023-05-30 13:02:33,735 UTC [364917] INFO esmvalcore._recipe.recipe:717 Found input files for Dataset: mrro, Lmon, CMIP5, IPSL-CM5B-LR, historical, r1i1p1, v20130506 2023-05-30 13:02:33,736 UTC [364917] INFO esmvalcore._recipe.recipe:873 PreprocessingTask catchment_analysis/mrro created. 2023-05-30 13:02:33,736 UTC [364917] DEBUG esmvalcore._recipe.recipe:874 PreprocessingTask catchment_analysis/mrro will create the files: /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/preproc/catchment_analysis/mrro/CMIP5_IPSL-CM5B-LR_Lmon_historical_r1i1p1_mrro_1970-2000.nc /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/preproc/catchment_analysis/mrro/CMIP5_MPI-ESM-LR_Lmon_historical_r1i1p1_mrro_1970-2000.nc 2023-05-30 13:02:33,736 UTC [364917] INFO esmvalcore._recipe.recipe:1216 Creating preprocessor task catchment_analysis/pr 2023-05-30 13:02:33,736 UTC [364917] INFO esmvalcore._recipe.recipe:849 Creating preprocessor 'default' task for variable 'pr' 2023-05-30 13:02:33,736 UTC [364917] DEBUG esmvalcore.local:458 Looking for files matching: /projects/NS9034K/CMIP5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/*/pr/pr_Amon_MPI-ESM-LR_historical_r1i1p1*.nc /projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/*/pr/pr_Amon_MPI-ESM-LR_historical_r1i1p1*.nc /scratch/adagj/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/*/pr/pr_Amon_MPI-ESM-LR_historical_r1i1p1*.nc 2023-05-30 13:02:33,738 UTC [364917] DEBUG esmvalcore._recipe.recipe:446 Using input files for variable pr of dataset MPI-ESM-LR: /projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/v20120315/pr/pr_Amon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc 2023-05-30 13:02:33,738 UTC [364917] INFO esmvalcore._recipe.recipe:717 Found input files for Dataset: pr, Amon, CMIP5, MPI-ESM-LR, historical, r1i1p1, v20120315 2023-05-30 13:02:33,738 UTC [364917] DEBUG esmvalcore.local:458 Looking for files matching: /projects/NS9034K/CMIP5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/*/pr/pr_Amon_IPSL-CM5B-LR_historical_r1i1p1*.nc /projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/*/pr/pr_Amon_IPSL-CM5B-LR_historical_r1i1p1*.nc /scratch/adagj/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/*/pr/pr_Amon_IPSL-CM5B-LR_historical_r1i1p1*.nc 2023-05-30 13:02:33,739 UTC [364917] DEBUG esmvalcore._recipe.recipe:446 Using input files for variable pr of dataset IPSL-CM5B-LR: /projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/v20120114/pr/pr_Amon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc 2023-05-30 13:02:33,740 UTC [364917] INFO esmvalcore._recipe.recipe:717 Found input files for Dataset: pr, Amon, CMIP5, IPSL-CM5B-LR, historical, r1i1p1, v20120114 2023-05-30 13:02:33,741 UTC [364917] INFO esmvalcore._recipe.recipe:873 PreprocessingTask catchment_analysis/pr created. 2023-05-30 13:02:33,741 UTC [364917] DEBUG esmvalcore._recipe.recipe:874 PreprocessingTask catchment_analysis/pr will create the files: /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/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_130233/preproc/catchment_analysis/pr/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_pr_1970-2000.nc 2023-05-30 13:02:33,741 UTC [364917] DEBUG esmvalcore._recipe.recipe:1091 Linking tasks for diagnostic catchment_analysis script catchment_analysis 2023-05-30 13:02:33,741 UTC [364917] DEBUG esmvalcore._recipe.recipe:1100 Pattern catchment_analysis/evspsbl matches ['catchment_analysis/evspsbl'] 2023-05-30 13:02:33,741 UTC [364917] DEBUG esmvalcore._recipe.recipe:1100 Pattern catchment_analysis/mrro matches ['catchment_analysis/mrro'] 2023-05-30 13:02:33,741 UTC [364917] DEBUG esmvalcore._recipe.recipe:1100 Pattern catchment_analysis/pr matches ['catchment_analysis/pr'] 2023-05-30 13:02:33,741 UTC [364917] INFO esmvalcore._recipe.recipe:1281 These tasks will be executed: catchment_analysis/pr, catchment_analysis/evspsbl, catchment_analysis/mrro, catchment_analysis/catchment_analysis 2023-05-30 13:02:33,744 UTC [364917] 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_130233/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_130233/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_130233/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_130233/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_130233/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_130233/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_130233/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_130233/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_130233/preproc/catchment_analysis/mrro/CMIP5_IPSL-CM5B-LR_Lmon_historical_r1i1p1_mrro_1970-2000.nc')}} PreprocessorFile: /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/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_130233/preproc/catchment_analysis/mrro/CMIP5_MPI-ESM-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_130233/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_130233/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_130233/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_130233/preproc/catchment_analysis/pr/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_pr_1970-2000.nc')}} ancestors: None 2023-05-30 13:02:33,750 UTC [364917] 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_130233/run/recipe_runoff_et_filled.yml 2023-05-30 13:02:33,750 UTC [364917] DEBUG esmvalcore.esgf._download:535 All required data is available locally, not downloading anything. 2023-05-30 13:02:33,750 UTC [364917] INFO esmvalcore._task:746 Running 4 tasks using 2 processes 2023-05-30 13:02:33,811 UTC [365060] INFO esmvalcore._task:259 Starting task catchment_analysis/mrro in process [365060] 2023-05-30 13:02:33,811 UTC [365059] INFO esmvalcore._task:259 Starting task catchment_analysis/evspsbl in process [365059] 2023-05-30 13:02:33,884 UTC [365060] DEBUG esmvalcore.esgf._download:535 All required data is available locally, not downloading anything. 2023-05-30 13:02:33,885 UTC [365060] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_file 2023-05-30 13:02:33,885 UTC [365060] 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_130233/preproc/fixed_files/mrro_Lmon_CMIP5_IPSL-CM5B-LR_historical_r1i1p1_v20130506_'), add_unique_suffix = True, mip = 'Lmon', dataset = 'IPSL-CM5B-LR', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', short_name = 'mrro', timerange = '1970/2000', variable_group = 'mrro', diagnostic = 'catchment_analysis', recipe_dataset_index = 1, alias = 'IPSL-CM5B-LR', product = ['output1', 'output2'], institute = ['IPSL'], original_short_name = 'mrro', standard_name = 'runoff_flux', long_name = 'Total Runoff', units = 'kg m-2 s-1', modeling_realm = ['land'], frequency = 'mon', version = 'v20130506' 2023-05-30 13:02:33,887 UTC [365060] DEBUG esmvalcore.preprocessor:390 Result [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/land/Lmon/r1i1p1/v20130506/mrro/mrro_Lmon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc')] 2023-05-30 13:02:33,887 UTC [365060] DEBUG esmvalcore.preprocessor:369 Running preprocessor step load 2023-05-30 13:02:33,888 UTC [365060] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'load' on the data LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/land/Lmon/r1i1p1/v20130506/mrro/mrro_Lmon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc') loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/land/Lmon/r1i1p1/v20130506/mrro/mrro_Lmon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) callback = 'default' 2023-05-30 13:02:33,888 UTC [365060] DEBUG esmvalcore.preprocessor._io:152 Loading: /projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/land/Lmon/r1i1p1/v20130506/mrro/mrro_Lmon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc 2023-05-30 13:02:33,906 UTC [364917] INFO esmvalcore._task:778 Progress: 2 tasks running, 2 tasks waiting for ancestors, 0/4 done 2023-05-30 13:02:33,915 UTC [365059] DEBUG esmvalcore.esgf._download:535 All required data is available locally, not downloading anything. 2023-05-30 13:02:33,915 UTC [365059] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_file 2023-05-30 13:02:33,916 UTC [365059] 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_130233/preproc/fixed_files/evspsbl_Amon_CMIP5_MPI-ESM-LR_historical_r1i1p1_v20120315_'), add_unique_suffix = True, mip = 'Amon', dataset = 'MPI-ESM-LR', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', short_name = 'evspsbl', timerange = '1970/2000', variable_group = 'evspsbl', diagnostic = 'catchment_analysis', recipe_dataset_index = 0, alias = 'MPI-ESM-LR', product = ['output1', 'output2'], institute = ['MPI-M'], original_short_name = 'evspsbl', standard_name = 'water_evaporation_flux', long_name = 'Evaporation', units = 'kg m-2 s-1', modeling_realm = ['atmos'], frequency = 'mon', version = 'v20120315' 2023-05-30 13:02:33,918 UTC [365059] DEBUG esmvalcore.preprocessor:390 Result [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/v20120315/evspsbl/evspsbl_Amon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc')] 2023-05-30 13:02:33,918 UTC [365059] DEBUG esmvalcore.preprocessor:369 Running preprocessor step load 2023-05-30 13:02:33,918 UTC [365059] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'load' on the data LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/v20120315/evspsbl/evspsbl_Amon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc') loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/v20120315/evspsbl/evspsbl_Amon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) callback = 'default' 2023-05-30 13:02:33,918 UTC [365059] DEBUG esmvalcore.preprocessor._io:152 Loading: /projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/v20120315/evspsbl/evspsbl_Amon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc 2023-05-30 13:02:33,953 UTC [365060] DEBUG esmvalcore.preprocessor._io:182 Done with loading /projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/land/Lmon/r1i1p1/v20130506/mrro/mrro_Lmon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc 2023-05-30 13:02:33,954 UTC [365060] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:02:33,957 UTC [365060] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/preproc/catchment_analysis/mrro/CMIP5_IPSL-CM5B-LR_Lmon_historical_r1i1p1_mrro_1970-2000/00_load.nc 2023-05-30 13:02:34,093 UTC [365059] DEBUG esmvalcore.preprocessor._io:182 Done with loading /projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/v20120315/evspsbl/evspsbl_Amon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc 2023-05-30 13:02:34,093 UTC [365059] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:02:34,097 UTC [365059] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/preproc/catchment_analysis/evspsbl/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_evspsbl_1970-2000/00_load.nc 2023-05-30 13:02:34,381 UTC [365060] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_metadata 2023-05-30 13:02:34,383 UTC [365060] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'fix_metadata' on the data [] loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/land/Lmon/r1i1p1/v20130506/mrro/mrro_Lmon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) check_level = , mip = 'Lmon', dataset = 'IPSL-CM5B-LR', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', short_name = 'mrro', timerange = '1970/2000', variable_group = 'mrro', diagnostic = 'catchment_analysis', recipe_dataset_index = 1, alias = 'IPSL-CM5B-LR', product = ['output1', 'output2'], institute = ['IPSL'], original_short_name = 'mrro', standard_name = 'runoff_flux', long_name = 'Total Runoff', units = 'kg m-2 s-1', modeling_realm = ['land'], frequency = 'mon', version = 'v20130506' 2023-05-30 13:02:34,389 UTC [365060] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:02:34,390 UTC [365060] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/preproc/catchment_analysis/mrro/CMIP5_IPSL-CM5B-LR_Lmon_historical_r1i1p1_mrro_1970-2000/01_fix_metadata.nc 2023-05-30 13:02:34,607 UTC [365060] DEBUG esmvalcore.preprocessor:369 Running preprocessor step concatenate 2023-05-30 13:02:34,609 UTC [365060] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'concatenate' on the data [] loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/land/Lmon/r1i1p1/v20130506/mrro/mrro_Lmon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) 2023-05-30 13:02:34,609 UTC [365060] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:02:34,609 UTC [365060] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/preproc/catchment_analysis/mrro/CMIP5_IPSL-CM5B-LR_Lmon_historical_r1i1p1_mrro_1970-2000/02_concatenate.nc 2023-05-30 13:02:34,642 UTC [365059] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_metadata 2023-05-30 13:02:34,644 UTC [365059] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'fix_metadata' on the data [] loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/v20120315/evspsbl/evspsbl_Amon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) check_level = , mip = 'Amon', dataset = 'MPI-ESM-LR', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', short_name = 'evspsbl', timerange = '1970/2000', variable_group = 'evspsbl', diagnostic = 'catchment_analysis', recipe_dataset_index = 0, alias = 'MPI-ESM-LR', product = ['output1', 'output2'], institute = ['MPI-M'], original_short_name = 'evspsbl', standard_name = 'water_evaporation_flux', long_name = 'Evaporation', units = 'kg m-2 s-1', modeling_realm = ['atmos'], frequency = 'mon', version = 'v20120315' 2023-05-30 13:02:34,651 UTC [365059] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:02:34,652 UTC [365059] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/preproc/catchment_analysis/evspsbl/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_evspsbl_1970-2000/01_fix_metadata.nc 2023-05-30 13:02:34,807 UTC [365060] DEBUG esmvalcore.preprocessor:369 Running preprocessor step cmor_check_metadata 2023-05-30 13:02:34,808 UTC [365060] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'cmor_check_metadata' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/land/Lmon/r1i1p1/v20130506/mrro/mrro_Lmon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) check_level = , cmor_table = 'CMIP5', mip = 'Lmon', frequency = 'mon', short_name = 'mrro' 2023-05-30 13:02:34,814 UTC [365060] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:02:34,815 UTC [365060] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/preproc/catchment_analysis/mrro/CMIP5_IPSL-CM5B-LR_Lmon_historical_r1i1p1_mrro_1970-2000/03_cmor_check_metadata.nc 2023-05-30 13:02:35,011 UTC [365059] DEBUG esmvalcore.preprocessor:369 Running preprocessor step concatenate 2023-05-30 13:02:35,013 UTC [365059] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'concatenate' on the data [] loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/v20120315/evspsbl/evspsbl_Amon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) 2023-05-30 13:02:35,013 UTC [365059] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:02:35,014 UTC [365059] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/preproc/catchment_analysis/evspsbl/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_evspsbl_1970-2000/02_concatenate.nc 2023-05-30 13:02:35,020 UTC [365060] DEBUG esmvalcore.preprocessor:369 Running preprocessor step clip_timerange 2023-05-30 13:02:35,021 UTC [365060] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'clip_timerange' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/land/Lmon/r1i1p1/v20130506/mrro/mrro_Lmon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) timerange = '1970/2000' 2023-05-30 13:02:35,033 UTC [365060] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:02:35,034 UTC [365060] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/preproc/catchment_analysis/mrro/CMIP5_IPSL-CM5B-LR_Lmon_historical_r1i1p1_mrro_1970-2000/04_clip_timerange.nc 2023-05-30 13:02:35,201 UTC [365060] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_data 2023-05-30 13:02:35,202 UTC [365060] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'fix_data' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/land/Lmon/r1i1p1/v20130506/mrro/mrro_Lmon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) check_level = , mip = 'Lmon', dataset = 'IPSL-CM5B-LR', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', short_name = 'mrro', timerange = '1970/2000', variable_group = 'mrro', diagnostic = 'catchment_analysis', recipe_dataset_index = 1, alias = 'IPSL-CM5B-LR', product = ['output1', 'output2'], institute = ['IPSL'], original_short_name = 'mrro', standard_name = 'runoff_flux', long_name = 'Total Runoff', units = 'kg m-2 s-1', modeling_realm = ['land'], frequency = 'mon', version = 'v20130506' 2023-05-30 13:02:35,203 UTC [365060] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:02:35,203 UTC [365060] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/preproc/catchment_analysis/mrro/CMIP5_IPSL-CM5B-LR_Lmon_historical_r1i1p1_mrro_1970-2000/05_fix_data.nc 2023-05-30 13:02:35,326 UTC [365059] DEBUG esmvalcore.preprocessor:369 Running preprocessor step cmor_check_metadata 2023-05-30 13:02:35,327 UTC [365059] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'cmor_check_metadata' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/v20120315/evspsbl/evspsbl_Amon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) check_level = , cmor_table = 'CMIP5', mip = 'Amon', frequency = 'mon', short_name = 'evspsbl' 2023-05-30 13:02:35,334 UTC [365059] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:02:35,335 UTC [365059] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/preproc/catchment_analysis/evspsbl/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_evspsbl_1970-2000/03_cmor_check_metadata.nc 2023-05-30 13:02:35,365 UTC [365060] DEBUG esmvalcore.preprocessor:369 Running preprocessor step cmor_check_data 2023-05-30 13:02:35,366 UTC [365060] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'cmor_check_data' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/land/Lmon/r1i1p1/v20130506/mrro/mrro_Lmon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) check_level = , cmor_table = 'CMIP5', mip = 'Lmon', frequency = 'mon', short_name = 'mrro' 2023-05-30 13:02:35,366 UTC [365060] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:02:35,367 UTC [365060] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/preproc/catchment_analysis/mrro/CMIP5_IPSL-CM5B-LR_Lmon_historical_r1i1p1_mrro_1970-2000/06_cmor_check_data.nc 2023-05-30 13:02:35,537 UTC [365060] DEBUG esmvalcore.preprocessor:369 Running preprocessor step add_supplementary_variables 2023-05-30 13:02:35,538 UTC [365060] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'add_supplementary_variables' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/land/Lmon/r1i1p1/v20130506/mrro/mrro_Lmon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) supplementary_cubes = [] 2023-05-30 13:02:35,538 UTC [365060] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:02:35,539 UTC [365060] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/preproc/catchment_analysis/mrro/CMIP5_IPSL-CM5B-LR_Lmon_historical_r1i1p1_mrro_1970-2000/07_add_supplementary_variables.nc 2023-05-30 13:02:35,690 UTC [365060] DEBUG esmvalcore.preprocessor:369 Running preprocessor step save 2023-05-30 13:02:35,692 UTC [365060] 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_130233/preproc/catchment_analysis/mrro/CMIP5_IPSL-CM5B-LR_Lmon_historical_r1i1p1_mrro_1970-2000.nc') 2023-05-30 13:02:35,692 UTC [365060] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/preproc/catchment_analysis/mrro/CMIP5_IPSL-CM5B-LR_Lmon_historical_r1i1p1_mrro_1970-2000.nc 2023-05-30 13:02:35,726 UTC [365059] DEBUG esmvalcore.preprocessor:369 Running preprocessor step clip_timerange 2023-05-30 13:02:35,727 UTC [365059] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'clip_timerange' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/v20120315/evspsbl/evspsbl_Amon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) timerange = '1970/2000' 2023-05-30 13:02:35,740 UTC [365059] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:02:35,740 UTC [365059] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/preproc/catchment_analysis/evspsbl/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_evspsbl_1970-2000/04_clip_timerange.nc 2023-05-30 13:02:35,917 UTC [365060] DEBUG esmvalcore.esgf._download:535 All required data is available locally, not downloading anything. 2023-05-30 13:02:35,917 UTC [365060] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_file 2023-05-30 13:02:35,918 UTC [365060] 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_130233/preproc/fixed_files/mrro_Lmon_CMIP5_MPI-ESM-LR_historical_r1i1p1_v20120625_'), add_unique_suffix = True, mip = 'Lmon', dataset = 'MPI-ESM-LR', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', short_name = 'mrro', timerange = '1970/2000', variable_group = 'mrro', diagnostic = 'catchment_analysis', recipe_dataset_index = 0, alias = 'MPI-ESM-LR', product = ['output1', 'output2'], institute = ['MPI-M'], original_short_name = 'mrro', standard_name = 'runoff_flux', long_name = 'Total Runoff', units = 'kg m-2 s-1', modeling_realm = ['land'], frequency = 'mon', version = 'v20120625' 2023-05-30 13:02:35,918 UTC [365060] DEBUG esmvalcore.preprocessor:390 Result [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/land/Lmon/r1i1p1/v20120625/mrro/mrro_Lmon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc')] 2023-05-30 13:02:35,918 UTC [365060] DEBUG esmvalcore.preprocessor:369 Running preprocessor step load 2023-05-30 13:02:35,919 UTC [365060] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'load' on the data LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/land/Lmon/r1i1p1/v20120625/mrro/mrro_Lmon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc') loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/land/Lmon/r1i1p1/v20120625/mrro/mrro_Lmon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) callback = 'default' 2023-05-30 13:02:35,919 UTC [365060] DEBUG esmvalcore.preprocessor._io:152 Loading: /projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/land/Lmon/r1i1p1/v20120625/mrro/mrro_Lmon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc 2023-05-30 13:02:35,947 UTC [365059] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_data 2023-05-30 13:02:35,948 UTC [365059] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'fix_data' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/v20120315/evspsbl/evspsbl_Amon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) check_level = , mip = 'Amon', dataset = 'MPI-ESM-LR', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', short_name = 'evspsbl', timerange = '1970/2000', variable_group = 'evspsbl', diagnostic = 'catchment_analysis', recipe_dataset_index = 0, alias = 'MPI-ESM-LR', product = ['output1', 'output2'], institute = ['MPI-M'], original_short_name = 'evspsbl', standard_name = 'water_evaporation_flux', long_name = 'Evaporation', units = 'kg m-2 s-1', modeling_realm = ['atmos'], frequency = 'mon', version = 'v20120315' 2023-05-30 13:02:35,949 UTC [365059] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:02:35,949 UTC [365059] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/preproc/catchment_analysis/evspsbl/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_evspsbl_1970-2000/05_fix_data.nc 2023-05-30 13:02:36,084 UTC [365060] DEBUG esmvalcore.preprocessor._io:182 Done with loading /projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/land/Lmon/r1i1p1/v20120625/mrro/mrro_Lmon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc 2023-05-30 13:02:36,084 UTC [365060] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:02:36,085 UTC [365060] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/preproc/catchment_analysis/mrro/CMIP5_MPI-ESM-LR_Lmon_historical_r1i1p1_mrro_1970-2000/00_load.nc 2023-05-30 13:02:36,142 UTC [365059] DEBUG esmvalcore.preprocessor:369 Running preprocessor step cmor_check_data 2023-05-30 13:02:36,144 UTC [365059] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'cmor_check_data' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/v20120315/evspsbl/evspsbl_Amon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) check_level = , cmor_table = 'CMIP5', mip = 'Amon', frequency = 'mon', short_name = 'evspsbl' 2023-05-30 13:02:36,144 UTC [365059] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:02:36,145 UTC [365059] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/preproc/catchment_analysis/evspsbl/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_evspsbl_1970-2000/06_cmor_check_data.nc 2023-05-30 13:02:36,342 UTC [365059] DEBUG esmvalcore.preprocessor:369 Running preprocessor step add_supplementary_variables 2023-05-30 13:02:36,343 UTC [365059] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'add_supplementary_variables' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/v20120315/evspsbl/evspsbl_Amon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) supplementary_cubes = [] 2023-05-30 13:02:36,343 UTC [365059] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:02:36,344 UTC [365059] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/preproc/catchment_analysis/evspsbl/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_evspsbl_1970-2000/07_add_supplementary_variables.nc 2023-05-30 13:02:36,391 UTC [365060] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_metadata 2023-05-30 13:02:36,393 UTC [365060] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'fix_metadata' on the data [] loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/land/Lmon/r1i1p1/v20120625/mrro/mrro_Lmon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) check_level = , mip = 'Lmon', dataset = 'MPI-ESM-LR', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', short_name = 'mrro', timerange = '1970/2000', variable_group = 'mrro', diagnostic = 'catchment_analysis', recipe_dataset_index = 0, alias = 'MPI-ESM-LR', product = ['output1', 'output2'], institute = ['MPI-M'], original_short_name = 'mrro', standard_name = 'runoff_flux', long_name = 'Total Runoff', units = 'kg m-2 s-1', modeling_realm = ['land'], frequency = 'mon', version = 'v20120625' 2023-05-30 13:02:36,400 UTC [365060] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:02:36,401 UTC [365060] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/preproc/catchment_analysis/mrro/CMIP5_MPI-ESM-LR_Lmon_historical_r1i1p1_mrro_1970-2000/01_fix_metadata.nc 2023-05-30 13:02:36,565 UTC [365059] DEBUG esmvalcore.preprocessor:369 Running preprocessor step save 2023-05-30 13:02:36,566 UTC [365059] 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_130233/preproc/catchment_analysis/evspsbl/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_evspsbl_1970-2000.nc') 2023-05-30 13:02:36,567 UTC [365059] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/preproc/catchment_analysis/evspsbl/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_evspsbl_1970-2000.nc 2023-05-30 13:02:36,762 UTC [365060] DEBUG esmvalcore.preprocessor:369 Running preprocessor step concatenate 2023-05-30 13:02:36,764 UTC [365060] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'concatenate' on the data [] loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/land/Lmon/r1i1p1/v20120625/mrro/mrro_Lmon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) 2023-05-30 13:02:36,764 UTC [365060] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:02:36,765 UTC [365060] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/preproc/catchment_analysis/mrro/CMIP5_MPI-ESM-LR_Lmon_historical_r1i1p1_mrro_1970-2000/02_concatenate.nc 2023-05-30 13:02:36,821 UTC [365059] DEBUG esmvalcore.esgf._download:535 All required data is available locally, not downloading anything. 2023-05-30 13:02:36,821 UTC [365059] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_file 2023-05-30 13:02:36,822 UTC [365059] 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_130233/preproc/fixed_files/evspsbl_Amon_CMIP5_IPSL-CM5B-LR_historical_r1i1p1_v20120114_'), add_unique_suffix = True, mip = 'Amon', dataset = 'IPSL-CM5B-LR', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', short_name = 'evspsbl', timerange = '1970/2000', variable_group = 'evspsbl', diagnostic = 'catchment_analysis', recipe_dataset_index = 1, alias = 'IPSL-CM5B-LR', product = ['output1', 'output2'], institute = ['IPSL'], original_short_name = 'evspsbl', standard_name = 'water_evaporation_flux', long_name = 'Evaporation', units = 'kg m-2 s-1', modeling_realm = ['atmos'], frequency = 'mon', version = 'v20120114' 2023-05-30 13:02:36,822 UTC [365059] DEBUG esmvalcore.preprocessor:390 Result [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/v20120114/evspsbl/evspsbl_Amon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc')] 2023-05-30 13:02:36,823 UTC [365059] DEBUG esmvalcore.preprocessor:369 Running preprocessor step load 2023-05-30 13:02:36,823 UTC [365059] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'load' on the data LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/v20120114/evspsbl/evspsbl_Amon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc') loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/v20120114/evspsbl/evspsbl_Amon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) callback = 'default' 2023-05-30 13:02:36,823 UTC [365059] DEBUG esmvalcore.preprocessor._io:152 Loading: /projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/v20120114/evspsbl/evspsbl_Amon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc 2023-05-30 13:02:36,945 UTC [365059] DEBUG esmvalcore.preprocessor._io:182 Done with loading /projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/v20120114/evspsbl/evspsbl_Amon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc 2023-05-30 13:02:36,945 UTC [365059] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:02:36,946 UTC [365059] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/preproc/catchment_analysis/evspsbl/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_evspsbl_1970-2000/00_load.nc 2023-05-30 13:02:37,126 UTC [365060] DEBUG esmvalcore.preprocessor:369 Running preprocessor step cmor_check_metadata 2023-05-30 13:02:37,127 UTC [365060] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'cmor_check_metadata' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/land/Lmon/r1i1p1/v20120625/mrro/mrro_Lmon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) check_level = , cmor_table = 'CMIP5', mip = 'Lmon', frequency = 'mon', short_name = 'mrro' 2023-05-30 13:02:37,133 UTC [365060] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:02:37,134 UTC [365060] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/preproc/catchment_analysis/mrro/CMIP5_MPI-ESM-LR_Lmon_historical_r1i1p1_mrro_1970-2000/03_cmor_check_metadata.nc 2023-05-30 13:02:37,151 UTC [365059] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_metadata 2023-05-30 13:02:37,153 UTC [365059] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'fix_metadata' on the data [] loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/v20120114/evspsbl/evspsbl_Amon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) check_level = , mip = 'Amon', dataset = 'IPSL-CM5B-LR', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', short_name = 'evspsbl', timerange = '1970/2000', variable_group = 'evspsbl', diagnostic = 'catchment_analysis', recipe_dataset_index = 1, alias = 'IPSL-CM5B-LR', product = ['output1', 'output2'], institute = ['IPSL'], original_short_name = 'evspsbl', standard_name = 'water_evaporation_flux', long_name = 'Evaporation', units = 'kg m-2 s-1', modeling_realm = ['atmos'], frequency = 'mon', version = 'v20120114' 2023-05-30 13:02:37,158 UTC [365059] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:02:37,159 UTC [365059] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/preproc/catchment_analysis/evspsbl/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_evspsbl_1970-2000/01_fix_metadata.nc 2023-05-30 13:02:37,369 UTC [365059] DEBUG esmvalcore.preprocessor:369 Running preprocessor step concatenate 2023-05-30 13:02:37,370 UTC [365059] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'concatenate' on the data [] loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/v20120114/evspsbl/evspsbl_Amon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) 2023-05-30 13:02:37,370 UTC [365059] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:02:37,371 UTC [365059] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/preproc/catchment_analysis/evspsbl/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_evspsbl_1970-2000/02_concatenate.nc 2023-05-30 13:02:37,453 UTC [365060] DEBUG esmvalcore.preprocessor:369 Running preprocessor step clip_timerange 2023-05-30 13:02:37,455 UTC [365060] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'clip_timerange' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/land/Lmon/r1i1p1/v20120625/mrro/mrro_Lmon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) timerange = '1970/2000' 2023-05-30 13:02:37,465 UTC [365060] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:02:37,466 UTC [365060] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/preproc/catchment_analysis/mrro/CMIP5_MPI-ESM-LR_Lmon_historical_r1i1p1_mrro_1970-2000/04_clip_timerange.nc 2023-05-30 13:02:37,599 UTC [365059] DEBUG esmvalcore.preprocessor:369 Running preprocessor step cmor_check_metadata 2023-05-30 13:02:37,600 UTC [365059] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'cmor_check_metadata' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/v20120114/evspsbl/evspsbl_Amon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) check_level = , cmor_table = 'CMIP5', mip = 'Amon', frequency = 'mon', short_name = 'evspsbl' 2023-05-30 13:02:37,606 UTC [365059] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:02:37,607 UTC [365059] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/preproc/catchment_analysis/evspsbl/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_evspsbl_1970-2000/03_cmor_check_metadata.nc 2023-05-30 13:02:37,696 UTC [365060] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_data 2023-05-30 13:02:37,697 UTC [365060] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'fix_data' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/land/Lmon/r1i1p1/v20120625/mrro/mrro_Lmon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) check_level = , mip = 'Lmon', dataset = 'MPI-ESM-LR', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', short_name = 'mrro', timerange = '1970/2000', variable_group = 'mrro', diagnostic = 'catchment_analysis', recipe_dataset_index = 0, alias = 'MPI-ESM-LR', product = ['output1', 'output2'], institute = ['MPI-M'], original_short_name = 'mrro', standard_name = 'runoff_flux', long_name = 'Total Runoff', units = 'kg m-2 s-1', modeling_realm = ['land'], frequency = 'mon', version = 'v20120625' 2023-05-30 13:02:37,698 UTC [365060] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:02:37,699 UTC [365060] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/preproc/catchment_analysis/mrro/CMIP5_MPI-ESM-LR_Lmon_historical_r1i1p1_mrro_1970-2000/05_fix_data.nc 2023-05-30 13:02:37,791 UTC [365059] DEBUG esmvalcore.preprocessor:369 Running preprocessor step clip_timerange 2023-05-30 13:02:37,792 UTC [365059] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'clip_timerange' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/v20120114/evspsbl/evspsbl_Amon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) timerange = '1970/2000' 2023-05-30 13:02:37,802 UTC [365059] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:02:37,803 UTC [365059] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/preproc/catchment_analysis/evspsbl/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_evspsbl_1970-2000/04_clip_timerange.nc 2023-05-30 13:02:37,911 UTC [365060] DEBUG esmvalcore.preprocessor:369 Running preprocessor step cmor_check_data 2023-05-30 13:02:37,912 UTC [365060] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'cmor_check_data' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/land/Lmon/r1i1p1/v20120625/mrro/mrro_Lmon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) check_level = , cmor_table = 'CMIP5', mip = 'Lmon', frequency = 'mon', short_name = 'mrro' 2023-05-30 13:02:37,913 UTC [365060] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:02:37,914 UTC [365060] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/preproc/catchment_analysis/mrro/CMIP5_MPI-ESM-LR_Lmon_historical_r1i1p1_mrro_1970-2000/06_cmor_check_data.nc 2023-05-30 13:02:37,950 UTC [365059] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_data 2023-05-30 13:02:37,951 UTC [365059] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'fix_data' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/v20120114/evspsbl/evspsbl_Amon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) check_level = , mip = 'Amon', dataset = 'IPSL-CM5B-LR', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', short_name = 'evspsbl', timerange = '1970/2000', variable_group = 'evspsbl', diagnostic = 'catchment_analysis', recipe_dataset_index = 1, alias = 'IPSL-CM5B-LR', product = ['output1', 'output2'], institute = ['IPSL'], original_short_name = 'evspsbl', standard_name = 'water_evaporation_flux', long_name = 'Evaporation', units = 'kg m-2 s-1', modeling_realm = ['atmos'], frequency = 'mon', version = 'v20120114' 2023-05-30 13:02:37,951 UTC [365059] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:02:37,952 UTC [365059] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/preproc/catchment_analysis/evspsbl/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_evspsbl_1970-2000/05_fix_data.nc 2023-05-30 13:02:38,101 UTC [365059] DEBUG esmvalcore.preprocessor:369 Running preprocessor step cmor_check_data 2023-05-30 13:02:38,102 UTC [365059] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'cmor_check_data' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/v20120114/evspsbl/evspsbl_Amon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) check_level = , cmor_table = 'CMIP5', mip = 'Amon', frequency = 'mon', short_name = 'evspsbl' 2023-05-30 13:02:38,103 UTC [365059] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:02:38,103 UTC [365059] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/preproc/catchment_analysis/evspsbl/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_evspsbl_1970-2000/06_cmor_check_data.nc 2023-05-30 13:02:38,116 UTC [365060] DEBUG esmvalcore.preprocessor:369 Running preprocessor step add_supplementary_variables 2023-05-30 13:02:38,117 UTC [365060] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'add_supplementary_variables' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/land/Lmon/r1i1p1/v20120625/mrro/mrro_Lmon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) supplementary_cubes = [] 2023-05-30 13:02:38,118 UTC [365060] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:02:38,118 UTC [365060] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/preproc/catchment_analysis/mrro/CMIP5_MPI-ESM-LR_Lmon_historical_r1i1p1_mrro_1970-2000/07_add_supplementary_variables.nc 2023-05-30 13:02:38,256 UTC [365059] DEBUG esmvalcore.preprocessor:369 Running preprocessor step add_supplementary_variables 2023-05-30 13:02:38,294 UTC [365059] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'add_supplementary_variables' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/v20120114/evspsbl/evspsbl_Amon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) supplementary_cubes = [] 2023-05-30 13:02:38,294 UTC [365059] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:02:38,295 UTC [365059] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/preproc/catchment_analysis/evspsbl/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_evspsbl_1970-2000/07_add_supplementary_variables.nc 2023-05-30 13:02:38,320 UTC [365060] DEBUG esmvalcore.preprocessor:369 Running preprocessor step save 2023-05-30 13:02:38,321 UTC [365060] 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_130233/preproc/catchment_analysis/mrro/CMIP5_MPI-ESM-LR_Lmon_historical_r1i1p1_mrro_1970-2000.nc') 2023-05-30 13:02:38,322 UTC [365060] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/preproc/catchment_analysis/mrro/CMIP5_MPI-ESM-LR_Lmon_historical_r1i1p1_mrro_1970-2000.nc 2023-05-30 13:02:38,441 UTC [365059] DEBUG esmvalcore.preprocessor:369 Running preprocessor step save 2023-05-30 13:02:38,443 UTC [365059] 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_130233/preproc/catchment_analysis/evspsbl/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_evspsbl_1970-2000.nc') 2023-05-30 13:02:38,443 UTC [365059] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/preproc/catchment_analysis/evspsbl/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_evspsbl_1970-2000.nc 2023-05-30 13:02:38,549 UTC [365060] INFO esmvalcore._task:264 Successfully completed task catchment_analysis/mrro (priority 2) in 0:00:04.738246 2023-05-30 13:02:38,598 UTC [365059] INFO esmvalcore._task:264 Successfully completed task catchment_analysis/evspsbl (priority 1) in 0:00:04.786509 2023-05-30 13:02:38,614 UTC [364917] INFO esmvalcore._task:778 Progress: 0 tasks running, 2 tasks waiting for ancestors, 2/4 done 2023-05-30 13:02:38,616 UTC [365060] INFO esmvalcore._task:259 Starting task catchment_analysis/pr in process [365060] 2023-05-30 13:02:38,677 UTC [365060] DEBUG esmvalcore.esgf._download:535 All required data is available locally, not downloading anything. 2023-05-30 13:02:38,677 UTC [365060] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_file 2023-05-30 13:02:38,677 UTC [365060] 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_130233/preproc/fixed_files/pr_Amon_CMIP5_MPI-ESM-LR_historical_r1i1p1_v20120315_'), add_unique_suffix = True, mip = 'Amon', dataset = 'MPI-ESM-LR', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', short_name = 'pr', timerange = '1970/2000', variable_group = 'pr', diagnostic = 'catchment_analysis', recipe_dataset_index = 0, alias = 'MPI-ESM-LR', product = ['output1', 'output2'], institute = ['MPI-M'], original_short_name = 'pr', standard_name = 'precipitation_flux', long_name = 'Precipitation', units = 'kg m-2 s-1', modeling_realm = ['atmos'], frequency = 'mon', version = 'v20120315' 2023-05-30 13:02:38,677 UTC [365060] DEBUG esmvalcore.preprocessor:390 Result [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/v20120315/pr/pr_Amon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc')] 2023-05-30 13:02:38,677 UTC [365060] DEBUG esmvalcore.preprocessor:369 Running preprocessor step load 2023-05-30 13:02:38,678 UTC [365060] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'load' on the data LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/v20120315/pr/pr_Amon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc') loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/v20120315/pr/pr_Amon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) callback = 'default' 2023-05-30 13:02:38,678 UTC [365060] DEBUG esmvalcore.preprocessor._io:152 Loading: /projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/v20120315/pr/pr_Amon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc 2023-05-30 13:02:38,715 UTC [364917] INFO esmvalcore._task:778 Progress: 1 tasks running, 1 tasks waiting for ancestors, 2/4 done 2023-05-30 13:02:38,861 UTC [365060] DEBUG esmvalcore.preprocessor._io:182 Done with loading /projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/v20120315/pr/pr_Amon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc 2023-05-30 13:02:38,861 UTC [365060] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:02:38,862 UTC [365060] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/preproc/catchment_analysis/pr/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_pr_1970-2000/00_load.nc 2023-05-30 13:02:39,192 UTC [365060] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_metadata 2023-05-30 13:02:39,194 UTC [365060] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'fix_metadata' on the data [] loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/v20120315/pr/pr_Amon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) check_level = , mip = 'Amon', dataset = 'MPI-ESM-LR', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', short_name = 'pr', timerange = '1970/2000', variable_group = 'pr', diagnostic = 'catchment_analysis', recipe_dataset_index = 0, alias = 'MPI-ESM-LR', product = ['output1', 'output2'], institute = ['MPI-M'], original_short_name = 'pr', standard_name = 'precipitation_flux', long_name = 'Precipitation', units = 'kg m-2 s-1', modeling_realm = ['atmos'], frequency = 'mon', version = 'v20120315' 2023-05-30 13:02:39,201 UTC [365060] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:02:39,202 UTC [365060] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/preproc/catchment_analysis/pr/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_pr_1970-2000/01_fix_metadata.nc 2023-05-30 13:02:39,554 UTC [365060] DEBUG esmvalcore.preprocessor:369 Running preprocessor step concatenate 2023-05-30 13:02:39,555 UTC [365060] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'concatenate' on the data [] loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/v20120315/pr/pr_Amon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) 2023-05-30 13:02:39,555 UTC [365060] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:02:39,556 UTC [365060] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/preproc/catchment_analysis/pr/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_pr_1970-2000/02_concatenate.nc 2023-05-30 13:02:39,882 UTC [365060] DEBUG esmvalcore.preprocessor:369 Running preprocessor step cmor_check_metadata 2023-05-30 13:02:39,883 UTC [365060] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'cmor_check_metadata' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/v20120315/pr/pr_Amon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) check_level = , cmor_table = 'CMIP5', mip = 'Amon', frequency = 'mon', short_name = 'pr' 2023-05-30 13:02:39,890 UTC [365060] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:02:39,891 UTC [365060] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/preproc/catchment_analysis/pr/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_pr_1970-2000/03_cmor_check_metadata.nc 2023-05-30 13:02:40,229 UTC [365060] DEBUG esmvalcore.preprocessor:369 Running preprocessor step clip_timerange 2023-05-30 13:02:40,230 UTC [365060] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'clip_timerange' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/v20120315/pr/pr_Amon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) timerange = '1970/2000' 2023-05-30 13:02:40,241 UTC [365060] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:02:40,242 UTC [365060] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/preproc/catchment_analysis/pr/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_pr_1970-2000/04_clip_timerange.nc 2023-05-30 13:02:40,428 UTC [365060] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_data 2023-05-30 13:02:40,429 UTC [365060] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'fix_data' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/v20120315/pr/pr_Amon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) check_level = , mip = 'Amon', dataset = 'MPI-ESM-LR', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', short_name = 'pr', timerange = '1970/2000', variable_group = 'pr', diagnostic = 'catchment_analysis', recipe_dataset_index = 0, alias = 'MPI-ESM-LR', product = ['output1', 'output2'], institute = ['MPI-M'], original_short_name = 'pr', standard_name = 'precipitation_flux', long_name = 'Precipitation', units = 'kg m-2 s-1', modeling_realm = ['atmos'], frequency = 'mon', version = 'v20120315' 2023-05-30 13:02:40,429 UTC [365060] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:02:40,430 UTC [365060] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/preproc/catchment_analysis/pr/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_pr_1970-2000/05_fix_data.nc 2023-05-30 13:02:40,615 UTC [365060] DEBUG esmvalcore.preprocessor:369 Running preprocessor step cmor_check_data 2023-05-30 13:02:40,616 UTC [365060] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'cmor_check_data' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/v20120315/pr/pr_Amon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) check_level = , cmor_table = 'CMIP5', mip = 'Amon', frequency = 'mon', short_name = 'pr' 2023-05-30 13:02:40,617 UTC [365060] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:02:40,617 UTC [365060] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/preproc/catchment_analysis/pr/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_pr_1970-2000/06_cmor_check_data.nc 2023-05-30 13:02:40,819 UTC [365060] DEBUG esmvalcore.preprocessor:369 Running preprocessor step add_supplementary_variables 2023-05-30 13:02:40,820 UTC [365060] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'add_supplementary_variables' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/v20120315/pr/pr_Amon_MPI-ESM-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) supplementary_cubes = [] 2023-05-30 13:02:40,820 UTC [365060] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:02:40,821 UTC [365060] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/preproc/catchment_analysis/pr/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_pr_1970-2000/07_add_supplementary_variables.nc 2023-05-30 13:02:41,011 UTC [365060] DEBUG esmvalcore.preprocessor:369 Running preprocessor step save 2023-05-30 13:02:41,013 UTC [365060] 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_130233/preproc/catchment_analysis/pr/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_pr_1970-2000.nc') 2023-05-30 13:02:41,013 UTC [365060] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/preproc/catchment_analysis/pr/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_pr_1970-2000.nc 2023-05-30 13:02:41,203 UTC [365060] DEBUG esmvalcore.esgf._download:535 All required data is available locally, not downloading anything. 2023-05-30 13:02:41,203 UTC [365060] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_file 2023-05-30 13:02:41,204 UTC [365060] 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_130233/preproc/fixed_files/pr_Amon_CMIP5_IPSL-CM5B-LR_historical_r1i1p1_v20120114_'), add_unique_suffix = True, mip = 'Amon', dataset = 'IPSL-CM5B-LR', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', short_name = 'pr', timerange = '1970/2000', variable_group = 'pr', diagnostic = 'catchment_analysis', recipe_dataset_index = 1, alias = 'IPSL-CM5B-LR', product = ['output1', 'output2'], institute = ['IPSL'], original_short_name = 'pr', standard_name = 'precipitation_flux', long_name = 'Precipitation', units = 'kg m-2 s-1', modeling_realm = ['atmos'], frequency = 'mon', version = 'v20120114' 2023-05-30 13:02:41,204 UTC [365060] DEBUG esmvalcore.preprocessor:390 Result [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/v20120114/pr/pr_Amon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc')] 2023-05-30 13:02:41,204 UTC [365060] DEBUG esmvalcore.preprocessor:369 Running preprocessor step load 2023-05-30 13:02:41,204 UTC [365060] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'load' on the data LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/v20120114/pr/pr_Amon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc') loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/v20120114/pr/pr_Amon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) callback = 'default' 2023-05-30 13:02:41,204 UTC [365060] DEBUG esmvalcore.preprocessor._io:152 Loading: /projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/v20120114/pr/pr_Amon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc 2023-05-30 13:02:41,250 UTC [365060] DEBUG esmvalcore.preprocessor._io:182 Done with loading /projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/v20120114/pr/pr_Amon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc 2023-05-30 13:02:41,250 UTC [365060] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:02:41,251 UTC [365060] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/preproc/catchment_analysis/pr/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_pr_1970-2000/00_load.nc 2023-05-30 13:02:41,449 UTC [365060] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_metadata 2023-05-30 13:02:41,451 UTC [365060] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'fix_metadata' on the data [] loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/v20120114/pr/pr_Amon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) check_level = , mip = 'Amon', dataset = 'IPSL-CM5B-LR', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', short_name = 'pr', timerange = '1970/2000', variable_group = 'pr', diagnostic = 'catchment_analysis', recipe_dataset_index = 1, alias = 'IPSL-CM5B-LR', product = ['output1', 'output2'], institute = ['IPSL'], original_short_name = 'pr', standard_name = 'precipitation_flux', long_name = 'Precipitation', units = 'kg m-2 s-1', modeling_realm = ['atmos'], frequency = 'mon', version = 'v20120114' 2023-05-30 13:02:41,456 UTC [365060] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:02:41,457 UTC [365060] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/preproc/catchment_analysis/pr/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_pr_1970-2000/01_fix_metadata.nc 2023-05-30 13:02:41,666 UTC [365060] DEBUG esmvalcore.preprocessor:369 Running preprocessor step concatenate 2023-05-30 13:02:41,667 UTC [365060] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'concatenate' on the data [] loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/v20120114/pr/pr_Amon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) 2023-05-30 13:02:41,667 UTC [365060] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:02:41,668 UTC [365060] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/preproc/catchment_analysis/pr/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_pr_1970-2000/02_concatenate.nc 2023-05-30 13:02:41,866 UTC [365060] DEBUG esmvalcore.preprocessor:369 Running preprocessor step cmor_check_metadata 2023-05-30 13:02:41,867 UTC [365060] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'cmor_check_metadata' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/v20120114/pr/pr_Amon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) check_level = , cmor_table = 'CMIP5', mip = 'Amon', frequency = 'mon', short_name = 'pr' 2023-05-30 13:02:41,873 UTC [365060] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:02:41,874 UTC [365060] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/preproc/catchment_analysis/pr/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_pr_1970-2000/03_cmor_check_metadata.nc 2023-05-30 13:02:42,065 UTC [365060] DEBUG esmvalcore.preprocessor:369 Running preprocessor step clip_timerange 2023-05-30 13:02:42,066 UTC [365060] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'clip_timerange' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/v20120114/pr/pr_Amon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) timerange = '1970/2000' 2023-05-30 13:02:42,076 UTC [365060] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:02:42,077 UTC [365060] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/preproc/catchment_analysis/pr/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_pr_1970-2000/04_clip_timerange.nc 2023-05-30 13:02:42,223 UTC [365060] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_data 2023-05-30 13:02:42,224 UTC [365060] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'fix_data' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/v20120114/pr/pr_Amon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) check_level = , mip = 'Amon', dataset = 'IPSL-CM5B-LR', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', short_name = 'pr', timerange = '1970/2000', variable_group = 'pr', diagnostic = 'catchment_analysis', recipe_dataset_index = 1, alias = 'IPSL-CM5B-LR', product = ['output1', 'output2'], institute = ['IPSL'], original_short_name = 'pr', standard_name = 'precipitation_flux', long_name = 'Precipitation', units = 'kg m-2 s-1', modeling_realm = ['atmos'], frequency = 'mon', version = 'v20120114' 2023-05-30 13:02:42,224 UTC [365060] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:02:42,225 UTC [365060] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/preproc/catchment_analysis/pr/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_pr_1970-2000/05_fix_data.nc 2023-05-30 13:02:42,367 UTC [365060] DEBUG esmvalcore.preprocessor:369 Running preprocessor step cmor_check_data 2023-05-30 13:02:42,368 UTC [365060] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'cmor_check_data' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/v20120114/pr/pr_Amon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) check_level = , cmor_table = 'CMIP5', mip = 'Amon', frequency = 'mon', short_name = 'pr' 2023-05-30 13:02:42,368 UTC [365060] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:02:42,369 UTC [365060] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/preproc/catchment_analysis/pr/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_pr_1970-2000/06_cmor_check_data.nc 2023-05-30 13:02:42,512 UTC [365060] DEBUG esmvalcore.preprocessor:369 Running preprocessor step add_supplementary_variables 2023-05-30 13:02:42,513 UTC [365060] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'add_supplementary_variables' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/IPSL/IPSL-CM5B-LR/historical/mon/atmos/Amon/r1i1p1/v20120114/pr/pr_Amon_IPSL-CM5B-LR_historical_r1i1p1_185001-200512.nc')] with function argument(s) supplementary_cubes = [] 2023-05-30 13:02:42,513 UTC [365060] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-30 13:02:42,514 UTC [365060] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/preproc/catchment_analysis/pr/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_pr_1970-2000/07_add_supplementary_variables.nc 2023-05-30 13:02:42,656 UTC [365060] DEBUG esmvalcore.preprocessor:369 Running preprocessor step save 2023-05-30 13:02:42,658 UTC [365060] 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_130233/preproc/catchment_analysis/pr/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_pr_1970-2000.nc') 2023-05-30 13:02:42,658 UTC [365060] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/preproc/catchment_analysis/pr/CMIP5_IPSL-CM5B-LR_Amon_historical_r1i1p1_pr_1970-2000.nc 2023-05-30 13:02:42,809 UTC [365060] INFO esmvalcore._task:264 Successfully completed task catchment_analysis/pr (priority 3) in 0:00:04.192969 2023-05-30 13:02:42,821 UTC [364917] INFO esmvalcore._task:778 Progress: 0 tasks running, 1 tasks waiting for ancestors, 3/4 done 2023-05-30 13:02:42,830 UTC [365059] INFO esmvalcore._task:259 Starting task catchment_analysis/catchment_analysis in process [365059] 2023-05-30 13:02:42,833 UTC [365059] 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_130233/run/catchment_analysis/catchment_analysis/settings.yml'] 2023-05-30 13:02:42,833 UTC [365059] DEBUG esmvalcore._task:501 in environment {'MPLBACKEND': 'Agg'} 2023-05-30 13:02:42,833 UTC [365059] DEBUG esmvalcore._task:503 in current working directory: /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/run/catchment_analysis/catchment_analysis 2023-05-30 13:02:42,833 UTC [365059] INFO esmvalcore._task:504 Writing output to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/work/catchment_analysis/catchment_analysis 2023-05-30 13:02:42,833 UTC [365059] INFO esmvalcore._task:505 Writing plots to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/plots/catchment_analysis/catchment_analysis 2023-05-30 13:02:42,833 UTC [365059] INFO esmvalcore._task:506 Writing log to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/run/catchment_analysis/catchment_analysis/log.txt 2023-05-30 13:02:42,834 UTC [365059] INFO esmvalcore._task:516 To re-run this diagnostic script, run: cd /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/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_130233/run/catchment_analysis/catchment_analysis/settings.yml 2023-05-30 13:02:42,922 UTC [364917] INFO esmvalcore._task:778 Progress: 1 tasks running, 0 tasks waiting for ancestors, 3/4 done 2023-05-30 13:03:17,955 UTC [365059] INFO esmvalcore._task:126 Maximum memory used (estimate): 0.7 GB 2023-05-30 13:03:17,956 UTC [365059] INFO esmvalcore._task:128 Sampled every second. It may be inaccurate if short but high spikes in memory consumption occur. 2023-05-30 13:03:17,956 UTC [365059] DEBUG esmvalcore._task:589 Script runoff_et/catchment_analysis.py completed successfully 2023-05-30 13:03:17,957 UTC [365059] WARNING esmvalcore._task:602 No provenance information was written to /projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/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:03:17,957 UTC [365059] INFO esmvalcore._task:264 Successfully completed task catchment_analysis/catchment_analysis (priority 0) in 0:00:35.126944 2023-05-30 13:03:18,015 UTC [364917] INFO esmvalcore._task:778 Progress: 0 tasks running, 0 tasks waiting for ancestors, 4/4 done 2023-05-30 13:03:18,015 UTC [364917] INFO esmvalcore._task:783 Successfully completed all tasks. 2023-05-30 13:03:18,055 UTC [364917] 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_130233/run/recipe_runoff_et_filled.yml 2023-05-30 13:03:18,138 UTC [364917] INFO esmvalcore.experimental.recipe_output:205 Wrote recipe output to: file:///projects/NS9560K/www/diagnostics/esmvaltool/adagj/tmp/recipe_runoff_et_20230530_130233/index.html 2023-05-30 13:03:18,139 UTC [364917] INFO esmvalcore._main:125 Ending the Earth System Model Evaluation Tool at time: 2023-05-30 13:03:18 UTC 2023-05-30 13:03:18,139 UTC [364917] INFO esmvalcore._main:128 Time for running the recipe was: 0:00:44.472304 2023-05-30 13:03:18,284 UTC [364917] INFO esmvalcore._task:126 Maximum memory used (estimate): 2.3 GB 2023-05-30 13:03:18,284 UTC [364917] INFO esmvalcore._task:128 Sampled every second. It may be inaccurate if short but high spikes in memory consumption occur. 2023-05-30 13:03:18,285 UTC [364917] INFO esmvalcore._main:453 Run was successful