Running: ./testmodel.py --libraries=/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IBPSA_master_IBPSA.Fluid.MixingVolumes.Validation.MoistureMixingConservationDynamicBalance.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.Fluid.MixingVolumes.Validation.MoistureMixingConservationDynamicBalance,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IBPSA_master_IBPSA.Fluid.MixingVolumes.Validation.MoistureMixingConservationDynamicBalance")
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo): time 0.002538/0.002542, allocations: 357.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.471/1.471, allocations: 165.8 MB / 183.1 MB, free: 5.422 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 3.884/3.884, allocations: 410.7 MB / 0.6001 GB, free: 15.29 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.001764/0.001764, allocations: 202.4 kB / 0.6668 GB, free: 6.961 MB / 298.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0004657/0.000466, allocations: 12 kB / 0.7429 GB, free: 8.992 MB / 378.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.4244/0.4248, allocations: 67.44 MB / 0.8087 GB, free: 28.81 MB / 378.7 MB
Notification: Performance of NFInst.instantiate(IBPSA.Fluid.MixingVolumes.Validation.MoistureMixingConservationDynamicBalance): time 0.8051/1.23, allocations: 199 MB / 1.003 GB, free: 14.21 MB / 490.7 MB
Notification: Performance of NFInst.instExpressions: time 0.02341/1.253, allocations: 11.88 MB / 1.015 GB, free: 10.94 MB / 490.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.00289/1.256, allocations: 63.06 kB / 1.015 GB, free: 10.91 MB / 490.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.003878/1.26, allocations: 0.7939 MB / 1.016 GB, free: 10.35 MB / 490.7 MB
Notification: Performance of NFTyping.typeBindings: time 0.01162/1.272, allocations: 2.819 MB / 1.018 GB, free: 8.531 MB / 490.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.006723/1.279, allocations: 1.558 MB / 1.02 GB, free: 7.898 MB / 490.7 MB
Notification: Performance of NFFlatten.flatten: time 0.008381/1.287, allocations: 5.121 MB / 1.025 GB, free: 6.055 MB / 490.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.002895/1.29, allocations: 1.298 MB / 1.026 GB, free: 5.496 MB / 490.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.005458/1.296, allocations: 1.734 MB / 1.028 GB, free: 4.73 MB / 490.7 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.003745/1.299, allocations: 1.425 MB / 1.029 GB, free: 3.609 MB / 490.7 MB
Notification: Performance of NFPackage.collectConstants: time 0.0006313/1.3, allocations: 80 kB / 1.029 GB, free: 3.531 MB / 490.7 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.004279/1.304, allocations: 0.844 MB / 1.03 GB, free: 2.824 MB / 490.7 MB
Notification: Performance of NFScalarize.scalarize: time 0.001372/1.306, allocations: 0.5841 MB / 1.031 GB, free: 2.352 MB / 490.7 MB
Notification: Performance of NFVerifyModel.verify: time 0.001/1.307, allocations: 382.6 kB / 1.031 GB, free: 2.078 MB / 490.7 MB
Notification: Performance of NFConvertDAE.convert: time 0.004717/1.311, allocations: 2.155 MB / 1.033 GB, free: 148 kB / 490.7 MB
Notification: Performance of FrontEnd - DAE generated: time 6.422e-06/1.312, allocations: 0 / 1.033 GB, free: 148 kB / 490.7 MB
Notification: Performance of FrontEnd: time 2.414e-06/1.312, allocations: 0 / 1.033 GB, free: 148 kB / 490.7 MB
Notification: Performance of Transformations before backend: time 8.733e-05/1.312, allocations: 0 / 1.033 GB, free: 148 kB / 490.7 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 351
 * Number of variables: 351
