Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr BuildingSystems_BuildingSystems.Airflow.Multizone.Examples.ReverseBuoyancy.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildingSystems 2.0.0-master/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/ModelicaServices 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)
Using package NcDataReader2 with version 2.5.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/NcDataReader2 2.5.1-master/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)
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 BuildingSystems with version 2.0.0-beta (/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildingSystems 2.0.0-master/package.mo)
Running command: translateModel(BuildingSystems.Airflow.Multizone.Examples.ReverseBuoyancy,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="BuildingSystems_BuildingSystems.Airflow.Multizone.Examples.ReverseBuoyancy")
translateModel(BuildingSystems.Airflow.Multizone.Examples.ReverseBuoyancy,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="BuildingSystems_BuildingSystems.Airflow.Multizone.Examples.ReverseBuoyancy")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildingSystems 2.0.0-master/package.mo): time 1.022/1.022, allocations: 143.4 MB / 158.3 MB, free: 5.777 MB / 122.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001304/0.001304, allocations: 180 kB / 191.5 MB, free: 5.77 MB / 154.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.609/1.609, allocations: 223.2 MB / 447.7 MB, free: 4.809 MB / 330.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001108/0.001108, allocations: 84.33 kB / 0.5188 GB, free: 1.168 MB / 410.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/NcDataReader2 2.5.1-master/package.mo): time 0.002046/0.002046, allocations: 260.9 kB / 0.6005 GB, free: 48.76 MB / 410.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0005229/0.000523, allocations: 15.09 kB / 0.6929 GB, free: 59.69 MB / 442.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.2304/0.231, allocations: 82.79 MB / 0.7737 GB, free: 13.86 MB / 458.7 MB
Notification: Performance of FrontEnd - scodeFlatten: time 5.626/5.858, allocations: 1.898 GB / 2.671 GB, free: 130.7 MB / 0.7136 GB
Notification: Performance of FrontEnd - mkProgramGraph: time 0.0002735/5.858, allocations: 99.14 kB / 2.671 GB, free: 130.6 MB / 0.7136 GB
Notification: Performance of FrontEnd - DAE generated: time 8.063/13.92, allocations: 1.968 GB / 4.639 GB, free: 58.82 MB / 0.7761 GB
Notification: Performance of FrontEnd: time 2.144e-06/13.92, allocations: 1.688 kB / 4.639 GB, free: 58.82 MB / 0.7761 GB
Notification: Performance of Transformations before backend: time 0.0003164/13.92, allocations: 90.09 kB / 4.64 GB, free: 58.81 MB / 0.7761 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 843
 * Number of variables: 843
