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/Annex60 1.0.0/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.2+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.2+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.2+maint.om/package.mo", uses=false)
Using package ModelicaServices with version 3.2.2 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.2+maint.om/package.mo)
Using package Modelica with version 3.2.2 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.2+maint.om/package.mo)
Using package Complex with version 3.2.2 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.2+maint.om/package.mo)
Using package Annex60 with version 1.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Annex60 1.0.0/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/Annex60 1.0.0/package.mo): time 0.3722/0.3722, allocations: 55.01 MB / 69.96 MB, free: 8.691 MB / 58.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.2+maint.om/package.mo): time 0.001743/0.001743, allocations: 185.7 kB / 83.97 MB, free: 10.86 MB / 74.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.2+maint.om/package.mo): time 2.164/2.164, allocations: 194.4 MB / 292.3 MB, free: 3.602 MB / 218.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.2+maint.om/package.mo): time 0.001653/0.001653, allocations: 116.7 kB / 350.7 MB, free: 9.102 MB / 282.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0005064/0.0005064, allocations: 16 kB / 418.9 MB, free: 37.02 MB / 298.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1653/0.1658, allocations: 57.65 MB / 476.5 MB, free: 11.3 MB / 330.7 MB
Notification: Performance of FrontEnd - scodeFlatten: time 5.968/6.134, allocations: 2.148 GB / 2.613 GB, free: 34.25 MB / 0.4948 GB
Notification: Performance of FrontEnd - mkProgramGraph: time 0.0002785/6.134, allocations: 89.03 kB / 2.613 GB, free: 34.16 MB / 0.4948 GB
Notification: Performance of FrontEnd - DAE generated: time 6.961/13.1, allocations: 1.704 GB / 4.317 GB, free: 42.29 MB / 0.5886 GB
Notification: Performance of FrontEnd: time 1.894e-06/13.1, allocations: 0 / 4.317 GB, free: 42.29 MB / 0.5886 GB
Notification: Performance of Transformations before backend: time 0.0003539/13.1, allocations: 87.14 kB / 4.317 GB, free: 42.29 MB / 0.5886 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.02317/13.12, allocations: 4.767 MB / 4.322 GB, free: 40.89 MB / 0.5886 GB
Notification: Performance of prepare preOptimizeDAE: time 6.105e-05/13.12, allocations: 12.47 kB / 4.322 GB, free: 40.89 MB / 0.5886 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.009457/13.13, allocations: 0.9844 MB / 4.323 GB, free: 40.69 MB / 0.5886 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.007997/13.14, allocations: 2.347 MB / 4.325 GB, free: 40.21 MB / 0.5886 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0002226/13.14, allocations: 250.5 kB / 4.326 GB, free: 40.2 MB / 0.5886 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0008942/13.14, allocations: 327.2 kB / 4.326 GB, free: 40.2 MB / 0.5886 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.007707/13.15, allocations: 4.131 MB / 4.33 GB, free: 39.9 MB / 0.5886 GB
Notification: Performance of preOpt findStateOrder (simulation): time 8.267e-05/13.15, allocations: 14.89 kB / 4.33 GB, free: 39.89 MB / 0.5886 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0003983/13.15, allocations: 137.6 kB / 4.33 GB, free: 39.89 MB / 0.5886 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.000142/13.15, allocations: 148.7 kB / 4.33 GB, free: 39.89 MB / 0.5886 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.007799/13.15, allocations: 4.493 MB / 4.335 GB, free: 39.86 MB / 0.5886 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.02164/13.18, allocations: 14.36 MB / 4.349 GB, free: 33.38 MB / 0.5886 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.005701/13.18, allocations: 3.812 MB / 4.352 GB, free: 33.3 MB / 0.5886 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.00111/13.18, allocations: 1.348 MB / 4.354 GB, free: 31.89 MB / 0.5886 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 6.431e-05/13.18, allocations: 72.94 kB / 4.354 GB, free: 31.84 MB / 0.5886 GB
Notification: Performance of pre-optimization done (n=373): time 5.581e-06/13.18, allocations: 1.219 kB / 4.354 GB, free: 31.84 MB / 0.5886 GB
Notification: Performance of matching and sorting (n=373): time 0.008931/13.19, allocations: 5.3 MB / 4.359 GB, free: 31.57 MB / 0.5886 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 6.766e-05/13.19, allocations: 122.2 kB / 4.359 GB, free: 31.47 MB / 0.5886 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002379/13.19, allocations: 1.342 MB / 4.36 GB, free: 31.27 MB / 0.5886 GB
Notification: Performance of collectPreVariables (initialization): time 0.0003979/13.19, allocations: 92.36 kB / 4.361 GB, free: 31.23 MB / 0.5886 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0007972/13.2, allocations: 1.095 MB / 4.362 GB, free: 30.81 MB / 0.5886 GB
Notification: Performance of collectInitialBindings (initialization): time 0.001316/13.2, allocations: 1.255 MB / 4.363 GB, free: 29.99 MB / 0.5886 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0001922/13.2, allocations: 65.38 kB / 4.363 GB, free: 29.99 MB / 0.5886 GB
Notification: Performance of setup shared object (initialization): time 0.0001831/13.2, allocations: 435.5 kB / 4.363 GB, free: 29.68 MB / 0.5886 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.002284/13.2, allocations: 1.502 MB / 4.365 GB, free: 29.67 MB / 0.5886 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.002498/13.2, allocations: 1.893 MB / 4.367 GB, free: 29.37 MB / 0.5886 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.003338/13.21, allocations: 1.77 MB / 4.368 GB, free: 29.33 MB / 0.5886 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.629e-05/13.21, allocations: 2.094 kB / 4.368 GB, free: 29.33 MB / 0.5886 GB
Notification: Performance of matching and sorting (n=412) (initialization): time 0.0107/13.22, allocations: 4.016 MB / 4.372 GB, free: 29.07 MB / 0.5886 GB
Notification: Performance of prepare postOptimizeDAE: time 4.162e-05/13.22, allocations: 10.27 kB / 4.372 GB, free: 29.07 MB / 0.5886 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.746e-05/13.22, allocations: 3.188 kB / 4.372 GB, free: 29.07 MB / 0.5886 GB
Notification: Performance of postOpt tearingSystem (initialization): time 5.098e-05/13.22, allocations: 19.31 kB / 4.372 GB, free: 29.07 MB / 0.5886 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.005591/13.22, allocations: 0.6782 MB / 4.373 GB, free: 29.07 MB / 0.5886 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 9.41e-05/13.22, allocations: 22.94 kB / 4.373 GB, free: 29.07 MB / 0.5886 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.006991/13.23, allocations: 428.9 kB / 4.373 GB, free: 28.93 MB / 0.5886 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001002/13.23, allocations: 116.1 kB / 4.373 GB, free: 28.93 MB / 0.5886 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 (linear and non-linear blocks): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of prepare postOptimizeDAE: time 0.003669/13.23, allocations: 0.767 MB / 4.374 GB, free: 28.81 MB / 0.5886 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.001323/13.23, allocations: 284.4 kB / 4.375 GB, free: 28.67 MB / 0.5886 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.0121/13.25, allocations: 4.401 MB / 4.379 GB, free: 28.48 MB / 0.5886 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 5.5e-05/13.25, allocations: 36.53 kB / 4.379 GB, free: 28.48 MB / 0.5886 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 2.1e-05/13.25, allocations: 6.062 kB / 4.379 GB, free: 28.48 MB / 0.5886 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.008706/13.26, allocations: 3.737 MB / 4.382 GB, free: 28.14 MB / 0.5886 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.01862/13.27, allocations: 8.52 MB / 4.391 GB, free: 27.36 MB / 0.5886 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.135e-05/13.27, allocations: 0 / 4.391 GB, free: 27.36 MB / 0.5886 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.003718/13.28, allocations: 0.7299 MB / 4.392 GB, free: 27.36 MB / 0.5886 GB
Notification: Performance of postOpt tearingSystem (simulation): time 3.629e-05/13.28, allocations: 16.38 kB / 4.392 GB, free: 27.36 MB / 0.5886 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0003052/13.28, allocations: 87.81 kB / 4.392 GB, free: 27.36 MB / 0.5886 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 1.823e-05/13.28, allocations: 20.58 kB / 4.392 GB, free: 27.36 MB / 0.5886 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 4.007e-06/13.28, allocations: 3.25 kB / 4.392 GB, free: 27.36 MB / 0.5886 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.01001/13.29, allocations: 6.87 MB / 4.398 GB, free: 26.6 MB / 0.5886 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.003827/13.29, allocations: 0.799 MB / 4.399 GB, free: 26.32 MB / 0.5886 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.001158/13.29, allocations: 72.64 kB / 4.399 GB, free: 26.32 MB / 0.5886 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.004332/13.3, allocations: 282.7 kB / 4.399 GB, free: 26.3 MB / 0.5886 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.000455/13.3, allocations: 223.9 kB / 4.4 GB, free: 26.29 MB / 0.5886 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0003115/13.3, allocations: 126.8 kB / 4.4 GB, free: 26.29 MB / 0.5886 GB
Notification: Performance of sorting global known variables: time 0.001817/13.3, allocations: 1.042 MB / 4.401 GB, free: 26.14 MB / 0.5886 GB
Notification: Performance of sort global known variables: time 4.21e-07/13.3, allocations: 3.844 kB / 4.401 GB, free: 26.14 MB / 0.5886 GB
Notification: Performance of remove unused functions: time 0.007969/13.31, allocations: 1.658 MB / 4.402 GB, free: 26.02 MB / 0.5886 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 (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.00936/13.32, allocations: 5.106 MB / 4.407 GB, free: 23.52 MB / 0.5886 GB
Notification: Performance of simCode: created initialization part: time 0.008216/13.33, allocations: 3.827 MB / 4.411 GB, free: 23.45 MB / 0.5886 GB
Notification: Performance of simCode: created event and clocks part: time 1.361e-05/13.33, allocations: 2.406 kB / 4.411 GB, free: 23.45 MB / 0.5886 GB
Notification: Performance of simCode: created simulation system equations: time 0.003542/13.33, allocations: 2.091 MB / 4.413 GB, free: 23.43 MB / 0.5886 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.008136/13.34, allocations: 1.499 MB / 4.415 GB, free: 23.39 MB / 0.5886 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.01433/13.35, allocations: 9.079 MB / 4.424 GB, free: 20.15 MB / 0.5886 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001661/13.35, allocations: 2.231 MB / 4.426 GB, free: 19.38 MB / 0.5886 GB
Notification: Performance of simCode: alias equations: time 0.005325/13.36, allocations: 1.147 MB / 4.427 GB, free: 19.35 MB / 0.5886 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.001253/13.36, allocations: 281.2 kB / 4.427 GB, free: 19.34 MB / 0.5886 GB
Notification: Performance of SimCode: time 1.042e-06/13.36, allocations: 3.844 kB / 4.427 GB, free: 19.34 MB / 0.5886 GB
Notification: Performance of Templates: time 0.5939/13.95, allocations: 106.9 MB / 4.531 GB, free: 56.03 MB / 0.6042 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)