Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ThermofluidStream_dev_ThermofluidStream.Examples.EspressoMachine.conf.json
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.001554/0.001554, allocations: 78.09 kB / 19.76 MB, free: 2.031 MB / 14.72 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.001626/0.001626, allocations: 161 kB / 23.01 MB, free: 4.945 MB / 14.72 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 1.394/1.394, allocations: 177.2 MB / 203.4 MB, free: 8.961 MB / 190.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermofluidStream main/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermofluidStream main/package.mo): time 0.7713/0.7713, allocations: 79.61 MB / 339.4 MB, free: 10.96 MB / 318.1 MB
"
[Timeout remaining time 179]
Using package ThermofluidStream with version 1.2.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermofluidStream 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)
Running command: translateModel(ThermofluidStream.Examples.EspressoMachine,tolerance=1e-06,outputFormat="mat",numberOfIntervals=1000,variableFilter="PI.x|PID1.I.y|PID2.I.y|PID3.I.y|Tasse.sink.inlet.m_flow|Tasse.x|Tasse1.x|Time|boiler.phaseSeparator2_1.M|boiler.phaseSeparator2_1.U_med|brewing_head.T|conductionElement1.h|espressoValve.T_start|espressoValve.count|firstOrder1.y|firstOrder2.y|firstOrder3.y|firstOrder7.y|hex.M|hex.U_med|hex.m_flow_in|hex.m_flow_out|pump.m_flow|pump1.m_flow|steamSink1.x|steam_valve.T_start|steam_valve.count|steam_valve1.T_start|steam_valve1.count|tanValve1.inlet.m_flow|tanValve6.inlet.m_flow|waterSink.x",fileNamePrefix="ThermofluidStream_dev_ThermofluidStream.Examples.EspressoMachine")
translateModel(ThermofluidStream.Examples.EspressoMachine,tolerance=1e-06,outputFormat="mat",numberOfIntervals=1000,variableFilter="PI.x|PID1.I.y|PID2.I.y|PID3.I.y|Tasse.sink.inlet.m_flow|Tasse.x|Tasse1.x|Time|boiler.phaseSeparator2_1.M|boiler.phaseSeparator2_1.U_med|brewing_head.T|conductionElement1.h|espressoValve.T_start|espressoValve.count|firstOrder1.y|firstOrder2.y|firstOrder3.y|firstOrder7.y|hex.M|hex.U_med|hex.m_flow_in|hex.m_flow_out|pump.m_flow|pump1.m_flow|steamSink1.x|steam_valve.T_start|steam_valve.count|steam_valve1.T_start|steam_valve1.count|tanValve1.inlet.m_flow|tanValve6.inlet.m_flow|waterSink.x",fileNamePrefix="ThermofluidStream_dev_ThermofluidStream.Examples.EspressoMachine") [Timeout 660]
"Notification: ThermofluidStream 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: ThermofluidStream requested package Complex of version 4.0.0. Complex 4.1.0 is used instead which states that it is fully compatible without conversion script needed.
Notification: Performance of FrontEnd - loaded program: time 0.002476/0.002476, allocations: 87.53 kB / 0.4924 GB, free: 25.98 MB / 446.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1511/0.1536, allocations: 74.59 MB / 0.5652 GB, free: 5.957 MB / 478.1 MB
Notification: Performance of NFInst.instantiate(ThermofluidStream.Examples.EspressoMachine): time 0.5952/0.7488, allocations: 245.1 MB / 0.8046 GB, free: 13.78 MB / 0.6231 GB
Notification: Performance of NFInst.instExpressions: time 0.1107/0.8595, allocations: 89.37 MB / 0.8918 GB, free: 7.062 MB / 0.7012 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.006434/0.8659, allocations: 194.4 kB / 0.892 GB, free: 6.871 MB / 0.7012 GB
Notification: Performance of NFTyping.typeComponents: time 0.01076/0.8767, allocations: 2.914 MB / 0.8949 GB, free: 3.938 MB / 0.7012 GB
Notification: Performance of NFTyping.typeBindings: time 0.02583/0.9025, allocations: 8.07 MB / 0.9028 GB, free: 11.84 MB / 0.7169 GB
Notification: Performance of NFTyping.typeClassSections: time 0.02455/0.9271, allocations: 7.319 MB / 0.9099 GB, free: 4.512 MB / 0.7169 GB
Notification: Performance of NFFlatten.flatten: time 0.01413/0.9412, allocations: 7.498 MB / 0.9172 GB, free: 12.98 MB / 0.7325 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.002996/0.9442, allocations: 1.288 MB / 0.9185 GB, free: 11.62 MB / 0.7325 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.02216/0.9663, allocations: 9.59 MB / 0.9279 GB, free: 1.918 MB / 0.7325 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.005586/0.9719, allocations: 2.783 MB / 0.9306 GB, free: 15.12 MB / 0.7481 GB
Notification: Performance of NFPackage.collectConstants: time 0.002219/0.9741, allocations: 0.5312 MB / 0.9311 GB, free: 14.59 MB / 0.7481 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.02583/1, allocations: 10.91 MB / 0.9417 GB, free: 3.668 MB / 0.7481 GB
Notification: Performance of NFScalarize.scalarize: time 0.002399/1.002, allocations: 1.222 MB / 0.9429 GB, free: 2.441 MB / 0.7481 GB
Notification: Performance of NFVerifyModel.verify: time 0.005109/1.007, allocations: 2.446 MB / 0.9453 GB, free: 15.98 MB / 0.7637 GB
Notification: Performance of NFConvertDAE.convert: time 0.0331/1.041, allocations: 13.42 MB / 0.9584 GB, free: 2.527 MB / 0.7637 GB
Notification: Performance of FrontEnd - DAE generated: time 6.542e-06/1.041, allocations: 0 / 0.9584 GB, free: 2.527 MB / 0.7637 GB
Notification: Performance of FrontEnd: time 1.463e-06/1.041, allocations: 0 / 0.9584 GB, free: 2.527 MB / 0.7637 GB
Notification: Performance of Transformations before backend: time 0.0002889/1.041, allocations: 0 / 0.9584 GB, free: 2.527 MB / 0.7637 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 1157
 * Number of variables: 1157
