Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipesWithTraceSubstances.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.00141/0.00141, allocations: 99.64 kB / 21.25 MB, free: 424 kB / 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.001779/0.001779, allocations: 214.5 kB / 24.55 MB, free: 3.719 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.442/1.442, allocations: 230.5 MB / 258.2 MB, free: 7.715 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.2407/0.2407, allocations: 46.94 MB / 361.6 MB, free: 3.871 MB / 286.1 MB
"
[Timeout remaining time 180]
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.Pipes.DynamicPipesWithTraceSubstances,tolerance=1e-05,outputFormat="mat",numberOfIntervals=5003,variableFilter="time|pipe2.mediums.1..p|pipe2.mediums.1..T|pipe2.mediums.2..p|pipe2.mediums.2..T|pipe2.mediums.3..p|pipe2.mediums.3..T|pipe2.mediums.4..p|pipe2.mediums.4..T|pipe2.mediums.5..p|pipe2.mediums.5..T|pipe3.mediums.1..p|pipe3.mediums.1..T|pipe3.mediums.2..p|pipe3.mediums.2..T|pipe3.mediums.3..p|pipe3.mediums.3..T|pipe3.mediums.4..p|pipe3.mediums.4..T|pipe3.mediums.5..p|pipe3.mediums.5..T|pipe1.mediums.1..p|pipe1.mediums.1..T|pipe1.mediums.2..p|pipe1.mediums.2..T|pipe1.mediums.3..p|pipe1.mediums.3..T|pipe1.mediums.4..p|pipe1.mediums.4..T|pipe1.mediums.5..p|pipe1.mediums.5..T|pipe4.mediums.1..p|pipe4.mediums.1..T|pipe4.mediums.2..p|pipe4.mediums.2..T|pipe4.mediums.3..p|pipe4.mediums.3..T|pipe4.mediums.4..p|pipe4.mediums.4..T|pipe4.mediums.5..p|pipe4.mediums.5..T|junction1.medium.p|junction1.medium.T|junction1.mC_scaled.1.|junction1.mC_scaled.2.|junction2.medium.p|junction2.medium.T|junction2.mC_scaled.1.|junction2.mC_scaled.2.|pipe5.mediums.1..p|pipe5.mediums.1..T|pipe5.mediums.2..p|pipe5.mediums.2..T|pipe5.mediums.3..p|pipe5.mediums.3..T|pipe5.mediums.4..p|pipe5.mediums.4..T|pipe5.mediums.5..p|pipe5.mediums.5..T|pipe6.mediums.1..p|pipe6.mediums.1..T|pipe6.mediums.2..p|pipe6.mediums.2..T|pipe6.mediums.3..p|pipe6.mediums.3..T|pipe6.mediums.4..p|pipe6.mediums.4..T|pipe6.mediums.5..p|pipe6.mediums.5..T|pipe7.mediums.1..p|pipe7.mediums.1..T|pipe7.mediums.2..p|pipe7.mediums.2..T|pipe7.mediums.3..p|pipe7.mediums.3..T|pipe7.mediums.4..p|pipe7.mediums.4..T|pipe7.mediums.5..p|pipe7.mediums.5..T|pipe8.mediums.1..p|pipe8.mediums.1..T|pipe8.mediums.2..p|pipe8.mediums.2..T|pipe8.mediums.3..p|pipe8.mediums.3..T|pipe8.mediums.4..p|pipe8.mediums.4..T|pipe8.mediums.5..p|pipe8.mediums.5..T",fileNamePrefix="ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipesWithTraceSubstances")
translateModel(ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipesWithTraceSubstances,tolerance=1e-05,outputFormat="mat",numberOfIntervals=5003,variableFilter="time|pipe2.mediums.1..p|pipe2.mediums.1..T|pipe2.mediums.2..p|pipe2.mediums.2..T|pipe2.mediums.3..p|pipe2.mediums.3..T|pipe2.mediums.4..p|pipe2.mediums.4..T|pipe2.mediums.5..p|pipe2.mediums.5..T|pipe3.mediums.1..p|pipe3.mediums.1..T|pipe3.mediums.2..p|pipe3.mediums.2..T|pipe3.mediums.3..p|pipe3.mediums.3..T|pipe3.mediums.4..p|pipe3.mediums.4..T|pipe3.mediums.5..p|pipe3.mediums.5..T|pipe1.mediums.1..p|pipe1.mediums.1..T|pipe1.mediums.2..p|pipe1.mediums.2..T|pipe1.mediums.3..p|pipe1.mediums.3..T|pipe1.mediums.4..p|pipe1.mediums.4..T|pipe1.mediums.5..p|pipe1.mediums.5..T|pipe4.mediums.1..p|pipe4.mediums.1..T|pipe4.mediums.2..p|pipe4.mediums.2..T|pipe4.mediums.3..p|pipe4.mediums.3..T|pipe4.mediums.4..p|pipe4.mediums.4..T|pipe4.mediums.5..p|pipe4.mediums.5..T|junction1.medium.p|junction1.medium.T|junction1.mC_scaled.1.|junction1.mC_scaled.2.|junction2.medium.p|junction2.medium.T|junction2.mC_scaled.1.|junction2.mC_scaled.2.|pipe5.mediums.1..p|pipe5.mediums.1..T|pipe5.mediums.2..p|pipe5.mediums.2..T|pipe5.mediums.3..p|pipe5.mediums.3..T|pipe5.mediums.4..p|pipe5.mediums.4..T|pipe5.mediums.5..p|pipe5.mediums.5..T|pipe6.mediums.1..p|pipe6.mediums.1..T|pipe6.mediums.2..p|pipe6.mediums.2..T|pipe6.mediums.3..p|pipe6.mediums.3..T|pipe6.mediums.4..p|pipe6.mediums.4..T|pipe6.mediums.5..p|pipe6.mediums.5..T|pipe7.mediums.1..p|pipe7.mediums.1..T|pipe7.mediums.2..p|pipe7.mediums.2..T|pipe7.mediums.3..p|pipe7.mediums.3..T|pipe7.mediums.4..p|pipe7.mediums.4..T|pipe7.mediums.5..p|pipe7.mediums.5..T|pipe8.mediums.1..p|pipe8.mediums.1..T|pipe8.mediums.2..p|pipe8.mediums.2..T|pipe8.mediums.3..p|pipe8.mediums.3..T|pipe8.mediums.4..p|pipe8.mediums.4..T|pipe8.mediums.5..p|pipe8.mediums.5..T",fileNamePrefix="ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipesWithTraceSubstances") [Timeout 660]
"Notification: Performance of FrontEnd - Absyn->SCode: time 2.023e-05/2.023e-05, allocations: 2.281 kB / 0.4974 GB, free: 7.035 MB / 366.1 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipesWithTraceSubstances): time 0.9983/0.9984, allocations: 311.8 MB / 0.8019 GB, free: 1.059 MB / 0.545 GB
Notification: Performance of NFInst.instExpressions: time 0.05323/1.052, allocations: 32.17 MB / 0.8333 GB, free: 15.75 MB / 0.5606 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.007401/1.059, allocations: 269.7 kB / 0.8336 GB, free: 15.75 MB / 0.5606 GB
Notification: Performance of NFTyping.typeComponents: time 0.007637/1.067, allocations: 1.955 MB / 0.8355 GB, free: 15.36 MB / 0.5606 GB
Notification: Performance of NFTyping.typeBindings: time 0.03707/1.104, allocations: 9.147 MB / 0.8444 GB, free: 11.68 MB / 0.5606 GB
Notification: Performance of NFTyping.typeClassSections: time 0.04013/1.144, allocations: 14.04 MB / 0.8581 GB, free: 3.328 MB / 0.5606 GB
Notification: Performance of NFFlatten.flatten: time 0.04698/1.191, allocations: 32.5 MB / 0.8899 GB, free: 8.969 MB / 0.5919 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.02328/1.214, allocations: 6.933 MB / 0.8966 GB, free: 2.191 MB / 0.5919 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.0392/1.253, allocations: 15.05 MB / 0.9113 GB, free: 4.625 MB / 0.6075 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.01837/1.272, allocations: 6.881 MB / 0.9181 GB, free: 14.52 MB / 0.6231 GB
Notification: Performance of NFPackage.collectConstants: time 0.004896/1.277, allocations: 0.5664 MB / 0.9186 GB, free: 13.95 MB / 0.6231 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.02021/1.297, allocations: 4.977 MB / 0.9235 GB, free: 9.125 MB / 0.6231 GB
Notification: Performance of combineBinaries: time 0.02773/1.324, allocations: 14.26 MB / 0.9374 GB, free: 11.83 MB / 0.6387 GB
Notification: Performance of replaceArrayConstructors: time 0.01435/1.339, allocations: 8.443 MB / 0.9456 GB, free: 3.859 MB / 0.6387 GB
Notification: Performance of NFVerifyModel.verify: time 0.005176/1.344, allocations: 476 kB / 0.9461 GB, free: 3.395 MB / 0.6387 GB
Notification: Performance of FrontEnd: time 0.001276/1.345, allocations: 146.9 kB / 0.9462 GB, free: 3.254 MB / 0.6387 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 3585 (875)
 * Number of variables: 3585 (835)
