Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ModelicaTest_4.0.0_ModelicaTest.Fluid.TestComponents.Fittings.TestMultiPortTraceSubstances.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.001382/0.001382, allocations: 112.9 kB / 20.54 MB, free: 1.777 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.001464/0.001464, allocations: 192.5 kB / 23.72 MB, free: 5.402 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.287/1.287, allocations: 225.6 MB / 252.3 MB, free: 13.36 MB / 206.1 MB
"
[Timeout remaining time 179]
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.1969/0.1969, allocations: 44.91 MB / 352.4 MB, free: 12.33 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.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(ModelicaTest.Fluid.TestComponents.Fittings.TestMultiPortTraceSubstances,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5003,variableFilter="time|volume1.mC_scaled.1.|volume1.medium.T|volume1.medium.Xi.1.|volume1.medium.p|volume2.mC_scaled.1.|volume2.medium.T|volume2.medium.Xi.1.|volume2.medium.p|volume3.mC_scaled.1.|volume3.medium.T|volume3.medium.Xi.1.|volume3.medium.p",fileNamePrefix="ModelicaTest_4.0.0_ModelicaTest.Fluid.TestComponents.Fittings.TestMultiPortTraceSubstances")
translateModel(ModelicaTest.Fluid.TestComponents.Fittings.TestMultiPortTraceSubstances,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5003,variableFilter="time|volume1.mC_scaled.1.|volume1.medium.T|volume1.medium.Xi.1.|volume1.medium.p|volume2.mC_scaled.1.|volume2.medium.T|volume2.medium.Xi.1.|volume2.medium.p|volume3.mC_scaled.1.|volume3.medium.T|volume3.medium.Xi.1.|volume3.medium.p",fileNamePrefix="ModelicaTest_4.0.0_ModelicaTest.Fluid.TestComponents.Fittings.TestMultiPortTraceSubstances") [Timeout 660]
"Notification: Performance of FrontEnd - Absyn->SCode: time 2.015e-05/2.015e-05, allocations: 2.281 kB / 495.9 MB, free: 1.938 MB / 350.1 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.Fluid.TestComponents.Fittings.TestMultiPortTraceSubstances): time 0.7892/0.7892, allocations: 332.4 MB / 0.8089 GB, free: 36 kB / 0.5294 GB
Notification: Performance of NFInst.instExpressions: time 0.02925/0.8185, allocations: 28.62 MB / 0.8369 GB, free: 10.61 MB / 0.545 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.002482/0.8209, allocations: 73.91 kB / 0.8369 GB, free: 10.61 MB / 0.545 GB
Notification: Performance of NFTyping.typeComponents: time 0.002816/0.8238, allocations: 1.385 MB / 0.8383 GB, free: 9.945 MB / 0.545 GB
Notification: Performance of NFTyping.typeBindings: time 0.02242/0.8462, allocations: 9.749 MB / 0.8478 GB, free: 4.047 MB / 0.545 GB
Notification: Performance of NFTyping.typeClassSections: time 0.01808/0.8643, allocations: 8.055 MB / 0.8557 GB, free: 13.52 MB / 0.5606 GB
Notification: Performance of NFFlatten.flatten: time 0.01657/0.8808, allocations: 11.2 MB / 0.8666 GB, free: 3.672 MB / 0.5606 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.006402/0.8872, allocations: 2.898 MB / 0.8695 GB, free: 0.8477 MB / 0.5606 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.01746/0.9047, allocations: 7.662 MB / 0.8769 GB, free: 9.781 MB / 0.5762 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.007541/0.9122, allocations: 3.669 MB / 0.8805 GB, free: 6.453 MB / 0.5762 GB
Notification: Performance of NFPackage.collectConstants: time 0.00109/0.9133, allocations: 340 kB / 0.8808 GB, free: 6.121 MB / 0.5762 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.02982/0.9431, allocations: 17.26 MB / 0.8977 GB, free: 5.902 MB / 0.5919 GB
Notification: Performance of combineBinaries: time 0.009337/0.9525, allocations: 7.539 MB / 0.9051 GB, free: 14.86 MB / 0.6075 GB
Notification: Performance of replaceArrayConstructors: time 0.004259/0.9567, allocations: 3.991 MB / 0.909 GB, free: 11.1 MB / 0.6075 GB
Notification: Performance of NFVerifyModel.verify: time 0.001523/0.9583, allocations: 0.5181 MB / 0.9095 GB, free: 10.58 MB / 0.6075 GB
Notification: Performance of FrontEnd: time 0.0006789/0.9589, allocations: 79.69 kB / 0.9095 GB, free: 10.5 MB / 0.6075 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 752 (557)
 * Number of variables: 800 (511)
