Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_11_Buildings.Fluid.DXSystems.Cooling.AirSource.Examples.SpaceCooling.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.001656/0.001656, allocations: 113.9 kB / 18.94 MB, free: 2.93 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.001749/0.001749, allocations: 191.7 kB / 22.23 MB, free: 5.105 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.647/1.647, allocations: 225.6 MB / 251 MB, free: 13.02 MB / 206.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.1.1-maint.11.x/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.1.1-maint.11.x/package.mo): time 2.928/2.928, allocations: 476.7 MB / 0.7646 GB, free: 9.891 MB / 0.6231 GB
"
[Timeout remaining time 176]
Using package Buildings with version 11.1.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.1.1-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: translateModel(Buildings.Fluid.DXSystems.Cooling.AirSource.Examples.SpaceCooling,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5213,variableFilter="time|rooSinSpe.vol.T|rooMulSpe.vol.T|rooVarSpe.vol.T|weaDat.weaBus.TDryBul|rooSinSpe.vol.Xi.1.|rooMulSpe.vol.Xi.1.|rooVarSpe.vol.Xi.1.|sinSpePow.y|varSpePow.y|mulSpePow.y",fileNamePrefix="Buildings_11_Buildings.Fluid.DXSystems.Cooling.AirSource.Examples.SpaceCooling")
translateModel(Buildings.Fluid.DXSystems.Cooling.AirSource.Examples.SpaceCooling,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5213,variableFilter="time|rooSinSpe.vol.T|rooMulSpe.vol.T|rooVarSpe.vol.T|weaDat.weaBus.TDryBul|rooSinSpe.vol.Xi.1.|rooMulSpe.vol.Xi.1.|rooVarSpe.vol.Xi.1.|sinSpePow.y|varSpePow.y|mulSpePow.y",fileNamePrefix="Buildings_11_Buildings.Fluid.DXSystems.Cooling.AirSource.Examples.SpaceCooling") [Timeout 300]
"Notification: Performance of FrontEnd - loaded program: time 0.002467/0.002467, allocations: 67.89 kB / 1.11 GB, free: 6.289 MB / 0.9044 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 1.206/1.209, allocations: 168.8 MB / 1.274 GB, free: 4.188 MB / 0.9669 GB
Notification: Performance of NFInst.instantiate(Buildings.Fluid.DXSystems.Cooling.AirSource.Examples.SpaceCooling): time 2.055/3.263, allocations: 0.6463 GB / 1.921 GB, free: 12.04 MB / 1.389 GB
Notification: Performance of NFInst.instExpressions: time 0.2179/3.481, allocations: 116.7 MB / 2.035 GB, free: 6.984 MB / 1.498 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.03534/3.517, allocations: 0.5233 MB / 2.035 GB, free: 6.457 MB / 1.498 GB
Notification: Performance of NFTyping.typeComponents: time 0.03495/3.551, allocations: 8.294 MB / 2.043 GB, free: 14.11 MB / 1.514 GB
Notification: Performance of NFTyping.typeBindings: time 0.08544/3.637, allocations: 20.77 MB / 2.064 GB, free: 9.266 MB / 1.529 GB
Notification: Performance of NFTyping.typeClassSections: time 0.05669/3.694, allocations: 17 MB / 2.08 GB, free: 8.34 MB / 1.545 GB
Notification: Performance of NFFlatten.flatten: time 0.09223/3.786, allocations: 44.72 MB / 2.124 GB, free: 11.53 MB / 1.592 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.03393/3.82, allocations: 11.56 MB / 2.135 GB, free: 15.82 MB / 1.607 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.05749/3.877, allocations: 17.81 MB / 2.153 GB, free: 14 MB / 1.623 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.03576/3.913, allocations: 12.52 MB / 2.165 GB, free: 1.488 MB / 1.623 GB
Notification: Performance of NFPackage.collectConstants: time 0.01705/3.93, allocations: 2.301 MB / 2.167 GB, free: 15.18 MB / 1.639 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.0719/4.002, allocations: 21.27 MB / 2.188 GB, free: 9.867 MB / 1.654 GB
Notification: Performance of NFScalarize.scalarize: time 0.02031/4.022, allocations: 7.522 MB / 2.195 GB, free: 2.324 MB / 1.654 GB
Notification: Performance of NFVerifyModel.verify: time 0.04253/4.065, allocations: 11.66 MB / 2.207 GB, free: 6.617 MB / 1.67 GB
Notification: Performance of NFConvertDAE.convert: time 0.1245/4.189, allocations: 44.05 MB / 2.25 GB, free: 10.43 MB / 1.717 GB
Notification: Performance of FrontEnd - DAE generated: time 1.094e-05/4.189, allocations: 0 / 2.25 GB, free: 10.43 MB / 1.717 GB
Notification: Performance of FrontEnd: time 4.048e-06/4.189, allocations: 0 / 2.25 GB, free: 10.43 MB / 1.717 GB
Notification: Performance of Transformations before backend: time 0.001775/4.191, allocations: 0 / 2.25 GB, free: 10.43 MB / 1.717 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 2403
 * Number of variables: 2403
