Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_11_Buildings.Templates.Plants.Controls.StagingRotation.Validation.StageCompletion.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001678/0.001678, allocations: 114 kB / 17.6 MB, free: 4.699 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001807/0.001807, allocations: 186.7 kB / 20.78 MB, free: 1.539 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.477/1.477, allocations: 225.6 MB / 249.4 MB, free: 3.16 MB / 190.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.1.0-maint.11.x/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.1.0-maint.11.x/package.mo): time 2.908/2.908, allocations: 476.7 MB / 0.7629 GB, free: 15.09 MB / 0.6075 GB
"
[Timeout remaining time 176]
Using package Buildings with version 11.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.1.0-maint.11.x/package.mo)
Using package Modelica with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo)
Using package Complex with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo)
Using package ModelicaServices with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo)
Running command: "" <> buildModelFMU(Buildings.Templates.Plants.Controls.StagingRotation.Validation.StageCompletion,fileNamePrefix="Buildings_11_Buildings_Templates_Plants_Controls_StagingRotation_Validation_StageCompletion",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(Buildings.Templates.Plants.Controls.StagingRotation.Validation.StageCompletion,fileNamePrefix="Buildings_11_Buildings_Templates_Plants_Controls_StagingRotation_Validation_StageCompletion",fmuType="me",version="2.0",platforms={"static"}) [Timeout 300]
"Notification: Performance of FrontEnd - loaded program: time 0.002326/0.002326, allocations: 67.89 kB / 1.107 GB, free: 5.141 MB / 0.8419 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.9558/0.9581, allocations: 168.7 MB / 1.271 GB, free: 7.711 MB / 0.9981 GB
Notification: Performance of NFInst.instantiate(Buildings.Templates.Plants.Controls.StagingRotation.Validation.StageCompletion): time 0.004535/0.9626, allocations: 2.751 MB / 1.274 GB, free: 5.816 MB / 0.9981 GB
Notification: Performance of NFInst.instExpressions: time 0.002567/0.9652, allocations: 1.531 MB / 1.276 GB, free: 4.746 MB / 0.9981 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0003692/0.9656, allocations: 15.22 kB / 1.276 GB, free: 4.742 MB / 0.9981 GB
Notification: Performance of NFTyping.typeComponents: time 0.0007689/0.9663, allocations: 305.6 kB / 1.276 GB, free: 4.633 MB / 0.9981 GB
Notification: Performance of NFTyping.typeBindings: time 0.0003293/0.9667, allocations: 182.1 kB / 1.276 GB, free: 4.551 MB / 0.9981 GB
Notification: Performance of NFTyping.typeClassSections: time 0.001585/0.9683, allocations: 0.7042 MB / 1.277 GB, free: 4.125 MB / 0.9981 GB
Notification: Performance of NFFlatten.flatten: time 0.002697/0.971, allocations: 2.31 MB / 1.279 GB, free: 3.094 MB / 0.9981 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.002332/0.9733, allocations: 1.229 MB / 1.28 GB, free: 2.566 MB / 0.9981 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.001354/0.9746, allocations: 0.8404 MB / 1.281 GB, free: 2.219 MB / 0.9981 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.001112/0.9758, allocations: 0.711 MB / 1.282 GB, free: 1.902 MB / 0.9981 GB
Notification: Performance of NFPackage.collectConstants: time 0.0004091/0.9762, allocations: 199.5 kB / 1.282 GB, free: 1.898 MB / 0.9981 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.0004886/0.9766, allocations: 252.8 kB / 1.282 GB, free: 1.875 MB / 0.9981 GB
Notification: Performance of NFScalarize.scalarize: time 0.001224/0.9779, allocations: 0.9477 MB / 1.283 GB, free: 1.5 MB / 0.9981 GB
Notification: Performance of NFVerifyModel.verify: time 0.0008608/0.9787, allocations: 0.7954 MB / 1.284 GB, free: 0.9688 MB / 0.9981 GB
Notification: Performance of NFConvertDAE.convert: time 0.003143/0.9819, allocations: 2.614 MB / 1.286 GB, free: 32 kB / 0.9981 GB
Notification: Performance of FrontEnd - DAE generated: time 4.658e-06/0.9819, allocations: 0 / 1.286 GB, free: 32 kB / 0.9981 GB
Notification: Performance of FrontEnd: time 1.433e-06/0.9819, allocations: 0 / 1.286 GB, free: 32 kB / 0.9981 GB
Notification: Performance of Transformations before backend: time 5.306e-05/0.9819, allocations: 1.906 kB / 1.286 GB, free: 32 kB / 0.9981 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 244
 * Number of variables: 244
Notification: Performance of Generate backend data structure: time 0.004173/0.9861, allocations: 1.805 MB / 1.288 GB, free: 14.92 MB / 1.014 GB
Notification: Performance of prepare preOptimizeDAE: time 4.746e-05/0.9862, allocations: 10.19 kB / 1.288 GB, free: 14.92 MB / 1.014 GB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.000256/0.9864, allocations: 154.8 kB / 1.288 GB, free: 14.82 MB / 1.014 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0005284/0.9869, allocations: 158.9 kB / 1.289 GB, free: 14.75 MB / 1.014 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.001884/0.9888, allocations: 0.9915 MB / 1.29 GB, free: 14.18 MB / 1.014 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001359/0.989, allocations: 114.1 kB / 1.29 GB, free: 14.14 MB / 1.014 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0003296/0.9893, allocations: 154.9 kB / 1.29 GB, free: 14.09 MB / 1.014 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.002775/0.9921, allocations: 1.383 MB / 1.291 GB, free: 13.44 MB / 1.014 GB
Notification: Performance of preOpt findStateOrder (simulation): time 2.826e-05/0.9921, allocations: 5.531 kB / 1.291 GB, free: 13.43 MB / 1.014 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.000123/0.9922, allocations: 44.69 kB / 1.291 GB, free: 13.41 MB / 1.014 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 3.323e-05/0.9923, allocations: 23.69 kB / 1.291 GB, free: 13.41 MB / 1.014 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.001973/0.9942, allocations: 0.9878 MB / 1.292 GB, free: 13.04 MB / 1.014 GB
Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.008628/1.003, allocations: 5.007 MB / 1.297 GB, free: 9.754 MB / 1.014 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.002209/1.005, allocations: 1.259 MB / 1.298 GB, free: 9.152 MB / 1.014 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0009061/1.006, allocations: 0.5183 MB / 1.299 GB, free: 8.914 MB / 1.014 GB
Notification: Performance of preOpt evalFunc (simulation): time 4.418e-05/1.006, allocations: 10.47 kB / 1.299 GB, free: 8.914 MB / 1.014 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.001528/1.008, allocations: 0.8553 MB / 1.3 GB, free: 8.559 MB / 1.014 GB
Notification: Performance of pre-optimization done (n=107): time 2.965e-06/1.008, allocations: 0 / 1.3 GB, free: 8.559 MB / 1.014 GB
Notification: Performance of matching and sorting (n=107): time 0.003814/1.011, allocations: 1.733 MB / 1.301 GB, free: 7.941 MB / 1.014 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0002006/1.012, allocations: 237 kB / 1.302 GB, free: 7.684 MB / 1.014 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001785/1.013, allocations: 0.9904 MB / 1.303 GB, free: 7.285 MB / 1.014 GB
Notification: Performance of collectPreVariables (initialization): time 0.0005758/1.014, allocations: 105.7 kB / 1.303 GB, free: 7.211 MB / 1.014 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0006829/1.015, allocations: 494.2 kB / 1.303 GB, free: 6.836 MB / 1.014 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0003276/1.015, allocations: 261.4 kB / 1.303 GB, free: 6.637 MB / 1.014 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0009456/1.016, allocations: 488.7 kB / 1.304 GB, free: 6.477 MB / 1.014 GB
Notification: Performance of setup shared object (initialization): time 0.0003393/1.016, allocations: 418.2 kB / 1.304 GB, free: 6.121 MB / 1.014 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0009375/1.017, allocations: 430 kB / 1.305 GB, free: 5.973 MB / 1.014 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.00279/1.02, allocations: 1.548 MB / 1.306 GB, free: 4.773 MB / 1.014 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.001913/1.022, allocations: 1.031 MB / 1.307 GB, free: 4.004 MB / 1.014 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.228e-05/1.022, allocations: 3.938 kB / 1.307 GB, free: 4.004 MB / 1.014 GB
Notification: Performance of matching and sorting (n=174) (initialization): time 0.003132/1.025, allocations: 1.309 MB / 1.308 GB, free: 3.484 MB / 1.014 GB
Notification: Performance of prepare postOptimizeDAE: time 6.115e-05/1.025, allocations: 14.34 kB / 1.308 GB, free: 3.48 MB / 1.014 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 3.437e-05/1.025, allocations: 13.11 kB / 1.308 GB, free: 3.48 MB / 1.014 GB
Notification: Performance of postOpt tearingSystem (initialization): time 5.245e-05/1.025, allocations: 18.16 kB / 1.308 GB, free: 3.48 MB / 1.014 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0005644/1.026, allocations: 135.8 kB / 1.309 GB, free: 3.453 MB / 1.014 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 5.716e-05/1.026, allocations: 29.2 kB / 1.309 GB, free: 3.445 MB / 1.014 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002669/1.028, allocations: 262.2 kB / 1.309 GB, free: 3.336 MB / 1.014 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001517/1.029, allocations: 57.27 kB / 1.309 GB, free: 3.328 MB / 1.014 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 52
 * Number of states: 0 ()
 * Number of discrete variables: 148 ($PRE.comSta.holAnyCha.onDel1.u,$PRE.comSta.holAnyCha.onDel2.u,$PRE.comSta.holAnyCha.toTrue.enableFire,$PRE.comSta.holAnyCha.toFalse.enableFire,$PRE.comSta.holAnyCha.toTrue1.enableFire,$PRE.comSta.holAnyCha.toFalse1.enableFire,$PRE.y1ComSta.onDelay.u,$PRE.y1ComSta.toOutputTrue.enableFire,$PRE.y1ComSta.toInitial.enableFire,$whenCondition22,$whenCondition21,$whenCondition20,$PRE.y1ComSta.onDelay.t_next,$whenCondition17,$whenCondition16,$whenCondition15,$whenCondition14,$whenCondition13,$whenCondition12,$whenCondition11,$whenCondition10,$PRE.comSta.holAnyCha.onDel2.t_next,$whenCondition7,$PRE.comSta.holAnyCha.onDel1.t_next,$whenCondition4,y1ComSta.onDelay.t_next,comSta.holAnyCha.onDel2.t_next,comSta.holAnyCha.onDel1.t_next,idxSta.idx,$PRE.idxSta.idx,idxSta.y[1],$PRE.idxSta.y[1],y1ComSta.toInitial.enableFire,y1ComSta.toOutputTrue.enableFire,y1ComSta.outputTrue.active,y1ComSta.outputTrue.oldActive,$PRE.y1ComSta.outputTrue.oldActive,y1ComSta.outputTrue.newActive,$PRE.y1ComSta.outputTrue.newActive,y1ComSta.outputTrue.localActive,$PRE.y1ComSta.outputTrue.localActive,y1ComSta.initialStep.oldActive,$PRE.y1ComSta.initialStep.oldActive,y1ComSta.initialStep.newActive,$PRE.y1ComSta.initialStep.newActive,y1ComSta.initialStep.localActive,$PRE.y1ComSta.initialStep.localActive,y1ComSta.initialStep.active,y1ComSta.onDelay.y,y1ComSta.onDelay.u,y1ComSta.stateGraphRoot.activeSteps,y1ComSta.u,booTimTab.intTimTab.idx,$PRE.booTimTab.intTimTab.idx,booTimTab.intTimTab.y[4],$PRE.booTimTab.intTimTab.y[4],booTimTab.intTimTab.y[3],$PRE.booTimTab.intTimTab.y[3],booTimTab.intTimTab.y[2],$PRE.booTimTab.intTimTab.y[2],booTimTab.intTimTab.y[1],$PRE.booTimTab.intTimTab.y[1],booTimTab.y[4],booTimTab.y[3],comSta.chaSta.down,comSta.chaSta.up,comSta.chaSta.y,comSta.chaSta.u,$PRE.comSta.chaSta.u,comSta.holAnyCha.toFalse1.enableFire,comSta.holAnyCha.toTrue1.enableFire,comSta.holAnyCha.initialStep.oldActive,$PRE.comSta.holAnyCha.initialStep.oldActive,comSta.holAnyCha.initialStep.newActive,$PRE.comSta.holAnyCha.initialStep.newActive,comSta.holAnyCha.initialStep.outPort[2].available,comSta.holAnyCha.initialStep.localActive,$PRE.comSta.holAnyCha.initialStep.localActive,comSta.holAnyCha.initialStep.active,comSta.holAnyCha.toFalse.enableFire,comSta.holAnyCha.toFalse.localCondition,comSta.holAnyCha.outputTrue.active,comSta.holAnyCha.outputTrue.oldActive,$PRE.comSta.holAnyCha.outputTrue.oldActive,comSta.holAnyCha.outputTrue.newActive,$PRE.comSta.holAnyCha.outputTrue.newActive,comSta.holAnyCha.outputTrue.inPort[2].occupied,comSta.holAnyCha.outputTrue.localActive,$PRE.comSta.holAnyCha.outputTrue.localActive,comSta.holAnyCha.toTrue.enableFire,comSta.holAnyCha.toTrue.localCondition,comSta.holAnyCha.outputFalse.active,comSta.holAnyCha.outputFalse.oldActive,$PRE.comSta.holAnyCha.outputFalse.oldActive,comSta.holAnyCha.outputFalse.newActive,$PRE.comSta.holAnyCha.outputFalse.newActive,comSta.holAnyCha.outputFalse.inPort[2].occupied,comSta.holAnyCha.outputFalse.localActive,$PRE.comSta.holAnyCha.outputFalse.localActive,comSta.holAnyCha.stateGraphRoot.activeSteps,comSta.holAnyCha.onDel2.y,comSta.holAnyCha.onDel2.u,comSta.holAnyCha.onDel1.y,comSta.holAnyCha.onDel1.u,comSta.holAnyCha.u,comSta.chaAndMat.y,comSta.anyCha.u[1],comSta.lckAnyCha.y,comSta.cha[2].y,comSta.cha[2].u,$PRE.comSta.cha[2].u,comSta.cha[1].u,$PRE.comSta.cha[1].u,comSta.lckChaSta.y,comSta.endStaPro.not_u,$PRE.comSta.endStaPro.not_u,comSta.onOrOff[2].y,comSta.allTru.y,comSta.allTru.u[1],comSta.disAndOff[2].y,comSta.disAndOff[1].y,comSta.enaAndOn[2].y,comSta.enaAndOn[1].y,$whenCondition1,$whenCondition2,$whenCondition3,$whenCondition6,$whenCondition5,$whenCondition9,$whenCondition8,$whenCondition19,$whenCondition18,comSta.holAnyCha.toTrue.t_start,$PRE.comSta.holAnyCha.toTrue.t_start,comSta.holAnyCha.toFalse.t_start,$PRE.comSta.holAnyCha.toFalse.t_start,comSta.holAnyCha.toTrue1.t_start,$PRE.comSta.holAnyCha.toTrue1.t_start,comSta.holAnyCha.toFalse1.t_start,$PRE.comSta.holAnyCha.toFalse1.t_start,y1ComSta.toOutputTrue.t_start,$PRE.y1ComSta.toOutputTrue.t_start,y1ComSta.toInitial.t_start,$PRE.y1ComSta.toInitial.t_start,y1ComSta.stateGraphRoot.resume,y1ComSta.stateGraphRoot.suspend,comSta.holAnyCha.stateGraphRoot.resume,comSta.holAnyCha.stateGraphRoot.suspend)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (174):
 * Single equations (assignments): 174
 * Array equations: 0
 * Algorithm blocks: 0
 * 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.001446/1.03, allocations: 0.5307 MB / 1.309 GB, free: 3.004 MB / 1.014 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0003365/1.03, allocations: 104.3 kB / 1.31 GB, free: 2.949 MB / 1.014 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.002438/1.033, allocations: 1.347 MB / 1.311 GB, free: 2.434 MB / 1.014 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 2.162e-05/1.033, allocations: 14.11 kB / 1.311 GB, free: 2.434 MB / 1.014 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.032e-05/1.033, allocations: 5.156 kB / 1.311 GB, free: 2.43 MB / 1.014 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 1.996e-05/1.033, allocations: 11.7 kB / 1.311 GB, free: 2.426 MB / 1.014 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.004806/1.038, allocations: 2.785 MB / 1.314 GB, free: 1.121 MB / 1.014 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 8.205e-06/1.038, allocations: 2.406 kB / 1.314 GB, free: 1.121 MB / 1.014 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0001918/1.038, allocations: 49.58 kB / 1.314 GB, free: 1.105 MB / 1.014 GB
Notification: Performance of postOpt tearingSystem (simulation): time 1.305e-05/1.038, allocations: 10.19 kB / 1.314 GB, free: 1.102 MB / 1.014 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 8.236e-05/1.038, allocations: 34.45 kB / 1.314 GB, free: 1.086 MB / 1.014 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 1.07e-05/1.038, allocations: 6.438 kB / 1.314 GB, free: 1.086 MB / 1.014 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 3.617e-06/1.038, allocations: 2.219 kB / 1.314 GB, free: 1.086 MB / 1.014 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.002333/1.04, allocations: 1.44 MB / 1.315 GB, free: 460 kB / 1.014 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0002402/1.041, allocations: 185.1 kB / 1.315 GB, free: 296 kB / 1.014 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001699/1.041, allocations: 47.14 kB / 1.315 GB, free: 268 kB / 1.014 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0003898/1.041, allocations: 38.84 kB / 1.315 GB, free: 256 kB / 1.014 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0003206/1.041, allocations: 130.5 kB / 1.316 GB, free: 224 kB / 1.014 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0001059/1.042, allocations: 54 kB / 1.316 GB, free: 216 kB / 1.014 GB
Notification: Performance of sorting global known variables: time 0.001075/1.043, allocations: 0.6232 MB / 1.316 GB, free: 15.97 MB / 1.029 GB
Notification: Performance of sort global known variables: time 8e-08/1.043, allocations: 1.25 kB / 1.316 GB, free: 15.97 MB / 1.029 GB
Notification: Performance of remove unused functions: time 0.001606/1.044, allocations: 328.7 kB / 1.316 GB, free: 15.89 MB / 1.029 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 7
 * Number of states: 0 ()
 * Number of discrete variables: 107 (y1ComSta.toInitial.t_start,y1ComSta.toOutputTrue.t_start,comSta.holAnyCha.toFalse1.t_start,comSta.holAnyCha.toTrue1.t_start,comSta.holAnyCha.toFalse.t_start,comSta.holAnyCha.toTrue.t_start,comSta.chaAndMat.y,comSta.chaSta.y,y1ComSta.outputTrue.localActive,y1ComSta.onDelay.u,y1ComSta.outputTrue.active,y1ComSta.initialStep.active,comSta.holAnyCha.initialStep.active,comSta.holAnyCha.outputTrue.localActive,comSta.holAnyCha.onDel2.u,comSta.holAnyCha.outputTrue.active,comSta.holAnyCha.outputFalse.localActive,comSta.holAnyCha.onDel1.u,comSta.holAnyCha.outputFalse.active,$cse1,$cse2,$cse4,$cse5,$cse6,$cse7,$cse8,$whenCondition22,$whenCondition21,$whenCondition20,$whenCondition17,$whenCondition18,$whenCondition19,$whenCondition16,$whenCondition15,$whenCondition14,$whenCondition13,$whenCondition12,$whenCondition11,$whenCondition10,$whenCondition7,$whenCondition8,$whenCondition9,$whenCondition4,$whenCondition5,$whenCondition6,$whenCondition3,$whenCondition2,$whenCondition1,comSta.enaAndOn[1].y,comSta.enaAndOn[2].y,comSta.disAndOff[1].y,comSta.disAndOff[2].y,comSta.allTru.u[1],comSta.allTru.y,comSta.onOrOff[2].y,comSta.endStaPro.not_u,comSta.lckChaSta.y,comSta.cha[1].u,comSta.cha[2].u,comSta.cha[2].y,comSta.lckAnyCha.y,comSta.anyCha.u[1],comSta.holAnyCha.u,comSta.holAnyCha.onDel1.y,comSta.holAnyCha.onDel1.t_next,comSta.holAnyCha.onDel2.y,comSta.holAnyCha.onDel2.t_next,comSta.holAnyCha.stateGraphRoot.activeSteps,comSta.holAnyCha.outputFalse.inPort[2].occupied,comSta.holAnyCha.outputFalse.newActive,comSta.holAnyCha.outputFalse.oldActive,comSta.holAnyCha.toTrue.localCondition,comSta.holAnyCha.toTrue.enableFire,comSta.holAnyCha.outputTrue.inPort[2].occupied,comSta.holAnyCha.outputTrue.newActive,comSta.holAnyCha.outputTrue.oldActive,comSta.holAnyCha.toFalse.localCondition,comSta.holAnyCha.toFalse.enableFire,comSta.holAnyCha.initialStep.localActive,comSta.holAnyCha.initialStep.outPort[2].available,comSta.holAnyCha.initialStep.newActive,comSta.holAnyCha.initialStep.oldActive,comSta.holAnyCha.toTrue1.enableFire,comSta.holAnyCha.toFalse1.enableFire,comSta.chaSta.u,comSta.chaSta.up,comSta.chaSta.down,booTimTab.y[3],booTimTab.y[4],booTimTab.intTimTab.y[1],booTimTab.intTimTab.y[2],booTimTab.intTimTab.y[3],booTimTab.intTimTab.y[4],booTimTab.intTimTab.idx,y1ComSta.u,y1ComSta.stateGraphRoot.activeSteps,y1ComSta.onDelay.y,y1ComSta.onDelay.t_next,y1ComSta.initialStep.localActive,y1ComSta.initialStep.newActive,y1ComSta.initialStep.oldActive,y1ComSta.outputTrue.newActive,y1ComSta.outputTrue.oldActive,y1ComSta.toOutputTrue.enableFire,y1ComSta.toInitial.enableFire,idxSta.y[1],idxSta.idx)
 * Number of discrete states: 18 (y1ComSta.onDelay.t_next,comSta.holAnyCha.onDel2.t_next,comSta.holAnyCha.onDel1.t_next,comSta.holAnyCha.outputFalse.newActive,comSta.holAnyCha.outputTrue.newActive,comSta.holAnyCha.initialStep.newActive,y1ComSta.initialStep.newActive,y1ComSta.outputTrue.newActive,comSta.chaSta.u,comSta.cha[1].u,comSta.cha[2].u,comSta.endStaPro.not_u,comSta.holAnyCha.toTrue.t_start,comSta.holAnyCha.toFalse.t_start,comSta.holAnyCha.toTrue1.t_start,comSta.holAnyCha.toFalse1.t_start,y1ComSta.toOutputTrue.t_start,y1ComSta.toInitial.t_start)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (114):
 * Single equations (assignments): 88
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 26
 * 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.002902/1.047, allocations: 2.12 MB / 1.319 GB, free: 14.66 MB / 1.029 GB
Notification: Performance of simCode: created initialization part: time 0.002489/1.05, allocations: 1.13 MB / 1.32 GB, free: 14.29 MB / 1.029 GB
Notification: Performance of simCode: created event and clocks part: time 4.358e-06/1.05, allocations: 1.312 kB / 1.32 GB, free: 14.29 MB / 1.029 GB
Notification: Performance of simCode: created simulation system equations: time 0.0009325/1.051, allocations: 0.5348 MB / 1.32 GB, free: 14.12 MB / 1.029 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.0007749/1.051, allocations: 128 kB / 1.32 GB, free: 14.05 MB / 1.029 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.01948/1.071, allocations: 9.463 MB / 1.33 GB, free: 9.078 MB / 1.029 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001185/1.072, allocations: 1.118 MB / 1.331 GB, free: 8.324 MB / 1.029 GB
Notification: Performance of simCode: alias equations: time 0.001154/1.073, allocations: 222 kB / 1.331 GB, free: 8.293 MB / 1.029 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0009228/1.074, allocations: 440.2 kB / 1.331 GB, free: 7.977 MB / 1.029 GB
Notification: Performance of SimCode: time 1.062e-06/1.074, allocations: 0 / 1.331 GB, free: 7.977 MB / 1.029 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.06962/1.144, allocations: 25.58 MB / 1.356 GB, free: 13.1 MB / 1.045 GB
Notification: Performance of buildModelFMU: Generate platform static: time 9.858/11, allocations: 12.23 kB / 1.356 GB, free: 13.09 MB / 1.045 GB
"
[Timeout remaining time 289]
(rm -f Buildings_11_Buildings.Templates.Plants.Controls.StagingRotation.Validation.StageCompletion.pipe ; mkfifo Buildings_11_Buildings.Templates.Plants.Controls.StagingRotation.Validation.StageCompletion.pipe ; head -c 1048576 < Buildings_11_Buildings.Templates.Plants.Controls.StagingRotation.Validation.StageCompletion.pipe >> ../files/Buildings_11_Buildings.Templates.Plants.Controls.StagingRotation.Validation.StageCompletion.sim & python3 -m fmpy simulate  --output-file Buildings_11_Buildings.Templates.Plants.Controls.StagingRotation.Validation.StageCompletion_res.csv --start-time 0 --stop-time 1800 --timeout 400 --relative-tolerance 1e-06 --interface-type ModelExchange --solver CVode --output-interval 0.72 Buildings_11_Buildings_Templates_Plants_Controls_StagingRotation_Validation_StageCompletion.fmu > Buildings_11_Buildings.Templates.Plants.Controls.StagingRotation.Validation.StageCompletion.pipe 2>&1) [Timeout 420.0]
[Calling os._exit(0), Time elapsed: 17.138376185001107]
Failed to read output from testmodel.py, exit status != 0:
11.0903600580059 11.113729897 10.127224533
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7fcc62060a90>