Notification: Performance of Generate backend data structure: time 0.01981/1.061, allocations: 7.562 MB / 0.9658 GB, free: 10.86 MB / 0.7794 GB
Notification: Performance of prepare preOptimizeDAE: time 4.086e-05/1.061, allocations: 9.469 kB / 0.9658 GB, free: 10.85 MB / 0.7794 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.00649/1.067, allocations: 1.202 MB / 0.967 GB, free: 9.641 MB / 0.7794 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.007055/1.074, allocations: 2.898 MB / 0.9698 GB, free: 6.668 MB / 0.7794 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0004434/1.075, allocations: 459.8 kB / 0.9703 GB, free: 6.191 MB / 0.7794 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.000989/1.076, allocations: 475.8 kB / 0.9707 GB, free: 5.727 MB / 0.7794 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.01217/1.088, allocations: 5.742 MB / 0.9763 GB, free: 15.68 MB / 0.795 GB
Notification: Performance of preOpt findStateOrder (simulation): time 8.454e-05/1.088, allocations: 7.875 kB / 0.9763 GB, free: 15.68 MB / 0.795 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0003907/1.088, allocations: 188 kB / 0.9765 GB, free: 15.49 MB / 0.795 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001627/1.089, allocations: 156.7 kB / 0.9767 GB, free: 15.34 MB / 0.795 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.01039/1.099, allocations: 4.242 MB / 0.9808 GB, free: 11.08 MB / 0.795 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.02598/1.125, allocations: 14.16 MB / 0.9946 GB, free: 12.68 MB / 0.8106 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.007414/1.132, allocations: 3.083 MB / 0.9976 GB, free: 9.594 MB / 0.8106 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.002846/1.135, allocations: 1.445 MB / 0.9991 GB, free: 8.137 MB / 0.8106 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.3264/1.462, allocations: 11.16 MB / 1.01 GB, free: 332.5 MB / 0.8106 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.005771/1.467, allocations: 2.451 MB / 1.012 GB, free: 331.9 MB / 0.8106 GB
Notification: Performance of pre-optimization done (n=314): time 5.892e-06/1.467, allocations: 3.25 kB / 1.012 GB, free: 331.9 MB / 0.8106 GB
Notification: Performance of matching and sorting (n=318): time 0.02535/1.493, allocations: 10.06 MB / 1.022 GB, free: 328.7 MB / 0.8106 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001081/1.493, allocations: 322.8 kB / 1.022 GB, free: 328.4 MB / 0.8106 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.003387/1.496, allocations: 2.521 MB / 1.025 GB, free: 327.4 MB / 0.8106 GB
Notification: Performance of collectPreVariables (initialization): time 0.0003531/1.497, allocations: 92.48 kB / 1.025 GB, free: 327.4 MB / 0.8106 GB
Notification: Performance of collectInitialEqns (initialization): time 0.001313/1.498, allocations: 2.149 MB / 1.027 GB, free: 325.9 MB / 0.8106 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0007328/1.499, allocations: 1.13 MB / 1.028 GB, free: 325.2 MB / 0.8106 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0007355/1.499, allocations: 0.5987 MB / 1.029 GB, free: 324.9 MB / 0.8106 GB
Notification: Performance of setup shared object (initialization): time 4.122e-05/1.499, allocations: 301.1 kB / 1.029 GB, free: 324.6 MB / 0.8106 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.002186/1.502, allocations: 1.265 MB / 1.03 GB, free: 324.1 MB / 0.8106 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.002468/1.504, allocations: 2.122 MB / 1.032 GB, free: 322.6 MB / 0.8106 GB
Warning: It was not possible to determine if the initialization problem is consistent, because of not evaluable parameters/start values during compile time: conductionElement1.deltaE_system = $START.conductionElement1.deltaE_system (0.0 = $START.conductionElement1.deltaE_system)
Notification: Performance of analyzeInitialSystem (initialization): time 0.004773/1.509, allocations: 3.079 MB / 1.035 GB, free: 320.8 MB / 0.8106 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.181e-05/1.509, allocations: 7 kB / 1.035 GB, free: 320.8 MB / 0.8106 GB
Notification: Performance of matching and sorting (n=409) (initialization): time 0.007345/1.516, allocations: 4.181 MB / 1.04 GB, free: 318.9 MB / 0.8106 GB
Notification: Performance of prepare postOptimizeDAE: time 6.098e-05/1.516, allocations: 98.91 kB / 1.04 GB, free: 318.8 MB / 0.8106 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.005814/1.522, allocations: 3.472 MB / 1.043 GB, free: 317.3 MB / 0.8106 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001691/1.524, allocations: 0.5794 MB / 1.044 GB, free: 317.2 MB / 0.8106 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002664/1.526, allocations: 0.7492 MB / 1.044 GB, free: 316.7 MB / 0.8106 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.008391/1.535, allocations: 10.5 MB / 1.055 GB, free: 306.2 MB / 0.8106 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.003019/1.538, allocations: 155.3 kB / 1.055 GB, free: 306.1 MB / 0.8106 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0004238/1.538, allocations: 142.5 kB / 1.055 GB, free: 306 MB / 0.8106 GB
Warning: The initial conditions are over specified. The following 1 initial equations are redundant, so they are removed from the initialization system:
         conductionElement1.deltaE_system = $START.conductionElement1.deltaE_system.
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.003838/1.542, allocations: 1.823 MB / 1.057 GB, free: 304.3 MB / 0.8106 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.002343/1.544, allocations: 2.079 MB / 1.059 GB, free: 301.9 MB / 0.8106 GB
Warning: It was not possible to determine if the initialization problem is consistent, because of not evaluable parameters/start values during compile time: conductionElement1.deltaE_system = $START.conductionElement1.deltaE_system (0.0 = $START.conductionElement1.deltaE_system)
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.004652/1.549, allocations: 3.016 MB / 1.062 GB, free: 298.7 MB / 0.8106 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 1.434e-05/1.549, allocations: 7.938 kB / 1.062 GB, free: 298.7 MB / 0.8106 GB
Notification: Performance of matching and sorting (n=409) (initialization_lambda0): time 0.00744/1.556, allocations: 4.107 MB / 1.066 GB, free: 294.6 MB / 0.8106 GB
Notification: Performance of prepare postOptimizeDAE: time 5.382e-05/1.557, allocations: 101.1 kB / 1.066 GB, free: 294.4 MB / 0.8106 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.005665/1.562, allocations: 3.399 MB / 1.069 GB, free: 291 MB / 0.8106 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001677/1.564, allocations: 0.5812 MB / 1.07 GB, free: 290.4 MB / 0.8106 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.00233/1.566, allocations: 0.651 MB / 1.07 GB, free: 289.7 MB / 0.8106 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.007623/1.574, allocations: 9.056 MB / 1.079 GB, free: 280.3 MB / 0.8106 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002806/1.577, allocations: 153.7 kB / 1.079 GB, free: 280.1 MB / 0.8106 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.000404/1.577, allocations: 140.8 kB / 1.079 GB, free: 280 MB / 0.8106 GB
Warning: The initial conditions are over specified. The following 1 initial equations are redundant, so they are removed from the initialization_lambda0 system:
         conductionElement1.deltaE_system = $START.conductionElement1.deltaE_system.
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 57
 * Number of states: 0 ()
 * Number of discrete variables: 40 (coffeeStrainer.coffeeStrainer.outlet.state.phase,pump1.outlet.state.phase,tanValve6.outlet.state.phase,tanValve1.outlet.state.phase,conductionElement1.outlet.state.phase,tanValve2.outlet.state.phase,boiler.phaseSeparator2_1.state_out[2].phase,boiler.phaseSeparator2_1.state_out[1].phase,steam_valve1.count,$PRE.steam_valve1.count,steam_valve1.T_start,$PRE.steam_valve1.T_start,espressoValve.count,$PRE.espressoValve.count,espressoValve.T_start,$PRE.espressoValve.T_start,hex.medium.phase,steam_valve.count,$PRE.steam_valve.count,steam_valve.T_start,$PRE.steam_valve.T_start,boiler.phaseSeparator2_1.medium.phase,$whenCondition1,$whenCondition2,$whenCondition3,junctionT2_1.junctionN.outlet.state.phase,flowResistance4.outlet.state.phase,Tasse1.flowResistance.outlet.state.phase,flowResistance5.outlet.state.phase,PID3.I.local_reset,PID2.I.local_reset,PID1.I.local_reset,pump.outlet.state.phase,conductionElement1.state.phase,Tasse.flowResistance.outlet.state.phase,flowResistance2.outlet.state.phase,source1.outlet.state.phase,flowResistance1.outlet.state.phase,tanValve.outlet.state.phase,flowResistance.outlet.state.phase)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (358):
 * Single equations (assignments): 349
 * Array equations: 0
 * Algorithm blocks: 3
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 1
 * Torn equation systems: 5
 * Mixed (continuous/discrete) equation systems: 0
