Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_latest_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case900FF.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo): time 0.002487/0.002487, allocations: 93.47 kB / 19.44 MB, free: 336 kB / 13.93 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo): time 0.002971/0.002971, allocations: 169.2 kB / 22.76 MB, free: 1.664 MB / 18.57 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo): time 1.571/1.571, allocations: 177.1 MB / 203.1 MB, free: 5.574 MB / 186.7 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings master/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings master/package.mo): time 3.426/3.426, allocations: 429.5 MB / 0.6729 GB, free: 4.016 MB / 0.6355 GB
"
[Timeout remaining time 176]
Using package Buildings with version 14.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings master/package.mo)
Using package Modelica with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo)
Using package Complex with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo)
Using package ModelicaServices with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo)
Running command: translateModel(Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case900FF,tolerance=1e-06,outputFormat="mat",numberOfIntervals=8765,variableFilter="time|TRooHou.y|staRes.minT.Min|staRes.minT.Mean|staRes.minT.Max|staRes.maxT.Min|staRes.maxT.Mean|staRes.maxT.Max|TRooAnn.y|staRes.meanT.Min|staRes.meanT.Mean|staRes.meanT.Max",fileNamePrefix="Buildings_latest_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case900FF")
translateModel(Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case900FF,tolerance=1e-06,outputFormat="mat",numberOfIntervals=8765,variableFilter="time|TRooHou.y|staRes.minT.Min|staRes.minT.Mean|staRes.minT.Max|staRes.maxT.Min|staRes.maxT.Mean|staRes.maxT.Max|TRooAnn.y|staRes.meanT.Min|staRes.meanT.Mean|staRes.meanT.Max",fileNamePrefix="Buildings_latest_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case900FF") [Timeout 300]
"Notification: Performance of FrontEnd - loaded program: time 1.954e-06/1.954e-06, allocations: 0 / 0.8775 GB, free: 6.625 MB / 0.8386 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 2.84e-05/3.036e-05, allocations: 2.312 kB / 0.8775 GB, free: 6.621 MB / 0.8386 GB
Notification: Performance of NFInst.instantiate(Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case900FF): time 0.771/0.771, allocations: 234 MB / 1.106 GB, free: 47.18 MB / 1.01 GB
Notification: Performance of NFInst.instExpressions: time 0.0651/0.8361, allocations: 44.65 MB / 1.15 GB, free: 43.19 MB / 1.01 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.01406/0.8502, allocations: 477.3 kB / 1.15 GB, free: 43.19 MB / 1.01 GB
Notification: Performance of NFTyping.typeComponents: time 0.02165/0.8718, allocations: 7.775 MB / 1.158 GB, free: 41.44 MB / 1.01 GB
Notification: Performance of NFTyping.typeBindings: time 0.02385/0.8957, allocations: 7.275 MB / 1.165 GB, free: 38.54 MB / 1.01 GB
Notification: Performance of NFTyping.typeClassSections: time 0.02026/0.9159, allocations: 6.697 MB / 1.171 GB, free: 35.35 MB / 1.01 GB
Notification: Performance of NFFlatten.flatten: time 0.05276/0.9687, allocations: 53.31 MB / 1.223 GB, free: 11.43 MB / 1.01 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.03121/0.9999, allocations: 19.73 MB / 1.243 GB, free: 14.68 MB / 1.026 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.06727/1.067, allocations: 30.95 MB / 1.273 GB, free: 6.637 MB / 1.042 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.04151/1.109, allocations: 19.26 MB / 1.292 GB, free: 4.051 MB / 1.057 GB
Notification: Performance of NFPackage.collectConstants: time 0.01275/1.121, allocations: 3.781 MB / 1.295 GB, free: 276 kB / 1.057 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.02699/1.148, allocations: 8.356 MB / 1.304 GB, free: 8.176 MB / 1.073 GB
Notification: Performance of NFScalarize.scalarize: time 0.0231/1.172, allocations: 13.39 MB / 1.317 GB, free: 11.11 MB / 1.089 GB
Notification: Performance of NFVerifyModel.verify: time 0.03507/1.207, allocations: 11.95 MB / 1.328 GB, free: 15.47 MB / 1.104 GB
Notification: Performance of NFConvertDAE.convert: time 0.09926/1.306, allocations: 64.52 MB / 1.391 GB, free: 0.8516 MB / 1.151 GB
Notification: Performance of FrontEnd - DAE generated: time 5.61e-06/1.306, allocations: 0 / 1.391 GB, free: 0.8516 MB / 1.151 GB
Notification: Performance of FrontEnd: time 1.473e-06/1.306, allocations: 4 kB / 1.391 GB, free: 0.8477 MB / 1.151 GB
Notification: Performance of Transformations before backend: time 0.001651/1.308, allocations: 0 / 1.391 GB, free: 0.8477 MB / 1.151 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 2814
 * Number of variables: 2814
