Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Vessels.TestVolume.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo): time 0.001263/0.001263, allocations: 107.6 kB / 21.25 MB, free: 0.5625 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo): time 0.001577/0.001577, allocations: 222.3 kB / 24.56 MB, free: 3.816 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo): time 1.503/1.503, allocations: 230.5 MB / 258.2 MB, free: 7.73 MB / 206.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest trunk/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest trunk/package.mo): time 0.2363/0.2363, allocations: 46.94 MB / 361.6 MB, free: 3.867 MB / 286.1 MB
"
[Timeout remaining time 179]
Using package ModelicaTest with version trunk (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest trunk/package.mo)
Using package Modelica with version trunk (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo)
Using package Complex with version trunk (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo)
Using package ModelicaServices with version trunk (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo)
Running command: translateModel(ModelicaTest.Fluid.TestComponents.Vessels.TestVolume,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5003,variableFilter="time|Volume.ports.1..m_flow|Volume.ports.1..p|Volume.ports.1..h_outflow|Volume.ports.2..m_flow|Volume.ports.2..p|Volume.ports.2..h_outflow|Volume.portsData.1..diameter|Volume.portsData.1..height|Volume.portsData.1..zeta_out|Volume.portsData.1..zeta_in|Volume.portsData.2..diameter|Volume.portsData.2..height|Volume.portsData.2..zeta_out|Volume.portsData.2..zeta_in|Volume.ports_H_flow.1.|Volume.ports_H_flow.2.|Volume.ports_E_flow.1.|Volume.ports_E_flow.2.|Volume.ports_penetration.1.|Volume.ports_penetration.2.|Volume.portsData_diameter_internal.1.|Volume.portsData_diameter_internal.2.|Volume.portsData_height_internal.1.|Volume.portsData_height_internal.2.|Volume.portsData_zeta_in_internal.1.|Volume.portsData_zeta_in_internal.2.|Volume.portsData_zeta_out_internal.1.|Volume.portsData_zeta_out_internal.2.|Volume.portsData_diameter.1.|Volume.portsData_diameter.2.|Volume.portsData_height.1.|Volume.portsData_height.2.|Volume.portsData_zeta_in.1.|Volume.portsData_zeta_in.2.|Volume.portsData_zeta_out.1.|Volume.portsData_zeta_out.2.|FlowSource.ports.1..m_flow|FlowSource.ports.1..p|FlowSource.ports.1..h_outflow|Sink.ports.1..m_flow|Sink.ports.1..p|Sink.ports.1..h_outflow|Valve.port_b.m_flow|Valve.port_b.p|Valve.port_b.h_outflow|Step1.y",fileNamePrefix="ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Vessels.TestVolume")
translateModel(ModelicaTest.Fluid.TestComponents.Vessels.TestVolume,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5003,variableFilter="time|Volume.ports.1..m_flow|Volume.ports.1..p|Volume.ports.1..h_outflow|Volume.ports.2..m_flow|Volume.ports.2..p|Volume.ports.2..h_outflow|Volume.portsData.1..diameter|Volume.portsData.1..height|Volume.portsData.1..zeta_out|Volume.portsData.1..zeta_in|Volume.portsData.2..diameter|Volume.portsData.2..height|Volume.portsData.2..zeta_out|Volume.portsData.2..zeta_in|Volume.ports_H_flow.1.|Volume.ports_H_flow.2.|Volume.ports_E_flow.1.|Volume.ports_E_flow.2.|Volume.ports_penetration.1.|Volume.ports_penetration.2.|Volume.portsData_diameter_internal.1.|Volume.portsData_diameter_internal.2.|Volume.portsData_height_internal.1.|Volume.portsData_height_internal.2.|Volume.portsData_zeta_in_internal.1.|Volume.portsData_zeta_in_internal.2.|Volume.portsData_zeta_out_internal.1.|Volume.portsData_zeta_out_internal.2.|Volume.portsData_diameter.1.|Volume.portsData_diameter.2.|Volume.portsData_height.1.|Volume.portsData_height.2.|Volume.portsData_zeta_in.1.|Volume.portsData_zeta_in.2.|Volume.portsData_zeta_out.1.|Volume.portsData_zeta_out.2.|FlowSource.ports.1..m_flow|FlowSource.ports.1..p|FlowSource.ports.1..h_outflow|Sink.ports.1..m_flow|Sink.ports.1..p|Sink.ports.1..h_outflow|Valve.port_b.m_flow|Valve.port_b.p|Valve.port_b.h_outflow|Step1.y",fileNamePrefix="ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Vessels.TestVolume") [Timeout 660]
"Notification: Performance of FrontEnd - Absyn->SCode: time 2.412e-05/2.412e-05, allocations: 4.672 kB / 0.4974 GB, free: 7.043 MB / 366.1 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.Fluid.TestComponents.Vessels.TestVolume): time 0.3247/0.3247, allocations: 33.38 MB / 0.53 GB, free: 14.61 MB / 382.1 MB
Notification: Performance of NFInst.instExpressions: time 0.023/0.3477, allocations: 14.95 MB / 0.5446 GB, free: 7.363 MB / 382.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.000968/0.3487, allocations: 26.03 kB / 0.5446 GB, free: 7.348 MB / 382.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.001295/0.35, allocations: 386.6 kB / 0.545 GB, free: 7.152 MB / 382.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.01493/0.3649, allocations: 4.024 MB / 0.5489 GB, free: 5.434 MB / 382.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.01257/0.3775, allocations: 3.104 MB / 0.552 GB, free: 3.191 MB / 382.1 MB
Notification: Performance of NFFlatten.flatten: time 0.004925/0.3824, allocations: 2.295 MB / 0.5542 GB, free: 1.883 MB / 382.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.001215/0.3836, allocations: 0.5791 MB / 0.5548 GB, free: 1.461 MB / 382.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.002983/0.3866, allocations: 1.053 MB / 0.5558 GB, free: 0.8633 MB / 382.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.001682/0.3883, allocations: 0.6002 MB / 0.5564 GB, free: 0.5312 MB / 382.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.0001904/0.3885, allocations: 66.09 kB / 0.5565 GB, free: 0.5312 MB / 382.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.01813/0.4066, allocations: 6.63 MB / 0.5629 GB, free: 13.28 MB / 398.1 MB
Notification: Performance of combineBinaries: time 0.002101/0.4087, allocations: 1.603 MB / 0.5645 GB, free: 12.19 MB / 398.1 MB
Notification: Performance of replaceArrayConstructors: time 0.0008152/0.4095, allocations: 0.9657 MB / 0.5654 GB, free: 11.25 MB / 398.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.0001881/0.4097, allocations: 72 kB / 0.5655 GB, free: 11.18 MB / 398.1 MB
Notification: Performance of FrontEnd: time 0.0001783/0.4099, allocations: 27.86 kB / 0.5655 GB, free: 11.15 MB / 398.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 151 (123)
 * Number of variables: 151 (129)
