Running: ./testmodel.py --libraries=/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IBPSA_master_IBPSA.Fluid.HeatExchangers.Validation.ConstantEffectiveness.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.HeatExchangers.Validation.ConstantEffectiveness,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IBPSA_master_IBPSA.Fluid.HeatExchangers.Validation.ConstantEffectiveness")
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo): time 0.001422/0.001422, allocations: 188.1 kB / 15.77 MB, free: 6 MB / 13.93 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 3.0.0-master/package.mo): time 0.7173/0.7173, allocations: 82.92 MB / 99.41 MB, free: 3.219 MB / 74.72 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 2.245/2.245, allocations: 205.4 MB / 325.4 MB, free: 3.305 MB / 250.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo): time 0.001287/0.001287, allocations: 90.75 kB / 393.6 MB, free: 15.07 MB / 330.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.000778/0.0007784, allocations: 12 kB / 471.5 MB, free: 66.54 MB / 362.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.08881/0.08962, allocations: 67.46 MB / 0.5264 GB, free: 15.05 MB / 378.7 MB
Notification: Performance of NFInst.instantiate(IBPSA.Fluid.HeatExchangers.Validation.ConstantEffectiveness): time 0.6091/0.6988, allocations: 166.7 MB / 0.6892 GB, free: 8.754 MB / 474.7 MB
Notification: Performance of NFInst.instExpressions: time 0.01371/0.7126, allocations: 6.957 MB / 0.696 GB, free: 1.785 MB / 474.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001413/0.714, allocations: 31.75 kB / 0.696 GB, free: 1.754 MB / 474.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.002266/0.7163, allocations: 0.6221 MB / 0.6966 GB, free: 1.129 MB / 474.7 MB
Notification: Performance of NFTyping.typeBindings: time 0.006492/0.7228, allocations: 1.737 MB / 0.6983 GB, free: 15.39 MB / 490.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.004563/0.7274, allocations: 1.164 MB / 0.6994 GB, free: 14.25 MB / 490.7 MB
Notification: Performance of NFFlatten.flatten: time 0.003486/0.7309, allocations: 1.545 MB / 0.7009 GB, free: 12.7 MB / 490.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.001491/0.7325, allocations: 0.7412 MB / 0.7017 GB, free: 11.94 MB / 490.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.002869/0.7353, allocations: 1.09 MB / 0.7027 GB, free: 10.85 MB / 490.7 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.001016/0.7364, allocations: 0.5445 MB / 0.7033 GB, free: 10.3 MB / 490.7 MB
Notification: Performance of NFPackage.collectConstants: time 0.0001524/0.7366, allocations: 44 kB / 0.7033 GB, free: 10.26 MB / 490.7 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.003197/0.7398, allocations: 1.104 MB / 0.7044 GB, free: 9.152 MB / 490.7 MB
Notification: Performance of NFScalarize.scalarize: time 0.0004819/0.7403, allocations: 247.1 kB / 0.7046 GB, free: 8.91 MB / 490.7 MB
Notification: Performance of NFVerifyModel.verify: time 0.0004934/0.7408, allocations: 245.1 kB / 0.7048 GB, free: 8.664 MB / 490.7 MB
Notification: Performance of NFConvertDAE.convert: time 0.002838/0.7437, allocations: 1.403 MB / 0.7062 GB, free: 7.258 MB / 490.7 MB
Notification: Performance of FrontEnd - DAE generated: time 3.821e-06/0.7437, allocations: 0 / 0.7062 GB, free: 7.258 MB / 490.7 MB
Notification: Performance of FrontEnd: time 2.371e-06/0.7437, allocations: 0 / 0.7062 GB, free: 7.258 MB / 490.7 MB
Notification: Performance of Transformations before backend: time 2.101e-05/0.7437, allocations: 0 / 0.7062 GB, free: 7.258 MB / 490.7 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 177
 * Number of variables: 177
