Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr BuildSysPro_BuildSysPro.IBPSA.Fluid.MixingVolumes.Validation.MixingVolumeMoistureReverseFlow.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.001397/0.001397, 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.001666/0.001666, allocations: 215 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.39/1.39, allocations: 230.7 MB / 256.9 MB, free: 7.723 MB / 206.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildSysPro 3.7.0/package.mo", uses=false) [Timeout 180]
"[/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildSysPro 3.7.0/Building/BuildingEnvelope/HeatTransfer/package.mo:2:1-40:17:writable] Warning: Soil_case_nappe was referenced in the package.order file, but was not found in package.mo, Soil_case_nappe/package.mo or Soil_case_nappe.mo.
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildSysPro 3.7.0/package.mo): time 0.8548/0.8548, allocations: 145 MB / 458.3 MB, free: 15.23 MB / 366.1 MB
"
[Timeout remaining time 179]
Using package BuildSysPro with version 3.6.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildSysPro 3.7.0/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(BuildSysPro.IBPSA.Fluid.MixingVolumes.Validation.MixingVolumeMoistureReverseFlow,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="BuildSysPro_BuildSysPro.IBPSA.Fluid.MixingVolumes.Validation.MixingVolumeMoistureReverseFlow")
translateModel(BuildSysPro.IBPSA.Fluid.MixingVolumes.Validation.MixingVolumeMoistureReverseFlow,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="BuildSysPro_BuildSysPro.IBPSA.Fluid.MixingVolumes.Validation.MixingVolumeMoistureReverseFlow") [Timeout 660]
"Notification: Performance of FrontEnd - Absyn->SCode: time 2.532e-05/2.532e-05, allocations: 5.641 kB / 0.6344 GB, free: 6.113 MB / 462.1 MB
Notification: Performance of NFInst.instantiate(BuildSysPro.IBPSA.Fluid.MixingVolumes.Validation.MixingVolumeMoistureReverseFlow): time 0.5456/0.5456, allocations: 196.1 MB / 0.8259 GB, free: 13.95 MB / 0.5762 GB
Notification: Performance of NFInst.instExpressions: time 0.009083/0.5547, allocations: 5.43 MB / 0.8312 GB, free: 9.633 MB / 0.5762 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001024/0.5557, allocations: 57.72 kB / 0.8313 GB, free: 9.602 MB / 0.5762 GB
Notification: Performance of NFTyping.typeComponents: time 0.001527/0.5572, allocations: 0.5543 MB / 0.8318 GB, free: 9.148 MB / 0.5762 GB
Notification: Performance of NFTyping.typeBindings: time 0.004783/0.562, allocations: 1.933 MB / 0.8337 GB, free: 7.656 MB / 0.5762 GB
Notification: Performance of NFTyping.typeClassSections: time 0.003095/0.5651, allocations: 1.201 MB / 0.8349 GB, free: 6.746 MB / 0.5762 GB
Notification: Performance of NFFlatten.flatten: time 0.004251/0.5693, allocations: 3.486 MB / 0.8383 GB, free: 4.715 MB / 0.5762 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.001354/0.5707, allocations: 0.9132 MB / 0.8392 GB, free: 4.051 MB / 0.5762 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.002229/0.5729, allocations: 1.367 MB / 0.8405 GB, free: 3.258 MB / 0.5762 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.002148/0.5751, allocations: 1.007 MB / 0.8415 GB, free: 2.707 MB / 0.5762 GB
Notification: Performance of NFPackage.collectConstants: time 0.0001765/0.5753, allocations: 104 kB / 0.8416 GB, free: 2.707 MB / 0.5762 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.002545/0.5778, allocations: 1.179 MB / 0.8427 GB, free: 2.074 MB / 0.5762 GB
Notification: Performance of combineBinaries: time 0.002328/0.5801, allocations: 2.581 MB / 0.8453 GB, free: 324 kB / 0.5762 GB
Notification: Performance of replaceArrayConstructors: time 0.001312/0.5814, allocations: 1.593 MB / 0.8468 GB, free: 15.21 MB / 0.5919 GB
Notification: Performance of NFVerifyModel.verify: time 0.0002693/0.5817, allocations: 109.1 kB / 0.8469 GB, free: 15.21 MB / 0.5919 GB
Notification: Performance of FrontEnd: time 0.0002348/0.5819, allocations: 46.66 kB / 0.847 GB, free: 15.19 MB / 0.5919 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 215 (195)
 * Number of variables: 215 (180)
