Running: ./testmodel.py --libraries=/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_master_Buildings.Fluid.MassExchangers.Validation.ConstantEffectivenessZeroFlow.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.Fluid.MassExchangers.Validation.ConstantEffectivenessZeroFlow,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Buildings_master_Buildings.Fluid.MassExchangers.Validation.ConstantEffectivenessZeroFlow")
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 9.0.0-master/package.mo): time 4.863/4.863, allocations: 0.5623 GB / 0.5775 GB, free: 3.324 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.002605/0.002606, allocations: 354 kB / 0.6446 GB, free: 185.6 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.161/4.161, allocations: 410.7 MB / 1.113 GB, free: 147.8 MB / 0.5886 GB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo): time 0.001838/0.001837, allocations: 182.3 kB / 1.226 GB, free: 35.94 MB / 0.5886 GB
Notification: Performance of FrontEnd - loaded program: time 0.0007131/0.0007133, allocations: 13.31 kB / 1.349 GB, free: 121.7 MB / 0.6042 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.2294/0.2301, allocations: 115.3 MB / 1.461 GB, free: 6.582 MB / 0.6042 GB
Notification: Performance of FrontEnd - scodeFlatten: time 6.674/6.904, allocations: 2.089 GB / 3.551 GB, free: 132.2 MB / 0.948 GB
Notification: Performance of FrontEnd - mkProgramGraph: time 0.0003108/6.904, allocations: 95.42 kB / 3.551 GB, free: 132.2 MB / 0.948 GB
Notification: Performance of FrontEnd - DAE generated: time 5.369/12.27, allocations: 0.9903 GB / 4.541 GB, free: 168.8 MB / 0.9636 GB
Notification: Performance of FrontEnd: time 2.454e-06/12.27, allocations: 0 / 4.541 GB, free: 168.8 MB / 0.9636 GB
Notification: Performance of Transformations before backend: time 0.0001319/12.27, allocations: 33.92 kB / 4.541 GB, free: 168.8 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: 209
 * Number of variables: 209