Notification: Performance of [SIM] Bindings: time 0.07028/1.416, allocations: 38.64 MB / 0.984 GB, free: 14.02 MB / 0.6856 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 $i40
[/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 $i54
[/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 $i68
[/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 $i82
[/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 $i96
[/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 $i110
[/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 $i124
[/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 $i138
Notification: Performance of [SIM] FunctionAlias: time 0.01469/1.43, allocations: 7.034 MB / 0.9908 GB, free: 7.035 MB / 0.6856 GB
Notification: Performance of [SIM] Early Inline: time 0.5716/2.002, allocations: 26.45 MB / 1.017 GB, free: 70.8 MB / 0.6856 GB
Notification: Performance of [SIM] Simplify 1: time 0.01221/2.014, allocations: 3.645 MB / 1.02 GB, free: 70.14 MB / 0.6856 GB
Warning: NBAlias.setStartFixed: Alias set with conflicting unfixed start values detected. Use -d=dumprepl for more information.
Notification: Performance of [SIM] Alias: time 0.05367/2.068, allocations: 21.78 MB / 1.041 GB, free: 66.38 MB / 0.6856 GB
Notification: Performance of [SIM] Simplify 2: time 0.01211/2.08, allocations: 3.381 MB / 1.045 GB, free: 65.71 MB / 0.6856 GB
Notification: Performance of [SIM] Remove Stream: time 0.008194/2.088, allocations: 2.275 MB / 1.047 GB, free: 65.36 MB / 0.6856 GB
Notification: Performance of [SIM] Detect States: time 0.01199/2.1, allocations: 4.649 MB / 1.052 GB, free: 64.95 MB / 0.6856 GB
Notification: Performance of [SIM] Events: time 0.004166/2.104, allocations: 1.502 MB / 1.053 GB, free: 64.7 MB / 0.6856 GB
Notification: Performance of [SIM] Partitioning: time 0.02378/2.128, allocations: 8.702 MB / 1.062 GB, free: 63.6 MB / 0.6856 GB
Error: Internal error NBResolveSingularities.indexReduction failed because dynamic index reduction is not yet supported.
"
[Timeout remaining time 658]
[Calling sys.exit(0), Time elapsed: 4.889863017015159]
Failed to read output from testmodel.py, exit status != 0:
['time', 'pipe2.mediums[1].p', 'pipe2.mediums[1].T', 'pipe2.mediums[2].p', 'pipe2.mediums[2].T', 'pipe2.mediums[3].p', 'pipe2.mediums[3].T', 'pipe2.mediums[4].p', 'pipe2.mediums[4].T', 'pipe2.mediums[5].p', 'pipe2.mediums[5].T', 'pipe3.mediums[1].p', 'pipe3.mediums[1].T', 'pipe3.mediums[2].p', 'pipe3.mediums[2].T', 'pipe3.mediums[3].p', 'pipe3.mediums[3].T', 'pipe3.mediums[4].p', 'pipe3.mediums[4].T', 'pipe3.mediums[5].p', 'pipe3.mediums[5].T', 'pipe1.mediums[1].p', 'pipe1.mediums[1].T', 'pipe1.mediums[2].p', 'pipe1.mediums[2].T', 'pipe1.mediums[3].p', 'pipe1.mediums[3].T', 'pipe1.mediums[4].p', 'pipe1.mediums[4].T', 'pipe1.mediums[5].p', 'pipe1.mediums[5].T', 'pipe4.mediums[1].p', 'pipe4.mediums[1].T', 'pipe4.mediums[2].p', 'pipe4.mediums[2].T', 'pipe4.mediums[3].p', 'pipe4.mediums[3].T', 'pipe4.mediums[4].p', 'pipe4.mediums[4].T', 'pipe4.mediums[5].p', 'pipe4.mediums[5].T', 'junction1.medium.p', 'junction1.medium.T', 'junction1.mC_scaled[1]', 'junction1.mC_scaled[2]', 'junction2.medium.p', 'junction2.medium.T', 'junction2.mC_scaled[1]', 'junction2.mC_scaled[2]', 'pipe5.mediums[1].p', 'pipe5.mediums[1].T', 'pipe5.mediums[2].p', 'pipe5.mediums[2].T', 'pipe5.mediums[3].p', 'pipe5.mediums[3].T', 'pipe5.mediums[4].p', 'pipe5.mediums[4].T', 'pipe5.mediums[5].p', 'pipe5.mediums[5].T', 'pipe6.mediums[1].p', 'pipe6.mediums[1].T', 'pipe6.mediums[2].p', 'pipe6.mediums[2].T', 'pipe6.mediums[3].p', 'pipe6.mediums[3].T', 'pipe6.mediums[4].p', 'pipe6.mediums[4].T', 'pipe6.mediums[5].p', 'pipe6.mediums[5].T', 'pipe7.mediums[1].p', 'pipe7.mediums[1].T', 'pipe7.mediums[2].p', 'pipe7.mediums[2].T', 'pipe7.mediums[3].p', 'pipe7.mediums[3].T', 'pipe7.mediums[4].p', 'pipe7.mediums[4].T', 'pipe7.mediums[5].p', 'pipe7.mediums[5].T', 'pipe8.mediums[1].p', 'pipe8.mediums[1].T', 'pipe8.mediums[2].p', 'pipe8.mediums[2].T', 'pipe8.mediums[3].p', 'pipe8.mediums[3].T', 'pipe8.mediums[4].p', 'pipe8.mediums[4].T', 'pipe8.mediums[5].p', 'pipe8.mediums[5].T']
2.1662665150361136 2.181602677 0.832317744
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7ff7256befb0>