Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr BuildingSystems_BuildingSystems.Fluid.MassExchangers.Examples.ConstantEffectiveness.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildingSystems 2.0.0-master/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/NcDataReader2 2.5.0/package.mo", uses=false)
Using package NcDataReader2 with version 2.5.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/NcDataReader2 2.5.0/package.mo)
Using package ModelicaServices with version 3.2.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo)
Using package Modelica with version 3.2.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo)
Using package Complex with version 3.2.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo)
Using package BuildingSystems with version 2.0.0-beta (/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildingSystems 2.0.0-master/package.mo)
Running command: translateModel(BuildingSystems.Fluid.MassExchangers.Examples.ConstantEffectiveness,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="BuildingSystems_BuildingSystems.Fluid.MassExchangers.Examples.ConstantEffectiveness")
translateModel(BuildingSystems.Fluid.MassExchangers.Examples.ConstantEffectiveness,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="BuildingSystems_BuildingSystems.Fluid.MassExchangers.Examples.ConstantEffectiveness")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildingSystems 2.0.0-master/package.mo): time 0.767/0.767, allocations: 140.1 MB / 156 MB, free: 5.168 MB / 122.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo): time 0.0011/0.0011, allocations: 173.6 kB / 188.5 MB, free: 15.83 MB / 154.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 1.599/1.599, allocations: 205.4 MB / 426.4 MB, free: 8.465 MB / 314.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo): time 0.0008474/0.0008471, allocations: 82.42 kB / 0.4945 GB, free: 8.41 MB / 394.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/NcDataReader2 2.5.0/package.mo): time 0.00168/0.00168, allocations: 266.6 kB / 0.5728 GB, free: 66.22 MB / 410.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.000531/0.0005309, allocations: 20 kB / 0.662 GB, free: 6.824 MB / 442.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.5155/0.516, allocations: 79.3 MB / 0.7395 GB, free: 46.36 MB / 458.7 MB
Notification: Performance of FrontEnd - scodeFlatten: time 4.852/5.368, allocations: 2.059 GB / 2.799 GB, free: 229.9 MB / 0.6823 GB
Notification: Performance of FrontEnd - mkProgramGraph: time 0.0002813/5.368, allocations: 90.48 kB / 2.799 GB, free: 229.8 MB / 0.6823 GB
Notification: Performance of FrontEnd - DAE generated: time 3.489/8.857, allocations: 0.9907 GB / 3.789 GB, free: 12.64 MB / 0.698 GB
Notification: Performance of FrontEnd: time 3.436e-06/8.857, allocations: 4 kB / 3.789 GB, free: 12.64 MB / 0.698 GB
Notification: Performance of Transformations before backend: time 0.0002163/8.857, allocations: 32 kB / 3.789 GB, free: 12.61 MB / 0.698 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.00868/8.866, allocations: 1.896 MB / 3.791 GB, free: 10.65 MB / 0.698 GB
Notification: Performance of prepare preOptimizeDAE: time 5.736e-05/8.866, allocations: 12.03 kB / 3.791 GB, free: 10.64 MB / 0.698 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.003719/8.87, allocations: 0.534 MB / 3.792 GB, free: 10.1 MB / 0.698 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.004635/8.875, allocations: 1.094 MB / 3.793 GB, free: 8.965 MB / 0.698 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0007875/8.875, allocations: 194.4 kB / 3.793 GB, free: 8.773 MB / 0.698 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0006979/8.876, allocations: 88.31 kB / 3.793 GB, free: 8.688 MB / 0.698 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.004789/8.881, allocations: 1.349 MB / 3.795 GB, free: 7.324 MB / 0.698 GB
Notification: Performance of preOpt findStateOrder (simulation): time 3.108e-05/8.881, allocations: 0 / 3.795 GB, free: 7.324 MB / 0.698 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001883/8.881, allocations: 35.98 kB / 3.795 GB, free: 7.289 MB / 0.698 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 8.237e-05/8.881, allocations: 53.98 kB / 3.795 GB, free: 7.234 MB / 0.698 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.004232/8.886, allocations: 1.569 MB / 3.796 GB, free: 5.668 MB / 0.698 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.009278/8.895, allocations: 4.11 MB / 3.8 GB, free: 1.277 MB / 0.698 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.002699/8.898, allocations: 1.067 MB / 3.801 GB, free: 208 kB / 0.698 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.5389/9.437, allocations: 0.6908 MB / 3.802 GB, free: 98.27 MB / 0.698 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.001106/9.438, allocations: 0.6054 MB / 3.802 GB, free: 97.7 MB / 0.698 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 4.775e-05/9.438, allocations: 42.3 kB / 3.803 GB, free: 97.66 MB / 0.698 GB
Notification: Performance of pre-optimization done (n=78): time 3.897e-06/9.438, allocations: 1.75 kB / 3.803 GB, free: 97.66 MB / 0.698 GB
Notification: Performance of matching and sorting (n=78): time 0.006746/9.445, allocations: 1.922 MB / 3.804 GB, free: 97.62 MB / 0.698 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 4.982e-05/9.445, allocations: 60.94 kB / 3.804 GB, free: 97.56 MB / 0.698 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001881/9.447, allocations: 0.8114 MB / 3.805 GB, free: 97.42 MB / 0.698 GB
Notification: Performance of collectPreVariables (initialization): time 0.000237/9.447, allocations: 42.73 kB / 3.805 GB, free: 97.39 MB / 0.698 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0005207/9.447, allocations: 447.6 kB / 3.806 GB, free: 97.3 MB / 0.698 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0003518/9.448, allocations: 271.6 kB / 3.806 GB, free: 97.18 MB / 0.698 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 6.052e-05/9.448, allocations: 14.19 kB / 3.806 GB, free: 97.18 MB / 0.698 GB
Notification: Performance of setup shared object (initialization): time 0.0001343/9.448, allocations: 336.9 kB / 3.806 GB, free: 96.88 MB / 0.698 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001832/9.45, allocations: 0.5623 MB / 3.807 GB, free: 96.88 MB / 0.698 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001732/9.451, allocations: 0.7203 MB / 3.808 GB, free: 96.76 MB / 0.698 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.00321/9.455, allocations: 1.236 MB / 3.809 GB, free: 96.67 MB / 0.698 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 6.733e-06/9.455, allocations: 3.75 kB / 3.809 GB, free: 96.67 MB / 0.698 GB
Notification: Performance of matching and sorting (n=89) (initialization): time 0.003892/9.459, allocations: 1.44 MB / 3.81 GB, free: 96.54 MB / 0.698 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001568/9.459, allocations: 154.8 kB / 3.81 GB, free: 96.39 MB / 0.698 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.105e-05/9.459, allocations: 0 / 3.81 GB, free: 96.39 MB / 0.698 GB
Notification: Performance of postOpt tearingSystem (initialization): time 2.41e-05/9.459, allocations: 7.312 kB / 3.81 GB, free: 96.39 MB / 0.698 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001656/9.461, allocations: 295.2 kB / 3.811 GB, free: 96.39 MB / 0.698 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0006599/9.461, allocations: 1.193 MB / 3.812 GB, free: 95.21 MB / 0.698 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001815/9.463, allocations: 199.8 kB / 3.812 GB, free: 95.2 MB / 0.698 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001417/9.463, allocations: 38.81 kB / 3.812 GB, free: 95.2 MB / 0.698 GB
Notification: Performance of prepare postOptimizeDAE: time 1.77e-05/9.463, allocations: 5.031 kB / 3.812 GB, free: 95.2 MB / 0.698 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.003439/9.467, allocations: 1.34 MB / 3.813 GB, free: 95.14 MB / 0.698 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 6.111e-06/9.467, allocations: 3.797 kB / 3.813 GB, free: 95.14 MB / 0.698 GB
Notification: Performance of postOpt tearingSystem (initialization): time 1.359e-05/9.467, allocations: 12.08 kB / 3.813 GB, free: 95.14 MB / 0.698 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001701/9.468, allocations: 254 kB / 3.814 GB, free: 95.14 MB / 0.698 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 8.947e-06/9.468, allocations: 3.688 kB / 3.814 GB, free: 95.14 MB / 0.698 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001892/9.47, allocations: 203.6 kB / 3.814 GB, free: 95.12 MB / 0.698 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001197/9.471, allocations: 38.45 kB / 3.814 GB, free: 95.12 MB / 0.698 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 (88):
 * Single equations (assignments): 85
 * 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.001268/9.472, allocations: 368.4 kB / 3.814 GB, free: 94.93 MB / 0.698 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0004164/9.472, allocations: 103.7 kB / 3.814 GB, free: 94.88 MB / 0.698 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.004103/9.476, allocations: 1.46 MB / 3.816 GB, free: 94.81 MB / 0.698 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.854e-05/9.476, allocations: 13.83 kB / 3.816 GB, free: 94.81 MB / 0.698 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.028e-05/9.476, allocations: 0 / 3.816 GB, free: 94.81 MB / 0.698 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 1.155e-05/9.476, allocations: 3.844 kB / 3.816 GB, free: 94.81 MB / 0.698 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.006473/9.483, allocations: 2.922 MB / 3.819 GB, free: 94.36 MB / 0.698 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.067e-05/9.483, allocations: 3.875 kB / 3.819 GB, free: 94.36 MB / 0.698 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.001277/9.484, allocations: 263 kB / 3.819 GB, free: 94.36 MB / 0.698 GB
