Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Modelica_3.2.3_Modelica.Fluid.Examples.BranchingDynamicPipes.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.001978/0.001978, allocations: 111.4 kB / 21.99 MB, free: 4.555 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.002424/0.002424, allocations: 213.5 kB / 25.3 MB, free: 2.902 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 1.704/1.704, allocations: 207.7 MB / 236.2 MB, free: 9.762 MB / 190.1 MB
"
[Timeout remaining time 178]
Using package Modelica with version 3.2.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+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(Modelica.Fluid.Examples.BranchingDynamicPipes,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5015,variableFilter="time|pipe1.flowModel.m_flows.1.|pipe1.flowModel.m_flows.2.|pipe1.flowModel.m_flows.3.|pipe1.flowModel.m_flows.4.|pipe1.flowModel.m_flows.5.|pipe1.flowModel.m_flows.6.|pipe1.mediums.1..T|pipe1.mediums.1..Xi.1.|pipe1.mediums.1..p|pipe1.mediums.2..T|pipe1.mediums.2..Xi.1.|pipe1.mediums.2..p|pipe1.mediums.3..T|pipe1.mediums.3..Xi.1.|pipe1.mediums.3..p|pipe1.mediums.4..T|pipe1.mediums.4..Xi.1.|pipe1.mediums.4..p|pipe1.mediums.5..T|pipe1.mediums.5..Xi.1.|pipe1.mediums.5..p|pipe2.flowModel.m_flows.1.|pipe2.flowModel.m_flows.2.|pipe2.flowModel.m_flows.3.|pipe2.flowModel.m_flows.4.|pipe2.mediums.1..T|pipe2.mediums.1..Xi.1.|pipe2.mediums.1..p|pipe2.mediums.2..T|pipe2.mediums.2..Xi.1.|pipe2.mediums.2..p|pipe2.mediums.3..T|pipe2.mediums.3..Xi.1.|pipe2.mediums.3..p|pipe2.mediums.4..T|pipe2.mediums.4..Xi.1.|pipe2.mediums.4..p|pipe2.mediums.5..T|pipe2.mediums.5..Xi.1.|pipe2.mediums.5..p|pipe3.flowModel.m_flows.1.|pipe3.flowModel.m_flows.2.|pipe3.flowModel.m_flows.3.|pipe3.flowModel.m_flows.4.|pipe3.flowModel.m_flows.5.|pipe3.flowModel.m_flows.6.|pipe3.mediums.1..T|pipe3.mediums.1..Xi.1.|pipe3.mediums.1..p|pipe3.mediums.2..T|pipe3.mediums.2..Xi.1.|pipe3.mediums.2..p|pipe3.mediums.3..T|pipe3.mediums.3..Xi.1.|pipe3.mediums.3..p|pipe3.mediums.4..T|pipe3.mediums.4..Xi.1.|pipe3.mediums.4..p|pipe3.mediums.5..T|pipe3.mediums.5..Xi.1.|pipe3.mediums.5..p|pipe4.flowModel.m_flows.1.|pipe4.flowModel.m_flows.2.|pipe4.flowModel.m_flows.3.|pipe4.flowModel.m_flows.4.|pipe4.flowModel.m_flows.5.|pipe4.flowModel.m_flows.6.|pipe4.mediums.1..T|pipe4.mediums.1..Xi.1.|pipe4.mediums.1..p|pipe4.mediums.2..T|pipe4.mediums.2..Xi.1.|pipe4.mediums.2..p|pipe4.mediums.3..T|pipe4.mediums.3..Xi.1.|pipe4.mediums.3..p|pipe4.mediums.4..T|pipe4.mediums.4..Xi.1.|pipe4.mediums.4..p|pipe4.mediums.5..T|pipe4.mediums.5..Xi.1.|pipe4.mediums.5..p",fileNamePrefix="Modelica_3.2.3_Modelica.Fluid.Examples.BranchingDynamicPipes")
translateModel(Modelica.Fluid.Examples.BranchingDynamicPipes,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5015,variableFilter="time|pipe1.flowModel.m_flows.1.|pipe1.flowModel.m_flows.2.|pipe1.flowModel.m_flows.3.|pipe1.flowModel.m_flows.4.|pipe1.flowModel.m_flows.5.|pipe1.flowModel.m_flows.6.|pipe1.mediums.1..T|pipe1.mediums.1..Xi.1.|pipe1.mediums.1..p|pipe1.mediums.2..T|pipe1.mediums.2..Xi.1.|pipe1.mediums.2..p|pipe1.mediums.3..T|pipe1.mediums.3..Xi.1.|pipe1.mediums.3..p|pipe1.mediums.4..T|pipe1.mediums.4..Xi.1.|pipe1.mediums.4..p|pipe1.mediums.5..T|pipe1.mediums.5..Xi.1.|pipe1.mediums.5..p|pipe2.flowModel.m_flows.1.|pipe2.flowModel.m_flows.2.|pipe2.flowModel.m_flows.3.|pipe2.flowModel.m_flows.4.|pipe2.mediums.1..T|pipe2.mediums.1..Xi.1.|pipe2.mediums.1..p|pipe2.mediums.2..T|pipe2.mediums.2..Xi.1.|pipe2.mediums.2..p|pipe2.mediums.3..T|pipe2.mediums.3..Xi.1.|pipe2.mediums.3..p|pipe2.mediums.4..T|pipe2.mediums.4..Xi.1.|pipe2.mediums.4..p|pipe2.mediums.5..T|pipe2.mediums.5..Xi.1.|pipe2.mediums.5..p|pipe3.flowModel.m_flows.1.|pipe3.flowModel.m_flows.2.|pipe3.flowModel.m_flows.3.|pipe3.flowModel.m_flows.4.|pipe3.flowModel.m_flows.5.|pipe3.flowModel.m_flows.6.|pipe3.mediums.1..T|pipe3.mediums.1..Xi.1.|pipe3.mediums.1..p|pipe3.mediums.2..T|pipe3.mediums.2..Xi.1.|pipe3.mediums.2..p|pipe3.mediums.3..T|pipe3.mediums.3..Xi.1.|pipe3.mediums.3..p|pipe3.mediums.4..T|pipe3.mediums.4..Xi.1.|pipe3.mediums.4..p|pipe3.mediums.5..T|pipe3.mediums.5..Xi.1.|pipe3.mediums.5..p|pipe4.flowModel.m_flows.1.|pipe4.flowModel.m_flows.2.|pipe4.flowModel.m_flows.3.|pipe4.flowModel.m_flows.4.|pipe4.flowModel.m_flows.5.|pipe4.flowModel.m_flows.6.|pipe4.mediums.1..T|pipe4.mediums.1..Xi.1.|pipe4.mediums.1..p|pipe4.mediums.2..T|pipe4.mediums.2..Xi.1.|pipe4.mediums.2..p|pipe4.mediums.3..T|pipe4.mediums.3..Xi.1.|pipe4.mediums.3..p|pipe4.mediums.4..T|pipe4.mediums.4..Xi.1.|pipe4.mediums.4..p|pipe4.mediums.5..T|pipe4.mediums.5..Xi.1.|pipe4.mediums.5..p",fileNamePrefix="Modelica_3.2.3_Modelica.Fluid.Examples.BranchingDynamicPipes") [Timeout 660]
"Notification: Performance of FrontEnd - Absyn->SCode: time 3.024e-05/3.024e-05, allocations: 2.281 kB / 348.5 MB, free: 9.383 MB / 286.1 MB
Notification: Performance of NFInst.instantiate(Modelica.Fluid.Examples.BranchingDynamicPipes): time 1.036/1.036, allocations: 252.7 MB / 0.5871 GB, free: 0.7773 MB / 446.1 MB
Notification: Performance of NFInst.instExpressions: time 0.04022/1.076, allocations: 23.87 MB / 0.6104 GB, free: 496 kB / 446.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.006135/1.082, allocations: 144.8 kB / 0.6105 GB, free: 492 kB / 446.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.006009/1.088, allocations: 1.177 MB / 0.6117 GB, free: 472 kB / 446.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.03075/1.119, allocations: 7.235 MB / 0.6187 GB, free: 128 kB / 446.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.03197/1.151, allocations: 9.35 MB / 0.6279 GB, free: 12.29 MB / 462.1 MB
Notification: Performance of NFFlatten.flatten: time 0.0274/1.178, allocations: 17.29 MB / 0.6447 GB, free: 3.875 MB / 462.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.01233/1.191, allocations: 3.553 MB / 0.6482 GB, free: 416 kB / 462.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.01835/1.209, allocations: 6.788 MB / 0.6548 GB, free: 10.25 MB / 478.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.01088/1.22, allocations: 4.185 MB / 0.6589 GB, free: 6.656 MB / 478.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.002277/1.222, allocations: 356 kB / 0.6593 GB, free: 6.309 MB / 478.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.03387/1.256, allocations: 10.06 MB / 0.6691 GB, free: 13.26 MB / 494.1 MB
Notification: Performance of combineBinaries: time 0.01748/1.273, allocations: 8.206 MB / 0.6771 GB, free: 5.895 MB / 494.1 MB
Notification: Performance of replaceArrayConstructors: time 0.006981/1.28, allocations: 4.639 MB / 0.6816 GB, free: 1.641 MB / 494.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.003188/1.284, allocations: 248 kB / 0.6819 GB, free: 1.395 MB / 494.1 MB
Notification: Performance of FrontEnd: time 0.001234/1.285, allocations: 64.12 kB / 0.6819 GB, free: 1.34 MB / 494.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 2025 (453)
 * Number of variables: 2025 (449)
