Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr IBPSA_latest_IBPSA.Fluid.Storage.BaseClasses.Examples.IndirectTankHeatExchanger.conf.json
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/IBPSA 4.0.0-master/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/ModelicaServices 4.0.0+maint.om/package.mo", uses=false)
Using package ModelicaServices with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/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 IBPSA with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 4.0.0-master/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)
Running command: translateModel(IBPSA.Fluid.Storage.BaseClasses.Examples.IndirectTankHeatExchanger,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IBPSA_latest_IBPSA.Fluid.Storage.BaseClasses.Examples.IndirectTankHeatExchanger")
translateModel(IBPSA.Fluid.Storage.BaseClasses.Examples.IndirectTankHeatExchanger,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IBPSA_latest_IBPSA.Fluid.Storage.BaseClasses.Examples.IndirectTankHeatExchanger")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001778/0.001779, allocations: 185.1 kB / 16.63 MB, free: 5.117 MB / 13.93 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 4.0.0-master/package.mo): time 0.5374/0.5374, allocations: 87.49 MB / 104.9 MB, free: 13.04 MB / 90.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.456/1.456, allocations: 222.9 MB / 349.1 MB, free: 2.77 MB / 282.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001059/0.001059, allocations: 103.9 kB / 420 MB, free: 8.5 MB / 314.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.001016/0.001017, allocations: 63.84 kB / 0.4891 GB, free: 7.691 MB / 394.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.4031/0.4042, allocations: 70.06 MB / 0.5575 GB, free: 44.79 MB / 410.7 MB
Notification: Performance of NFInst.instantiate(IBPSA.Fluid.Storage.BaseClasses.Examples.IndirectTankHeatExchanger): time 0.02124/0.4255, allocations: 28.4 MB / 0.5852 GB, free: 16.71 MB / 410.7 MB
Notification: Performance of NFInst.instExpressions: time 0.01026/0.4358, allocations: 7.974 MB / 0.593 GB, free: 8.719 MB / 410.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.00144/0.4372, allocations: 31.81 kB / 0.593 GB, free: 8.688 MB / 410.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.001033/0.4383, allocations: 326.1 kB / 0.5934 GB, free: 8.367 MB / 410.7 MB
Notification: Performance of NFTyping.typeBindings: time 0.002436/0.4408, allocations: 0.9263 MB / 0.5943 GB, free: 7.438 MB / 410.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.002353/0.4432, allocations: 0.9442 MB / 0.5952 GB, free: 6.5 MB / 410.7 MB
Notification: Performance of NFFlatten.flatten: time 0.004433/0.4476, allocations: 6.115 MB / 0.6012 GB, free: 384 kB / 410.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.002291/0.4499, allocations: 1.859 MB / 0.603 GB, free: 14.48 MB / 426.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.0037/0.4536, allocations: 1.416 MB / 0.6044 GB, free: 13.05 MB / 426.7 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.003372/0.457, allocations: 1.385 MB / 0.6057 GB, free: 11.66 MB / 426.7 MB
Notification: Performance of NFPackage.collectConstants: time 0.0003615/0.4574, allocations: 104 kB / 0.6058 GB, free: 11.56 MB / 426.7 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.003078/0.4605, allocations: 1.158 MB / 0.6069 GB, free: 10.4 MB / 426.7 MB
Notification: Performance of NFScalarize.scalarize: time 0.0005188/0.4611, allocations: 422.3 kB / 0.6073 GB, free: 9.988 MB / 426.7 MB
Notification: Performance of NFVerifyModel.verify: time 0.001678/0.4627, allocations: 1.007 MB / 0.6083 GB, free: 8.977 MB / 426.7 MB
Notification: Performance of NFConvertDAE.convert: time 0.004859/0.4676, allocations: 3.545 MB / 0.6118 GB, free: 5.422 MB / 426.7 MB
Notification: Performance of FrontEnd - DAE generated: time 6.803e-06/0.4676, allocations: 4 kB / 0.6118 GB, free: 5.418 MB / 426.7 MB
Notification: Performance of FrontEnd: time 1.673e-06/0.4676, allocations: 0 / 0.6118 GB, free: 5.418 MB / 426.7 MB
Notification: Performance of Transformations before backend: time 5.978e-05/0.4677, allocations: 0 / 0.6118 GB, free: 5.418 MB / 426.7 MB
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.005241/0.473, allocations: 2.552 MB / 0.6143 GB, free: 2.812 MB / 426.7 MB
Notification: Performance of prepare preOptimizeDAE: time 4.545e-05/0.473, allocations: 16.03 kB / 0.6143 GB, free: 2.797 MB / 426.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.000804/0.4738, allocations: 230.5 kB / 0.6145 GB, free: 2.57 MB / 426.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.003298/0.4771, allocations: 1.77 MB / 0.6162 GB, free: 0.7461 MB / 426.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001045/0.4773, allocations: 118.7 kB / 0.6164 GB, free: 0.6289 MB / 426.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0002281/0.4775, allocations: 156 kB / 0.6165 GB, free: 488 kB / 426.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.003145/0.4807, allocations: 2.005 MB / 0.6185 GB, free: 14.41 MB / 442.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 3.534e-05/0.4807, allocations: 0 / 0.6185 GB, free: 14.41 MB / 442.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.000128/0.4808, allocations: 60 kB / 0.6185 GB, free: 14.35 MB / 442.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 4.537e-05/0.4809, allocations: 36 kB / 0.6186 GB, free: 14.31 MB / 442.7 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.00266/0.4836, allocations: 1.798 MB / 0.6203 GB, free: 12.51 MB / 442.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.01137/0.4949, allocations: 7.59 MB / 0.6277 GB, free: 4.609 MB / 442.7 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.001773/0.4967, allocations: 1.453 MB / 0.6291 GB, free: 3.133 MB / 442.7 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0008158/0.4976, allocations: 0.6705 MB / 0.6298 GB, free: 2.465 MB / 442.7 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.006412/0.504, allocations: 3.83 MB / 0.6335 GB, free: 14.32 MB / 458.7 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 4.099e-05/0.5041, allocations: 43.56 kB / 0.6336 GB, free: 14.27 MB / 458.7 MB
Notification: Performance of pre-optimization done (n=88): time 2.885e-06/0.5041, allocations: 0 / 0.6336 GB, free: 14.27 MB / 458.7 MB
Notification: Performance of matching and sorting (n=88): time 0.002784/0.5069, allocations: 1.514 MB / 0.6351 GB, free: 12.74 MB / 458.7 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 5.552e-05/0.5069, allocations: 60.41 kB / 0.6351 GB, free: 12.67 MB / 458.7 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002316/0.5093, allocations: 1.606 MB / 0.6367 GB, free: 11.05 MB / 458.7 MB
Notification: Performance of collectPreVariables (initialization): time 0.0001039/0.5094, allocations: 53.7 kB / 0.6367 GB, free: 10.99 MB / 458.7 MB
Notification: Performance of collectInitialEqns (initialization): time 0.0005991/0.51, allocations: 0.7575 MB / 0.6375 GB, free: 10.23 MB / 458.7 MB
Notification: Performance of collectInitialBindings (initialization): time 0.0002839/0.5103, allocations: 307.6 kB / 0.6378 GB, free: 9.922 MB / 458.7 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0004061/0.5107, allocations: 291.3 kB / 0.638 GB, free: 9.633 MB / 458.7 MB
Notification: Performance of setup shared object (initialization): time 0.0001461/0.5108, allocations: 369.9 kB / 0.6384 GB, free: 9.266 MB / 458.7 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0009495/0.5118, allocations: 0.6878 MB / 0.6391 GB, free: 8.574 MB / 458.7 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001191/0.513, allocations: 1.024 MB / 0.6401 GB, free: 7.418 MB / 458.7 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.001948/0.515, allocations: 1.624 MB / 0.6417 GB, free: 5.672 MB / 458.7 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 9.548e-06/0.515, allocations: 7.938 kB / 0.6417 GB, free: 5.664 MB / 458.7 MB
Notification: Performance of matching and sorting (n=175) (initialization): time 0.002898/0.5179, allocations: 1.947 MB / 0.6436 GB, free: 3.707 MB / 458.7 MB
Notification: Performance of prepare postOptimizeDAE: time 2.57e-05/0.5179, allocations: 8 kB / 0.6436 GB, free: 3.699 MB / 458.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.663e-05/0.5179, allocations: 15.97 kB / 0.6436 GB, free: 3.684 MB / 458.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 3.574e-05/0.518, allocations: 16.75 kB / 0.6436 GB, free: 3.668 MB / 458.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001148/0.5191, allocations: 331.5 kB / 0.6439 GB, free: 3.344 MB / 458.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.467e-05/0.5192, allocations: 27.92 kB / 0.6439 GB, free: 3.316 MB / 458.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001264/0.5204, allocations: 214 kB / 0.6441 GB, free: 3.105 MB / 458.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001086/0.5206, allocations: 67.92 kB / 0.6442 GB, free: 3.039 MB / 458.7 MB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.001734/0.5223, allocations: 1.284 MB / 0.6455 GB, free: 1.75 MB / 458.7 MB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.001175/0.5235, allocations: 1.024 MB / 0.6465 GB, free: 0.6016 MB / 458.7 MB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.001943/0.5254, allocations: 1.612 MB / 0.648 GB, free: 14.86 MB / 474.7 MB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 7.254e-06/0.5255, allocations: 4 kB / 0.648 GB, free: 14.86 MB / 474.7 MB
Notification: Performance of matching and sorting (n=175) (initialization_lambda0): time 0.002875/0.5283, allocations: 1.952 MB / 0.65 GB, free: 12.9 MB / 474.7 MB
Notification: Performance of prepare postOptimizeDAE: time 1.702e-05/0.5284, allocations: 8.188 kB / 0.65 GB, free: 12.89 MB / 474.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.131e-05/0.5284, allocations: 19.98 kB / 0.65 GB, free: 12.87 MB / 474.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 2.35e-05/0.5284, allocations: 16 kB / 0.65 GB, free: 12.86 MB / 474.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.00112/0.5295, allocations: 331.5 kB / 0.6503 GB, free: 12.53 MB / 474.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.188e-05/0.5296, allocations: 19.92 kB / 0.6503 GB, free: 12.51 MB / 474.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001168/0.5307, allocations: 170.8 kB / 0.6505 GB, free: 12.34 MB / 474.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001033/0.5309, allocations: 59.98 kB / 0.6505 GB, free: 12.29 MB / 474.7 MB
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.0003436/0.5312, allocations: 260.4 kB / 0.6508 GB, free: 12.02 MB / 474.7 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0002796/0.5315, allocations: 150.1 kB / 0.6509 GB, free: 11.88 MB / 474.7 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.002023/0.5335, allocations: 1.275 MB / 0.6522 GB, free: 10.59 MB / 474.7 MB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.345e-05/0.5335, allocations: 8 kB / 0.6522 GB, free: 10.58 MB / 474.7 MB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.244e-05/0.5336, allocations: 8.125 kB / 0.6522 GB, free: 10.57 MB / 474.7 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.00135/0.5349, allocations: 1.288 MB / 0.6535 GB, free: 9.195 MB / 474.7 MB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.004213/0.5391, allocations: 2.932 MB / 0.6563 GB, free: 6.188 MB / 474.7 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 7.724e-06/0.5392, allocations: 4 kB / 0.6563 GB, free: 6.184 MB / 474.7 MB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0007565/0.5399, allocations: 183.8 kB / 0.6565 GB, free: 6.004 MB / 474.7 MB
Notification: Performance of postOpt tearingSystem (simulation): time 1.333e-05/0.54, allocations: 4 kB / 0.6565 GB, free: 6 MB / 474.7 MB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 7.403e-05/0.54, allocations: 23.98 kB / 0.6565 GB, free: 5.977 MB / 474.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 9.518e-06/0.5401, allocations: 7.938 kB / 0.6565 GB, free: 5.969 MB / 474.7 MB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 6.882e-06/0.5401, allocations: 8.062 kB / 0.6565 GB, free: 5.961 MB / 474.7 MB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.03844/0.5785, allocations: 13.68 MB / 0.6699 GB, free: 8.094 MB / 490.7 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.001032/0.5796, allocations: 394.8 kB / 0.6703 GB, free: 7.688 MB / 490.7 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0003914/0.58, allocations: 28 kB / 0.6703 GB, free: 7.66 MB / 490.7 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001087/0.5811, allocations: 71.77 kB / 0.6704 GB, free: 7.59 MB / 490.7 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001124/0.5812, allocations: 64.8 kB / 0.6704 GB, free: 7.527 MB / 490.7 MB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 7.79e-05/0.5813, allocations: 35.98 kB / 0.6705 GB, free: 7.492 MB / 490.7 MB
Notification: Performance of sorting global known variables: time 0.001704/0.583, allocations: 1.207 MB / 0.6716 GB, free: 6.289 MB / 490.7 MB
Notification: Performance of sort global known variables: time 1.51e-07/0.583, allocations: 0 / 0.6716 GB, free: 6.289 MB / 490.7 MB
Notification: Performance of remove unused functions: time 0.003864/0.5869, allocations: 1.412 MB / 0.673 GB, free: 4.875 MB / 490.7 MB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 5
 * Number of states: 6 (indTanHex.vol[1].dynBal.U,indTanHex.vol[2].dynBal.U,indTanHex.vol[3].dynBal.U,indTanHex.cap[1].T,indTanHex.cap[2].T,indTanHex.cap[3].T)
 * Number of discrete variables: 0 ()
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (89):
 * Single equations (assignments): 87
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 2
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of Backend phase and start with SimCode phase: time 0.0008848/0.5878, allocations: 370 kB / 0.6734 GB, free: 4.516 MB / 490.7 MB
Notification: Performance of simCode: created initialization part: time 0.0035/0.5913, allocations: 2.321 MB / 0.6756 GB, free: 2.199 MB / 490.7 MB
Notification: Performance of simCode: created event and clocks part: time 3.697e-06/0.5913, allocations: 4 kB / 0.6756 GB, free: 2.195 MB / 490.7 MB
Notification: Performance of simCode: created simulation system equations: time 0.0006506/0.592, allocations: 0.517 MB / 0.6762 GB, free: 1.68 MB / 490.7 MB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.003726/0.5957, allocations: 0.8674 MB / 0.677 GB, free: 0.8281 MB / 490.7 MB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.00671/0.6024, allocations: 4.958 MB / 0.6818 GB, free: 11.81 MB / 0.4948 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001175/0.6036, allocations: 1.694 MB / 0.6835 GB, free: 10.08 MB / 0.4948 GB
Notification: Performance of simCode: alias equations: time 0.003156/0.6068, allocations: 0.9702 MB / 0.6844 GB, free: 9.117 MB / 0.4948 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0005609/0.6074, allocations: 155.3 kB / 0.6846 GB, free: 8.965 MB / 0.4948 GB
Notification: Performance of SimCode: time 9.22e-07/0.6074, allocations: 0 / 0.6846 GB, free: 8.965 MB / 0.4948 GB
Notification: Performance of Templates: time 0.3914/0.9988, allocations: 42.38 MB / 0.726 GB, free: 131.9 MB / 0.5105 GB
make -j1 -f IBPSA_latest_IBPSA.Fluid.Storage.BaseClasses.Examples.IndirectTankHeatExchanger.makefile
(rm -f IBPSA_latest_IBPSA.Fluid.Storage.BaseClasses.Examples.IndirectTankHeatExchanger.pipe ; mkfifo IBPSA_latest_IBPSA.Fluid.Storage.BaseClasses.Examples.IndirectTankHeatExchanger.pipe ; head -c 1048576 < IBPSA_latest_IBPSA.Fluid.Storage.BaseClasses.Examples.IndirectTankHeatExchanger.pipe >> ../files/IBPSA_latest_IBPSA.Fluid.Storage.BaseClasses.Examples.IndirectTankHeatExchanger.sim & ./IBPSA_latest_IBPSA.Fluid.Storage.BaseClasses.Examples.IndirectTankHeatExchanger  -abortSlowSimulation -alarm=480 -lv LOG_STATS > IBPSA_latest_IBPSA.Fluid.Storage.BaseClasses.Examples.IndirectTankHeatExchanger.pipe 2>&1)