Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr BuildingSystems_BuildingSystems.Fluid.MixingVolumes.Validation.MixingVolumeHeatReverseFlow.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.001203/0.001203, allocations: 104.3 kB / 19.77 MB, free: 2.051 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.001263/0.001263, allocations: 215.8 kB / 23.07 MB, free: 4.844 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.35/1.35, allocations: 230.7 MB / 256.9 MB, free: 7.766 MB / 206.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/NcDataReader2 master/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/NcDataReader2 master/package.mo): time 0.002362/0.002362, allocations: 303.9 kB / 313.6 MB, free: 2.566 MB / 238.1 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildingSystems master/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildingSystems master/package.mo): time 1.166/1.166, allocations: 180.7 MB / 0.5378 GB, free: 14.49 MB / 382.1 MB
"
[Timeout remaining time 179]
Using package BuildingSystems with version 2.0.0-beta (/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildingSystems master/package.mo)
Using package NcDataReader2 with version 2.5.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/NcDataReader2 master/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(BuildingSystems.Fluid.MixingVolumes.Validation.MixingVolumeHeatReverseFlow,tolerance=1e-08,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="BuildingSystems_BuildingSystems.Fluid.MixingVolumes.Validation.MixingVolumeHeatReverseFlow")
translateModel(BuildingSystems.Fluid.MixingVolumes.Validation.MixingVolumeHeatReverseFlow,tolerance=1e-08,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="BuildingSystems_BuildingSystems.Fluid.MixingVolumes.Validation.MixingVolumeHeatReverseFlow") [Timeout 660]
"Notification: Performance of FrontEnd - Absyn->SCode: time 1.956e-05/1.956e-05, allocations: 2.281 kB / 0.7408 GB, free: 27.77 MB / 0.5294 GB
Notification: Performance of NFInst.instantiate(BuildingSystems.Fluid.MixingVolumes.Validation.MixingVolumeHeatReverseFlow): time 0.2113/0.2113, allocations: 168.5 MB / 0.9053 GB, free: 14.28 MB / 0.6544 GB
Notification: Performance of NFInst.instExpressions: time 0.01034/0.2216, allocations: 5.434 MB / 0.9106 GB, free: 8.836 MB / 0.6544 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001431/0.2231, allocations: 59.5 kB / 0.9107 GB, free: 8.777 MB / 0.6544 GB
Notification: Performance of NFTyping.typeComponents: time 0.00182/0.2249, allocations: 0.563 MB / 0.9112 GB, free: 8.211 MB / 0.6544 GB
Notification: Performance of NFTyping.typeBindings: time 0.005282/0.2302, allocations: 1.921 MB / 0.9131 GB, free: 6.281 MB / 0.6544 GB
Notification: Performance of NFTyping.typeClassSections: time 0.003358/0.2335, allocations: 1.208 MB / 0.9143 GB, free: 5.078 MB / 0.6544 GB
Notification: Performance of NFFlatten.flatten: time 0.004855/0.2384, allocations: 3.496 MB / 0.9177 GB, free: 1.578 MB / 0.6544 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.001704/0.2401, allocations: 0.8841 MB / 0.9186 GB, free: 0.6836 MB / 0.6544 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.002832/0.2429, allocations: 1.359 MB / 0.9199 GB, free: 15.32 MB / 0.67 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.002358/0.2453, allocations: 0.9777 MB / 0.9209 GB, free: 14.34 MB / 0.67 GB
Notification: Performance of NFPackage.collectConstants: time 0.0003116/0.2456, allocations: 104 kB / 0.921 GB, free: 14.24 MB / 0.67 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.002771/0.2484, allocations: 1.176 MB / 0.9221 GB, free: 13.06 MB / 0.67 GB
Notification: Performance of combineBinaries: time 0.00317/0.2515, allocations: 2.577 MB / 0.9246 GB, free: 10.46 MB / 0.67 GB
Notification: Performance of replaceArrayConstructors: time 0.001731/0.2533, allocations: 1.6 MB / 0.9262 GB, free: 8.852 MB / 0.67 GB
Notification: Performance of NFVerifyModel.verify: time 0.0005152/0.2538, allocations: 112 kB / 0.9263 GB, free: 8.742 MB / 0.67 GB
Notification: Performance of FrontEnd: time 0.0002072/0.254, allocations: 39.8 kB / 0.9263 GB, free: 8.703 MB / 0.67 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 213 (193)
 * Number of variables: 213 (178)
