Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_latest_Buildings.Fluid.Storage.Ice.Validation.ExperimentNIST.Discharging3.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.001519/0.001519, allocations: 104.3 kB / 19.76 MB, free: 1.906 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.001604/0.001604, allocations: 215.2 kB / 23.06 MB, free: 4.984 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.357/1.357, allocations: 230.7 MB / 256.9 MB, free: 7.949 MB / 206.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings master/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings master/package.mo): time 3.01/3.01, allocations: 0.5108 GB / 0.8167 GB, free: 17.71 MB / 0.6231 GB
"
[Timeout remaining time 177]
Using package Buildings with version 13.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 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(Buildings.Fluid.Storage.Ice.Validation.ExperimentNIST.Discharging3,tolerance=1e-06,outputFormat="mat",numberOfIntervals=4488,variableFilter="time|dat.y.1.|TIn.Celsius|dat.y.2.|TOut.T|dat.y.3.|iceTan.m_flow|dat.y.4.|iceTan.SOC",fileNamePrefix="Buildings_latest_Buildings.Fluid.Storage.Ice.Validation.ExperimentNIST.Discharging3")
translateModel(Buildings.Fluid.Storage.Ice.Validation.ExperimentNIST.Discharging3,tolerance=1e-06,outputFormat="mat",numberOfIntervals=4488,variableFilter="time|dat.y.1.|TIn.Celsius|dat.y.2.|TOut.T|dat.y.3.|iceTan.m_flow|dat.y.4.|iceTan.SOC",fileNamePrefix="Buildings_latest_Buildings.Fluid.Storage.Ice.Validation.ExperimentNIST.Discharging3") [Timeout 300]
"Notification: Performance of FrontEnd - Absyn->SCode: time 1.535e-05/1.535e-05, allocations: 2.281 kB / 1.187 GB, free: 13.54 MB / 0.9044 GB
Notification: Performance of NFInst.instantiate(Buildings.Fluid.Storage.Ice.Validation.ExperimentNIST.Discharging3): time 0.05261/0.05263, allocations: 49.99 MB / 1.236 GB, free: 10.7 MB / 0.9356 GB
Notification: Performance of NFInst.instExpressions: time 0.01389/0.06652, allocations: 8.685 MB / 1.244 GB, free: 3.855 MB / 0.9356 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001736/0.06825, allocations: 60.69 kB / 1.245 GB, free: 3.824 MB / 0.9356 GB
Notification: Performance of NFTyping.typeComponents: time 0.001604/0.06986, allocations: 0.5387 MB / 1.245 GB, free: 3.375 MB / 0.9356 GB
Notification: Performance of NFTyping.typeBindings: time 0.003986/0.07384, allocations: 1.454 MB / 1.246 GB, free: 2.227 MB / 0.9356 GB
Notification: Performance of NFTyping.typeClassSections: time 0.003119/0.07696, allocations: 1.216 MB / 1.248 GB, free: 1.293 MB / 0.9356 GB
Notification: Performance of NFFlatten.flatten: time 0.00438/0.08134, allocations: 3.375 MB / 1.251 GB, free: 15.23 MB / 0.9512 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.001489/0.08283, allocations: 1.022 MB / 1.252 GB, free: 14.47 MB / 0.9512 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.007244/0.09008, allocations: 3.076 MB / 1.255 GB, free: 12.57 MB / 0.9512 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.001696/0.09177, allocations: 0.8185 MB / 1.256 GB, free: 12.07 MB / 0.9512 GB
Notification: Performance of NFPackage.collectConstants: time 0.0002088/0.09198, allocations: 124 kB / 1.256 GB, free: 12.07 MB / 0.9512 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.003115/0.0951, allocations: 1.394 MB / 1.257 GB, free: 11.38 MB / 0.9512 GB
Notification: Performance of combineBinaries: time 0.002332/0.09743, allocations: 2.71 MB / 1.26 GB, free: 8.98 MB / 0.9512 GB
Notification: Performance of replaceArrayConstructors: time 0.001214/0.09864, allocations: 1.711 MB / 1.262 GB, free: 7.25 MB / 0.9512 GB
Notification: Performance of NFVerifyModel.verify: time 0.0002322/0.09888, allocations: 104 kB / 1.262 GB, free: 7.148 MB / 0.9512 GB
Notification: Performance of FrontEnd: time 0.0003423/0.09922, allocations: 55.61 kB / 1.262 GB, free: 7.094 MB / 0.9512 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 189 (182)
 * Number of variables: 189 (179)
