Running: ./testmodel.py --libraries=/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_master_Buildings.Airflow.Multizone.Examples.ChimneyShaftWithVolume.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.ChimneyShaftWithVolume,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Buildings_master_Buildings.Airflow.Multizone.Examples.ChimneyShaftWithVolume")
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 9.0.0-master/package.mo): time 4.69/4.69, allocations: 0.5623 GB / 0.5775 GB, free: 3.387 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.002419/0.002419, allocations: 355 kB / 0.6446 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.074/4.074, allocations: 410.7 MB / 1.113 GB, free: 6.035 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.001839/0.001838, allocations: 187.8 kB / 1.226 GB, free: 6.203 MB / 0.7136 GB
Notification: Performance of FrontEnd - loaded program: time 0.0004859/0.0004862, allocations: 12 kB / 1.349 GB, free: 8.344 MB / 0.8386 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.7011/0.7016, allocations: 115.3 MB / 1.461 GB, free: 284.4 MB / 0.8542 GB
Notification: Performance of FrontEnd - scodeFlatten: time 6.293/6.995, allocations: 2.084 GB / 3.545 GB, free: 274 MB / 0.948 GB
Notification: Performance of FrontEnd - mkProgramGraph: time 0.0003019/6.995, allocations: 97.56 kB / 3.546 GB, free: 274 MB / 0.948 GB
Notification: Performance of FrontEnd - DAE generated: time 5.415/12.41, allocations: 1.057 GB / 4.603 GB, free: 147 MB / 0.9636 GB
Notification: Performance of FrontEnd: time 2.074e-06/12.41, allocations: 3.406 kB / 4.603 GB, free: 147 MB / 0.9636 GB
Notification: Performance of Transformations before backend: time 0.000211/12.41, allocations: 49 kB / 4.603 GB, free: 147 MB / 0.9636 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 344
 * Number of variables: 344
