Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ClaRa_dev_ClaRa.Components.FlueGasCleaning.Desulfurization.Check.Test_FlueGasCleaning.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.01887/0.01887, allocations: 1.766 MB / 21.43 MB, free: 236 kB / 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.002074/0.002074, allocations: 107.4 kB / 25 MB, free: 2.016 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.00251/0.00251, allocations: 209.3 kB / 28.73 MB, free: 3.254 MB / 19.63 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.219/1.219, allocations: 230.7 MB / 262.9 MB, free: 5.793 MB / 206.1 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.8787/0.8787, allocations: 130.7 MB / 450.5 MB, free: 6.387 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_FlueGasCleaning,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="Time|deNOx.bulk.h|deNOx.bulk.p|deNOx.bulk.xi.1.|deNOx.bulk.xi.2.|deNOx.bulk.xi.3.|deNOx.bulk.xi.4.|deNOx.bulk.xi.5.|deNOx.bulk.xi.6.|deNOx.bulk.xi.7.|deNOx.bulk.xi.8.|deNOx.bulk.xi.9.|deSO_ideal_L1_1.bulk.h|deSO_ideal_L1_1.bulk.p|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.|e_Filter_dynamic.bulk.h|e_Filter_dynamic.bulk.xi.1.|e_Filter_dynamic.bulk.xi.2.|e_Filter_dynamic.bulk.xi.3.|e_Filter_dynamic.bulk.xi.4.|e_Filter_dynamic.bulk.xi.5.|e_Filter_dynamic.bulk.xi.6.|e_Filter_dynamic.bulk.xi.7.|e_Filter_dynamic.bulk.xi.8.|e_Filter_dynamic.bulk.xi.9.|e_Filter_dynamic1.bulk.h|e_Filter_dynamic1.bulk.p|e_Filter_dynamic1.bulk.xi.1.|e_Filter_dynamic1.bulk.xi.2.|e_Filter_dynamic1.bulk.xi.3.|e_Filter_dynamic1.bulk.xi.4.|e_Filter_dynamic1.bulk.xi.5.|e_Filter_dynamic1.bulk.xi.6.|e_Filter_dynamic1.bulk.xi.7.|e_Filter_dynamic1.bulk.xi.8.|e_Filter_dynamic1.bulk.xi.9.|e_Filter_dynamic2.bulk.h|e_Filter_dynamic2.bulk.p|e_Filter_dynamic2.bulk.xi.1.|e_Filter_dynamic2.bulk.xi.2.|e_Filter_dynamic2.bulk.xi.3.|e_Filter_dynamic2.bulk.xi.4.|e_Filter_dynamic2.bulk.xi.5.|e_Filter_dynamic2.bulk.xi.6.|e_Filter_dynamic2.bulk.xi.7.|e_Filter_dynamic2.bulk.xi.8.|e_Filter_dynamic2.bulk.xi.9.|pipeFlowGas_L4_Simple.h.1.|pipeFlowGas_L4_Simple.h.2.|pipeFlowGas_L4_Simple.h.3.|pipeFlowGas_L4_Simple.p.1.|pipeFlowGas_L4_Simple.p.2.|pipeFlowGas_L4_Simple.p.3.|pipeFlowGas_L4_Simple.xi.1,1.|pipeFlowGas_L4_Simple.xi.1,2.|pipeFlowGas_L4_Simple.xi.1,3.|pipeFlowGas_L4_Simple.xi.1,4.|pipeFlowGas_L4_Simple.xi.1,5.|pipeFlowGas_L4_Simple.xi.1,6.|pipeFlowGas_L4_Simple.xi.1,7.|pipeFlowGas_L4_Simple.xi.1,8.|pipeFlowGas_L4_Simple.xi.1,9.|pipeFlowGas_L4_Simple.xi.2,1.|pipeFlowGas_L4_Simple.xi.2,2.|pipeFlowGas_L4_Simple.xi.2,3.|pipeFlowGas_L4_Simple.xi.2,4.|pipeFlowGas_L4_Simple.xi.2,5.|pipeFlowGas_L4_Simple.xi.2,6.|pipeFlowGas_L4_Simple.xi.2,7.|pipeFlowGas_L4_Simple.xi.2,8.|pipeFlowGas_L4_Simple.xi.2,9.|pipeFlowGas_L4_Simple.xi.3,1.|pipeFlowGas_L4_Simple.xi.3,2.|pipeFlowGas_L4_Simple.xi.3,3.|pipeFlowGas_L4_Simple.xi.3,4.|pipeFlowGas_L4_Simple.xi.3,5.|pipeFlowGas_L4_Simple.xi.3,6.|pipeFlowGas_L4_Simple.xi.3,7.|pipeFlowGas_L4_Simple.xi.3,8.|pipeFlowGas_L4_Simple.xi.3,9.",fileNamePrefix="ClaRa_dev_ClaRa.Components.FlueGasCleaning.Desulfurization.Check.Test_FlueGasCleaning")
translateModel(ClaRa.Components.FlueGasCleaning.Desulfurization.Check.Test_FlueGasCleaning,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="Time|deNOx.bulk.h|deNOx.bulk.p|deNOx.bulk.xi.1.|deNOx.bulk.xi.2.|deNOx.bulk.xi.3.|deNOx.bulk.xi.4.|deNOx.bulk.xi.5.|deNOx.bulk.xi.6.|deNOx.bulk.xi.7.|deNOx.bulk.xi.8.|deNOx.bulk.xi.9.|deSO_ideal_L1_1.bulk.h|deSO_ideal_L1_1.bulk.p|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.|e_Filter_dynamic.bulk.h|e_Filter_dynamic.bulk.xi.1.|e_Filter_dynamic.bulk.xi.2.|e_Filter_dynamic.bulk.xi.3.|e_Filter_dynamic.bulk.xi.4.|e_Filter_dynamic.bulk.xi.5.|e_Filter_dynamic.bulk.xi.6.|e_Filter_dynamic.bulk.xi.7.|e_Filter_dynamic.bulk.xi.8.|e_Filter_dynamic.bulk.xi.9.|e_Filter_dynamic1.bulk.h|e_Filter_dynamic1.bulk.p|e_Filter_dynamic1.bulk.xi.1.|e_Filter_dynamic1.bulk.xi.2.|e_Filter_dynamic1.bulk.xi.3.|e_Filter_dynamic1.bulk.xi.4.|e_Filter_dynamic1.bulk.xi.5.|e_Filter_dynamic1.bulk.xi.6.|e_Filter_dynamic1.bulk.xi.7.|e_Filter_dynamic1.bulk.xi.8.|e_Filter_dynamic1.bulk.xi.9.|e_Filter_dynamic2.bulk.h|e_Filter_dynamic2.bulk.p|e_Filter_dynamic2.bulk.xi.1.|e_Filter_dynamic2.bulk.xi.2.|e_Filter_dynamic2.bulk.xi.3.|e_Filter_dynamic2.bulk.xi.4.|e_Filter_dynamic2.bulk.xi.5.|e_Filter_dynamic2.bulk.xi.6.|e_Filter_dynamic2.bulk.xi.7.|e_Filter_dynamic2.bulk.xi.8.|e_Filter_dynamic2.bulk.xi.9.|pipeFlowGas_L4_Simple.h.1.|pipeFlowGas_L4_Simple.h.2.|pipeFlowGas_L4_Simple.h.3.|pipeFlowGas_L4_Simple.p.1.|pipeFlowGas_L4_Simple.p.2.|pipeFlowGas_L4_Simple.p.3.|pipeFlowGas_L4_Simple.xi.1,1.|pipeFlowGas_L4_Simple.xi.1,2.|pipeFlowGas_L4_Simple.xi.1,3.|pipeFlowGas_L4_Simple.xi.1,4.|pipeFlowGas_L4_Simple.xi.1,5.|pipeFlowGas_L4_Simple.xi.1,6.|pipeFlowGas_L4_Simple.xi.1,7.|pipeFlowGas_L4_Simple.xi.1,8.|pipeFlowGas_L4_Simple.xi.1,9.|pipeFlowGas_L4_Simple.xi.2,1.|pipeFlowGas_L4_Simple.xi.2,2.|pipeFlowGas_L4_Simple.xi.2,3.|pipeFlowGas_L4_Simple.xi.2,4.|pipeFlowGas_L4_Simple.xi.2,5.|pipeFlowGas_L4_Simple.xi.2,6.|pipeFlowGas_L4_Simple.xi.2,7.|pipeFlowGas_L4_Simple.xi.2,8.|pipeFlowGas_L4_Simple.xi.2,9.|pipeFlowGas_L4_Simple.xi.3,1.|pipeFlowGas_L4_Simple.xi.3,2.|pipeFlowGas_L4_Simple.xi.3,3.|pipeFlowGas_L4_Simple.xi.3,4.|pipeFlowGas_L4_Simple.xi.3,5.|pipeFlowGas_L4_Simple.xi.3,6.|pipeFlowGas_L4_Simple.xi.3,7.|pipeFlowGas_L4_Simple.xi.3,8.|pipeFlowGas_L4_Simple.xi.3,9.",fileNamePrefix="ClaRa_dev_ClaRa.Components.FlueGasCleaning.Desulfurization.Check.Test_FlueGasCleaning") [Timeout 800]
"Notification: Performance of FrontEnd - Absyn->SCode: time 1.495e-05/1.495e-05, allocations: 4.906 kB / 0.6167 GB, free: 8.793 MB / 446.1 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.FlueGasCleaning.Desulfurization.Check.Test_FlueGasCleaning): time 0.2009/0.201, allocations: 90.03 MB / 0.7046 GB, free: 15.15 MB / 0.5294 GB
Notification: Performance of NFInst.instExpressions: time 0.04875/0.2497, allocations: 34.24 MB / 0.7381 GB, free: 12.82 MB / 0.5607 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.005468/0.2552, allocations: 191.1 kB / 0.7382 GB, free: 12.63 MB / 0.5607 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.009741/0.2649, allocations: 4.724 MB / 0.7429 GB, free: 7.883 MB / 0.5607 GB
Notification: Performance of NFTyping.typeBindings: time 0.01428/0.2792, allocations: 6.809 MB / 0.7495 GB, free: 1.039 MB / 0.5607 GB
Notification: Performance of NFTyping.typeClassSections: time 0.2332/0.5124, allocations: 9.821 MB / 0.7591 GB, free: 34.21 MB / 0.5607 GB
Notification: Performance of NFFlatten.flatten: time 0.02194/0.5343, allocations: 26.24 MB / 0.7847 GB, free: 34.01 MB / 0.5607 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.00921/0.5435, allocations: 8.261 MB / 0.7928 GB, free: 31.21 MB / 0.5607 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.0131/0.5566, allocations: 11.74 MB / 0.8043 GB, free: 25 MB / 0.5607 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.01014/0.5668, allocations: 10.4 MB / 0.8144 GB, free: 15.47 MB / 0.5607 GB
Notification: Performance of NFPackage.collectConstants: time 0.00182/0.5686, allocations: 1.648 MB / 0.816 GB, free: 13.82 MB / 0.5607 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.09597/0.6645, allocations: 18.95 MB / 0.8345 GB, free: 13.79 MB / 0.5763 GB
Notification: Performance of combineBinaries: time 0.03274/0.6973, allocations: 32.88 MB / 0.8666 GB, free: 14.46 MB / 0.6075 GB
Notification: Performance of replaceArrayConstructors: time 0.01636/0.7137, allocations: 19.02 MB / 0.8852 GB, free: 12.3 MB / 0.6232 GB
Notification: Performance of NFVerifyModel.verify: time 0.003411/0.7171, allocations: 0.9375 MB / 0.8861 GB, free: 11.36 MB / 0.6232 GB
Notification: Performance of FrontEnd: time 0.00131/0.7184, allocations: 496.9 kB / 0.8866 GB, free: 10.99 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: 4794 (1966)
 * Number of variables: 4794 (2029)
