Running: ./testmodel.py --libraries=/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_master_Buildings.Airflow.Multizone.Examples.ReverseBuoyancy3Zones.conf.json
Using package ModelicaServices with version 3.2.3 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo)
Using package Modelica with version 3.2.3 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo)
Using package Complex with version 3.2.3 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo)
Using package Buildings with version 9.0.0 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 9.0.0-master/package.mo)
Running command: translateModel(Buildings.Airflow.Multizone.Examples.ReverseBuoyancy3Zones,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Buildings_master_Buildings.Airflow.Multizone.Examples.ReverseBuoyancy3Zones")
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 9.0.0-master/package.mo): time 5.075/5.075, allocations: 0.5623 GB / 0.5776 GB, free: 3.391 MB / 474.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo): time 0.002551/0.002551, allocations: 356 kB / 0.6447 GB, free: 185.7 MB / 474.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 4.097/4.097, allocations: 410.7 MB / 1.113 GB, free: 5.984 MB / 0.6042 GB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo): time 0.001899/0.001899, allocations: 186.9 kB / 1.226 GB, free: 6.18 MB / 0.7136 GB
Notification: Performance of FrontEnd - loaded program: time 0.0007152/0.0007155, allocations: 15.98 kB / 1.349 GB, free: 8.312 MB / 0.8386 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.7173/0.7181, allocations: 115.3 MB / 1.461 GB, free: 284.4 MB / 0.8542 GB
Notification: Performance of NFInst.instantiate(Buildings.Airflow.Multizone.Examples.ReverseBuoyancy3Zones): time 0.313/1.031, allocations: 262.1 MB / 1.717 GB, free: 22.09 MB / 0.8542 GB
Notification: Performance of NFInst.instExpressions: time 0.03117/1.062, allocations: 18.31 MB / 1.735 GB, free: 3.746 MB / 0.8542 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.003478/1.066, allocations: 63.62 kB / 1.735 GB, free: 3.684 MB / 0.8542 GB
Notification: Performance of NFTyping.typeComponents: time 0.006009/1.072, allocations: 1.456 MB / 1.737 GB, free: 2.219 MB / 0.8542 GB
Notification: Performance of NFTyping.typeBindings: time 0.7801/1.852, allocations: 5.25 MB / 1.742 GB, free: 13.77 MB / 0.8542 GB
Notification: Performance of NFTyping.typeClassSections: time 0.008597/1.861, allocations: 2.188 MB / 1.744 GB, free: 13.73 MB / 0.8542 GB
Notification: Performance of NFFlatten.flatten: time 0.01307/1.874, allocations: 9.298 MB / 1.753 GB, free: 13.72 MB / 0.8542 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.00413/1.878, allocations: 1.893 MB / 1.755 GB, free: 13.49 MB / 0.8542 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.00715/1.885, allocations: 2.534 MB / 1.757 GB, free: 13.48 MB / 0.8542 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.006371/1.892, allocations: 2.612 MB / 1.76 GB, free: 13.48 MB / 0.8542 GB
Notification: Performance of NFPackage.collectConstants: time 0.0009311/1.893, allocations: 156.8 kB / 1.76 GB, free: 13.48 MB / 0.8542 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.009637/1.902, allocations: 2.149 MB / 1.762 GB, free: 13.47 MB / 0.8542 GB
Notification: Performance of NFScalarize.scalarize: time 0.002754/1.905, allocations: 1.147 MB / 1.763 GB, free: 13.47 MB / 0.8542 GB
Notification: Performance of NFVerifyModel.verify: time 0.002073/1.907, allocations: 0.664 MB / 1.764 GB, free: 13.44 MB / 0.8542 GB
Notification: Performance of NFConvertDAE.convert: time 0.008658/1.916, allocations: 4.124 MB / 1.768 GB, free: 13.12 MB / 0.8542 GB
Notification: Performance of FrontEnd - DAE generated: time 7.645e-06/1.916, allocations: 3.312 kB / 1.768 GB, free: 13.12 MB / 0.8542 GB
Notification: Performance of FrontEnd: time 2.545e-06/1.916, allocations: 0 / 1.768 GB, free: 13.12 MB / 0.8542 GB
Notification: Performance of Transformations before backend: time 0.0001535/1.916, allocations: 0 / 1.768 GB, free: 13.12 MB / 0.8542 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 669
 * Number of variables: 669
