Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr IDEAS_dev_IDEAS.Airflow.Multizone.Examples.ReverseBuoyancy.conf.json
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/IDEAS 3.0.0-master/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)
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 IDEAS with version 3.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0-master/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)
Running command: translateModel(IDEAS.Airflow.Multizone.Examples.ReverseBuoyancy,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.Airflow.Multizone.Examples.ReverseBuoyancy")
translateModel(IDEAS.Airflow.Multizone.Examples.ReverseBuoyancy,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.Airflow.Multizone.Examples.ReverseBuoyancy")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.008803/0.008803, allocations: 170.1 kB / 15.11 MB, free: 6.039 MB / 13.93 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0-master/package.mo): time 0.8407/0.8407, allocations: 135.2 MB / 151.1 MB, free: 13.8 MB / 122.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.654/1.654, allocations: 223.2 MB / 406.9 MB, free: 3.207 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.0009253/0.0009253, allocations: 106.4 kB / 489.9 MB, free: 10.91 MB / 362.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0004423/0.0004423, allocations: 8 kB / 0.5691 GB, free: 14.19 MB / 458.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.5759/0.5763, allocations: 82.31 MB / 0.6495 GB, free: 36.17 MB / 458.7 MB
Notification: Performance of FrontEnd - scodeFlatten: time 6.407/6.983, allocations: 1.901 GB / 2.55 GB, free: 74.83 MB / 0.6823 GB
Notification: Performance of FrontEnd - mkProgramGraph: time 0.0003394/6.983, allocations: 93.2 kB / 2.55 GB, free: 74.74 MB / 0.6823 GB
Notification: Performance of FrontEnd - DAE generated: time 8.253/15.24, allocations: 1.969 GB / 4.519 GB, free: 67.82 MB / 0.7761 GB
Notification: Performance of FrontEnd: time 1.453e-06/15.24, allocations: 1.5 kB / 4.519 GB, free: 67.82 MB / 0.7761 GB
Notification: Performance of Transformations before backend: time 0.000367/15.24, allocations: 87.34 kB / 4.52 GB, free: 67.82 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.02216/15.26, allocations: 4.785 MB / 4.524 GB, free: 66.54 MB / 0.7761 GB
Notification: Performance of prepare preOptimizeDAE: time 5.751e-05/15.26, allocations: 7.75 kB / 4.524 GB, free: 66.54 MB / 0.7761 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01064/15.27, allocations: 0.9959 MB / 4.525 GB, free: 66.33 MB / 0.7761 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.01169/15.28, allocations: 2.241 MB / 4.527 GB, free: 65.98 MB / 0.7761 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0004569/15.28, allocations: 247.4 kB / 4.528 GB, free: 65.98 MB / 0.7761 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.002034/15.28, allocations: 340.1 kB / 4.528 GB, free: 65.97 MB / 0.7761 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.01785/15.3, allocations: 4.14 MB / 4.532 GB, free: 65.65 MB / 0.7761 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0003959/15.3, allocations: 3.875 kB / 4.532 GB, free: 65.65 MB / 0.7761 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.001944/15.3, allocations: 138.4 kB / 4.532 GB, free: 65.65 MB / 0.7761 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0003062/15.3, allocations: 150.9 kB / 4.532 GB, free: 65.64 MB / 0.7761 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.01576/15.32, allocations: 4.634 MB / 4.537 GB, free: 65.61 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.0356/15.36, allocations: 14.69 MB / 4.551 GB, free: 58.9 MB / 0.7761 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.008385/15.36, allocations: 4.322 MB / 4.555 GB, free: 58.81 MB / 0.7761 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.001883/15.37, allocations: 1.612 MB / 4.557 GB, free: 57.12 MB / 0.7761 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 9.624e-05/15.37, allocations: 76.92 kB / 4.557 GB, free: 57.08 MB / 0.7761 GB
Notification: Performance of pre-optimization done (n=392): time 7.855e-06/15.37, allocations: 2.906 kB / 4.557 GB, free: 57.08 MB / 0.7761 GB
Notification: Performance of matching and sorting (n=392): time 0.01468/15.38, allocations: 5.491 MB / 4.562 GB, free: 56.79 MB / 0.7761 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 7.606e-05/15.38, allocations: 91.83 kB / 4.562 GB, free: 56.73 MB / 0.7761 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.003947/15.39, allocations: 1.455 MB / 4.564 GB, free: 56.53 MB / 0.7761 GB
Notification: Performance of collectPreVariables (initialization): time 0.0009146/15.39, allocations: 95.95 kB / 4.564 GB, free: 56.5 MB / 0.7761 GB
Notification: Performance of collectInitialEqns (initialization): time 0.001254/15.39, allocations: 1.142 MB / 4.565 GB, free: 56.07 MB / 0.7761 GB
Notification: Performance of collectInitialBindings (initialization): time 0.002201/15.39, allocations: 1.329 MB / 4.566 GB, free: 55.21 MB / 0.7761 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0006962/15.39, allocations: 70.06 kB / 4.566 GB, free: 55.21 MB / 0.7761 GB
Notification: Performance of setup shared object (initialization): time 0.0004748/15.39, allocations: 443.3 kB / 4.567 GB, free: 54.89 MB / 0.7761 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.003449/15.39, allocations: 1.539 MB / 4.568 GB, free: 54.89 MB / 0.7761 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.003765/15.4, allocations: 1.953 MB / 4.57 GB, free: 54.57 MB / 0.7761 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.003883/15.4, allocations: 1.841 MB / 4.572 GB, free: 54.53 MB / 0.7761 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 2.291e-05/15.4, allocations: 5.906 kB / 4.572 GB, free: 54.53 MB / 0.7761 GB
Notification: Performance of matching and sorting (n=430) (initialization): time 0.009366/15.41, allocations: 4.14 MB / 4.576 GB, free: 54.26 MB / 0.7761 GB
Notification: Performance of prepare postOptimizeDAE: time 3.99e-05/15.41, allocations: 7.656 kB / 4.576 GB, free: 54.26 MB / 0.7761 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.608e-05/15.41, allocations: 3.375 kB / 4.576 GB, free: 54.26 MB / 0.7761 GB
Notification: Performance of postOpt tearingSystem (initialization): time 5.952e-05/15.41, allocations: 21.81 kB / 4.576 GB, free: 54.26 MB / 0.7761 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.003422/15.42, allocations: 0.6991 MB / 4.577 GB, free: 54.26 MB / 0.7761 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 8.574e-05/15.42, allocations: 24.75 kB / 4.577 GB, free: 54.26 MB / 0.7761 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.004853/15.42, allocations: 426.4 kB / 4.577 GB, free: 54.12 MB / 0.7761 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.000715/15.42, allocations: 119.2 kB / 4.577 GB, free: 54.12 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.003268/15.42, allocations: 0.8012 MB / 4.578 GB, free: 54 MB / 0.7761 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.001707/15.43, allocations: 291.5 kB / 4.578 GB, free: 53.86 MB / 0.7761 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01124/15.44, allocations: 4.407 MB / 4.583 GB, free: 53.66 MB / 0.7761 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 3.54e-05/15.44, allocations: 38.91 kB / 4.583 GB, free: 53.66 MB / 0.7761 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 2.088e-05/15.44, allocations: 0 / 4.583 GB, free: 53.66 MB / 0.7761 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.006556/15.44, allocations: 3.757 MB / 4.586 GB, free: 53.32 MB / 0.7761 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.01933/15.46, allocations: 8.602 MB / 4.595 GB, free: 52.52 MB / 0.7761 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.831e-05/15.46, allocations: 2.438 kB / 4.595 GB, free: 52.52 MB / 0.7761 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.003725/15.47, allocations: 0.74 MB / 4.596 GB, free: 52.52 MB / 0.7761 GB
Notification: Performance of postOpt tearingSystem (simulation): time 7.065e-05/15.47, allocations: 18.03 kB / 4.596 GB, free: 52.52 MB / 0.7761 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0005066/15.47, allocations: 89.02 kB / 4.596 GB, free: 52.52 MB / 0.7761 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 4.037e-05/15.47, allocations: 15 kB / 4.596 GB, free: 52.52 MB / 0.7761 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 6.282e-06/15.47, allocations: 6.219 kB / 4.596 GB, free: 52.52 MB / 0.7761 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.0127/15.48, allocations: 6.943 MB / 4.602 GB, free: 51.73 MB / 0.7761 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.003651/15.48, allocations: 0.8004 MB / 4.603 GB, free: 51.44 MB / 0.7761 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.001414/15.49, allocations: 70.5 kB / 4.603 GB, free: 51.44 MB / 0.7761 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.004267/15.49, allocations: 264.7 kB / 4.604 GB, free: 51.42 MB / 0.7761 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0006218/15.49, allocations: 226.6 kB / 4.604 GB, free: 51.41 MB / 0.7761 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0004619/15.49, allocations: 114.8 kB / 4.604 GB, free: 51.41 MB / 0.7761 GB
Notification: Performance of sorting global known variables: time 0.002695/15.49, allocations: 1.147 MB / 4.605 GB, free: 51.27 MB / 0.7761 GB
Notification: Performance of sort global known variables: time 4.51e-07/15.49, allocations: 0 / 4.605 GB, free: 51.27 MB / 0.7761 GB
Notification: Performance of remove unused functions: time 0.007558/15.5, allocations: 1.667 MB / 4.607 GB, free: 51.14 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.00984/15.51, allocations: 5.105 MB / 4.612 GB, free: 48.64 MB / 0.7761 GB
Notification: Performance of simCode: created initialization part: time 0.009485/15.52, allocations: 3.899 MB / 4.615 GB, free: 48.57 MB / 0.7761 GB
Notification: Performance of simCode: created event and clocks part: time 1.525e-05/15.52, allocations: 4.844 kB / 4.615 GB, free: 48.57 MB / 0.7761 GB
Notification: Performance of simCode: created simulation system equations: time 0.005125/15.53, allocations: 2.093 MB / 4.617 GB, free: 48.55 MB / 0.7761 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.009717/15.54, allocations: 1.475 MB / 4.619 GB, free: 48.52 MB / 0.7761 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.02274/15.56, allocations: 9.154 MB / 4.628 GB, free: 45.26 MB / 0.7761 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.004004/15.56, allocations: 2.266 MB / 4.63 GB, free: 44.49 MB / 0.7761 GB
Notification: Performance of simCode: alias equations: time 0.008054/15.57, allocations: 1.205 MB / 4.631 GB, free: 44.46 MB / 0.7761 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.002312/15.57, allocations: 279 kB / 4.632 GB, free: 44.45 MB / 0.7761 GB
Notification: Performance of SimCode: time 1.162e-06/15.57, allocations: 0 / 4.632 GB, free: 44.45 MB / 0.7761 GB
Notification: Performance of Templates: time 0.1697/15.74, allocations: 104.9 MB / 4.734 GB, free: 34.22 MB / 0.7761 GB
make -j1 -f IDEAS_dev_IDEAS.Airflow.Multizone.Examples.ReverseBuoyancy.makefile
(rm -f IDEAS_dev_IDEAS.Airflow.Multizone.Examples.ReverseBuoyancy.pipe ; mkfifo IDEAS_dev_IDEAS.Airflow.Multizone.Examples.ReverseBuoyancy.pipe ; head -c 1048576 < IDEAS_dev_IDEAS.Airflow.Multizone.Examples.ReverseBuoyancy.pipe >> ../files/IDEAS_dev_IDEAS.Airflow.Multizone.Examples.ReverseBuoyancy.sim & ./IDEAS_dev_IDEAS.Airflow.Multizone.Examples.ReverseBuoyancy  -abortSlowSimulation -alarm=480 -lv LOG_STATS > IDEAS_dev_IDEAS.Airflow.Multizone.Examples.ReverseBuoyancy.pipe 2>&1)