Notification: Performance of Generate backend data structure: time 0.009251/12.28, allocations: 1.9 MB / 4.543 GB, free: 167.9 MB / 0.9636 GB
Notification: Performance of prepare preOptimizeDAE: time 4.229e-05/12.28, allocations: 13.48 kB / 4.543 GB, free: 167.9 MB / 0.9636 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.005495/12.29, allocations: 0.5498 MB / 4.543 GB, free: 167.9 MB / 0.9636 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.003989/12.29, allocations: 1.049 MB / 4.544 GB, free: 167.6 MB / 0.9636 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.001223/12.29, allocations: 202.9 kB / 4.545 GB, free: 167.6 MB / 0.9636 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0004583/12.29, allocations: 87.88 kB / 4.545 GB, free: 167.6 MB / 0.9636 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.005078/12.3, allocations: 1.341 MB / 4.546 GB, free: 167.5 MB / 0.9636 GB
Notification: Performance of preOpt findStateOrder (simulation): time 3.409e-05/12.3, allocations: 0 / 4.546 GB, free: 167.5 MB / 0.9636 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001827/12.3, allocations: 30.81 kB / 4.546 GB, free: 167.5 MB / 0.9636 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 8.393e-05/12.3, allocations: 47.88 kB / 4.546 GB, free: 167.5 MB / 0.9636 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.006765/12.31, allocations: 1.566 MB / 4.548 GB, free: 167.5 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.01045/12.32, allocations: 4.084 MB / 4.552 GB, free: 166 MB / 0.9636 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.004445/12.32, allocations: 1.04 MB / 4.553 GB, free: 165.9 MB / 0.9636 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.002739/12.32, allocations: 0.6962 MB / 4.553 GB, free: 165.9 MB / 0.9636 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.001415/12.33, allocations: 0.6071 MB / 4.554 GB, free: 165.3 MB / 0.9636 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.296e-05/12.33, allocations: 43.28 kB / 4.554 GB, free: 165.3 MB / 0.9636 GB
Notification: Performance of pre-optimization done (n=76): time 3.427e-06/12.33, allocations: 0 / 4.554 GB, free: 165.3 MB / 0.9636 GB
Notification: Performance of matching and sorting (n=76): time 0.008699/12.33, allocations: 1.89 MB / 4.556 GB, free: 165.2 MB / 0.9636 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 4.931e-05/12.33, allocations: 59.66 kB / 4.556 GB, free: 165.1 MB / 0.9636 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001484/12.34, allocations: 0.8132 MB / 4.557 GB, free: 165 MB / 0.9636 GB
Notification: Performance of collectPreVariables (initialization): time 0.0002345/12.34, allocations: 44.61 kB / 4.557 GB, free: 165 MB / 0.9636 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0003688/12.34, allocations: 452 kB / 4.557 GB, free: 164.8 MB / 0.9636 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0002881/12.34, allocations: 254 kB / 4.557 GB, free: 164.7 MB / 0.9636 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 9.575e-05/12.34, allocations: 20.38 kB / 4.557 GB, free: 164.7 MB / 0.9636 GB
Notification: Performance of setup shared object (initialization): time 8.324e-05/12.34, allocations: 338.5 kB / 4.558 GB, free: 164.4 MB / 0.9636 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.002593/12.34, allocations: 0.5575 MB / 4.558 GB, free: 164.4 MB / 0.9636 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.002728/12.34, allocations: 0.7103 MB / 4.559 GB, free: 164.2 MB / 0.9636 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.002636/12.35, allocations: 0.614 MB / 4.56 GB, free: 164.2 MB / 0.9636 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 5.861e-06/12.35, allocations: 3.844 kB / 4.56 GB, free: 164.2 MB / 0.9636 GB
Notification: Performance of matching and sorting (n=87) (initialization): time 0.005957/12.35, allocations: 1.419 MB / 4.561 GB, free: 164.1 MB / 0.9636 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001049/12.35, allocations: 156.9 kB / 4.561 GB, free: 163.9 MB / 0.9636 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.034e-05/12.35, allocations: 0 / 4.561 GB, free: 163.9 MB / 0.9636 GB
Notification: Performance of postOpt tearingSystem (initialization): time 3.189e-05/12.35, allocations: 7.625 kB / 4.561 GB, free: 163.9 MB / 0.9636 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002955/12.35, allocations: 286.9 kB / 4.561 GB, free: 163.9 MB / 0.9636 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0007369/12.36, allocations: 1.194 MB / 4.563 GB, free: 162.7 MB / 0.9636 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002456/12.36, allocations: 205.4 kB / 4.563 GB, free: 162.7 MB / 0.9636 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001667/12.36, allocations: 36.28 kB / 4.563 GB, free: 162.7 MB / 0.9636 GB
Notification: Performance of prepare postOptimizeDAE: time 1.237e-05/12.36, allocations: 1.844 kB / 4.563 GB, free: 162.7 MB / 0.9636 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.005602/12.36, allocations: 1.314 MB / 4.564 GB, free: 162.6 MB / 0.9636 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 8.266e-06/12.36, allocations: 0 / 4.564 GB, free: 162.6 MB / 0.9636 GB
Notification: Performance of postOpt tearingSystem (initialization): time 1.144e-05/12.36, allocations: 7.156 kB / 4.564 GB, free: 162.6 MB / 0.9636 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002282/12.37, allocations: 250.8 kB / 4.564 GB, free: 162.6 MB / 0.9636 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 1.234e-05/12.37, allocations: 7.844 kB / 4.564 GB, free: 162.6 MB / 0.9636 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002332/12.37, allocations: 201.6 kB / 4.564 GB, free: 162.6 MB / 0.9636 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001538/12.37, allocations: 35.75 kB / 4.564 GB, free: 162.6 MB / 0.9636 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 5
 * Number of states: 0 ()
 * Number of discrete variables: 2 (hex.i1_w,hex.i2_w)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (86):
 * Single equations (assignments): 83
 * Array equations: 0
 * Algorithm blocks: 1
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 2
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Equation system details:
 * Constant Jacobian: 0
 * Linear Jacobian (size,density): 0
 * Non-linear Jacobian: 2 {1,1}
 * Without analytic Jacobian: 0
