Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr BuildingSystems_BuildingSystems.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/NcDataReader2 2.5.1-master/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildingSystems 2.0.0-master/package.mo", uses=false)
Using package BuildingSystems with version 2.0.0-beta (/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildingSystems 2.0.0-master/package.mo)
Using package NcDataReader2 with version 2.5.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/NcDataReader2 2.5.1-master/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(BuildingSystems.ThermalZones.ISO13790.Validation.BESTEST.Case900FF,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="BuildingSystems_BuildingSystems.ThermalZones.ISO13790.Validation.BESTEST.Case900FF")
translateModel(BuildingSystems.ThermalZones.ISO13790.Validation.BESTEST.Case900FF,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="BuildingSystems_BuildingSystems.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.001474/0.001474, allocations: 115.5 kB / 16.42 MB, free: 6.031 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.001794/0.001794, allocations: 186.2 kB / 17.35 MB, free: 5.633 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.275/1.275, allocations: 222.9 MB / 241 MB, free: 15.16 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/NcDataReader2 2.5.1-master/package.mo): time 0.002096/0.002096, allocations: 285.2 kB / 291.5 MB, free: 14.44 MB / 238.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildingSystems 2.0.0-master/package.mo): time 0.921/0.921, allocations: 169.3 MB / 0.499 GB, free: 4.41 MB / 382.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.001756/0.001756, allocations: 95.84 kB / 0.6821 GB, free: 6.957 MB / 494.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.3618/0.3636, allocations: 86.98 MB / 0.767 GB, free: 3.918 MB / 0.5294 GB
Notification: Performance of NFInst.instantiate(BuildingSystems.ThermalZones.ISO13790.Validation.BESTEST.Case900FF): time 0.01048/0.3741, allocations: 9.748 MB / 0.7766 GB, free: 10.12 MB / 0.545 GB
Notification: Performance of NFInst.instExpressions: time 0.146/0.5202, allocations: 153.2 MB / 0.9262 GB, free: 328 kB / 0.6856 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001596/0.5218, allocations: 35.88 kB / 0.9262 GB, free: 292 kB / 0.6856 GB
Notification: Performance of NFTyping.typeComponents: time 0.001648/0.5235, allocations: 1.206 MB / 0.9274 GB, free: 15.07 MB / 0.7012 GB
Notification: Performance of NFTyping.typeBindings: time 0.002734/0.5262, allocations: 1.462 MB / 0.9288 GB, free: 13.61 MB / 0.7012 GB
Notification: Performance of NFTyping.typeClassSections: time 0.003339/0.5296, allocations: 1.999 MB / 0.9308 GB, free: 11.61 MB / 0.7012 GB
Notification: Performance of NFFlatten.flatten: time 0.008127/0.5377, allocations: 10.15 MB / 0.9407 GB, free: 1.441 MB / 0.7012 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.008591/0.5463, allocations: 8.791 MB / 0.9493 GB, free: 8.539 MB / 0.7169 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.004987/0.5513, allocations: 5.104 MB / 0.9542 GB, free: 3.422 MB / 0.7169 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.3346/0.8859, allocations: 5.691 MB / 0.9598 GB, free: 15.56 MB / 0.7169 GB
Notification: Performance of NFPackage.collectConstants: time 0.003835/0.8898, allocations: 1.791 MB / 0.9616 GB, free: 15.56 MB / 0.7169 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.003378/0.8932, allocations: 2.214 MB / 0.9637 GB, free: 15.56 MB / 0.7169 GB
Notification: Performance of NFScalarize.scalarize: time 0.002252/0.8955, allocations: 3.319 MB / 0.967 GB, free: 15.56 MB / 0.7169 GB
Notification: Performance of NFVerifyModel.verify: time 0.005206/0.9007, allocations: 5.675 MB / 0.9725 GB, free: 15.56 MB / 0.7169 GB
Notification: Performance of NFConvertDAE.convert: time 0.01226/0.9129, allocations: 19.24 MB / 0.9913 GB, free: 14.07 MB / 0.7169 GB
Notification: Performance of FrontEnd - DAE generated: time 6.382e-06/0.913, allocations: 4.656 kB / 0.9913 GB, free: 14.07 MB / 0.7169 GB
Notification: Performance of FrontEnd: time 1.583e-06/0.913, allocations: 0 / 0.9913 GB, free: 14.07 MB / 0.7169 GB
Notification: Performance of Transformations before backend: time 0.000359/0.9133, allocations: 0.9062 kB / 0.9913 GB, free: 14.07 MB / 0.7169 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.02427/0.9376, allocations: 10.52 MB / 1.002 GB, free: 10.61 MB / 0.7169 GB
Notification: Performance of prepare preOptimizeDAE: time 3.823e-05/0.9377, allocations: 7.312 kB / 1.002 GB, free: 10.61 MB / 0.7169 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.05283/0.9905, allocations: 10.85 MB / 1.012 GB, free: 6.914 MB / 0.7169 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.0102/1.001, allocations: 5.535 MB / 1.018 GB, free: 5.297 MB / 0.7169 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0004042/1.001, allocations: 0.6242 MB / 1.018 GB, free: 5.273 MB / 0.7169 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.002095/1.003, allocations: 0.8089 MB / 1.019 GB, free: 5.27 MB / 0.7169 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.03843/1.042, allocations: 17.74 MB / 1.036 GB, free: 10.87 MB / 0.7325 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0001584/1.042, allocations: 0 / 1.036 GB, free: 10.87 MB / 0.7325 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.001774/1.044, allocations: 348 kB / 1.037 GB, free: 10.53 MB / 0.7325 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001433/1.044, allocations: 207.8 kB / 1.037 GB, free: 10.33 MB / 0.7325 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.05781/1.102, allocations: 22.91 MB / 1.059 GB, free: 3.395 MB / 0.7481 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.07585/1.178, allocations: 39.22 MB / 1.098 GB, free: 12.66 MB / 0.795 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.03581/1.213, allocations: 13.8 MB / 1.111 GB, free: 14.88 MB / 0.8106 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.01875/1.232, allocations: 7.638 MB / 1.118 GB, free: 7.219 MB / 0.8106 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.001094/1.233, allocations: 0.6425 MB / 1.119 GB, free: 6.535 MB / 0.8106 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.02033/1.254, allocations: 8.567 MB / 1.127 GB, free: 13.9 MB / 0.8262 GB
Notification: Performance of pre-optimization done (n=643): time 9.678e-06/1.254, allocations: 0 / 1.127 GB, free: 13.9 MB / 0.8262 GB
Notification: Performance of matching and sorting (n=643): time 0.05875/1.312, allocations: 21.85 MB / 1.149 GB, free: 7.93 MB / 0.8419 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.000159/1.313, allocations: 282.6 kB / 1.149 GB, free: 7.602 MB / 0.8419 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.007765/1.32, allocations: 5.221 MB / 1.154 GB, free: 2.359 MB / 0.8419 GB
Notification: Performance of collectPreVariables (initialization): time 0.001023/1.321, allocations: 153.7 kB / 1.154 GB, free: 2.203 MB / 0.8419 GB
Notification: Performance of collectInitialEqns (initialization): time 0.002902/1.324, allocations: 3.047 MB / 1.157 GB, free: 15.13 MB / 0.8575 GB
Notification: Performance of collectInitialBindings (initialization): time 0.002405/1.327, allocations: 2.083 MB / 1.159 GB, free: 13.07 MB / 0.8575 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.003368/1.33, allocations: 1.237 MB / 1.161 GB, free: 11.82 MB / 0.8575 GB
Notification: Performance of setup shared object (initialization): time 9.613e-05/1.33, allocations: 301.1 kB / 1.161 GB, free: 11.53 MB / 0.8575 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.01761/1.348, allocations: 6.752 MB / 1.167 GB, free: 4.766 MB / 0.8575 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.01811/1.366, allocations: 7.276 MB / 1.174 GB, free: 13.42 MB / 0.8731 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.03502/1.401, allocations: 13.49 MB / 1.188 GB, free: 15.84 MB / 0.8887 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.483e-05/1.401, allocations: 0 / 1.188 GB, free: 15.84 MB / 0.8887 GB
Notification: Performance of matching and sorting (n=744) (initialization): time 0.04538/1.446, allocations: 15.03 MB / 1.202 GB, free: 0.7656 MB / 0.8887 GB
Notification: Performance of prepare postOptimizeDAE: time 3.221e-05/1.446, allocations: 11.75 kB / 1.202 GB, free: 0.7578 MB / 0.8887 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.45e-05/1.446, allocations: 4 kB / 1.202 GB, free: 0.7539 MB / 0.8887 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0009831/1.447, allocations: 213.5 kB / 1.203 GB, free: 0.5391 MB / 0.8887 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01468/1.462, allocations: 2.325 MB / 1.205 GB, free: 14.28 MB / 0.9044 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.004647/1.467, allocations: 3.914 MB / 1.209 GB, free: 10.11 MB / 0.9044 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01243/1.479, allocations: 1.579 MB / 1.21 GB, free: 8.52 MB / 0.9044 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.002116/1.481, allocations: 299.7 kB / 1.21 GB, free: 8.227 MB / 0.9044 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 (731):
 * Single equations (assignments): 729
 * 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,11,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 1 system
   {(1,2)}
Notification: Performance of prepare postOptimizeDAE: time 0.007649/1.489, allocations: 2.954 MB / 1.213 GB, free: 5.324 MB / 0.9044 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.002397/1.492, allocations: 0.5285 MB / 1.214 GB, free: 4.789 MB / 0.9044 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.04808/1.54, allocations: 16.83 MB / 1.23 GB, free: 3.875 MB / 0.92 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 9.494e-05/1.54, allocations: 31.98 kB / 1.23 GB, free: 3.844 MB / 0.92 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.427e-05/1.54, allocations: 7.938 kB / 1.23 GB, free: 3.836 MB / 0.92 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.004844/1.545, allocations: 2.336 MB / 1.233 GB, free: 1.473 MB / 0.92 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.001796/1.546, allocations: 195.3 kB / 1.233 GB, free: 1.281 MB / 0.92 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.009835/1.556, allocations: 1.225 MB / 1.234 GB, free: 56 kB / 0.92 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.001116/1.557, allocations: 488.6 kB / 1.234 GB, free: 15.57 MB / 0.9356 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.0456/1.603, allocations: 16.13 MB / 1.25 GB, free: 15.48 MB / 0.9512 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.0578/1.661, allocations: 24.91 MB / 1.275 GB, free: 6.445 MB / 0.9669 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.01763/1.678, allocations: 7.458 MB / 1.282 GB, free: 14.96 MB / 0.9825 GB
Notification: Performance of sorting global known variables: time 0.006466/1.685, allocations: 4.025 MB / 1.286 GB, free: 10.95 MB / 0.9825 GB
Notification: Performance of Backend: time 3.91e-07/1.685, allocations: 0 / 1.286 GB, free: 10.95 MB / 0.9825 GB
Notification: Performance of simCode: created initialization part: time 0.0277/1.713, allocations: 9.831 MB / 1.295 GB, free: 1.621 MB / 0.9825 GB
Notification: Performance of SimCode: time 0.02334/1.736, allocations: 14.45 MB / 1.309 GB, free: 3.145 MB / 0.9981 GB
Notification: Performance of Templates: time 0.4419/2.178, allocations: 140.3 MB / 1.447 GB, free: 333.5 MB / 0.9981 GB
make -j1 -f BuildingSystems_BuildingSystems.ThermalZones.ISO13790.Validation.BESTEST.Case900FF.makefile
(rm -f BuildingSystems_BuildingSystems.ThermalZones.ISO13790.Validation.BESTEST.Case900FF.pipe ; mkfifo BuildingSystems_BuildingSystems.ThermalZones.ISO13790.Validation.BESTEST.Case900FF.pipe ; head -c 1048576 < BuildingSystems_BuildingSystems.ThermalZones.ISO13790.Validation.BESTEST.Case900FF.pipe >> ../files/BuildingSystems_BuildingSystems.ThermalZones.ISO13790.Validation.BESTEST.Case900FF.sim & ./BuildingSystems_BuildingSystems.ThermalZones.ISO13790.Validation.BESTEST.Case900FF  -abortSlowSimulation -alarm=480 -lv LOG_STATS > BuildingSystems_BuildingSystems.ThermalZones.ISO13790.Validation.BESTEST.Case900FF.pipe 2>&1)