2023-05-23 12:01:25,190 UTC [1003141] INFO esmvalcore._main:495 ______________________________________________________________________ _____ ____ __ ____ __ _ _____ _ | ____/ ___|| \/ \ \ / /_ _| |_ _|__ ___ | | | _| \___ \| |\/| |\ \ / / _` | | | |/ _ \ / _ \| | | |___ ___) | | | | \ V / (_| | | | | (_) | (_) | | |_____|____/|_| |_| \_/ \__,_|_| |_|\___/ \___/|_| ______________________________________________________________________ ESMValTool - Earth System Model Evaluation Tool. http://www.esmvaltool.org CORE DEVELOPMENT TEAM AND CONTACTS: Birgit Hassler (Co-PI; DLR, Germany - birgit.hassler@dlr.de) Alistair Sellar (Co-PI; Met Office, UK - alistair.sellar@metoffice.gov.uk) Bouwe Andela (Netherlands eScience Center, The Netherlands - b.andela@esciencecenter.nl) Lee de Mora (PML, UK - ledm@pml.ac.uk) Niels Drost (Netherlands eScience Center, The Netherlands - n.drost@esciencecenter.nl) Veronika Eyring (DLR, Germany - veronika.eyring@dlr.de) Bettina Gier (UBremen, Germany - gier@uni-bremen.de) Remi Kazeroni (DLR, Germany - remi.kazeroni@dlr.de) Nikolay Koldunov (AWI, Germany - nikolay.koldunov@awi.de) Axel Lauer (DLR, Germany - axel.lauer@dlr.de) Saskia Loosveldt-Tomas (BSC, Spain - saskia.loosveldt@bsc.es) Ruth Lorenz (ETH Zurich, Switzerland - ruth.lorenz@env.ethz.ch) Benjamin Mueller (LMU, Germany - b.mueller@iggf.geo.uni-muenchen.de) Valeriu Predoi (URead, UK - valeriu.predoi@ncas.ac.uk) Mattia Righi (DLR, Germany - mattia.righi@dlr.de) Manuel Schlund (DLR, Germany - manuel.schlund@dlr.de) Breixo Solino Fernandez (DLR, Germany - breixo.solinofernandez@dlr.de) Javier Vegas-Regidor (BSC, Spain - javier.vegas@bsc.es) Klaus Zimmermann (SMHI, Sweden - klaus.zimmermann@smhi.se) For further help, please read the documentation at http://docs.esmvaltool.org. Have fun! 2023-05-23 12:01:25,191 UTC [1003141] INFO esmvalcore._main:496 Package versions 2023-05-23 12:01:25,191 UTC [1003141] INFO esmvalcore._main:497 ---------------- 2023-05-23 12:01:25,191 UTC [1003141] INFO esmvalcore._main:498 ESMValCore: 2.8.0 2023-05-23 12:01:25,191 UTC [1003141] INFO esmvalcore._main:500 ESMValTool: 2.8.0 2023-05-23 12:01:25,191 UTC [1003141] INFO esmvalcore._main:501 ---------------- 2023-05-23 12:01:25,191 UTC [1003141] INFO esmvalcore._main:502 Using config file /projects/NS2980K/home/tomast/ESMValTool/rundir_ipcc_node/esmvaltool2.8.0/config-NS9560K.yml 2023-05-23 12:01:25,191 UTC [1003141] INFO esmvalcore._main:503 Writing program log files to: /projects/NS2980K/www/tomast/esmvaltool2.8.0/recipe_julia_20230523_120125/run/main_log.txt /projects/NS2980K/www/tomast/esmvaltool2.8.0/recipe_julia_20230523_120125/run/main_log_debug.txt 2023-05-23 12:01:25,963 UTC [1003141] INFO esmvalcore._main:85 Starting the Earth System Model Evaluation Tool at time: 2023-05-23 12:01:25 UTC 2023-05-23 12:01:25,964 UTC [1003141] INFO esmvalcore._main:89 ---------------------------------------------------------------------- 2023-05-23 12:01:25,964 UTC [1003141] INFO esmvalcore._main:90 RECIPE = /projects/NS2980K/home/tomast/ESMValTool/rundir_ipcc_node/esmvaltool2.8.0/recipe_julia.yml 2023-05-23 12:01:25,964 UTC [1003141] INFO esmvalcore._main:91 RUNDIR = /projects/NS2980K/www/tomast/esmvaltool2.8.0/recipe_julia_20230523_120125/run 2023-05-23 12:01:25,964 UTC [1003141] INFO esmvalcore._main:92 WORKDIR = /projects/NS2980K/www/tomast/esmvaltool2.8.0/recipe_julia_20230523_120125/work 2023-05-23 12:01:25,964 UTC [1003141] INFO esmvalcore._main:93 PREPROCDIR = /projects/NS2980K/www/tomast/esmvaltool2.8.0/recipe_julia_20230523_120125/preproc 2023-05-23 12:01:25,964 UTC [1003141] INFO esmvalcore._main:94 PLOTDIR = /projects/NS2980K/www/tomast/esmvaltool2.8.0/recipe_julia_20230523_120125/plots 2023-05-23 12:01:25,964 UTC [1003141] INFO esmvalcore._main:95 ---------------------------------------------------------------------- 2023-05-23 12:01:25,966 UTC [1003141] INFO esmvalcore._main:98 Running tasks using at most 8 processes 2023-05-23 12:01:25,966 UTC [1003141] INFO esmvalcore._main:100 If your system hangs during execution, it may not have enough memory for keeping this number of tasks in memory. 2023-05-23 12:01:25,966 UTC [1003141] INFO esmvalcore._main:103 If you experience memory problems, try reducing 'max_parallel_tasks' in your user configuration file. 2023-05-23 12:01:25,967 UTC [1003141] DEBUG esmvalcore._recipe.check:52 Checking recipe against schema /projects/NS2980K/conda/esmvaltool2.8.0/lib/python3.10/site-packages/esmvalcore/_recipe/recipe_schema.yml 2023-05-23 12:01:25,980 UTC [1003141] DEBUG esmvalcore._recipe.to_datasets:344 Populating list of datasets for variable tas in diagnostic example 2023-05-23 12:01:25,981 UTC [1003141] DEBUG esmvalcore._recipe.to_datasets:368 Found Dataset: tas, Amon, CMIP5, CanESM2, historical, r1i1p1 2023-05-23 12:01:25,981 UTC [1003141] DEBUG esmvalcore._recipe.recipe:1014 Retrieving diagnostics from recipe 2023-05-23 12:01:25,981 UTC [1003141] DEBUG esmvalcore._recipe.recipe:1042 Setting script for diagnostic example 2023-05-23 12:01:25,981 UTC [1003141] INFO esmvalcore._recipe.recipe:1232 Creating tasks from recipe 2023-05-23 12:01:25,981 UTC [1003141] INFO esmvalcore._recipe.recipe:1241 Creating tasks for diagnostic example 2023-05-23 12:01:25,982 UTC [1003141] INFO esmvalcore._recipe.recipe:1163 Creating diagnostic task example/main 2023-05-23 12:01:25,982 UTC [1003141] INFO esmvalcore._recipe.recipe:1216 Creating preprocessor task example/tas 2023-05-23 12:01:25,982 UTC [1003141] INFO esmvalcore._recipe.recipe:849 Creating preprocessor 'preproc' task for variable 'tas' 2023-05-23 12:01:25,982 UTC [1003141] DEBUG esmvalcore.config._config:48 Loading extra facets from /projects/NS2980K/conda/esmvaltool2.8.0/lib/python3.10/site-packages/esmvalcore/config/extra_facets/cmip5-fx.yml 2023-05-23 12:01:25,983 UTC [1003141] DEBUG esmvalcore.config._config:48 Loading extra facets from /projects/NS2980K/conda/esmvaltool2.8.0/lib/python3.10/site-packages/esmvalcore/config/extra_facets/cmip5-institutes.yml 2023-05-23 12:01:26,012 UTC [1003141] DEBUG esmvalcore.config._config:48 Loading extra facets from /projects/NS2980K/conda/esmvaltool2.8.0/lib/python3.10/site-packages/esmvalcore/config/extra_facets/cmip5-product.yml 2023-05-23 12:01:26,019 UTC [1003141] DEBUG esmvalcore.local:458 Looking for files matching: /projects/NS9034K/CMIP5/output1/CCCMA/CanESM2/historical/mon/atmos/Amon/r1i1p1/*/tas/tas_Amon_CanESM2_historical_r1i1p1*.nc /projects/NS9034K/CMIP5/output1/CCCma/CanESM2/historical/mon/atmos/Amon/r1i1p1/*/tas/tas_Amon_CanESM2_historical_r1i1p1*.nc /projects/NS9034K/CMIP5/output2/CCCMA/CanESM2/historical/mon/atmos/Amon/r1i1p1/*/tas/tas_Amon_CanESM2_historical_r1i1p1*.nc /projects/NS9034K/CMIP5/output2/CCCma/CanESM2/historical/mon/atmos/Amon/r1i1p1/*/tas/tas_Amon_CanESM2_historical_r1i1p1*.nc /projects/NS9560K-datalake/ESGF/cmip5/output1/CCCMA/CanESM2/historical/mon/atmos/Amon/r1i1p1/*/tas/tas_Amon_CanESM2_historical_r1i1p1*.nc /projects/NS9560K-datalake/ESGF/cmip5/output1/CCCma/CanESM2/historical/mon/atmos/Amon/r1i1p1/*/tas/tas_Amon_CanESM2_historical_r1i1p1*.nc /projects/NS9560K-datalake/ESGF/cmip5/output2/CCCMA/CanESM2/historical/mon/atmos/Amon/r1i1p1/*/tas/tas_Amon_CanESM2_historical_r1i1p1*.nc /projects/NS9560K-datalake/ESGF/cmip5/output2/CCCma/CanESM2/historical/mon/atmos/Amon/r1i1p1/*/tas/tas_Amon_CanESM2_historical_r1i1p1*.nc 2023-05-23 12:01:26,041 UTC [1003141] DEBUG esmvalcore._recipe.recipe:446 Using input files for variable tas of dataset CanESM2: /projects/NS9560K-datalake/ESGF/cmip5/output1/CCCma/CanESM2/historical/mon/atmos/Amon/r1i1p1/v20120718/tas/tas_Amon_CanESM2_historical_r1i1p1_185001-200512.nc 2023-05-23 12:01:26,042 UTC [1003141] INFO esmvalcore._recipe.recipe:717 Found input files for Dataset: tas, Amon, CMIP5, CanESM2, historical, r1i1p1, v20120718 2023-05-23 12:01:26,043 UTC [1003141] INFO esmvalcore._recipe.recipe:873 PreprocessingTask example/tas created. 2023-05-23 12:01:26,047 UTC [1003141] DEBUG esmvalcore._recipe.recipe:874 PreprocessingTask example/tas will create the files: /projects/NS2980K/www/tomast/esmvaltool2.8.0/recipe_julia_20230523_120125/preproc/example/tas/CMIP5_CanESM2_Amon_historical_r1i1p1_tas_1997-1997.nc 2023-05-23 12:01:26,047 UTC [1003141] DEBUG esmvalcore._recipe.recipe:1091 Linking tasks for diagnostic example script main 2023-05-23 12:01:26,048 UTC [1003141] DEBUG esmvalcore._recipe.recipe:1100 Pattern example/tas matches ['example/tas'] 2023-05-23 12:01:26,048 UTC [1003141] INFO esmvalcore._recipe.recipe:1281 These tasks will be executed: example/tas, example/main 2023-05-23 12:01:26,049 UTC [1003141] DEBUG esmvalcore._main:120 Recipe summary: DiagnosticTask: example/main script: examples/diagnostic.jl settings: {'auxiliary_data_dir': PosixPath('/projects/NS9252K/share/esmvaltool/auxiliary_data'), 'log_level': 'info', 'output_file_type': 'png', 'parameter1': 1, 'plot_dir': '/projects/NS2980K/www/tomast/esmvaltool2.8.0/recipe_julia_20230523_120125/plots/example/main', 'profile_diagnostic': False, 'recipe': PosixPath('recipe_julia.yml'), 'run_dir': '/projects/NS2980K/www/tomast/esmvaltool2.8.0/recipe_julia_20230523_120125/run/example/main', 'script': 'main', 'version': '2.8.0', 'work_dir': '/projects/NS2980K/www/tomast/esmvaltool2.8.0/recipe_julia_20230523_120125/work/example/main'} ancestors: PreprocessingTask: example/tas order: ['load', 'regrid', 'remove_supplementary_variables', 'save'] PreprocessorFile: /projects/NS2980K/www/tomast/esmvaltool2.8.0/recipe_julia_20230523_120125/preproc/example/tas/CMIP5_CanESM2_Amon_historical_r1i1p1_tas_1997-1997.nc input files: [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/CCCma/CanESM2/historical/mon/atmos/Amon/r1i1p1/v20120718/tas/tas_Amon_CanESM2_historical_r1i1p1_185001-200512.nc')] settings: {'load': {'callback': 'default'}, 'regrid': {'scheme': 'linear', 'target_grid': '1x1'}, 'remove_supplementary_variables': {}, 'save': {'compress': False, 'filename': PosixPath('/projects/NS2980K/www/tomast/esmvaltool2.8.0/recipe_julia_20230523_120125/preproc/example/tas/CMIP5_CanESM2_Amon_historical_r1i1p1_tas_1997-1997.nc')}} ancestors: None 2023-05-23 12:01:26,052 UTC [1003141] INFO esmvalcore._recipe.recipe:1344 Wrote recipe with version numbers and wildcards to: file:///projects/NS2980K/www/tomast/esmvaltool2.8.0/recipe_julia_20230523_120125/run/recipe_julia_filled.yml 2023-05-23 12:01:26,053 UTC [1003141] INFO esmvalcore._task:746 Running 2 tasks using 2 processes 2023-05-23 12:01:26,089 UTC [1003283] INFO esmvalcore._task:259 Starting task example/tas in process [1003283] 2023-05-23 12:01:26,176 UTC [1003283] DEBUG esmvalcore.preprocessor:660 Running block ['regrid'] 2023-05-23 12:01:26,176 UTC [1003283] DEBUG esmvalcore.preprocessor:667 Applying single-model steps to PreprocessorFile: /projects/NS2980K/www/tomast/esmvaltool2.8.0/recipe_julia_20230523_120125/preproc/example/tas/CMIP5_CanESM2_Amon_historical_r1i1p1_tas_1997-1997.nc 2023-05-23 12:01:26,177 UTC [1003283] DEBUG esmvalcore.esgf._download:535 All required data is available locally, not downloading anything. 2023-05-23 12:01:26,178 UTC [1003283] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_file 2023-05-23 12:01:26,179 UTC [1003283] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'fix_file' on the data LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/CCCma/CanESM2/historical/mon/atmos/Amon/r1i1p1/v20120718/tas/tas_Amon_CanESM2_historical_r1i1p1_185001-200512.nc') loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/CCCma/CanESM2/historical/mon/atmos/Amon/r1i1p1/v20120718/tas/tas_Amon_CanESM2_historical_r1i1p1_185001-200512.nc')] with function argument(s) output_dir = PosixPath('/projects/NS2980K/www/tomast/esmvaltool2.8.0/recipe_julia_20230523_120125/preproc/fixed_files/tas_Amon_CMIP5_CanESM2_historical_r1i1p1_v20120718_'), add_unique_suffix = True, mip = 'Amon', preprocessor = 'preproc', reference_dataset = 'CanESM2', dataset = 'CanESM2', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', short_name = 'tas', timerange = '1997/1997', variable_group = 'tas', diagnostic = 'example', recipe_dataset_index = 0, alias = 'CanESM2', product = ['output1', 'output2'], institute = ['CCCma', 'CCCMA'], original_short_name = 'tas', standard_name = 'air_temperature', long_name = 'Near-Surface Air Temperature', units = 'K', modeling_realm = ['atmos'], frequency = 'mon', version = 'v20120718' 2023-05-23 12:01:26,180 UTC [1003283] DEBUG esmvalcore.preprocessor:369 Running preprocessor step load 2023-05-23 12:01:26,180 UTC [1003283] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'load' on the data LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/CCCma/CanESM2/historical/mon/atmos/Amon/r1i1p1/v20120718/tas/tas_Amon_CanESM2_historical_r1i1p1_185001-200512.nc') loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/CCCma/CanESM2/historical/mon/atmos/Amon/r1i1p1/v20120718/tas/tas_Amon_CanESM2_historical_r1i1p1_185001-200512.nc')] with function argument(s) callback = 'default' 2023-05-23 12:01:26,180 UTC [1003283] DEBUG esmvalcore.preprocessor._io:152 Loading: /projects/NS9560K-datalake/ESGF/cmip5/output1/CCCma/CanESM2/historical/mon/atmos/Amon/r1i1p1/v20120718/tas/tas_Amon_CanESM2_historical_r1i1p1_185001-200512.nc 2023-05-23 12:01:26,184 UTC [1003141] INFO esmvalcore._task:778 Progress: 1 tasks running, 1 tasks waiting for ancestors, 0/2 done 2023-05-23 12:01:26,329 UTC [1003283] DEBUG esmvalcore.preprocessor._io:182 Done with loading /projects/NS9560K-datalake/ESGF/cmip5/output1/CCCma/CanESM2/historical/mon/atmos/Amon/r1i1p1/v20120718/tas/tas_Amon_CanESM2_historical_r1i1p1_185001-200512.nc 2023-05-23 12:01:26,329 UTC [1003283] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_metadata 2023-05-23 12:01:26,332 UTC [1003283] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'fix_metadata' on the data [] loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/CCCma/CanESM2/historical/mon/atmos/Amon/r1i1p1/v20120718/tas/tas_Amon_CanESM2_historical_r1i1p1_185001-200512.nc')] with function argument(s) check_level = , mip = 'Amon', preprocessor = 'preproc', reference_dataset = 'CanESM2', dataset = 'CanESM2', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', short_name = 'tas', timerange = '1997/1997', variable_group = 'tas', diagnostic = 'example', recipe_dataset_index = 0, alias = 'CanESM2', product = ['output1', 'output2'], institute = ['CCCma', 'CCCMA'], original_short_name = 'tas', standard_name = 'air_temperature', long_name = 'Near-Surface Air Temperature', units = 'K', modeling_realm = ['atmos'], frequency = 'mon', version = 'v20120718' 2023-05-23 12:01:26,339 UTC [1003283] DEBUG esmvalcore.preprocessor:369 Running preprocessor step concatenate 2023-05-23 12:01:26,388 UTC [1003283] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'concatenate' on the data [] loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/CCCma/CanESM2/historical/mon/atmos/Amon/r1i1p1/v20120718/tas/tas_Amon_CanESM2_historical_r1i1p1_185001-200512.nc')] with function argument(s) 2023-05-23 12:01:26,388 UTC [1003283] DEBUG esmvalcore.preprocessor:369 Running preprocessor step cmor_check_metadata 2023-05-23 12:01:26,389 UTC [1003283] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'cmor_check_metadata' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/CCCma/CanESM2/historical/mon/atmos/Amon/r1i1p1/v20120718/tas/tas_Amon_CanESM2_historical_r1i1p1_185001-200512.nc')] with function argument(s) check_level = , cmor_table = 'CMIP5', mip = 'Amon', frequency = 'mon', short_name = 'tas' 2023-05-23 12:01:26,494 UTC [1003283] DEBUG esmvalcore.preprocessor:369 Running preprocessor step clip_timerange 2023-05-23 12:01:26,496 UTC [1003283] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'clip_timerange' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/CCCma/CanESM2/historical/mon/atmos/Amon/r1i1p1/v20120718/tas/tas_Amon_CanESM2_historical_r1i1p1_185001-200512.nc')] with function argument(s) timerange = '1997/1997' 2023-05-23 12:01:26,508 UTC [1003283] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_data 2023-05-23 12:01:26,509 UTC [1003283] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'fix_data' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/CCCma/CanESM2/historical/mon/atmos/Amon/r1i1p1/v20120718/tas/tas_Amon_CanESM2_historical_r1i1p1_185001-200512.nc')] with function argument(s) check_level = , mip = 'Amon', preprocessor = 'preproc', reference_dataset = 'CanESM2', dataset = 'CanESM2', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', short_name = 'tas', timerange = '1997/1997', variable_group = 'tas', diagnostic = 'example', recipe_dataset_index = 0, alias = 'CanESM2', product = ['output1', 'output2'], institute = ['CCCma', 'CCCMA'], original_short_name = 'tas', standard_name = 'air_temperature', long_name = 'Near-Surface Air Temperature', units = 'K', modeling_realm = ['atmos'], frequency = 'mon', version = 'v20120718' 2023-05-23 12:01:26,509 UTC [1003283] DEBUG esmvalcore.preprocessor:369 Running preprocessor step cmor_check_data 2023-05-23 12:01:26,510 UTC [1003283] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'cmor_check_data' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/CCCma/CanESM2/historical/mon/atmos/Amon/r1i1p1/v20120718/tas/tas_Amon_CanESM2_historical_r1i1p1_185001-200512.nc')] with function argument(s) check_level = , cmor_table = 'CMIP5', mip = 'Amon', frequency = 'mon', short_name = 'tas' 2023-05-23 12:01:26,511 UTC [1003283] DEBUG esmvalcore.preprocessor:369 Running preprocessor step add_supplementary_variables 2023-05-23 12:01:26,511 UTC [1003283] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'add_supplementary_variables' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/CCCma/CanESM2/historical/mon/atmos/Amon/r1i1p1/v20120718/tas/tas_Amon_CanESM2_historical_r1i1p1_185001-200512.nc')] with function argument(s) supplementary_cubes = [] 2023-05-23 12:01:26,511 UTC [1003283] DEBUG esmvalcore.preprocessor:369 Running preprocessor step regrid 2023-05-23 12:01:26,512 UTC [1003283] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'regrid' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/CCCma/CanESM2/historical/mon/atmos/Amon/r1i1p1/v20120718/tas/tas_Amon_CanESM2_historical_r1i1p1_185001-200512.nc')] with function argument(s) scheme = 'linear', target_grid = '1x1' 2023-05-23 12:01:26,517 UTC [1003283] DEBUG esmvalcore.preprocessor:369 Running preprocessor step save 2023-05-23 12:01:26,518 UTC [1003283] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'save' on the data [] loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/CCCma/CanESM2/historical/mon/atmos/Amon/r1i1p1/v20120718/tas/tas_Amon_CanESM2_historical_r1i1p1_185001-200512.nc')] with function argument(s) compress = False, filename = PosixPath('/projects/NS2980K/www/tomast/esmvaltool2.8.0/recipe_julia_20230523_120125/preproc/example/tas/CMIP5_CanESM2_Amon_historical_r1i1p1_tas_1997-1997.nc') 2023-05-23 12:01:26,519 UTC [1003283] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS2980K/www/tomast/esmvaltool2.8.0/recipe_julia_20230523_120125/preproc/example/tas/CMIP5_CanESM2_Amon_historical_r1i1p1_tas_1997-1997.nc 2023-05-23 12:01:26,931 UTC [1003283] INFO esmvalcore._task:264 Successfully completed task example/tas (priority 1) in 0:00:00.842142 2023-05-23 12:01:26,986 UTC [1003141] INFO esmvalcore._task:778 Progress: 0 tasks running, 1 tasks waiting for ancestors, 1/2 done 2023-05-23 12:01:26,990 UTC [1003284] INFO esmvalcore._task:259 Starting task example/main in process [1003284] 2023-05-23 12:01:26,993 UTC [1003284] INFO esmvalcore._task:500 Running command ['/projects/NS2980K/conda/esmvaltool2.8.0/bin/julia', '/projects/NS2980K/conda/esmvaltool2.8.0/lib/python3.10/site-packages/esmvaltool/diag_scripts/examples/diagnostic.jl', '/projects/NS2980K/www/tomast/esmvaltool2.8.0/recipe_julia_20230523_120125/run/example/main/settings.yml'] 2023-05-23 12:01:26,993 UTC [1003284] DEBUG esmvalcore._task:501 in environment {'JULIA_LOAD_PATH': '/projects/NS2980K/conda/esmvaltool2.8.0/lib/python3.10/site-packages/esmvaltool/install/Julia:@:@esmvaltool2.8.0:@stdlib', 'MPLBACKEND': 'Agg'} 2023-05-23 12:01:26,993 UTC [1003284] DEBUG esmvalcore._task:503 in current working directory: /projects/NS2980K/www/tomast/esmvaltool2.8.0/recipe_julia_20230523_120125/run/example/main 2023-05-23 12:01:26,993 UTC [1003284] INFO esmvalcore._task:504 Writing output to /projects/NS2980K/www/tomast/esmvaltool2.8.0/recipe_julia_20230523_120125/work/example/main 2023-05-23 12:01:26,993 UTC [1003284] INFO esmvalcore._task:505 Writing plots to /projects/NS2980K/www/tomast/esmvaltool2.8.0/recipe_julia_20230523_120125/plots/example/main 2023-05-23 12:01:26,993 UTC [1003284] INFO esmvalcore._task:506 Writing log to /projects/NS2980K/www/tomast/esmvaltool2.8.0/recipe_julia_20230523_120125/run/example/main/log.txt 2023-05-23 12:01:26,994 UTC [1003284] INFO esmvalcore._task:516 To re-run this diagnostic script, run: cd /projects/NS2980K/www/tomast/esmvaltool2.8.0/recipe_julia_20230523_120125/run/example/main; MPLBACKEND="Agg" JULIA_LOAD_PATH="/projects/NS2980K/conda/esmvaltool2.8.0/lib/python3.10/site-packages/esmvaltool/install/Julia:@:@esmvaltool2.8.0:@stdlib" /projects/NS2980K/conda/esmvaltool2.8.0/bin/julia /projects/NS2980K/conda/esmvaltool2.8.0/lib/python3.10/site-packages/esmvaltool/diag_scripts/examples/diagnostic.jl /projects/NS2980K/www/tomast/esmvaltool2.8.0/recipe_julia_20230523_120125/run/example/main/settings.yml 2023-05-23 12:01:27,086 UTC [1003141] INFO esmvalcore._task:778 Progress: 1 tasks running, 0 tasks waiting for ancestors, 1/2 done 2023-05-23 12:02:28,220 UTC [1003284] INFO esmvalcore._task:126 Maximum memory used (estimate): 0.9 GB 2023-05-23 12:02:28,222 UTC [1003284] INFO esmvalcore._task:128 Sampled every second. It may be inaccurate if short but high spikes in memory consumption occur. 2023-05-23 12:02:28,222 UTC [1003284] DEBUG esmvalcore._task:589 Script examples/diagnostic.jl completed successfully 2023-05-23 12:02:28,222 UTC [1003284] DEBUG esmvalcore._task:608 Collecting provenance from /projects/NS2980K/www/tomast/esmvaltool2.8.0/recipe_julia_20230523_120125/run/example/main/diagnostic_provenance.yml 2023-05-23 12:02:28,289 UTC [1003284] DEBUG PIL.PngImagePlugin:204 STREAM b'IHDR' 16 13 2023-05-23 12:02:28,290 UTC [1003284] DEBUG PIL.PngImagePlugin:204 STREAM b'tEXt' 41 57 2023-05-23 12:02:28,290 UTC [1003284] DEBUG PIL.PngImagePlugin:204 STREAM b'pHYs' 110 9 2023-05-23 12:02:28,290 UTC [1003284] DEBUG PIL.PngImagePlugin:204 STREAM b'IDAT' 131 65536 2023-05-23 12:02:28,339 UTC [1003284] DEBUG esmvalcore._task:683 Collecting provenance of task example/main took 0.1 seconds 2023-05-23 12:02:28,339 UTC [1003284] INFO esmvalcore._task:264 Successfully completed task example/main (priority 0) in 0:01:01.348697 2023-05-23 12:02:28,354 UTC [1003141] INFO esmvalcore._task:778 Progress: 0 tasks running, 0 tasks waiting for ancestors, 2/2 done 2023-05-23 12:02:28,355 UTC [1003141] INFO esmvalcore._task:783 Successfully completed all tasks. 2023-05-23 12:02:28,372 UTC [1003141] INFO esmvalcore._recipe.recipe:1309 Wrote recipe with version numbers and wildcards to: file:///projects/NS2980K/www/tomast/esmvaltool2.8.0/recipe_julia_20230523_120125/run/recipe_julia_filled.yml 2023-05-23 12:02:28,405 UTC [1003141] INFO esmvalcore.experimental.recipe_output:205 Wrote recipe output to: file:///projects/NS2980K/www/tomast/esmvaltool2.8.0/recipe_julia_20230523_120125/index.html 2023-05-23 12:02:28,405 UTC [1003141] INFO esmvalcore._main:125 Ending the Earth System Model Evaluation Tool at time: 2023-05-23 12:02:28 UTC 2023-05-23 12:02:28,405 UTC [1003141] INFO esmvalcore._main:128 Time for running the recipe was: 0:01:02.441761 2023-05-23 12:02:28,443 UTC [1003141] INFO esmvalcore._task:126 Maximum memory used (estimate): 1.9 GB 2023-05-23 12:02:28,444 UTC [1003141] INFO esmvalcore._task:128 Sampled every second. It may be inaccurate if short but high spikes in memory consumption occur. 2023-05-23 12:02:28,444 UTC [1003141] INFO esmvalcore._main:473 Removing `preproc` directory containing preprocessed data 2023-05-23 12:02:28,444 UTC [1003141] INFO esmvalcore._main:476 If this data is further needed, then set `remove_preproc_dir` to `false` in your user configuration file 2023-05-23 12:02:28,445 UTC [1003141] INFO esmvalcore._main:453 Run was successful