Notification: Performance of prepare postOptimizeDAE: time 0.0008866/12.37, allocations: 377.9 kB / 4.565 GB, free: 162.4 MB / 0.9636 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0003029/12.37, allocations: 102.9 kB / 4.565 GB, free: 162.4 MB / 0.9636 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.005995/12.38, allocations: 1.43 MB / 4.566 GB, free: 162.3 MB / 0.9636 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.335e-05/12.38, allocations: 11.17 kB / 4.566 GB, free: 162.3 MB / 0.9636 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 9.568e-06/12.38, allocations: 3.422 kB / 4.566 GB, free: 162.3 MB / 0.9636 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 1.231e-05/12.38, allocations: 3.844 kB / 4.566 GB, free: 162.3 MB / 0.9636 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.0126/12.39, allocations: 2.898 MB / 4.569 GB, free: 161.8 MB / 0.9636 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.803e-05/12.39, allocations: 3.906 kB / 4.569 GB, free: 161.8 MB / 0.9636 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.003733/12.39, allocations: 241.8 kB / 4.569 GB, free: 161.8 MB / 0.9636 GB
Notification: Performance of postOpt tearingSystem (simulation): time 2.31e-05/12.39, allocations: 10.34 kB / 4.569 GB, free: 161.8 MB / 0.9636 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0002375/12.39, allocations: 28.66 kB / 4.569 GB, free: 161.8 MB / 0.9636 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.0007732/12.39, allocations: 1.194 MB / 4.571 GB, free: 160.6 MB / 0.9636 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 8.796e-06/12.39, allocations: 6.938 kB / 4.571 GB, free: 160.6 MB / 0.9636 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.006152/12.4, allocations: 1.53 MB / 4.572 GB, free: 160.3 MB / 0.9636 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.000987/12.4, allocations: 317.4 kB / 4.572 GB, free: 160.2 MB / 0.9636 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0003043/12.4, allocations: 17.12 kB / 4.572 GB, free: 160.2 MB / 0.9636 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.002578/12.4, allocations: 162.1 kB / 4.573 GB, free: 160.1 MB / 0.9636 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0002227/12.4, allocations: 67.64 kB / 4.573 GB, free: 160.1 MB / 0.9636 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0001359/12.4, allocations: 36.62 kB / 4.573 GB, free: 160.1 MB / 0.9636 GB
Notification: Performance of sorting global known variables: time 0.001091/12.4, allocations: 0.5555 MB / 4.573 GB, free: 160 MB / 0.9636 GB
Notification: Performance of sort global known variables: time 5.31e-07/12.4, allocations: 3.688 kB / 4.573 GB, free: 160 MB / 0.9636 GB
Notification: Performance of remove unused functions: time 0.003327/12.41, allocations: 0.7577 MB / 4.574 GB, free: 160 MB / 0.9636 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 16
 * 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 simulation (76):
 * Single equations (assignments): 74
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 2
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Equation system details:
 * Constant Jacobian: 0
 * Linear Jacobian (size,density): 0
 * Non-linear Jacobian: 2 {1,1}
 * Without analytic Jacobian: 0
Notification: Performance of Backend phase and start with SimCode phase: time 0.004462/12.41, allocations: 2.351 MB / 4.576 GB, free: 159.1 MB / 0.9636 GB
Notification: Performance of simCode: created initialization part: time 0.009763/12.42, allocations: 2.14 MB / 4.578 GB, free: 159 MB / 0.9636 GB
Notification: Performance of simCode: created event and clocks part: time 1.251e-05/12.42, allocations: 0 / 4.578 GB, free: 159 MB / 0.9636 GB
Notification: Performance of simCode: created simulation system equations: time 0.003219/12.43, allocations: 0.6953 MB / 4.579 GB, free: 159 MB / 0.9636 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.004908/12.43, allocations: 0.5033 MB / 4.58 GB, free: 158.9 MB / 0.9636 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.007295/12.44, allocations: 2.468 MB / 4.582 GB, free: 157.9 MB / 0.9636 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0007162/12.44, allocations: 1.116 MB / 4.583 GB, free: 157.2 MB / 0.9636 GB
Notification: Performance of simCode: alias equations: time 0.003025/12.44, allocations: 400.6 kB / 4.583 GB, free: 157.2 MB / 0.9636 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0005996/12.44, allocations: 86.05 kB / 4.584 GB, free: 157.1 MB / 0.9636 GB
Notification: Performance of SimCode: time 1.513e-06/12.44, allocations: 2.844 kB / 4.584 GB, free: 157.1 MB / 0.9636 GB
Notification: Performance of Templates: time 0.12/12.56, allocations: 45.6 MB / 4.628 GB, free: 138 MB / 0.9636 GB