Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IDEAS_dev_IDEAS.Fluid.Storage.Validation.HeatExchangerDynamics.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.Validation.HeatExchangerDynamics,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.Fluid.Storage.Validation.HeatExchangerDynamics")
translateModel(IDEAS.Fluid.Storage.Validation.HeatExchangerDynamics,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.Fluid.Storage.Validation.HeatExchangerDynamics")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001176/0.001176, allocations: 111.9 kB / 16.42 MB, free: 6.453 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.001188/0.001188, allocations: 192.3 kB / 17.35 MB, free: 5.715 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.19/1.19, allocations: 222.9 MB / 241 MB, free: 15.09 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0-master/package.mo): time 0.7224/0.7224, allocations: 135.1 MB / 426.3 MB, free: 4.105 MB / 334.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.001079/0.001079, allocations: 63.81 kB / 0.5863 GB, free: 21.5 MB / 446.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1155/0.1166, allocations: 80.92 MB / 0.6653 GB, free: 5.801 MB / 0.4981 GB
Notification: Performance of NFInst.instantiate(IDEAS.Fluid.Storage.Validation.HeatExchangerDynamics): time 0.3555/0.4721, allocations: 112 MB / 0.7747 GB, free: 3.254 MB / 0.5762 GB
Notification: Performance of NFInst.instExpressions: time 0.03037/0.5025, allocations: 32.03 MB / 0.806 GB, free: 15.89 MB / 0.5919 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.004249/0.5068, allocations: 154.1 kB / 0.8061 GB, free: 15.89 MB / 0.5919 GB
Notification: Performance of NFTyping.typeComponents: time 0.003747/0.5105, allocations: 1.843 MB / 0.8079 GB, free: 14.9 MB / 0.5919 GB
Notification: Performance of NFTyping.typeBindings: time 0.01044/0.521, allocations: 4.835 MB / 0.8127 GB, free: 12.66 MB / 0.5919 GB
Notification: Performance of NFTyping.typeClassSections: time 0.007589/0.5286, allocations: 3.607 MB / 0.8162 GB, free: 10.43 MB / 0.5919 GB
Notification: Performance of NFFlatten.flatten: time 0.0395/0.5681, allocations: 47.74 MB / 0.8628 GB, free: 5.211 MB / 0.6231 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.02681/0.595, allocations: 23.86 MB / 0.8861 GB, free: 13.2 MB / 0.6544 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.02487/0.6198, allocations: 16.41 MB / 0.9021 GB, free: 12.82 MB / 0.67 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.01956/0.6394, allocations: 14.04 MB / 0.9158 GB, free: 14.73 MB / 0.6856 GB
Notification: Performance of NFPackage.collectConstants: time 0.005705/0.6451, allocations: 2.434 MB / 0.9182 GB, free: 12.29 MB / 0.6856 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.01297/0.6581, allocations: 4.742 MB / 0.9229 GB, free: 7.547 MB / 0.6856 GB
Notification: Performance of NFScalarize.scalarize: time 0.007437/0.6656, allocations: 5.505 MB / 0.9282 GB, free: 2.027 MB / 0.6856 GB
Notification: Performance of NFVerifyModel.verify: time 0.01897/0.6846, allocations: 11.09 MB / 0.9391 GB, free: 6.891 MB / 0.7012 GB
Notification: Performance of NFConvertDAE.convert: time 0.03568/0.7203, allocations: 34.62 MB / 0.9729 GB, free: 4.176 MB / 0.7325 GB
Notification: Performance of FrontEnd - DAE generated: time 5.651e-06/0.7203, allocations: 0 / 0.9729 GB, free: 4.176 MB / 0.7325 GB
Notification: Performance of FrontEnd: time 1.333e-06/0.7203, allocations: 0 / 0.9729 GB, free: 4.176 MB / 0.7325 GB
Notification: Performance of Transformations before backend: time 0.0007849/0.7211, allocations: 0 / 0.9729 GB, free: 4.176 MB / 0.7325 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 3345
 * Number of variables: 3345
Notification: Performance of Generate backend data structure: time 0.04633/0.7674, allocations: 19.84 MB / 0.9922 GB, free: 200 kB / 0.7481 GB
Notification: Performance of prepare preOptimizeDAE: time 4e-05/0.7675, allocations: 9.109 kB / 0.9923 GB, free: 192 kB / 0.7481 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.008397/0.7759, allocations: 1.983 MB / 0.9942 GB, free: 14.18 MB / 0.7637 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.02924/0.8052, allocations: 16.35 MB / 1.01 GB, free: 13.73 MB / 0.7794 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0007798/0.806, allocations: 0.9981 MB / 1.011 GB, free: 12.73 MB / 0.7794 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.004309/0.8103, allocations: 1.34 MB / 1.012 GB, free: 11.39 MB / 0.7794 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.03777/0.8481, allocations: 20.25 MB / 1.032 GB, free: 6.582 MB / 0.795 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0002596/0.8484, allocations: 47.64 kB / 1.032 GB, free: 6.535 MB / 0.795 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.001561/0.8499, allocations: 0.5468 MB / 1.033 GB, free: 5.988 MB / 0.795 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0002873/0.8502, allocations: 375.9 kB / 1.033 GB, free: 5.621 MB / 0.795 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.03244/0.8827, allocations: 18.15 MB / 1.051 GB, free: 3.441 MB / 0.8106 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.6017/1.484, allocations: 86.44 MB / 1.135 GB, free: 209.8 MB / 0.8107 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.01411/1.499, allocations: 12.96 MB / 1.148 GB, free: 202.6 MB / 0.8107 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.007453/1.506, allocations: 7.403 MB / 1.155 GB, free: 197.7 MB / 0.8107 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 evalFunc (simulation): time 0.03863/1.545, allocations: 26.93 MB / 1.181 GB, free: 170.1 MB / 0.8107 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.007186/1.552, allocations: 6.057 MB / 1.187 GB, free: 164 MB / 0.8107 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.004001/1.556, allocations: 0.8208 MB / 1.188 GB, free: 163.2 MB / 0.8107 GB
Notification: Performance of pre-optimization done (n=772): time 1.187e-05/1.556, allocations: 0 / 1.188 GB, free: 163.2 MB / 0.8107 GB
Notification: Performance of matching and sorting (n=772): time 0.08718/1.643, allocations: 32.38 MB / 1.22 GB, free: 130.8 MB / 0.8107 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 5.111e-05/1.643, allocations: 155.1 kB / 1.22 GB, free: 130.6 MB / 0.8107 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.01385/1.657, allocations: 12.83 MB / 1.232 GB, free: 117.8 MB / 0.8107 GB
Notification: Performance of collectPreVariables (initialization): time 0.001566/1.659, allocations: 205.7 kB / 1.233 GB, free: 117.6 MB / 0.8107 GB
Notification: Performance of collectInitialEqns (initialization): time 0.004565/1.663, allocations: 7.028 MB / 1.24 GB, free: 110.6 MB / 0.8107 GB
Notification: Performance of collectInitialBindings (initialization): time 0.002352/1.666, allocations: 2.695 MB / 1.242 GB, free: 107.9 MB / 0.8107 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.002716/1.668, allocations: 2.313 MB / 1.244 GB, free: 105.6 MB / 0.8107 GB
Notification: Performance of setup shared object (initialization): time 3.232e-05/1.668, allocations: 305.1 kB / 1.245 GB, free: 105.3 MB / 0.8107 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.007125/1.675, allocations: 6.326 MB / 1.251 GB, free: 98.94 MB / 0.8107 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.008139/1.684, allocations: 9.606 MB / 1.26 GB, free: 87.95 MB / 0.8107 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.01542/1.699, allocations: 15.95 MB / 1.276 GB, free: 70.54 MB / 0.8107 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 5.236e-05/1.699, allocations: 28 kB / 1.276 GB, free: 70.51 MB / 0.8107 GB
Notification: Performance of matching and sorting (n=1474) (initialization): time 0.02557/1.725, allocations: 18.88 MB / 1.294 GB, free: 51.51 MB / 0.8107 GB
Notification: Performance of prepare postOptimizeDAE: time 7.178e-05/1.725, allocations: 77.69 kB / 1.294 GB, free: 51.43 MB / 0.8107 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 8.676e-05/1.725, allocations: 100 kB / 1.294 GB, free: 51.33 MB / 0.8107 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0561/1.781, allocations: 9.117 MB / 1.303 GB, free: 42.2 MB / 0.8107 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.008794/1.79, allocations: 2.457 MB / 1.306 GB, free: 39.73 MB / 0.8107 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.009108/1.799, allocations: 10.82 MB / 1.316 GB, free: 28.61 MB / 0.8107 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0098/1.809, allocations: 0.7255 MB / 1.317 GB, free: 27.89 MB / 0.8107 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.00124/1.81, allocations: 0.5233 MB / 1.318 GB, free: 27.36 MB / 0.8107 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.01357/1.824, allocations: 11.73 MB / 1.329 GB, free: 15.62 MB / 0.8107 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.00815/1.832, allocations: 9.586 MB / 1.338 GB, free: 4.652 MB / 0.8107 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.0188/1.851, allocations: 15.95 MB / 1.354 GB, free: 3.234 MB / 0.8263 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 5.595e-05/1.851, allocations: 34.42 kB / 1.354 GB, free: 3.203 MB / 0.8263 GB
Notification: Performance of matching and sorting (n=1474) (initialization_lambda0): time 0.02986/1.881, allocations: 18.87 MB / 1.372 GB, free: 212 kB / 0.8419 GB
Notification: Performance of prepare postOptimizeDAE: time 8.66e-05/1.881, allocations: 77.7 kB / 1.372 GB, free: 128 kB / 0.8419 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001028/1.881, allocations: 96 kB / 1.373 GB, free: 32 kB / 0.8419 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.5773/2.458, allocations: 9.114 MB / 1.381 GB, free: 285.3 MB / 0.842 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.009713/2.468, allocations: 2.456 MB / 1.384 GB, free: 285.3 MB / 0.842 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01027/2.478, allocations: 10.81 MB / 1.394 GB, free: 281.5 MB / 0.842 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.009996/2.488, allocations: 0.7174 MB / 1.395 GB, free: 281.4 MB / 0.842 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.00119/2.489, allocations: 0.5148 MB / 1.396 GB, free: 281.3 MB / 0.842 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 448
 * Number of states: 0 ()
 * Number of discrete variables: 5 (mHex_flow_in.count,$PRE.mHex_flow_in.count,mHex_flow_in.T_start,$PRE.mHex_flow_in.T_start,$whenCondition1)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (1286):
 * Single equations (assignments): 1282
 * Array equations: 0
 * Algorithm blocks: 1
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 3
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 2 systems
   {(1,14,100.0%), (1,14,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 1 system
   {(16,144)}
Notification: Performance of prepare postOptimizeDAE: time 0.001868/2.491, allocations: 0.8638 MB / 1.396 GB, free: 280.6 MB / 0.842 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.00269/2.494, allocations: 1.167 MB / 1.398 GB, free: 280.6 MB / 0.842 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01733/2.511, allocations: 13.38 MB / 1.411 GB, free: 275.4 MB / 0.842 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.01398/2.525, allocations: 11.04 MB / 1.421 GB, free: 271.2 MB / 0.842 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.841e-05/2.525, allocations: 0 / 1.421 GB, free: 271.2 MB / 0.842 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.006169/2.531, allocations: 2.773 MB / 1.424 GB, free: 269.8 MB / 0.842 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.002773/2.534, allocations: 160.6 kB / 1.424 GB, free: 269.7 MB / 0.842 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.006567/2.541, allocations: 460.2 kB / 1.425 GB, free: 269.5 MB / 0.842 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0007599/2.542, allocations: 461.2 kB / 1.425 GB, free: 269.5 MB / 0.842 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.02061/2.562, allocations: 14.32 MB / 1.439 GB, free: 257.7 MB / 0.842 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.0204/2.583, allocations: 18.92 MB / 1.458 GB, free: 238.7 MB / 0.842 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.005254/2.588, allocations: 5.52 MB / 1.463 GB, free: 233.1 MB / 0.842 GB
Notification: Performance of sorting global known variables: time 0.01136/2.599, allocations: 8.9 MB / 1.472 GB, free: 224.3 MB / 0.842 GB
Notification: Performance of Backend: time 7.31e-07/2.599, allocations: 3.828 kB / 1.472 GB, free: 224.3 MB / 0.842 GB
Notification: Performance of simCode: created initialization part: time 0.03031/2.63, allocations: 19.77 MB / 1.491 GB, free: 204.6 MB / 0.842 GB
Notification: Performance of SimCode: time 0.05181/2.682, allocations: 36.07 MB / 1.526 GB, free: 168.8 MB / 0.842 GB
Notification: Performance of Templates: time 0.6187/3.3, allocations: 333.1 MB / 1.852 GB, free: 147.5 MB / 0.842 GB
make -j1 -f IDEAS_dev_IDEAS.Fluid.Storage.Validation.HeatExchangerDynamics.makefile
(rm -f IDEAS_dev_IDEAS.Fluid.Storage.Validation.HeatExchangerDynamics.pipe ; mkfifo IDEAS_dev_IDEAS.Fluid.Storage.Validation.HeatExchangerDynamics.pipe ; head -c 1048576 < IDEAS_dev_IDEAS.Fluid.Storage.Validation.HeatExchangerDynamics.pipe >> ../files/IDEAS_dev_IDEAS.Fluid.Storage.Validation.HeatExchangerDynamics.sim & ./IDEAS_dev_IDEAS.Fluid.Storage.Validation.HeatExchangerDynamics  -abortSlowSimulation -alarm=480 -lv LOG_STATS > IDEAS_dev_IDEAS.Fluid.Storage.Validation.HeatExchangerDynamics.pipe 2>&1)