Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_13_Buildings.Controls.OBC.ASHRAE.G36.AHUs.SingleZone.VAV.SetPoints.Validation.ModeAndSetPoints.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.001302/0.001302, allocations: 91.67 kB / 20.95 MB, free: 3.305 MB / 18.57 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.00558/0.00558, allocations: 161.6 kB / 24.37 MB, free: 8.484 MB / 18.57 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 0.971/0.971, allocations: 177.2 MB / 204.8 MB, free: 5.391 MB / 186.7 MB
"
[Timeout remaining time 179]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 13.0.2-maint.13.x/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 13.0.2-maint.13.x/package.mo): time 1.875/1.875, allocations: 389.6 MB / 0.6356 GB, free: 12.22 MB / 0.6042 GB
"
[Timeout remaining time 178]
Using package Buildings with version 13.0.2 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 13.0.2-maint.13.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.Controls.OBC.ASHRAE.G36.AHUs.SingleZone.VAV.SetPoints.Validation.ModeAndSetPoints,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="Buildings_13_Buildings.Controls.OBC.ASHRAE.G36.AHUs.SingleZone.VAV.SetPoints.Validation.ModeAndSetPoints")
translateModel(Buildings.Controls.OBC.ASHRAE.G36.AHUs.SingleZone.VAV.SetPoints.Validation.ModeAndSetPoints,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="Buildings_13_Buildings.Controls.OBC.ASHRAE.G36.AHUs.SingleZone.VAV.SetPoints.Validation.ModeAndSetPoints") [Timeout 300]
"Notification: Performance of FrontEnd - loaded program: time 2.074e-06/2.074e-06, allocations: 0 / 0.7756 GB, free: 5.062 MB / 0.7292 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 2.207e-05/2.415e-05, allocations: 9.484 kB / 0.7757 GB, free: 5.055 MB / 0.7292 GB
Notification: Performance of NFInst.instantiate(Buildings.Controls.OBC.ASHRAE.G36.AHUs.SingleZone.VAV.SetPoints.Validation.ModeAndSetPoints): time 0.007541/0.007565, allocations: 6.803 MB / 0.7823 GB, free: 14.27 MB / 0.7448 GB
Notification: Performance of NFInst.instExpressions: time 0.006125/0.01369, allocations: 3.502 MB / 0.7857 GB, free: 10.76 MB / 0.7448 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001178/0.01487, allocations: 48.44 kB / 0.7858 GB, free: 10.71 MB / 0.7448 GB
Notification: Performance of NFTyping.typeComponents: time 0.0007002/0.01557, allocations: 320.6 kB / 0.7861 GB, free: 10.39 MB / 0.7448 GB
Notification: Performance of NFTyping.typeBindings: time 0.0007299/0.0163, allocations: 338.9 kB / 0.7864 GB, free: 10.06 MB / 0.7448 GB
Notification: Performance of NFTyping.typeClassSections: time 0.002327/0.01863, allocations: 1.535 MB / 0.7879 GB, free: 8.527 MB / 0.7448 GB
Notification: Performance of NFFlatten.flatten: time 0.00264/0.02127, allocations: 3.466 MB / 0.7913 GB, free: 5.055 MB / 0.7448 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.001553/0.02282, allocations: 1.353 MB / 0.7926 GB, free: 3.621 MB / 0.7448 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.00175/0.02457, allocations: 2.021 MB / 0.7946 GB, free: 1.598 MB / 0.7448 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.0008027/0.02537, allocations: 0.924 MB / 0.7955 GB, free: 0.6719 MB / 0.7448 GB
Notification: Performance of NFPackage.collectConstants: time 0.0003962/0.02577, allocations: 425.7 kB / 0.7959 GB, free: 264 kB / 0.7448 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.0005135/0.02628, allocations: 0.5271 MB / 0.7964 GB, free: 15.73 MB / 0.7605 GB
Notification: Performance of NFScalarize.scalarize: time 0.0004161/0.0267, allocations: 0.7829 MB / 0.7972 GB, free: 14.95 MB / 0.7605 GB
Notification: Performance of NFVerifyModel.verify: time 0.0007254/0.02742, allocations: 0.9586 MB / 0.7981 GB, free: 13.98 MB / 0.7605 GB
Notification: Performance of NFConvertDAE.convert: time 0.001938/0.02936, allocations: 2.379 MB / 0.8004 GB, free: 11.6 MB / 0.7605 GB
Notification: Performance of FrontEnd - DAE generated: time 3.898e-06/0.02936, allocations: 0 / 0.8004 GB, free: 11.6 MB / 0.7605 GB
Notification: Performance of FrontEnd: time 1.573e-06/0.02937, allocations: 0.5 kB / 0.8004 GB, free: 11.6 MB / 0.7605 GB
Notification: Performance of Transformations before backend: time 1.986e-05/0.02939, allocations: 0 / 0.8004 GB, free: 11.6 MB / 0.7605 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 685
 * Number of variables: 685
