Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IBPSA_latest_IBPSA.Examples.Tutorial.SimpleHouse.SimpleHouse1.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.001344/0.001344, allocations: 96.41 kB / 20.52 MB, free: 1.145 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.001446/0.001446, allocations: 214.4 kB / 23.81 MB, free: 4.336 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.392/1.392, allocations: 230.7 MB / 257.6 MB, free: 7.738 MB / 206.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA master/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA master/package.mo): time 0.9256/0.9256, allocations: 149.9 MB / 463.9 MB, free: 10.29 MB / 366.1 MB
"
[Timeout remaining time 179]
Using package IBPSA with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 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(IBPSA.Examples.Tutorial.SimpleHouse.SimpleHouse1,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="IBPSA_latest_IBPSA.Examples.Tutorial.SimpleHouse.SimpleHouse1")
translateModel(IBPSA.Examples.Tutorial.SimpleHouse.SimpleHouse1,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="IBPSA_latest_IBPSA.Examples.Tutorial.SimpleHouse.SimpleHouse1") [Timeout 660]
"Notification: Performance of FrontEnd - Absyn->SCode: time 2.129e-05/2.129e-05, allocations: 4.953 kB / 0.6424 GB, free: 9.629 MB / 478.1 MB
Notification: Performance of NFInst.instantiate(IBPSA.Examples.Tutorial.SimpleHouse.SimpleHouse1): time 0.007345/0.007366, allocations: 4.648 MB / 0.6469 GB, free: 4.98 MB / 478.1 MB
Notification: Performance of NFInst.instExpressions: time 0.5606/0.5679, allocations: 132.7 MB / 0.7765 GB, free: 7.285 MB / 0.5762 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0009695/0.5689, allocations: 22.69 kB / 0.7765 GB, free: 7.285 MB / 0.5762 GB
Notification: Performance of NFTyping.typeComponents: time 0.0006072/0.5695, allocations: 203.4 kB / 0.7767 GB, free: 7.285 MB / 0.5762 GB
Notification: Performance of NFTyping.typeBindings: time 0.001736/0.5712, allocations: 0.5784 MB / 0.7773 GB, free: 7.27 MB / 0.5762 GB
Notification: Performance of NFTyping.typeClassSections: time 0.00186/0.5731, allocations: 0.8728 MB / 0.7782 GB, free: 7.262 MB / 0.5762 GB
Notification: Performance of NFFlatten.flatten: time 0.001729/0.5748, allocations: 1.565 MB / 0.7797 GB, free: 7.246 MB / 0.5762 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.0007295/0.5755, allocations: 393.6 kB / 0.7801 GB, free: 7.18 MB / 0.5762 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.000855/0.5764, allocations: 0.5795 MB / 0.7806 GB, free: 7.176 MB / 0.5762 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.0005426/0.5769, allocations: 442.2 kB / 0.781 GB, free: 7.176 MB / 0.5762 GB
Notification: Performance of NFPackage.collectConstants: time 0.0001731/0.5771, allocations: 106.1 kB / 0.7811 GB, free: 7.176 MB / 0.5762 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.001046/0.5782, allocations: 480 kB / 0.7816 GB, free: 7.164 MB / 0.5762 GB
Notification: Performance of combineBinaries: time 0.001643/0.5798, allocations: 2.027 MB / 0.7836 GB, free: 6.633 MB / 0.5762 GB
Notification: Performance of replaceArrayConstructors: time 0.0008497/0.5807, allocations: 1.233 MB / 0.7848 GB, free: 6.004 MB / 0.5762 GB
Notification: Performance of NFVerifyModel.verify: time 0.0002205/0.5809, allocations: 83.28 kB / 0.7849 GB, free: 6.004 MB / 0.5762 GB
Notification: Performance of FrontEnd: time 0.0002367/0.5811, allocations: 49.94 kB / 0.7849 GB, free: 5.992 MB / 0.5762 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 219 (192)
 * Number of variables: 219 (192)
