Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ClaRa_dev_ClaRa.Components.FlueGasCleaning.Desulfurization.Check.Test_Desulfurization_ideal.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.01281/0.01281, allocations: 1.771 MB / 18.83 MB, free: 4.332 MB / 14.72 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.001339/0.001339, allocations: 99.7 kB / 22.07 MB, free: 1.09 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.001855/0.001855, allocations: 211.7 kB / 25.45 MB, free: 2.797 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.464/1.464, allocations: 230.6 MB / 259.2 MB, free: 13.12 MB / 206.1 MB
"
[Timeout remaining time 178]
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 1.09/1.09, allocations: 130.5 MB / 446.3 MB, free: 14.54 MB / 350.1 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.3.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/SMArtInt main/package.mo)
Running command: translateModel(ClaRa.Components.FlueGasCleaning.Desulfurization.Check.Test_Desulfurization_ideal,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="Time|deSO_ideal_L1_1.bulk.h|deSO_ideal_L1_1.bulk.xi.1.|deSO_ideal_L1_1.bulk.xi.2.|deSO_ideal_L1_1.bulk.xi.3.|deSO_ideal_L1_1.bulk.xi.4.|deSO_ideal_L1_1.bulk.xi.5.|deSO_ideal_L1_1.bulk.xi.6.|deSO_ideal_L1_1.bulk.xi.7.|deSO_ideal_L1_1.bulk.xi.8.|deSO_ideal_L1_1.bulk.xi.9.|deSO_ideal_L1_1.chemicalReactions.h_aux|deSO_ideal_L1_1.chemicalReactions.m_flow_aux|deSO_ideal_L1_1.chemicalReactions.xi_aux.1.|deSO_ideal_L1_1.chemicalReactions.xi_aux.2.|deSO_ideal_L1_1.chemicalReactions.xi_aux.3.|deSO_ideal_L1_1.chemicalReactions.xi_aux.4.|deSO_ideal_L1_1.chemicalReactions.xi_aux.5.|deSO_ideal_L1_1.chemicalReactions.xi_aux.6.|deSO_ideal_L1_1.chemicalReactions.xi_aux.7.|deSO_ideal_L1_1.chemicalReactions.xi_aux.8.|deSO_ideal_L1_1.chemicalReactions.xi_aux.9.",fileNamePrefix="ClaRa_dev_ClaRa.Components.FlueGasCleaning.Desulfurization.Check.Test_Desulfurization_ideal")
translateModel(ClaRa.Components.FlueGasCleaning.Desulfurization.Check.Test_Desulfurization_ideal,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="Time|deSO_ideal_L1_1.bulk.h|deSO_ideal_L1_1.bulk.xi.1.|deSO_ideal_L1_1.bulk.xi.2.|deSO_ideal_L1_1.bulk.xi.3.|deSO_ideal_L1_1.bulk.xi.4.|deSO_ideal_L1_1.bulk.xi.5.|deSO_ideal_L1_1.bulk.xi.6.|deSO_ideal_L1_1.bulk.xi.7.|deSO_ideal_L1_1.bulk.xi.8.|deSO_ideal_L1_1.bulk.xi.9.|deSO_ideal_L1_1.chemicalReactions.h_aux|deSO_ideal_L1_1.chemicalReactions.m_flow_aux|deSO_ideal_L1_1.chemicalReactions.xi_aux.1.|deSO_ideal_L1_1.chemicalReactions.xi_aux.2.|deSO_ideal_L1_1.chemicalReactions.xi_aux.3.|deSO_ideal_L1_1.chemicalReactions.xi_aux.4.|deSO_ideal_L1_1.chemicalReactions.xi_aux.5.|deSO_ideal_L1_1.chemicalReactions.xi_aux.6.|deSO_ideal_L1_1.chemicalReactions.xi_aux.7.|deSO_ideal_L1_1.chemicalReactions.xi_aux.8.|deSO_ideal_L1_1.chemicalReactions.xi_aux.9.",fileNamePrefix="ClaRa_dev_ClaRa.Components.FlueGasCleaning.Desulfurization.Check.Test_Desulfurization_ideal") [Timeout 800]
"Notification: SMArtInt 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: ClaRa 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 uses annotation from ClaRa.
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.
Warning: Requested package SMArtInt of version 0.5.1, but this package was already loaded with version 0.3.1. There are no conversion annotations for this version but 0.5.1 is newer than 0.3.1. There is a possibility that 0.3.1 remains backwards compatible, but it is not loaded so OpenModelica cannot verify this.
Notification: Performance of FrontEnd - loaded program: time 0.3834/0.3834, allocations: 46.14 MB / 0.6556 GB, free: 30.52 MB / 0.4982 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.177/0.5605, allocations: 89.06 MB / 0.7426 GB, free: 2.391 MB / 0.545 GB
Notification: Performance of NFInst.instantiate(ClaRa.Components.FlueGasCleaning.Desulfurization.Check.Test_Desulfurization_ideal): time 0.01292/0.5734, allocations: 10.27 MB / 0.7526 GB, free: 8.078 MB / 0.5607 GB
Notification: Performance of NFInst.instExpressions: time 0.03001/0.6034, allocations: 21.09 MB / 0.7732 GB, free: 2.926 MB / 0.5763 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001429/0.6048, allocations: 31.88 kB / 0.7732 GB, free: 2.895 MB / 0.5763 GB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/ClaRa main/Basics/Interfaces/CycleSumModel.mo:3:3-3:52: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.00307/0.6079, allocations: 1.221 MB / 0.7744 GB, free: 1.668 MB / 0.5763 GB
Notification: Performance of NFTyping.typeBindings: time 0.00258/0.6105, allocations: 1.076 MB / 0.7755 GB, free: 0.5859 MB / 0.5763 GB
Notification: Performance of NFTyping.typeClassSections: time 0.007764/0.6183, allocations: 3.047 MB / 0.7785 GB, free: 13.53 MB / 0.5919 GB
Notification: Performance of NFFlatten.flatten: time 0.004903/0.6232, allocations: 3.415 MB / 0.7818 GB, free: 10.11 MB / 0.5919 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.003212/0.6264, allocations: 2.489 MB / 0.7842 GB, free: 7.555 MB / 0.5919 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.002828/0.6292, allocations: 1.823 MB / 0.786 GB, free: 5.727 MB / 0.5919 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.004104/0.6333, allocations: 2.946 MB / 0.7889 GB, free: 2.773 MB / 0.5919 GB
Notification: Performance of NFPackage.collectConstants: time 0.001284/0.6346, allocations: 0.7266 MB / 0.7896 GB, free: 2.047 MB / 0.5919 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.009461/0.6441, allocations: 5.138 MB / 0.7946 GB, free: 12.9 MB / 0.6075 GB
Notification: Performance of NFScalarize.scalarize: time 0.003564/0.6476, allocations: 3.075 MB / 0.7976 GB, free: 9.82 MB / 0.6075 GB
Notification: Performance of NFVerifyModel.verify: time 0.004692/0.6523, allocations: 3.407 MB / 0.8009 GB, free: 6.398 MB / 0.6075 GB
Notification: Performance of NFConvertDAE.convert: time 0.02258/0.6749, allocations: 13.77 MB / 0.8144 GB, free: 8.582 MB / 0.6232 GB
Notification: Performance of FrontEnd - DAE generated: time 5.78e-06/0.6749, allocations: 0 / 0.8144 GB, free: 8.582 MB / 0.6232 GB
Notification: Performance of FrontEnd: time 4.549e-06/0.6749, allocations: 4 kB / 0.8144 GB, free: 8.578 MB / 0.6232 GB
Notification: Performance of Transformations before backend: time 0.0002405/0.6751, allocations: 0 / 0.8144 GB, free: 8.578 MB / 0.6232 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 629
 * Number of variables: 629
