Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ClaRa_ClaRa.Components.HeatExchangers.Check.Test_PlateHEXvle2vle_L4.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/SMArtInt main/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/SMArtInt main/package.mo): time 0.008564/0.008564, allocations: 1.784 MB / 21.64 MB, free: 2.816 MB / 18.57 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo): time 0.0008434/0.0008434, allocations: 83.64 kB / 25.48 MB, free: 6.41 MB / 18.57 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo): time 0.0009032/0.0009032, allocations: 166.3 kB / 28.89 MB, free: 3.375 MB / 18.57 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo): time 0.8534/0.8534, allocations: 177.2 MB / 209.3 MB, free: 2.223 MB / 186.7 MB
"
[Timeout remaining time 179]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ClaRa 1.9.0/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ClaRa 1.9.0/package.mo): time 0.682/0.682, allocations: 102.5 MB / 368.3 MB, free: 0.7539 MB / 330.8 MB
"
[Timeout remaining time 179]
Using package ClaRa with version 1.9.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ClaRa 1.9.0/package.mo)
Using package Modelica with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo)
Using package Complex with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo)
Using package ModelicaServices with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo)
Using package SMArtInt with version 1.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/SMArtInt main/package.mo)
Running command: translateModel(ClaRa.Components.HeatExchangers.Check.Test_PlateHEXvle2vle_L4,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="Time|plateHEX.flow_a.h.[0-9,]+.|plateHEX.flow_a.p.[0-9,]+.|plateHEX.flow_b.h.[0-9,]+.|plateHEX.flow_b.p.[0-9,]+.|plateHEX.thinWall.U.[0-9,]+.",fileNamePrefix="ClaRa_ClaRa.Components.HeatExchangers.Check.Test_PlateHEXvle2vle_L4")
translateModel(ClaRa.Components.HeatExchangers.Check.Test_PlateHEXvle2vle_L4,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="Time|plateHEX.flow_a.h.[0-9,]+.|plateHEX.flow_a.p.[0-9,]+.|plateHEX.flow_b.h.[0-9,]+.|plateHEX.flow_b.p.[0-9,]+.|plateHEX.thinWall.U.[0-9,]+.",fileNamePrefix="ClaRa_ClaRa.Components.HeatExchangers.Check.Test_PlateHEXvle2vle_L4") [Timeout 800]
"Notification: Performance of FrontEnd - loaded program: time 1.904e-06/1.904e-06, allocations: 0 / 415.1 MB, free: 2.203 MB / 378.8 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 2.083e-05/2.273e-05, allocations: 2.312 kB / 415.1 MB, free: 2.199 MB / 378.8 MB
Notification: TILMedia requested package Modelica of version 4.0.0. Modelica 4.1.0 is used instead which states that it is fully compatible without conversion script needed.
Notification: Automatically loaded package TILMedia 1.9.0 ClaRa due to usage.
Notification: Performance of NFInst.instantiate(ClaRa.Components.HeatExchangers.Check.Test_PlateHEXvle2vle_L4): time 0.1153/0.1153, allocations: 73.35 MB / 488.4 MB, free: 8.859 MB / 458.8 MB
Notification: Performance of NFInst.instExpressions: time 0.02334/0.1386, allocations: 20.71 MB / 0.4972 GB, free: 4.09 MB / 474.8 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.002663/0.1413, allocations: 103.2 kB / 0.4973 GB, free: 3.988 MB / 474.8 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/ClaRa 1.9.0/SimCenter.mo:71:5-72:35:writable] Warning: Connector cycleSumPort is not balanced: The number of potential variables (0) is not equal to the number of flow variables (4).
Notification: Performance of NFTyping.typeComponents: time 0.003926/0.1452, allocations: 2.317 MB / 0.4996 GB, free: 1.66 MB / 474.8 MB
Notification: Performance of NFTyping.typeBindings: time 0.006038/0.1513, allocations: 3.683 MB / 0.5032 GB, free: 13.96 MB / 490.8 MB
Notification: Performance of NFTyping.typeClassSections: time 0.004754/0.156, allocations: 3.238 MB / 0.5063 GB, free: 10.71 MB / 490.8 MB
Notification: Performance of NFFlatten.flatten: time 0.1858/0.3419, allocations: 13.57 MB / 0.5196 GB, free: 46.68 MB / 490.8 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.004887/0.3467, allocations: 3.996 MB / 0.5235 GB, free: 46.34 MB / 490.8 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.09636/0.4431, allocations: 43.54 MB / 0.566 GB, free: 25.02 MB / 490.8 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.006632/0.4497, allocations: 4.894 MB / 0.5708 GB, free: 24.59 MB / 490.8 MB
Notification: Performance of NFPackage.collectConstants: time 0.002008/0.4517, allocations: 0.8759 MB / 0.5716 GB, free: 24.59 MB / 490.8 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.003029/0.4548, allocations: 1.981 MB / 0.5736 GB, free: 23.3 MB / 490.8 MB
Notification: Performance of NFScalarize.scalarize: time 0.001944/0.4567, allocations: 3.829 MB / 0.5773 GB, free: 20.84 MB / 490.8 MB
Notification: Performance of NFVerifyModel.verify: time 0.002597/0.4593, allocations: 3.17 MB / 0.5804 GB, free: 17.76 MB / 490.8 MB
Notification: Performance of NFConvertDAE.convert: time 0.00656/0.4659, allocations: 9.056 MB / 0.5893 GB, free: 9.309 MB / 490.8 MB
Notification: Performance of FrontEnd - DAE generated: time 5.29e-06/0.4659, allocations: 0 / 0.5893 GB, free: 9.309 MB / 490.8 MB
Notification: Performance of FrontEnd: time 1.172e-06/0.4659, allocations: 0 / 0.5893 GB, free: 9.309 MB / 490.8 MB
Notification: Performance of Transformations before backend: time 0.0002367/0.4661, allocations: 0 / 0.5893 GB, free: 9.309 MB / 490.8 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 1680
 * Number of variables: 1680
