Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_latest_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 11.0.1-master/package.mo", uses=false)
Using package Buildings with version 11.0.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.0.1-master/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_latest_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_latest_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.001564/0.001564, allocations: 110.8 kB / 16.42 MB, free: 6.496 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.001879/0.001879, allocations: 188.3 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.449/1.449, allocations: 222.9 MB / 241 MB, free: 15.16 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.0.1-master/package.mo): time 2.625/2.625, allocations: 461.9 MB / 0.7355 GB, free: 11.09 MB / 0.6075 GB
Notification: Performance of FrontEnd - loaded program: time 0.001415/0.001415, allocations: 68.11 kB / 1.055 GB, free: 7.699 MB / 0.8262 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.7787/0.7801, allocations: 157.4 MB / 1.208 GB, free: 13.67 MB / 0.9356 GB
Notification: Performance of NFInst.instantiate(Buildings.Fluid.HeatExchangers.Examples.WaterHeater_u): time 0.07161/0.8518, allocations: 67.46 MB / 1.274 GB, free: 9.977 MB / 0.9981 GB
Notification: Performance of NFInst.instExpressions: time 0.02949/0.8813, allocations: 18.6 MB / 1.292 GB, free: 7.34 MB / 1.014 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.003913/0.8853, allocations: 95.5 kB / 1.293 GB, free: 7.246 MB / 1.014 GB
Notification: Performance of NFTyping.typeComponents: time 0.006452/0.8917, allocations: 1.995 MB / 1.295 GB, free: 5.242 MB / 1.014 GB
Notification: Performance of NFTyping.typeBindings: time 0.008605/0.9003, allocations: 2.947 MB / 1.297 GB, free: 2.285 MB / 1.014 GB
Notification: Performance of NFTyping.typeClassSections: time 0.007002/0.9074, allocations: 2.44 MB / 1.3 GB, free: 15.86 MB / 1.029 GB
Notification: Performance of NFFlatten.flatten: time 0.01233/0.9197, allocations: 8.286 MB / 1.308 GB, free: 7.559 MB / 1.029 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.003515/0.9232, allocations: 1.938 MB / 1.31 GB, free: 5.566 MB / 1.029 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.005338/0.9286, allocations: 2.16 MB / 1.312 GB, free: 3.406 MB / 1.029 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.003025/0.9316, allocations: 1.558 MB / 1.313 GB, free: 1.844 MB / 1.029 GB
Notification: Performance of NFPackage.collectConstants: time 0.0007208/0.9324, allocations: 200 kB / 1.314 GB, free: 1.648 MB / 1.029 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.005086/0.9375, allocations: 2.152 MB / 1.316 GB, free: 15.49 MB / 1.045 GB
Notification: Performance of NFScalarize.scalarize: time 0.001109/0.9386, allocations: 0.6969 MB / 1.316 GB, free: 14.79 MB / 1.045 GB
Notification: Performance of NFVerifyModel.verify: time 0.002537/0.9411, allocations: 1.321 MB / 1.318 GB, free: 13.46 MB / 1.045 GB
Notification: Performance of NFConvertDAE.convert: time 0.006971/0.9481, allocations: 4.241 MB / 1.322 GB, free: 9.211 MB / 1.045 GB
Notification: Performance of FrontEnd - DAE generated: time 6.072e-06/0.9482, allocations: 4 kB / 1.322 GB, free: 9.207 MB / 1.045 GB
Notification: Performance of FrontEnd: time 1.302e-06/0.9482, allocations: 0 / 1.322 GB, free: 9.207 MB / 1.045 GB
Notification: Performance of Transformations before backend: time 0.0001094/0.9483, allocations: 0 / 1.322 GB, free: 9.207 MB / 1.045 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 314
 * Number of variables: 314
