Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_12_Buildings.DHC.ETS.Combined.Examples.ChillerOnly.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.001843/0.001843, allocations: 99.75 kB / 18.95 MB, free: 2.832 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.002168/0.002168, allocations: 216.9 kB / 22.25 MB, free: 5.105 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.469/1.469, allocations: 230.6 MB / 256 MB, free: 7.797 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.232/3.232, allocations: 0.49 GB / 0.7951 GB, free: 35.42 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: "" <> buildModelFMU(Buildings.DHC.ETS.Combined.Examples.ChillerOnly,fileNamePrefix="Buildings_12_Buildings_DHC_ETS_Combined_Examples_ChillerOnly",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(Buildings.DHC.ETS.Combined.Examples.ChillerOnly,fileNamePrefix="Buildings_12_Buildings_DHC_ETS_Combined_Examples_ChillerOnly",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.002087/0.002087, allocations: 68.86 kB / 1.154 GB, free: 25.41 MB / 0.9044 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.4026/0.4047, allocations: 176.1 MB / 1.326 GB, free: 1.418 MB / 1.014 GB
Notification: Performance of NFInst.instantiate(Buildings.DHC.ETS.Combined.Examples.ChillerOnly): time 3.438/3.842, allocations: 1.381 GB / 2.707 GB, free: 123.7 MB / 1.764 GB
Notification: Performance of NFInst.instExpressions: time 0.4145/4.257, allocations: 260.7 MB / 2.961 GB, free: 6.488 MB / 1.904 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.06528/4.322, allocations: 1.813 MB / 2.963 GB, free: 4.66 MB / 1.904 GB
Notification: Performance of NFTyping.typeComponents: time 0.04765/4.37, allocations: 15 MB / 2.978 GB, free: 5.578 MB / 1.92 GB
Notification: Performance of NFTyping.typeBindings: time 0.1137/4.483, allocations: 33.81 MB / 3.011 GB, free: 3.648 MB / 1.951 GB
Notification: Performance of NFTyping.typeClassSections: time 1.487/5.97, allocations: 26.94 MB / 3.037 GB, free: 49.86 MB / 1.967 GB
Notification: Performance of NFFlatten.flatten: time 0.2655/6.236, allocations: 137 MB / 3.171 GB, free: 46.5 MB / 1.967 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.07043/6.306, allocations: 27.44 MB / 3.197 GB, free: 44.78 MB / 1.967 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.08789/6.394, allocations: 36.33 MB / 3.233 GB, free: 43.18 MB / 1.967 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.05435/6.448, allocations: 24.72 MB / 3.257 GB, free: 39.26 MB / 1.967 GB
Notification: Performance of NFPackage.collectConstants: time 0.01669/6.465, allocations: 4.262 MB / 3.261 GB, free: 39.26 MB / 1.967 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.04754/6.512, allocations: 12.27 MB / 3.273 GB, free: 39.26 MB / 1.967 GB
Notification: Performance of NFScalarize.scalarize: time 0.02338/6.536, allocations: 10.31 MB / 3.283 GB, free: 37.77 MB / 1.967 GB
Notification: Performance of NFVerifyModel.verify: time 0.04564/6.581, allocations: 15.46 MB / 3.298 GB, free: 34.09 MB / 1.967 GB
Notification: Performance of NFConvertDAE.convert: time 0.1058/6.687, allocations: 67.97 MB / 3.365 GB, free: 11.7 MB / 1.967 GB
Notification: Performance of FrontEnd - DAE generated: time 8.155e-06/6.687, allocations: 0 / 3.365 GB, free: 11.7 MB / 1.967 GB
Notification: Performance of FrontEnd: time 1.844e-06/6.687, allocations: 0 / 3.365 GB, free: 11.7 MB / 1.967 GB
Notification: Performance of Transformations before backend: time 0.001903/6.689, allocations: 0 / 3.365 GB, free: 11.7 MB / 1.967 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 4443
 * Number of variables: 4443
Notification: Performance of Generate backend data structure: time 0.1405/6.83, allocations: 44.79 MB / 3.408 GB, free: 8.484 MB / 1.998 GB
Notification: Performance of prepare preOptimizeDAE: time 7.885e-05/6.83, allocations: 12.03 kB / 3.408 GB, free: 8.473 MB / 1.998 GB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.01823/6.848, allocations: 2.273 MB / 3.411 GB, free: 7.277 MB / 1.998 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.03438/6.882, allocations: 5.541 MB / 3.416 GB, free: 1.73 MB / 1.998 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.133/7.015, allocations: 58.77 MB / 3.473 GB, free: 9.418 MB / 2.061 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.002733/7.018, allocations: 1.497 MB / 3.475 GB, free: 7.898 MB / 2.061 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.01114/7.029, allocations: 1.797 MB / 3.477 GB, free: 6.109 MB / 2.061 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.0967/7.126, allocations: 27.97 MB / 3.504 GB, free: 8.938 MB / 2.092 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.001198/7.127, allocations: 39.89 kB / 3.504 GB, free: 8.914 MB / 2.092 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.008066/7.135, allocations: 0.7362 MB / 3.505 GB, free: 8.184 MB / 2.092 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0004941/7.136, allocations: 473.6 kB / 3.505 GB, free: 7.727 MB / 2.092 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.06263/7.198, allocations: 20.57 MB / 3.525 GB, free: 3.309 MB / 2.107 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.2422/7.44, allocations: 94.72 MB / 3.618 GB, free: 4.996 MB / 2.201 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.02458/7.465, allocations: 9.601 MB / 3.627 GB, free: 11.5 MB / 2.217 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.01555/7.481, allocations: 5.91 MB / 3.633 GB, free: 5.586 MB / 2.217 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.07185/7.552, allocations: 21.35 MB / 3.654 GB, free: 424 kB / 2.232 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.02087/7.573, allocations: 9.49 MB / 3.663 GB, free: 6.297 MB / 2.248 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.01503/7.588, allocations: 1.251 MB / 3.664 GB, free: 5.047 MB / 2.248 GB
Notification: Performance of pre-optimization done (n=730): time 3.659e-05/7.588, allocations: 0 / 3.664 GB, free: 5.047 MB / 2.248 GB
Notification: Performance of matching and sorting (n=730): time 0.05871/7.647, allocations: 17.22 MB / 3.681 GB, free: 3.777 MB / 2.264 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.000233/7.647, allocations: 231.9 kB / 3.681 GB, free: 3.512 MB / 2.264 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.09076/7.738, allocations: 31.05 MB / 3.712 GB, free: 4.652 MB / 2.295 GB
Notification: Performance of collectPreVariables (initialization): time 0.003365/7.741, allocations: 268.8 kB / 3.712 GB, free: 4.387 MB / 2.295 GB
Notification: Performance of collectInitialEqns (initialization): time 0.02603/7.767, allocations: 14.43 MB / 3.726 GB, free: 6.035 MB / 2.311 GB
Notification: Performance of collectInitialBindings (initialization): time 0.005708/7.773, allocations: 2.662 MB / 3.729 GB, free: 3.41 MB / 2.311 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.009913/7.783, allocations: 3.232 MB / 3.732 GB, free: 172 kB / 2.311 GB
Notification: Performance of setup shared object (initialization): time 0.0001463/7.783, allocations: 305.1 kB / 3.732 GB, free: 15.87 MB / 2.326 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.01668/7.8, allocations: 8.396 MB / 3.74 GB, free: 7.477 MB / 2.326 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.02777/7.828, allocations: 15.87 MB / 3.756 GB, free: 5.004 MB / 2.342 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.04293/7.871, allocations: 20.44 MB / 3.776 GB, free: 15.36 MB / 2.373 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0001778/7.871, allocations: 36 kB / 3.776 GB, free: 15.32 MB / 2.373 GB
Notification: Performance of matching and sorting (n=1878) (initialization): time 0.06793/7.939, allocations: 24.32 MB / 3.799 GB, free: 7.707 MB / 2.389 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001143/7.939, allocations: 60 kB / 3.8 GB, free: 7.648 MB / 2.389 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0002389/7.939, allocations: 123.9 kB / 3.8 GB, free: 7.527 MB / 2.389 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.004784/7.944, allocations: 0.958 MB / 3.801 GB, free: 6.555 MB / 2.389 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01721/7.961, allocations: 3.023 MB / 3.804 GB, free: 3.73 MB / 2.389 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01501/7.976, allocations: 13.96 MB / 3.817 GB, free: 5.227 MB / 2.404 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.02582/8.002, allocations: 0.8557 MB / 3.818 GB, free: 4.371 MB / 2.404 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.004214/8.006, allocations: 0.7388 MB / 3.819 GB, free: 3.633 MB / 2.404 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.03922/8.045, allocations: 16.2 MB / 3.835 GB, free: 3.43 MB / 2.42 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.02729/8.073, allocations: 15.09 MB / 3.849 GB, free: 1.723 MB / 2.436 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.04795/8.121, allocations: 18.91 MB / 3.868 GB, free: 13.57 MB / 2.467 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 0.000257/8.121, allocations: 36 kB / 3.868 GB, free: 13.54 MB / 2.467 GB
Notification: Performance of matching and sorting (n=1878) (initialization_lambda0): time 0.06404/8.185, allocations: 22.66 MB / 3.89 GB, free: 7.543 MB / 2.482 GB
Notification: Performance of prepare postOptimizeDAE: time 0.000192/8.185, allocations: 64.59 kB / 3.89 GB, free: 7.48 MB / 2.482 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0002712/8.185, allocations: 124 kB / 3.89 GB, free: 7.359 MB / 2.482 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.004748/8.19, allocations: 0.8891 MB / 3.891 GB, free: 6.453 MB / 2.482 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01723/8.207, allocations: 2.994 MB / 3.894 GB, free: 3.656 MB / 2.482 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01468/8.222, allocations: 13.26 MB / 3.907 GB, free: 5.758 MB / 2.498 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.02502/8.247, allocations: 0.9012 MB / 3.908 GB, free: 4.859 MB / 2.498 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.00427/8.251, allocations: 0.6873 MB / 3.908 GB, free: 4.172 MB / 2.498 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 554
 * Number of states: 0 ()
 * Number of discrete variables: 113 ($PRE.loa.nextTimeEvent,$whenCondition14,$PRE.TDisWatSup.nextTimeEvent,$whenCondition13,ets.chi.chi.tru.y,EChi.local_reset,ets.chi.con.conValCon.conPID.cheYMinMax.y,ets.chi.con.conValEva.conPID.cheYMinMax.y,ets.conSup.conCol.conTChiWatSup.conPID.cheYMinMax.y,ets.conSup.conHot.conHeaRej.conPID.cheYMinMax.y,ets.conSup.conHot.conColRej.conPID.cheYMinMax.y,ets.hex.hex.flowRegime_nominal,ets.hex.hex.flowRegime,ets.conSup.uHeaHol.u,$PRE.ets.conSup.uHeaHol.u,ets.conSup.uHeaHol.y,$PRE.ets.conSup.uHeaHol.y,ets.conSup.uHeaHol.not_u,$PRE.ets.conSup.uHeaHol.not_u,ets.conSup.uHeaHol.not_y,$PRE.ets.conSup.uHeaHol.not_y,ets.conSup.uHeaHol.entryTimeTrue,$PRE.ets.conSup.uHeaHol.entryTimeTrue,ets.conSup.uHeaHol.entryTimeFalse,$PRE.ets.conSup.uHeaHol.entryTimeFalse,ets.conSup.uCooHol.u,$PRE.ets.conSup.uCooHol.u,ets.conSup.uCooHol.y,$PRE.ets.conSup.uCooHol.y,ets.conSup.uCooHol.not_u,$PRE.ets.conSup.uCooHol.not_u,ets.conSup.uCooHol.not_y,$PRE.ets.conSup.uCooHol.not_y,ets.conSup.uCooHol.entryTimeTrue,$PRE.ets.conSup.uCooHol.entryTimeTrue,ets.conSup.uCooHol.entryTimeFalse,$PRE.ets.conSup.uCooHol.entryTimeFalse,ets.conSup.conHot.greThr.greHys.y,$PRE.ets.conSup.conHot.greThr.greHys.y,ets.conSup.conHot.isValIsoConClo.lesHys.y,$PRE.ets.conSup.conHot.isValIsoConClo.lesHys.y,ets.conSup.conHot.isValIsoEvaClo.lesHys.y,$PRE.ets.conSup.conHot.isValIsoEvaClo.lesHys.y,ets.conSup.conHot.mulAnd.y,ets.conSup.conHot.mulAnd.uTemp[2],ets.conSup.conHot.isBelLoc.lesHys.y,$PRE.ets.conSup.conHot.isBelLoc.lesHys.y,ets.conSup.conHot.truFalHol.u,$PRE.ets.conSup.conHot.truFalHol.u,ets.conSup.conHot.truFalHol.y,$PRE.ets.conSup.conHot.truFalHol.y,ets.conSup.conHot.truFalHol.not_u,$PRE.ets.conSup.conHot.truFalHol.not_u,ets.conSup.conHot.truFalHol.not_y,$PRE.ets.conSup.conHot.truFalHol.not_y,ets.conSup.conHot.truFalHol.entryTimeTrue,$PRE.ets.conSup.conHot.truFalHol.entryTimeTrue,ets.conSup.conHot.truFalHol.entryTimeFalse,$PRE.ets.conSup.conHot.truFalHol.entryTimeFalse,ets.conSup.conHot.pre.u,$PRE.ets.conSup.conHot.pre.u,ets.conSup.conHot.and2.y,ets.conSup.conCol.greThr.greHys.y,$PRE.ets.conSup.conCol.greThr.greHys.y,ets.conSup.conCol.truFalHol.u,$PRE.ets.conSup.conCol.truFalHol.u,ets.conSup.conCol.truFalHol.y,$PRE.ets.conSup.conCol.truFalHol.y,ets.conSup.conCol.truFalHol.not_u,$PRE.ets.conSup.conCol.truFalHol.not_u,ets.conSup.conCol.truFalHol.not_y,$PRE.ets.conSup.conCol.truFalHol.not_y,ets.conSup.conCol.truFalHol.entryTimeTrue,$PRE.ets.conSup.conCol.truFalHol.entryTimeTrue,ets.conSup.conCol.truFalHol.entryTimeFalse,$PRE.ets.conSup.conCol.truFalHol.entryTimeFalse,ets.conSup.conCol.pre.u,$PRE.ets.conSup.conCol.pre.u,ets.hex.con.greThr.greHys.y,$PRE.ets.hex.con.greThr.greHys.y,ets.hex.con.and2.y,ets.hex.con.heaRej.greHys.y,$PRE.ets.hex.con.heaRej.greHys.y,ets.hex.con.cooRej.greHys.y,$PRE.ets.hex.con.cooRej.greHys.y,ets.hex.con.or1.y,ets.chi.con.yChi,uHea.greHys.y,$PRE.uHea.greHys.y,uCoo.greHys.y,$PRE.uCoo.greHys.y,TDisWatSup.nextTimeEvent,TDisWatSup.nextTimeEventScaled,$PRE.TDisWatSup.nextTimeEventScaled,loa.nextTimeEvent,loa.nextTimeEventScaled,$PRE.loa.nextTimeEventScaled,$whenCondition1,$whenCondition2,$whenCondition3,$whenCondition4,$whenCondition5,$whenCondition6,$whenCondition7,$whenCondition8,$whenCondition9,$whenCondition10,$whenCondition11,$whenCondition12,$whenCondition15,$whenCondition16,$whenCondition17,$whenCondition18)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (1631):
 * Single equations (assignments): 1606
 * Array equations: 6
 * Algorithm blocks: 0
 * Record equations: 6
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 6
 * Torn equation systems: 7
 * 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,1,100.0%), (1,1,100.0%), (1,9,100.0%), (1,9,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 3 systems
   {(2,8), (1,4), (1,4)}
Notification: Performance of prepare postOptimizeDAE: time 0.00794/8.259, allocations: 1.077 MB / 3.909 GB, free: 3.285 MB / 2.498 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.01253/8.272, allocations: 2.639 MB / 3.912 GB, free: 0.6289 MB / 2.498 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.05106/8.323, allocations: 14.37 MB / 3.926 GB, free: 2.246 MB / 2.514 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.0001384/8.323, allocations: 83.98 kB / 3.926 GB, free: 2.164 MB / 2.514 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 2.776e-05/8.323, allocations: 4 kB / 3.926 GB, free: 2.16 MB / 2.514 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.8527/9.176, allocations: 10.34 MB / 3.936 GB, free: 1.338 GB / 2.514 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.1057/9.281, allocations: 33.59 MB / 3.969 GB, free: 1.335 GB / 2.514 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 3.387e-05/9.281, allocations: 3.969 kB / 3.969 GB, free: 1.335 GB / 2.514 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.009364/9.291, allocations: 1.595 MB / 3.971 GB, free: 1.335 GB / 2.514 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.003329/9.294, allocations: 0.6365 MB / 3.971 GB, free: 1.334 GB / 2.514 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.001869/9.296, allocations: 254.9 kB / 3.971 GB, free: 1.334 GB / 2.514 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.007937/9.304, allocations: 13.27 MB / 3.984 GB, free: 1.323 GB / 2.514 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 4.047e-06/9.304, allocations: 7.844 kB / 3.984 GB, free: 1.323 GB / 2.514 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.05044/9.354, allocations: 20.45 MB / 4.004 GB, free: 1.316 GB / 2.514 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.02087/9.375, allocations: 4.596 MB / 4.009 GB, free: 1.314 GB / 2.514 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.01027/9.385, allocations: 223.1 kB / 4.009 GB, free: 1.314 GB / 2.514 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.01978/9.405, allocations: 0.6279 MB / 4.01 GB, free: 1.314 GB / 2.514 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.002789/9.408, allocations: 0.5975 MB / 4.01 GB, free: 1.314 GB / 2.514 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.002204/9.41, allocations: 418.1 kB / 4.011 GB, free: 1.314 GB / 2.514 GB
Notification: Performance of sorting global known variables: time 0.05153/9.462, allocations: 21.53 MB / 4.032 GB, free: 1.306 GB / 2.514 GB
Notification: Performance of sort global known variables: time 4.01e-07/9.462, allocations: 3.906 kB / 4.032 GB, free: 1.306 GB / 2.514 GB
Notification: Performance of remove unused functions: time 0.0547/9.516, allocations: 12.63 MB / 4.044 GB, free: 1.305 GB / 2.514 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 5
 * Number of states: 44 (senTDisWatRet.T,EChi.y,senTDisWatSup.T,volChiWat.dynBal.U,volHeaWat.dynBal.U,senTChiWatRet.T,senTHeaWatRet.T,ets.chi.valCon.vol.dynBal.U,ets.chi.valEva.vol.dynBal.U,ets.chi.senTEvaLvg.T,ets.chi.senTEvaEnt.T,ets.chi.senTConEnt.T,ets.chi.senTConLvg.T,ets.chi.con.conValCon.conPID.I.y,ets.chi.con.conValEva.conPID.I.y,ets.chi.chi.vol2.dynBal.U,ets.chi.chi.vol1.dynBal.U,ets.colAmbWat.con[1].junConRet.vol.dynBal.U,ets.colAmbWat.con[1].junConSup.vol.dynBal.U,ets.colHeaWat.con[2].junConRet.vol.dynBal.U,ets.colHeaWat.con[2].junConSup.vol.dynBal.U,ets.colHeaWat.con[1].junConRet.vol.dynBal.U,ets.colHeaWat.con[1].junConSup.vol.dynBal.U,ets.colChiWat.con[2].junConRet.vol.dynBal.U,ets.colChiWat.con[2].junConSup.vol.dynBal.U,ets.colChiWat.con[1].junConRet.vol.dynBal.U,ets.colChiWat.con[1].junConSup.vol.dynBal.U,ets.tanHeaWat.tan.vol[3].dynBal.U,ets.tanHeaWat.tan.vol[2].dynBal.U,ets.tanHeaWat.tan.vol[1].dynBal.U,ets.tanChiWat.tan.vol[3].dynBal.U,ets.tanChiWat.tan.vol[2].dynBal.U,ets.tanChiWat.tan.vol[1].dynBal.U,ets.hex.val2.vol.dynBal.U,ets.hex.senT2WatLvg.T,ets.hex.senT2WatEnt.T,ets.conSup.resTCooSup.ramLimHea.y,ets.conSup.resTHeaSup.ramLimHea.y,ets.conSup.conCol.ramLimHea.y,ets.conSup.conCol.conTChiWatSup.conPID.I.y,ets.conSup.conHot.conHeaRej.conPID.I.y,ets.conSup.conHot.conColRej.conPID.I.y,senTChiWatSup.T,senTHeaWatSup.T)
 * Number of discrete variables: 64 (ets.conSup.conHot.mulAnd.y,ets.chi.con.yChi,ets.conSup.conHot.and2.y,$whenCondition18,$whenCondition17,$whenCondition16,$whenCondition15,$whenCondition14,$whenCondition13,$whenCondition12,$whenCondition11,$whenCondition10,$whenCondition9,$whenCondition8,$whenCondition7,$whenCondition6,$whenCondition5,$whenCondition4,$whenCondition3,$whenCondition2,$whenCondition1,loa.nextTimeEventScaled,loa.nextTimeEvent,TDisWatSup.nextTimeEventScaled,TDisWatSup.nextTimeEvent,uCoo.greHys.y,uHea.greHys.y,ets.hex.con.or1.y,ets.hex.con.cooRej.greHys.y,ets.hex.con.heaRej.greHys.y,ets.hex.con.and2.y,ets.hex.con.greThr.greHys.y,ets.conSup.conCol.pre.u,ets.conSup.conCol.truFalHol.entryTimeFalse,ets.conSup.conCol.truFalHol.entryTimeTrue,ets.conSup.conCol.truFalHol.not_y,ets.conSup.conCol.truFalHol.not_u,ets.conSup.conCol.truFalHol.y,ets.conSup.conCol.truFalHol.u,ets.conSup.conCol.greThr.greHys.y,ets.conSup.conHot.pre.u,ets.conSup.conHot.truFalHol.entryTimeFalse,ets.conSup.conHot.truFalHol.entryTimeTrue,ets.conSup.conHot.truFalHol.not_y,ets.conSup.conHot.truFalHol.not_u,ets.conSup.conHot.truFalHol.y,ets.conSup.conHot.truFalHol.u,ets.conSup.conHot.isBelLoc.lesHys.y,ets.conSup.conHot.mulAnd.uTemp[2],ets.conSup.conHot.isValIsoEvaClo.lesHys.y,ets.conSup.conHot.isValIsoConClo.lesHys.y,ets.conSup.conHot.greThr.greHys.y,ets.conSup.uCooHol.entryTimeFalse,ets.conSup.uCooHol.entryTimeTrue,ets.conSup.uCooHol.not_y,ets.conSup.uCooHol.not_u,ets.conSup.uCooHol.y,ets.conSup.uCooHol.u,ets.conSup.uHeaHol.entryTimeFalse,ets.conSup.uHeaHol.entryTimeTrue,ets.conSup.uHeaHol.not_y,ets.conSup.uHeaHol.not_u,ets.conSup.uHeaHol.y,ets.conSup.uHeaHol.u)
 * Number of discrete states: 40 (loa.nextTimeEvent,TDisWatSup.nextTimeEvent,ets.conSup.conCol.truFalHol.entryTimeFalse,ets.conSup.conCol.truFalHol.entryTimeTrue,ets.conSup.conHot.truFalHol.entryTimeFalse,ets.conSup.conHot.truFalHol.entryTimeTrue,ets.conSup.uCooHol.entryTimeFalse,ets.conSup.uCooHol.entryTimeTrue,ets.conSup.uHeaHol.entryTimeFalse,ets.conSup.uHeaHol.entryTimeTrue,ets.conSup.conHot.pre.u,ets.conSup.conHot.truFalHol.u,ets.conSup.conHot.truFalHol.not_u,ets.conSup.conCol.pre.u,ets.conSup.conCol.truFalHol.u,ets.conSup.conCol.truFalHol.not_u,ets.conSup.conHot.isBelLoc.lesHys.y,loa.nextTimeEventScaled,uCoo.greHys.y,ets.conSup.uCooHol.u,ets.conSup.uCooHol.not_u,uHea.greHys.y,ets.conSup.uHeaHol.u,ets.conSup.uHeaHol.not_u,TDisWatSup.nextTimeEventScaled,ets.conSup.conCol.truFalHol.y,ets.conSup.conCol.truFalHol.not_y,ets.hex.con.cooRej.greHys.y,ets.conSup.conHot.isValIsoEvaClo.lesHys.y,ets.conSup.conHot.truFalHol.y,ets.conSup.conHot.truFalHol.not_y,ets.hex.con.heaRej.greHys.y,ets.conSup.conHot.isValIsoConClo.lesHys.y,ets.conSup.uCooHol.y,ets.conSup.uCooHol.not_y,ets.conSup.conHot.greThr.greHys.y,ets.conSup.uHeaHol.y,ets.conSup.uHeaHol.not_y,ets.conSup.conCol.greThr.greHys.y,ets.hex.con.greThr.greHys.y)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (772):
 * Single equations (assignments): 712
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 31
 * When equations: 16
 * If-equations: 0
 * Equation systems (not torn): 6
 * Torn equation systems: 7
 * 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,1,100.0%), (1,1,100.0%), (1,9,100.0%), (1,9,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 3 systems
   {(2,8), (1,4), (1,4)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.0523/9.569, allocations: 24.87 MB / 4.068 GB, free: 1.285 GB / 2.514 GB
Notification: Performance of simCode: created initialization part: time 0.0513/9.62, allocations: 26.68 MB / 4.094 GB, free: 1.262 GB / 2.514 GB
Notification: Performance of simCode: created event and clocks part: time 2.02e-05/9.62, allocations: 11.28 kB / 4.094 GB, free: 1.262 GB / 2.514 GB
Notification: Performance of simCode: created simulation system equations: time 0.01378/9.634, allocations: 5.946 MB / 4.1 GB, free: 1.257 GB / 2.514 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.07074/9.705, allocations: 14.14 MB / 4.114 GB, free: 1.247 GB / 2.514 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.5228/10.23, allocations: 220.8 MB / 4.33 GB, free: 1.033 GB / 2.514 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.03909/10.27, allocations: 15.58 MB / 4.345 GB, free: 1.018 GB / 2.514 GB
Notification: Performance of simCode: alias equations: time 0.03707/10.3, allocations: 7.267 MB / 4.352 GB, free: 1.011 GB / 2.514 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.02902/10.33, allocations: 13.77 MB / 4.365 GB, free: 0.9971 GB / 2.514 GB
Notification: Performance of SimCode: time 1.323e-06/10.33, allocations: 0 / 4.365 GB, free: 0.9971 GB / 2.514 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.9642/11.3, allocations: 0.773 GB / 5.138 GB, free: 231.2 MB / 2.514 GB
Notification: Performance of buildModelFMU: Generate platform static: time 265.7/277, allocations: 15.86 kB / 5.138 GB, free: 231.2 MB / 2.514 GB
"
[Timeout remaining time 22]
(rm -f Buildings_12_Buildings.DHC.ETS.Combined.Examples.ChillerOnly.pipe ; mkfifo Buildings_12_Buildings.DHC.ETS.Combined.Examples.ChillerOnly.pipe ; head -c 1048576 < Buildings_12_Buildings.DHC.ETS.Combined.Examples.ChillerOnly.pipe >> ../files/Buildings_12_Buildings.DHC.ETS.Combined.Examples.ChillerOnly.sim & /home/hudson/saved_omc/OMSimulator/install/bin/OMSimulator -r=Buildings_12_Buildings.DHC.ETS.Combined.Examples.ChillerOnly_res.mat --tempDir=temp_Buildings_12_Buildings_DHC_ETS_Combined_Examples_ChillerOnly_fmu --startTime=6.5e+06 --stopTime=7e+06 --stepSize=200 --timeout=400 --tolerance=1e-06 Buildings_12_Buildings_DHC_ETS_Combined_Examples_ChillerOnly.fmu > Buildings_12_Buildings.DHC.ETS.Combined.Examples.ChillerOnly.pipe 2>&1) [Timeout 420.0]
diffSimulationResults("Buildings_12_Buildings.DHC.ETS.Combined.Examples.ChillerOnly_res.mat","/mnt/ReferenceFiles/Buildings/csv/maint_12.x/Buildings_DHC_ETS_Combined_Examples_ChillerOnly.csv","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_12_Buildings.DHC.ETS.Combined.Examples.ChillerOnly.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001) [Timeout 300]
""
[Timeout remaining time 299]
Reference file matches
[Calling sys.exit(0), Time elapsed: 290.1626784830005]