Notification: Performance of Generate backend data structure: time 0.008324/0.4744, allocations: 8.668 MB / 0.5977 GB, free: 1.18 MB / 490.8 MB
Notification: Performance of prepare preOptimizeDAE: time 3.116e-05/0.4745, allocations: 10.72 kB / 0.5977 GB, free: 1.172 MB / 490.8 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0008774/0.4753, allocations: 0.7463 MB / 0.5985 GB, free: 448 kB / 490.8 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.004278/0.4796, allocations: 3.91 MB / 0.6023 GB, free: 12.72 MB / 0.4949 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001472/0.4798, allocations: 306.8 kB / 0.6026 GB, free: 12.44 MB / 0.4949 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0004477/0.4802, allocations: 410.9 kB / 0.603 GB, free: 12.05 MB / 0.4949 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.008599/0.4888, allocations: 7.921 MB / 0.6107 GB, free: 3.324 MB / 0.4949 GB
Notification: Performance of preOpt findStateOrder (simulation): time 6.993e-05/0.4889, allocations: 45.53 kB / 0.6107 GB, free: 3.309 MB / 0.4949 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0003331/0.4892, allocations: 195.3 kB / 0.6109 GB, free: 3.129 MB / 0.4949 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.000452/0.4897, allocations: 0.62 MB / 0.6115 GB, free: 2.508 MB / 0.4949 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.005836/0.4955, allocations: 3.889 MB / 0.6153 GB, free: 14.91 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.02246/0.518, allocations: 36.03 MB / 0.6505 GB, free: 10.55 MB / 0.5418 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.006848/0.5248, allocations: 4.273 MB / 0.6547 GB, free: 6.258 MB / 0.5418 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001156/0.526, allocations: 0.8594 MB / 0.6555 GB, free: 5.352 MB / 0.5418 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0003367/0.5263, allocations: 206.5 kB / 0.6557 GB, free: 5.148 MB / 0.5418 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 6.698e-05/0.5264, allocations: 107.5 kB / 0.6558 GB, free: 5.043 MB / 0.5418 GB
Notification: Performance of pre-optimization done (n=794): time 5.941e-06/0.5264, allocations: 0 / 0.6558 GB, free: 5.043 MB / 0.5418 GB
Notification: Performance of matching and sorting (n=794): time 0.01398/0.5404, allocations: 7.528 MB / 0.6632 GB, free: 13.55 MB / 0.5574 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0002852/0.5406, allocations: 0.992 MB / 0.6641 GB, free: 12.34 MB / 0.5574 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.004257/0.5449, allocations: 4.566 MB / 0.6686 GB, free: 8.543 MB / 0.5574 GB
Notification: Performance of collectPreVariables (initialization): time 0.0002651/0.5452, allocations: 89.7 kB / 0.6687 GB, free: 8.449 MB / 0.5574 GB
Notification: Performance of collectInitialEqns (initialization): time 0.001172/0.5463, allocations: 2.232 MB / 0.6709 GB, free: 6.422 MB / 0.5574 GB
Notification: Performance of collectInitialBindings (initialization): time 0.001433/0.5478, allocations: 2.721 MB / 0.6735 GB, free: 3.863 MB / 0.5574 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.001248/0.549, allocations: 1.325 MB / 0.6748 GB, free: 2.703 MB / 0.5574 GB
Notification: Performance of setup shared object (initialization): time 6.267e-05/0.5491, allocations: 301.1 kB / 0.6751 GB, free: 2.406 MB / 0.5574 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.00123/0.5503, allocations: 0.8876 MB / 0.676 GB, free: 1.5 MB / 0.5574 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.002259/0.5526, allocations: 3.463 MB / 0.6794 GB, free: 13.12 MB / 0.573 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.004797/0.5574, allocations: 5.427 MB / 0.6847 GB, free: 7.203 MB / 0.573 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 2.435e-05/0.5574, allocations: 20 kB / 0.6847 GB, free: 7.184 MB / 0.573 GB
Notification: Performance of matching and sorting (n=1133) (initialization): time 0.005609/0.563, allocations: 4.381 MB / 0.6889 GB, free: 3.195 MB / 0.573 GB
Notification: Performance of prepare postOptimizeDAE: time 4.239e-05/0.563, allocations: 32 kB / 0.689 GB, free: 3.164 MB / 0.573 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0002392/0.5633, allocations: 247.8 kB / 0.6892 GB, free: 2.922 MB / 0.573 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.002388/0.5657, allocations: 1.078 MB / 0.6903 GB, free: 1.824 MB / 0.573 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001998/0.5677, allocations: 1.085 MB / 0.6913 GB, free: 0.8203 MB / 0.573 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01023/0.5779, allocations: 24.32 MB / 0.7151 GB, free: 6.801 MB / 0.6043 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.003982/0.5819, allocations: 0.7322 MB / 0.7158 GB, free: 6.062 MB / 0.6043 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0003921/0.5823, allocations: 262.6 kB / 0.716 GB, free: 5.809 MB / 0.6043 GB
Warning: Assuming fixed start value for the following 20 variables:
         plateHEX.flow_a.h[1]:VARIABLE(start = plateHEX.flow_a.h_start[1] unit = \"J/kg\" fixed = true nominal = 1000.0 stateSelect=StateSelect.prefer protected = true )  \"Cell enthalpy\" type: Real [5]
         plateHEX.flow_a.h[2]:VARIABLE(start = plateHEX.flow_a.h_start[2] unit = \"J/kg\" fixed = true nominal = 1000.0 stateSelect=StateSelect.prefer protected = true )  \"Cell enthalpy\" type: Real [5]
         plateHEX.flow_a.h[3]:VARIABLE(start = plateHEX.flow_a.h_start[3] unit = \"J/kg\" fixed = true nominal = 1000.0 stateSelect=StateSelect.prefer protected = true )  \"Cell enthalpy\" type: Real [5]
         plateHEX.flow_a.h[4]:VARIABLE(start = plateHEX.flow_a.h_start[4] unit = \"J/kg\" fixed = true nominal = 1000.0 stateSelect=StateSelect.prefer protected = true )  \"Cell enthalpy\" type: Real [5]
         plateHEX.flow_a.h[5]:VARIABLE(start = plateHEX.flow_a.h_start[5] unit = \"J/kg\" fixed = true nominal = 1000.0 stateSelect=StateSelect.prefer protected = true )  \"Cell enthalpy\" type: Real [5]
         plateHEX.flow_a.p[1]:VARIABLE(min = 0.0 start = plateHEX.flow_a.p_start_internal[1] unit = \"Pa\" fixed = true nominal = 1e5 protected = true )  \"Cell pressure\" type: Real [5]
         plateHEX.flow_a.p[2]:VARIABLE(min = 0.0 start = plateHEX.flow_a.p_start_internal[2] unit = \"Pa\" fixed = true nominal = 1e5 protected = true )  \"Cell pressure\" type: Real [5]
         plateHEX.flow_a.p[3]:VARIABLE(min = 0.0 start = plateHEX.flow_a.p_start_internal[3] unit = \"Pa\" fixed = true nominal = 1e5 protected = true )  \"Cell pressure\" type: Real [5]
         plateHEX.flow_a.p[4]:VARIABLE(min = 0.0 start = plateHEX.flow_a.p_start_internal[4] unit = \"Pa\" fixed = true nominal = 1e5 protected = true )  \"Cell pressure\" type: Real [5]
         plateHEX.flow_a.p[5]:VARIABLE(min = 0.0 start = plateHEX.flow_a.p_start_internal[5] unit = \"Pa\" fixed = true nominal = 1e5 protected = true )  \"Cell pressure\" type: Real [5]
         plateHEX.flow_b.h[1]:VARIABLE(start = plateHEX.flow_b.h_start[1] unit = \"J/kg\" fixed = true nominal = 1000.0 stateSelect=StateSelect.prefer protected = true )  \"Cell enthalpy\" type: Real [5]
         plateHEX.flow_b.h[2]:VARIABLE(start = plateHEX.flow_b.h_start[2] unit = \"J/kg\" fixed = true nominal = 1000.0 stateSelect=StateSelect.prefer protected = true )  \"Cell enthalpy\" type: Real [5]
         plateHEX.flow_b.h[3]:VARIABLE(start = plateHEX.flow_b.h_start[3] unit = \"J/kg\" fixed = true nominal = 1000.0 stateSelect=StateSelect.prefer protected = true )  \"Cell enthalpy\" type: Real [5]
         plateHEX.flow_b.h[4]:VARIABLE(start = plateHEX.flow_b.h_start[4] unit = \"J/kg\" fixed = true nominal = 1000.0 stateSelect=StateSelect.prefer protected = true )  \"Cell enthalpy\" type: Real [5]
         plateHEX.flow_b.h[5]:VARIABLE(start = plateHEX.flow_b.h_start[5] unit = \"J/kg\" fixed = true nominal = 1000.0 stateSelect=StateSelect.prefer protected = true )  \"Cell enthalpy\" type: Real [5]
         plateHEX.flow_b.p[1]:VARIABLE(min = 0.0 start = plateHEX.flow_b.p_start_internal[1] unit = \"Pa\" fixed = true nominal = 1e5 protected = true )  \"Cell pressure\" type: Real [5]
         plateHEX.flow_b.p[2]:VARIABLE(min = 0.0 start = plateHEX.flow_b.p_start_internal[2] unit = \"Pa\" fixed = true nominal = 1e5 protected = true )  \"Cell pressure\" type: Real [5]
         plateHEX.flow_b.p[3]:VARIABLE(min = 0.0 start = plateHEX.flow_b.p_start_internal[3] unit = \"Pa\" fixed = true nominal = 1e5 protected = true )  \"Cell pressure\" type: Real [5]
         plateHEX.flow_b.p[4]:VARIABLE(min = 0.0 start = plateHEX.flow_b.p_start_internal[4] unit = \"Pa\" fixed = true nominal = 1e5 protected = true )  \"Cell pressure\" type: Real [5]
         plateHEX.flow_b.p[5]:VARIABLE(min = 0.0 start = plateHEX.flow_b.p_start_internal[5] unit = \"Pa\" fixed = true nominal = 1e5 protected = true )  \"Cell pressure\" type: Real [5]
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.002972/0.5852, allocations: 1.183 MB / 0.7172 GB, free: 4.629 MB / 0.6043 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.002292/0.5875, allocations: 3.454 MB / 0.7206 GB, free: 236 kB / 0.6043 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.004876/0.5924, allocations: 5.358 MB / 0.7258 GB, free: 10.1 MB / 0.6199 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 3.269e-05/0.5924, allocations: 20 kB / 0.7258 GB, free: 10.08 MB / 0.6199 GB
Notification: Performance of matching and sorting (n=1133) (initialization_lambda0): time 0.005629/0.5981, allocations: 4.35 MB / 0.7301 GB, free: 5.664 MB / 0.6199 GB
Notification: Performance of prepare postOptimizeDAE: time 3.041e-05/0.5981, allocations: 36 kB / 0.7301 GB, free: 5.629 MB / 0.6199 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0003508/0.5985, allocations: 247.8 kB / 0.7303 GB, free: 5.387 MB / 0.6199 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.00215/0.6006, allocations: 1.077 MB / 0.7314 GB, free: 4.281 MB / 0.6199 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.00194/0.6025, allocations: 1.083 MB / 0.7325 GB, free: 3.199 MB / 0.6199 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.2412/0.8437, allocations: 24.29 MB / 0.7562 GB, free: 163 MB / 0.6355 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.003607/0.8473, allocations: 0.6084 MB / 0.7568 GB, free: 163 MB / 0.6355 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0003665/0.8477, allocations: 255.4 kB / 0.757 GB, free: 163 MB / 0.6355 GB
Warning: Assuming fixed start value for the following 20 variables:
         plateHEX.flow_a.h[1]:VARIABLE(start = plateHEX.flow_a.h_start[1] unit = \"J/kg\" fixed = true nominal = 1000.0 stateSelect=StateSelect.prefer protected = true )  \"Cell enthalpy\" type: Real [5]
         plateHEX.flow_a.h[2]:VARIABLE(start = plateHEX.flow_a.h_start[2] unit = \"J/kg\" fixed = true nominal = 1000.0 stateSelect=StateSelect.prefer protected = true )  \"Cell enthalpy\" type: Real [5]
         plateHEX.flow_a.h[3]:VARIABLE(start = plateHEX.flow_a.h_start[3] unit = \"J/kg\" fixed = true nominal = 1000.0 stateSelect=StateSelect.prefer protected = true )  \"Cell enthalpy\" type: Real [5]
         plateHEX.flow_a.h[4]:VARIABLE(start = plateHEX.flow_a.h_start[4] unit = \"J/kg\" fixed = true nominal = 1000.0 stateSelect=StateSelect.prefer protected = true )  \"Cell enthalpy\" type: Real [5]
         plateHEX.flow_a.h[5]:VARIABLE(start = plateHEX.flow_a.h_start[5] unit = \"J/kg\" fixed = true nominal = 1000.0 stateSelect=StateSelect.prefer protected = true )  \"Cell enthalpy\" type: Real [5]
         plateHEX.flow_a.p[1]:VARIABLE(min = 0.0 start = plateHEX.flow_a.p_start_internal[1] unit = \"Pa\" fixed = true nominal = 1e5 protected = true )  \"Cell pressure\" type: Real [5]
         plateHEX.flow_a.p[2]:VARIABLE(min = 0.0 start = plateHEX.flow_a.p_start_internal[2] unit = \"Pa\" fixed = true nominal = 1e5 protected = true )  \"Cell pressure\" type: Real [5]
         plateHEX.flow_a.p[3]:VARIABLE(min = 0.0 start = plateHEX.flow_a.p_start_internal[3] unit = \"Pa\" fixed = true nominal = 1e5 protected = true )  \"Cell pressure\" type: Real [5]
         plateHEX.flow_a.p[4]:VARIABLE(min = 0.0 start = plateHEX.flow_a.p_start_internal[4] unit = \"Pa\" fixed = true nominal = 1e5 protected = true )  \"Cell pressure\" type: Real [5]
         plateHEX.flow_a.p[5]:VARIABLE(min = 0.0 start = plateHEX.flow_a.p_start_internal[5] unit = \"Pa\" fixed = true nominal = 1e5 protected = true )  \"Cell pressure\" type: Real [5]
         plateHEX.flow_b.h[1]:VARIABLE(start = plateHEX.flow_b.h_start[1] unit = \"J/kg\" fixed = true nominal = 1000.0 stateSelect=StateSelect.prefer protected = true )  \"Cell enthalpy\" type: Real [5]
         plateHEX.flow_b.h[2]:VARIABLE(start = plateHEX.flow_b.h_start[2] unit = \"J/kg\" fixed = true nominal = 1000.0 stateSelect=StateSelect.prefer protected = true )  \"Cell enthalpy\" type: Real [5]
         plateHEX.flow_b.h[3]:VARIABLE(start = plateHEX.flow_b.h_start[3] unit = \"J/kg\" fixed = true nominal = 1000.0 stateSelect=StateSelect.prefer protected = true )  \"Cell enthalpy\" type: Real [5]
         plateHEX.flow_b.h[4]:VARIABLE(start = plateHEX.flow_b.h_start[4] unit = \"J/kg\" fixed = true nominal = 1000.0 stateSelect=StateSelect.prefer protected = true )  \"Cell enthalpy\" type: Real [5]
         plateHEX.flow_b.h[5]:VARIABLE(start = plateHEX.flow_b.h_start[5] unit = \"J/kg\" fixed = true nominal = 1000.0 stateSelect=StateSelect.prefer protected = true )  \"Cell enthalpy\" type: Real [5]
         plateHEX.flow_b.p[1]:VARIABLE(min = 0.0 start = plateHEX.flow_b.p_start_internal[1] unit = \"Pa\" fixed = true nominal = 1e5 protected = true )  \"Cell pressure\" type: Real [5]
         plateHEX.flow_b.p[2]:VARIABLE(min = 0.0 start = plateHEX.flow_b.p_start_internal[2] unit = \"Pa\" fixed = true nominal = 1e5 protected = true )  \"Cell pressure\" type: Real [5]
         plateHEX.flow_b.p[3]:VARIABLE(min = 0.0 start = plateHEX.flow_b.p_start_internal[3] unit = \"Pa\" fixed = true nominal = 1e5 protected = true )  \"Cell pressure\" type: Real [5]
         plateHEX.flow_b.p[4]:VARIABLE(min = 0.0 start = plateHEX.flow_b.p_start_internal[4] unit = \"Pa\" fixed = true nominal = 1e5 protected = true )  \"Cell pressure\" type: Real [5]
         plateHEX.flow_b.p[5]:VARIABLE(min = 0.0 start = plateHEX.flow_b.p_start_internal[5] unit = \"Pa\" fixed = true nominal = 1e5 protected = true )  \"Cell pressure\" type: Real [5]
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 320
 * 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 (693):
 * Single equations (assignments): 605
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 68
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 20
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 20 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%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 0 systems
Notification: Performance of prepare postOptimizeDAE: time 0.001029/0.8487, allocations: 0.7025 MB / 0.7577 GB, free: 162.8 MB / 0.6355 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0009204/0.8496, allocations: 456.4 kB / 0.7581 GB, free: 162.8 MB / 0.6355 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01126/0.8609, allocations: 14.92 MB / 0.7727 GB, free: 160.9 MB / 0.6355 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 5.964e-05/0.8609, allocations: 47.45 kB / 0.7727 GB, free: 160.9 MB / 0.6355 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.984e-05/0.861, allocations: 7.469 kB / 0.7728 GB, free: 160.9 MB / 0.6355 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 4.363e-05/0.861, allocations: 15.89 kB / 0.7728 GB, free: 160.9 MB / 0.6355 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.005175/0.8662, allocations: 3.473 MB / 0.7762 GB, free: 160.8 MB / 0.6355 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 0.0001606/0.8663, allocations: 136.1 kB / 0.7763 GB, free: 160.8 MB / 0.6355 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.001176/0.8675, allocations: 490.7 kB / 0.7768 GB, free: 160.8 MB / 0.6355 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.002878/0.8704, allocations: 1.49 MB / 0.7782 GB, free: 160.5 MB / 0.6355 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0004602/0.8709, allocations: 118.3 kB / 0.7783 GB, free: 160.5 MB / 0.6355 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.007043/0.8779, allocations: 24.19 MB / 0.8019 GB, free: 137.4 MB / 0.6355 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.332e-06/0.8779, allocations: 4.938 kB / 0.802 GB, free: 137.4 MB / 0.6355 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.005318/0.8832, allocations: 3.826 MB / 0.8057 GB, free: 136.7 MB / 0.6355 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.001987/0.8852, allocations: 1.366 MB / 0.807 GB, free: 136.4 MB / 0.6355 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0008339/0.886, allocations: 145.3 kB / 0.8072 GB, free: 136.4 MB / 0.6355 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001298/0.8873, allocations: 70.03 kB / 0.8072 GB, free: 136.4 MB / 0.6355 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0004109/0.8877, allocations: 260.5 kB / 0.8075 GB, free: 136.4 MB / 0.6355 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0002135/0.888, allocations: 88.42 kB / 0.8076 GB, free: 136.4 MB / 0.6355 GB
Notification: Performance of sorting global known variables: time 0.002294/0.8903, allocations: 2.3 MB / 0.8098 GB, free: 136.2 MB / 0.6355 GB
Notification: Performance of sort global known variables: time 2.1e-07/0.8903, allocations: 0 / 0.8098 GB, free: 136.2 MB / 0.6355 GB
Notification: Performance of remove unused functions: time 0.006939/0.8972, allocations: 3.791 MB / 0.8135 GB, free: 136 MB / 0.6355 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 1
 * Number of states: 25 (plateHEX.flow_a.h[1],plateHEX.flow_a.h[2],plateHEX.flow_a.h[3],plateHEX.flow_a.h[4],plateHEX.flow_a.h[5],plateHEX.flow_a.p[1],plateHEX.flow_a.p[2],plateHEX.flow_a.p[3],plateHEX.flow_a.p[4],plateHEX.flow_a.p[5],plateHEX.flow_b.h[1],plateHEX.flow_b.h[2],plateHEX.flow_b.h[3],plateHEX.flow_b.h[4],plateHEX.flow_b.h[5],plateHEX.flow_b.p[1],plateHEX.flow_b.p[2],plateHEX.flow_b.p[3],plateHEX.flow_b.p[4],plateHEX.flow_b.p[5],plateHEX.thinWall.U[1],plateHEX.thinWall.U[2],plateHEX.thinWall.U[3],plateHEX.thinWall.U[4],plateHEX.thinWall.U[5])
 * 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 (326):
 * Single equations (assignments): 260
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 46
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 20
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 20 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%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 0 systems
Notification: Performance of Backend phase and start with SimCode phase: time 0.001486/0.8987, allocations: 0.8632 MB / 0.8144 GB, free: 135.9 MB / 0.6355 GB
Notification: Performance of simCode: created initialization part: time 0.009272/0.9079, allocations: 13.5 MB / 0.8275 GB, free: 127 MB / 0.6355 GB
Notification: Performance of simCode: created event and clocks part: time 0.0001776/0.9081, allocations: 87.16 kB / 0.8276 GB, free: 127 MB / 0.6355 GB
Notification: Performance of simCode: created simulation system equations: time 0.003651/0.9118, allocations: 4.79 MB / 0.8323 GB, free: 123.3 MB / 0.6355 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.005671/0.9174, allocations: 1.939 MB / 0.8342 GB, free: 123.2 MB / 0.6355 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.01726/0.9347, allocations: 12.09 MB / 0.846 GB, free: 113 MB / 0.6355 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001954/0.9367, allocations: 1.74 MB / 0.8477 GB, free: 111.4 MB / 0.6355 GB
Notification: Performance of simCode: alias equations: time 0.00466/0.9413, allocations: 1.51 MB / 0.8492 GB, free: 110.2 MB / 0.6355 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.005041/0.9464, allocations: 2.166 MB / 0.8513 GB, free: 108.2 MB / 0.6355 GB
Notification: Performance of SimCode: time 2.004e-06/0.9464, allocations: 0 / 0.8513 GB, free: 108.2 MB / 0.6355 GB
Notification: Performance of Templates: time 0.1338/1.08, allocations: 135.9 MB / 0.984 GB, free: 9.734 MB / 0.6668 GB
"
[Timeout remaining time 799]
make -j1 -f ClaRa_ClaRa.Components.HeatExchangers.Check.Test_PlateHEXvle2vle_L4.makefile [Timeout 800]
(rm -f ClaRa_ClaRa.Components.HeatExchangers.Check.Test_PlateHEXvle2vle_L4.pipe ; mkfifo ClaRa_ClaRa.Components.HeatExchangers.Check.Test_PlateHEXvle2vle_L4.pipe ; head -c 1048576 < ClaRa_ClaRa.Components.HeatExchangers.Check.Test_PlateHEXvle2vle_L4.pipe >> ../files/ClaRa_ClaRa.Components.HeatExchangers.Check.Test_PlateHEXvle2vle_L4.sim & ./ClaRa_ClaRa.Components.HeatExchangers.Check.Test_PlateHEXvle2vle_L4 -abortSlowSimulation -alarm=240  -emit_protected -lv LOG_STATS > ClaRa_ClaRa.Components.HeatExchangers.Check.Test_PlateHEXvle2vle_L4.pipe 2>&1) [Timeout 240]
diffSimulationResults("ClaRa_ClaRa.Components.HeatExchangers.Check.Test_PlateHEXvle2vle_L4_res.mat","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/ReferenceFiles/ClaRa/ReferenceResults/ClaRa.Components.HeatExchangers.Check.Test_PlateHEXvle2vle_L4.mat","",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001) [Timeout 800]
""
[Timeout remaining time 800]
Reference file matches
[Calling sys.exit(0), Time elapsed: 7.488347921986133]