Notification: Performance of Generate backend data structure: time 0.005661/1.317, allocations: 1.87 MB / 1.035 GB, free: 14.36 MB / 0.4948 GB
Notification: Performance of prepare preOptimizeDAE: time 4.76e-05/1.317, allocations: 8.031 kB / 1.035 GB, free: 14.35 MB / 0.4948 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.004746/1.322, allocations: 0.4978 MB / 1.035 GB, free: 13.88 MB / 0.4948 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.003664/1.326, allocations: 1.189 MB / 1.037 GB, free: 12.86 MB / 0.4948 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001435/1.326, allocations: 108 kB / 1.037 GB, free: 12.8 MB / 0.4948 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0004661/1.327, allocations: 155 kB / 1.037 GB, free: 12.7 MB / 0.4948 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.004808/1.331, allocations: 1.747 MB / 1.039 GB, free: 11.35 MB / 0.4948 GB
Notification: Performance of preOpt findStateOrder (simulation): time 6.457e-05/1.331, allocations: 3.938 kB / 1.039 GB, free: 11.35 MB / 0.4948 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0002196/1.332, allocations: 66.11 kB / 1.039 GB, free: 11.33 MB / 0.4948 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001076/1.332, allocations: 50.55 kB / 1.039 GB, free: 11.28 MB / 0.4948 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.00417/1.336, allocations: 1.385 MB / 1.04 GB, free: 10.33 MB / 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.01486/1.351, allocations: 7.287 MB / 1.047 GB, free: 3.801 MB / 0.4948 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.002551/1.353, allocations: 1.023 MB / 1.048 GB, free: 3.082 MB / 0.4948 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001763/1.355, allocations: 0.6954 MB / 1.049 GB, free: 2.395 MB / 0.4948 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0003464/1.356, allocations: 114.2 kB / 1.049 GB, free: 2.266 MB / 0.4948 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 5.855e-05/1.356, allocations: 55.45 kB / 1.049 GB, free: 2.199 MB / 0.4948 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.002095/1.358, allocations: 306.5 kB / 1.049 GB, free: 1.898 MB / 0.4948 GB
Notification: Performance of pre-optimization done (n=106): time 6.773e-06/1.358, allocations: 0 / 1.049 GB, free: 1.898 MB / 0.4948 GB
Notification: Performance of matching and sorting (n=112): time 0.01299/1.371, allocations: 4.276 MB / 1.053 GB, free: 13.54 MB / 0.5105 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 9.926e-05/1.371, allocations: 171.2 kB / 1.054 GB, free: 13.34 MB / 0.5105 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002476/1.374, allocations: 1.231 MB / 1.055 GB, free: 12.1 MB / 0.5105 GB
Notification: Performance of collectPreVariables (initialization): time 0.0003168/1.374, allocations: 53.7 kB / 1.055 GB, free: 12.04 MB / 0.5105 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0007785/1.375, allocations: 0.7007 MB / 1.056 GB, free: 11.33 MB / 0.5105 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0006407/1.375, allocations: 400.1 kB / 1.056 GB, free: 10.94 MB / 0.5105 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0001178/1.375, allocations: 28 kB / 1.056 GB, free: 10.91 MB / 0.5105 GB
Notification: Performance of setup shared object (initialization): time 0.0001745/1.376, allocations: 357.9 kB / 1.056 GB, free: 10.55 MB / 0.5105 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001446/1.377, allocations: 0.5075 MB / 1.057 GB, free: 10.05 MB / 0.5105 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001785/1.379, allocations: 0.8352 MB / 1.058 GB, free: 9.086 MB / 0.5105 GB
Warning: It was not possible to determine if the initialization problem is consistent, because of not evaluable parameters/start values during compile time: vol2.dynBal.medium.p = vol2.dynBal.p_start (sin.p = vol2.dynBal.p_start)
Warning: It was not possible to determine if the initialization problem is consistent, because of not evaluable parameters/start values during compile time: vol1.dynBal.medium.p = vol1.dynBal.p_start (sin.p = vol1.dynBal.p_start)
Warning: It was not possible to determine if the initialization problem is consistent, because of not evaluable parameters/start values during compile time: vol.dynBal.medium.p = vol.dynBal.p_start (sin.p = vol.dynBal.p_start)
Notification: Performance of analyzeInitialSystem (initialization): time 0.01822/1.397, allocations: 3.453 MB / 1.061 GB, free: 5.586 MB / 0.5105 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.312e-05/1.397, allocations: 7.953 kB / 1.061 GB, free: 5.578 MB / 0.5105 GB
Notification: Performance of matching and sorting (n=169) (initialization): time 0.00423/1.401, allocations: 1.589 MB / 1.063 GB, free: 3.984 MB / 0.5105 GB
Notification: Performance of prepare postOptimizeDAE: time 3.04e-05/1.401, allocations: 11.94 kB / 1.063 GB, free: 3.973 MB / 0.5105 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.974e-05/1.401, allocations: 8 kB / 1.063 GB, free: 3.965 MB / 0.5105 GB
Notification: Performance of postOpt tearingSystem (initialization): time 3.97e-05/1.402, allocations: 20.03 kB / 1.063 GB, free: 3.945 MB / 0.5105 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002335/1.404, allocations: 291.5 kB / 1.063 GB, free: 3.66 MB / 0.5105 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 3.484e-05/1.404, allocations: 15.94 kB / 1.063 GB, free: 3.645 MB / 0.5105 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002592/1.407, allocations: 101.2 kB / 1.063 GB, free: 3.547 MB / 0.5105 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.000178/1.407, allocations: 57.73 kB / 1.063 GB, free: 3.492 MB / 0.5105 GB
Warning: The initial conditions are over specified. The following 3 initial equations are redundant, so they are removed from the initialization sytem:
         vol2.dynBal.medium.p = vol2.dynBal.p_start
         vol1.dynBal.medium.p = vol1.dynBal.p_start
         vol.dynBal.medium.p = vol.dynBal.p_start.
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 37
 * Number of states: 0 ()
 * Number of discrete variables: 6 (intMasVapOut.local_reset,intEntIn.local_reset,intEntOut.local_reset,intMasFloIn.local_reset,intMasFloOut.local_reset,intMasFloVapIn.local_reset)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (169):
 * Single equations (assignments): 169
 * 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.001075/1.408, allocations: 425.3 kB / 1.063 GB, free: 3.066 MB / 0.5105 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0004668/1.408, allocations: 174 kB / 1.064 GB, free: 2.895 MB / 0.5105 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.00338/1.412, allocations: 1.259 MB / 1.065 GB, free: 1.621 MB / 0.5105 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.002572/1.414, allocations: 1.221 MB / 1.066 GB, free: 340 kB / 0.5105 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.073e-05/1.414, allocations: 4 kB / 1.066 GB, free: 336 kB / 0.5105 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.001087/1.415, allocations: 347.1 kB / 1.066 GB, free: 15.96 MB / 0.5261 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.000335/1.416, allocations: 27.98 kB / 1.066 GB, free: 15.94 MB / 0.5261 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.002192/1.418, allocations: 87.78 kB / 1.066 GB, free: 15.85 MB / 0.5261 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.000183/1.418, allocations: 64.88 kB / 1.067 GB, free: 15.79 MB / 0.5261 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.004935/1.423, allocations: 1.662 MB / 1.068 GB, free: 14.12 MB / 0.5261 GB
Notification: Performance of postOpt detectDAEmodeSparsePattern (simulation): time 0.004937/1.428, allocations: 2.369 MB / 1.07 GB, free: 11.73 MB / 0.5261 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.00125/1.429, allocations: 0.5388 MB / 1.071 GB, free: 11.2 MB / 0.5261 GB
Notification: Performance of sorting global known variables: time 0.001759/1.431, allocations: 0.8248 MB / 1.072 GB, free: 10.37 MB / 0.5261 GB
Notification: Performance of Backend: time 7.21e-07/1.431, allocations: 0 / 1.072 GB, free: 10.37 MB / 0.5261 GB
Notification: Performance of simCode: created initialization part: time 0.004877/1.436, allocations: 1.245 MB / 1.073 GB, free: 9.137 MB / 0.5261 GB
Notification: Performance of SimCode: time 0.01277/1.449, allocations: 4.528 MB / 1.077 GB, free: 4.574 MB / 0.5261 GB
Notification: Performance of Templates: time 0.08381/1.533, allocations: 30.92 MB / 1.108 GB, free: 5.926 MB / 0.5573 GB