Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ClaRa_dev_ClaRa.Components.HeatExchangers.Check.EvaluateDesuperheater.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.008493/0.008493, allocations: 1.442 MB / 20.54 MB, free: 4.012 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.0008657/0.0008657, allocations: 91.45 kB / 24.16 MB, free: 396 kB / 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.0007603/0.0007603, allocations: 165.8 kB / 27.86 MB, free: 5.496 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.8275/0.8275, allocations: 177.1 MB / 208.6 MB, free: 2.973 MB / 186.7 MB
"
[Timeout remaining time 179]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ClaRa main/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ClaRa main/package.mo): time 0.6766/0.6766, allocations: 102.4 MB / 367.9 MB, free: 1.5 MB / 330.8 MB
"
[Timeout remaining time 179]
Using package ClaRa with version 1.9.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ClaRa main/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 0.5.2 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/SMArtInt main/package.mo)
Running command: translateModel(ClaRa.Components.HeatExchangers.Check.EvaluateDesuperheater,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="Time|desuperheater_1.shell.h|desuperheater_1.shell.p|desuperheater_1.tubes.h|desuperheater_1.tubes.p|desuperheater_1.wall.T_w_a|desuperheater_1.wall.T_w_i|desuperheater_2.shell.h|desuperheater_2.shell.p|desuperheater_2.tubes.h|desuperheater_2.tubes.p|desuperheater_2.wall.T_w_a|desuperheater_2.wall.T_w_i",fileNamePrefix="ClaRa_dev_ClaRa.Components.HeatExchangers.Check.EvaluateDesuperheater")
translateModel(ClaRa.Components.HeatExchangers.Check.EvaluateDesuperheater,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="Time|desuperheater_1.shell.h|desuperheater_1.shell.p|desuperheater_1.tubes.h|desuperheater_1.tubes.p|desuperheater_1.wall.T_w_a|desuperheater_1.wall.T_w_i|desuperheater_2.shell.h|desuperheater_2.shell.p|desuperheater_2.tubes.h|desuperheater_2.tubes.p|desuperheater_2.wall.T_w_a|desuperheater_2.wall.T_w_i",fileNamePrefix="ClaRa_dev_ClaRa.Components.HeatExchangers.Check.EvaluateDesuperheater") [Timeout 800]
"Notification: Performance of FrontEnd - loaded program: time 1.263e-06/1.263e-06, allocations: 0 / 0.5367 GB, free: 39.29 MB / 490.8 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 1.333e-05/1.459e-05, allocations: 8.891 kB / 0.5367 GB, free: 39.28 MB / 490.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.EvaluateDesuperheater): time 0.1138/0.1138, allocations: 81.24 MB / 0.616 GB, free: 10.39 MB / 0.5105 GB
Notification: Performance of NFInst.instExpressions: time 0.03424/0.148, allocations: 27.42 MB / 0.6428 GB, free: 14.89 MB / 0.5418 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.006877/0.1549, allocations: 226.3 kB / 0.643 GB, free: 14.67 MB / 0.5418 GB
Notification: Performance of NFTyping.typeComponents: time 0.006202/0.1611, allocations: 3.786 MB / 0.6467 GB, free: 10.86 MB / 0.5418 GB
Notification: Performance of NFTyping.typeBindings: time 0.01181/0.1729, allocations: 6.414 MB / 0.653 GB, free: 4.406 MB / 0.5418 GB
Notification: Performance of NFTyping.typeClassSections: time 0.009934/0.1829, allocations: 6.262 MB / 0.6591 GB, free: 14.13 MB / 0.5574 GB
Notification: Performance of NFFlatten.flatten: time 0.01938/0.2022, allocations: 18.26 MB / 0.6769 GB, free: 11.81 MB / 0.573 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.007847/0.2101, allocations: 5.699 MB / 0.6825 GB, free: 6.023 MB / 0.573 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.01569/0.2258, allocations: 9.911 MB / 0.6921 GB, free: 12.09 MB / 0.5887 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.008363/0.2341, allocations: 5.942 MB / 0.6979 GB, free: 6.129 MB / 0.5887 GB
Notification: Performance of NFPackage.collectConstants: time 0.00275/0.2369, allocations: 1.176 MB / 0.6991 GB, free: 4.953 MB / 0.5887 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.005453/0.2423, allocations: 2.602 MB / 0.7016 GB, free: 2.348 MB / 0.5887 GB
Notification: Performance of NFScalarize.scalarize: time 0.002845/0.2452, allocations: 3.445 MB / 0.705 GB, free: 14.89 MB / 0.6043 GB
Notification: Performance of NFVerifyModel.verify: time 0.005559/0.2507, allocations: 3.88 MB / 0.7088 GB, free: 11 MB / 0.6043 GB
Notification: Performance of NFConvertDAE.convert: time 0.0153/0.266, allocations: 17.51 MB / 0.7259 GB, free: 9.441 MB / 0.6199 GB
Notification: Performance of FrontEnd - DAE generated: time 5.801e-06/0.266, allocations: 0 / 0.7259 GB, free: 9.441 MB / 0.6199 GB
Notification: Performance of FrontEnd: time 1.824e-06/0.2661, allocations: 4 kB / 0.7259 GB, free: 9.438 MB / 0.6199 GB
Notification: Performance of Transformations before backend: time 0.0003725/0.2664, allocations: 0 / 0.7259 GB, free: 9.438 MB / 0.6199 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 2265
 * Number of variables: 2265
