2022-09-17 10:55:13,693 UTC [184920] INFO esmvalcore._main:473 ______________________________________________________________________ _____ ____ __ ____ __ _ _____ _ | ____/ ___|| \/ \ \ / /_ _| |_ _|__ ___ | | | _| \___ \| |\/| |\ \ / / _` | | | |/ _ \ / _ \| | | |___ ___) | | | | \ 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! 2022-09-17 10:55:13,694 UTC [184920] INFO esmvalcore._main:474 Package versions 2022-09-17 10:55:13,694 UTC [184920] INFO esmvalcore._main:475 ---------------- 2022-09-17 10:55:13,694 UTC [184920] INFO esmvalcore._main:476 ESMValCore: 2.6.0 2022-09-17 10:55:13,694 UTC [184920] INFO esmvalcore._main:478 ESMValTool: 2.6.0 2022-09-17 10:55:13,695 UTC [184920] INFO esmvalcore._main:479 ---------------- 2022-09-17 10:55:13,695 UTC [184920] INFO esmvalcore._main:480 Using config file /projects/NS9252K/users/tomast/test_ipcc_node/config-run_esmvaltool.yml 2022-09-17 10:55:13,695 UTC [184920] INFO esmvalcore._main:481 Writing program log files to: /projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_r_20220917_105511/run/main_log.txt /projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_r_20220917_105511/run/main_log_debug.txt 2022-09-17 10:55:13,696 UTC [184920] INFO esmvalcore._main:86 Starting the Earth System Model Evaluation Tool at time: 2022-09-17 10:55:13 UTC 2022-09-17 10:55:13,696 UTC [184920] INFO esmvalcore._main:90 ---------------------------------------------------------------------- 2022-09-17 10:55:13,697 UTC [184920] INFO esmvalcore._main:91 RECIPE = /projects/NS9252K/users/tomast/test_ipcc_node/recipe_r.yml 2022-09-17 10:55:13,697 UTC [184920] INFO esmvalcore._main:92 RUNDIR = /projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_r_20220917_105511/run 2022-09-17 10:55:13,698 UTC [184920] INFO esmvalcore._main:93 WORKDIR = /projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_r_20220917_105511/work 2022-09-17 10:55:13,698 UTC [184920] INFO esmvalcore._main:94 PREPROCDIR = /projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_r_20220917_105511/preproc 2022-09-17 10:55:13,698 UTC [184920] INFO esmvalcore._main:95 PLOTDIR = /projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_r_20220917_105511/plots 2022-09-17 10:55:13,698 UTC [184920] INFO esmvalcore._main:96 ---------------------------------------------------------------------- 2022-09-17 10:55:13,698 UTC [184920] INFO esmvalcore._main:100 Running tasks using at most 1 processes 2022-09-17 10:55:13,700 UTC [184920] INFO esmvalcore._main:102 If your system hangs during execution, it may not have enough memory for keeping this number of tasks in memory. 2022-09-17 10:55:13,700 UTC [184920] INFO esmvalcore._main:105 If you experience memory problems, try reducing 'max_parallel_tasks' in your user configuration file. 2022-09-17 10:55:13,702 UTC [184920] DEBUG esmvalcore._recipe_checks:47 Checking recipe against schema /projects/NS2980K/conda/esmvaltool2.6.0/lib/python3.9/site-packages/esmvalcore/recipe_schema.yml 2022-09-17 10:55:13,725 UTC [184920] DEBUG esmvalcore._recipe:1342 Retrieving diagnostics from recipe 2022-09-17 10:55:13,725 UTC [184920] DEBUG esmvalcore._recipe:1479 Populating list of variables for diagnostic example 2022-09-17 10:55:13,727 UTC [184920] DEBUG esmvalcore._config._config:48 Loading extra facets from /projects/NS2980K/conda/esmvaltool2.6.0/lib/python3.9/site-packages/esmvalcore/_config/extra_facets/cmip5-institutes.yml 2022-09-17 10:55:13,784 UTC [184920] DEBUG esmvalcore._config._config:48 Loading extra facets from /projects/NS2980K/conda/esmvaltool2.6.0/lib/python3.9/site-packages/esmvalcore/_config/extra_facets/cmip5-product.yml 2022-09-17 10:55:13,794 UTC [184920] DEBUG esmvalcore._recipe:1609 Setting script for diagnostic example 2022-09-17 10:55:13,795 UTC [184920] INFO esmvalcore._recipe:1845 Creating tasks from recipe 2022-09-17 10:55:13,795 UTC [184920] INFO esmvalcore._recipe:1854 Creating tasks for diagnostic example 2022-09-17 10:55:13,795 UTC [184920] INFO esmvalcore._recipe:1728 Creating diagnostic task example/main 2022-09-17 10:55:13,827 UTC [184920] INFO esmvalcore._recipe:1825 Creating preprocessor task example/pr 2022-09-17 10:55:13,827 UTC [184920] INFO esmvalcore._recipe:1214 Creating preprocessor 'preproc' task for variable 'pr' 2022-09-17 10:55:13,842 UTC [184920] DEBUG esmvalcore._data_finder:19 Looking for files matching ['pr_day_EC-EARTH_historical_r1i1p1*.nc'] in ['/projects/NS9252K/ESGF_betzy/cmip5/output1/ICHEC/EC-EARTH/historical/day/atmos/day/r1i1p1/v20121115/pr'] 2022-09-17 10:55:13,848 UTC [184920] DEBUG esmvalcore._recipe:624 Using input files for variable pr of dataset EC-EARTH: /projects/NS9252K/ESGF_betzy/cmip5/output1/ICHEC/EC-EARTH/historical/day/atmos/day/r1i1p1/v20121115/pr/pr_day_EC-EARTH_historical_r1i1p1_19900101-19991231.nc 2022-09-17 10:55:13,850 UTC [184920] INFO esmvalcore._recipe:633 Found input files for EC-EARTH 2022-09-17 10:55:13,880 UTC [184920] INFO esmvalcore._recipe:1095 PreprocessingTask example/pr created. 2022-09-17 10:55:13,880 UTC [184920] DEBUG esmvalcore._recipe:1096 PreprocessingTask example/pr will create the files: /projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_r_20220917_105511/preproc/example/pr/CMIP5_EC-EARTH_day_historical_r1i1p1_pr_1997-1997.nc 2022-09-17 10:55:13,880 UTC [184920] DEBUG esmvalcore._recipe:1656 Linking tasks for diagnostic example script main 2022-09-17 10:55:13,881 UTC [184920] DEBUG esmvalcore._recipe:1665 Pattern example/pr matches ['example/pr'] 2022-09-17 10:55:13,881 UTC [184920] INFO esmvalcore._recipe:1894 These tasks will be executed: example/pr, example/main 2022-09-17 10:55:13,883 UTC [184920] DEBUG esmvalcore._main:122 Recipe summary: DiagnosticTask: example/main script: examples/diagnostic.R settings: {'auxiliary_data_dir': '/projects/NS9252K/share/esmvaltool/auxiliary_data', 'log_level': 'info', 'output_file_type': 'png', 'parameter1': 1, 'plot_dir': '/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_r_20220917_105511/plots/example/main', 'profile_diagnostic': False, 'recipe': 'recipe_r.yml', 'run_dir': '/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_r_20220917_105511/run/example/main', 'script': 'main', 'version': '2.6.0', 'work_dir': '/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_r_20220917_105511/work/example/main'} ancestors: PreprocessingTask: example/pr order: ['fix_file', 'load', 'fix_metadata', 'concatenate', 'cmor_check_metadata', 'clip_timerange', 'fix_data', 'cmor_check_data', 'add_fx_variables', 'remove_fx_variables', 'save', 'cleanup'] PreprocessorFile: /projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_r_20220917_105511/preproc/example/pr/CMIP5_EC-EARTH_day_historical_r1i1p1_pr_1997-1997.nc {'add_fx_variables': {'check_level': , 'fx_variables': {}}, 'cleanup': {'remove': ['/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_r_20220917_105511/preproc/example/pr/CMIP5_EC-EARTH_day_historical_r1i1p1_pr_1997-1997_fixed']}, 'clip_timerange': {'timerange': '1997/1997'}, 'cmor_check_data': {'check_level': , 'cmor_table': 'CMIP5', 'frequency': 'day', 'mip': 'day', 'short_name': 'pr'}, 'cmor_check_metadata': {'check_level': , 'cmor_table': 'CMIP5', 'frequency': 'day', 'mip': 'day', 'short_name': 'pr'}, 'concatenate': {}, 'fix_data': {'alias': 'EC-EARTH', 'check_level': , 'dataset': 'EC-EARTH', 'diagnostic': 'example', 'ensemble': 'r1i1p1', 'exp': 'historical', 'filename': '/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_r_20220917_105511/preproc/example/pr/CMIP5_EC-EARTH_day_historical_r1i1p1_pr_1997-1997.nc', 'frequency': 'day', 'institute': ['ICHEC'], 'long_name': 'Precipitation', 'mip': 'day', 'modeling_realm': ['atmos'], 'original_short_name': 'pr', 'preprocessor': 'preproc', 'product': ['output1', 'output2'], 'project': 'CMIP5', 'recipe_dataset_index': 0, 'reference_dataset': 'EC-EARTH', 'short_name': 'pr', 'standard_name': 'precipitation_flux', 'timerange': '1997/1997', 'units': 'kg m-2 s-1', 'variable_group': 'pr'}, 'fix_file': {'alias': 'EC-EARTH', 'dataset': 'EC-EARTH', 'diagnostic': 'example', 'ensemble': 'r1i1p1', 'exp': 'historical', 'filename': '/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_r_20220917_105511/preproc/example/pr/CMIP5_EC-EARTH_day_historical_r1i1p1_pr_1997-1997.nc', 'frequency': 'day', 'institute': ['ICHEC'], 'long_name': 'Precipitation', 'mip': 'day', 'modeling_realm': ['atmos'], 'original_short_name': 'pr', 'output_dir': '/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_r_20220917_105511/preproc/example/pr/CMIP5_EC-EARTH_day_historical_r1i1p1_pr_1997-1997_fixed', 'preprocessor': 'preproc', 'product': ['output1', 'output2'], 'project': 'CMIP5', 'recipe_dataset_index': 0, 'reference_dataset': 'EC-EARTH', 'short_name': 'pr', 'standard_name': 'precipitation_flux', 'timerange': '1997/1997', 'units': 'kg m-2 s-1', 'variable_group': 'pr'}, 'fix_metadata': {'alias': 'EC-EARTH', 'check_level': , 'dataset': 'EC-EARTH', 'diagnostic': 'example', 'ensemble': 'r1i1p1', 'exp': 'historical', 'filename': '/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_r_20220917_105511/preproc/example/pr/CMIP5_EC-EARTH_day_historical_r1i1p1_pr_1997-1997.nc', 'frequency': 'day', 'institute': ['ICHEC'], 'long_name': 'Precipitation', 'mip': 'day', 'modeling_realm': ['atmos'], 'original_short_name': 'pr', 'preprocessor': 'preproc', 'product': ['output1', 'output2'], 'project': 'CMIP5', 'recipe_dataset_index': 0, 'reference_dataset': 'EC-EARTH', 'short_name': 'pr', 'standard_name': 'precipitation_flux', 'timerange': '1997/1997', 'units': 'kg m-2 s-1', 'variable_group': 'pr'}, 'load': {'callback': }, 'remove_fx_variables': {}, 'save': {'compress': False, 'filename': '/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_r_20220917_105511/preproc/example/pr/CMIP5_EC-EARTH_day_historical_r1i1p1_pr_1997-1997.nc'}} ancestors: None 2022-09-17 10:55:13,889 UTC [184920] INFO esmvalcore._task:730 Running 2 tasks sequentially 2022-09-17 10:55:13,889 UTC [184920] INFO esmvalcore._task:260 Starting task example/pr in process [184920] 2022-09-17 10:55:13,895 UTC [184920] DEBUG esmvalcore.preprocessor:598 Running block ['fix_metadata', 'concatenate', 'cmor_check_metadata', 'clip_timerange', 'fix_data', 'cmor_check_data', 'add_fx_variables', 'remove_fx_variables'] 2022-09-17 10:55:13,896 UTC [184920] DEBUG esmvalcore.preprocessor:605 Applying single-model steps to PreprocessorFile: /projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_r_20220917_105511/preproc/example/pr/CMIP5_EC-EARTH_day_historical_r1i1p1_pr_1997-1997.nc 2022-09-17 10:55:13,896 UTC [184920] DEBUG esmvalcore.preprocessor:345 Running preprocessor step fix_file 2022-09-17 10:55:13,897 UTC [184920] DEBUG esmvalcore.preprocessor:306 Running preprocessor function 'fix_file' on the data '/projects/NS9252K/ESGF_betzy/cmip5/output1/ICHEC/EC-EARTH/historical/day/atmos/day/r1i1p1/v20121115/pr/pr_day_EC-EARTH_historical_r1i1p1_19900101-19991231.nc' with function argument(s) preprocessor = 'preproc', reference_dataset = 'EC-EARTH', mip = 'day', variable_group = 'pr', short_name = 'pr', diagnostic = 'example', dataset = 'EC-EARTH', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', recipe_dataset_index = 0, institute = ['ICHEC'], product = ['output1', 'output2'], timerange = '1997/1997', alias = 'EC-EARTH', original_short_name = 'pr', standard_name = 'precipitation_flux', long_name = 'Precipitation', units = 'kg m-2 s-1', modeling_realm = ['atmos'], frequency = 'day', filename = '/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_r_20220917_105511/preproc/example/pr/CMIP5_EC-EARTH_day_historical_r1i1p1_pr_1997-1997.nc', output_dir = '/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_r_20220917_105511/preproc/example/pr/CMIP5_EC-EARTH_day_historical_r1i1p1_pr_1997-1997_fixed' 2022-09-17 10:55:13,930 UTC [184920] DEBUG esmvalcore.preprocessor:345 Running preprocessor step load 2022-09-17 10:55:13,930 UTC [184920] DEBUG esmvalcore.preprocessor:306 Running preprocessor function 'load' on the data '/projects/NS9252K/ESGF_betzy/cmip5/output1/ICHEC/EC-EARTH/historical/day/atmos/day/r1i1p1/v20121115/pr/pr_day_EC-EARTH_historical_r1i1p1_19900101-19991231.nc' with function argument(s) callback = 2022-09-17 10:55:13,930 UTC [184920] DEBUG esmvalcore.preprocessor._io:139 Loading: /projects/NS9252K/ESGF_betzy/cmip5/output1/ICHEC/EC-EARTH/historical/day/atmos/day/r1i1p1/v20121115/pr/pr_day_EC-EARTH_historical_r1i1p1_19900101-19991231.nc 2022-09-17 10:55:20,545 UTC [184920] DEBUG esmvalcore.preprocessor._io:169 Done with loading /projects/NS9252K/ESGF_betzy/cmip5/output1/ICHEC/EC-EARTH/historical/day/atmos/day/r1i1p1/v20121115/pr/pr_day_EC-EARTH_historical_r1i1p1_19900101-19991231.nc 2022-09-17 10:55:20,545 UTC [184920] DEBUG esmvalcore.preprocessor:345 Running preprocessor step fix_metadata 2022-09-17 10:55:20,552 UTC [184920] DEBUG esmvalcore.preprocessor:306 Running preprocessor function 'fix_metadata' on the data [] loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/cmip5/output1/ICHEC/EC-EARTH/historical/day/atmos/day/r1i1p1/v20121115/pr/pr_day_EC-EARTH_historical_r1i1p1_19900101-19991231.nc'] with function argument(s) preprocessor = 'preproc', reference_dataset = 'EC-EARTH', mip = 'day', variable_group = 'pr', short_name = 'pr', diagnostic = 'example', dataset = 'EC-EARTH', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', recipe_dataset_index = 0, institute = ['ICHEC'], product = ['output1', 'output2'], timerange = '1997/1997', alias = 'EC-EARTH', original_short_name = 'pr', standard_name = 'precipitation_flux', long_name = 'Precipitation', units = 'kg m-2 s-1', modeling_realm = ['atmos'], frequency = 'day', filename = '/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_r_20220917_105511/preproc/example/pr/CMIP5_EC-EARTH_day_historical_r1i1p1_pr_1997-1997.nc', check_level = 2022-09-17 10:55:20,571 UTC [184920] DEBUG esmvalcore.preprocessor:345 Running preprocessor step concatenate 2022-09-17 10:55:20,574 UTC [184920] DEBUG esmvalcore.preprocessor:306 Running preprocessor function 'concatenate' on the data [] loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/cmip5/output1/ICHEC/EC-EARTH/historical/day/atmos/day/r1i1p1/v20121115/pr/pr_day_EC-EARTH_historical_r1i1p1_19900101-19991231.nc'] with function argument(s) 2022-09-17 10:55:20,574 UTC [184920] DEBUG esmvalcore.preprocessor:345 Running preprocessor step cmor_check_metadata 2022-09-17 10:55:20,575 UTC [184920] DEBUG esmvalcore.preprocessor:306 Running preprocessor function 'cmor_check_metadata' on the data loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/cmip5/output1/ICHEC/EC-EARTH/historical/day/atmos/day/r1i1p1/v20121115/pr/pr_day_EC-EARTH_historical_r1i1p1_19900101-19991231.nc'] with function argument(s) cmor_table = 'CMIP5', mip = 'day', short_name = 'pr', frequency = 'day', check_level = 2022-09-17 10:55:20,592 UTC [184920] DEBUG esmvalcore.preprocessor:345 Running preprocessor step clip_timerange 2022-09-17 10:55:20,594 UTC [184920] DEBUG esmvalcore.preprocessor:306 Running preprocessor function 'clip_timerange' on the data loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/cmip5/output1/ICHEC/EC-EARTH/historical/day/atmos/day/r1i1p1/v20121115/pr/pr_day_EC-EARTH_historical_r1i1p1_19900101-19991231.nc'] with function argument(s) timerange = '1997/1997' 2022-09-17 10:55:21,788 UTC [184920] DEBUG esmvalcore.preprocessor:345 Running preprocessor step fix_data 2022-09-17 10:55:21,789 UTC [184920] DEBUG esmvalcore.preprocessor:306 Running preprocessor function 'fix_data' on the data loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/cmip5/output1/ICHEC/EC-EARTH/historical/day/atmos/day/r1i1p1/v20121115/pr/pr_day_EC-EARTH_historical_r1i1p1_19900101-19991231.nc'] with function argument(s) preprocessor = 'preproc', reference_dataset = 'EC-EARTH', mip = 'day', variable_group = 'pr', short_name = 'pr', diagnostic = 'example', dataset = 'EC-EARTH', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', recipe_dataset_index = 0, institute = ['ICHEC'], product = ['output1', 'output2'], timerange = '1997/1997', alias = 'EC-EARTH', original_short_name = 'pr', standard_name = 'precipitation_flux', long_name = 'Precipitation', units = 'kg m-2 s-1', modeling_realm = ['atmos'], frequency = 'day', filename = '/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_r_20220917_105511/preproc/example/pr/CMIP5_EC-EARTH_day_historical_r1i1p1_pr_1997-1997.nc', check_level = 2022-09-17 10:55:21,789 UTC [184920] DEBUG esmvalcore.preprocessor:345 Running preprocessor step cmor_check_data 2022-09-17 10:55:21,790 UTC [184920] DEBUG esmvalcore.preprocessor:306 Running preprocessor function 'cmor_check_data' on the data loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/cmip5/output1/ICHEC/EC-EARTH/historical/day/atmos/day/r1i1p1/v20121115/pr/pr_day_EC-EARTH_historical_r1i1p1_19900101-19991231.nc'] with function argument(s) cmor_table = 'CMIP5', mip = 'day', short_name = 'pr', frequency = 'day', check_level = 2022-09-17 10:55:21,790 UTC [184920] DEBUG esmvalcore.preprocessor:345 Running preprocessor step add_fx_variables 2022-09-17 10:55:21,791 UTC [184920] DEBUG esmvalcore.preprocessor:306 Running preprocessor function 'add_fx_variables' on the data loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/cmip5/output1/ICHEC/EC-EARTH/historical/day/atmos/day/r1i1p1/v20121115/pr/pr_day_EC-EARTH_historical_r1i1p1_19900101-19991231.nc'] with function argument(s) fx_variables = {}, check_level = 2022-09-17 10:55:21,791 UTC [184920] DEBUG esmvalcore.preprocessor:345 Running preprocessor step remove_fx_variables 2022-09-17 10:55:21,792 UTC [184920] DEBUG esmvalcore.preprocessor:306 Running preprocessor function 'remove_fx_variables' on the data loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/cmip5/output1/ICHEC/EC-EARTH/historical/day/atmos/day/r1i1p1/v20121115/pr/pr_day_EC-EARTH_historical_r1i1p1_19900101-19991231.nc'] with function argument(s) 2022-09-17 10:55:21,792 UTC [184920] DEBUG esmvalcore.preprocessor:345 Running preprocessor step save 2022-09-17 10:55:21,793 UTC [184920] DEBUG esmvalcore.preprocessor:306 Running preprocessor function 'save' on the data [] loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/cmip5/output1/ICHEC/EC-EARTH/historical/day/atmos/day/r1i1p1/v20121115/pr/pr_day_EC-EARTH_historical_r1i1p1_19900101-19991231.nc'] with function argument(s) compress = False, filename = '/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_r_20220917_105511/preproc/example/pr/CMIP5_EC-EARTH_day_historical_r1i1p1_pr_1997-1997.nc' 2022-09-17 10:55:21,794 UTC [184920] DEBUG esmvalcore.preprocessor._io:309 Saving cubes [] to /projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_r_20220917_105511/preproc/example/pr/CMIP5_EC-EARTH_day_historical_r1i1p1_pr_1997-1997.nc 2022-09-17 10:55:23,064 UTC [184920] DEBUG esmvalcore.preprocessor:345 Running preprocessor step cleanup 2022-09-17 10:55:23,065 UTC [184920] DEBUG esmvalcore.preprocessor:306 Running preprocessor function 'cleanup' on the data ['/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_r_20220917_105511/preproc/example/pr/CMIP5_EC-EARTH_day_historical_r1i1p1_pr_1997-1997.nc'] loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/cmip5/output1/ICHEC/EC-EARTH/historical/day/atmos/day/r1i1p1/v20121115/pr/pr_day_EC-EARTH_historical_r1i1p1_19900101-19991231.nc'] with function argument(s) remove = ['/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_r_20220917_105511/preproc/example/pr/CMIP5_EC-EARTH_day_historical_r1i1p1_pr_1997-1997_fixed'] 2022-09-17 10:55:23,219 UTC [184920] INFO esmvalcore._task:265 Successfully completed task example/pr (priority 1) in 0:00:09.327994 2022-09-17 10:55:23,219 UTC [184920] INFO esmvalcore._task:260 Starting task example/main in process [184920] 2022-09-17 10:55:23,327 UTC [184920] INFO esmvalcore._task:501 Running command ['/projects/NS2980K/conda/esmvaltool2.6.0/bin/Rscript', '/projects/NS2980K/conda/esmvaltool2.6.0/lib/python3.9/site-packages/esmvaltool/diag_scripts/examples/diagnostic.R', '/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_r_20220917_105511/run/example/main/settings.yml'] 2022-09-17 10:55:23,328 UTC [184920] DEBUG esmvalcore._task:502 in environment {'diag_scripts': '/projects/NS2980K/conda/esmvaltool2.6.0/lib/python3.9/site-packages/esmvaltool/diag_scripts'} 2022-09-17 10:55:23,328 UTC [184920] DEBUG esmvalcore._task:504 in current working directory: /projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_r_20220917_105511/run/example/main 2022-09-17 10:55:23,328 UTC [184920] INFO esmvalcore._task:505 Writing output to /projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_r_20220917_105511/work/example/main 2022-09-17 10:55:23,328 UTC [184920] INFO esmvalcore._task:506 Writing plots to /projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_r_20220917_105511/plots/example/main 2022-09-17 10:55:23,329 UTC [184920] INFO esmvalcore._task:507 Writing log to /projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_r_20220917_105511/run/example/main/log.txt 2022-09-17 10:55:23,329 UTC [184920] INFO esmvalcore._task:517 To re-run this diagnostic script, run: cd /projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_r_20220917_105511/run/example/main; diag_scripts="/projects/NS2980K/conda/esmvaltool2.6.0/lib/python3.9/site-packages/esmvaltool/diag_scripts" /projects/NS2980K/conda/esmvaltool2.6.0/bin/Rscript /projects/NS2980K/conda/esmvaltool2.6.0/lib/python3.9/site-packages/esmvaltool/diag_scripts/examples/diagnostic.R /projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_r_20220917_105511/run/example/main/settings.yml 2022-09-17 10:55:27,445 UTC [184920] INFO esmvalcore._task:127 Maximum memory used (estimate): 0.0 GB 2022-09-17 10:55:27,447 UTC [184920] INFO esmvalcore._task:129 Sampled every second. It may be inaccurate if short but high spikes in memory consumption occur. 2022-09-17 10:55:27,448 UTC [184920] DEBUG esmvalcore._task:590 Script examples/diagnostic.R completed successfully 2022-09-17 10:55:27,449 UTC [184920] WARNING esmvalcore._task:603 No provenance information was written to /projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_r_20220917_105511/run/example/main/diagnostic_provenance.yml. Unable to record provenance for files created by diagnostic script examples/diagnostic.R in task example/main 2022-09-17 10:55:27,449 UTC [184920] INFO esmvalcore._task:265 Successfully completed task example/main (priority 0) in 0:00:04.230370 2022-09-17 10:55:28,327 UTC [184920] INFO esmvalcore.experimental.recipe_output:212 Wrote recipe output to: file:///projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_r_20220917_105511/index.html 2022-09-17 10:55:28,327 UTC [184920] INFO esmvalcore._main:127 Ending the Earth System Model Evaluation Tool at time: 2022-09-17 10:55:28 UTC 2022-09-17 10:55:28,328 UTC [184920] INFO esmvalcore._main:130 Time for running the recipe was: 0:00:14.631533 2022-09-17 10:55:29,149 UTC [184920] INFO esmvalcore._task:127 Maximum memory used (estimate): 0.3 GB 2022-09-17 10:55:29,150 UTC [184920] INFO esmvalcore._task:129 Sampled every second. It may be inaccurate if short but high spikes in memory consumption occur. 2022-09-17 10:55:29,151 UTC [184920] INFO esmvalcore._main:454 Removing preproc containing preprocessed data 2022-09-17 10:55:29,151 UTC [184920] INFO esmvalcore._main:455 If this data is further needed, then 2022-09-17 10:55:29,151 UTC [184920] INFO esmvalcore._main:456 set remove_preproc_dir to false in config-user.yml 2022-09-17 10:55:29,154 UTC [184920] INFO esmvalcore._main:446 Run was successful