Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ModelicaTest_4.0.0_ModelicaTest.Fluid.TestComponents.Valves.TestValvesIncompressibleReverse.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.001601/0.001601, allocations: 99.61 kB / 21.25 MB, free: 0.5547 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.001738/0.001738, allocations: 207 kB / 24.55 MB, free: 3.828 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.42/1.42, allocations: 230.6 MB / 258.3 MB, free: 7.719 MB / 206.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 4.0.0+maint.om/package.mo): time 0.2166/0.2166, allocations: 44.94 MB / 359.7 MB, free: 6.078 MB / 286.1 MB
"
[Timeout remaining time 180]
Using package ModelicaTest with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 4.0.0+maint.om/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(ModelicaTest.Fluid.TestComponents.Valves.TestValvesIncompressibleReverse,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5003,variableFilter="time|SourceP1.ports.1..m_flow|SourceP1.ports.1..p|SourceP1.ports.1..h_outflow|SourceP1.ports.2..m_flow|SourceP1.ports.2..p|SourceP1.ports.2..h_outflow|SourceP2.ports.1..m_flow|SourceP2.ports.1..p|SourceP2.ports.1..h_outflow|SourceP2.ports.2..m_flow|SourceP2.ports.2..p|SourceP2.ports.2..h_outflow|SinkP1.ports.1..m_flow|SinkP1.ports.1..p|SinkP1.ports.1..h_outflow|V1.port_b.m_flow|V1.port_b.p|V1.port_b.h_outflow|V1.minLimiter.y|V2.port_b.m_flow|V2.port_b.p|V2.port_b.h_outflow|V2.minLimiter.y|V3.port_b.m_flow|V3.port_b.p|V3.port_b.h_outflow|V3.minLimiter.y|V4.port_b.m_flow|V4.port_b.p|V4.port_b.h_outflow|V4.minLimiter.y|V5.port_b.m_flow|V5.port_b.p|V5.port_b.h_outflow|V5.minLimiter.y|SinkP2.ports.1..m_flow|SinkP2.ports.1..p|SinkP2.ports.1..h_outflow|SinkP3.ports.1..m_flow|SinkP3.ports.1..p|SinkP3.ports.1..h_outflow|CloseLoad.y|OpenRelief.y|CloseValves.y",fileNamePrefix="ModelicaTest_4.0.0_ModelicaTest.Fluid.TestComponents.Valves.TestValvesIncompressibleReverse")
translateModel(ModelicaTest.Fluid.TestComponents.Valves.TestValvesIncompressibleReverse,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5003,variableFilter="time|SourceP1.ports.1..m_flow|SourceP1.ports.1..p|SourceP1.ports.1..h_outflow|SourceP1.ports.2..m_flow|SourceP1.ports.2..p|SourceP1.ports.2..h_outflow|SourceP2.ports.1..m_flow|SourceP2.ports.1..p|SourceP2.ports.1..h_outflow|SourceP2.ports.2..m_flow|SourceP2.ports.2..p|SourceP2.ports.2..h_outflow|SinkP1.ports.1..m_flow|SinkP1.ports.1..p|SinkP1.ports.1..h_outflow|V1.port_b.m_flow|V1.port_b.p|V1.port_b.h_outflow|V1.minLimiter.y|V2.port_b.m_flow|V2.port_b.p|V2.port_b.h_outflow|V2.minLimiter.y|V3.port_b.m_flow|V3.port_b.p|V3.port_b.h_outflow|V3.minLimiter.y|V4.port_b.m_flow|V4.port_b.p|V4.port_b.h_outflow|V4.minLimiter.y|V5.port_b.m_flow|V5.port_b.p|V5.port_b.h_outflow|V5.minLimiter.y|SinkP2.ports.1..m_flow|SinkP2.ports.1..p|SinkP2.ports.1..h_outflow|SinkP3.ports.1..m_flow|SinkP3.ports.1..p|SinkP3.ports.1..h_outflow|CloseLoad.y|OpenRelief.y|CloseValves.y",fileNamePrefix="ModelicaTest_4.0.0_ModelicaTest.Fluid.TestComponents.Valves.TestValvesIncompressibleReverse") [Timeout 660]
"Notification: Performance of FrontEnd - Absyn->SCode: time 1.912e-05/1.912e-05, allocations: 2.281 kB / 0.4943 GB, free: 10.02 MB / 366.1 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.Fluid.TestComponents.Valves.TestValvesIncompressibleReverse): time 0.2833/0.2834, allocations: 46.79 MB / 0.54 GB, free: 11.02 MB / 382.1 MB
Notification: Performance of NFInst.instExpressions: time 0.01181/0.2952, allocations: 7.001 MB / 0.5469 GB, free: 6.762 MB / 382.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001718/0.2969, allocations: 71.44 kB / 0.5469 GB, free: 6.711 MB / 382.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.001341/0.2982, allocations: 0.5116 MB / 0.5474 GB, free: 6.398 MB / 382.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.00763/0.3059, allocations: 3.237 MB / 0.5506 GB, free: 4.961 MB / 382.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.004944/0.3108, allocations: 2.206 MB / 0.5527 GB, free: 3.742 MB / 382.1 MB
Notification: Performance of NFFlatten.flatten: time 0.004245/0.315, allocations: 3.326 MB / 0.556 GB, free: 1.797 MB / 382.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.001936/0.317, allocations: 0.961 MB / 0.5569 GB, free: 1.102 MB / 382.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.008593/0.3256, allocations: 4.611 MB / 0.5614 GB, free: 14.82 MB / 398.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.004447/0.33, allocations: 2.614 MB / 0.564 GB, free: 13.52 MB / 398.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.0003623/0.3304, allocations: 108.8 kB / 0.5641 GB, free: 13.52 MB / 398.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.005935/0.3363, allocations: 2.857 MB / 0.5669 GB, free: 10.7 MB / 398.1 MB
Notification: Performance of combineBinaries: time 0.00355/0.3399, allocations: 2.896 MB / 0.5697 GB, free: 7.777 MB / 398.1 MB
Notification: Performance of replaceArrayConstructors: time 0.001898/0.3418, allocations: 1.755 MB / 0.5714 GB, free: 6.004 MB / 398.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.0006302/0.3424, allocations: 128 kB / 0.5715 GB, free: 5.879 MB / 398.1 MB
Notification: Performance of FrontEnd: time 0.000276/0.3427, allocations: 51.78 kB / 0.5716 GB, free: 5.828 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: 209 (195)
 * Number of variables: 209 (203)
