Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_11_Buildings.ThermalZones.ISO13790.Validation.BESTEST.Case900FF.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.1.0-maint.11.x/package.mo", uses=false)
Using package Buildings with version 11.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.1.0-maint.11.x/package.mo)
Using package Modelica with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo)
Using package Complex with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo)
Using package ModelicaServices with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo)
Running command: translateModel(Buildings.ThermalZones.ISO13790.Validation.BESTEST.Case900FF,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|zon5R1C.TAir",fileNamePrefix="Buildings_11_Buildings.ThermalZones.ISO13790.Validation.BESTEST.Case900FF")
translateModel(Buildings.ThermalZones.ISO13790.Validation.BESTEST.Case900FF,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|zon5R1C.TAir",fileNamePrefix="Buildings_11_Buildings.ThermalZones.ISO13790.Validation.BESTEST.Case900FF")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001615/0.001615, allocations: 114.2 kB / 16.81 MB, free: 5.77 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001767/0.001767, allocations: 196.7 kB / 17.77 MB, free: 5.109 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.461/1.461, allocations: 225.6 MB / 244.2 MB, free: 13.89 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.1.0-maint.11.x/package.mo): time 2.806/2.806, allocations: 476.7 MB / 0.7556 GB, free: 11.31 MB / 0.6231 GB
Notification: Performance of FrontEnd - loaded program: time 0.001889/0.001889, allocations: 63.16 kB / 1.097 GB, free: 11.79 MB / 0.8419 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.3072/0.3091, allocations: 168.7 MB / 1.262 GB, free: 12.96 MB / 0.9825 GB
Notification: Performance of NFInst.instantiate(Buildings.ThermalZones.ISO13790.Validation.BESTEST.Case900FF): time 0.01582/0.3249, allocations: 13.68 MB / 1.275 GB, free: 15.21 MB / 0.9981 GB
Notification: Performance of NFInst.instExpressions: time 0.1772/0.5021, allocations: 154.1 MB / 1.426 GB, free: 4.504 MB / 1.139 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.002545/0.5047, allocations: 35.88 kB / 1.426 GB, free: 4.469 MB / 1.139 GB
Notification: Performance of NFTyping.typeComponents: time 0.002452/0.5071, allocations: 1.345 MB / 1.427 GB, free: 3.117 MB / 1.139 GB
Notification: Performance of NFTyping.typeBindings: time 0.00486/0.512, allocations: 1.783 MB / 1.429 GB, free: 1.328 MB / 1.139 GB
Notification: Performance of NFTyping.typeClassSections: time 0.004383/0.5164, allocations: 2.053 MB / 1.431 GB, free: 15.28 MB / 1.154 GB
Notification: Performance of NFFlatten.flatten: time 0.01336/0.5297, allocations: 11.79 MB / 1.443 GB, free: 3.457 MB / 1.154 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.008437/0.5382, allocations: 5.647 MB / 1.448 GB, free: 13.69 MB / 1.17 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.0084/0.5466, allocations: 5.346 MB / 1.453 GB, free: 8.332 MB / 1.17 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.01069/0.5572, allocations: 6.04 MB / 1.459 GB, free: 2.27 MB / 1.17 GB
Notification: Performance of NFPackage.collectConstants: time 0.005299/0.5625, allocations: 1.793 MB / 1.461 GB, free: 488 kB / 1.17 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.006473/0.569, allocations: 2.214 MB / 1.463 GB, free: 14.26 MB / 1.186 GB
Notification: Performance of NFScalarize.scalarize: time 0.005397/0.5744, allocations: 3.325 MB / 1.466 GB, free: 10.93 MB / 1.186 GB
Notification: Performance of NFVerifyModel.verify: time 0.011/0.5854, allocations: 5.993 MB / 1.472 GB, free: 4.914 MB / 1.186 GB
Notification: Performance of NFConvertDAE.convert: time 0.02438/0.6098, allocations: 19.82 MB / 1.492 GB, free: 1.039 MB / 1.201 GB
Notification: Performance of FrontEnd - DAE generated: time 9.137e-06/0.6098, allocations: 4 kB / 1.492 GB, free: 1.035 MB / 1.201 GB
Notification: Performance of FrontEnd: time 2.174e-06/0.6098, allocations: 0 / 1.492 GB, free: 1.035 MB / 1.201 GB
Notification: Performance of Transformations before backend: time 0.0004999/0.6103, allocations: 3.938 kB / 1.492 GB, free: 1.031 MB / 1.201 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 2188
 * Number of variables: 2188
Notification: Performance of Generate backend data structure: time 0.03777/0.6481, allocations: 11.01 MB / 1.502 GB, free: 5.871 MB / 1.217 GB
Notification: Performance of prepare preOptimizeDAE: time 5.171e-05/0.6481, allocations: 8.031 kB / 1.502 GB, free: 5.863 MB / 1.217 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.05732/0.7055, allocations: 10.9 MB / 1.513 GB, free: 10.94 MB / 1.232 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.01237/0.7178, allocations: 5.559 MB / 1.518 GB, free: 5.312 MB / 1.232 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0007135/0.7185, allocations: 0.6261 MB / 1.519 GB, free: 4.684 MB / 1.232 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.003746/0.7223, allocations: 0.8086 MB / 1.52 GB, free: 3.875 MB / 1.232 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.05182/0.7741, allocations: 17.74 MB / 1.537 GB, free: 2.031 MB / 1.248 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0002393/0.7743, allocations: 4 kB / 1.537 GB, free: 2.027 MB / 1.248 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.003095/0.7774, allocations: 348 kB / 1.537 GB, free: 1.688 MB / 1.248 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001959/0.7776, allocations: 208 kB / 1.538 GB, free: 1.484 MB / 1.248 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 1.323/2.101, allocations: 22.9 MB / 1.56 GB, free: 265.3 MB / 1.264 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 0.07863/2.179, allocations: 41.57 MB / 1.601 GB, free: 242.1 MB / 1.264 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.03537/2.215, allocations: 13.26 MB / 1.614 GB, free: 235 MB / 1.264 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.01749/2.232, allocations: 7.206 MB / 1.621 GB, free: 231.1 MB / 1.264 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.001227/2.233, allocations: 0.6391 MB / 1.621 GB, free: 230.6 MB / 1.264 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.02078/2.254, allocations: 8.583 MB / 1.63 GB, free: 222.4 MB / 1.264 GB
Notification: Performance of pre-optimization done (n=643): time 1.75e-05/2.254, allocations: 0 / 1.63 GB, free: 222.4 MB / 1.264 GB
Notification: Performance of matching and sorting (n=643): time 0.06334/2.318, allocations: 21.9 MB / 1.651 GB, free: 200.4 MB / 1.264 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001123/2.318, allocations: 282.5 kB / 1.651 GB, free: 200 MB / 1.264 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.007155/2.325, allocations: 5.229 MB / 1.656 GB, free: 194.8 MB / 1.264 GB
Notification: Performance of collectPreVariables (initialization): time 0.002531/2.327, allocations: 149.7 kB / 1.656 GB, free: 194.6 MB / 1.264 GB
Notification: Performance of collectInitialEqns (initialization): time 0.002753/2.33, allocations: 3.119 MB / 1.66 GB, free: 191.9 MB / 1.264 GB
Notification: Performance of collectInitialBindings (initialization): time 0.003507/2.334, allocations: 2.187 MB / 1.662 GB, free: 190 MB / 1.264 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.007262/2.341, allocations: 1.242 MB / 1.663 GB, free: 188.7 MB / 1.264 GB
Notification: Performance of setup shared object (initialization): time 5.006e-05/2.341, allocations: 309.1 kB / 1.663 GB, free: 188.4 MB / 1.264 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.01733/2.358, allocations: 6.76 MB / 1.67 GB, free: 181.7 MB / 1.264 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.01732/2.376, allocations: 7.273 MB / 1.677 GB, free: 174.3 MB / 1.264 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.03382/2.409, allocations: 13.49 MB / 1.69 GB, free: 160.7 MB / 1.264 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 2.687e-05/2.409, allocations: 0 / 1.69 GB, free: 160.7 MB / 1.264 GB
Notification: Performance of matching and sorting (n=744) (initialization): time 0.04243/2.452, allocations: 15.07 MB / 1.705 GB, free: 145.6 MB / 1.264 GB
Notification: Performance of prepare postOptimizeDAE: time 3.022e-05/2.452, allocations: 8 kB / 1.705 GB, free: 145.6 MB / 1.264 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.067e-05/2.452, allocations: 4 kB / 1.705 GB, free: 145.5 MB / 1.264 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0009057/2.453, allocations: 221.6 kB / 1.705 GB, free: 145.3 MB / 1.264 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01339/2.466, allocations: 2.313 MB / 1.707 GB, free: 143 MB / 1.264 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.003693/2.47, allocations: 4.053 MB / 1.711 GB, free: 138.7 MB / 1.264 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01171/2.482, allocations: 1.592 MB / 1.713 GB, free: 137.1 MB / 1.264 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.002117/2.484, allocations: 295.7 kB / 1.713 GB, free: 136.8 MB / 1.264 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 19
 * Number of states: 0 ()
 * Number of discrete variables: 76 ($PRE.daiComBESTESTFF.nextTimeEvent,$whenCondition1,daiComBESTESTFF.nextTimeEventScaled,$PRE.daiComBESTESTFF.nextTimeEventScaled,daiComBESTESTFF.nextTimeEvent,weaDat.conTim.canRepeatWeatherFile,weaDat.conTimMin.canRepeatWeatherFile,weaDat.decAng.tNext,$PRE.weaDat.decAng.tNext,weaDat.eqnTim.tNext,$PRE.weaDat.eqnTim.tNext,weaDat.conTim.tNext,$PRE.weaDat.conTim.tNext,weaDat.conTimMin.tNext,$PRE.weaDat.conTimMin.tNext,weaDat.locTim.tNext,$PRE.weaDat.locTim.tNext,zon5R1C.opa.HDifTilRof.incAng.decAng.tNext,$PRE.zon5R1C.opa.HDifTilRof.incAng.decAng.tNext,zon5R1C.opa.HDirTilRoo.incAng.decAng.tNext,$PRE.zon5R1C.opa.HDirTilRoo.incAng.decAng.tNext,zon5R1C.opa.HDifTil[4].incAng.decAng.tNext,$PRE.zon5R1C.opa.HDifTil[4].incAng.decAng.tNext,zon5R1C.opa.HDifTil[3].incAng.decAng.tNext,$PRE.zon5R1C.opa.HDifTil[3].incAng.decAng.tNext,zon5R1C.opa.HDifTil[2].incAng.decAng.tNext,$PRE.zon5R1C.opa.HDifTil[2].incAng.decAng.tNext,zon5R1C.opa.HDifTil[1].incAng.decAng.tNext,$PRE.zon5R1C.opa.HDifTil[1].incAng.decAng.tNext,zon5R1C.opa.HDirTil[4].incAng.decAng.tNext,$PRE.zon5R1C.opa.HDirTil[4].incAng.decAng.tNext,zon5R1C.opa.HDirTil[3].incAng.decAng.tNext,$PRE.zon5R1C.opa.HDirTil[3].incAng.decAng.tNext,zon5R1C.opa.HDirTil[2].incAng.decAng.tNext,$PRE.zon5R1C.opa.HDirTil[2].incAng.decAng.tNext,zon5R1C.opa.HDirTil[1].incAng.decAng.tNext,$PRE.zon5R1C.opa.HDirTil[1].incAng.decAng.tNext,zon5R1C.win.HDifTil[4].incAng.decAng.tNext,$PRE.zon5R1C.win.HDifTil[4].incAng.decAng.tNext,zon5R1C.win.HDifTil[3].incAng.decAng.tNext,$PRE.zon5R1C.win.HDifTil[3].incAng.decAng.tNext,zon5R1C.win.HDifTil[2].incAng.decAng.tNext,$PRE.zon5R1C.win.HDifTil[2].incAng.decAng.tNext,zon5R1C.win.HDifTil[1].incAng.decAng.tNext,$PRE.zon5R1C.win.HDifTil[1].incAng.decAng.tNext,zon5R1C.win.HDirTil[4].incAng.decAng.tNext,$PRE.zon5R1C.win.HDirTil[4].incAng.decAng.tNext,zon5R1C.win.HDirTil[3].incAng.decAng.tNext,$PRE.zon5R1C.win.HDirTil[3].incAng.decAng.tNext,zon5R1C.win.HDirTil[2].incAng.decAng.tNext,$PRE.zon5R1C.win.HDirTil[2].incAng.decAng.tNext,zon5R1C.win.HDirTil[1].incAng.decAng.tNext,$PRE.zon5R1C.win.HDirTil[1].incAng.decAng.tNext,$whenCondition2,$whenCondition3,$whenCondition4,$whenCondition5,$whenCondition6,$whenCondition7,$whenCondition8,$whenCondition9,$whenCondition10,$whenCondition11,$whenCondition12,$whenCondition13,$whenCondition14,$whenCondition15,$whenCondition16,$whenCondition17,$whenCondition18,$whenCondition19,$whenCondition20,$whenCondition21,$whenCondition22,$whenCondition23,$whenCondition24)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (730):
 * Single equations (assignments): 728
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 2
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 1 system
   {(1,12,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 1 system
   {(1,2)}
Notification: Performance of prepare postOptimizeDAE: time 0.007273/2.491, allocations: 2.962 MB / 1.716 GB, free: 133.8 MB / 1.264 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.002505/2.493, allocations: 0.5588 MB / 1.716 GB, free: 133.2 MB / 1.264 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.04599/2.539, allocations: 16.82 MB / 1.733 GB, free: 116.3 MB / 1.264 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.0001724/2.54, allocations: 31.88 kB / 1.733 GB, free: 116.3 MB / 1.264 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.789e-05/2.54, allocations: 3.938 kB / 1.733 GB, free: 116.3 MB / 1.264 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.005209/2.545, allocations: 2.374 MB / 1.735 GB, free: 113.9 MB / 1.264 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.002825/2.548, allocations: 191.6 kB / 1.735 GB, free: 113.7 MB / 1.264 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.01069/2.558, allocations: 1.225 MB / 1.737 GB, free: 112.5 MB / 1.264 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.001902/2.56, allocations: 0.4886 MB / 1.737 GB, free: 112 MB / 1.264 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.04773/2.608, allocations: 16.15 MB / 1.753 GB, free: 95.76 MB / 1.264 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.05864/2.667, allocations: 24.92 MB / 1.777 GB, free: 70.71 MB / 1.264 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.01704/2.684, allocations: 7.044 MB / 1.784 GB, free: 63.64 MB / 1.264 GB
Notification: Performance of sorting global known variables: time 0.007084/2.691, allocations: 4.021 MB / 1.788 GB, free: 59.63 MB / 1.264 GB
Notification: Performance of Backend: time 9.52e-07/2.691, allocations: 0 / 1.788 GB, free: 59.63 MB / 1.264 GB
Notification: Performance of simCode: created initialization part: time 0.03219/2.723, allocations: 9.418 MB / 1.797 GB, free: 50.61 MB / 1.264 GB
Notification: Performance of SimCode: time 0.02618/2.749, allocations: 14.99 MB / 1.812 GB, free: 35.56 MB / 1.264 GB
Notification: Performance of Templates: time 0.2345/2.984, allocations: 150.2 MB / 1.959 GB, free: 13.51 MB / 1.389 GB
make -j1 -f Buildings_11_Buildings.ThermalZones.ISO13790.Validation.BESTEST.Case900FF.makefile
(rm -f Buildings_11_Buildings.ThermalZones.ISO13790.Validation.BESTEST.Case900FF.pipe ; mkfifo Buildings_11_Buildings.ThermalZones.ISO13790.Validation.BESTEST.Case900FF.pipe ; head -c 1048576 < Buildings_11_Buildings.ThermalZones.ISO13790.Validation.BESTEST.Case900FF.pipe >> ../files/Buildings_11_Buildings.ThermalZones.ISO13790.Validation.BESTEST.Case900FF.sim & ./Buildings_11_Buildings.ThermalZones.ISO13790.Validation.BESTEST.Case900FF  -abortSlowSimulation -alarm=400  -emit_protected -lv LOG_STATS > Buildings_11_Buildings.ThermalZones.ISO13790.Validation.BESTEST.Case900FF.pipe 2>&1)