Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_11_Buildings.Fluid.HeatExchangers.Validation.HeaterCooler_u.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.1.0-maint.11.x/package.mo", uses=false)
Using package Buildings with version 11.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.1.0-maint.11.x/package.mo)
Using package Modelica with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo)
Using package Complex with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo)
Using package ModelicaServices with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo)
Running command: translateModel(Buildings.Fluid.HeatExchangers.Validation.HeaterCooler_u,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|con1.u_s|con1.u_m|con2.u_m|con1.y|con2.y",fileNamePrefix="Buildings_11_Buildings.Fluid.HeatExchangers.Validation.HeaterCooler_u")
translateModel(Buildings.Fluid.HeatExchangers.Validation.HeaterCooler_u,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|con1.u_s|con1.u_m|con2.u_m|con1.y|con2.y",fileNamePrefix="Buildings_11_Buildings.Fluid.HeatExchangers.Validation.HeaterCooler_u")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001709/0.001709, allocations: 115.9 kB / 16.81 MB, free: 5.766 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001929/0.001929, allocations: 196.7 kB / 17.77 MB, free: 5.117 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.505/1.505, allocations: 225.6 MB / 244.2 MB, free: 13.89 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.1.0-maint.11.x/package.mo): time 2.732/2.732, allocations: 476.7 MB / 0.7556 GB, free: 11.35 MB / 0.6231 GB
Notification: Performance of FrontEnd - loaded program: time 0.001956/0.001956, allocations: 60.5 kB / 1.097 GB, free: 11.76 MB / 0.8419 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.338/0.3399, allocations: 168.7 MB / 1.262 GB, free: 12.96 MB / 0.9825 GB
Notification: Performance of NFInst.instantiate(Buildings.Fluid.HeatExchangers.Validation.HeaterCooler_u): time 0.2876/0.6276, allocations: 256.8 MB / 1.513 GB, free: 11.17 MB / 1.232 GB
Notification: Performance of NFInst.instExpressions: time 0.0167/0.6443, allocations: 9.614 MB / 1.522 GB, free: 1.535 MB / 1.232 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.00322/0.6475, allocations: 79.5 kB / 1.522 GB, free: 1.457 MB / 1.232 GB
Notification: Performance of NFTyping.typeComponents: time 0.003204/0.6507, allocations: 0.994 MB / 1.523 GB, free: 468 kB / 1.232 GB
Notification: Performance of NFTyping.typeBindings: time 0.007693/0.6584, allocations: 2.769 MB / 1.526 GB, free: 13.68 MB / 1.248 GB
Notification: Performance of NFTyping.typeClassSections: time 0.005747/0.6641, allocations: 2.2 MB / 1.528 GB, free: 11.49 MB / 1.248 GB
Notification: Performance of NFFlatten.flatten: time 0.006465/0.6706, allocations: 4.152 MB / 1.532 GB, free: 7.324 MB / 1.248 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.002091/0.6727, allocations: 1.311 MB / 1.534 GB, free: 5.977 MB / 1.248 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.004298/0.677, allocations: 2.028 MB / 1.535 GB, free: 3.941 MB / 1.248 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.002862/0.6799, allocations: 1.364 MB / 1.537 GB, free: 2.578 MB / 1.248 GB
Notification: Performance of NFPackage.collectConstants: time 0.0003131/0.6802, allocations: 183.9 kB / 1.537 GB, free: 2.398 MB / 1.248 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.006276/0.6864, allocations: 3.293 MB / 1.54 GB, free: 15.1 MB / 1.264 GB
Notification: Performance of NFScalarize.scalarize: time 0.000765/0.6872, allocations: 0.6151 MB / 1.541 GB, free: 14.48 MB / 1.264 GB
Notification: Performance of NFVerifyModel.verify: time 0.001366/0.6886, allocations: 1.022 MB / 1.542 GB, free: 13.45 MB / 1.264 GB
Notification: Performance of NFConvertDAE.convert: time 0.006826/0.6954, allocations: 3.706 MB / 1.545 GB, free: 9.734 MB / 1.264 GB
Notification: Performance of FrontEnd - DAE generated: time 4.118e-06/0.6954, allocations: 0 / 1.545 GB, free: 9.734 MB / 1.264 GB
Notification: Performance of FrontEnd: time 1.533e-06/0.6954, allocations: 0 / 1.545 GB, free: 9.734 MB / 1.264 GB
Notification: Performance of Transformations before backend: time 4.219e-05/0.6954, allocations: 0 / 1.545 GB, free: 9.734 MB / 1.264 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 294
 * Number of variables: 294
Notification: Performance of Generate backend data structure: time 0.005139/0.7006, allocations: 2.552 MB / 1.548 GB, free: 7.102 MB / 1.264 GB
Notification: Performance of prepare preOptimizeDAE: time 5.003e-05/0.7006, allocations: 8.625 kB / 1.548 GB, free: 7.094 MB / 1.264 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.004063/0.7047, allocations: 0.6387 MB / 1.549 GB, free: 6.453 MB / 1.264 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.003168/0.7079, allocations: 1.451 MB / 1.55 GB, free: 4.949 MB / 1.264 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 9.641e-05/0.708, allocations: 90.28 kB / 1.55 GB, free: 4.859 MB / 1.264 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0002534/0.7082, allocations: 135.9 kB / 1.55 GB, free: 4.727 MB / 1.264 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.003012/0.7112, allocations: 1.42 MB / 1.552 GB, free: 3.238 MB / 1.264 GB
Notification: Performance of preOpt findStateOrder (simulation): time 3.329e-05/0.7113, allocations: 4 kB / 1.552 GB, free: 3.234 MB / 1.264 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001305/0.7114, allocations: 44 kB / 1.552 GB, free: 3.191 MB / 1.264 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 5.647e-05/0.7114, allocations: 42.22 kB / 1.552 GB, free: 3.148 MB / 1.264 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.002704/0.7142, allocations: 1.195 MB / 1.553 GB, free: 1.945 MB / 1.264 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.6399/1.354, allocations: 5.684 MB / 1.558 GB, free: 290.3 MB / 1.264 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.002001/1.356, allocations: 0.989 MB / 1.559 GB, free: 290.1 MB / 1.264 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001043/1.357, allocations: 0.4919 MB / 1.56 GB, free: 289.9 MB / 1.264 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0005581/1.358, allocations: 314.9 kB / 1.56 GB, free: 289.6 MB / 1.264 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.001196/1.359, allocations: 0.5639 MB / 1.561 GB, free: 289.4 MB / 1.264 GB
Notification: Performance of pre-optimization done (n=85): time 3.266e-06/1.359, allocations: 0 / 1.561 GB, free: 289.4 MB / 1.264 GB
Notification: Performance of matching and sorting (n=92): time 0.009408/1.368, allocations: 3.54 MB / 1.564 GB, free: 287.8 MB / 1.264 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 4.914e-05/1.368, allocations: 95.75 kB / 1.564 GB, free: 287.7 MB / 1.264 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002222/1.371, allocations: 1.343 MB / 1.566 GB, free: 287.2 MB / 1.264 GB
Notification: Performance of collectPreVariables (initialization): time 0.000131/1.371, allocations: 47.11 kB / 1.566 GB, free: 287.2 MB / 1.264 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0006232/1.371, allocations: 0.7343 MB / 1.566 GB, free: 286.6 MB / 1.264 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0002919/1.372, allocations: 332.6 kB / 1.567 GB, free: 286.4 MB / 1.264 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0003181/1.372, allocations: 195.2 kB / 1.567 GB, free: 286.3 MB / 1.264 GB
Notification: Performance of setup shared object (initialization): time 8.712e-05/1.372, allocations: 352.3 kB / 1.567 GB, free: 286 MB / 1.264 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.00104/1.373, allocations: 454.2 kB / 1.568 GB, free: 285.8 MB / 1.264 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001143/1.374, allocations: 0.6505 MB / 1.568 GB, free: 285.5 MB / 1.264 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.01356/1.388, allocations: 3.316 MB / 1.571 GB, free: 284.4 MB / 1.264 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 5.801e-06/1.388, allocations: 1.375 kB / 1.571 GB, free: 284.4 MB / 1.264 GB
Notification: Performance of matching and sorting (n=126) (initialization): time 0.003425/1.391, allocations: 1.52 MB / 1.573 GB, free: 283.8 MB / 1.264 GB
Notification: Performance of prepare postOptimizeDAE: time 4.507e-05/1.391, allocations: 38.23 kB / 1.573 GB, free: 283.8 MB / 1.264 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.341e-05/1.391, allocations: 7.719 kB / 1.573 GB, free: 283.8 MB / 1.264 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0007405/1.392, allocations: 228.5 kB / 1.573 GB, free: 283.7 MB / 1.264 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0009667/1.393, allocations: 193.5 kB / 1.573 GB, free: 283.7 MB / 1.264 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.00357/1.397, allocations: 4.606 MB / 1.578 GB, free: 279.6 MB / 1.264 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001533/1.398, allocations: 69.03 kB / 1.578 GB, free: 279.6 MB / 1.264 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001025/1.398, allocations: 45 kB / 1.578 GB, free: 279.6 MB / 1.264 GB
Warning: The initial conditions are over specified. The following 1 initial equations are redundant, so they are removed from the initialization system:
         $DER.heaDyn.vol.dynBal.medium.p = 0.0.
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.001568/1.4, allocations: 0.7594 MB / 1.579 GB, free: 279.3 MB / 1.264 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.001105/1.401, allocations: 0.6439 MB / 1.579 GB, free: 278.9 MB / 1.264 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.01321/1.414, allocations: 3.283 MB / 1.583 GB, free: 277.8 MB / 1.264 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 5.6e-06/1.414, allocations: 1.094 kB / 1.583 GB, free: 277.8 MB / 1.264 GB
Notification: Performance of matching and sorting (n=126) (initialization_lambda0): time 0.003312/1.417, allocations: 1.49 MB / 1.584 GB, free: 277.2 MB / 1.264 GB
Notification: Performance of prepare postOptimizeDAE: time 3.571e-05/1.417, allocations: 36 kB / 1.584 GB, free: 277.2 MB / 1.264 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.128e-05/1.417, allocations: 8.406 kB / 1.584 GB, free: 277.2 MB / 1.264 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0004973/1.418, allocations: 203.8 kB / 1.584 GB, free: 277.1 MB / 1.264 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.000924/1.419, allocations: 197.7 kB / 1.584 GB, free: 277.1 MB / 1.264 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.004089/1.423, allocations: 5.788 MB / 1.59 GB, free: 271.9 MB / 1.264 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001535/1.424, allocations: 72.5 kB / 1.59 GB, free: 271.8 MB / 1.264 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001122/1.425, allocations: 40.41 kB / 1.59 GB, free: 271.8 MB / 1.264 GB
Warning: The initial conditions are over specified. The following 1 initial equations are redundant, so they are removed from the initialization_lambda0 system:
         $DER.heaDyn.vol.dynBal.medium.p = 0.0.
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 18
 * Number of states: 0 ()
 * Number of discrete variables: 9 (TSet.nextEventScaled,TSet.nextEvent,$PRE.TSet.nextEvent,TSet.last,TSet.b,TSet.a,$whenCondition1,con2.I.trigger_internal,con1.I.trigger_internal)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (105):
 * Single equations (assignments): 99
 * Array equations: 2
 * Algorithm blocks: 1
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 3
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 0 systems
 * Non-linear torn systems (#iteration vars, #inner vars): 3 systems
   {(1,8), (1,2), (1,4)}
Notification: Performance of prepare postOptimizeDAE: time 0.0004172/1.425, allocations: 274.2 kB / 1.59 GB, free: 271.6 MB / 1.264 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0003279/1.425, allocations: 174.6 kB / 1.591 GB, free: 271.5 MB / 1.264 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.002813/1.428, allocations: 1.282 MB / 1.592 GB, free: 270.9 MB / 1.264 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.002129/1.43, allocations: 1.144 MB / 1.593 GB, free: 270.4 MB / 1.264 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 5.069e-06/1.43, allocations: 3.938 kB / 1.593 GB, free: 270.4 MB / 1.264 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.000754/1.431, allocations: 345.9 kB / 1.593 GB, free: 270.2 MB / 1.264 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0002212/1.431, allocations: 24.69 kB / 1.593 GB, free: 270.1 MB / 1.264 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0009992/1.432, allocations: 65.27 kB / 1.593 GB, free: 270.1 MB / 1.264 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001475/1.432, allocations: 50.11 kB / 1.593 GB, free: 270.1 MB / 1.264 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.002697/1.435, allocations: 1.36 MB / 1.595 GB, free: 269.5 MB / 1.264 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.003066/1.438, allocations: 1.973 MB / 1.597 GB, free: 268.6 MB / 1.264 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.0008476/1.439, allocations: 476.2 kB / 1.597 GB, free: 268.4 MB / 1.264 GB
Notification: Performance of sorting global known variables: time 0.00117/1.44, allocations: 0.9131 MB / 1.598 GB, free: 268.1 MB / 1.264 GB
Notification: Performance of Backend: time 5.71e-07/1.44, allocations: 3.969 kB / 1.598 GB, free: 268.1 MB / 1.264 GB
Notification: Performance of simCode: created initialization part: time 0.005388/1.446, allocations: 2.684 MB / 1.601 GB, free: 266.6 MB / 1.264 GB
Notification: Performance of SimCode: time 0.005984/1.452, allocations: 3.918 MB / 1.605 GB, free: 263.6 MB / 1.264 GB
Notification: Performance of Templates: time 0.05489/1.506, allocations: 43.09 MB / 1.647 GB, free: 220.9 MB / 1.264 GB
make -j1 -f Buildings_11_Buildings.Fluid.HeatExchangers.Validation.HeaterCooler_u.makefile
(rm -f Buildings_11_Buildings.Fluid.HeatExchangers.Validation.HeaterCooler_u.pipe ; mkfifo Buildings_11_Buildings.Fluid.HeatExchangers.Validation.HeaterCooler_u.pipe ; head -c 1048576 < Buildings_11_Buildings.Fluid.HeatExchangers.Validation.HeaterCooler_u.pipe >> ../files/Buildings_11_Buildings.Fluid.HeatExchangers.Validation.HeaterCooler_u.sim & ./Buildings_11_Buildings.Fluid.HeatExchangers.Validation.HeaterCooler_u  -abortSlowSimulation -alarm=400  -emit_protected -lv LOG_STATS > Buildings_11_Buildings.Fluid.HeatExchangers.Validation.HeaterCooler_u.pipe 2>&1)
diffSimulationResults("Buildings_11_Buildings.Fluid.HeatExchangers.Validation.HeaterCooler_u_res.mat","/mnt/ReferenceFiles/Buildings/csv/maint_11.x/Buildings_Fluid_HeatExchangers_Validation_HeaterCooler_u.csv","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_11_Buildings.Fluid.HeatExchangers.Validation.HeaterCooler_u.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001)
Reference file matches