Notification: Performance of Generate backend data structure: time 0.02023/0.6954, allocations: 8.216 MB / 0.8224 GB, free: 276 kB / 0.6232 GB
Notification: Performance of prepare preOptimizeDAE: time 4.71e-05/0.6954, allocations: 16.02 kB / 0.8224 GB, free: 260 kB / 0.6232 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.00263/0.698, allocations: 0.6949 MB / 0.8231 GB, free: 15.55 MB / 0.6388 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.01733/0.7154, allocations: 8.787 MB / 0.8317 GB, free: 6.699 MB / 0.6388 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0002312/0.7156, allocations: 171 kB / 0.8319 GB, free: 6.527 MB / 0.6388 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0008347/0.7164, allocations: 187.9 kB / 0.832 GB, free: 6.344 MB / 0.6388 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.01731/0.7337, allocations: 8.654 MB / 0.8405 GB, free: 12.96 MB / 0.6544 GB
Notification: Performance of preOpt findStateOrder (simulation): time 4.383e-05/0.7338, allocations: 11.94 kB / 0.8405 GB, free: 12.95 MB / 0.6544 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0004636/0.7343, allocations: 115.9 kB / 0.8406 GB, free: 12.84 MB / 0.6544 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0003401/0.7346, allocations: 312.5 kB / 0.8409 GB, free: 12.53 MB / 0.6544 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.02759/0.7622, allocations: 16.9 MB / 0.8574 GB, free: 11.6 MB / 0.67 GB
Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.3887/1.151, allocations: 20.94 MB / 0.8779 GB, free: 103.5 MB / 0.67 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.01176/1.163, allocations: 6.002 MB / 0.8837 GB, free: 101.2 MB / 0.67 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.005612/1.168, allocations: 4.526 MB / 0.8881 GB, free: 99.37 MB / 0.67 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0007883/1.169, allocations: 349.1 kB / 0.8885 GB, free: 99.31 MB / 0.67 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 5.612e-05/1.169, allocations: 68.39 kB / 0.8885 GB, free: 99.25 MB / 0.67 GB
Notification: Performance of pre-optimization done (n=330): time 5.771e-06/1.169, allocations: 0.6562 kB / 0.8885 GB, free: 99.25 MB / 0.67 GB
Notification: Performance of matching and sorting (n=330): time 0.03309/1.202, allocations: 15.69 MB / 0.9039 GB, free: 93.82 MB / 0.67 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.000178/1.202, allocations: 450 kB / 0.9043 GB, free: 93.32 MB / 0.67 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0146/1.217, allocations: 4.947 MB / 0.9091 GB, free: 91.12 MB / 0.67 GB
Notification: Performance of collectPreVariables (initialization): time 0.001059/1.218, allocations: 83.39 kB / 0.9092 GB, free: 91.05 MB / 0.67 GB
Notification: Performance of collectInitialEqns (initialization): time 0.00245/1.22, allocations: 2.009 MB / 0.9112 GB, free: 89.55 MB / 0.67 GB
Notification: Performance of collectInitialBindings (initialization): time 0.001621/1.222, allocations: 1.165 MB / 0.9123 GB, free: 88.86 MB / 0.67 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.003001/1.225, allocations: 0.6924 MB / 0.913 GB, free: 88.5 MB / 0.67 GB
Notification: Performance of setup shared object (initialization): time 5.341e-05/1.225, allocations: 306.1 kB / 0.9133 GB, free: 88.2 MB / 0.67 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.005916/1.231, allocations: 4.435 MB / 0.9176 GB, free: 85.94 MB / 0.67 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.005924/1.237, allocations: 4.97 MB / 0.9225 GB, free: 83.11 MB / 0.67 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.0955/1.332, allocations: 38.3 MB / 0.9599 GB, free: 53.17 MB / 0.67 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.932e-05/1.332, allocations: 0 / 0.9599 GB, free: 53.17 MB / 0.67 GB
Notification: Performance of matching and sorting (n=398) (initialization): time 0.01632/1.349, allocations: 10.61 MB / 0.9702 GB, free: 42.59 MB / 0.67 GB
Notification: Performance of prepare postOptimizeDAE: time 3.427e-05/1.349, allocations: 10.41 kB / 0.9702 GB, free: 42.59 MB / 0.67 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.01273/1.362, allocations: 9.843 MB / 0.9798 GB, free: 32.72 MB / 0.67 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.002717/1.364, allocations: 0.8575 MB / 0.9807 GB, free: 31.86 MB / 0.67 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.007035/1.371, allocations: 0.9168 MB / 0.9816 GB, free: 30.98 MB / 0.67 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.002292/1.374, allocations: 1.656 MB / 0.9832 GB, free: 29.31 MB / 0.67 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.00357/1.377, allocations: 305.7 kB / 0.9835 GB, free: 29.08 MB / 0.67 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0007849/1.378, allocations: 196.9 kB / 0.9837 GB, free: 28.89 MB / 0.67 GB
Warning: Assuming fixed start value for the following 10 variables:
         deSO_ideal_L1_1.bulk.h:VARIABLE(start = deSO_ideal_L1_1.h_start unit = \"J/kg\" fixed = true nominal = 1000.0 stateSelect=StateSelect.prefer )  \"Specific enthalpy\" type: Real
         deSO_ideal_L1_1.bulk.xi[1]:VARIABLE(min = 0.0 max = 1.0 start = 9.910802775024783e-4 unit = \"1\" fixed = true nominal = 1.0 stateSelect=StateSelect.prefer )  \"Mass fraction\" type: Real [9]
         deSO_ideal_L1_1.bulk.xi[2]:VARIABLE(min = 0.0 max = 1.0 start = 9.910802775024783e-4 unit = \"1\" fixed = true nominal = 1.0 stateSelect=StateSelect.prefer )  \"Mass fraction\" type: Real [9]
         deSO_ideal_L1_1.bulk.xi[3]:VARIABLE(min = 0.0 max = 1.0 start = 9.910802775024783e-4 unit = \"1\" fixed = true nominal = 1.0 stateSelect=StateSelect.prefer )  \"Mass fraction\" type: Real [9]
         deSO_ideal_L1_1.bulk.xi[4]:VARIABLE(min = 0.0 max = 1.0 start = 9.910802775024783e-4 unit = \"1\" fixed = true nominal = 1.0 stateSelect=StateSelect.prefer )  \"Mass fraction\" type: Real [9]
         deSO_ideal_L1_1.bulk.xi[5]:VARIABLE(min = 0.0 max = 1.0 start = 0.9910802775024783 unit = \"1\" fixed = true nominal = 1.0 stateSelect=StateSelect.prefer )  \"Mass fraction\" type: Real [9]
         deSO_ideal_L1_1.bulk.xi[6]:VARIABLE(min = 0.0 max = 1.0 start = 9.910802775024783e-4 unit = \"1\" fixed = true nominal = 1.0 stateSelect=StateSelect.prefer )  \"Mass fraction\" type: Real [9]
         deSO_ideal_L1_1.bulk.xi[7]:VARIABLE(min = 0.0 max = 1.0 start = 9.910802775024783e-4 unit = \"1\" fixed = true nominal = 1.0 stateSelect=StateSelect.prefer )  \"Mass fraction\" type: Real [9]
         deSO_ideal_L1_1.bulk.xi[8]:VARIABLE(min = 0.0 max = 1.0 start = 9.910802775024783e-4 unit = \"1\" fixed = true nominal = 1.0 stateSelect=StateSelect.prefer )  \"Mass fraction\" type: Real [9]
         deSO_ideal_L1_1.bulk.xi[9]:VARIABLE(min = 0.0 max = 1.0 start = 9.910802775024783e-4 unit = \"1\" fixed = true nominal = 1.0 stateSelect=StateSelect.prefer )  \"Mass fraction\" type: Real [9]
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 42
 * 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 (368):
 * Single equations (assignments): 367
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 1
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 0 systems
 * Non-linear torn systems (#iteration vars, #inner vars): 1 system
   {(2,29)}
Notification: Performance of prepare postOptimizeDAE: time 0.003509/1.381, allocations: 1.666 MB / 0.9853 GB, free: 27.27 MB / 0.67 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.001856/1.383, allocations: 0.5433 MB / 0.9858 GB, free: 26.72 MB / 0.67 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01653/1.4, allocations: 11.19 MB / 0.9968 GB, free: 15.54 MB / 0.67 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 2.287e-05/1.4, allocations: 32 kB / 0.9968 GB, free: 15.51 MB / 0.67 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.451e-05/1.4, allocations: 0 / 0.9968 GB, free: 15.51 MB / 0.67 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 3.737e-05/1.4, allocations: 18.66 kB / 0.9968 GB, free: 15.49 MB / 0.67 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.02536/1.425, allocations: 17.87 MB / 1.014 GB, free: 13.64 MB / 0.6857 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 0.01442/1.44, allocations: 9.269 MB / 1.023 GB, free: 4.328 MB / 0.6857 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.007042/1.447, allocations: 0.804 MB / 1.024 GB, free: 3.551 MB / 0.6857 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.002766/1.45, allocations: 0.7565 MB / 1.025 GB, free: 2.801 MB / 0.6857 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0005615/1.45, allocations: 115.9 kB / 1.025 GB, free: 2.688 MB / 0.6857 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.001849/1.452, allocations: 1.356 MB / 1.026 GB, free: 1.305 MB / 0.6857 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 4.338e-06/1.452, allocations: 2.812 kB / 1.026 GB, free: 1.305 MB / 0.6857 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.02561/1.478, allocations: 15.97 MB / 1.042 GB, free: 1.254 MB / 0.7013 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.003789/1.481, allocations: 1.488 MB / 1.043 GB, free: 15.79 MB / 0.7169 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.001358/1.483, allocations: 76.86 kB / 1.043 GB, free: 15.71 MB / 0.7169 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.002788/1.485, allocations: 91.94 kB / 1.043 GB, free: 15.62 MB / 0.7169 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0006918/1.486, allocations: 214.2 kB / 1.044 GB, free: 15.41 MB / 0.7169 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.000475/1.487, allocations: 163.9 kB / 1.044 GB, free: 15.25 MB / 0.7169 GB
Notification: Performance of sorting global known variables: time 0.007731/1.494, allocations: 3.506 MB / 1.047 GB, free: 11.78 MB / 0.7169 GB
Notification: Performance of sort global known variables: time 1.1e-07/1.494, allocations: 0 / 1.047 GB, free: 11.78 MB / 0.7169 GB
Notification: Performance of remove unused functions: time 0.004678/1.499, allocations: 1.231 MB / 1.048 GB, free: 10.63 MB / 0.7169 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 4
 * Number of states: 21 (deSO_ideal_L1_1.chemicalReactions.xi_aux[1],deSO_ideal_L1_1.chemicalReactions.xi_aux[2],deSO_ideal_L1_1.chemicalReactions.xi_aux[3],deSO_ideal_L1_1.chemicalReactions.xi_aux[4],deSO_ideal_L1_1.chemicalReactions.xi_aux[5],deSO_ideal_L1_1.chemicalReactions.xi_aux[6],deSO_ideal_L1_1.chemicalReactions.xi_aux[7],deSO_ideal_L1_1.chemicalReactions.xi_aux[8],deSO_ideal_L1_1.chemicalReactions.xi_aux[9],deSO_ideal_L1_1.chemicalReactions.m_flow_aux,deSO_ideal_L1_1.chemicalReactions.h_aux,deSO_ideal_L1_1.bulk.h,deSO_ideal_L1_1.bulk.xi[1],deSO_ideal_L1_1.bulk.xi[2],deSO_ideal_L1_1.bulk.xi[3],deSO_ideal_L1_1.bulk.xi[4],deSO_ideal_L1_1.bulk.xi[5],deSO_ideal_L1_1.bulk.xi[6],deSO_ideal_L1_1.bulk.xi[7],deSO_ideal_L1_1.bulk.xi[8],deSO_ideal_L1_1.bulk.xi[9])
 * 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 (304):
 * Single equations (assignments): 302
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 1
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 1
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 0 systems
 * Non-linear torn systems (#iteration vars, #inner vars): 1 system
   {(1,22)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.003477/1.503, allocations: 1.07 MB / 1.05 GB, free: 10.03 MB / 0.7169 GB
Notification: Performance of simCode: created initialization part: time 0.01613/1.519, allocations: 9.991 MB / 1.059 GB, free: 72 kB / 0.7169 GB
Notification: Performance of simCode: created event and clocks part: time 6.331e-06/1.519, allocations: 4.062 kB / 1.059 GB, free: 68 kB / 0.7169 GB
Notification: Performance of simCode: created simulation system equations: time 0.007719/1.526, allocations: 5.023 MB / 1.064 GB, free: 11.1 MB / 0.7325 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.007325/1.534, allocations: 1.123 MB / 1.065 GB, free: 10.07 MB / 0.7325 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.02611/1.56, allocations: 14.14 MB / 1.079 GB, free: 11.99 MB / 0.7482 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.003649/1.563, allocations: 3.094 MB / 1.082 GB, free: 8.859 MB / 0.7482 GB
Notification: Performance of simCode: alias equations: time 0.004946/1.568, allocations: 1.599 MB / 1.084 GB, free: 7.27 MB / 0.7482 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.001502/1.57, allocations: 435.2 kB / 1.084 GB, free: 6.844 MB / 0.7482 GB
Notification: Performance of SimCode: time 8.31e-07/1.57, allocations: 0 / 1.084 GB, free: 6.844 MB / 0.7482 GB
Notification: Performance of Templates: time 0.1326/1.703, allocations: 73.87 MB / 1.156 GB, free: 13.64 MB / 0.8263 GB
"
[Timeout remaining time 798]
make -j1 -f ClaRa_dev_ClaRa.Components.FlueGasCleaning.Desulfurization.Check.Test_Desulfurization_ideal.makefile [Timeout 800]
(rm -f ClaRa_dev_ClaRa.Components.FlueGasCleaning.Desulfurization.Check.Test_Desulfurization_ideal.pipe ; mkfifo ClaRa_dev_ClaRa.Components.FlueGasCleaning.Desulfurization.Check.Test_Desulfurization_ideal.pipe ; head -c 1048576 < ClaRa_dev_ClaRa.Components.FlueGasCleaning.Desulfurization.Check.Test_Desulfurization_ideal.pipe >> ../files/ClaRa_dev_ClaRa.Components.FlueGasCleaning.Desulfurization.Check.Test_Desulfurization_ideal.sim & ./ClaRa_dev_ClaRa.Components.FlueGasCleaning.Desulfurization.Check.Test_Desulfurization_ideal  -abortSlowSimulation -alarm=800  -emit_protected -lv LOG_STATS > ClaRa_dev_ClaRa.Components.FlueGasCleaning.Desulfurization.Check.Test_Desulfurization_ideal.pipe 2>&1) [Timeout 800]
[Calling os._exit(0), Time elapsed: 9.613500314007979]
Failed to read output from testmodel.py, exit status != 0:
1.712134342000354 1.725680145 1.047758767
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7eff1575f3a0>