Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ClaRa_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.01157/0.01157, allocations: 1.759 MB / 21.42 MB, free: 392 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.001401/0.001401, allocations: 96.16 kB / 25 MB, free: 1.98 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.00169/0.00169, allocations: 204.2 kB / 28.72 MB, free: 3.266 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.308/1.308, 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 1.9.0/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ClaRa 1.9.0/package.mo): time 0.9354/0.9354, allocations: 130.7 MB / 450.5 MB, free: 6.383 MB / 350.1 MB
"
[Timeout remaining time 179]
Using package ClaRa with version 1.9.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ClaRa 1.9.0/package.mo)
Using package Modelica with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo)
Using package Complex with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo)
Using package ModelicaServices with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo)
Using package SMArtInt with version 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_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_ClaRa.Components.FlueGasCleaning.Desulfurization.Check.Test_FlueGasCleaning") [Timeout 800]
"Notification: Performance of FrontEnd - Absyn->SCode: time 3.611e-05/3.611e-05, allocations: 4.578 kB / 0.6167 GB, free: 8.73 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.2177/0.2177, allocations: 90.01 MB / 0.7046 GB, free: 15.11 MB / 0.5294 GB
Notification: Performance of NFInst.instExpressions: time 0.05544/0.2732, allocations: 34.25 MB / 0.7381 GB, free: 12.77 MB / 0.5607 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.007632/0.2808, allocations: 191.1 kB / 0.7383 GB, free: 12.58 MB / 0.5607 GB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/ClaRa 1.9.0/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.01171/0.2925, allocations: 4.726 MB / 0.7429 GB, free: 7.832 MB / 0.5607 GB
Notification: Performance of NFTyping.typeBindings: time 0.01761/0.3101, allocations: 6.798 MB / 0.7495 GB, free: 1 MB / 0.5607 GB
Notification: Performance of NFTyping.typeClassSections: time 0.2797/0.5898, allocations: 9.82 MB / 0.7591 GB, free: 33.62 MB / 0.5607 GB
Notification: Performance of NFFlatten.flatten: time 0.0261/0.6159, allocations: 26.24 MB / 0.7847 GB, free: 33.41 MB / 0.5607 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.01226/0.6282, allocations: 8.268 MB / 0.7928 GB, free: 30.95 MB / 0.5607 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.01713/0.6453, allocations: 11.74 MB / 0.8043 GB, free: 24.7 MB / 0.5607 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.0127/0.658, allocations: 10.4 MB / 0.8144 GB, free: 15.16 MB / 0.5607 GB
Notification: Performance of NFPackage.collectConstants: time 0.004601/0.6626, allocations: 1.645 MB / 0.816 GB, free: 13.52 MB / 0.5607 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.1026/0.7652, allocations: 18.95 MB / 0.8345 GB, free: 13.5 MB / 0.5763 GB
Notification: Performance of combineBinaries: time 0.03713/0.8024, allocations: 32.88 MB / 0.8666 GB, free: 14.16 MB / 0.6075 GB
Notification: Performance of replaceArrayConstructors: time 0.01814/0.8205, allocations: 19.01 MB / 0.8852 GB, free: 12.01 MB / 0.6232 GB
Notification: Performance of NFVerifyModel.verify: time 0.005098/0.8256, allocations: 0.9375 MB / 0.8861 GB, free: 11.07 MB / 0.6232 GB
Notification: Performance of FrontEnd: time 0.001498/0.8271, allocations: 498 kB / 0.8866 GB, free: 10.71 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.116/0.9431, allocations: 95.23 MB / 0.9796 GB, free: 15.35 MB / 0.7169 GB
Notification: Performance of [SIM] FunctionAlias: time 0.02169/0.9648, allocations: 14.23 MB / 0.9935 GB, free: 1.184 MB / 0.7169 GB
Notification: Performance of [SIM] Early Inline: time 0.3757/1.341, allocations: 51.85 MB / 1.044 GB, free: 129.4 MB / 0.7638 GB
Notification: Performance of [SIM] Simplify 1: time 0.01808/1.359, allocations: 7.554 MB / 1.052 GB, free: 127.9 MB / 0.7638 GB
Notification: Performance of [SIM] Alias: time 0.05532/1.414, allocations: 41.44 MB / 1.092 GB, free: 121.6 MB / 0.7638 GB
Notification: Performance of [SIM] Simplify 2: time 0.01127/1.425, allocations: 6.826 MB / 1.099 GB, free: 120.1 MB / 0.7638 GB
Notification: Performance of [SIM] Remove Stream: time 0.0053/1.431, allocations: 3.847 MB / 1.102 GB, free: 119.7 MB / 0.7638 GB
Notification: Performance of [SIM] Detect States: time 0.01016/1.441, allocations: 9.788 MB / 1.112 GB, free: 119 MB / 0.7638 GB
Notification: Performance of [SIM] Events: time 0.006293/1.447, allocations: 5.567 MB / 1.117 GB, free: 118.1 MB / 0.7638 GB
"
[Timeout remaining time 798]
[Calling sys.exit(0), Time elapsed: 4.878351310035214]
Failed to read output from testmodel.py, exit status != 0:
1.602110804989934 1.61047176 0.781082266
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7fcd46f2add0>