Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_latest_Buildings.ThermalZones.Detailed.Examples.MixedAirFreeResponse.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 12.0.0-master/package.mo", uses=false)
Using package Buildings with version 12.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.0.0-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(Buildings.ThermalZones.Detailed.Examples.MixedAirFreeResponse,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|roo.weaBus.TDryBul|roo.air.vol.T",fileNamePrefix="Buildings_latest_Buildings.ThermalZones.Detailed.Examples.MixedAirFreeResponse")
translateModel(Buildings.ThermalZones.Detailed.Examples.MixedAirFreeResponse,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|roo.weaBus.TDryBul|roo.air.vol.T",fileNamePrefix="Buildings_latest_Buildings.ThermalZones.Detailed.Examples.MixedAirFreeResponse")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001431/0.001431, allocations: 117.8 kB / 16.42 MB, free: 6.48 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.001624/0.001625, allocations: 185.7 kB / 17.34 MB, free: 5.746 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.36/1.36, allocations: 222.9 MB / 241.1 MB, free: 15.16 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.0.0-master/package.mo): time 2.692/2.692, allocations: 472.7 MB / 0.746 GB, free: 432 kB / 0.6075 GB
Notification: Performance of FrontEnd - loaded program: time 0.00146/0.00146, allocations: 59.91 kB / 1.07 GB, free: 9.582 MB / 0.8419 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.7668/0.7682, allocations: 159.9 MB / 1.226 GB, free: 13.51 MB / 0.9512 GB
Notification: Performance of NFInst.instantiate(Buildings.ThermalZones.Detailed.Examples.MixedAirFreeResponse): time 0.2043/0.9726, allocations: 219.9 MB / 1.441 GB, free: 0.7305 MB / 1.154 GB
Notification: Performance of NFInst.instExpressions: time 0.05264/1.025, allocations: 38.08 MB / 1.478 GB, free: 10.52 MB / 1.201 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.01118/1.036, allocations: 346.2 kB / 1.479 GB, free: 10.18 MB / 1.201 GB
Notification: Performance of NFTyping.typeComponents: time 0.0156/1.052, allocations: 6.849 MB / 1.485 GB, free: 3.301 MB / 1.201 GB
Notification: Performance of NFTyping.typeBindings: time 0.01452/1.067, allocations: 5.683 MB / 1.491 GB, free: 13.59 MB / 1.217 GB
Notification: Performance of NFTyping.typeClassSections: time 0.01094/1.078, allocations: 4.817 MB / 1.496 GB, free: 8.781 MB / 1.217 GB
Notification: Performance of NFFlatten.flatten: time 1.357/2.434, allocations: 75.73 MB / 1.57 GB, free: 18.56 MB / 1.279 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.04165/2.476, allocations: 31.84 MB / 1.601 GB, free: 14.59 MB / 1.279 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.04399/2.52, allocations: 29.95 MB / 1.63 GB, free: 12.26 MB / 1.279 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.04426/2.565, allocations: 29.85 MB / 1.659 GB, free: 8.266 MB / 1.279 GB
Notification: Performance of NFPackage.collectConstants: time 0.02022/2.585, allocations: 6.023 MB / 1.665 GB, free: 8.266 MB / 1.279 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.03102/2.616, allocations: 9.514 MB / 1.674 GB, free: 8.266 MB / 1.279 GB
Notification: Performance of NFScalarize.scalarize: time 0.03187/2.648, allocations: 23.52 MB / 1.697 GB, free: 6.625 MB / 1.279 GB
Notification: Performance of NFVerifyModel.verify: time 0.06545/2.713, allocations: 25.83 MB / 1.722 GB, free: 9.344 MB / 1.295 GB
Notification: Performance of NFConvertDAE.convert: time 0.1074/2.821, allocations: 88.88 MB / 1.809 GB, free: 1.855 MB / 1.373 GB
Notification: Performance of FrontEnd - DAE generated: time 7.504e-06/2.821, allocations: 0 / 1.809 GB, free: 1.855 MB / 1.373 GB
Notification: Performance of FrontEnd: time 1.833e-06/2.821, allocations: 4 kB / 1.809 GB, free: 1.852 MB / 1.373 GB
Notification: Performance of Transformations before backend: time 0.002221/2.823, allocations: 0 / 1.809 GB, free: 1.852 MB / 1.373 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 3214
 * Number of variables: 3214
Notification: Performance of Generate backend data structure: time 0.1634/2.986, allocations: 59.46 MB / 1.867 GB, free: 6.5 MB / 1.436 GB
Notification: Performance of prepare preOptimizeDAE: time 6.443e-05/2.986, allocations: 12.03 kB / 1.867 GB, free: 6.488 MB / 1.436 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.07767/3.064, allocations: 15.62 MB / 1.883 GB, free: 6.82 MB / 1.451 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.1225/3.187, allocations: 72.73 MB / 1.954 GB, free: 15.17 MB / 1.529 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.002498/3.189, allocations: 2.464 MB / 1.956 GB, free: 12.45 MB / 1.529 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.01279/3.202, allocations: 1.711 MB / 1.958 GB, free: 10.73 MB / 1.529 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.06563/3.268, allocations: 26.54 MB / 1.984 GB, free: 15.58 MB / 1.561 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0003406/3.268, allocations: 30.84 kB / 1.984 GB, free: 15.57 MB / 1.561 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.005331/3.273, allocations: 0.5143 MB / 1.984 GB, free: 15.06 MB / 1.561 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0004113/3.274, allocations: 454.7 kB / 1.984 GB, free: 14.61 MB / 1.561 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.06719/3.341, allocations: 30.53 MB / 2.014 GB, free: 224 kB / 1.576 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.3055/3.646, allocations: 161.9 MB / 2.172 GB, free: 12.55 MB / 1.748 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.03951/3.686, allocations: 19.69 MB / 2.192 GB, free: 8.863 MB / 1.764 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.7222/4.408, allocations: 13.82 MB / 2.205 GB, free: 0.6886 GB / 1.764 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.001616/4.41, allocations: 0.6912 MB / 2.206 GB, free: 0.6881 GB / 1.764 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.02553/4.436, allocations: 12.35 MB / 2.218 GB, free: 0.6866 GB / 1.764 GB
Notification: Performance of pre-optimization done (n=926): time 1.333e-05/4.436, allocations: 0 / 2.218 GB, free: 0.6866 GB / 1.764 GB
Notification: Performance of matching and sorting (n=926): time 0.1675/4.603, allocations: 69.6 MB / 2.286 GB, free: 0.6633 GB / 1.764 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0004679/4.604, allocations: 0.7715 MB / 2.287 GB, free: 0.6628 GB / 1.764 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.1599/4.763, allocations: 105.1 MB / 2.389 GB, free: 0.5648 GB / 1.764 GB
Notification: Performance of collectPreVariables (initialization): time 0.007562/4.771, allocations: 410.8 kB / 2.39 GB, free: 0.5644 GB / 1.764 GB
Notification: Performance of collectInitialEqns (initialization): time 0.02596/4.797, allocations: 17.87 MB / 2.407 GB, free: 0.5481 GB / 1.764 GB
Notification: Performance of collectInitialBindings (initialization): time 0.00505/4.802, allocations: 3.432 MB / 2.41 GB, free: 0.5448 GB / 1.764 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.02902/4.831, allocations: 15.35 MB / 2.425 GB, free: 0.5298 GB / 1.764 GB
Notification: Performance of setup shared object (initialization): time 4.823e-05/4.831, allocations: 312.7 kB / 2.426 GB, free: 0.5295 GB / 1.764 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.105/4.936, allocations: 115.5 MB / 2.538 GB, free: 426.7 MB / 1.764 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.1115/5.048, allocations: 123.3 MB / 2.659 GB, free: 301.2 MB / 1.764 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.1474/5.195, allocations: 141.7 MB / 2.797 GB, free: 157.4 MB / 1.764 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0001581/5.195, allocations: 44 kB / 2.797 GB, free: 157.4 MB / 1.764 GB
Notification: Performance of matching and sorting (n=5588) (initialization): time 0.989/6.184, allocations: 259.2 MB / 3.05 GB, free: 0.5952 GB / 1.764 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0008652/6.185, allocations: 0.6162 MB / 3.051 GB, free: 0.5947 GB / 1.764 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.2127/6.398, allocations: 188.9 MB / 3.235 GB, free: 429 MB / 1.764 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.03828/6.436, allocations: 16.51 MB / 3.252 GB, free: 412.6 MB / 1.764 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.03224/6.469, allocations: 5.942 MB / 3.257 GB, free: 407 MB / 1.764 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.02576/6.494, allocations: 27.11 MB / 3.284 GB, free: 379.2 MB / 1.764 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0439/6.538, allocations: 5.354 MB / 3.289 GB, free: 375.1 MB / 1.764 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.008423/6.547, allocations: 0.9948 MB / 3.29 GB, free: 374.2 MB / 1.764 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.136/6.683, allocations: 136 MB / 3.423 GB, free: 238.1 MB / 1.764 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.1157/6.799, allocations: 123.3 MB / 3.543 GB, free: 112.7 MB / 1.764 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.8493/7.648, allocations: 141.6 MB / 3.682 GB, free: 0.61 GB / 1.764 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 0.0002249/7.648, allocations: 41.78 kB / 3.682 GB, free: 0.61 GB / 1.764 GB
Notification: Performance of matching and sorting (n=5588) (initialization_lambda0): time 0.2897/7.938, allocations: 261 MB / 3.936 GB, free: 430 MB / 1.764 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0006721/7.939, allocations: 0.6165 MB / 3.937 GB, free: 429.4 MB / 1.764 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.212/8.151, allocations: 191.7 MB / 4.124 GB, free: 237.9 MB / 1.764 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.03492/8.186, allocations: 15.86 MB / 4.14 GB, free: 222 MB / 1.764 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.03163/8.217, allocations: 5.943 MB / 4.146 GB, free: 216.1 MB / 1.764 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.07443/8.292, allocations: 67.37 MB / 4.211 GB, free: 148.2 MB / 1.764 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.04404/8.336, allocations: 4.748 MB / 4.216 GB, free: 143.5 MB / 1.764 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.007939/8.344, allocations: 0.9899 MB / 4.217 GB, free: 142.5 MB / 1.764 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 684
 * Number of states: 0 ()
 * Number of discrete variables: 62 (weaDat.conTim.canRepeatWeatherFile,weaDat.conTimMin.canRepeatWeatherFile,roo.solRadExc.is_flo[21],roo.solRadExc.is_flo[20],roo.solRadExc.is_flo[19],roo.solRadExc.is_flo[18],roo.solRadExc.is_flo[17],roo.solRadExc.is_flo[16],roo.solRadExc.is_flo[15],roo.solRadExc.is_flo[14],roo.solRadExc.is_flo[13],roo.solRadExc.is_flo[12],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.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,roo.bouConExtWin.HDifTil[4].incAng.decAng.tNext,$PRE.roo.bouConExtWin.HDifTil[4].incAng.decAng.tNext,roo.bouConExtWin.HDifTil[3].incAng.decAng.tNext,$PRE.roo.bouConExtWin.HDifTil[3].incAng.decAng.tNext,roo.bouConExtWin.HDifTil[2].incAng.decAng.tNext,$PRE.roo.bouConExtWin.HDifTil[2].incAng.decAng.tNext,roo.bouConExtWin.HDifTil[1].incAng.decAng.tNext,$PRE.roo.bouConExtWin.HDifTil[1].incAng.decAng.tNext,roo.bouConExtWin.HDirTil[4].incAng.decAng.tNext,$PRE.roo.bouConExtWin.HDirTil[4].incAng.decAng.tNext,roo.bouConExtWin.HDirTil[3].incAng.decAng.tNext,$PRE.roo.bouConExtWin.HDirTil[3].incAng.decAng.tNext,roo.bouConExtWin.HDirTil[2].incAng.decAng.tNext,$PRE.roo.bouConExtWin.HDirTil[2].incAng.decAng.tNext,roo.bouConExtWin.HDirTil[1].incAng.decAng.tNext,$PRE.roo.bouConExtWin.HDirTil[1].incAng.decAng.tNext,$whenCondition1,$whenCondition2,$whenCondition3,$whenCondition4,$whenCondition5,$whenCondition6,$whenCondition7,$whenCondition8,$whenCondition9,$whenCondition10,$whenCondition11,$whenCondition12,$whenCondition13)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (2557):
 * Single equations (assignments): 2400
 * Array equations: 144
 * Algorithm blocks: 4
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 9
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 8 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%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 1 system
   {(31,161)}
Notification: Performance of prepare postOptimizeDAE: time 0.0104/8.354, allocations: 1.941 MB / 4.219 GB, free: 140.6 MB / 1.764 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.01113/8.365, allocations: 3.639 MB / 4.222 GB, free: 136.9 MB / 1.764 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.07459/8.44, allocations: 37.26 MB / 4.259 GB, free: 99.58 MB / 1.764 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.0002062/8.44, allocations: 39.84 kB / 4.259 GB, free: 99.54 MB / 1.764 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.538e-05/8.44, allocations: 0 / 4.259 GB, free: 99.54 MB / 1.764 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.02327/8.464, allocations: 9.623 MB / 4.268 GB, free: 89.87 MB / 1.764 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.01226/8.476, allocations: 263.9 kB / 4.269 GB, free: 89.61 MB / 1.764 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.02263/8.498, allocations: 1.747 MB / 4.27 GB, free: 87.86 MB / 1.764 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.003182/8.502, allocations: 0.7689 MB / 4.271 GB, free: 87.09 MB / 1.764 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.06335/8.565, allocations: 34.3 MB / 4.304 GB, free: 52.82 MB / 1.764 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.7382/9.303, allocations: 44.62 MB / 4.348 GB, free: 0.6367 GB / 1.764 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.02189/9.325, allocations: 13.67 MB / 4.361 GB, free: 0.635 GB / 1.764 GB
Notification: Performance of sorting global known variables: time 0.08934/9.415, allocations: 70.37 MB / 4.43 GB, free: 0.6137 GB / 1.764 GB
Notification: Performance of Backend: time 1.012e-06/9.415, allocations: 0 / 4.43 GB, free: 0.6137 GB / 1.764 GB
Notification: Performance of simCode: created initialization part: time 0.2846/9.699, allocations: 287.6 MB / 4.711 GB, free: 365.3 MB / 1.764 GB
Notification: Performance of SimCode: time 0.1919/9.891, allocations: 125.3 MB / 4.833 GB, free: 242 MB / 1.764 GB
Notification: Performance of Templates: time 3.346/13.24, allocations: 1.028 GB / 5.861 GB, free: 0.5268 GB / 1.764 GB
make -j1 -f Buildings_latest_Buildings.ThermalZones.Detailed.Examples.MixedAirFreeResponse.makefile
(rm -f Buildings_latest_Buildings.ThermalZones.Detailed.Examples.MixedAirFreeResponse.pipe ; mkfifo Buildings_latest_Buildings.ThermalZones.Detailed.Examples.MixedAirFreeResponse.pipe ; head -c 1048576 < Buildings_latest_Buildings.ThermalZones.Detailed.Examples.MixedAirFreeResponse.pipe >> ../files/Buildings_latest_Buildings.ThermalZones.Detailed.Examples.MixedAirFreeResponse.sim & ./Buildings_latest_Buildings.ThermalZones.Detailed.Examples.MixedAirFreeResponse  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > Buildings_latest_Buildings.ThermalZones.Detailed.Examples.MixedAirFreeResponse.pipe 2>&1)