Notification: Performance of [SIM] Bindings: time 0.008174/0.3508, allocations: 6.415 MB / 0.5779 GB, free: 15.21 MB / 414.1 MB
Notification: Performance of [SIM] FunctionAlias: time 0.001488/0.3523, allocations: 0.8695 MB / 0.5787 GB, free: 14.33 MB / 414.1 MB
Notification: Performance of [SIM] Early Inline: time 0.009189/0.3615, allocations: 6.605 MB / 0.5852 GB, free: 7.68 MB / 414.1 MB
Notification: Performance of [SIM] Simplify 1: time 0.001962/0.3635, allocations: 0.8328 MB / 0.586 GB, free: 6.789 MB / 414.1 MB
Notification: Performance of [SIM] Alias: time 0.006677/0.3702, allocations: 4.824 MB / 0.5907 GB, free: 1.508 MB / 414.1 MB
Notification: Performance of [SIM] Simplify 2: time 0.001309/0.3715, allocations: 0.8174 MB / 0.5915 GB, free: 0.6602 MB / 414.1 MB
Notification: Performance of [SIM] Remove Stream: time 0.0006308/0.3721, allocations: 0.5153 MB / 0.592 GB, free: 116 kB / 414.1 MB
Notification: Performance of [SIM] Detect States: time 0.001059/0.3732, allocations: 1.046 MB / 0.593 GB, free: 15.01 MB / 430.1 MB
Notification: Performance of [SIM] Events: time 0.00138/0.3745, allocations: 0.9753 MB / 0.594 GB, free: 14.07 MB / 430.1 MB
Notification: Performance of [SIM] Partitioning: time 0.002943/0.3775, allocations: 2.33 MB / 0.5962 GB, free: 11.49 MB / 430.1 MB
Notification: Performance of [SIM] Causalize: time 0.006039/0.3835, allocations: 4.15 MB / 0.6003 GB, free: 7.062 MB / 430.1 MB
Notification: Performance of [SIM] After Index Reduction Inline: time 0.005959/0.3895, allocations: 5.45 MB / 0.6056 GB, free: 1.609 MB / 430.1 MB
Notification: Performance of [INI] Simplify: time 0.004542/0.394, allocations: 2.3 MB / 0.6079 GB, free: 15.12 MB / 446.1 MB
Notification: Performance of [INI] Inline: time 0.008051/0.4021, allocations: 7.439 MB / 0.6151 GB, free: 7.656 MB / 446.1 MB
Notification: Performance of [INI] Partitioning: time 0.0003017/0.4024, allocations: 100.8 kB / 0.6152 GB, free: 7.531 MB / 446.1 MB
Notification: Performance of [INI] Cleanup: time 0.002336/0.4047, allocations: 1.483 MB / 0.6167 GB, free: 6.027 MB / 446.1 MB
Notification: Performance of [INI] Causalize: time 0.01542/0.4201, allocations: 9.96 MB / 0.6264 GB, free: 11.73 MB / 462.1 MB
Notification: Performance of [INI] Tearing: time 0.001474/0.4216, allocations: 0.9839 MB / 0.6274 GB, free: 10.74 MB / 462.1 MB
Notification: Performance of [SIM] Initialization: time 2.314e-06/0.4216, allocations: 4 kB / 0.6274 GB, free: 10.73 MB / 462.1 MB
Notification: Performance of [SIM] DAE-Mode: time 0.003677/0.4253, allocations: 2.607 MB / 0.6299 GB, free: 8.094 MB / 462.1 MB
Notification: Performance of [SIM] Remove Dummies: time 2.337e-05/0.4253, allocations: 5.312 kB / 0.6299 GB, free: 8.09 MB / 462.1 MB
Notification: Performance of [SIM] Tearing: time 0.0009928/0.4263, allocations: 0.7045 MB / 0.6306 GB, free: 7.406 MB / 462.1 MB
Notification: Performance of [SIM] Categorize: time 6.846e-05/0.4264, allocations: 15.88 kB / 0.6306 GB, free: 7.391 MB / 462.1 MB
Notification: Performance of [SIM] Solve: time 0.01357/0.4399, allocations: 9.082 MB / 0.6395 GB, free: 14.47 MB / 478.1 MB
Error: Internal error NBJacobian.SparsityColoring.PartialD2ColoringAlgC.getIndices failed because cref SourceP1.ports[2].h_outflow is neither a seed nor a partial candidate!
"
[Timeout remaining time 660]
[Calling sys.exit(0), Time elapsed: 3.036125461978372]
Failed to read output from testmodel.py, exit status != 0:
['time', 'SourceP1.ports[1].m_flow', 'SourceP1.ports[1].p', 'SourceP1.ports[1].h_outflow', 'SourceP1.ports[2].m_flow', 'SourceP1.ports[2].p', 'SourceP1.ports[2].h_outflow', 'SourceP2.ports[1].m_flow', 'SourceP2.ports[1].p', 'SourceP2.ports[1].h_outflow', 'SourceP2.ports[2].m_flow', 'SourceP2.ports[2].p', 'SourceP2.ports[2].h_outflow', 'SinkP1.ports[1].m_flow', 'SinkP1.ports[1].p', 'SinkP1.ports[1].h_outflow', 'V1.port_b.m_flow', 'V1.port_b.p', 'V1.port_b.h_outflow', 'V1.minLimiter.y', 'V2.port_b.m_flow', 'V2.port_b.p', 'V2.port_b.h_outflow', 'V2.minLimiter.y', 'V3.port_b.m_flow', 'V3.port_b.p', 'V3.port_b.h_outflow', 'V3.minLimiter.y', 'V4.port_b.m_flow', 'V4.port_b.p', 'V4.port_b.h_outflow', 'V4.minLimiter.y', 'V5.port_b.m_flow', 'V5.port_b.p', 'V5.port_b.h_outflow', 'V5.minLimiter.y', 'SinkP2.ports[1].m_flow', 'SinkP2.ports[1].p', 'SinkP2.ports[1].h_outflow', 'SinkP3.ports[1].m_flow', 'SinkP3.ports[1].p', 'SinkP3.ports[1].h_outflow', 'CloseLoad.y', 'OpenRelief.y', 'CloseValves.y']
0.4494996960274875 0.463229727 0.117556587
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7fc61d272fb0>