Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_12_Buildings.Air.Systems.SingleZone.VAV.Examples.OptimalStart.ConventionalWinter.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.00144/0.00144, 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.001538/0.001538, allocations: 215.9 kB / 23.06 MB, free: 4.848 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.305/1.305, allocations: 230.7 MB / 256.9 MB, free: 7.719 MB / 206.1 MB
"
[Timeout remaining time 179]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.1.1-maint.12.x/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.1.1-maint.12.x/package.mo): time 2.833/2.833, allocations: 0.4893 GB / 0.7952 GB, free: 35.43 MB / 0.6231 GB
"
[Timeout remaining time 177]
Using package Buildings with version 12.1.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.1.1-maint.12.x/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.Air.Systems.SingleZone.VAV.Examples.OptimalStart.ConventionalWinter,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|TSetRooHea.y.1.|TSetRooCoo.y.1.|zonAHUOpt.TZon|zonAHUCon.TZon|optSta.tOpt",fileNamePrefix="Buildings_12_Buildings.Air.Systems.SingleZone.VAV.Examples.OptimalStart.ConventionalWinter")
translateModel(Buildings.Air.Systems.SingleZone.VAV.Examples.OptimalStart.ConventionalWinter,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|TSetRooHea.y.1.|TSetRooCoo.y.1.|zonAHUOpt.TZon|zonAHUCon.TZon|optSta.tOpt",fileNamePrefix="Buildings_12_Buildings.Air.Systems.SingleZone.VAV.Examples.OptimalStart.ConventionalWinter") [Timeout 300]
"Notification: Performance of FrontEnd - Absyn->SCode: time 1.731e-05/1.731e-05, allocations: 4.25 kB / 1.154 GB, free: 25.5 MB / 0.9044 GB
Notification: Performance of NFInst.instantiate(Buildings.Air.Systems.SingleZone.VAV.Examples.OptimalStart.ConventionalWinter): time 1.597/1.597, allocations: 0.8658 GB / 2.02 GB, free: 2.852 MB / 1.42 GB
Notification: Performance of NFInst.instExpressions: time 0.2989/1.896, allocations: 196.7 MB / 2.212 GB, free: 13.7 MB / 1.623 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.04582/1.941, allocations: 1.717 MB / 2.214 GB, free: 11.97 MB / 1.623 GB
Notification: Performance of NFTyping.typeComponents: time 0.9787/2.92, allocations: 22.26 MB / 2.236 GB, free: 10.64 MB / 1.623 GB
Notification: Performance of NFTyping.typeBindings: time 0.1002/3.02, allocations: 38.56 MB / 2.273 GB, free: 10.25 MB / 1.623 GB
Notification: Performance of NFTyping.typeClassSections: time 0.06069/3.081, allocations: 28.85 MB / 2.302 GB, free: 9.727 MB / 1.623 GB
Notification: Performance of NFFlatten.flatten: time 0.1952/3.276, allocations: 202.6 MB / 2.499 GB, free: 8.234 MB / 1.654 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.09809/3.374, allocations: 47.77 MB / 2.546 GB, free: 10.09 MB / 1.701 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.1485/3.523, allocations: 80.09 MB / 2.624 GB, free: 0.8281 MB / 1.764 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.09217/3.615, allocations: 54.44 MB / 2.677 GB, free: 14.93 MB / 1.826 GB
Notification: Performance of NFPackage.collectConstants: time 0.02371/3.639, allocations: 7.711 MB / 2.685 GB, free: 7.219 MB / 1.826 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.08604/3.725, allocations: 31.57 MB / 2.716 GB, free: 10.94 MB / 1.857 GB
Notification: Performance of combineBinaries: time 0.1993/3.924, allocations: 152.9 MB / 2.865 GB, free: 9.016 MB / 1.998 GB
Notification: Performance of replaceArrayConstructors: time 0.09492/4.019, allocations: 81.79 MB / 2.945 GB, free: 10.88 MB / 2.076 GB
Notification: Performance of NFVerifyModel.verify: time 0.02997/4.049, allocations: 3.95 MB / 2.949 GB, free: 6.922 MB / 2.076 GB
Notification: Performance of FrontEnd: time 0.009679/4.059, allocations: 1.335 MB / 2.95 GB, free: 5.863 MB / 2.076 GB
Error: Internal error NBackendDAE.lowerVariable failed for protected final parameter Real[3, 1, ({{2}, {4}, {2}})[$conPar1, $lay1]] zonAHUCon.sinZonFlo.flo.conPar.opa.lay.CInv = {{1.0 / zonAHUCon.sinZonFlo.flo.conPar[$conPar1].opa.lay[$lay1].C[i] for i in 1:({{2}, {4}, {2}})[$conPar1, $lay1]} for $lay1 in 1:1, $conPar1 in 1:3}
"
[Timeout remaining time 296]
[Calling sys.exit(0), Time elapsed: 9.826699343975633]
Failed to read output from testmodel.py, exit status != 0:
4.0806981270434335 4.093611891 0.031402718
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f02dfd46fb0>