Notification: Performance of Generate backend data structure: time 0.00576/0.954, allocations: 3.099 MB / 1.325 GB, free: 6.023 MB / 1.045 GB
Notification: Performance of prepare preOptimizeDAE: time 6.4e-05/0.9541, allocations: 12.03 kB / 1.325 GB, free: 6.012 MB / 1.045 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.002059/0.9562, allocations: 476.4 kB / 1.325 GB, free: 5.543 MB / 1.045 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.004874/0.9611, allocations: 2.887 MB / 1.328 GB, free: 2.582 MB / 1.045 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 9.32e-05/0.9612, allocations: 98.45 kB / 1.328 GB, free: 2.484 MB / 1.045 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.000218/0.9614, allocations: 139.9 kB / 1.328 GB, free: 2.348 MB / 1.045 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.002754/0.9642, allocations: 1.452 MB / 1.33 GB, free: 0.8047 MB / 1.045 GB
Notification: Performance of preOpt findStateOrder (simulation): time 3.178e-05/0.9642, allocations: 3.938 kB / 1.33 GB, free: 0.8008 MB / 1.045 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001323/0.9643, allocations: 56 kB / 1.33 GB, free: 0.7461 MB / 1.045 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 4.848e-05/0.9644, allocations: 42.31 kB / 1.33 GB, free: 0.7031 MB / 1.045 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.002682/0.9671, allocations: 1.122 MB / 1.331 GB, free: 15.57 MB / 1.061 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.01052/0.9776, allocations: 7.742 MB / 1.339 GB, free: 7.254 MB / 1.061 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.002151/0.9798, allocations: 1.275 MB / 1.34 GB, free: 5.859 MB / 1.061 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001005/0.9808, allocations: 458 kB / 1.34 GB, free: 5.41 MB / 1.061 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.004811/0.9856, allocations: 2.712 MB / 1.343 GB, free: 2.465 MB / 1.061 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.001097/0.9868, allocations: 478.6 kB / 1.343 GB, free: 1.977 MB / 1.061 GB
Notification: Performance of pre-optimization done (n=62): time 3.206e-06/0.9868, allocations: 0 / 1.343 GB, free: 1.977 MB / 1.061 GB
Notification: Performance of matching and sorting (n=62): time 0.003183/0.99, allocations: 1.236 MB / 1.345 GB, free: 0.7148 MB / 1.061 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 5.859e-05/0.99, allocations: 115.4 kB / 1.345 GB, free: 0.5781 MB / 1.061 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002941/0.993, allocations: 2.071 MB / 1.347 GB, free: 14.48 MB / 1.076 GB
Notification: Performance of collectPreVariables (initialization): time 9.007e-05/0.9931, allocations: 41.7 kB / 1.347 GB, free: 14.43 MB / 1.076 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0009637/0.9941, allocations: 1.038 MB / 1.348 GB, free: 13.39 MB / 1.076 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0002204/0.9943, allocations: 220.9 kB / 1.348 GB, free: 13.17 MB / 1.076 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0004349/0.9947, allocations: 314.5 kB / 1.348 GB, free: 12.86 MB / 1.076 GB
Notification: Performance of setup shared object (initialization): time 9.983e-05/0.9948, allocations: 309.1 kB / 1.349 GB, free: 12.55 MB / 1.076 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001177/0.996, allocations: 0.5415 MB / 1.349 GB, free: 12 MB / 1.076 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001487/0.9975, allocations: 0.9696 MB / 1.35 GB, free: 10.85 MB / 1.076 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.002484/1, allocations: 1.422 MB / 1.351 GB, free: 9.273 MB / 1.076 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 8.706e-06/1, allocations: 4 kB / 1.351 GB, free: 9.27 MB / 1.076 GB
Notification: Performance of matching and sorting (n=188) (initialization): time 0.0035/1.004, allocations: 1.742 MB / 1.353 GB, free: 7.512 MB / 1.076 GB
Notification: Performance of prepare postOptimizeDAE: time 5.274e-05/1.004, allocations: 45.62 kB / 1.353 GB, free: 7.461 MB / 1.076 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.979e-05/1.004, allocations: 16.06 kB / 1.353 GB, free: 7.445 MB / 1.076 GB
Notification: Performance of postOpt tearingSystem (initialization): time 3.196e-05/1.004, allocations: 16 kB / 1.353 GB, free: 7.43 MB / 1.076 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001151/1.005, allocations: 291.6 kB / 1.353 GB, free: 7.145 MB / 1.076 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 3.962e-05/1.005, allocations: 31.86 kB / 1.353 GB, free: 7.113 MB / 1.076 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001534/1.006, allocations: 170.6 kB / 1.354 GB, free: 6.945 MB / 1.076 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001207/1.007, allocations: 63.98 kB / 1.354 GB, free: 6.883 MB / 1.076 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.001907/1.008, allocations: 0.9833 MB / 1.355 GB, free: 5.898 MB / 1.076 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.001433/1.01, allocations: 0.9619 MB / 1.356 GB, free: 4.766 MB / 1.076 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.002457/1.012, allocations: 1.43 MB / 1.357 GB, free: 3.18 MB / 1.076 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 8.706e-06/1.012, allocations: 4 kB / 1.357 GB, free: 3.176 MB / 1.076 GB
Notification: Performance of matching and sorting (n=188) (initialization_lambda0): time 0.0036/1.016, allocations: 1.752 MB / 1.359 GB, free: 1.406 MB / 1.076 GB
Notification: Performance of prepare postOptimizeDAE: time 3.628e-05/1.016, allocations: 36.2 kB / 1.359 GB, free: 1.367 MB / 1.076 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.696e-05/1.016, allocations: 15.94 kB / 1.359 GB, free: 1.352 MB / 1.076 GB
Notification: Performance of postOpt tearingSystem (initialization): time 1.929e-05/1.016, allocations: 20.66 kB / 1.359 GB, free: 1.332 MB / 1.076 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001123/1.017, allocations: 307.5 kB / 1.359 GB, free: 1.031 MB / 1.076 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.827e-05/1.017, allocations: 23.94 kB / 1.359 GB, free: 1.008 MB / 1.076 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.00151/1.019, allocations: 151.1 kB / 1.359 GB, free: 0.8594 MB / 1.076 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001173/1.019, allocations: 55.98 kB / 1.359 GB, free: 0.8047 MB / 1.076 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 49
 * 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 (154):
 * Single equations (assignments): 151
 * Array equations: 1
 * Algorithm blocks: 1
 * Record equations: 1
 * 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.0003183/1.019, allocations: 251.9 kB / 1.36 GB, free: 0.5508 MB / 1.076 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0004525/1.02, allocations: 213.3 kB / 1.36 GB, free: 348 kB / 1.076 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.00271/1.022, allocations: 1.076 MB / 1.361 GB, free: 15.25 MB / 1.092 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.001897/1.024, allocations: 0.7764 MB / 1.362 GB, free: 14.46 MB / 1.092 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 7.014e-06/1.024, allocations: 4 kB / 1.362 GB, free: 14.46 MB / 1.092 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0007719/1.025, allocations: 390.1 kB / 1.362 GB, free: 14.05 MB / 1.092 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0003485/1.025, allocations: 16 kB / 1.362 GB, free: 14.04 MB / 1.092 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001087/1.027, allocations: 71.86 kB / 1.362 GB, free: 13.97 MB / 1.092 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001259/1.027, allocations: 48.5 kB / 1.362 GB, free: 13.92 MB / 1.092 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.00281/1.03, allocations: 1.175 MB / 1.363 GB, free: 12.73 MB / 1.092 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.003508/1.033, allocations: 1.741 MB / 1.365 GB, free: 10.97 MB / 1.092 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.000918/1.034, allocations: 412.3 kB / 1.365 GB, free: 10.57 MB / 1.092 GB
