Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_10_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.001629/0.001629, allocations: 108.8 kB / 18.93 MB, free: 2.945 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.001641/0.001641, allocations: 190.8 kB / 22.23 MB, free: 5.16 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.574/1.574, allocations: 225.6 MB / 251 MB, free: 13.01 MB / 206.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 10.1.2-maint.10.0.x/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 10.1.2-maint.10.0.x/package.mo): time 2.678/2.678, allocations: 443.4 MB / 0.7321 GB, free: 12.28 MB / 0.5919 GB
"
[Timeout remaining time 177]
Using package Buildings with version 10.1.2 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 10.1.2-maint.10.0.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_10_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_10_Buildings.Fluid.DXSystems.Cooling.AirSource.Examples.SpaceCooling") [Timeout 300]
"Notification: Performance of FrontEnd - loaded program: time 0.002237/0.002237, allocations: 67.89 kB / 1.062 GB, free: 2.922 MB / 0.8575 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 1.05/1.053, allocations: 160.8 MB / 1.219 GB, free: 3.629 MB / 0.92 GB
Notification: Performance of NFInst.instantiate(Buildings.Fluid.DXSystems.Cooling.AirSource.Examples.SpaceCooling): time 1.843/2.895, allocations: 0.6464 GB / 1.865 GB, free: 9.332 MB / 1.311 GB
Notification: Performance of NFInst.instExpressions: time 0.2035/3.099, allocations: 116.7 MB / 1.979 GB, free: 5.797 MB / 1.42 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.02444/3.123, allocations: 0.5233 MB / 1.979 GB, free: 5.27 MB / 1.42 GB
Notification: Performance of NFTyping.typeComponents: time 0.02861/3.152, allocations: 8.305 MB / 1.987 GB, free: 12.91 MB / 1.436 GB
Notification: Performance of NFTyping.typeBindings: time 0.07321/3.225, allocations: 20.76 MB / 2.008 GB, free: 8.07 MB / 1.451 GB
Notification: Performance of NFTyping.typeClassSections: time 0.05353/3.278, allocations: 16.97 MB / 2.024 GB, free: 7.121 MB / 1.467 GB
Notification: Performance of NFFlatten.flatten: time 0.0997/3.378, allocations: 44.73 MB / 2.068 GB, free: 10.29 MB / 1.514 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.04176/3.42, allocations: 11.56 MB / 2.079 GB, free: 14.57 MB / 1.529 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.05644/3.476, allocations: 17.8 MB / 2.097 GB, free: 12.77 MB / 1.545 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.03142/3.508, allocations: 12.53 MB / 2.109 GB, free: 252 kB / 1.545 GB
Notification: Performance of NFPackage.collectConstants: time 0.0121/3.52, allocations: 2.297 MB / 2.111 GB, free: 13.95 MB / 1.561 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.06541/3.585, allocations: 21.28 MB / 2.132 GB, free: 8.625 MB / 1.576 GB
Notification: Performance of NFScalarize.scalarize: time 0.01699/3.602, allocations: 7.518 MB / 2.139 GB, free: 1.086 MB / 1.576 GB
Notification: Performance of NFVerifyModel.verify: time 0.03612/3.638, allocations: 11.66 MB / 2.151 GB, free: 5.371 MB / 1.592 GB
Notification: Performance of NFConvertDAE.convert: time 0.106/3.744, allocations: 44.03 MB / 2.194 GB, free: 9.199 MB / 1.639 GB
Notification: Performance of FrontEnd - DAE generated: time 7.404e-06/3.744, allocations: 4 kB / 2.194 GB, free: 9.195 MB / 1.639 GB
Notification: Performance of FrontEnd: time 3.066e-06/3.744, allocations: 0 / 2.194 GB, free: 9.195 MB / 1.639 GB
Notification: Performance of Transformations before backend: time 0.001685/3.746, allocations: 0 / 2.194 GB, free: 9.195 MB / 1.639 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 0.1091/3.855, allocations: 26.65 MB / 2.22 GB, free: 14.2 MB / 1.67 GB
Notification: Performance of prepare preOptimizeDAE: time 5.964e-05/3.855, allocations: 12.03 kB / 2.22 GB, free: 14.18 MB / 1.67 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.09805/3.953, allocations: 11.79 MB / 2.231 GB, free: 2.363 MB / 1.67 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 1.059/5.013, allocations: 20.5 MB / 2.251 GB, free: 0.6704 GB / 1.67 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.002686/5.015, allocations: 1.457 MB / 2.253 GB, free: 0.6694 GB / 1.67 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.005964/5.021, allocations: 0.995 MB / 2.254 GB, free: 0.6691 GB / 1.67 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.05837/5.08, allocations: 18.42 MB / 2.272 GB, free: 0.6623 GB / 1.67 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0003566/5.08, allocations: 14.66 kB / 2.272 GB, free: 0.6623 GB / 1.67 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.004207/5.084, allocations: 394.8 kB / 2.272 GB, free: 0.662 GB / 1.67 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0003238/5.085, allocations: 378.2 kB / 2.272 GB, free: 0.6619 GB / 1.67 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.06694/5.152, allocations: 21.83 MB / 2.294 GB, free: 0.6514 GB / 1.67 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.1639/5.315, allocations: 74.18 MB / 2.366 GB, free: 0.5863 GB / 1.67 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.05735/5.373, allocations: 17.28 MB / 2.383 GB, free: 0.5697 GB / 1.67 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.02716/5.4, allocations: 9.337 MB / 2.392 GB, free: 0.5607 GB / 1.67 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.002317/5.402, allocations: 1.477 MB / 2.394 GB, free: 0.559 GB / 1.67 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.03342/5.436, allocations: 11.67 MB / 2.405 GB, free: 0.5477 GB / 1.67 GB
Notification: Performance of pre-optimization done (n=734): time 1.661e-05/5.436, allocations: 0 / 2.405 GB, free: 0.5477 GB / 1.67 GB
Notification: Performance of matching and sorting (n=743): time 0.2501/5.686, allocations: 56.46 MB / 2.46 GB, free: 0.4922 GB / 1.67 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001705/5.686, allocations: 307.4 kB / 2.46 GB, free: 0.4918 GB / 1.67 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.05139/5.737, allocations: 20.54 MB / 2.48 GB, free: 483.2 MB / 1.67 GB
Notification: Performance of collectPreVariables (initialization): time 0.005079/5.742, allocations: 257.7 kB / 2.481 GB, free: 482.9 MB / 1.67 GB
Notification: Performance of collectInitialEqns (initialization): time 0.01113/5.754, allocations: 7.768 MB / 2.488 GB, free: 475.1 MB / 1.67 GB
Notification: Performance of collectInitialBindings (initialization): time 0.004254/5.758, allocations: 2.593 MB / 2.491 GB, free: 472.6 MB / 1.67 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.006165/5.764, allocations: 2.21 MB / 2.493 GB, free: 470.4 MB / 1.67 GB
Notification: Performance of setup shared object (initialization): time 5.28e-05/5.764, allocations: 301.1 kB / 2.493 GB, free: 470.1 MB / 1.67 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.02876/5.793, allocations: 11.42 MB / 2.504 GB, free: 458.6 MB / 1.67 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.03179/5.825, allocations: 12.74 MB / 2.517 GB, free: 445.3 MB / 1.67 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.578/6.403, allocations: 214.8 MB / 2.727 GB, free: 229.7 MB / 1.67 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0001113/6.403, allocations: 12 kB / 2.727 GB, free: 229.7 MB / 1.67 GB
Notification: Performance of matching and sorting (n=1245) (initialization): time 0.1389/6.542, allocations: 31.27 MB / 2.757 GB, free: 198.3 MB / 1.67 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0005245/6.542, allocations: 351.2 kB / 2.758 GB, free: 197.9 MB / 1.67 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001003/6.542, allocations: 28 kB / 2.758 GB, free: 197.9 MB / 1.67 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.01375/6.556, allocations: 3.451 MB / 2.761 GB, free: 194.4 MB / 1.67 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01927/6.575, allocations: 2.976 MB / 2.764 GB, free: 191.4 MB / 1.67 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.03293/6.608, allocations: 37.47 MB / 2.8 GB, free: 151.5 MB / 1.67 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.02654/6.635, allocations: 1.62 MB / 2.802 GB, free: 149.9 MB / 1.67 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.004644/6.639, allocations: 0.5071 MB / 2.802 GB, free: 149.4 MB / 1.67 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.04283/6.682, allocations: 16.02 MB / 2.818 GB, free: 133.3 MB / 1.67 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.03153/6.714, allocations: 12.65 MB / 2.83 GB, free: 120.1 MB / 1.67 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 1.37/8.083, allocations: 214.2 MB / 3.04 GB, free: 0.6084 GB / 1.67 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 4.427e-05/8.083, allocations: 12 kB / 3.04 GB, free: 0.6083 GB / 1.67 GB
Notification: Performance of matching and sorting (n=1245) (initialization_lambda0): time 0.1325/8.216, allocations: 30.85 MB / 3.07 GB, free: 0.5819 GB / 1.67 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0003559/8.216, allocations: 351.2 kB / 3.07 GB, free: 0.5815 GB / 1.67 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 6.759e-05/8.216, allocations: 28 kB / 3.07 GB, free: 0.5815 GB / 1.67 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.01083/8.227, allocations: 3.138 MB / 3.073 GB, free: 0.5784 GB / 1.67 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01816/8.245, allocations: 2.913 MB / 3.076 GB, free: 0.5756 GB / 1.67 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.03043/8.276, allocations: 36.87 MB / 3.112 GB, free: 0.5372 GB / 1.67 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.02565/8.301, allocations: 1.65 MB / 3.114 GB, free: 0.5356 GB / 1.67 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.003749/8.305, allocations: 0.4953 MB / 3.114 GB, free: 0.5351 GB / 1.67 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.005948/8.311, allocations: 0.7634 MB / 3.115 GB, free: 0.5344 GB / 1.67 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.007882/8.319, allocations: 1.644 MB / 3.117 GB, free: 0.5337 GB / 1.67 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.1251/8.444, allocations: 25.77 MB / 3.142 GB, free: 0.5085 GB / 1.67 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 8.161e-05/8.444, allocations: 72 kB / 3.142 GB, free: 0.5084 GB / 1.67 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 4.211e-05/8.444, allocations: 11.83 kB / 3.142 GB, free: 0.5084 GB / 1.67 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.1079/8.552, allocations: 22.86 MB / 3.164 GB, free: 497.6 MB / 1.67 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.1613/8.713, allocations: 49.14 MB / 3.212 GB, free: 448.5 MB / 1.67 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 7.692e-05/8.713, allocations: 0 / 3.212 GB, free: 448.5 MB / 1.67 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0164/8.73, allocations: 2.492 MB / 3.215 GB, free: 446 MB / 1.67 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.005733/8.736, allocations: 1.816 MB / 3.216 GB, free: 444.2 MB / 1.67 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.002658/8.738, allocations: 295.6 kB / 3.217 GB, free: 443.9 MB / 1.67 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.02076/8.759, allocations: 21.3 MB / 3.237 GB, free: 421.4 MB / 1.67 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 3.146e-06/8.759, allocations: 3.938 kB / 3.237 GB, free: 421.4 MB / 1.67 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.1547/8.914, allocations: 36.89 MB / 3.273 GB, free: 385.3 MB / 1.67 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.01406/8.928, allocations: 4.382 MB / 3.278 GB, free: 381.3 MB / 1.67 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.008249/8.936, allocations: 247.9 kB / 3.278 GB, free: 381 MB / 1.67 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.02252/8.958, allocations: 1.572 MB / 3.28 GB, free: 379.5 MB / 1.67 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0022/8.961, allocations: 0.5789 MB / 3.28 GB, free: 378.9 MB / 1.67 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.002483/8.963, allocations: 387.5 kB / 3.28 GB, free: 378.5 MB / 1.67 GB
Notification: Performance of sorting global known variables: time 0.02734/8.99, allocations: 14.18 MB / 3.294 GB, free: 364.4 MB / 1.67 GB
Notification: Performance of sort global known variables: time 2.1e-07/8.99, allocations: 0 / 3.294 GB, free: 364.4 MB / 1.67 GB
Notification: Performance of remove unused functions: time 0.03167/9.022, allocations: 6.626 MB / 3.301 GB, free: 357.8 MB / 1.67 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.006789/9.029, allocations: 1.87 MB / 3.303 GB, free: 356.3 MB / 1.67 GB
Notification: Performance of simCode: created initialization part: time 0.1028/9.132, allocations: 40.42 MB / 3.342 GB, free: 315.2 MB / 1.67 GB
Notification: Performance of simCode: created event and clocks part: time 1.289e-05/9.132, allocations: 6.656 kB / 3.342 GB, free: 315.2 MB / 1.67 GB
Notification: Performance of simCode: created simulation system equations: time 0.03666/9.168, allocations: 11.2 MB / 3.353 GB, free: 303.9 MB / 1.67 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.04339/9.212, allocations: 6.828 MB / 3.36 GB, free: 297.2 MB / 1.67 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.1103/9.322, allocations: 41.27 MB / 3.4 GB, free: 256 MB / 1.67 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.01892/9.341, allocations: 9.493 MB / 3.409 GB, free: 246.4 MB / 1.67 GB
Notification: Performance of simCode: alias equations: time 0.02598/9.367, allocations: 5.216 MB / 3.414 GB, free: 241.2 MB / 1.67 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.008588/9.376, allocations: 1.264 MB / 3.416 GB, free: 239.9 MB / 1.67 GB
Notification: Performance of SimCode: time 1.132e-06/9.376, allocations: 0 / 3.416 GB, free: 239.9 MB / 1.67 GB
Notification: Performance of Templates: time 1.996/11.37, allocations: 379.6 MB / 3.786 GB, free: 0.5527 GB / 1.67 GB
"
[Timeout remaining time 289]
make -j1 -f Buildings_10_Buildings.Fluid.DXSystems.Cooling.AirSource.Examples.SpaceCooling.makefile [Timeout 300]
(rm -f Buildings_10_Buildings.Fluid.DXSystems.Cooling.AirSource.Examples.SpaceCooling.pipe ; mkfifo Buildings_10_Buildings.Fluid.DXSystems.Cooling.AirSource.Examples.SpaceCooling.pipe ; head -c 1048576 < Buildings_10_Buildings.Fluid.DXSystems.Cooling.AirSource.Examples.SpaceCooling.pipe >> ../files/Buildings_10_Buildings.Fluid.DXSystems.Cooling.AirSource.Examples.SpaceCooling.sim & ./Buildings_10_Buildings.Fluid.DXSystems.Cooling.AirSource.Examples.SpaceCooling  -abortSlowSimulation -alarm=400  -emit_protected -lv LOG_STATS > Buildings_10_Buildings.Fluid.DXSystems.Cooling.AirSource.Examples.SpaceCooling.pipe 2>&1) [Timeout 400]
[Calling os._exit(0), Time elapsed: 32.83011589478701]
Failed to read output from testmodel.py, exit status != 0:
11.383670730516315 11.394068643 7.646633756
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f5cb7c497b0>