Notification: Performance of [SIM] Bindings: time 0.00398/0.5851, allocations: 4.487 MB / 0.7893 GB, free: 4.098 MB / 0.5762 GB
Notification: Performance of [SIM] FunctionAlias: time 0.0005022/0.5856, allocations: 476.7 kB / 0.7898 GB, free: 4.043 MB / 0.5762 GB
Notification: Performance of [SIM] Early Inline: time 0.002712/0.5883, allocations: 2.734 MB / 0.7924 GB, free: 3.938 MB / 0.5762 GB
Notification: Performance of [SIM] Simplify 1: time 0.0009311/0.5892, allocations: 478.9 kB / 0.7929 GB, free: 3.734 MB / 0.5762 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.006287/0.5955, allocations: 4.641 MB / 0.7974 GB, free: 2.555 MB / 0.5762 GB
Notification: Performance of [SIM] Simplify 2: time 0.0004139/0.5959, allocations: 321.2 kB / 0.7977 GB, free: 2.414 MB / 0.5762 GB
Notification: Performance of [SIM] Remove Stream: time 0.000165/0.5961, allocations: 185.2 kB / 0.7979 GB, free: 2.348 MB / 0.5762 GB
Notification: Performance of [SIM] Detect States: time 0.0004133/0.5965, allocations: 432 kB / 0.7983 GB, free: 2.219 MB / 0.5762 GB
Notification: Performance of [SIM] Events: time 0.0002399/0.5968, allocations: 180.1 kB / 0.7985 GB, free: 2.172 MB / 0.5762 GB
Notification: Performance of [SIM] Partitioning: time 0.0006052/0.5974, allocations: 0.6867 MB / 0.7991 GB, free: 2 MB / 0.5762 GB
Notification: Performance of [SIM] Causalize: time 0.001527/0.5989, allocations: 1.424 MB / 0.8005 GB, free: 1.754 MB / 0.5762 GB
Notification: Performance of [SIM] After Index Reduction Inline: time 0.000914/0.5998, allocations: 1.297 MB / 0.8018 GB, free: 1.746 MB / 0.5762 GB
Notification: Performance of [INI] Simplify: time 0.004511/0.6043, allocations: 1.579 MB / 0.8033 GB, free: 1.266 MB / 0.5762 GB
Notification: Performance of [INI] Inline: time 0.001916/0.6062, allocations: 2.545 MB / 0.8058 GB, free: 1.18 MB / 0.5762 GB
Notification: Performance of [INI] Partitioning: time 8.815e-05/0.6063, allocations: 63.88 kB / 0.8059 GB, free: 1.133 MB / 0.5762 GB
Notification: Performance of [INI] Cleanup: time 0.000316/0.6066, allocations: 387 kB / 0.8063 GB, free: 1.133 MB / 0.5762 GB
Notification: Performance of [INI] Causalize: time 0.004832/0.6115, allocations: 4.303 MB / 0.8105 GB, free: 0.6367 MB / 0.5762 GB
Notification: Performance of [INI] Tearing: time 0.0001343/0.6116, allocations: 128.4 kB / 0.8106 GB, free: 0.582 MB / 0.5762 GB
Notification: Performance of [SIM] Initialization: time 9.81e-07/0.6116, allocations: 2.25 kB / 0.8106 GB, free: 0.582 MB / 0.5762 GB
Notification: Performance of [SIM] DAE-Mode: time 0.0005524/0.6122, allocations: 493.9 kB / 0.8111 GB, free: 332 kB / 0.5762 GB
Notification: Performance of [SIM] Remove Dummies: time 9.418e-06/0.6122, allocations: 4.875 kB / 0.8111 GB, free: 332 kB / 0.5762 GB
Notification: Performance of [SIM] Tearing: time 8.869e-05/0.6123, allocations: 118.5 kB / 0.8112 GB, free: 284 kB / 0.5762 GB
Notification: Performance of [SIM] Categorize: time 2.305e-05/0.6123, allocations: 5.406 kB / 0.8112 GB, free: 284 kB / 0.5762 GB
Notification: Performance of [SIM] Solve: time 0.001934/0.6142, allocations: 1.727 MB / 0.8129 GB, free: 96 kB / 0.5762 GB
Error: Internal error NBJacobian.SparsityColoring.PartialD2ColoringAlgC.getIndices failed because cref weaDat.datRea.y[16] is neither a seed nor a partial candidate!
"
[Timeout remaining time 659]
[Calling sys.exit(0), Time elapsed: 4.034857195045333]
Failed to read output from testmodel.py, exit status != 0:
0.6225282330415212 0.6342477559999999 0.050490221
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7fe83bb86fb0>