Notification: Performance of Generate backend data structure: time 0.002447/0.03183, allocations: 2.763 MB / 0.8031 GB, free: 8.766 MB / 0.7605 GB
Notification: Performance of prepare preOptimizeDAE: time 3.293e-05/0.03187, allocations: 9.344 kB / 0.8031 GB, free: 8.758 MB / 0.7605 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0004619/0.03233, allocations: 453.8 kB / 0.8036 GB, free: 8.316 MB / 0.7605 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.001055/0.03338, allocations: 0.9658 MB / 0.8045 GB, free: 7.309 MB / 0.7605 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001535/0.03354, allocations: 238.2 kB / 0.8047 GB, free: 7.074 MB / 0.7605 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001985/0.03373, allocations: 288.9 kB / 0.805 GB, free: 6.793 MB / 0.7605 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.001531/0.03527, allocations: 1.609 MB / 0.8066 GB, free: 5.129 MB / 0.7605 GB
Notification: Performance of preOpt findStateOrder (simulation): time 2.871e-05/0.03529, allocations: 1.625 kB / 0.8066 GB, free: 5.129 MB / 0.7605 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001056/0.0354, allocations: 123.9 kB / 0.8067 GB, free: 5.008 MB / 0.7605 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 3.413e-05/0.03543, allocations: 67.98 kB / 0.8068 GB, free: 4.941 MB / 0.7605 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.00095/0.03638, allocations: 0.7374 MB / 0.8075 GB, free: 4.176 MB / 0.7605 GB
Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.00519/0.04157, allocations: 5.412 MB / 0.8128 GB, free: 14.54 MB / 0.7761 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.0009757/0.04255, allocations: 0.9638 MB / 0.8137 GB, free: 13.57 MB / 0.7761 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0003252/0.04287, allocations: 339.4 kB / 0.814 GB, free: 13.24 MB / 0.7761 GB
Notification: Performance of preOpt evalFunc (simulation): time 6.163e-05/0.04294, allocations: 43.11 kB / 0.8141 GB, free: 13.2 MB / 0.7761 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.000728/0.04366, allocations: 0.8839 MB / 0.8149 GB, free: 12.29 MB / 0.7761 GB
Notification: Performance of pre-optimization done (n=212): time 3.297e-06/0.04367, allocations: 0 / 0.8149 GB, free: 12.29 MB / 0.7761 GB
Notification: Performance of matching and sorting (n=212): time 0.001092/0.04476, allocations: 1.04 MB / 0.816 GB, free: 11.25 MB / 0.7761 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 5.572e-05/0.04482, allocations: 115 kB / 0.8161 GB, free: 11.12 MB / 0.7761 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.000592/0.04541, allocations: 1.023 MB / 0.8171 GB, free: 10.08 MB / 0.7761 GB
Notification: Performance of collectPreVariables (initialization): time 0.0001027/0.04551, allocations: 121.7 kB / 0.8172 GB, free: 9.957 MB / 0.7761 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0004534/0.04596, allocations: 0.864 MB / 0.818 GB, free: 9.082 MB / 0.7761 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0002885/0.04625, allocations: 0.5929 MB / 0.8186 GB, free: 8.484 MB / 0.7761 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0004411/0.04669, allocations: 0.5926 MB / 0.8192 GB, free: 7.887 MB / 0.7761 GB
Notification: Performance of setup shared object (initialization): time 7.401e-05/0.04677, allocations: 305.9 kB / 0.8195 GB, free: 7.586 MB / 0.7761 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0003602/0.04713, allocations: 348.5 kB / 0.8198 GB, free: 7.227 MB / 0.7761 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0006956/0.04782, allocations: 1.268 MB / 0.821 GB, free: 5.605 MB / 0.7761 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.0009767/0.0488, allocations: 1.315 MB / 0.8223 GB, free: 4.031 MB / 0.7761 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.003e-05/0.04881, allocations: 9.125 kB / 0.8223 GB, free: 4.023 MB / 0.7761 GB
Notification: Performance of matching and sorting (n=339) (initialization): time 0.001244/0.05005, allocations: 1.407 MB / 0.8237 GB, free: 2.566 MB / 0.7761 GB
Notification: Performance of prepare postOptimizeDAE: time 4.869e-05/0.0501, allocations: 71.39 kB / 0.8238 GB, free: 2.484 MB / 0.7761 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.244e-05/0.05012, allocations: 16 kB / 0.8238 GB, free: 2.469 MB / 0.7761 GB
Notification: Performance of postOpt tearingSystem (initialization): time 2.65e-05/0.05015, allocations: 35.94 kB / 0.8238 GB, free: 2.434 MB / 0.7761 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0007579/0.05091, allocations: 391.9 kB / 0.8242 GB, free: 2.051 MB / 0.7761 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.676e-05/0.05094, allocations: 44.58 kB / 0.8242 GB, free: 2.008 MB / 0.7761 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0005607/0.0515, allocations: 289.2 kB / 0.8245 GB, free: 1.727 MB / 0.7761 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 9.761e-05/0.05159, allocations: 91.97 kB / 0.8246 GB, free: 1.637 MB / 0.7761 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.0005655/0.05216, allocations: 468 kB / 0.8251 GB, free: 1.16 MB / 0.7761 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.0007479/0.05291, allocations: 1.271 MB / 0.8263 GB, free: 15.53 MB / 0.7917 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.0009577/0.05387, allocations: 1.314 MB / 0.8276 GB, free: 13.96 MB / 0.7917 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 8.516e-06/0.05387, allocations: 4 kB / 0.8276 GB, free: 13.96 MB / 0.7917 GB
Notification: Performance of matching and sorting (n=339) (initialization_lambda0): time 0.001248/0.05512, allocations: 1.403 MB / 0.8289 GB, free: 12.51 MB / 0.7917 GB
Notification: Performance of prepare postOptimizeDAE: time 4.231e-05/0.05516, allocations: 75.39 kB / 0.829 GB, free: 12.42 MB / 0.7917 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.785e-05/0.05518, allocations: 16.97 kB / 0.829 GB, free: 12.41 MB / 0.7917 GB
Notification: Performance of postOpt tearingSystem (initialization): time 2.048e-05/0.0552, allocations: 35.88 kB / 0.8291 GB, free: 12.37 MB / 0.7917 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0006311/0.05583, allocations: 383.7 kB / 0.8294 GB, free: 12 MB / 0.7917 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.128e-05/0.05585, allocations: 36.42 kB / 0.8295 GB, free: 11.96 MB / 0.7917 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0005422/0.0564, allocations: 271.2 kB / 0.8297 GB, free: 11.7 MB / 0.7917 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 8.419e-05/0.05648, allocations: 83.98 kB / 0.8298 GB, free: 11.62 MB / 0.7917 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 76
 * Number of states: 0 ()
 * Number of discrete variables: 225 (modSetPoi.TZonSet.yAla,$whenCondition4,$whenCondition5,$whenCondition2,$whenCondition3,modSetPoi.TZonSet.not1.y,modSetPoi.TZonSet.not2.y,modSetPoi.TZonSet.booToRea6.u,modSetPoi.TZonSet.or7.y,modSetPoi.TZonSet.not1.u,modSetPoi.TZonSet.booToRea7.u,modSetPoi.TZonSet.or8.y,modSetPoi.TZonSet.not2.u,modSetPoi.zonSta.and5.u2,modSetPoi.zonSta.and3.u2,modSetPoi.zonSta.and1.u2,modSetPoi.zonSta.and2.u2,modSetPoi.zonSta.booToRea.u,modSetPoi.zonSta.not1.y,modSetPoi.booToInt.u,modSetPoi.winOpe.y,heaDemLimLev.y,cooDemLimLev.y,modSetPoi.winSta.y,modSetPoi.zonSta.con.y,modSetPoi.TZonSet.conInt5.y,modSetPoi.TZonSet.conInt4.y,modSetPoi.TZonSet.conInt3.y,modSetPoi.TZonSet.conInt7.y,modSetPoi.TZonSet.conInt6.y,modSetPoi.TZonSet.conInt8.y,modSetPoi.TZonSet.have_occSenCon.y,modSetPoi.TZonSet.winSenCon.y,modSetPoi.TZonSet.conFal.y,modSetPoi.TZonSet.heaSetAdjCon.y,modSetPoi.TZonSet.cooSetAdjCon.y,modSetPoi.TZonSet.conInt2.y,modSetPoi.TZonSet.conInt1.y,modSetPoi.TZonSet.conInt.y,modSetPoi.opeModSel.totZon.y,modSetPoi.TZonSet.and11.y,modSetPoi.TZonSet.intEqu7.y,modSetPoi.TZonSet.intEqu8.y,modSetPoi.TZonSet.intEqu6.y,modSetPoi.TZonSet.intGreThr.y,modSetPoi.TZonSet.intGreThr1.y,modSetPoi.TZonSet.intEqu3.y,modSetPoi.TZonSet.intEqu4.y,modSetPoi.TZonSet.intEqu5.y,modSetPoi.TZonSet.or4.y,modSetPoi.TZonSet.or1.y,modSetPoi.TZonSet.edg.u,$PRE.modSetPoi.TZonSet.edg.u,modSetPoi.opeModSel.intGreThr1.y,occSch.tNext,$PRE.occSch.tNext,occSch.tNonOcc,$PRE.occSch.tNonOcc,occSch.tOcc,$PRE.occSch.tOcc,occSch.occupied,$PRE.occSch.occupied,occSta.y,$PRE.occSta.y,winSta.y,$PRE.winSta.y,modSetPoi.hotZon.y,modSetPoi.colZon.y,modSetPoi.zonSta.hys4.y,$PRE.modSetPoi.zonSta.hys4.y,modSetPoi.zonSta.hys3.y,$PRE.modSetPoi.zonSta.hys3.y,modSetPoi.zonSta.hys5.y,$PRE.modSetPoi.zonSta.hys5.y,modSetPoi.zonSta.hys2.y,$PRE.modSetPoi.zonSta.hys2.y,modSetPoi.zonSta.hys1.y,$PRE.modSetPoi.zonSta.hys1.y,modSetPoi.zonSta.hys.y,$PRE.modSetPoi.zonSta.hys.y,modSetPoi.TZonSet.and10.y,modSetPoi.TZonSet.gre2.y,modSetPoi.TZonSet.gre.y,modSetPoi.TZonSet.les.y,modSetPoi.TZonSet.not5.y,modSetPoi.TZonSet.or9.y,modSetPoi.TZonSet.intEqu1.y,modSetPoi.TZonSet.intEqu.y,modSetPoi.TZonSet.or6.y,modSetPoi.TZonSet.heaSetSam.y,$PRE.modSetPoi.TZonSet.heaSetSam.y,modSetPoi.TZonSet.cooSetSam.y,$PRE.modSetPoi.TZonSet.cooSetSam.y,modSetPoi.TZonSet.edg1.y,modSetPoi.TZonSet.edg1.u,$PRE.modSetPoi.TZonSet.edg1.u,modSetPoi.TZonSet.truHol.entryTimeFalse,$PRE.modSetPoi.TZonSet.truHol.entryTimeFalse,modSetPoi.TZonSet.truHol.entryTimeTrue,$PRE.modSetPoi.TZonSet.truHol.entryTimeTrue,modSetPoi.TZonSet.truHol.not_y,$PRE.modSetPoi.TZonSet.truHol.not_y,modSetPoi.TZonSet.truHol.not_u,$PRE.modSetPoi.TZonSet.truHol.not_u,modSetPoi.TZonSet.truHol.y,$PRE.modSetPoi.TZonSet.truHol.y,modSetPoi.TZonSet.truHol.u,$PRE.modSetPoi.TZonSet.truHol.u,modSetPoi.TZonSet.tim.entryTime,$PRE.modSetPoi.TZonSet.tim.entryTime,modSetPoi.TZonSet.tim.passed,$PRE.modSetPoi.TZonSet.tim.passed,modSetPoi.TZonSet.heaSetFre.y,$PRE.modSetPoi.TZonSet.heaSetFre.y,modSetPoi.TZonSet.or5.y,modSetPoi.TZonSet.cooSetFre.y,$PRE.modSetPoi.TZonSet.cooSetFre.y,modSetPoi.TZonSet.edg.y,modSetPoi.opeModSel.or10.y,modSetPoi.opeModSel.or8.y,modSetPoi.opeModSel.addInt7.y,modSetPoi.opeModSel.addInt6.y,modSetPoi.opeModSel.endSetUp.u,$PRE.modSetPoi.opeModSel.endSetUp.u,modSetPoi.opeModSel.endSetBac.u,$PRE.modSetPoi.opeModSel.endSetBac.u,modSetPoi.opeModSel.allHot.y,modSetPoi.opeModSel.allCol.y,modSetPoi.opeModSel.and4.y,modSetPoi.opeModSel.setBacMod2.y,modSetPoi.opeModSel.setBacMod1.y,modSetPoi.opeModSel.not1.y,modSetPoi.opeModSel.notOcc.y,modSetPoi.opeModSel.or5.y,modSetPoi.opeModSel.or4.y,modSetPoi.opeModSel.or9.y,modSetPoi.opeModSel.or1.y,modSetPoi.opeModSel.and1.y,modSetPoi.opeModSel.not2.y,modSetPoi.opeModSel.booToInt3.y,modSetPoi.opeModSel.truFalHol1.entryTimeFalse,$PRE.modSetPoi.opeModSel.truFalHol1.entryTimeFalse,modSetPoi.opeModSel.truFalHol1.entryTimeTrue,$PRE.modSetPoi.opeModSel.truFalHol1.entryTimeTrue,modSetPoi.opeModSel.truFalHol1.not_y,$PRE.modSetPoi.opeModSel.truFalHol1.not_y,modSetPoi.opeModSel.truFalHol1.not_u,$PRE.modSetPoi.opeModSel.truFalHol1.not_u,modSetPoi.opeModSel.truFalHol1.y,$PRE.modSetPoi.opeModSel.truFalHol1.y,modSetPoi.opeModSel.truFalHol1.u,$PRE.modSetPoi.opeModSel.truFalHol1.u,modSetPoi.opeModSel.edg1.u,$PRE.modSetPoi.opeModSel.edg1.u,modSetPoi.opeModSel.truFalHol.entryTimeFalse,$PRE.modSetPoi.opeModSel.truFalHol.entryTimeFalse,modSetPoi.opeModSel.truFalHol.entryTimeTrue,$PRE.modSetPoi.opeModSel.truFalHol.entryTimeTrue,modSetPoi.opeModSel.truFalHol.not_y,$PRE.modSetPoi.opeModSel.truFalHol.not_y,modSetPoi.opeModSel.truFalHol.not_u,$PRE.modSetPoi.opeModSel.truFalHol.not_u,modSetPoi.opeModSel.truFalHol.y,$PRE.modSetPoi.opeModSel.truFalHol.y,modSetPoi.opeModSel.truFalHol.u,$PRE.modSetPoi.opeModSel.truFalHol.u,modSetPoi.opeModSel.edg.u,$PRE.modSetPoi.opeModSel.edg.u,modSetPoi.opeModSel.setUpMod.y,modSetPoi.opeModSel.freProSetBacMod.y,modSetPoi.opeModSel.setBacMod.y,modSetPoi.opeModSel.occMod.y,modSetPoi.opeModSel.addInt4.y,modSetPoi.opeModSel.addInt3.y,modSetPoi.opeModSel.addInt2.y,modSetPoi.opeModSel.addInt1.y,modSetPoi.opeModSel.addInt.y,modSetPoi.opeModSel.intGreThr2.y,modSetPoi.opeModSel.hys10.y,$PRE.modSetPoi.opeModSel.hys10.y,modSetPoi.opeModSel.hys9.y,$PRE.modSetPoi.opeModSel.hys9.y,modSetPoi.opeModSel.hys5.y,$PRE.modSetPoi.opeModSel.hys5.y,modSetPoi.opeModSel.hys4.y,$PRE.modSetPoi.opeModSel.hys4.y,modSetPoi.opeModSel.hys3.y,$PRE.modSetPoi.opeModSel.hys3.y,modSetPoi.opeModSel.hys2.y,$PRE.modSetPoi.opeModSel.hys2.y,modSetPoi.opeModSel.lat2.y,$PRE.modSetPoi.opeModSel.lat2.y,modSetPoi.opeModSel.lat2.clr,modSetPoi.opeModSel.lat2.u,modSetPoi.opeModSel.lat1.y,$PRE.modSetPoi.opeModSel.lat1.y,modSetPoi.opeModSel.lat1.clr,modSetPoi.opeModSel.lat1.u,modSetPoi.opeModSel.lat.y,$PRE.modSetPoi.opeModSel.lat.y,modSetPoi.opeModSel.lat.clr,modSetPoi.opeModSel.lat.u,modSetPoi.opeModSel.intGreThr.y,modSetPoi.yOpeMod,$whenCondition1,$whenCondition6,$whenCondition7,$whenCondition8,$whenCondition9,$whenCondition12,$whenCondition11,$whenCondition10,$whenCondition13,$whenCondition14,$whenCondition15,$whenCondition16,$whenCondition17,$whenCondition18,$whenCondition19,$whenCondition20,$whenCondition21,$whenCondition22,$whenCondition23,$whenCondition24,$whenCondition25)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (332):
 * Single equations (assignments): 329
 * Array equations: 0
 * Algorithm blocks: 2
 * Record equations: 1
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of prepare postOptimizeDAE: time 0.0003139/0.05679, allocations: 480 kB / 0.8303 GB, free: 11.14 MB / 0.7917 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0001524/0.05695, allocations: 171.8 kB / 0.8304 GB, free: 10.97 MB / 0.7917 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.0009489/0.0579, allocations: 0.8725 MB / 0.8313 GB, free: 10.09 MB / 0.7917 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.084e-05/0.05791, allocations: 21.03 kB / 0.8313 GB, free: 10.07 MB / 0.7917 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 3.917e-06/0.05791, allocations: 4 kB / 0.8313 GB, free: 10.06 MB / 0.7917 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 1.482e-05/0.05793, allocations: 15.94 kB / 0.8313 GB, free: 10.05 MB / 0.7917 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.00227/0.0602, allocations: 2.287 MB / 0.8336 GB, free: 7.684 MB / 0.7917 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 6.212e-06/0.0602, allocations: 8 kB / 0.8336 GB, free: 7.676 MB / 0.7917 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0004347/0.06064, allocations: 236.7 kB / 0.8338 GB, free: 7.445 MB / 0.7917 GB
Notification: Performance of postOpt tearingSystem (simulation): time 1.016e-05/0.06065, allocations: 15.94 kB / 0.8338 GB, free: 7.43 MB / 0.7917 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 6.338e-05/0.06071, allocations: 51.94 kB / 0.8339 GB, free: 7.379 MB / 0.7917 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 7.514e-06/0.06072, allocations: 12.66 kB / 0.8339 GB, free: 7.367 MB / 0.7917 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 3.226e-06/0.06072, allocations: 4 kB / 0.8339 GB, free: 7.363 MB / 0.7917 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.000888/0.06161, allocations: 1.136 MB / 0.835 GB, free: 6.156 MB / 0.7917 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0001088/0.06172, allocations: 166.5 kB / 0.8351 GB, free: 5.992 MB / 0.7917 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001489/0.06187, allocations: 87.97 kB / 0.8352 GB, free: 5.906 MB / 0.7917 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0002928/0.06216, allocations: 85.31 kB / 0.8353 GB, free: 5.824 MB / 0.7917 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0002825/0.06244, allocations: 265.4 kB / 0.8356 GB, free: 5.566 MB / 0.7917 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 7.851e-05/0.06252, allocations: 67.94 kB / 0.8356 GB, free: 5.5 MB / 0.7917 GB
Notification: Performance of sorting global known variables: time 0.0002552/0.06278, allocations: 394.8 kB / 0.836 GB, free: 5.105 MB / 0.7917 GB
Notification: Performance of sort global known variables: time 7e-08/0.06278, allocations: 0 / 0.836 GB, free: 5.105 MB / 0.7917 GB
Notification: Performance of remove unused functions: time 0.00124/0.06402, allocations: 1.016 MB / 0.837 GB, free: 4.086 MB / 0.7917 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 19
 * Number of states: 0 ()
 * Number of discrete variables: 126 (modSetPoi.TZonSet.edg1.y,modSetPoi.TZonSet.and10.y,modSetPoi.opeModSel.lat.u,modSetPoi.opeModSel.lat1.u,modSetPoi.opeModSel.lat1.clr,modSetPoi.opeModSel.lat2.u,modSetPoi.opeModSel.lat.clr,modSetPoi.opeModSel.lat2.clr,modSetPoi.TZonSet.edg.y,$whenCondition25,$whenCondition24,$whenCondition23,$whenCondition22,$whenCondition21,$whenCondition20,$whenCondition19,$whenCondition18,$whenCondition17,$whenCondition16,$whenCondition15,$whenCondition14,$whenCondition13,$whenCondition10,$whenCondition11,$whenCondition12,$whenCondition9,$whenCondition8,$whenCondition7,$whenCondition6,$whenCondition4,$whenCondition5,$whenCondition2,$whenCondition3,$whenCondition1,modSetPoi.yOpeMod,modSetPoi.opeModSel.intGreThr.y,modSetPoi.opeModSel.lat.y,modSetPoi.opeModSel.lat1.y,modSetPoi.opeModSel.lat2.y,modSetPoi.opeModSel.hys4.y,modSetPoi.opeModSel.hys5.y,modSetPoi.opeModSel.hys9.y,modSetPoi.opeModSel.hys10.y,modSetPoi.opeModSel.intGreThr2.y,modSetPoi.opeModSel.addInt.y,modSetPoi.opeModSel.addInt1.y,modSetPoi.opeModSel.addInt2.y,modSetPoi.opeModSel.addInt3.y,modSetPoi.opeModSel.addInt4.y,modSetPoi.opeModSel.occMod.y,modSetPoi.opeModSel.setBacMod.y,modSetPoi.opeModSel.freProSetBacMod.y,modSetPoi.opeModSel.setUpMod.y,modSetPoi.opeModSel.edg.u,modSetPoi.opeModSel.truFalHol.u,modSetPoi.opeModSel.truFalHol.y,modSetPoi.opeModSel.truFalHol.not_u,modSetPoi.opeModSel.truFalHol.not_y,modSetPoi.opeModSel.truFalHol.entryTimeTrue,modSetPoi.opeModSel.truFalHol.entryTimeFalse,modSetPoi.opeModSel.edg1.u,modSetPoi.opeModSel.truFalHol1.u,modSetPoi.opeModSel.truFalHol1.y,modSetPoi.opeModSel.truFalHol1.not_u,modSetPoi.opeModSel.truFalHol1.not_y,modSetPoi.opeModSel.truFalHol1.entryTimeTrue,modSetPoi.opeModSel.truFalHol1.entryTimeFalse,modSetPoi.opeModSel.booToInt3.y,modSetPoi.opeModSel.not2.y,modSetPoi.opeModSel.and1.y,modSetPoi.opeModSel.or1.y,modSetPoi.opeModSel.or9.y,modSetPoi.opeModSel.or4.y,modSetPoi.opeModSel.or5.y,modSetPoi.opeModSel.notOcc.y,modSetPoi.opeModSel.not1.y,modSetPoi.opeModSel.setBacMod1.y,modSetPoi.opeModSel.setBacMod2.y,modSetPoi.opeModSel.and4.y,modSetPoi.opeModSel.allCol.y,modSetPoi.opeModSel.allHot.y,modSetPoi.opeModSel.endSetBac.u,modSetPoi.opeModSel.endSetUp.u,modSetPoi.opeModSel.addInt6.y,modSetPoi.opeModSel.addInt7.y,modSetPoi.opeModSel.or8.y,modSetPoi.opeModSel.or10.y,modSetPoi.TZonSet.cooSetFre.y,modSetPoi.TZonSet.heaSetFre.y,modSetPoi.TZonSet.tim.passed,modSetPoi.TZonSet.tim.entryTime,modSetPoi.TZonSet.truHol.u,modSetPoi.TZonSet.truHol.y,modSetPoi.TZonSet.truHol.not_u,modSetPoi.TZonSet.truHol.not_y,modSetPoi.TZonSet.truHol.entryTimeTrue,modSetPoi.TZonSet.truHol.entryTimeFalse,modSetPoi.TZonSet.edg1.u,modSetPoi.TZonSet.cooSetSam.y,modSetPoi.TZonSet.heaSetSam.y,modSetPoi.TZonSet.or6.y,modSetPoi.TZonSet.intEqu.y,modSetPoi.TZonSet.intEqu1.y,modSetPoi.TZonSet.or9.y,modSetPoi.TZonSet.not5.y,modSetPoi.TZonSet.les.y,modSetPoi.TZonSet.gre.y,modSetPoi.TZonSet.gre2.y,modSetPoi.zonSta.hys.y,modSetPoi.zonSta.hys1.y,modSetPoi.zonSta.hys2.y,modSetPoi.zonSta.hys5.y,modSetPoi.zonSta.hys3.y,modSetPoi.zonSta.hys4.y,modSetPoi.colZon.y,modSetPoi.hotZon.y,winSta.y,occSta.y,occSch.occupied,occSch.tOcc,occSch.tNonOcc,occSch.tNext,modSetPoi.opeModSel.hys2.y,modSetPoi.opeModSel.hys3.y,modSetPoi.TZonSet.or5.y,modSetPoi.TZonSet.yAla)
 * Number of discrete states: 35 (modSetPoi.opeModSel.truFalHol.entryTimeFalse,modSetPoi.opeModSel.truFalHol.entryTimeTrue,modSetPoi.opeModSel.truFalHol1.entryTimeFalse,modSetPoi.opeModSel.truFalHol1.entryTimeTrue,modSetPoi.TZonSet.truHol.entryTimeFalse,modSetPoi.TZonSet.truHol.entryTimeTrue,occSch.tNext,modSetPoi.zonSta.hys4.y,modSetPoi.zonSta.hys3.y,modSetPoi.zonSta.hys5.y,modSetPoi.zonSta.hys2.y,modSetPoi.zonSta.hys1.y,modSetPoi.zonSta.hys.y,modSetPoi.opeModSel.endSetUp.u,modSetPoi.opeModSel.endSetBac.u,modSetPoi.opeModSel.hys10.y,modSetPoi.opeModSel.hys9.y,modSetPoi.opeModSel.hys5.y,modSetPoi.opeModSel.edg.u,modSetPoi.opeModSel.truFalHol1.u,modSetPoi.opeModSel.truFalHol1.not_u,modSetPoi.opeModSel.truFalHol1.y,modSetPoi.opeModSel.truFalHol1.not_y,modSetPoi.opeModSel.hys4.y,modSetPoi.opeModSel.edg1.u,modSetPoi.opeModSel.truFalHol.u,modSetPoi.opeModSel.truFalHol.not_u,modSetPoi.opeModSel.truFalHol.y,modSetPoi.opeModSel.truFalHol.not_y,modSetPoi.TZonSet.tim.entryTime,modSetPoi.TZonSet.truHol.u,modSetPoi.TZonSet.truHol.not_u,modSetPoi.TZonSet.truHol.y,modSetPoi.TZonSet.truHol.not_y,modSetPoi.TZonSet.edg1.u)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (209):
 * Single equations (assignments): 188
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 21
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of Backend phase and start with SimCode phase: time 0.0003212/0.06434, allocations: 319.8 kB / 0.8373 GB, free: 3.762 MB / 0.7917 GB
Notification: Performance of simCode: created initialization part: time 0.00189/0.06623, allocations: 2.28 MB / 0.8395 GB, free: 1.387 MB / 0.7917 GB
Notification: Performance of simCode: created event and clocks part: time 2.19e-05/0.06625, allocations: 19.75 kB / 0.8395 GB, free: 1.371 MB / 0.7917 GB
Notification: Performance of simCode: created simulation system equations: time 0.0004835/0.06673, allocations: 0.5595 MB / 0.8401 GB, free: 0.8086 MB / 0.7917 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.0005046/0.06724, allocations: 208.3 kB / 0.8403 GB, free: 0.6055 MB / 0.7917 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.003413/0.07065, allocations: 3.313 MB / 0.8435 GB, free: 13.18 MB / 0.8073 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0002283/0.07088, allocations: 356.7 kB / 0.8439 GB, free: 12.8 MB / 0.8073 GB
Notification: Performance of simCode: alias equations: time 0.0006879/0.07157, allocations: 306.2 kB / 0.8442 GB, free: 12.5 MB / 0.8073 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0005901/0.07216, allocations: 371.2 kB / 0.8445 GB, free: 12.14 MB / 0.8073 GB
Notification: Performance of SimCode: time 9.12e-07/0.07216, allocations: 0 / 0.8445 GB, free: 12.14 MB / 0.8073 GB
Notification: Performance of Templates: time 0.02734/0.0995, allocations: 22.92 MB / 0.8669 GB, free: 5.543 MB / 0.823 GB
"
[Timeout remaining time 300]
make -j1 -f Buildings_13_Buildings.Controls.OBC.ASHRAE.G36.AHUs.SingleZone.VAV.SetPoints.Validation.ModeAndSetPoints.makefile [Timeout 300]
(rm -f Buildings_13_Buildings.Controls.OBC.ASHRAE.G36.AHUs.SingleZone.VAV.SetPoints.Validation.ModeAndSetPoints.pipe ; mkfifo Buildings_13_Buildings.Controls.OBC.ASHRAE.G36.AHUs.SingleZone.VAV.SetPoints.Validation.ModeAndSetPoints.pipe ; head -c 1048576 < Buildings_13_Buildings.Controls.OBC.ASHRAE.G36.AHUs.SingleZone.VAV.SetPoints.Validation.ModeAndSetPoints.pipe >> ../files/Buildings_13_Buildings.Controls.OBC.ASHRAE.G36.AHUs.SingleZone.VAV.SetPoints.Validation.ModeAndSetPoints.sim & (cd run_cvode && ../Buildings_13_Buildings.Controls.OBC.ASHRAE.G36.AHUs.SingleZone.VAV.SetPoints.Validation.ModeAndSetPoints -abortSlowSimulation -alarm=240  -lv LOG_STATS -inputPath=.. -s cvode) > Buildings_13_Buildings.Controls.OBC.ASHRAE.G36.AHUs.SingleZone.VAV.SetPoints.Validation.ModeAndSetPoints.pipe 2>&1) [Timeout 240]
(rm -f Buildings_13_Buildings.Controls.OBC.ASHRAE.G36.AHUs.SingleZone.VAV.SetPoints.Validation.ModeAndSetPoints_gbode.pipe ; mkfifo Buildings_13_Buildings.Controls.OBC.ASHRAE.G36.AHUs.SingleZone.VAV.SetPoints.Validation.ModeAndSetPoints_gbode.pipe ; head -c 1048576 < Buildings_13_Buildings.Controls.OBC.ASHRAE.G36.AHUs.SingleZone.VAV.SetPoints.Validation.ModeAndSetPoints_gbode.pipe >> /var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_13_Buildings.Controls.OBC.ASHRAE.G36.AHUs.SingleZone.VAV.SetPoints.Validation.ModeAndSetPoints_gbode.sim & (cd run_gbode && ../Buildings_13_Buildings.Controls.OBC.ASHRAE.G36.AHUs.SingleZone.VAV.SetPoints.Validation.ModeAndSetPoints -abortSlowSimulation -alarm=240  -lv LOG_STATS -inputPath=.. -s gbode -gbm=radauIIA3) > Buildings_13_Buildings.Controls.OBC.ASHRAE.G36.AHUs.SingleZone.VAV.SetPoints.Validation.ModeAndSetPoints_gbode.pipe 2>&1) [Timeout 240]
(rm -f Buildings_13_Buildings.Controls.OBC.ASHRAE.G36.AHUs.SingleZone.VAV.SetPoints.Validation.ModeAndSetPoints_ida.pipe ; mkfifo Buildings_13_Buildings.Controls.OBC.ASHRAE.G36.AHUs.SingleZone.VAV.SetPoints.Validation.ModeAndSetPoints_ida.pipe ; head -c 1048576 < Buildings_13_Buildings.Controls.OBC.ASHRAE.G36.AHUs.SingleZone.VAV.SetPoints.Validation.ModeAndSetPoints_ida.pipe >> /var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_13_Buildings.Controls.OBC.ASHRAE.G36.AHUs.SingleZone.VAV.SetPoints.Validation.ModeAndSetPoints_ida.sim & (cd run_ida && ../Buildings_13_Buildings.Controls.OBC.ASHRAE.G36.AHUs.SingleZone.VAV.SetPoints.Validation.ModeAndSetPoints -abortSlowSimulation -alarm=240  -lv LOG_STATS -inputPath=.. -s ida) > Buildings_13_Buildings.Controls.OBC.ASHRAE.G36.AHUs.SingleZone.VAV.SetPoints.Validation.ModeAndSetPoints_ida.pipe 2>&1) [Timeout 240]
[Calling sys.exit(0), Time elapsed: 5.6187752010300756]