Notification: Performance of Generate backend data structure: time 0.004463/0.7482, allocations: 1.444 MB / 0.7076 GB, free: 5.758 MB / 490.7 MB
Notification: Performance of prepare preOptimizeDAE: time 4.392e-05/0.7483, allocations: 12.03 kB / 0.7076 GB, free: 5.746 MB / 490.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.003087/0.7514, allocations: 478.1 kB / 0.7081 GB, free: 5.277 MB / 490.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.002271/0.7537, allocations: 0.8635 MB / 0.7089 GB, free: 4.371 MB / 490.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0007592/0.7545, allocations: 186.6 kB / 0.7091 GB, free: 4.188 MB / 490.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001943/0.7547, allocations: 76 kB / 0.7092 GB, free: 4.113 MB / 490.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.003521/0.7582, allocations: 1.122 MB / 0.7103 GB, free: 2.973 MB / 490.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 2.665e-05/0.7583, allocations: 7.938 kB / 0.7103 GB, free: 2.965 MB / 490.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001233/0.7584, allocations: 24 kB / 0.7103 GB, free: 2.941 MB / 490.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 6.358e-05/0.7585, allocations: 33.98 kB / 0.7103 GB, free: 2.906 MB / 490.7 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.00464/0.7632, allocations: 1.265 MB / 0.7116 GB, free: 1.645 MB / 490.7 MB
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.009297/0.7725, allocations: 4.189 MB / 0.7157 GB, free: 13.16 MB / 0.4948 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.003502/0.776, allocations: 0.9537 MB / 0.7166 GB, free: 12.2 MB / 0.4948 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0008195/0.7769, allocations: 490 kB / 0.7171 GB, free: 11.63 MB / 0.4948 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.002086/0.779, allocations: 0.6265 MB / 0.7177 GB, free: 10.98 MB / 0.4948 GB
Notification: Performance of pre-optimization done (n=57): time 3.869e-06/0.779, allocations: 0 / 0.7177 GB, free: 10.98 MB / 0.4948 GB
Notification: Performance of matching and sorting (n=57): time 0.005776/0.7848, allocations: 1.52 MB / 0.7192 GB, free: 9.461 MB / 0.4948 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 8.497e-05/0.7849, allocations: 93.61 kB / 0.7193 GB, free: 9.352 MB / 0.4948 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001539/0.7865, allocations: 0.8239 MB / 0.7201 GB, free: 8.504 MB / 0.4948 GB
Notification: Performance of collectPreVariables (initialization): time 0.0001316/0.7866, allocations: 45.7 kB / 0.7201 GB, free: 8.453 MB / 0.4948 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0004897/0.7871, allocations: 432.3 kB / 0.7205 GB, free: 8.027 MB / 0.4948 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0002552/0.7874, allocations: 197.1 kB / 0.7207 GB, free: 7.832 MB / 0.4948 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 6.118e-05/0.7875, allocations: 8 kB / 0.7207 GB, free: 7.824 MB / 0.4948 GB
Notification: Performance of setup shared object (initialization): time 0.0001862/0.7877, allocations: 338 kB / 0.721 GB, free: 7.488 MB / 0.4948 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001741/0.7894, allocations: 456.7 kB / 0.7215 GB, free: 7.043 MB / 0.4948 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001873/0.7913, allocations: 0.576 MB / 0.722 GB, free: 6.422 MB / 0.4948 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.00175/0.7931, allocations: 499.6 kB / 0.7225 GB, free: 5.926 MB / 0.4948 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 5.537e-06/0.7931, allocations: 0 / 0.7225 GB, free: 5.926 MB / 0.4948 GB
Notification: Performance of matching and sorting (n=70) (initialization): time 0.004147/0.7973, allocations: 1.163 MB / 0.7236 GB, free: 4.75 MB / 0.4948 GB
Notification: Performance of prepare postOptimizeDAE: time 0.000447/0.7977, allocations: 0.7227 MB / 0.7244 GB, free: 3.969 MB / 0.4948 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.033e-05/0.7978, allocations: 0 / 0.7244 GB, free: 3.969 MB / 0.4948 GB
Notification: Performance of postOpt tearingSystem (initialization): time 2.4e-05/0.7978, allocations: 11.95 kB / 0.7244 GB, free: 3.957 MB / 0.4948 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001799/0.7996, allocations: 255.7 kB / 0.7246 GB, free: 3.707 MB / 0.4948 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.001458/0.8011, allocations: 1.188 MB / 0.7258 GB, free: 2.473 MB / 0.4948 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.00277/0.8039, allocations: 195.2 kB / 0.726 GB, free: 2.281 MB / 0.4948 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0002171/0.8042, allocations: 27.98 kB / 0.726 GB, free: 2.254 MB / 0.4948 GB
Notification: Performance of prepare postOptimizeDAE: time 2.611e-05/0.8042, allocations: 10.14 kB / 0.726 GB, free: 2.246 MB / 0.4948 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.00731/0.8115, allocations: 1.053 MB / 0.727 GB, free: 1.184 MB / 0.4948 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.44e-05/0.8116, allocations: 0 / 0.727 GB, free: 1.184 MB / 0.4948 GB
Notification: Performance of postOpt tearingSystem (initialization): time 1.879e-05/0.8116, allocations: 8 kB / 0.727 GB, free: 1.176 MB / 0.4948 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002575/0.8142, allocations: 223.9 kB / 0.7272 GB, free: 0.957 MB / 0.4948 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.531e-05/0.8143, allocations: 7.984 kB / 0.7272 GB, free: 0.9492 MB / 0.4948 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002646/0.817, allocations: 183.3 kB / 0.7274 GB, free: 0.7695 MB / 0.4948 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001967/0.8172, allocations: 23.98 kB / 0.7274 GB, free: 0.7461 MB / 0.4948 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 8
 * Number of states: 0 ()
 * Number of discrete variables: 5 ($whenCondition1,$PRE.trapezoid.T_start,trapezoid.T_start,$PRE.trapezoid.count,trapezoid.count)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (69):
 * Single equations (assignments): 66
 * 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.001178/0.8184, allocations: 342 kB / 0.7278 GB, free: 412 kB / 0.4948 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0004242/0.8188, allocations: 106.7 kB / 0.7279 GB, free: 304 kB / 0.4948 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.007991/0.8269, allocations: 1.207 MB / 0.7291 GB, free: 15.08 MB / 0.5105 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 3.867e-05/0.8269, allocations: 11.98 kB / 0.7291 GB, free: 15.07 MB / 0.5105 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.087e-05/0.827, allocations: 0 / 0.7291 GB, free: 15.07 MB / 0.5105 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 1.704e-05/0.827, allocations: 0 / 0.7291 GB, free: 15.07 MB / 0.5105 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.01215/0.8392, allocations: 2.403 MB / 0.7314 GB, free: 12.58 MB / 0.5105 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.923e-05/0.8393, allocations: 4 kB / 0.7314 GB, free: 12.58 MB / 0.5105 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.002333/0.8416, allocations: 220 kB / 0.7316 GB, free: 12.36 MB / 0.5105 GB