Notification: Performance of Generate backend data structure: time 0.1344/1.442, allocations: 47.03 MB / 1.437 GB, free: 1.797 MB / 1.198 GB
Notification: Performance of prepare preOptimizeDAE: time 4.58e-05/1.442, allocations: 8.031 kB / 1.437 GB, free: 1.789 MB / 1.198 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.1046/1.547, allocations: 18.23 MB / 1.455 GB, free: 15.51 MB / 1.229 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.1017/1.648, allocations: 35.49 MB / 1.49 GB, free: 12.49 MB / 1.26 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.002774/1.651, allocations: 2.315 MB / 1.492 GB, free: 9.867 MB / 1.26 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.007712/1.659, allocations: 1.363 MB / 1.493 GB, free: 8.508 MB / 1.26 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.07803/1.737, allocations: 24.85 MB / 1.518 GB, free: 14.85 MB / 1.292 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0004623/1.737, allocations: 27.77 kB / 1.518 GB, free: 14.82 MB / 1.292 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.005023/1.742, allocations: 458.2 kB / 1.518 GB, free: 14.38 MB / 1.292 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0005196/1.743, allocations: 396.6 kB / 1.518 GB, free: 13.98 MB / 1.292 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.08165/1.824, allocations: 25.98 MB / 1.544 GB, free: 3.961 MB / 1.307 GB
Warning: The model contains alias variables with redundant start and/or conflicting nominal values. It is recommended to resolve the conflicts, because otherwise the system could be hard to solve. To print the conflicting alias sets and the chosen candidates please use -d=aliasConflicts.
Notification: Performance of preOpt removeSimpleEquations (simulation): time 1.04/2.865, allocations: 211.4 MB / 1.75 GB, free: 280 MB / 1.307 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.03697/2.902, allocations: 16.06 MB / 1.766 GB, free: 266.4 MB / 1.307 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.02727/2.929, allocations: 11.4 MB / 1.777 GB, free: 255 MB / 1.307 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.00131/2.93, allocations: 309.1 kB / 1.777 GB, free: 254.7 MB / 1.307 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.02884/2.959, allocations: 12.43 MB / 1.789 GB, free: 242.3 MB / 1.307 GB
Notification: Performance of pre-optimization done (n=848): time 1.41e-05/2.959, allocations: 0 / 1.789 GB, free: 242.3 MB / 1.307 GB
Notification: Performance of matching and sorting (n=848): time 0.1111/3.07, allocations: 36.35 MB / 1.825 GB, free: 206.8 MB / 1.307 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0002799/3.071, allocations: 390.2 kB / 1.825 GB, free: 206.3 MB / 1.307 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.1013/3.172, allocations: 51.36 MB / 1.876 GB, free: 155.3 MB / 1.307 GB
Notification: Performance of collectPreVariables (initialization): time 0.003958/3.176, allocations: 321.7 kB / 1.876 GB, free: 155 MB / 1.307 GB
Notification: Performance of collectInitialEqns (initialization): time 0.02575/3.202, allocations: 17.72 MB / 1.893 GB, free: 137.5 MB / 1.307 GB
Notification: Performance of collectInitialBindings (initialization): time 0.008374/3.21, allocations: 3.607 MB / 1.897 GB, free: 134 MB / 1.307 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.02172/3.232, allocations: 8.712 MB / 1.905 GB, free: 125.3 MB / 1.307 GB
Notification: Performance of setup shared object (initialization): time 5.59e-05/3.232, allocations: 480.8 kB / 1.906 GB, free: 124.8 MB / 1.307 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.03608/3.268, allocations: 16.22 MB / 1.921 GB, free: 108.7 MB / 1.307 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.04244/3.31, allocations: 24.79 MB / 1.946 GB, free: 81.49 MB / 1.307 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.06631/3.377, allocations: 34.21 MB / 1.979 GB, free: 45.11 MB / 1.307 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0001838/3.377, allocations: 32 kB / 1.979 GB, free: 45.08 MB / 1.307 GB
Notification: Performance of matching and sorting (n=2551) (initialization): time 0.1127/3.489, allocations: 47.31 MB / 2.025 GB, free: 13.7 MB / 1.323 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0004004/3.49, allocations: 165.6 kB / 2.025 GB, free: 13.53 MB / 1.323 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.558/4.048, allocations: 34.86 MB / 2.06 GB, free: 391.2 MB / 1.323 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.1117/4.16, allocations: 31.16 MB / 2.09 GB, free: 391 MB / 1.323 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.02786/4.187, allocations: 5.102 MB / 2.095 GB, free: 391 MB / 1.323 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.02284/4.21, allocations: 35.01 MB / 2.129 GB, free: 360 MB / 1.323 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.03878/4.249, allocations: 5.273 MB / 2.134 GB, free: 358.2 MB / 1.323 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.005227/4.254, allocations: 0.7024 MB / 2.135 GB, free: 358.2 MB / 1.323 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.05592/4.31, allocations: 25.21 MB / 2.16 GB, free: 353.6 MB / 1.323 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.04424/4.354, allocations: 24.76 MB / 2.184 GB, free: 341.3 MB / 1.323 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.06893/4.423, allocations: 34.12 MB / 2.217 GB, free: 307.3 MB / 1.323 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 0.0002601/4.424, allocations: 39.97 kB / 2.217 GB, free: 307.2 MB / 1.323 GB
Notification: Performance of matching and sorting (n=2551) (initialization_lambda0): time 0.1159/4.54, allocations: 46.4 MB / 2.262 GB, free: 262.3 MB / 1.323 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0003762/4.54, allocations: 174.1 kB / 2.263 GB, free: 262.1 MB / 1.323 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0801/4.62, allocations: 34.76 MB / 2.297 GB, free: 227.3 MB / 1.323 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.01135/4.631, allocations: 2.936 MB / 2.299 GB, free: 224.4 MB / 1.323 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.02645/4.658, allocations: 5.105 MB / 2.304 GB, free: 219.2 MB / 1.323 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0259/4.684, allocations: 30.36 MB / 2.334 GB, free: 187.6 MB / 1.323 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0373/4.721, allocations: 4.969 MB / 2.339 GB, free: 182.7 MB / 1.323 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.004975/4.726, allocations: 0.7027 MB / 2.34 GB, free: 182 MB / 1.323 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 530
 * Number of states: 0 ()
 * Number of discrete variables: 94 (TRooAnn.mode,$PRE.TRooAnn.mode,$whenCondition1,TRooHou.mode,$PRE.TRooHou.mode,$whenCondition2,weaDat.conTim.canRepeatWeatherFile,weaDat.conTimMin.canRepeatWeatherFile,roo.solRadExc.is_flo[11],roo.solRadExc.is_flo[10],roo.solRadExc.is_flo[9],roo.solRadExc.is_flo[8],roo.solRadExc.is_flo[7],roo.solRadExc.is_flo[6],roo.solRadExc.is_flo[5],roo.solRadExc.is_flo[4],roo.solRadExc.is_flo[3],roo.solRadExc.is_flo[2],roo.solRadExc.is_flo[1],weaDat.decAng.k,$PRE.weaDat.decAng.k,weaDat.decAng.tNext,$PRE.weaDat.decAng.tNext,weaDat.eqnTim.k,$PRE.weaDat.eqnTim.k,weaDat.eqnTim.tNext,$PRE.weaDat.eqnTim.tNext,weaDat.conTim.k,$PRE.weaDat.conTim.k,weaDat.conTim.tNext,$PRE.weaDat.conTim.tNext,weaDat.conTimMin.k,$PRE.weaDat.conTimMin.k,weaDat.conTimMin.tNext,$PRE.weaDat.conTimMin.tNext,weaDat.locTim.k,$PRE.weaDat.locTim.k,weaDat.locTim.tNext,$PRE.weaDat.locTim.tNext,roo.bouConExtWin.HDifTil[1].incAng.decAng.k,$PRE.roo.bouConExtWin.HDifTil[1].incAng.decAng.k,roo.bouConExtWin.HDifTil[1].incAng.decAng.tNext,$PRE.roo.bouConExtWin.HDifTil[1].incAng.decAng.tNext,roo.bouConExtWin.HDirTil[1].incAng.decAng.k,$PRE.roo.bouConExtWin.HDirTil[1].incAng.decAng.k,roo.bouConExtWin.HDirTil[1].incAng.decAng.tNext,$PRE.roo.bouConExtWin.HDirTil[1].incAng.decAng.tNext,roo.bouConExt.HDifTil[4].incAng.decAng.k,$PRE.roo.bouConExt.HDifTil[4].incAng.decAng.k,roo.bouConExt.HDifTil[4].incAng.decAng.tNext,$PRE.roo.bouConExt.HDifTil[4].incAng.decAng.tNext,roo.bouConExt.HDifTil[3].incAng.decAng.k,$PRE.roo.bouConExt.HDifTil[3].incAng.decAng.k,roo.bouConExt.HDifTil[3].incAng.decAng.tNext,$PRE.roo.bouConExt.HDifTil[3].incAng.decAng.tNext,roo.bouConExt.HDifTil[2].incAng.decAng.k,$PRE.roo.bouConExt.HDifTil[2].incAng.decAng.k,roo.bouConExt.HDifTil[2].incAng.decAng.tNext,$PRE.roo.bouConExt.HDifTil[2].incAng.decAng.tNext,roo.bouConExt.HDifTil[1].incAng.decAng.k,$PRE.roo.bouConExt.HDifTil[1].incAng.decAng.k,roo.bouConExt.HDifTil[1].incAng.decAng.tNext,$PRE.roo.bouConExt.HDifTil[1].incAng.decAng.tNext,roo.bouConExt.HDirTil[4].incAng.decAng.k,$PRE.roo.bouConExt.HDirTil[4].incAng.decAng.k,roo.bouConExt.HDirTil[4].incAng.decAng.tNext,$PRE.roo.bouConExt.HDirTil[4].incAng.decAng.tNext,roo.bouConExt.HDirTil[3].incAng.decAng.k,$PRE.roo.bouConExt.HDirTil[3].incAng.decAng.k,roo.bouConExt.HDirTil[3].incAng.decAng.tNext,$PRE.roo.bouConExt.HDirTil[3].incAng.decAng.tNext,roo.bouConExt.HDirTil[2].incAng.decAng.k,$PRE.roo.bouConExt.HDirTil[2].incAng.decAng.k,roo.bouConExt.HDirTil[2].incAng.decAng.tNext,$PRE.roo.bouConExt.HDirTil[2].incAng.decAng.tNext,roo.bouConExt.HDirTil[1].incAng.decAng.k,$PRE.roo.bouConExt.HDirTil[1].incAng.decAng.k,roo.bouConExt.HDirTil[1].incAng.decAng.tNext,$PRE.roo.bouConExt.HDirTil[1].incAng.decAng.tNext,$whenCondition3,$whenCondition4,$whenCondition5,$whenCondition6,$whenCondition7,$whenCondition8,$whenCondition9,$whenCondition10,$whenCondition11,$whenCondition12,$whenCondition13,$whenCondition14,$whenCondition15,$whenCondition16,$whenCondition17)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (1754):
 * Single equations (assignments): 1696
 * Array equations: 39
 * Algorithm blocks: 1
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 6
 * Torn equation systems: 12
 * Mixed (continuous/discrete) equation systems: 0
