Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_latest_Buildings.DHC.Loads.Combined.Examples.BuildingTimeSeriesWithETS.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.00183/0.00183, allocations: 114.3 kB / 18.94 MB, free: 2.934 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.002389/0.002389, allocations: 211.2 kB / 22.25 MB, free: 5.086 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.456/1.456, allocations: 230.6 MB / 256 MB, free: 8.027 MB / 206.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings master/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings master/package.mo): time 3.205/3.205, allocations: 0.505 GB / 0.8101 GB, free: 22.23 MB / 0.6231 GB
"
[Timeout remaining time 176]
Using package Buildings with version 13.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings master/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: "" <> buildModelFMU(Buildings.DHC.Loads.Combined.Examples.BuildingTimeSeriesWithETS,fileNamePrefix="Buildings_latest_Buildings_DHC_Loads_Combined_Examples_BuildingTimeSeriesWithETS",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(Buildings.DHC.Loads.Combined.Examples.BuildingTimeSeriesWithETS,fileNamePrefix="Buildings_latest_Buildings_DHC_Loads_Combined_Examples_BuildingTimeSeriesWithETS",fmuType="me",version="2.0",platforms={"static"}) [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.002207/0.002207, allocations: 74.34 kB / 1.177 GB, free: 17.09 MB / 0.9044 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.3461/0.3483, allocations: 180.2 MB / 1.353 GB, free: 8.531 MB / 1.045 GB
Notification: Performance of NFInst.instantiate(Buildings.DHC.Loads.Combined.Examples.BuildingTimeSeriesWithETS): time 3.349/3.698, allocations: 1.484 GB / 2.837 GB, free: 1.824 MB / 1.857 GB
Notification: Performance of NFInst.instExpressions: time 1.862/5.56, allocations: 308.7 MB / 3.139 GB, free: 28.85 MB / 2.107 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.05776/5.617, allocations: 1.926 MB / 3.141 GB, free: 28.85 MB / 2.107 GB
Notification: Performance of NFTyping.typeComponents: time 0.1406/5.758, allocations: 28.7 MB / 3.169 GB, free: 25.84 MB / 2.107 GB
Notification: Performance of NFTyping.typeBindings: time 0.1126/5.871, allocations: 41.55 MB / 3.209 GB, free: 25.09 MB / 2.107 GB
Notification: Performance of NFTyping.typeClassSections: time 0.06758/5.938, allocations: 31.7 MB / 3.24 GB, free: 24.15 MB / 2.107 GB
Notification: Performance of NFFlatten.flatten: time 0.1813/6.12, allocations: 126.6 MB / 3.364 GB, free: 23.36 MB / 2.107 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.06844/6.188, allocations: 23.74 MB / 3.387 GB, free: 19.02 MB / 2.107 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.09123/6.279, allocations: 35.33 MB / 3.421 GB, free: 11.14 MB / 2.107 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.0519/6.331, allocations: 21.53 MB / 3.442 GB, free: 14.59 MB / 2.123 GB
Notification: Performance of NFPackage.collectConstants: time 0.01804/6.349, allocations: 4.535 MB / 3.447 GB, free: 10.05 MB / 2.123 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.06028/6.409, allocations: 20.27 MB / 3.467 GB, free: 8.031 MB / 2.139 GB
Notification: Performance of NFScalarize.scalarize: time 0.01881/6.428, allocations: 10.57 MB / 3.477 GB, free: 13.79 MB / 2.154 GB
Notification: Performance of NFVerifyModel.verify: time 0.04951/6.478, allocations: 19.81 MB / 3.496 GB, free: 10.23 MB / 2.17 GB
Notification: Performance of NFConvertDAE.convert: time 0.1286/6.606, allocations: 71.71 MB / 3.566 GB, free: 4.477 MB / 2.232 GB
Notification: Performance of FrontEnd - DAE generated: time 6.984e-06/6.606, allocations: 0 / 3.566 GB, free: 4.477 MB / 2.232 GB
Notification: Performance of FrontEnd: time 1.593e-06/6.606, allocations: 0 / 3.566 GB, free: 4.477 MB / 2.232 GB
Notification: Performance of Transformations before backend: time 0.001736/6.608, allocations: 0 / 3.566 GB, free: 4.477 MB / 2.232 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 3848
 * Number of variables: 3848
Notification: Performance of Generate backend data structure: time 0.1102/6.718, allocations: 41.51 MB / 3.607 GB, free: 11.27 MB / 2.279 GB
Notification: Performance of prepare preOptimizeDAE: time 5.393e-05/6.718, allocations: 12.03 kB / 3.607 GB, free: 11.26 MB / 2.279 GB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.007002/6.725, allocations: 1.928 MB / 3.609 GB, free: 9.328 MB / 2.279 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.04897/6.774, allocations: 8.142 MB / 3.617 GB, free: 1.168 MB / 2.279 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.1493/6.924, allocations: 73.6 MB / 3.689 GB, free: 9.047 MB / 2.357 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.001953/6.926, allocations: 1.33 MB / 3.69 GB, free: 7.699 MB / 2.357 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.00646/6.932, allocations: 1.611 MB / 3.692 GB, free: 6.094 MB / 2.357 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.06254/6.995, allocations: 22.45 MB / 3.713 GB, free: 14.89 MB / 2.389 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0005061/6.995, allocations: 43.62 kB / 3.714 GB, free: 14.86 MB / 2.389 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.004798/7, allocations: 0.6334 MB / 3.714 GB, free: 14.23 MB / 2.389 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0005744/7, allocations: 0.5508 MB / 3.715 GB, free: 13.67 MB / 2.389 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.05598/7.056, allocations: 19.33 MB / 3.734 GB, free: 10.33 MB / 2.404 GB
Warning: The model contains alias variables with redundant start and/or conflicting nominal values. It is recommended to resolve the conflicts, because otherwise the system could be hard to solve. To print the conflicting alias sets and the chosen candidates please use -d=aliasConflicts.
Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.2162/7.273, allocations: 126 MB / 3.857 GB, free: 6.453 MB / 2.529 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.03219/7.305, allocations: 12.31 MB / 3.869 GB, free: 10.23 MB / 2.545 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0185/7.323, allocations: 7.038 MB / 3.875 GB, free: 3.188 MB / 2.545 GB
Warning: The model contains alias variables with redundant start and/or conflicting nominal values. It is recommended to resolve the conflicts, because otherwise the system could be hard to solve. To print the conflicting alias sets and the chosen candidates please use -d=aliasConflicts.
Notification: Performance of preOpt evalFunc (simulation): time 0.07754/7.401, allocations: 30.88 MB / 3.906 GB, free: 4.609 MB / 2.576 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.02355/7.424, allocations: 8.825 MB / 3.914 GB, free: 11.72 MB / 2.592 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.01345/7.438, allocations: 2.158 MB / 3.916 GB, free: 9.57 MB / 2.592 GB
Notification: Performance of pre-optimization done (n=788): time 2.951e-05/7.438, allocations: 4 kB / 3.916 GB, free: 9.566 MB / 2.592 GB
Notification: Performance of matching and sorting (n=788): time 0.1378/7.576, allocations: 32.54 MB / 3.948 GB, free: 8.98 MB / 2.623 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0002995/7.576, allocations: 475.6 kB / 3.949 GB, free: 8.422 MB / 2.623 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.07146/7.648, allocations: 26.39 MB / 3.974 GB, free: 14.21 MB / 2.654 GB
Notification: Performance of collectPreVariables (initialization): time 0.003396/7.651, allocations: 263.3 kB / 3.975 GB, free: 13.95 MB / 2.654 GB
Notification: Performance of collectInitialEqns (initialization): time 0.02062/7.672, allocations: 12.85 MB / 3.987 GB, free: 1.148 MB / 2.654 GB
Notification: Performance of collectInitialBindings (initialization): time 0.005245/7.677, allocations: 2.867 MB / 3.99 GB, free: 14.32 MB / 2.67 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.01417/7.691, allocations: 3.917 MB / 3.994 GB, free: 10.39 MB / 2.67 GB
Notification: Performance of setup shared object (initialization): time 0.0001309/7.691, allocations: 305.1 kB / 3.994 GB, free: 10.09 MB / 2.67 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.02556/7.717, allocations: 11.25 MB / 4.005 GB, free: 14.85 MB / 2.686 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.03257/7.749, allocations: 16.11 MB / 4.021 GB, free: 12.79 MB / 2.701 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.05306/7.802, allocations: 25.28 MB / 4.046 GB, free: 2.004 MB / 2.717 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0001465/7.802, allocations: 32 kB / 4.046 GB, free: 1.973 MB / 2.717 GB
Notification: Performance of matching and sorting (n=2145) (initialization): time 0.8684/8.671, allocations: 33.23 MB / 4.078 GB, free: 1.518 GB / 2.717 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001288/8.671, allocations: 56.41 kB / 4.078 GB, free: 1.518 GB / 2.717 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0002455/8.671, allocations: 116 kB / 4.078 GB, free: 1.518 GB / 2.717 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.02029/8.692, allocations: 5.87 MB / 4.084 GB, free: 1.516 GB / 2.717 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01602/8.708, allocations: 3.275 MB / 4.087 GB, free: 1.516 GB / 2.717 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.03209/8.74, allocations: 26.84 MB / 4.113 GB, free: 1.496 GB / 2.717 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.02185/8.761, allocations: 1.102 MB / 4.114 GB, free: 1.496 GB / 2.717 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.003962/8.765, allocations: 0.8392 MB / 4.115 GB, free: 1.496 GB / 2.717 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.03429/8.8, allocations: 17.23 MB / 4.132 GB, free: 1.488 GB / 2.717 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.02346/8.823, allocations: 15 MB / 4.147 GB, free: 1.478 GB / 2.717 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.03978/8.863, allocations: 23.11 MB / 4.169 GB, free: 1.465 GB / 2.717 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 0.0001364/8.863, allocations: 31.78 kB / 4.169 GB, free: 1.465 GB / 2.717 GB
Notification: Performance of matching and sorting (n=2145) (initialization_lambda0): time 0.08928/8.952, allocations: 31.44 MB / 4.2 GB, free: 1.454 GB / 2.717 GB
Notification: Performance of prepare postOptimizeDAE: time 9.738e-05/8.952, allocations: 49.78 kB / 4.2 GB, free: 1.454 GB / 2.717 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.000207/8.953, allocations: 117.6 kB / 4.2 GB, free: 1.454 GB / 2.717 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.01726/8.97, allocations: 5.579 MB / 4.206 GB, free: 1.452 GB / 2.717 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01426/8.984, allocations: 3.249 MB / 4.209 GB, free: 1.452 GB / 2.717 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.03833/9.023, allocations: 31.71 MB / 4.24 GB, free: 1.425 GB / 2.717 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.02177/9.044, allocations: 1.158 MB / 4.241 GB, free: 1.424 GB / 2.717 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.00363/9.048, allocations: 0.7867 MB / 4.242 GB, free: 1.423 GB / 2.717 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 510
 * Number of states: 0 ()
 * Number of discrete variables: 79 ($PRE.bui.bui.loa.nextTimeEvent,$whenCondition1,bui.enaSHW.y,bui.bui.terUniCoo.con1.y,bui.bui.terUniHea.con1.y,bui.ets.enaSHW.not_u,$PRE.bui.ets.enaSHW.not_u,$whenCondition10,bui.bui.terUniHea.hex.flowRegime_nominal,bui.bui.terUniHea.hex.flowRegime,bui.ets.hexChi.flowRegime_nominal,bui.ets.hexChi.flowRegime,bui.bui.terUniCoo.hexWetNtu.flowRegime_nominal,bui.bui.terUniCoo.hexWetNtu.dryWetCalcs.fullyDry.cfg,bui.bui.terUniCoo.hexWetNtu.dryWetCalcs.fullyWet.cfg,bui.bui.terUniCoo.hexWetNtu.dryWetCalcs.cfg,bui.bui.terUniCoo.hexWetNtu.flowRegime,bui.bui.terUniCoo.hexWetNtu.UAFroRated.isFulWet,bui.bui.terUniCoo.hexWetNtu.UAFroRated.isFulDry,bui.ets.enaSHW.u,$PRE.bui.ets.enaSHW.u,bui.bui.loa.nextTimeEvent,bui.bui.loa.nextTimeEventScaled,$PRE.bui.bui.loa.nextTimeEventScaled,bui.bui.terUniHea.greThr.greHys.y,$PRE.bui.bui.terUniHea.greThr.greHys.y,bui.bui.terUniCoo.greThr.greHys.y,$PRE.bui.bui.terUniCoo.greThr.greHys.y,bui.ets.swiFlo.con.posDom.greHys.y,$PRE.bui.ets.swiFlo.con.posDom.greHys.y,bui.ets.swiFlo.con.truFalHol.u,$PRE.bui.ets.swiFlo.con.truFalHol.u,bui.ets.swiFlo.con.truFalHol.y,$PRE.bui.ets.swiFlo.con.truFalHol.y,bui.ets.swiFlo.con.truFalHol.not_u,$PRE.bui.ets.swiFlo.con.truFalHol.not_u,bui.ets.swiFlo.con.truFalHol.not_y,$PRE.bui.ets.swiFlo.con.truFalHol.not_y,bui.ets.swiFlo.con.truFalHol.entryTimeTrue,$PRE.bui.ets.swiFlo.con.truFalHol.entryTimeTrue,bui.ets.swiFlo.con.truFalHol.entryTimeFalse,$PRE.bui.ets.swiFlo.con.truFalHol.entryTimeFalse,bui.ets.swiFlo.con.movAve.mode,$PRE.bui.ets.swiFlo.con.movAve.mode,bui.ets.enaHea.u,$PRE.bui.ets.enaHea.u,bui.ets.enaHea.y,$PRE.bui.ets.enaHea.y,bui.ets.enaHea.not_u,$PRE.bui.ets.enaHea.not_u,bui.ets.enaHea.not_y,$PRE.bui.ets.enaHea.not_y,bui.ets.enaHea.entryTimeTrue,$PRE.bui.ets.enaHea.entryTimeTrue,bui.ets.enaHea.entryTimeFalse,$PRE.bui.ets.enaHea.entryTimeFalse,bui.ets.enaSHW.y,$PRE.bui.ets.enaSHW.y,bui.ets.enaSHW.not_y,$PRE.bui.ets.enaSHW.not_y,bui.ets.enaSHW.entryTimeTrue,$PRE.bui.ets.enaSHW.entryTimeTrue,bui.ets.enaSHW.entryTimeFalse,$PRE.bui.ets.enaSHW.entryTimeFalse,bui.enaHeaCoo[2].y,$whenCondition2,$whenCondition3,$whenCondition4,$whenCondition5,$whenCondition6,$whenCondition7,$whenCondition8,$whenCondition9,$whenCondition11,$whenCondition12,$whenCondition13,$whenCondition14,$whenCondition15,$whenCondition16)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (1661):
 * Single equations (assignments): 1623
 * Array equations: 11
 * Algorithm blocks: 0
 * Record equations: 9
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 6
 * Torn equation systems: 12
 * Mixed (continuous/discrete) equation systems: 0
Notification: Equation system details (not torn):
 * Constant Jacobian (size): 0 systems
 * Linear Jacobian (size,density): 0 systems
 * Non-linear Jacobian (size): 6 systems
   {1, 1, 1, 1, 1, 1}
 * Without analytic Jacobian (size): 0 systems
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 4 systems
   {(1,3,100.0%), (1,3,100.0%), (1,3,100.0%), (4,8,93.8%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 8 systems
   {(1,4), (1,34), (1,4), (1,2), (1,60), (5,2), (1,4), (6,32)}
Notification: Performance of prepare postOptimizeDAE: time 0.006123/9.054, allocations: 1.08 MB / 4.243 GB, free: 1.422 GB / 2.717 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.008347/9.062, allocations: 2.484 MB / 4.245 GB, free: 1.42 GB / 2.717 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.06171/9.124, allocations: 19.61 MB / 4.264 GB, free: 1.402 GB / 2.717 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.0002074/9.124, allocations: 106.1 kB / 4.264 GB, free: 1.402 GB / 2.717 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 3.805e-05/9.124, allocations: 8 kB / 4.264 GB, free: 1.402 GB / 2.717 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.04848/9.173, allocations: 15.62 MB / 4.28 GB, free: 1.386 GB / 2.717 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.1154/9.288, allocations: 45.72 MB / 4.324 GB, free: 1.342 GB / 2.717 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 9.559e-05/9.288, allocations: 11.97 kB / 4.324 GB, free: 1.342 GB / 2.717 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.009155/9.297, allocations: 1.676 MB / 4.326 GB, free: 1.34 GB / 2.717 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.01204/9.31, allocations: 4.071 MB / 4.33 GB, free: 1.336 GB / 2.717 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.002243/9.312, allocations: 271.8 kB / 4.33 GB, free: 1.336 GB / 2.717 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.02793/9.34, allocations: 25.25 MB / 4.355 GB, free: 1.311 GB / 2.717 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 6.673e-06/9.34, allocations: 11.94 kB / 4.355 GB, free: 1.311 GB / 2.717 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.07598/9.416, allocations: 28.79 MB / 4.383 GB, free: 1.283 GB / 2.717 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.01401/9.43, allocations: 4.809 MB / 4.388 GB, free: 1.278 GB / 2.717 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.007858/9.438, allocations: 223.9 kB / 4.388 GB, free: 1.278 GB / 2.717 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.01811/9.456, allocations: 0.8354 MB / 4.389 GB, free: 1.277 GB / 2.717 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.003037/9.459, allocations: 0.6413 MB / 4.389 GB, free: 1.276 GB / 2.717 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.003095/9.462, allocations: 439.7 kB / 4.39 GB, free: 1.276 GB / 2.717 GB
Notification: Performance of sorting global known variables: time 0.03959/9.501, allocations: 17.96 MB / 4.407 GB, free: 1.258 GB / 2.717 GB
Notification: Performance of sort global known variables: time 1.9e-07/9.501, allocations: 4 kB / 4.407 GB, free: 1.258 GB / 2.717 GB
Notification: Performance of remove unused functions: time 0.04641/9.548, allocations: 11.97 MB / 4.419 GB, free: 1.248 GB / 2.717 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 39
 * Number of states: 29 (bui.ets.proHotWat.conPI.I.y,bui.ets.proHotWat.valHeaPumEva.actPos.y,bui.ets.proHotWat.pumCon.vol.dynBal.U,bui.ets.proHotWat.heaPum.eva.vol.dynBal.U,bui.ets.proHotWat.heaPum.con.outCon.T,bui.ets.senTChiWatRet.T,bui.ets.senTHeaWatRet.T,bui.ets.proHeaWat.conPI.I.y,bui.ets.proHeaWat.valHeaPumEva.actPos.y,bui.ets.proHeaWat.pumCon.vol.dynBal.U,bui.ets.proHeaWat.heaPum.eva.vol.dynBal.U,bui.ets.proHeaWat.heaPum.con.outCon.T,bui.ets.swiFlo.con.movAve.mu,bui.ets.senTChiWatSup.T,bui.ets.senTHeaWatSup.T,bui.ets.conTChiWat.conPID.I.y,bui.ets.volChiWat.dynBal.U,bui.ets.volHeaWatRet.dynBal.U,bui.ets.volMix_b.dynBal.U,bui.ets.volMix_a.dynBal.U,bui.bui.terUniCoo.TLoaODE.TAir,bui.bui.terUniCoo.hexWetNtu.dryWetCalcs.fullyWet.TWatOutEst,bui.bui.terUniCoo.con.I.y,bui.bui.disFloCoo.senTSup.T,bui.bui.disFloCoo.heaCoo.vol.dynBal.U,bui.bui.disFloHea.senTSup.T,bui.bui.disFloHea.heaCoo.vol.dynBal.U,bui.bui.terUniHea.TLoaODE.TAir,bui.bui.terUniHea.con.I.y)
 * Number of discrete variables: 39 (bui.enaHeaCoo[2].y,$whenCondition16,$whenCondition15,$whenCondition14,$whenCondition13,$whenCondition12,$whenCondition11,$whenCondition10,$whenCondition9,$whenCondition8,$whenCondition7,$whenCondition6,$whenCondition5,$whenCondition4,$whenCondition3,$whenCondition2,$whenCondition1,bui.ets.enaSHW.entryTimeFalse,bui.ets.enaSHW.entryTimeTrue,bui.ets.enaSHW.not_y,bui.ets.enaSHW.y,bui.ets.enaHea.entryTimeFalse,bui.ets.enaHea.entryTimeTrue,bui.ets.enaHea.not_y,bui.ets.enaHea.not_u,bui.ets.enaHea.y,bui.ets.enaHea.u,bui.ets.swiFlo.con.movAve.mode,bui.ets.swiFlo.con.truFalHol.entryTimeFalse,bui.ets.swiFlo.con.truFalHol.entryTimeTrue,bui.ets.swiFlo.con.truFalHol.not_y,bui.ets.swiFlo.con.truFalHol.not_u,bui.ets.swiFlo.con.truFalHol.y,bui.ets.swiFlo.con.truFalHol.u,bui.ets.swiFlo.con.posDom.greHys.y,bui.bui.terUniCoo.greThr.greHys.y,bui.bui.terUniHea.greThr.greHys.y,bui.bui.loa.nextTimeEventScaled,bui.bui.loa.nextTimeEvent)
 * Number of discrete states: 21 (bui.ets.enaSHW.entryTimeFalse,bui.ets.enaSHW.entryTimeTrue,bui.ets.enaHea.entryTimeFalse,bui.ets.enaHea.entryTimeTrue,bui.ets.swiFlo.con.truFalHol.entryTimeFalse,bui.ets.swiFlo.con.truFalHol.entryTimeTrue,bui.bui.loa.nextTimeEvent,bui.ets.enaSHW.y,bui.ets.enaSHW.not_y,bui.ets.swiFlo.con.posDom.greHys.y,bui.ets.swiFlo.con.truFalHol.u,bui.ets.swiFlo.con.truFalHol.not_u,bui.ets.swiFlo.con.truFalHol.y,bui.ets.swiFlo.con.truFalHol.not_y,bui.bui.loa.nextTimeEventScaled,bui.bui.terUniCoo.greThr.greHys.y,bui.ets.enaHea.u,bui.ets.enaHea.not_u,bui.ets.enaHea.y,bui.ets.enaHea.not_y,bui.bui.terUniHea.greThr.greHys.y)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (741):
 * Single equations (assignments): 676
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 36
 * When equations: 12
 * If-equations: 0
 * Equation systems (not torn): 5
 * Torn equation systems: 12
 * Mixed (continuous/discrete) equation systems: 0
Notification: Equation system details (not torn):
 * Constant Jacobian (size): 0 systems
 * Linear Jacobian (size,density): 0 systems
 * Non-linear Jacobian (size): 5 systems
   {1, 1, 1, 1, 1}
 * Without analytic Jacobian (size): 0 systems
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 4 systems
   {(1,3,100.0%), (1,3,100.0%), (4,8,93.8%), (1,3,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 8 systems
   {(1,4), (1,4), (6,34), (1,4), (1,2), (1,56), (1,1), (1,36)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.07764/9.625, allocations: 32.01 MB / 4.45 GB, free: 1.217 GB / 2.717 GB
Notification: Performance of simCode: created initialization part: time 0.07773/9.703, allocations: 35.17 MB / 4.485 GB, free: 1.182 GB / 2.717 GB
Notification: Performance of simCode: created event and clocks part: time 2.371e-05/9.703, allocations: 11 kB / 4.485 GB, free: 1.182 GB / 2.717 GB
Notification: Performance of simCode: created simulation system equations: time 0.02123/9.724, allocations: 8.706 MB / 4.493 GB, free: 1.174 GB / 2.717 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.05951/9.784, allocations: 13.05 MB / 4.506 GB, free: 1.162 GB / 2.717 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.5326/10.32, allocations: 214.7 MB / 4.715 GB, free: 0.9477 GB / 2.717 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.02695/10.34, allocations: 11.93 MB / 4.727 GB, free: 0.936 GB / 2.717 GB
Notification: Performance of simCode: alias equations: time 0.03456/10.38, allocations: 5.845 MB / 4.733 GB, free: 0.9305 GB / 2.717 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.02464/10.4, allocations: 12.53 MB / 4.745 GB, free: 0.9182 GB / 2.717 GB
Notification: Performance of SimCode: time 1.102e-06/10.4, allocations: 0 / 4.745 GB, free: 0.9182 GB / 2.717 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 1.023/11.43, allocations: 0.757 GB / 5.502 GB, free: 166.1 MB / 2.717 GB
Notification: Performance of buildModelFMU: Generate platform static: time 201.7/213.1, allocations: 3.797 kB / 5.502 GB, free: 166.1 MB / 2.717 GB
"
[Timeout remaining time 86]
(rm -f Buildings_latest_Buildings.DHC.Loads.Combined.Examples.BuildingTimeSeriesWithETS.pipe ; mkfifo Buildings_latest_Buildings.DHC.Loads.Combined.Examples.BuildingTimeSeriesWithETS.pipe ; head -c 1048576 < Buildings_latest_Buildings.DHC.Loads.Combined.Examples.BuildingTimeSeriesWithETS.pipe >> ../files/Buildings_latest_Buildings.DHC.Loads.Combined.Examples.BuildingTimeSeriesWithETS.sim & python3 -m fmpy simulate  --output-file Buildings_latest_Buildings.DHC.Loads.Combined.Examples.BuildingTimeSeriesWithETS_res.csv --start-time 0 --stop-time 864000 --timeout 800 --relative-tolerance 1e-06 --interface-type ModelExchange --solver CVode --output-interval 345.6 Buildings_latest_Buildings_DHC_Loads_Combined_Examples_BuildingTimeSeriesWithETS.fmu > Buildings_latest_Buildings.DHC.Loads.Combined.Examples.BuildingTimeSeriesWithETS.pipe 2>&1) [Timeout 840.0]
[Calling os._exit(0), Time elapsed: 220.4579509580003]
Failed to read output from testmodel.py, exit status != 0:
213.75613144199997 213.770909792 207.160493892
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f0af44f2f20>