Notification: Performance of postOpt tearingSystem (simulation): time 1.689e-05/9.484, allocations: 4.406 kB / 3.819 GB, free: 94.36 MB / 0.698 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 8.472e-05/9.484, allocations: 32.19 kB / 3.819 GB, free: 94.36 MB / 0.698 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.0005289/9.485, allocations: 1.194 MB / 3.82 GB, free: 93.19 MB / 0.698 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 5.821e-06/9.485, allocations: 2.781 kB / 3.82 GB, free: 93.19 MB / 0.698 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.003384/9.488, allocations: 1.556 MB / 3.822 GB, free: 92.86 MB / 0.698 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0008616/9.489, allocations: 310.1 kB / 3.822 GB, free: 92.72 MB / 0.698 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0003101/9.489, allocations: 23.83 kB / 3.822 GB, free: 92.72 MB / 0.698 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.00154/9.491, allocations: 165.9 kB / 3.822 GB, free: 92.71 MB / 0.698 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001632/9.491, allocations: 65.73 kB / 3.822 GB, free: 92.71 MB / 0.698 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 9.993e-05/9.491, allocations: 39.73 kB / 3.822 GB, free: 92.71 MB / 0.698 GB
Notification: Performance of sorting global known variables: time 0.001142/9.492, allocations: 0.5569 MB / 3.823 GB, free: 92.6 MB / 0.698 GB
Notification: Performance of sort global known variables: time 3.41e-07/9.492, allocations: 1.844 kB / 3.823 GB, free: 92.6 MB / 0.698 GB
Notification: Performance of remove unused functions: time 0.00351/9.496, allocations: 0.7518 MB / 3.823 GB, free: 92.58 MB / 0.698 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 (78):
 * Single equations (assignments): 76
 * 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.004973/9.501, allocations: 2.369 MB / 3.826 GB, free: 91.75 MB / 0.698 GB
