Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr HelmholtzMedia_HelmholtzMedia.Examples.Parameter.setSat_parameter.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.0014/0.0014, allocations: 104.3 kB / 19.77 MB, free: 2.051 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.00151/0.00151, allocations: 216.4 kB / 23.06 MB, free: 4.848 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.474/1.474, allocations: 230.7 MB / 256.9 MB, free: 7.77 MB / 206.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/HelmholtzMedia main/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/HelmholtzMedia main/package.mo): time 0.04999/0.04999, allocations: 9.135 MB / 322.4 MB, free: 10.19 MB / 254.1 MB
"
[Timeout remaining time 180]
Using package HelmholtzMedia with version 2.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/HelmholtzMedia 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(HelmholtzMedia.Examples.Parameter.setSat_parameter,tolerance=1e-07,outputFormat="empty",numberOfIntervals=2,variableFilter="",fileNamePrefix="HelmholtzMedia_HelmholtzMedia.Examples.Parameter.setSat_parameter")
translateModel(HelmholtzMedia.Examples.Parameter.setSat_parameter,tolerance=1e-07,outputFormat="empty",numberOfIntervals=2,variableFilter="",fileNamePrefix="HelmholtzMedia_HelmholtzMedia.Examples.Parameter.setSat_parameter") [Timeout 660]
"Notification: Performance of FrontEnd - Absyn->SCode: time 2.122e-05/2.122e-05, allocations: 2.281 kB / 447.8 MB, free: 112 kB / 302.1 MB
Notification: Performance of NFInst.instantiate(HelmholtzMedia.Examples.Parameter.setSat_parameter): time 0.02125/0.02127, allocations: 17.22 MB / 465 MB, free: 14.81 MB / 334.1 MB
Notification: Performance of NFInst.instExpressions: time 0.008132/0.0294, allocations: 6.578 MB / 471.6 MB, free: 8.211 MB / 334.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.000315/0.02972, allocations: 4 kB / 471.6 MB, free: 8.207 MB / 334.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.001243/0.03096, allocations: 379 kB / 472 MB, free: 7.836 MB / 334.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.0006858/0.03165, allocations: 270.5 kB / 472.3 MB, free: 7.57 MB / 334.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.01121/0.04285, allocations: 4.391 MB / 476.6 MB, free: 3.18 MB / 334.1 MB
Notification: Performance of NFFlatten.flatten: time 0.0005973/0.04345, allocations: 417.9 kB / 477.1 MB, free: 2.77 MB / 334.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 4.404e-05/0.04349, allocations: 0 / 477.1 MB, free: 2.77 MB / 334.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.0003101/0.0438, allocations: 171.2 kB / 477.2 MB, free: 2.602 MB / 334.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.0001264/0.04393, allocations: 83.55 kB / 477.3 MB, free: 2.52 MB / 334.1 MB
Notification: Performance of NFPackage.collectConstants: time 9.678e-06/0.04394, allocations: 3.938 kB / 477.3 MB, free: 2.516 MB / 334.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.008872/0.05281, allocations: 4.771 MB / 482.1 MB, free: 13.73 MB / 350.1 MB
Notification: Performance of combineBinaries: time 0.0004769/0.05329, allocations: 363.7 kB / 482.4 MB, free: 13.38 MB / 350.1 MB
Notification: Performance of replaceArrayConstructors: time 0.000196/0.05348, allocations: 284.3 kB / 482.7 MB, free: 13.09 MB / 350.1 MB
Notification: Performance of NFVerifyModel.verify: time 6.047e-05/0.05354, allocations: 24 kB / 482.7 MB, free: 13.07 MB / 350.1 MB
Notification: Performance of FrontEnd: time 1.391e-05/0.05356, allocations: 7.938 kB / 482.7 MB, free: 13.06 MB / 350.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 64 (4)
 * Number of variables: 64 (64)