Notification: Performance of [SIM] Bindings: time 0.006423/0.5884, allocations: 6.339 MB / 0.8532 GB, free: 10.83 MB / 0.5919 GB
Notification: Performance of [SIM] FunctionAlias: time 0.000769/0.5891, allocations: 0.6371 MB / 0.8538 GB, free: 10.35 MB / 0.5919 GB
Notification: Performance of [SIM] Early Inline: time 0.003315/0.5925, allocations: 3.036 MB / 0.8567 GB, free: 7.457 MB / 0.5919 GB
Notification: Performance of [SIM] Simplify 1: time 0.000936/0.5934, allocations: 0.5218 MB / 0.8572 GB, free: 6.867 MB / 0.5919 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.00675/0.6001, allocations: 4.423 MB / 0.8616 GB, free: 2.109 MB / 0.5919 GB
Notification: Performance of [SIM] Simplify 2: time 0.0007189/0.6009, allocations: 438.3 kB / 0.862 GB, free: 1.621 MB / 0.5919 GB
Notification: Performance of [SIM] Remove Stream: time 0.000371/0.6012, allocations: 293.3 kB / 0.8623 GB, free: 1.305 MB / 0.5919 GB
Notification: Performance of [SIM] Detect States: time 0.0007242/0.602, allocations: 0.6022 MB / 0.8629 GB, free: 0.6406 MB / 0.5919 GB
Notification: Performance of [SIM] Events: time 0.0003212/0.6023, allocations: 208.1 kB / 0.8631 GB, free: 448 kB / 0.5919 GB
Notification: Performance of [SIM] Partitioning: time 0.001046/0.6033, allocations: 0.8474 MB / 0.8639 GB, free: 15.57 MB / 0.6075 GB
Notification: Performance of [SIM] Causalize: time 0.00619/0.6095, allocations: 4.285 MB / 0.8681 GB, free: 11.17 MB / 0.6075 GB
Notification: Performance of [SIM] After Index Reduction Inline: time 0.00208/0.6116, allocations: 1.971 MB / 0.87 GB, free: 9.195 MB / 0.6075 GB
Notification: Performance of [INI] Simplify: time 0.002777/0.6144, allocations: 1.451 MB / 0.8714 GB, free: 7.637 MB / 0.6075 GB
Notification: Performance of [INI] Inline: time 0.004005/0.6184, allocations: 3.764 MB / 0.8751 GB, free: 3.859 MB / 0.6075 GB
Notification: Performance of [INI] Partitioning: time 0.0001459/0.6185, allocations: 60 kB / 0.8751 GB, free: 3.785 MB / 0.6075 GB
Notification: Performance of [INI] Cleanup: time 0.0005097/0.619, allocations: 491.5 kB / 0.8756 GB, free: 3.305 MB / 0.6075 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_289);
Notification: Performance of [INI] Causalize: time 0.007512/0.6265, allocations: 5.219 MB / 0.8807 GB, free: 13.99 MB / 0.6231 GB
Notification: Performance of [INI] Tearing: time 0.0001911/0.6267, allocations: 156 kB / 0.8809 GB, free: 13.84 MB / 0.6231 GB
Notification: Performance of [SIM] Initialization: time 9.42e-07/0.6267, allocations: 0 / 0.8809 GB, free: 13.84 MB / 0.6231 GB
Notification: Performance of [SIM] DAE-Mode: time 0.0009663/0.6277, allocations: 0.5739 MB / 0.8814 GB, free: 13.25 MB / 0.6231 GB
Notification: Performance of [SIM] Remove Dummies: time 1.104e-05/0.6277, allocations: 9 kB / 0.8814 GB, free: 13.24 MB / 0.6231 GB
Notification: Performance of [SIM] Tearing: time 0.0001644/0.6279, allocations: 187.9 kB / 0.8816 GB, free: 13.06 MB / 0.6231 GB
Notification: Performance of [SIM] Categorize: time 2.082e-05/0.6279, allocations: 7.984 kB / 0.8816 GB, free: 13.05 MB / 0.6231 GB
Notification: Performance of [SIM] Solve: time 0.004153/0.632, allocations: 2.823 MB / 0.8844 GB, free: 10.23 MB / 0.6231 GB
Error: Internal error NBJacobian.SparsityColoring.PartialD2ColoringAlgC.getIndices failed because cref $DER.volDyn.dynBal.medium.p_bar is neither a seed nor a partial candidate!
"
[Timeout remaining time 659]
[Calling sys.exit(0), Time elapsed: 4.024285908963066]
Failed to read output from testmodel.py, exit status != 0:
0.6413407170330174 0.654831956 0.069899628
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7fbf13366fb0>