Notification: Performance of [SIM] Bindings: time 0.04282/1.328, allocations: 23.69 MB / 0.7051 GB, free: 10.71 MB / 0.5137 GB
[/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/Compiler/NBackEnd/Classes/NBackendDAE.mo:1505:5-1505:109:writable] Error: Internal error NBVariable.VariablePointers.getVarSafe failed for $i24
[/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/Compiler/NBackEnd/Classes/NBackendDAE.mo:1505:5-1505:109:writable] Error: Internal error NBVariable.VariablePointers.getVarSafe failed for $i38
[/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/Compiler/NBackEnd/Classes/NBackendDAE.mo:1505:5-1505:109:writable] Error: Internal error NBVariable.VariablePointers.getVarSafe failed for $i58
[/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/Compiler/NBackEnd/Classes/NBackendDAE.mo:1505:5-1505:109:writable] Error: Internal error NBVariable.VariablePointers.getVarSafe failed for $i72
Notification: Performance of [SIM] FunctionAlias: time 0.008838/1.336, allocations: 4.24 MB / 0.7092 GB, free: 6.543 MB / 0.5137 GB
Error: Internal error NFInstNode.InstNode.definition failed for non class/component node: $EMPTY
"
[Timeout remaining time 659]
[Calling sys.exit(0), Time elapsed: 4.041447377996519]
Failed to read output from testmodel.py, exit status != 0:
['time', 'pipe1.flowModel.m_flows[1]', 'pipe1.flowModel.m_flows[2]', 'pipe1.flowModel.m_flows[3]', 'pipe1.flowModel.m_flows[4]', 'pipe1.flowModel.m_flows[5]', 'pipe1.flowModel.m_flows[6]', 'pipe1.mediums[1].T', 'pipe1.mediums[1].Xi[1]', 'pipe1.mediums[1].p', 'pipe1.mediums[2].T', 'pipe1.mediums[2].Xi[1]', 'pipe1.mediums[2].p', 'pipe1.mediums[3].T', 'pipe1.mediums[3].Xi[1]', 'pipe1.mediums[3].p', 'pipe1.mediums[4].T', 'pipe1.mediums[4].Xi[1]', 'pipe1.mediums[4].p', 'pipe1.mediums[5].T', 'pipe1.mediums[5].Xi[1]', 'pipe1.mediums[5].p', 'pipe2.flowModel.m_flows[1]', 'pipe2.flowModel.m_flows[2]', 'pipe2.flowModel.m_flows[3]', 'pipe2.flowModel.m_flows[4]', 'pipe2.mediums[1].T', 'pipe2.mediums[1].Xi[1]', 'pipe2.mediums[1].p', 'pipe2.mediums[2].T', 'pipe2.mediums[2].Xi[1]', 'pipe2.mediums[2].p', 'pipe2.mediums[3].T', 'pipe2.mediums[3].Xi[1]', 'pipe2.mediums[3].p', 'pipe2.mediums[4].T', 'pipe2.mediums[4].Xi[1]', 'pipe2.mediums[4].p', 'pipe2.mediums[5].T', 'pipe2.mediums[5].Xi[1]', 'pipe2.mediums[5].p', 'pipe3.flowModel.m_flows[1]', 'pipe3.flowModel.m_flows[2]', 'pipe3.flowModel.m_flows[3]', 'pipe3.flowModel.m_flows[4]', 'pipe3.flowModel.m_flows[5]', 'pipe3.flowModel.m_flows[6]', 'pipe3.mediums[1].T', 'pipe3.mediums[1].Xi[1]', 'pipe3.mediums[1].p', 'pipe3.mediums[2].T', 'pipe3.mediums[2].Xi[1]', 'pipe3.mediums[2].p', 'pipe3.mediums[3].T', 'pipe3.mediums[3].Xi[1]', 'pipe3.mediums[3].p', 'pipe3.mediums[4].T', 'pipe3.mediums[4].Xi[1]', 'pipe3.mediums[4].p', 'pipe3.mediums[5].T', 'pipe3.mediums[5].Xi[1]', 'pipe3.mediums[5].p', 'pipe4.flowModel.m_flows[1]', 'pipe4.flowModel.m_flows[2]', 'pipe4.flowModel.m_flows[3]', 'pipe4.flowModel.m_flows[4]', 'pipe4.flowModel.m_flows[5]', 'pipe4.flowModel.m_flows[6]', 'pipe4.mediums[1].T', 'pipe4.mediums[1].Xi[1]', 'pipe4.mediums[1].p', 'pipe4.mediums[2].T', 'pipe4.mediums[2].Xi[1]', 'pipe4.mediums[2].p', 'pipe4.mediums[3].T', 'pipe4.mediums[3].Xi[1]', 'pipe4.mediums[3].p', 'pipe4.mediums[4].T', 'pipe4.mediums[4].Xi[1]', 'pipe4.mediums[4].p', 'pipe4.mediums[5].T', 'pipe4.mediums[5].Xi[1]', 'pipe4.mediums[5].p']
1.3463171269977465 1.361044204 0.07219133599999994
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f60838b6fb0>