Notification: Performance of Generate backend data structure: time 2.061/6.252, allocations: 26.61 MB / 2.276 GB, free: 0.6781 GB / 1.717 GB
Notification: Performance of prepare preOptimizeDAE: time 6.04e-05/6.252, allocations: 9.938 kB / 2.276 GB, free: 0.6781 GB / 1.717 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0971/6.349, allocations: 11.81 MB / 2.287 GB, free: 0.6759 GB / 1.717 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.05832/6.407, allocations: 20.25 MB / 2.307 GB, free: 0.6639 GB / 1.717 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.002533/6.41, allocations: 1.461 MB / 2.308 GB, free: 0.6629 GB / 1.717 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.006056/6.416, allocations: 0.9952 MB / 2.309 GB, free: 0.6626 GB / 1.717 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.0637/6.479, allocations: 18.42 MB / 2.327 GB, free: 0.6519 GB / 1.717 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0004893/6.48, allocations: 17.78 kB / 2.327 GB, free: 0.6519 GB / 1.717 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.00525/6.485, allocations: 395.8 kB / 2.328 GB, free: 0.6515 GB / 1.717 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0003316/6.485, allocations: 370.2 kB / 2.328 GB, free: 0.6512 GB / 1.717 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.06773/6.553, allocations: 21.83 MB / 2.349 GB, free: 0.6301 GB / 1.717 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.1688/6.722, allocations: 73.86 MB / 2.421 GB, free: 0.5563 GB / 1.717 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.06065/6.783, allocations: 16.59 MB / 2.438 GB, free: 0.5402 GB / 1.717 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0286/6.811, allocations: 9.346 MB / 2.447 GB, free: 0.531 GB / 1.717 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.002351/6.813, allocations: 362 kB / 2.447 GB, free: 0.5307 GB / 1.717 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.03636/6.85, allocations: 11.67 MB / 2.459 GB, free: 0.5193 GB / 1.717 GB
Notification: Performance of pre-optimization done (n=734): time 1.807e-05/6.85, allocations: 0 / 2.459 GB, free: 0.5193 GB / 1.717 GB
Notification: Performance of matching and sorting (n=743): time 0.3012/7.151, allocations: 55.4 MB / 2.513 GB, free: 476.5 MB / 1.717 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001878/7.151, allocations: 311.3 kB / 2.513 GB, free: 476.2 MB / 1.717 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.05577/7.207, allocations: 20.55 MB / 2.533 GB, free: 455.8 MB / 1.717 GB
Notification: Performance of collectPreVariables (initialization): time 0.004442/7.211, allocations: 253.7 kB / 2.533 GB, free: 455.5 MB / 1.717 GB
Notification: Performance of collectInitialEqns (initialization): time 0.01264/7.224, allocations: 7.777 MB / 2.541 GB, free: 447.9 MB / 1.717 GB
Notification: Performance of collectInitialBindings (initialization): time 0.005162/7.229, allocations: 2.598 MB / 2.543 GB, free: 445.3 MB / 1.717 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.01312/7.242, allocations: 2.201 MB / 2.546 GB, free: 443.1 MB / 1.717 GB
Notification: Performance of setup shared object (initialization): time 5.774e-05/7.242, allocations: 305.1 kB / 2.546 GB, free: 442.8 MB / 1.717 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.03117/7.274, allocations: 11.42 MB / 2.557 GB, free: 431.4 MB / 1.717 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.03343/7.307, allocations: 12.72 MB / 2.569 GB, free: 418.1 MB / 1.717 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.5874/7.894, allocations: 214.8 MB / 2.779 GB, free: 202.5 MB / 1.717 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 4.916e-05/7.894, allocations: 8 kB / 2.779 GB, free: 202.5 MB / 1.717 GB
Notification: Performance of matching and sorting (n=1245) (initialization): time 0.1356/8.03, allocations: 31.28 MB / 2.81 GB, free: 171.1 MB / 1.717 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0003862/8.03, allocations: 359.4 kB / 2.81 GB, free: 170.7 MB / 1.717 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 5.4e-05/8.03, allocations: 28 kB / 2.81 GB, free: 170.7 MB / 1.717 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.01363/8.044, allocations: 3.442 MB / 2.813 GB, free: 167.1 MB / 1.717 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01959/8.064, allocations: 2.976 MB / 2.816 GB, free: 164.2 MB / 1.717 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0344/8.098, allocations: 35.94 MB / 2.851 GB, free: 126.2 MB / 1.717 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.02804/8.126, allocations: 1.615 MB / 2.853 GB, free: 124.6 MB / 1.717 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.004361/8.131, allocations: 0.4957 MB / 2.853 GB, free: 124.1 MB / 1.717 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.04401/8.175, allocations: 16.02 MB / 2.869 GB, free: 108 MB / 1.717 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.0325/8.207, allocations: 12.65 MB / 2.881 GB, free: 94.84 MB / 1.717 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 1.571/9.779, allocations: 214.2 MB / 3.091 GB, free: 0.5853 GB / 1.717 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 4.554e-05/9.779, allocations: 8 kB / 3.091 GB, free: 0.5853 GB / 1.717 GB
Notification: Performance of matching and sorting (n=1245) (initialization_lambda0): time 0.1373/9.916, allocations: 30.85 MB / 3.121 GB, free: 0.5582 GB / 1.717 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0004026/9.916, allocations: 351.2 kB / 3.121 GB, free: 0.5578 GB / 1.717 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 5.024e-05/9.916, allocations: 32.88 kB / 3.121 GB, free: 0.5578 GB / 1.717 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.01108/9.927, allocations: 3.138 MB / 3.124 GB, free: 0.5547 GB / 1.717 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01923/9.947, allocations: 2.921 MB / 3.127 GB, free: 0.5519 GB / 1.717 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.03062/9.977, allocations: 35.02 MB / 3.161 GB, free: 0.5158 GB / 1.717 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.02826/10.01, allocations: 1.641 MB / 3.163 GB, free: 0.5142 GB / 1.717 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.004292/10.01, allocations: 499.6 kB / 3.163 GB, free: 0.5137 GB / 1.717 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: 114 (sinSpeDX.i_x,mulStaDX.i_x,varSpeDX.i_x,$PRE.mulSpeCon.multiSwitch1.y,weaDat.conTim.canRepeatWeatherFile,weaDat.conTimMin.canRepeatWeatherFile,$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 (1057):
 * Single equations (assignments): 1012
 * 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%), (1,5,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.007509/10.02, allocations: 0.7762 MB / 3.164 GB, free: 0.513 GB / 1.717 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.00755/10.02, allocations: 1.648 MB / 3.166 GB, free: 0.5122 GB / 1.717 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.1298/10.15, allocations: 25.76 MB / 3.191 GB, free: 498.7 MB / 1.717 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.0001201/10.15, allocations: 72 kB / 3.191 GB, free: 498.6 MB / 1.717 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 6.41e-05/10.15, allocations: 4 kB / 3.191 GB, free: 498.6 MB / 1.717 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.1162/10.27, allocations: 22.86 MB / 3.213 GB, free: 475.7 MB / 1.717 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.1839/10.45, allocations: 49.17 MB / 3.261 GB, free: 426.5 MB / 1.717 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 0.0001012/10.45, allocations: 4 kB / 3.261 GB, free: 426.5 MB / 1.717 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0175/10.47, allocations: 2.488 MB / 3.264 GB, free: 424 MB / 1.717 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.005584/10.48, allocations: 1.809 MB / 3.266 GB, free: 422.2 MB / 1.717 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.002973/10.48, allocations: 303.6 kB / 3.266 GB, free: 421.9 MB / 1.717 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.02157/10.5, allocations: 20.59 MB / 3.286 GB, free: 400.3 MB / 1.717 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 3.506e-06/10.5, allocations: 3.938 kB / 3.286 GB, free: 400.3 MB / 1.717 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.173/10.68, allocations: 36.88 MB / 3.322 GB, free: 364.2 MB / 1.717 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.01752/10.69, allocations: 4.357 MB / 3.326 GB, free: 360 MB / 1.717 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.01043/10.7, allocations: 247.9 kB / 3.326 GB, free: 359.7 MB / 1.717 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.02785/10.73, allocations: 1.574 MB / 3.328 GB, free: 358.2 MB / 1.717 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.003012/10.73, allocations: 0.5789 MB / 3.329 GB, free: 357.6 MB / 1.717 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0034/10.74, allocations: 395.5 kB / 3.329 GB, free: 357.2 MB / 1.717 GB
Notification: Performance of sorting global known variables: time 0.03594/10.77, allocations: 14.17 MB / 3.343 GB, free: 343.1 MB / 1.717 GB
Notification: Performance of sort global known variables: time 3.41e-07/10.77, allocations: 0 / 3.343 GB, free: 343.1 MB / 1.717 GB
Notification: Performance of remove unused functions: time 0.04532/10.82, allocations: 6.621 MB / 3.349 GB, free: 336.5 MB / 1.717 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 1
 * Number of states: 36 (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.filter.s[2],fan2.filter.s[1],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.filter.s[2],fan1.filter.s[1],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.filter.s[2],fan.filter.s[1])
 * 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 (710):
 * Single equations (assignments): 666
 * 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.007662/10.83, allocations: 1.867 MB / 3.351 GB, free: 335 MB / 1.717 GB
Notification: Performance of simCode: created initialization part: time 0.1115/10.94, allocations: 40.42 MB / 3.391 GB, free: 293.9 MB / 1.717 GB
Notification: Performance of simCode: created event and clocks part: time 1.694e-05/10.94, allocations: 10.59 kB / 3.391 GB, free: 293.9 MB / 1.717 GB
Notification: Performance of simCode: created simulation system equations: time 0.03871/10.98, allocations: 11.21 MB / 3.401 GB, free: 282.6 MB / 1.717 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.05232/11.03, allocations: 6.812 MB / 3.408 GB, free: 276 MB / 1.717 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.1195/11.15, allocations: 41.3 MB / 3.448 GB, free: 234.7 MB / 1.717 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.02333/11.17, allocations: 9.485 MB / 3.458 GB, free: 225.2 MB / 1.717 GB
Notification: Performance of simCode: alias equations: time 0.03389/11.21, allocations: 5.201 MB / 3.463 GB, free: 220 MB / 1.717 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.01229/11.22, allocations: 1.264 MB / 3.464 GB, free: 218.7 MB / 1.717 GB
Notification: Performance of SimCode: time 2.134e-06/11.22, allocations: 0 / 3.464 GB, free: 218.7 MB / 1.717 GB
Notification: Performance of Templates: time 1.583/12.8, allocations: 379.1 MB / 3.834 GB, free: 0.5336 GB / 1.717 GB
"
[Timeout remaining time 287]
make -j1 -f Buildings_11_Buildings.Fluid.DXSystems.Cooling.AirSource.Examples.SpaceCooling.makefile [Timeout 300]
(rm -f Buildings_11_Buildings.Fluid.DXSystems.Cooling.AirSource.Examples.SpaceCooling.pipe ; mkfifo Buildings_11_Buildings.Fluid.DXSystems.Cooling.AirSource.Examples.SpaceCooling.pipe ; head -c 1048576 < Buildings_11_Buildings.Fluid.DXSystems.Cooling.AirSource.Examples.SpaceCooling.pipe >> ../files/Buildings_11_Buildings.Fluid.DXSystems.Cooling.AirSource.Examples.SpaceCooling.sim & ./Buildings_11_Buildings.Fluid.DXSystems.Cooling.AirSource.Examples.SpaceCooling  -abortSlowSimulation -alarm=400  -emit_protected -lv LOG_STATS > Buildings_11_Buildings.Fluid.DXSystems.Cooling.AirSource.Examples.SpaceCooling.pipe 2>&1) [Timeout 400]
[Calling os._exit(0), Time elapsed: 34.80424723774195]
Failed to read output from testmodel.py, exit status != 0:
12.815695849247277 12.825395714 8.632711217
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f6c179c97b0>