Notification: Performance of postOpt tearingSystem (simulation): time 2.9e-05/0.8417, allocations: 11.98 kB / 0.7316 GB, free: 12.35 MB / 0.5105 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0001538/0.8418, allocations: 19.98 kB / 0.7317 GB, free: 12.33 MB / 0.5105 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.001288/0.8432, allocations: 1.184 MB / 0.7328 GB, free: 11.1 MB / 0.5105 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 9.496e-06/0.8432, allocations: 7.938 kB / 0.7328 GB, free: 11.09 MB / 0.5105 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.00726/0.8505, allocations: 1.423 MB / 0.7342 GB, free: 9.551 MB / 0.5105 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.001293/0.8518, allocations: 299.6 kB / 0.7345 GB, free: 9.238 MB / 0.5105 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0003719/0.8522, allocations: 12 kB / 0.7345 GB, free: 9.227 MB / 0.5105 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.002996/0.8553, allocations: 155.8 kB / 0.7347 GB, free: 9.074 MB / 0.5105 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.000365/0.8557, allocations: 68.23 kB / 0.7347 GB, free: 9.008 MB / 0.5105 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.000214/0.8559, allocations: 31.98 kB / 0.7347 GB, free: 8.977 MB / 0.5105 GB
Notification: Performance of sorting global known variables: time 0.002065/0.858, allocations: 0.5743 MB / 0.7353 GB, free: 8.391 MB / 0.5105 GB
Notification: Performance of sort global known variables: time 1.313e-06/0.858, allocations: 0 / 0.7353 GB, free: 8.391 MB / 0.5105 GB
Notification: Performance of remove unused functions: time 0.003746/0.8618, allocations: 491 kB / 0.7358 GB, free: 7.91 MB / 0.5105 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 12
 * Number of states: 0 ()
 * Number of discrete variables: 3 ($whenCondition1,trapezoid.T_start,trapezoid.count)
 * Number of discrete states: 1 (trapezoid.count)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (63):
 * Single equations (assignments): 57
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 2
 * When equations: 2
 * 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.00185/0.8637, allocations: 285.2 kB / 0.736 GB, free: 7.629 MB / 0.5105 GB
Notification: Performance of simCode: created initialization part: time 0.0136/0.8774, allocations: 1.746 MB / 0.7378 GB, free: 5.859 MB / 0.5105 GB
Notification: Performance of simCode: created event and clocks part: time 1.006e-05/0.8774, allocations: 0 / 0.7378 GB, free: 5.859 MB / 0.5105 GB
Notification: Performance of simCode: created simulation system equations: time 0.002386/0.8798, allocations: 0.612 MB / 0.7384 GB, free: 5.246 MB / 0.5105 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.00277/0.8826, allocations: 456 kB / 0.7388 GB, free: 4.793 MB / 0.5105 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.005914/0.8886, allocations: 2.226 MB / 0.741 GB, free: 2.504 MB / 0.5105 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0009564/0.8896, allocations: 1.066 MB / 0.742 GB, free: 1.41 MB / 0.5105 GB
Notification: Performance of simCode: alias equations: time 0.001978/0.8916, allocations: 279.1 kB / 0.7423 GB, free: 1.133 MB / 0.5105 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.000402/0.892, allocations: 79.41 kB / 0.7423 GB, free: 1.055 MB / 0.5105 GB
Notification: Performance of SimCode: time 1.88e-06/0.892, allocations: 0 / 0.7423 GB, free: 1.055 MB / 0.5105 GB
Notification: Performance of Templates: time 0.05551/0.9475, allocations: 18.26 MB / 0.7602 GB, free: 14.95 MB / 0.5417 GB