Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_9_Buildings.Fluid.HeatExchangers.Examples.WaterHeater_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 9.1.3-maint.9.1.x/package.mo", uses=false)
Using package Buildings with version 9.1.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 9.1.3-maint.9.1.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.Examples.WaterHeater_u,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|TSet.y|TOut.y|TVol.T|THeaOut.T|hea.Q_flow",fileNamePrefix="Buildings_9_Buildings.Fluid.HeatExchangers.Examples.WaterHeater_u")
translateModel(Buildings.Fluid.HeatExchangers.Examples.WaterHeater_u,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|TSet.y|TOut.y|TVol.T|THeaOut.T|hea.Q_flow",fileNamePrefix="Buildings_9_Buildings.Fluid.HeatExchangers.Examples.WaterHeater_u")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001266/0.001265, allocations: 109.2 kB / 16.42 MB, free: 6.488 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.001207/0.001207, allocations: 185.7 kB / 17.35 MB, free: 5.762 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.346/1.346, allocations: 222.9 MB / 241 MB, free: 15.15 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 9.1.3-maint.9.1.x/package.mo): time 2.183/2.183, allocations: 390.3 MB / 0.6655 GB, free: 0.6094 MB / 0.5294 GB
Notification: Performance of FrontEnd - loaded program: time 0.001276/0.001276, allocations: 63.91 kB / 0.9516 GB, free: 7.629 MB / 0.7325 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.729/0.7303, allocations: 140.4 MB / 1.089 GB, free: 5.516 MB / 0.8575 GB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/Blocks/Math.mo:543:5-544:48:writable] Warning: Parameter mov.gaiSpe.k has no value, and is fixed during initialization (fixed=true), using available start value (start=1) as default value.
Notification: Performance of NFInst.instantiate(Buildings.Fluid.HeatExchangers.Examples.WaterHeater_u): time 0.06896/0.7993, allocations: 67.02 MB / 1.154 GB, free: 5.484 MB / 0.9044 GB
Notification: Performance of NFInst.instExpressions: time 0.02618/0.8255, allocations: 16.77 MB / 1.17 GB, free: 9.48 MB / 0.92 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.003774/0.8293, allocations: 98.31 kB / 1.171 GB, free: 9.445 MB / 0.92 GB
Notification: Performance of NFTyping.typeComponents: time 0.003821/0.8332, allocations: 1.186 MB / 1.172 GB, free: 8.762 MB / 0.92 GB
Notification: Performance of NFTyping.typeBindings: time 0.008459/0.8417, allocations: 2.782 MB / 1.174 GB, free: 7.133 MB / 0.92 GB
Notification: Performance of NFTyping.typeClassSections: time 0.007556/0.8492, allocations: 2.363 MB / 1.177 GB, free: 5.855 MB / 0.92 GB
Notification: Performance of NFFlatten.flatten: time 0.008869/0.8581, allocations: 5.371 MB / 1.182 GB, free: 2.699 MB / 0.92 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.003222/0.8614, allocations: 1.894 MB / 1.184 GB, free: 1.457 MB / 0.92 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.005072/0.8664, allocations: 2.155 MB / 1.186 GB, free: 172 kB / 0.92 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.002795/0.8693, allocations: 1.492 MB / 1.187 GB, free: 15.23 MB / 0.9356 GB
Notification: Performance of NFPackage.collectConstants: time 0.0005308/0.8698, allocations: 190.1 kB / 1.188 GB, free: 15.23 MB / 0.9356 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.004924/0.8747, allocations: 1.97 MB / 1.19 GB, free: 14.18 MB / 0.9356 GB
Notification: Performance of NFScalarize.scalarize: time 0.0008102/0.8756, allocations: 0.5523 MB / 1.19 GB, free: 13.76 MB / 0.9356 GB
Notification: Performance of NFVerifyModel.verify: time 0.002102/0.8777, allocations: 1.138 MB / 1.191 GB, free: 12.98 MB / 0.9356 GB
Notification: Performance of NFConvertDAE.convert: time 0.006466/0.8841, allocations: 3.646 MB / 1.195 GB, free: 10.54 MB / 0.9356 GB
Notification: Performance of FrontEnd - DAE generated: time 4.448e-06/0.8842, allocations: 1.312 kB / 1.195 GB, free: 10.54 MB / 0.9356 GB
Notification: Performance of FrontEnd: time 1.442e-06/0.8842, allocations: 0 / 1.195 GB, free: 10.54 MB / 0.9356 GB
Notification: Performance of Transformations before backend: time 0.0001082/0.8843, allocations: 4 kB / 1.195 GB, free: 10.54 MB / 0.9356 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 310
 * Number of variables: 310