Notification: Performance of Generate backend data structure: time 0.01061/12.42, allocations: 2.434 MB / 4.605 GB, free: 146.4 MB / 0.9636 GB
Notification: Performance of prepare preOptimizeDAE: time 4.154e-05/12.42, allocations: 10.72 kB / 4.605 GB, free: 146.4 MB / 0.9636 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.004932/12.43, allocations: 0.5101 MB / 4.606 GB, free: 146.3 MB / 0.9636 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.003474/12.43, allocations: 1.262 MB / 4.607 GB, free: 146 MB / 0.9636 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001004/12.43, allocations: 104.3 kB / 4.607 GB, free: 146 MB / 0.9636 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0003193/12.43, allocations: 146.2 kB / 4.607 GB, free: 146 MB / 0.9636 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.004117/12.43, allocations: 1.666 MB / 4.609 GB, free: 145.7 MB / 0.9636 GB
Notification: Performance of preOpt findStateOrder (simulation): time 5.743e-05/12.43, allocations: 4.031 kB / 4.609 GB, free: 145.7 MB / 0.9636 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.000205/12.43, allocations: 57.31 kB / 4.609 GB, free: 145.7 MB / 0.9636 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 8.143e-05/12.43, allocations: 56.47 kB / 4.609 GB, free: 145.7 MB / 0.9636 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.003815/12.44, allocations: 1.416 MB / 4.61 GB, free: 145.7 MB / 0.9636 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.01175/12.45, allocations: 7.157 MB / 4.617 GB, free: 142.3 MB / 0.9636 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.002577/12.45, allocations: 1.194 MB / 4.618 GB, free: 142 MB / 0.9636 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001397/12.45, allocations: 0.6136 MB / 4.619 GB, free: 142 MB / 0.9636 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0009909/12.45, allocations: 0.8624 MB / 4.62 GB, free: 141.1 MB / 0.9636 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.001487/12.46, allocations: 0.6158 MB / 4.62 GB, free: 141 MB / 0.9636 GB
Notification: Performance of pre-optimization done (n=110): time 3.797e-06/12.46, allocations: 0 / 4.62 GB, free: 141 MB / 0.9636 GB
Notification: Performance of matching and sorting (n=110): time 0.004687/12.46, allocations: 1.573 MB / 4.622 GB, free: 140.9 MB / 0.9636 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 6.207e-05/12.46, allocations: 93.89 kB / 4.622 GB, free: 140.8 MB / 0.9636 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002066/12.46, allocations: 1.177 MB / 4.623 GB, free: 140.7 MB / 0.9636 GB
Notification: Performance of collectPreVariables (initialization): time 0.0001512/12.46, allocations: 49.52 kB / 4.623 GB, free: 140.6 MB / 0.9636 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0006488/12.46, allocations: 0.674 MB / 4.624 GB, free: 140.4 MB / 0.9636 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0004139/12.46, allocations: 390 kB / 4.624 GB, free: 140.2 MB / 0.9636 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 8.429e-05/12.46, allocations: 18.03 kB / 4.624 GB, free: 140.2 MB / 0.9636 GB
Notification: Performance of setup shared object (initialization): time 9.487e-05/12.46, allocations: 348 kB / 4.625 GB, free: 139.9 MB / 0.9636 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001155/12.47, allocations: 418.6 kB / 4.625 GB, free: 139.9 MB / 0.9636 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001269/12.47, allocations: 0.6004 MB / 4.626 GB, free: 139.8 MB / 0.9636 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.001297/12.47, allocations: 0.4971 MB / 4.626 GB, free: 139.8 MB / 0.9636 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 7.875e-06/12.47, allocations: 7.078 kB / 4.626 GB, free: 139.8 MB / 0.9636 GB
Notification: Performance of matching and sorting (n=126) (initialization): time 0.0032/12.47, allocations: 1.207 MB / 4.627 GB, free: 139.6 MB / 0.9636 GB
Notification: Performance of prepare postOptimizeDAE: time 8.039e-05/12.47, allocations: 168.5 kB / 4.627 GB, free: 139.5 MB / 0.9636 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.224e-05/12.47, allocations: 2.781 kB / 4.627 GB, free: 139.5 MB / 0.9636 GB
Notification: Performance of postOpt tearingSystem (initialization): time 3.392e-05/12.47, allocations: 12.56 kB / 4.627 GB, free: 139.5 MB / 0.9636 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001815/12.47, allocations: 218.5 kB / 4.628 GB, free: 139.5 MB / 0.9636 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 1.804e-05/12.47, allocations: 7.109 kB / 4.628 GB, free: 139.5 MB / 0.9636 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002344/12.48, allocations: 175.3 kB / 4.628 GB, free: 139.4 MB / 0.9636 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001325/12.48, allocations: 38.17 kB / 4.628 GB, free: 139.4 MB / 0.9636 GB
Notification: Performance of prepare postOptimizeDAE: time 8.216e-06/12.48, allocations: 3.719 kB / 4.628 GB, free: 139.4 MB / 0.9636 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.002587/12.48, allocations: 1.042 MB / 4.629 GB, free: 139.4 MB / 0.9636 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 8.075e-06/12.48, allocations: 3.953 kB / 4.629 GB, free: 139.4 MB / 0.9636 GB
Notification: Performance of postOpt tearingSystem (initialization): time 1.178e-05/12.48, allocations: 9.656 kB / 4.629 GB, free: 139.4 MB / 0.9636 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001685/12.48, allocations: 211.3 kB / 4.629 GB, free: 139.4 MB / 0.9636 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 1.627e-05/12.48, allocations: 10.02 kB / 4.629 GB, free: 139.4 MB / 0.9636 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002194/12.48, allocations: 167.8 kB / 4.629 GB, free: 139.4 MB / 0.9636 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001219/12.48, allocations: 41.09 kB / 4.629 GB, free: 139.4 MB / 0.9636 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 11
 * Number of states: 0 ()
 * Number of discrete variables: 5 ($whenCondition1,$PRE.mRoo_flow.nextTimeEvent,mRoo_flow.nextTimeEvent,$PRE.mRoo_flow.nextTimeEventScaled,mRoo_flow.nextTimeEventScaled)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (126):
 * Single equations (assignments): 126
 * 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.001138/12.48, allocations: 493.3 kB / 4.63 GB, free: 139.2 MB / 0.9636 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0003748/12.48, allocations: 151.2 kB / 4.63 GB, free: 139.1 MB / 0.9636 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.003538/12.49, allocations: 1.259 MB / 4.631 GB, free: 139 MB / 0.9636 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.488e-05/12.49, allocations: 10.25 kB / 4.631 GB, free: 139 MB / 0.9636 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 9.798e-06/12.49, allocations: 0 / 4.631 GB, free: 139 MB / 0.9636 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.002587/12.49, allocations: 1.014 MB / 4.632 GB, free: 138.9 MB / 0.9636 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.007978/12.5, allocations: 3.196 MB / 4.635 GB, free: 138.3 MB / 0.9636 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 8.226e-06/12.5, allocations: 0 / 4.635 GB, free: 138.3 MB / 0.9636 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.002144/12.5, allocations: 242.1 kB / 4.635 GB, free: 138.3 MB / 0.9636 GB
