2022-09-17 10:52:48,330 UTC [183604] 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:52:48,330 UTC [183604] INFO esmvalcore._main:474 Package versions 2022-09-17 10:52:48,331 UTC [183604] INFO esmvalcore._main:475 ---------------- 2022-09-17 10:52:48,331 UTC [183604] INFO esmvalcore._main:476 ESMValCore: 2.6.0 2022-09-17 10:52:48,331 UTC [183604] INFO esmvalcore._main:478 ESMValTool: 2.6.0 2022-09-17 10:52:48,331 UTC [183604] INFO esmvalcore._main:479 ---------------- 2022-09-17 10:52:48,331 UTC [183604] INFO esmvalcore._main:480 Using config file /projects/NS9252K/users/tomast/test_ipcc_node/config-run_esmvaltool.yml 2022-09-17 10:52:48,331 UTC [183604] INFO esmvalcore._main:481 Writing program log files to: /projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/run/main_log.txt /projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/run/main_log_debug.txt 2022-09-17 10:52:48,332 UTC [183604] INFO esmvalcore._main:86 Starting the Earth System Model Evaluation Tool at time: 2022-09-17 10:52:48 UTC 2022-09-17 10:52:48,332 UTC [183604] INFO esmvalcore._main:90 ---------------------------------------------------------------------- 2022-09-17 10:52:48,332 UTC [183604] INFO esmvalcore._main:91 RECIPE = /projects/NS9252K/users/tomast/test_ipcc_node/recipe_ncl.yml 2022-09-17 10:52:48,332 UTC [183604] INFO esmvalcore._main:92 RUNDIR = /projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/run 2022-09-17 10:52:48,332 UTC [183604] INFO esmvalcore._main:93 WORKDIR = /projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/work 2022-09-17 10:52:48,333 UTC [183604] INFO esmvalcore._main:94 PREPROCDIR = /projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc 2022-09-17 10:52:48,333 UTC [183604] INFO esmvalcore._main:95 PLOTDIR = /projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/plots 2022-09-17 10:52:48,333 UTC [183604] INFO esmvalcore._main:96 ---------------------------------------------------------------------- 2022-09-17 10:52:48,333 UTC [183604] INFO esmvalcore._main:100 Running tasks using at most 1 processes 2022-09-17 10:52:48,334 UTC [183604] 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:52:48,334 UTC [183604] INFO esmvalcore._main:105 If you experience memory problems, try reducing 'max_parallel_tasks' in your user configuration file. 2022-09-17 10:52:48,335 UTC [183604] 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:52:48,347 UTC [183604] INFO esmvalcore._recipe:1327 NCL script detected, checking NCL version 2022-09-17 10:52:49,236 UTC [183604] INFO esmvalcore._recipe_checks:36 Found NCL version 6.6.2 2022-09-17 10:52:49,236 UTC [183604] DEBUG esmvalcore._recipe:1342 Retrieving diagnostics from recipe 2022-09-17 10:52:49,237 UTC [183604] DEBUG esmvalcore._recipe:1479 Populating list of variables for diagnostic example 2022-09-17 10:52:49,239 UTC [183604] 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:52:49,295 UTC [183604] 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:52:49,312 UTC [183604] DEBUG esmvalcore._recipe:1609 Setting script for diagnostic example 2022-09-17 10:52:49,314 UTC [183604] INFO esmvalcore._recipe:1845 Creating tasks from recipe 2022-09-17 10:52:49,314 UTC [183604] INFO esmvalcore._recipe:1854 Creating tasks for diagnostic example 2022-09-17 10:52:49,314 UTC [183604] INFO esmvalcore._recipe:1728 Creating diagnostic task example/test_ta 2022-09-17 10:52:49,346 UTC [183604] INFO esmvalcore._recipe:1825 Creating preprocessor task example/ta 2022-09-17 10:52:49,346 UTC [183604] INFO esmvalcore._recipe:1214 Creating preprocessor 'preprocessor_1' task for variable 'ta' 2022-09-17 10:52:49,360 UTC [183604] DEBUG esmvalcore._data_finder:19 Looking for files matching ['ta_Amon_bcc-csm1-1_historical_r1i1p1*.nc'] in ['/projects/NS9252K/ESGF_betzy/cmip5/output1/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/ta'] 2022-09-17 10:52:49,364 UTC [183604] DEBUG esmvalcore._recipe:624 Using input files for variable ta of dataset bcc-csm1-1: /projects/NS9252K/ESGF_betzy/cmip5/output1/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/ta/ta_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc 2022-09-17 10:52:49,367 UTC [183604] INFO esmvalcore._recipe:633 Found input files for bcc-csm1-1 2022-09-17 10:52:49,378 UTC [183604] DEBUG esmvalcore._data_finder:19 Looking for files matching ['ta_Amon_GFDL-ESM2G_historical_r1i1p1*.nc'] in ['/projects/NS9252K/ESGF_betzy/cmip5/output1/NOAA-GFDL/GFDL-ESM2G/historical/mon/atmos/Amon/r1i1p1/v20120412/ta'] 2022-09-17 10:52:49,384 UTC [183604] DEBUG esmvalcore._recipe:624 Using input files for variable ta of dataset GFDL-ESM2G: /projects/NS9252K/ESGF_betzy/cmip5/output1/NOAA-GFDL/GFDL-ESM2G/historical/mon/atmos/Amon/r1i1p1/v20120412/ta/ta_Amon_GFDL-ESM2G_historical_r1i1p1_199601-200012.nc /projects/NS9252K/ESGF_betzy/cmip5/output1/NOAA-GFDL/GFDL-ESM2G/historical/mon/atmos/Amon/r1i1p1/v20120412/ta/ta_Amon_GFDL-ESM2G_historical_r1i1p1_200101-200512.nc 2022-09-17 10:52:49,384 UTC [183604] INFO esmvalcore._recipe:633 Found input files for GFDL-ESM2G 2022-09-17 10:52:49,466 UTC [183604] DEBUG esmvalcore._data_finder:19 Looking for files matching ['ta_Amon_MPI-ESM-LR_historical_r1i1p1*.nc'] in ['/projects/NS9252K/ESGF_betzy/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/latest/ta'] 2022-09-17 10:52:49,471 UTC [183604] DEBUG esmvalcore._recipe:624 Using input files for variable ta of dataset MPI-ESM-LR: /projects/NS9252K/ESGF_betzy/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/latest/ta/ta_Amon_MPI-ESM-LR_historical_r1i1p1_200001-200512.nc 2022-09-17 10:52:49,471 UTC [183604] INFO esmvalcore._recipe:633 Found input files for MPI-ESM-LR 2022-09-17 10:52:49,488 UTC [183604] DEBUG esmvalcore._data_finder:19 Looking for files matching ['ta_Amon_CanESM2_historical_r1i1p1*.nc'] in ['/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/atmos/Amon/r1i1p1/latest/ta'] 2022-09-17 10:52:49,491 UTC [183604] DEBUG esmvalcore._recipe:624 Using input files for variable ta of dataset CanESM2: /projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/atmos/Amon/r1i1p1/latest/ta/ta_Amon_CanESM2_historical_r1i1p1_185001-200512.nc 2022-09-17 10:52:49,491 UTC [183604] INFO esmvalcore._recipe:633 Found input files for CanESM2 2022-09-17 10:52:49,532 UTC [183604] INFO esmvalcore._recipe:1095 PreprocessingTask example/ta created. 2022-09-17 10:52:49,532 UTC [183604] DEBUG esmvalcore._recipe:1096 PreprocessingTask example/ta will create the files: /projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_CanESM2_Amon_historical_r1i1p1_ta_2000-2002.nc /projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_ta_2000-2002.nc /projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_ta_2000-2002.nc /projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_GFDL-ESM2G_Amon_historical_r1i1p1_ta_2000-2002.nc 2022-09-17 10:52:49,533 UTC [183604] DEBUG esmvalcore._recipe:1656 Linking tasks for diagnostic example script test_ta 2022-09-17 10:52:49,533 UTC [183604] DEBUG esmvalcore._recipe:1665 Pattern example/ta matches ['example/ta'] 2022-09-17 10:52:49,533 UTC [183604] INFO esmvalcore._recipe:1894 These tasks will be executed: example/test_ta, example/ta 2022-09-17 10:52:49,536 UTC [183604] DEBUG esmvalcore._main:122 Recipe summary: DiagnosticTask: example/test_ta script: examples/diagnostic.ncl settings: {'auxiliary_data_dir': '/projects/NS9252K/share/esmvaltool/auxiliary_data', 'colormap': 'WhiteBlueGreenYellowRed', 'exit_on_ncl_warning': False, 'log_level': 'info', 'ncdf': 'default', 'output_file_type': 'png', 'plot_dir': '/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/plots/example/test_ta', 'profile_diagnostic': False, 'projection': 'Mollweide', 'realms': ['atmos'], 'recipe': 'recipe_ncl.yml', 'run_dir': '/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/run/example/test_ta', 'script': 'test_ta', 'themes': ['phys'], 'version': '2.6.0', 'work_dir': '/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/work/example/test_ta'} ancestors: PreprocessingTask: example/ta order: ['fix_file', 'load', 'fix_metadata', 'concatenate', 'cmor_check_metadata', 'clip_timerange', 'fix_data', 'cmor_check_data', 'add_fx_variables', 'extract_levels', 'remove_fx_variables', 'save', 'cleanup'] PreprocessorFile: /projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_CanESM2_Amon_historical_r1i1p1_ta_2000-2002.nc {'add_fx_variables': {'check_level': , 'fx_variables': {}}, 'cleanup': {'remove': ['/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_CanESM2_Amon_historical_r1i1p1_ta_2000-2002_fixed']}, 'clip_timerange': {'timerange': '2000/2002'}, 'cmor_check_data': {'check_level': , 'cmor_table': 'CMIP5', 'frequency': 'mon', 'mip': 'Amon', 'short_name': 'ta'}, 'cmor_check_metadata': {'check_level': , 'cmor_table': 'CMIP5', 'frequency': 'mon', 'mip': 'Amon', 'short_name': 'ta'}, 'concatenate': {}, 'extract_levels': {'levels': 85000, 'scheme': 'nearest'}, 'fix_data': {'alias': 'CanESM2', 'check_level': , 'dataset': 'CanESM2', 'diagnostic': 'example', 'ensemble': 'r1i1p1', 'exp': 'historical', 'filename': '/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_CanESM2_Amon_historical_r1i1p1_ta_2000-2002.nc', 'frequency': 'mon', 'institute': ['CCCma'], 'long_name': 'Air Temperature', 'mip': 'Amon', 'modeling_realm': ['atmos'], 'original_short_name': 'ta', 'preprocessor': 'preprocessor_1', 'product': ['output1', 'output2'], 'project': 'CMIP5', 'recipe_dataset_index': 3, 'reference_dataset': 'MPI-ESM-LR', 'short_name': 'ta', 'standard_name': 'air_temperature', 'timerange': '2000/2002', 'units': 'K', 'variable_group': 'ta'}, 'fix_file': {'alias': 'CanESM2', 'dataset': 'CanESM2', 'diagnostic': 'example', 'ensemble': 'r1i1p1', 'exp': 'historical', 'filename': '/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_CanESM2_Amon_historical_r1i1p1_ta_2000-2002.nc', 'frequency': 'mon', 'institute': ['CCCma'], 'long_name': 'Air Temperature', 'mip': 'Amon', 'modeling_realm': ['atmos'], 'original_short_name': 'ta', 'output_dir': '/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_CanESM2_Amon_historical_r1i1p1_ta_2000-2002_fixed', 'preprocessor': 'preprocessor_1', 'product': ['output1', 'output2'], 'project': 'CMIP5', 'recipe_dataset_index': 3, 'reference_dataset': 'MPI-ESM-LR', 'short_name': 'ta', 'standard_name': 'air_temperature', 'timerange': '2000/2002', 'units': 'K', 'variable_group': 'ta'}, 'fix_metadata': {'alias': 'CanESM2', 'check_level': , 'dataset': 'CanESM2', 'diagnostic': 'example', 'ensemble': 'r1i1p1', 'exp': 'historical', 'filename': '/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_CanESM2_Amon_historical_r1i1p1_ta_2000-2002.nc', 'frequency': 'mon', 'institute': ['CCCma'], 'long_name': 'Air Temperature', 'mip': 'Amon', 'modeling_realm': ['atmos'], 'original_short_name': 'ta', 'preprocessor': 'preprocessor_1', 'product': ['output1', 'output2'], 'project': 'CMIP5', 'recipe_dataset_index': 3, 'reference_dataset': 'MPI-ESM-LR', 'short_name': 'ta', 'standard_name': 'air_temperature', 'timerange': '2000/2002', 'units': 'K', 'variable_group': 'ta'}, 'load': {'callback': }, 'remove_fx_variables': {}, 'save': {'compress': False, 'filename': '/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_CanESM2_Amon_historical_r1i1p1_ta_2000-2002.nc'}} PreprocessorFile: /projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_ta_2000-2002.nc {'add_fx_variables': {'check_level': , 'fx_variables': {}}, 'cleanup': {'remove': ['/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_ta_2000-2002_fixed']}, 'clip_timerange': {'timerange': '2000/2002'}, 'cmor_check_data': {'check_level': , 'cmor_table': 'CMIP5', 'frequency': 'mon', 'mip': 'Amon', 'short_name': 'ta'}, 'cmor_check_metadata': {'check_level': , 'cmor_table': 'CMIP5', 'frequency': 'mon', 'mip': 'Amon', 'short_name': 'ta'}, 'concatenate': {}, 'extract_levels': {'levels': 85000, 'scheme': 'nearest'}, 'fix_data': {'alias': 'bcc-csm1-1', 'check_level': , 'dataset': 'bcc-csm1-1', 'diagnostic': 'example', 'ensemble': 'r1i1p1', 'exp': 'historical', 'filename': '/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_ta_2000-2002.nc', 'frequency': 'mon', 'institute': ['BCC'], 'long_name': 'Air Temperature', 'mip': 'Amon', 'modeling_realm': ['atmos'], 'original_short_name': 'ta', 'preprocessor': 'preprocessor_1', 'product': ['output1', 'output2'], 'project': 'CMIP5', 'recipe_dataset_index': 0, 'reference_dataset': 'MPI-ESM-LR', 'short_name': 'ta', 'standard_name': 'air_temperature', 'timerange': '2000/2002', 'units': 'K', 'variable_group': 'ta'}, 'fix_file': {'alias': 'bcc-csm1-1', 'dataset': 'bcc-csm1-1', 'diagnostic': 'example', 'ensemble': 'r1i1p1', 'exp': 'historical', 'filename': '/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_ta_2000-2002.nc', 'frequency': 'mon', 'institute': ['BCC'], 'long_name': 'Air Temperature', 'mip': 'Amon', 'modeling_realm': ['atmos'], 'original_short_name': 'ta', 'output_dir': '/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_ta_2000-2002_fixed', 'preprocessor': 'preprocessor_1', 'product': ['output1', 'output2'], 'project': 'CMIP5', 'recipe_dataset_index': 0, 'reference_dataset': 'MPI-ESM-LR', 'short_name': 'ta', 'standard_name': 'air_temperature', 'timerange': '2000/2002', 'units': 'K', 'variable_group': 'ta'}, 'fix_metadata': {'alias': 'bcc-csm1-1', 'check_level': , 'dataset': 'bcc-csm1-1', 'diagnostic': 'example', 'ensemble': 'r1i1p1', 'exp': 'historical', 'filename': '/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_ta_2000-2002.nc', 'frequency': 'mon', 'institute': ['BCC'], 'long_name': 'Air Temperature', 'mip': 'Amon', 'modeling_realm': ['atmos'], 'original_short_name': 'ta', 'preprocessor': 'preprocessor_1', 'product': ['output1', 'output2'], 'project': 'CMIP5', 'recipe_dataset_index': 0, 'reference_dataset': 'MPI-ESM-LR', 'short_name': 'ta', 'standard_name': 'air_temperature', 'timerange': '2000/2002', 'units': 'K', 'variable_group': 'ta'}, 'load': {'callback': }, 'remove_fx_variables': {}, 'save': {'compress': False, 'filename': '/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_ta_2000-2002.nc'}} PreprocessorFile: /projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_ta_2000-2002.nc {'add_fx_variables': {'check_level': , 'fx_variables': {}}, 'cleanup': {'remove': ['/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_ta_2000-2002_fixed']}, 'clip_timerange': {'timerange': '2000/2002'}, 'cmor_check_data': {'check_level': , 'cmor_table': 'CMIP5', 'frequency': 'mon', 'mip': 'Amon', 'short_name': 'ta'}, 'cmor_check_metadata': {'check_level': , 'cmor_table': 'CMIP5', 'frequency': 'mon', 'mip': 'Amon', 'short_name': 'ta'}, 'concatenate': {}, 'extract_levels': {'levels': 85000, 'scheme': 'nearest'}, 'fix_data': {'alias': 'MPI-ESM-LR', 'check_level': , 'dataset': 'MPI-ESM-LR', 'diagnostic': 'example', 'ensemble': 'r1i1p1', 'exp': 'historical', 'filename': '/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_ta_2000-2002.nc', 'frequency': 'mon', 'institute': ['MPI-M'], 'long_name': 'Air Temperature', 'mip': 'Amon', 'modeling_realm': ['atmos'], 'original_short_name': 'ta', 'preprocessor': 'preprocessor_1', 'product': ['output1', 'output2'], 'project': 'CMIP5', 'recipe_dataset_index': 2, 'reference_dataset': 'MPI-ESM-LR', 'short_name': 'ta', 'standard_name': 'air_temperature', 'timerange': '2000/2002', 'units': 'K', 'variable_group': 'ta'}, 'fix_file': {'alias': 'MPI-ESM-LR', 'dataset': 'MPI-ESM-LR', 'diagnostic': 'example', 'ensemble': 'r1i1p1', 'exp': 'historical', 'filename': '/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_ta_2000-2002.nc', 'frequency': 'mon', 'institute': ['MPI-M'], 'long_name': 'Air Temperature', 'mip': 'Amon', 'modeling_realm': ['atmos'], 'original_short_name': 'ta', 'output_dir': '/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_ta_2000-2002_fixed', 'preprocessor': 'preprocessor_1', 'product': ['output1', 'output2'], 'project': 'CMIP5', 'recipe_dataset_index': 2, 'reference_dataset': 'MPI-ESM-LR', 'short_name': 'ta', 'standard_name': 'air_temperature', 'timerange': '2000/2002', 'units': 'K', 'variable_group': 'ta'}, 'fix_metadata': {'alias': 'MPI-ESM-LR', 'check_level': , 'dataset': 'MPI-ESM-LR', 'diagnostic': 'example', 'ensemble': 'r1i1p1', 'exp': 'historical', 'filename': '/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_ta_2000-2002.nc', 'frequency': 'mon', 'institute': ['MPI-M'], 'long_name': 'Air Temperature', 'mip': 'Amon', 'modeling_realm': ['atmos'], 'original_short_name': 'ta', 'preprocessor': 'preprocessor_1', 'product': ['output1', 'output2'], 'project': 'CMIP5', 'recipe_dataset_index': 2, 'reference_dataset': 'MPI-ESM-LR', 'short_name': 'ta', 'standard_name': 'air_temperature', 'timerange': '2000/2002', 'units': 'K', 'variable_group': 'ta'}, 'load': {'callback': }, 'remove_fx_variables': {}, 'save': {'compress': False, 'filename': '/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_ta_2000-2002.nc'}} PreprocessorFile: /projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_GFDL-ESM2G_Amon_historical_r1i1p1_ta_2000-2002.nc {'add_fx_variables': {'check_level': , 'fx_variables': {}}, 'cleanup': {'remove': ['/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_GFDL-ESM2G_Amon_historical_r1i1p1_ta_2000-2002_fixed']}, 'clip_timerange': {'timerange': '2000/2002'}, 'cmor_check_data': {'check_level': , 'cmor_table': 'CMIP5', 'frequency': 'mon', 'mip': 'Amon', 'short_name': 'ta'}, 'cmor_check_metadata': {'check_level': , 'cmor_table': 'CMIP5', 'frequency': 'mon', 'mip': 'Amon', 'short_name': 'ta'}, 'concatenate': {}, 'extract_levels': {'levels': 85000, 'scheme': 'nearest'}, 'fix_data': {'alias': 'GFDL-ESM2G', 'check_level': , 'dataset': 'GFDL-ESM2G', 'diagnostic': 'example', 'ensemble': 'r1i1p1', 'exp': 'historical', 'filename': '/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_GFDL-ESM2G_Amon_historical_r1i1p1_ta_2000-2002.nc', 'frequency': 'mon', 'institute': ['NOAA-GFDL'], 'long_name': 'Air Temperature', 'mip': 'Amon', 'modeling_realm': ['atmos'], 'original_short_name': 'ta', 'preprocessor': 'preprocessor_1', 'product': ['output1', 'output2'], 'project': 'CMIP5', 'recipe_dataset_index': 1, 'reference_dataset': 'MPI-ESM-LR', 'short_name': 'ta', 'standard_name': 'air_temperature', 'timerange': '2000/2002', 'units': 'K', 'variable_group': 'ta'}, 'fix_file': {'alias': 'GFDL-ESM2G', 'dataset': 'GFDL-ESM2G', 'diagnostic': 'example', 'ensemble': 'r1i1p1', 'exp': 'historical', 'filename': '/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_GFDL-ESM2G_Amon_historical_r1i1p1_ta_2000-2002.nc', 'frequency': 'mon', 'institute': ['NOAA-GFDL'], 'long_name': 'Air Temperature', 'mip': 'Amon', 'modeling_realm': ['atmos'], 'original_short_name': 'ta', 'output_dir': '/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_GFDL-ESM2G_Amon_historical_r1i1p1_ta_2000-2002_fixed', 'preprocessor': 'preprocessor_1', 'product': ['output1', 'output2'], 'project': 'CMIP5', 'recipe_dataset_index': 1, 'reference_dataset': 'MPI-ESM-LR', 'short_name': 'ta', 'standard_name': 'air_temperature', 'timerange': '2000/2002', 'units': 'K', 'variable_group': 'ta'}, 'fix_metadata': {'alias': 'GFDL-ESM2G', 'check_level': , 'dataset': 'GFDL-ESM2G', 'diagnostic': 'example', 'ensemble': 'r1i1p1', 'exp': 'historical', 'filename': '/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_GFDL-ESM2G_Amon_historical_r1i1p1_ta_2000-2002.nc', 'frequency': 'mon', 'institute': ['NOAA-GFDL'], 'long_name': 'Air Temperature', 'mip': 'Amon', 'modeling_realm': ['atmos'], 'original_short_name': 'ta', 'preprocessor': 'preprocessor_1', 'product': ['output1', 'output2'], 'project': 'CMIP5', 'recipe_dataset_index': 1, 'reference_dataset': 'MPI-ESM-LR', 'short_name': 'ta', 'standard_name': 'air_temperature', 'timerange': '2000/2002', 'units': 'K', 'variable_group': 'ta'}, 'load': {'callback': }, 'remove_fx_variables': {}, 'save': {'compress': False, 'filename': '/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_GFDL-ESM2G_Amon_historical_r1i1p1_ta_2000-2002.nc'}} ancestors: None 2022-09-17 10:52:49,551 UTC [183604] INFO esmvalcore._task:730 Running 2 tasks sequentially 2022-09-17 10:52:49,552 UTC [183604] INFO esmvalcore._task:260 Starting task example/ta in process [183604] 2022-09-17 10:52:49,575 UTC [183604] DEBUG esmvalcore.preprocessor:598 Running block ['fix_metadata', 'concatenate', 'cmor_check_metadata', 'clip_timerange', 'fix_data', 'cmor_check_data', 'add_fx_variables', 'extract_levels', 'remove_fx_variables'] 2022-09-17 10:52:49,575 UTC [183604] DEBUG esmvalcore.preprocessor:605 Applying single-model steps to PreprocessorFile: /projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_CanESM2_Amon_historical_r1i1p1_ta_2000-2002.nc 2022-09-17 10:52:49,576 UTC [183604] DEBUG esmvalcore.preprocessor:345 Running preprocessor step fix_file 2022-09-17 10:52:49,576 UTC [183604] DEBUG esmvalcore.preprocessor:306 Running preprocessor function 'fix_file' on the data '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/atmos/Amon/r1i1p1/latest/ta/ta_Amon_CanESM2_historical_r1i1p1_185001-200512.nc' with function argument(s) preprocessor = 'preprocessor_1', reference_dataset = 'MPI-ESM-LR', mip = 'Amon', variable_group = 'ta', short_name = 'ta', diagnostic = 'example', dataset = 'CanESM2', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', recipe_dataset_index = 3, institute = ['CCCma'], product = ['output1', 'output2'], timerange = '2000/2002', alias = 'CanESM2', original_short_name = 'ta', standard_name = 'air_temperature', long_name = 'Air Temperature', units = 'K', modeling_realm = ['atmos'], frequency = 'mon', filename = '/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_CanESM2_Amon_historical_r1i1p1_ta_2000-2002.nc', output_dir = '/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_CanESM2_Amon_historical_r1i1p1_ta_2000-2002_fixed' 2022-09-17 10:52:49,579 UTC [183604] DEBUG esmvalcore.preprocessor:345 Running preprocessor step load 2022-09-17 10:52:49,579 UTC [183604] DEBUG esmvalcore.preprocessor:306 Running preprocessor function 'load' on the data '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/atmos/Amon/r1i1p1/latest/ta/ta_Amon_CanESM2_historical_r1i1p1_185001-200512.nc' with function argument(s) callback = 2022-09-17 10:52:49,579 UTC [183604] DEBUG esmvalcore.preprocessor._io:139 Loading: /projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/atmos/Amon/r1i1p1/latest/ta/ta_Amon_CanESM2_historical_r1i1p1_185001-200512.nc 2022-09-17 10:52:58,865 UTC [183604] DEBUG esmvalcore.preprocessor._io:169 Done with loading /projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/atmos/Amon/r1i1p1/latest/ta/ta_Amon_CanESM2_historical_r1i1p1_185001-200512.nc 2022-09-17 10:52:58,865 UTC [183604] DEBUG esmvalcore.preprocessor:345 Running preprocessor step fix_metadata 2022-09-17 10:52:58,873 UTC [183604] DEBUG esmvalcore.preprocessor:306 Running preprocessor function 'fix_metadata' on the data [] loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/atmos/Amon/r1i1p1/latest/ta/ta_Amon_CanESM2_historical_r1i1p1_185001-200512.nc'] with function argument(s) preprocessor = 'preprocessor_1', reference_dataset = 'MPI-ESM-LR', mip = 'Amon', variable_group = 'ta', short_name = 'ta', diagnostic = 'example', dataset = 'CanESM2', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', recipe_dataset_index = 3, institute = ['CCCma'], product = ['output1', 'output2'], timerange = '2000/2002', alias = 'CanESM2', original_short_name = 'ta', standard_name = 'air_temperature', long_name = 'Air Temperature', units = 'K', modeling_realm = ['atmos'], frequency = 'mon', filename = '/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_CanESM2_Amon_historical_r1i1p1_ta_2000-2002.nc', check_level = 2022-09-17 10:52:59,780 UTC [183604] DEBUG esmvalcore.preprocessor:345 Running preprocessor step concatenate 2022-09-17 10:52:59,781 UTC [183604] DEBUG esmvalcore.preprocessor:306 Running preprocessor function 'concatenate' on the data [] loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/atmos/Amon/r1i1p1/latest/ta/ta_Amon_CanESM2_historical_r1i1p1_185001-200512.nc'] with function argument(s) 2022-09-17 10:52:59,781 UTC [183604] DEBUG esmvalcore.preprocessor:345 Running preprocessor step cmor_check_metadata 2022-09-17 10:52:59,782 UTC [183604] 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/CCCma/CanESM2/historical/mon/atmos/Amon/r1i1p1/latest/ta/ta_Amon_CanESM2_historical_r1i1p1_185001-200512.nc'] with function argument(s) cmor_table = 'CMIP5', mip = 'Amon', short_name = 'ta', frequency = 'mon', check_level = 2022-09-17 10:53:00,832 UTC [183604] DEBUG esmvalcore.preprocessor:345 Running preprocessor step clip_timerange 2022-09-17 10:53:00,833 UTC [183604] DEBUG esmvalcore.preprocessor:306 Running preprocessor function 'clip_timerange' on the data loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/atmos/Amon/r1i1p1/latest/ta/ta_Amon_CanESM2_historical_r1i1p1_185001-200512.nc'] with function argument(s) timerange = '2000/2002' 2022-09-17 10:53:01,323 UTC [183604] DEBUG esmvalcore.preprocessor:345 Running preprocessor step fix_data 2022-09-17 10:53:01,324 UTC [183604] DEBUG esmvalcore.preprocessor:306 Running preprocessor function 'fix_data' on the data loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/atmos/Amon/r1i1p1/latest/ta/ta_Amon_CanESM2_historical_r1i1p1_185001-200512.nc'] with function argument(s) preprocessor = 'preprocessor_1', reference_dataset = 'MPI-ESM-LR', mip = 'Amon', variable_group = 'ta', short_name = 'ta', diagnostic = 'example', dataset = 'CanESM2', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', recipe_dataset_index = 3, institute = ['CCCma'], product = ['output1', 'output2'], timerange = '2000/2002', alias = 'CanESM2', original_short_name = 'ta', standard_name = 'air_temperature', long_name = 'Air Temperature', units = 'K', modeling_realm = ['atmos'], frequency = 'mon', filename = '/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_CanESM2_Amon_historical_r1i1p1_ta_2000-2002.nc', check_level = 2022-09-17 10:53:01,324 UTC [183604] DEBUG esmvalcore.preprocessor:345 Running preprocessor step cmor_check_data 2022-09-17 10:53:01,325 UTC [183604] 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/CCCma/CanESM2/historical/mon/atmos/Amon/r1i1p1/latest/ta/ta_Amon_CanESM2_historical_r1i1p1_185001-200512.nc'] with function argument(s) cmor_table = 'CMIP5', mip = 'Amon', short_name = 'ta', frequency = 'mon', check_level = 2022-09-17 10:53:01,325 UTC [183604] DEBUG esmvalcore.preprocessor:345 Running preprocessor step add_fx_variables 2022-09-17 10:53:01,326 UTC [183604] 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/CCCma/CanESM2/historical/mon/atmos/Amon/r1i1p1/latest/ta/ta_Amon_CanESM2_historical_r1i1p1_185001-200512.nc'] with function argument(s) fx_variables = {}, check_level = 2022-09-17 10:53:01,326 UTC [183604] DEBUG esmvalcore.preprocessor:345 Running preprocessor step extract_levels 2022-09-17 10:53:01,326 UTC [183604] DEBUG esmvalcore.preprocessor:306 Running preprocessor function 'extract_levels' on the data loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/atmos/Amon/r1i1p1/latest/ta/ta_Amon_CanESM2_historical_r1i1p1_185001-200512.nc'] with function argument(s) levels = 85000, scheme = 'nearest' 2022-09-17 10:53:01,329 UTC [183604] DEBUG esmvalcore.preprocessor:345 Running preprocessor step remove_fx_variables 2022-09-17 10:53:01,330 UTC [183604] 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/CCCma/CanESM2/historical/mon/atmos/Amon/r1i1p1/latest/ta/ta_Amon_CanESM2_historical_r1i1p1_185001-200512.nc'] with function argument(s) 2022-09-17 10:53:01,330 UTC [183604] DEBUG esmvalcore.preprocessor:345 Running preprocessor step save 2022-09-17 10:53:01,331 UTC [183604] DEBUG esmvalcore.preprocessor:306 Running preprocessor function 'save' on the data [] loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/atmos/Amon/r1i1p1/latest/ta/ta_Amon_CanESM2_historical_r1i1p1_185001-200512.nc'] with function argument(s) compress = False, filename = '/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_CanESM2_Amon_historical_r1i1p1_ta_2000-2002.nc' 2022-09-17 10:53:01,332 UTC [183604] DEBUG esmvalcore.preprocessor._io:309 Saving cubes [] to /projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_CanESM2_Amon_historical_r1i1p1_ta_2000-2002.nc 2022-09-17 10:53:02,080 UTC [183604] DEBUG esmvalcore.preprocessor:345 Running preprocessor step cleanup 2022-09-17 10:53:02,080 UTC [183604] DEBUG esmvalcore.preprocessor:306 Running preprocessor function 'cleanup' on the data ['/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_CanESM2_Amon_historical_r1i1p1_ta_2000-2002.nc'] loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/atmos/Amon/r1i1p1/latest/ta/ta_Amon_CanESM2_historical_r1i1p1_185001-200512.nc'] with function argument(s) remove = ['/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_CanESM2_Amon_historical_r1i1p1_ta_2000-2002_fixed'] 2022-09-17 10:53:02,207 UTC [183604] DEBUG esmvalcore.preprocessor:605 Applying single-model steps to PreprocessorFile: /projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_ta_2000-2002.nc 2022-09-17 10:53:02,207 UTC [183604] DEBUG esmvalcore.preprocessor:345 Running preprocessor step fix_file 2022-09-17 10:53:02,208 UTC [183604] DEBUG esmvalcore.preprocessor:306 Running preprocessor function 'fix_file' on the data '/projects/NS9252K/ESGF_betzy/cmip5/output1/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/ta/ta_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc' with function argument(s) preprocessor = 'preprocessor_1', reference_dataset = 'MPI-ESM-LR', mip = 'Amon', variable_group = 'ta', short_name = 'ta', diagnostic = 'example', dataset = 'bcc-csm1-1', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', recipe_dataset_index = 0, institute = ['BCC'], product = ['output1', 'output2'], timerange = '2000/2002', alias = 'bcc-csm1-1', original_short_name = 'ta', standard_name = 'air_temperature', long_name = 'Air Temperature', units = 'K', modeling_realm = ['atmos'], frequency = 'mon', filename = '/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_ta_2000-2002.nc', output_dir = '/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_ta_2000-2002_fixed' 2022-09-17 10:53:02,208 UTC [183604] DEBUG esmvalcore.preprocessor:345 Running preprocessor step load 2022-09-17 10:53:02,208 UTC [183604] DEBUG esmvalcore.preprocessor:306 Running preprocessor function 'load' on the data '/projects/NS9252K/ESGF_betzy/cmip5/output1/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/ta/ta_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc' with function argument(s) callback = 2022-09-17 10:53:02,208 UTC [183604] DEBUG esmvalcore.preprocessor._io:139 Loading: /projects/NS9252K/ESGF_betzy/cmip5/output1/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/ta/ta_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc 2022-09-17 10:53:02,239 UTC [183604] DEBUG esmvalcore.preprocessor._io:169 Done with loading /projects/NS9252K/ESGF_betzy/cmip5/output1/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/ta/ta_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc 2022-09-17 10:53:02,239 UTC [183604] DEBUG esmvalcore.preprocessor:345 Running preprocessor step fix_metadata 2022-09-17 10:53:02,241 UTC [183604] DEBUG esmvalcore.preprocessor:306 Running preprocessor function 'fix_metadata' on the data [] loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/cmip5/output1/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/ta/ta_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc'] with function argument(s) preprocessor = 'preprocessor_1', reference_dataset = 'MPI-ESM-LR', mip = 'Amon', variable_group = 'ta', short_name = 'ta', diagnostic = 'example', dataset = 'bcc-csm1-1', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', recipe_dataset_index = 0, institute = ['BCC'], product = ['output1', 'output2'], timerange = '2000/2002', alias = 'bcc-csm1-1', original_short_name = 'ta', standard_name = 'air_temperature', long_name = 'Air Temperature', units = 'K', modeling_realm = ['atmos'], frequency = 'mon', filename = '/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_ta_2000-2002.nc', check_level = 2022-09-17 10:53:03,385 UTC [183604] DEBUG esmvalcore.preprocessor:345 Running preprocessor step concatenate 2022-09-17 10:53:03,387 UTC [183604] DEBUG esmvalcore.preprocessor:306 Running preprocessor function 'concatenate' on the data [] loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/cmip5/output1/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/ta/ta_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc'] with function argument(s) 2022-09-17 10:53:03,387 UTC [183604] DEBUG esmvalcore.preprocessor:345 Running preprocessor step cmor_check_metadata 2022-09-17 10:53:03,388 UTC [183604] 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/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/ta/ta_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc'] with function argument(s) cmor_table = 'CMIP5', mip = 'Amon', short_name = 'ta', frequency = 'mon', check_level = 2022-09-17 10:53:04,300 UTC [183604] DEBUG esmvalcore.preprocessor:345 Running preprocessor step clip_timerange 2022-09-17 10:53:04,301 UTC [183604] DEBUG esmvalcore.preprocessor:306 Running preprocessor function 'clip_timerange' on the data loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/cmip5/output1/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/ta/ta_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc'] with function argument(s) timerange = '2000/2002' 2022-09-17 10:53:04,748 UTC [183604] DEBUG esmvalcore.preprocessor:345 Running preprocessor step fix_data 2022-09-17 10:53:04,749 UTC [183604] DEBUG esmvalcore.preprocessor:306 Running preprocessor function 'fix_data' on the data loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/cmip5/output1/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/ta/ta_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc'] with function argument(s) preprocessor = 'preprocessor_1', reference_dataset = 'MPI-ESM-LR', mip = 'Amon', variable_group = 'ta', short_name = 'ta', diagnostic = 'example', dataset = 'bcc-csm1-1', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', recipe_dataset_index = 0, institute = ['BCC'], product = ['output1', 'output2'], timerange = '2000/2002', alias = 'bcc-csm1-1', original_short_name = 'ta', standard_name = 'air_temperature', long_name = 'Air Temperature', units = 'K', modeling_realm = ['atmos'], frequency = 'mon', filename = '/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_ta_2000-2002.nc', check_level = 2022-09-17 10:53:04,749 UTC [183604] DEBUG esmvalcore.preprocessor:345 Running preprocessor step cmor_check_data 2022-09-17 10:53:04,750 UTC [183604] 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/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/ta/ta_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc'] with function argument(s) cmor_table = 'CMIP5', mip = 'Amon', short_name = 'ta', frequency = 'mon', check_level = 2022-09-17 10:53:04,750 UTC [183604] DEBUG esmvalcore.preprocessor:345 Running preprocessor step add_fx_variables 2022-09-17 10:53:04,751 UTC [183604] 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/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/ta/ta_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc'] with function argument(s) fx_variables = {}, check_level = 2022-09-17 10:53:04,751 UTC [183604] DEBUG esmvalcore.preprocessor:345 Running preprocessor step extract_levels 2022-09-17 10:53:04,752 UTC [183604] DEBUG esmvalcore.preprocessor:306 Running preprocessor function 'extract_levels' on the data loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/cmip5/output1/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/ta/ta_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc'] with function argument(s) levels = 85000, scheme = 'nearest' 2022-09-17 10:53:04,754 UTC [183604] DEBUG esmvalcore.preprocessor:345 Running preprocessor step remove_fx_variables 2022-09-17 10:53:04,755 UTC [183604] 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/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/ta/ta_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc'] with function argument(s) 2022-09-17 10:53:04,755 UTC [183604] DEBUG esmvalcore.preprocessor:345 Running preprocessor step save 2022-09-17 10:53:04,756 UTC [183604] DEBUG esmvalcore.preprocessor:306 Running preprocessor function 'save' on the data [] loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/cmip5/output1/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/ta/ta_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc'] with function argument(s) compress = False, filename = '/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_ta_2000-2002.nc' 2022-09-17 10:53:04,756 UTC [183604] DEBUG esmvalcore.preprocessor._io:309 Saving cubes [] to /projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_ta_2000-2002.nc 2022-09-17 10:53:05,188 UTC [183604] DEBUG esmvalcore.preprocessor:345 Running preprocessor step cleanup 2022-09-17 10:53:05,188 UTC [183604] DEBUG esmvalcore.preprocessor:306 Running preprocessor function 'cleanup' on the data ['/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_ta_2000-2002.nc'] loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/cmip5/output1/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/ta/ta_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc'] with function argument(s) remove = ['/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_ta_2000-2002_fixed'] 2022-09-17 10:53:05,249 UTC [183604] DEBUG esmvalcore.preprocessor:605 Applying single-model steps to PreprocessorFile: /projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_ta_2000-2002.nc 2022-09-17 10:53:05,250 UTC [183604] DEBUG esmvalcore.preprocessor:345 Running preprocessor step fix_file 2022-09-17 10:53:05,250 UTC [183604] DEBUG esmvalcore.preprocessor:306 Running preprocessor function 'fix_file' on the data '/projects/NS9252K/ESGF_betzy/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/latest/ta/ta_Amon_MPI-ESM-LR_historical_r1i1p1_200001-200512.nc' with function argument(s) preprocessor = 'preprocessor_1', reference_dataset = 'MPI-ESM-LR', mip = 'Amon', variable_group = 'ta', short_name = 'ta', diagnostic = 'example', dataset = 'MPI-ESM-LR', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', recipe_dataset_index = 2, institute = ['MPI-M'], product = ['output1', 'output2'], timerange = '2000/2002', alias = 'MPI-ESM-LR', original_short_name = 'ta', standard_name = 'air_temperature', long_name = 'Air Temperature', units = 'K', modeling_realm = ['atmos'], frequency = 'mon', filename = '/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_ta_2000-2002.nc', output_dir = '/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_ta_2000-2002_fixed' 2022-09-17 10:53:05,297 UTC [183604] DEBUG esmvalcore.preprocessor:345 Running preprocessor step load 2022-09-17 10:53:05,298 UTC [183604] DEBUG esmvalcore.preprocessor:306 Running preprocessor function 'load' on the data '/projects/NS9252K/ESGF_betzy/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/latest/ta/ta_Amon_MPI-ESM-LR_historical_r1i1p1_200001-200512.nc' with function argument(s) callback = 2022-09-17 10:53:05,298 UTC [183604] DEBUG esmvalcore.preprocessor._io:139 Loading: /projects/NS9252K/ESGF_betzy/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/latest/ta/ta_Amon_MPI-ESM-LR_historical_r1i1p1_200001-200512.nc 2022-09-17 10:53:05,506 UTC [183604] DEBUG esmvalcore.preprocessor._io:169 Done with loading /projects/NS9252K/ESGF_betzy/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/latest/ta/ta_Amon_MPI-ESM-LR_historical_r1i1p1_200001-200512.nc 2022-09-17 10:53:05,507 UTC [183604] DEBUG esmvalcore.preprocessor:345 Running preprocessor step fix_metadata 2022-09-17 10:53:05,510 UTC [183604] DEBUG esmvalcore.preprocessor:306 Running preprocessor function 'fix_metadata' on the data [] loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/latest/ta/ta_Amon_MPI-ESM-LR_historical_r1i1p1_200001-200512.nc'] with function argument(s) preprocessor = 'preprocessor_1', reference_dataset = 'MPI-ESM-LR', mip = 'Amon', variable_group = 'ta', short_name = 'ta', diagnostic = 'example', dataset = 'MPI-ESM-LR', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', recipe_dataset_index = 2, institute = ['MPI-M'], product = ['output1', 'output2'], timerange = '2000/2002', alias = 'MPI-ESM-LR', original_short_name = 'ta', standard_name = 'air_temperature', long_name = 'Air Temperature', units = 'K', modeling_realm = ['atmos'], frequency = 'mon', filename = '/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_ta_2000-2002.nc', check_level = 2022-09-17 10:53:05,590 UTC [183604] DEBUG esmvalcore.preprocessor:345 Running preprocessor step concatenate 2022-09-17 10:53:05,592 UTC [183604] DEBUG esmvalcore.preprocessor:306 Running preprocessor function 'concatenate' on the data [] loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/latest/ta/ta_Amon_MPI-ESM-LR_historical_r1i1p1_200001-200512.nc'] with function argument(s) 2022-09-17 10:53:05,593 UTC [183604] DEBUG esmvalcore.preprocessor:345 Running preprocessor step cmor_check_metadata 2022-09-17 10:53:05,594 UTC [183604] 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/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/latest/ta/ta_Amon_MPI-ESM-LR_historical_r1i1p1_200001-200512.nc'] with function argument(s) cmor_table = 'CMIP5', mip = 'Amon', short_name = 'ta', frequency = 'mon', check_level = 2022-09-17 10:53:05,652 UTC [183604] DEBUG esmvalcore.preprocessor:345 Running preprocessor step clip_timerange 2022-09-17 10:53:05,653 UTC [183604] DEBUG esmvalcore.preprocessor:306 Running preprocessor function 'clip_timerange' on the data loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/latest/ta/ta_Amon_MPI-ESM-LR_historical_r1i1p1_200001-200512.nc'] with function argument(s) timerange = '2000/2002' 2022-09-17 10:53:05,682 UTC [183604] DEBUG esmvalcore.preprocessor:345 Running preprocessor step fix_data 2022-09-17 10:53:05,682 UTC [183604] DEBUG esmvalcore.preprocessor:306 Running preprocessor function 'fix_data' on the data loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/latest/ta/ta_Amon_MPI-ESM-LR_historical_r1i1p1_200001-200512.nc'] with function argument(s) preprocessor = 'preprocessor_1', reference_dataset = 'MPI-ESM-LR', mip = 'Amon', variable_group = 'ta', short_name = 'ta', diagnostic = 'example', dataset = 'MPI-ESM-LR', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', recipe_dataset_index = 2, institute = ['MPI-M'], product = ['output1', 'output2'], timerange = '2000/2002', alias = 'MPI-ESM-LR', original_short_name = 'ta', standard_name = 'air_temperature', long_name = 'Air Temperature', units = 'K', modeling_realm = ['atmos'], frequency = 'mon', filename = '/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_ta_2000-2002.nc', check_level = 2022-09-17 10:53:05,683 UTC [183604] DEBUG esmvalcore.preprocessor:345 Running preprocessor step cmor_check_data 2022-09-17 10:53:05,684 UTC [183604] 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/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/latest/ta/ta_Amon_MPI-ESM-LR_historical_r1i1p1_200001-200512.nc'] with function argument(s) cmor_table = 'CMIP5', mip = 'Amon', short_name = 'ta', frequency = 'mon', check_level = 2022-09-17 10:53:05,684 UTC [183604] DEBUG esmvalcore.preprocessor:345 Running preprocessor step add_fx_variables 2022-09-17 10:53:05,685 UTC [183604] 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/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/latest/ta/ta_Amon_MPI-ESM-LR_historical_r1i1p1_200001-200512.nc'] with function argument(s) fx_variables = {}, check_level = 2022-09-17 10:53:05,685 UTC [183604] DEBUG esmvalcore.preprocessor:345 Running preprocessor step extract_levels 2022-09-17 10:53:05,686 UTC [183604] DEBUG esmvalcore.preprocessor:306 Running preprocessor function 'extract_levels' on the data loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/latest/ta/ta_Amon_MPI-ESM-LR_historical_r1i1p1_200001-200512.nc'] with function argument(s) levels = 85000, scheme = 'nearest' 2022-09-17 10:53:05,688 UTC [183604] DEBUG esmvalcore.preprocessor:345 Running preprocessor step remove_fx_variables 2022-09-17 10:53:05,689 UTC [183604] 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/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/latest/ta/ta_Amon_MPI-ESM-LR_historical_r1i1p1_200001-200512.nc'] with function argument(s) 2022-09-17 10:53:05,689 UTC [183604] DEBUG esmvalcore.preprocessor:345 Running preprocessor step save 2022-09-17 10:53:05,690 UTC [183604] DEBUG esmvalcore.preprocessor:306 Running preprocessor function 'save' on the data [] loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/latest/ta/ta_Amon_MPI-ESM-LR_historical_r1i1p1_200001-200512.nc'] with function argument(s) compress = False, filename = '/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_ta_2000-2002.nc' 2022-09-17 10:53:05,690 UTC [183604] DEBUG esmvalcore.preprocessor._io:309 Saving cubes [] to /projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_ta_2000-2002.nc 2022-09-17 10:53:06,215 UTC [183604] DEBUG esmvalcore.preprocessor:345 Running preprocessor step cleanup 2022-09-17 10:53:06,216 UTC [183604] DEBUG esmvalcore.preprocessor:306 Running preprocessor function 'cleanup' on the data ['/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_ta_2000-2002.nc'] loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/cmip5/output1/MPI-M/MPI-ESM-LR/historical/mon/atmos/Amon/r1i1p1/latest/ta/ta_Amon_MPI-ESM-LR_historical_r1i1p1_200001-200512.nc'] with function argument(s) remove = ['/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_MPI-ESM-LR_Amon_historical_r1i1p1_ta_2000-2002_fixed'] 2022-09-17 10:53:06,228 UTC [183604] DEBUG esmvalcore.preprocessor:605 Applying single-model steps to PreprocessorFile: /projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_GFDL-ESM2G_Amon_historical_r1i1p1_ta_2000-2002.nc 2022-09-17 10:53:06,228 UTC [183604] DEBUG esmvalcore.preprocessor:345 Running preprocessor step fix_file 2022-09-17 10:53:06,228 UTC [183604] DEBUG esmvalcore.preprocessor:306 Running preprocessor function 'fix_file' on the data '/projects/NS9252K/ESGF_betzy/cmip5/output1/NOAA-GFDL/GFDL-ESM2G/historical/mon/atmos/Amon/r1i1p1/v20120412/ta/ta_Amon_GFDL-ESM2G_historical_r1i1p1_199601-200012.nc' with function argument(s) preprocessor = 'preprocessor_1', reference_dataset = 'MPI-ESM-LR', mip = 'Amon', variable_group = 'ta', short_name = 'ta', diagnostic = 'example', dataset = 'GFDL-ESM2G', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', recipe_dataset_index = 1, institute = ['NOAA-GFDL'], product = ['output1', 'output2'], timerange = '2000/2002', alias = 'GFDL-ESM2G', original_short_name = 'ta', standard_name = 'air_temperature', long_name = 'Air Temperature', units = 'K', modeling_realm = ['atmos'], frequency = 'mon', filename = '/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_GFDL-ESM2G_Amon_historical_r1i1p1_ta_2000-2002.nc', output_dir = '/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_GFDL-ESM2G_Amon_historical_r1i1p1_ta_2000-2002_fixed' 2022-09-17 10:53:06,276 UTC [183604] DEBUG esmvalcore.preprocessor:306 Running preprocessor function 'fix_file' on the data '/projects/NS9252K/ESGF_betzy/cmip5/output1/NOAA-GFDL/GFDL-ESM2G/historical/mon/atmos/Amon/r1i1p1/v20120412/ta/ta_Amon_GFDL-ESM2G_historical_r1i1p1_200101-200512.nc' with function argument(s) preprocessor = 'preprocessor_1', reference_dataset = 'MPI-ESM-LR', mip = 'Amon', variable_group = 'ta', short_name = 'ta', diagnostic = 'example', dataset = 'GFDL-ESM2G', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', recipe_dataset_index = 1, institute = ['NOAA-GFDL'], product = ['output1', 'output2'], timerange = '2000/2002', alias = 'GFDL-ESM2G', original_short_name = 'ta', standard_name = 'air_temperature', long_name = 'Air Temperature', units = 'K', modeling_realm = ['atmos'], frequency = 'mon', filename = '/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_GFDL-ESM2G_Amon_historical_r1i1p1_ta_2000-2002.nc', output_dir = '/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_GFDL-ESM2G_Amon_historical_r1i1p1_ta_2000-2002_fixed' 2022-09-17 10:53:06,277 UTC [183604] DEBUG esmvalcore.preprocessor:345 Running preprocessor step load 2022-09-17 10:53:06,277 UTC [183604] DEBUG esmvalcore.preprocessor:306 Running preprocessor function 'load' on the data '/projects/NS9252K/ESGF_betzy/cmip5/output1/NOAA-GFDL/GFDL-ESM2G/historical/mon/atmos/Amon/r1i1p1/v20120412/ta/ta_Amon_GFDL-ESM2G_historical_r1i1p1_199601-200012.nc' with function argument(s) callback = 2022-09-17 10:53:06,277 UTC [183604] DEBUG esmvalcore.preprocessor._io:139 Loading: /projects/NS9252K/ESGF_betzy/cmip5/output1/NOAA-GFDL/GFDL-ESM2G/historical/mon/atmos/Amon/r1i1p1/v20120412/ta/ta_Amon_GFDL-ESM2G_historical_r1i1p1_199601-200012.nc 2022-09-17 10:53:06,511 UTC [183604] DEBUG esmvalcore.preprocessor._io:169 Done with loading /projects/NS9252K/ESGF_betzy/cmip5/output1/NOAA-GFDL/GFDL-ESM2G/historical/mon/atmos/Amon/r1i1p1/v20120412/ta/ta_Amon_GFDL-ESM2G_historical_r1i1p1_199601-200012.nc 2022-09-17 10:53:06,511 UTC [183604] DEBUG esmvalcore.preprocessor:306 Running preprocessor function 'load' on the data '/projects/NS9252K/ESGF_betzy/cmip5/output1/NOAA-GFDL/GFDL-ESM2G/historical/mon/atmos/Amon/r1i1p1/v20120412/ta/ta_Amon_GFDL-ESM2G_historical_r1i1p1_200101-200512.nc' with function argument(s) callback = 2022-09-17 10:53:06,511 UTC [183604] DEBUG esmvalcore.preprocessor._io:139 Loading: /projects/NS9252K/ESGF_betzy/cmip5/output1/NOAA-GFDL/GFDL-ESM2G/historical/mon/atmos/Amon/r1i1p1/v20120412/ta/ta_Amon_GFDL-ESM2G_historical_r1i1p1_200101-200512.nc 2022-09-17 10:53:06,742 UTC [183604] DEBUG esmvalcore.preprocessor._io:169 Done with loading /projects/NS9252K/ESGF_betzy/cmip5/output1/NOAA-GFDL/GFDL-ESM2G/historical/mon/atmos/Amon/r1i1p1/v20120412/ta/ta_Amon_GFDL-ESM2G_historical_r1i1p1_200101-200512.nc 2022-09-17 10:53:06,742 UTC [183604] DEBUG esmvalcore.preprocessor:345 Running preprocessor step fix_metadata 2022-09-17 10:53:06,755 UTC [183604] DEBUG esmvalcore.preprocessor:306 Running preprocessor function 'fix_metadata' on the data [, , , , , , , ] loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/cmip5/output1/NOAA-GFDL/GFDL-ESM2G/historical/mon/atmos/Amon/r1i1p1/v20120412/ta/ta_Amon_GFDL-ESM2G_historical_r1i1p1_199601-200012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/NOAA-GFDL/GFDL-ESM2G/historical/mon/atmos/Amon/r1i1p1/v20120412/ta/ta_Amon_GFDL-ESM2G_historical_r1i1p1_200101-200512.nc'] with function argument(s) preprocessor = 'preprocessor_1', reference_dataset = 'MPI-ESM-LR', mip = 'Amon', variable_group = 'ta', short_name = 'ta', diagnostic = 'example', dataset = 'GFDL-ESM2G', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', recipe_dataset_index = 1, institute = ['NOAA-GFDL'], product = ['output1', 'output2'], timerange = '2000/2002', alias = 'GFDL-ESM2G', original_short_name = 'ta', standard_name = 'air_temperature', long_name = 'Air Temperature', units = 'K', modeling_realm = ['atmos'], frequency = 'mon', filename = '/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_GFDL-ESM2G_Amon_historical_r1i1p1_ta_2000-2002.nc', check_level = 2022-09-17 10:53:06,843 UTC [183604] DEBUG esmvalcore.preprocessor:345 Running preprocessor step concatenate 2022-09-17 10:53:06,845 UTC [183604] DEBUG esmvalcore.preprocessor:306 Running preprocessor function 'concatenate' on the data [, ] loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/cmip5/output1/NOAA-GFDL/GFDL-ESM2G/historical/mon/atmos/Amon/r1i1p1/v20120412/ta/ta_Amon_GFDL-ESM2G_historical_r1i1p1_199601-200012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/NOAA-GFDL/GFDL-ESM2G/historical/mon/atmos/Amon/r1i1p1/v20120412/ta/ta_Amon_GFDL-ESM2G_historical_r1i1p1_200101-200512.nc'] with function argument(s) 2022-09-17 10:53:06,849 UTC [183604] DEBUG esmvalcore.preprocessor:345 Running preprocessor step cmor_check_metadata 2022-09-17 10:53:06,850 UTC [183604] 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/NOAA-GFDL/GFDL-ESM2G/historical/mon/atmos/Amon/r1i1p1/v20120412/ta/ta_Amon_GFDL-ESM2G_historical_r1i1p1_199601-200012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/NOAA-GFDL/GFDL-ESM2G/historical/mon/atmos/Amon/r1i1p1/v20120412/ta/ta_Amon_GFDL-ESM2G_historical_r1i1p1_200101-200512.nc'] with function argument(s) cmor_table = 'CMIP5', mip = 'Amon', short_name = 'ta', frequency = 'mon', check_level = 2022-09-17 10:53:06,908 UTC [183604] DEBUG esmvalcore.preprocessor:345 Running preprocessor step clip_timerange 2022-09-17 10:53:06,909 UTC [183604] DEBUG esmvalcore.preprocessor:306 Running preprocessor function 'clip_timerange' on the data loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/cmip5/output1/NOAA-GFDL/GFDL-ESM2G/historical/mon/atmos/Amon/r1i1p1/v20120412/ta/ta_Amon_GFDL-ESM2G_historical_r1i1p1_199601-200012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/NOAA-GFDL/GFDL-ESM2G/historical/mon/atmos/Amon/r1i1p1/v20120412/ta/ta_Amon_GFDL-ESM2G_historical_r1i1p1_200101-200512.nc'] with function argument(s) timerange = '2000/2002' 2022-09-17 10:53:06,943 UTC [183604] DEBUG esmvalcore.preprocessor:345 Running preprocessor step fix_data 2022-09-17 10:53:06,944 UTC [183604] DEBUG esmvalcore.preprocessor:306 Running preprocessor function 'fix_data' on the data loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/cmip5/output1/NOAA-GFDL/GFDL-ESM2G/historical/mon/atmos/Amon/r1i1p1/v20120412/ta/ta_Amon_GFDL-ESM2G_historical_r1i1p1_199601-200012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/NOAA-GFDL/GFDL-ESM2G/historical/mon/atmos/Amon/r1i1p1/v20120412/ta/ta_Amon_GFDL-ESM2G_historical_r1i1p1_200101-200512.nc'] with function argument(s) preprocessor = 'preprocessor_1', reference_dataset = 'MPI-ESM-LR', mip = 'Amon', variable_group = 'ta', short_name = 'ta', diagnostic = 'example', dataset = 'GFDL-ESM2G', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', recipe_dataset_index = 1, institute = ['NOAA-GFDL'], product = ['output1', 'output2'], timerange = '2000/2002', alias = 'GFDL-ESM2G', original_short_name = 'ta', standard_name = 'air_temperature', long_name = 'Air Temperature', units = 'K', modeling_realm = ['atmos'], frequency = 'mon', filename = '/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_GFDL-ESM2G_Amon_historical_r1i1p1_ta_2000-2002.nc', check_level = 2022-09-17 10:53:06,944 UTC [183604] DEBUG esmvalcore.preprocessor:345 Running preprocessor step cmor_check_data 2022-09-17 10:53:06,945 UTC [183604] 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/NOAA-GFDL/GFDL-ESM2G/historical/mon/atmos/Amon/r1i1p1/v20120412/ta/ta_Amon_GFDL-ESM2G_historical_r1i1p1_199601-200012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/NOAA-GFDL/GFDL-ESM2G/historical/mon/atmos/Amon/r1i1p1/v20120412/ta/ta_Amon_GFDL-ESM2G_historical_r1i1p1_200101-200512.nc'] with function argument(s) cmor_table = 'CMIP5', mip = 'Amon', short_name = 'ta', frequency = 'mon', check_level = 2022-09-17 10:53:06,946 UTC [183604] DEBUG esmvalcore.preprocessor:345 Running preprocessor step add_fx_variables 2022-09-17 10:53:06,946 UTC [183604] 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/NOAA-GFDL/GFDL-ESM2G/historical/mon/atmos/Amon/r1i1p1/v20120412/ta/ta_Amon_GFDL-ESM2G_historical_r1i1p1_199601-200012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/NOAA-GFDL/GFDL-ESM2G/historical/mon/atmos/Amon/r1i1p1/v20120412/ta/ta_Amon_GFDL-ESM2G_historical_r1i1p1_200101-200512.nc'] with function argument(s) fx_variables = {}, check_level = 2022-09-17 10:53:06,947 UTC [183604] DEBUG esmvalcore.preprocessor:345 Running preprocessor step extract_levels 2022-09-17 10:53:06,947 UTC [183604] DEBUG esmvalcore.preprocessor:306 Running preprocessor function 'extract_levels' on the data loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/cmip5/output1/NOAA-GFDL/GFDL-ESM2G/historical/mon/atmos/Amon/r1i1p1/v20120412/ta/ta_Amon_GFDL-ESM2G_historical_r1i1p1_199601-200012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/NOAA-GFDL/GFDL-ESM2G/historical/mon/atmos/Amon/r1i1p1/v20120412/ta/ta_Amon_GFDL-ESM2G_historical_r1i1p1_200101-200512.nc'] with function argument(s) levels = 85000, scheme = 'nearest' 2022-09-17 10:53:06,950 UTC [183604] DEBUG esmvalcore.preprocessor:345 Running preprocessor step remove_fx_variables 2022-09-17 10:53:06,950 UTC [183604] 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/NOAA-GFDL/GFDL-ESM2G/historical/mon/atmos/Amon/r1i1p1/v20120412/ta/ta_Amon_GFDL-ESM2G_historical_r1i1p1_199601-200012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/NOAA-GFDL/GFDL-ESM2G/historical/mon/atmos/Amon/r1i1p1/v20120412/ta/ta_Amon_GFDL-ESM2G_historical_r1i1p1_200101-200512.nc'] with function argument(s) 2022-09-17 10:53:06,950 UTC [183604] DEBUG esmvalcore.preprocessor:345 Running preprocessor step save 2022-09-17 10:53:06,952 UTC [183604] DEBUG esmvalcore.preprocessor:306 Running preprocessor function 'save' on the data [] loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/cmip5/output1/NOAA-GFDL/GFDL-ESM2G/historical/mon/atmos/Amon/r1i1p1/v20120412/ta/ta_Amon_GFDL-ESM2G_historical_r1i1p1_199601-200012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/NOAA-GFDL/GFDL-ESM2G/historical/mon/atmos/Amon/r1i1p1/v20120412/ta/ta_Amon_GFDL-ESM2G_historical_r1i1p1_200101-200512.nc'] with function argument(s) compress = False, filename = '/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_GFDL-ESM2G_Amon_historical_r1i1p1_ta_2000-2002.nc' 2022-09-17 10:53:06,952 UTC [183604] DEBUG esmvalcore.preprocessor._io:309 Saving cubes [] to /projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_GFDL-ESM2G_Amon_historical_r1i1p1_ta_2000-2002.nc 2022-09-17 10:53:07,476 UTC [183604] DEBUG esmvalcore.preprocessor:345 Running preprocessor step cleanup 2022-09-17 10:53:07,477 UTC [183604] DEBUG esmvalcore.preprocessor:306 Running preprocessor function 'cleanup' on the data ['/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_GFDL-ESM2G_Amon_historical_r1i1p1_ta_2000-2002.nc'] loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/cmip5/output1/NOAA-GFDL/GFDL-ESM2G/historical/mon/atmos/Amon/r1i1p1/v20120412/ta/ta_Amon_GFDL-ESM2G_historical_r1i1p1_199601-200012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/NOAA-GFDL/GFDL-ESM2G/historical/mon/atmos/Amon/r1i1p1/v20120412/ta/ta_Amon_GFDL-ESM2G_historical_r1i1p1_200101-200512.nc'] with function argument(s) remove = ['/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/CMIP5_GFDL-ESM2G_Amon_historical_r1i1p1_ta_2000-2002_fixed'] 2022-09-17 10:53:07,544 UTC [183604] DEBUG esmvalcore._task:176 Writing NCL configuration file /projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/preproc/example/ta/ta_info.ncl 2022-09-17 10:53:07,578 UTC [183604] INFO esmvalcore._task:265 Successfully completed task example/ta (priority 1) in 0:00:18.025985 2022-09-17 10:53:07,578 UTC [183604] INFO esmvalcore._task:260 Starting task example/test_ta in process [183604] 2022-09-17 10:53:07,722 UTC [183604] DEBUG esmvalcore._task:176 Writing NCL configuration file /projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/run/example/test_ta/settings.ncl 2022-09-17 10:53:07,754 UTC [183604] INFO esmvalcore._task:501 Running command ['/projects/NS2980K/conda/esmvaltool2.6.0/bin/ncl', '-n', '-p', '/projects/NS2980K/conda/esmvaltool2.6.0/lib/python3.9/site-packages/esmvaltool/diag_scripts/examples/diagnostic.ncl'] 2022-09-17 10:53:07,754 UTC [183604] DEBUG esmvalcore._task:502 in environment {'diag_scripts': '/projects/NS2980K/conda/esmvaltool2.6.0/lib/python3.9/site-packages/esmvaltool/diag_scripts', 'settings': PosixPath('/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/run/example/test_ta/settings.ncl')} 2022-09-17 10:53:07,754 UTC [183604] DEBUG esmvalcore._task:504 in current working directory: /projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/run/example/test_ta 2022-09-17 10:53:07,755 UTC [183604] INFO esmvalcore._task:505 Writing output to /projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/work/example/test_ta 2022-09-17 10:53:07,755 UTC [183604] INFO esmvalcore._task:506 Writing plots to /projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/plots/example/test_ta 2022-09-17 10:53:07,755 UTC [183604] INFO esmvalcore._task:507 Writing log to /projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/run/example/test_ta/log.txt 2022-09-17 10:53:07,755 UTC [183604] INFO esmvalcore._task:517 To re-run this diagnostic script, run: cd /projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/run/example/test_ta; diag_scripts="/projects/NS2980K/conda/esmvaltool2.6.0/lib/python3.9/site-packages/esmvaltool/diag_scripts" settings="/projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/run/example/test_ta/settings.ncl" /projects/NS2980K/conda/esmvaltool2.6.0/bin/ncl -n -p /projects/NS2980K/conda/esmvaltool2.6.0/lib/python3.9/site-packages/esmvaltool/diag_scripts/examples/diagnostic.ncl 2022-09-17 10:53:18,906 UTC [183604] INFO esmvalcore._task:127 Maximum memory used (estimate): 0.2 GB 2022-09-17 10:53:18,908 UTC [183604] INFO esmvalcore._task:129 Sampled every second. It may be inaccurate if short but high spikes in memory consumption occur. 2022-09-17 10:53:18,909 UTC [183604] DEBUG esmvalcore._task:590 Script examples/diagnostic.ncl completed successfully 2022-09-17 10:53:18,909 UTC [183604] DEBUG esmvalcore._task:609 Collecting provenance from /projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/run/example/test_ta/diagnostic_provenance.yml 2022-09-17 10:53:19,246 UTC [183604] DEBUG PIL.PngImagePlugin:201 STREAM b'IHDR' 16 13 2022-09-17 10:53:19,246 UTC [183604] DEBUG PIL.PngImagePlugin:201 STREAM b'bKGD' 41 6 2022-09-17 10:53:19,246 UTC [183604] DEBUG PIL.PngImagePlugin:734 b'bKGD' 41 6 (unknown) 2022-09-17 10:53:19,247 UTC [183604] DEBUG PIL.PngImagePlugin:201 STREAM b'IDAT' 59 8192 2022-09-17 10:53:19,459 UTC [183604] DEBUG esmvalcore._task:684 Collecting provenance of task example/test_ta took 0.5 seconds 2022-09-17 10:53:19,459 UTC [183604] INFO esmvalcore._task:265 Successfully completed task example/test_ta (priority 0) in 0:00:11.880801 2022-09-17 10:53:20,253 UTC [183604] INFO esmvalcore.experimental.recipe_output:212 Wrote recipe output to: file:///projects/NS2980K/www/tomast/esmvaltool2.6.0/recipe_ncl_20220917_105247/index.html 2022-09-17 10:53:20,253 UTC [183604] INFO esmvalcore._main:127 Ending the Earth System Model Evaluation Tool at time: 2022-09-17 10:53:20 UTC 2022-09-17 10:53:20,253 UTC [183604] INFO esmvalcore._main:130 Time for running the recipe was: 0:00:31.921328 2022-09-17 10:53:21,080 UTC [183604] INFO esmvalcore._task:127 Maximum memory used (estimate): 0.5 GB 2022-09-17 10:53:21,080 UTC [183604] INFO esmvalcore._task:129 Sampled every second. It may be inaccurate if short but high spikes in memory consumption occur. 2022-09-17 10:53:21,081 UTC [183604] INFO esmvalcore._main:454 Removing preproc containing preprocessed data 2022-09-17 10:53:21,082 UTC [183604] INFO esmvalcore._main:455 If this data is further needed, then 2022-09-17 10:53:21,082 UTC [183604] INFO esmvalcore._main:456 set remove_preproc_dir to false in config-user.yml 2022-09-17 10:53:21,116 UTC [183604] INFO esmvalcore._main:446 Run was successful