Notification: Equation system details (not torn):
 * Constant Jacobian (size): 0 systems
 * Linear Jacobian (size,density): 0 systems
 * Non-linear Jacobian (size): 1 system
   {1}
 * Without analytic Jacobian (size): 0 systems
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 4 systems
   {(1,7,100.0%), (6,29,58.3%), (1,3,100.0%), (1,3,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 1 system
   {(1,1)}
Notification: Performance of prepare postOptimizeDAE: time 0.0008554/1.578, allocations: 393.8 kB / 1.08 GB, free: 279.6 MB / 0.8106 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.001009/1.579, allocations: 385.9 kB / 1.08 GB, free: 279.2 MB / 0.8106 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01189/1.591, allocations: 9.33 MB / 1.089 GB, free: 269.9 MB / 0.8106 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 6.058e-05/1.591, allocations: 111.8 kB / 1.089 GB, free: 269.8 MB / 0.8106 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 2.721e-05/1.591, allocations: 11.94 kB / 1.089 GB, free: 269.8 MB / 0.8106 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 3.639e-05/1.591, allocations: 15.94 kB / 1.089 GB, free: 269.8 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 postOpt removeSimpleEquations (simulation): time 0.01677/1.608, allocations: 13.06 MB / 1.102 GB, free: 256.8 MB / 0.8106 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 0.008527/1.616, allocations: 7.518 MB / 1.109 GB, free: 249.2 MB / 0.8106 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.002034/1.618, allocations: 0.4993 MB / 1.11 GB, free: 248.7 MB / 0.8106 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.002615/1.621, allocations: 1.427 MB / 1.111 GB, free: 247.3 MB / 0.8106 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0002984/1.621, allocations: 95.92 kB / 1.111 GB, free: 247.2 MB / 0.8106 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.01022/1.631, allocations: 12.22 MB / 1.123 GB, free: 234.4 MB / 0.8106 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.224e-06/1.631, allocations: 0 / 1.123 GB, free: 234.4 MB / 0.8106 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.01257/1.644, allocations: 9.025 MB / 1.132 GB, free: 225.3 MB / 0.8106 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.00178/1.646, allocations: 0.7865 MB / 1.133 GB, free: 224.6 MB / 0.8106 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0007628/1.646, allocations: 89.95 kB / 1.133 GB, free: 224.5 MB / 0.8106 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.002255/1.649, allocations: 151.8 kB / 1.133 GB, free: 224.3 MB / 0.8106 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.000473/1.649, allocations: 289.5 kB / 1.133 GB, free: 224.1 MB / 0.8106 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0002152/1.649, allocations: 115.9 kB / 1.134 GB, free: 223.9 MB / 0.8106 GB
Notification: Performance of sorting global known variables: time 0.002307/1.652, allocations: 1.659 MB / 1.135 GB, free: 222.3 MB / 0.8106 GB
Notification: Performance of sort global known variables: time 7e-08/1.652, allocations: 0 / 1.135 GB, free: 222.3 MB / 0.8106 GB
Notification: Performance of remove unused functions: time 0.008252/1.66, allocations: 3.14 MB / 1.138 GB, free: 219.3 MB / 0.8106 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 6
 * Number of states: 25 (boiler.phaseSeparator2_1.M,boiler.phaseSeparator2_1.U_med,steamSink1.inlet.m_flow,steamSink1.x,firstOrder1.y,hex.M,hex.U_med,flowResistance2.inlet.m_flow,Tasse.x,coffeeStrainer.coffeeStrainer.inlet.m_flow,firstOrder2.y,brewing_head.T,conductionElement1.h,pump.m_flow,PI.x,pump1.m_flow,PID1.I.y,PID2.I.y,firstOrder3.y,PID3.I.y,waterSink.inlet.m_flow,waterSink.x,firstOrder7.y,Tasse1.x,Tasse1.flowResistance.inlet.m_flow)
 * Number of discrete variables: 57 ($cse1.region3boundary,$cse2.region3boundary,$cse3.phase,$cse3.region,$cse7.phase,$cse7.region,$cse8.phase,$cse8.region,$cse9.phase,$cse9.region,$cse12.phase,$cse12.region,$cse15.phase,$cse15.region,$cse17.phase,$cse17.region,$cse18.region3boundary,$cse19.region3boundary,$cse20.phase,$cse20.region,$cse22.phase,$cse22.region,$cse23.phase,$cse23.region,$cse24.phase,$cse24.region,$cse27.phase,$cse27.region,$cse28.phase,$cse28.region,$cse29.phase,$cse29.region,$cse31.phase,$cse31.region,$cse33.phase,$cse33.region,$cse36.phase,$cse36.region,$cse38.phase,$cse38.region,$cse39.phase,$cse39.region,$cse40.phase,$cse40.region,$cse41.region3boundary,$cse43.region3boundary,$whenCondition3,$whenCondition2,$whenCondition1,boiler.phaseSeparator2_1.medium.phase,steam_valve.T_start,steam_valve.count,hex.medium.phase,espressoValve.T_start,espressoValve.count,steam_valve1.T_start,steam_valve1.count)
 * Number of discrete states: 3 (steam_valve.count,espressoValve.count,steam_valve1.count)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (295):
 * Single equations (assignments): 261
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 21
 * When equations: 6
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 7
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 4 systems
   {(6,29,58.3%), (1,3,100.0%), (1,3,100.0%), (1,7,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 3 systems
   {(1,5), (1,5), (1,8)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.006307/1.666, allocations: 2.395 MB / 1.141 GB, free: 217.4 MB / 0.8106 GB
Notification: Performance of simCode: created initialization part: time 0.01344/1.68, allocations: 7.375 MB / 1.148 GB, free: 209.7 MB / 0.8106 GB
Notification: Performance of simCode: created event and clocks part: time 9.798e-06/1.68, allocations: 0 / 1.148 GB, free: 209.7 MB / 0.8106 GB
Notification: Performance of simCode: created simulation system equations: time 0.00523/1.685, allocations: 3.248 MB / 1.151 GB, free: 206.4 MB / 0.8106 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.006768/1.692, allocations: 1.341 MB / 1.152 GB, free: 205.1 MB / 0.8106 GB
[/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/Compiler/SimCode/SimCodeUtil.mo:10545:11-10545:220:writable] Error: Internal error Unexpected expression (should have been handled earlier, probably in the front-end. Unit/displayUnit expression is not a string literal: ThermofluidStream.Sensors.Internal.getFlowUnit(singleFlowSensor5.quantity)
[/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/Compiler/SimCode/SimCodeUtil.mo:10545:11-10545:220:writable] Error: Internal error Unexpected expression (should have been handled earlier, probably in the front-end. Unit/displayUnit expression is not a string literal: ThermofluidStream.Sensors.Internal.getTwoPhaseUnit(sensorVaporQuality2.quantity)
[/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/Compiler/SimCode/SimCodeUtil.mo:10545:11-10545:220:writable] Error: Internal error Unexpected expression (should have been handled earlier, probably in the front-end. Unit/displayUnit expression is not a string literal: ThermofluidStream.Sensors.Internal.getTwoPhaseUnit(sensorVaporQuality1.quantity)
[/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/Compiler/SimCode/SimCodeUtil.mo:10545:11-10545:220:writable] Error: Internal error Unexpected expression (should have been handled earlier, probably in the front-end. Unit/displayUnit expression is not a string literal: ThermofluidStream.Sensors.Internal.getTwoPhaseUnit(sensorVaporQuality.quantity)
[/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/Compiler/SimCode/SimCodeUtil.mo:10545:11-10545:220:writable] Error: Internal error Unexpected expression (should have been handled earlier, probably in the front-end. Unit/displayUnit expression is not a string literal: ThermofluidStream.Sensors.Internal.getFlowUnit(singleFlowSensor3.quantity)
[/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/Compiler/SimCode/SimCodeUtil.mo:10545:11-10545:220:writable] Error: Internal error Unexpected expression (should have been handled earlier, probably in the front-end. Unit/displayUnit expression is not a string literal: ThermofluidStream.Sensors.Internal.getFlowUnit(singleFlowSensor2.quantity)
[/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/Compiler/SimCode/SimCodeUtil.mo:10545:11-10545:220:writable] Error: Internal error Unexpected expression (should have been handled earlier, probably in the front-end. Unit/displayUnit expression is not a string literal: ThermofluidStream.Sensors.Internal.getFlowUnit(singleFlowSensor1.quantity)
[/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/Compiler/SimCode/SimCodeUtil.mo:10545:11-10545:220:writable] Error: Internal error Unexpected expression (should have been handled earlier, probably in the front-end. Unit/displayUnit expression is not a string literal: ThermofluidStream.Sensors.Internal.getFlowUnit(singleFlowSensor.quantity)
[/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/Compiler/SimCode/SimCodeUtil.mo:10545:11-10545:220:writable] Error: Internal error Unexpected expression (should have been handled earlier, probably in the front-end. Unit/displayUnit expression is not a string literal: ThermofluidStream.Sensors.Internal.getFlowUnit(singleFlowSensor5.quantity)
[/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/Compiler/SimCode/SimCodeUtil.mo:10545:11-10545:220:writable] Error: Internal error Unexpected expression (should have been handled earlier, probably in the front-end. Unit/displayUnit expression is not a string literal: ThermofluidStream.Sensors.Internal.getTwoPhaseUnit(sensorVaporQuality2.quantity)
[/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/Compiler/SimCode/SimCodeUtil.mo:10545:11-10545:220:writable] Error: Internal error Unexpected expression (should have been handled earlier, probably in the front-end. Unit/displayUnit expression is not a string literal: ThermofluidStream.Sensors.Internal.getTwoPhaseUnit(sensorVaporQuality1.quantity)
[/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/Compiler/SimCode/SimCodeUtil.mo:10545:11-10545:220:writable] Error: Internal error Unexpected expression (should have been handled earlier, probably in the front-end. Unit/displayUnit expression is not a string literal: ThermofluidStream.Sensors.Internal.getTwoPhaseUnit(sensorVaporQuality.quantity)
[/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/Compiler/SimCode/SimCodeUtil.mo:10545:11-10545:220:writable] Error: Internal error Unexpected expression (should have been handled earlier, probably in the front-end. Unit/displayUnit expression is not a string literal: ThermofluidStream.Sensors.Internal.getFlowUnit(singleFlowSensor3.quantity)
[/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/Compiler/SimCode/SimCodeUtil.mo:10545:11-10545:220:writable] Error: Internal error Unexpected expression (should have been handled earlier, probably in the front-end. Unit/displayUnit expression is not a string literal: ThermofluidStream.Sensors.Internal.getFlowUnit(singleFlowSensor2.quantity)
[/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/Compiler/SimCode/SimCodeUtil.mo:10545:11-10545:220:writable] Error: Internal error Unexpected expression (should have been handled earlier, probably in the front-end. Unit/displayUnit expression is not a string literal: ThermofluidStream.Sensors.Internal.getFlowUnit(singleFlowSensor1.quantity)
[/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/Compiler/SimCode/SimCodeUtil.mo:10545:11-10545:220:writable] Error: Internal error Unexpected expression (should have been handled earlier, probably in the front-end. Unit/displayUnit expression is not a string literal: ThermofluidStream.Sensors.Internal.getFlowUnit(singleFlowSensor.quantity)
[/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/Compiler/SimCode/SimCodeUtil.mo:10545:11-10545:220:writable] Error: Internal error Unexpected expression (should have been handled earlier, probably in the front-end. Unit/displayUnit expression is not a string literal: ThermofluidStream.Sensors.Internal.getFlowUnit(singleFlowSensor1.quantity)
[/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/Compiler/SimCode/SimCodeUtil.mo:10545:11-10545:220:writable] Error: Internal error Unexpected expression (should have been handled earlier, probably in the front-end. Unit/displayUnit expression is not a string literal: ThermofluidStream.Sensors.Internal.getFlowUnit(singleFlowSensor5.quantity)
[/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/Compiler/SimCode/SimCodeUtil.mo:10545:11-10545:220:writable] Error: Internal error Unexpected expression (should have been handled earlier, probably in the front-end. Unit/displayUnit expression is not a string literal: ThermofluidStream.Sensors.Internal.getTwoPhaseUnit(sensorVaporQuality2.quantity)
[/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/Compiler/SimCode/SimCodeUtil.mo:10545:11-10545:220:writable] Error: Internal error Unexpected expression (should have been handled earlier, probably in the front-end. Unit/displayUnit expression is not a string literal: ThermofluidStream.Sensors.Internal.getTwoPhaseUnit(sensorVaporQuality1.quantity)
[/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/Compiler/SimCode/SimCodeUtil.mo:10545:11-10545:220:writable] Error: Internal error Unexpected expression (should have been handled earlier, probably in the front-end. Unit/displayUnit expression is not a string literal: ThermofluidStream.Sensors.Internal.getTwoPhaseUnit(sensorVaporQuality.quantity)
[/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/Compiler/SimCode/SimCodeUtil.mo:10545:11-10545:220:writable] Error: Internal error Unexpected expression (should have been handled earlier, probably in the front-end. Unit/displayUnit expression is not a string literal: ThermofluidStream.Sensors.Internal.getFlowUnit(singleFlowSensor3.quantity)
[/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/Compiler/SimCode/SimCodeUtil.mo:10545:11-10545:220:writable] Error: Internal error Unexpected expression (should have been handled earlier, probably in the front-end. Unit/displayUnit expression is not a string literal: ThermofluidStream.Sensors.Internal.getFlowUnit(singleFlowSensor2.quantity)
[/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/Compiler/SimCode/SimCodeUtil.mo:10545:11-10545:220:writable] Error: Internal error Unexpected expression (should have been handled earlier, probably in the front-end. Unit/displayUnit expression is not a string literal: ThermofluidStream.Sensors.Internal.getFlowUnit(singleFlowSensor.quantity)
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.01942/1.711, allocations: 11.64 MB / 1.164 GB, free: 193.5 MB / 0.8106 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001818/1.713, allocations: 2.43 MB / 1.166 GB, free: 191 MB / 0.8106 GB
Notification: Performance of simCode: alias equations: time 0.003936/1.717, allocations: 2.167 MB / 1.168 GB, free: 188.8 MB / 0.8106 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0007578/1.718, allocations: 300.4 kB / 1.168 GB, free: 188.6 MB / 0.8106 GB
Notification: Performance of SimCode: time 7.52e-07/1.718, allocations: 0 / 1.168 GB, free: 188.6 MB / 0.8106 GB
Notification: Performance of Templates: time 0.1338/1.851, allocations: 118.5 MB / 1.284 GB, free: 70.95 MB / 0.8106 GB
"
[Timeout remaining time 658]
make -j1 -f ThermofluidStream_dev_ThermofluidStream.Examples.EspressoMachine.makefile [Timeout 660]
(rm -f ThermofluidStream_dev_ThermofluidStream.Examples.EspressoMachine.pipe ; mkfifo ThermofluidStream_dev_ThermofluidStream.Examples.EspressoMachine.pipe ; head -c 1048576 < ThermofluidStream_dev_ThermofluidStream.Examples.EspressoMachine.pipe >> ../files/ThermofluidStream_dev_ThermofluidStream.Examples.EspressoMachine.sim & ./ThermofluidStream_dev_ThermofluidStream.Examples.EspressoMachine  -abortSlowSimulation -alarm=1200 -s ida -emit_protected -lv LOG_STATS > ThermofluidStream_dev_ThermofluidStream.Examples.EspressoMachine.pipe 2>&1) [Timeout 1200]
[Calling os._exit(0), Time elapsed: 49.920812509953976]
Failed to read output from testmodel.py, exit status != 0:
1.8602177889551967 1.869153991 0.825991742
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f9b8af0afe0>