Notification: Equation system details (not torn):
 * Constant Jacobian (size): 0 systems
 * Linear Jacobian (size,density): 0 systems
 * Non-linear Jacobian (size): 6 systems
   {1, 1, 1, 1, 1, 1}
 * Without analytic Jacobian (size): 0 systems
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 10 systems
   {(1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 2 systems
   {(13,44), (1,23)}
Notification: Performance of prepare postOptimizeDAE: time 0.008599/4.735, allocations: 1.291 MB / 2.341 GB, free: 180.7 MB / 1.323 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.01406/4.749, allocations: 2.923 MB / 2.344 GB, free: 177.8 MB / 1.323 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.07733/4.826, allocations: 25.02 MB / 2.368 GB, free: 152.6 MB / 1.323 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 8.173e-05/4.826, allocations: 84 kB / 2.368 GB, free: 152.5 MB / 1.323 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 4.171e-05/4.826, allocations: 4 kB / 2.368 GB, free: 152.5 MB / 1.323 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.05908/4.885, allocations: 21 MB / 2.389 GB, free: 131.3 MB / 1.323 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.1539/5.039, allocations: 67.64 MB / 2.455 GB, free: 62.09 MB / 1.323 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 0.1009/5.14, allocations: 25.9 MB / 2.48 GB, free: 36.11 MB / 1.323 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.01928/5.159, allocations: 3.14 MB / 2.483 GB, free: 32.97 MB / 1.323 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.03606/5.195, allocations: 6.791 MB / 2.49 GB, free: 26.11 MB / 1.323 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.003068/5.198, allocations: 363.6 kB / 2.49 GB, free: 25.76 MB / 1.323 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.02941/5.228, allocations: 38.5 MB / 2.528 GB, free: 1 MB / 1.339 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 3.346e-06/5.228, allocations: 0 / 2.528 GB, free: 1 MB / 1.339 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.635/5.863, allocations: 44.01 MB / 2.571 GB, free: 402.8 MB / 1.354 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.02628/5.889, allocations: 7.568 MB / 2.578 GB, free: 402.7 MB / 1.354 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.01108/5.9, allocations: 316.5 kB / 2.578 GB, free: 402.7 MB / 1.354 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.03/5.93, allocations: 3.062 MB / 2.581 GB, free: 402.7 MB / 1.354 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.003287/5.933, allocations: 0.5937 MB / 2.582 GB, free: 402.7 MB / 1.354 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.003008/5.936, allocations: 326 kB / 2.582 GB, free: 402.7 MB / 1.354 GB
Notification: Performance of sorting global known variables: time 0.08734/6.024, allocations: 35.25 MB / 2.617 GB, free: 395.5 MB / 1.354 GB
Notification: Performance of sort global known variables: time 3e-07/6.024, allocations: 0 / 2.617 GB, free: 395.5 MB / 1.354 GB
Notification: Performance of remove unused functions: time 0.05985/6.084, allocations: 15.55 MB / 2.632 GB, free: 393.8 MB / 1.354 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 4
 * Number of states: 72 (roo.conExt[1].opa.lay[1].T[1],roo.conExt[1].opa.lay[1].T[2],roo.conExt[1].opa.lay[2].T[1],roo.conExt[1].opa.lay[2].T[2],roo.conExt[1].opa.lay[2].T[3],roo.conExt[1].opa.lay[2].T[4],roo.conExt[1].opa.lay[3].T[1],roo.conExt[1].opa.lay[3].T[2],roo.conExt[2].opa.lay[1].T[1],roo.conExt[2].opa.lay[1].T[2],roo.conExt[2].opa.lay[2].T[1],roo.conExt[2].opa.lay[2].T[2],roo.conExt[2].opa.lay[3].T[1],roo.conExt[2].opa.lay[3].T[2],roo.conExt[2].opa.lay[3].T[3],roo.conExt[2].opa.lay[3].T[4],roo.conExt[2].opa.lay[3].T[5],roo.conExt[2].opa.lay[3].T[6],roo.conExt[2].opa.lay[3].T[7],roo.conExt[2].opa.lay[3].T[8],roo.conExt[2].opa.lay[3].T[9],roo.conExt[3].opa.lay[1].T[1],roo.conExt[3].opa.lay[1].T[2],roo.conExt[3].opa.lay[2].T[1],roo.conExt[3].opa.lay[2].T[2],roo.conExt[3].opa.lay[3].T[1],roo.conExt[3].opa.lay[3].T[2],roo.conExt[3].opa.lay[3].T[3],roo.conExt[3].opa.lay[3].T[4],roo.conExt[3].opa.lay[3].T[5],roo.conExt[3].opa.lay[3].T[6],roo.conExt[3].opa.lay[3].T[7],roo.conExt[3].opa.lay[3].T[8],roo.conExt[3].opa.lay[3].T[9],roo.conExt[4].opa.lay[1].T[1],roo.conExt[4].opa.lay[1].T[2],roo.conExt[4].opa.lay[2].T[1],roo.conExt[4].opa.lay[2].T[2],roo.conExt[4].opa.lay[3].T[1],roo.conExt[4].opa.lay[3].T[2],roo.conExt[4].opa.lay[3].T[3],roo.conExt[4].opa.lay[3].T[4],roo.conExt[4].opa.lay[3].T[5],roo.conExt[4].opa.lay[3].T[6],roo.conExt[4].opa.lay[3].T[7],roo.conExt[4].opa.lay[3].T[8],roo.conExt[4].opa.lay[3].T[9],roo.conExtWin[1].opa.lay[1].T[1],roo.conExtWin[1].opa.lay[1].T[2],roo.conExtWin[1].opa.lay[2].T[1],roo.conExtWin[1].opa.lay[2].T[2],roo.conExtWin[1].opa.lay[3].T[1],roo.conExtWin[1].opa.lay[3].T[2],roo.conExtWin[1].opa.lay[3].T[3],roo.conExtWin[1].opa.lay[3].T[4],roo.conExtWin[1].opa.lay[3].T[5],roo.conExtWin[1].opa.lay[3].T[6],roo.conExtWin[1].opa.lay[3].T[7],roo.conExtWin[1].opa.lay[3].T[8],roo.conExtWin[1].opa.lay[3].T[9],roo.conExtWin[1].win.capGla.TUns,roo.conExtWin[1].win.capFra.T,roo.conBou[1].opa.lay[2].T[1],roo.conBou[1].opa.lay[2].T[2],roo.conBou[1].opa.lay[2].T[3],roo.conBou[1].opa.lay[2].T[4],roo.conBou[1].opa.lay[2].T[5],roo.air.vol.dynBal.medium.Xi[1],roo.air.vol.dynBal.U,roo.air.vol.dynBal.m,TRooHou.mu,TRooAnn.mu)
 * Number of discrete variables: 49 ($whenCondition17,$whenCondition16,$whenCondition15,$whenCondition14,$whenCondition13,$whenCondition12,$whenCondition11,$whenCondition10,$whenCondition9,$whenCondition8,$whenCondition7,$whenCondition6,$whenCondition5,$whenCondition4,$whenCondition3,$whenCondition2,$whenCondition1,roo.bouConExt.HDirTil[1].incAng.decAng.tNext,roo.bouConExt.HDirTil[1].incAng.decAng.k,roo.bouConExt.HDirTil[2].incAng.decAng.tNext,roo.bouConExt.HDirTil[2].incAng.decAng.k,roo.bouConExt.HDirTil[3].incAng.decAng.tNext,roo.bouConExt.HDirTil[3].incAng.decAng.k,roo.bouConExt.HDirTil[4].incAng.decAng.tNext,roo.bouConExt.HDirTil[4].incAng.decAng.k,roo.bouConExt.HDifTil[1].incAng.decAng.tNext,roo.bouConExt.HDifTil[1].incAng.decAng.k,roo.bouConExt.HDifTil[2].incAng.decAng.tNext,roo.bouConExt.HDifTil[2].incAng.decAng.k,roo.bouConExt.HDifTil[3].incAng.decAng.tNext,roo.bouConExt.HDifTil[3].incAng.decAng.k,roo.bouConExt.HDifTil[4].incAng.decAng.tNext,roo.bouConExt.HDifTil[4].incAng.decAng.k,roo.bouConExtWin.HDirTil[1].incAng.decAng.tNext,roo.bouConExtWin.HDirTil[1].incAng.decAng.k,roo.bouConExtWin.HDifTil[1].incAng.decAng.tNext,roo.bouConExtWin.HDifTil[1].incAng.decAng.k,weaDat.locTim.tNext,weaDat.locTim.k,weaDat.conTimMin.tNext,weaDat.conTimMin.k,weaDat.conTim.tNext,weaDat.conTim.k,weaDat.eqnTim.tNext,weaDat.eqnTim.k,weaDat.decAng.tNext,weaDat.decAng.k,TRooHou.mode,TRooAnn.mode)
 * Number of discrete states: 30 (weaDat.conTimMin.tNext,weaDat.conTimMin.k,weaDat.locTim.tNext,weaDat.locTim.k,weaDat.conTim.tNext,weaDat.conTim.k,weaDat.eqnTim.tNext,weaDat.eqnTim.k,roo.bouConExtWin.HDirTil[1].incAng.decAng.tNext,roo.bouConExtWin.HDirTil[1].incAng.decAng.k,roo.bouConExtWin.HDifTil[1].incAng.decAng.tNext,roo.bouConExtWin.HDifTil[1].incAng.decAng.k,roo.bouConExt.HDirTil[1].incAng.decAng.tNext,roo.bouConExt.HDirTil[1].incAng.decAng.k,roo.bouConExt.HDifTil[1].incAng.decAng.tNext,roo.bouConExt.HDifTil[1].incAng.decAng.k,roo.bouConExt.HDirTil[2].incAng.decAng.tNext,roo.bouConExt.HDirTil[2].incAng.decAng.k,roo.bouConExt.HDifTil[2].incAng.decAng.tNext,roo.bouConExt.HDifTil[2].incAng.decAng.k,roo.bouConExt.HDirTil[3].incAng.decAng.tNext,roo.bouConExt.HDirTil[3].incAng.decAng.k,roo.bouConExt.HDifTil[3].incAng.decAng.tNext,roo.bouConExt.HDifTil[3].incAng.decAng.k,roo.bouConExt.HDirTil[4].incAng.decAng.tNext,roo.bouConExt.HDirTil[4].incAng.decAng.k,roo.bouConExt.HDifTil[4].incAng.decAng.tNext,roo.bouConExt.HDifTil[4].incAng.decAng.k,weaDat.decAng.tNext,weaDat.decAng.k)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (793):
 * Single equations (assignments): 740
 * Array equations: 0
 * Algorithm blocks: 1
 * Record equations: 0
 * When equations: 32
 * If-equations: 0
 * Equation systems (not torn): 7
 * Torn equation systems: 13
 * Mixed (continuous/discrete) equation systems: 0
Notification: Equation system details (not torn):
 * Constant Jacobian (size): 0 systems
 * Linear Jacobian (size,density): 0 systems
 * Non-linear Jacobian (size): 7 systems
   {1, 1, 1, 1, 1, 1, 1}
 * Without analytic Jacobian (size): 0 systems
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 11 systems
   {(1,5,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 2 systems
   {(1,23), (11,30)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.008417/6.092, allocations: 1.729 MB / 2.634 GB, free: 393.4 MB / 1.354 GB
Notification: Performance of simCode: created initialization part: time 0.1259/6.218, allocations: 58.48 MB / 2.691 GB, free: 360.1 MB / 1.354 GB
Notification: Performance of simCode: created event and clocks part: time 1.052e-05/6.218, allocations: 4 kB / 2.691 GB, free: 360.1 MB / 1.354 GB
Notification: Performance of simCode: created simulation system equations: time 0.03375/6.252, allocations: 14.16 MB / 2.704 GB, free: 345.8 MB / 1.354 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.05605/6.308, allocations: 9.235 MB / 2.713 GB, free: 337.1 MB / 1.354 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.1152/6.423, allocations: 70.3 MB / 2.782 GB, free: 267 MB / 1.354 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.02825/6.451, allocations: 17.83 MB / 2.8 GB, free: 249.1 MB / 1.354 GB
Notification: Performance of simCode: alias equations: time 0.03865/6.49, allocations: 13.61 MB / 2.813 GB, free: 235.4 MB / 1.354 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0125/6.502, allocations: 1.598 MB / 2.814 GB, free: 233.9 MB / 1.354 GB
Notification: Performance of SimCode: time 1.042e-06/6.502, allocations: 0 / 2.814 GB, free: 233.9 MB / 1.354 GB
Notification: Performance of Templates: time 1.131/7.633, allocations: 0.5342 GB / 3.349 GB, free: 190.7 MB / 1.37 GB
"
[Timeout remaining time 292]
make -j1 -f Buildings_latest_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case900FF.makefile [Timeout 300]
(rm -f Buildings_latest_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case900FF.pipe ; mkfifo Buildings_latest_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case900FF.pipe ; head -c 1048576 < Buildings_latest_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case900FF.pipe >> ../files/Buildings_latest_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case900FF.sim & ./Buildings_latest_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case900FF -abortSlowSimulation -alarm=240  -emit_protected -lv LOG_STATS > Buildings_latest_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case900FF.pipe 2>&1) [Timeout 240]
diffSimulationResults("Buildings_latest_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case900FF_res.mat","/mnt/ReferenceFiles/Buildings/csv/master/Buildings_ThermalZones_Detailed_Validation_BESTEST_Cases9xx_Case900FF.csv","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_latest_Buildings.ThermalZones.Detailed.Validation.BESTEST.Cases9xx.Case900FF.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001) [Timeout 300]
""
[Timeout remaining time 300]
Reference file matches
[Calling sys.exit(0), Time elapsed: 67.98802316794172]