Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_13_Buildings.Controls.OBC.ASHRAE.G36.ThermalZones.Validation.Setpoints.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.0009088/0.0009088, allocations: 80.81 kB / 21.55 MB, free: 2.945 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.001538/0.001538, allocations: 164.8 kB / 24.97 MB, free: 9.168 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.953/0.953, allocations: 177.1 MB / 205.4 MB, free: 5.484 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.905/1.905, allocations: 389.6 MB / 0.6362 GB, free: 12.27 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.ThermalZones.Validation.Setpoints,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="Buildings_13_Buildings.Controls.OBC.ASHRAE.G36.ThermalZones.Validation.Setpoints")
translateModel(Buildings.Controls.OBC.ASHRAE.G36.ThermalZones.Validation.Setpoints,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="Buildings_13_Buildings.Controls.OBC.ASHRAE.G36.ThermalZones.Validation.Setpoints") [Timeout 300]
"Notification: Performance of FrontEnd - loaded program: time 2.385e-06/2.385e-06, allocations: 0 / 0.776 GB, free: 5.359 MB / 0.7292 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 2.165e-05/2.404e-05, allocations: 3.609 kB / 0.776 GB, free: 5.355 MB / 0.7292 GB
Notification: Performance of NFInst.instantiate(Buildings.Controls.OBC.ASHRAE.G36.ThermalZones.Validation.Setpoints): time 0.004116/0.00414, allocations: 3.558 MB / 0.7795 GB, free: 1.828 MB / 0.7292 GB
Notification: Performance of NFInst.instExpressions: time 0.0047/0.00884, allocations: 2.758 MB / 0.7821 GB, free: 15.05 MB / 0.7448 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0007636/0.009604, allocations: 31.88 kB / 0.7822 GB, free: 15.02 MB / 0.7448 GB
Notification: Performance of NFTyping.typeComponents: time 0.0004029/0.01001, allocations: 169.8 kB / 0.7823 GB, free: 14.85 MB / 0.7448 GB
Notification: Performance of NFTyping.typeBindings: time 0.0003862/0.01039, allocations: 166.2 kB / 0.7825 GB, free: 14.69 MB / 0.7448 GB
Notification: Performance of NFTyping.typeClassSections: time 0.001205/0.0116, allocations: 0.7207 MB / 0.7832 GB, free: 13.97 MB / 0.7448 GB
Notification: Performance of NFFlatten.flatten: time 0.001171/0.01277, allocations: 1.568 MB / 0.7847 GB, free: 12.39 MB / 0.7448 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.0007733/0.01354, allocations: 0.6569 MB / 0.7854 GB, free: 11.69 MB / 0.7448 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.0008933/0.01443, allocations: 0.9315 MB / 0.7863 GB, free: 10.75 MB / 0.7448 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.0003764/0.01481, allocations: 458.2 kB / 0.7867 GB, free: 10.31 MB / 0.7448 GB
Notification: Performance of NFPackage.collectConstants: time 0.0004207/0.01523, allocations: 168 kB / 0.7869 GB, free: 10.14 MB / 0.7448 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.0001956/0.01543, allocations: 184 kB / 0.7871 GB, free: 9.965 MB / 0.7448 GB
Notification: Performance of NFScalarize.scalarize: time 0.0001656/0.01559, allocations: 350.8 kB / 0.7874 GB, free: 9.621 MB / 0.7448 GB
Notification: Performance of NFVerifyModel.verify: time 0.0002666/0.01586, allocations: 450.8 kB / 0.7878 GB, free: 9.18 MB / 0.7448 GB
Notification: Performance of NFConvertDAE.convert: time 0.0009389/0.0168, allocations: 1.074 MB / 0.7889 GB, free: 8.102 MB / 0.7448 GB
Notification: Performance of FrontEnd - DAE generated: time 4.057e-06/0.0168, allocations: 0.5625 kB / 0.7889 GB, free: 8.102 MB / 0.7448 GB
Notification: Performance of FrontEnd: time 1.142e-06/0.0168, allocations: 0 / 0.7889 GB, free: 8.102 MB / 0.7448 GB
Notification: Performance of Transformations before backend: time 1.263e-05/0.01682, allocations: 3.781 kB / 0.7889 GB, free: 8.102 MB / 0.7448 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 357
 * Number of variables: 357