Notification: Performance of postOpt tearingSystem (simulation): time 1.602e-05/12.5, allocations: 11 kB / 4.635 GB, free: 138.3 MB / 0.9636 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0001099/12.5, allocations: 31.22 kB / 4.635 GB, free: 138.3 MB / 0.9636 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 1.289e-05/12.5, allocations: 10.09 kB / 4.635 GB, free: 138.3 MB / 0.9636 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 4.378e-06/12.5, allocations: 0 / 4.635 GB, free: 138.3 MB / 0.9636 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.004653/12.51, allocations: 2.007 MB / 4.637 GB, free: 138 MB / 0.9636 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.001/12.51, allocations: 370.6 kB / 4.638 GB, free: 137.8 MB / 0.9636 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0003078/12.51, allocations: 25.78 kB / 4.638 GB, free: 137.8 MB / 0.9636 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001946/12.51, allocations: 117 kB / 4.638 GB, free: 137.8 MB / 0.9636 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0002112/12.51, allocations: 77.5 kB / 4.638 GB, free: 137.8 MB / 0.9636 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0001235/12.51, allocations: 40.48 kB / 4.638 GB, free: 137.8 MB / 0.9636 GB
Notification: Performance of sorting global known variables: time 0.001582/12.51, allocations: 0.8137 MB / 4.639 GB, free: 137.7 MB / 0.9636 GB
Notification: Performance of sort global known variables: time 4e-07/12.51, allocations: 0 / 4.639 GB, free: 137.7 MB / 0.9636 GB
Notification: Performance of remove unused functions: time 0.003642/12.51, allocations: 1.098 MB / 4.64 GB, free: 137.7 MB / 0.9636 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 11
 * Number of states: 9 (roo.dynBal.U,roo.dynBal.m,roo.dynBal.mXi[1],oriChiTop.mExc,oriBot.mExc,oriChiBot.mExc,sha.vol.dynBal.U,sha.vol.dynBal.m,sha.vol.dynBal.mXi[1])
 * Number of discrete variables: 3 ($whenCondition1,mRoo_flow.nextTimeEvent,mRoo_flow.nextTimeEventScaled)
 * Number of discrete states: 2 (mRoo_flow.nextTimeEvent,mRoo_flow.nextTimeEventScaled)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (111):
 * Single equations (assignments): 109
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 2
 * 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.005473/12.52, allocations: 2.907 MB / 4.643 GB, free: 136.7 MB / 0.9636 GB
Notification: Performance of simCode: created initialization part: time 0.004331/12.52, allocations: 1.612 MB / 4.644 GB, free: 136.7 MB / 0.9636 GB
Notification: Performance of simCode: created event and clocks part: time 7.424e-06/12.52, allocations: 0.5625 kB / 4.644 GB, free: 136.7 MB / 0.9636 GB
Notification: Performance of simCode: created simulation system equations: time 0.001342/12.53, allocations: 0.5643 MB / 4.645 GB, free: 136.7 MB / 0.9636 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.006921/12.53, allocations: 0.8319 MB / 4.646 GB, free: 136.6 MB / 0.9636 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.007638/12.54, allocations: 3.998 MB / 4.65 GB, free: 135 MB / 0.9636 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001149/12.54, allocations: 1.398 MB / 4.651 GB, free: 134.3 MB / 0.9636 GB
Notification: Performance of simCode: alias equations: time 0.003155/12.54, allocations: 465.7 kB / 4.651 GB, free: 134.3 MB / 0.9636 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0006374/12.55, allocations: 117.4 kB / 4.652 GB, free: 134.3 MB / 0.9636 GB
Notification: Performance of SimCode: time 9.02e-07/12.55, allocations: 0 / 4.652 GB, free: 134.3 MB / 0.9636 GB
Notification: Performance of Templates: time 0.1249/12.67, allocations: 56.47 MB / 4.707 GB, free: 132.5 MB / 0.9636 GB