Notification: Performance of Generate backend data structure: time 0.02207/13.94, allocations: 4.767 MB / 4.644 GB, free: 57.03 MB / 0.7761 GB
Notification: Performance of prepare preOptimizeDAE: time 5.667e-05/13.94, allocations: 13.8 kB / 4.644 GB, free: 57.03 MB / 0.7761 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.009071/13.95, allocations: 0.9971 MB / 4.645 GB, free: 56.82 MB / 0.7761 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.007825/13.96, allocations: 2.205 MB / 4.647 GB, free: 56.31 MB / 0.7761 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0003098/13.96, allocations: 250.8 kB / 4.648 GB, free: 56.3 MB / 0.7761 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.001674/13.96, allocations: 340.6 kB / 4.648 GB, free: 56.29 MB / 0.7761 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.01005/13.97, allocations: 4.137 MB / 4.652 GB, free: 55.97 MB / 0.7761 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0001039/13.97, allocations: 8.844 kB / 4.652 GB, free: 55.97 MB / 0.7761 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0004409/13.97, allocations: 135.5 kB / 4.652 GB, free: 55.97 MB / 0.7761 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001673/13.97, allocations: 153.6 kB / 4.652 GB, free: 55.96 MB / 0.7761 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.009728/13.98, allocations: 4.638 MB / 4.657 GB, free: 55.93 MB / 0.7761 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.03047/14.01, allocations: 14.67 MB / 4.671 GB, free: 49.18 MB / 0.7761 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.00928/14.02, allocations: 4.334 MB / 4.675 GB, free: 49.05 MB / 0.7761 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.002092/14.03, allocations: 1.614 MB / 4.677 GB, free: 47.36 MB / 0.7761 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0001067/14.03, allocations: 78.95 kB / 4.677 GB, free: 47.32 MB / 0.7761 GB
Notification: Performance of pre-optimization done (n=392): time 6.362e-06/14.03, allocations: 3.938 kB / 4.677 GB, free: 47.32 MB / 0.7761 GB
Notification: Performance of matching and sorting (n=392): time 0.01642/14.04, allocations: 5.481 MB / 4.682 GB, free: 47.04 MB / 0.7761 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 7.195e-05/14.04, allocations: 90.2 kB / 4.682 GB, free: 46.97 MB / 0.7761 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.004967/14.05, allocations: 1.45 MB / 4.684 GB, free: 46.77 MB / 0.7761 GB
Notification: Performance of collectPreVariables (initialization): time 0.001667/14.05, allocations: 93.08 kB / 4.684 GB, free: 46.74 MB / 0.7761 GB
Notification: Performance of collectInitialEqns (initialization): time 0.001916/14.05, allocations: 1.131 MB / 4.685 GB, free: 46.32 MB / 0.7761 GB
Notification: Performance of collectInitialBindings (initialization): time 0.003011/14.05, allocations: 1.327 MB / 4.686 GB, free: 45.45 MB / 0.7761 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0009888/14.05, allocations: 69.09 kB / 4.686 GB, free: 45.45 MB / 0.7761 GB
Notification: Performance of setup shared object (initialization): time 0.000557/14.06, allocations: 438.3 kB / 4.687 GB, free: 45.14 MB / 0.7761 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.003781/14.06, allocations: 1.542 MB / 4.688 GB, free: 45.13 MB / 0.7761 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.00415/14.06, allocations: 1.957 MB / 4.69 GB, free: 44.82 MB / 0.7761 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.004268/14.07, allocations: 1.828 MB / 4.692 GB, free: 44.78 MB / 0.7761 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 2.759e-05/14.07, allocations: 6.922 kB / 4.692 GB, free: 44.77 MB / 0.7761 GB
Notification: Performance of matching and sorting (n=430) (initialization): time 0.0116/14.08, allocations: 4.135 MB / 4.696 GB, free: 44.51 MB / 0.7761 GB
Notification: Performance of prepare postOptimizeDAE: time 4.22e-05/14.08, allocations: 9.375 kB / 4.696 GB, free: 44.51 MB / 0.7761 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.246e-05/14.08, allocations: 3.906 kB / 4.696 GB, free: 44.51 MB / 0.7761 GB
Notification: Performance of postOpt tearingSystem (initialization): time 6.113e-05/14.08, allocations: 21.72 kB / 4.696 GB, free: 44.51 MB / 0.7761 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.003987/14.08, allocations: 0.6974 MB / 4.697 GB, free: 44.51 MB / 0.7761 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.000104/14.08, allocations: 25.12 kB / 4.697 GB, free: 44.51 MB / 0.7761 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.005652/14.09, allocations: 429.5 kB / 4.697 GB, free: 44.36 MB / 0.7761 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.00108/14.09, allocations: 119.6 kB / 4.697 GB, free: 44.36 MB / 0.7761 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 22
 * Number of states: 0 ()
 * Number of discrete variables: 0 ()
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (430):
 * Single equations (assignments): 430
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of prepare postOptimizeDAE: time 0.003866/14.09, allocations: 0.7974 MB / 4.698 GB, free: 44.25 MB / 0.7761 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.001883/14.1, allocations: 295.4 kB / 4.698 GB, free: 44.11 MB / 0.7761 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01172/14.11, allocations: 4.402 MB / 4.703 GB, free: 43.91 MB / 0.7761 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 2.978e-05/14.11, allocations: 36.75 kB / 4.703 GB, free: 43.91 MB / 0.7761 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 2.141e-05/14.11, allocations: 7.109 kB / 4.703 GB, free: 43.91 MB / 0.7761 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.007635/14.12, allocations: 3.754 MB / 4.706 GB, free: 43.57 MB / 0.7761 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.02159/14.14, allocations: 8.579 MB / 4.715 GB, free: 42.78 MB / 0.7761 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.781e-05/14.14, allocations: 3.906 kB / 4.715 GB, free: 42.78 MB / 0.7761 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.004027/14.14, allocations: 0.7373 MB / 4.715 GB, free: 42.78 MB / 0.7761 GB
Notification: Performance of postOpt tearingSystem (simulation): time 7.304e-05/14.14, allocations: 17.44 kB / 4.715 GB, free: 42.78 MB / 0.7761 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0006159/14.14, allocations: 90.78 kB / 4.716 GB, free: 42.78 MB / 0.7761 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 4.454e-05/14.14, allocations: 16.09 kB / 4.716 GB, free: 42.78 MB / 0.7761 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 6.101e-06/14.14, allocations: 8.125 kB / 4.716 GB, free: 42.78 MB / 0.7761 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.0125/14.15, allocations: 6.935 MB / 4.722 GB, free: 39.84 MB / 0.7761 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0034/14.16, allocations: 0.8018 MB / 4.723 GB, free: 39.36 MB / 0.7761 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.00118/14.16, allocations: 71.59 kB / 4.723 GB, free: 39.31 MB / 0.7761 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.004339/14.16, allocations: 273.5 kB / 4.723 GB, free: 39.24 MB / 0.7761 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0004781/14.16, allocations: 223.9 kB / 4.724 GB, free: 39.21 MB / 0.7761 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0003975/14.16, allocations: 114.2 kB / 4.724 GB, free: 39.19 MB / 0.7761 GB
Notification: Performance of sorting global known variables: time 0.002934/14.17, allocations: 1.133 MB / 4.725 GB, free: 38.73 MB / 0.7761 GB
Notification: Performance of sort global known variables: time 3.2e-07/14.17, allocations: 0 / 4.725 GB, free: 38.73 MB / 0.7761 GB
Notification: Performance of remove unused functions: time 0.008577/14.18, allocations: 1.672 MB / 4.727 GB, free: 38.26 MB / 0.7761 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 11
 * Number of states: 20 (volBotEas.dynBal.U,volBotEas.dynBal.m,volBotEas.dynBal.mXi[1],oriOutBot.mExc,oriOutTop.mExc,oriWesTop.mExc,dooOpeClo.mExcAB,dooOpeClo.mExcBA,volBotWes.dynBal.U,volBotWes.dynBal.m,volBotWes.dynBal.mXi[1],oriEasTop.mExc,volTopEas.dynBal.U,volTopEas.dynBal.m,volTopEas.dynBal.mXi[1],volTopWes.dynBal.U,volTopWes.dynBal.m,volTopWes.dynBal.mXi[1],dooOpeCloTop.mExcAB,dooOpeCloTop.mExcBA)
 * Number of discrete variables: 0 ()
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (392):
 * Single equations (assignments): 392
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of Backend phase and start with SimCode phase: time 0.0111/14.19, allocations: 5.103 MB / 4.732 GB, free: 35.67 MB / 0.7761 GB
Notification: Performance of simCode: created initialization part: time 0.01012/14.2, allocations: 3.9 MB / 4.735 GB, free: 34.4 MB / 0.7761 GB
Notification: Performance of simCode: created event and clocks part: time 1.481e-05/14.2, allocations: 3.938 kB / 4.735 GB, free: 34.4 MB / 0.7761 GB
Notification: Performance of simCode: created simulation system equations: time 0.005161/14.2, allocations: 2.101 MB / 4.737 GB, free: 33.75 MB / 0.7761 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.009708/14.21, allocations: 1.485 MB / 4.739 GB, free: 33.45 MB / 0.7761 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.02311/14.24, allocations: 9.132 MB / 4.748 GB, free: 28.73 MB / 0.7761 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.004059/14.24, allocations: 2.26 MB / 4.75 GB, free: 27.05 MB / 0.7761 GB
Notification: Performance of simCode: alias equations: time 0.007189/14.25, allocations: 1.214 MB / 4.751 GB, free: 26.23 MB / 0.7761 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.002278/14.25, allocations: 277.2 kB / 4.751 GB, free: 25.98 MB / 0.7761 GB
Notification: Performance of SimCode: time 4.318e-06/14.25, allocations: 0 / 4.751 GB, free: 25.98 MB / 0.7761 GB
Notification: Performance of Templates: time 0.7889/15.04, allocations: 104.9 MB / 4.854 GB, free: 65.35 MB / 0.7917 GB
make -j1 -f BuildingSystems_BuildingSystems.Airflow.Multizone.Examples.ReverseBuoyancy.makefile
(rm -f BuildingSystems_BuildingSystems.Airflow.Multizone.Examples.ReverseBuoyancy.pipe ; mkfifo BuildingSystems_BuildingSystems.Airflow.Multizone.Examples.ReverseBuoyancy.pipe ; head -c 1048576 < BuildingSystems_BuildingSystems.Airflow.Multizone.Examples.ReverseBuoyancy.pipe >> ../files/BuildingSystems_BuildingSystems.Airflow.Multizone.Examples.ReverseBuoyancy.sim & ./BuildingSystems_BuildingSystems.Airflow.Multizone.Examples.ReverseBuoyancy  -abortSlowSimulation -alarm=480 -lv LOG_STATS > BuildingSystems_BuildingSystems.Airflow.Multizone.Examples.ReverseBuoyancy.pipe 2>&1)