Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Modelica_4.0.0_Modelica.Fluid.Examples.BranchingDynamicPipes.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001612/0.001612, allocations: 104 kB / 21.25 MB, free: 0.5664 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.002119/0.002119, allocations: 190.7 kB / 24.53 MB, free: 3.852 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.549/1.549, allocations: 225.7 MB / 253.4 MB, free: 12.79 MB / 206.1 MB
"
[Timeout remaining time 178]
Using package Modelica with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo)
Using package Complex with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo)
Using package ModelicaServices with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.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_4.0.0_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_4.0.0_Modelica.Fluid.Examples.BranchingDynamicPipes") [Timeout 660]
"Notification: Performance of FrontEnd - Absyn->SCode: time 3.156e-05/3.156e-05, allocations: 2.281 kB / 371.7 MB, free: 9.18 MB / 302.1 MB
Notification: Performance of NFInst.instantiate(Modelica.Fluid.Examples.BranchingDynamicPipes): time 0.9857/0.9857, allocations: 238.9 MB / 0.5963 GB, free: 0.9844 MB / 446.1 MB
Notification: Performance of NFInst.instExpressions: time 0.04058/1.026, allocations: 21.2 MB / 0.617 GB, free: 388 kB / 446.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.004816/1.031, allocations: 141.7 kB / 0.6172 GB, free: 384 kB / 446.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.004505/1.036, allocations: 1.17 MB / 0.6183 GB, free: 360 kB / 446.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.02418/1.06, allocations: 6.643 MB / 0.6248 GB, free: 13.9 MB / 462.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.02965/1.089, allocations: 9.018 MB / 0.6336 GB, free: 8.832 MB / 462.1 MB
Notification: Performance of NFFlatten.flatten: time 0.02672/1.116, allocations: 17.3 MB / 0.6505 GB, free: 13.04 MB / 478.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.01177/1.128, allocations: 3.557 MB / 0.654 GB, free: 9.566 MB / 478.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.01788/1.146, allocations: 6.783 MB / 0.6606 GB, free: 3.418 MB / 478.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.01033/1.156, allocations: 4.189 MB / 0.6647 GB, free: 15.81 MB / 494.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.003082/1.159, allocations: 358.5 kB / 0.665 GB, free: 15.46 MB / 494.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.02689/1.186, allocations: 9.194 MB / 0.674 GB, free: 7.242 MB / 494.1 MB
Notification: Performance of combineBinaries: time 0.01558/1.202, allocations: 8.208 MB / 0.682 GB, free: 15.87 MB / 0.4981 GB
Notification: Performance of replaceArrayConstructors: time 0.006744/1.208, allocations: 4.639 MB / 0.6865 GB, free: 11.62 MB / 0.4981 GB
Notification: Performance of NFVerifyModel.verify: time 0.002751/1.211, allocations: 248 kB / 0.6868 GB, free: 11.38 MB / 0.4981 GB
Notification: Performance of FrontEnd: time 0.0007535/1.212, allocations: 75.69 kB / 0.6869 GB, free: 11.31 MB / 0.4981 GB
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.04066/1.253, allocations: 23.66 MB / 0.71 GB, free: 4.695 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.008894/1.261, allocations: 4.243 MB / 0.7141 GB, free: 0.5664 MB / 0.5137 GB
Notification: Performance of [SIM] Early Inline: time 0.03559/1.297, allocations: 18.25 MB / 0.7319 GB, free: 14.84 MB / 0.545 GB
Notification: Performance of [SIM] Simplify 1: time 0.007786/1.305, allocations: 2.607 MB / 0.7345 GB, free: 12.22 MB / 0.545 GB
Notification: Performance of [SIM] Alias: time 0.02667/1.332, allocations: 11.94 MB / 0.7461 GB, free: 116 kB / 0.545 GB
Notification: Performance of [SIM] Simplify 2: time 0.4439/1.775, allocations: 2.496 MB / 0.7486 GB, free: 62.34 MB / 0.545 GB
Notification: Performance of [SIM] Remove Stream: time 0.005134/1.781, allocations: 1.825 MB / 0.7504 GB, free: 62.03 MB / 0.545 GB
Notification: Performance of [SIM] Detect States: time 0.00622/1.787, allocations: 3.217 MB / 0.7535 GB, free: 61.74 MB / 0.545 GB
Notification: Performance of [SIM] Events: time 0.001875/1.789, allocations: 0.9061 MB / 0.7544 GB, free: 61.63 MB / 0.545 GB
Notification: Performance of [SIM] Partitioning: time 0.008246/1.797, allocations: 5.506 MB / 0.7598 GB, free: 61.27 MB / 0.545 GB
Error: Internal error NBDifferentiate.differentiateComponentRef failed for: $i1
"
[Timeout remaining time 658]
[Calling sys.exit(0), Time elapsed: 4.332204872975126]
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.8509947650018148 1.861564228 0.6466426390000001
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f39b9996fb0>