Notification: Performance of simCode: created initialization part: time 0.005958/9.507, allocations: 2.168 MB / 3.828 GB, free: 91.61 MB / 0.698 GB
Notification: Performance of simCode: created event and clocks part: time 1.064e-05/9.507, allocations: 0 / 3.828 GB, free: 91.61 MB / 0.698 GB
Notification: Performance of simCode: created simulation system equations: time 0.00193/9.509, allocations: 0.7065 MB / 3.829 GB, free: 91.6 MB / 0.698 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.004132/9.513, allocations: 0.5159 MB / 3.829 GB, free: 91.58 MB / 0.698 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.006393/9.52, allocations: 2.551 MB / 3.832 GB, free: 90.51 MB / 0.698 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001/9.521, allocations: 1.094 MB / 3.833 GB, free: 89.8 MB / 0.698 GB
Notification: Performance of simCode: alias equations: time 0.002367/9.523, allocations: 409.8 kB / 3.833 GB, free: 89.79 MB / 0.698 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0004574/9.523, allocations: 92.39 kB / 3.833 GB, free: 89.79 MB / 0.698 GB
Notification: Performance of SimCode: time 1.654e-06/9.523, allocations: 0 / 3.833 GB, free: 89.79 MB / 0.698 GB
Notification: Performance of Templates: time 0.07759/9.601, allocations: 46.23 MB / 3.878 GB, free: 88.32 MB / 0.698 GB
make -j1 -f BuildingSystems_BuildingSystems.Fluid.MassExchangers.Examples.ConstantEffectiveness.makefile
(rm -f BuildingSystems_BuildingSystems.Fluid.MassExchangers.Examples.ConstantEffectiveness.pipe ; mkfifo BuildingSystems_BuildingSystems.Fluid.MassExchangers.Examples.ConstantEffectiveness.pipe ; head -c 1048576 < BuildingSystems_BuildingSystems.Fluid.MassExchangers.Examples.ConstantEffectiveness.pipe >> ../files/BuildingSystems_BuildingSystems.Fluid.MassExchangers.Examples.ConstantEffectiveness.sim & ./BuildingSystems_BuildingSystems.Fluid.MassExchangers.Examples.ConstantEffectiveness -abortSlowSimulation -alarm=480 -lv LOG_STATS > BuildingSystems_BuildingSystems.Fluid.MassExchangers.Examples.ConstantEffectiveness.pipe 2>&1)