Notification: Performance of Generate backend data structure: time 0.007173/0.8915, allocations: 2.671 MB / 1.197 GB, free: 8.535 MB / 0.9356 GB
Notification: Performance of prepare preOptimizeDAE: time 4.371e-05/0.8915, allocations: 8.719 kB / 1.197 GB, free: 8.535 MB / 0.9356 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.002561/0.8941, allocations: 459.4 kB / 1.198 GB, free: 8.332 MB / 0.9356 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.004608/0.8987, allocations: 1.856 MB / 1.2 GB, free: 6.953 MB / 0.9356 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001177/0.8989, allocations: 99.62 kB / 1.2 GB, free: 6.906 MB / 0.9356 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0002995/0.8992, allocations: 129 kB / 1.2 GB, free: 6.867 MB / 0.9356 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.003791/0.903, allocations: 1.454 MB / 1.201 GB, free: 5.922 MB / 0.9356 GB
Notification: Performance of preOpt findStateOrder (simulation): time 5.675e-05/0.903, allocations: 8.828 kB / 1.201 GB, free: 5.914 MB / 0.9356 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0002264/0.9033, allocations: 49 kB / 1.201 GB, free: 5.879 MB / 0.9356 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 7.749e-05/0.9034, allocations: 48.41 kB / 1.201 GB, free: 5.871 MB / 0.9356 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.003014/0.9064, allocations: 1.149 MB / 1.202 GB, free: 5.301 MB / 0.9356 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.01143/0.9178, allocations: 7.409 MB / 1.21 GB, free: 14.68 MB / 0.9512 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.002537/0.9204, allocations: 1.337 MB / 1.211 GB, free: 13.66 MB / 0.9512 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001278/0.9217, allocations: 474 kB / 1.211 GB, free: 13.43 MB / 0.9512 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.005493/0.9272, allocations: 2.697 MB / 1.214 GB, free: 11.05 MB / 0.9512 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.001286/0.9285, allocations: 0.4897 MB / 1.215 GB, free: 10.75 MB / 0.9512 GB
Notification: Performance of pre-optimization done (n=63): time 3.236e-06/0.9285, allocations: 0 / 1.215 GB, free: 10.75 MB / 0.9512 GB
Notification: Performance of matching and sorting (n=63): time 0.003622/0.9322, allocations: 1.272 MB / 1.216 GB, free: 10.06 MB / 0.9512 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 5.609e-05/0.9322, allocations: 114.1 kB / 1.216 GB, free: 9.934 MB / 0.9512 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002518/0.9348, allocations: 1.48 MB / 1.217 GB, free: 8.977 MB / 0.9512 GB
Notification: Performance of collectPreVariables (initialization): time 0.0001083/0.9349, allocations: 45.69 kB / 1.217 GB, free: 8.926 MB / 0.9512 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0008107/0.9357, allocations: 0.8996 MB / 1.218 GB, free: 8.016 MB / 0.9512 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0002407/0.936, allocations: 216.8 kB / 1.218 GB, free: 7.801 MB / 0.9512 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0003308/0.9363, allocations: 210.4 kB / 1.219 GB, free: 7.59 MB / 0.9512 GB
Notification: Performance of setup shared object (initialization): time 0.0001787/0.9365, allocations: 345.9 kB / 1.219 GB, free: 7.246 MB / 0.9512 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001028/0.9375, allocations: 400.6 kB / 1.219 GB, free: 6.852 MB / 0.9512 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0013/0.9388, allocations: 0.7476 MB / 1.22 GB, free: 5.938 MB / 0.9512 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.002211/0.9411, allocations: 1.133 MB / 1.221 GB, free: 4.656 MB / 0.9512 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 6.673e-06/0.9411, allocations: 0 / 1.221 GB, free: 4.656 MB / 0.9512 GB
Notification: Performance of matching and sorting (n=122) (initialization): time 0.003109/0.9442, allocations: 1.309 MB / 1.223 GB, free: 3.332 MB / 0.9512 GB
Notification: Performance of prepare postOptimizeDAE: time 5.211e-05/0.9443, allocations: 37.69 kB / 1.223 GB, free: 3.289 MB / 0.9512 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.739e-05/0.9443, allocations: 19.94 kB / 1.223 GB, free: 3.27 MB / 0.9512 GB
Notification: Performance of postOpt tearingSystem (initialization): time 2.983e-05/0.9443, allocations: 16 kB / 1.223 GB, free: 3.254 MB / 0.9512 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001045/0.9454, allocations: 252.3 kB / 1.223 GB, free: 3.008 MB / 0.9512 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.748e-05/0.9454, allocations: 27.86 kB / 1.223 GB, free: 2.98 MB / 0.9512 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001364/0.9468, allocations: 135.7 kB / 1.223 GB, free: 2.848 MB / 0.9512 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001088/0.9469, allocations: 51.98 kB / 1.223 GB, free: 2.797 MB / 0.9512 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.001651/0.9486, allocations: 0.6971 MB / 1.224 GB, free: 2.094 MB / 0.9512 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.001279/0.9499, allocations: 0.732 MB / 1.224 GB, free: 1.203 MB / 0.9512 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.002206/0.9521, allocations: 1.102 MB / 1.226 GB, free: 15.96 MB / 0.9669 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 5.52e-06/0.9521, allocations: 0 / 1.226 GB, free: 15.96 MB / 0.9669 GB
Notification: Performance of matching and sorting (n=122) (initialization_lambda0): time 0.003089/0.9552, allocations: 1.29 MB / 1.227 GB, free: 14.66 MB / 0.9669 GB
Notification: Performance of prepare postOptimizeDAE: time 3.759e-05/0.9552, allocations: 37.7 kB / 1.227 GB, free: 14.61 MB / 0.9669 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.492e-05/0.9553, allocations: 8 kB / 1.227 GB, free: 14.61 MB / 0.9669 GB
Notification: Performance of postOpt tearingSystem (initialization): time 1.699e-05/0.9553, allocations: 16 kB / 1.227 GB, free: 14.59 MB / 0.9669 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001027/0.9563, allocations: 255.7 kB / 1.227 GB, free: 14.34 MB / 0.9669 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.287e-05/0.9564, allocations: 23.92 kB / 1.227 GB, free: 14.32 MB / 0.9669 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001362/0.9577, allocations: 119.9 kB / 1.227 GB, free: 14.2 MB / 0.9669 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 9.89e-05/0.9578, allocations: 55.98 kB / 1.227 GB, free: 14.14 MB / 0.9669 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 45
 * Number of states: 0 ()
 * Number of discrete variables: 6 (TSet.count,$PRE.TSet.count,TSet.T_start,$PRE.TSet.T_start,$whenCondition1,conPI.I.trigger_internal)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (120):
 * Single equations (assignments): 118
 * Array equations: 1
 * Algorithm blocks: 1
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of prepare postOptimizeDAE: time 0.0003204/0.9582, allocations: 253.2 kB / 1.228 GB, free: 13.89 MB / 0.9669 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0004394/0.9586, allocations: 165.9 kB / 1.228 GB, free: 13.73 MB / 0.9669 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.00281/0.9614, allocations: 1.1 MB / 1.229 GB, free: 12.61 MB / 0.9669 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.001952/0.9634, allocations: 0.8121 MB / 1.23 GB, free: 11.79 MB / 0.9669 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 6.903e-06/0.9634, allocations: 4 kB / 1.23 GB, free: 11.78 MB / 0.9669 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0008973/0.9643, allocations: 334.7 kB / 1.23 GB, free: 11.43 MB / 0.9669 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.000405/0.9647, allocations: 23.92 kB / 1.23 GB, free: 11.41 MB / 0.9669 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001109/0.9658, allocations: 63.94 kB / 1.23 GB, free: 11.35 MB / 0.9669 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001389/0.966, allocations: 56.58 kB / 1.23 GB, free: 11.29 MB / 0.9669 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.003113/0.9691, allocations: 1.219 MB / 1.231 GB, free: 10.06 MB / 0.9669 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.003579/0.9727, allocations: 1.778 MB / 1.233 GB, free: 8.266 MB / 0.9669 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.0009618/0.9737, allocations: 433 kB / 1.233 GB, free: 7.84 MB / 0.9669 GB
Notification: Performance of sorting global known variables: time 0.001635/0.9753, allocations: 0.9891 MB / 1.234 GB, free: 6.859 MB / 0.9669 GB
Notification: Performance of Backend: time 5.21e-07/0.9753, allocations: 0 / 1.234 GB, free: 6.859 MB / 0.9669 GB
Notification: Performance of simCode: created initialization part: time 0.005579/0.9809, allocations: 1.898 MB / 1.236 GB, free: 4.941 MB / 0.9669 GB
Notification: Performance of SimCode: time 0.007281/0.9882, allocations: 3.964 MB / 1.24 GB, free: 0.9336 MB / 0.9669 GB
Notification: Performance of Templates: time 0.05922/1.047, allocations: 37.86 MB / 1.277 GB, free: 11.51 MB / 1.014 GB
make -j1 -f Buildings_9_Buildings.Fluid.HeatExchangers.Examples.WaterHeater_u.makefile
(rm -f Buildings_9_Buildings.Fluid.HeatExchangers.Examples.WaterHeater_u.pipe ; mkfifo Buildings_9_Buildings.Fluid.HeatExchangers.Examples.WaterHeater_u.pipe ; head -c 1048576 < Buildings_9_Buildings.Fluid.HeatExchangers.Examples.WaterHeater_u.pipe >> ../files/Buildings_9_Buildings.Fluid.HeatExchangers.Examples.WaterHeater_u.sim & ./Buildings_9_Buildings.Fluid.HeatExchangers.Examples.WaterHeater_u  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > Buildings_9_Buildings.Fluid.HeatExchangers.Examples.WaterHeater_u.pipe 2>&1)
diffSimulationResults("Buildings_9_Buildings.Fluid.HeatExchangers.Examples.WaterHeater_u_res.mat","/mnt/ReferenceFiles/Buildings/csv/maint_9.1.x/Buildings_Fluid_HeatExchangers_Examples_WaterHeater_u.csv","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_9_Buildings.Fluid.HeatExchangers.Examples.WaterHeater_u.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001)
Reference file matches