Notification: Performance of [SIM] Bindings: time 0.006153/0.1054, allocations: 6.254 MB / 1.268 GB, free: 0.6133 MB / 0.9512 GB
Notification: Performance of [SIM] FunctionAlias: time 0.0006628/0.106, allocations: 0.5778 MB / 1.268 GB, free: 16 kB / 0.9512 GB
Notification: Performance of [SIM] Early Inline: time 0.00362/0.1097, allocations: 3.462 MB / 1.272 GB, free: 12.51 MB / 0.9669 GB
Notification: Performance of [SIM] Simplify 1: time 0.001298/0.111, allocations: 0.931 MB / 1.273 GB, free: 11.51 MB / 0.9669 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.007053/0.118, allocations: 5.063 MB / 1.278 GB, free: 6.008 MB / 0.9669 GB
Notification: Performance of [SIM] Simplify 2: time 0.0007924/0.1188, allocations: 0.5451 MB / 1.278 GB, free: 5.406 MB / 0.9669 GB
Notification: Performance of [SIM] Remove Stream: time 0.0002662/0.1191, allocations: 229.4 kB / 1.278 GB, free: 5.156 MB / 0.9669 GB
Notification: Performance of [SIM] Detect States: time 0.0006953/0.1198, allocations: 0.5989 MB / 1.279 GB, free: 4.5 MB / 0.9669 GB
Notification: Performance of [SIM] Events: time 0.0004527/0.1202, allocations: 319.8 kB / 1.279 GB, free: 4.199 MB / 0.9669 GB
Notification: Performance of [SIM] Partitioning: time 0.0011/0.1213, allocations: 0.8743 MB / 1.28 GB, free: 3.293 MB / 0.9669 GB
Notification: Performance of [SIM] Causalize: time 0.004234/0.1255, allocations: 2.942 MB / 1.283 GB, free: 256 kB / 0.9669 GB
Notification: Performance of [SIM] After Index Reduction Inline: time 0.00193/0.1275, allocations: 1.983 MB / 1.285 GB, free: 14.27 MB / 0.9825 GB
Notification: Performance of [INI] Simplify: time 0.004003/0.1315, allocations: 1.731 MB / 1.287 GB, free: 12.47 MB / 0.9825 GB
Notification: Performance of [INI] Inline: time 0.003458/0.1349, allocations: 3.444 MB / 1.29 GB, free: 9.016 MB / 0.9825 GB
Notification: Performance of [INI] Partitioning: time 0.0001272/0.1351, allocations: 64.06 kB / 1.29 GB, free: 8.938 MB / 0.9825 GB
Notification: Performance of [INI] Cleanup: time 0.0006908/0.1358, allocations: 0.7103 MB / 1.291 GB, free: 8.219 MB / 0.9825 GB
Notification: Performance of [INI] Causalize: time 0.01766/0.1534, allocations: 12.51 MB / 1.303 GB, free: 11.5 MB / 0.9981 GB
Notification: Performance of [INI] Tearing: time 0.0001437/0.1536, allocations: 176.1 kB / 1.303 GB, free: 11.33 MB / 0.9981 GB
Notification: Performance of [SIM] Initialization: time 1.212e-06/0.1536, allocations: 4 kB / 1.303 GB, free: 11.32 MB / 0.9981 GB
Notification: Performance of [SIM] DAE-Mode: time 0.0009032/0.1545, allocations: 0.7058 MB / 1.304 GB, free: 10.63 MB / 0.9981 GB
Notification: Performance of [SIM] Remove Dummies: time 9.538e-06/0.1545, allocations: 5 kB / 1.304 GB, free: 10.62 MB / 0.9981 GB
Notification: Performance of [SIM] Tearing: time 8.544e-05/0.1546, allocations: 84 kB / 1.304 GB, free: 10.54 MB / 0.9981 GB
Notification: Performance of [SIM] Categorize: time 1.577e-05/0.1546, allocations: 4 kB / 1.304 GB, free: 10.54 MB / 0.9981 GB
Notification: Performance of [SIM] Solve: time 0.004498/0.1591, allocations: 3.539 MB / 1.307 GB, free: 7.035 MB / 0.9981 GB
Error: Internal error NBJacobian.SparsityColoring.PartialD2ColoringAlgC.getIndices failed because cref dat.y[3] is neither a seed nor a partial candidate!
"
[Timeout remaining time 300]
[Calling sys.exit(0), Time elapsed: 6.143089983961545]
Failed to read output from testmodel.py, exit status != 0:
0.16706342599354684 0.181155229 0.078955471
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7fbc7cb8afb0>