Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_12_Buildings.Controls.OBC.ASHRAE.G36.TerminalUnits.Reheat.Subsequences.Validation.Alarms.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.001802/0.001802, allocations: 97.11 kB / 19.7 MB, free: 2.129 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.002425/0.002425, allocations: 208.7 kB / 23 MB, free: 4.93 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.509/1.509, allocations: 230.6 MB / 256.8 MB, free: 7.789 MB / 206.1 MB
"
[Timeout remaining time 178]
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 3.394/3.394, allocations: 0.49 GB / 0.7959 GB, free: 35.43 MB / 0.6231 GB
"
[Timeout remaining time 176]
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.Controls.OBC.ASHRAE.G36.TerminalUnits.Reheat.Subsequences.Validation.Alarms,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|ala.VDis_flow|ala.VActSet_flow|ala.yLowFloAla|ala.u1Fan|ala.uOpeMod|ala.uDam|ala.uVal|ala.TSup|ala.TDis|ala.TDisSet|ala.yFloSenAla|ala.yLowTemAla|ala.yLeaValAla",fileNamePrefix="Buildings_12_Buildings.Controls.OBC.ASHRAE.G36.TerminalUnits.Reheat.Subsequences.Validation.Alarms")
translateModel(Buildings.Controls.OBC.ASHRAE.G36.TerminalUnits.Reheat.Subsequences.Validation.Alarms,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|ala.VDis_flow|ala.VActSet_flow|ala.yLowFloAla|ala.u1Fan|ala.uOpeMod|ala.uDam|ala.uVal|ala.TSup|ala.TDis|ala.TDisSet|ala.yFloSenAla|ala.yLowTemAla|ala.yLeaValAla",fileNamePrefix="Buildings_12_Buildings.Controls.OBC.ASHRAE.G36.TerminalUnits.Reheat.Subsequences.Validation.Alarms") [Timeout 300]
"Notification: Buildings requested package Modelica of version 4.0.0. Modelica 4.1.0 is used instead which states that it is fully compatible without conversion script needed.
Notification: Performance of FrontEnd - loaded program: time 0.002096/0.002096, allocations: 75.25 kB / 1.155 GB, free: 25.26 MB / 0.9044 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.4229/0.425, allocations: 176.1 MB / 1.327 GB, free: 0.9844 MB / 1.014 GB
Notification: Performance of NFInst.instantiate(Buildings.Controls.OBC.ASHRAE.G36.TerminalUnits.Reheat.Subsequences.Validation.Alarms): time 0.008519/0.4336, allocations: 3.098 MB / 1.33 GB, free: 13.88 MB / 1.029 GB
Notification: Performance of NFInst.instExpressions: time 0.008171/0.4417, allocations: 2.539 MB / 1.333 GB, free: 11.32 MB / 1.029 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.002447/0.4442, allocations: 35.75 kB / 1.333 GB, free: 11.29 MB / 1.029 GB
Notification: Performance of NFTyping.typeComponents: time 0.001317/0.4455, allocations: 193.9 kB / 1.333 GB, free: 11.1 MB / 1.029 GB
Notification: Performance of NFTyping.typeBindings: time 0.001664/0.4472, allocations: 178.2 kB / 1.333 GB, free: 10.92 MB / 1.029 GB
Notification: Performance of NFTyping.typeClassSections: time 0.005488/0.4526, allocations: 0.9168 MB / 1.334 GB, free: 10.02 MB / 1.029 GB
Notification: Performance of NFFlatten.flatten: time 0.006655/0.4593, allocations: 1.823 MB / 1.336 GB, free: 8.188 MB / 1.029 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.002673/0.462, allocations: 0.5158 MB / 1.336 GB, free: 7.633 MB / 1.029 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.002001/0.464, allocations: 0.6932 MB / 1.337 GB, free: 6.938 MB / 1.029 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.001479/0.4655, allocations: 0.6924 MB / 1.338 GB, free: 6.242 MB / 1.029 GB
Notification: Performance of NFPackage.collectConstants: time 0.0005142/0.466, allocations: 200 kB / 1.338 GB, free: 6.047 MB / 1.029 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.0004987/0.4665, allocations: 200 kB / 1.338 GB, free: 5.852 MB / 1.029 GB
Notification: Performance of NFScalarize.scalarize: time 0.0004885/0.467, allocations: 366.9 kB / 1.338 GB, free: 5.492 MB / 1.029 GB
Notification: Performance of NFVerifyModel.verify: time 0.001063/0.468, allocations: 0.599 MB / 1.339 GB, free: 4.891 MB / 1.029 GB
Notification: Performance of NFConvertDAE.convert: time 0.004444/0.4725, allocations: 2.288 MB / 1.341 GB, free: 2.594 MB / 1.029 GB
Notification: Performance of FrontEnd - DAE generated: time 8.356e-06/0.4725, allocations: 0 / 1.341 GB, free: 2.594 MB / 1.029 GB
Notification: Performance of FrontEnd: time 2.895e-06/0.4725, allocations: 0 / 1.341 GB, free: 2.594 MB / 1.029 GB
Notification: Performance of Transformations before backend: time 5.192e-05/0.4725, allocations: 0 / 1.341 GB, free: 2.594 MB / 1.029 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 249
 * Number of variables: 249
Notification: Performance of Generate backend data structure: time 0.00709/0.4796, allocations: 1.728 MB / 1.343 GB, free: 0.7852 MB / 1.029 GB
Notification: Performance of prepare preOptimizeDAE: time 7.275e-05/0.4797, allocations: 12.03 kB / 1.343 GB, free: 0.7734 MB / 1.029 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0005974/0.4803, allocations: 172 kB / 1.343 GB, free: 0.6055 MB / 1.029 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.004493/0.4848, allocations: 0.8635 MB / 1.344 GB, free: 15.71 MB / 1.045 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0002216/0.485, allocations: 102.3 kB / 1.344 GB, free: 15.62 MB / 1.045 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0004545/0.4855, allocations: 148.3 kB / 1.344 GB, free: 15.47 MB / 1.045 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.004377/0.4898, allocations: 1.175 MB / 1.345 GB, free: 14.25 MB / 1.045 GB
Notification: Performance of preOpt findStateOrder (simulation): time 4.194e-05/0.4899, allocations: 3.938 kB / 1.345 GB, free: 14.24 MB / 1.045 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.000207/0.4901, allocations: 51.97 kB / 1.345 GB, free: 14.19 MB / 1.045 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 3.93e-05/0.4901, allocations: 28 kB / 1.345 GB, free: 14.16 MB / 1.045 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.00356/0.4937, allocations: 0.7691 MB / 1.346 GB, free: 13.39 MB / 1.045 GB
Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.01095/0.5046, allocations: 2.519 MB / 1.348 GB, free: 10.82 MB / 1.045 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.00424/0.5089, allocations: 0.9069 MB / 1.349 GB, free: 9.898 MB / 1.045 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001627/0.5105, allocations: 354.6 kB / 1.35 GB, free: 9.551 MB / 1.045 GB
Notification: Performance of preOpt evalFunc (simulation): time 4.498e-05/0.5105, allocations: 4.656 kB / 1.35 GB, free: 9.547 MB / 1.045 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.002748/0.5133, allocations: 0.918 MB / 1.351 GB, free: 8.574 MB / 1.045 GB
Notification: Performance of pre-optimization done (n=110): time 7.795e-06/0.5133, allocations: 3.938 kB / 1.351 GB, free: 8.57 MB / 1.045 GB
Notification: Performance of matching and sorting (n=110): time 0.007032/0.5203, allocations: 1.609 MB / 1.352 GB, free: 6.961 MB / 1.045 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 9.935e-05/0.5204, allocations: 72.41 kB / 1.352 GB, free: 6.875 MB / 1.045 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001967/0.5224, allocations: 0.7188 MB / 1.353 GB, free: 6.148 MB / 1.045 GB
Notification: Performance of collectPreVariables (initialization): time 0.000399/0.5228, allocations: 81.7 kB / 1.353 GB, free: 6.062 MB / 1.045 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0008589/0.5237, allocations: 0.4939 MB / 1.354 GB, free: 5.562 MB / 1.045 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0004685/0.5241, allocations: 258 kB / 1.354 GB, free: 5.309 MB / 1.045 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0008637/0.525, allocations: 326.8 kB / 1.354 GB, free: 4.98 MB / 1.045 GB
Notification: Performance of setup shared object (initialization): time 0.0004658/0.5255, allocations: 414.7 kB / 1.354 GB, free: 4.566 MB / 1.045 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.002067/0.5275, allocations: 0.5448 MB / 1.355 GB, free: 3.996 MB / 1.045 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.002231/0.5298, allocations: 0.9059 MB / 1.356 GB, free: 2.926 MB / 1.045 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.003409/0.5332, allocations: 1.109 MB / 1.357 GB, free: 1.641 MB / 1.045 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.712e-05/0.5332, allocations: 8 kB / 1.357 GB, free: 1.633 MB / 1.045 GB
Notification: Performance of matching and sorting (n=174) (initialization): time 0.005189/0.5384, allocations: 1.584 MB / 1.359 GB, free: 15.99 MB / 1.061 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001804/0.5386, allocations: 134.7 kB / 1.359 GB, free: 15.84 MB / 1.061 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 3.738e-05/0.5386, allocations: 12 kB / 1.359 GB, free: 15.82 MB / 1.061 GB
Notification: Performance of postOpt tearingSystem (initialization): time 5.713e-05/0.5386, allocations: 16 kB / 1.359 GB, free: 15.81 MB / 1.061 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001083/0.5397, allocations: 159.6 kB / 1.359 GB, free: 15.65 MB / 1.061 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 5.109e-05/0.5398, allocations: 32.02 kB / 1.359 GB, free: 15.62 MB / 1.061 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002523/0.5423, allocations: 255 kB / 1.359 GB, free: 15.37 MB / 1.061 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0002208/0.5425, allocations: 67.98 kB / 1.359 GB, free: 15.3 MB / 1.061 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 48
 * Number of states: 0 ()
 * Number of discrete variables: 139 ($PRE.ala.truDel.u,$PRE.ala.truDel1.u,$PRE.ala.truDel2.u,$PRE.ala.truDel3.u,$PRE.ala.truDel4.u,$PRE.ala.truDel5.u,$PRE.ala.truDel6.u,$PRE.ala.truDel7.u,$PRE.ala.fanIni.u,$PRE.ala.truDel.t_next,$whenCondition33,$PRE.ala.truDel1.t_next,$whenCondition30,$PRE.ala.truDel2.t_next,$whenCondition27,$PRE.ala.truDel3.t_next,$whenCondition24,$PRE.ala.truDel4.t_next,$whenCondition21,$PRE.ala.truDel5.t_next,$whenCondition18,$PRE.ala.truDel6.t_next,$whenCondition15,$PRE.ala.truDel7.t_next,$whenCondition12,$PRE.ala.fanIni.t_next,$whenCondition9,$whenCondition7,$whenCondition8,$whenCondition5,$whenCondition6,$whenCondition3,$whenCondition4,$whenCondition1,$whenCondition2,ala.truDel.t_next,ala.truDel1.t_next,ala.truDel2.t_next,ala.truDel3.t_next,ala.truDel4.t_next,ala.truDel5.t_next,ala.truDel6.t_next,ala.truDel7.t_next,ala.fanIni.t_next,ala.occMod.y,ala.conInt2.y,ala.conInt.y,ala.greThr1.y,ala.greThr2.y,ala.booToInt5.y,ala.booToInt1.y,intPul.booPul.y,$PRE.intPul.booPul.y,intPul.y,hotPla.y,$PRE.hotPla.y,damSta.y,$PRE.damSta.y,supFan.y,$PRE.supFan.y,ala.isOcc.y,ala.fanIni.y,ala.fanIni.u,ala.fanHotPlaOn.y,ala.truDel7.y,ala.truDel7.u,ala.leaValAla.y,ala.gre2.greHys.y,$PRE.ala.gre2.greHys.y,ala.cloVal.lesHys.y,$PRE.ala.cloVal.lesHys.y,ala.truDel6.y,ala.truDel6.u,ala.not7.y,ala.and9.y,ala.booToInt4.y,ala.and8.y,ala.lowTemAla.y,ala.not6.y,ala.and7.y,ala.and6.y,ala.truDel5.y,ala.truDel5.u,ala.truDel4.y,ala.truDel4.u,ala.les2.lesHys.y,$PRE.ala.les2.lesHys.y,ala.les1.lesHys.y,$PRE.ala.les1.lesHys.y,ala.leaDamAla.y,ala.cloDam.lesHys.y,$PRE.ala.cloDam.lesHys.y,ala.truDel3.y,ala.truDel3.u,ala.gre1.greHys.y,$PRE.ala.gre1.greHys.y,ala.truDel2.y,ala.truDel2.u,ala.not2.y,ala.and12.y,ala.not1.y,ala.and4.y,ala.booToInt.y,ala.lowFloAla.y,ala.and1.y,ala.and2.y,ala.truDel1.y,ala.truDel1.u,ala.gre.greHys.y,$PRE.ala.gre.greHys.y,ala.greThr.greHys.y,$PRE.ala.greThr.greHys.y,ala.truDel.y,ala.truDel.u,ala.les.lesHys.y,$PRE.ala.les.lesHys.y,ala.yLowTemAla,ala.yLeaValAla,ala.yLeaDamAla,ala.yFloSenAla,ala.yLowFloAla,$whenCondition11,$whenCondition10,$whenCondition14,$whenCondition13,$whenCondition17,$whenCondition16,$whenCondition20,$whenCondition19,$whenCondition23,$whenCondition22,$whenCondition26,$whenCondition25,$whenCondition29,$whenCondition28,$whenCondition32,$whenCondition31,$whenCondition35,$whenCondition34)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (166):
 * Single equations (assignments): 162
 * Array equations: 0
 * Algorithm blocks: 4
 * 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.001135/0.5437, allocations: 363 kB / 1.36 GB, free: 14.93 MB / 1.061 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0003132/0.544, allocations: 111.4 kB / 1.36 GB, free: 14.82 MB / 1.061 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.0002912/0.5443, allocations: 105.5 kB / 1.36 GB, free: 14.72 MB / 1.061 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 1.5e-05/0.5443, allocations: 3.984 kB / 1.36 GB, free: 14.71 MB / 1.061 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 5.4e-06/0.5443, allocations: 0 / 1.36 GB, free: 14.71 MB / 1.061 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0002391/0.5445, allocations: 103.1 kB / 1.36 GB, free: 14.61 MB / 1.061 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.000247/0.5448, allocations: 43.91 kB / 1.36 GB, free: 14.57 MB / 1.061 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001011/0.5458, allocations: 91.88 kB / 1.36 GB, free: 14.48 MB / 1.061 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0005341/0.5463, allocations: 164.6 kB / 1.36 GB, free: 14.32 MB / 1.061 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.005147/0.5515, allocations: 1.333 MB / 1.361 GB, free: 12.98 MB / 1.061 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.004855/0.5563, allocations: 1.432 MB / 1.363 GB, free: 11.53 MB / 1.061 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.001803/0.5581, allocations: 467.6 kB / 1.363 GB, free: 11.07 MB / 1.061 GB
Notification: Performance of sorting global known variables: time 0.00102/0.5591, allocations: 427 kB / 1.364 GB, free: 10.66 MB / 1.061 GB
Notification: Performance of Backend: time 8.31e-07/0.5591, allocations: 0 / 1.364 GB, free: 10.66 MB / 1.061 GB
Notification: Performance of simCode: created initialization part: time 0.004347/0.5635, allocations: 1.137 MB / 1.365 GB, free: 9.441 MB / 1.061 GB
Notification: Performance of SimCode: time 0.005206/0.5687, allocations: 2.039 MB / 1.367 GB, free: 7.348 MB / 1.061 GB
Notification: Performance of Templates: time 0.04496/0.6137, allocations: 17.79 MB / 1.384 GB, free: 5.844 MB / 1.076 GB
"
[Timeout remaining time 299]
make -j1 -f Buildings_12_Buildings.Controls.OBC.ASHRAE.G36.TerminalUnits.Reheat.Subsequences.Validation.Alarms.makefile [Timeout 300]
(rm -f Buildings_12_Buildings.Controls.OBC.ASHRAE.G36.TerminalUnits.Reheat.Subsequences.Validation.Alarms.pipe ; mkfifo Buildings_12_Buildings.Controls.OBC.ASHRAE.G36.TerminalUnits.Reheat.Subsequences.Validation.Alarms.pipe ; head -c 1048576 < Buildings_12_Buildings.Controls.OBC.ASHRAE.G36.TerminalUnits.Reheat.Subsequences.Validation.Alarms.pipe >> ../files/Buildings_12_Buildings.Controls.OBC.ASHRAE.G36.TerminalUnits.Reheat.Subsequences.Validation.Alarms.sim & ./Buildings_12_Buildings.Controls.OBC.ASHRAE.G36.TerminalUnits.Reheat.Subsequences.Validation.Alarms  -abortSlowSimulation -alarm=400  -emit_protected -lv LOG_STATS > Buildings_12_Buildings.Controls.OBC.ASHRAE.G36.TerminalUnits.Reheat.Subsequences.Validation.Alarms.pipe 2>&1) [Timeout 400]
diffSimulationResults("Buildings_12_Buildings.Controls.OBC.ASHRAE.G36.TerminalUnits.Reheat.Subsequences.Validation.Alarms_res.mat","/mnt/ReferenceFiles/Buildings/csv/maint_12.x/Buildings_Controls_OBC_ASHRAE_G36_TerminalUnits_Reheat_Subsequences_Validation_Alarms.csv","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_12_Buildings.Controls.OBC.ASHRAE.G36.TerminalUnits.Reheat.Subsequences.Validation.Alarms.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001) [Timeout 300]
""
[Timeout remaining time 300]
Reference file matches
[Calling sys.exit(0), Time elapsed: 10.055314206998446]