Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_12_Buildings.Fluid.HydronicConfigurations.ActiveNetworks.Examples.DecouplingMixing.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.001792/0.001792, allocations: 79.73 kB / 19.76 MB, free: 1.871 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.002102/0.002102, allocations: 164.7 kB / 23.01 MB, free: 4.594 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.446/1.446, allocations: 177.2 MB / 203.4 MB, free: 8.992 MB / 190.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 2.778/2.778, allocations: 377.9 MB / 0.6228 GB, free: 12.56 MB / 0.5919 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: translateModel(Buildings.Fluid.HydronicConfigurations.ActiveNetworks.Examples.DecouplingMixing,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|con.dp3.p_rel|con.dp3Set.y|con.val.y_actual|con1.set|T1Sup.T|con1.T2Sup.T|con1.T2Ret.T|con.T2Ret.T|T1ConRet.T|con1.yVal_actual|pum.m_flow|con.res3.m_flow|con1.pum.m_flow|con1.res3.m_flow|mPum_flow_nominal|con1.mPum_flow_nominal|pum.y_actual|con1.yPum_actual|fraLoa.y.1.|fraLoa.y.2.|loa.yLoa_actual|loa1.yLoa_actual|loa.con.val.y_actual|loa1.con.val.y_actual",fileNamePrefix="Buildings_12_Buildings.Fluid.HydronicConfigurations.ActiveNetworks.Examples.DecouplingMixing")
translateModel(Buildings.Fluid.HydronicConfigurations.ActiveNetworks.Examples.DecouplingMixing,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|con.dp3.p_rel|con.dp3Set.y|con.val.y_actual|con1.set|T1Sup.T|con1.T2Sup.T|con1.T2Ret.T|con.T2Ret.T|T1ConRet.T|con1.yVal_actual|pum.m_flow|con.res3.m_flow|con1.pum.m_flow|con1.res3.m_flow|mPum_flow_nominal|con1.mPum_flow_nominal|pum.y_actual|con1.yPum_actual|fraLoa.y.1.|fraLoa.y.2.|loa.yLoa_actual|loa1.yLoa_actual|loa.con.val.y_actual|loa1.con.val.y_actual",fileNamePrefix="Buildings_12_Buildings.Fluid.HydronicConfigurations.ActiveNetworks.Examples.DecouplingMixing") [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.00219/0.00219, allocations: 67.91 kB / 0.9821 GB, free: 12.08 MB / 0.9356 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 1.081/1.083, allocations: 176.1 MB / 1.154 GB, free: 33.31 MB / 1.076 GB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.1.1-maint.12.x/Fluid/HydronicConfigurations/Interfaces/PartialHydronicConfiguration.mo:25:3-29:67:writable] Warning: Parameter loa.con.dp1_nominal has no value, and is fixed during initialization (fixed=true), using available start value (start=0) as default value.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.1.1-maint.12.x/Fluid/HydronicConfigurations/Interfaces/PartialHydronicConfiguration.mo:25:3-29:67:writable] Warning: Parameter loa1.con.dp1_nominal has no value, and is fixed during initialization (fixed=true), using available start value (start=0) as default value.
Notification: Performance of NFInst.instantiate(Buildings.Fluid.HydronicConfigurations.ActiveNetworks.Examples.DecouplingMixing): time 2.383/3.467, allocations: 1.08 GB / 2.234 GB, free: 1.711 MB / 1.701 GB
Notification: Performance of NFInst.instExpressions: time 0.3811/3.848, allocations: 202.9 MB / 2.432 GB, free: 6.355 MB / 1.904 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.06628/3.914, allocations: 1.53 MB / 2.433 GB, free: 4.812 MB / 1.904 GB
Notification: Performance of NFTyping.typeComponents: time 0.04278/3.957, allocations: 11.73 MB / 2.445 GB, free: 9.012 MB / 1.92 GB
Notification: Performance of NFTyping.typeBindings: time 1.649/5.606, allocations: 34.81 MB / 2.479 GB, free: 41.72 MB / 1.92 GB
Notification: Performance of NFTyping.typeClassSections: time 0.06066/5.666, allocations: 21.05 MB / 2.5 GB, free: 41.58 MB / 1.92 GB
Notification: Performance of NFFlatten.flatten: time 0.1678/5.834, allocations: 86.43 MB / 2.584 GB, free: 41.22 MB / 1.92 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.07904/5.913, allocations: 17.72 MB / 2.601 GB, free: 39.95 MB / 1.92 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.09007/6.003, allocations: 26.46 MB / 2.627 GB, free: 39.31 MB / 1.92 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.04907/6.053, allocations: 16.95 MB / 2.644 GB, free: 36.34 MB / 1.92 GB
Notification: Performance of NFPackage.collectConstants: time 0.01672/6.069, allocations: 3.282 MB / 2.647 GB, free: 36.34 MB / 1.92 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.06471/6.134, allocations: 16.58 MB / 2.663 GB, free: 36.22 MB / 1.92 GB
Notification: Performance of NFScalarize.scalarize: time 0.01931/6.153, allocations: 8.118 MB / 2.671 GB, free: 35.11 MB / 1.92 GB
Notification: Performance of NFVerifyModel.verify: time 0.04291/6.196, allocations: 11.79 MB / 2.682 GB, free: 32.29 MB / 1.92 GB
Notification: Performance of NFConvertDAE.convert: time 0.1233/6.319, allocations: 53.54 MB / 2.735 GB, free: 15.85 MB / 1.92 GB
Notification: Performance of FrontEnd - DAE generated: time 7.274e-06/6.319, allocations: 0 / 2.735 GB, free: 15.85 MB / 1.92 GB
Notification: Performance of FrontEnd: time 2.134e-06/6.319, allocations: 2.875 kB / 2.735 GB, free: 15.85 MB / 1.92 GB
Notification: Performance of Transformations before backend: time 0.002893/6.322, allocations: 0 / 2.735 GB, free: 15.85 MB / 1.92 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 3674
 * Number of variables: 3674
Notification: Performance of Generate backend data structure: time 0.1502/6.473, allocations: 35.01 MB / 2.769 GB, free: 14.82 MB / 1.936 GB
Notification: Performance of prepare preOptimizeDAE: time 6.197e-05/6.473, allocations: 9.219 kB / 2.769 GB, free: 14.82 MB / 1.936 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.07509/6.548, allocations: 9.661 MB / 2.778 GB, free: 10.84 MB / 1.936 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.08365/6.631, allocations: 26.81 MB / 2.805 GB, free: 8.969 MB / 1.951 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.002363/6.634, allocations: 1.26 MB / 2.806 GB, free: 7.688 MB / 1.951 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.01038/6.644, allocations: 1.513 MB / 2.807 GB, free: 6.18 MB / 1.951 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.09208/6.736, allocations: 22.53 MB / 2.829 GB, free: 14.91 MB / 1.982 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0009371/6.737, allocations: 26.58 kB / 2.829 GB, free: 14.9 MB / 1.982 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.008691/6.746, allocations: 0.5835 MB / 2.83 GB, free: 14.32 MB / 1.982 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0007752/6.747, allocations: 0.5424 MB / 2.83 GB, free: 13.78 MB / 1.982 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.08237/6.829, allocations: 20.84 MB / 2.851 GB, free: 8.926 MB / 1.998 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.2321/7.061, allocations: 70.1 MB / 2.919 GB, free: 4.328 MB / 2.061 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.04049/7.102, allocations: 12.79 MB / 2.932 GB, free: 7.66 MB / 2.076 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.02641/7.128, allocations: 8.064 MB / 2.94 GB, free: 15.53 MB / 2.092 GB
Warning: The model contains alias variables with redundant start and/or conflicting nominal values. It is recommended to resolve the conflicts, because otherwise the system could be hard to solve. To print the conflicting alias sets and the chosen candidates please use -d=aliasConflicts.
Notification: Performance of preOpt evalFunc (simulation): time 0.09318/7.221, allocations: 24.01 MB / 2.963 GB, free: 7.938 MB / 2.107 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.03227/7.253, allocations: 10.05 MB / 2.973 GB, free: 13.42 MB / 2.123 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.01441/7.268, allocations: 0.7873 MB / 2.974 GB, free: 12.63 MB / 2.123 GB
Notification: Performance of pre-optimization done (n=930): time 6.983e-05/7.268, allocations: 0 / 2.974 GB, free: 12.63 MB / 2.123 GB
Notification: Performance of matching and sorting (n=954): time 0.1986/7.467, allocations: 42.98 MB / 3.016 GB, free: 1.543 MB / 2.154 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0006083/7.467, allocations: 0.5645 MB / 3.016 GB, free: 0.8672 MB / 2.154 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.06354/7.531, allocations: 18.38 MB / 3.034 GB, free: 14.6 MB / 2.186 GB
Notification: Performance of collectPreVariables (initialization): time 0.004683/7.535, allocations: 255.3 kB / 3.034 GB, free: 14.34 MB / 2.186 GB
Notification: Performance of collectInitialEqns (initialization): time 0.01933/7.555, allocations: 10.42 MB / 3.044 GB, free: 3.941 MB / 2.186 GB
Notification: Performance of collectInitialBindings (initialization): time 0.008289/7.563, allocations: 3.385 MB / 3.048 GB, free: 0.6016 MB / 2.186 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.01707/7.58, allocations: 2.833 MB / 3.051 GB, free: 13.75 MB / 2.201 GB
Notification: Performance of setup shared object (initialization): time 0.0001565/7.58, allocations: 301.1 kB / 3.051 GB, free: 13.46 MB / 2.201 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.02797/7.608, allocations: 8.393 MB / 3.059 GB, free: 4.984 MB / 2.201 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.03601/7.644, allocations: 14.58 MB / 3.073 GB, free: 4.434 MB / 2.217 GB
Warning: It was not possible to determine if the initialization problem is consistent, because of not evaluable parameters/start values during compile time: loa.loa.coi.heaCooHum_u.vol.dynBal.medium.p = loa.loa.coi.heaCooHum_u.vol.dynBal.p_start (loa.loa.outAir.p = loa.loa.coi.heaCooHum_u.vol.dynBal.p_start)
Warning: It was not possible to determine if the initialization problem is consistent, because of not evaluable parameters/start values during compile time: loa1.loa.coi.heaCooHum_u.vol.dynBal.medium.p = loa1.loa.coi.heaCooHum_u.vol.dynBal.p_start (loa1.loa.outAir.p = loa1.loa.coi.heaCooHum_u.vol.dynBal.p_start)
Notification: Performance of analyzeInitialSystem (initialization): time 0.2807/7.925, allocations: 68.48 MB / 3.14 GB, free: 14.96 MB / 2.295 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0002084/7.925, allocations: 20 kB / 3.14 GB, free: 14.94 MB / 2.295 GB
Notification: Performance of matching and sorting (n=1632) (initialization): time 0.1029/8.028, allocations: 23.31 MB / 3.163 GB, free: 7.875 MB / 2.311 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0004682/8.028, allocations: 309 kB / 3.163 GB, free: 7.512 MB / 2.311 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0002432/8.029, allocations: 68 kB / 3.163 GB, free: 7.445 MB / 2.311 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.009146/8.038, allocations: 2.49 MB / 3.166 GB, free: 4.93 MB / 2.311 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.02571/8.064, allocations: 3.72 MB / 3.169 GB, free: 1.379 MB / 2.311 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.03123/8.095, allocations: 25.48 MB / 3.194 GB, free: 6.789 MB / 2.342 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.03233/8.127, allocations: 1.532 MB / 3.196 GB, free: 5.266 MB / 2.342 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.006043/8.133, allocations: 0.7502 MB / 3.196 GB, free: 4.52 MB / 2.342 GB
Warning: The initial conditions are over specified. The following 4 initial equations are redundant, so they are removed from the initialization system:
         loa.loa.coi.heaCooHum_u.vol.dynBal.medium.p = loa.loa.coi.heaCooHum_u.vol.dynBal.p_start
         $DER.loa.loa.coiNom.heaCooHum_u.vol.dynBal.medium.p = 0.0
         loa1.loa.coi.heaCooHum_u.vol.dynBal.medium.p = loa1.loa.coi.heaCooHum_u.vol.dynBal.p_start
         $DER.loa1.loa.coiNom.heaCooHum_u.vol.dynBal.medium.p = 0.0.
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.04693/8.18, allocations: 12.77 MB / 3.209 GB, free: 7.676 MB / 2.357 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.0376/8.218, allocations: 14.39 MB / 3.223 GB, free: 7.309 MB / 2.373 GB
Warning: It was not possible to determine if the initialization problem is consistent, because of not evaluable parameters/start values during compile time: loa.loa.coi.heaCooHum_u.vol.dynBal.medium.p = loa.loa.coi.heaCooHum_u.vol.dynBal.p_start (loa.loa.outAir.p = loa.loa.coi.heaCooHum_u.vol.dynBal.p_start)
Warning: It was not possible to determine if the initialization problem is consistent, because of not evaluable parameters/start values during compile time: loa1.loa.coi.heaCooHum_u.vol.dynBal.medium.p = loa1.loa.coi.heaCooHum_u.vol.dynBal.p_start (loa1.loa.outAir.p = loa1.loa.coi.heaCooHum_u.vol.dynBal.p_start)
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.2871/8.505, allocations: 67.43 MB / 3.289 GB, free: 2.887 MB / 2.436 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 0.0001765/8.505, allocations: 16 kB / 3.289 GB, free: 2.871 MB / 2.436 GB
Notification: Performance of matching and sorting (n=1632) (initialization_lambda0): time 0.1009/8.606, allocations: 22.98 MB / 3.311 GB, free: 12.14 MB / 2.467 GB
Notification: Performance of prepare postOptimizeDAE: time 0.00041/8.606, allocations: 313 kB / 3.312 GB, free: 11.77 MB / 2.467 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0002202/8.607, allocations: 68 kB / 3.312 GB, free: 11.71 MB / 2.467 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.008432/8.615, allocations: 2.377 MB / 3.314 GB, free: 9.297 MB / 2.467 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.02511/8.64, allocations: 3.681 MB / 3.318 GB, free: 5.785 MB / 2.467 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 1.053/9.694, allocations: 29.71 MB / 3.347 GB, free: 1.286 GB / 2.482 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.02998/9.724, allocations: 1.578 MB / 3.348 GB, free: 1.286 GB / 2.482 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.005207/9.729, allocations: 0.7261 MB / 3.349 GB, free: 1.286 GB / 2.482 GB
Warning: The initial conditions are over specified. The following 4 initial equations are redundant, so they are removed from the initialization_lambda0 system:
         loa.loa.coi.heaCooHum_u.vol.dynBal.medium.p = loa.loa.coi.heaCooHum_u.vol.dynBal.p_start
         $DER.loa.loa.coiNom.heaCooHum_u.vol.dynBal.medium.p = 0.0
         loa1.loa.coi.heaCooHum_u.vol.dynBal.medium.p = loa1.loa.coi.heaCooHum_u.vol.dynBal.p_start
         $DER.loa1.loa.coiNom.heaCooHum_u.vol.dynBal.medium.p = 0.0.
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 313
 * Number of states: 0 ()
 * Number of discrete variables: 77 ($whenCondition9,$whenCondition8,$whenCondition7,$whenCondition6,$whenCondition5,$whenCondition4,$whenCondition3,$whenCondition2,$PRE.fraLoa.tab.nextTimeEvent,$whenCondition1,loa1.loa.coiNom.flowRegime_nominal,loa1.loa.coiNom.UAFroRated.isFulWet,loa1.loa.coiNom.UAFroRated.isFulDry,loa1.loa.coi.flowRegime_nominal,loa1.loa.coi.UAFroRated.isFulWet,loa1.loa.coi.UAFroRated.isFulDry,loa.loa.coiNom.flowRegime_nominal,loa.loa.coiNom.UAFroRated.isFulWet,loa.loa.coiNom.UAFroRated.isFulDry,loa.loa.coi.flowRegime_nominal,loa.loa.coi.UAFroRated.isFulWet,loa.loa.coi.UAFroRated.isFulDry,$PRE.con.ctl.cha.u,$PRE.loa.loa.ctl.cha.u,$PRE.loa1.loa.ctl.cha.u,$PRE.mode.y[1],$PRE.mode.idx,$PRE.con1.ctl.cha.u,$PRE.resT2.cha.u,con.isEna.y,con.ctl.cha.u,con.ctl.cha.y,con.ctl.cha.up,con.ctl.cha.down,con.ctl.isDis.y,con.ctl.addPar.y,loa.loa.ctl.cha.u,loa.loa.ctl.cha.y,loa.loa.ctl.cha.up,loa.loa.ctl.cha.down,loa.loa.ctl.isDis.y,loa.loa.ctl.addPar.y,loa.loa.addPar.y,loa1.loa.ctl.cha.u,loa1.loa.ctl.cha.y,loa1.loa.ctl.cha.up,loa1.loa.ctl.cha.down,loa1.loa.ctl.isDis.y,loa1.loa.ctl.addPar.y,loa1.loa.addPar.y,fraLoa.tab.nextTimeEvent,fraLoa.tab.nextTimeEventScaled,$PRE.fraLoa.tab.nextTimeEventScaled,mode.y[1],mode.idx,isEna.y,addPar.y,con1.ctl.cha.u,con1.ctl.cha.y,con1.ctl.cha.up,con1.ctl.cha.down,con1.ctl.isDis.y,con1.ctl.addPar.y,con1.isEna.y,resT2.cha.u,resT2.cha.y,resT2.cha.up,resT2.cha.down,resT2.isDis.y,resT2.addPar.y,$whenCondition10,$whenCondition11,$whenCondition12,$whenCondition13,$whenCondition14,con1.ctl.conPID.cheYMinMax.y,con.ctl.conPID.cheYMinMax.y)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (1528):
 * Single equations (assignments): 1488
 * Array equations: 10
 * Algorithm blocks: 10
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 5
 * Torn equation systems: 15
 * Mixed (continuous/discrete) equation systems: 0
Notification: Equation system details (not torn):
 * Constant Jacobian (size): 0 systems
 * Linear Jacobian (size,density): 0 systems
 * Non-linear Jacobian (size): 5 systems
   {1, 1, 1, 1, 1}
 * Without analytic Jacobian (size): 0 systems
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 0 systems
 * Non-linear torn systems (#iteration vars, #inner vars): 15 systems
   {(1,2), (1,2), (7,24), (5,2), (1,10), (1,2), (1,2), (1,2), (5,2), (5,2), (1,10), (1,2), (1,2), (1,2), (5,2)}
Notification: Performance of prepare postOptimizeDAE: time 0.00852/9.737, allocations: 1.24 MB / 3.35 GB, free: 1.285 GB / 2.482 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.009979/9.747, allocations: 1.938 MB / 3.352 GB, free: 1.285 GB / 2.482 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.07482/9.822, allocations: 18.77 MB / 3.37 GB, free: 1.284 GB / 2.482 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.000369/9.822, allocations: 107.4 kB / 3.37 GB, free: 1.284 GB / 2.482 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 7.652e-05/9.822, allocations: 4.359 kB / 3.37 GB, free: 1.284 GB / 2.482 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.06216/9.885, allocations: 15.04 MB / 3.385 GB, free: 1.283 GB / 2.482 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.1541/10.04, allocations: 41.2 MB / 3.425 GB, free: 1.265 GB / 2.482 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 0.0002917/10.04, allocations: 22.47 kB / 3.425 GB, free: 1.265 GB / 2.482 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.01725/10.06, allocations: 2.315 MB / 3.428 GB, free: 1.265 GB / 2.482 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.004217/10.06, allocations: 0.9957 MB / 3.429 GB, free: 1.264 GB / 2.482 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.004151/10.06, allocations: 346.1 kB / 3.429 GB, free: 1.264 GB / 2.482 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.0097/10.07, allocations: 10.07 MB / 3.439 GB, free: 1.255 GB / 2.482 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 3.742e-05/10.07, allocations: 33.72 kB / 3.439 GB, free: 1.255 GB / 2.482 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.1053/10.18, allocations: 28.18 MB / 3.466 GB, free: 1.243 GB / 2.482 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0202/10.2, allocations: 4.171 MB / 3.47 GB, free: 1.242 GB / 2.482 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.01434/10.21, allocations: 242.4 kB / 3.471 GB, free: 1.241 GB / 2.482 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.02749/10.24, allocations: 1.052 MB / 3.472 GB, free: 1.241 GB / 2.482 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.003904/10.25, allocations: 0.718 MB / 3.472 GB, free: 1.241 GB / 2.482 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.004307/10.25, allocations: 0.5449 MB / 3.473 GB, free: 1.241 GB / 2.482 GB
Notification: Performance of sorting global known variables: time 0.04206/10.29, allocations: 12.26 MB / 3.485 GB, free: 1.237 GB / 2.482 GB
Notification: Performance of sort global known variables: time 5.61e-07/10.29, allocations: 0 / 3.485 GB, free: 1.237 GB / 2.482 GB
Notification: Performance of remove unused functions: time 0.05926/10.35, allocations: 8.876 MB / 3.493 GB, free: 1.236 GB / 2.482 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 101
 * Number of states: 51 (resT2.conPID.I.y,con1.T2Ret.T,con1.ctl.conPID.I.y,con1.T2Sup.T,con1.pum.pumSpe.motSpe.y,con1.pum.pumSpe.vol.dynBal.U,con1.jun.vol.dynBal.U,con1.val.valEquLin.actPos.y,con1.val.valEquLin.vol.dynBal.U,jun.vol.dynBal.U,T1ConRet.T,del2.dynBal.U,ctlPum2.I.y,loa1.con.val.valEqu.actPos.y,loa1.loa.TAirLvgNom.T,loa1.loa.TLiqLvg.T,loa1.loa.TLiqEnt.T,loa1.loa.coiNom.dryWetCalcs.fullyWet.TWatOutEst,loa1.loa.coiNom.heaCooHum_u.vol.dynBal.medium.T,loa1.loa.coiNom.heaCooHum_u.vol.dynBal.medium.Xi[1],loa1.loa.coiNom.heaCoo.vol.dynBal.medium.T,loa1.loa.ctl.conPID.I.y,loa1.loa.coi.dryWetCalcs.fullyWet.TWatOutEst,loa1.loa.coi.heaCooHum_u.vol.dynBal.U,loa1.loa.coi.heaCooHum_u.vol.dynBal.medium.Xi[1],loa1.loa.coi.heaCoo.vol.dynBal.U,loa1.loa.TAirLvg.T,loa.con.val.valEqu.actPos.y,loa.loa.TAirLvgNom.T,loa.loa.TLiqLvg.T,loa.loa.TLiqEnt.T,loa.loa.coiNom.dryWetCalcs.fullyWet.TWatOutEst,loa.loa.coiNom.heaCooHum_u.vol.dynBal.medium.T,loa.loa.coiNom.heaCooHum_u.vol.dynBal.medium.Xi[1],loa.loa.coiNom.heaCoo.vol.dynBal.medium.T,loa.loa.ctl.conPID.I.y,loa.loa.coi.dryWetCalcs.fullyWet.TWatOutEst,loa.loa.coi.heaCooHum_u.vol.dynBal.U,loa.loa.coi.heaCooHum_u.vol.dynBal.medium.Xi[1],loa.loa.coi.heaCoo.vol.dynBal.U,loa.loa.TAirLvg.T,con.T2Ret.T,con.T2Sup.T,con.val.valEqu.actPos.y,con.junBypRet.vol.dynBal.U,con.junBypSup.vol.dynBal.U,del1.dynBal.U,T1Sup.T,T1Ret.T,pum.pumDp.motSpe.y,pum.pumDp.vol.dynBal.U)
 * Number of discrete variables: 54 (con1.ctl.cha.y,resT2.cha.y,loa.loa.ctl.cha.y,loa1.loa.ctl.cha.y,isEna.y,$whenCondition14,$whenCondition13,$whenCondition12,$whenCondition11,$whenCondition10,$whenCondition9,$whenCondition8,$whenCondition7,$whenCondition6,$whenCondition5,$whenCondition4,$whenCondition3,$whenCondition2,$whenCondition1,resT2.addPar.y,resT2.isDis.y,resT2.cha.down,resT2.cha.up,resT2.cha.u,con1.isEna.y,con1.ctl.addPar.y,con1.ctl.isDis.y,con1.ctl.cha.down,con1.ctl.cha.up,con1.ctl.cha.u,addPar.y,mode.idx,mode.y[1],fraLoa.tab.nextTimeEventScaled,fraLoa.tab.nextTimeEvent,loa1.loa.addPar.y,loa1.loa.ctl.addPar.y,loa1.loa.ctl.isDis.y,loa1.loa.ctl.cha.down,loa1.loa.ctl.cha.up,loa1.loa.ctl.cha.u,loa.loa.addPar.y,loa.loa.ctl.addPar.y,loa.loa.ctl.isDis.y,loa.loa.ctl.cha.down,loa.loa.ctl.cha.up,loa.loa.ctl.cha.u,con.ctl.addPar.y,con.ctl.isDis.y,con.ctl.cha.down,con.ctl.cha.up,con.ctl.cha.y,con.ctl.cha.u,con.isEna.y)
 * Number of discrete states: 7 (fraLoa.tab.nextTimeEvent,con.ctl.cha.u,loa1.loa.ctl.cha.u,loa.loa.ctl.cha.u,resT2.cha.u,con1.ctl.cha.u,fraLoa.tab.nextTimeEventScaled)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (991):
 * Single equations (assignments): 936
 * Array equations: 0
 * Algorithm blocks: 10
 * Record equations: 31
 * When equations: 4
 * If-equations: 0
 * Equation systems (not torn): 1
 * Torn equation systems: 9
 * 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): 1 system
   {1}
 * Without analytic Jacobian (size): 0 systems
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 0 systems
 * Non-linear torn systems (#iteration vars, #inner vars): 9 systems
   {(1,2), (1,2), (7,25), (1,2), (1,2), (1,1), (1,1), (1,1), (1,1)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.01185/10.36, allocations: 3.512 MB / 3.497 GB, free: 1.235 GB / 2.482 GB
Notification: Performance of simCode: created initialization part: time 0.1015/10.46, allocations: 31.64 MB / 3.528 GB, free: 1.219 GB / 2.482 GB
Notification: Performance of simCode: created event and clocks part: time 6.907e-05/10.46, allocations: 10.66 kB / 3.528 GB, free: 1.219 GB / 2.482 GB
Notification: Performance of simCode: created simulation system equations: time 0.02636/10.49, allocations: 8.659 MB / 3.536 GB, free: 1.211 GB / 2.482 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.06877/10.56, allocations: 10.28 MB / 3.546 GB, free: 1.204 GB / 2.482 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.105/10.66, allocations: 42.75 MB / 3.588 GB, free: 1.165 GB / 2.482 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.02564/10.69, allocations: 9.355 MB / 3.597 GB, free: 1.159 GB / 2.482 GB
Notification: Performance of simCode: alias equations: time 0.04147/10.73, allocations: 5.156 MB / 3.602 GB, free: 1.155 GB / 2.482 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.01116/10.74, allocations: 1.522 MB / 3.604 GB, free: 1.154 GB / 2.482 GB
Notification: Performance of SimCode: time 2.274e-06/10.74, allocations: 0 / 3.604 GB, free: 1.154 GB / 2.482 GB
Notification: Performance of Templates: time 0.6364/11.38, allocations: 433.1 MB / 4.027 GB, free: 0.7354 GB / 2.482 GB
"
[Timeout remaining time 289]
make -j1 -f Buildings_12_Buildings.Fluid.HydronicConfigurations.ActiveNetworks.Examples.DecouplingMixing.makefile [Timeout 300]
(rm -f Buildings_12_Buildings.Fluid.HydronicConfigurations.ActiveNetworks.Examples.DecouplingMixing.pipe ; mkfifo Buildings_12_Buildings.Fluid.HydronicConfigurations.ActiveNetworks.Examples.DecouplingMixing.pipe ; head -c 1048576 < Buildings_12_Buildings.Fluid.HydronicConfigurations.ActiveNetworks.Examples.DecouplingMixing.pipe >> ../files/Buildings_12_Buildings.Fluid.HydronicConfigurations.ActiveNetworks.Examples.DecouplingMixing.sim & ./Buildings_12_Buildings.Fluid.HydronicConfigurations.ActiveNetworks.Examples.DecouplingMixing  -abortSlowSimulation -alarm=400 -s ida -emit_protected -lv LOG_STATS > Buildings_12_Buildings.Fluid.HydronicConfigurations.ActiveNetworks.Examples.DecouplingMixing.pipe 2>&1) [Timeout 400]
[Calling os._exit(0), Time elapsed: 136.09743345191237]
Failed to read output from testmodel.py, exit status != 0:
11.392510583042167 11.401373161 5.079041117
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7fe80df7efe0>