Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_12_Buildings.Fluid.DXSystems.Cooling.AirSource.Examples.SpaceCooling.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.001347/0.001347, allocations: 97.92 kB / 19.73 MB, free: 2.133 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.001463/0.001463, allocations: 219.8 kB / 23.03 MB, free: 4.945 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.492/1.492, allocations: 230.6 MB / 256.8 MB, free: 7.793 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.323/3.323, allocations: 0.49 GB / 0.7959 GB, free: 35.58 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.Fluid.DXSystems.Cooling.AirSource.Examples.SpaceCooling,fileNamePrefix="Buildings_12_Buildings_Fluid_DXSystems_Cooling_AirSource_Examples_SpaceCooling",fmuType="cs",version="2.0",platforms={"static"})
"" <> buildModelFMU(Buildings.Fluid.DXSystems.Cooling.AirSource.Examples.SpaceCooling,fileNamePrefix="Buildings_12_Buildings_Fluid_DXSystems_Cooling_AirSource_Examples_SpaceCooling",fmuType="cs",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.001954/0.001954, allocations: 68.84 kB / 1.155 GB, free: 25.47 MB / 0.9044 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.3605/0.3624, allocations: 176.1 MB / 1.327 GB, free: 1.484 MB / 1.014 GB
Notification: Performance of NFInst.instantiate(Buildings.Fluid.DXSystems.Cooling.AirSource.Examples.SpaceCooling): time 1.368/1.73, allocations: 0.5721 GB / 1.899 GB, free: 1.211 MB / 1.389 GB
Notification: Performance of NFInst.instExpressions: time 0.1678/1.898, allocations: 107.5 MB / 2.004 GB, free: 5.414 MB / 1.498 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.01985/1.918, allocations: 0.531 MB / 2.004 GB, free: 4.879 MB / 1.498 GB
Notification: Performance of NFTyping.typeComponents: time 0.02525/1.943, allocations: 7.801 MB / 2.012 GB, free: 13.03 MB / 1.514 GB
Notification: Performance of NFTyping.typeBindings: time 0.06397/2.007, allocations: 20.67 MB / 2.032 GB, free: 8.281 MB / 1.529 GB
Notification: Performance of NFTyping.typeClassSections: time 0.04751/2.055, allocations: 16.79 MB / 2.049 GB, free: 7.57 MB / 1.545 GB
Notification: Performance of NFFlatten.flatten: time 0.07074/2.125, allocations: 43.94 MB / 2.091 GB, free: 11.55 MB / 1.592 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.03195/2.157, allocations: 11.56 MB / 2.103 GB, free: 15.83 MB / 1.607 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.05016/2.208, allocations: 18.47 MB / 2.121 GB, free: 13.35 MB / 1.623 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.02722/2.235, allocations: 12.37 MB / 2.133 GB, free: 0.9883 MB / 1.623 GB
Notification: Performance of NFPackage.collectConstants: time 0.00885/2.244, allocations: 2.297 MB / 2.135 GB, free: 14.69 MB / 1.639 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.04355/2.287, allocations: 16.93 MB / 2.152 GB, free: 13.73 MB / 1.654 GB
Notification: Performance of NFScalarize.scalarize: time 0.01215/2.299, allocations: 7.487 MB / 2.159 GB, free: 6.219 MB / 1.654 GB
Notification: Performance of NFVerifyModel.verify: time 0.02442/2.324, allocations: 9.14 MB / 2.168 GB, free: 13.04 MB / 1.67 GB
Notification: Performance of NFConvertDAE.convert: time 0.08149/2.405, allocations: 43.68 MB / 2.21 GB, free: 1.215 MB / 1.701 GB
Notification: Performance of FrontEnd - DAE generated: time 7.614e-06/2.405, allocations: 0 / 2.21 GB, free: 1.215 MB / 1.701 GB
Notification: Performance of FrontEnd: time 1.774e-06/2.405, allocations: 4 kB / 2.21 GB, free: 1.211 MB / 1.701 GB
Notification: Performance of Transformations before backend: time 0.001221/2.406, allocations: 4 kB / 2.21 GB, free: 1.207 MB / 1.701 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 2394
 * Number of variables: 2394
Notification: Performance of Generate backend data structure: time 0.07855/2.485, allocations: 26.55 MB / 2.236 GB, free: 6.332 MB / 1.732 GB
Notification: Performance of prepare preOptimizeDAE: time 5.086e-05/2.485, allocations: 12.02 kB / 2.236 GB, free: 6.32 MB / 1.732 GB
Notification: Performance of preOpt introduceOutputRealDerivatives (simulation): time 0.0002979/2.485, allocations: 237.8 kB / 2.237 GB, free: 6.086 MB / 1.732 GB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.004541/2.49, allocations: 1.242 MB / 2.238 GB, free: 4.832 MB / 1.732 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.1001/2.59, allocations: 11.99 MB / 2.25 GB, free: 8.812 MB / 1.748 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.05191/2.642, allocations: 20.27 MB / 2.269 GB, free: 4.406 MB / 1.764 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.00263/2.645, allocations: 1.902 MB / 2.271 GB, free: 2.273 MB / 1.764 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.004605/2.649, allocations: 0.9921 MB / 2.272 GB, free: 1.281 MB / 1.764 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.7937/3.443, allocations: 19.77 MB / 2.292 GB, free: 0.6958 GB / 1.779 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0006084/3.443, allocations: 9.688 kB / 2.292 GB, free: 0.6958 GB / 1.779 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.004202/3.448, allocations: 400.7 kB / 2.292 GB, free: 0.6958 GB / 1.779 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0006435/3.448, allocations: 370.3 kB / 2.292 GB, free: 0.6958 GB / 1.779 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.07511/3.523, allocations: 21.8 MB / 2.314 GB, free: 0.69 GB / 1.779 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.139/3.662, allocations: 58.74 MB / 2.371 GB, free: 0.6589 GB / 1.779 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.05835/3.721, allocations: 16.61 MB / 2.387 GB, free: 0.6462 GB / 1.779 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.02698/3.748, allocations: 9.351 MB / 2.396 GB, free: 0.6372 GB / 1.779 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.001752/3.75, allocations: 328.6 kB / 2.397 GB, free: 0.6369 GB / 1.779 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.03212/3.782, allocations: 12.82 MB / 2.409 GB, free: 0.6242 GB / 1.779 GB
Notification: Performance of pre-optimization done (n=728): time 1.671e-05/3.782, allocations: 4 kB / 2.409 GB, free: 0.6242 GB / 1.779 GB
Notification: Performance of matching and sorting (n=737): time 0.2346/4.016, allocations: 55.56 MB / 2.463 GB, free: 0.5706 GB / 1.779 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001439/4.016, allocations: 307.4 kB / 2.464 GB, free: 0.5703 GB / 1.779 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.03106/4.047, allocations: 20.55 MB / 2.484 GB, free: 0.5503 GB / 1.779 GB
Notification: Performance of collectPreVariables (initialization): time 0.002622/4.05, allocations: 253.7 kB / 2.484 GB, free: 0.5501 GB / 1.779 GB
Notification: Performance of collectInitialEqns (initialization): time 0.006988/4.057, allocations: 7.786 MB / 2.492 GB, free: 0.5426 GB / 1.779 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0033/4.06, allocations: 2.564 MB / 2.494 GB, free: 0.5402 GB / 1.779 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.004784/4.065, allocations: 2.174 MB / 2.496 GB, free: 0.5381 GB / 1.779 GB
Notification: Performance of setup shared object (initialization): time 3.605e-05/4.065, allocations: 309.1 kB / 2.496 GB, free: 0.5378 GB / 1.779 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.02867/4.094, allocations: 11.73 MB / 2.508 GB, free: 0.5262 GB / 1.779 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.03031/4.124, allocations: 14.37 MB / 2.522 GB, free: 0.5113 GB / 1.779 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.5807/4.705, allocations: 214.7 MB / 2.732 GB, free: 308 MB / 1.779 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 3.863e-05/4.705, allocations: 12 kB / 2.732 GB, free: 308 MB / 1.779 GB
Notification: Performance of matching and sorting (n=1228) (initialization): time 0.1312/4.836, allocations: 31.68 MB / 2.763 GB, free: 276.1 MB / 1.779 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0002891/4.836, allocations: 355.2 kB / 2.763 GB, free: 275.7 MB / 1.779 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 4.62e-05/4.836, allocations: 28 kB / 2.763 GB, free: 275.7 MB / 1.779 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.01337/4.85, allocations: 3.462 MB / 2.766 GB, free: 272.1 MB / 1.779 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01879/4.869, allocations: 2.937 MB / 2.769 GB, free: 269.2 MB / 1.779 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.03122/4.9, allocations: 35.67 MB / 2.804 GB, free: 231.5 MB / 1.779 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.02341/4.923, allocations: 1.62 MB / 2.806 GB, free: 229.9 MB / 1.779 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.003505/4.927, allocations: 0.4953 MB / 2.806 GB, free: 229.4 MB / 1.779 GB
Warning: Assuming fixed start value for the following 3 variables:
         sinSpeDX.watVapEva.off:DISCRETE(fixed = true protected = true )  \"Signal, true when component is off\" type: Boolean
         mulStaDX.watVapEva.off:DISCRETE(fixed = true protected = true )  \"Signal, true when component is off\" type: Boolean
         varSpeDX.watVapEva.off:DISCRETE(fixed = true protected = true )  \"Signal, true when component is off\" type: Boolean
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.04049/4.967, allocations: 16.32 MB / 2.822 GB, free: 213 MB / 1.779 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.03064/4.998, allocations: 14.29 MB / 2.836 GB, free: 197.8 MB / 1.779 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 1.44/6.438, allocations: 214.2 MB / 3.045 GB, free: 0.6654 GB / 1.779 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 3.921e-05/6.438, allocations: 8.719 kB / 3.045 GB, free: 0.6654 GB / 1.779 GB
Notification: Performance of matching and sorting (n=1228) (initialization_lambda0): time 0.1293/6.567, allocations: 31.28 MB / 3.076 GB, free: 0.6593 GB / 1.779 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0003049/6.568, allocations: 347.7 kB / 3.076 GB, free: 0.659 GB / 1.779 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 4.53e-05/6.568, allocations: 30.66 kB / 3.076 GB, free: 0.659 GB / 1.779 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.01165/6.579, allocations: 3.147 MB / 3.079 GB, free: 0.6583 GB / 1.779 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01866/6.598, allocations: 2.882 MB / 3.082 GB, free: 0.6581 GB / 1.779 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0296/6.628, allocations: 34.76 MB / 3.116 GB, free: 0.6283 GB / 1.779 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.02411/6.652, allocations: 1.661 MB / 3.118 GB, free: 0.6282 GB / 1.779 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.003437/6.655, allocations: 498.3 kB / 3.118 GB, free: 0.6281 GB / 1.779 GB
Warning: Assuming fixed start value for the following 3 variables:
         sinSpeDX.watVapEva.off:DISCRETE(fixed = true protected = true )  \"Signal, true when component is off\" type: Boolean
         mulStaDX.watVapEva.off:DISCRETE(fixed = true protected = true )  \"Signal, true when component is off\" type: Boolean
         varSpeDX.watVapEva.off:DISCRETE(fixed = true protected = true )  \"Signal, true when component is off\" type: Boolean
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 137
 * Number of states: 0 ()
 * Number of discrete variables: 112 (sinSpeDX.i_x,mulStaDX.i_x,varSpeDX.i_x,$PRE.mulSpeCon.multiSwitch1.y,$PRE.con.y,$PRE.sinSpeDX.dxCoi.wetCoi.coiCap.checkBoundsTEva[1],$PRE.sinSpeDX.dxCoi.wetCoi.coiCap.checkBoundsTCon[1],$PRE.sinSpeDX.dxCoi.dryCoi.coiCap.checkBoundsTEva[1],$PRE.sinSpeDX.dxCoi.dryCoi.coiCap.checkBoundsTCon[1],$PRE.sinSpeDX.watVapEva.off,$PRE.mulStaDX.dxCoi.wetCoi.coiCap.checkBoundsTEva[1],$PRE.mulStaDX.dxCoi.wetCoi.coiCap.checkBoundsTEva[2],$PRE.mulStaDX.dxCoi.wetCoi.coiCap.checkBoundsTCon[1],$PRE.mulStaDX.dxCoi.wetCoi.coiCap.checkBoundsTCon[2],$PRE.mulStaDX.dxCoi.dryCoi.coiCap.checkBoundsTEva[1],$PRE.mulStaDX.dxCoi.dryCoi.coiCap.checkBoundsTEva[2],$PRE.mulStaDX.dxCoi.dryCoi.coiCap.checkBoundsTCon[1],$PRE.mulStaDX.dxCoi.dryCoi.coiCap.checkBoundsTCon[2],$PRE.mulStaDX.watVapEva.off,$PRE.mulSpeCon.con1.y,$PRE.mulSpeCon.con2.y,$PRE.varSpeDX.dxCoi.wetCoi.coiCap.checkBoundsTEva[1],$PRE.varSpeDX.dxCoi.wetCoi.coiCap.checkBoundsTEva[2],$PRE.varSpeDX.dxCoi.wetCoi.coiCap.checkBoundsTCon[1],$PRE.varSpeDX.dxCoi.wetCoi.coiCap.checkBoundsTCon[2],$PRE.varSpeDX.dxCoi.dryCoi.coiCap.checkBoundsTEva[1],$PRE.varSpeDX.dxCoi.dryCoi.coiCap.checkBoundsTEva[2],$PRE.varSpeDX.dxCoi.dryCoi.coiCap.checkBoundsTCon[1],$PRE.varSpeDX.dxCoi.dryCoi.coiCap.checkBoundsTCon[2],$PRE.varSpeDX.watVapEva.off,$PRE.varSpeDX.deaBan.y,mulSpeCon.multiSwitch1.expr[2],mulSpeCon.multiSwitch1.expr[1],weaDat.locTim.tNext,$PRE.weaDat.locTim.tNext,weaDat.conTimMin.tNext,$PRE.weaDat.conTimMin.tNext,weaDat.conTim.tNext,$PRE.weaDat.conTim.tNext,weaDat.eqnTim.tNext,$PRE.weaDat.eqnTim.tNext,weaDat.decAng.tNext,$PRE.weaDat.decAng.tNext,con.y,sinSpeDX.dxCoi.wetCoi.coiCap.stage,sinSpeDX.dxCoi.wetCoi.coiCap.checkBoundsTEva[1],sinSpeDX.dxCoi.wetCoi.coiCap.checkBoundsTCon[1],sinSpeDX.dxCoi.wetCoi.shr.on,sinSpeDX.dxCoi.dryCoi.coiCap.stage,sinSpeDX.dxCoi.dryCoi.coiCap.checkBoundsTEva[1],sinSpeDX.dxCoi.dryCoi.coiCap.checkBoundsTCon[1],sinSpeDX.watVapEva.off,mulStaDX.dxCoi.wetCoi.coiCap.stage,mulStaDX.dxCoi.wetCoi.coiCap.checkBoundsTEva[1],mulStaDX.dxCoi.wetCoi.coiCap.checkBoundsTEva[2],mulStaDX.dxCoi.wetCoi.coiCap.checkBoundsTCon[1],mulStaDX.dxCoi.wetCoi.coiCap.checkBoundsTCon[2],mulStaDX.dxCoi.wetCoi.shr.on,mulStaDX.dxCoi.dryCoi.coiCap.stage,mulStaDX.dxCoi.dryCoi.coiCap.checkBoundsTEva[1],mulStaDX.dxCoi.dryCoi.coiCap.checkBoundsTEva[2],mulStaDX.dxCoi.dryCoi.coiCap.checkBoundsTCon[1],mulStaDX.dxCoi.dryCoi.coiCap.checkBoundsTCon[2],mulStaDX.watVapEva.off,mulSpeCon.con1.y,mulSpeCon.con2.y,mulSpeCon.multiSwitch1.y,mulSpeCon.multiSwitch1.firstActiveIndex,varSpeDX.dxCoi.wetCoi.coiCap.stage,varSpeDX.dxCoi.wetCoi.coiCap.checkBoundsTEva[1],varSpeDX.dxCoi.wetCoi.coiCap.checkBoundsTEva[2],varSpeDX.dxCoi.wetCoi.coiCap.checkBoundsTCon[1],varSpeDX.dxCoi.wetCoi.coiCap.checkBoundsTCon[2],varSpeDX.dxCoi.wetCoi.shr.on,varSpeDX.dxCoi.dryCoi.coiCap.stage,varSpeDX.dxCoi.dryCoi.coiCap.checkBoundsTEva[1],varSpeDX.dxCoi.dryCoi.coiCap.checkBoundsTEva[2],varSpeDX.dxCoi.dryCoi.coiCap.checkBoundsTCon[1],varSpeDX.dxCoi.dryCoi.coiCap.checkBoundsTCon[2],varSpeDX.watVapEva.off,varSpeDX.deaBan.y,$whenCondition1,$whenCondition2,$whenCondition3,$whenCondition4,$whenCondition5,$whenCondition6,$whenCondition7,$whenCondition8,$whenCondition9,$whenCondition10,$whenCondition11,$whenCondition12,$whenCondition13,$whenCondition14,$whenCondition15,$whenCondition16,$whenCondition17,$whenCondition18,$whenCondition19,$whenCondition20,$whenCondition21,$whenCondition22,$whenCondition23,$whenCondition24,$whenCondition25,$whenCondition26,$whenCondition27,$whenCondition28,varSpePow.local_reset,mulSpePow.local_reset,sinSpePow.local_reset)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (1040):
 * Single equations (assignments): 995
 * Array equations: 6
 * Algorithm blocks: 9
 * Record equations: 3
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 6
 * Torn equation systems: 21
 * 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
   {7, 1, 7, 1, 7, 1}
 * Without analytic Jacobian (size): 0 systems
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 3 systems
   {(1,5,100.0%), (2,4,100.0%), (2,4,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 18 systems
   {(1,1), (1,2), (1,4), (1,2), (1,2), (1,1), (1,2), (1,4), (1,2), (1,2), (1,2), (1,1), (1,2), (1,4), (1,2), (1,2), (1,2), (1,2)}
Notification: Performance of prepare postOptimizeDAE: time 0.003989/6.659, allocations: 0.7586 MB / 3.119 GB, free: 0.6275 GB / 1.779 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.005373/6.665, allocations: 1.642 MB / 3.12 GB, free: 0.6275 GB / 1.779 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.1203/6.785, allocations: 25.91 MB / 3.146 GB, free: 0.613 GB / 1.779 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 6.297e-05/6.785, allocations: 72 kB / 3.146 GB, free: 0.613 GB / 1.779 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 2.148e-05/6.785, allocations: 4 kB / 3.146 GB, free: 0.613 GB / 1.779 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.1112/6.896, allocations: 23.02 MB / 3.168 GB, free: 0.5904 GB / 1.779 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 postOpt removeSimpleEquations (simulation): time 0.1561/7.052, allocations: 44.8 MB / 3.212 GB, free: 0.5468 GB / 1.779 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 6.339e-05/7.052, allocations: 4 kB / 3.212 GB, free: 0.5468 GB / 1.779 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.01677/7.069, allocations: 2.5 MB / 3.214 GB, free: 0.5443 GB / 1.779 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.005397/7.075, allocations: 1.814 MB / 3.216 GB, free: 0.5426 GB / 1.779 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.002201/7.077, allocations: 299.6 kB / 3.217 GB, free: 0.5423 GB / 1.779 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.02282/7.1, allocations: 20.7 MB / 3.237 GB, free: 0.5211 GB / 1.779 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.254e-06/7.1, allocations: 4 kB / 3.237 GB, free: 0.5211 GB / 1.779 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.1423/7.242, allocations: 36.98 MB / 3.273 GB, free: 496.9 MB / 1.779 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.01165/7.254, allocations: 4.346 MB / 3.277 GB, free: 492.5 MB / 1.779 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.006019/7.26, allocations: 247.3 kB / 3.277 GB, free: 492.3 MB / 1.779 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.02269/7.282, allocations: 1.589 MB / 3.279 GB, free: 490.7 MB / 1.779 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.002072/7.284, allocations: 0.5712 MB / 3.279 GB, free: 490.1 MB / 1.779 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.00169/7.286, allocations: 387.5 kB / 3.28 GB, free: 489.8 MB / 1.779 GB
Notification: Performance of sorting global known variables: time 0.02606/7.312, allocations: 14.19 MB / 3.294 GB, free: 475.6 MB / 1.779 GB
Notification: Performance of sort global known variables: time 2.41e-07/7.312, allocations: 0 / 3.294 GB, free: 475.6 MB / 1.779 GB
Notification: Performance of remove unused functions: time 0.02679/7.339, allocations: 6.594 MB / 3.3 GB, free: 469.1 MB / 1.779 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 1
 * Number of states: 33 (varSpePow.y,mulSpePow.y,sinSpePow.y,senTemHXEvaOut2.T,varSpeDX.watVapEva.m,varSpeDX.vol.dynBal.m,varSpeDX.vol.dynBal.U,varSpeDX.vol.dynBal.medium.Xi[1],senTemSupAir2.T,fan2.motSpe.y,rooVarSpe.heaCap.T,rooVarSpe.vol.dynBal.m,rooVarSpe.vol.dynBal.medium.Xi[1],rooMulSpe.heaCap.T,rooMulSpe.vol.dynBal.m,rooMulSpe.vol.dynBal.medium.Xi[1],mulStaDX.watVapEva.m,mulStaDX.vol.dynBal.m,mulStaDX.vol.dynBal.U,mulStaDX.vol.dynBal.medium.Xi[1],senTemSupAir1.T,senTemHXEvaOut1.T,fan1.motSpe.y,rooSinSpe.heaCap.T,rooSinSpe.vol.dynBal.m,rooSinSpe.vol.dynBal.medium.Xi[1],sinSpeDX.watVapEva.m,sinSpeDX.vol.dynBal.m,sinSpeDX.vol.dynBal.U,sinSpeDX.vol.dynBal.medium.Xi[1],senTemSupAir.T,senTemHXEvaOut.T,fan.motSpe.y)
 * Number of discrete variables: 71 (mulSpeCon.multiSwitch1.y,$whenCondition28,$whenCondition27,$whenCondition26,$whenCondition25,$whenCondition24,$whenCondition23,$whenCondition22,$whenCondition21,$whenCondition20,$whenCondition19,$whenCondition18,$whenCondition17,$whenCondition16,$whenCondition15,$whenCondition14,$whenCondition13,$whenCondition12,$whenCondition11,$whenCondition10,$whenCondition9,$whenCondition8,$whenCondition7,$whenCondition6,$whenCondition5,$whenCondition4,$whenCondition3,$whenCondition2,$whenCondition1,varSpeDX.deaBan.y,varSpeDX.watVapEva.off,varSpeDX.dxCoi.dryCoi.coiCap.checkBoundsTCon[2],varSpeDX.dxCoi.dryCoi.coiCap.checkBoundsTCon[1],varSpeDX.dxCoi.dryCoi.coiCap.checkBoundsTEva[2],varSpeDX.dxCoi.dryCoi.coiCap.checkBoundsTEva[1],varSpeDX.dxCoi.dryCoi.coiCap.stage,varSpeDX.dxCoi.wetCoi.shr.on,varSpeDX.dxCoi.wetCoi.coiCap.checkBoundsTCon[2],varSpeDX.dxCoi.wetCoi.coiCap.checkBoundsTCon[1],varSpeDX.dxCoi.wetCoi.coiCap.checkBoundsTEva[2],varSpeDX.dxCoi.wetCoi.coiCap.checkBoundsTEva[1],varSpeDX.dxCoi.wetCoi.coiCap.stage,mulSpeCon.multiSwitch1.firstActiveIndex,mulSpeCon.con2.y,mulSpeCon.con1.y,mulStaDX.watVapEva.off,mulStaDX.dxCoi.dryCoi.coiCap.checkBoundsTCon[2],mulStaDX.dxCoi.dryCoi.coiCap.checkBoundsTCon[1],mulStaDX.dxCoi.dryCoi.coiCap.checkBoundsTEva[2],mulStaDX.dxCoi.dryCoi.coiCap.checkBoundsTEva[1],mulStaDX.dxCoi.dryCoi.coiCap.stage,mulStaDX.dxCoi.wetCoi.shr.on,mulStaDX.dxCoi.wetCoi.coiCap.checkBoundsTCon[2],mulStaDX.dxCoi.wetCoi.coiCap.checkBoundsTCon[1],mulStaDX.dxCoi.wetCoi.coiCap.checkBoundsTEva[2],mulStaDX.dxCoi.wetCoi.coiCap.checkBoundsTEva[1],mulStaDX.dxCoi.wetCoi.coiCap.stage,sinSpeDX.watVapEva.off,sinSpeDX.dxCoi.dryCoi.coiCap.checkBoundsTCon[1],sinSpeDX.dxCoi.dryCoi.coiCap.checkBoundsTEva[1],sinSpeDX.dxCoi.dryCoi.coiCap.stage,sinSpeDX.dxCoi.wetCoi.shr.on,sinSpeDX.dxCoi.wetCoi.coiCap.checkBoundsTCon[1],sinSpeDX.dxCoi.wetCoi.coiCap.checkBoundsTEva[1],sinSpeDX.dxCoi.wetCoi.coiCap.stage,con.y,weaDat.decAng.tNext,weaDat.eqnTim.tNext,weaDat.conTim.tNext,weaDat.conTimMin.tNext,weaDat.locTim.tNext)
 * Number of discrete states: 30 (varSpeDX.deaBan.y,varSpeDX.dxCoi.wetCoi.coiCap.stage,varSpeDX.dxCoi.wetCoi.coiCap.checkBoundsTCon[varSpeDX.dxCoi.wetCoi.coiCap.stage],varSpeDX.dxCoi.wetCoi.coiCap.checkBoundsTEva[varSpeDX.dxCoi.wetCoi.coiCap.stage],varSpeDX.dxCoi.dryCoi.coiCap.stage,varSpeDX.dxCoi.dryCoi.coiCap.checkBoundsTCon[varSpeDX.dxCoi.dryCoi.coiCap.stage],varSpeDX.dxCoi.dryCoi.coiCap.checkBoundsTEva[varSpeDX.dxCoi.dryCoi.coiCap.stage],varSpeDX.watVapEva.off,mulSpeCon.con2.y,mulSpeCon.con1.y,mulStaDX.dxCoi.dryCoi.coiCap.stage,mulStaDX.dxCoi.dryCoi.coiCap.checkBoundsTCon[mulStaDX.dxCoi.dryCoi.coiCap.stage],mulStaDX.dxCoi.dryCoi.coiCap.checkBoundsTEva[mulStaDX.dxCoi.dryCoi.coiCap.stage],mulStaDX.dxCoi.wetCoi.coiCap.stage,mulStaDX.dxCoi.wetCoi.coiCap.checkBoundsTCon[mulStaDX.dxCoi.wetCoi.coiCap.stage],mulStaDX.dxCoi.wetCoi.coiCap.checkBoundsTEva[mulStaDX.dxCoi.wetCoi.coiCap.stage],mulStaDX.watVapEva.off,con.y,sinSpeDX.dxCoi.wetCoi.coiCap.stage,sinSpeDX.dxCoi.wetCoi.coiCap.checkBoundsTCon[sinSpeDX.dxCoi.wetCoi.coiCap.stage],sinSpeDX.dxCoi.wetCoi.coiCap.checkBoundsTEva[sinSpeDX.dxCoi.wetCoi.coiCap.stage],sinSpeDX.dxCoi.dryCoi.coiCap.stage,sinSpeDX.dxCoi.dryCoi.coiCap.checkBoundsTCon[sinSpeDX.dxCoi.dryCoi.coiCap.stage],sinSpeDX.dxCoi.dryCoi.coiCap.checkBoundsTEva[sinSpeDX.dxCoi.dryCoi.coiCap.stage],sinSpeDX.watVapEva.off,weaDat.conTimMin.tNext,weaDat.decAng.tNext,weaDat.eqnTim.tNext,weaDat.conTim.tNext,weaDat.locTim.tNext)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (704):
 * Single equations (assignments): 660
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 25
 * If-equations: 0
 * Equation systems (not torn): 6
 * Torn equation systems: 13
 * 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
   {7, 7, 7, 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): 3 systems
   {(1,4,100.0%), (1,4,100.0%), (1,4,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 10 systems
   {(1,1), (1,3), (1,1), (1,3), (1,1), (1,3), (1,3), (1,3), (1,3), (1,3)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.1014/7.44, allocations: 35.2 MB / 3.334 GB, free: 434.1 MB / 1.779 GB
Notification: Performance of simCode: created initialization part: time 0.1055/7.546, allocations: 41.09 MB / 3.375 GB, free: 392.3 MB / 1.779 GB
Notification: Performance of simCode: created event and clocks part: time 1.14e-05/7.546, allocations: 6.656 kB / 3.375 GB, free: 392.3 MB / 1.779 GB
Notification: Performance of simCode: created simulation system equations: time 0.03675/7.582, allocations: 11.37 MB / 3.386 GB, free: 380.8 MB / 1.779 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.04095/7.623, allocations: 6.824 MB / 3.392 GB, free: 374.2 MB / 1.779 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.592/8.215, allocations: 215.5 MB / 3.603 GB, free: 156.7 MB / 1.779 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.01279/8.228, allocations: 9.142 MB / 3.612 GB, free: 147.5 MB / 1.779 GB
Notification: Performance of simCode: alias equations: time 0.02213/8.25, allocations: 5.173 MB / 3.617 GB, free: 142.3 MB / 1.779 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.01524/8.266, allocations: 8.145 MB / 3.625 GB, free: 134.1 MB / 1.779 GB
Notification: Performance of SimCode: time 1.443e-06/8.266, allocations: 0 / 3.625 GB, free: 134.1 MB / 1.779 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 1.992/10.26, allocations: 0.523 GB / 4.148 GB, free: 340.9 MB / 1.779 GB
Notification: Performance of buildModelFMU: Generate platform static: time 100.9/111.1, allocations: 8.047 kB / 4.148 GB, free: 340.9 MB / 1.779 GB
"
[Timeout remaining time 188]
(rm -f Buildings_12_Buildings.Fluid.DXSystems.Cooling.AirSource.Examples.SpaceCooling.pipe ; mkfifo Buildings_12_Buildings.Fluid.DXSystems.Cooling.AirSource.Examples.SpaceCooling.pipe ; head -c 1048576 < Buildings_12_Buildings.Fluid.DXSystems.Cooling.AirSource.Examples.SpaceCooling.pipe >> ../files/Buildings_12_Buildings.Fluid.DXSystems.Cooling.AirSource.Examples.SpaceCooling.sim & /home/hudson/saved_omc/OMSimulator/install/bin/OMSimulator -r=Buildings_12_Buildings.Fluid.DXSystems.Cooling.AirSource.Examples.SpaceCooling_res.mat --tempDir=temp_Buildings_12_Buildings_Fluid_DXSystems_Cooling_AirSource_Examples_SpaceCooling_fmu --startTime=1.58112e+07 --stopTime=1.6416e+07 --stepSize=116.018 --timeout=400 --tolerance=1e-06 Buildings_12_Buildings_Fluid_DXSystems_Cooling_AirSource_Examples_SpaceCooling.fmu > Buildings_12_Buildings.Fluid.DXSystems.Cooling.AirSource.Examples.SpaceCooling.pipe 2>&1) [Timeout 420.0]
[Calling os._exit(0), Time elapsed: 119.44015959906392]
Failed to read output from testmodel.py, exit status != 0:
111.71876658895053 111.735742927 109.326867165
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f7d5ef7f3a0>