Notification: Performance of Generate backend data structure: time 0.001404/0.01822, allocations: 1.49 MB / 0.7903 GB, free: 6.562 MB / 0.7448 GB
Notification: Performance of prepare preOptimizeDAE: time 3.986e-05/0.01826, allocations: 9.344 kB / 0.7903 GB, free: 6.555 MB / 0.7448 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0003163/0.01858, allocations: 247.5 kB / 0.7906 GB, free: 6.316 MB / 0.7448 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.0005797/0.01916, allocations: 0.51 MB / 0.7911 GB, free: 5.785 MB / 0.7448 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 8.154e-05/0.01924, allocations: 123.2 kB / 0.7912 GB, free: 5.664 MB / 0.7448 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001047/0.01934, allocations: 144.4 kB / 0.7913 GB, free: 5.523 MB / 0.7448 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.0007808/0.02012, allocations: 0.8128 MB / 0.7921 GB, free: 4.688 MB / 0.7448 GB
Notification: Performance of preOpt findStateOrder (simulation): time 1.952e-05/0.02014, allocations: 192 / 0.7921 GB, free: 4.688 MB / 0.7448 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 5.577e-05/0.0202, allocations: 61.3 kB / 0.7922 GB, free: 4.629 MB / 0.7448 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 2.024e-05/0.02022, allocations: 39.94 kB / 0.7922 GB, free: 4.59 MB / 0.7448 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.0004534/0.02067, allocations: 391.1 kB / 0.7926 GB, free: 4.195 MB / 0.7448 GB
Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.002994/0.02367, allocations: 2.736 MB / 0.7953 GB, free: 1.305 MB / 0.7448 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.0005392/0.02421, allocations: 449.1 kB / 0.7957 GB, free: 0.8672 MB / 0.7448 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0001511/0.02436, allocations: 153.2 kB / 0.7958 GB, free: 0.7109 MB / 0.7448 GB
Notification: Performance of preOpt evalFunc (simulation): time 4.073e-05/0.0244, allocations: 24.98 kB / 0.7959 GB, free: 0.6875 MB / 0.7448 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0003355/0.02473, allocations: 358.9 kB / 0.7962 GB, free: 332 kB / 0.7448 GB
Notification: Performance of pre-optimization done (n=100): time 3.086e-06/0.02474, allocations: 1.219 kB / 0.7962 GB, free: 332 kB / 0.7448 GB
Notification: Performance of matching and sorting (n=100): time 0.0005645/0.0253, allocations: 0.514 MB / 0.7967 GB, free: 15.81 MB / 0.7605 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 3.41e-05/0.02533, allocations: 73.12 kB / 0.7968 GB, free: 15.72 MB / 0.7605 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0003393/0.02567, allocations: 0.6086 MB / 0.7974 GB, free: 15.11 MB / 0.7605 GB
Notification: Performance of collectPreVariables (initialization): time 5.399e-05/0.02573, allocations: 58.7 kB / 0.7974 GB, free: 15.04 MB / 0.7605 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0002324/0.02596, allocations: 0.5213 MB / 0.7979 GB, free: 14.51 MB / 0.7605 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0001414/0.0261, allocations: 305.5 kB / 0.7982 GB, free: 14.21 MB / 0.7605 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.000237/0.02634, allocations: 311.3 kB / 0.7985 GB, free: 13.9 MB / 0.7605 GB
Notification: Performance of setup shared object (initialization): time 0.0001137/0.02645, allocations: 402.6 kB / 0.7989 GB, free: 13.5 MB / 0.7605 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.000201/0.02665, allocations: 214.7 kB / 0.7991 GB, free: 13.27 MB / 0.7605 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0003647/0.02702, allocations: 0.6513 MB / 0.7997 GB, free: 12.43 MB / 0.7605 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.0008365/0.02785, allocations: 0.8102 MB / 0.8005 GB, free: 11.47 MB / 0.7605 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 6.983e-06/0.02786, allocations: 7.938 kB / 0.8005 GB, free: 11.46 MB / 0.7605 GB
Notification: Performance of matching and sorting (n=169) (initialization): time 0.0006962/0.02856, allocations: 0.8383 MB / 0.8014 GB, free: 10.6 MB / 0.7605 GB
Notification: Performance of prepare postOptimizeDAE: time 4.469e-05/0.0286, allocations: 67.39 kB / 0.8014 GB, free: 10.52 MB / 0.7605 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.214e-05/0.02861, allocations: 16.59 kB / 0.8014 GB, free: 10.5 MB / 0.7605 GB
Notification: Performance of postOpt tearingSystem (initialization): time 2.061e-05/0.02864, allocations: 20.5 kB / 0.8015 GB, free: 10.48 MB / 0.7605 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0003779/0.02901, allocations: 227 kB / 0.8017 GB, free: 10.27 MB / 0.7605 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 1.583e-05/0.02903, allocations: 27.88 kB / 0.8017 GB, free: 10.24 MB / 0.7605 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0003319/0.02936, allocations: 163.1 kB / 0.8019 GB, free: 10.08 MB / 0.7605 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 5.513e-05/0.02942, allocations: 55.97 kB / 0.8019 GB, free: 10.02 MB / 0.7605 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.0002852/0.0297, allocations: 310.8 kB / 0.8022 GB, free: 9.707 MB / 0.7605 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.0003557/0.03006, allocations: 0.6411 MB / 0.8028 GB, free: 8.875 MB / 0.7605 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.0005622/0.03062, allocations: 0.8076 MB / 0.8036 GB, free: 7.91 MB / 0.7605 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 4.929e-06/0.03062, allocations: 5.625 kB / 0.8036 GB, free: 7.906 MB / 0.7605 GB
Notification: Performance of matching and sorting (n=169) (initialization_lambda0): time 0.0006905/0.03131, allocations: 0.8344 MB / 0.8044 GB, free: 7.047 MB / 0.7605 GB
Notification: Performance of prepare postOptimizeDAE: time 4.006e-05/0.03135, allocations: 71.39 kB / 0.8045 GB, free: 6.965 MB / 0.7605 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 8.956e-06/0.03136, allocations: 12 kB / 0.8045 GB, free: 6.953 MB / 0.7605 GB
Notification: Performance of postOpt tearingSystem (initialization): time 1.601e-05/0.03138, allocations: 24.8 kB / 0.8045 GB, free: 6.93 MB / 0.7605 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0003476/0.03173, allocations: 216.8 kB / 0.8048 GB, free: 6.719 MB / 0.7605 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 1.308e-05/0.03174, allocations: 23.94 kB / 0.8048 GB, free: 6.695 MB / 0.7605 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0003126/0.03205, allocations: 157.2 kB / 0.8049 GB, free: 6.543 MB / 0.7605 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 4.871e-05/0.0321, allocations: 55.98 kB / 0.805 GB, free: 6.488 MB / 0.7605 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 53
 * Number of states: 0 ()
 * Number of discrete variables: 93 ($whenCondition3,$whenCondition4,$whenCondition1,$whenCondition2,TZonSet.not1.y,TZonSet.not2.y,TZonSet.booToRea6.u,TZonSet.or7.y,TZonSet.not1.u,TZonSet.booToRea7.u,TZonSet.or8.y,TZonSet.not2.u,heaDemLimLev.y,cooDemLimLev.y,TZonSet.conInt5.y,TZonSet.conInt4.y,TZonSet.conInt3.y,TZonSet.conInt7.y,TZonSet.conInt6.y,TZonSet.conInt8.y,TZonSet.have_occSenCon.y,TZonSet.winSenCon.y,TZonSet.heaSetAdjCon.y,TZonSet.cooSetAdjCon.y,TZonSet.conInt2.y,TZonSet.conInt1.y,TZonSet.conInt.y,TZonSet.intEqu7.y,TZonSet.intEqu8.y,TZonSet.intEqu6.y,TZonSet.intGreThr.y,TZonSet.intGreThr1.y,TZonSet.intEqu3.y,TZonSet.intEqu4.y,TZonSet.intEqu5.y,TZonSet.or4.y,TZonSet.or1.y,TZonSet.edg.u,$PRE.TZonSet.edg.u,not1.y,occSta.y,$PRE.occSta.y,winSta.y,$PRE.winSta.y,booToInt.y,TZonSet.and10.y,TZonSet.gre2.y,TZonSet.gre.y,TZonSet.les.y,TZonSet.not5.y,TZonSet.and11.y,TZonSet.or9.y,TZonSet.intEqu1.y,TZonSet.intEqu.y,TZonSet.or6.y,TZonSet.heaSetSam.y,$PRE.TZonSet.heaSetSam.y,TZonSet.cooSetSam.y,$PRE.TZonSet.cooSetSam.y,TZonSet.edg1.y,TZonSet.edg1.u,$PRE.TZonSet.edg1.u,TZonSet.truHol.entryTimeFalse,$PRE.TZonSet.truHol.entryTimeFalse,TZonSet.truHol.entryTimeTrue,$PRE.TZonSet.truHol.entryTimeTrue,TZonSet.truHol.not_y,$PRE.TZonSet.truHol.not_y,TZonSet.truHol.not_u,$PRE.TZonSet.truHol.not_u,TZonSet.truHol.y,$PRE.TZonSet.truHol.y,TZonSet.truHol.u,$PRE.TZonSet.truHol.u,TZonSet.tim.entryTime,$PRE.TZonSet.tim.entryTime,TZonSet.tim.passed,$PRE.TZonSet.tim.passed,TZonSet.heaSetFre.y,$PRE.TZonSet.heaSetFre.y,TZonSet.or5.y,TZonSet.cooSetFre.y,$PRE.TZonSet.cooSetFre.y,TZonSet.edg.y,TZonSet.yAla,$whenCondition5,$whenCondition6,$whenCondition7,$whenCondition8,$whenCondition11,$whenCondition10,$whenCondition9,$whenCondition12)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (165):
 * Single equations (assignments): 163
 * Array equations: 0
 * Algorithm blocks: 2
 * Record equations: 0
 * 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.000213/0.03231, allocations: 311.5 kB / 0.8053 GB, free: 6.18 MB / 0.7605 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 8.8e-05/0.0324, allocations: 83.92 kB / 0.8054 GB, free: 6.098 MB / 0.7605 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.0001117/0.03251, allocations: 97.45 kB / 0.8055 GB, free: 5.996 MB / 0.7605 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 7.084e-06/0.03252, allocations: 3.984 kB / 0.8055 GB, free: 5.992 MB / 0.7605 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.003e-06/0.03252, allocations: 1.062 kB / 0.8055 GB, free: 5.992 MB / 0.7605 GB
