Running: ./testmodel.py --libraries=/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IBPSA_master_IBPSA.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 IBPSA with version 3.0.0 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 3.0.0-master/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)
Running command: translateModel(IBPSA.Airflow.Multizone.Examples.ChimneyShaftWithVolume,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IBPSA_master_IBPSA.Airflow.Multizone.Examples.ChimneyShaftWithVolume")
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo): time 0.0049/0.004905, allocations: 356.5 kB / 16.59 MB, free: 5.562 MB / 13.93 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 3.0.0-master/package.mo): time 1.707/1.707, allocations: 165.8 MB / 183.1 MB, free: 5.414 MB / 138.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 4.21/4.21, allocations: 410.8 MB / 0.6001 GB, free: 15.28 MB / 298.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo): time 0.001851/0.001851, allocations: 189.8 kB / 0.6668 GB, free: 6.938 MB / 298.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0005066/0.0005068, allocations: 11.94 kB / 0.7429 GB, free: 8.973 MB / 378.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.4575/0.458, allocations: 67.44 MB / 0.8087 GB, free: 28.79 MB / 378.7 MB
Notification: Performance of NFInst.instantiate(IBPSA.Airflow.Multizone.Examples.ChimneyShaftWithVolume): time 0.7997/1.258, allocations: 210.6 MB / 1.014 GB, free: 10.74 MB / 490.7 MB
Notification: Performance of NFInst.instExpressions: time 0.02437/1.282, allocations: 10.79 MB / 1.025 GB, free: 6.391 MB / 490.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.003315/1.286, allocations: 47.16 kB / 1.025 GB, free: 6.371 MB / 490.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.005516/1.291, allocations: 0.956 MB / 1.026 GB, free: 5.707 MB / 490.7 MB
Notification: Performance of NFTyping.typeBindings: time 0.01616/1.307, allocations: 3.124 MB / 1.029 GB, free: 3.684 MB / 490.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.007993/1.315, allocations: 1.574 MB / 1.03 GB, free: 3.012 MB / 490.7 MB
Notification: Performance of NFFlatten.flatten: time 0.01058/1.326, allocations: 5.26 MB / 1.036 GB, free: 200 kB / 490.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.003397/1.329, allocations: 1.177 MB / 1.037 GB, free: 15.2 MB / 0.4948 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.004765/1.334, allocations: 1.387 MB / 1.038 GB, free: 13.97 MB / 0.4948 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.004067/1.338, allocations: 1.403 MB / 1.039 GB, free: 12.59 MB / 0.4948 GB
Notification: Performance of NFPackage.collectConstants: time 0.0006534/1.339, allocations: 76 kB / 1.04 GB, free: 12.52 MB / 0.4948 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.006362/1.345, allocations: 1.211 MB / 1.041 GB, free: 11.3 MB / 0.4948 GB
Notification: Performance of NFScalarize.scalarize: time 0.00173/1.347, allocations: 0.5762 MB / 1.041 GB, free: 10.73 MB / 0.4948 GB
Notification: Performance of NFVerifyModel.verify: time 0.001584/1.349, allocations: 400.8 kB / 1.042 GB, free: 10.33 MB / 0.4948 GB
Notification: Performance of NFConvertDAE.convert: time 0.006565/1.356, allocations: 2.4 MB / 1.044 GB, free: 7.922 MB / 0.4948 GB
Notification: Performance of FrontEnd - DAE generated: time 7.985e-06/1.356, allocations: 4 kB / 1.044 GB, free: 7.918 MB / 0.4948 GB
Notification: Performance of FrontEnd: time 3.206e-06/1.356, allocations: 0 / 1.044 GB, free: 7.918 MB / 0.4948 GB
Notification: Performance of Transformations before backend: time 0.0001017/1.356, allocations: 0 / 1.044 GB, free: 7.918 MB / 0.4948 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.008657/1.364, allocations: 2.085 MB / 1.046 GB, free: 5.777 MB / 0.4948 GB
Notification: Performance of prepare preOptimizeDAE: time 6.278e-05/1.364, allocations: 8.031 kB / 1.046 GB, free: 5.77 MB / 0.4948 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.005514/1.37, allocations: 0.5323 MB / 1.047 GB, free: 5.234 MB / 0.4948 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.00371/1.374, allocations: 1.171 MB / 1.048 GB, free: 4.008 MB / 0.4948 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001521/1.374, allocations: 102.7 kB / 1.048 GB, free: 3.906 MB / 0.4948 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.000416/1.374, allocations: 136 kB / 1.048 GB, free: 3.773 MB / 0.4948 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.005256/1.38, allocations: 1.662 MB / 1.05 GB, free: 2.043 MB / 0.4948 GB
Notification: Performance of preOpt findStateOrder (simulation): time 6.607e-05/1.38, allocations: 7.906 kB / 1.05 GB, free: 2.035 MB / 0.4948 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0002308/1.38, allocations: 59.98 kB / 1.05 GB, free: 1.977 MB / 0.4948 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001466/1.38, allocations: 70.52 kB / 1.05 GB, free: 1.906 MB / 0.4948 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.005087/1.385, allocations: 1.443 MB / 1.051 GB, free: 468 kB / 0.4948 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.02044/1.406, allocations: 6.949 MB / 1.058 GB, free: 9.051 MB / 0.5105 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.01687/1.423, allocations: 1.192 MB / 1.059 GB, free: 7.812 MB / 0.5105 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.002481/1.425, allocations: 0.6161 MB / 1.06 GB, free: 7.199 MB / 0.5105 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.00825/1.433, allocations: 0.8633 MB / 1.061 GB, free: 6.152 MB / 0.5105 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.002786/1.436, allocations: 0.6064 MB / 1.061 GB, free: 5.535 MB / 0.5105 GB
Notification: Performance of pre-optimization done (n=110): time 6.502e-06/1.436, allocations: 0 / 1.061 GB, free: 5.535 MB / 0.5105 GB
Notification: Performance of matching and sorting (n=110): time 0.01361/1.45, allocations: 1.573 MB / 1.063 GB, free: 3.953 MB / 0.5105 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001081/1.45, allocations: 94.09 kB / 1.063 GB, free: 3.844 MB / 0.5105 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.01017/1.46, allocations: 1.175 MB / 1.064 GB, free: 2.66 MB / 0.5105 GB
Notification: Performance of collectPreVariables (initialization): time 0.0003641/1.461, allocations: 49.7 kB / 1.064 GB, free: 2.605 MB / 0.5105 GB
Notification: Performance of collectInitialEqns (initialization): time 0.001184/1.462, allocations: 0.6737 MB / 1.065 GB, free: 1.926 MB / 0.5105 GB
Notification: Performance of collectInitialBindings (initialization): time 0.003132/1.465, allocations: 386.3 kB / 1.065 GB, free: 1.543 MB / 0.5105 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.000142/1.465, allocations: 27.94 kB / 1.065 GB, free: 1.516 MB / 0.5105 GB
Notification: Performance of setup shared object (initialization): time 0.0002587/1.466, allocations: 353.9 kB / 1.065 GB, free: 1.164 MB / 0.5105 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001989/1.468, allocations: 413.8 kB / 1.066 GB, free: 0.7617 MB / 0.5105 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.002146/1.47, allocations: 0.5652 MB / 1.066 GB, free: 156 kB / 0.5105 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.002146/1.472, allocations: 498.9 kB / 1.067 GB, free: 15.66 MB / 0.5261 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 8.286e-06/1.472, allocations: 0 / 1.067 GB, free: 15.66 MB / 0.5261 GB
Notification: Performance of matching and sorting (n=126) (initialization): time 0.005239/1.477, allocations: 1.214 MB / 1.068 GB, free: 14.44 MB / 0.5261 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001953/1.478, allocations: 159.5 kB / 1.068 GB, free: 14.25 MB / 0.5261 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.862e-05/1.478, allocations: 8 kB / 1.068 GB, free: 14.24 MB / 0.5261 GB
Notification: Performance of postOpt tearingSystem (initialization): time 3.601e-05/1.478, allocations: 4 kB / 1.068 GB, free: 14.24 MB / 0.5261 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002552/1.48, allocations: 219.7 kB / 1.068 GB, free: 14.02 MB / 0.5261 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 4.115e-05/1.48, allocations: 8 kB / 1.068 GB, free: 14.02 MB / 0.5261 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.003358/1.484, allocations: 175.9 kB / 1.068 GB, free: 13.84 MB / 0.5261 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0002709/1.484, allocations: 39.94 kB / 1.069 GB, free: 13.8 MB / 0.5261 GB
Notification: Performance of prepare postOptimizeDAE: time 1.994e-05/1.484, allocations: 4 kB / 1.069 GB, free: 13.8 MB / 0.5261 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.00438/1.488, allocations: 1.031 MB / 1.07 GB, free: 12.77 MB / 0.5261 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.956e-05/1.488, allocations: 3.938 kB / 1.07 GB, free: 12.77 MB / 0.5261 GB
Notification: Performance of postOpt tearingSystem (initialization): time 2.564e-05/1.489, allocations: 8 kB / 1.07 GB, free: 12.76 MB / 0.5261 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002492/1.491, allocations: 211.7 kB / 1.07 GB, free: 12.55 MB / 0.5261 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.022e-05/1.491, allocations: 4 kB / 1.07 GB, free: 12.55 MB / 0.5261 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002517/1.494, allocations: 164.7 kB / 1.07 GB, free: 12.39 MB / 0.5261 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001494/1.494, allocations: 40 kB / 1.07 GB, free: 12.35 MB / 0.5261 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.001289/1.495, allocations: 488.8 kB / 1.07 GB, free: 11.86 MB / 0.5261 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0004725/1.496, allocations: 150.2 kB / 1.071 GB, free: 11.71 MB / 0.5261 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.003906/1.499, allocations: 1.25 MB / 1.072 GB, free: 10.45 MB / 0.5261 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.002935/1.502, allocations: 1.007 MB / 1.073 GB, free: 9.426 MB / 0.5261 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 6.422e-06/1.502, allocations: 0 / 1.073 GB, free: 9.426 MB / 0.5261 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.001171/1.504, allocations: 359 kB / 1.073 GB, free: 9.055 MB / 0.5261 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0003139/1.504, allocations: 27.98 kB / 1.073 GB, free: 9.027 MB / 0.5261 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001865/1.506, allocations: 110.8 kB / 1.073 GB, free: 8.922 MB / 0.5261 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0002272/1.506, allocations: 68.84 kB / 1.073 GB, free: 8.855 MB / 0.5261 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.005034/1.511, allocations: 1.31 MB / 1.075 GB, free: 7.543 MB / 0.5261 GB
Notification: Performance of postOpt detectDAEmodeSparsePattern (simulation): time 0.005751/1.517, allocations: 2.048 MB / 1.077 GB, free: 5.48 MB / 0.5261 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.001561/1.519, allocations: 0.5389 MB / 1.077 GB, free: 4.941 MB / 0.5261 GB
Notification: Performance of sorting global known variables: time 0.001914/1.521, allocations: 0.8138 MB / 1.078 GB, free: 4.125 MB / 0.5261 GB
Notification: Performance of Backend: time 3.487e-06/1.521, allocations: 3.938 kB / 1.078 GB, free: 4.121 MB / 0.5261 GB
Notification: Performance of simCode: created initialization part: time 0.008126/1.529, allocations: 2.141 MB / 1.08 GB, free: 2.176 MB / 0.5261 GB
Notification: Performance of SimCode: time 0.0134/1.542, allocations: 4.636 MB / 1.085 GB, free: 13.49 MB / 0.5417 GB
Notification: Performance of Templates: time 0.1036/1.646, allocations: 36.04 MB / 1.12 GB, free: 9.719 MB / 0.573 GB