Notification: Performance of Bindings: time 0.01641/0.9753, allocations: 14.15 MB / 0.9234 GB, free: 13.01 MB / 0.6231 GB
Notification: Performance of FunctionAlias: time 0.00276/0.9781, allocations: 2.245 MB / 0.9255 GB, free: 10.89 MB / 0.6231 GB
Notification: Performance of Early Inline: time 0.01232/0.9904, allocations: 9.944 MB / 0.9353 GB, free: 1.191 MB / 0.6231 GB
Notification: Performance of Simplify 1: time 0.003009/0.9934, allocations: 1.71 MB / 0.9369 GB, free: 15.44 MB / 0.6387 GB
Warning: NBAlias.setStartFixed: Alias set with conflicting unfixed start values detected. Use -d=dumprepl for more information.
Notification: Performance of Alias: time 0.008869/1.002, allocations: 5.882 MB / 0.9427 GB, free: 9.016 MB / 0.6387 GB
Notification: Performance of Simplify 2: time 0.002882/1.005, allocations: 1.65 MB / 0.9443 GB, free: 7.309 MB / 0.6387 GB
Notification: Performance of Remove Stream: time 0.001666/1.007, allocations: 1.396 MB / 0.9456 GB, free: 5.855 MB / 0.6387 GB
Notification: Performance of Detect States: time 0.002066/1.009, allocations: 2.047 MB / 0.9476 GB, free: 3.816 MB / 0.6387 GB
Notification: Performance of Events: time 0.001852/1.011, allocations: 1.476 MB / 0.9491 GB, free: 2.367 MB / 0.6387 GB
Notification: Performance of Partitioning: time 0.004635/1.015, allocations: 4.342 MB / 0.9533 GB, free: 13.65 MB / 0.6544 GB
Error: Internal error NBResolveSingularities.noIndexReduction failed.
(18|48) Unmatched Variables
*****************************
	[ALGB] (4) input Real[2, 2] pipe6.flowModel.states.T (start = {288.15 for $f9 in 1:2}, min = {190.0 for $f11 in 1:2}, max = {647.0 for $f10 in 1:2}, nominal = {300.0 for $f8 in 1:2})
	slice: {2, 3}
	[ALGB] (4) input Real[2, 2] pipe5.flowModel.states.T (start = {288.15 for $f9 in 1:2}, min = {190.0 for $f11 in 1:2}, max = {647.0 for $f10 in 1:2}, nominal = {300.0 for $f8 in 1:2})
	slice: {2, 3}
	[ALGB] (4) input Real[2, 2] pipe4.flowModel.states.T (start = {288.15 for $f9 in 1:2}, min = {190.0 for $f11 in 1:2}, max = {647.0 for $f10 in 1:2}, nominal = {300.0 for $f8 in 1:2})
	slice: {2, 3}
	[ALGB] (4) input Real[2, 2] pipe3.flowModel.states.T (start = {288.15 for $f9 in 1:2}, min = {190.0 for $f11 in 1:2}, max = {647.0 for $f10 in 1:2}, nominal = {300.0 for $f8 in 1:2})
	slice: {2, 3}
	[ALGB] (4) input Real[2, 2] pipe2.flowModel.states.T (start = {288.15 for $f9 in 1:2}, min = {190.0 for $f11 in 1:2}, max = {647.0 for $f10 in 1:2}, nominal = {300.0 for $f8 in 1:2})
	slice: {2, 3}
	[ALGB] (4) input Real[2, 2] pipe1.flowModel.states.T (start = {288.15 for $f9 in 1:2}, min = {190.0 for $f11 in 1:2}, max = {647.0 for $f10 in 1:2}, nominal = {300.0 for $f8 in 1:2})
	slice: {2, 3}
	[ALGB] (8) input Real[2, 2, 2] pipe6.flowModel.states.X (start = {{0.01, 0.99} for $f17 in 1:2}, min = {0.0 for $f20 in 1:2, $f21 in 1:2}, max = {1.0 for $f18 in 1:2, $f19 in 1:2}, nominal = {0.1 for $f15 in 1:2, $f16 in 1:2})
	slice: {4, 5, 6, 7}
	[ALGB] (8) input Real[2, 2, 2] pipe5.flowModel.states.X (start = {{0.01, 0.99} for $f17 in 1:2}, min = {0.0 for $f20 in 1:2, $f21 in 1:2}, max = {1.0 for $f18 in 1:2, $f19 in 1:2}, nominal = {0.1 for $f15 in 1:2, $f16 in 1:2})
	slice: {4, 5, 6, 7}
	[ALGB] (8) input Real[2, 2, 2] pipe4.flowModel.states.X (start = {{0.01, 0.99} for $f17 in 1:2}, min = {0.0 for $f20 in 1:2, $f21 in 1:2}, max = {1.0 for $f18 in 1:2, $f19 in 1:2}, nominal = {0.1 for $f15 in 1:2, $f16 in 1:2})
	slice: {4, 5, 6, 7}
	[ALGB] (8) input Real[2, 2, 2] pipe3.flowModel.states.X (start = {{0.01, 0.99} for $f17 in 1:2}, min = {0.0 for $f20 in 1:2, $f21 in 1:2}, max = {1.0 for $f18 in 1:2, $f19 in 1:2}, nominal = {0.1 for $f15 in 1:2, $f16 in 1:2})
	slice: {4, 5, 6, 7}
	[ALGB] (8) input Real[2, 2, 2] pipe2.flowModel.states.X (start = {{0.01, 0.99} for $f17 in 1:2}, min = {0.0 for $f20 in 1:2, $f21 in 1:2}, max = {1.0 for $f18 in 1:2, $f19 in 1:2}, nominal = {0.1 for $f15 in 1:2, $f16 in 1:2})
	slice: {4, 5, 6, 7}
	[ALGB] (8) input Real[2, 2, 2] pipe1.flowModel.states.X (start = {{0.01, 0.99} for $f17 in 1:2}, min = {0.0 for $f20 in 1:2, $f21 in 1:2}, max = {1.0 for $f18 in 1:2, $f19 in 1:2}, nominal = {0.1 for $f15 in 1:2, $f16 in 1:2})
	slice: {4, 5, 6, 7}
	[ALGB] (4) input Real[2, 2] pipe6.flowModel.states.p (start = {1e5 for $f2 in 1:2}, min = {0.0 for $f4 in 1:2}, max = {1e8 for $f3 in 1:2}, nominal = {1e5 for $f1 in 1:2})
	slice: {2, 3}
	[ALGB] (4) input Real[2, 2] pipe5.flowModel.states.p (start = {1e5 for $f2 in 1:2}, min = {0.0 for $f4 in 1:2}, max = {1e8 for $f3 in 1:2}, nominal = {1e5 for $f1 in 1:2})
	slice: {2, 3}
	[ALGB] (4) input Real[2, 2] pipe4.flowModel.states.p (start = {1e5 for $f2 in 1:2}, min = {0.0 for $f4 in 1:2}, max = {1e8 for $f3 in 1:2}, nominal = {1e5 for $f1 in 1:2})
	slice: {2, 3}
	[ALGB] (4) input Real[2, 2] pipe3.flowModel.states.p (start = {1e5 for $f2 in 1:2}, min = {0.0 for $f4 in 1:2}, max = {1e8 for $f3 in 1:2}, nominal = {1e5 for $f1 in 1:2})
	slice: {2, 3}
	[ALGB] (4) input Real[2, 2] pipe2.flowModel.states.p (start = {1e5 for $f2 in 1:2}, min = {0.0 for $f4 in 1:2}, max = {1e8 for $f3 in 1:2}, nominal = {1e5 for $f1 in 1:2})
	slice: {2, 3}
	[ALGB] (4) input Real[2, 2] pipe1.flowModel.states.p (start = {1e5 for $f2 in 1:2}, min = {0.0 for $f4 in 1:2}, max = {1e8 for $f3 in 1:2}, nominal = {1e5 for $f1 in 1:2})
	slice: {2, 3}

(0|0) Unmatched Equations
***************************
"
[Timeout remaining time 659]
[Calling sys.exit(0), Time elapsed: 3.740869216620922]