ReFrame logs

1. ReFrame scheduler script

#!/bin/bash
#SBATCH --job-name="rfm_RegressionTest_3fec2952"
#SBATCH --ntasks=16
#SBATCH --ntasks-per-node=16
#SBATCH --cpus-per-task=1
#SBATCH --output=rfm_job.out
#SBATCH --error=rfm_job.err
#SBATCH --exclusive
#SBATCH --partition=public
#SBATCH --threads-per-core=1
#SBATCH --time=0-00:5:0
source /etc/profile.d/modules.sh
export PATH=/opt/apptainer/v1.3.5/apptainer/bin/:$PATH
mpiexec -n 16 -bind-to core apptainer exec -B"/data/cemosis/github-actions-runner/actions-runner-4/_work/bench.ktirio.fr/bench.ktirio.fr/build/reframe/stage/gaya/public/default/RegressionTest_3fec2952:/rfm_workdir" --home /data/cemosis/benchmark --bind /data/cemosis/benchmark/input_data:/input_data --env OMP_NUM_THREADS=1 --sharens --bind /opt/:/opt/ /data/cemosis/github-actions-runner/actions-runner-4/_work/bench.ktirio.fr/bench.ktirio.fr/kub.sif feelpp_kub_cem --config-files /input_data/kub/idealHeaters.cfg --cem.simulator.lod0.modelisation.maxfloors=10 --cem.simulator.sun.filename=/input_data/kub/simulators/Sun.fmu --cem.gis.metadata.filename=/input_data/kub/Kernante/gis.json --cem.mesh.lod0.filename=/input_data/kub/Kernante/mesh.msh --cem.weather.filename=/input_data/kub/Kernante/weather.csv --cem.scenarios.filename=/input_data/kub/scenarios_local/scenarios.json --cem.instance.time.start=0 --cem.instance.time.stop=86400 --cem.instance.time.step=3600 --cem.instance.postprocess.export.visualization.enabled=false --cem.instance.postprocess.export.report.enabled=true --cem.instance.postprocess.export.outputs.csv.enabled=false --cem.instance.postprocess.export.outputs.enabled=true --cem.instance.solar_shading.enabled=true --cem.instance.idealflows.enabled=true --cem.database.directory /data/cemosis/benchmark/kub/3fec2952/kernante --directory /data/cemosis/benchmark/kub/3fec2952/kernante

2. ReFrame output log

