Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Modelica_4.0.0_Modelica.Fluid.Examples.HeatExchanger.HeatExchangerSimulation.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001838/0.001838, allocations: 99.86 kB / 20.96 MB, free: 3.457 MB / 18.57 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001902/0.001902, allocations: 145.1 kB / 24.26 MB, free: 168 kB / 18.57 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.565/1.565, allocations: 173.3 MB / 200.8 MB, free: 9.312 MB / 186.7 MB
"
[Timeout remaining time 178]
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(Modelica.Fluid.Examples.HeatExchanger.HeatExchangerSimulation,tolerance=1e-05,outputFormat="mat",numberOfIntervals=5004,variableFilter="time|HEX.pipe_1.mediums.10..T|HEX.pipe_1.mediums.10..p|HEX.pipe_1.mediums.11..T|HEX.pipe_1.mediums.11..p|HEX.pipe_1.mediums.12..T|HEX.pipe_1.mediums.12..p|HEX.pipe_1.mediums.13..T|HEX.pipe_1.mediums.13..p|HEX.pipe_1.mediums.14..T|HEX.pipe_1.mediums.14..p|HEX.pipe_1.mediums.15..T|HEX.pipe_1.mediums.15..p|HEX.pipe_1.mediums.16..T|HEX.pipe_1.mediums.16..p|HEX.pipe_1.mediums.17..T|HEX.pipe_1.mediums.17..p|HEX.pipe_1.mediums.18..T|HEX.pipe_1.mediums.18..p|HEX.pipe_1.mediums.19..T|HEX.pipe_1.mediums.19..p|HEX.pipe_1.mediums.1..T|HEX.pipe_1.mediums.1..p|HEX.pipe_1.mediums.20..T|HEX.pipe_1.mediums.20..p|HEX.pipe_1.mediums.2..T|HEX.pipe_1.mediums.2..p|HEX.pipe_1.mediums.3..T|HEX.pipe_1.mediums.3..p|HEX.pipe_1.mediums.4..T|HEX.pipe_1.mediums.4..p|HEX.pipe_1.mediums.5..T|HEX.pipe_1.mediums.5..p|HEX.pipe_1.mediums.6..T|HEX.pipe_1.mediums.6..p|HEX.pipe_1.mediums.7..T|HEX.pipe_1.mediums.7..p|HEX.pipe_1.mediums.8..T|HEX.pipe_1.mediums.8..p|HEX.pipe_1.mediums.9..T|HEX.pipe_1.mediums.9..p|HEX.pipe_2.mediums.10..T|HEX.pipe_2.mediums.10..p|HEX.pipe_2.mediums.11..T|HEX.pipe_2.mediums.11..p|HEX.pipe_2.mediums.12..T|HEX.pipe_2.mediums.12..p|HEX.pipe_2.mediums.13..T|HEX.pipe_2.mediums.13..p|HEX.pipe_2.mediums.14..T|HEX.pipe_2.mediums.14..p|HEX.pipe_2.mediums.15..T|HEX.pipe_2.mediums.15..p|HEX.pipe_2.mediums.16..T|HEX.pipe_2.mediums.16..p|HEX.pipe_2.mediums.17..T|HEX.pipe_2.mediums.17..p|HEX.pipe_2.mediums.18..T|HEX.pipe_2.mediums.18..p|HEX.pipe_2.mediums.19..T|HEX.pipe_2.mediums.19..p|HEX.pipe_2.mediums.1..T|HEX.pipe_2.mediums.1..p|HEX.pipe_2.mediums.20..T|HEX.pipe_2.mediums.20..p|HEX.pipe_2.mediums.2..T|HEX.pipe_2.mediums.2..p|HEX.pipe_2.mediums.3..T|HEX.pipe_2.mediums.3..p|HEX.pipe_2.mediums.4..T|HEX.pipe_2.mediums.4..p|HEX.pipe_2.mediums.5..T|HEX.pipe_2.mediums.5..p|HEX.pipe_2.mediums.6..T|HEX.pipe_2.mediums.6..p|HEX.pipe_2.mediums.7..T|HEX.pipe_2.mediums.7..p|HEX.pipe_2.mediums.8..T|HEX.pipe_2.mediums.8..p|HEX.pipe_2.mediums.9..T|HEX.pipe_2.mediums.9..p|HEX.wall.T.10.|HEX.wall.T.11.|HEX.wall.T.12.|HEX.wall.T.13.|HEX.wall.T.14.|HEX.wall.T.15.|HEX.wall.T.16.|HEX.wall.T.17.|HEX.wall.T.18.|HEX.wall.T.19.|HEX.wall.T.1.|HEX.wall.T.20.|HEX.wall.T.2.|HEX.wall.T.3.|HEX.wall.T.4.|HEX.wall.T.5.|HEX.wall.T.6.|HEX.wall.T.7.|HEX.wall.T.8.|HEX.wall.T.9.",fileNamePrefix="Modelica_4.0.0_Modelica.Fluid.Examples.HeatExchanger.HeatExchangerSimulation")
translateModel(Modelica.Fluid.Examples.HeatExchanger.HeatExchangerSimulation,tolerance=1e-05,outputFormat="mat",numberOfIntervals=5004,variableFilter="time|HEX.pipe_1.mediums.10..T|HEX.pipe_1.mediums.10..p|HEX.pipe_1.mediums.11..T|HEX.pipe_1.mediums.11..p|HEX.pipe_1.mediums.12..T|HEX.pipe_1.mediums.12..p|HEX.pipe_1.mediums.13..T|HEX.pipe_1.mediums.13..p|HEX.pipe_1.mediums.14..T|HEX.pipe_1.mediums.14..p|HEX.pipe_1.mediums.15..T|HEX.pipe_1.mediums.15..p|HEX.pipe_1.mediums.16..T|HEX.pipe_1.mediums.16..p|HEX.pipe_1.mediums.17..T|HEX.pipe_1.mediums.17..p|HEX.pipe_1.mediums.18..T|HEX.pipe_1.mediums.18..p|HEX.pipe_1.mediums.19..T|HEX.pipe_1.mediums.19..p|HEX.pipe_1.mediums.1..T|HEX.pipe_1.mediums.1..p|HEX.pipe_1.mediums.20..T|HEX.pipe_1.mediums.20..p|HEX.pipe_1.mediums.2..T|HEX.pipe_1.mediums.2..p|HEX.pipe_1.mediums.3..T|HEX.pipe_1.mediums.3..p|HEX.pipe_1.mediums.4..T|HEX.pipe_1.mediums.4..p|HEX.pipe_1.mediums.5..T|HEX.pipe_1.mediums.5..p|HEX.pipe_1.mediums.6..T|HEX.pipe_1.mediums.6..p|HEX.pipe_1.mediums.7..T|HEX.pipe_1.mediums.7..p|HEX.pipe_1.mediums.8..T|HEX.pipe_1.mediums.8..p|HEX.pipe_1.mediums.9..T|HEX.pipe_1.mediums.9..p|HEX.pipe_2.mediums.10..T|HEX.pipe_2.mediums.10..p|HEX.pipe_2.mediums.11..T|HEX.pipe_2.mediums.11..p|HEX.pipe_2.mediums.12..T|HEX.pipe_2.mediums.12..p|HEX.pipe_2.mediums.13..T|HEX.pipe_2.mediums.13..p|HEX.pipe_2.mediums.14..T|HEX.pipe_2.mediums.14..p|HEX.pipe_2.mediums.15..T|HEX.pipe_2.mediums.15..p|HEX.pipe_2.mediums.16..T|HEX.pipe_2.mediums.16..p|HEX.pipe_2.mediums.17..T|HEX.pipe_2.mediums.17..p|HEX.pipe_2.mediums.18..T|HEX.pipe_2.mediums.18..p|HEX.pipe_2.mediums.19..T|HEX.pipe_2.mediums.19..p|HEX.pipe_2.mediums.1..T|HEX.pipe_2.mediums.1..p|HEX.pipe_2.mediums.20..T|HEX.pipe_2.mediums.20..p|HEX.pipe_2.mediums.2..T|HEX.pipe_2.mediums.2..p|HEX.pipe_2.mediums.3..T|HEX.pipe_2.mediums.3..p|HEX.pipe_2.mediums.4..T|HEX.pipe_2.mediums.4..p|HEX.pipe_2.mediums.5..T|HEX.pipe_2.mediums.5..p|HEX.pipe_2.mediums.6..T|HEX.pipe_2.mediums.6..p|HEX.pipe_2.mediums.7..T|HEX.pipe_2.mediums.7..p|HEX.pipe_2.mediums.8..T|HEX.pipe_2.mediums.8..p|HEX.pipe_2.mediums.9..T|HEX.pipe_2.mediums.9..p|HEX.wall.T.10.|HEX.wall.T.11.|HEX.wall.T.12.|HEX.wall.T.13.|HEX.wall.T.14.|HEX.wall.T.15.|HEX.wall.T.16.|HEX.wall.T.17.|HEX.wall.T.18.|HEX.wall.T.19.|HEX.wall.T.1.|HEX.wall.T.20.|HEX.wall.T.2.|HEX.wall.T.3.|HEX.wall.T.4.|HEX.wall.T.5.|HEX.wall.T.6.|HEX.wall.T.7.|HEX.wall.T.8.|HEX.wall.T.9.",fileNamePrefix="Modelica_4.0.0_Modelica.Fluid.Examples.HeatExchanger.HeatExchangerSimulation") [Timeout 660]
"Notification: Performance of FrontEnd - loaded program: time 1.232e-06/1.232e-06, allocations: 0 / 267.3 MB, free: 6.723 MB / 250.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 2.343e-05/2.467e-05, allocations: 6.312 kB / 267.3 MB, free: 6.715 MB / 250.7 MB
Notification: Performance of NFInst.instantiate(Modelica.Fluid.Examples.HeatExchanger.HeatExchangerSimulation): time 0.2112/0.2112, allocations: 85.56 MB / 352.9 MB, free: 4.105 MB / 298.7 MB
Notification: Performance of NFInst.instExpressions: time 0.3952/0.6065, allocations: 171.9 MB / 0.5125 GB, free: 10.46 MB / 394.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.002311/0.6088, allocations: 88.19 kB / 0.5126 GB, free: 10.41 MB / 394.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.002676/0.6114, allocations: 0.9431 MB / 0.5135 GB, free: 9.832 MB / 394.7 MB
Notification: Performance of NFTyping.typeBindings: time 0.01224/0.6237, allocations: 4.65 MB / 0.5181 GB, free: 7.617 MB / 394.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.02931/0.653, allocations: 10.79 MB / 0.5286 GB, free: 3.23 MB / 394.7 MB
Notification: Performance of NFFlatten.flatten: time 0.04406/0.697, allocations: 24.71 MB / 0.5527 GB, free: 11.93 MB / 426.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.01744/0.7145, allocations: 6.429 MB / 0.559 GB, free: 5.727 MB / 426.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.07084/0.7853, allocations: 17.83 MB / 0.5764 GB, free: 3.918 MB / 442.7 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.06123/0.8466, allocations: 15.25 MB / 0.5913 GB, free: 4.539 MB / 458.7 MB
Notification: Performance of NFPackage.collectConstants: time 0.008293/0.8548, allocations: 1.73 MB / 0.593 GB, free: 2.809 MB / 458.7 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.2915/1.146, allocations: 10.16 MB / 0.6029 GB, free: 40.57 MB / 458.7 MB
Notification: Performance of NFScalarize.scalarize: time 0.007855/1.154, allocations: 6.391 MB / 0.6092 GB, free: 40.57 MB / 458.7 MB
Notification: Performance of NFVerifyModel.verify: time 0.01913/1.173, allocations: 6.344 MB / 0.6154 GB, free: 40.57 MB / 458.7 MB
Notification: Performance of NFConvertDAE.convert: time 0.05211/1.225, allocations: 33.69 MB / 0.6483 GB, free: 35.93 MB / 458.7 MB
Notification: Performance of FrontEnd - DAE generated: time 8.536e-06/1.225, allocations: 2.812 kB / 0.6483 GB, free: 35.93 MB / 458.7 MB
Notification: Performance of FrontEnd: time 2.435e-06/1.225, allocations: 0.8125 kB / 0.6483 GB, free: 35.93 MB / 458.7 MB
Notification: Performance of Transformations before backend: time 0.0008504/1.226, allocations: 0 / 0.6483 GB, free: 35.93 MB / 458.7 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 3731
 * Number of variables: 3731