Notification: Performance of postOpt removeConstants (simulation): time 6.53e-05/0.03259, allocations: 87.19 kB / 0.8055 GB, free: 5.906 MB / 0.7605 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 5.936e-05/0.03265, allocations: 29.36 kB / 0.8056 GB, free: 5.879 MB / 0.7605 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0001262/0.03277, allocations: 43.89 kB / 0.8056 GB, free: 5.836 MB / 0.7605 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001125/0.03289, allocations: 77.67 kB / 0.8057 GB, free: 5.762 MB / 0.7605 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.0004439/0.03333, allocations: 472.5 kB / 0.8061 GB, free: 5.293 MB / 0.7605 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.0004441/0.03377, allocations: 0.5911 MB / 0.8067 GB, free: 4.688 MB / 0.7605 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.0002012/0.03398, allocations: 236 kB / 0.8069 GB, free: 4.457 MB / 0.7605 GB
Notification: Performance of sorting global known variables: time 0.0001483/0.03412, allocations: 220.6 kB / 0.8071 GB, free: 4.242 MB / 0.7605 GB
Notification: Performance of Backend: time 3.3e-07/0.03412, allocations: 0 / 0.8071 GB, free: 4.242 MB / 0.7605 GB
Notification: Performance of simCode: created initialization part: time 0.001464/0.03559, allocations: 1.299 MB / 0.8084 GB, free: 2.879 MB / 0.7605 GB
Notification: Performance of SimCode: time 0.00203/0.03762, allocations: 2.112 MB / 0.8105 GB, free: 0.707 MB / 0.7605 GB
Notification: Performance of Templates: time 0.01877/0.05639, allocations: 14.95 MB / 0.8251 GB, free: 2.004 MB / 0.7761 GB
"
[Timeout remaining time 300]
make -j1 -f Buildings_13_Buildings.Controls.OBC.ASHRAE.G36.ThermalZones.Validation.Setpoints.makefile [Timeout 300]
(rm -f Buildings_13_Buildings.Controls.OBC.ASHRAE.G36.ThermalZones.Validation.Setpoints.pipe ; mkfifo Buildings_13_Buildings.Controls.OBC.ASHRAE.G36.ThermalZones.Validation.Setpoints.pipe ; head -c 1048576 < Buildings_13_Buildings.Controls.OBC.ASHRAE.G36.ThermalZones.Validation.Setpoints.pipe >> ../files/Buildings_13_Buildings.Controls.OBC.ASHRAE.G36.ThermalZones.Validation.Setpoints.sim & ./Buildings_13_Buildings.Controls.OBC.ASHRAE.G36.ThermalZones.Validation.Setpoints -abortSlowSimulation -alarm=240  -lv LOG_STATS > Buildings_13_Buildings.Controls.OBC.ASHRAE.G36.ThermalZones.Validation.Setpoints.pipe 2>&1) [Timeout 240]
[Calling sys.exit(0), Time elapsed: 5.116965143941343]