Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Annex60_1.0.0_Annex60.Airflow.Multizone.Examples.ReverseBuoyancy.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 3.2.3+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Annex60 1.0.0/package.mo", uses=false)
Using package Annex60 with version 1.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Annex60 1.0.0/package.mo)
Using package Modelica with version 3.2.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+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(Annex60.Airflow.Multizone.Examples.ReverseBuoyancy,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Annex60_1.0.0_Annex60.Airflow.Multizone.Examples.ReverseBuoyancy")
translateModel(Annex60.Airflow.Multizone.Examples.ReverseBuoyancy,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Annex60_1.0.0_Annex60.Airflow.Multizone.Examples.ReverseBuoyancy")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001232/0.001232, allocations: 108 kB / 15.6 MB, free: 132 kB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001607/0.001607, allocations: 199.7 kB / 16.54 MB, free: 6.672 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 1.44/1.44, allocations: 205.1 MB / 222.4 MB, free: 4.625 MB / 174.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Annex60 1.0.0/package.mo): time 0.406/0.406, allocations: 54.95 MB / 324.7 MB, free: 15.99 MB / 270.1 MB
Notification: Modelica requested package Complex of version 3.2.3. Complex 4.0.0 is used instead which states that it is fully compatible without conversion script needed.
Notification: Modelica requested package ModelicaServices of version 3.2.3. ModelicaServices 4.0.0 is used instead which states that it is fully compatible without conversion script needed.
Notification: Annex60 requested package Modelica of version 3.2.2. Modelica 3.2.3 is used instead which states that it is fully compatible without conversion script needed.
Notification: Performance of FrontEnd - loaded program: time 0.001433/0.001433, allocations: 67.91 kB / 395.3 MB, free: 11.82 MB / 334.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1074/0.1089, allocations: 59.6 MB / 454.9 MB, free: 156 kB / 382.1 MB
Notification: Performance of NFInst.instantiate(Annex60.Airflow.Multizone.Examples.ReverseBuoyancy): time 0.7565/0.8654, allocations: 314.2 MB / 0.7511 GB, free: 14.7 MB / 0.5137 GB
Notification: Performance of NFInst.instExpressions: time 0.02487/0.8903, allocations: 18.38 MB / 0.769 GB, free: 5.688 MB / 0.5137 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.004259/0.8946, allocations: 87.94 kB / 0.7691 GB, free: 5.629 MB / 0.5137 GB
Notification: Performance of NFTyping.typeComponents: time 0.005457/0.9001, allocations: 2.179 MB / 0.7712 GB, free: 4.23 MB / 0.5137 GB
Notification: Performance of NFTyping.typeBindings: time 0.01976/0.9199, allocations: 7.271 MB / 0.7783 GB, free: 15.38 MB / 0.5294 GB
Notification: Performance of NFTyping.typeClassSections: time 0.008547/0.9285, allocations: 3.387 MB / 0.7817 GB, free: 12.67 MB / 0.5294 GB
Notification: Performance of NFFlatten.flatten: time 0.0131/0.9416, allocations: 9.58 MB / 0.791 GB, free: 3.883 MB / 0.5294 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.005076/0.9467, allocations: 3.231 MB / 0.7942 GB, free: 0.6562 MB / 0.5294 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.006768/0.9535, allocations: 3.59 MB / 0.7977 GB, free: 13.26 MB / 0.545 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.006344/0.9599, allocations: 3.334 MB / 0.8009 GB, free: 10.2 MB / 0.545 GB
Notification: Performance of NFPackage.collectConstants: time 0.001322/0.9612, allocations: 420 kB / 0.8013 GB, free: 9.789 MB / 0.545 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.01474/0.9759, allocations: 6.601 MB / 0.8078 GB, free: 4.004 MB / 0.545 GB
Notification: Performance of NFScalarize.scalarize: time 0.002988/0.979, allocations: 1.675 MB / 0.8094 GB, free: 2.324 MB / 0.545 GB
Notification: Performance of NFVerifyModel.verify: time 0.005934/0.9849, allocations: 2.291 MB / 0.8116 GB, free: 24 kB / 0.545 GB
Notification: Performance of NFConvertDAE.convert: time 0.01617/1.001, allocations: 8.096 MB / 0.8196 GB, free: 7.902 MB / 0.5606 GB
Notification: Performance of FrontEnd - DAE generated: time 6.532e-06/1.001, allocations: 4 kB / 0.8196 GB, free: 7.898 MB / 0.5606 GB
Notification: Performance of FrontEnd: time 1.583e-06/1.001, allocations: 0 / 0.8196 GB, free: 7.898 MB / 0.5606 GB
Notification: Performance of Transformations before backend: time 0.0001736/1.001, allocations: 0 / 0.8196 GB, free: 7.898 MB / 0.5606 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 830
 * Number of variables: 830
Notification: Performance of Generate backend data structure: time 0.01448/1.016, allocations: 4.946 MB / 0.8244 GB, free: 2.883 MB / 0.5606 GB
Notification: Performance of prepare preOptimizeDAE: time 4.171e-05/1.016, allocations: 8.031 kB / 0.8244 GB, free: 2.875 MB / 0.5606 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.006574/1.022, allocations: 0.9516 MB / 0.8253 GB, free: 1.918 MB / 0.5606 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.004119/1.027, allocations: 2.052 MB / 0.8273 GB, free: 15.81 MB / 0.5762 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001801/1.027, allocations: 242.3 kB / 0.8276 GB, free: 15.57 MB / 0.5762 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0005286/1.027, allocations: 327.9 kB / 0.8279 GB, free: 15.25 MB / 0.5762 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.007164/1.034, allocations: 4.231 MB / 0.832 GB, free: 10.95 MB / 0.5762 GB
Notification: Performance of preOpt findStateOrder (simulation): time 7.146e-05/1.035, allocations: 7.906 kB / 0.832 GB, free: 10.94 MB / 0.5762 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0003362/1.035, allocations: 135.9 kB / 0.8321 GB, free: 10.8 MB / 0.5762 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001661/1.035, allocations: 162.3 kB / 0.8323 GB, free: 10.64 MB / 0.5762 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.007339/1.042, allocations: 4.635 MB / 0.8368 GB, free: 6 MB / 0.5762 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.01961/1.062, allocations: 14.18 MB / 0.8507 GB, free: 6.852 MB / 0.5919 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.006848/1.069, allocations: 4.114 MB / 0.8547 GB, free: 2.746 MB / 0.5919 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.003322/1.072, allocations: 2.383 MB / 0.857 GB, free: 364 kB / 0.5919 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.001413/1.074, allocations: 1.347 MB / 0.8583 GB, free: 14.73 MB / 0.6075 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 6.259e-05/1.074, allocations: 81.48 kB / 0.8584 GB, free: 14.64 MB / 0.6075 GB
Notification: Performance of pre-optimization done (n=373): time 4.909e-06/1.074, allocations: 0 / 0.8584 GB, free: 14.64 MB / 0.6075 GB
Notification: Performance of matching and sorting (n=373): time 0.008794/1.083, allocations: 5.344 MB / 0.8636 GB, free: 9.27 MB / 0.6075 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 8.781e-05/1.083, allocations: 116 kB / 0.8637 GB, free: 9.137 MB / 0.6075 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002119/1.085, allocations: 1.555 MB / 0.8653 GB, free: 7.535 MB / 0.6075 GB
Notification: Performance of collectPreVariables (initialization): time 0.0002479/1.085, allocations: 93.7 kB / 0.8653 GB, free: 7.438 MB / 0.6075 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0007405/1.086, allocations: 1.103 MB / 0.8664 GB, free: 6.32 MB / 0.6075 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0009718/1.087, allocations: 1.251 MB / 0.8676 GB, free: 5.051 MB / 0.6075 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0008443/1.088, allocations: 0.5463 MB / 0.8682 GB, free: 4.496 MB / 0.6075 GB
Notification: Performance of setup shared object (initialization): time 9.376e-05/1.088, allocations: 305.1 kB / 0.8685 GB, free: 4.195 MB / 0.6075 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.002391/1.09, allocations: 1.517 MB / 0.87 GB, free: 2.676 MB / 0.6075 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.002626/1.093, allocations: 1.881 MB / 0.8718 GB, free: 0.7148 MB / 0.6075 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.2135/1.306, allocations: 3.636 MB / 0.8753 GB, free: 257.3 MB / 0.6075 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.721e-05/1.306, allocations: 0 / 0.8753 GB, free: 257.3 MB / 0.6075 GB
Notification: Performance of matching and sorting (n=412) (initialization): time 0.006659/1.313, allocations: 4.041 MB / 0.8793 GB, free: 257.2 MB / 0.6075 GB
Notification: Performance of prepare postOptimizeDAE: time 2.988e-05/1.313, allocations: 7.312 kB / 0.8793 GB, free: 257.2 MB / 0.6075 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.538e-05/1.313, allocations: 5.312 kB / 0.8793 GB, free: 257.2 MB / 0.6075 GB
Notification: Performance of postOpt tearingSystem (initialization): time 3.494e-05/1.313, allocations: 18.66 kB / 0.8793 GB, free: 257.2 MB / 0.6075 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002931/1.316, allocations: 0.6768 MB / 0.88 GB, free: 257.1 MB / 0.6075 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.795e-05/1.316, allocations: 19.12 kB / 0.88 GB, free: 257.1 MB / 0.6075 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002337/1.319, allocations: 251 kB / 0.8802 GB, free: 257.1 MB / 0.6075 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001972/1.319, allocations: 112.8 kB / 0.8803 GB, free: 257.1 MB / 0.6075 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 20
 * 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 (412):
 * Single equations (assignments): 412
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of prepare postOptimizeDAE: time 0.001252/1.32, allocations: 0.7702 MB / 0.8811 GB, free: 256.7 MB / 0.6075 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0004648/1.32, allocations: 284.7 kB / 0.8814 GB, free: 256.7 MB / 0.6075 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.00606/1.327, allocations: 4.417 MB / 0.8857 GB, free: 254.9 MB / 0.6075 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 2.656e-05/1.327, allocations: 38.45 kB / 0.8857 GB, free: 254.9 MB / 0.6075 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.065e-05/1.327, allocations: 0 / 0.8857 GB, free: 254.9 MB / 0.6075 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.004554/1.331, allocations: 3.768 MB / 0.8894 GB, free: 253.3 MB / 0.6075 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.01206/1.343, allocations: 8.536 MB / 0.8977 GB, free: 249.7 MB / 0.6075 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.12e-05/1.343, allocations: 2.719 kB / 0.8977 GB, free: 249.7 MB / 0.6075 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.003377/1.347, allocations: 0.7283 MB / 0.8984 GB, free: 249.7 MB / 0.6075 GB
Notification: Performance of postOpt tearingSystem (simulation): time 2.448e-05/1.347, allocations: 15.94 kB / 0.8985 GB, free: 249.7 MB / 0.6075 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.000206/1.347, allocations: 86.8 kB / 0.8985 GB, free: 249.7 MB / 0.6075 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 2.642e-05/1.347, allocations: 16.06 kB / 0.8986 GB, free: 249.7 MB / 0.6075 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.002e-05/1.347, allocations: 4.438 kB / 0.8986 GB, free: 249.7 MB / 0.6075 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.01021/1.357, allocations: 6.776 MB / 0.9052 GB, free: 246.7 MB / 0.6075 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.002256/1.359, allocations: 0.7955 MB / 0.906 GB, free: 246.3 MB / 0.6075 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0004641/1.36, allocations: 71 kB / 0.906 GB, free: 246.2 MB / 0.6075 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.002138/1.362, allocations: 94.77 kB / 0.9061 GB, free: 246.2 MB / 0.6075 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0004555/1.363, allocations: 234 kB / 0.9063 GB, free: 246.1 MB / 0.6075 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0002316/1.363, allocations: 121.6 kB / 0.9065 GB, free: 246.1 MB / 0.6075 GB
Notification: Performance of sorting global known variables: time 0.001431/1.364, allocations: 1.056 MB / 0.9075 GB, free: 245.7 MB / 0.6075 GB
Notification: Performance of sort global known variables: time 1.4e-07/1.364, allocations: 0 / 0.9075 GB, free: 245.7 MB / 0.6075 GB
Notification: Performance of remove unused functions: time 0.00275/1.367, allocations: 1.223 MB / 0.9087 GB, free: 245.4 MB / 0.6075 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 10
 * 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 (393):
 * Single equations (assignments): 393
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of Backend phase and start with SimCode phase: time 0.0008487/1.368, allocations: 470.8 kB / 0.9091 GB, free: 245.3 MB / 0.6075 GB
Notification: Performance of simCode: created initialization part: time 0.01965/1.387, allocations: 9.33 MB / 0.9182 GB, free: 244 MB / 0.6075 GB
Notification: Performance of simCode: created event and clocks part: time 1.095e-05/1.388, allocations: 0.5625 kB / 0.9182 GB, free: 244 MB / 0.6075 GB
Notification: Performance of simCode: created simulation system equations: time 0.002763/1.39, allocations: 2.146 MB / 0.9203 GB, free: 243.3 MB / 0.6075 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.006817/1.397, allocations: 1.635 MB / 0.9219 GB, free: 242.9 MB / 0.6075 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.009885/1.407, allocations: 7.682 MB / 0.9294 GB, free: 238.7 MB / 0.6075 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001653/1.409, allocations: 2.167 MB / 0.9316 GB, free: 237 MB / 0.6075 GB
Notification: Performance of simCode: alias equations: time 0.00441/1.413, allocations: 1.139 MB / 0.9327 GB, free: 236.2 MB / 0.6075 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.000945/1.414, allocations: 270.4 kB / 0.9329 GB, free: 235.9 MB / 0.6075 GB
Notification: Performance of SimCode: time 1.122e-06/1.414, allocations: 4 kB / 0.9329 GB, free: 235.9 MB / 0.6075 GB
Notification: Performance of Templates: time 0.08361/1.498, allocations: 64.43 MB / 0.9958 GB, free: 175.5 MB / 0.6075 GB
make -j1 -f Annex60_1.0.0_Annex60.Airflow.Multizone.Examples.ReverseBuoyancy.makefile
(rm -f Annex60_1.0.0_Annex60.Airflow.Multizone.Examples.ReverseBuoyancy.pipe ; mkfifo Annex60_1.0.0_Annex60.Airflow.Multizone.Examples.ReverseBuoyancy.pipe ; head -c 1048576 < Annex60_1.0.0_Annex60.Airflow.Multizone.Examples.ReverseBuoyancy.pipe >> ../files/Annex60_1.0.0_Annex60.Airflow.Multizone.Examples.ReverseBuoyancy.sim & ./Annex60_1.0.0_Annex60.Airflow.Multizone.Examples.ReverseBuoyancy  -abortSlowSimulation -alarm=480 -lv LOG_STATS > Annex60_1.0.0_Annex60.Airflow.Multizone.Examples.ReverseBuoyancy.pipe 2>&1)