Notification: Performance of Generate backend data structure: time 0.1802/1.407, allocations: 39.09 MB / 0.6865 GB, free: 9.254 MB / 458.7 MB
Notification: Performance of prepare preOptimizeDAE: time 4.712e-05/1.407, allocations: 8.922 kB / 0.6865 GB, free: 9.246 MB / 458.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.03061/1.437, allocations: 5.669 MB / 0.692 GB, free: 3.562 MB / 458.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.02562/1.463, allocations: 8.567 MB / 0.7004 GB, free: 11.34 MB / 474.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.001165/1.464, allocations: 0.8316 MB / 0.7012 GB, free: 10.52 MB / 474.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.007166/1.471, allocations: 1.133 MB / 0.7023 GB, free: 9.391 MB / 474.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.06845/1.54, allocations: 22.97 MB / 0.7247 GB, free: 1.043 MB / 490.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0004689/1.54, allocations: 38.06 kB / 0.7247 GB, free: 1.02 MB / 490.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.005606/1.546, allocations: 447.6 kB / 0.7252 GB, free: 0.5938 MB / 490.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.002484/1.548, allocations: 1.967 MB / 0.7271 GB, free: 14.62 MB / 0.4948 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.05857/1.607, allocations: 16.47 MB / 0.7432 GB, free: 14.27 MB / 0.5105 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.4073/2.014, allocations: 299.6 MB / 1.036 GB, free: 27.79 MB / 0.5417 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.02666/2.041, allocations: 11.12 MB / 1.047 GB, free: 18.18 MB / 0.5417 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.01176/2.052, allocations: 5.178 MB / 1.052 GB, free: 13.7 MB / 0.5417 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.2377/2.29, allocations: 25.79 MB / 1.077 GB, free: 245.4 MB / 0.5417 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0001843/2.29, allocations: 175.5 kB / 1.077 GB, free: 245.3 MB / 0.5417 GB
Notification: Performance of pre-optimization done (n=1173): time 1.702e-05/2.29, allocations: 0 / 1.077 GB, free: 245.3 MB / 0.5417 GB
Notification: Performance of matching and sorting (n=1373): time 0.154/2.444, allocations: 50.89 MB / 1.127 GB, free: 233.1 MB / 0.5417 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0002024/2.445, allocations: 0.8021 MB / 1.127 GB, free: 232.3 MB / 0.5417 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.00787/2.452, allocations: 6.21 MB / 1.134 GB, free: 228.7 MB / 0.5417 GB
Notification: Performance of collectPreVariables (initialization): time 0.002923/2.455, allocations: 265.7 kB / 1.134 GB, free: 228.4 MB / 0.5417 GB
Notification: Performance of collectInitialEqns (initialization): time 0.002573/2.458, allocations: 5.476 MB / 1.139 GB, free: 223.2 MB / 0.5417 GB
Notification: Performance of collectInitialBindings (initialization): time 0.005676/2.464, allocations: 5.664 MB / 1.145 GB, free: 217.6 MB / 0.5417 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.007291/2.471, allocations: 4.033 MB / 1.149 GB, free: 213.5 MB / 0.5417 GB
Notification: Performance of setup shared object (initialization): time 5.344e-05/2.471, allocations: 480.7 kB / 1.149 GB, free: 213.1 MB / 0.5417 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.01186/2.483, allocations: 6.294 MB / 1.155 GB, free: 206.8 MB / 0.5417 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.01661/2.499, allocations: 12.21 MB / 1.167 GB, free: 192.7 MB / 0.5417 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.02938/2.529, allocations: 19.24 MB / 1.186 GB, free: 171.7 MB / 0.5417 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.000108/2.529, allocations: 24 kB / 1.186 GB, free: 171.7 MB / 0.5417 GB
Notification: Performance of matching and sorting (n=1986) (initialization): time 0.05335/2.582, allocations: 24.51 MB / 1.21 GB, free: 147.1 MB / 0.5417 GB
Notification: Performance of prepare postOptimizeDAE: time 8.32e-05/2.582, allocations: 44 kB / 1.21 GB, free: 147.1 MB / 0.5417 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001124/2.582, allocations: 87.94 kB / 1.21 GB, free: 147 MB / 0.5417 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.4207/3.003, allocations: 84.62 MB / 1.293 GB, free: 211.1 MB / 0.5417 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.006479/3.01, allocations: 1.662 MB / 1.294 GB, free: 211.1 MB / 0.5417 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.05374/3.063, allocations: 25.22 MB / 1.319 GB, free: 202.2 MB / 0.5417 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01289/3.076, allocations: 0.7997 MB / 1.32 GB, free: 201.8 MB / 0.5417 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.003117/3.079, allocations: 0.7042 MB / 1.32 GB, free: 201.3 MB / 0.5417 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.01706/3.096, allocations: 8.012 MB / 1.328 GB, free: 195.4 MB / 0.5417 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.01513/3.112, allocations: 11.92 MB / 1.34 GB, free: 182.8 MB / 0.5417 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.02881/3.14, allocations: 18.4 MB / 1.358 GB, free: 164.4 MB / 0.5417 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 0.0001127/3.14, allocations: 24 kB / 1.358 GB, free: 164.4 MB / 0.5417 GB
Notification: Performance of matching and sorting (n=1986) (initialization_lambda0): time 0.05066/3.191, allocations: 23.42 MB / 1.381 GB, free: 143.9 MB / 0.5417 GB
Notification: Performance of prepare postOptimizeDAE: time 8.116e-05/3.191, allocations: 40.75 kB / 1.381 GB, free: 143.9 MB / 0.5417 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001087/3.191, allocations: 88 kB / 1.381 GB, free: 143.8 MB / 0.5417 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.2284/3.42, allocations: 47.05 MB / 1.427 GB, free: 102.1 MB / 0.5417 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.1643/3.584, allocations: 1.735 MB / 1.428 GB, free: 222.2 MB / 0.5417 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.05041/3.634, allocations: 23.6 MB / 1.451 GB, free: 221 MB / 0.5417 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01279/3.647, allocations: 0.7786 MB / 1.452 GB, free: 221 MB / 0.5417 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.002793/3.65, allocations: 0.6823 MB / 1.453 GB, free: 221 MB / 0.5417 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 390
 * Number of states: 0 ()
 * Number of discrete variables: 48 (HEX.pipe_2.mediums[20].phase,HEX.pipe_2.mediums[19].phase,HEX.pipe_2.mediums[18].phase,HEX.pipe_2.mediums[17].phase,HEX.pipe_2.mediums[16].phase,HEX.pipe_2.mediums[15].phase,HEX.pipe_2.mediums[14].phase,HEX.pipe_2.mediums[13].phase,HEX.pipe_2.mediums[12].phase,HEX.pipe_2.mediums[11].phase,HEX.pipe_2.mediums[10].phase,HEX.pipe_2.mediums[9].phase,HEX.pipe_2.mediums[8].phase,HEX.pipe_2.mediums[7].phase,HEX.pipe_2.mediums[6].phase,HEX.pipe_2.mediums[5].phase,HEX.pipe_2.mediums[4].phase,HEX.pipe_2.mediums[3].phase,HEX.pipe_2.mediums[2].phase,HEX.pipe_2.mediums[1].phase,HEX.pipe_2.state_a.phase,HEX.pipe_1.mediums[20].phase,HEX.pipe_1.mediums[19].phase,HEX.pipe_1.mediums[18].phase,HEX.pipe_1.mediums[17].phase,HEX.pipe_1.mediums[16].phase,HEX.pipe_1.mediums[15].phase,HEX.pipe_1.mediums[14].phase,HEX.pipe_1.mediums[13].phase,HEX.pipe_1.mediums[12].phase,HEX.pipe_1.mediums[11].phase,HEX.pipe_1.mediums[10].phase,HEX.pipe_1.mediums[9].phase,HEX.pipe_1.mediums[8].phase,HEX.pipe_1.mediums[7].phase,HEX.pipe_1.mediums[6].phase,HEX.pipe_1.mediums[5].phase,HEX.pipe_1.mediums[4].phase,HEX.pipe_1.mediums[3].phase,HEX.pipe_1.mediums[2].phase,HEX.pipe_1.mediums[1].phase,HEX.pipe_1.state_b.phase,massFlowRate1.medium.phase,massFlowRate2.medium.phase,ambient1.medium.phase,ambient2.medium.phase,HEX.pipe_2.state_b.phase,HEX.pipe_1.state_a.phase)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (923):
 * Single equations (assignments): 922
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 1
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 0 systems
 * Non-linear torn systems (#iteration vars, #inner vars): 1 system
   {(100,964)}
Notification: Performance of prepare postOptimizeDAE: time 0.00379/3.654, allocations: 1.099 MB / 1.454 GB, free: 220.7 MB / 0.5417 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.00359/3.657, allocations: 1.254 MB / 1.455 GB, free: 220.7 MB / 0.5417 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.05446/3.712, allocations: 26.84 MB / 1.481 GB, free: 212.6 MB / 0.5417 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.0001968/3.712, allocations: 282.4 kB / 1.482 GB, free: 212.5 MB / 0.5417 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 6.961e-05/3.712, allocations: 11.5 kB / 1.482 GB, free: 212.5 MB / 0.5417 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.04016/3.752, allocations: 21.58 MB / 1.503 GB, free: 200.2 MB / 0.5417 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.1029/3.855, allocations: 44.83 MB / 1.547 GB, free: 155.6 MB / 0.5417 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 0.0001677/3.855, allocations: 0 / 1.547 GB, free: 155.6 MB / 0.5417 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.01879/3.874, allocations: 2.885 MB / 1.549 GB, free: 152.8 MB / 0.5417 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.07301/3.947, allocations: 13.06 MB / 1.562 GB, free: 139.7 MB / 0.5417 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.00399/3.951, allocations: 0.5426 MB / 1.563 GB, free: 139.1 MB / 0.5417 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.04778/3.999, allocations: 109.9 MB / 1.67 GB, free: 23.41 MB / 0.5417 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.633e-06/3.999, allocations: 0 / 1.67 GB, free: 23.41 MB / 0.5417 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.2119/4.211, allocations: 29.49 MB / 1.699 GB, free: 199.3 MB / 0.5417 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.002733/4.214, allocations: 1.229 MB / 1.7 GB, free: 199.3 MB / 0.5417 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.003829/4.217, allocations: 445.6 kB / 1.7 GB, free: 199.3 MB / 0.5417 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.008852/4.226, allocations: 0.5654 MB / 1.701 GB, free: 199.3 MB / 0.5417 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.003214/4.229, allocations: 0.9613 MB / 1.702 GB, free: 199.3 MB / 0.5417 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.001982/4.231, allocations: 0.4925 MB / 1.702 GB, free: 199.3 MB / 0.5417 GB
Notification: Performance of sorting global known variables: time 0.004802/4.236, allocations: 3.185 MB / 1.706 GB, free: 199 MB / 0.5417 GB
Notification: Performance of sort global known variables: time 1e-07/4.236, allocations: 2.562 kB / 1.706 GB, free: 199 MB / 0.5417 GB
Notification: Performance of remove unused functions: time 0.0283/4.265, allocations: 8.76 MB / 1.714 GB, free: 199 MB / 0.5417 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 1
 * Number of states: 100 (HEX.wall.T[1],HEX.wall.T[2],HEX.wall.T[3],HEX.wall.T[4],HEX.wall.T[5],HEX.wall.T[6],HEX.wall.T[7],HEX.wall.T[8],HEX.wall.T[9],HEX.wall.T[10],HEX.wall.T[11],HEX.wall.T[12],HEX.wall.T[13],HEX.wall.T[14],HEX.wall.T[15],HEX.wall.T[16],HEX.wall.T[17],HEX.wall.T[18],HEX.wall.T[19],HEX.wall.T[20],HEX.pipe_1.mediums[1].p,HEX.pipe_1.mediums[1].T,HEX.pipe_1.mediums[2].p,HEX.pipe_1.mediums[2].T,HEX.pipe_1.mediums[3].p,HEX.pipe_1.mediums[3].T,HEX.pipe_1.mediums[4].p,HEX.pipe_1.mediums[4].T,HEX.pipe_1.mediums[5].p,HEX.pipe_1.mediums[5].T,HEX.pipe_1.mediums[6].p,HEX.pipe_1.mediums[6].T,HEX.pipe_1.mediums[7].p,HEX.pipe_1.mediums[7].T,HEX.pipe_1.mediums[8].p,HEX.pipe_1.mediums[8].T,HEX.pipe_1.mediums[9].p,HEX.pipe_1.mediums[9].T,HEX.pipe_1.mediums[10].p,HEX.pipe_1.mediums[10].T,HEX.pipe_1.mediums[11].p,HEX.pipe_1.mediums[11].T,HEX.pipe_1.mediums[12].p,HEX.pipe_1.mediums[12].T,HEX.pipe_1.mediums[13].p,HEX.pipe_1.mediums[13].T,HEX.pipe_1.mediums[14].p,HEX.pipe_1.mediums[14].T,HEX.pipe_1.mediums[15].p,HEX.pipe_1.mediums[15].T,HEX.pipe_1.mediums[16].p,HEX.pipe_1.mediums[16].T,HEX.pipe_1.mediums[17].p,HEX.pipe_1.mediums[17].T,HEX.pipe_1.mediums[18].p,HEX.pipe_1.mediums[18].T,HEX.pipe_1.mediums[19].p,HEX.pipe_1.mediums[19].T,HEX.pipe_1.mediums[20].p,HEX.pipe_1.mediums[20].T,HEX.pipe_2.mediums[1].p,HEX.pipe_2.mediums[1].T,HEX.pipe_2.mediums[2].p,HEX.pipe_2.mediums[2].T,HEX.pipe_2.mediums[3].p,HEX.pipe_2.mediums[3].T,HEX.pipe_2.mediums[4].p,HEX.pipe_2.mediums[4].T,HEX.pipe_2.mediums[5].p,HEX.pipe_2.mediums[5].T,HEX.pipe_2.mediums[6].p,HEX.pipe_2.mediums[6].T,HEX.pipe_2.mediums[7].p,HEX.pipe_2.mediums[7].T,HEX.pipe_2.mediums[8].p,HEX.pipe_2.mediums[8].T,HEX.pipe_2.mediums[9].p,HEX.pipe_2.mediums[9].T,HEX.pipe_2.mediums[10].p,HEX.pipe_2.mediums[10].T,HEX.pipe_2.mediums[11].p,HEX.pipe_2.mediums[11].T,HEX.pipe_2.mediums[12].p,HEX.pipe_2.mediums[12].T,HEX.pipe_2.mediums[13].p,HEX.pipe_2.mediums[13].T,HEX.pipe_2.mediums[14].p,HEX.pipe_2.mediums[14].T,HEX.pipe_2.mediums[15].p,HEX.pipe_2.mediums[15].T,HEX.pipe_2.mediums[16].p,HEX.pipe_2.mediums[16].T,HEX.pipe_2.mediums[17].p,HEX.pipe_2.mediums[17].T,HEX.pipe_2.mediums[18].p,HEX.pipe_2.mediums[18].T,HEX.pipe_2.mediums[19].p,HEX.pipe_2.mediums[19].T,HEX.pipe_2.mediums[20].p,HEX.pipe_2.mediums[20].T)
 * Number of discrete variables: 92 ($cse1.phase,$cse1.region,$cse2.phase,$cse2.region,$cse3.phase,$cse3.region,$cse4.phase,$cse4.region,$cse5.phase,$cse5.region,$cse6.phase,$cse6.region,$cse7.phase,$cse7.region,$cse8.phase,$cse8.region,$cse9.phase,$cse9.region,$cse10.phase,$cse10.region,$cse11.phase,$cse11.region,$cse12.phase,$cse12.region,$cse13.phase,$cse13.region,$cse14.phase,$cse14.region,$cse15.phase,$cse15.region,$cse16.phase,$cse16.region,$cse17.phase,$cse17.region,$cse18.phase,$cse18.region,$cse19.phase,$cse19.region,$cse20.phase,$cse20.region,$cse81.phase,$cse81.region,$cse82.phase,$cse82.region,$cse83.phase,$cse83.region,$cse84.phase,$cse84.region,$cse85.phase,$cse85.region,$cse86.phase,$cse86.region,$cse87.phase,$cse87.region,$cse88.phase,$cse88.region,$cse89.phase,$cse89.region,$cse90.phase,$cse90.region,$cse91.phase,$cse91.region,$cse92.phase,$cse92.region,$cse93.phase,$cse93.region,$cse94.phase,$cse94.region,$cse95.phase,$cse95.region,$cse96.phase,$cse96.region,$cse97.phase,$cse97.region,$cse98.phase,$cse98.region,$cse99.phase,$cse99.region,$cse100.phase,$cse100.region,$cse101.phase,$cse101.region,$cse102.phase,$cse102.region,$cse123.phase,$cse123.region,$cse124.phase,$cse124.region,$cse127.phase,$cse127.region,$cse128.phase,$cse128.region)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (1379):
 * Single equations (assignments): 1253
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 46
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 80
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 40 systems
   {(1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 40 systems
   {(2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1), (2,1)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.01007/4.275, allocations: 2.481 MB / 1.716 GB, free: 198.8 MB / 0.5417 GB
Notification: Performance of simCode: created initialization part: time 0.08176/4.356, allocations: 32.1 MB / 1.748 GB, free: 194.9 MB / 0.5417 GB
Notification: Performance of simCode: created event and clocks part: time 1.193e-05/4.356, allocations: 5.75 kB / 1.748 GB, free: 194.9 MB / 0.5417 GB
Notification: Performance of simCode: created simulation system equations: time 0.02695/4.383, allocations: 17.12 MB / 1.765 GB, free: 178.9 MB / 0.5417 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.02201/4.405, allocations: 3.978 MB / 1.768 GB, free: 176 MB / 0.5417 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.05432/4.46, allocations: 35.67 MB / 1.803 GB, free: 141.3 MB / 0.5417 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.008184/4.468, allocations: 7.622 MB / 1.811 GB, free: 133.6 MB / 0.5417 GB
Notification: Performance of simCode: alias equations: time 0.01616/4.484, allocations: 5.777 MB / 1.816 GB, free: 127.9 MB / 0.5417 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.005867/4.49, allocations: 0.8479 MB / 1.817 GB, free: 127.1 MB / 0.5417 GB
Notification: Performance of SimCode: time 1.714e-06/4.49, allocations: 0 / 1.817 GB, free: 127.1 MB / 0.5417 GB
Notification: Performance of Templates: time 1.078/5.567, allocations: 420 MB / 2.227 GB, free: 164.7 MB / 0.5418 GB
"
[Timeout remaining time 654]
make -j1 -f Modelica_4.0.0_Modelica.Fluid.Examples.HeatExchanger.HeatExchangerSimulation.makefile [Timeout 660]
(rm -f Modelica_4.0.0_Modelica.Fluid.Examples.HeatExchanger.HeatExchangerSimulation.pipe ; mkfifo Modelica_4.0.0_Modelica.Fluid.Examples.HeatExchanger.HeatExchangerSimulation.pipe ; head -c 1048576 < Modelica_4.0.0_Modelica.Fluid.Examples.HeatExchanger.HeatExchangerSimulation.pipe >> ../files/Modelica_4.0.0_Modelica.Fluid.Examples.HeatExchanger.HeatExchangerSimulation.sim & ./Modelica_4.0.0_Modelica.Fluid.Examples.HeatExchanger.HeatExchangerSimulation -abortSlowSimulation -alarm=240  -emit_protected -lv LOG_STATS > Modelica_4.0.0_Modelica.Fluid.Examples.HeatExchanger.HeatExchangerSimulation.pipe 2>&1) [Timeout 240]
[Calling os._exit(0), Time elapsed: 27.351970135001466]