Notification: Performance of [SIM] Bindings: time 0.005144/0.415, allocations: 4.597 MB / 0.57 GB, free: 6.371 MB / 398.1 MB
Notification: Performance of [SIM] FunctionAlias: time 0.0005305/0.4155, allocations: 447.3 kB / 0.5705 GB, free: 5.922 MB / 398.1 MB
Notification: Performance of [SIM] Early Inline: time 0.00492/0.4205, allocations: 4.194 MB / 0.5745 GB, free: 1.684 MB / 398.1 MB
Notification: Performance of [SIM] Simplify 1: time 0.001018/0.4215, allocations: 0.6039 MB / 0.5751 GB, free: 1.02 MB / 398.1 MB
Warning: NBAlias.setStartFixed: Alias set with conflicting unfixed start values detected. Use -d=dumprepl for more information.
Notification: Performance of [SIM] Alias: time 0.004245/0.4257, allocations: 2.764 MB / 0.5778 GB, free: 13.98 MB / 414.1 MB
Notification: Performance of [SIM] Simplify 2: time 0.0008695/0.4266, allocations: 0.5523 MB / 0.5784 GB, free: 13.39 MB / 414.1 MB
Notification: Performance of [SIM] Remove Stream: time 0.0003497/0.4269, allocations: 287.9 kB / 0.5787 GB, free: 13.08 MB / 414.1 MB
Notification: Performance of [SIM] Detect States: time 0.0007488/0.4277, allocations: 0.6687 MB / 0.5793 GB, free: 12.36 MB / 414.1 MB
Notification: Performance of [SIM] Events: time 0.0008187/0.4285, allocations: 0.5375 MB / 0.5798 GB, free: 11.81 MB / 414.1 MB
Notification: Performance of [SIM] Partitioning: time 0.00158/0.4301, allocations: 1.312 MB / 0.5811 GB, free: 10.41 MB / 414.1 MB
Notification: Performance of [SIM] Causalize: time 0.004136/0.4342, allocations: 2.815 MB / 0.5839 GB, free: 7.488 MB / 414.1 MB
Notification: Performance of [SIM] After Index Reduction Inline: time 0.003665/0.4379, allocations: 3.372 MB / 0.5872 GB, free: 4.113 MB / 414.1 MB
Notification: Performance of [INI] Simplify: time 0.003062/0.441, allocations: 1.542 MB / 0.5887 GB, free: 2.457 MB / 414.1 MB
Notification: Performance of [INI] Inline: time 0.004597/0.4456, allocations: 4.302 MB / 0.5929 GB, free: 14.14 MB / 430.1 MB
Notification: Performance of [INI] Partitioning: time 0.0001296/0.4457, allocations: 60.05 kB / 0.5929 GB, free: 14.07 MB / 430.1 MB
Notification: Performance of [INI] Cleanup: time 0.000627/0.4463, allocations: 0.5658 MB / 0.5935 GB, free: 13.5 MB / 430.1 MB
Notification: Performance of [INI] Causalize: time 0.00497/0.4513, allocations: 3.303 MB / 0.5967 GB, free: 10.15 MB / 430.1 MB
Notification: Performance of [INI] Tearing: time 0.002093/0.4534, allocations: 1.652 MB / 0.5983 GB, free: 8.539 MB / 430.1 MB
Notification: Performance of [SIM] Initialization: time 1.573e-06/0.4534, allocations: 0 / 0.5983 GB, free: 8.539 MB / 430.1 MB
Notification: Performance of [SIM] DAE-Mode: time 0.0009413/0.4543, allocations: 0.6161 MB / 0.5989 GB, free: 7.867 MB / 430.1 MB
Notification: Performance of [SIM] Remove Dummies: time 1.106e-05/0.4543, allocations: 8.938 kB / 0.5989 GB, free: 7.859 MB / 430.1 MB
"
[Timeout remaining time 660]
[Calling sys.exit(0), Time elapsed: 3.2576248760451563]
Failed to read output from testmodel.py, exit status != 0:
['time', 'Volume.ports[1].m_flow', 'Volume.ports[1].p', 'Volume.ports[1].h_outflow', 'Volume.ports[2].m_flow', 'Volume.ports[2].p', 'Volume.ports[2].h_outflow', 'Volume.portsData[1].diameter', 'Volume.portsData[1].height', 'Volume.portsData[1].zeta_out', 'Volume.portsData[1].zeta_in', 'Volume.portsData[2].diameter', 'Volume.portsData[2].height', 'Volume.portsData[2].zeta_out', 'Volume.portsData[2].zeta_in', 'Volume.ports_H_flow[1]', 'Volume.ports_H_flow[2]', 'Volume.ports_E_flow[1]', 'Volume.ports_E_flow[2]', 'Volume.ports_penetration[1]', 'Volume.ports_penetration[2]', 'Volume.portsData_diameter_internal[1]', 'Volume.portsData_diameter_internal[2]', 'Volume.portsData_height_internal[1]', 'Volume.portsData_height_internal[2]', 'Volume.portsData_zeta_in_internal[1]', 'Volume.portsData_zeta_in_internal[2]', 'Volume.portsData_zeta_out_internal[1]', 'Volume.portsData_zeta_out_internal[2]', 'Volume.portsData_diameter[1]', 'Volume.portsData_diameter[2]', 'Volume.portsData_height[1]', 'Volume.portsData_height[2]', 'Volume.portsData_zeta_in[1]', 'Volume.portsData_zeta_in[2]', 'Volume.portsData_zeta_out[1]', 'Volume.portsData_zeta_out[2]', 'FlowSource.ports[1].m_flow', 'FlowSource.ports[1].p', 'FlowSource.ports[1].h_outflow', 'Sink.ports[1].m_flow', 'Sink.ports[1].p', 'Sink.ports[1].h_outflow', 'Valve.port_b.m_flow', 'Valve.port_b.p', 'Valve.port_b.h_outflow', 'Step1.y']
0.46295722702052444 0.47716637100000003 0.064022277
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7ff8fb966fb0>