2023-05-31 09:09:08,240 UTC [645282] 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-31 09:09:08,240 UTC [645282] INFO esmvalcore._main:496 Package versions 2023-05-31 09:09:08,240 UTC [645282] INFO esmvalcore._main:497 ---------------- 2023-05-31 09:09:08,240 UTC [645282] INFO esmvalcore._main:498 ESMValCore: 2.8.0 2023-05-31 09:09:08,240 UTC [645282] INFO esmvalcore._main:500 ESMValTool: 2.8.0 2023-05-31 09:09:08,240 UTC [645282] INFO esmvalcore._main:501 ---------------- 2023-05-31 09:09:08,240 UTC [645282] INFO esmvalcore._main:502 Using config file /nird/home/agu002/.esmvaltool/config-user.yml 2023-05-31 09:09:08,241 UTC [645282] INFO esmvalcore._main:503 Writing program log files to: /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/run/main_log.txt /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/run/main_log_debug.txt 2023-05-31 09:09:08,914 UTC [645282] INFO esmvalcore._main:85 Starting the Earth System Model Evaluation Tool at time: 2023-05-31 09:09:08 UTC 2023-05-31 09:09:08,915 UTC [645282] INFO esmvalcore._main:89 ---------------------------------------------------------------------- 2023-05-31 09:09:08,915 UTC [645282] INFO esmvalcore._main:90 RECIPE = /nird/home/agu002/noresmvaltool/esmvaltool/recipe_python.yml 2023-05-31 09:09:08,915 UTC [645282] INFO esmvalcore._main:91 RUNDIR = /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/run 2023-05-31 09:09:08,915 UTC [645282] INFO esmvalcore._main:92 WORKDIR = /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/work 2023-05-31 09:09:08,915 UTC [645282] INFO esmvalcore._main:93 PREPROCDIR = /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc 2023-05-31 09:09:08,915 UTC [645282] INFO esmvalcore._main:94 PLOTDIR = /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/plots 2023-05-31 09:09:08,915 UTC [645282] INFO esmvalcore._main:95 ---------------------------------------------------------------------- 2023-05-31 09:09:08,917 UTC [645282] INFO esmvalcore._main:98 Running tasks using at most 2 processes 2023-05-31 09:09:08,917 UTC [645282] 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-31 09:09:08,917 UTC [645282] INFO esmvalcore._main:103 If you experience memory problems, try reducing 'max_parallel_tasks' in your user configuration file. 2023-05-31 09:09:08,918 UTC [645282] DEBUG esmvalcore._recipe.check:52 Checking recipe against schema /diagnostics/esmvaltool/2.8.0/lib/python3.10/site-packages/esmvalcore/_recipe/recipe_schema.yml 2023-05-31 09:09:08,946 UTC [645282] DEBUG esmvalcore._recipe.to_datasets:344 Populating list of datasets for variable tas in diagnostic map 2023-05-31 09:09:08,946 UTC [645282] DEBUG esmvalcore._recipe.to_datasets:368 Found Dataset: tas, Amon, CMIP6, BCC-ESM1, historical, r1i1p1f1, gn 2023-05-31 09:09:08,947 UTC [645282] DEBUG esmvalcore._recipe.to_datasets:368 Found Dataset: tas, Amon, CMIP5, bcc-csm1-1, historical, r1i1p1 2023-05-31 09:09:08,947 UTC [645282] DEBUG esmvalcore._recipe.to_datasets:344 Populating list of datasets for variable tas_bergen in diagnostic timeseries 2023-05-31 09:09:08,947 UTC [645282] DEBUG esmvalcore._recipe.to_datasets:368 Found Dataset: tas, Amon, CMIP6, BCC-ESM1, historical, r1i1p1f1, gn 2023-05-31 09:09:08,947 UTC [645282] DEBUG esmvalcore._recipe.to_datasets:368 Found Dataset: tas, Amon, CMIP5, bcc-csm1-1, historical, r1i1p1 2023-05-31 09:09:08,947 UTC [645282] DEBUG esmvalcore._recipe.to_datasets:344 Populating list of datasets for variable tas_global in diagnostic timeseries 2023-05-31 09:09:08,948 UTC [645282] WARNING esmvalcore.local:426 'CMIP6' rootpaths '/scratch/agu002/ESGF/CMIP6' set in config-user.yml do not exist 2023-05-31 09:09:08,949 UTC [645282] DEBUG esmvalcore.local:458 Looking for files matching: /projects/NS9034K/CMIP6/*/*/BCC-ESM1/*/*/fx/areacella/gn/*/areacella_fx_BCC-ESM1_*_*_gn*.nc /projects/NS9560K-datalake/ESGF/CMIP6/*/*/BCC-ESM1/*/*/fx/areacella/gn/*/areacella_fx_BCC-ESM1_*_*_gn*.nc /scratch/agu002/ESGF/CMIP6/*/*/BCC-ESM1/*/*/fx/areacella/gn/*/areacella_fx_BCC-ESM1_*_*_gn*.nc 2023-05-31 09:09:08,956 UTC [645282] DEBUG esmvalcore._recipe.to_datasets:368 Found Dataset: tas, Amon, CMIP6, BCC-ESM1, historical, r1i1p1f1, gn, supplementaries: areacella, fx, CMIP, 1pctCO2 2023-05-31 09:09:08,957 UTC [645282] DEBUG esmvalcore.config._config:48 Loading extra facets from /diagnostics/esmvaltool/2.8.0/lib/python3.10/site-packages/esmvalcore/config/extra_facets/cmip5-fx.yml 2023-05-31 09:09:08,958 UTC [645282] DEBUG esmvalcore.config._config:48 Loading extra facets from /diagnostics/esmvaltool/2.8.0/lib/python3.10/site-packages/esmvalcore/config/extra_facets/cmip5-institutes.yml 2023-05-31 09:09:08,986 UTC [645282] DEBUG esmvalcore.config._config:48 Loading extra facets from /diagnostics/esmvaltool/2.8.0/lib/python3.10/site-packages/esmvalcore/config/extra_facets/cmip5-product.yml 2023-05-31 09:09:08,992 UTC [645282] WARNING esmvalcore.local:426 'CMIP5' rootpaths '/scratch/agu002/ESGF/cmip5/output1' set in config-user.yml do not exist 2023-05-31 09:09:08,993 UTC [645282] DEBUG esmvalcore.local:458 Looking for files matching: /projects/NS9034K/CMIP5/output1/*/bcc-csm1-1/*/fx/atmos/fx/*/*/areacella/areacella_fx_bcc-csm1-1_*_**.nc /projects/NS9034K/CMIP5/output1/*/bcc-csm1-1/*/fx/land/fx/*/*/areacella/areacella_fx_bcc-csm1-1_*_**.nc /projects/NS9560K-datalake/ESGF/cmip5/output1/*/bcc-csm1-1/*/fx/atmos/fx/*/*/areacella/areacella_fx_bcc-csm1-1_*_**.nc /projects/NS9560K-datalake/ESGF/cmip5/output1/*/bcc-csm1-1/*/fx/land/fx/*/*/areacella/areacella_fx_bcc-csm1-1_*_**.nc /scratch/agu002/ESGF/cmip5/output1/*/bcc-csm1-1/*/fx/atmos/fx/*/*/areacella/areacella_fx_bcc-csm1-1_*_**.nc /scratch/agu002/ESGF/cmip5/output1/*/bcc-csm1-1/*/fx/land/fx/*/*/areacella/areacella_fx_bcc-csm1-1_*_**.nc 2023-05-31 09:09:08,995 UTC [645282] INFO esmvalcore.dataset:314 For Dataset: tas, Amon, CMIP5, bcc-csm1-1, historical, r1i1p1, supplementaries: areacella, *, *, *: ignoring supplementary variable 'areacella', unable to expand wildcards 'mip', 'exp', 'ensemble', 'institute', 'product'. 2023-05-31 09:09:08,996 UTC [645282] DEBUG esmvalcore._recipe.to_datasets:368 Found Dataset: tas, Amon, CMIP5, bcc-csm1-1, historical, r1i1p1 2023-05-31 09:09:08,996 UTC [645282] DEBUG esmvalcore._recipe.recipe:1014 Retrieving diagnostics from recipe 2023-05-31 09:09:08,996 UTC [645282] DEBUG esmvalcore._recipe.recipe:1042 Setting script for diagnostic map 2023-05-31 09:09:08,996 UTC [645282] DEBUG esmvalcore._recipe.recipe:1042 Setting script for diagnostic timeseries 2023-05-31 09:09:08,997 UTC [645282] INFO esmvalcore._recipe.recipe:1232 Creating tasks from recipe 2023-05-31 09:09:08,997 UTC [645282] INFO esmvalcore._recipe.recipe:1241 Creating tasks for diagnostic map 2023-05-31 09:09:08,997 UTC [645282] INFO esmvalcore._recipe.recipe:1163 Creating diagnostic task map/script1 2023-05-31 09:09:08,997 UTC [645282] INFO esmvalcore._recipe.recipe:1216 Creating preprocessor task map/tas 2023-05-31 09:09:08,997 UTC [645282] INFO esmvalcore._recipe.recipe:849 Creating preprocessor 'to_degrees_c' task for variable 'tas' 2023-05-31 09:09:08,997 UTC [645282] DEBUG esmvalcore.local:458 Looking for files matching: /projects/NS9034K/CMIP6/CMIP/BCC/BCC-ESM1/historical/r1i1p1f1/Amon/tas/gn/*/tas_Amon_BCC-ESM1_historical_r1i1p1f1_gn*.nc /projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/historical/r1i1p1f1/Amon/tas/gn/*/tas_Amon_BCC-ESM1_historical_r1i1p1f1_gn*.nc /scratch/agu002/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/historical/r1i1p1f1/Amon/tas/gn/*/tas_Amon_BCC-ESM1_historical_r1i1p1f1_gn*.nc 2023-05-31 09:09:09,003 UTC [645282] DEBUG esmvalcore._recipe.recipe:446 Using input files for variable tas of dataset CMIP6: /projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/historical/r1i1p1f1/Amon/tas/gn/v20181214/tas_Amon_BCC-ESM1_historical_r1i1p1f1_gn_185001-201412.nc 2023-05-31 09:09:09,003 UTC [645282] INFO esmvalcore._recipe.recipe:717 Found input files for Dataset: tas, Amon, CMIP6, BCC-ESM1, CMIP, historical, r1i1p1f1, gn, v20181214 2023-05-31 09:09:09,004 UTC [645282] DEBUG esmvalcore.local:458 Looking for files matching: /projects/NS9034K/CMIP5/output1/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/*/tas/tas_Amon_bcc-csm1-1_historical_r1i1p1*.nc /projects/NS9560K-datalake/ESGF/cmip5/output1/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/*/tas/tas_Amon_bcc-csm1-1_historical_r1i1p1*.nc /scratch/agu002/ESGF/cmip5/output1/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/*/tas/tas_Amon_bcc-csm1-1_historical_r1i1p1*.nc 2023-05-31 09:09:09,005 UTC [645282] DEBUG esmvalcore._recipe.recipe:446 Using input files for variable tas of dataset CMIP5: /projects/NS9560K-datalake/ESGF/cmip5/output1/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/tas/tas_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc 2023-05-31 09:09:09,005 UTC [645282] INFO esmvalcore._recipe.recipe:717 Found input files for Dataset: tas, Amon, CMIP5, bcc-csm1-1, historical, r1i1p1, v1 2023-05-31 09:09:09,007 UTC [645282] INFO esmvalcore._recipe.recipe:873 PreprocessingTask map/tas created. 2023-05-31 09:09:09,007 UTC [645282] DEBUG esmvalcore._recipe.recipe:874 PreprocessingTask map/tas will create the files: /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/map/tas/CMIP6_BCC-ESM1_Amon_historical_r1i1p1f1_tas_gn_2000-P1M.nc /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/map/tas/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_tas_2000-P1M.nc 2023-05-31 09:09:09,007 UTC [645282] INFO esmvalcore._recipe.recipe:1241 Creating tasks for diagnostic timeseries 2023-05-31 09:09:09,007 UTC [645282] INFO esmvalcore._recipe.recipe:1163 Creating diagnostic task timeseries/script1 2023-05-31 09:09:09,007 UTC [645282] INFO esmvalcore._recipe.recipe:1216 Creating preprocessor task timeseries/tas_bergen 2023-05-31 09:09:09,007 UTC [645282] INFO esmvalcore._recipe.recipe:849 Creating preprocessor 'annual_mean_bergen' task for variable 'tas_bergen' 2023-05-31 09:09:09,008 UTC [645282] DEBUG esmvalcore.local:458 Looking for files matching: /projects/NS9034K/CMIP6/CMIP/BCC/BCC-ESM1/historical/r1i1p1f1/Amon/tas/gn/*/tas_Amon_BCC-ESM1_historical_r1i1p1f1_gn*.nc /projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/historical/r1i1p1f1/Amon/tas/gn/*/tas_Amon_BCC-ESM1_historical_r1i1p1f1_gn*.nc /scratch/agu002/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/historical/r1i1p1f1/Amon/tas/gn/*/tas_Amon_BCC-ESM1_historical_r1i1p1f1_gn*.nc 2023-05-31 09:09:09,009 UTC [645282] DEBUG esmvalcore._recipe.recipe:446 Using input files for variable tas of dataset CMIP6: /projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/historical/r1i1p1f1/Amon/tas/gn/v20181214/tas_Amon_BCC-ESM1_historical_r1i1p1f1_gn_185001-201412.nc 2023-05-31 09:09:09,009 UTC [645282] INFO esmvalcore._recipe.recipe:717 Found input files for Dataset: tas, Amon, CMIP6, BCC-ESM1, CMIP, historical, r1i1p1f1, gn, v20181214 2023-05-31 09:09:09,009 UTC [645282] DEBUG esmvalcore.local:458 Looking for files matching: /projects/NS9034K/CMIP5/output1/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/*/tas/tas_Amon_bcc-csm1-1_historical_r1i1p1*.nc /projects/NS9560K-datalake/ESGF/cmip5/output1/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/*/tas/tas_Amon_bcc-csm1-1_historical_r1i1p1*.nc /scratch/agu002/ESGF/cmip5/output1/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/*/tas/tas_Amon_bcc-csm1-1_historical_r1i1p1*.nc 2023-05-31 09:09:09,010 UTC [645282] DEBUG esmvalcore._recipe.recipe:446 Using input files for variable tas of dataset CMIP5: /projects/NS9560K-datalake/ESGF/cmip5/output1/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/tas/tas_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc 2023-05-31 09:09:09,010 UTC [645282] INFO esmvalcore._recipe.recipe:717 Found input files for Dataset: tas, Amon, CMIP5, bcc-csm1-1, historical, r1i1p1, v1 2023-05-31 09:09:09,012 UTC [645282] INFO esmvalcore._recipe.recipe:873 PreprocessingTask timeseries/tas_bergen created. 2023-05-31 09:09:09,012 UTC [645282] DEBUG esmvalcore._recipe.recipe:874 PreprocessingTask timeseries/tas_bergen will create the files: /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_bergen/CMIP6_BCC-ESM1_Amon_historical_r1i1p1f1_tas_gn_1850-2000.nc /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_bergen/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_tas_1850-2000.nc 2023-05-31 09:09:09,012 UTC [645282] INFO esmvalcore._recipe.recipe:1216 Creating preprocessor task timeseries/tas_global 2023-05-31 09:09:09,012 UTC [645282] INFO esmvalcore._recipe.recipe:849 Creating preprocessor 'annual_mean_global' task for variable 'tas_global' 2023-05-31 09:09:09,013 UTC [645282] DEBUG esmvalcore.local:458 Looking for files matching: /projects/NS9034K/CMIP6/CMIP/BCC/BCC-ESM1/historical/r1i1p1f1/Amon/tas/gn/*/tas_Amon_BCC-ESM1_historical_r1i1p1f1_gn*.nc /projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/historical/r1i1p1f1/Amon/tas/gn/*/tas_Amon_BCC-ESM1_historical_r1i1p1f1_gn*.nc /scratch/agu002/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/historical/r1i1p1f1/Amon/tas/gn/*/tas_Amon_BCC-ESM1_historical_r1i1p1f1_gn*.nc 2023-05-31 09:09:09,014 UTC [645282] DEBUG esmvalcore.local:458 Looking for files matching: /projects/NS9034K/CMIP6/CMIP/BCC/BCC-ESM1/1pctCO2/r1i1p1f1/fx/areacella/gn/*/areacella_fx_BCC-ESM1_1pctCO2_r1i1p1f1_gn*.nc /projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/1pctCO2/r1i1p1f1/fx/areacella/gn/*/areacella_fx_BCC-ESM1_1pctCO2_r1i1p1f1_gn*.nc /scratch/agu002/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/1pctCO2/r1i1p1f1/fx/areacella/gn/*/areacella_fx_BCC-ESM1_1pctCO2_r1i1p1f1_gn*.nc 2023-05-31 09:09:09,015 UTC [645282] DEBUG esmvalcore._recipe.recipe:446 Using input files for variable tas of dataset CMIP6: /projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/historical/r1i1p1f1/Amon/tas/gn/v20181214/tas_Amon_BCC-ESM1_historical_r1i1p1f1_gn_185001-201412.nc /projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/1pctCO2/r1i1p1f1/fx/areacella/gn/v20190613/areacella_fx_BCC-ESM1_1pctCO2_r1i1p1f1_gn.nc 2023-05-31 09:09:09,015 UTC [645282] INFO esmvalcore._recipe.recipe:717 Found input files for Dataset: tas, Amon, CMIP6, BCC-ESM1, CMIP, historical, r1i1p1f1, gn, v20181214, supplementaries: areacella, fx, 1pctCO2, v20190613 2023-05-31 09:09:09,016 UTC [645282] WARNING esmvalcore._recipe.check:204 Preprocessor function area_statistics works best when at least one supplementary variable of ['areacella', 'areacello'] is defined in the recipe for Dataset: {'diagnostic': 'timeseries', 'variable_group': 'tas_global', 'dataset': 'bcc-csm1-1', 'project': 'CMIP5', 'mip': 'Amon', 'short_name': 'tas', 'alias': 'CMIP5', 'caption': 'Annual global mean {long_name} according to {dataset}.', 'ensemble': 'r1i1p1', 'exp': 'historical', 'frequency': 'mon', 'institute': ['BCC'], 'long_name': 'Near-Surface Air Temperature', 'modeling_realm': ['atmos'], 'original_short_name': 'tas', 'preprocessor': 'annual_mean_global', 'product': ['output1', 'output2'], 'recipe_dataset_index': 1, 'standard_name': 'air_temperature', 'timerange': '1850/2000', 'units': 'K'} session: 'recipe_python_20230531_090908'. 2023-05-31 09:09:09,016 UTC [645282] DEBUG esmvalcore.local:458 Looking for files matching: /projects/NS9034K/CMIP5/output1/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/*/tas/tas_Amon_bcc-csm1-1_historical_r1i1p1*.nc /projects/NS9560K-datalake/ESGF/cmip5/output1/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/*/tas/tas_Amon_bcc-csm1-1_historical_r1i1p1*.nc /scratch/agu002/ESGF/cmip5/output1/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/*/tas/tas_Amon_bcc-csm1-1_historical_r1i1p1*.nc 2023-05-31 09:09:09,017 UTC [645282] DEBUG esmvalcore._recipe.recipe:446 Using input files for variable tas of dataset CMIP5: /projects/NS9560K-datalake/ESGF/cmip5/output1/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/tas/tas_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc 2023-05-31 09:09:09,017 UTC [645282] INFO esmvalcore._recipe.recipe:717 Found input files for Dataset: tas, Amon, CMIP5, bcc-csm1-1, historical, r1i1p1, v1 2023-05-31 09:09:09,019 UTC [645282] INFO esmvalcore._recipe.recipe:873 PreprocessingTask timeseries/tas_global created. 2023-05-31 09:09:09,019 UTC [645282] DEBUG esmvalcore._recipe.recipe:874 PreprocessingTask timeseries/tas_global will create the files: /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_global/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_tas_1850-2000.nc /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_global/CMIP6_BCC-ESM1_Amon_historical_r1i1p1f1_tas_gn_1850-2000.nc 2023-05-31 09:09:09,019 UTC [645282] DEBUG esmvalcore._recipe.recipe:1091 Linking tasks for diagnostic map script script1 2023-05-31 09:09:09,019 UTC [645282] DEBUG esmvalcore._recipe.recipe:1100 Pattern map/tas matches ['map/tas'] 2023-05-31 09:09:09,019 UTC [645282] DEBUG esmvalcore._recipe.recipe:1091 Linking tasks for diagnostic timeseries script script1 2023-05-31 09:09:09,019 UTC [645282] DEBUG esmvalcore._recipe.recipe:1100 Pattern timeseries/tas_bergen matches ['timeseries/tas_bergen'] 2023-05-31 09:09:09,019 UTC [645282] DEBUG esmvalcore._recipe.recipe:1100 Pattern timeseries/tas_global matches ['timeseries/tas_global'] 2023-05-31 09:09:09,019 UTC [645282] INFO esmvalcore._recipe.recipe:1281 These tasks will be executed: timeseries/tas_bergen, map/tas, map/script1, timeseries/script1, timeseries/tas_global 2023-05-31 09:09:09,022 UTC [645282] DEBUG esmvalcore._main:120 Recipe summary: DiagnosticTask: map/script1 script: examples/diagnostic.py settings: {'auxiliary_data_dir': PosixPath('/projects/NS9560K-datalake/ESGF/auxiliary_data'), 'log_level': 'info', 'output_file_type': 'png', 'plot_dir': '/projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/plots/map/script1', 'profile_diagnostic': False, 'quickplot': {'cmap': 'Reds', 'plot_type': 'pcolormesh'}, 'realms': ['atmos'], 'recipe': PosixPath('recipe_python.yml'), 'run_dir': '/projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/run/map/script1', 'script': 'script1', 'themes': ['phys'], 'version': '2.8.0', 'work_dir': '/projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/work/map/script1'} ancestors: PreprocessingTask: map/tas order: ['load', 'convert_units', 'remove_supplementary_variables', 'save'] PreprocessorFile: /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/map/tas/CMIP6_BCC-ESM1_Amon_historical_r1i1p1f1_tas_gn_2000-P1M.nc input files: [LocalFile('/projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/historical/r1i1p1f1/Amon/tas/gn/v20181214/tas_Amon_BCC-ESM1_historical_r1i1p1f1_gn_185001-201412.nc')] settings: {'convert_units': {'units': 'degrees_C'}, 'load': {'callback': 'default'}, 'remove_supplementary_variables': {}, 'save': {'compress': False, 'filename': PosixPath('/projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/map/tas/CMIP6_BCC-ESM1_Amon_historical_r1i1p1f1_tas_gn_2000-P1M.nc')}} PreprocessorFile: /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/map/tas/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_tas_2000-P1M.nc input files: [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/tas/tas_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc')] settings: {'convert_units': {'units': 'degrees_C'}, 'load': {'callback': 'default'}, 'remove_supplementary_variables': {}, 'save': {'compress': False, 'filename': PosixPath('/projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/map/tas/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_tas_2000-P1M.nc')}} ancestors: None DiagnosticTask: timeseries/script1 script: examples/diagnostic.py settings: {'auxiliary_data_dir': PosixPath('/projects/NS9560K-datalake/ESGF/auxiliary_data'), 'log_level': 'info', 'output_file_type': 'png', 'plot_dir': '/projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/plots/timeseries/script1', 'profile_diagnostic': False, 'quickplot': {'plot_type': 'plot'}, 'realms': ['atmos'], 'recipe': PosixPath('recipe_python.yml'), 'run_dir': '/projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/run/timeseries/script1', 'script': 'script1', 'themes': ['phys'], 'version': '2.8.0', 'work_dir': '/projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/work/timeseries/script1'} ancestors: PreprocessingTask: timeseries/tas_bergen order: ['load', 'extract_location', 'annual_statistics', 'convert_units', 'multi_model_statistics', 'remove_supplementary_variables', 'save'] PreprocessorFile: /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_bergen/CMIP6_BCC-ESM1_Amon_historical_r1i1p1f1_tas_gn_1850-2000.nc input files: [LocalFile('/projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/historical/r1i1p1f1/Amon/tas/gn/v20181214/tas_Amon_BCC-ESM1_historical_r1i1p1f1_gn_185001-201412.nc')] settings: {'annual_statistics': {'operator': 'mean'}, 'convert_units': {'units': 'degrees_C'}, 'extract_location': {'location': 'Bergen', 'scheme': 'linear'}, 'load': {'callback': 'default'}, 'multi_model_statistics': {'output_products': defaultdict(, {'': {'mean': PreprocessorFile: /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_bergen/MultiModelMean_historical_Amon_tas_1850-2000.nc}}), 'span': 'overlap', 'statistics': ['mean']}, 'remove_supplementary_variables': {}, 'save': {'compress': False, 'filename': PosixPath('/projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_bergen/CMIP6_BCC-ESM1_Amon_historical_r1i1p1f1_tas_gn_1850-2000.nc')}} PreprocessorFile: /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_bergen/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_tas_1850-2000.nc input files: [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/tas/tas_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc')] settings: {'annual_statistics': {'operator': 'mean'}, 'convert_units': {'units': 'degrees_C'}, 'extract_location': {'location': 'Bergen', 'scheme': 'linear'}, 'load': {'callback': 'default'}, 'multi_model_statistics': {'output_products': defaultdict(, {'': {'mean': PreprocessorFile: /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_bergen/MultiModelMean_historical_Amon_tas_1850-2000.nc}}), 'span': 'overlap', 'statistics': ['mean']}, 'remove_supplementary_variables': {}, 'save': {'compress': False, 'filename': PosixPath('/projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_bergen/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_tas_1850-2000.nc')}} ancestors: None PreprocessingTask: timeseries/tas_global order: ['load', 'area_statistics', 'annual_statistics', 'convert_units', 'remove_supplementary_variables', 'save'] PreprocessorFile: /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_global/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_tas_1850-2000.nc input files: [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/tas/tas_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc')] settings: {'annual_statistics': {'operator': 'mean'}, 'area_statistics': {'operator': 'mean'}, 'convert_units': {'units': 'degrees_C'}, 'load': {'callback': 'default'}, 'remove_supplementary_variables': {}, 'save': {'compress': False, 'filename': PosixPath('/projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_global/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_tas_1850-2000.nc')}} PreprocessorFile: /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_global/CMIP6_BCC-ESM1_Amon_historical_r1i1p1f1_tas_gn_1850-2000.nc input files: [LocalFile('/projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/historical/r1i1p1f1/Amon/tas/gn/v20181214/tas_Amon_BCC-ESM1_historical_r1i1p1f1_gn_185001-201412.nc'), LocalFile('/projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/1pctCO2/r1i1p1f1/fx/areacella/gn/v20190613/areacella_fx_BCC-ESM1_1pctCO2_r1i1p1f1_gn.nc')] settings: {'annual_statistics': {'operator': 'mean'}, 'area_statistics': {'operator': 'mean'}, 'convert_units': {'units': 'degrees_C'}, 'load': {'callback': 'default'}, 'remove_supplementary_variables': {}, 'save': {'compress': False, 'filename': PosixPath('/projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_global/CMIP6_BCC-ESM1_Amon_historical_r1i1p1f1_tas_gn_1850-2000.nc')}} ancestors: None 2023-05-31 09:09:09,033 UTC [645282] INFO esmvalcore._recipe.recipe:1344 Wrote recipe with version numbers and wildcards to: file:///projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/run/recipe_python_filled.yml 2023-05-31 09:09:09,034 UTC [645282] INFO esmvalcore._task:746 Running 5 tasks using 2 processes 2023-05-31 09:09:09,074 UTC [645421] INFO esmvalcore._task:259 Starting task map/tas in process [645421] 2023-05-31 09:09:09,074 UTC [645422] INFO esmvalcore._task:259 Starting task timeseries/tas_bergen in process [645422] 2023-05-31 09:09:09,170 UTC [645282] INFO esmvalcore._task:778 Progress: 2 tasks running, 3 tasks waiting for ancestors, 0/5 done 2023-05-31 09:09:09,203 UTC [645421] DEBUG esmvalcore.preprocessor:660 Running block ['convert_units'] 2023-05-31 09:09:09,203 UTC [645421] DEBUG esmvalcore.preprocessor:667 Applying single-model steps to PreprocessorFile: /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/map/tas/CMIP6_BCC-ESM1_Amon_historical_r1i1p1f1_tas_gn_2000-P1M.nc 2023-05-31 09:09:09,204 UTC [645422] DEBUG esmvalcore.preprocessor:660 Running block ['extract_location', 'annual_statistics', 'convert_units'] 2023-05-31 09:09:09,204 UTC [645421] DEBUG esmvalcore.esgf._download:535 All required data is available locally, not downloading anything. 2023-05-31 09:09:09,205 UTC [645421] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_file 2023-05-31 09:09:09,204 UTC [645422] DEBUG esmvalcore.preprocessor:667 Applying single-model steps to PreprocessorFile: /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_bergen/CMIP6_BCC-ESM1_Amon_historical_r1i1p1f1_tas_gn_1850-2000.nc 2023-05-31 09:09:09,205 UTC [645422] DEBUG esmvalcore.esgf._download:535 All required data is available locally, not downloading anything. 2023-05-31 09:09:09,205 UTC [645421] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'fix_file' on the data LocalFile('/projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/historical/r1i1p1f1/Amon/tas/gn/v20181214/tas_Amon_BCC-ESM1_historical_r1i1p1f1_gn_185001-201412.nc') loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/historical/r1i1p1f1/Amon/tas/gn/v20181214/tas_Amon_BCC-ESM1_historical_r1i1p1f1_gn_185001-201412.nc')] with function argument(s) output_dir = PosixPath('/projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/fixed_files/tas_Amon_CMIP6_BCC-ESM1_CMIP_historical_r1i1p1f1_gn_v20181214_'), add_unique_suffix = True, mip = 'Amon', preprocessor = 'to_degrees_c', timerange = '2000/P1M', caption = 'Global map of {long_name} in January 2000 according to {dataset}.\n', dataset = 'BCC-ESM1', project = 'CMIP6', exp = 'historical', ensemble = 'r1i1p1f1', grid = 'gn', short_name = 'tas', variable_group = 'tas', diagnostic = 'map', recipe_dataset_index = 0, alias = 'CMIP6', institute = ['BCC'], activity = 'CMIP', original_short_name = 'tas', standard_name = 'air_temperature', long_name = 'Near-Surface Air Temperature', units = 'K', modeling_realm = ['atmos'], frequency = 'mon', version = 'v20181214' 2023-05-31 09:09:09,205 UTC [645422] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_file 2023-05-31 09:09:09,206 UTC [645422] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'fix_file' on the data LocalFile('/projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/historical/r1i1p1f1/Amon/tas/gn/v20181214/tas_Amon_BCC-ESM1_historical_r1i1p1f1_gn_185001-201412.nc') loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/historical/r1i1p1f1/Amon/tas/gn/v20181214/tas_Amon_BCC-ESM1_historical_r1i1p1f1_gn_185001-201412.nc')] with function argument(s) output_dir = PosixPath('/projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/fixed_files/tas_Amon_CMIP6_BCC-ESM1_CMIP_historical_r1i1p1f1_gn_v20181214_'), add_unique_suffix = True, short_name = 'tas', mip = 'Amon', preprocessor = 'annual_mean_bergen', timerange = '1850/2000', caption = 'Annual mean {long_name} in Amsterdam according to {dataset}.', dataset = 'BCC-ESM1', project = 'CMIP6', exp = 'historical', ensemble = 'r1i1p1f1', grid = 'gn', variable_group = 'tas_bergen', diagnostic = 'timeseries', recipe_dataset_index = 0, alias = 'CMIP6', institute = ['BCC'], activity = 'CMIP', original_short_name = 'tas', standard_name = 'air_temperature', long_name = 'Near-Surface Air Temperature', units = 'K', modeling_realm = ['atmos'], frequency = 'mon', version = 'v20181214' 2023-05-31 09:09:09,207 UTC [645421] DEBUG esmvalcore.preprocessor:390 Result [LocalFile('/projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/historical/r1i1p1f1/Amon/tas/gn/v20181214/tas_Amon_BCC-ESM1_historical_r1i1p1f1_gn_185001-201412.nc')] 2023-05-31 09:09:09,207 UTC [645421] DEBUG esmvalcore.preprocessor:369 Running preprocessor step load 2023-05-31 09:09:09,207 UTC [645421] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'load' on the data LocalFile('/projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/historical/r1i1p1f1/Amon/tas/gn/v20181214/tas_Amon_BCC-ESM1_historical_r1i1p1f1_gn_185001-201412.nc') loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/historical/r1i1p1f1/Amon/tas/gn/v20181214/tas_Amon_BCC-ESM1_historical_r1i1p1f1_gn_185001-201412.nc')] with function argument(s) callback = 'default' 2023-05-31 09:09:09,207 UTC [645421] DEBUG esmvalcore.preprocessor._io:152 Loading: /projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/historical/r1i1p1f1/Amon/tas/gn/v20181214/tas_Amon_BCC-ESM1_historical_r1i1p1f1_gn_185001-201412.nc 2023-05-31 09:09:09,207 UTC [645422] DEBUG esmvalcore.preprocessor:390 Result [LocalFile('/projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/historical/r1i1p1f1/Amon/tas/gn/v20181214/tas_Amon_BCC-ESM1_historical_r1i1p1f1_gn_185001-201412.nc')] 2023-05-31 09:09:09,207 UTC [645422] DEBUG esmvalcore.preprocessor:369 Running preprocessor step load 2023-05-31 09:09:09,207 UTC [645422] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'load' on the data LocalFile('/projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/historical/r1i1p1f1/Amon/tas/gn/v20181214/tas_Amon_BCC-ESM1_historical_r1i1p1f1_gn_185001-201412.nc') loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/historical/r1i1p1f1/Amon/tas/gn/v20181214/tas_Amon_BCC-ESM1_historical_r1i1p1f1_gn_185001-201412.nc')] with function argument(s) callback = 'default' 2023-05-31 09:09:09,207 UTC [645422] DEBUG esmvalcore.preprocessor._io:152 Loading: /projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/historical/r1i1p1f1/Amon/tas/gn/v20181214/tas_Amon_BCC-ESM1_historical_r1i1p1f1_gn_185001-201412.nc 2023-05-31 09:09:09,368 UTC [645421] DEBUG esmvalcore.preprocessor._io:182 Done with loading /projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/historical/r1i1p1f1/Amon/tas/gn/v20181214/tas_Amon_BCC-ESM1_historical_r1i1p1f1_gn_185001-201412.nc 2023-05-31 09:09:09,368 UTC [645421] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:09,372 UTC [645422] DEBUG esmvalcore.preprocessor._io:182 Done with loading /projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/historical/r1i1p1f1/Amon/tas/gn/v20181214/tas_Amon_BCC-ESM1_historical_r1i1p1f1_gn_185001-201412.nc 2023-05-31 09:09:09,372 UTC [645421] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/map/tas/CMIP6_BCC-ESM1_Amon_historical_r1i1p1f1_tas_gn_2000-P1M/00_load.nc 2023-05-31 09:09:09,372 UTC [645422] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:09,376 UTC [645422] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_bergen/CMIP6_BCC-ESM1_Amon_historical_r1i1p1f1_tas_gn_1850-2000/00_load.nc 2023-05-31 09:09:09,736 UTC [645421] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_metadata 2023-05-31 09:09:09,739 UTC [645421] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'fix_metadata' on the data [] loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/historical/r1i1p1f1/Amon/tas/gn/v20181214/tas_Amon_BCC-ESM1_historical_r1i1p1f1_gn_185001-201412.nc')] with function argument(s) check_level = , mip = 'Amon', preprocessor = 'to_degrees_c', timerange = '2000/P1M', caption = 'Global map of {long_name} in January 2000 according to {dataset}.\n', dataset = 'BCC-ESM1', project = 'CMIP6', exp = 'historical', ensemble = 'r1i1p1f1', grid = 'gn', short_name = 'tas', variable_group = 'tas', diagnostic = 'map', recipe_dataset_index = 0, alias = 'CMIP6', institute = ['BCC'], activity = 'CMIP', original_short_name = 'tas', standard_name = 'air_temperature', long_name = 'Near-Surface Air Temperature', units = 'K', modeling_realm = ['atmos'], frequency = 'mon', version = 'v20181214' 2023-05-31 09:09:09,745 UTC [645421] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:09,746 UTC [645422] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_metadata 2023-05-31 09:09:09,746 UTC [645421] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/map/tas/CMIP6_BCC-ESM1_Amon_historical_r1i1p1f1_tas_gn_2000-P1M/01_fix_metadata.nc 2023-05-31 09:09:09,748 UTC [645422] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'fix_metadata' on the data [] loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/historical/r1i1p1f1/Amon/tas/gn/v20181214/tas_Amon_BCC-ESM1_historical_r1i1p1f1_gn_185001-201412.nc')] with function argument(s) check_level = , short_name = 'tas', mip = 'Amon', preprocessor = 'annual_mean_bergen', timerange = '1850/2000', caption = 'Annual mean {long_name} in Amsterdam according to {dataset}.', dataset = 'BCC-ESM1', project = 'CMIP6', exp = 'historical', ensemble = 'r1i1p1f1', grid = 'gn', variable_group = 'tas_bergen', diagnostic = 'timeseries', recipe_dataset_index = 0, alias = 'CMIP6', institute = ['BCC'], activity = 'CMIP', original_short_name = 'tas', standard_name = 'air_temperature', long_name = 'Near-Surface Air Temperature', units = 'K', modeling_realm = ['atmos'], frequency = 'mon', version = 'v20181214' 2023-05-31 09:09:09,754 UTC [645422] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:09,755 UTC [645422] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_bergen/CMIP6_BCC-ESM1_Amon_historical_r1i1p1f1_tas_gn_1850-2000/01_fix_metadata.nc 2023-05-31 09:09:09,942 UTC [645421] DEBUG esmvalcore.preprocessor:369 Running preprocessor step concatenate 2023-05-31 09:09:09,944 UTC [645421] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'concatenate' on the data [] loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/historical/r1i1p1f1/Amon/tas/gn/v20181214/tas_Amon_BCC-ESM1_historical_r1i1p1f1_gn_185001-201412.nc')] with function argument(s) 2023-05-31 09:09:09,944 UTC [645421] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:09,945 UTC [645421] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/map/tas/CMIP6_BCC-ESM1_Amon_historical_r1i1p1f1_tas_gn_2000-P1M/02_concatenate.nc 2023-05-31 09:09:09,953 UTC [645422] DEBUG esmvalcore.preprocessor:369 Running preprocessor step concatenate 2023-05-31 09:09:09,955 UTC [645422] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'concatenate' on the data [] loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/historical/r1i1p1f1/Amon/tas/gn/v20181214/tas_Amon_BCC-ESM1_historical_r1i1p1f1_gn_185001-201412.nc')] with function argument(s) 2023-05-31 09:09:09,955 UTC [645422] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:09,956 UTC [645422] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_bergen/CMIP6_BCC-ESM1_Amon_historical_r1i1p1f1_tas_gn_1850-2000/02_concatenate.nc 2023-05-31 09:09:10,145 UTC [645421] DEBUG esmvalcore.preprocessor:369 Running preprocessor step cmor_check_metadata 2023-05-31 09:09:10,146 UTC [645421] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'cmor_check_metadata' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/historical/r1i1p1f1/Amon/tas/gn/v20181214/tas_Amon_BCC-ESM1_historical_r1i1p1f1_gn_185001-201412.nc')] with function argument(s) check_level = , cmor_table = 'CMIP6', mip = 'Amon', frequency = 'mon', short_name = 'tas' 2023-05-31 09:09:10,152 UTC [645421] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:10,153 UTC [645421] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/map/tas/CMIP6_BCC-ESM1_Amon_historical_r1i1p1f1_tas_gn_2000-P1M/03_cmor_check_metadata.nc 2023-05-31 09:09:10,164 UTC [645422] DEBUG esmvalcore.preprocessor:369 Running preprocessor step cmor_check_metadata 2023-05-31 09:09:10,166 UTC [645422] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'cmor_check_metadata' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/historical/r1i1p1f1/Amon/tas/gn/v20181214/tas_Amon_BCC-ESM1_historical_r1i1p1f1_gn_185001-201412.nc')] with function argument(s) check_level = , cmor_table = 'CMIP6', mip = 'Amon', frequency = 'mon', short_name = 'tas' 2023-05-31 09:09:10,171 UTC [645422] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:10,172 UTC [645422] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_bergen/CMIP6_BCC-ESM1_Amon_historical_r1i1p1f1_tas_gn_1850-2000/03_cmor_check_metadata.nc 2023-05-31 09:09:10,345 UTC [645421] DEBUG esmvalcore.preprocessor:369 Running preprocessor step clip_timerange 2023-05-31 09:09:10,345 UTC [645422] DEBUG esmvalcore.preprocessor:369 Running preprocessor step clip_timerange 2023-05-31 09:09:10,346 UTC [645421] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'clip_timerange' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/historical/r1i1p1f1/Amon/tas/gn/v20181214/tas_Amon_BCC-ESM1_historical_r1i1p1f1_gn_185001-201412.nc')] with function argument(s) timerange = '2000/P1M' 2023-05-31 09:09:10,347 UTC [645422] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'clip_timerange' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/historical/r1i1p1f1/Amon/tas/gn/v20181214/tas_Amon_BCC-ESM1_historical_r1i1p1f1_gn_185001-201412.nc')] with function argument(s) timerange = '1850/2000' 2023-05-31 09:09:10,357 UTC [645421] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:10,357 UTC [645422] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:10,358 UTC [645421] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/map/tas/CMIP6_BCC-ESM1_Amon_historical_r1i1p1f1_tas_gn_2000-P1M/04_clip_timerange.nc 2023-05-31 09:09:10,358 UTC [645422] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_bergen/CMIP6_BCC-ESM1_Amon_historical_r1i1p1f1_tas_gn_1850-2000/04_clip_timerange.nc 2023-05-31 09:09:10,502 UTC [645421] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_data 2023-05-31 09:09:10,504 UTC [645421] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'fix_data' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/historical/r1i1p1f1/Amon/tas/gn/v20181214/tas_Amon_BCC-ESM1_historical_r1i1p1f1_gn_185001-201412.nc')] with function argument(s) check_level = , mip = 'Amon', preprocessor = 'to_degrees_c', timerange = '2000/P1M', caption = 'Global map of {long_name} in January 2000 according to {dataset}.\n', dataset = 'BCC-ESM1', project = 'CMIP6', exp = 'historical', ensemble = 'r1i1p1f1', grid = 'gn', short_name = 'tas', variable_group = 'tas', diagnostic = 'map', recipe_dataset_index = 0, alias = 'CMIP6', institute = ['BCC'], activity = 'CMIP', original_short_name = 'tas', standard_name = 'air_temperature', long_name = 'Near-Surface Air Temperature', units = 'K', modeling_realm = ['atmos'], frequency = 'mon', version = 'v20181214' 2023-05-31 09:09:10,504 UTC [645421] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:10,505 UTC [645421] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/map/tas/CMIP6_BCC-ESM1_Amon_historical_r1i1p1f1_tas_gn_2000-P1M/05_fix_data.nc 2023-05-31 09:09:10,621 UTC [645422] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_data 2023-05-31 09:09:10,623 UTC [645422] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'fix_data' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/historical/r1i1p1f1/Amon/tas/gn/v20181214/tas_Amon_BCC-ESM1_historical_r1i1p1f1_gn_185001-201412.nc')] with function argument(s) check_level = , short_name = 'tas', mip = 'Amon', preprocessor = 'annual_mean_bergen', timerange = '1850/2000', caption = 'Annual mean {long_name} in Amsterdam according to {dataset}.', dataset = 'BCC-ESM1', project = 'CMIP6', exp = 'historical', ensemble = 'r1i1p1f1', grid = 'gn', variable_group = 'tas_bergen', diagnostic = 'timeseries', recipe_dataset_index = 0, alias = 'CMIP6', institute = ['BCC'], activity = 'CMIP', original_short_name = 'tas', standard_name = 'air_temperature', long_name = 'Near-Surface Air Temperature', units = 'K', modeling_realm = ['atmos'], frequency = 'mon', version = 'v20181214' 2023-05-31 09:09:10,623 UTC [645422] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:10,624 UTC [645422] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_bergen/CMIP6_BCC-ESM1_Amon_historical_r1i1p1f1_tas_gn_1850-2000/05_fix_data.nc 2023-05-31 09:09:10,642 UTC [645421] DEBUG esmvalcore.preprocessor:369 Running preprocessor step cmor_check_data 2023-05-31 09:09:10,643 UTC [645421] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'cmor_check_data' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/historical/r1i1p1f1/Amon/tas/gn/v20181214/tas_Amon_BCC-ESM1_historical_r1i1p1f1_gn_185001-201412.nc')] with function argument(s) check_level = , cmor_table = 'CMIP6', mip = 'Amon', frequency = 'mon', short_name = 'tas' 2023-05-31 09:09:10,643 UTC [645421] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:10,644 UTC [645421] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/map/tas/CMIP6_BCC-ESM1_Amon_historical_r1i1p1f1_tas_gn_2000-P1M/06_cmor_check_data.nc 2023-05-31 09:09:10,809 UTC [645421] DEBUG esmvalcore.preprocessor:369 Running preprocessor step add_supplementary_variables 2023-05-31 09:09:10,811 UTC [645421] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'add_supplementary_variables' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/historical/r1i1p1f1/Amon/tas/gn/v20181214/tas_Amon_BCC-ESM1_historical_r1i1p1f1_gn_185001-201412.nc')] with function argument(s) supplementary_cubes = [] 2023-05-31 09:09:10,811 UTC [645421] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:10,812 UTC [645421] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/map/tas/CMIP6_BCC-ESM1_Amon_historical_r1i1p1f1_tas_gn_2000-P1M/07_add_supplementary_variables.nc 2023-05-31 09:09:10,915 UTC [645422] DEBUG esmvalcore.preprocessor:369 Running preprocessor step cmor_check_data 2023-05-31 09:09:10,916 UTC [645422] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'cmor_check_data' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/historical/r1i1p1f1/Amon/tas/gn/v20181214/tas_Amon_BCC-ESM1_historical_r1i1p1f1_gn_185001-201412.nc')] with function argument(s) check_level = , cmor_table = 'CMIP6', mip = 'Amon', frequency = 'mon', short_name = 'tas' 2023-05-31 09:09:10,916 UTC [645422] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:10,918 UTC [645422] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_bergen/CMIP6_BCC-ESM1_Amon_historical_r1i1p1f1_tas_gn_1850-2000/06_cmor_check_data.nc 2023-05-31 09:09:10,946 UTC [645421] DEBUG esmvalcore.preprocessor:369 Running preprocessor step convert_units 2023-05-31 09:09:10,947 UTC [645421] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'convert_units' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/historical/r1i1p1f1/Amon/tas/gn/v20181214/tas_Amon_BCC-ESM1_historical_r1i1p1f1_gn_185001-201412.nc')] with function argument(s) units = 'degrees_C' 2023-05-31 09:09:10,948 UTC [645421] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:10,950 UTC [645421] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/map/tas/CMIP6_BCC-ESM1_Amon_historical_r1i1p1f1_tas_gn_2000-P1M/08_convert_units.nc 2023-05-31 09:09:11,102 UTC [645421] DEBUG esmvalcore.preprocessor:369 Running preprocessor step save 2023-05-31 09:09:11,104 UTC [645421] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'save' on the data [] loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/historical/r1i1p1f1/Amon/tas/gn/v20181214/tas_Amon_BCC-ESM1_historical_r1i1p1f1_gn_185001-201412.nc')] with function argument(s) compress = False, filename = PosixPath('/projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/map/tas/CMIP6_BCC-ESM1_Amon_historical_r1i1p1f1_tas_gn_2000-P1M.nc') 2023-05-31 09:09:11,104 UTC [645421] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/map/tas/CMIP6_BCC-ESM1_Amon_historical_r1i1p1f1_tas_gn_2000-P1M.nc 2023-05-31 09:09:11,167 UTC [645422] DEBUG esmvalcore.preprocessor:369 Running preprocessor step add_supplementary_variables 2023-05-31 09:09:11,168 UTC [645422] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'add_supplementary_variables' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/historical/r1i1p1f1/Amon/tas/gn/v20181214/tas_Amon_BCC-ESM1_historical_r1i1p1f1_gn_185001-201412.nc')] with function argument(s) supplementary_cubes = [] 2023-05-31 09:09:11,168 UTC [645422] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:11,169 UTC [645422] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_bergen/CMIP6_BCC-ESM1_Amon_historical_r1i1p1f1_tas_gn_1850-2000/07_add_supplementary_variables.nc 2023-05-31 09:09:11,359 UTC [645421] DEBUG esmvalcore.preprocessor:667 Applying single-model steps to PreprocessorFile: /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/map/tas/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_tas_2000-P1M.nc 2023-05-31 09:09:11,359 UTC [645421] DEBUG esmvalcore.esgf._download:535 All required data is available locally, not downloading anything. 2023-05-31 09:09:11,360 UTC [645421] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_file 2023-05-31 09:09:11,360 UTC [645421] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'fix_file' on the data LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/tas/tas_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc') loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/tas/tas_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc')] with function argument(s) output_dir = PosixPath('/projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/fixed_files/tas_Amon_CMIP5_bcc-csm1-1_historical_r1i1p1_v1_'), add_unique_suffix = True, mip = 'Amon', preprocessor = 'to_degrees_c', timerange = '2000/P1M', caption = 'Global map of {long_name} in January 2000 according to {dataset}.\n', dataset = 'bcc-csm1-1', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', short_name = 'tas', variable_group = 'tas', diagnostic = 'map', recipe_dataset_index = 1, alias = 'CMIP5', product = ['output1', 'output2'], institute = ['BCC'], original_short_name = 'tas', standard_name = 'air_temperature', long_name = 'Near-Surface Air Temperature', units = 'K', modeling_realm = ['atmos'], frequency = 'mon', version = 'v1' 2023-05-31 09:09:11,361 UTC [645421] DEBUG esmvalcore.preprocessor:390 Result [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/tas/tas_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc')] 2023-05-31 09:09:11,361 UTC [645421] DEBUG esmvalcore.preprocessor:369 Running preprocessor step load 2023-05-31 09:09:11,361 UTC [645421] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'load' on the data LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/tas/tas_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc') loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/tas/tas_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc')] with function argument(s) callback = 'default' 2023-05-31 09:09:11,361 UTC [645421] DEBUG esmvalcore.preprocessor._io:152 Loading: /projects/NS9560K-datalake/ESGF/cmip5/output1/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/tas/tas_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc 2023-05-31 09:09:11,427 UTC [645422] DEBUG esmvalcore.preprocessor:369 Running preprocessor step extract_location 2023-05-31 09:09:11,428 UTC [645422] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'extract_location' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/historical/r1i1p1f1/Amon/tas/gn/v20181214/tas_Amon_BCC-ESM1_historical_r1i1p1f1_gn_185001-201412.nc')] with function argument(s) location = 'Bergen', scheme = 'linear' 2023-05-31 09:09:11,428 UTC [645422] DEBUG urllib3.util.retry:282 Converted retries value: 2 -> Retry(total=2, connect=None, read=None, redirect=None, status=None) 2023-05-31 09:09:11,429 UTC [645422] DEBUG urllib3.util.retry:282 Converted retries value: 2 -> Retry(total=2, connect=None, read=None, redirect=None, status=None) 2023-05-31 09:09:11,429 UTC [645422] DEBUG geopy:295 Nominatim.geocode: https://nominatim.openstreetmap.org/search?q=Bergen&format=json&limit=1 2023-05-31 09:09:11,430 UTC [645422] DEBUG urllib3.connectionpool:1048 Starting new HTTPS connection (1): nominatim.openstreetmap.org:443 2023-05-31 09:09:11,595 UTC [645421] DEBUG esmvalcore.preprocessor._io:182 Done with loading /projects/NS9560K-datalake/ESGF/cmip5/output1/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/tas/tas_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc 2023-05-31 09:09:11,595 UTC [645421] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:11,596 UTC [645421] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/map/tas/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_tas_2000-P1M/00_load.nc 2023-05-31 09:09:11,787 UTC [645421] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_metadata 2023-05-31 09:09:11,789 UTC [645421] 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/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/tas/tas_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc')] with function argument(s) check_level = , mip = 'Amon', preprocessor = 'to_degrees_c', timerange = '2000/P1M', caption = 'Global map of {long_name} in January 2000 according to {dataset}.\n', dataset = 'bcc-csm1-1', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', short_name = 'tas', variable_group = 'tas', diagnostic = 'map', recipe_dataset_index = 1, alias = 'CMIP5', product = ['output1', 'output2'], institute = ['BCC'], original_short_name = 'tas', standard_name = 'air_temperature', long_name = 'Near-Surface Air Temperature', units = 'K', modeling_realm = ['atmos'], frequency = 'mon', version = 'v1' 2023-05-31 09:09:11,795 UTC [645421] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:11,796 UTC [645421] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/map/tas/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_tas_2000-P1M/01_fix_metadata.nc 2023-05-31 09:09:11,948 UTC [645422] DEBUG urllib3.connectionpool:546 https://nominatim.openstreetmap.org:443 "GET /search?q=Bergen&format=json&limit=1 HTTP/1.1" 200 None 2023-05-31 09:09:11,949 UTC [645422] INFO esmvalcore.preprocessor._regrid:367 Extracting data for Bergen, Vestland, Norge (60.3943055 °N, 5.3259192 °E) 2023-05-31 09:09:12,021 UTC [645421] DEBUG esmvalcore.preprocessor:369 Running preprocessor step concatenate 2023-05-31 09:09:12,023 UTC [645421] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'concatenate' on the data [] loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/tas/tas_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc')] with function argument(s) 2023-05-31 09:09:12,023 UTC [645421] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:12,024 UTC [645421] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/map/tas/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_tas_2000-P1M/02_concatenate.nc 2023-05-31 09:09:12,213 UTC [645421] DEBUG esmvalcore.preprocessor:369 Running preprocessor step cmor_check_metadata 2023-05-31 09:09:12,214 UTC [645421] 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/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/tas/tas_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc')] with function argument(s) check_level = , cmor_table = 'CMIP5', mip = 'Amon', frequency = 'mon', short_name = 'tas' 2023-05-31 09:09:12,220 UTC [645421] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:12,221 UTC [645421] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/map/tas/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_tas_2000-P1M/03_cmor_check_metadata.nc 2023-05-31 09:09:12,232 UTC [645422] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:12,234 UTC [645422] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_bergen/CMIP6_BCC-ESM1_Amon_historical_r1i1p1f1_tas_gn_1850-2000/08_extract_location.nc 2023-05-31 09:09:12,245 UTC [645422] DEBUG esmvalcore.preprocessor:369 Running preprocessor step annual_statistics 2023-05-31 09:09:12,246 UTC [645422] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'annual_statistics' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/historical/r1i1p1f1/Amon/tas/gn/v20181214/tas_Amon_BCC-ESM1_historical_r1i1p1f1_gn_185001-201412.nc')] with function argument(s) operator = 'mean' 2023-05-31 09:09:12,392 UTC [645421] DEBUG esmvalcore.preprocessor:369 Running preprocessor step clip_timerange 2023-05-31 09:09:12,393 UTC [645421] 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/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/tas/tas_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc')] with function argument(s) timerange = '2000/P1M' 2023-05-31 09:09:12,404 UTC [645421] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:12,405 UTC [645421] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/map/tas/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_tas_2000-P1M/04_clip_timerange.nc 2023-05-31 09:09:12,533 UTC [645421] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_data 2023-05-31 09:09:12,534 UTC [645421] 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/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/tas/tas_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc')] with function argument(s) check_level = , mip = 'Amon', preprocessor = 'to_degrees_c', timerange = '2000/P1M', caption = 'Global map of {long_name} in January 2000 according to {dataset}.\n', dataset = 'bcc-csm1-1', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', short_name = 'tas', variable_group = 'tas', diagnostic = 'map', recipe_dataset_index = 1, alias = 'CMIP5', product = ['output1', 'output2'], institute = ['BCC'], original_short_name = 'tas', standard_name = 'air_temperature', long_name = 'Near-Surface Air Temperature', units = 'K', modeling_realm = ['atmos'], frequency = 'mon', version = 'v1' 2023-05-31 09:09:12,534 UTC [645421] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:12,535 UTC [645421] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/map/tas/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_tas_2000-P1M/05_fix_data.nc 2023-05-31 09:09:12,667 UTC [645421] DEBUG esmvalcore.preprocessor:369 Running preprocessor step cmor_check_data 2023-05-31 09:09:12,669 UTC [645421] 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/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/tas/tas_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc')] with function argument(s) check_level = , cmor_table = 'CMIP5', mip = 'Amon', frequency = 'mon', short_name = 'tas' 2023-05-31 09:09:12,669 UTC [645421] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:12,670 UTC [645421] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/map/tas/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_tas_2000-P1M/06_cmor_check_data.nc 2023-05-31 09:09:12,679 UTC [645422] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:12,680 UTC [645422] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_bergen/CMIP6_BCC-ESM1_Amon_historical_r1i1p1f1_tas_gn_1850-2000/09_annual_statistics.nc 2023-05-31 09:09:12,692 UTC [645422] DEBUG esmvalcore.preprocessor:369 Running preprocessor step convert_units 2023-05-31 09:09:12,693 UTC [645422] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'convert_units' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/historical/r1i1p1f1/Amon/tas/gn/v20181214/tas_Amon_BCC-ESM1_historical_r1i1p1f1_gn_185001-201412.nc')] with function argument(s) units = 'degrees_C' 2023-05-31 09:09:12,694 UTC [645422] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:12,695 UTC [645422] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_bergen/CMIP6_BCC-ESM1_Amon_historical_r1i1p1f1_tas_gn_1850-2000/10_convert_units.nc 2023-05-31 09:09:12,706 UTC [645422] DEBUG esmvalcore.preprocessor:667 Applying single-model steps to PreprocessorFile: /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_bergen/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_tas_1850-2000.nc 2023-05-31 09:09:12,706 UTC [645422] DEBUG esmvalcore.esgf._download:535 All required data is available locally, not downloading anything. 2023-05-31 09:09:12,706 UTC [645422] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_file 2023-05-31 09:09:12,707 UTC [645422] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'fix_file' on the data LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/tas/tas_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc') loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/tas/tas_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc')] with function argument(s) output_dir = PosixPath('/projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/fixed_files/tas_Amon_CMIP5_bcc-csm1-1_historical_r1i1p1_v1_'), add_unique_suffix = True, short_name = 'tas', mip = 'Amon', preprocessor = 'annual_mean_bergen', timerange = '1850/2000', caption = 'Annual mean {long_name} in Amsterdam according to {dataset}.', dataset = 'bcc-csm1-1', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', variable_group = 'tas_bergen', diagnostic = 'timeseries', recipe_dataset_index = 1, alias = 'CMIP5', product = ['output1', 'output2'], institute = ['BCC'], original_short_name = 'tas', standard_name = 'air_temperature', long_name = 'Near-Surface Air Temperature', units = 'K', modeling_realm = ['atmos'], frequency = 'mon', version = 'v1' 2023-05-31 09:09:12,707 UTC [645422] DEBUG esmvalcore.preprocessor:390 Result [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/tas/tas_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc')] 2023-05-31 09:09:12,708 UTC [645422] DEBUG esmvalcore.preprocessor:369 Running preprocessor step load 2023-05-31 09:09:12,708 UTC [645422] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'load' on the data LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/tas/tas_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc') loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/tas/tas_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc')] with function argument(s) callback = 'default' 2023-05-31 09:09:12,708 UTC [645422] DEBUG esmvalcore.preprocessor._io:152 Loading: /projects/NS9560K-datalake/ESGF/cmip5/output1/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/tas/tas_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc 2023-05-31 09:09:12,734 UTC [645422] DEBUG esmvalcore.preprocessor._io:182 Done with loading /projects/NS9560K-datalake/ESGF/cmip5/output1/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/tas/tas_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc 2023-05-31 09:09:12,734 UTC [645422] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:12,735 UTC [645422] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_bergen/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_tas_1850-2000/00_load.nc 2023-05-31 09:09:12,826 UTC [645421] DEBUG esmvalcore.preprocessor:369 Running preprocessor step add_supplementary_variables 2023-05-31 09:09:12,827 UTC [645421] 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/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/tas/tas_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc')] with function argument(s) supplementary_cubes = [] 2023-05-31 09:09:12,828 UTC [645421] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:12,828 UTC [645421] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/map/tas/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_tas_2000-P1M/07_add_supplementary_variables.nc 2023-05-31 09:09:12,912 UTC [645422] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_metadata 2023-05-31 09:09:12,914 UTC [645422] 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/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/tas/tas_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc')] with function argument(s) check_level = , short_name = 'tas', mip = 'Amon', preprocessor = 'annual_mean_bergen', timerange = '1850/2000', caption = 'Annual mean {long_name} in Amsterdam according to {dataset}.', dataset = 'bcc-csm1-1', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', variable_group = 'tas_bergen', diagnostic = 'timeseries', recipe_dataset_index = 1, alias = 'CMIP5', product = ['output1', 'output2'], institute = ['BCC'], original_short_name = 'tas', standard_name = 'air_temperature', long_name = 'Near-Surface Air Temperature', units = 'K', modeling_realm = ['atmos'], frequency = 'mon', version = 'v1' 2023-05-31 09:09:12,920 UTC [645422] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:12,921 UTC [645422] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_bergen/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_tas_1850-2000/01_fix_metadata.nc 2023-05-31 09:09:12,972 UTC [645421] DEBUG esmvalcore.preprocessor:369 Running preprocessor step convert_units 2023-05-31 09:09:12,980 UTC [645421] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'convert_units' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/tas/tas_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc')] with function argument(s) units = 'degrees_C' 2023-05-31 09:09:12,981 UTC [645421] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:12,982 UTC [645421] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/map/tas/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_tas_2000-P1M/08_convert_units.nc 2023-05-31 09:09:13,097 UTC [645422] DEBUG esmvalcore.preprocessor:369 Running preprocessor step concatenate 2023-05-31 09:09:13,099 UTC [645422] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'concatenate' on the data [] loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/tas/tas_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc')] with function argument(s) 2023-05-31 09:09:13,099 UTC [645422] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:13,100 UTC [645422] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_bergen/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_tas_1850-2000/02_concatenate.nc 2023-05-31 09:09:13,122 UTC [645421] DEBUG esmvalcore.preprocessor:369 Running preprocessor step save 2023-05-31 09:09:13,125 UTC [645421] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'save' on the data [] loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/tas/tas_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc')] with function argument(s) compress = False, filename = PosixPath('/projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/map/tas/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_tas_2000-P1M.nc') 2023-05-31 09:09:13,125 UTC [645421] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/map/tas/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_tas_2000-P1M.nc 2023-05-31 09:09:13,277 UTC [645421] INFO esmvalcore._task:264 Successfully completed task map/tas (priority 1) in 0:00:04.202714 2023-05-31 09:09:13,287 UTC [645422] DEBUG esmvalcore.preprocessor:369 Running preprocessor step cmor_check_metadata 2023-05-31 09:09:13,288 UTC [645422] 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/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/tas/tas_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc')] with function argument(s) check_level = , cmor_table = 'CMIP5', mip = 'Amon', frequency = 'mon', short_name = 'tas' 2023-05-31 09:09:13,294 UTC [645422] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:13,295 UTC [645422] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_bergen/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_tas_1850-2000/03_cmor_check_metadata.nc 2023-05-31 09:09:13,463 UTC [645422] DEBUG esmvalcore.preprocessor:369 Running preprocessor step clip_timerange 2023-05-31 09:09:13,464 UTC [645422] 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/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/tas/tas_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc')] with function argument(s) timerange = '1850/2000' 2023-05-31 09:09:13,474 UTC [645422] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:13,475 UTC [645422] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_bergen/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_tas_1850-2000/04_clip_timerange.nc 2023-05-31 09:09:13,477 UTC [645282] INFO esmvalcore._task:778 Progress: 1 tasks running, 3 tasks waiting for ancestors, 1/5 done 2023-05-31 09:09:13,481 UTC [645421] INFO esmvalcore._task:259 Starting task map/script1 in process [645421] 2023-05-31 09:09:13,485 UTC [645421] INFO esmvalcore._task:500 Running command ['/diagnostics/esmvaltool/2.8.0/bin/python', '/diagnostics/esmvaltool/2.8.0/lib/python3.10/site-packages/esmvaltool/diag_scripts/examples/diagnostic.py', '/projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/run/map/script1/settings.yml'] 2023-05-31 09:09:13,485 UTC [645421] DEBUG esmvalcore._task:501 in environment {'MPLBACKEND': 'Agg'} 2023-05-31 09:09:13,485 UTC [645421] DEBUG esmvalcore._task:503 in current working directory: /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/run/map/script1 2023-05-31 09:09:13,485 UTC [645421] INFO esmvalcore._task:504 Writing output to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/work/map/script1 2023-05-31 09:09:13,485 UTC [645421] INFO esmvalcore._task:505 Writing plots to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/plots/map/script1 2023-05-31 09:09:13,485 UTC [645421] INFO esmvalcore._task:506 Writing log to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/run/map/script1/log.txt 2023-05-31 09:09:13,485 UTC [645421] INFO esmvalcore._task:516 To re-run this diagnostic script, run: cd /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/run/map/script1; MPLBACKEND="Agg" /diagnostics/esmvaltool/2.8.0/bin/python /diagnostics/esmvaltool/2.8.0/lib/python3.10/site-packages/esmvaltool/diag_scripts/examples/diagnostic.py /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/run/map/script1/settings.yml 2023-05-31 09:09:13,577 UTC [645282] INFO esmvalcore._task:778 Progress: 2 tasks running, 2 tasks waiting for ancestors, 1/5 done 2023-05-31 09:09:13,739 UTC [645422] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_data 2023-05-31 09:09:13,741 UTC [645422] 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/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/tas/tas_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc')] with function argument(s) check_level = , short_name = 'tas', mip = 'Amon', preprocessor = 'annual_mean_bergen', timerange = '1850/2000', caption = 'Annual mean {long_name} in Amsterdam according to {dataset}.', dataset = 'bcc-csm1-1', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', variable_group = 'tas_bergen', diagnostic = 'timeseries', recipe_dataset_index = 1, alias = 'CMIP5', product = ['output1', 'output2'], institute = ['BCC'], original_short_name = 'tas', standard_name = 'air_temperature', long_name = 'Near-Surface Air Temperature', units = 'K', modeling_realm = ['atmos'], frequency = 'mon', version = 'v1' 2023-05-31 09:09:13,741 UTC [645422] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:13,742 UTC [645422] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_bergen/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_tas_1850-2000/05_fix_data.nc 2023-05-31 09:09:14,003 UTC [645422] DEBUG esmvalcore.preprocessor:369 Running preprocessor step cmor_check_data 2023-05-31 09:09:14,004 UTC [645422] 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/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/tas/tas_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc')] with function argument(s) check_level = , cmor_table = 'CMIP5', mip = 'Amon', frequency = 'mon', short_name = 'tas' 2023-05-31 09:09:14,005 UTC [645422] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:14,006 UTC [645422] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_bergen/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_tas_1850-2000/06_cmor_check_data.nc 2023-05-31 09:09:14,277 UTC [645422] DEBUG esmvalcore.preprocessor:369 Running preprocessor step add_supplementary_variables 2023-05-31 09:09:14,278 UTC [645422] 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/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/tas/tas_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc')] with function argument(s) supplementary_cubes = [] 2023-05-31 09:09:14,278 UTC [645422] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:14,279 UTC [645422] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_bergen/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_tas_1850-2000/07_add_supplementary_variables.nc 2023-05-31 09:09:14,551 UTC [645422] DEBUG esmvalcore.preprocessor:369 Running preprocessor step extract_location 2023-05-31 09:09:14,553 UTC [645422] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'extract_location' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/tas/tas_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc')] with function argument(s) location = 'Bergen', scheme = 'linear' 2023-05-31 09:09:14,553 UTC [645422] DEBUG urllib3.util.retry:282 Converted retries value: 2 -> Retry(total=2, connect=None, read=None, redirect=None, status=None) 2023-05-31 09:09:14,553 UTC [645422] DEBUG urllib3.util.retry:282 Converted retries value: 2 -> Retry(total=2, connect=None, read=None, redirect=None, status=None) 2023-05-31 09:09:14,553 UTC [645422] DEBUG geopy:295 Nominatim.geocode: https://nominatim.openstreetmap.org/search?q=Bergen&format=json&limit=1 2023-05-31 09:09:14,554 UTC [645422] DEBUG urllib3.connectionpool:1048 Starting new HTTPS connection (1): nominatim.openstreetmap.org:443 2023-05-31 09:09:14,791 UTC [645422] DEBUG urllib3.connectionpool:546 https://nominatim.openstreetmap.org:443 "GET /search?q=Bergen&format=json&limit=1 HTTP/1.1" 200 None 2023-05-31 09:09:14,792 UTC [645422] INFO esmvalcore.preprocessor._regrid:367 Extracting data for Bergen, Vestland, Norge (60.3943055 °N, 5.3259192 °E) 2023-05-31 09:09:14,979 UTC [645422] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:14,980 UTC [645422] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_bergen/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_tas_1850-2000/08_extract_location.nc 2023-05-31 09:09:14,991 UTC [645422] DEBUG esmvalcore.preprocessor:369 Running preprocessor step annual_statistics 2023-05-31 09:09:14,992 UTC [645422] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'annual_statistics' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/tas/tas_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc')] with function argument(s) operator = 'mean' 2023-05-31 09:09:15,420 UTC [645422] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:15,421 UTC [645422] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_bergen/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_tas_1850-2000/09_annual_statistics.nc 2023-05-31 09:09:15,435 UTC [645422] DEBUG esmvalcore.preprocessor:369 Running preprocessor step convert_units 2023-05-31 09:09:15,435 UTC [645422] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'convert_units' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/tas/tas_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc')] with function argument(s) units = 'degrees_C' 2023-05-31 09:09:15,436 UTC [645422] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:15,436 UTC [645422] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_bergen/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_tas_1850-2000/10_convert_units.nc 2023-05-31 09:09:15,448 UTC [645422] DEBUG esmvalcore.preprocessor:660 Running block ['multi_model_statistics'] 2023-05-31 09:09:15,448 UTC [645422] DEBUG esmvalcore.preprocessor:574 Applying multi_model_statistics to PreprocessorFile: /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_bergen/CMIP6_BCC-ESM1_Amon_historical_r1i1p1f1_tas_gn_1850-2000.nc PreprocessorFile: /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_bergen/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_tas_1850-2000.nc 2023-05-31 09:09:15,449 UTC [645422] DEBUG esmvalcore.preprocessor:369 Running preprocessor step multi_model_statistics 2023-05-31 09:09:15,449 UTC [645422] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'multi_model_statistics' on the data {PreprocessorFile: /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_bergen/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_tas_1850-2000.nc, PreprocessorFile: /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_bergen/CMIP6_BCC-ESM1_Amon_historical_r1i1p1f1_tas_gn_1850-2000.nc} with function argument(s) statistics = ['mean'], span = 'overlap', output_products = defaultdict(, {'': {'mean': PreprocessorFile: /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_bergen/MultiModelMean_historical_Amon_tas_1850-2000.nc}}) 2023-05-31 09:09:15,456 UTC [645422] DEBUG esmvalcore.preprocessor._multimodel:590 Multicube statistics: computing: mean 2023-05-31 09:09:15,474 UTC [645422] INFO esmvalcore.preprocessor._multimodel:628 Generated PreprocessorFile: /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_bergen/MultiModelMean_historical_Amon_tas_1850-2000.nc 2023-05-31 09:09:15,474 UTC [645422] DEBUG esmvalcore.preprocessor:581 Result /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_bergen/CMIP6_BCC-ESM1_Amon_historical_r1i1p1f1_tas_gn_1850-2000.nc 2023-05-31 09:09:15,474 UTC [645422] DEBUG esmvalcore.preprocessor:584 with cube air_temperature / (degrees_C) (time: 151) Dimension coordinates: time x Auxiliary coordinates: year x Scalar coordinates: height 2.0 m latitude 60.3943055 degrees_north longitude 5.3259192 degrees_east Cell methods: 0 area: time: mean (interval: 20 minutes interval: 20 minutes) 1 year: mean Attributes: Conventions 'CF-1.7 CMIP-6.2' activity_id 'CMIP' branch_method 'Standard' branch_time_in_child 0.0 branch_time_in_parent 2110.0 cmor_version '3.3.2' contact 'Dr. Tongwen Wu(twwu@cma.gov.cn)' data_specs_version '01.00.27' description 'DECK: historical' experiment 'all-forcing simulation of the recent past' experiment_id 'historical' external_variables 'areacella' forcing_index 1 frequency 'mon' further_info_url 'https://furtherinfo.es-doc.org/CMIP6.BCC.BCC-ESM1.historical.none.r1i1 ...' grid 'T42' grid_label 'gn' initialization_index 1 institution 'Beijing Climate Center, Beijing 100081, China' institution_id 'BCC' license 'CMIP6 model data produced by BCC is licensed under a Creative Commons Attribution ...' mip_era 'CMIP6' nominal_resolution '250 km' original_name 'TREFHT' parent_activity_id 'CMIP' parent_experiment_id 'piControl' parent_mip_era 'CMIP6' parent_source_id 'BCC-ESM1' parent_time_units 'days since 1850-1-1 00:00:00' parent_variant_label 'r1i1p1f1' physics_index 1 product 'model-output' realization_index 1 realm 'atmos' references 'Model described by Tongwen Wu et al. (JGR 2013; JMR 2014; submmitted to ...' run_variant 'forcing: greenhouse gases,aerosol emission,solar constant,volcano mass,land ...' source 'BCC-ESM 1 (2017): aerosol: none atmos: BCC_AGCM3_LR (T42; 128 x 64 longitude/latitude; ...' source_id 'BCC-ESM1' source_type 'AER AOGCM CHEM' sub_experiment 'none' sub_experiment_id 'none' table_id 'Amon' table_info 'Creation Date:(30 July 2018) MD5:e53ff52009d0b97d9d867dc12b6096c7' title 'BCC-ESM1 output prepared for CMIP6' variable_id 'tas' variant_label 'r1i1p1f1' 2023-05-31 09:09:15,476 UTC [645422] DEBUG esmvalcore.preprocessor:581 Result /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_bergen/MultiModelMean_historical_Amon_tas_1850-2000.nc 2023-05-31 09:09:15,476 UTC [645422] DEBUG esmvalcore.preprocessor:584 with cube air_temperature / (degrees_C) (time: 151) Dimension coordinates: time x Auxiliary coordinates: year x Scalar coordinates: height 2.0 m latitude 60.3943055 degrees_north longitude 5.3259192 degrees_east Cell methods: 0 multi-model: mean (input_cubes: 2) Attributes: experiment_id 'historical' frequency 'mon' original_name 'TREFHT' parent_experiment_id 'piControl' 2023-05-31 09:09:15,477 UTC [645422] DEBUG esmvalcore.preprocessor:581 Result /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_bergen/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_tas_1850-2000.nc 2023-05-31 09:09:15,477 UTC [645422] DEBUG esmvalcore.preprocessor:584 with cube air_temperature / (degrees_C) (time: 151) Dimension coordinates: time x Auxiliary coordinates: year x Scalar coordinates: height 2.0 m latitude 60.3943055 degrees_north longitude 5.3259192 degrees_east Cell methods: 0 time: mean (interval: 20 mintues) 1 year: mean Attributes: Conventions 'CF-1.4' associated_files 'baseURL: http://cmip-pcmdi.llnl.gov/CMIP5/dataLocation gridspecFile: gridspec_atmos_fx_bcc-csm1-1_historical_r0i0p0.nc ...' branch_time 470.0 cmor_version '2.5.6' contact 'Dr. Tongwen Wu (twwu@cma.gov.cn)' experiment 'historical' experiment_id 'historical' forcing 'Nat Ant GHG SD Oz Sl Vl SS Ds BC OC' frequency 'mon' initialization_method 1 institute_id 'BCC' institution 'Beijing Climate Center(BCC),China Meteorological Administration,China' model_id 'bcc-csm1-1' modeling_realm 'atmos' original_name 'TREFHT' parent_experiment 'pre-industrial control' parent_experiment_id 'piControl' parent_experiment_rip 'r1i1p1' physics_version 1 product 'output' project_id 'CMIP5' realization 1 source 'bcc-csm1-1:atmosphere: BCC_AGCM2.1 (T42L26); land: BCC_AVIM1.0;ocean: ...' table_id 'Table Amon (11 April 2011) 1cfdc7322cf2f4a32614826fab42c1ab' title 'bcc-csm1-1 model output prepared for CMIP5 historical' 2023-05-31 09:09:15,478 UTC [645422] DEBUG esmvalcore.preprocessor:369 Running preprocessor step save 2023-05-31 09:09:15,479 UTC [645422] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'save' on the data [] loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/historical/r1i1p1f1/Amon/tas/gn/v20181214/tas_Amon_BCC-ESM1_historical_r1i1p1f1_gn_185001-201412.nc')] with function argument(s) compress = False, filename = PosixPath('/projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_bergen/CMIP6_BCC-ESM1_Amon_historical_r1i1p1f1_tas_gn_1850-2000.nc') 2023-05-31 09:09:15,479 UTC [645422] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_bergen/CMIP6_BCC-ESM1_Amon_historical_r1i1p1f1_tas_gn_1850-2000.nc 2023-05-31 09:09:15,544 UTC [645422] DEBUG esmvalcore.preprocessor:369 Running preprocessor step save 2023-05-31 09:09:15,545 UTC [645422] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'save' on the data [] loaded from original input file(s) [] with function argument(s) filename = PosixPath('/projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_bergen/MultiModelMean_historical_Amon_tas_1850-2000.nc') 2023-05-31 09:09:15,545 UTC [645422] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_bergen/MultiModelMean_historical_Amon_tas_1850-2000.nc 2023-05-31 09:09:15,563 UTC [645422] DEBUG esmvalcore.preprocessor:369 Running preprocessor step save 2023-05-31 09:09:15,564 UTC [645422] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'save' on the data [] loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/tas/tas_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc')] with function argument(s) compress = False, filename = PosixPath('/projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_bergen/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_tas_1850-2000.nc') 2023-05-31 09:09:15,564 UTC [645422] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_bergen/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_tas_1850-2000.nc 2023-05-31 09:09:15,588 UTC [645422] INFO esmvalcore._task:264 Successfully completed task timeseries/tas_bergen (priority 3) in 0:00:06.513338 2023-05-31 09:09:15,781 UTC [645282] INFO esmvalcore._task:778 Progress: 1 tasks running, 2 tasks waiting for ancestors, 2/5 done 2023-05-31 09:09:15,783 UTC [645422] INFO esmvalcore._task:259 Starting task timeseries/tas_global in process [645422] 2023-05-31 09:09:15,793 UTC [645422] DEBUG esmvalcore.preprocessor:660 Running block ['area_statistics', 'annual_statistics', 'convert_units'] 2023-05-31 09:09:15,793 UTC [645422] DEBUG esmvalcore.preprocessor:667 Applying single-model steps to PreprocessorFile: /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_global/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_tas_1850-2000.nc 2023-05-31 09:09:15,793 UTC [645422] DEBUG esmvalcore.esgf._download:535 All required data is available locally, not downloading anything. 2023-05-31 09:09:15,794 UTC [645422] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_file 2023-05-31 09:09:15,794 UTC [645422] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'fix_file' on the data LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/tas/tas_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc') loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/tas/tas_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc')] with function argument(s) output_dir = PosixPath('/projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/fixed_files/tas_Amon_CMIP5_bcc-csm1-1_historical_r1i1p1_v1_'), add_unique_suffix = True, short_name = 'tas', mip = 'Amon', preprocessor = 'annual_mean_global', timerange = '1850/2000', caption = 'Annual global mean {long_name} according to {dataset}.', dataset = 'bcc-csm1-1', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', variable_group = 'tas_global', diagnostic = 'timeseries', recipe_dataset_index = 1, alias = 'CMIP5', product = ['output1', 'output2'], institute = ['BCC'], original_short_name = 'tas', standard_name = 'air_temperature', long_name = 'Near-Surface Air Temperature', units = 'K', modeling_realm = ['atmos'], frequency = 'mon', version = 'v1' 2023-05-31 09:09:15,794 UTC [645422] DEBUG esmvalcore.preprocessor:390 Result [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/tas/tas_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc')] 2023-05-31 09:09:15,794 UTC [645422] DEBUG esmvalcore.preprocessor:369 Running preprocessor step load 2023-05-31 09:09:15,794 UTC [645422] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'load' on the data LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/tas/tas_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc') loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/tas/tas_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc')] with function argument(s) callback = 'default' 2023-05-31 09:09:15,794 UTC [645422] DEBUG esmvalcore.preprocessor._io:152 Loading: /projects/NS9560K-datalake/ESGF/cmip5/output1/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/tas/tas_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc 2023-05-31 09:09:15,820 UTC [645422] DEBUG esmvalcore.preprocessor._io:182 Done with loading /projects/NS9560K-datalake/ESGF/cmip5/output1/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/tas/tas_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc 2023-05-31 09:09:15,820 UTC [645422] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:15,822 UTC [645422] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_global/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_tas_1850-2000/00_load.nc 2023-05-31 09:09:15,881 UTC [645282] INFO esmvalcore._task:778 Progress: 2 tasks running, 1 tasks waiting for ancestors, 2/5 done 2023-05-31 09:09:16,019 UTC [645422] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_metadata 2023-05-31 09:09:16,021 UTC [645422] 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/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/tas/tas_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc')] with function argument(s) check_level = , short_name = 'tas', mip = 'Amon', preprocessor = 'annual_mean_global', timerange = '1850/2000', caption = 'Annual global mean {long_name} according to {dataset}.', dataset = 'bcc-csm1-1', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', variable_group = 'tas_global', diagnostic = 'timeseries', recipe_dataset_index = 1, alias = 'CMIP5', product = ['output1', 'output2'], institute = ['BCC'], original_short_name = 'tas', standard_name = 'air_temperature', long_name = 'Near-Surface Air Temperature', units = 'K', modeling_realm = ['atmos'], frequency = 'mon', version = 'v1' 2023-05-31 09:09:16,028 UTC [645422] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:16,029 UTC [645422] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_global/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_tas_1850-2000/01_fix_metadata.nc 2023-05-31 09:09:16,214 UTC [645422] DEBUG esmvalcore.preprocessor:369 Running preprocessor step concatenate 2023-05-31 09:09:16,216 UTC [645422] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'concatenate' on the data [] loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/tas/tas_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc')] with function argument(s) 2023-05-31 09:09:16,216 UTC [645422] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:16,217 UTC [645422] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_global/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_tas_1850-2000/02_concatenate.nc 2023-05-31 09:09:16,411 UTC [645422] DEBUG esmvalcore.preprocessor:369 Running preprocessor step cmor_check_metadata 2023-05-31 09:09:16,412 UTC [645422] 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/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/tas/tas_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc')] with function argument(s) check_level = , cmor_table = 'CMIP5', mip = 'Amon', frequency = 'mon', short_name = 'tas' 2023-05-31 09:09:16,418 UTC [645422] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:16,419 UTC [645422] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_global/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_tas_1850-2000/03_cmor_check_metadata.nc 2023-05-31 09:09:16,629 UTC [645422] DEBUG esmvalcore.preprocessor:369 Running preprocessor step clip_timerange 2023-05-31 09:09:16,631 UTC [645422] 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/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/tas/tas_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc')] with function argument(s) timerange = '1850/2000' 2023-05-31 09:09:16,641 UTC [645422] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:16,642 UTC [645422] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_global/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_tas_1850-2000/04_clip_timerange.nc 2023-05-31 09:09:16,905 UTC [645422] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_data 2023-05-31 09:09:16,907 UTC [645422] 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/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/tas/tas_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc')] with function argument(s) check_level = , short_name = 'tas', mip = 'Amon', preprocessor = 'annual_mean_global', timerange = '1850/2000', caption = 'Annual global mean {long_name} according to {dataset}.', dataset = 'bcc-csm1-1', project = 'CMIP5', exp = 'historical', ensemble = 'r1i1p1', variable_group = 'tas_global', diagnostic = 'timeseries', recipe_dataset_index = 1, alias = 'CMIP5', product = ['output1', 'output2'], institute = ['BCC'], original_short_name = 'tas', standard_name = 'air_temperature', long_name = 'Near-Surface Air Temperature', units = 'K', modeling_realm = ['atmos'], frequency = 'mon', version = 'v1' 2023-05-31 09:09:16,907 UTC [645422] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:16,908 UTC [645422] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_global/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_tas_1850-2000/05_fix_data.nc 2023-05-31 09:09:17,178 UTC [645422] DEBUG esmvalcore.preprocessor:369 Running preprocessor step cmor_check_data 2023-05-31 09:09:17,180 UTC [645422] 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/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/tas/tas_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc')] with function argument(s) check_level = , cmor_table = 'CMIP5', mip = 'Amon', frequency = 'mon', short_name = 'tas' 2023-05-31 09:09:17,180 UTC [645422] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:17,181 UTC [645422] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_global/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_tas_1850-2000/06_cmor_check_data.nc 2023-05-31 09:09:17,433 UTC [645422] DEBUG esmvalcore.preprocessor:369 Running preprocessor step add_supplementary_variables 2023-05-31 09:09:17,435 UTC [645422] 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/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/tas/tas_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc')] with function argument(s) supplementary_cubes = [] 2023-05-31 09:09:17,435 UTC [645422] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:17,436 UTC [645422] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_global/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_tas_1850-2000/07_add_supplementary_variables.nc 2023-05-31 09:09:17,683 UTC [645422] DEBUG esmvalcore.preprocessor:369 Running preprocessor step area_statistics 2023-05-31 09:09:17,685 UTC [645422] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'area_statistics' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/tas/tas_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc')] with function argument(s) operator = 'mean' 2023-05-31 09:09:17,686 UTC [645422] DEBUG esmvalcore.preprocessor._area:269 Cell measure "cell_area" not found in cube air_temperature / (K) (time: 1812; latitude: 64; longitude: 128). Check fx_file availability. 2023-05-31 09:09:17,686 UTC [645422] DEBUG esmvalcore.preprocessor._area:272 Attempting to calculate grid cell area... 2023-05-31 09:09:17,688 UTC [645422] DEBUG esmvalcore.preprocessor._area:200 Using DEFAULT_SPHERICAL_EARTH_RADIUS. while computing area weights of the following cube: air_temperature / (K) (time: 1812; latitude: 64; longitude: 128) Dimension coordinates: time x - - latitude - x - longitude - - x Scalar coordinates: height 2.0 m Cell methods: 0 time: mean (interval: 20 mintues) Attributes: Conventions 'CF-1.4' associated_files 'baseURL: http://cmip-pcmdi.llnl.gov/CMIP5/dataLocation gridspecFile: gridspec_atmos_fx_bcc-csm1-1_historical_r0i0p0.nc ...' branch_time 470.0 cmor_version '2.5.6' contact 'Dr. Tongwen Wu (twwu@cma.gov.cn)' experiment 'historical' experiment_id 'historical' forcing 'Nat Ant GHG SD Oz Sl Vl SS Ds BC OC' frequency 'mon' initialization_method 1 institute_id 'BCC' institution 'Beijing Climate Center(BCC),China Meteorological Administration,China' model_id 'bcc-csm1-1' modeling_realm 'atmos' original_name 'TREFHT' parent_experiment 'pre-industrial control' parent_experiment_id 'piControl' parent_experiment_rip 'r1i1p1' physics_version 1 product 'output' project_id 'CMIP5' realization 1 source 'bcc-csm1-1:atmosphere: BCC_AGCM2.1 (T42L26); land: BCC_AVIM1.0;ocean: ...' table_id 'Table Amon (11 April 2011) 1cfdc7322cf2f4a32614826fab42c1ab' title 'bcc-csm1-1 model output prepared for CMIP5 historical' 2023-05-31 09:09:17,690 UTC [645422] DEBUG esmvalcore.preprocessor._area:298 Calculated grid area shape: (1812, 64, 128) 2023-05-31 09:09:17,740 UTC [645422] DEBUG esmvalcore.preprocessor._area:317 area_statistics changed dtype from float32 to float64, changing back 2023-05-31 09:09:17,741 UTC [645422] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:17,742 UTC [645422] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_global/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_tas_1850-2000/08_area_statistics.nc 2023-05-31 09:09:17,957 UTC [645422] DEBUG esmvalcore.preprocessor:369 Running preprocessor step annual_statistics 2023-05-31 09:09:17,959 UTC [645422] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'annual_statistics' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/tas/tas_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc')] with function argument(s) operator = 'mean' 2023-05-31 09:09:18,500 UTC [645421] INFO esmvalcore._task:126 Maximum memory used (estimate): 0.4 GB 2023-05-31 09:09:18,501 UTC [645421] INFO esmvalcore._task:128 Sampled every second. It may be inaccurate if short but high spikes in memory consumption occur. 2023-05-31 09:09:18,501 UTC [645421] DEBUG esmvalcore._task:589 Script examples/diagnostic.py completed successfully 2023-05-31 09:09:18,501 UTC [645421] DEBUG esmvalcore._task:608 Collecting provenance from /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/run/map/script1/diagnostic_provenance.yml 2023-05-31 09:09:18,520 UTC [645421] DEBUG PIL.PngImagePlugin:204 STREAM b'IHDR' 16 13 2023-05-31 09:09:18,520 UTC [645421] DEBUG PIL.PngImagePlugin:204 STREAM b'tEXt' 41 57 2023-05-31 09:09:18,520 UTC [645421] DEBUG PIL.PngImagePlugin:204 STREAM b'pHYs' 110 9 2023-05-31 09:09:18,520 UTC [645421] DEBUG PIL.PngImagePlugin:204 STREAM b'IDAT' 131 24856 2023-05-31 09:09:18,558 UTC [645421] DEBUG urllib3.connectionpool:1048 Starting new HTTPS connection (1): cera-www.dkrz.de:443 2023-05-31 09:09:18,611 UTC [645422] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:18,612 UTC [645422] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_global/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_tas_1850-2000/09_annual_statistics.nc 2023-05-31 09:09:18,938 UTC [645421] DEBUG urllib3.connectionpool:546 https://cera-www.dkrz.de:443 "GET /WDCC/ui/cerasearch/cerarest/exportcmip6?input=CMIP6.CMIP.BCC.BCC-ESM1.historical HTTP/1.1" 302 273 2023-05-31 09:09:18,973 UTC [645421] DEBUG urllib3.connectionpool:546 https://cera-www.dkrz.de:443 "GET /ui/cerarest/exportcmip6?input=CMIP6.CMIP.BCC.BCC-ESM1.historical HTTP/1.1" 302 275 2023-05-31 09:09:18,975 UTC [645421] DEBUG urllib3.connectionpool:1048 Starting new HTTPS connection (1): www.wdc-climate.de:443 2023-05-31 09:09:19,270 UTC [645421] DEBUG urllib3.connectionpool:546 https://www.wdc-climate.de:443 "GET /ui/cerarest/exportcmip6?input=CMIP6.CMIP.BCC.BCC-ESM1.historical HTTP/1.1" 200 5640 2023-05-31 09:09:19,276 UTC [645421] DEBUG PIL.PngImagePlugin:204 STREAM b'IHDR' 16 13 2023-05-31 09:09:19,276 UTC [645421] DEBUG PIL.PngImagePlugin:204 STREAM b'tEXt' 41 57 2023-05-31 09:09:19,276 UTC [645421] DEBUG PIL.PngImagePlugin:204 STREAM b'pHYs' 110 9 2023-05-31 09:09:19,276 UTC [645421] DEBUG PIL.PngImagePlugin:204 STREAM b'IDAT' 131 25184 2023-05-31 09:09:19,327 UTC [645421] DEBUG esmvalcore._task:683 Collecting provenance of task map/script1 took 0.8 seconds 2023-05-31 09:09:19,327 UTC [645421] INFO esmvalcore._task:264 Successfully completed task map/script1 (priority 0) in 0:00:05.846087 2023-05-31 09:09:19,400 UTC [645422] DEBUG esmvalcore.preprocessor:369 Running preprocessor step convert_units 2023-05-31 09:09:19,402 UTC [645422] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'convert_units' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/tas/tas_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc')] with function argument(s) units = 'degrees_C' 2023-05-31 09:09:19,403 UTC [645422] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:19,404 UTC [645422] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_global/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_tas_1850-2000/10_convert_units.nc 2023-05-31 09:09:19,486 UTC [645282] INFO esmvalcore._task:778 Progress: 1 tasks running, 1 tasks waiting for ancestors, 3/5 done 2023-05-31 09:09:20,159 UTC [645422] DEBUG esmvalcore.preprocessor:369 Running preprocessor step save 2023-05-31 09:09:20,161 UTC [645422] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'save' on the data [] loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/cmip5/output1/BCC/bcc-csm1-1/historical/mon/atmos/Amon/r1i1p1/v1/tas/tas_Amon_bcc-csm1-1_historical_r1i1p1_185001-201212.nc')] with function argument(s) compress = False, filename = PosixPath('/projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_global/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_tas_1850-2000.nc') 2023-05-31 09:09:20,161 UTC [645422] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_global/CMIP5_bcc-csm1-1_Amon_historical_r1i1p1_tas_1850-2000.nc 2023-05-31 09:09:20,950 UTC [645422] DEBUG esmvalcore.preprocessor:667 Applying single-model steps to PreprocessorFile: /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_global/CMIP6_BCC-ESM1_Amon_historical_r1i1p1f1_tas_gn_1850-2000.nc 2023-05-31 09:09:20,950 UTC [645422] DEBUG esmvalcore.esgf._download:535 All required data is available locally, not downloading anything. 2023-05-31 09:09:20,950 UTC [645422] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_file 2023-05-31 09:09:20,950 UTC [645422] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'fix_file' on the data LocalFile('/projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/historical/r1i1p1f1/Amon/tas/gn/v20181214/tas_Amon_BCC-ESM1_historical_r1i1p1f1_gn_185001-201412.nc') loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/historical/r1i1p1f1/Amon/tas/gn/v20181214/tas_Amon_BCC-ESM1_historical_r1i1p1f1_gn_185001-201412.nc')] with function argument(s) output_dir = PosixPath('/projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/fixed_files/tas_Amon_CMIP6_BCC-ESM1_CMIP_historical_r1i1p1f1_gn_v20181214_'), add_unique_suffix = True, short_name = 'tas', mip = 'Amon', preprocessor = 'annual_mean_global', timerange = '1850/2000', caption = 'Annual global mean {long_name} according to {dataset}.', dataset = 'BCC-ESM1', project = 'CMIP6', exp = 'historical', ensemble = 'r1i1p1f1', grid = 'gn', variable_group = 'tas_global', diagnostic = 'timeseries', recipe_dataset_index = 0, alias = 'CMIP6', institute = ['BCC'], activity = 'CMIP', original_short_name = 'tas', standard_name = 'air_temperature', long_name = 'Near-Surface Air Temperature', units = 'K', modeling_realm = ['atmos'], frequency = 'mon', version = 'v20181214' 2023-05-31 09:09:20,951 UTC [645422] DEBUG esmvalcore.preprocessor:390 Result [LocalFile('/projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/historical/r1i1p1f1/Amon/tas/gn/v20181214/tas_Amon_BCC-ESM1_historical_r1i1p1f1_gn_185001-201412.nc')] 2023-05-31 09:09:20,951 UTC [645422] DEBUG esmvalcore.preprocessor:369 Running preprocessor step load 2023-05-31 09:09:20,951 UTC [645422] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'load' on the data LocalFile('/projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/historical/r1i1p1f1/Amon/tas/gn/v20181214/tas_Amon_BCC-ESM1_historical_r1i1p1f1_gn_185001-201412.nc') loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/historical/r1i1p1f1/Amon/tas/gn/v20181214/tas_Amon_BCC-ESM1_historical_r1i1p1f1_gn_185001-201412.nc')] with function argument(s) callback = 'default' 2023-05-31 09:09:20,951 UTC [645422] DEBUG esmvalcore.preprocessor._io:152 Loading: /projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/historical/r1i1p1f1/Amon/tas/gn/v20181214/tas_Amon_BCC-ESM1_historical_r1i1p1f1_gn_185001-201412.nc 2023-05-31 09:09:21,022 UTC [645422] DEBUG esmvalcore.preprocessor._io:182 Done with loading /projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/historical/r1i1p1f1/Amon/tas/gn/v20181214/tas_Amon_BCC-ESM1_historical_r1i1p1f1_gn_185001-201412.nc 2023-05-31 09:09:21,022 UTC [645422] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:21,024 UTC [645422] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_global/CMIP6_BCC-ESM1_Amon_historical_r1i1p1f1_tas_gn_1850-2000/00_load.nc 2023-05-31 09:09:21,224 UTC [645422] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_metadata 2023-05-31 09:09:21,226 UTC [645422] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'fix_metadata' on the data [] loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/historical/r1i1p1f1/Amon/tas/gn/v20181214/tas_Amon_BCC-ESM1_historical_r1i1p1f1_gn_185001-201412.nc')] with function argument(s) check_level = , short_name = 'tas', mip = 'Amon', preprocessor = 'annual_mean_global', timerange = '1850/2000', caption = 'Annual global mean {long_name} according to {dataset}.', dataset = 'BCC-ESM1', project = 'CMIP6', exp = 'historical', ensemble = 'r1i1p1f1', grid = 'gn', variable_group = 'tas_global', diagnostic = 'timeseries', recipe_dataset_index = 0, alias = 'CMIP6', institute = ['BCC'], activity = 'CMIP', original_short_name = 'tas', standard_name = 'air_temperature', long_name = 'Near-Surface Air Temperature', units = 'K', modeling_realm = ['atmos'], frequency = 'mon', version = 'v20181214' 2023-05-31 09:09:21,232 UTC [645422] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:21,233 UTC [645422] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_global/CMIP6_BCC-ESM1_Amon_historical_r1i1p1f1_tas_gn_1850-2000/01_fix_metadata.nc 2023-05-31 09:09:21,418 UTC [645422] DEBUG esmvalcore.preprocessor:369 Running preprocessor step concatenate 2023-05-31 09:09:21,421 UTC [645422] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'concatenate' on the data [] loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/historical/r1i1p1f1/Amon/tas/gn/v20181214/tas_Amon_BCC-ESM1_historical_r1i1p1f1_gn_185001-201412.nc')] with function argument(s) 2023-05-31 09:09:21,421 UTC [645422] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:21,422 UTC [645422] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_global/CMIP6_BCC-ESM1_Amon_historical_r1i1p1f1_tas_gn_1850-2000/02_concatenate.nc 2023-05-31 09:09:21,633 UTC [645422] DEBUG esmvalcore.preprocessor:369 Running preprocessor step cmor_check_metadata 2023-05-31 09:09:21,634 UTC [645422] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'cmor_check_metadata' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/historical/r1i1p1f1/Amon/tas/gn/v20181214/tas_Amon_BCC-ESM1_historical_r1i1p1f1_gn_185001-201412.nc')] with function argument(s) check_level = , cmor_table = 'CMIP6', mip = 'Amon', frequency = 'mon', short_name = 'tas' 2023-05-31 09:09:21,640 UTC [645422] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:21,641 UTC [645422] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_global/CMIP6_BCC-ESM1_Amon_historical_r1i1p1f1_tas_gn_1850-2000/03_cmor_check_metadata.nc 2023-05-31 09:09:21,835 UTC [645422] DEBUG esmvalcore.preprocessor:369 Running preprocessor step clip_timerange 2023-05-31 09:09:21,836 UTC [645422] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'clip_timerange' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/historical/r1i1p1f1/Amon/tas/gn/v20181214/tas_Amon_BCC-ESM1_historical_r1i1p1f1_gn_185001-201412.nc')] with function argument(s) timerange = '1850/2000' 2023-05-31 09:09:21,847 UTC [645422] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:21,848 UTC [645422] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_global/CMIP6_BCC-ESM1_Amon_historical_r1i1p1f1_tas_gn_1850-2000/04_clip_timerange.nc 2023-05-31 09:09:22,079 UTC [645422] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_data 2023-05-31 09:09:22,080 UTC [645422] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'fix_data' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/historical/r1i1p1f1/Amon/tas/gn/v20181214/tas_Amon_BCC-ESM1_historical_r1i1p1f1_gn_185001-201412.nc')] with function argument(s) check_level = , short_name = 'tas', mip = 'Amon', preprocessor = 'annual_mean_global', timerange = '1850/2000', caption = 'Annual global mean {long_name} according to {dataset}.', dataset = 'BCC-ESM1', project = 'CMIP6', exp = 'historical', ensemble = 'r1i1p1f1', grid = 'gn', variable_group = 'tas_global', diagnostic = 'timeseries', recipe_dataset_index = 0, alias = 'CMIP6', institute = ['BCC'], activity = 'CMIP', original_short_name = 'tas', standard_name = 'air_temperature', long_name = 'Near-Surface Air Temperature', units = 'K', modeling_realm = ['atmos'], frequency = 'mon', version = 'v20181214' 2023-05-31 09:09:22,080 UTC [645422] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:22,081 UTC [645422] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_global/CMIP6_BCC-ESM1_Amon_historical_r1i1p1f1_tas_gn_1850-2000/05_fix_data.nc 2023-05-31 09:09:22,314 UTC [645422] DEBUG esmvalcore.preprocessor:369 Running preprocessor step cmor_check_data 2023-05-31 09:09:22,315 UTC [645422] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'cmor_check_data' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/historical/r1i1p1f1/Amon/tas/gn/v20181214/tas_Amon_BCC-ESM1_historical_r1i1p1f1_gn_185001-201412.nc')] with function argument(s) check_level = , cmor_table = 'CMIP6', mip = 'Amon', frequency = 'mon', short_name = 'tas' 2023-05-31 09:09:22,315 UTC [645422] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:22,316 UTC [645422] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_global/CMIP6_BCC-ESM1_Amon_historical_r1i1p1f1_tas_gn_1850-2000/06_cmor_check_data.nc 2023-05-31 09:09:22,557 UTC [645422] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_file 2023-05-31 09:09:22,558 UTC [645422] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'fix_file' on the data LocalFile('/projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/1pctCO2/r1i1p1f1/fx/areacella/gn/v20190613/areacella_fx_BCC-ESM1_1pctCO2_r1i1p1f1_gn.nc') loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/1pctCO2/r1i1p1f1/fx/areacella/gn/v20190613/areacella_fx_BCC-ESM1_1pctCO2_r1i1p1f1_gn.nc')] with function argument(s) output_dir = PosixPath('/projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/fixed_files/areacella_fx_CMIP6_BCC-ESM1_CMIP_1pctCO2_r1i1p1f1_gn_v20190613_'), add_unique_suffix = True, short_name = 'areacella', mip = 'fx', caption = 'Annual global mean {long_name} according to {dataset}.', dataset = 'BCC-ESM1', project = 'CMIP6', exp = '1pctCO2', ensemble = 'r1i1p1f1', grid = 'gn', activity = 'CMIP', institute = 'BCC', original_short_name = 'areacella', standard_name = 'cell_area', long_name = 'Grid-Cell Area for Atmospheric Grid Variables', units = 'm2', modeling_realm = ['atmos', 'land'], frequency = 'fx', version = 'v20190613' 2023-05-31 09:09:22,558 UTC [645422] DEBUG esmvalcore.preprocessor:390 Result [LocalFile('/projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/1pctCO2/r1i1p1f1/fx/areacella/gn/v20190613/areacella_fx_BCC-ESM1_1pctCO2_r1i1p1f1_gn.nc')] 2023-05-31 09:09:22,558 UTC [645422] DEBUG esmvalcore.preprocessor:369 Running preprocessor step load 2023-05-31 09:09:22,558 UTC [645422] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'load' on the data LocalFile('/projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/1pctCO2/r1i1p1f1/fx/areacella/gn/v20190613/areacella_fx_BCC-ESM1_1pctCO2_r1i1p1f1_gn.nc') loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/1pctCO2/r1i1p1f1/fx/areacella/gn/v20190613/areacella_fx_BCC-ESM1_1pctCO2_r1i1p1f1_gn.nc')] with function argument(s) callback = 'default' 2023-05-31 09:09:22,558 UTC [645422] DEBUG esmvalcore.preprocessor._io:152 Loading: /projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/1pctCO2/r1i1p1f1/fx/areacella/gn/v20190613/areacella_fx_BCC-ESM1_1pctCO2_r1i1p1f1_gn.nc 2023-05-31 09:09:22,565 UTC [645422] DEBUG esmvalcore.preprocessor._io:182 Done with loading /projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/1pctCO2/r1i1p1f1/fx/areacella/gn/v20190613/areacella_fx_BCC-ESM1_1pctCO2_r1i1p1f1_gn.nc 2023-05-31 09:09:22,566 UTC [645422] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:22,567 UTC [645422] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/CMIP6_BCC-ESM1_fx_1pctCO2_r1i1p1f1_areacella_gn/00_load.nc 2023-05-31 09:09:22,587 UTC [645422] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_metadata 2023-05-31 09:09:22,588 UTC [645422] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'fix_metadata' on the data [] loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/1pctCO2/r1i1p1f1/fx/areacella/gn/v20190613/areacella_fx_BCC-ESM1_1pctCO2_r1i1p1f1_gn.nc')] with function argument(s) check_level = , short_name = 'areacella', mip = 'fx', caption = 'Annual global mean {long_name} according to {dataset}.', dataset = 'BCC-ESM1', project = 'CMIP6', exp = '1pctCO2', ensemble = 'r1i1p1f1', grid = 'gn', activity = 'CMIP', institute = 'BCC', original_short_name = 'areacella', standard_name = 'cell_area', long_name = 'Grid-Cell Area for Atmospheric Grid Variables', units = 'm2', modeling_realm = ['atmos', 'land'], frequency = 'fx', version = 'v20190613' 2023-05-31 09:09:22,588 UTC [645422] WARNING esmvalcore.cmor.check:261 There were warnings in variable areacella: Long name for areacella changed from Grid-Cell Area for Atmospheric Variables to Grid-Cell Area for Atmospheric Grid Variables loaded from file /projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/1pctCO2/r1i1p1f1/fx/areacella/gn/v20190613/areacella_fx_BCC-ESM1_1pctCO2_r1i1p1f1_gn.nc 2023-05-31 09:09:22,588 UTC [645422] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:22,589 UTC [645422] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/CMIP6_BCC-ESM1_fx_1pctCO2_r1i1p1f1_areacella_gn/01_fix_metadata.nc 2023-05-31 09:09:22,607 UTC [645422] DEBUG esmvalcore.preprocessor:369 Running preprocessor step concatenate 2023-05-31 09:09:22,608 UTC [645422] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'concatenate' on the data [] loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/1pctCO2/r1i1p1f1/fx/areacella/gn/v20190613/areacella_fx_BCC-ESM1_1pctCO2_r1i1p1f1_gn.nc')] with function argument(s) 2023-05-31 09:09:22,608 UTC [645422] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:22,609 UTC [645422] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/CMIP6_BCC-ESM1_fx_1pctCO2_r1i1p1f1_areacella_gn/02_concatenate.nc 2023-05-31 09:09:22,627 UTC [645422] DEBUG esmvalcore.preprocessor:369 Running preprocessor step cmor_check_metadata 2023-05-31 09:09:22,628 UTC [645422] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'cmor_check_metadata' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/1pctCO2/r1i1p1f1/fx/areacella/gn/v20190613/areacella_fx_BCC-ESM1_1pctCO2_r1i1p1f1_gn.nc')] with function argument(s) check_level = , cmor_table = 'CMIP6', mip = 'fx', frequency = 'fx', short_name = 'areacella' 2023-05-31 09:09:22,628 UTC [645422] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:22,629 UTC [645422] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/CMIP6_BCC-ESM1_fx_1pctCO2_r1i1p1f1_areacella_gn/03_cmor_check_metadata.nc 2023-05-31 09:09:22,648 UTC [645422] DEBUG esmvalcore.preprocessor:369 Running preprocessor step fix_data 2023-05-31 09:09:22,648 UTC [645422] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'fix_data' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/1pctCO2/r1i1p1f1/fx/areacella/gn/v20190613/areacella_fx_BCC-ESM1_1pctCO2_r1i1p1f1_gn.nc')] with function argument(s) check_level = , short_name = 'areacella', mip = 'fx', caption = 'Annual global mean {long_name} according to {dataset}.', dataset = 'BCC-ESM1', project = 'CMIP6', exp = '1pctCO2', ensemble = 'r1i1p1f1', grid = 'gn', activity = 'CMIP', institute = 'BCC', original_short_name = 'areacella', standard_name = 'cell_area', long_name = 'Grid-Cell Area for Atmospheric Grid Variables', units = 'm2', modeling_realm = ['atmos', 'land'], frequency = 'fx', version = 'v20190613' 2023-05-31 09:09:22,649 UTC [645422] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:22,649 UTC [645422] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/CMIP6_BCC-ESM1_fx_1pctCO2_r1i1p1f1_areacella_gn/04_fix_data.nc 2023-05-31 09:09:22,667 UTC [645422] DEBUG esmvalcore.preprocessor:369 Running preprocessor step cmor_check_data 2023-05-31 09:09:22,668 UTC [645422] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'cmor_check_data' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/1pctCO2/r1i1p1f1/fx/areacella/gn/v20190613/areacella_fx_BCC-ESM1_1pctCO2_r1i1p1f1_gn.nc')] with function argument(s) check_level = , cmor_table = 'CMIP6', mip = 'fx', frequency = 'fx', short_name = 'areacella' 2023-05-31 09:09:22,669 UTC [645422] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:22,669 UTC [645422] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/CMIP6_BCC-ESM1_fx_1pctCO2_r1i1p1f1_areacella_gn/05_cmor_check_data.nc 2023-05-31 09:09:22,688 UTC [645422] DEBUG esmvalcore.preprocessor:369 Running preprocessor step add_supplementary_variables 2023-05-31 09:09:22,690 UTC [645422] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'add_supplementary_variables' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/historical/r1i1p1f1/Amon/tas/gn/v20181214/tas_Amon_BCC-ESM1_historical_r1i1p1f1_gn_185001-201412.nc'), LocalFile('/projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/1pctCO2/r1i1p1f1/fx/areacella/gn/v20190613/areacella_fx_BCC-ESM1_1pctCO2_r1i1p1f1_gn.nc')] with function argument(s) supplementary_cubes = [] 2023-05-31 09:09:22,690 UTC [645422] DEBUG esmvalcore.preprocessor._supplementary_vars:142 Added areacella as cell measure in cube of tas. 2023-05-31 09:09:22,690 UTC [645422] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:22,704 UTC [645422] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_global/CMIP6_BCC-ESM1_Amon_historical_r1i1p1f1_tas_gn_1850-2000/07_add_supplementary_variables.nc 2023-05-31 09:09:22,986 UTC [645422] DEBUG esmvalcore.preprocessor:369 Running preprocessor step area_statistics 2023-05-31 09:09:22,999 UTC [645422] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'area_statistics' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/historical/r1i1p1f1/Amon/tas/gn/v20181214/tas_Amon_BCC-ESM1_historical_r1i1p1f1_gn_185001-201412.nc'), LocalFile('/projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/1pctCO2/r1i1p1f1/fx/areacella/gn/v20190613/areacella_fx_BCC-ESM1_1pctCO2_r1i1p1f1_gn.nc')] with function argument(s) operator = 'mean' 2023-05-31 09:09:23,044 UTC [645422] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:23,046 UTC [645422] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_global/CMIP6_BCC-ESM1_Amon_historical_r1i1p1f1_tas_gn_1850-2000/08_area_statistics.nc 2023-05-31 09:09:23,387 UTC [645422] DEBUG esmvalcore.preprocessor:369 Running preprocessor step annual_statistics 2023-05-31 09:09:23,389 UTC [645422] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'annual_statistics' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/historical/r1i1p1f1/Amon/tas/gn/v20181214/tas_Amon_BCC-ESM1_historical_r1i1p1f1_gn_185001-201412.nc'), LocalFile('/projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/1pctCO2/r1i1p1f1/fx/areacella/gn/v20190613/areacella_fx_BCC-ESM1_1pctCO2_r1i1p1f1_gn.nc')] with function argument(s) operator = 'mean' 2023-05-31 09:09:24,043 UTC [645422] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:24,044 UTC [645422] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_global/CMIP6_BCC-ESM1_Amon_historical_r1i1p1f1_tas_gn_1850-2000/09_annual_statistics.nc 2023-05-31 09:09:24,784 UTC [645422] DEBUG esmvalcore.preprocessor:369 Running preprocessor step convert_units 2023-05-31 09:09:24,786 UTC [645422] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'convert_units' on the data loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/historical/r1i1p1f1/Amon/tas/gn/v20181214/tas_Amon_BCC-ESM1_historical_r1i1p1f1_gn_185001-201412.nc'), LocalFile('/projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/1pctCO2/r1i1p1f1/fx/areacella/gn/v20190613/areacella_fx_BCC-ESM1_1pctCO2_r1i1p1f1_gn.nc')] with function argument(s) units = 'degrees_C' 2023-05-31 09:09:24,787 UTC [645422] DEBUG esmvalcore.preprocessor:390 Result [] 2023-05-31 09:09:24,788 UTC [645422] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_global/CMIP6_BCC-ESM1_Amon_historical_r1i1p1f1_tas_gn_1850-2000/10_convert_units.nc 2023-05-31 09:09:25,531 UTC [645422] DEBUG esmvalcore.preprocessor:369 Running preprocessor step save 2023-05-31 09:09:25,533 UTC [645422] DEBUG esmvalcore.preprocessor:323 Running preprocessor function 'save' on the data [] loaded from original input file(s) [LocalFile('/projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/historical/r1i1p1f1/Amon/tas/gn/v20181214/tas_Amon_BCC-ESM1_historical_r1i1p1f1_gn_185001-201412.nc'), LocalFile('/projects/NS9560K-datalake/ESGF/CMIP6/CMIP/BCC/BCC-ESM1/1pctCO2/r1i1p1f1/fx/areacella/gn/v20190613/areacella_fx_BCC-ESM1_1pctCO2_r1i1p1f1_gn.nc')] with function argument(s) compress = False, filename = PosixPath('/projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_global/CMIP6_BCC-ESM1_Amon_historical_r1i1p1f1_tas_gn_1850-2000.nc') 2023-05-31 09:09:25,533 UTC [645422] DEBUG esmvalcore.preprocessor._io:307 Saving cubes [] to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/preproc/timeseries/tas_global/CMIP6_BCC-ESM1_Amon_historical_r1i1p1f1_tas_gn_1850-2000.nc 2023-05-31 09:09:26,312 UTC [645422] INFO esmvalcore._task:264 Successfully completed task timeseries/tas_global (priority 4) in 0:00:10.529195 2023-05-31 09:09:26,395 UTC [645282] INFO esmvalcore._task:778 Progress: 0 tasks running, 1 tasks waiting for ancestors, 4/5 done 2023-05-31 09:09:26,404 UTC [645421] INFO esmvalcore._task:259 Starting task timeseries/script1 in process [645421] 2023-05-31 09:09:26,407 UTC [645421] INFO esmvalcore._task:500 Running command ['/diagnostics/esmvaltool/2.8.0/bin/python', '/diagnostics/esmvaltool/2.8.0/lib/python3.10/site-packages/esmvaltool/diag_scripts/examples/diagnostic.py', '/projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/run/timeseries/script1/settings.yml'] 2023-05-31 09:09:26,407 UTC [645421] DEBUG esmvalcore._task:501 in environment {'MPLBACKEND': 'Agg'} 2023-05-31 09:09:26,407 UTC [645421] DEBUG esmvalcore._task:503 in current working directory: /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/run/timeseries/script1 2023-05-31 09:09:26,407 UTC [645421] INFO esmvalcore._task:504 Writing output to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/work/timeseries/script1 2023-05-31 09:09:26,407 UTC [645421] INFO esmvalcore._task:505 Writing plots to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/plots/timeseries/script1 2023-05-31 09:09:26,407 UTC [645421] INFO esmvalcore._task:506 Writing log to /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/run/timeseries/script1/log.txt 2023-05-31 09:09:26,407 UTC [645421] INFO esmvalcore._task:516 To re-run this diagnostic script, run: cd /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/run/timeseries/script1; MPLBACKEND="Agg" /diagnostics/esmvaltool/2.8.0/bin/python /diagnostics/esmvaltool/2.8.0/lib/python3.10/site-packages/esmvaltool/diag_scripts/examples/diagnostic.py /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/run/timeseries/script1/settings.yml 2023-05-31 09:09:26,496 UTC [645282] INFO esmvalcore._task:778 Progress: 1 tasks running, 0 tasks waiting for ancestors, 4/5 done 2023-05-31 09:09:31,423 UTC [645421] INFO esmvalcore._task:126 Maximum memory used (estimate): 0.6 GB 2023-05-31 09:09:31,424 UTC [645421] INFO esmvalcore._task:128 Sampled every second. It may be inaccurate if short but high spikes in memory consumption occur. 2023-05-31 09:09:31,424 UTC [645421] DEBUG esmvalcore._task:589 Script examples/diagnostic.py completed successfully 2023-05-31 09:09:31,424 UTC [645421] DEBUG esmvalcore._task:608 Collecting provenance from /projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/run/timeseries/script1/diagnostic_provenance.yml 2023-05-31 09:09:31,450 UTC [645421] DEBUG PIL.PngImagePlugin:204 STREAM b'IHDR' 16 13 2023-05-31 09:09:31,450 UTC [645421] DEBUG PIL.PngImagePlugin:204 STREAM b'tEXt' 41 57 2023-05-31 09:09:31,450 UTC [645421] DEBUG PIL.PngImagePlugin:204 STREAM b'pHYs' 110 9 2023-05-31 09:09:31,451 UTC [645421] DEBUG PIL.PngImagePlugin:204 STREAM b'IDAT' 131 47609 2023-05-31 09:09:31,499 UTC [645421] DEBUG PIL.PngImagePlugin:204 STREAM b'IHDR' 16 13 2023-05-31 09:09:31,499 UTC [645421] DEBUG PIL.PngImagePlugin:204 STREAM b'tEXt' 41 57 2023-05-31 09:09:31,499 UTC [645421] DEBUG PIL.PngImagePlugin:204 STREAM b'pHYs' 110 9 2023-05-31 09:09:31,499 UTC [645421] DEBUG PIL.PngImagePlugin:204 STREAM b'IDAT' 131 48330 2023-05-31 09:09:31,889 UTC [645421] DEBUG PIL.PngImagePlugin:204 STREAM b'IHDR' 16 13 2023-05-31 09:09:31,889 UTC [645421] DEBUG PIL.PngImagePlugin:204 STREAM b'tEXt' 41 57 2023-05-31 09:09:31,889 UTC [645421] DEBUG PIL.PngImagePlugin:204 STREAM b'pHYs' 110 9 2023-05-31 09:09:31,889 UTC [645421] DEBUG PIL.PngImagePlugin:204 STREAM b'IDAT' 131 54066 2023-05-31 09:09:31,935 UTC [645421] DEBUG PIL.PngImagePlugin:204 STREAM b'IHDR' 16 13 2023-05-31 09:09:31,935 UTC [645421] DEBUG PIL.PngImagePlugin:204 STREAM b'tEXt' 41 57 2023-05-31 09:09:31,935 UTC [645421] DEBUG PIL.PngImagePlugin:204 STREAM b'pHYs' 110 9 2023-05-31 09:09:31,935 UTC [645421] DEBUG PIL.PngImagePlugin:204 STREAM b'IDAT' 131 38927 2023-05-31 09:09:31,978 UTC [645421] DEBUG urllib3.connectionpool:1048 Starting new HTTPS connection (1): cera-www.dkrz.de:443 2023-05-31 09:09:32,162 UTC [645421] DEBUG urllib3.connectionpool:546 https://cera-www.dkrz.de:443 "GET /WDCC/ui/cerasearch/cerarest/exportcmip6?input=CMIP6.CMIP.BCC.BCC-ESM1.1pctCO2 HTTP/1.1" 302 270 2023-05-31 09:09:32,198 UTC [645421] DEBUG urllib3.connectionpool:546 https://cera-www.dkrz.de:443 "GET /ui/cerarest/exportcmip6?input=CMIP6.CMIP.BCC.BCC-ESM1.1pctCO2 HTTP/1.1" 302 272 2023-05-31 09:09:32,199 UTC [645421] DEBUG urllib3.connectionpool:1048 Starting new HTTPS connection (1): www.wdc-climate.de:443 2023-05-31 09:09:32,438 UTC [645421] DEBUG urllib3.connectionpool:546 https://www.wdc-climate.de:443 "GET /ui/cerarest/exportcmip6?input=CMIP6.CMIP.BCC.BCC-ESM1.1pctCO2 HTTP/1.1" 200 4745 2023-05-31 09:09:32,443 UTC [645421] DEBUG PIL.PngImagePlugin:204 STREAM b'IHDR' 16 13 2023-05-31 09:09:32,443 UTC [645421] DEBUG PIL.PngImagePlugin:204 STREAM b'tEXt' 41 57 2023-05-31 09:09:32,443 UTC [645421] DEBUG PIL.PngImagePlugin:204 STREAM b'pHYs' 110 9 2023-05-31 09:09:32,443 UTC [645421] DEBUG PIL.PngImagePlugin:204 STREAM b'IDAT' 131 46244 2023-05-31 09:09:32,532 UTC [645421] DEBUG esmvalcore._task:683 Collecting provenance of task timeseries/script1 took 1.1 seconds 2023-05-31 09:09:32,532 UTC [645421] INFO esmvalcore._task:264 Successfully completed task timeseries/script1 (priority 2) in 0:00:06.128466 2023-05-31 09:09:32,603 UTC [645282] INFO esmvalcore._task:778 Progress: 0 tasks running, 0 tasks waiting for ancestors, 5/5 done 2023-05-31 09:09:32,604 UTC [645282] INFO esmvalcore._task:783 Successfully completed all tasks. 2023-05-31 09:09:32,643 UTC [645282] INFO esmvalcore._recipe.recipe:1309 Wrote recipe with version numbers and wildcards to: file:///projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/run/recipe_python_filled.yml 2023-05-31 09:09:32,709 UTC [645282] INFO esmvalcore.experimental.recipe_output:205 Wrote recipe output to: file:///projects/NS9560K/www/diagnostics/esmvaltool/agu002/tmp/recipe_python_20230531_090908/index.html 2023-05-31 09:09:32,710 UTC [645282] INFO esmvalcore._main:125 Ending the Earth System Model Evaluation Tool at time: 2023-05-31 09:09:32 UTC 2023-05-31 09:09:32,710 UTC [645282] INFO esmvalcore._main:128 Time for running the recipe was: 0:00:23.795335 2023-05-31 09:09:33,334 UTC [645282] INFO esmvalcore._task:126 Maximum memory used (estimate): 2.3 GB 2023-05-31 09:09:33,334 UTC [645282] INFO esmvalcore._task:128 Sampled every second. It may be inaccurate if short but high spikes in memory consumption occur. 2023-05-31 09:09:33,334 UTC [645282] INFO esmvalcore._main:453 Run was successful