Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_latest_Buildings.Fluid.Storage.BaseClasses.Examples.IndirectTankHeatExchanger.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 12.0.0-master/package.mo", uses=false)
Using package Buildings with version 12.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.0.0-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.Storage.BaseClasses.Examples.IndirectTankHeatExchanger,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|indTanHex.vol.1..T|indTanHex.vol.2..T|indTanHex.vol.3..T",fileNamePrefix="Buildings_latest_Buildings.Fluid.Storage.BaseClasses.Examples.IndirectTankHeatExchanger")
translateModel(Buildings.Fluid.Storage.BaseClasses.Examples.IndirectTankHeatExchanger,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|indTanHex.vol.1..T|indTanHex.vol.2..T|indTanHex.vol.3..T",fileNamePrefix="Buildings_latest_Buildings.Fluid.Storage.BaseClasses.Examples.IndirectTankHeatExchanger")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001362/0.001362, allocations: 111.6 kB / 16.42 MB, free: 6.484 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.001348/0.001348, allocations: 190.7 kB / 17.35 MB, free: 5.707 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.319/1.319, allocations: 222.9 MB / 241.1 MB, free: 15.19 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.0.0-master/package.mo): time 2.536/2.536, allocations: 472.7 MB / 0.746 GB, free: 496 kB / 0.6075 GB
Notification: Performance of FrontEnd - loaded program: time 0.001373/0.001373, allocations: 63.89 kB / 1.07 GB, free: 9.559 MB / 0.8419 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.8195/0.8209, allocations: 159.9 MB / 1.226 GB, free: 13.47 MB / 0.9512 GB
Notification: Performance of NFInst.instantiate(Buildings.Fluid.Storage.BaseClasses.Examples.IndirectTankHeatExchanger): time 0.02777/0.8487, allocations: 28.6 MB / 1.254 GB, free: 0.7734 MB / 0.9669 GB
Notification: Performance of NFInst.instExpressions: time 0.01009/0.8588, allocations: 7.918 MB / 1.262 GB, free: 8.84 MB / 0.9825 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001085/0.8599, allocations: 35.81 kB / 1.262 GB, free: 8.805 MB / 0.9825 GB
Notification: Performance of NFTyping.typeComponents: time 0.001029/0.861, allocations: 417.2 kB / 1.262 GB, free: 8.395 MB / 0.9825 GB
Notification: Performance of NFTyping.typeBindings: time 0.002596/0.8636, allocations: 1.061 MB / 1.263 GB, free: 7.328 MB / 0.9825 GB
Notification: Performance of NFTyping.typeClassSections: time 0.00244/0.8661, allocations: 1.085 MB / 1.265 GB, free: 6.25 MB / 0.9825 GB
Notification: Performance of NFFlatten.flatten: time 0.004378/0.8705, allocations: 4.919 MB / 1.269 GB, free: 1.312 MB / 0.9825 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.002392/0.8729, allocations: 2.277 MB / 1.272 GB, free: 15 MB / 0.9981 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.003273/0.8762, allocations: 1.827 MB / 1.273 GB, free: 13.18 MB / 0.9981 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.002171/0.8783, allocations: 1.451 MB / 1.275 GB, free: 11.72 MB / 0.9981 GB
Notification: Performance of NFPackage.collectConstants: time 0.0005693/0.8789, allocations: 232 kB / 1.275 GB, free: 11.49 MB / 0.9981 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.002801/0.8817, allocations: 1.307 MB / 1.276 GB, free: 10.18 MB / 0.9981 GB
Notification: Performance of NFScalarize.scalarize: time 0.0007992/0.8825, allocations: 0.5569 MB / 1.277 GB, free: 9.625 MB / 0.9981 GB
Notification: Performance of NFVerifyModel.verify: time 0.001911/0.8845, allocations: 1.163 MB / 1.278 GB, free: 8.457 MB / 0.9981 GB
Notification: Performance of NFConvertDAE.convert: time 0.004875/0.8894, allocations: 3.692 MB / 1.282 GB, free: 4.758 MB / 0.9981 GB
Notification: Performance of FrontEnd - DAE generated: time 5.039e-06/0.8894, allocations: 0 / 1.282 GB, free: 4.758 MB / 0.9981 GB
Notification: Performance of FrontEnd: time 1.362e-06/0.8894, allocations: 0 / 1.282 GB, free: 4.758 MB / 0.9981 GB
Notification: Performance of Transformations before backend: time 9.79e-05/0.8895, allocations: 0 / 1.282 GB, free: 4.758 MB / 0.9981 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 348
 * Number of variables: 348
Notification: Performance of Generate backend data structure: time 0.005534/0.895, allocations: 2.621 MB / 1.284 GB, free: 2.078 MB / 0.9981 GB
Notification: Performance of prepare preOptimizeDAE: time 4.167e-05/0.8951, allocations: 12.03 kB / 1.284 GB, free: 2.066 MB / 0.9981 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0007989/0.8959, allocations: 243.6 kB / 1.284 GB, free: 1.828 MB / 0.9981 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.002765/0.8987, allocations: 1.811 MB / 1.286 GB, free: 15.96 MB / 1.014 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 7.386e-05/0.8987, allocations: 114.7 kB / 1.286 GB, free: 15.85 MB / 1.014 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0002318/0.899, allocations: 156 kB / 1.286 GB, free: 15.7 MB / 1.014 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.002767/0.9018, allocations: 2.005 MB / 1.288 GB, free: 13.63 MB / 1.014 GB
Notification: Performance of preOpt findStateOrder (simulation): time 3.88e-05/0.9018, allocations: 7.938 kB / 1.288 GB, free: 13.62 MB / 1.014 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001405/0.902, allocations: 59.94 kB / 1.288 GB, free: 13.57 MB / 1.014 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 4.121e-05/0.902, allocations: 40 kB / 1.288 GB, free: 13.53 MB / 1.014 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.002478/0.9045, allocations: 1.802 MB / 1.29 GB, free: 11.72 MB / 1.014 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.0116/0.9161, allocations: 7.615 MB / 1.298 GB, free: 3.801 MB / 1.014 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.001775/0.9179, allocations: 1.441 MB / 1.299 GB, free: 2.332 MB / 1.014 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0008429/0.9188, allocations: 0.6661 MB / 1.3 GB, free: 1.664 MB / 1.014 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.006109/0.9249, allocations: 3.855 MB / 1.303 GB, free: 13.49 MB / 1.029 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.762e-05/0.925, allocations: 47.55 kB / 1.303 GB, free: 13.44 MB / 1.029 GB
Notification: Performance of pre-optimization done (n=88): time 3.537e-06/0.925, allocations: 0 / 1.303 GB, free: 13.44 MB / 1.029 GB
Notification: Performance of matching and sorting (n=88): time 0.002483/0.9275, allocations: 1.522 MB / 1.305 GB, free: 11.91 MB / 1.029 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 3.14e-05/0.9275, allocations: 60.41 kB / 1.305 GB, free: 11.84 MB / 1.029 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002212/0.9297, allocations: 1.649 MB / 1.307 GB, free: 10.18 MB / 1.029 GB
Notification: Performance of collectPreVariables (initialization): time 0.0001064/0.9298, allocations: 53.7 kB / 1.307 GB, free: 10.12 MB / 1.029 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0006042/0.9304, allocations: 0.7709 MB / 1.307 GB, free: 9.34 MB / 1.029 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0002753/0.9307, allocations: 329.2 kB / 1.308 GB, free: 9.016 MB / 1.029 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0004153/0.9312, allocations: 291.5 kB / 1.308 GB, free: 8.723 MB / 1.029 GB
Notification: Performance of setup shared object (initialization): time 0.0001269/0.9313, allocations: 365.9 kB / 1.308 GB, free: 8.359 MB / 1.029 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0009665/0.9323, allocations: 0.6917 MB / 1.309 GB, free: 7.664 MB / 1.029 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001201/0.9335, allocations: 1.016 MB / 1.31 GB, free: 6.516 MB / 1.029 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.001995/0.9355, allocations: 1.628 MB / 1.312 GB, free: 4.766 MB / 1.029 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 9.318e-06/0.9355, allocations: 8 kB / 1.312 GB, free: 4.758 MB / 1.029 GB
Notification: Performance of matching and sorting (n=175) (initialization): time 0.00296/0.9385, allocations: 1.956 MB / 1.314 GB, free: 2.793 MB / 1.029 GB
Notification: Performance of prepare postOptimizeDAE: time 2.152e-05/0.9385, allocations: 8 kB / 1.314 GB, free: 2.785 MB / 1.029 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.417e-05/0.9385, allocations: 8.906 kB / 1.314 GB, free: 2.777 MB / 1.029 GB
Notification: Performance of postOpt tearingSystem (initialization): time 2.828e-05/0.9385, allocations: 16 kB / 1.314 GB, free: 2.762 MB / 1.029 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001231/0.9398, allocations: 339.5 kB / 1.314 GB, free: 2.43 MB / 1.029 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 3.626e-05/0.9398, allocations: 23.92 kB / 1.314 GB, free: 2.406 MB / 1.029 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001127/0.941, allocations: 194.6 kB / 1.314 GB, free: 2.215 MB / 1.029 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001229/0.9411, allocations: 63.98 kB / 1.314 GB, free: 2.152 MB / 1.029 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.001679/0.9428, allocations: 1.284 MB / 1.315 GB, free: 0.8633 MB / 1.029 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.001184/0.944, allocations: 1.02 MB / 1.316 GB, free: 15.72 MB / 1.045 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.001997/0.946, allocations: 1.62 MB / 1.318 GB, free: 13.98 MB / 1.045 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 7.864e-06/0.946, allocations: 4 kB / 1.318 GB, free: 13.97 MB / 1.045 GB
Notification: Performance of matching and sorting (n=175) (initialization_lambda0): time 0.002957/0.949, allocations: 1.956 MB / 1.32 GB, free: 12.01 MB / 1.045 GB
Notification: Performance of prepare postOptimizeDAE: time 1.593e-05/0.949, allocations: 12 kB / 1.32 GB, free: 12 MB / 1.045 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.103e-05/0.949, allocations: 8 kB / 1.32 GB, free: 11.99 MB / 1.045 GB
Notification: Performance of postOpt tearingSystem (initialization): time 1.725e-05/0.949, allocations: 16 kB / 1.32 GB, free: 11.97 MB / 1.045 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001204/0.9502, allocations: 339.4 kB / 1.32 GB, free: 11.64 MB / 1.045 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.647e-05/0.9503, allocations: 23.88 kB / 1.32 GB, free: 11.62 MB / 1.045 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001097/0.9514, allocations: 151.6 kB / 1.32 GB, free: 11.47 MB / 1.045 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001185/0.9515, allocations: 63.98 kB / 1.321 GB, free: 11.41 MB / 1.045 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 40
 * 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 initialization (175):
 * Single equations (assignments): 175
 * Array equations: 0
 * Algorithm blocks: 0
 * 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.0002955/0.9518, allocations: 271.7 kB / 1.321 GB, free: 11.13 MB / 1.045 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0003442/0.9522, allocations: 155 kB / 1.321 GB, free: 10.98 MB / 1.045 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.001962/0.9541, allocations: 1.274 MB / 1.322 GB, free: 9.695 MB / 1.045 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.00141/0.9556, allocations: 1.292 MB / 1.323 GB, free: 8.32 MB / 1.045 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 4.709e-06/0.9556, allocations: 0 / 1.323 GB, free: 8.32 MB / 1.045 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0006527/0.9562, allocations: 395.8 kB / 1.324 GB, free: 7.914 MB / 1.045 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0002442/0.9565, allocations: 20 kB / 1.324 GB, free: 7.895 MB / 1.045 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0007313/0.9572, allocations: 47.89 kB / 1.324 GB, free: 7.848 MB / 1.045 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001022/0.9573, allocations: 56.92 kB / 1.324 GB, free: 7.789 MB / 1.045 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.002067/0.9594, allocations: 1.251 MB / 1.325 GB, free: 6.535 MB / 1.045 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.0025/0.9619, allocations: 2.033 MB / 1.327 GB, free: 4.484 MB / 1.045 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.0006432/0.9626, allocations: 0.527 MB / 1.328 GB, free: 3.957 MB / 1.045 GB
Notification: Performance of sorting global known variables: time 0.001544/0.9641, allocations: 1.165 MB / 1.329 GB, free: 2.793 MB / 1.045 GB
Notification: Performance of Backend: time 3.31e-07/0.9641, allocations: 0 / 1.329 GB, free: 2.793 MB / 1.045 GB
Notification: Performance of simCode: created initialization part: time 0.004334/0.9685, allocations: 2.304 MB / 1.331 GB, free: 0.4961 MB / 1.045 GB
Notification: Performance of SimCode: time 0.00701/0.9755, allocations: 4.428 MB / 1.335 GB, free: 12.02 MB / 1.061 GB
Notification: Performance of Templates: time 0.0643/1.04, allocations: 42.44 MB / 1.377 GB, free: 1.918 MB / 1.092 GB
make -j1 -f Buildings_latest_Buildings.Fluid.Storage.BaseClasses.Examples.IndirectTankHeatExchanger.makefile
(rm -f Buildings_latest_Buildings.Fluid.Storage.BaseClasses.Examples.IndirectTankHeatExchanger.pipe ; mkfifo Buildings_latest_Buildings.Fluid.Storage.BaseClasses.Examples.IndirectTankHeatExchanger.pipe ; head -c 1048576 < Buildings_latest_Buildings.Fluid.Storage.BaseClasses.Examples.IndirectTankHeatExchanger.pipe >> ../files/Buildings_latest_Buildings.Fluid.Storage.BaseClasses.Examples.IndirectTankHeatExchanger.sim & ./Buildings_latest_Buildings.Fluid.Storage.BaseClasses.Examples.IndirectTankHeatExchanger  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > Buildings_latest_Buildings.Fluid.Storage.BaseClasses.Examples.IndirectTankHeatExchanger.pipe 2>&1)
diffSimulationResults("Buildings_latest_Buildings.Fluid.Storage.BaseClasses.Examples.IndirectTankHeatExchanger_res.mat","/mnt/ReferenceFiles/Buildings/csv/master/Buildings_Fluid_Storage_BaseClasses_Examples_IndirectTankHeatExchanger.csv","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_latest_Buildings.Fluid.Storage.BaseClasses.Examples.IndirectTankHeatExchanger.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001)
Reference file matches