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/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/IBPSA 4.0.0-master/package.mo", uses=false)
Using package IBPSA with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 4.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(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/ModelicaServices 4.0.0+maint.om/package.mo): time 0.0008089/0.0008089, allocations: 92.7 kB / 15.7 MB, free: 472 kB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.0009849/0.0009849, allocations: 172.7 kB / 16.58 MB, free: 6.848 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.357/1.357, allocations: 223.3 MB / 240.6 MB, free: 5.422 MB / 190.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 4.0.0-master/package.mo): time 0.6952/0.6952, allocations: 115.5 MB / 407.2 MB, free: 2.852 MB / 334.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.000296/0.0002963, allocations: 12 kB / 495.2 MB, free: 6.738 MB / 350.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1284/0.1287, allocations: 77.53 MB / 0.5593 GB, free: 9.41 MB / 430.1 MB
Notification: Performance of NFInst.instantiate(IBPSA.Fluid.Storage.BaseClasses.Examples.IndirectTankHeatExchanger): time 0.2648/0.3936, allocations: 26.21 MB / 0.5849 GB, free: 11.94 MB / 446.1 MB
Notification: Performance of NFInst.instExpressions: time 0.009785/0.4034, allocations: 7.394 MB / 0.5921 GB, free: 11.81 MB / 446.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0009864/0.4044, allocations: 30 kB / 0.5922 GB, free: 11.81 MB / 446.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.0008541/0.4053, allocations: 290.9 kB / 0.5924 GB, free: 11.81 MB / 446.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.002246/0.4075, allocations: 0.8124 MB / 0.5932 GB, free: 11.71 MB / 446.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.0024/0.4099, allocations: 0.777 MB / 0.594 GB, free: 11.63 MB / 446.1 MB
Notification: Performance of NFFlatten.flatten: time 0.005711/0.4157, allocations: 5.256 MB / 0.5991 GB, free: 10.83 MB / 446.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.002392/0.4181, allocations: 1.618 MB / 0.6007 GB, free: 10.55 MB / 446.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.002599/0.4207, allocations: 1.315 MB / 0.602 GB, free: 10.25 MB / 446.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.002126/0.4228, allocations: 1.224 MB / 0.6032 GB, free: 9.98 MB / 446.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.0002369/0.4231, allocations: 82.31 kB / 0.6033 GB, free: 9.977 MB / 446.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.002467/0.4255, allocations: 0.9832 MB / 0.6042 GB, free: 9.918 MB / 446.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.0004244/0.426, allocations: 357.7 kB / 0.6046 GB, free: 9.848 MB / 446.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.0005588/0.4266, allocations: 420.5 kB / 0.605 GB, free: 9.754 MB / 446.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.002754/0.4293, allocations: 2.826 MB / 0.6077 GB, free: 9.277 MB / 446.1 MB
Notification: Performance of FrontEnd - DAE generated: time 4.91e-06/0.4293, allocations: 3.938 kB / 0.6077 GB, free: 9.273 MB / 446.1 MB
Notification: Performance of FrontEnd: time 1.833e-06/0.4293, allocations: 0 / 0.6077 GB, free: 9.273 MB / 446.1 MB
Notification: Performance of Transformations before backend: time 5.397e-05/0.4294, allocations: 0 / 0.6077 GB, free: 9.273 MB / 446.1 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.004076/0.4335, allocations: 2.171 MB / 0.6099 GB, free: 23.93 MB / 462.1 MB
Notification: Performance of prepare preOptimizeDAE: time 3.506e-05/0.4335, allocations: 9 kB / 0.6099 GB, free: 23.93 MB / 462.1 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0007612/0.4343, allocations: 232.9 kB / 0.6101 GB, free: 23.82 MB / 462.1 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.002553/0.4369, allocations: 1.724 MB / 0.6118 GB, free: 22.64 MB / 462.1 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 8.105e-05/0.437, allocations: 111.9 kB / 0.6119 GB, free: 22.59 MB / 462.1 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0002378/0.4372, allocations: 152.2 kB / 0.612 GB, free: 22.54 MB / 462.1 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.002995/0.4402, allocations: 1.984 MB / 0.614 GB, free: 21.32 MB / 462.1 MB
Notification: Performance of preOpt findStateOrder (simulation): time 3.764e-05/0.4403, allocations: 15.84 kB / 0.614 GB, free: 21.31 MB / 462.1 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001369/0.4404, allocations: 52.62 kB / 0.614 GB, free: 21.27 MB / 462.1 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 5.072e-05/0.4405, allocations: 44.2 kB / 0.6141 GB, free: 21.27 MB / 462.1 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.002565/0.443, allocations: 1.789 MB / 0.6158 GB, free: 20.34 MB / 462.1 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.009509/0.4525, allocations: 7.614 MB / 0.6233 GB, free: 14.64 MB / 462.1 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.001779/0.4543, allocations: 1.443 MB / 0.6247 GB, free: 13.83 MB / 462.1 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.000903/0.4553, allocations: 0.652 MB / 0.6253 GB, free: 13.5 MB / 462.1 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.005891/0.4612, allocations: 3.846 MB / 0.6291 GB, free: 10.31 MB / 462.1 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.825e-05/0.4612, allocations: 48.66 kB / 0.6291 GB, free: 10.26 MB / 462.1 MB
Notification: Performance of pre-optimization done (n=88): time 2.154e-06/0.4612, allocations: 0 / 0.6291 GB, free: 10.26 MB / 462.1 MB
Notification: Performance of matching and sorting (n=88): time 0.002282/0.4635, allocations: 1.51 MB / 0.6306 GB, free: 9.512 MB / 462.1 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 4.012e-05/0.4636, allocations: 64.09 kB / 0.6306 GB, free: 9.445 MB / 462.1 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002052/0.4656, allocations: 1.589 MB / 0.6322 GB, free: 8.586 MB / 462.1 MB
Notification: Performance of collectPreVariables (initialization): time 0.0001019/0.4657, allocations: 52.14 kB / 0.6322 GB, free: 8.535 MB / 462.1 MB
Notification: Performance of collectInitialEqns (initialization): time 0.000646/0.4664, allocations: 0.7553 MB / 0.633 GB, free: 7.828 MB / 462.1 MB
Notification: Performance of collectInitialBindings (initialization): time 0.0003083/0.4667, allocations: 316.3 kB / 0.6333 GB, free: 7.523 MB / 462.1 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 7.744e-05/0.4668, allocations: 32 kB / 0.6333 GB, free: 7.492 MB / 462.1 MB
Notification: Performance of setup shared object (initialization): time 0.0001498/0.467, allocations: 357.9 kB / 0.6336 GB, free: 7.137 MB / 462.1 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001061/0.468, allocations: 0.6792 MB / 0.6343 GB, free: 6.457 MB / 462.1 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001248/0.4693, allocations: 1.012 MB / 0.6353 GB, free: 5.312 MB / 462.1 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.001285/0.4706, allocations: 0.8689 MB / 0.6361 GB, free: 4.445 MB / 462.1 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 5.37e-06/0.4706, allocations: 0 / 0.6361 GB, free: 4.445 MB / 462.1 MB
Notification: Performance of matching and sorting (n=175) (initialization): time 0.003028/0.4736, allocations: 1.94 MB / 0.638 GB, free: 2.496 MB / 462.1 MB
Notification: Performance of prepare postOptimizeDAE: time 0.0002188/0.4739, allocations: 360.7 kB / 0.6384 GB, free: 2.02 MB / 462.1 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.289e-05/0.4739, allocations: 8 kB / 0.6384 GB, free: 2.012 MB / 462.1 MB
Notification: Performance of postOpt tearingSystem (initialization): time 2.752e-05/0.4739, allocations: 20 kB / 0.6384 GB, free: 1.992 MB / 462.1 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001256/0.4752, allocations: 331.5 kB / 0.6387 GB, free: 1.668 MB / 462.1 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.543e-05/0.4752, allocations: 26.33 kB / 0.6388 GB, free: 1.645 MB / 462.1 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001269/0.4765, allocations: 218 kB / 0.639 GB, free: 1.43 MB / 462.1 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001312/0.4766, allocations: 59.98 kB / 0.639 GB, free: 1.371 MB / 462.1 MB
Notification: Performance of prepare postOptimizeDAE: time 7.705e-06/0.4766, allocations: 8 kB / 0.639 GB, free: 1.363 MB / 462.1 MB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.002658/0.4793, allocations: 1.787 MB / 0.6408 GB, free: 15.57 MB / 478.1 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.145e-05/0.4793, allocations: 8 kB / 0.6408 GB, free: 15.57 MB / 478.1 MB
Notification: Performance of postOpt tearingSystem (initialization): time 1.845e-05/0.4794, allocations: 20.83 kB / 0.6408 GB, free: 15.55 MB / 478.1 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001215/0.4806, allocations: 331.5 kB / 0.6411 GB, free: 15.22 MB / 478.1 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.179e-05/0.4806, allocations: 23.94 kB / 0.6411 GB, free: 15.2 MB / 478.1 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001086/0.4817, allocations: 186.5 kB / 0.6413 GB, free: 15.02 MB / 478.1 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001153/0.4818, allocations: 59.98 kB / 0.6414 GB, free: 14.96 MB / 478.1 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 (linear and non-linear blocks): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of prepare postOptimizeDAE: time 0.001115/0.4829, allocations: 0.7552 MB / 0.6421 GB, free: 14.19 MB / 478.1 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0002941/0.4832, allocations: 150.1 kB / 0.6423 GB, free: 14.04 MB / 478.1 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.002111/0.4854, allocations: 1.289 MB / 0.6435 GB, free: 12.76 MB / 478.1 MB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.376e-05/0.4854, allocations: 8.062 kB / 0.6435 GB, free: 12.75 MB / 478.1 MB
Notification: Performance of postOpt constantLinearSystem (simulation): time 6.352e-06/0.4854, allocations: 4 kB / 0.6435 GB, free: 12.75 MB / 478.1 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.001514/0.4869, allocations: 1.284 MB / 0.6448 GB, free: 11.38 MB / 478.1 MB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.004244/0.4912, allocations: 2.926 MB / 0.6476 GB, free: 8.395 MB / 478.1 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 4.699e-06/0.4912, allocations: 4.031 kB / 0.6476 GB, free: 8.391 MB / 478.1 MB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0008258/0.492, allocations: 191.7 kB / 0.6478 GB, free: 8.203 MB / 478.1 MB
Notification: Performance of postOpt tearingSystem (simulation): time 8.456e-06/0.4921, allocations: 4 kB / 0.6478 GB, free: 8.199 MB / 478.1 MB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 6.348e-05/0.4921, allocations: 23.98 kB / 0.6478 GB, free: 8.176 MB / 478.1 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 6.863e-06/0.4921, allocations: 6.734 kB / 0.6479 GB, free: 8.172 MB / 478.1 MB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.843e-06/0.4921, allocations: 0 / 0.6479 GB, free: 8.172 MB / 478.1 MB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.002566/0.4947, allocations: 1.909 MB / 0.6497 GB, free: 6.23 MB / 478.1 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.0007195/0.4954, allocations: 426.7 kB / 0.6501 GB, free: 5.793 MB / 478.1 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0002857/0.4957, allocations: 20 kB / 0.6501 GB, free: 5.773 MB / 478.1 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0008418/0.4966, allocations: 80.75 kB / 0.6502 GB, free: 5.695 MB / 478.1 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 9.361e-05/0.4967, allocations: 52.92 kB / 0.6503 GB, free: 5.641 MB / 478.1 MB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 7.514e-05/0.4968, allocations: 31.98 kB / 0.6503 GB, free: 5.609 MB / 478.1 MB
Notification: Performance of sorting global known variables: time 0.001668/0.4985, allocations: 1.195 MB / 0.6515 GB, free: 4.418 MB / 478.1 MB
Notification: Performance of sort global known variables: time 1.4e-07/0.4985, allocations: 4 kB / 0.6515 GB, free: 4.414 MB / 478.1 MB
Notification: Performance of remove unused functions: time 0.002426/0.5009, allocations: 0.9045 MB / 0.6524 GB, free: 3.508 MB / 478.1 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 (linear and non-linear blocks): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of Backend phase and start with SimCode phase: time 0.0007321/0.5016, allocations: 353.8 kB / 0.6527 GB, free: 3.18 MB / 478.1 MB
Notification: Performance of simCode: created initialization part: time 0.003409/0.5051, allocations: 2.309 MB / 0.655 GB, free: 0.8789 MB / 478.1 MB
Notification: Performance of simCode: created event and clocks part: time 3.327e-06/0.5051, allocations: 0 / 0.655 GB, free: 0.8789 MB / 478.1 MB
Notification: Performance of simCode: created simulation system equations: time 0.0007099/0.5058, allocations: 0.517 MB / 0.6555 GB, free: 372 kB / 478.1 MB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.003694/0.5095, allocations: 0.8651 MB / 0.6563 GB, free: 15.52 MB / 494.1 MB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.005853/0.5154, allocations: 4.373 MB / 0.6606 GB, free: 11.11 MB / 494.1 MB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001242/0.5166, allocations: 1.686 MB / 0.6622 GB, free: 9.395 MB / 494.1 MB
Notification: Performance of simCode: alias equations: time 0.00268/0.5193, allocations: 0.9107 MB / 0.6631 GB, free: 8.492 MB / 494.1 MB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0003924/0.5197, allocations: 131.4 kB / 0.6632 GB, free: 8.363 MB / 494.1 MB
Notification: Performance of SimCode: time 9.41e-07/0.5197, allocations: 4 kB / 0.6632 GB, free: 8.359 MB / 494.1 MB
Notification: Performance of Templates: time 0.05104/0.5708, allocations: 32.95 MB / 0.6954 GB, free: 7.816 MB / 0.5137 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)