Notification: Performance of sorting global known variables: time 0.002494/1.036, allocations: 1.377 MB / 1.367 GB, free: 9.176 MB / 1.092 GB
Notification: Performance of Backend: time 5.01e-07/1.037, allocations: 4 kB / 1.367 GB, free: 9.172 MB / 1.092 GB
Notification: Performance of simCode: created initialization part: time 0.006517/1.043, allocations: 2.504 MB / 1.369 GB, free: 6.656 MB / 1.092 GB
Notification: Performance of SimCode: time 0.009399/1.052, allocations: 4.783 MB / 1.374 GB, free: 1.852 MB / 1.092 GB
Notification: Performance of Templates: time 0.07616/1.129, allocations: 45.85 MB / 1.419 GB, free: 4.484 MB / 1.139 GB
make -j1 -f Buildings_latest_Buildings.Fluid.HeatExchangers.Examples.WaterHeater_u.makefile
(rm -f Buildings_latest_Buildings.Fluid.HeatExchangers.Examples.WaterHeater_u.pipe ; mkfifo Buildings_latest_Buildings.Fluid.HeatExchangers.Examples.WaterHeater_u.pipe ; head -c 1048576 < Buildings_latest_Buildings.Fluid.HeatExchangers.Examples.WaterHeater_u.pipe >> ../files/Buildings_latest_Buildings.Fluid.HeatExchangers.Examples.WaterHeater_u.sim & ./Buildings_latest_Buildings.Fluid.HeatExchangers.Examples.WaterHeater_u  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > Buildings_latest_Buildings.Fluid.HeatExchangers.Examples.WaterHeater_u.pipe 2>&1)
diffSimulationResults("Buildings_latest_Buildings.Fluid.HeatExchangers.Examples.WaterHeater_u_res.mat","/mnt/ReferenceFiles/Buildings/csv/master/Buildings_Fluid_HeatExchangers_Examples_WaterHeater_u.csv","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_latest_Buildings.Fluid.HeatExchangers.Examples.WaterHeater_u.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001)
Reference file matches