Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IDEAS_dev_IDEAS.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/IDEAS 3.0.0-master/package.mo", uses=false)
Using package IDEAS with version 3.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.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(IDEAS.Fluid.Storage.BaseClasses.Examples.IndirectTankHeatExchanger,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.Fluid.Storage.BaseClasses.Examples.IndirectTankHeatExchanger")
translateModel(IDEAS.Fluid.Storage.BaseClasses.Examples.IndirectTankHeatExchanger,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.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.001399/0.001399, allocations: 101.1 kB / 16.27 MB, free: 6.414 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.001296/0.001296, allocations: 190.3 kB / 17.2 MB, free: 5.953 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.386/1.386, allocations: 222.9 MB / 240.9 MB, free: 15.22 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0-master/package.mo): time 0.846/0.846, allocations: 135.2 MB / 426.2 MB, free: 4.156 MB / 334.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.001899/0.001899, allocations: 71.88 kB / 0.506 GB, free: 8.371 MB / 430.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.347/0.3489, allocations: 80.91 MB / 0.5851 GB, free: 25.38 MB / 446.1 MB
Notification: Performance of NFInst.instantiate(IDEAS.Fluid.Storage.BaseClasses.Examples.IndirectTankHeatExchanger): time 0.02153/0.3705, allocations: 28.55 MB / 0.6129 GB, free: 13.93 MB / 462.1 MB
Notification: Performance of NFInst.instExpressions: time 0.01198/0.3825, allocations: 7.9 MB / 0.6206 GB, free: 6.043 MB / 462.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001158/0.3837, allocations: 35.81 kB / 0.6207 GB, free: 6.008 MB / 462.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.001106/0.3849, allocations: 405.2 kB / 0.6211 GB, free: 5.609 MB / 462.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.002633/0.3875, allocations: 1.003 MB / 0.622 GB, free: 4.602 MB / 462.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.002702/0.3902, allocations: 1.07 MB / 0.6231 GB, free: 3.543 MB / 462.1 MB
Notification: Performance of NFFlatten.flatten: time 0.005305/0.3956, allocations: 4.912 MB / 0.6279 GB, free: 14.62 MB / 478.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.002827/0.3984, allocations: 2.285 MB / 0.6301 GB, free: 12.3 MB / 478.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.003727/0.4022, allocations: 1.793 MB / 0.6319 GB, free: 10.51 MB / 478.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.002048/0.4042, allocations: 1.455 MB / 0.6333 GB, free: 9.047 MB / 478.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.0003858/0.4046, allocations: 228 kB / 0.6335 GB, free: 8.824 MB / 478.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.00267/0.4073, allocations: 1.311 MB / 0.6348 GB, free: 7.512 MB / 478.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.0006029/0.4079, allocations: 0.5569 MB / 0.6353 GB, free: 6.953 MB / 478.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.001552/0.4095, allocations: 1.155 MB / 0.6365 GB, free: 5.793 MB / 478.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.00449/0.414, allocations: 3.65 MB / 0.64 GB, free: 2.133 MB / 478.1 MB
Notification: Performance of FrontEnd - DAE generated: time 7.163e-06/0.414, allocations: 0 / 0.64 GB, free: 2.133 MB / 478.1 MB
Notification: Performance of FrontEnd: time 1.623e-06/0.414, allocations: 3.938 kB / 0.64 GB, free: 2.129 MB / 478.1 MB
Notification: Performance of Transformations before backend: time 5.044e-05/0.4141, allocations: 4 kB / 0.64 GB, free: 2.125 MB / 478.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.004961/0.419, allocations: 2.55 MB / 0.6425 GB, free: 15.52 MB / 494.1 MB
Notification: Performance of prepare preOptimizeDAE: time 4.233e-05/0.4191, allocations: 13.11 kB / 0.6425 GB, free: 15.51 MB / 494.1 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.000832/0.4199, allocations: 230.5 kB / 0.6428 GB, free: 15.28 MB / 494.1 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.002891/0.4228, allocations: 1.737 MB / 0.6445 GB, free: 13.49 MB / 494.1 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 9.038e-05/0.4229, allocations: 110.7 kB / 0.6446 GB, free: 13.38 MB / 494.1 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0002503/0.4232, allocations: 151.9 kB / 0.6447 GB, free: 13.23 MB / 494.1 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.003156/0.4263, allocations: 1.997 MB / 0.6467 GB, free: 11.17 MB / 494.1 MB
Notification: Performance of preOpt findStateOrder (simulation): time 3.541e-05/0.4264, allocations: 4 kB / 0.6467 GB, free: 11.16 MB / 494.1 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.000145/0.4265, allocations: 56 kB / 0.6467 GB, free: 11.11 MB / 494.1 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 5.591e-05/0.4266, allocations: 43.92 kB / 0.6468 GB, free: 11.07 MB / 494.1 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.00282/0.4294, allocations: 1.798 MB / 0.6485 GB, free: 9.262 MB / 494.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.01212/0.4416, allocations: 7.645 MB / 0.656 GB, free: 1.309 MB / 494.1 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.002031/0.4436, allocations: 1.442 MB / 0.6574 GB, free: 15.84 MB / 0.4981 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0009291/0.4446, allocations: 0.6677 MB / 0.658 GB, free: 15.17 MB / 0.4981 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.006834/0.4514, allocations: 3.862 MB / 0.6618 GB, free: 10.99 MB / 0.4981 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 4.602e-05/0.4515, allocations: 47.56 kB / 0.6618 GB, free: 10.94 MB / 0.4981 GB
Notification: Performance of pre-optimization done (n=88): time 2.926e-06/0.4515, allocations: 0 / 0.6618 GB, free: 10.94 MB / 0.4981 GB
Notification: Performance of matching and sorting (n=88): time 0.002604/0.4541, allocations: 1.51 MB / 0.6633 GB, free: 9.422 MB / 0.4981 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 5.643e-05/0.4542, allocations: 68.41 kB / 0.6634 GB, free: 9.344 MB / 0.4981 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002283/0.4565, allocations: 1.645 MB / 0.665 GB, free: 7.688 MB / 0.4981 GB
Notification: Performance of collectPreVariables (initialization): time 0.0001006/0.4566, allocations: 49.7 kB / 0.665 GB, free: 7.633 MB / 0.4981 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0006931/0.4573, allocations: 0.7498 MB / 0.6658 GB, free: 6.875 MB / 0.4981 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0003179/0.4576, allocations: 319.4 kB / 0.6661 GB, free: 6.559 MB / 0.4981 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0004204/0.458, allocations: 299.3 kB / 0.6664 GB, free: 6.262 MB / 0.4981 GB
Notification: Performance of setup shared object (initialization): time 0.0001815/0.4582, allocations: 361.9 kB / 0.6667 GB, free: 5.902 MB / 0.4981 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001044/0.4593, allocations: 0.6995 MB / 0.6674 GB, free: 5.199 MB / 0.4981 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001318/0.4606, allocations: 1.016 MB / 0.6684 GB, free: 4.055 MB / 0.4981 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.002167/0.4628, allocations: 1.624 MB / 0.67 GB, free: 2.305 MB / 0.4981 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 6.161e-06/0.4628, allocations: 0 / 0.67 GB, free: 2.305 MB / 0.4981 GB
Notification: Performance of matching and sorting (n=175) (initialization): time 0.003246/0.466, allocations: 1.948 MB / 0.6719 GB, free: 356 kB / 0.4981 GB
Notification: Performance of prepare postOptimizeDAE: time 2.661e-05/0.4661, allocations: 10.5 kB / 0.6719 GB, free: 348 kB / 0.4981 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.442e-05/0.4661, allocations: 8.094 kB / 0.6719 GB, free: 340 kB / 0.4981 GB
Notification: Performance of postOpt tearingSystem (initialization): time 3.036e-05/0.4661, allocations: 20 kB / 0.6719 GB, free: 320 kB / 0.4981 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001251/0.4674, allocations: 335.5 kB / 0.6722 GB, free: 15.98 MB / 0.5137 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.888e-05/0.4674, allocations: 19.94 kB / 0.6722 GB, free: 15.96 MB / 0.5137 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001277/0.4687, allocations: 202.1 kB / 0.6724 GB, free: 15.77 MB / 0.5137 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001155/0.4688, allocations: 60.05 kB / 0.6725 GB, free: 15.71 MB / 0.5137 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.001934/0.4708, allocations: 1.284 MB / 0.6738 GB, free: 14.42 MB / 0.5137 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.001345/0.4721, allocations: 1.016 MB / 0.6747 GB, free: 13.27 MB / 0.5137 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.002192/0.4743, allocations: 1.632 MB / 0.6763 GB, free: 11.52 MB / 0.5137 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 4.428e-06/0.4744, allocations: 0 / 0.6763 GB, free: 11.52 MB / 0.5137 GB
Notification: Performance of matching and sorting (n=175) (initialization_lambda0): time 0.003282/0.4776, allocations: 1.951 MB / 0.6782 GB, free: 9.555 MB / 0.5137 GB
Notification: Performance of prepare postOptimizeDAE: time 1.924e-05/0.4777, allocations: 8 kB / 0.6783 GB, free: 9.547 MB / 0.5137 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.524e-05/0.4777, allocations: 8 kB / 0.6783 GB, free: 9.539 MB / 0.5137 GB
Notification: Performance of postOpt tearingSystem (initialization): time 1.927e-05/0.4777, allocations: 19.94 kB / 0.6783 GB, free: 9.52 MB / 0.5137 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001199/0.4789, allocations: 331.5 kB / 0.6786 GB, free: 9.195 MB / 0.5137 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.418e-05/0.479, allocations: 24.52 kB / 0.6786 GB, free: 9.172 MB / 0.5137 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001208/0.4802, allocations: 154.9 kB / 0.6788 GB, free: 9.02 MB / 0.5137 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001111/0.4803, allocations: 63.92 kB / 0.6788 GB, free: 8.957 MB / 0.5137 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.0003566/0.4807, allocations: 255.8 kB / 0.6791 GB, free: 8.699 MB / 0.5137 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0003347/0.481, allocations: 150.2 kB / 0.6792 GB, free: 8.551 MB / 0.5137 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.002173/0.4832, allocations: 1.277 MB / 0.6805 GB, free: 7.262 MB / 0.5137 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.517e-05/0.4832, allocations: 8 kB / 0.6805 GB, free: 7.254 MB / 0.5137 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 5.841e-06/0.4832, allocations: 0 / 0.6805 GB, free: 7.254 MB / 0.5137 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.001584/0.4848, allocations: 1.292 MB / 0.6817 GB, free: 5.875 MB / 0.5137 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.004431/0.4892, allocations: 2.955 MB / 0.6846 GB, free: 2.844 MB / 0.5137 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 5.591e-06/0.4893, allocations: 0 / 0.6846 GB, free: 2.844 MB / 0.5137 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0007787/0.4901, allocations: 187.8 kB / 0.6848 GB, free: 2.66 MB / 0.5137 GB
Notification: Performance of postOpt tearingSystem (simulation): time 1.381e-05/0.4901, allocations: 7.984 kB / 0.6848 GB, free: 2.652 MB / 0.5137 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 5.848e-05/0.4901, allocations: 20 kB / 0.6848 GB, free: 2.633 MB / 0.5137 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 1.038e-05/0.4902, allocations: 11.88 kB / 0.6848 GB, free: 2.621 MB / 0.5137 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.683e-06/0.4902, allocations: 0 / 0.6848 GB, free: 2.621 MB / 0.5137 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.002702/0.4929, allocations: 1.913 MB / 0.6867 GB, free: 0.6758 MB / 0.5137 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0007145/0.4936, allocations: 402.9 kB / 0.6871 GB, free: 268 kB / 0.5137 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0002103/0.4938, allocations: 23.98 kB / 0.6871 GB, free: 244 kB / 0.5137 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0007535/0.4946, allocations: 52.08 kB / 0.6872 GB, free: 192 kB / 0.5137 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001029/0.4947, allocations: 56.86 kB / 0.6872 GB, free: 136 kB / 0.5137 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 7.126e-05/0.4948, allocations: 35.98 kB / 0.6872 GB, free: 100 kB / 0.5137 GB
Notification: Performance of sorting global known variables: time 0.001777/0.4965, allocations: 1.238 MB / 0.6885 GB, free: 14.86 MB / 0.5294 GB
Notification: Performance of sort global known variables: time 1.6e-07/0.4966, allocations: 3.938 kB / 0.6885 GB, free: 14.86 MB / 0.5294 GB
Notification: Performance of remove unused functions: time 0.00232/0.4989, allocations: 0.9124 MB / 0.6894 GB, free: 13.95 MB / 0.5294 GB
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.0008603/0.4998, allocations: 373 kB / 0.6897 GB, free: 13.59 MB / 0.5294 GB
Notification: Performance of simCode: created initialization part: time 0.004693/0.5045, allocations: 2.831 MB / 0.6925 GB, free: 10.76 MB / 0.5294 GB
Notification: Performance of simCode: created event and clocks part: time 5.22e-06/0.5045, allocations: 0 / 0.6925 GB, free: 10.76 MB / 0.5294 GB
Notification: Performance of simCode: created simulation system equations: time 0.0007558/0.5052, allocations: 0.5186 MB / 0.693 GB, free: 10.24 MB / 0.5294 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.003968/0.5092, allocations: 0.932 MB / 0.6939 GB, free: 9.379 MB / 0.5294 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.005553/0.5148, allocations: 3.68 MB / 0.6975 GB, free: 5.648 MB / 0.5294 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001302/0.5161, allocations: 1.634 MB / 0.6991 GB, free: 3.977 MB / 0.5294 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0005385/0.5167, allocations: 151.3 kB / 0.6992 GB, free: 3.828 MB / 0.5294 GB
Notification: Performance of SimCode: time 6.61e-07/0.5167, allocations: 4 kB / 0.6992 GB, free: 3.824 MB / 0.5294 GB
Notification: Performance of Templates: time 0.04839/0.5651, allocations: 32.61 MB / 0.7311 GB, free: 3.355 MB / 0.5606 GB
make -j1 -f IDEAS_dev_IDEAS.Fluid.Storage.BaseClasses.Examples.IndirectTankHeatExchanger.makefile
(rm -f IDEAS_dev_IDEAS.Fluid.Storage.BaseClasses.Examples.IndirectTankHeatExchanger.pipe ; mkfifo IDEAS_dev_IDEAS.Fluid.Storage.BaseClasses.Examples.IndirectTankHeatExchanger.pipe ; head -c 1048576 < IDEAS_dev_IDEAS.Fluid.Storage.BaseClasses.Examples.IndirectTankHeatExchanger.pipe >> ../files/IDEAS_dev_IDEAS.Fluid.Storage.BaseClasses.Examples.IndirectTankHeatExchanger.sim & ./IDEAS_dev_IDEAS.Fluid.Storage.BaseClasses.Examples.IndirectTankHeatExchanger  -abortSlowSimulation -alarm=480 -lv LOG_STATS > IDEAS_dev_IDEAS.Fluid.Storage.BaseClasses.Examples.IndirectTankHeatExchanger.pipe 2>&1)