Notification: Performance of Generate backend data structure: time 0.01536/1.931, allocations: 3.456 MB / 1.771 GB, free: 11.6 MB / 0.8542 GB
Notification: Performance of prepare preOptimizeDAE: time 5.202e-05/1.931, allocations: 12.17 kB / 1.771 GB, free: 11.6 MB / 0.8542 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.009717/1.941, allocations: 0.9225 MB / 1.772 GB, free: 11.43 MB / 0.8542 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.005428/1.947, allocations: 1.765 MB / 1.774 GB, free: 10.97 MB / 0.8542 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.000193/1.947, allocations: 198 kB / 1.774 GB, free: 10.96 MB / 0.8542 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0007172/1.948, allocations: 262.5 kB / 1.774 GB, free: 10.96 MB / 0.8542 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.009559/1.957, allocations: 3.307 MB / 1.778 GB, free: 10.66 MB / 0.8542 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0001109/1.957, allocations: 9.906 kB / 1.778 GB, free: 10.66 MB / 0.8542 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0004139/1.958, allocations: 107.1 kB / 1.778 GB, free: 10.66 MB / 0.8542 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0002336/1.958, allocations: 143.2 kB / 1.778 GB, free: 10.65 MB / 0.8542 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.01041/1.968, allocations: 3.466 MB / 1.781 GB, free: 10.62 MB / 0.8542 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.02603/1.995, allocations: 12.07 MB / 1.793 GB, free: 20.59 MB / 0.8698 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.007885/2.002, allocations: 3.508 MB / 1.796 GB, free: 20.01 MB / 0.8698 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.005095/2.008, allocations: 1.806 MB / 1.798 GB, free: 19.97 MB / 0.8698 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.002553/2.01, allocations: 1.495 MB / 1.8 GB, free: 18.37 MB / 0.8698 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 8.34e-05/2.01, allocations: 65.81 kB / 1.8 GB, free: 18.32 MB / 0.8698 GB
Notification: Performance of pre-optimization done (n=278): time 5.61e-06/2.01, allocations: 0 / 1.8 GB, free: 18.32 MB / 0.8698 GB
Notification: Performance of matching and sorting (n=278): time 0.01331/2.024, allocations: 3.864 MB / 1.803 GB, free: 18.06 MB / 0.8698 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 7.938e-05/2.024, allocations: 80.28 kB / 1.804 GB, free: 18 MB / 0.8698 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002914/2.027, allocations: 1.348 MB / 1.805 GB, free: 17.83 MB / 0.8698 GB
Notification: Performance of collectPreVariables (initialization): time 0.0006548/2.027, allocations: 78.52 kB / 1.805 GB, free: 17.8 MB / 0.8698 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0008585/2.028, allocations: 0.9724 MB / 1.806 GB, free: 17.42 MB / 0.8698 GB
Notification: Performance of collectInitialBindings (initialization): time 0.001434/2.03, allocations: 0.9461 MB / 1.807 GB, free: 16.79 MB / 0.8698 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0002409/2.03, allocations: 49.56 kB / 1.807 GB, free: 16.79 MB / 0.8698 GB
Notification: Performance of setup shared object (initialization): time 0.0002762/2.03, allocations: 403.8 kB / 1.807 GB, free: 16.48 MB / 0.8698 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.003104/2.033, allocations: 1.079 MB / 1.808 GB, free: 16.48 MB / 0.8698 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.003493/2.037, allocations: 1.372 MB / 1.81 GB, free: 16.26 MB / 0.8698 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.003694/2.041, allocations: 1.279 MB / 1.811 GB, free: 16.21 MB / 0.8698 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.583e-05/2.041, allocations: 0 / 1.811 GB, free: 16.21 MB / 0.8698 GB
Notification: Performance of matching and sorting (n=311) (initialization): time 0.008563/2.049, allocations: 2.945 MB / 1.814 GB, free: 15.98 MB / 0.8698 GB
Notification: Performance of prepare postOptimizeDAE: time 3.374e-05/2.049, allocations: 7.75 kB / 1.814 GB, free: 15.98 MB / 0.8698 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.343e-05/2.049, allocations: 5.906 kB / 1.814 GB, free: 15.98 MB / 0.8698 GB
Notification: Performance of postOpt tearingSystem (initialization): time 3.88e-05/2.049, allocations: 15.12 kB / 1.814 GB, free: 15.98 MB / 0.8698 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.00459/2.054, allocations: 0.5118 MB / 1.814 GB, free: 15.97 MB / 0.8698 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 5.03e-05/2.054, allocations: 16.73 kB / 1.814 GB, free: 15.97 MB / 0.8698 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.004962/2.059, allocations: 342.1 kB / 1.815 GB, free: 15.85 MB / 0.8698 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0004587/2.06, allocations: 84.02 kB / 1.815 GB, free: 15.85 MB / 0.8698 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 19
 * 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 (311):
 * Single equations (assignments): 311
 * 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.002073/2.062, allocations: 0.6446 MB / 1.815 GB, free: 15.73 MB / 0.8698 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0009086/2.063, allocations: 231.1 kB / 1.816 GB, free: 15.62 MB / 0.8698 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.008746/2.071, allocations: 3.092 MB / 1.819 GB, free: 15.43 MB / 0.8698 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.006898/2.078, allocations: 2.626 MB / 1.821 GB, free: 15.18 MB / 0.8698 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.468e-05/2.078, allocations: 0 / 1.821 GB, free: 15.18 MB / 0.8698 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.00247/2.081, allocations: 0.6093 MB / 1.822 GB, free: 14.94 MB / 0.8698 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0007393/2.082, allocations: 55.34 kB / 1.822 GB, free: 14.94 MB / 0.8698 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.003855/2.086, allocations: 229.5 kB / 1.822 GB, free: 14.9 MB / 0.8698 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0004948/2.086, allocations: 159.4 kB / 1.822 GB, free: 14.9 MB / 0.8698 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.009921/2.096, allocations: 3.173 MB / 1.825 GB, free: 14.41 MB / 0.8698 GB
Notification: Performance of postOpt detectDAEmodeSparsePattern (simulation): time 0.01173/2.108, allocations: 4.999 MB / 1.83 GB, free: 13.35 MB / 0.8698 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.003195/2.111, allocations: 1.45 MB / 1.832 GB, free: 13.11 MB / 0.8698 GB
Notification: Performance of sorting global known variables: time 0.00195/2.113, allocations: 0.9209 MB / 1.832 GB, free: 12.85 MB / 0.8698 GB
Notification: Performance of Backend: time 7.21e-07/2.113, allocations: 0 / 1.832 GB, free: 12.85 MB / 0.8698 GB
Notification: Performance of simCode: created initialization part: time 0.00826/2.121, allocations: 2.573 MB / 1.835 GB, free: 12.29 MB / 0.8698 GB
Notification: Performance of SimCode: time 0.01811/2.139, allocations: 7.443 MB / 1.842 GB, free: 7.68 MB / 0.8698 GB
Notification: Performance of Templates: time 0.1514/2.291, allocations: 55.64 MB / 1.897 GB, free: 4.016 MB / 0.9167 GB