Notification: Performance of [SIM] Bindings: time 0.001977/0.05554, allocations: 2.102 MB / 484.8 MB, free: 10.82 MB / 350.1 MB
Notification: Performance of [SIM] FunctionAlias: time 0.0004233/0.05596, allocations: 302.6 kB / 485.1 MB, free: 10.51 MB / 350.1 MB
Notification: Performance of [SIM] Early Inline: time 0.001099/0.05706, allocations: 1.13 MB / 486.3 MB, free: 9.352 MB / 350.1 MB
Notification: Performance of [SIM] Simplify 1: time 0.0002394/0.0573, allocations: 168.4 kB / 486.4 MB, free: 9.137 MB / 350.1 MB
Notification: Performance of [SIM] Alias: time 0.0004731/0.05777, allocations: 435.5 kB / 486.9 MB, free: 8.656 MB / 350.1 MB
Notification: Performance of [SIM] Simplify 2: time 0.0002327/0.058, allocations: 172.4 kB / 487 MB, free: 8.438 MB / 350.1 MB
Notification: Performance of [SIM] Remove Stream: time 0.0001324/0.05814, allocations: 124.2 kB / 487.2 MB, free: 8.289 MB / 350.1 MB
Notification: Performance of [SIM] Detect States: time 0.0002825/0.05842, allocations: 264.6 kB / 487.4 MB, free: 7.98 MB / 350.1 MB
Notification: Performance of [SIM] Events: time 5.844e-05/0.05848, allocations: 47.98 kB / 487.5 MB, free: 7.934 MB / 350.1 MB
Error: Internal error NBPartitioning.partitioningClocked (ODE) failed because the following variables could not be assigned to a partition:
  {[ALGB] (1) Real sat_dv.vap.s (start = 5e59, min = 0.52129, max = 1e60, nominal = 1000.0)
[ALGB] (1) Real sat_dv.vap.h (start = 6e5, min = -1e5, max = 1.3e6, nominal = 1e6)
[ALGB] (1) Real sat_dv.vap.u (min = -1e8, max = 1e8, nominal = 1e6)
[ALGB] (1) Real sat_dv.vap.d (start = 467.6, min = 2.2250738585072014e-308, max = 1638.9, nominal = 1.0)
[ALGB] (1) Real sat_dv.vap.p (start = 101325.0, min = 0.0, max = 8.01e8, nominal = 1e5)
[ALGB] (1) Real sat_dv.vap.T (start = 298.15, min = 216.592, max = 2000.0, nominal = 300.0)
[DISC] (1) Integer sat_dv.vap.phase (start = 0, min = 0, max = 2)
[ALGB] (1) Real sat_dv.liq.s (start = 5e59, min = 0.52129, max = 1e60, nominal = 1000.0)
[ALGB] (1) Real sat_dv.liq.h (start = 6e5, min = -1e5, max = 1.3e6, nominal = 1e6)
[ALGB] (1) Real sat_dv.liq.u (min = -1e8, max = 1e8, nominal = 1e6)
[ALGB] (1) Real sat_dv.liq.d (start = 467.6, min = 2.2250738585072014e-308, max = 1638.9, nominal = 1.0)
[ALGB] (1) Real sat_dv.liq.p (start = 101325.0, min = 0.0, max = 8.01e8, nominal = 1e5)
[ALGB] (1) Real sat_dv.liq.T (start = 298.15, min = 216.592, max = 2000.0, nominal = 300.0)
[DISC] (1) Integer sat_dv.liq.phase (start = 0, min = 0, max = 2)
[ALGB] (1) Real sat_dl.vap.s (start = 5e59, min = 0.52129, max = 1e60, nominal = 1000.0)
[ALGB] (1) Real sat_dl.vap.h (start = 6e5, min = -1e5, max = 1.3e6, nominal = 1e6)
[ALGB] (1) Real sat_dl.vap.u (min = -1e8, max = 1e8, nominal = 1e6)
[ALGB] (1) Real sat_dl.vap.d (start = 467.6, min = 2.2250738585072014e-308, max = 1638.9, nominal = 1.0)
[ALGB] (1) Real sat_dl.vap.p (start = 101325.0, min = 0.0, max = 8.01e8, nominal = 1e5)
[ALGB] (1) Real sat_dl.vap.T (start = 298.15, min = 216.592, max = 2000.0, nominal = 300.0)
[DISC] (1) Integer sat_dl.vap.phase (start = 0, min = 0, max = 2)
[ALGB] (1) Real sat_dl.liq.s (start = 5e59, min = 0.52129, max = 1e60, nominal = 1000.0)
[ALGB] (1) Real sat_dl.liq.h (start = 6e5, min = -1e5, max = 1.3e6, nominal = 1e6)
[ALGB] (1) Real sat_dl.liq.u (min = -1e8, max = 1e8, nominal = 1e6)
[ALGB] (1) Real sat_dl.liq.d (start = 467.6, min = 2.2250738585072014e-308, max = 1638.9, nominal = 1.0)
[ALGB] (1) Real sat_dl.liq.p (start = 101325.0, min = 0.0, max = 8.01e8, nominal = 1e5)
[ALGB] (1) Real sat_dl.liq.T (start = 298.15, min = 216.592, max = 2000.0, nominal = 300.0)
[DISC] (1) Integer sat_dl.liq.phase (start = 0, min = 0, max = 2)
[ALGB] (1) Real sat_p.vap.s (start = 5e59, min = 0.52129, max = 1e60, nominal = 1000.0)
[ALGB] (1) Real sat_p.vap.h (start = 6e5, min = -1e5, max = 1.3e6, nominal = 1e6)
[ALGB] (1) Real sat_p.vap.u (min = -1e8, max = 1e8, nominal = 1e6)
[ALGB] (1) Real sat_p.vap.d (start = 467.6, min = 2.2250738585072014e-308, max = 1638.9, nominal = 1.0)
[ALGB] (1) Real sat_p.vap.p (start = 101325.0, min = 0.0, max = 8.01e8, nominal = 1e5)
[ALGB] (1) Real sat_p.vap.T (start = 298.15, min = 216.592, max = 2000.0, nominal = 300.0)
[DISC] (1) Integer sat_p.vap.phase (start = 0, min = 0, max = 2)
[ALGB] (1) Real sat_p.liq.s (start = 5e59, min = 0.52129, max = 1e60, nominal = 1000.0)
[ALGB] (1) Real sat_p.liq.h (start = 6e5, min = -1e5, max = 1.3e6, nominal = 1e6)
[ALGB] (1) Real sat_p.liq.u (min = -1e8, max = 1e8, nominal = 1e6)
[ALGB] (1) Real sat_p.liq.d (start = 467.6, min = 2.2250738585072014e-308, max = 1638.9, nominal = 1.0)
[ALGB] (1) Real sat_p.liq.p (start = 101325.0, min = 0.0, max = 8.01e8, nominal = 1e5)
[ALGB] (1) Real sat_p.liq.T (start = 298.15, min = 216.592, max = 2000.0, nominal = 300.0)
[DISC] (1) Integer sat_p.liq.phase (start = 0, min = 0, max = 2)
[ALGB] (1) Real sat.vap.s (start = 5e59, min = 0.52129, max = 1e60, nominal = 1000.0)
[ALGB] (1) Real sat.vap.h (start = 6e5, min = -1e5, max = 1.3e6, nominal = 1e6)
[ALGB] (1) Real sat.vap.u (min = -1e8, max = 1e8, nominal = 1e6)
[ALGB] (1) Real sat.vap.p (start = 101325.0, min = 0.0, max = 8.01e8, nominal = 1e5)
[ALGB] (1) Real sat.vap.T (start = 298.15, min = 216.592, max = 2000.0, nominal = 300.0)
[DISC] (1) Integer sat.vap.phase (start = 0, min = 0, max = 2)
[ALGB] (1) Real sat.liq.s (start = 5e59, min = 0.52129, max = 1e60, nominal = 1000.0)
[ALGB] (1) Real sat.liq.h (start = 6e5, min = -1e5, max = 1.3e6, nominal = 1e6)
[ALGB] (1) Real sat.liq.u (min = -1e8, max = 1e8, nominal = 1e6)
[ALGB] (1) Real sat.liq.p (start = 101325.0, min = 0.0, max = 8.01e8, nominal = 1e5)
[ALGB] (1) Real sat.liq.T (start = 298.15, min = 216.592, max = 2000.0, nominal = 300.0)
[DISC] (1) Integer sat.liq.phase (start = 0, min = 0, max = 2)}
"
[Timeout remaining time 660]
[Calling sys.exit(0), Time elapsed: 2.554446871043183]
Failed to read output from testmodel.py, exit status != 0:
0.06604822399094701 0.08053439100000001 0.023803607
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f8704d16fb0>