[32mReading /input_data/kub/idealHeaters.cfg...[00m
[ Starting Feel++ ] [32mapplication City_Energy_Modeling version 0.111.0-preview.120 date 2025-Mar-28[00m
[feelpp] create Feel++ root repository: /data/cemosis/benchmark/kub/3fec2952/kernante

[feelpp] create Feel++ geo repository: /data/cemosis/benchmark/kub/3fec2952/kernante/geo

[feelpp] create Feel++ results directory: /data/cemosis/benchmark/kub/3fec2952/kernante/np_16

[feelpp] create Feel++ expressions directory: /data/cemosis/benchmark/kub/3fec2952/kernante/exprs

[feelpp] create Feel++ logs directory: /data/cemosis/benchmark/kub/3fec2952/kernante/np_16/logs

[31m . City_Energy_Modeling files are stored in [31m/data/cemosis/benchmark/kub/3fec2952/kernante/np_16[00m
 .. logfiles :/data/cemosis/benchmark/kub/3fec2952/kernante/np_16/logs
[ KUB ] application City_Energy_modeling version 0.5.0
[CityEnergyModelload] constructor start ...
[CityEnergyModelload] constructor current done in 0.00227586 s
[CityEnergyModelload] updateForUse start ...
[CityEnergyModelload] GisMeshInit start ...
[CityEnergyModelload] GisMeshInit current done in 0.00819937 s
[CityEnergyModelload] GisPartition start ...
nBuildings=40
[CityEnergyModelload] GisPartition current done in 1.4176e-05 s
[CityEnergyModelload] updateMeshBuilding start ...
 load full mesh start ...
[loadMesh] Loading Gmsh compatible mesh: "/data/cemosis/benchmark/kub/3fec2952/kernante/cem/gis/mesh.lod0.msh"
[loadMesh] Loading Gmsh compatible mesh: "/data/cemosis/benchmark/kub/3fec2952/kernante/cem/gis/mesh.lod0.msh" done
 load full mesh current done in 0.0857315 s
 mesh partioning step distribute building start ...
 mesh partioning step distribute building current done in 3.4885e-05 s
 mesh partioning step collectionOfMarkedelements start ...
 mesh partioning step collectionOfMarkedelements current done in 0.00461156 s
 mesh partioning step update process id of mesh element start ...
 mesh partioning step update process id of mesh element current done in 3.1309e-05 s
 mesh partioning step write mesh start ...
 mesh partioning step write mesh current done in 0.106149 s
[loadMesh] Loading mesh in format json+h5: "/data/cemosis/benchmark/kub/3fec2952/kernante/cem/gis/partitioning/mesh.lod0.np16.json"
[CityEnergyModelload] updateMeshBuilding current done in 0.303447 s
[CityEnergyModelload] buildingMap start ...
[CityEnergyModelload] buildingMap current done in 0.0276437 s
[CityEnergyModelload] scenarios start ...
[CityEnergyModelload] scenarios current done in 0.107795 s
[CityEnergyModelload] weather start ...
[CityEnergyModelload] weather current done in 0.0545772 s
[CityEnergyModelload] sunModel start ...
checking if fmu tmp path /data/cemosis/benchmark/kub/3fec2952/kernante/np_16/fmus/fmi4cpp_sun exists: false
unzipping /data/cemosis/benchmark/kub/3fec2952/kernante/cem/simulators/sun.fmu in /data/cemosis/benchmark/kub/3fec2952/kernante/np_16/fmus/fmi4cpp_sun
[CityEnergyModelload] sunModel current done in 0.170345 s
[CityEnergyModelload] initBuildingModels start ...
checking if fmu tmp path /data/cemosis/benchmark/kub/3fec2952/kernante/np_16/fmus/fmi4cpp_lod0.buildingfloor0 exists: false
unzipping /data/cemosis/benchmark/kub/3fec2952/kernante/cem/simulators/lod0.buildingfloor0.fmu in /data/cemosis/benchmark/kub/3fec2952/kernante/np_16/fmus/fmi4cpp_lod0.buildingfloor0
checking if fmu tmp path /data/cemosis/benchmark/kub/3fec2952/kernante/np_16/fmus/fmi4cpp_lod0.buildingfloor1 exists: false
unzipping /data/cemosis/benchmark/kub/3fec2952/kernante/cem/simulators/lod0.buildingfloor1.fmu in /data/cemosis/benchmark/kub/3fec2952/kernante/np_16/fmus/fmi4cpp_lod0.buildingfloor1
checking if fmu tmp path /data/cemosis/benchmark/kub/3fec2952/kernante/np_16/fmus/fmi4cpp_lod0.buildingfloor2 exists: false
unzipping /data/cemosis/benchmark/kub/3fec2952/kernante/cem/simulators/lod0.buildingfloor2.fmu in /data/cemosis/benchmark/kub/3fec2952/kernante/np_16/fmus/fmi4cpp_lod0.buildingfloor2
checking if fmu tmp path /data/cemosis/benchmark/kub/3fec2952/kernante/np_16/fmus/fmi4cpp_lod0.buildingfloor3 exists: false
unzipping /data/cemosis/benchmark/kub/3fec2952/kernante/cem/simulators/lod0.buildingfloor3.fmu in /data/cemosis/benchmark/kub/3fec2952/kernante/np_16/fmus/fmi4cpp_lod0.buildingfloor3
checking if fmu tmp path /data/cemosis/benchmark/kub/3fec2952/kernante/np_16/fmus/fmi4cpp_lod0.buildingfloor4 exists: false
unzipping /data/cemosis/benchmark/kub/3fec2952/kernante/cem/simulators/lod0.buildingfloor4.fmu in /data/cemosis/benchmark/kub/3fec2952/kernante/np_16/fmus/fmi4cpp_lod0.buildingfloor4
checking if fmu tmp path /data/cemosis/benchmark/kub/3fec2952/kernante/np_16/fmus/fmi4cpp_lod0.buildingfloor5 exists: false
unzipping /data/cemosis/benchmark/kub/3fec2952/kernante/cem/simulators/lod0.buildingfloor5.fmu in /data/cemosis/benchmark/kub/3fec2952/kernante/np_16/fmus/fmi4cpp_lod0.buildingfloor5
checking if fmu tmp path /data/cemosis/benchmark/kub/3fec2952/kernante/np_16/fmus/fmi4cpp_lod0.buildingfloor6 exists: false
unzipping /data/cemosis/benchmark/kub/3fec2952/kernante/cem/simulators/lod0.buildingfloor6.fmu in /data/cemosis/benchmark/kub/3fec2952/kernante/np_16/fmus/fmi4cpp_lod0.buildingfloor6
checking if fmu tmp path /data/cemosis/benchmark/kub/3fec2952/kernante/np_16/fmus/fmi4cpp_lod0.buildingfloor7 exists: false
unzipping /data/cemosis/benchmark/kub/3fec2952/kernante/cem/simulators/lod0.buildingfloor7.fmu in /data/cemosis/benchmark/kub/3fec2952/kernante/np_16/fmus/fmi4cpp_lod0.buildingfloor7
checking if fmu tmp path /data/cemosis/benchmark/kub/3fec2952/kernante/np_16/fmus/fmi4cpp_lod0.buildingfloor8 exists: false
unzipping /data/cemosis/benchmark/kub/3fec2952/kernante/cem/simulators/lod0.buildingfloor8.fmu in /data/cemosis/benchmark/kub/3fec2952/kernante/np_16/fmus/fmi4cpp_lod0.buildingfloor8
checking if fmu tmp path /data/cemosis/benchmark/kub/3fec2952/kernante/np_16/fmus/fmi4cpp_lod0.buildingfloor9 exists: false
unzipping /data/cemosis/benchmark/kub/3fec2952/kernante/cem/simulators/lod0.buildingfloor9.fmu in /data/cemosis/benchmark/kub/3fec2952/kernante/np_16/fmus/fmi4cpp_lod0.buildingfloor9
[CityEnergyModelload] initBuildingModels current done in 5.49162 s
[CityEnergyModelload] updateForUse current done in 6.16397 s
[SunModel::SunInstance] creating sun new instance
[CityEnergyModel::Instance]
  |-- export outputs enabled: 1
  |-- export visualization enabled: 0
  |-- export report enabled: 1
  |-- export building report enabled: 0
  |-- solar shading coefficients enabled: building
  |-- solar shading components: building
[CityEnergyModelInstance] execute start ...
execute at time=3600
[CityEnergyModelInstance] execute.simulation start ...
[CityEnergyModelInstance] execute.simulation.solarMasks start ...
[CityEnergyModelInstance] updateSolarPosition : create bvh start ...
[CityEnergyModelInstance] updateSolarPosition : create bvh current done in 8.488e-05 s
[CityEnergyModelInstance] updateSolarPosition : create rays start ...
[CityEnergyModelInstance] updateSolarPosition : create rays current done in 0.000613363 s
[CityEnergyModelInstance] updateSolarPosition : create rays intersect start ...
[CityEnergyModelInstance] updateSolarPosition : create rays intersect current done in 0.000100339 s
[CityEnergyModelInstance] updateSolarPosition :  update solar shading coefficients start ...
[CityEnergyModelInstance] updateSolarPosition :  update solar shading coefficients current done in 5.51e-07 s
[CityEnergyModelInstance] execute.simulation.solarMasks current done in 0.000975875 s
[CityEnergyModelInstance] execute.simulation.buildingExecuteStep start ...
[CityEnergyModelInstance] execute.simulation.buildingExecuteStep current done in 0.0241616 s
[CityEnergyModelInstance] execute.simulation current done in 0.0252013 s
[CityEnergyModelInstance] execute.postprocess start ...
[CityEnergyModelInstance] report start ...
[CityEnergyModelInstance] report current done in 6.3199e-05 s
[CityEnergyModelInstance] report start ...
[CityEnergyModelInstance] report current done in 0.047944 s
[CityEnergyModelInstance] exportOutputs start ...
[CityEnergyModelInstance] exportOutputs current done in 0.0554738 s
[CityEnergyModelInstance] execute.postprocess current done in 0.103538 s
execute at time=7200
[CityEnergyModelInstance] execute.simulation start ...
[CityEnergyModelInstance] execute.simulation.solarMasks start ...
[CityEnergyModelInstance] updateSolarPosition : create bvh start ...
[CityEnergyModelInstance] updateSolarPosition : create bvh current done in 1.21e-07 s
[CityEnergyModelInstance] updateSolarPosition : create rays start ...
[CityEnergyModelInstance] updateSolarPosition : create rays current done in 0.000419439 s
[CityEnergyModelInstance] updateSolarPosition : create rays intersect start ...
[CityEnergyModelInstance] updateSolarPosition : create rays intersect current done in 4.8862e-05 s
[CityEnergyModelInstance] updateSolarPosition :  update solar shading coefficients start ...
[CityEnergyModelInstance] updateSolarPosition :  update solar shading coefficients current done in 7.31e-07 s
[CityEnergyModelInstance] execute.simulation.solarMasks current done in 0.000560394 s
[CityEnergyModelInstance] execute.simulation.buildingExecuteStep start ...
[CityEnergyModelInstance] execute.simulation.buildingExecuteStep current done in 0.000967049 s
[CityEnergyModelInstance] execute.simulation current done in 0.00158636 s
[CityEnergyModelInstance] execute.postprocess start ...
[CityEnergyModelInstance] report start ...
[CityEnergyModelInstance] report current done in 5.6056e-05 s
[CityEnergyModelInstance] report start ...
[CityEnergyModelInstance] report current done in 0.0039875 s
[CityEnergyModelInstance] exportOutputs start ...
[CityEnergyModelInstance] exportOutputs current done in 0.025797 s
[CityEnergyModelInstance] execute.postprocess current done in 0.0299026 s
execute at time=10800
[CityEnergyModelInstance] execute.simulation start ...
[CityEnergyModelInstance] execute.simulation.solarMasks start ...
[CityEnergyModelInstance] updateSolarPosition : create bvh start ...
[CityEnergyModelInstance] updateSolarPosition : create bvh current done in 1.2e-07 s
[CityEnergyModelInstance] updateSolarPosition : create rays start ...
[CityEnergyModelInstance] updateSolarPosition : create rays current done in 0.000416414 s
[CityEnergyModelInstance] updateSolarPosition : create rays intersect start ...
[CityEnergyModelInstance] updateSolarPosition : create rays intersect current done in 4.6337e-05 s
[CityEnergyModelInstance] updateSolarPosition :  update solar shading coefficients start ...
[CityEnergyModelInstance] updateSolarPosition :  update solar shading coefficients current done in 7.81e-07 s
[CityEnergyModelInstance] execute.simulation.solarMasks current done in 0.000542751 s
[CityEnergyModelInstance] execute.simulation.buildingExecuteStep start ...
[CityEnergyModelInstance] execute.simulation.buildingExecuteStep current done in 0.00080811 s
[CityEnergyModelInstance] execute.simulation current done in 0.0014157 s
[CityEnergyModelInstance] execute.postprocess start ...
[CityEnergyModelInstance] report start ...
[CityEnergyModelInstance] report current done in 5.5354e-05 s
[CityEnergyModelInstance] report start ...
[CityEnergyModelInstance] report current done in 0.00374522 s
[CityEnergyModelInstance] exportOutputs start ...
[CityEnergyModelInstance] exportOutputs current done in 0.0263279 s
[CityEnergyModelInstance] execute.postprocess current done in 0.0301885 s
execute at time=14400
[CityEnergyModelInstance] execute.simulation start ...
[CityEnergyModelInstance] execute.simulation.solarMasks start ...
[CityEnergyModelInstance] updateSolarPosition : create bvh start ...
[CityEnergyModelInstance] updateSolarPosition : create bvh current done in 1.5e-07 s
[CityEnergyModelInstance] updateSolarPosition : create rays start ...
[CityEnergyModelInstance] updateSolarPosition : create rays current done in 0.00041456 s
[CityEnergyModelInstance] updateSolarPosition : create rays intersect start ...
[CityEnergyModelInstance] updateSolarPosition : create rays intersect current done in 0.0001599 s
[CityEnergyModelInstance] updateSolarPosition :  update solar shading coefficients start ...
[CityEnergyModelInstance] updateSolarPosition :  update solar shading coefficients current done in 8.52e-07 s
[CityEnergyModelInstance] execute.simulation.solarMasks current done in 0.000678095 s
[CityEnergyModelInstance] execute.simulation.buildingExecuteStep start ...
[CityEnergyModelInstance] execute.simulation.buildingExecuteStep current done in 0.000762133 s
[CityEnergyModelInstance] execute.simulation current done in 0.00149627 s
[CityEnergyModelInstance] execute.postprocess start ...
[CityEnergyModelInstance] report start ...
[CityEnergyModelInstance] report current done in 5.5444e-05 s
[CityEnergyModelInstance] report start ...
[CityEnergyModelInstance] report current done in 0.00506231 s
[CityEnergyModelInstance] exportOutputs start ...
[CityEnergyModelInstance] exportOutputs current done in 0.0255694 s
[CityEnergyModelInstance] execute.postprocess current done in 0.0307442 s
execute at time=18000
[CityEnergyModelInstance] execute.simulation start ...
[CityEnergyModelInstance] execute.simulation.solarMasks start ...
[CityEnergyModelInstance] updateSolarPosition : create bvh start ...
[CityEnergyModelInstance] updateSolarPosition : create bvh current done in 1.2e-07 s
[CityEnergyModelInstance] updateSolarPosition : create rays start ...
[CityEnergyModelInstance] updateSolarPosition : create rays current done in 0.00042021 s
[CityEnergyModelInstance] updateSolarPosition : create rays intersect start ...
[CityEnergyModelInstance] updateSolarPosition : create rays intersect current done in 4.8632e-05 s
[CityEnergyModelInstance] updateSolarPosition :  update solar shading coefficients start ...
[CityEnergyModelInstance] updateSolarPosition :  update solar shading coefficients current done in 1.262e-06 s
[CityEnergyModelInstance] execute.simulation.solarMasks current done in 0.000565554 s
[CityEnergyModelInstance] execute.simulation.buildingExecuteStep start ...
[CityEnergyModelInstance] execute.simulation.buildingExecuteStep current done in 0.00075503 s
[CityEnergyModelInstance] execute.simulation current done in 0.00137839 s
[CityEnergyModelInstance] execute.postprocess start ...
[CityEnergyModelInstance] report start ...
[CityEnergyModelInstance] report current done in 5.5104e-05 s
[CityEnergyModelInstance] report start ...
[CityEnergyModelInstance] report current done in 0.00329392 s
[CityEnergyModelInstance] exportOutputs start ...
[CityEnergyModelInstance] exportOutputs current done in 0.0261022 s
[CityEnergyModelInstance] execute.postprocess current done in 0.0295067 s
execute at time=21600
[CityEnergyModelInstance] execute.simulation start ...
[CityEnergyModelInstance] execute.simulation.solarMasks start ...
[CityEnergyModelInstance] updateSolarPosition : create bvh start ...
[CityEnergyModelInstance] updateSolarPosition : create bvh current done in 1.21e-07 s
[CityEnergyModelInstance] updateSolarPosition : create rays start ...
[CityEnergyModelInstance] updateSolarPosition : create rays current done in 0.000412826 s
[CityEnergyModelInstance] updateSolarPosition : create rays intersect start ...
[CityEnergyModelInstance] updateSolarPosition : create rays intersect current done in 8.1594e-05 s
[CityEnergyModelInstance] updateSolarPosition :  update solar shading coefficients start ...
[CityEnergyModelInstance] updateSolarPosition :  update solar shading coefficients current done in 9.12e-07 s
[CityEnergyModelInstance] execute.simulation.solarMasks current done in 0.000581674 s
[CityEnergyModelInstance] execute.simulation.buildingExecuteStep start ...
[CityEnergyModelInstance] execute.simulation.buildingExecuteStep current done in 0.00139267 s
[CityEnergyModelInstance] execute.simulation current done in 0.00204663 s
[CityEnergyModelInstance] execute.postprocess start ...
[CityEnergyModelInstance] report start ...
[CityEnergyModelInstance] report current done in 5.7278e-05 s
[CityEnergyModelInstance] report start ...
[CityEnergyModelInstance] report current done in 0.00309004 s
[CityEnergyModelInstance] exportOutputs start ...
[CityEnergyModelInstance] exportOutputs current done in 0.02578 s
[CityEnergyModelInstance] execute.postprocess current done in 0.0289865 s
execute at time=25200
[CityEnergyModelInstance] execute.simulation start ...
[CityEnergyModelInstance] execute.simulation.solarMasks start ...
[CityEnergyModelInstance] updateSolarPosition : create bvh start ...
[CityEnergyModelInstance] updateSolarPosition : create bvh current done in 1.2e-07 s
[CityEnergyModelInstance] updateSolarPosition : create rays start ...
[CityEnergyModelInstance] updateSolarPosition : create rays current done in 0.000415812 s
[CityEnergyModelInstance] updateSolarPosition : create rays intersect start ...
[CityEnergyModelInstance] updateSolarPosition : create rays intersect current done in 4.3973e-05 s
[CityEnergyModelInstance] updateSolarPosition :  update solar shading coefficients start ...
[CityEnergyModelInstance] updateSolarPosition :  update solar shading coefficients current done in 9.42e-07 s
[CityEnergyModelInstance] execute.simulation.solarMasks current done in 0.000543723 s
[CityEnergyModelInstance] execute.simulation.buildingExecuteStep start ...
[CityEnergyModelInstance] execute.simulation.buildingExecuteStep current done in 0.000798772 s
[CityEnergyModelInstance] execute.simulation current done in 0.00140799 s
[CityEnergyModelInstance] execute.postprocess start ...
[CityEnergyModelInstance] report start ...
[CityEnergyModelInstance] report current done in 5.6336e-05 s
[CityEnergyModelInstance] report start ...
[CityEnergyModelInstance] report current done in 0.00506843 s
[CityEnergyModelInstance] exportOutputs start ...
[CityEnergyModelInstance] exportOutputs current done in 0.0527055 s
[CityEnergyModelInstance] execute.postprocess current done in 0.0578979 s
execute at time=28800
[CityEnergyModelInstance] execute.simulation start ...
[CityEnergyModelInstance] execute.simulation.solarMasks start ...
[CityEnergyModelInstance] updateSolarPosition : create bvh start ...
[CityEnergyModelInstance] updateSolarPosition : create bvh current done in 1.21e-07 s
[CityEnergyModelInstance] updateSolarPosition : create rays start ...
[CityEnergyModelInstance] updateSolarPosition : create rays current done in 0.000415662 s
[CityEnergyModelInstance] updateSolarPosition : create rays intersect start ...
[CityEnergyModelInstance] updateSolarPosition : create rays intersect current done in 4.6888e-05 s
[CityEnergyModelInstance] updateSolarPosition :  update solar shading coefficients start ...
[CityEnergyModelInstance] updateSolarPosition :  update solar shading coefficients current done in 9.21e-07 s
[CityEnergyModelInstance] execute.simulation.solarMasks current done in 0.000558601 s
[CityEnergyModelInstance] execute.simulation.buildingExecuteStep start ...
[CityEnergyModelInstance] execute.simulation.buildingExecuteStep current done in 0.000631829 s
[CityEnergyModelInstance] execute.simulation current done in 0.00124616 s
[CityEnergyModelInstance] execute.postprocess start ...
[CityEnergyModelInstance] report start ...
[CityEnergyModelInstance] report current done in 5.5414e-05 s
[CityEnergyModelInstance] report start ...
[CityEnergyModelInstance] report current done in 0.00285112 s
[CityEnergyModelInstance] exportOutputs start ...
[CityEnergyModelInstance] exportOutputs current done in 0.025219 s
[CityEnergyModelInstance] execute.postprocess current done in 0.0281799 s
execute at time=32400
[CityEnergyModelInstance] execute.simulation start ...
[CityEnergyModelInstance] execute.simulation.solarMasks start ...
[CityEnergyModelInstance] updateSolarPosition : create bvh start ...
[CityEnergyModelInstance] updateSolarPosition : create bvh current done in 1.11e-07 s
[CityEnergyModelInstance] updateSolarPosition : create rays start ...
[CityEnergyModelInstance] updateSolarPosition : create rays current done in 0.00044161 s
[CityEnergyModelInstance] updateSolarPosition : create rays intersect start ...
[CityEnergyModelInstance] updateSolarPosition : create rays intersect current done in 0.0017668 s
[CityEnergyModelInstance] updateSolarPosition :  update solar shading coefficients start ...
[CityEnergyModelInstance] updateSolarPosition :  update solar shading coefficients current done in 0.00978637 s
[CityEnergyModelInstance] execute.simulation.solarMasks current done in 0.0120789 s
[CityEnergyModelInstance] execute.simulation.buildingExecuteStep start ...
[CityEnergyModelInstance] execute.simulation.buildingExecuteStep current done in 0.0023585 s
[CityEnergyModelInstance] execute.simulation current done in 0.0145155 s
[CityEnergyModelInstance] execute.postprocess start ...
[CityEnergyModelInstance] report start ...
[CityEnergyModelInstance] report current done in 5.7989e-05 s
[CityEnergyModelInstance] report start ...
[CityEnergyModelInstance] report current done in 0.0256264 s
[CityEnergyModelInstance] exportOutputs start ...
[CityEnergyModelInstance] exportOutputs current done in 0.0386525 s
[CityEnergyModelInstance] execute.postprocess current done in 0.0643968 s
execute at time=36000
[CityEnergyModelInstance] execute.simulation start ...
[CityEnergyModelInstance] execute.simulation.solarMasks start ...
[CityEnergyModelInstance] updateSolarPosition : create bvh start ...
[CityEnergyModelInstance] updateSolarPosition : create bvh current done in 1.2e-07 s
[CityEnergyModelInstance] updateSolarPosition : create rays start ...
[CityEnergyModelInstance] updateSolarPosition : create rays current done in 0.000434277 s
[CityEnergyModelInstance] updateSolarPosition : create rays intersect start ...
[CityEnergyModelInstance] updateSolarPosition : create rays intersect current done in 0.0014385 s
[CityEnergyModelInstance] updateSolarPosition :  update solar shading coefficients start ...
[CityEnergyModelInstance] updateSolarPosition :  update solar shading coefficients current done in 0.0097641 s
[CityEnergyModelInstance] execute.simulation.solarMasks current done in 0.0117298 s
[CityEnergyModelInstance] execute.simulation.buildingExecuteStep start ...
[CityEnergyModelInstance] execute.simulation.buildingExecuteStep current done in 0.00262115 s
[CityEnergyModelInstance] execute.simulation current done in 0.0144184 s
[CityEnergyModelInstance] execute.postprocess start ...
[CityEnergyModelInstance] report start ...
[CityEnergyModelInstance] report current done in 5.87e-05 s
[CityEnergyModelInstance] report start ...
[CityEnergyModelInstance] report current done in 0.0224933 s
[CityEnergyModelInstance] exportOutputs start ...
[CityEnergyModelInstance] exportOutputs current done in 0.037732 s
[CityEnergyModelInstance] execute.postprocess current done in 0.0603413 s
execute at time=39600
[CityEnergyModelInstance] execute.simulation start ...
[CityEnergyModelInstance] execute.simulation.solarMasks start ...
[CityEnergyModelInstance] updateSolarPosition : create bvh start ...
[CityEnergyModelInstance] updateSolarPosition : create bvh current done in 1.3e-07 s
[CityEnergyModelInstance] updateSolarPosition : create rays start ...
[CityEnergyModelInstance] updateSolarPosition : create rays current done in 0.000431812 s
[CityEnergyModelInstance] updateSolarPosition : create rays intersect start ...
[CityEnergyModelInstance] updateSolarPosition : create rays intersect current done in 0.00141131 s
[CityEnergyModelInstance] updateSolarPosition :  update solar shading coefficients start ...
[CityEnergyModelInstance] updateSolarPosition :  update solar shading coefficients current done in 0.00962437 s
[CityEnergyModelInstance] execute.simulation.solarMasks current done in 0.0115608 s
[CityEnergyModelInstance] execute.simulation.buildingExecuteStep start ...
[CityEnergyModelInstance] execute.simulation.buildingExecuteStep current done in 0.00124245 s
[CityEnergyModelInstance] execute.simulation current done in 0.0128868 s
[CityEnergyModelInstance] execute.postprocess start ...
[CityEnergyModelInstance] report start ...
[CityEnergyModelInstance] report current done in 5.5936e-05 s
[CityEnergyModelInstance] report start ...
[CityEnergyModelInstance] report current done in 0.0258802 s
[CityEnergyModelInstance] exportOutputs start ...
[CityEnergyModelInstance] exportOutputs current done in 0.0557175 s
[CityEnergyModelInstance] execute.postprocess current done in 0.0817108 s
execute at time=43200
[CityEnergyModelInstance] execute.simulation start ...
[CityEnergyModelInstance] execute.simulation.solarMasks start ...
[CityEnergyModelInstance] updateSolarPosition : create bvh start ...
[CityEnergyModelInstance] updateSolarPosition : create bvh current done in 1.21e-07 s
[CityEnergyModelInstance] updateSolarPosition : create rays start ...
[CityEnergyModelInstance] updateSolarPosition : create rays current done in 0.000431091 s
[CityEnergyModelInstance] updateSolarPosition : create rays intersect start ...
[CityEnergyModelInstance] updateSolarPosition : create rays intersect current done in 0.00138161 s
[CityEnergyModelInstance] updateSolarPosition :  update solar shading coefficients start ...
[CityEnergyModelInstance] updateSolarPosition :  update solar shading coefficients current done in 0.00959539 s
[CityEnergyModelInstance] execute.simulation.solarMasks current done in 0.0114962 s
[CityEnergyModelInstance] execute.simulation.buildingExecuteStep start ...
[CityEnergyModelInstance] execute.simulation.buildingExecuteStep current done in 0.00076017 s
[CityEnergyModelInstance] execute.simulation current done in 0.0123154 s
[CityEnergyModelInstance] execute.postprocess start ...
[CityEnergyModelInstance] report start ...
[CityEnergyModelInstance] report current done in 6.0363e-05 s
[CityEnergyModelInstance] report start ...
[CityEnergyModelInstance] report current done in 0.0230343 s
[CityEnergyModelInstance] exportOutputs start ...
[CityEnergyModelInstance] exportOutputs current done in 0.0258873 s
[CityEnergyModelInstance] execute.postprocess current done in 0.0490446 s
execute at time=46800
[CityEnergyModelInstance] execute.simulation start ...
[CityEnergyModelInstance] execute.simulation.solarMasks start ...
[CityEnergyModelInstance] updateSolarPosition : create bvh start ...
[CityEnergyModelInstance] updateSolarPosition : create bvh current done in 1.81e-07 s
[CityEnergyModelInstance] updateSolarPosition : create rays start ...
[CityEnergyModelInstance] updateSolarPosition : create rays current done in 0.000439416 s
[CityEnergyModelInstance] updateSolarPosition : create rays intersect start ...
[CityEnergyModelInstance] updateSolarPosition : create rays intersect current done in 0.00140889 s
[CityEnergyModelInstance] updateSolarPosition :  update solar shading coefficients start ...
[CityEnergyModelInstance] updateSolarPosition :  update solar shading coefficients current done in 0.00966648 s
[CityEnergyModelInstance] execute.simulation.solarMasks current done in 0.0116175 s
[CityEnergyModelInstance] execute.simulation.buildingExecuteStep start ...
[CityEnergyModelInstance] execute.simulation.buildingExecuteStep current done in 0.00104734 s
[CityEnergyModelInstance] execute.simulation current done in 0.0127302 s
[CityEnergyModelInstance] execute.postprocess start ...
[CityEnergyModelInstance] report start ...
[CityEnergyModelInstance] report current done in 6.1656e-05 s
[CityEnergyModelInstance] report start ...
[CityEnergyModelInstance] report current done in 0.0214703 s
[CityEnergyModelInstance] exportOutputs start ...
[CityEnergyModelInstance] exportOutputs current done in 0.027911 s
[CityEnergyModelInstance] execute.postprocess current done in 0.0494983 s
execute at time=50400
[CityEnergyModelInstance] execute.simulation start ...
[CityEnergyModelInstance] execute.simulation.solarMasks start ...
[CityEnergyModelInstance] updateSolarPosition : create bvh start ...
[CityEnergyModelInstance] updateSolarPosition : create bvh current done in 1e-07 s
[CityEnergyModelInstance] updateSolarPosition : create rays start ...
[CityEnergyModelInstance] updateSolarPosition : create rays current done in 0.000432674 s
[CityEnergyModelInstance] updateSolarPosition : create rays intersect start ...
[CityEnergyModelInstance] updateSolarPosition : create rays intersect current done in 0.00138969 s
[CityEnergyModelInstance] updateSolarPosition :  update solar shading coefficients start ...
[CityEnergyModelInstance] updateSolarPosition :  update solar shading coefficients current done in 0.00966631 s
[CityEnergyModelInstance] execute.simulation.solarMasks current done in 0.0115806 s
[CityEnergyModelInstance] execute.simulation.buildingExecuteStep start ...
[CityEnergyModelInstance] execute.simulation.buildingExecuteStep current done in 0.000763165 s
[CityEnergyModelInstance] execute.simulation current done in 0.0124049 s
[CityEnergyModelInstance] execute.postprocess start ...
[CityEnergyModelInstance] report start ...
[CityEnergyModelInstance] report current done in 5.9311e-05 s
[CityEnergyModelInstance] report start ...
[CityEnergyModelInstance] report current done in 0.0233002 s
[CityEnergyModelInstance] exportOutputs start ...
[CityEnergyModelInstance] exportOutputs current done in 0.0272533 s
[CityEnergyModelInstance] execute.postprocess current done in 0.0506721 s
execute at time=54000
[CityEnergyModelInstance] execute.simulation start ...
[CityEnergyModelInstance] execute.simulation.solarMasks start ...
[CityEnergyModelInstance] updateSolarPosition : create bvh start ...
[CityEnergyModelInstance] updateSolarPosition : create bvh current done in 1.2e-07 s
[CityEnergyModelInstance] updateSolarPosition : create rays start ...
[CityEnergyModelInstance] updateSolarPosition : create rays current done in 0.000431612 s
[CityEnergyModelInstance] updateSolarPosition : create rays intersect start ...
[CityEnergyModelInstance] updateSolarPosition : create rays intersect current done in 0.00144771 s
[CityEnergyModelInstance] updateSolarPosition :  update solar shading coefficients start ...
[CityEnergyModelInstance] updateSolarPosition :  update solar shading coefficients current done in 0.00964578 s
[CityEnergyModelInstance] execute.simulation.solarMasks current done in 0.0116212 s
[CityEnergyModelInstance] execute.simulation.buildingExecuteStep start ...
[CityEnergyModelInstance] execute.simulation.buildingExecuteStep current done in 0.000633792 s
[CityEnergyModelInstance] execute.simulation current done in 0.0123189 s
[CityEnergyModelInstance] execute.postprocess start ...
[CityEnergyModelInstance] report start ...
[CityEnergyModelInstance] report current done in 5.863e-05 s
[CityEnergyModelInstance] report start ...
[CityEnergyModelInstance] report current done in 0.0220061 s
[CityEnergyModelInstance] exportOutputs start ...
[CityEnergyModelInstance] exportOutputs current done in 0.0799577 s
[CityEnergyModelInstance] execute.postprocess current done in 0.102085 s
execute at time=57600
[CityEnergyModelInstance] execute.simulation start ...
[CityEnergyModelInstance] execute.simulation.solarMasks start ...
[CityEnergyModelInstance] updateSolarPosition : create bvh start ...
[CityEnergyModelInstance] updateSolarPosition : create bvh current done in 1.1e-07 s
[CityEnergyModelInstance] updateSolarPosition : create rays start ...
[CityEnergyModelInstance] updateSolarPosition : create rays current done in 0.000429077 s
[CityEnergyModelInstance] updateSolarPosition : create rays intersect start ...
[CityEnergyModelInstance] updateSolarPosition : create rays intersect current done in 0.00152689 s
[CityEnergyModelInstance] updateSolarPosition :  update solar shading coefficients start ...
[CityEnergyModelInstance] updateSolarPosition :  update solar shading coefficients current done in 0.00967847 s
[CityEnergyModelInstance] execute.simulation.solarMasks current done in 0.011727 s
[CityEnergyModelInstance] execute.simulation.buildingExecuteStep start ...
[CityEnergyModelInstance] execute.simulation.buildingExecuteStep current done in 0.000762464 s
[CityEnergyModelInstance] execute.simulation current done in 0.0125542 s
[CityEnergyModelInstance] execute.postprocess start ...
[CityEnergyModelInstance] report start ...
[CityEnergyModelInstance] report current done in 5.9442e-05 s
[CityEnergyModelInstance] report start ...
[CityEnergyModelInstance] report current done in 0.0250752 s
[CityEnergyModelInstance] exportOutputs start ...
[CityEnergyModelInstance] exportOutputs current done in 0.0250546 s
[CityEnergyModelInstance] execute.postprocess current done in 0.0502476 s
execute at time=61200
[CityEnergyModelInstance] execute.simulation start ...
[CityEnergyModelInstance] execute.simulation.solarMasks start ...
[CityEnergyModelInstance] updateSolarPosition : create bvh start ...
[CityEnergyModelInstance] updateSolarPosition : create bvh current done in 1.1e-07 s
[CityEnergyModelInstance] updateSolarPosition : create rays start ...
[CityEnergyModelInstance] updateSolarPosition : create rays current done in 0.000413488 s
[CityEnergyModelInstance] updateSolarPosition : create rays intersect start ...
[CityEnergyModelInstance] updateSolarPosition : create rays intersect current done in 4.7419e-05 s
[CityEnergyModelInstance] updateSolarPosition :  update solar shading coefficients start ...
[CityEnergyModelInstance] updateSolarPosition :  update solar shading coefficients current done in 1.082e-06 s
[CityEnergyModelInstance] execute.simulation.solarMasks current done in 0.000546949 s
[CityEnergyModelInstance] execute.simulation.buildingExecuteStep start ...
[CityEnergyModelInstance] execute.simulation.buildingExecuteStep current done in 0.0025835 s
[CityEnergyModelInstance] execute.simulation current done in 0.00319564 s
[CityEnergyModelInstance] execute.postprocess start ...
[CityEnergyModelInstance] report start ...
[CityEnergyModelInstance] report current done in 5.6506e-05 s
[CityEnergyModelInstance] report start ...
[CityEnergyModelInstance] report current done in 0.00704197 s
[CityEnergyModelInstance] exportOutputs start ...
[CityEnergyModelInstance] exportOutputs current done in 0.0249303 s
[CityEnergyModelInstance] execute.postprocess current done in 0.0320835 s
execute at time=64800
[CityEnergyModelInstance] execute.simulation start ...
[CityEnergyModelInstance] execute.simulation.solarMasks start ...
[CityEnergyModelInstance] updateSolarPosition : create bvh start ...
[CityEnergyModelInstance] updateSolarPosition : create bvh current done in 1.3e-07 s
[CityEnergyModelInstance] updateSolarPosition : create rays start ...
[CityEnergyModelInstance] updateSolarPosition : create rays current done in 0.000412847 s
[CityEnergyModelInstance] updateSolarPosition : create rays intersect start ...
[CityEnergyModelInstance] updateSolarPosition : create rays intersect current done in 4.4814e-05 s
[CityEnergyModelInstance] updateSolarPosition :  update solar shading coefficients start ...
[CityEnergyModelInstance] updateSolarPosition :  update solar shading coefficients current done in 7.02e-07 s
[CityEnergyModelInstance] execute.simulation.solarMasks current done in 0.000543623 s
[CityEnergyModelInstance] execute.simulation.buildingExecuteStep start ...
[CityEnergyModelInstance] execute.simulation.buildingExecuteStep current done in 0.00105722 s
[CityEnergyModelInstance] execute.simulation current done in 0.00166555 s
[CityEnergyModelInstance] execute.postprocess start ...
[CityEnergyModelInstance] report start ...
[CityEnergyModelInstance] report current done in 5.7939e-05 s
[CityEnergyModelInstance] report start ...
[CityEnergyModelInstance] report current done in 0.00312907 s
[CityEnergyModelInstance] exportOutputs start ...
[CityEnergyModelInstance] exportOutputs current done in 0.0251263 s
[CityEnergyModelInstance] execute.postprocess current done in 0.0283734 s
execute at time=68400
[CityEnergyModelInstance] execute.simulation start ...
[CityEnergyModelInstance] execute.simulation.solarMasks start ...
[CityEnergyModelInstance] updateSolarPosition : create bvh start ...
[CityEnergyModelInstance] updateSolarPosition : create bvh current done in 1.21e-07 s
[CityEnergyModelInstance] updateSolarPosition : create rays start ...
[CityEnergyModelInstance] updateSolarPosition : create rays current done in 0.000414189 s
[CityEnergyModelInstance] updateSolarPosition : create rays intersect start ...
[CityEnergyModelInstance] updateSolarPosition : create rays intersect current done in 4.5967e-05 s
[CityEnergyModelInstance] updateSolarPosition :  update solar shading coefficients start ...
[CityEnergyModelInstance] updateSolarPosition :  update solar shading coefficients current done in 1.173e-06 s
[CityEnergyModelInstance] execute.simulation.solarMasks current done in 0.000555886 s
[CityEnergyModelInstance] execute.simulation.buildingExecuteStep start ...
[CityEnergyModelInstance] execute.simulation.buildingExecuteStep current done in 0.000919579 s
[CityEnergyModelInstance] execute.simulation current done in 0.00153676 s
[CityEnergyModelInstance] execute.postprocess start ...
[CityEnergyModelInstance] report start ...
[CityEnergyModelInstance] report current done in 5.7568e-05 s
[CityEnergyModelInstance] report start ...
[CityEnergyModelInstance] report current done in 0.00368552 s
[CityEnergyModelInstance] exportOutputs start ...
[CityEnergyModelInstance] exportOutputs current done in 0.0250651 s
[CityEnergyModelInstance] execute.postprocess current done in 0.028872 s
execute at time=72000
[CityEnergyModelInstance] execute.simulation start ...
[CityEnergyModelInstance] execute.simulation.solarMasks start ...
[CityEnergyModelInstance] updateSolarPosition : create bvh start ...
[CityEnergyModelInstance] updateSolarPosition : create bvh current done in 1.5e-07 s
[CityEnergyModelInstance] updateSolarPosition : create rays start ...
[CityEnergyModelInstance] updateSolarPosition : create rays current done in 0.000416754 s
[CityEnergyModelInstance] updateSolarPosition : create rays intersect start ...
[CityEnergyModelInstance] updateSolarPosition : create rays intersect current done in 4.4073e-05 s
[CityEnergyModelInstance] updateSolarPosition :  update solar shading coefficients start ...
[CityEnergyModelInstance] updateSolarPosition :  update solar shading coefficients current done in 9.62e-07 s
[CityEnergyModelInstance] execute.simulation.solarMasks current done in 0.000546408 s
[CityEnergyModelInstance] execute.simulation.buildingExecuteStep start ...
[CityEnergyModelInstance] execute.simulation.buildingExecuteStep current done in 0.000896286 s
[CityEnergyModelInstance] execute.simulation current done in 0.00150464 s
[CityEnergyModelInstance] execute.postprocess start ...
[CityEnergyModelInstance] report start ...
[CityEnergyModelInstance] report current done in 5.7278e-05 s
[CityEnergyModelInstance] report start ...
[CityEnergyModelInstance] report current done in 0.00418642 s
[CityEnergyModelInstance] exportOutputs start ...
[CityEnergyModelInstance] exportOutputs current done in 0.0246225 s
[CityEnergyModelInstance] execute.postprocess current done in 0.0289256 s
execute at time=75600
[CityEnergyModelInstance] execute.simulation start ...
[CityEnergyModelInstance] execute.simulation.solarMasks start ...
[CityEnergyModelInstance] updateSolarPosition : create bvh start ...
[CityEnergyModelInstance] updateSolarPosition : create bvh current done in 1.21e-07 s
[CityEnergyModelInstance] updateSolarPosition : create rays start ...
[CityEnergyModelInstance] updateSolarPosition : create rays current done in 0.000416223 s
[CityEnergyModelInstance] updateSolarPosition : create rays intersect start ...
[CityEnergyModelInstance] updateSolarPosition : create rays intersect current done in 4.6848e-05 s
[CityEnergyModelInstance] updateSolarPosition :  update solar shading coefficients start ...
[CityEnergyModelInstance] updateSolarPosition :  update solar shading coefficients current done in 8.11e-07 s
[CityEnergyModelInstance] execute.simulation.solarMasks current done in 0.000545496 s
[CityEnergyModelInstance] execute.simulation.buildingExecuteStep start ...
[CityEnergyModelInstance] execute.simulation.buildingExecuteStep current done in 0.000954846 s
[CityEnergyModelInstance] execute.simulation current done in 0.00156085 s
[CityEnergyModelInstance] execute.postprocess start ...
[CityEnergyModelInstance] report start ...
[CityEnergyModelInstance] report current done in 5.4282e-05 s
[CityEnergyModelInstance] report start ...
[CityEnergyModelInstance] report current done in 0.00398657 s
[CityEnergyModelInstance] exportOutputs start ...
[CityEnergyModelInstance] exportOutputs current done in 0.108119 s
[CityEnergyModelInstance] execute.postprocess current done in 0.112219 s
execute at time=79200
[CityEnergyModelInstance] execute.simulation start ...
[CityEnergyModelInstance] execute.simulation.solarMasks start ...
[CityEnergyModelInstance] updateSolarPosition : create bvh start ...
[CityEnergyModelInstance] updateSolarPosition : create bvh current done in 1.2e-07 s
[CityEnergyModelInstance] updateSolarPosition : create rays start ...
[CityEnergyModelInstance] updateSolarPosition : create rays current done in 0.000414911 s
[CityEnergyModelInstance] updateSolarPosition : create rays intersect start ...
[CityEnergyModelInstance] updateSolarPosition : create rays intersect current done in 4.4995e-05 s
[CityEnergyModelInstance] updateSolarPosition :  update solar shading coefficients start ...
[CityEnergyModelInstance] updateSolarPosition :  update solar shading coefficients current done in 8.81e-07 s
[CityEnergyModelInstance] execute.simulation.solarMasks current done in 0.000540867 s
[CityEnergyModelInstance] execute.simulation.buildingExecuteStep start ...
[CityEnergyModelInstance] execute.simulation.buildingExecuteStep current done in 0.00105795 s
[CityEnergyModelInstance] execute.simulation current done in 0.00165365 s
[CityEnergyModelInstance] execute.postprocess start ...
[CityEnergyModelInstance] report start ...
[CityEnergyModelInstance] report current done in 5.6737e-05 s
[CityEnergyModelInstance] report start ...
[CityEnergyModelInstance] report current done in 0.00360048 s
[CityEnergyModelInstance] exportOutputs start ...
[CityEnergyModelInstance] exportOutputs current done in 0.0646035 s
[CityEnergyModelInstance] execute.postprocess current done in 0.0683131 s
execute at time=82800
[CityEnergyModelInstance] execute.simulation start ...
[CityEnergyModelInstance] execute.simulation.solarMasks start ...
[CityEnergyModelInstance] updateSolarPosition : create bvh start ...
[CityEnergyModelInstance] updateSolarPosition : create bvh current done in 1e-07 s
[CityEnergyModelInstance] updateSolarPosition : create rays start ...
[CityEnergyModelInstance] updateSolarPosition : create rays current done in 0.000418176 s
[CityEnergyModelInstance] updateSolarPosition : create rays intersect start ...
[CityEnergyModelInstance] updateSolarPosition : create rays intersect current done in 5.4442e-05 s
[CityEnergyModelInstance] updateSolarPosition :  update solar shading coefficients start ...
[CityEnergyModelInstance] updateSolarPosition :  update solar shading coefficients current done in 8.01e-07 s
[CityEnergyModelInstance] execute.simulation.solarMasks current done in 0.000551588 s
[CityEnergyModelInstance] execute.simulation.buildingExecuteStep start ...
[CityEnergyModelInstance] execute.simulation.buildingExecuteStep current done in 0.000865899 s
[CityEnergyModelInstance] execute.simulation current done in 0.00147022 s
[CityEnergyModelInstance] execute.postprocess start ...
[CityEnergyModelInstance] report start ...
[CityEnergyModelInstance] report current done in 5.6707e-05 s
[CityEnergyModelInstance] report start ...
[CityEnergyModelInstance] report current done in 0.00413088 s
[CityEnergyModelInstance] exportOutputs start ...
[CityEnergyModelInstance] exportOutputs current done in 0.0631542 s
[CityEnergyModelInstance] execute.postprocess current done in 0.0673978 s
execute at time=86400
[CityEnergyModelInstance] execute.simulation start ...
[CityEnergyModelInstance] execute.simulation.solarMasks start ...
[CityEnergyModelInstance] updateSolarPosition : create bvh start ...
[CityEnergyModelInstance] updateSolarPosition : create bvh current done in 1.4e-07 s
[CityEnergyModelInstance] updateSolarPosition : create rays start ...
[CityEnergyModelInstance] updateSolarPosition : create rays current done in 0.000419809 s
[CityEnergyModelInstance] updateSolarPosition : create rays intersect start ...
[CityEnergyModelInstance] updateSolarPosition : create rays intersect current done in 4.4333e-05 s
[CityEnergyModelInstance] updateSolarPosition :  update solar shading coefficients start ...
[CityEnergyModelInstance] updateSolarPosition :  update solar shading coefficients current done in 7.51e-07 s
[CityEnergyModelInstance] execute.simulation.solarMasks current done in 0.000583338 s
[CityEnergyModelInstance] execute.simulation.buildingExecuteStep start ...
[CityEnergyModelInstance] execute.simulation.buildingExecuteStep current done in 0.00388596 s
[CityEnergyModelInstance] execute.simulation current done in 0.00452714 s
[CityEnergyModelInstance] execute.postprocess start ...
[CityEnergyModelInstance] report start ...
[CityEnergyModelInstance] report current done in 5.6707e-05 s
[CityEnergyModelInstance] report start ...
[CityEnergyModelInstance] report current done in 0.00835166 s
[CityEnergyModelInstance] exportOutputs start ...
[CityEnergyModelInstance] exportOutputs current done in 0.0268886 s
[CityEnergyModelInstance] execute.postprocess current done in 0.0353553 s
[CityEnergyModelInstance] execute current done in 1.406 s
+----------------------------------------------------------------------------------------------------------------------------------------------------------------------------------+
|                                                                               City_Energy_Modeling                                                                               |
+----------------------------------------------------------------------------------------------------------------------------------------------------------------------------------+
| +-------------+----------------------------------------------------------------------------------------------------------------------------------------------------------------+ |
| | logs        | /data/cemosis/benchmark/kub/3fec2952/kernante/np_16/logs                                                                                                       | |
| +-------------+----------------------------------------------------------------------------------------------------------------------------------------------------------------+ |
| | journal     | /data/cemosis/benchmark/kub/3fec2952/kernante/np_16/journal.json                                                                                               | |
| +-------------+----------------------------------------------------------------------------------------------------------------------------------------------------------------+ |
| | directories | +------------------------------------------------------------------------------------------------------------------------------------------------------------+ | |
| |             | | /data/cemosis/benchmark/kub/3fec2952/kernante/np_16                                                                                                        | | |
| |             | +------------------------------------------------------------------------------------------------------------------------------------------------------------+ | |
| |             | | /data/cemosis/github-actions-runner/actions-runner-4/_work/bench.ktirio.fr/bench.ktirio.fr/build/reframe/stage/gaya/public/default/RegressionTest_3fec2952 | | |
| |             | +------------------------------------------------------------------------------------------------------------------------------------------------------------+ | |
| +-------------+----------------------------------------------------------------------------------------------------------------------------------------------------------------+ |
+----------------------------------------------------------------------------------------------------------------------------------------------------------------------------------+

[ Stopping Feel++ ] [32mapplication City_Energy_Modeling execution time 8.11592s[00m

3. feelpp_kub_cem.INFO

Log file created at: 2025/03/28 10:53:32
Running on machine: gaya4
Log line format: [IWEF]mmdd hh:mm:ss.uuuuuu threadid file:line] msg
I0328 10:53:32.288148 2305557 environment.cpp:1708] File /data/cemosis/benchmark/kub/3fec2952/kernante/cem/gis/mesh.lod0.msh found
I0328 10:53:32.322463 2305557 environment.cpp:1708] File /data/cemosis/benchmark/kub/3fec2952/kernante/cem/gis/mesh.lod0.msh found
I0328 10:53:32.322481 2305557 importergmsh.hpp:989] Reading Msh file /data/cemosis/benchmark/kub/3fec2952/kernante/cem/gis/mesh.lod0.msh
I0328 10:53:32.322702 2305557 importergmsh.hpp:1013] GMSH mesh file version : 4.1 format: ascii size of double: 8
I0328 10:53:32.338239 2305557 meshimpl.hpp:1411] We have 480 faces in the database
I0328 10:53:32.341014 2305557 meshimpl.hpp:1890] update boundary points...
I0328 10:53:32.341019 2305557 meshimpl.hpp:1910] update boundary elements...
I0328 10:53:32.349519 2305557 meshimpl.hpp:1411] We have 480 faces in the database
I0328 10:53:32.349750 2305557 meshimpl.hpp:1890] update boundary points...
I0328 10:53:32.349758 2305557 meshimpl.hpp:1910] update boundary elements...
I0328 10:53:32.352838 2305557 worldcomm.cpp:895] [rank 0] makeResultRange: mesh count=1
I0328 10:53:32.352844 2305557 worldcomm.cpp:895] [rank 0] makeResultRange: res size=36
I0328 10:53:32.352849 2305557 worldcomm.cpp:895] [rank 0] makeResultRange: mesh count=1
I0328 10:53:32.352851 2305557 worldcomm.cpp:895] [rank 0] makeResultRange: res size=36
I0328 10:53:32.352854 2305557 worldcomm.cpp:895] [rank 0] makeResultRange: mesh count=1
I0328 10:53:32.352856 2305557 worldcomm.cpp:895] [rank 0] makeResultRange: res size=36
I0328 10:53:32.352859 2305557 worldcomm.cpp:895] [rank 0] makeResultRange: mesh count=1
I0328 10:53:32.352860 2305557 worldcomm.cpp:895] [rank 0] makeResultRange: res size=36
I0328 10:53:32.352862 2305557 worldcomm.cpp:895] [rank 0] makeResultRange: mesh count=1
I0328 10:53:32.352864 2305557 worldcomm.cpp:895] [rank 0] makeResultRange: res size=36
I0328 10:53:32.352866 2305557 worldcomm.cpp:895] [rank 0] makeResultRange: mesh count=1
I0328 10:53:32.352869 2305557 worldcomm.cpp:895] [rank 0] makeResultRange: res size=36
I0328 10:53:32.352871 2305557 worldcomm.cpp:895] [rank 0] makeResultRange: mesh count=1
I0328 10:53:32.352873 2305557 worldcomm.cpp:895] [rank 0] makeResultRange: res size=36
I0328 10:53:32.352875 2305557 worldcomm.cpp:895] [rank 0] makeResultRange: mesh count=1
I0328 10:53:32.352877 2305557 worldcomm.cpp:895] [rank 0] makeResultRange: res size=36
I0328 10:53:32.352880 2305557 worldcomm.cpp:895] [rank 0] makeResultRange: mesh count=1
I0328 10:53:32.352881 2305557 worldcomm.cpp:895] [rank 0] makeResultRange: res size=24
I0328 10:53:32.352883 2305557 worldcomm.cpp:895] [rank 0] makeResultRange: mesh count=1
I0328 10:53:32.352885 2305557 worldcomm.cpp:895] [rank 0] makeResultRange: res size=24
I0328 10:53:32.352887 2305557 worldcomm.cpp:895] [rank 0] makeResultRange: mesh count=1
I0328 10:53:32.352890 2305557 worldcomm.cpp:895] [rank 0] makeResultRange: res size=24
I0328 10:53:32.352891 2305557 worldcomm.cpp:895] [rank 0] makeResultRange: mesh count=1
I0328 10:53:32.352893 2305557 worldcomm.cpp:895] [rank 0] makeResultRange: res size=24
I0328 10:53:32.352895 2305557 worldcomm.cpp:895] [rank 0] makeResultRange: mesh count=1
I0328 10:53:32.352897 2305557 worldcomm.cpp:895] [rank 0] makeResultRange: res size=24
I0328 10:53:32.352900 2305557 worldcomm.cpp:895] [rank 0] makeResultRange: mesh count=1
I0328 10:53:32.352901 2305557 worldcomm.cpp:895] [rank 0] makeResultRange: res size=24
I0328 10:53:32.352903 2305557 worldcomm.cpp:895] [rank 0] makeResultRange: mesh count=1
I0328 10:53:32.352905 2305557 worldcomm.cpp:895] [rank 0] makeResultRange: res size=24
I0328 10:53:32.352907 2305557 worldcomm.cpp:895] [rank 0] makeResultRange: mesh count=1
I0328 10:53:32.352909 2305557 worldcomm.cpp:895] [rank 0] makeResultRange: res size=24
I0328 10:53:32.354507 2305557 partitionio.hpp:319] writing mesh in HDF5 format in /data/cemosis/benchmark/kub/3fec2952/kernante/cem/gis/partitioning/mesh.lod0.np16.h5
I0328 10:53:32.462401 2305557 environment.cpp:1708] File /data/cemosis/benchmark/kub/3fec2952/kernante/cem/gis/partitioning/mesh.lod0.np16.json found
I0328 10:53:32.462435 2305557 loadmesh.hpp:246]  Loading mesh in json+h5 format "/data/cemosis/benchmark/kub/3fec2952/kernante/cem/gis/partitioning/mesh.lod0.np16.json"
I0328 10:53:32.555619 2305557 partitionio.hpp:1134] read stat points 329,33,0
I0328 10:53:32.555634 2305557 partitionio.hpp:1137] read stat elements 488,44,0
I0328 10:53:32.555636 2305557 partitionio.hpp:1140] read stat ghost_elements 0,0,0
I0328 10:53:32.555639 2305557 partitionio.hpp:1143] read stat marked_faces 480,36,0
I0328 10:53:32.555640 2305557 partitionio.hpp:1146] read stat marked_edges 0,0,0
I0328 10:53:32.555642 2305557 partitionio.hpp:1149] read stat marked_points 0,0,0
I0328 10:53:32.556349 2305557 partitionio.hpp:1168] loaded points_ids:1x329
I0328 10:53:32.556975 2305557 partitionio.hpp:1170] loaded points_coords:1x987
I0328 10:53:32.559407 2305557 partitionio.hpp:1267] loaded elements:1x1952
I0328 10:53:32.560874 2305557 partitionio.hpp:1373] loaded ghost_elements:1x0
I0328 10:53:32.561445 2305557 partitionio.hpp:1568] loaded marked_subentities:1x1440
I0328 10:53:32.562430 2305557 meshimpl.hpp:1411] We have 36 faces in the database
I0328 10:53:32.562489 2305557 meshimpl.hpp:1890] update boundary points...
I0328 10:53:32.562492 2305557 meshimpl.hpp:1910] update boundary elements...
I0328 10:53:32.772042 2305557 mpifmu.cpp:149] [mpifmu] unzipPath=/data/cemosis/benchmark/kub/3fec2952/kernante/np_16/fmus/fmi4cpp_sun using unzipPath: /data/cemosis/benchmark/kub/3fec2952/kernante/np_16/fmus/fmi4cpp_sun ,fmuName: sun
I0328 10:53:32.924701 2305557 mpifmu.cpp:183] [mpifmu] Using input weather file
I0328 10:53:32.924717 2305557 mpifmu.cpp:201] [mpifmu] uncompressed fmu ready for consumption
I0328 10:53:32.940310 2305557 mpifmu.cpp:149] [mpifmu] unzipPath=/data/cemosis/benchmark/kub/3fec2952/kernante/np_16/fmus/fmi4cpp_lod0.buildingfloor0 using unzipPath: /data/cemosis/benchmark/kub/3fec2952/kernante/np_16/fmus/fmi4cpp_lod0.buildingfloor0 ,fmuName: lod0.buildingfloor0
I0328 10:53:33.031291 2305557 mpifmu.cpp:183] [mpifmu] Using input weather file
I0328 10:53:33.031303 2305557 mpifmu.cpp:201] [mpifmu] uncompressed fmu ready for consumption
I0328 10:53:33.059939 2305557 mpifmu.cpp:149] [mpifmu] unzipPath=/data/cemosis/benchmark/kub/3fec2952/kernante/np_16/fmus/fmi4cpp_lod0.buildingfloor1 using unzipPath: /data/cemosis/benchmark/kub/3fec2952/kernante/np_16/fmus/fmi4cpp_lod0.buildingfloor1 ,fmuName: lod0.buildingfloor1
I0328 10:53:33.221078 2305557 mpifmu.cpp:183] [mpifmu] Using input weather file
I0328 10:53:33.221104 2305557 mpifmu.cpp:201] [mpifmu] uncompressed fmu ready for consumption
I0328 10:53:33.264928 2305557 mpifmu.cpp:149] [mpifmu] unzipPath=/data/cemosis/benchmark/kub/3fec2952/kernante/np_16/fmus/fmi4cpp_lod0.buildingfloor2 using unzipPath: /data/cemosis/benchmark/kub/3fec2952/kernante/np_16/fmus/fmi4cpp_lod0.buildingfloor2 ,fmuName: lod0.buildingfloor2
I0328 10:53:33.403797 2305557 mpifmu.cpp:183] [mpifmu] Using input weather file
I0328 10:53:33.403844 2305557 mpifmu.cpp:201] [mpifmu] uncompressed fmu ready for consumption
I0328 10:53:33.468354 2305557 mpifmu.cpp:149] [mpifmu] unzipPath=/data/cemosis/benchmark/kub/3fec2952/kernante/np_16/fmus/fmi4cpp_lod0.buildingfloor3 using unzipPath: /data/cemosis/benchmark/kub/3fec2952/kernante/np_16/fmus/fmi4cpp_lod0.buildingfloor3 ,fmuName: lod0.buildingfloor3
I0328 10:53:33.683792 2305557 mpifmu.cpp:183] [mpifmu] Using input weather file
I0328 10:53:33.683815 2305557 mpifmu.cpp:201] [mpifmu] uncompressed fmu ready for consumption
I0328 10:53:35.481451 2305557 mpifmu.cpp:149] [mpifmu] unzipPath=/data/cemosis/benchmark/kub/3fec2952/kernante/np_16/fmus/fmi4cpp_lod0.buildingfloor4 using unzipPath: /data/cemosis/benchmark/kub/3fec2952/kernante/np_16/fmus/fmi4cpp_lod0.buildingfloor4 ,fmuName: lod0.buildingfloor4
I0328 10:53:36.208021 2305557 mpifmu.cpp:183] [mpifmu] Using input weather file
I0328 10:53:36.208041 2305557 mpifmu.cpp:201] [mpifmu] uncompressed fmu ready for consumption
I0328 10:53:36.365252 2305557 mpifmu.cpp:149] [mpifmu] unzipPath=/data/cemosis/benchmark/kub/3fec2952/kernante/np_16/fmus/fmi4cpp_lod0.buildingfloor5 using unzipPath: /data/cemosis/benchmark/kub/3fec2952/kernante/np_16/fmus/fmi4cpp_lod0.buildingfloor5 ,fmuName: lod0.buildingfloor5
I0328 10:53:36.638828 2305557 mpifmu.cpp:183] [mpifmu] Using input weather file
I0328 10:53:36.638850 2305557 mpifmu.cpp:201] [mpifmu] uncompressed fmu ready for consumption
I0328 10:53:36.779453 2305557 mpifmu.cpp:149] [mpifmu] unzipPath=/data/cemosis/benchmark/kub/3fec2952/kernante/np_16/fmus/fmi4cpp_lod0.buildingfloor6 using unzipPath: /data/cemosis/benchmark/kub/3fec2952/kernante/np_16/fmus/fmi4cpp_lod0.buildingfloor6 ,fmuName: lod0.buildingfloor6
I0328 10:53:36.939241 2305557 mpifmu.cpp:183] [mpifmu] Using input weather file
I0328 10:53:36.939261 2305557 mpifmu.cpp:201] [mpifmu] uncompressed fmu ready for consumption
I0328 10:53:37.152534 2305557 mpifmu.cpp:149] [mpifmu] unzipPath=/data/cemosis/benchmark/kub/3fec2952/kernante/np_16/fmus/fmi4cpp_lod0.buildingfloor7 using unzipPath: /data/cemosis/benchmark/kub/3fec2952/kernante/np_16/fmus/fmi4cpp_lod0.buildingfloor7 ,fmuName: lod0.buildingfloor7
I0328 10:53:37.424221 2305557 mpifmu.cpp:183] [mpifmu] Using input weather file
I0328 10:53:37.424244 2305557 mpifmu.cpp:201] [mpifmu] uncompressed fmu ready for consumption
I0328 10:53:37.604095 2305557 mpifmu.cpp:149] [mpifmu] unzipPath=/data/cemosis/benchmark/kub/3fec2952/kernante/np_16/fmus/fmi4cpp_lod0.buildingfloor8 using unzipPath: /data/cemosis/benchmark/kub/3fec2952/kernante/np_16/fmus/fmi4cpp_lod0.buildingfloor8 ,fmuName: lod0.buildingfloor8
I0328 10:53:37.857549 2305557 mpifmu.cpp:183] [mpifmu] Using input weather file
I0328 10:53:37.857571 2305557 mpifmu.cpp:201] [mpifmu] uncompressed fmu ready for consumption
I0328 10:53:38.014906 2305557 mpifmu.cpp:149] [mpifmu] unzipPath=/data/cemosis/benchmark/kub/3fec2952/kernante/np_16/fmus/fmi4cpp_lod0.buildingfloor9 using unzipPath: /data/cemosis/benchmark/kub/3fec2952/kernante/np_16/fmus/fmi4cpp_lod0.buildingfloor9 ,fmuName: lod0.buildingfloor9
I0328 10:53:38.260533 2305557 mpifmu.cpp:183] [mpifmu] Using input weather file
I0328 10:53:38.260555 2305557 mpifmu.cpp:201] [mpifmu] uncompressed fmu ready for consumption
W0328 10:53:38.437856 2305557 buildingmodel.cpp:45] [BuildingModel::Instance] building instance 1889076496270595 not simulated
W0328 10:53:38.459059 2305557 buildingmodel.cpp:45] [BuildingModel::Instance] building instance 4597160418045805 not simulated
I0328 10:53:38.477272 2305557 worldcomm.cpp:895] [rank 0] [DofTable::build] starts, has mesh support: false
I0328 10:53:38.477304 2305557 worldcomm.cpp:895] [rank 0] [DofTable::buildDofMap] starts, dof_indices empty: true
I0328 10:53:38.477308 2305557 worldcomm.cpp:895] [rank 0] [DofTable::buildDofMap] allocation done
I0328 10:53:38.477311 2305557 worldcomm.cpp:895] [rank 0] [DofTable::buildDofMap]  n_elts =  44 on processor 0
I0328 10:53:38.477358 2305557 worldcomm.cpp:895] [rank 0] [builddofmap - 0] dof generation hasNoElt : false theFirstDF: 0 thelastDof: 43
I0328 10:53:38.477361 2305557 worldcomm.cpp:895] [rank 0] [builddofmap - 0] gather discontinuous dof info hasNoElt : false theFirstDF: 0 thelastDof: 43
I0328 10:53:38.477548 2305557 worldcomm.cpp:895] [rank 0] [DofTable::buildGhostDofMap rank=0] starts. hasMeshSupport: false
I0328 10:53:38.478655 2305557 element_impl.hpp:199] creating element u : u
I0328 10:53:38.478659 2305557 element_impl.hpp:199] creating element u : u
I0328 10:53:38.478664 2305557 element_impl.hpp:199] creating element u : u
I0328 10:53:38.478667 2305557 element_impl.hpp:199] creating element u : u
I0328 10:53:38.478669 2305557 element_impl.hpp:199] creating element u : u
I0328 10:53:38.478672 2305557 element_impl.hpp:199] creating element u : u
I0328 10:53:38.478673 2305557 element_impl.hpp:199] creating element u : u
I0328 10:53:38.478675 2305557 element_impl.hpp:199] creating element u : u
I0328 10:53:38.478677 2305557 element_impl.hpp:199] creating element u : u
I0328 10:53:38.478691 2305557 exporterimpl.hpp:219] [Exporter] format :  ensightgold
I0328 10:53:38.478693 2305557 exporterimpl.hpp:220] [Exporter] N      :  1
I0328 10:53:40.090287 2305557 environment.cpp:2423] Environment::clearSomeMemory before: PETSC get current memory usage (resident memory): 628797  KBytes 628.797  MBytes 0.628797 GBytes
I0328 10:53:40.090303 2305557 environment.cpp:2428] Environment::clearSomeMemory before: PETSC get current PETSC Malloc usage: 0  KBytes 0 MBytes 0 GBytes
I0328 10:53:40.090309 2305557 environment.cpp:2430] Environment::clearSomeMemory before: PETSC get maximum PETSC Malloc usage(largest memory ever used so far): 0  KBytes 0 MBytes 0 GBytes
I0328 10:53:40.090337 2305557 environment.cpp:2423] Environment::clearSomeMemory after: PETSC get current memory usage (resident memory): 628797  KBytes 628.797  MBytes 0.628797 GBytes
I0328 10:53:40.090342 2305557 environment.cpp:2428] Environment::clearSomeMemory after: PETSC get current PETSC Malloc usage: 0  KBytes 0 MBytes 0 GBytes
I0328 10:53:40.090344 2305557 environment.cpp:2430] Environment::clearSomeMemory after: PETSC get maximum PETSC Malloc usage(largest memory ever used so far): 0  KBytes 0 MBytes 0 GBytes

4. feelpp_kub_cem.WARNING

Log file created at: 2025/03/28 10:53:38
Running on machine: gaya4
Log line format: [IWEF]mmdd hh:mm:ss.uuuuuu threadid file:line] msg
W0328 10:53:38.437856 2305557 buildingmodel.cpp:45] [BuildingModel::Instance] building instance 1889076496270595 not simulated
W0328 10:53:38.459059 2305557 buildingmodel.cpp:45] [BuildingModel::Instance] building instance 4597160418045805 not simulated