Notification: Performance of [SIM] Bindings: time 0.007486/0.2615, allocations: 6.307 MB / 0.9325 GB, free: 2.188 MB / 0.67 GB
Notification: Performance of [SIM] FunctionAlias: time 0.001009/0.2625, allocations: 0.6532 MB / 0.9331 GB, free: 1.531 MB / 0.67 GB
Notification: Performance of [SIM] Early Inline: time 0.003858/0.2663, allocations: 3.014 MB / 0.9361 GB, free: 14.48 MB / 0.6856 GB
Notification: Performance of [SIM] Simplify 1: time 0.00092/0.2672, allocations: 0.5145 MB / 0.9366 GB, free: 13.89 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.006606/0.2739, allocations: 4.434 MB / 0.9409 GB, free: 9.098 MB / 0.6856 GB
Notification: Performance of [SIM] Simplify 2: time 0.00067/0.2745, allocations: 455.9 kB / 0.9413 GB, free: 8.594 MB / 0.6856 GB
Notification: Performance of [SIM] Remove Stream: time 0.0003542/0.2749, allocations: 285.3 kB / 0.9416 GB, free: 8.285 MB / 0.6856 GB
Notification: Performance of [SIM] Detect States: time 0.0007162/0.2756, allocations: 0.5845 MB / 0.9422 GB, free: 7.641 MB / 0.6856 GB
Notification: Performance of [SIM] Events: time 0.0004002/0.276, allocations: 211.7 kB / 0.9424 GB, free: 7.434 MB / 0.6856 GB
Notification: Performance of [SIM] Partitioning: time 0.001081/0.2771, allocations: 0.8547 MB / 0.9432 GB, free: 6.551 MB / 0.6856 GB
Notification: Performance of [SIM] Causalize: time 0.006005/0.2831, allocations: 4.294 MB / 0.9474 GB, free: 2.137 MB / 0.6856 GB
Notification: Performance of [SIM] After Index Reduction Inline: time 0.001978/0.2851, allocations: 1.967 MB / 0.9493 GB, free: 172 kB / 0.6856 GB
Notification: Performance of [INI] Simplify: time 0.002629/0.2877, allocations: 1.448 MB / 0.9507 GB, free: 14.61 MB / 0.7012 GB
Notification: Performance of [INI] Inline: time 0.003969/0.2917, allocations: 3.775 MB / 0.9544 GB, free: 10.82 MB / 0.7012 GB
Notification: Performance of [INI] Partitioning: time 0.0001559/0.2918, allocations: 63.98 kB / 0.9545 GB, free: 10.74 MB / 0.7012 GB
Notification: Performance of [INI] Cleanup: time 0.0005562/0.2924, allocations: 495.5 kB / 0.955 GB, free: 10.26 MB / 0.7012 GB
Warning: NBResolveSingularities.balanceInitialization reports an overdetermined initialization!
Checking for consistency is not yet supported, following equations had to be removed:
	[SCAL] (1) volDyn.dynBal.p_start = volDyn.p_start ($RES_BND_285);
Notification: Performance of [INI] Causalize: time 0.00744/0.2998, allocations: 5.232 MB / 0.9601 GB, free: 4.926 MB / 0.7012 GB
Notification: Performance of [INI] Tearing: time 0.0002376/0.3, allocations: 192.2 kB / 0.9603 GB, free: 4.742 MB / 0.7012 GB
Notification: Performance of [SIM] Initialization: time 2.084e-06/0.3, allocations: 4 kB / 0.9603 GB, free: 4.738 MB / 0.7012 GB
Notification: Performance of [SIM] DAE-Mode: time 0.0009527/0.301, allocations: 0.5632 MB / 0.9608 GB, free: 4.16 MB / 0.7012 GB
Notification: Performance of [SIM] Remove Dummies: time 1.025e-05/0.301, allocations: 5 kB / 0.9608 GB, free: 4.156 MB / 0.7012 GB
Notification: Performance of [SIM] Tearing: time 0.0002063/0.3012, allocations: 222.9 kB / 0.961 GB, free: 3.941 MB / 0.7012 GB
Notification: Performance of [SIM] Categorize: time 2.025e-05/0.3012, allocations: 8 kB / 0.961 GB, free: 3.934 MB / 0.7012 GB
Notification: Performance of [SIM] Solve: time 0.004151/0.3054, allocations: 2.819 MB / 0.9638 GB, free: 1.125 MB / 0.7012 GB
Error: Internal error NBJacobian.SparsityColoring.PartialD2ColoringAlgC.getIndices failed because cref volDyn.ports[1].p is neither a seed nor a partial candidate!
"
[Timeout remaining time 660]
[Calling sys.exit(0), Time elapsed: 4.070946030027699]
Failed to read output from testmodel.py, exit status != 0:
0.3137695490149781 0.32827192899999996 0.071272102
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7fcde9056fb0>