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.001416/0.001416, allocations: 104.3 kB / 19.72 MB, free: 2.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.00156/0.00156, allocations: 209.8 kB / 23 MB, free: 4.961 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.309/1.309, allocations: 230.6 MB / 256.8 MB, free: 7.812 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.836/2.836, allocations: 0.49 GB / 0.7958 GB, free: 35.46 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.967e-05/1.967e-05, allocations: 2.281 kB / 1.155 GB, free: 25.24 MB / 0.9044 GB
Notification: Performance of NFInst.instantiate(Buildings.Air.Systems.SingleZone.VAV.Examples.OptimalStart.ConventionalWinter): time 1.515/1.515, allocations: 0.8658 GB / 2.021 GB, free: 1.848 MB / 1.42 GB
Notification: Performance of NFInst.instExpressions: time 0.2921/1.807, allocations: 196.7 MB / 2.213 GB, free: 12.71 MB / 1.623 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.04475/1.852, allocations: 1.717 MB / 2.215 GB, free: 10.98 MB / 1.623 GB
Notification: Performance of NFTyping.typeComponents: time 0.915/2.767, allocations: 22.31 MB / 2.236 GB, free: 10.23 MB / 1.623 GB
Notification: Performance of NFTyping.typeBindings: time 0.09967/2.867, allocations: 38.63 MB / 2.274 GB, free: 9.84 MB / 1.623 GB
Notification: Performance of NFTyping.typeClassSections: time 0.05927/2.926, allocations: 29 MB / 2.302 GB, free: 9.301 MB / 1.623 GB
Notification: Performance of NFFlatten.flatten: time 0.1887/3.115, allocations: 199.5 MB / 2.497 GB, free: 9.398 MB / 1.654 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.1106/3.225, allocations: 47.85 MB / 2.544 GB, free: 11.17 MB / 1.701 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.1514/3.377, allocations: 80.39 MB / 2.622 GB, free: 1.621 MB / 1.764 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.09082/3.467, allocations: 54.46 MB / 2.676 GB, free: 15.68 MB / 1.826 GB
Notification: Performance of NFPackage.collectConstants: time 0.02173/3.489, allocations: 7.711 MB / 2.683 GB, free: 7.973 MB / 1.826 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.07916/3.568, allocations: 32.13 MB / 2.714 GB, free: 11.15 MB / 1.857 GB
Notification: Performance of combineBinaries: time 0.1877/3.756, allocations: 153 MB / 2.864 GB, free: 9.148 MB / 1.998 GB
Notification: Performance of replaceArrayConstructors: time 0.09001/3.846, allocations: 81.77 MB / 2.944 GB, free: 11.04 MB / 2.076 GB
Notification: Performance of NFVerifyModel.verify: time 0.0289/3.875, allocations: 3.954 MB / 2.948 GB, free: 7.082 MB / 2.076 GB
Notification: Performance of FrontEnd: time 0.009534/3.885, allocations: 1.342 MB / 2.949 GB, free: 6.023 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.594128319062293]
Failed to read output from testmodel.py, exit status != 0:
3.9063647729344666 3.919462692 0.031836163
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f3edbbaaf20>