Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr IDEAS_IDEAS.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 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0/package.mo", uses=false)
Using package IDEAS with version 3.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0/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(IDEAS.Airflow.Multizone.Examples.ReverseBuoyancy,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IDEAS_IDEAS.Airflow.Multizone.Examples.ReverseBuoyancy")
translateModel(IDEAS.Airflow.Multizone.Examples.ReverseBuoyancy,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IDEAS_IDEAS.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.000857/0.000857, allocations: 92.08 kB / 15.06 MB, free: 1.098 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.001103/0.001103, allocations: 172.7 kB / 15.95 MB, free: 208 kB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.232/1.232, allocations: 223.3 MB / 240 MB, free: 5.441 MB / 190.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0/package.mo): time 0.702/0.702, allocations: 132.3 MB / 423.4 MB, free: 2.09 MB / 350.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.0003182/0.0003183, allocations: 17.5 kB / 0.5034 GB, free: 4.242 MB / 366.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.3351/0.3354, allocations: 81.58 MB / 0.5831 GB, free: 3.961 MB / 430.1 MB
Notification: Performance of NFInst.instantiate(IDEAS.Airflow.Multizone.Examples.ReverseBuoyancy): time 0.5491/0.8846, allocations: 287.1 MB / 0.8634 GB, free: 8.688 MB / 0.6387 GB
Notification: Performance of NFInst.instExpressions: time 0.01781/0.9024, allocations: 17.33 MB / 0.8803 GB, free: 8.379 MB / 0.6387 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.002519/0.9049, allocations: 72.44 kB / 0.8804 GB, free: 8.379 MB / 0.6387 GB
Notification: Performance of NFTyping.typeComponents: time 0.003269/0.9082, allocations: 1.408 MB / 0.8818 GB, free: 8.352 MB / 0.6387 GB
Notification: Performance of NFTyping.typeBindings: time 0.01143/0.9197, allocations: 5.319 MB / 0.887 GB, free: 8.113 MB / 0.6387 GB
Notification: Performance of NFTyping.typeClassSections: time 0.005836/0.9255, allocations: 2.246 MB / 0.8892 GB, free: 8.059 MB / 0.6387 GB
Notification: Performance of NFFlatten.flatten: time 0.01009/0.9356, allocations: 10.97 MB / 0.8999 GB, free: 8.031 MB / 0.6387 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.003216/0.9389, allocations: 2.383 MB / 0.9022 GB, free: 23.18 MB / 0.6544 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.004072/0.943, allocations: 2.871 MB / 0.905 GB, free: 22.8 MB / 0.6544 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.003177/0.9461, allocations: 3.15 MB / 0.9081 GB, free: 22.2 MB / 0.6544 GB
Notification: Performance of NFPackage.collectConstants: time 0.0003373/0.9465, allocations: 196.4 kB / 0.9083 GB, free: 22.2 MB / 0.6544 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.007855/0.9544, allocations: 3.485 MB / 0.9117 GB, free: 21.55 MB / 0.6544 GB
Notification: Performance of NFScalarize.scalarize: time 0.001163/0.9555, allocations: 1.467 MB / 0.9131 GB, free: 21.05 MB / 0.6544 GB
Notification: Performance of NFVerifyModel.verify: time 0.001062/0.9566, allocations: 0.7995 MB / 0.9139 GB, free: 21.02 MB / 0.6544 GB
Notification: Performance of NFConvertDAE.convert: time 0.005485/0.9621, allocations: 5.395 MB / 0.9192 GB, free: 18.43 MB / 0.6544 GB
Notification: Performance of FrontEnd - DAE generated: time 5.02e-06/0.9621, allocations: 1.969 kB / 0.9192 GB, free: 18.43 MB / 0.6544 GB
Notification: Performance of FrontEnd: time 2.013e-06/0.9621, allocations: 0 / 0.9192 GB, free: 18.43 MB / 0.6544 GB
Notification: Performance of Transformations before backend: time 0.0001141/0.9622, allocations: 0 / 0.9192 GB, free: 18.43 MB / 0.6544 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.009528/0.9718, allocations: 4.357 MB / 0.9234 GB, free: 15.94 MB / 0.6544 GB
Notification: Performance of prepare preOptimizeDAE: time 3.154e-05/0.9718, allocations: 13.56 kB / 0.9234 GB, free: 15.93 MB / 0.6544 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.005666/0.9775, allocations: 1.006 MB / 0.9244 GB, free: 15.52 MB / 0.6544 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.002992/0.9805, allocations: 2.092 MB / 0.9265 GB, free: 14.66 MB / 0.6544 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.000117/0.9806, allocations: 242.2 kB / 0.9267 GB, free: 14.65 MB / 0.6544 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0003694/0.981, allocations: 332.6 kB / 0.927 GB, free: 14.64 MB / 0.6544 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.005766/0.9868, allocations: 4.209 MB / 0.9311 GB, free: 13.31 MB / 0.6544 GB
Notification: Performance of preOpt findStateOrder (simulation): time 6.44e-05/0.9868, allocations: 3.906 kB / 0.9311 GB, free: 13.31 MB / 0.6544 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0002729/0.9871, allocations: 140.5 kB / 0.9312 GB, free: 13.27 MB / 0.6544 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001501/0.9873, allocations: 170.6 kB / 0.9314 GB, free: 13.12 MB / 0.6544 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.006737/0.994, allocations: 4.748 MB / 0.936 GB, free: 9.77 MB / 0.6544 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.0151/1.009, allocations: 14.36 MB / 0.9501 GB, free: 13.5 MB / 0.67 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.005221/1.014, allocations: 4.506 MB / 0.9545 GB, free: 10.86 MB / 0.67 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.003056/1.017, allocations: 2.438 MB / 0.9569 GB, free: 9.297 MB / 0.67 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.001453/1.019, allocations: 1.61 MB / 0.9584 GB, free: 7.375 MB / 0.67 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 5.499e-05/1.019, allocations: 81.7 kB / 0.9585 GB, free: 7.312 MB / 0.67 GB
Notification: Performance of pre-optimization done (n=392): time 5.42e-06/1.019, allocations: 0 / 0.9585 GB, free: 7.312 MB / 0.67 GB
Notification: Performance of matching and sorting (n=392): time 0.008363/1.027, allocations: 5.498 MB / 0.9639 GB, free: 3.566 MB / 0.67 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 5.516e-05/1.027, allocations: 90.48 kB / 0.964 GB, free: 3.465 MB / 0.67 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002095/1.03, allocations: 1.679 MB / 0.9656 GB, free: 2.184 MB / 0.67 GB
Notification: Performance of collectPreVariables (initialization): time 0.0002154/1.03, allocations: 95.39 kB / 0.9657 GB, free: 2.137 MB / 0.67 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0006572/1.03, allocations: 1.135 MB / 0.9668 GB, free: 1.441 MB / 0.67 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0009815/1.031, allocations: 1.317 MB / 0.9681 GB, free: 316 kB / 0.67 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0001759/1.032, allocations: 69.88 kB / 0.9682 GB, free: 300 kB / 0.67 GB
Notification: Performance of setup shared object (initialization): time 0.0001896/1.032, allocations: 437.1 kB / 0.9686 GB, free: 15.91 MB / 0.6856 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.002202/1.034, allocations: 1.554 MB / 0.9701 GB, free: 14.91 MB / 0.6856 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.002444/1.036, allocations: 1.924 MB / 0.972 GB, free: 13.52 MB / 0.6856 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.002578/1.039, allocations: 1.823 MB / 0.9737 GB, free: 12.43 MB / 0.6856 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 8.877e-06/1.039, allocations: 4 kB / 0.9738 GB, free: 12.42 MB / 0.6856 GB
Notification: Performance of matching and sorting (n=430) (initialization): time 0.005874/1.045, allocations: 4.143 MB / 0.9778 GB, free: 9.621 MB / 0.6856 GB
Notification: Performance of prepare postOptimizeDAE: time 2.239e-05/1.045, allocations: 10.84 kB / 0.9778 GB, free: 9.613 MB / 0.6856 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.346e-05/1.045, allocations: 4 kB / 0.9778 GB, free: 9.609 MB / 0.6856 GB
Notification: Performance of postOpt tearingSystem (initialization): time 2.913e-05/1.045, allocations: 24 kB / 0.9778 GB, free: 9.586 MB / 0.6856 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002819/1.048, allocations: 0.6936 MB / 0.9785 GB, free: 8.957 MB / 0.6856 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.856e-05/1.048, allocations: 22.7 kB / 0.9785 GB, free: 8.938 MB / 0.6856 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002557/1.05, allocations: 437.6 kB / 0.979 GB, free: 8.562 MB / 0.6856 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.000212/1.051, allocations: 113 kB / 0.9791 GB, free: 8.477 MB / 0.6856 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.00121/1.052, allocations: 0.8014 MB / 0.9798 GB, free: 8.004 MB / 0.6856 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0003946/1.052, allocations: 292.5 kB / 0.9801 GB, free: 7.715 MB / 0.6856 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.006431/1.059, allocations: 4.404 MB / 0.9844 GB, free: 4.883 MB / 0.6856 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 2.533e-05/1.059, allocations: 36 kB / 0.9845 GB, free: 4.848 MB / 0.6856 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 9.177e-06/1.059, allocations: 0 / 0.9845 GB, free: 4.848 MB / 0.6856 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.004795/1.064, allocations: 3.776 MB / 0.9881 GB, free: 2.242 MB / 0.6856 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.01115/1.075, allocations: 8.587 MB / 0.9965 GB, free: 12.37 MB / 0.7012 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.019e-05/1.075, allocations: 4 kB / 0.9965 GB, free: 12.36 MB / 0.7012 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.003031/1.078, allocations: 0.7321 MB / 0.9972 GB, free: 11.7 MB / 0.7012 GB
Notification: Performance of postOpt tearingSystem (simulation): time 1.919e-05/1.078, allocations: 19.98 kB / 0.9973 GB, free: 11.68 MB / 0.7012 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0001856/1.078, allocations: 84.97 kB / 0.9973 GB, free: 11.64 MB / 0.7012 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 1.79e-05/1.078, allocations: 18.34 kB / 0.9974 GB, free: 11.62 MB / 0.7012 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 3.887e-06/1.078, allocations: 4 kB / 0.9974 GB, free: 11.62 MB / 0.7012 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.008281/1.086, allocations: 6.798 MB / 1.004 GB, free: 7.055 MB / 0.7012 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.001253/1.088, allocations: 0.7964 MB / 1.005 GB, free: 6.414 MB / 0.7012 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0003651/1.088, allocations: 67.19 kB / 1.005 GB, free: 6.398 MB / 0.7012 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001972/1.09, allocations: 271.8 kB / 1.005 GB, free: 6.184 MB / 0.7012 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0003355/1.09, allocations: 238 kB / 1.005 GB, free: 5.98 MB / 0.7012 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0002056/1.091, allocations: 113.9 kB / 1.005 GB, free: 5.895 MB / 0.7012 GB
Notification: Performance of sorting global known variables: time 0.001312/1.092, allocations: 1.136 MB / 1.007 GB, free: 5.051 MB / 0.7012 GB
Notification: Performance of sort global known variables: time 1.9e-07/1.092, allocations: 3 kB / 1.007 GB, free: 5.051 MB / 0.7012 GB
Notification: Performance of remove unused functions: time 0.002177/1.094, allocations: 1.229 MB / 1.008 GB, free: 3.934 MB / 0.7012 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.0007385/1.095, allocations: 472 kB / 1.008 GB, free: 3.59 MB / 0.7012 GB
Notification: Performance of simCode: created initialization part: time 0.004963/1.1, allocations: 3.905 MB / 1.012 GB, free: 0.9258 MB / 0.7012 GB
Notification: Performance of simCode: created event and clocks part: time 2.726e-06/1.1, allocations: 0 / 1.012 GB, free: 0.9258 MB / 0.7012 GB
Notification: Performance of simCode: created simulation system equations: time 0.002575/1.102, allocations: 2.143 MB / 1.014 GB, free: 15.5 MB / 0.7169 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.005437/1.108, allocations: 1.537 MB / 1.016 GB, free: 14.3 MB / 0.7169 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.01059/1.118, allocations: 9.185 MB / 1.025 GB, free: 5.699 MB / 0.7169 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001615/1.12, allocations: 2.205 MB / 1.027 GB, free: 3.457 MB / 0.7169 GB
Notification: Performance of simCode: alias equations: time 0.003542/1.124, allocations: 1.197 MB / 1.028 GB, free: 2.254 MB / 0.7169 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0008663/1.124, allocations: 274.9 kB / 1.028 GB, free: 1.988 MB / 0.7169 GB
Notification: Performance of SimCode: time 8.62e-07/1.124, allocations: 0 / 1.028 GB, free: 1.988 MB / 0.7169 GB
Notification: Performance of Templates: time 0.08049/1.205, allocations: 57.05 MB / 1.084 GB, free: 9.801 MB / 0.7794 GB
make -j1 -f IDEAS_IDEAS.Airflow.Multizone.Examples.ReverseBuoyancy.makefile
(rm -f IDEAS_IDEAS.Airflow.Multizone.Examples.ReverseBuoyancy.pipe ; mkfifo IDEAS_IDEAS.Airflow.Multizone.Examples.ReverseBuoyancy.pipe ; head -c 1048576 < IDEAS_IDEAS.Airflow.Multizone.Examples.ReverseBuoyancy.pipe >> ../files/IDEAS_IDEAS.Airflow.Multizone.Examples.ReverseBuoyancy.sim & ./IDEAS_IDEAS.Airflow.Multizone.Examples.ReverseBuoyancy  -abortSlowSimulation -alarm=480 -lv LOG_STATS > IDEAS_IDEAS.Airflow.Multizone.Examples.ReverseBuoyancy.pipe 2>&1)