Notification: Performance of Generate backend data structure: time 0.01614/0.2826, allocations: 14.22 MB / 0.7398 GB, free: 11.01 MB / 0.6355 GB
Notification: Performance of prepare preOptimizeDAE: time 3.753e-05/0.2826, allocations: 8.031 kB / 0.7398 GB, free: 11 MB / 0.6355 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.002337/0.2849, allocations: 1.504 MB / 0.7412 GB, free: 9.488 MB / 0.6355 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.00989/0.2948, allocations: 8.524 MB / 0.7496 GB, free: 0.875 MB / 0.6355 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0003208/0.2952, allocations: 463.8 kB / 0.75 GB, free: 432 kB / 0.6355 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0005591/0.2957, allocations: 0.578 MB / 0.7506 GB, free: 15.84 MB / 0.6512 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.2369/0.5326, allocations: 16.84 MB / 0.767 GB, free: 168 MB / 0.6512 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0001038/0.5327, allocations: 58.34 kB / 0.7671 GB, free: 168 MB / 0.6512 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0005484/0.5333, allocations: 292.7 kB / 0.7674 GB, free: 168 MB / 0.6512 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001605/0.5334, allocations: 201.5 kB / 0.7676 GB, free: 168 MB / 0.6512 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.01721/0.5507, allocations: 12.25 MB / 0.7795 GB, free: 164.1 MB / 0.6512 GB
Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.02822/0.5789, allocations: 50.62 MB / 0.8289 GB, free: 120.9 MB / 0.6512 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.01417/0.593, allocations: 11.02 MB / 0.8397 GB, free: 114.7 MB / 0.6512 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.003521/0.5966, allocations: 3.683 MB / 0.8433 GB, free: 112.6 MB / 0.6512 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0005068/0.5971, allocations: 333 kB / 0.8436 GB, free: 112.4 MB / 0.6512 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.01112/0.6082, allocations: 9.125 MB / 0.8525 GB, free: 105 MB / 0.6512 GB
Notification: Performance of pre-optimization done (n=1350): time 8.496e-06/0.6082, allocations: 3.938 kB / 0.8525 GB, free: 105 MB / 0.6512 GB
Notification: Performance of matching and sorting (n=1350): time 0.02969/0.6379, allocations: 21.11 MB / 0.8732 GB, free: 83.82 MB / 0.6512 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0002286/0.6381, allocations: 2.104 MB / 0.8752 GB, free: 81.23 MB / 0.6512 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.007144/0.6453, allocations: 7.947 MB / 0.883 GB, free: 73.42 MB / 0.6512 GB
Notification: Performance of collectPreVariables (initialization): time 0.0006818/0.646, allocations: 189.6 kB / 0.8831 GB, free: 73.23 MB / 0.6512 GB
Notification: Performance of collectInitialEqns (initialization): time 0.001568/0.6475, allocations: 3.858 MB / 0.8869 GB, free: 69.69 MB / 0.6512 GB
Notification: Performance of collectInitialBindings (initialization): time 0.00198/0.6495, allocations: 4.378 MB / 0.8912 GB, free: 65.93 MB / 0.6512 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.00204/0.6515, allocations: 2.549 MB / 0.8937 GB, free: 63.38 MB / 0.6512 GB
Notification: Performance of setup shared object (initialization): time 2.42e-05/0.6516, allocations: 309.1 kB / 0.894 GB, free: 63.07 MB / 0.6512 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.004784/0.6563, allocations: 4.961 MB / 0.8988 GB, free: 58.11 MB / 0.6512 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.005845/0.6622, allocations: 9.401 MB / 0.908 GB, free: 47.03 MB / 0.6512 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.1241/0.7862, allocations: 40.99 MB / 0.948 GB, free: 5.648 MB / 0.6512 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 4.797e-05/0.7863, allocations: 28 kB / 0.9481 GB, free: 5.621 MB / 0.6512 GB
Notification: Performance of matching and sorting (n=1769) (initialization): time 0.01993/0.8062, allocations: 15.4 MB / 0.9631 GB, free: 6.125 MB / 0.6668 GB
Notification: Performance of prepare postOptimizeDAE: time 5.017e-05/0.8063, allocations: 44 kB / 0.9631 GB, free: 6.082 MB / 0.6668 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.01364/0.8199, allocations: 11.53 MB / 0.9744 GB, free: 10.47 MB / 0.6824 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.02186/0.8418, allocations: 3.659 MB / 0.978 GB, free: 6.812 MB / 0.6824 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.006853/0.8486, allocations: 3.206 MB / 0.9811 GB, free: 3.602 MB / 0.6824 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.003627/0.8523, allocations: 6.33 MB / 0.9873 GB, free: 12.85 MB / 0.698 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.005603/0.8579, allocations: 1.212 MB / 0.9885 GB, free: 11.86 MB / 0.698 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001064/0.8589, allocations: 0.8119 MB / 0.9893 GB, free: 11.05 MB / 0.698 GB
Warning: Assuming fixed start value for the following 12 variables:
         desuperheater_1.wall.T_w_i:VARIABLE(min = 0.0 start = desuperheater_1.wall.T_w_i_start unit = \"K\" fixed = true protected = true )  \"Wall temperature at inner phase\" type: Real
         desuperheater_1.wall.T_w_a:VARIABLE(min = 0.0 start = desuperheater_1.wall.T_w_a_start unit = \"K\" fixed = true protected = true )  \"Wall temperature at outer phase\" type: Real
         desuperheater_1.tubes.h:VARIABLE(start = desuperheater_1.tubes.h_start unit = \"J/kg\" fixed = true nominal = 1000.0 protected = true )  \"spec. enthalpy state\" type: Real
         desuperheater_1.tubes.p:VARIABLE(min = 0.0 start = desuperheater_1.tubes.p_start unit = \"Pa\" fixed = true nominal = 1e5 stateSelect=StateSelect.prefer )  \"System pressure\" type: Real
         desuperheater_1.shell.h:VARIABLE(start = desuperheater_1.shell.h_start unit = \"J/kg\" fixed = true nominal = 1000.0 protected = true )  \"spec. enthalpy state\" type: Real
         desuperheater_1.shell.p:VARIABLE(min = 0.0 start = desuperheater_1.shell.p_start unit = \"Pa\" fixed = true nominal = 1e5 stateSelect=StateSelect.prefer )  \"System pressure\" type: Real
         desuperheater_2.tubes.h:VARIABLE(start = desuperheater_2.tubes.h_start unit = \"J/kg\" fixed = true nominal = 1000.0 protected = true )  \"spec. enthalpy state\" type: Real
         desuperheater_2.tubes.p:VARIABLE(min = 0.0 start = desuperheater_2.tubes.p_start unit = \"Pa\" fixed = true nominal = 1e5 stateSelect=StateSelect.prefer )  \"System pressure\" type: Real
         desuperheater_2.shell.h:VARIABLE(start = desuperheater_2.shell.h_start unit = \"J/kg\" fixed = true nominal = 1000.0 protected = true )  \"spec. enthalpy state\" type: Real
         desuperheater_2.shell.p:VARIABLE(min = 0.0 start = desuperheater_2.shell.p_start unit = \"Pa\" fixed = true nominal = 1e5 stateSelect=StateSelect.prefer )  \"System pressure\" type: Real
         desuperheater_2.wall.T_w_i:VARIABLE(min = 0.0 start = desuperheater_2.wall.T_w_i_start unit = \"K\" fixed = true protected = true )  \"Wall temperature at inner phase\" type: Real
         desuperheater_2.wall.T_w_a:VARIABLE(min = 0.0 start = desuperheater_2.wall.T_w_a_start unit = \"K\" fixed = true protected = true )  \"Wall temperature at outer phase\" type: Real
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.009726/0.8687, allocations: 6.798 MB / 0.9959 GB, free: 4.246 MB / 0.698 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.007635/0.8763, allocations: 9.321 MB / 1.005 GB, free: 9.242 MB / 0.7137 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.3621/1.238, allocations: 40.45 MB / 1.044 GB, free: 246.1 MB / 0.7449 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 9.792e-05/1.239, allocations: 25.91 kB / 1.045 GB, free: 246.1 MB / 0.7449 GB
Notification: Performance of matching and sorting (n=1769) (initialization_lambda0): time 0.02114/1.26, allocations: 15.29 MB / 1.059 GB, free: 243.3 MB / 0.7449 GB
Notification: Performance of prepare postOptimizeDAE: time 5.109e-05/1.26, allocations: 49.66 kB / 1.059 GB, free: 243.3 MB / 0.7449 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.01332/1.273, allocations: 11.33 MB / 1.071 GB, free: 239 MB / 0.7449 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.02199/1.295, allocations: 3.609 MB / 1.074 GB, free: 238.9 MB / 0.7449 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.007595/1.303, allocations: 3.195 MB / 1.077 GB, free: 238.6 MB / 0.7449 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.002533/1.305, allocations: 6.216 MB / 1.083 GB, free: 232.8 MB / 0.7449 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.005423/1.311, allocations: 1.073 MB / 1.084 GB, free: 232.6 MB / 0.7449 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0008642/1.311, allocations: 0.8108 MB / 1.085 GB, free: 232.5 MB / 0.7449 GB
Warning: Assuming fixed start value for the following 12 variables:
         desuperheater_1.wall.T_w_i:VARIABLE(min = 0.0 start = desuperheater_1.wall.T_w_i_start unit = \"K\" fixed = true protected = true )  \"Wall temperature at inner phase\" type: Real
         desuperheater_1.wall.T_w_a:VARIABLE(min = 0.0 start = desuperheater_1.wall.T_w_a_start unit = \"K\" fixed = true protected = true )  \"Wall temperature at outer phase\" type: Real
         desuperheater_1.tubes.h:VARIABLE(start = desuperheater_1.tubes.h_start unit = \"J/kg\" fixed = true nominal = 1000.0 protected = true )  \"spec. enthalpy state\" type: Real
         desuperheater_1.tubes.p:VARIABLE(min = 0.0 start = desuperheater_1.tubes.p_start unit = \"Pa\" fixed = true nominal = 1e5 stateSelect=StateSelect.prefer )  \"System pressure\" type: Real
         desuperheater_1.shell.h:VARIABLE(start = desuperheater_1.shell.h_start unit = \"J/kg\" fixed = true nominal = 1000.0 protected = true )  \"spec. enthalpy state\" type: Real
         desuperheater_1.shell.p:VARIABLE(min = 0.0 start = desuperheater_1.shell.p_start unit = \"Pa\" fixed = true nominal = 1e5 stateSelect=StateSelect.prefer )  \"System pressure\" type: Real
         desuperheater_2.tubes.h:VARIABLE(start = desuperheater_2.tubes.h_start unit = \"J/kg\" fixed = true nominal = 1000.0 protected = true )  \"spec. enthalpy state\" type: Real
         desuperheater_2.tubes.p:VARIABLE(min = 0.0 start = desuperheater_2.tubes.p_start unit = \"Pa\" fixed = true nominal = 1e5 stateSelect=StateSelect.prefer )  \"System pressure\" type: Real
         desuperheater_2.shell.h:VARIABLE(start = desuperheater_2.shell.h_start unit = \"J/kg\" fixed = true nominal = 1000.0 protected = true )  \"spec. enthalpy state\" type: Real
         desuperheater_2.shell.p:VARIABLE(min = 0.0 start = desuperheater_2.shell.p_start unit = \"Pa\" fixed = true nominal = 1e5 stateSelect=StateSelect.prefer )  \"System pressure\" type: Real
         desuperheater_2.wall.T_w_i:VARIABLE(min = 0.0 start = desuperheater_2.wall.T_w_i_start unit = \"K\" fixed = true protected = true )  \"Wall temperature at inner phase\" type: Real
         desuperheater_2.wall.T_w_a:VARIABLE(min = 0.0 start = desuperheater_2.wall.T_w_a_start unit = \"K\" fixed = true protected = true )  \"Wall temperature at outer phase\" type: Real
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 422
 * Number of states: 0 ()
 * Number of discrete variables: 209 (sampler[1].firstTrigger,$PRE.sampler[1].firstTrigger,sampler[2].firstTrigger,$PRE.sampler[2].firstTrigger,sampler[3].firstTrigger,$PRE.sampler[3].firstTrigger,sampler[4].firstTrigger,$PRE.sampler[4].firstTrigger,sampler[5].firstTrigger,$PRE.sampler[5].firstTrigger,sampler[6].firstTrigger,$PRE.sampler[6].firstTrigger,sampler[7].firstTrigger,$PRE.sampler[7].firstTrigger,sampler[8].firstTrigger,$PRE.sampler[8].firstTrigger,sampler[9].firstTrigger,$PRE.sampler[9].firstTrigger,sampler[10].firstTrigger,$PRE.sampler[10].firstTrigger,sampler[11].firstTrigger,$PRE.sampler[11].firstTrigger,sampler[12].firstTrigger,$PRE.sampler[12].firstTrigger,sampler[13].firstTrigger,$PRE.sampler[13].firstTrigger,sampler[14].firstTrigger,$PRE.sampler[14].firstTrigger,sampler[15].firstTrigger,$PRE.sampler[15].firstTrigger,sampler[16].firstTrigger,$PRE.sampler[16].firstTrigger,sampler[17].firstTrigger,$PRE.sampler[17].firstTrigger,sampler[18].firstTrigger,$PRE.sampler[18].firstTrigger,sampler[19].firstTrigger,$PRE.sampler[19].firstTrigger,sampler[20].firstTrigger,$PRE.sampler[20].firstTrigger,sampler[21].firstTrigger,$PRE.sampler[21].firstTrigger,sampler[22].firstTrigger,$PRE.sampler[22].firstTrigger,sampler[23].firstTrigger,$PRE.sampler[23].firstTrigger,sampler[24].firstTrigger,$PRE.sampler[24].firstTrigger,sampler[25].firstTrigger,$PRE.sampler[25].firstTrigger,sampler[26].firstTrigger,$PRE.sampler[26].firstTrigger,sampler[27].firstTrigger,$PRE.sampler[27].firstTrigger,sampler[28].firstTrigger,$PRE.sampler[28].firstTrigger,sampler[29].firstTrigger,$PRE.sampler[29].firstTrigger,sampler[30].firstTrigger,$PRE.sampler[30].firstTrigger,sampler[31].firstTrigger,$PRE.sampler[31].firstTrigger,sampler[32].firstTrigger,$PRE.sampler[32].firstTrigger,sampler[33].firstTrigger,$PRE.sampler[33].firstTrigger,sampler[34].firstTrigger,$PRE.sampler[34].firstTrigger,$PRE.MeasurementData.nextTimeEvent,$whenCondition35,sampler[34].sampleTrigger,$whenCondition1,sampler[33].sampleTrigger,$whenCondition2,sampler[32].sampleTrigger,$whenCondition3,sampler[31].sampleTrigger,$whenCondition4,sampler[30].sampleTrigger,$whenCondition5,sampler[29].sampleTrigger,$whenCondition6,sampler[28].sampleTrigger,$whenCondition7,sampler[27].sampleTrigger,$whenCondition8,sampler[26].sampleTrigger,$whenCondition9,sampler[25].sampleTrigger,$whenCondition10,sampler[24].sampleTrigger,$whenCondition11,sampler[23].sampleTrigger,$whenCondition12,sampler[22].sampleTrigger,$whenCondition13,sampler[21].sampleTrigger,$whenCondition14,sampler[20].sampleTrigger,$whenCondition15,sampler[19].sampleTrigger,$whenCondition16,sampler[18].sampleTrigger,$whenCondition17,sampler[17].sampleTrigger,$whenCondition18,sampler[16].sampleTrigger,$whenCondition19,sampler[15].sampleTrigger,$whenCondition20,sampler[14].sampleTrigger,$whenCondition21,sampler[13].sampleTrigger,$whenCondition22,sampler[12].sampleTrigger,$whenCondition23,sampler[11].sampleTrigger,$whenCondition24,sampler[10].sampleTrigger,$whenCondition25,sampler[9].sampleTrigger,$whenCondition26,sampler[8].sampleTrigger,$whenCondition27,sampler[7].sampleTrigger,$whenCondition28,sampler[6].sampleTrigger,$whenCondition29,sampler[5].sampleTrigger,$whenCondition30,sampler[4].sampleTrigger,$whenCondition31,sampler[3].sampleTrigger,$whenCondition32,sampler[2].sampleTrigger,$whenCondition33,sampler[1].sampleTrigger,$whenCondition34,sampler[34].y,$PRE.sampler[34].y,sampler[33].y,$PRE.sampler[33].y,sampler[32].y,$PRE.sampler[32].y,sampler[31].y,$PRE.sampler[31].y,sampler[30].y,$PRE.sampler[30].y,sampler[29].y,$PRE.sampler[29].y,sampler[28].y,$PRE.sampler[28].y,sampler[27].y,$PRE.sampler[27].y,sampler[26].y,$PRE.sampler[26].y,sampler[25].y,$PRE.sampler[25].y,sampler[24].y,$PRE.sampler[24].y,sampler[23].y,$PRE.sampler[23].y,sampler[22].y,$PRE.sampler[22].y,sampler[21].y,$PRE.sampler[21].y,sampler[20].y,$PRE.sampler[20].y,sampler[19].y,$PRE.sampler[19].y,sampler[18].y,$PRE.sampler[18].y,sampler[17].y,$PRE.sampler[17].y,sampler[16].y,$PRE.sampler[16].y,sampler[15].y,$PRE.sampler[15].y,sampler[14].y,$PRE.sampler[14].y,sampler[13].y,$PRE.sampler[13].y,sampler[12].y,$PRE.sampler[12].y,sampler[11].y,$PRE.sampler[11].y,sampler[10].y,$PRE.sampler[10].y,sampler[9].y,$PRE.sampler[9].y,sampler[8].y,$PRE.sampler[8].y,sampler[7].y,$PRE.sampler[7].y,sampler[6].y,$PRE.sampler[6].y,sampler[5].y,$PRE.sampler[5].y,sampler[4].y,$PRE.sampler[4].y,sampler[3].y,$PRE.sampler[3].y,sampler[2].y,$PRE.sampler[2].y,sampler[1].y,$PRE.sampler[1].y,MeasurementData.nextTimeEventScaled,$PRE.MeasurementData.nextTimeEventScaled,MeasurementData.nextTimeEvent)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (1759):
 * Single equations (assignments): 1754
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 5
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 4 systems
   {(1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 1 system
   {(1,6)}
Notification: Performance of prepare postOptimizeDAE: time 0.002453/1.314, allocations: 1.138 MB / 1.086 GB, free: 231.7 MB / 0.7449 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.001793/1.316, allocations: 1.084 MB / 1.087 GB, free: 231.1 MB / 0.7449 GB
Warning: After manipulating the system with postOptModule wrapFunctionCalls the system is unbalanced. This indicates that the original system is singular. You can use -d=dumpCSE and -d=dumpCSE_verbose for more information.
Error: Too many equations, over-determined system. The model has 2089 equation(s) and 2005 variable(s).
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/TILMedia main/VLEFluid/MixtureCompatible/VLEFluid_ph.mo:55:3-60:21:writable] Error: (massFlowSource1.fluidOut.q, massFlowSource1.fluidOut.cp, massFlowSource1.fluidOut.cv, massFlowSource1.fluidOut.beta, massFlowSource1.fluidOut.kappa, massFlowSource1.fluidOut.drhodp_hxi, massFlowSource1.fluidOut.drhodh_pxi, _, massFlowSource1.fluidOut.w, massFlowSource1.fluidOut.gamma) = ($cse123, $cse124, $cse125, $cse126, $cse127, $cse128, $cse129, $cse130, $cse131, $cse132) has size 9 but 2 variables ($cse89, MeasurementData.y[1])
Error: Internal error Transformation Module PFPlusExt index Reduction Method Pantelides failed!
Notification: Performance of <failed> postOpt wrapFunctionCalls (simulation): time 0.01552/1.331, allocations: 17.14 MB / 1.104 GB, free: 221.8 MB / 0.7449 GB
Error: post-optimization module wrapFunctionCalls (simulation) failed.
"
[Timeout remaining time 799]
[Calling sys.exit(0), Time elapsed: 3.8976004011929035]
Failed to read output from testmodel.py, exit status != 0:
1.4558743592351675 1.4630124119999999 1.1954256669999999
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7aeccbc09b20>