Notification: Performance of [SIM] Bindings: time 0.09577/0.8141, allocations: 95.22 MB / 0.9796 GB, free: 15.59 MB / 0.7169 GB
Notification: Performance of [SIM] FunctionAlias: time 0.01766/0.8318, allocations: 14.23 MB / 0.9935 GB, free: 1.43 MB / 0.7169 GB
Notification: Performance of [SIM] Early Inline: time 0.3026/1.134, allocations: 51.84 MB / 1.044 GB, free: 129.9 MB / 0.7638 GB
Notification: Performance of [SIM] Simplify 1: time 0.01402/1.148, allocations: 7.56 MB / 1.051 GB, free: 128.4 MB / 0.7638 GB
Notification: Performance of [SIM] Alias: time 0.04246/1.191, allocations: 41.44 MB / 1.092 GB, free: 122.1 MB / 0.7638 GB
Notification: Performance of [SIM] Simplify 2: time 0.008752/1.2, allocations: 6.813 MB / 1.099 GB, free: 120.6 MB / 0.7638 GB
Notification: Performance of [SIM] Remove Stream: time 0.003769/1.203, allocations: 3.858 MB / 1.102 GB, free: 120.2 MB / 0.7638 GB
Notification: Performance of [SIM] Detect States: time 0.006801/1.21, allocations: 9.787 MB / 1.112 GB, free: 119.4 MB / 0.7638 GB
Notification: Performance of [SIM] Events: time 0.005265/1.216, allocations: 5.559 MB / 1.117 GB, free: 118.6 MB / 0.7638 GB
"
[Timeout remaining time 799]
[Calling sys.exit(0), Time elapsed: 4.380679600988515]
Failed to read output from testmodel.py, exit status != 0:
1.3211842809687369 1.330455723 0.6099783959999999
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f85bdf86dd0>