2023-03-05 20:13:19,456 UTC [23486] 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! 2023-03-05 20:13:19,457 UTC [23486] INFO esmvalcore._main:474 Package versions 2023-03-05 20:13:19,457 UTC [23486] INFO esmvalcore._main:475 ---------------- 2023-03-05 20:13:19,457 UTC [23486] INFO esmvalcore._main:476 ESMValCore: 2.7.0 2023-03-05 20:13:19,458 UTC [23486] INFO esmvalcore._main:478 ESMValTool: 2.7.0 2023-03-05 20:13:19,458 UTC [23486] INFO esmvalcore._main:479 ---------------- 2023-03-05 20:13:19,458 UTC [23486] INFO esmvalcore._main:480 Using config file /projects/NS2980K/home/tomast/ESMValTool/rundir_ipcc_node/config-ipcc_node-270.yml 2023-03-05 20:13:19,458 UTC [23486] INFO esmvalcore._main:481 Writing program log files to: /projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/run/main_log.txt /projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/run/main_log_debug.txt 2023-03-05 20:13:19,459 UTC [23486] INFO esmvalcore._main:86 Starting the Earth System Model Evaluation Tool at time: 2023-03-05 20:13:19 UTC 2023-03-05 20:13:19,460 UTC [23486] INFO esmvalcore._main:90 ---------------------------------------------------------------------- 2023-03-05 20:13:19,460 UTC [23486] INFO esmvalcore._main:91 RECIPE = /projects/NS2980K/home/tomast/ESMValTool/rundir_ipcc_node/recipe_arctic_ocean.yml 2023-03-05 20:13:19,461 UTC [23486] INFO esmvalcore._main:92 RUNDIR = /projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/run 2023-03-05 20:13:19,461 UTC [23486] INFO esmvalcore._main:93 WORKDIR = /projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/work 2023-03-05 20:13:19,461 UTC [23486] INFO esmvalcore._main:94 PREPROCDIR = /projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc 2023-03-05 20:13:19,461 UTC [23486] INFO esmvalcore._main:95 PLOTDIR = /projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/plots 2023-03-05 20:13:19,461 UTC [23486] INFO esmvalcore._main:96 ---------------------------------------------------------------------- 2023-03-05 20:13:19,463 UTC [23486] INFO esmvalcore._main:100 Running tasks using at most 8 processes 2023-03-05 20:13:19,463 UTC [23486] INFO esmvalcore._main:102 If your system hangs during execution, it may not have enough memory for keeping this number of tasks in memory. 2023-03-05 20:13:19,464 UTC [23486] INFO esmvalcore._main:105 If you experience memory problems, try reducing 'max_parallel_tasks' in your user configuration file. 2023-03-05 20:13:19,601 UTC [23486] DEBUG esmvalcore._recipe_checks:47 Checking recipe against schema /projects/NS2980K/conda/esmvaltool2.7.0/lib/python3.10/site-packages/esmvalcore/recipe_schema.yml 2023-03-05 20:13:19,652 UTC [23486] DEBUG esmvalcore._recipe:1342 Retrieving diagnostics from recipe 2023-03-05 20:13:19,652 UTC [23486] DEBUG esmvalcore._recipe:1479 Populating list of variables for diagnostic arctic_ocean 2023-03-05 20:13:19,654 UTC [23486] DEBUG esmvalcore._config._config:48 Loading extra facets from /projects/NS2980K/conda/esmvaltool2.7.0/lib/python3.10/site-packages/esmvalcore/_config/extra_facets/cmip5-institutes.yml 2023-03-05 20:13:19,698 UTC [23486] DEBUG esmvalcore._config._config:48 Loading extra facets from /projects/NS2980K/conda/esmvaltool2.7.0/lib/python3.10/site-packages/esmvalcore/_config/extra_facets/cmip5-product.yml 2023-03-05 20:13:19,708 UTC [23486] DEBUG esmvalcore._recipe:1609 Setting script for diagnostic arctic_ocean 2023-03-05 20:13:19,708 UTC [23486] INFO esmvalcore._recipe:1845 Creating tasks from recipe 2023-03-05 20:13:19,709 UTC [23486] INFO esmvalcore._recipe:1854 Creating tasks for diagnostic arctic_ocean 2023-03-05 20:13:19,709 UTC [23486] INFO esmvalcore._recipe:1728 Creating diagnostic task arctic_ocean/arctic_ocean_main 2023-03-05 20:13:19,709 UTC [23486] INFO esmvalcore._recipe:1825 Creating preprocessor task arctic_ocean/areacello 2023-03-05 20:13:19,709 UTC [23486] INFO esmvalcore._recipe:1214 Creating preprocessor 'default' task for variable 'areacello' 2023-03-05 20:13:19,720 UTC [23486] DEBUG esmvalcore._data_finder:19 Looking for files matching ['areacello_fx_CanESM2_historical_r0i0p0*.nc'] in ['/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/fx/ocean/fx/r0i0p0/latest/areacello'] 2023-03-05 20:13:19,725 UTC [23486] DEBUG esmvalcore._recipe:624 Using input files for variable areacello of dataset CMIP5 r0i0p0: /projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/fx/ocean/fx/r0i0p0/latest/areacello/areacello_fx_CanESM2_historical_r0i0p0.nc 2023-03-05 20:13:19,725 UTC [23486] INFO esmvalcore._recipe:633 Found input files for CMIP5 r0i0p0 2023-03-05 20:13:19,730 UTC [23486] INFO esmvalcore._recipe:1095 PreprocessingTask arctic_ocean/areacello created. 2023-03-05 20:13:19,732 UTC [23486] DEBUG esmvalcore._recipe:1096 PreprocessingTask arctic_ocean/areacello will create the files: /projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/areacello/CMIP5_CanESM2_fx_historical_r0i0p0_areacello.nc 2023-03-05 20:13:19,732 UTC [23486] INFO esmvalcore._recipe:1825 Creating preprocessor task arctic_ocean/thetao 2023-03-05 20:13:19,732 UTC [23486] INFO esmvalcore._recipe:1214 Creating preprocessor 'default' task for variable 'thetao' 2023-03-05 20:13:19,742 UTC [23486] DEBUG esmvalcore._data_finder:19 Looking for files matching ['thetao_Omon_CanESM2_historical_r1i1p1*.nc'] in ['/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/thetao'] 2023-03-05 20:13:19,762 UTC [23486] DEBUG esmvalcore._recipe:624 Using input files for variable thetao of dataset CMIP5 r1i1p1: /projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/thetao/thetao_Omon_CanESM2_historical_r1i1p1_197101-198012.nc /projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/thetao/thetao_Omon_CanESM2_historical_r1i1p1_198101-199012.nc /projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/thetao/thetao_Omon_CanESM2_historical_r1i1p1_199101-200012.nc /projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/thetao/thetao_Omon_CanESM2_historical_r1i1p1_200101-200512.nc 2023-03-05 20:13:19,764 UTC [23486] INFO esmvalcore._recipe:633 Found input files for CMIP5 r1i1p1 2023-03-05 20:13:19,788 UTC [23486] DEBUG esmvalcore._data_finder:465 Skipping non-existent /projects/NS2980K/data/obsdata/cmor/Tier2/PHC 2023-03-05 20:13:19,788 UTC [23486] DEBUG esmvalcore._data_finder:19 Looking for files matching ['OBS6_PHC_clim_3_Omon_thetao[_.]*nc'] in ['/projects/NS9252K/ESGF_betzy/obsdata/Tier2/PHC', '/projects/NS9252K/obsdata/Tier2/PHC'] 2023-03-05 20:13:19,798 UTC [23486] DEBUG esmvalcore._recipe:624 Using input files for variable thetao of dataset OBS6: /projects/NS9252K/ESGF_betzy/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_thetao_195001-195012.nc /projects/NS9252K/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_thetao_195001-195012.nc 2023-03-05 20:13:19,798 UTC [23486] INFO esmvalcore._recipe:633 Found input files for OBS6 2023-03-05 20:13:19,812 UTC [23486] INFO esmvalcore._recipe:1095 PreprocessingTask arctic_ocean/thetao created. 2023-03-05 20:13:19,812 UTC [23486] DEBUG esmvalcore._recipe:1096 PreprocessingTask arctic_ocean/thetao will create the files: /projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/thetao/CMIP5_CanESM2_Omon_historical_r1i1p1_thetao_1980-2005.nc /projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/thetao/OBS6_PHC_clim_3_Omon_thetao_1950-1950.nc 2023-03-05 20:13:19,813 UTC [23486] INFO esmvalcore._recipe:1825 Creating preprocessor task arctic_ocean/so 2023-03-05 20:13:19,813 UTC [23486] INFO esmvalcore._recipe:1214 Creating preprocessor 'default' task for variable 'so' 2023-03-05 20:13:19,814 UTC [23486] DEBUG esmvalcore._data_finder:19 Looking for files matching ['so_Omon_CanESM2_historical_r1i1p1*.nc'] in ['/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/so'] 2023-03-05 20:13:19,818 UTC [23486] DEBUG esmvalcore._recipe:624 Using input files for variable so of dataset CMIP5 r1i1p1: /projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/so/so_Omon_CanESM2_historical_r1i1p1_197101-198012.nc /projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/so/so_Omon_CanESM2_historical_r1i1p1_198101-199012.nc /projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/so/so_Omon_CanESM2_historical_r1i1p1_199101-200012.nc /projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/so/so_Omon_CanESM2_historical_r1i1p1_200101-200512.nc 2023-03-05 20:13:19,818 UTC [23486] INFO esmvalcore._recipe:633 Found input files for CMIP5 r1i1p1 2023-03-05 20:13:19,825 UTC [23486] DEBUG esmvalcore._data_finder:465 Skipping non-existent /projects/NS2980K/data/obsdata/cmor/Tier2/PHC 2023-03-05 20:13:19,825 UTC [23486] DEBUG esmvalcore._data_finder:19 Looking for files matching ['OBS6_PHC_clim_3_Omon_so[_.]*nc'] in ['/projects/NS9252K/ESGF_betzy/obsdata/Tier2/PHC', '/projects/NS9252K/obsdata/Tier2/PHC'] 2023-03-05 20:13:19,826 UTC [23486] DEBUG esmvalcore._recipe:624 Using input files for variable so of dataset OBS6: /projects/NS9252K/ESGF_betzy/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_so_195001-195012.nc /projects/NS9252K/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_so_195001-195012.nc 2023-03-05 20:13:19,827 UTC [23486] INFO esmvalcore._recipe:633 Found input files for OBS6 2023-03-05 20:13:19,837 UTC [23486] INFO esmvalcore._recipe:1095 PreprocessingTask arctic_ocean/so created. 2023-03-05 20:13:19,837 UTC [23486] DEBUG esmvalcore._recipe:1096 PreprocessingTask arctic_ocean/so will create the files: /projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/so/CMIP5_CanESM2_Omon_historical_r1i1p1_so_1980-2005.nc /projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/so/OBS6_PHC_clim_3_Omon_so_1950-1950.nc 2023-03-05 20:13:19,838 UTC [23486] DEBUG esmvalcore._recipe:1656 Linking tasks for diagnostic arctic_ocean script arctic_ocean_main 2023-03-05 20:13:19,838 UTC [23486] DEBUG esmvalcore._recipe:1665 Pattern arctic_ocean/areacello matches ['arctic_ocean/areacello'] 2023-03-05 20:13:19,838 UTC [23486] DEBUG esmvalcore._recipe:1665 Pattern arctic_ocean/thetao matches ['arctic_ocean/thetao'] 2023-03-05 20:13:19,838 UTC [23486] DEBUG esmvalcore._recipe:1665 Pattern arctic_ocean/so matches ['arctic_ocean/so'] 2023-03-05 20:13:19,838 UTC [23486] INFO esmvalcore._recipe:1894 These tasks will be executed: arctic_ocean/so, arctic_ocean/arctic_ocean_main, arctic_ocean/areacello, arctic_ocean/thetao 2023-03-05 20:13:19,842 UTC [23486] DEBUG esmvalcore._main:122 Recipe summary: DiagnosticTask: arctic_ocean/arctic_ocean_main script: arctic_ocean/arctic_ocean.py settings: {'AW_core': True, 'AW_core_2d': True, 'auxiliary_data_dir': '/projects/NS9252K/share/esmvaltool/auxiliary_data', 'hofm_cmap': ['Spectral_r', 'custom_salinity1'], 'hofm_data': True, 'hofm_depth': 1500, 'hofm_limits': [[-2, 2.3, 41, 1], [30.5, 35.1, 47, 2]], 'hofm_ncol': 3, 'hofm_plot': True, 'hofm_regions': ['AB', 'EB'], 'hofm_vars': ['thetao', 'so'], 'log_level': 'info', 'mean': True, 'observational_dataset': {'dataset': 'PHC', 'project': 'OBS'}, 'output_file_type': 'png', 'plot2d': True, 'plot2d_bias': True, 'plot2d_bias_cmap': ['balance', 'balance'], 'plot2d_bias_depths': [10, 100], 'plot2d_bias_limits': [[-3, 3, 20, 1], [-2, 2, 47, 2]], 'plot2d_bias_ncol': 4, 'plot2d_bias_vars': ['thetao', 'so'], 'plot2d_cmap': ['Spectral_r', 'custom_salinity1'], 'plot2d_depths': [10, 100], 'plot2d_limits': [[-2, 4, 20, 1], [30.5, 35.1, 47, 2]], 'plot2d_ncol': 4, 'plot2d_vars': ['thetao', 'so'], 'plot_dir': '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/plots/arctic_ocean/arctic_ocean_main', 'profile_diagnostic': False, 'profiles': True, 'recipe': 'recipe_arctic_ocean.yml', 'run_dir': '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/run/arctic_ocean/arctic_ocean_main', 'script': 'arctic_ocean_main', 'transects': True, 'transects_cmap': ['Spectral_r', 'custom_salinity1'], 'transects_depth': 1500, 'transects_limits': [[-2, 4, 20, 1], [30.5, 35.1, 47, 2]], 'transects_ncol': 3, 'transects_regions': ['AWpath', 'Fram'], 'transects_vars': ['thetao', 'so'], 'tsdiag': True, 'tsdiag_depth': 1500, 'tsdiag_ncol': 3, 'tsdiag_regions': ['AB', 'EB'], 'version': '2.7.0', 'work_dir': '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/work/arctic_ocean/arctic_ocean_main'} ancestors: PreprocessingTask: arctic_ocean/areacello order: ['fix_file', 'load', 'fix_metadata', 'concatenate', 'cmor_check_metadata', 'fix_data', 'cmor_check_data', 'add_fx_variables', 'remove_fx_variables', 'save', 'cleanup'] PreprocessorFile: /projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/areacello/CMIP5_CanESM2_fx_historical_r0i0p0_areacello.nc {'add_fx_variables': {'check_level': , 'fx_variables': {}}, 'cleanup': {'remove': ['/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/areacello/CMIP5_CanESM2_fx_historical_r0i0p0_areacello_fixed']}, 'cmor_check_data': {'check_level': , 'cmor_table': 'CMIP5', 'frequency': 'fx', 'mip': 'fx', 'short_name': 'areacello'}, 'cmor_check_metadata': {'check_level': , 'cmor_table': 'CMIP5', 'frequency': 'fx', 'mip': 'fx', 'short_name': 'areacello'}, 'concatenate': {}, 'fix_data': {'alias': 'CMIP5_r0i0p0', 'check_level': , 'dataset': 'CanESM2', 'diagnostic': 'arctic_ocean', 'ensemble': 'r0i0p0', 'exp': 'historical', 'filename': '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/areacello/CMIP5_CanESM2_fx_historical_r0i0p0_areacello.nc', 'frequency': 'fx', 'institute': ['CCCma'], 'long_name': 'Ocean Grid-Cell Area', 'mip': 'fx', 'modeling_realm': ['ocean'], 'original_short_name': 'areacello', 'preprocessor': 'default', 'product': ['output1', 'output2'], 'project': 'CMIP5', 'recipe_dataset_index': 0, 'short_name': 'areacello', 'standard_name': 'cell_area', 'units': 'm2', 'variable_group': 'areacello'}, 'fix_file': {'alias': 'CMIP5_r0i0p0', 'dataset': 'CanESM2', 'diagnostic': 'arctic_ocean', 'ensemble': 'r0i0p0', 'exp': 'historical', 'filename': '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/areacello/CMIP5_CanESM2_fx_historical_r0i0p0_areacello.nc', 'frequency': 'fx', 'institute': ['CCCma'], 'long_name': 'Ocean Grid-Cell Area', 'mip': 'fx', 'modeling_realm': ['ocean'], 'original_short_name': 'areacello', 'output_dir': '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/areacello/CMIP5_CanESM2_fx_historical_r0i0p0_areacello_fixed', 'preprocessor': 'default', 'product': ['output1', 'output2'], 'project': 'CMIP5', 'recipe_dataset_index': 0, 'short_name': 'areacello', 'standard_name': 'cell_area', 'units': 'm2', 'variable_group': 'areacello'}, 'fix_metadata': {'alias': 'CMIP5_r0i0p0', 'check_level': , 'dataset': 'CanESM2', 'diagnostic': 'arctic_ocean', 'ensemble': 'r0i0p0', 'exp': 'historical', 'filename': '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/areacello/CMIP5_CanESM2_fx_historical_r0i0p0_areacello.nc', 'frequency': 'fx', 'institute': ['CCCma'], 'long_name': 'Ocean Grid-Cell Area', 'mip': 'fx', 'modeling_realm': ['ocean'], 'original_short_name': 'areacello', 'preprocessor': 'default', 'product': ['output1', 'output2'], 'project': 'CMIP5', 'recipe_dataset_index': 0, 'short_name': 'areacello', 'standard_name': 'cell_area', 'units': 'm2', 'variable_group': 'areacello'}, 'load': {'callback': }, 'remove_fx_variables': {}, 'save': {'compress': False, 'filename': '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/areacello/CMIP5_CanESM2_fx_historical_r0i0p0_areacello.nc'}} ancestors: None PreprocessingTask: arctic_ocean/thetao 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.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/thetao/CMIP5_CanESM2_Omon_historical_r1i1p1_thetao_1980-2005.nc {'add_fx_variables': {'check_level': , 'fx_variables': {}}, 'cleanup': {'remove': ['/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/thetao/CMIP5_CanESM2_Omon_historical_r1i1p1_thetao_1980-2005_fixed']}, 'clip_timerange': {'timerange': '1980/2005'}, 'cmor_check_data': {'check_level': , 'cmor_table': 'CMIP5', 'frequency': 'mon', 'mip': 'Omon', 'short_name': 'thetao'}, 'cmor_check_metadata': {'check_level': , 'cmor_table': 'CMIP5', 'frequency': 'mon', 'mip': 'Omon', 'short_name': 'thetao'}, 'concatenate': {}, 'fix_data': {'alias': 'CMIP5_r1i1p1', 'check_level': , 'dataset': 'CanESM2', 'diagnostic': 'arctic_ocean', 'ensemble': 'r1i1p1', 'exp': 'historical', 'filename': '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/thetao/CMIP5_CanESM2_Omon_historical_r1i1p1_thetao_1980-2005.nc', 'frequency': 'mon', 'institute': ['CCCma'], 'long_name': 'Sea Water Potential Temperature', 'mip': 'Omon', 'modeling_realm': ['ocean'], 'original_short_name': 'thetao', 'preprocessor': 'default', 'product': ['output1', 'output2'], 'project': 'CMIP5', 'recipe_dataset_index': 0, 'short_name': 'thetao', 'standard_name': 'sea_water_potential_temperature', 'timerange': '1980/2005', 'units': 'K', 'variable_group': 'thetao'}, 'fix_file': {'alias': 'CMIP5_r1i1p1', 'dataset': 'CanESM2', 'diagnostic': 'arctic_ocean', 'ensemble': 'r1i1p1', 'exp': 'historical', 'filename': '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/thetao/CMIP5_CanESM2_Omon_historical_r1i1p1_thetao_1980-2005.nc', 'frequency': 'mon', 'institute': ['CCCma'], 'long_name': 'Sea Water Potential Temperature', 'mip': 'Omon', 'modeling_realm': ['ocean'], 'original_short_name': 'thetao', 'output_dir': '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/thetao/CMIP5_CanESM2_Omon_historical_r1i1p1_thetao_1980-2005_fixed', 'preprocessor': 'default', 'product': ['output1', 'output2'], 'project': 'CMIP5', 'recipe_dataset_index': 0, 'short_name': 'thetao', 'standard_name': 'sea_water_potential_temperature', 'timerange': '1980/2005', 'units': 'K', 'variable_group': 'thetao'}, 'fix_metadata': {'alias': 'CMIP5_r1i1p1', 'check_level': , 'dataset': 'CanESM2', 'diagnostic': 'arctic_ocean', 'ensemble': 'r1i1p1', 'exp': 'historical', 'filename': '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/thetao/CMIP5_CanESM2_Omon_historical_r1i1p1_thetao_1980-2005.nc', 'frequency': 'mon', 'institute': ['CCCma'], 'long_name': 'Sea Water Potential Temperature', 'mip': 'Omon', 'modeling_realm': ['ocean'], 'original_short_name': 'thetao', 'preprocessor': 'default', 'product': ['output1', 'output2'], 'project': 'CMIP5', 'recipe_dataset_index': 0, 'short_name': 'thetao', 'standard_name': 'sea_water_potential_temperature', 'timerange': '1980/2005', 'units': 'K', 'variable_group': 'thetao'}, 'load': {'callback': }, 'remove_fx_variables': {}, 'save': {'compress': False, 'filename': '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/thetao/CMIP5_CanESM2_Omon_historical_r1i1p1_thetao_1980-2005.nc'}} PreprocessorFile: /projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/thetao/OBS6_PHC_clim_3_Omon_thetao_1950-1950.nc {'add_fx_variables': {'check_level': , 'fx_variables': {}}, 'cleanup': {'remove': ['/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/thetao/OBS6_PHC_clim_3_Omon_thetao_1950-1950_fixed']}, 'clip_timerange': {'timerange': '1950/1950'}, 'cmor_check_data': {'check_level': , 'cmor_table': 'OBS6', 'frequency': 'mon', 'mip': 'Omon', 'short_name': 'thetao'}, 'cmor_check_metadata': {'check_level': , 'cmor_table': 'OBS6', 'frequency': 'mon', 'mip': 'Omon', 'short_name': 'thetao'}, 'concatenate': {}, 'fix_data': {'activity': 'CMIP', 'alias': 'OBS6', 'check_level': , 'dataset': 'PHC', 'diagnostic': 'arctic_ocean', 'ensemble': 'r1i1p1', 'exp': 'historical', 'filename': '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/thetao/OBS6_PHC_clim_3_Omon_thetao_1950-1950.nc', 'frequency': 'mon', 'long_name': 'Sea Water Potential Temperature', 'mip': 'Omon', 'modeling_realm': ['ocean'], 'original_short_name': 'thetao', 'preprocessor': 'default', 'project': 'OBS6', 'recipe_dataset_index': 1, 'short_name': 'thetao', 'standard_name': 'sea_water_potential_temperature', 'tier': 2, 'timerange': '1950/1950', 'type': 'clim', 'units': 'degC', 'variable_group': 'thetao', 'version': 3}, 'fix_file': {'activity': 'CMIP', 'alias': 'OBS6', 'dataset': 'PHC', 'diagnostic': 'arctic_ocean', 'ensemble': 'r1i1p1', 'exp': 'historical', 'filename': '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/thetao/OBS6_PHC_clim_3_Omon_thetao_1950-1950.nc', 'frequency': 'mon', 'long_name': 'Sea Water Potential Temperature', 'mip': 'Omon', 'modeling_realm': ['ocean'], 'original_short_name': 'thetao', 'output_dir': '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/thetao/OBS6_PHC_clim_3_Omon_thetao_1950-1950_fixed', 'preprocessor': 'default', 'project': 'OBS6', 'recipe_dataset_index': 1, 'short_name': 'thetao', 'standard_name': 'sea_water_potential_temperature', 'tier': 2, 'timerange': '1950/1950', 'type': 'clim', 'units': 'degC', 'variable_group': 'thetao', 'version': 3}, 'fix_metadata': {'activity': 'CMIP', 'alias': 'OBS6', 'check_level': , 'dataset': 'PHC', 'diagnostic': 'arctic_ocean', 'ensemble': 'r1i1p1', 'exp': 'historical', 'filename': '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/thetao/OBS6_PHC_clim_3_Omon_thetao_1950-1950.nc', 'frequency': 'mon', 'long_name': 'Sea Water Potential Temperature', 'mip': 'Omon', 'modeling_realm': ['ocean'], 'original_short_name': 'thetao', 'preprocessor': 'default', 'project': 'OBS6', 'recipe_dataset_index': 1, 'short_name': 'thetao', 'standard_name': 'sea_water_potential_temperature', 'tier': 2, 'timerange': '1950/1950', 'type': 'clim', 'units': 'degC', 'variable_group': 'thetao', 'version': 3}, 'load': {'callback': }, 'remove_fx_variables': {}, 'save': {'compress': False, 'filename': '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/thetao/OBS6_PHC_clim_3_Omon_thetao_1950-1950.nc'}} ancestors: None PreprocessingTask: arctic_ocean/so 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.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/so/CMIP5_CanESM2_Omon_historical_r1i1p1_so_1980-2005.nc {'add_fx_variables': {'check_level': , 'fx_variables': {}}, 'cleanup': {'remove': ['/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/so/CMIP5_CanESM2_Omon_historical_r1i1p1_so_1980-2005_fixed']}, 'clip_timerange': {'timerange': '1980/2005'}, 'cmor_check_data': {'check_level': , 'cmor_table': 'CMIP5', 'frequency': 'mon', 'mip': 'Omon', 'short_name': 'so'}, 'cmor_check_metadata': {'check_level': , 'cmor_table': 'CMIP5', 'frequency': 'mon', 'mip': 'Omon', 'short_name': 'so'}, 'concatenate': {}, 'fix_data': {'alias': 'CMIP5_r1i1p1', 'check_level': , 'dataset': 'CanESM2', 'diagnostic': 'arctic_ocean', 'ensemble': 'r1i1p1', 'exp': 'historical', 'filename': '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/so/CMIP5_CanESM2_Omon_historical_r1i1p1_so_1980-2005.nc', 'frequency': 'mon', 'institute': ['CCCma'], 'long_name': 'Sea Water Salinity', 'mip': 'Omon', 'modeling_realm': ['ocean'], 'original_short_name': 'so', 'preprocessor': 'default', 'product': ['output1', 'output2'], 'project': 'CMIP5', 'recipe_dataset_index': 0, 'short_name': 'so', 'standard_name': 'sea_water_salinity', 'timerange': '1980/2005', 'units': 'psu', 'variable_group': 'so'}, 'fix_file': {'alias': 'CMIP5_r1i1p1', 'dataset': 'CanESM2', 'diagnostic': 'arctic_ocean', 'ensemble': 'r1i1p1', 'exp': 'historical', 'filename': '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/so/CMIP5_CanESM2_Omon_historical_r1i1p1_so_1980-2005.nc', 'frequency': 'mon', 'institute': ['CCCma'], 'long_name': 'Sea Water Salinity', 'mip': 'Omon', 'modeling_realm': ['ocean'], 'original_short_name': 'so', 'output_dir': '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/so/CMIP5_CanESM2_Omon_historical_r1i1p1_so_1980-2005_fixed', 'preprocessor': 'default', 'product': ['output1', 'output2'], 'project': 'CMIP5', 'recipe_dataset_index': 0, 'short_name': 'so', 'standard_name': 'sea_water_salinity', 'timerange': '1980/2005', 'units': 'psu', 'variable_group': 'so'}, 'fix_metadata': {'alias': 'CMIP5_r1i1p1', 'check_level': , 'dataset': 'CanESM2', 'diagnostic': 'arctic_ocean', 'ensemble': 'r1i1p1', 'exp': 'historical', 'filename': '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/so/CMIP5_CanESM2_Omon_historical_r1i1p1_so_1980-2005.nc', 'frequency': 'mon', 'institute': ['CCCma'], 'long_name': 'Sea Water Salinity', 'mip': 'Omon', 'modeling_realm': ['ocean'], 'original_short_name': 'so', 'preprocessor': 'default', 'product': ['output1', 'output2'], 'project': 'CMIP5', 'recipe_dataset_index': 0, 'short_name': 'so', 'standard_name': 'sea_water_salinity', 'timerange': '1980/2005', 'units': 'psu', 'variable_group': 'so'}, 'load': {'callback': }, 'remove_fx_variables': {}, 'save': {'compress': False, 'filename': '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/so/CMIP5_CanESM2_Omon_historical_r1i1p1_so_1980-2005.nc'}} PreprocessorFile: /projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/so/OBS6_PHC_clim_3_Omon_so_1950-1950.nc {'add_fx_variables': {'check_level': , 'fx_variables': {}}, 'cleanup': {'remove': ['/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/so/OBS6_PHC_clim_3_Omon_so_1950-1950_fixed']}, 'clip_timerange': {'timerange': '1950/1950'}, 'cmor_check_data': {'check_level': , 'cmor_table': 'OBS6', 'frequency': 'mon', 'mip': 'Omon', 'short_name': 'so'}, 'cmor_check_metadata': {'check_level': , 'cmor_table': 'OBS6', 'frequency': 'mon', 'mip': 'Omon', 'short_name': 'so'}, 'concatenate': {}, 'fix_data': {'activity': 'CMIP', 'alias': 'OBS6', 'check_level': , 'dataset': 'PHC', 'diagnostic': 'arctic_ocean', 'ensemble': 'r1i1p1', 'exp': 'historical', 'filename': '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/so/OBS6_PHC_clim_3_Omon_so_1950-1950.nc', 'frequency': 'mon', 'long_name': 'Sea Water Salinity', 'mip': 'Omon', 'modeling_realm': ['ocean'], 'original_short_name': 'so', 'preprocessor': 'default', 'project': 'OBS6', 'recipe_dataset_index': 1, 'short_name': 'so', 'standard_name': 'sea_water_salinity', 'tier': 2, 'timerange': '1950/1950', 'type': 'clim', 'units': '0.001', 'variable_group': 'so', 'version': 3}, 'fix_file': {'activity': 'CMIP', 'alias': 'OBS6', 'dataset': 'PHC', 'diagnostic': 'arctic_ocean', 'ensemble': 'r1i1p1', 'exp': 'historical', 'filename': '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/so/OBS6_PHC_clim_3_Omon_so_1950-1950.nc', 'frequency': 'mon', 'long_name': 'Sea Water Salinity', 'mip': 'Omon', 'modeling_realm': ['ocean'], 'original_short_name': 'so', 'output_dir': '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/so/OBS6_PHC_clim_3_Omon_so_1950-1950_fixed', 'preprocessor': 'default', 'project': 'OBS6', 'recipe_dataset_index': 1, 'short_name': 'so', 'standard_name': 'sea_water_salinity', 'tier': 2, 'timerange': '1950/1950', 'type': 'clim', 'units': '0.001', 'variable_group': 'so', 'version': 3}, 'fix_metadata': {'activity': 'CMIP', 'alias': 'OBS6', 'check_level': , 'dataset': 'PHC', 'diagnostic': 'arctic_ocean', 'ensemble': 'r1i1p1', 'exp': 'historical', 'filename': '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/so/OBS6_PHC_clim_3_Omon_so_1950-1950.nc', 'frequency': 'mon', 'long_name': 'Sea Water Salinity', 'mip': 'Omon', 'modeling_realm': ['ocean'], 'original_short_name': 'so', 'preprocessor': 'default', 'project': 'OBS6', 'recipe_dataset_index': 1, 'short_name': 'so', 'standard_name': 'sea_water_salinity', 'tier': 2, 'timerange': '1950/1950', 'type': 'clim', 'units': '0.001', 'variable_group': 'so', 'version': 3}, 'load': {'callback': }, 'remove_fx_variables': {}, 'save': {'compress': False, 'filename': '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/so/OBS6_PHC_clim_3_Omon_so_1950-1950.nc'}} ancestors: None 2023-03-05 20:13:19,853 UTC [23486] INFO esmvalcore._task:747 Running 4 tasks using 4 processes 2023-03-05 20:13:19,902 UTC [23621] INFO esmvalcore._task:260 Starting task arctic_ocean/areacello in process [23621] 2023-03-05 20:13:19,905 UTC [23622] INFO esmvalcore._task:260 Starting task arctic_ocean/thetao in process [23622] 2023-03-05 20:13:19,905 UTC [23623] INFO esmvalcore._task:260 Starting task arctic_ocean/so in process [23623] 2023-03-05 20:13:19,909 UTC [23621] DEBUG esmvalcore.preprocessor:600 Running block ['fix_metadata', 'concatenate', 'cmor_check_metadata', 'fix_data', 'cmor_check_data', 'add_fx_variables', 'remove_fx_variables'] 2023-03-05 20:13:19,909 UTC [23621] DEBUG esmvalcore.preprocessor:607 Applying single-model steps to PreprocessorFile: /projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/areacello/CMIP5_CanESM2_fx_historical_r0i0p0_areacello.nc 2023-03-05 20:13:19,911 UTC [23621] DEBUG esmvalcore.preprocessor:347 Running preprocessor step fix_file 2023-03-05 20:13:19,912 UTC [23621] DEBUG esmvalcore.preprocessor:308 Running preprocessor function 'fix_file' on the data '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/fx/ocean/fx/r0i0p0/latest/areacello/areacello_fx_CanESM2_historical_r0i0p0.nc' with function argument(s) project = 'CMIP5', mip = 'fx', exp = 'historical', ensemble = 'r0i0p0', variable_group = 'areacello', short_name = 'areacello', diagnostic = 'arctic_ocean', preprocessor = 'default', dataset = 'CanESM2', recipe_dataset_index = 0, institute = ['CCCma'], product = ['output1', 'output2'], alias = 'CMIP5_r0i0p0', original_short_name = 'areacello', standard_name = 'cell_area', long_name = 'Ocean Grid-Cell Area', units = 'm2', modeling_realm = ['ocean'], frequency = 'fx', filename = '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/areacello/CMIP5_CanESM2_fx_historical_r0i0p0_areacello.nc', output_dir = '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/areacello/CMIP5_CanESM2_fx_historical_r0i0p0_areacello_fixed' 2023-03-05 20:13:19,916 UTC [23621] DEBUG esmvalcore.preprocessor:347 Running preprocessor step load 2023-03-05 20:13:19,916 UTC [23621] DEBUG esmvalcore.preprocessor:308 Running preprocessor function 'load' on the data '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/fx/ocean/fx/r0i0p0/latest/areacello/areacello_fx_CanESM2_historical_r0i0p0.nc' with function argument(s) callback = 2023-03-05 20:13:19,916 UTC [23621] DEBUG esmvalcore.preprocessor._io:138 Loading: /projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/fx/ocean/fx/r0i0p0/latest/areacello/areacello_fx_CanESM2_historical_r0i0p0.nc 2023-03-05 20:13:19,927 UTC [23623] DEBUG esmvalcore.preprocessor:600 Running block ['fix_metadata', 'concatenate', 'cmor_check_metadata', 'clip_timerange', 'fix_data', 'cmor_check_data', 'add_fx_variables', 'remove_fx_variables'] 2023-03-05 20:13:19,927 UTC [23623] DEBUG esmvalcore.preprocessor:607 Applying single-model steps to PreprocessorFile: /projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/so/OBS6_PHC_clim_3_Omon_so_1950-1950.nc 2023-03-05 20:13:19,929 UTC [23623] DEBUG esmvalcore.preprocessor:347 Running preprocessor step fix_file 2023-03-05 20:13:19,930 UTC [23623] DEBUG esmvalcore.preprocessor:308 Running preprocessor function 'fix_file' on the data '/projects/NS9252K/ESGF_betzy/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_so_195001-195012.nc' with function argument(s) mip = 'Omon', project = 'OBS6', exp = 'historical', ensemble = 'r1i1p1', variable_group = 'so', short_name = 'so', diagnostic = 'arctic_ocean', preprocessor = 'default', dataset = 'PHC', tier = 2, type = 'clim', version = 3, recipe_dataset_index = 1, timerange = '1950/1950', activity = 'CMIP', alias = 'OBS6', original_short_name = 'so', standard_name = 'sea_water_salinity', long_name = 'Sea Water Salinity', units = '0.001', modeling_realm = ['ocean'], frequency = 'mon', filename = '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/so/OBS6_PHC_clim_3_Omon_so_1950-1950.nc', output_dir = '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/so/OBS6_PHC_clim_3_Omon_so_1950-1950_fixed' 2023-03-05 20:13:19,931 UTC [23623] DEBUG esmvalcore.preprocessor:308 Running preprocessor function 'fix_file' on the data '/projects/NS9252K/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_so_195001-195012.nc' with function argument(s) mip = 'Omon', project = 'OBS6', exp = 'historical', ensemble = 'r1i1p1', variable_group = 'so', short_name = 'so', diagnostic = 'arctic_ocean', preprocessor = 'default', dataset = 'PHC', tier = 2, type = 'clim', version = 3, recipe_dataset_index = 1, timerange = '1950/1950', activity = 'CMIP', alias = 'OBS6', original_short_name = 'so', standard_name = 'sea_water_salinity', long_name = 'Sea Water Salinity', units = '0.001', modeling_realm = ['ocean'], frequency = 'mon', filename = '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/so/OBS6_PHC_clim_3_Omon_so_1950-1950.nc', output_dir = '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/so/OBS6_PHC_clim_3_Omon_so_1950-1950_fixed' 2023-03-05 20:13:19,932 UTC [23623] DEBUG esmvalcore.preprocessor:347 Running preprocessor step load 2023-03-05 20:13:19,932 UTC [23623] DEBUG esmvalcore.preprocessor:308 Running preprocessor function 'load' on the data '/projects/NS9252K/ESGF_betzy/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_so_195001-195012.nc' with function argument(s) callback = 2023-03-05 20:13:19,932 UTC [23623] DEBUG esmvalcore.preprocessor._io:138 Loading: /projects/NS9252K/ESGF_betzy/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_so_195001-195012.nc 2023-03-05 20:13:19,932 UTC [23622] DEBUG esmvalcore.preprocessor:600 Running block ['fix_metadata', 'concatenate', 'cmor_check_metadata', 'clip_timerange', 'fix_data', 'cmor_check_data', 'add_fx_variables', 'remove_fx_variables'] 2023-03-05 20:13:19,932 UTC [23622] DEBUG esmvalcore.preprocessor:607 Applying single-model steps to PreprocessorFile: /projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/thetao/OBS6_PHC_clim_3_Omon_thetao_1950-1950.nc 2023-03-05 20:13:19,934 UTC [23622] DEBUG esmvalcore.preprocessor:347 Running preprocessor step fix_file 2023-03-05 20:13:19,935 UTC [23622] DEBUG esmvalcore.preprocessor:308 Running preprocessor function 'fix_file' on the data '/projects/NS9252K/ESGF_betzy/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_thetao_195001-195012.nc' with function argument(s) mip = 'Omon', project = 'OBS6', exp = 'historical', ensemble = 'r1i1p1', variable_group = 'thetao', short_name = 'thetao', diagnostic = 'arctic_ocean', preprocessor = 'default', dataset = 'PHC', tier = 2, type = 'clim', version = 3, recipe_dataset_index = 1, timerange = '1950/1950', activity = 'CMIP', alias = 'OBS6', original_short_name = 'thetao', standard_name = 'sea_water_potential_temperature', long_name = 'Sea Water Potential Temperature', units = 'degC', modeling_realm = ['ocean'], frequency = 'mon', filename = '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/thetao/OBS6_PHC_clim_3_Omon_thetao_1950-1950.nc', output_dir = '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/thetao/OBS6_PHC_clim_3_Omon_thetao_1950-1950_fixed' 2023-03-05 20:13:19,937 UTC [23622] DEBUG esmvalcore.preprocessor:308 Running preprocessor function 'fix_file' on the data '/projects/NS9252K/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_thetao_195001-195012.nc' with function argument(s) mip = 'Omon', project = 'OBS6', exp = 'historical', ensemble = 'r1i1p1', variable_group = 'thetao', short_name = 'thetao', diagnostic = 'arctic_ocean', preprocessor = 'default', dataset = 'PHC', tier = 2, type = 'clim', version = 3, recipe_dataset_index = 1, timerange = '1950/1950', activity = 'CMIP', alias = 'OBS6', original_short_name = 'thetao', standard_name = 'sea_water_potential_temperature', long_name = 'Sea Water Potential Temperature', units = 'degC', modeling_realm = ['ocean'], frequency = 'mon', filename = '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/thetao/OBS6_PHC_clim_3_Omon_thetao_1950-1950.nc', output_dir = '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/thetao/OBS6_PHC_clim_3_Omon_thetao_1950-1950_fixed' 2023-03-05 20:13:19,937 UTC [23622] DEBUG esmvalcore.preprocessor:347 Running preprocessor step load 2023-03-05 20:13:19,938 UTC [23622] DEBUG esmvalcore.preprocessor:308 Running preprocessor function 'load' on the data '/projects/NS9252K/ESGF_betzy/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_thetao_195001-195012.nc' with function argument(s) callback = 2023-03-05 20:13:19,938 UTC [23622] DEBUG esmvalcore.preprocessor._io:138 Loading: /projects/NS9252K/ESGF_betzy/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_thetao_195001-195012.nc 2023-03-05 20:13:19,973 UTC [23621] DEBUG esmvalcore.preprocessor._io:168 Done with loading /projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/fx/ocean/fx/r0i0p0/latest/areacello/areacello_fx_CanESM2_historical_r0i0p0.nc 2023-03-05 20:13:19,973 UTC [23621] DEBUG esmvalcore.preprocessor:347 Running preprocessor step fix_metadata 2023-03-05 20:13:19,976 UTC [23621] DEBUG esmvalcore.preprocessor:308 Running preprocessor function 'fix_metadata' on the data [] loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/fx/ocean/fx/r0i0p0/latest/areacello/areacello_fx_CanESM2_historical_r0i0p0.nc'] with function argument(s) project = 'CMIP5', mip = 'fx', exp = 'historical', ensemble = 'r0i0p0', variable_group = 'areacello', short_name = 'areacello', diagnostic = 'arctic_ocean', preprocessor = 'default', dataset = 'CanESM2', recipe_dataset_index = 0, institute = ['CCCma'], product = ['output1', 'output2'], alias = 'CMIP5_r0i0p0', original_short_name = 'areacello', standard_name = 'cell_area', long_name = 'Ocean Grid-Cell Area', units = 'm2', modeling_realm = ['ocean'], frequency = 'fx', filename = '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/areacello/CMIP5_CanESM2_fx_historical_r0i0p0_areacello.nc', check_level = 2023-03-05 20:13:19,977 UTC [23621] DEBUG esmvalcore.preprocessor:347 Running preprocessor step concatenate 2023-03-05 20:13:19,978 UTC [23621] DEBUG esmvalcore.preprocessor:308 Running preprocessor function 'concatenate' on the data [] loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/fx/ocean/fx/r0i0p0/latest/areacello/areacello_fx_CanESM2_historical_r0i0p0.nc'] with function argument(s) 2023-03-05 20:13:19,978 UTC [23621] DEBUG esmvalcore.preprocessor:347 Running preprocessor step cmor_check_metadata 2023-03-05 20:13:19,979 UTC [23621] DEBUG esmvalcore.preprocessor:308 Running preprocessor function 'cmor_check_metadata' on the data loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/fx/ocean/fx/r0i0p0/latest/areacello/areacello_fx_CanESM2_historical_r0i0p0.nc'] with function argument(s) cmor_table = 'CMIP5', mip = 'fx', short_name = 'areacello', frequency = 'fx', check_level = 2023-03-05 20:13:19,979 UTC [23621] DEBUG esmvalcore.preprocessor:347 Running preprocessor step fix_data 2023-03-05 20:13:19,980 UTC [23621] DEBUG esmvalcore.preprocessor:308 Running preprocessor function 'fix_data' on the data loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/fx/ocean/fx/r0i0p0/latest/areacello/areacello_fx_CanESM2_historical_r0i0p0.nc'] with function argument(s) project = 'CMIP5', mip = 'fx', exp = 'historical', ensemble = 'r0i0p0', variable_group = 'areacello', short_name = 'areacello', diagnostic = 'arctic_ocean', preprocessor = 'default', dataset = 'CanESM2', recipe_dataset_index = 0, institute = ['CCCma'], product = ['output1', 'output2'], alias = 'CMIP5_r0i0p0', original_short_name = 'areacello', standard_name = 'cell_area', long_name = 'Ocean Grid-Cell Area', units = 'm2', modeling_realm = ['ocean'], frequency = 'fx', filename = '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/areacello/CMIP5_CanESM2_fx_historical_r0i0p0_areacello.nc', check_level = 2023-03-05 20:13:19,980 UTC [23621] DEBUG esmvalcore.preprocessor:347 Running preprocessor step cmor_check_data 2023-03-05 20:13:19,981 UTC [23621] DEBUG esmvalcore.preprocessor:308 Running preprocessor function 'cmor_check_data' on the data loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/fx/ocean/fx/r0i0p0/latest/areacello/areacello_fx_CanESM2_historical_r0i0p0.nc'] with function argument(s) cmor_table = 'CMIP5', mip = 'fx', short_name = 'areacello', frequency = 'fx', check_level = 2023-03-05 20:13:19,981 UTC [23621] DEBUG esmvalcore.preprocessor:347 Running preprocessor step add_fx_variables 2023-03-05 20:13:19,982 UTC [23621] DEBUG esmvalcore.preprocessor:308 Running preprocessor function 'add_fx_variables' on the data loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/fx/ocean/fx/r0i0p0/latest/areacello/areacello_fx_CanESM2_historical_r0i0p0.nc'] with function argument(s) fx_variables = {}, check_level = 2023-03-05 20:13:19,982 UTC [23621] DEBUG esmvalcore.preprocessor:347 Running preprocessor step remove_fx_variables 2023-03-05 20:13:19,983 UTC [23621] DEBUG esmvalcore.preprocessor:308 Running preprocessor function 'remove_fx_variables' on the data loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/fx/ocean/fx/r0i0p0/latest/areacello/areacello_fx_CanESM2_historical_r0i0p0.nc'] with function argument(s) 2023-03-05 20:13:19,983 UTC [23621] DEBUG esmvalcore.preprocessor:347 Running preprocessor step save 2023-03-05 20:13:19,983 UTC [23621] DEBUG esmvalcore.preprocessor:308 Running preprocessor function 'save' on the data [] loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/fx/ocean/fx/r0i0p0/latest/areacello/areacello_fx_CanESM2_historical_r0i0p0.nc'] with function argument(s) compress = False, filename = '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/areacello/CMIP5_CanESM2_fx_historical_r0i0p0_areacello.nc' 2023-03-05 20:13:19,995 UTC [23486] INFO esmvalcore._task:779 Progress: 3 tasks running, 1 tasks waiting for ancestors, 0/4 done 2023-03-05 20:13:20,000 UTC [23623] DEBUG esmvalcore.preprocessor._io:168 Done with loading /projects/NS9252K/ESGF_betzy/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_so_195001-195012.nc 2023-03-05 20:13:20,000 UTC [23623] DEBUG esmvalcore.preprocessor:308 Running preprocessor function 'load' on the data '/projects/NS9252K/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_so_195001-195012.nc' with function argument(s) callback = 2023-03-05 20:13:20,000 UTC [23623] DEBUG esmvalcore.preprocessor._io:138 Loading: /projects/NS9252K/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_so_195001-195012.nc 2023-03-05 20:13:20,012 UTC [23623] DEBUG esmvalcore.preprocessor._io:168 Done with loading /projects/NS9252K/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_so_195001-195012.nc 2023-03-05 20:13:20,013 UTC [23623] DEBUG esmvalcore.preprocessor:347 Running preprocessor step fix_metadata 2023-03-05 20:13:20,016 UTC [23622] DEBUG esmvalcore.preprocessor._io:168 Done with loading /projects/NS9252K/ESGF_betzy/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_thetao_195001-195012.nc 2023-03-05 20:13:20,017 UTC [23623] DEBUG esmvalcore.preprocessor:308 Running preprocessor function 'fix_metadata' on the data [, ] loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_so_195001-195012.nc', '/projects/NS9252K/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_so_195001-195012.nc'] with function argument(s) mip = 'Omon', project = 'OBS6', exp = 'historical', ensemble = 'r1i1p1', variable_group = 'so', short_name = 'so', diagnostic = 'arctic_ocean', preprocessor = 'default', dataset = 'PHC', tier = 2, type = 'clim', version = 3, recipe_dataset_index = 1, timerange = '1950/1950', activity = 'CMIP', alias = 'OBS6', original_short_name = 'so', standard_name = 'sea_water_salinity', long_name = 'Sea Water Salinity', units = '0.001', modeling_realm = ['ocean'], frequency = 'mon', filename = '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/so/OBS6_PHC_clim_3_Omon_so_1950-1950.nc', check_level = 2023-03-05 20:13:20,017 UTC [23622] DEBUG esmvalcore.preprocessor:308 Running preprocessor function 'load' on the data '/projects/NS9252K/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_thetao_195001-195012.nc' with function argument(s) callback = 2023-03-05 20:13:20,017 UTC [23622] DEBUG esmvalcore.preprocessor._io:138 Loading: /projects/NS9252K/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_thetao_195001-195012.nc 2023-03-05 20:13:20,019 UTC [23623] DEBUG esmvalcore.cmor.check:279 There were metadata changes in variable so: Generic level coordinate olevel will be checked against depth_coord coordinate information loaded from file /projects/NS9252K/ESGF_betzy/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_so_195001-195012.nc 2023-03-05 20:13:20,019 UTC [23623] WARNING esmvalcore.cmor.check:261 There were warnings in variable so: Added guessed bounds to coordinate lon from var lon Coordinate lev units meters converted to m Added guessed bounds to coordinate time from var so loaded from file /projects/NS9252K/ESGF_betzy/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_so_195001-195012.nc 2023-03-05 20:13:20,021 UTC [23623] DEBUG esmvalcore.cmor.check:279 There were metadata changes in variable so: Generic level coordinate olevel will be checked against depth_coord coordinate information loaded from file /projects/NS9252K/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_so_195001-195012.nc 2023-03-05 20:13:20,021 UTC [23623] WARNING esmvalcore.cmor.check:261 There were warnings in variable so: Added guessed bounds to coordinate lon from var lon Coordinate lev units meters converted to m Added guessed bounds to coordinate time from var so loaded from file /projects/NS9252K/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_so_195001-195012.nc 2023-03-05 20:13:20,021 UTC [23623] DEBUG esmvalcore.preprocessor:347 Running preprocessor step concatenate 2023-03-05 20:13:20,023 UTC [23623] DEBUG esmvalcore.preprocessor:308 Running preprocessor function 'concatenate' on the data [, ] loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_so_195001-195012.nc', '/projects/NS9252K/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_so_195001-195012.nc'] with function argument(s) 2023-03-05 20:13:20,026 UTC [23623] DEBUG esmvalcore.preprocessor._io:431 Will attempt to concatenate cubes sea_water_salinity / (0.001) (time: 1; depth: 33; latitude: 180; longitude: 360) Dimension coordinates: time x - - - depth - x - - latitude - - x - longitude - - - x Attributes: Conventions 'CF-1.7' frequency 'yr' host 'ipcc' mip 'Omon' modeling_realm 'clim' project_id 'OBS6' reference 'doi:10.1175/1520-0442(2001)014<2079:pagohw>2.0.co;2' source 'http://psc.apl.washington.edu/nonwp_projects/PHC/Data3.html' tier '2' title 'PHC data reformatted for ESMValTool v2.1.1' user 'tomast' version '3' and sea_water_salinity / (0.001) (time: 1; depth: 33; latitude: 180; longitude: 360) Dimension coordinates: time x - - - depth - x - - latitude - - x - longitude - - - x Attributes: Conventions 'CF-1.7' frequency 'yr' host 'ipcc' mip 'Omon' modeling_realm 'clim' project_id 'OBS6' reference 'doi:10.1175/1520-0442(2001)014<2079:pagohw>2.0.co;2' source 'http://psc.apl.washington.edu/nonwp_projects/PHC/Data3.html' tier '2' title 'PHC data reformatted for ESMValTool v2.1.1' user 'tomast' version '3' in this order 2023-03-05 20:13:20,029 UTC [23623] DEBUG esmvalcore.preprocessor._io:456 Both cubes start at the same time but cube sea_water_salinity / (0.001) (time: 1; depth: 33; latitude: 180; longitude: 360) Dimension coordinates: time x - - - depth - x - - latitude - - x - longitude - - - x Attributes: Conventions 'CF-1.7' frequency 'yr' host 'ipcc' mip 'Omon' modeling_realm 'clim' project_id 'OBS6' reference 'doi:10.1175/1520-0442(2001)014<2079:pagohw>2.0.co;2' source 'http://psc.apl.washington.edu/nonwp_projects/PHC/Data3.html' tier '2' title 'PHC data reformatted for ESMValTool v2.1.1' user 'tomast' version '3' ends before sea_water_salinity / (0.001) (time: 1; depth: 33; latitude: 180; longitude: 360) Dimension coordinates: time x - - - depth - x - - latitude - - x - longitude - - - x Attributes: Conventions 'CF-1.7' frequency 'yr' host 'ipcc' mip 'Omon' modeling_realm 'clim' project_id 'OBS6' reference 'doi:10.1175/1520-0442(2001)014<2079:pagohw>2.0.co;2' source 'http://psc.apl.washington.edu/nonwp_projects/PHC/Data3.html' tier '2' title 'PHC data reformatted for ESMValTool v2.1.1' user 'tomast' version '3' 2023-03-05 20:13:20,031 UTC [23621] DEBUG esmvalcore.preprocessor._io:308 Saving cubes [] to /projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/areacello/CMIP5_CanESM2_fx_historical_r0i0p0_areacello.nc 2023-03-05 20:13:20,032 UTC [23622] DEBUG esmvalcore.preprocessor._io:168 Done with loading /projects/NS9252K/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_thetao_195001-195012.nc 2023-03-05 20:13:20,031 UTC [23623] DEBUG esmvalcore.preprocessor._io:459 Cube sea_water_salinity / (0.001) (time: 1; depth: 33; latitude: 180; longitude: 360) Dimension coordinates: time x - - - depth - x - - latitude - - x - longitude - - - x Attributes: Conventions 'CF-1.7' frequency 'yr' host 'ipcc' mip 'Omon' modeling_realm 'clim' project_id 'OBS6' reference 'doi:10.1175/1520-0442(2001)014<2079:pagohw>2.0.co;2' source 'http://psc.apl.washington.edu/nonwp_projects/PHC/Data3.html' tier '2' title 'PHC data reformatted for ESMValTool v2.1.1' user 'tomast' version '3' contains all needed data so using it fully 2023-03-05 20:13:20,032 UTC [23622] DEBUG esmvalcore.preprocessor:347 Running preprocessor step fix_metadata 2023-03-05 20:13:20,032 UTC [23623] DEBUG esmvalcore.preprocessor:347 Running preprocessor step cmor_check_metadata 2023-03-05 20:13:20,033 UTC [23623] DEBUG esmvalcore.preprocessor:308 Running preprocessor function 'cmor_check_metadata' on the data loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_so_195001-195012.nc', '/projects/NS9252K/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_so_195001-195012.nc'] with function argument(s) cmor_table = 'OBS6', mip = 'Omon', short_name = 'so', frequency = 'mon', check_level = 2023-03-05 20:13:20,034 UTC [23623] DEBUG esmvalcore.cmor.check:279 There were metadata changes in variable so: Generic level coordinate olevel will be checked against depth_coord coordinate information loaded from file 2023-03-05 20:13:20,034 UTC [23623] DEBUG esmvalcore.preprocessor:347 Running preprocessor step clip_timerange 2023-03-05 20:13:20,034 UTC [23623] DEBUG esmvalcore.preprocessor:308 Running preprocessor function 'clip_timerange' on the data loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_so_195001-195012.nc', '/projects/NS9252K/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_so_195001-195012.nc'] with function argument(s) timerange = '1950/1950' 2023-03-05 20:13:20,037 UTC [23622] DEBUG esmvalcore.preprocessor:308 Running preprocessor function 'fix_metadata' on the data [, ] loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_thetao_195001-195012.nc', '/projects/NS9252K/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_thetao_195001-195012.nc'] with function argument(s) mip = 'Omon', project = 'OBS6', exp = 'historical', ensemble = 'r1i1p1', variable_group = 'thetao', short_name = 'thetao', diagnostic = 'arctic_ocean', preprocessor = 'default', dataset = 'PHC', tier = 2, type = 'clim', version = 3, recipe_dataset_index = 1, timerange = '1950/1950', activity = 'CMIP', alias = 'OBS6', original_short_name = 'thetao', standard_name = 'sea_water_potential_temperature', long_name = 'Sea Water Potential Temperature', units = 'degC', modeling_realm = ['ocean'], frequency = 'mon', filename = '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/thetao/OBS6_PHC_clim_3_Omon_thetao_1950-1950.nc', check_level = 2023-03-05 20:13:20,037 UTC [23623] DEBUG esmvalcore.preprocessor:347 Running preprocessor step fix_data 2023-03-05 20:13:20,038 UTC [23623] DEBUG esmvalcore.preprocessor:308 Running preprocessor function 'fix_data' on the data loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_so_195001-195012.nc', '/projects/NS9252K/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_so_195001-195012.nc'] with function argument(s) mip = 'Omon', project = 'OBS6', exp = 'historical', ensemble = 'r1i1p1', variable_group = 'so', short_name = 'so', diagnostic = 'arctic_ocean', preprocessor = 'default', dataset = 'PHC', tier = 2, type = 'clim', version = 3, recipe_dataset_index = 1, timerange = '1950/1950', activity = 'CMIP', alias = 'OBS6', original_short_name = 'so', standard_name = 'sea_water_salinity', long_name = 'Sea Water Salinity', units = '0.001', modeling_realm = ['ocean'], frequency = 'mon', filename = '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/so/OBS6_PHC_clim_3_Omon_so_1950-1950.nc', check_level = 2023-03-05 20:13:20,038 UTC [23623] DEBUG esmvalcore.preprocessor:347 Running preprocessor step cmor_check_data 2023-03-05 20:13:20,039 UTC [23623] DEBUG esmvalcore.preprocessor:308 Running preprocessor function 'cmor_check_data' on the data loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_so_195001-195012.nc', '/projects/NS9252K/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_so_195001-195012.nc'] with function argument(s) cmor_table = 'OBS6', mip = 'Omon', short_name = 'so', frequency = 'mon', check_level = 2023-03-05 20:13:20,039 UTC [23623] DEBUG esmvalcore.preprocessor:347 Running preprocessor step add_fx_variables 2023-03-05 20:13:20,040 UTC [23623] DEBUG esmvalcore.preprocessor:308 Running preprocessor function 'add_fx_variables' on the data loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_so_195001-195012.nc', '/projects/NS9252K/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_so_195001-195012.nc'] with function argument(s) fx_variables = {}, check_level = 2023-03-05 20:13:20,040 UTC [23623] DEBUG esmvalcore.preprocessor:347 Running preprocessor step remove_fx_variables 2023-03-05 20:13:20,040 UTC [23622] DEBUG esmvalcore.cmor.check:279 There were metadata changes in variable thetao: Generic level coordinate olevel will be checked against depth_coord coordinate information loaded from file /projects/NS9252K/ESGF_betzy/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_thetao_195001-195012.nc 2023-03-05 20:13:20,040 UTC [23622] WARNING esmvalcore.cmor.check:261 There were warnings in variable thetao: Added guessed bounds to coordinate lon from var lon Coordinate lev units meters converted to m Added guessed bounds to coordinate time from var thetao loaded from file /projects/NS9252K/ESGF_betzy/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_thetao_195001-195012.nc 2023-03-05 20:13:20,040 UTC [23623] DEBUG esmvalcore.preprocessor:308 Running preprocessor function 'remove_fx_variables' on the data loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_so_195001-195012.nc', '/projects/NS9252K/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_so_195001-195012.nc'] with function argument(s) 2023-03-05 20:13:20,041 UTC [23623] DEBUG esmvalcore.preprocessor:347 Running preprocessor step save 2023-03-05 20:13:20,042 UTC [23623] DEBUG esmvalcore.preprocessor:308 Running preprocessor function 'save' on the data [] loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_so_195001-195012.nc', '/projects/NS9252K/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_so_195001-195012.nc'] with function argument(s) compress = False, filename = '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/so/OBS6_PHC_clim_3_Omon_so_1950-1950.nc' 2023-03-05 20:13:20,042 UTC [23622] DEBUG esmvalcore.cmor.check:279 There were metadata changes in variable thetao: Generic level coordinate olevel will be checked against depth_coord coordinate information loaded from file /projects/NS9252K/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_thetao_195001-195012.nc 2023-03-05 20:13:20,042 UTC [23622] WARNING esmvalcore.cmor.check:261 There were warnings in variable thetao: Added guessed bounds to coordinate lon from var lon Coordinate lev units meters converted to m Added guessed bounds to coordinate time from var thetao loaded from file /projects/NS9252K/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_thetao_195001-195012.nc 2023-03-05 20:13:20,042 UTC [23622] DEBUG esmvalcore.preprocessor:347 Running preprocessor step concatenate 2023-03-05 20:13:20,045 UTC [23622] DEBUG esmvalcore.preprocessor:308 Running preprocessor function 'concatenate' on the data [, ] loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_thetao_195001-195012.nc', '/projects/NS9252K/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_thetao_195001-195012.nc'] with function argument(s) 2023-03-05 20:13:20,049 UTC [23622] DEBUG esmvalcore.preprocessor._io:431 Will attempt to concatenate cubes sea_water_potential_temperature / (degC) (time: 1; depth: 33; latitude: 180; longitude: 360) Dimension coordinates: time x - - - depth - x - - latitude - - x - longitude - - - x Attributes: Conventions 'CF-1.7' frequency 'yr' host 'ipcc' mip 'Omon' modeling_realm 'clim' project_id 'OBS6' reference 'doi:10.1175/1520-0442(2001)014<2079:pagohw>2.0.co;2' source 'http://psc.apl.washington.edu/nonwp_projects/PHC/Data3.html' tier '2' title 'PHC data reformatted for ESMValTool v2.1.1' user 'tomast' version '3' and sea_water_potential_temperature / (degC) (time: 1; depth: 33; latitude: 180; longitude: 360) Dimension coordinates: time x - - - depth - x - - latitude - - x - longitude - - - x Attributes: Conventions 'CF-1.7' frequency 'yr' host 'ipcc' mip 'Omon' modeling_realm 'clim' project_id 'OBS6' reference 'doi:10.1175/1520-0442(2001)014<2079:pagohw>2.0.co;2' source 'http://psc.apl.washington.edu/nonwp_projects/PHC/Data3.html' tier '2' title 'PHC data reformatted for ESMValTool v2.1.1' user 'tomast' version '3' in this order 2023-03-05 20:13:20,053 UTC [23622] DEBUG esmvalcore.preprocessor._io:456 Both cubes start at the same time but cube sea_water_potential_temperature / (degC) (time: 1; depth: 33; latitude: 180; longitude: 360) Dimension coordinates: time x - - - depth - x - - latitude - - x - longitude - - - x Attributes: Conventions 'CF-1.7' frequency 'yr' host 'ipcc' mip 'Omon' modeling_realm 'clim' project_id 'OBS6' reference 'doi:10.1175/1520-0442(2001)014<2079:pagohw>2.0.co;2' source 'http://psc.apl.washington.edu/nonwp_projects/PHC/Data3.html' tier '2' title 'PHC data reformatted for ESMValTool v2.1.1' user 'tomast' version '3' ends before sea_water_potential_temperature / (degC) (time: 1; depth: 33; latitude: 180; longitude: 360) Dimension coordinates: time x - - - depth - x - - latitude - - x - longitude - - - x Attributes: Conventions 'CF-1.7' frequency 'yr' host 'ipcc' mip 'Omon' modeling_realm 'clim' project_id 'OBS6' reference 'doi:10.1175/1520-0442(2001)014<2079:pagohw>2.0.co;2' source 'http://psc.apl.washington.edu/nonwp_projects/PHC/Data3.html' tier '2' title 'PHC data reformatted for ESMValTool v2.1.1' user 'tomast' version '3' 2023-03-05 20:13:20,055 UTC [23622] DEBUG esmvalcore.preprocessor._io:459 Cube sea_water_potential_temperature / (degC) (time: 1; depth: 33; latitude: 180; longitude: 360) Dimension coordinates: time x - - - depth - x - - latitude - - x - longitude - - - x Attributes: Conventions 'CF-1.7' frequency 'yr' host 'ipcc' mip 'Omon' modeling_realm 'clim' project_id 'OBS6' reference 'doi:10.1175/1520-0442(2001)014<2079:pagohw>2.0.co;2' source 'http://psc.apl.washington.edu/nonwp_projects/PHC/Data3.html' tier '2' title 'PHC data reformatted for ESMValTool v2.1.1' user 'tomast' version '3' contains all needed data so using it fully 2023-03-05 20:13:20,057 UTC [23622] DEBUG esmvalcore.preprocessor:347 Running preprocessor step cmor_check_metadata 2023-03-05 20:13:20,057 UTC [23622] DEBUG esmvalcore.preprocessor:308 Running preprocessor function 'cmor_check_metadata' on the data loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_thetao_195001-195012.nc', '/projects/NS9252K/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_thetao_195001-195012.nc'] with function argument(s) cmor_table = 'OBS6', mip = 'Omon', short_name = 'thetao', frequency = 'mon', check_level = 2023-03-05 20:13:20,057 UTC [23623] DEBUG esmvalcore.preprocessor._io:308 Saving cubes [] to /projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/so/OBS6_PHC_clim_3_Omon_so_1950-1950.nc 2023-03-05 20:13:20,058 UTC [23622] DEBUG esmvalcore.cmor.check:279 There were metadata changes in variable thetao: Generic level coordinate olevel will be checked against depth_coord coordinate information loaded from file 2023-03-05 20:13:20,058 UTC [23622] DEBUG esmvalcore.preprocessor:347 Running preprocessor step clip_timerange 2023-03-05 20:13:20,059 UTC [23622] DEBUG esmvalcore.preprocessor:308 Running preprocessor function 'clip_timerange' on the data loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_thetao_195001-195012.nc', '/projects/NS9252K/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_thetao_195001-195012.nc'] with function argument(s) timerange = '1950/1950' 2023-03-05 20:13:20,063 UTC [23622] DEBUG esmvalcore.preprocessor:347 Running preprocessor step fix_data 2023-03-05 20:13:20,064 UTC [23622] DEBUG esmvalcore.preprocessor:308 Running preprocessor function 'fix_data' on the data loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_thetao_195001-195012.nc', '/projects/NS9252K/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_thetao_195001-195012.nc'] with function argument(s) mip = 'Omon', project = 'OBS6', exp = 'historical', ensemble = 'r1i1p1', variable_group = 'thetao', short_name = 'thetao', diagnostic = 'arctic_ocean', preprocessor = 'default', dataset = 'PHC', tier = 2, type = 'clim', version = 3, recipe_dataset_index = 1, timerange = '1950/1950', activity = 'CMIP', alias = 'OBS6', original_short_name = 'thetao', standard_name = 'sea_water_potential_temperature', long_name = 'Sea Water Potential Temperature', units = 'degC', modeling_realm = ['ocean'], frequency = 'mon', filename = '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/thetao/OBS6_PHC_clim_3_Omon_thetao_1950-1950.nc', check_level = 2023-03-05 20:13:20,064 UTC [23622] DEBUG esmvalcore.preprocessor:347 Running preprocessor step cmor_check_data 2023-03-05 20:13:20,065 UTC [23622] DEBUG esmvalcore.preprocessor:308 Running preprocessor function 'cmor_check_data' on the data loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_thetao_195001-195012.nc', '/projects/NS9252K/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_thetao_195001-195012.nc'] with function argument(s) cmor_table = 'OBS6', mip = 'Omon', short_name = 'thetao', frequency = 'mon', check_level = 2023-03-05 20:13:20,065 UTC [23622] DEBUG esmvalcore.preprocessor:347 Running preprocessor step add_fx_variables 2023-03-05 20:13:20,066 UTC [23622] DEBUG esmvalcore.preprocessor:308 Running preprocessor function 'add_fx_variables' on the data loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_thetao_195001-195012.nc', '/projects/NS9252K/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_thetao_195001-195012.nc'] with function argument(s) fx_variables = {}, check_level = 2023-03-05 20:13:20,066 UTC [23622] DEBUG esmvalcore.preprocessor:347 Running preprocessor step remove_fx_variables 2023-03-05 20:13:20,067 UTC [23622] DEBUG esmvalcore.preprocessor:308 Running preprocessor function 'remove_fx_variables' on the data loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_thetao_195001-195012.nc', '/projects/NS9252K/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_thetao_195001-195012.nc'] with function argument(s) 2023-03-05 20:13:20,067 UTC [23622] DEBUG esmvalcore.preprocessor:347 Running preprocessor step save 2023-03-05 20:13:20,068 UTC [23622] DEBUG esmvalcore.preprocessor:308 Running preprocessor function 'save' on the data [] loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_thetao_195001-195012.nc', '/projects/NS9252K/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_thetao_195001-195012.nc'] with function argument(s) compress = False, filename = '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/thetao/OBS6_PHC_clim_3_Omon_thetao_1950-1950.nc' 2023-03-05 20:13:20,084 UTC [23622] DEBUG esmvalcore.preprocessor._io:308 Saving cubes [] to /projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/thetao/OBS6_PHC_clim_3_Omon_thetao_1950-1950.nc 2023-03-05 20:13:20,085 UTC [23621] DEBUG esmvalcore.preprocessor:347 Running preprocessor step cleanup 2023-03-05 20:13:20,085 UTC [23621] DEBUG esmvalcore.preprocessor:308 Running preprocessor function 'cleanup' on the data ['/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/areacello/CMIP5_CanESM2_fx_historical_r0i0p0_areacello.nc'] loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/fx/ocean/fx/r0i0p0/latest/areacello/areacello_fx_CanESM2_historical_r0i0p0.nc'] with function argument(s) remove = ['/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/areacello/CMIP5_CanESM2_fx_historical_r0i0p0_areacello_fixed'] 2023-03-05 20:13:20,221 UTC [23621] INFO esmvalcore._task:265 Successfully completed task arctic_ocean/areacello (priority 1) in 0:00:00.318115 2023-03-05 20:13:20,397 UTC [23486] INFO esmvalcore._task:779 Progress: 2 tasks running, 1 tasks waiting for ancestors, 1/4 done 2023-03-05 20:13:20,442 UTC [23622] DEBUG esmvalcore.preprocessor:347 Running preprocessor step cleanup 2023-03-05 20:13:20,442 UTC [23622] DEBUG esmvalcore.preprocessor:308 Running preprocessor function 'cleanup' on the data ['/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/thetao/OBS6_PHC_clim_3_Omon_thetao_1950-1950.nc'] loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_thetao_195001-195012.nc', '/projects/NS9252K/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_thetao_195001-195012.nc'] with function argument(s) remove = ['/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/thetao/OBS6_PHC_clim_3_Omon_thetao_1950-1950_fixed'] 2023-03-05 20:13:20,542 UTC [23623] DEBUG esmvalcore.preprocessor:347 Running preprocessor step cleanup 2023-03-05 20:13:20,542 UTC [23623] DEBUG esmvalcore.preprocessor:308 Running preprocessor function 'cleanup' on the data ['/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/so/OBS6_PHC_clim_3_Omon_so_1950-1950.nc'] loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_so_195001-195012.nc', '/projects/NS9252K/obsdata/Tier2/PHC/OBS6_PHC_clim_3_Omon_so_195001-195012.nc'] with function argument(s) remove = ['/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/so/OBS6_PHC_clim_3_Omon_so_1950-1950_fixed'] 2023-03-05 20:13:20,581 UTC [23622] DEBUG esmvalcore.preprocessor:607 Applying single-model steps to PreprocessorFile: /projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/thetao/CMIP5_CanESM2_Omon_historical_r1i1p1_thetao_1980-2005.nc 2023-03-05 20:13:20,581 UTC [23622] DEBUG esmvalcore.preprocessor:347 Running preprocessor step fix_file 2023-03-05 20:13:20,581 UTC [23622] DEBUG esmvalcore.preprocessor:308 Running preprocessor function 'fix_file' on the data '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/thetao/thetao_Omon_CanESM2_historical_r1i1p1_197101-198012.nc' with function argument(s) mip = 'Omon', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', variable_group = 'thetao', short_name = 'thetao', diagnostic = 'arctic_ocean', preprocessor = 'default', dataset = 'CanESM2', recipe_dataset_index = 0, institute = ['CCCma'], product = ['output1', 'output2'], timerange = '1980/2005', alias = 'CMIP5_r1i1p1', original_short_name = 'thetao', standard_name = 'sea_water_potential_temperature', long_name = 'Sea Water Potential Temperature', units = 'K', modeling_realm = ['ocean'], frequency = 'mon', filename = '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/thetao/CMIP5_CanESM2_Omon_historical_r1i1p1_thetao_1980-2005.nc', output_dir = '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/thetao/CMIP5_CanESM2_Omon_historical_r1i1p1_thetao_1980-2005_fixed' 2023-03-05 20:13:20,584 UTC [23622] DEBUG esmvalcore.preprocessor:308 Running preprocessor function 'fix_file' on the data '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/thetao/thetao_Omon_CanESM2_historical_r1i1p1_198101-199012.nc' with function argument(s) mip = 'Omon', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', variable_group = 'thetao', short_name = 'thetao', diagnostic = 'arctic_ocean', preprocessor = 'default', dataset = 'CanESM2', recipe_dataset_index = 0, institute = ['CCCma'], product = ['output1', 'output2'], timerange = '1980/2005', alias = 'CMIP5_r1i1p1', original_short_name = 'thetao', standard_name = 'sea_water_potential_temperature', long_name = 'Sea Water Potential Temperature', units = 'K', modeling_realm = ['ocean'], frequency = 'mon', filename = '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/thetao/CMIP5_CanESM2_Omon_historical_r1i1p1_thetao_1980-2005.nc', output_dir = '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/thetao/CMIP5_CanESM2_Omon_historical_r1i1p1_thetao_1980-2005_fixed' 2023-03-05 20:13:20,585 UTC [23622] DEBUG esmvalcore.preprocessor:308 Running preprocessor function 'fix_file' on the data '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/thetao/thetao_Omon_CanESM2_historical_r1i1p1_199101-200012.nc' with function argument(s) mip = 'Omon', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', variable_group = 'thetao', short_name = 'thetao', diagnostic = 'arctic_ocean', preprocessor = 'default', dataset = 'CanESM2', recipe_dataset_index = 0, institute = ['CCCma'], product = ['output1', 'output2'], timerange = '1980/2005', alias = 'CMIP5_r1i1p1', original_short_name = 'thetao', standard_name = 'sea_water_potential_temperature', long_name = 'Sea Water Potential Temperature', units = 'K', modeling_realm = ['ocean'], frequency = 'mon', filename = '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/thetao/CMIP5_CanESM2_Omon_historical_r1i1p1_thetao_1980-2005.nc', output_dir = '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/thetao/CMIP5_CanESM2_Omon_historical_r1i1p1_thetao_1980-2005_fixed' 2023-03-05 20:13:20,585 UTC [23622] DEBUG esmvalcore.preprocessor:308 Running preprocessor function 'fix_file' on the data '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/thetao/thetao_Omon_CanESM2_historical_r1i1p1_200101-200512.nc' with function argument(s) mip = 'Omon', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', variable_group = 'thetao', short_name = 'thetao', diagnostic = 'arctic_ocean', preprocessor = 'default', dataset = 'CanESM2', recipe_dataset_index = 0, institute = ['CCCma'], product = ['output1', 'output2'], timerange = '1980/2005', alias = 'CMIP5_r1i1p1', original_short_name = 'thetao', standard_name = 'sea_water_potential_temperature', long_name = 'Sea Water Potential Temperature', units = 'K', modeling_realm = ['ocean'], frequency = 'mon', filename = '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/thetao/CMIP5_CanESM2_Omon_historical_r1i1p1_thetao_1980-2005.nc', output_dir = '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/thetao/CMIP5_CanESM2_Omon_historical_r1i1p1_thetao_1980-2005_fixed' 2023-03-05 20:13:20,585 UTC [23622] DEBUG esmvalcore.preprocessor:347 Running preprocessor step load 2023-03-05 20:13:20,586 UTC [23622] DEBUG esmvalcore.preprocessor:308 Running preprocessor function 'load' on the data '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/thetao/thetao_Omon_CanESM2_historical_r1i1p1_197101-198012.nc' with function argument(s) callback = 2023-03-05 20:13:20,586 UTC [23622] DEBUG esmvalcore.preprocessor._io:138 Loading: /projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/thetao/thetao_Omon_CanESM2_historical_r1i1p1_197101-198012.nc 2023-03-05 20:13:20,663 UTC [23623] DEBUG esmvalcore.preprocessor:607 Applying single-model steps to PreprocessorFile: /projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/so/CMIP5_CanESM2_Omon_historical_r1i1p1_so_1980-2005.nc 2023-03-05 20:13:20,663 UTC [23623] DEBUG esmvalcore.preprocessor:347 Running preprocessor step fix_file 2023-03-05 20:13:20,663 UTC [23623] DEBUG esmvalcore.preprocessor:308 Running preprocessor function 'fix_file' on the data '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/so/so_Omon_CanESM2_historical_r1i1p1_197101-198012.nc' with function argument(s) mip = 'Omon', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', variable_group = 'so', short_name = 'so', diagnostic = 'arctic_ocean', preprocessor = 'default', dataset = 'CanESM2', recipe_dataset_index = 0, institute = ['CCCma'], product = ['output1', 'output2'], timerange = '1980/2005', alias = 'CMIP5_r1i1p1', original_short_name = 'so', standard_name = 'sea_water_salinity', long_name = 'Sea Water Salinity', units = 'psu', modeling_realm = ['ocean'], frequency = 'mon', filename = '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/so/CMIP5_CanESM2_Omon_historical_r1i1p1_so_1980-2005.nc', output_dir = '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/so/CMIP5_CanESM2_Omon_historical_r1i1p1_so_1980-2005_fixed' 2023-03-05 20:13:20,665 UTC [23623] DEBUG esmvalcore.preprocessor:308 Running preprocessor function 'fix_file' on the data '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/so/so_Omon_CanESM2_historical_r1i1p1_198101-199012.nc' with function argument(s) mip = 'Omon', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', variable_group = 'so', short_name = 'so', diagnostic = 'arctic_ocean', preprocessor = 'default', dataset = 'CanESM2', recipe_dataset_index = 0, institute = ['CCCma'], product = ['output1', 'output2'], timerange = '1980/2005', alias = 'CMIP5_r1i1p1', original_short_name = 'so', standard_name = 'sea_water_salinity', long_name = 'Sea Water Salinity', units = 'psu', modeling_realm = ['ocean'], frequency = 'mon', filename = '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/so/CMIP5_CanESM2_Omon_historical_r1i1p1_so_1980-2005.nc', output_dir = '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/so/CMIP5_CanESM2_Omon_historical_r1i1p1_so_1980-2005_fixed' 2023-03-05 20:13:20,665 UTC [23623] DEBUG esmvalcore.preprocessor:308 Running preprocessor function 'fix_file' on the data '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/so/so_Omon_CanESM2_historical_r1i1p1_199101-200012.nc' with function argument(s) mip = 'Omon', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', variable_group = 'so', short_name = 'so', diagnostic = 'arctic_ocean', preprocessor = 'default', dataset = 'CanESM2', recipe_dataset_index = 0, institute = ['CCCma'], product = ['output1', 'output2'], timerange = '1980/2005', alias = 'CMIP5_r1i1p1', original_short_name = 'so', standard_name = 'sea_water_salinity', long_name = 'Sea Water Salinity', units = 'psu', modeling_realm = ['ocean'], frequency = 'mon', filename = '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/so/CMIP5_CanESM2_Omon_historical_r1i1p1_so_1980-2005.nc', output_dir = '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/so/CMIP5_CanESM2_Omon_historical_r1i1p1_so_1980-2005_fixed' 2023-03-05 20:13:20,666 UTC [23623] DEBUG esmvalcore.preprocessor:308 Running preprocessor function 'fix_file' on the data '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/so/so_Omon_CanESM2_historical_r1i1p1_200101-200512.nc' with function argument(s) mip = 'Omon', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', variable_group = 'so', short_name = 'so', diagnostic = 'arctic_ocean', preprocessor = 'default', dataset = 'CanESM2', recipe_dataset_index = 0, institute = ['CCCma'], product = ['output1', 'output2'], timerange = '1980/2005', alias = 'CMIP5_r1i1p1', original_short_name = 'so', standard_name = 'sea_water_salinity', long_name = 'Sea Water Salinity', units = 'psu', modeling_realm = ['ocean'], frequency = 'mon', filename = '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/so/CMIP5_CanESM2_Omon_historical_r1i1p1_so_1980-2005.nc', output_dir = '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/so/CMIP5_CanESM2_Omon_historical_r1i1p1_so_1980-2005_fixed' 2023-03-05 20:13:20,666 UTC [23623] DEBUG esmvalcore.preprocessor:347 Running preprocessor step load 2023-03-05 20:13:20,666 UTC [23623] DEBUG esmvalcore.preprocessor:308 Running preprocessor function 'load' on the data '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/so/so_Omon_CanESM2_historical_r1i1p1_197101-198012.nc' with function argument(s) callback = 2023-03-05 20:13:20,666 UTC [23623] DEBUG esmvalcore.preprocessor._io:138 Loading: /projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/so/so_Omon_CanESM2_historical_r1i1p1_197101-198012.nc 2023-03-05 20:13:21,210 UTC [23622] DEBUG esmvalcore.preprocessor._io:168 Done with loading /projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/thetao/thetao_Omon_CanESM2_historical_r1i1p1_197101-198012.nc 2023-03-05 20:13:21,210 UTC [23622] DEBUG esmvalcore.preprocessor:308 Running preprocessor function 'load' on the data '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/thetao/thetao_Omon_CanESM2_historical_r1i1p1_198101-199012.nc' with function argument(s) callback = 2023-03-05 20:13:21,211 UTC [23622] DEBUG esmvalcore.preprocessor._io:138 Loading: /projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/thetao/thetao_Omon_CanESM2_historical_r1i1p1_198101-199012.nc 2023-03-05 20:13:21,608 UTC [23623] DEBUG esmvalcore.preprocessor._io:168 Done with loading /projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/so/so_Omon_CanESM2_historical_r1i1p1_197101-198012.nc 2023-03-05 20:13:21,609 UTC [23623] DEBUG esmvalcore.preprocessor:308 Running preprocessor function 'load' on the data '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/so/so_Omon_CanESM2_historical_r1i1p1_198101-199012.nc' with function argument(s) callback = 2023-03-05 20:13:21,609 UTC [23623] DEBUG esmvalcore.preprocessor._io:138 Loading: /projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/so/so_Omon_CanESM2_historical_r1i1p1_198101-199012.nc 2023-03-05 20:13:22,273 UTC [23622] DEBUG esmvalcore.preprocessor._io:168 Done with loading /projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/thetao/thetao_Omon_CanESM2_historical_r1i1p1_198101-199012.nc 2023-03-05 20:13:22,273 UTC [23622] DEBUG esmvalcore.preprocessor:308 Running preprocessor function 'load' on the data '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/thetao/thetao_Omon_CanESM2_historical_r1i1p1_199101-200012.nc' with function argument(s) callback = 2023-03-05 20:13:22,273 UTC [23622] DEBUG esmvalcore.preprocessor._io:138 Loading: /projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/thetao/thetao_Omon_CanESM2_historical_r1i1p1_199101-200012.nc 2023-03-05 20:13:22,688 UTC [23623] DEBUG esmvalcore.preprocessor._io:168 Done with loading /projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/so/so_Omon_CanESM2_historical_r1i1p1_198101-199012.nc 2023-03-05 20:13:22,688 UTC [23623] DEBUG esmvalcore.preprocessor:308 Running preprocessor function 'load' on the data '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/so/so_Omon_CanESM2_historical_r1i1p1_199101-200012.nc' with function argument(s) callback = 2023-03-05 20:13:22,688 UTC [23623] DEBUG esmvalcore.preprocessor._io:138 Loading: /projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/so/so_Omon_CanESM2_historical_r1i1p1_199101-200012.nc 2023-03-05 20:13:23,245 UTC [23622] DEBUG esmvalcore.preprocessor._io:168 Done with loading /projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/thetao/thetao_Omon_CanESM2_historical_r1i1p1_199101-200012.nc 2023-03-05 20:13:23,246 UTC [23622] DEBUG esmvalcore.preprocessor:308 Running preprocessor function 'load' on the data '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/thetao/thetao_Omon_CanESM2_historical_r1i1p1_200101-200512.nc' with function argument(s) callback = 2023-03-05 20:13:23,246 UTC [23622] DEBUG esmvalcore.preprocessor._io:138 Loading: /projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/thetao/thetao_Omon_CanESM2_historical_r1i1p1_200101-200512.nc 2023-03-05 20:13:23,742 UTC [23623] DEBUG esmvalcore.preprocessor._io:168 Done with loading /projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/so/so_Omon_CanESM2_historical_r1i1p1_199101-200012.nc 2023-03-05 20:13:23,743 UTC [23623] DEBUG esmvalcore.preprocessor:308 Running preprocessor function 'load' on the data '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/so/so_Omon_CanESM2_historical_r1i1p1_200101-200512.nc' with function argument(s) callback = 2023-03-05 20:13:23,743 UTC [23623] DEBUG esmvalcore.preprocessor._io:138 Loading: /projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/so/so_Omon_CanESM2_historical_r1i1p1_200101-200512.nc 2023-03-05 20:13:23,867 UTC [23622] DEBUG esmvalcore.preprocessor._io:168 Done with loading /projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/thetao/thetao_Omon_CanESM2_historical_r1i1p1_200101-200512.nc 2023-03-05 20:13:23,868 UTC [23622] DEBUG esmvalcore.preprocessor:347 Running preprocessor step fix_metadata 2023-03-05 20:13:23,881 UTC [23622] DEBUG esmvalcore.preprocessor:308 Running preprocessor function 'fix_metadata' on the data [, , , ] loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/thetao/thetao_Omon_CanESM2_historical_r1i1p1_197101-198012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/thetao/thetao_Omon_CanESM2_historical_r1i1p1_198101-199012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/thetao/thetao_Omon_CanESM2_historical_r1i1p1_199101-200012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/thetao/thetao_Omon_CanESM2_historical_r1i1p1_200101-200512.nc'] with function argument(s) mip = 'Omon', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', variable_group = 'thetao', short_name = 'thetao', diagnostic = 'arctic_ocean', preprocessor = 'default', dataset = 'CanESM2', recipe_dataset_index = 0, institute = ['CCCma'], product = ['output1', 'output2'], timerange = '1980/2005', alias = 'CMIP5_r1i1p1', original_short_name = 'thetao', standard_name = 'sea_water_potential_temperature', long_name = 'Sea Water Potential Temperature', units = 'K', modeling_realm = ['ocean'], frequency = 'mon', filename = '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/thetao/CMIP5_CanESM2_Omon_historical_r1i1p1_thetao_1980-2005.nc', check_level = 2023-03-05 20:13:23,890 UTC [23622] DEBUG esmvalcore.preprocessor:347 Running preprocessor step concatenate 2023-03-05 20:13:23,901 UTC [23622] DEBUG esmvalcore.preprocessor:308 Running preprocessor function 'concatenate' on the data [, , , ] loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/thetao/thetao_Omon_CanESM2_historical_r1i1p1_197101-198012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/thetao/thetao_Omon_CanESM2_historical_r1i1p1_198101-199012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/thetao/thetao_Omon_CanESM2_historical_r1i1p1_199101-200012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/thetao/thetao_Omon_CanESM2_historical_r1i1p1_200101-200512.nc'] with function argument(s) 2023-03-05 20:13:23,914 UTC [23622] DEBUG esmvalcore.preprocessor:347 Running preprocessor step cmor_check_metadata 2023-03-05 20:13:23,915 UTC [23622] DEBUG esmvalcore.preprocessor:308 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/ocean/Omon/r1i1p1/latest/thetao/thetao_Omon_CanESM2_historical_r1i1p1_197101-198012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/thetao/thetao_Omon_CanESM2_historical_r1i1p1_198101-199012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/thetao/thetao_Omon_CanESM2_historical_r1i1p1_199101-200012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/thetao/thetao_Omon_CanESM2_historical_r1i1p1_200101-200512.nc'] with function argument(s) cmor_table = 'CMIP5', mip = 'Omon', short_name = 'thetao', frequency = 'mon', check_level = 2023-03-05 20:13:23,919 UTC [23622] DEBUG esmvalcore.preprocessor:347 Running preprocessor step clip_timerange 2023-03-05 20:13:23,920 UTC [23622] DEBUG esmvalcore.preprocessor:308 Running preprocessor function 'clip_timerange' on the data loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/thetao/thetao_Omon_CanESM2_historical_r1i1p1_197101-198012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/thetao/thetao_Omon_CanESM2_historical_r1i1p1_198101-199012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/thetao/thetao_Omon_CanESM2_historical_r1i1p1_199101-200012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/thetao/thetao_Omon_CanESM2_historical_r1i1p1_200101-200512.nc'] with function argument(s) timerange = '1980/2005' 2023-03-05 20:13:23,928 UTC [23622] DEBUG esmvalcore.preprocessor:347 Running preprocessor step fix_data 2023-03-05 20:13:23,929 UTC [23622] DEBUG esmvalcore.preprocessor:308 Running preprocessor function 'fix_data' on the data loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/thetao/thetao_Omon_CanESM2_historical_r1i1p1_197101-198012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/thetao/thetao_Omon_CanESM2_historical_r1i1p1_198101-199012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/thetao/thetao_Omon_CanESM2_historical_r1i1p1_199101-200012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/thetao/thetao_Omon_CanESM2_historical_r1i1p1_200101-200512.nc'] with function argument(s) mip = 'Omon', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', variable_group = 'thetao', short_name = 'thetao', diagnostic = 'arctic_ocean', preprocessor = 'default', dataset = 'CanESM2', recipe_dataset_index = 0, institute = ['CCCma'], product = ['output1', 'output2'], timerange = '1980/2005', alias = 'CMIP5_r1i1p1', original_short_name = 'thetao', standard_name = 'sea_water_potential_temperature', long_name = 'Sea Water Potential Temperature', units = 'K', modeling_realm = ['ocean'], frequency = 'mon', filename = '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/thetao/CMIP5_CanESM2_Omon_historical_r1i1p1_thetao_1980-2005.nc', check_level = 2023-03-05 20:13:23,930 UTC [23622] DEBUG esmvalcore.preprocessor:347 Running preprocessor step cmor_check_data 2023-03-05 20:13:23,931 UTC [23622] DEBUG esmvalcore.preprocessor:308 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/ocean/Omon/r1i1p1/latest/thetao/thetao_Omon_CanESM2_historical_r1i1p1_197101-198012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/thetao/thetao_Omon_CanESM2_historical_r1i1p1_198101-199012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/thetao/thetao_Omon_CanESM2_historical_r1i1p1_199101-200012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/thetao/thetao_Omon_CanESM2_historical_r1i1p1_200101-200512.nc'] with function argument(s) cmor_table = 'CMIP5', mip = 'Omon', short_name = 'thetao', frequency = 'mon', check_level = 2023-03-05 20:13:23,932 UTC [23622] DEBUG esmvalcore.preprocessor:347 Running preprocessor step add_fx_variables 2023-03-05 20:13:23,933 UTC [23622] DEBUG esmvalcore.preprocessor:308 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/ocean/Omon/r1i1p1/latest/thetao/thetao_Omon_CanESM2_historical_r1i1p1_197101-198012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/thetao/thetao_Omon_CanESM2_historical_r1i1p1_198101-199012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/thetao/thetao_Omon_CanESM2_historical_r1i1p1_199101-200012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/thetao/thetao_Omon_CanESM2_historical_r1i1p1_200101-200512.nc'] with function argument(s) fx_variables = {}, check_level = 2023-03-05 20:13:23,933 UTC [23622] DEBUG esmvalcore.preprocessor:347 Running preprocessor step remove_fx_variables 2023-03-05 20:13:23,935 UTC [23622] DEBUG esmvalcore.preprocessor:308 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/ocean/Omon/r1i1p1/latest/thetao/thetao_Omon_CanESM2_historical_r1i1p1_197101-198012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/thetao/thetao_Omon_CanESM2_historical_r1i1p1_198101-199012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/thetao/thetao_Omon_CanESM2_historical_r1i1p1_199101-200012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/thetao/thetao_Omon_CanESM2_historical_r1i1p1_200101-200512.nc'] with function argument(s) 2023-03-05 20:13:23,935 UTC [23622] DEBUG esmvalcore.preprocessor:347 Running preprocessor step save 2023-03-05 20:13:23,937 UTC [23622] DEBUG esmvalcore.preprocessor:308 Running preprocessor function 'save' on the data [] loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/thetao/thetao_Omon_CanESM2_historical_r1i1p1_197101-198012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/thetao/thetao_Omon_CanESM2_historical_r1i1p1_198101-199012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/thetao/thetao_Omon_CanESM2_historical_r1i1p1_199101-200012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/thetao/thetao_Omon_CanESM2_historical_r1i1p1_200101-200512.nc'] with function argument(s) compress = False, filename = '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/thetao/CMIP5_CanESM2_Omon_historical_r1i1p1_thetao_1980-2005.nc' 2023-03-05 20:13:23,937 UTC [23622] DEBUG esmvalcore.preprocessor._io:308 Saving cubes [] to /projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/thetao/CMIP5_CanESM2_Omon_historical_r1i1p1_thetao_1980-2005.nc 2023-03-05 20:13:24,768 UTC [23623] DEBUG esmvalcore.preprocessor._io:168 Done with loading /projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/so/so_Omon_CanESM2_historical_r1i1p1_200101-200512.nc 2023-03-05 20:13:24,768 UTC [23623] DEBUG esmvalcore.preprocessor:347 Running preprocessor step fix_metadata 2023-03-05 20:13:24,782 UTC [23623] DEBUG esmvalcore.preprocessor:308 Running preprocessor function 'fix_metadata' on the data [, , , ] loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/so/so_Omon_CanESM2_historical_r1i1p1_197101-198012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/so/so_Omon_CanESM2_historical_r1i1p1_198101-199012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/so/so_Omon_CanESM2_historical_r1i1p1_199101-200012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/so/so_Omon_CanESM2_historical_r1i1p1_200101-200512.nc'] with function argument(s) mip = 'Omon', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', variable_group = 'so', short_name = 'so', diagnostic = 'arctic_ocean', preprocessor = 'default', dataset = 'CanESM2', recipe_dataset_index = 0, institute = ['CCCma'], product = ['output1', 'output2'], timerange = '1980/2005', alias = 'CMIP5_r1i1p1', original_short_name = 'so', standard_name = 'sea_water_salinity', long_name = 'Sea Water Salinity', units = 'psu', modeling_realm = ['ocean'], frequency = 'mon', filename = '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/so/CMIP5_CanESM2_Omon_historical_r1i1p1_so_1980-2005.nc', check_level = 2023-03-05 20:13:24,792 UTC [23623] DEBUG esmvalcore.preprocessor:347 Running preprocessor step concatenate 2023-03-05 20:13:24,803 UTC [23623] DEBUG esmvalcore.preprocessor:308 Running preprocessor function 'concatenate' on the data [, , , ] loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/so/so_Omon_CanESM2_historical_r1i1p1_197101-198012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/so/so_Omon_CanESM2_historical_r1i1p1_198101-199012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/so/so_Omon_CanESM2_historical_r1i1p1_199101-200012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/so/so_Omon_CanESM2_historical_r1i1p1_200101-200512.nc'] with function argument(s) 2023-03-05 20:13:24,815 UTC [23623] DEBUG esmvalcore.preprocessor:347 Running preprocessor step cmor_check_metadata 2023-03-05 20:13:24,817 UTC [23623] DEBUG esmvalcore.preprocessor:308 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/ocean/Omon/r1i1p1/latest/so/so_Omon_CanESM2_historical_r1i1p1_197101-198012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/so/so_Omon_CanESM2_historical_r1i1p1_198101-199012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/so/so_Omon_CanESM2_historical_r1i1p1_199101-200012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/so/so_Omon_CanESM2_historical_r1i1p1_200101-200512.nc'] with function argument(s) cmor_table = 'CMIP5', mip = 'Omon', short_name = 'so', frequency = 'mon', check_level = 2023-03-05 20:13:24,821 UTC [23623] DEBUG esmvalcore.preprocessor:347 Running preprocessor step clip_timerange 2023-03-05 20:13:24,822 UTC [23623] DEBUG esmvalcore.preprocessor:308 Running preprocessor function 'clip_timerange' on the data loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/so/so_Omon_CanESM2_historical_r1i1p1_197101-198012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/so/so_Omon_CanESM2_historical_r1i1p1_198101-199012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/so/so_Omon_CanESM2_historical_r1i1p1_199101-200012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/so/so_Omon_CanESM2_historical_r1i1p1_200101-200512.nc'] with function argument(s) timerange = '1980/2005' 2023-03-05 20:13:24,830 UTC [23623] DEBUG esmvalcore.preprocessor:347 Running preprocessor step fix_data 2023-03-05 20:13:24,832 UTC [23623] DEBUG esmvalcore.preprocessor:308 Running preprocessor function 'fix_data' on the data loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/so/so_Omon_CanESM2_historical_r1i1p1_197101-198012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/so/so_Omon_CanESM2_historical_r1i1p1_198101-199012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/so/so_Omon_CanESM2_historical_r1i1p1_199101-200012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/so/so_Omon_CanESM2_historical_r1i1p1_200101-200512.nc'] with function argument(s) mip = 'Omon', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', variable_group = 'so', short_name = 'so', diagnostic = 'arctic_ocean', preprocessor = 'default', dataset = 'CanESM2', recipe_dataset_index = 0, institute = ['CCCma'], product = ['output1', 'output2'], timerange = '1980/2005', alias = 'CMIP5_r1i1p1', original_short_name = 'so', standard_name = 'sea_water_salinity', long_name = 'Sea Water Salinity', units = 'psu', modeling_realm = ['ocean'], frequency = 'mon', filename = '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/so/CMIP5_CanESM2_Omon_historical_r1i1p1_so_1980-2005.nc', check_level = 2023-03-05 20:13:24,832 UTC [23623] DEBUG esmvalcore.preprocessor:347 Running preprocessor step cmor_check_data 2023-03-05 20:13:24,833 UTC [23623] DEBUG esmvalcore.preprocessor:308 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/ocean/Omon/r1i1p1/latest/so/so_Omon_CanESM2_historical_r1i1p1_197101-198012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/so/so_Omon_CanESM2_historical_r1i1p1_198101-199012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/so/so_Omon_CanESM2_historical_r1i1p1_199101-200012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/so/so_Omon_CanESM2_historical_r1i1p1_200101-200512.nc'] with function argument(s) cmor_table = 'CMIP5', mip = 'Omon', short_name = 'so', frequency = 'mon', check_level = 2023-03-05 20:13:24,834 UTC [23623] DEBUG esmvalcore.preprocessor:347 Running preprocessor step add_fx_variables 2023-03-05 20:13:24,835 UTC [23623] DEBUG esmvalcore.preprocessor:308 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/ocean/Omon/r1i1p1/latest/so/so_Omon_CanESM2_historical_r1i1p1_197101-198012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/so/so_Omon_CanESM2_historical_r1i1p1_198101-199012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/so/so_Omon_CanESM2_historical_r1i1p1_199101-200012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/so/so_Omon_CanESM2_historical_r1i1p1_200101-200512.nc'] with function argument(s) fx_variables = {}, check_level = 2023-03-05 20:13:24,835 UTC [23623] DEBUG esmvalcore.preprocessor:347 Running preprocessor step remove_fx_variables 2023-03-05 20:13:24,837 UTC [23623] DEBUG esmvalcore.preprocessor:308 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/ocean/Omon/r1i1p1/latest/so/so_Omon_CanESM2_historical_r1i1p1_197101-198012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/so/so_Omon_CanESM2_historical_r1i1p1_198101-199012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/so/so_Omon_CanESM2_historical_r1i1p1_199101-200012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/so/so_Omon_CanESM2_historical_r1i1p1_200101-200512.nc'] with function argument(s) 2023-03-05 20:13:24,837 UTC [23623] DEBUG esmvalcore.preprocessor:347 Running preprocessor step save 2023-03-05 20:13:24,839 UTC [23623] DEBUG esmvalcore.preprocessor:308 Running preprocessor function 'save' on the data [] loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/so/so_Omon_CanESM2_historical_r1i1p1_197101-198012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/so/so_Omon_CanESM2_historical_r1i1p1_198101-199012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/so/so_Omon_CanESM2_historical_r1i1p1_199101-200012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/so/so_Omon_CanESM2_historical_r1i1p1_200101-200512.nc'] with function argument(s) compress = False, filename = '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/so/CMIP5_CanESM2_Omon_historical_r1i1p1_so_1980-2005.nc' 2023-03-05 20:13:24,839 UTC [23623] DEBUG esmvalcore.preprocessor._io:308 Saving cubes [] to /projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/so/CMIP5_CanESM2_Omon_historical_r1i1p1_so_1980-2005.nc 2023-03-05 20:13:36,835 UTC [23622] DEBUG esmvalcore.preprocessor:347 Running preprocessor step cleanup 2023-03-05 20:13:36,837 UTC [23622] DEBUG esmvalcore.preprocessor:308 Running preprocessor function 'cleanup' on the data ['/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/thetao/CMIP5_CanESM2_Omon_historical_r1i1p1_thetao_1980-2005.nc'] loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/thetao/thetao_Omon_CanESM2_historical_r1i1p1_197101-198012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/thetao/thetao_Omon_CanESM2_historical_r1i1p1_198101-199012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/thetao/thetao_Omon_CanESM2_historical_r1i1p1_199101-200012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/thetao/thetao_Omon_CanESM2_historical_r1i1p1_200101-200512.nc'] with function argument(s) remove = ['/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/thetao/CMIP5_CanESM2_Omon_historical_r1i1p1_thetao_1980-2005_fixed'] 2023-03-05 20:13:36,897 UTC [23622] INFO esmvalcore._task:265 Successfully completed task arctic_ocean/thetao (priority 2) in 0:00:16.991275 2023-03-05 20:13:37,040 UTC [23486] INFO esmvalcore._task:779 Progress: 1 tasks running, 1 tasks waiting for ancestors, 2/4 done 2023-03-05 20:13:39,395 UTC [23623] DEBUG esmvalcore.preprocessor:347 Running preprocessor step cleanup 2023-03-05 20:13:39,396 UTC [23623] DEBUG esmvalcore.preprocessor:308 Running preprocessor function 'cleanup' on the data ['/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/so/CMIP5_CanESM2_Omon_historical_r1i1p1_so_1980-2005.nc'] loaded from original input file(s) ['/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/so/so_Omon_CanESM2_historical_r1i1p1_197101-198012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/so/so_Omon_CanESM2_historical_r1i1p1_198101-199012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/so/so_Omon_CanESM2_historical_r1i1p1_199101-200012.nc', '/projects/NS9252K/ESGF_betzy/cmip5/output1/CCCma/CanESM2/historical/mon/ocean/Omon/r1i1p1/latest/so/so_Omon_CanESM2_historical_r1i1p1_200101-200512.nc'] with function argument(s) remove = ['/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/preproc/arctic_ocean/so/CMIP5_CanESM2_Omon_historical_r1i1p1_so_1980-2005_fixed'] 2023-03-05 20:13:39,442 UTC [23623] INFO esmvalcore._task:265 Successfully completed task arctic_ocean/so (priority 3) in 0:00:19.535668 2023-03-05 20:13:39,450 UTC [23486] INFO esmvalcore._task:779 Progress: 0 tasks running, 1 tasks waiting for ancestors, 3/4 done 2023-03-05 20:13:39,477 UTC [23624] INFO esmvalcore._task:260 Starting task arctic_ocean/arctic_ocean_main in process [23624] 2023-03-05 20:13:39,539 UTC [23624] INFO esmvalcore._task:501 Running command ['/projects/NS2980K/conda/esmvaltool2.7.0/bin/python', '/projects/NS2980K/conda/esmvaltool2.7.0/lib/python3.10/site-packages/esmvaltool/diag_scripts/arctic_ocean/arctic_ocean.py', '/projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/run/arctic_ocean/arctic_ocean_main/settings.yml'] 2023-03-05 20:13:39,539 UTC [23624] DEBUG esmvalcore._task:502 in environment {'MPLBACKEND': 'Agg'} 2023-03-05 20:13:39,539 UTC [23624] DEBUG esmvalcore._task:504 in current working directory: /projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/run/arctic_ocean/arctic_ocean_main 2023-03-05 20:13:39,540 UTC [23624] INFO esmvalcore._task:505 Writing output to /projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/work/arctic_ocean/arctic_ocean_main 2023-03-05 20:13:39,540 UTC [23624] INFO esmvalcore._task:506 Writing plots to /projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/plots/arctic_ocean/arctic_ocean_main 2023-03-05 20:13:39,540 UTC [23624] INFO esmvalcore._task:507 Writing log to /projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/run/arctic_ocean/arctic_ocean_main/log.txt 2023-03-05 20:13:39,540 UTC [23624] INFO esmvalcore._task:517 To re-run this diagnostic script, run: cd /projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/run/arctic_ocean/arctic_ocean_main; MPLBACKEND="Agg" /projects/NS2980K/conda/esmvaltool2.7.0/bin/python /projects/NS2980K/conda/esmvaltool2.7.0/lib/python3.10/site-packages/esmvaltool/diag_scripts/arctic_ocean/arctic_ocean.py /projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/run/arctic_ocean/arctic_ocean_main/settings.yml 2023-03-05 20:13:39,551 UTC [23486] INFO esmvalcore._task:779 Progress: 1 tasks running, 0 tasks waiting for ancestors, 3/4 done 2023-03-05 20:14:18,805 UTC [23624] INFO esmvalcore._task:127 Maximum memory used (estimate): 0.2 GB 2023-03-05 20:14:18,808 UTC [23624] INFO esmvalcore._task:129 Sampled every second. It may be inaccurate if short but high spikes in memory consumption occur. 2023-03-05 20:14:19,959 UTC [23486] INFO esmvalcore._task:127 Maximum memory used (estimate): 6.5 GB 2023-03-05 20:14:19,961 UTC [23486] INFO esmvalcore._task:129 Sampled every second. It may be inaccurate if short but high spikes in memory consumption occur. 2023-03-05 20:14:19,962 UTC [23486] ERROR esmvalcore._main:511 Program terminated abnormally, see stack trace below for more information: multiprocessing.pool.RemoteTraceback: """ Traceback (most recent call last): File "/projects/NS2980K/conda/esmvaltool2.7.0/lib/python3.10/multiprocessing/pool.py", line 125, in worker result = (True, func(*args, **kwds)) File "/projects/NS2980K/conda/esmvaltool2.7.0/lib/python3.10/site-packages/esmvalcore/_task.py", line 796, in _run_task output_files = task.run() File "/projects/NS2980K/conda/esmvaltool2.7.0/lib/python3.10/site-packages/esmvalcore/_task.py", line 263, in run self.output_files = self._run(input_files) File "/projects/NS2980K/conda/esmvaltool2.7.0/lib/python3.10/site-packages/esmvalcore/_task.py", line 594, in _run raise DiagnosticError( esmvalcore._task.DiagnosticError: Diagnostic script arctic_ocean/arctic_ocean.py failed with return code 1. See the log in /projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/run/arctic_ocean/arctic_ocean_main/log.txt """ The above exception was the direct cause of the following exception: Traceback (most recent call last): File "/projects/NS2980K/conda/esmvaltool2.7.0/lib/python3.10/site-packages/esmvalcore/_main.py", line 499, in run fire.Fire(ESMValTool()) File "/projects/NS2980K/conda/esmvaltool2.7.0/lib/python3.10/site-packages/fire/core.py", line 141, in Fire component_trace = _Fire(component, args, parsed_flag_args, context, name) File "/projects/NS2980K/conda/esmvaltool2.7.0/lib/python3.10/site-packages/fire/core.py", line 466, in _Fire component, remaining_args = _CallAndUpdateTrace( File "/projects/NS2980K/conda/esmvaltool2.7.0/lib/python3.10/site-packages/fire/core.py", line 681, in _CallAndUpdateTrace component = fn(*varargs, **kwargs) File "/projects/NS2980K/conda/esmvaltool2.7.0/lib/python3.10/site-packages/esmvalcore/_main.py", line 443, in run process_recipe(recipe_file=recipe, config_user=cfg) File "/projects/NS2980K/conda/esmvaltool2.7.0/lib/python3.10/site-packages/esmvalcore/_main.py", line 124, in process_recipe recipe.run() File "/projects/NS2980K/conda/esmvaltool2.7.0/lib/python3.10/site-packages/esmvalcore/_recipe.py", line 1921, in run self.tasks.run(max_parallel_tasks=self._cfg['max_parallel_tasks']) File "/projects/NS2980K/conda/esmvaltool2.7.0/lib/python3.10/site-packages/esmvalcore/_task.py", line 725, in run self._run_parallel(max_parallel_tasks) File "/projects/NS2980K/conda/esmvaltool2.7.0/lib/python3.10/site-packages/esmvalcore/_task.py", line 768, in _run_parallel _copy_results(task, running[task]) File "/projects/NS2980K/conda/esmvaltool2.7.0/lib/python3.10/site-packages/esmvalcore/_task.py", line 791, in _copy_results task.output_files, task.products = future.get() File "/projects/NS2980K/conda/esmvaltool2.7.0/lib/python3.10/multiprocessing/pool.py", line 774, in get raise self._value File "/projects/NS2980K/conda/esmvaltool2.7.0/lib/python3.10/multiprocessing/pool.py", line 125, in worker result = (True, func(*args, **kwds)) File "/projects/NS2980K/conda/esmvaltool2.7.0/lib/python3.10/site-packages/esmvalcore/_task.py", line 796, in _run_task output_files = task.run() File "/projects/NS2980K/conda/esmvaltool2.7.0/lib/python3.10/site-packages/esmvalcore/_task.py", line 263, in run self.output_files = self._run(input_files) File "/projects/NS2980K/conda/esmvaltool2.7.0/lib/python3.10/site-packages/esmvalcore/_task.py", line 594, in _run raise DiagnosticError( esmvalcore._task.DiagnosticError: Diagnostic script arctic_ocean/arctic_ocean.py failed with return code 1. See the log in /projects/NS2980K/www/tomast/esmvaltool2.7.0/recipe_arctic_ocean_20230305_201317/run/arctic_ocean/arctic_ocean_main/log.txt 2023-03-05 20:14:19,968 UTC [23486] INFO esmvalcore._main:515 If you have a question or need help, please start a new discussion on https://github.com/ESMValGroup/ESMValTool/discussions If you suspect this is a bug, please open an issue on https://github.com/ESMValGroup/ESMValTool/issues To make it easier to find out what the problem is, please consider attaching the files run/recipe_*.yml and run/main_log_debug.txt from the output directory.