Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_latest_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.001168/0.001168, allocations: 113.5 kB / 19.73 MB, free: 2.242 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.001233/0.001233, allocations: 219.5 kB / 23.04 MB, free: 5.074 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.294/1.294, allocations: 230.6 MB / 256.8 MB, free: 8 MB / 206.1 MB
"
[Timeout remaining time 179]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings master/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings master/package.mo): time 2.874/2.874, allocations: 0.5003 GB / 0.8061 GB, free: 26.71 MB / 0.6231 GB
"
[Timeout remaining time 177]
Using package Buildings with version 13.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings master/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.HydronicConfigurations.ActiveNetworks.Examples.DecouplingMixing,fileNamePrefix="Buildings_latest_Buildings_Fluid_HydronicConfigurations_ActiveNetworks_Examples_DecouplingMixing",fmuType="cs",version="2.0",platforms={"static"})
"" <> buildModelFMU(Buildings.Fluid.HydronicConfigurations.ActiveNetworks.Examples.DecouplingMixing,fileNamePrefix="Buildings_latest_Buildings_Fluid_HydronicConfigurations_ActiveNetworks_Examples_DecouplingMixing",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.001828/0.001828, allocations: 66.39 kB / 1.171 GB, free: 19.8 MB / 0.9044 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.3034/0.3053, allocations: 179 MB / 1.345 GB, free: 292 kB / 1.029 GB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings master/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 master/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.625/2.93, allocations: 1.21 GB / 2.556 GB, free: 104.3 MB / 1.764 GB
Notification: Performance of NFInst.instExpressions: time 0.2359/3.166, allocations: 217.2 MB / 2.768 GB, free: 2.93 MB / 1.779 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.04603/3.212, allocations: 1.525 MB / 2.769 GB, free: 1.527 MB / 1.779 GB
Notification: Performance of NFTyping.typeComponents: time 0.03501/3.247, allocations: 12.37 MB / 2.781 GB, free: 5.102 MB / 1.795 GB
Notification: Performance of NFTyping.typeBindings: time 0.09322/3.34, allocations: 34.99 MB / 2.816 GB, free: 1.984 MB / 1.826 GB
Notification: Performance of NFTyping.typeClassSections: time 0.04878/3.389, allocations: 21.46 MB / 2.836 GB, free: 12.59 MB / 1.857 GB
Notification: Performance of NFFlatten.flatten: time 0.1185/3.508, allocations: 81.96 MB / 2.917 GB, free: 10.47 MB / 1.936 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.03611/3.544, allocations: 17.94 MB / 2.934 GB, free: 8.359 MB / 1.951 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.05915/3.603, allocations: 26.15 MB / 2.96 GB, free: 14.21 MB / 1.982 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.03397/3.637, allocations: 18.04 MB / 2.977 GB, free: 12.12 MB / 1.998 GB
Notification: Performance of NFPackage.collectConstants: time 0.01015/3.647, allocations: 3.336 MB / 2.98 GB, free: 8.781 MB / 1.998 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.04729/3.694, allocations: 21.36 MB / 3.001 GB, free: 3.379 MB / 2.014 GB
Notification: Performance of NFScalarize.scalarize: time 0.01311/3.707, allocations: 8.201 MB / 3.009 GB, free: 11.15 MB / 2.029 GB
Notification: Performance of NFVerifyModel.verify: time 0.02929/3.737, allocations: 15.33 MB / 3.024 GB, free: 11.75 MB / 2.045 GB
Notification: Performance of NFConvertDAE.convert: time 0.09019/3.827, allocations: 54.56 MB / 3.078 GB, free: 5.02 MB / 2.092 GB
Notification: Performance of FrontEnd - DAE generated: time 6.782e-06/3.827, allocations: 0 / 3.078 GB, free: 5.02 MB / 2.092 GB
Notification: Performance of FrontEnd: time 1.703e-06/3.827, allocations: 0 / 3.078 GB, free: 5.02 MB / 2.092 GB
Notification: Performance of Transformations before backend: time 0.001187/3.828, allocations: 0 / 3.078 GB, free: 5.02 MB / 2.092 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 1.16/4.988, allocations: 35.19 MB / 3.112 GB, free: 0.9685 GB / 2.092 GB
Notification: Performance of prepare preOptimizeDAE: time 4.598e-05/4.988, allocations: 8.906 kB / 3.112 GB, free: 0.9685 GB / 2.092 GB
Notification: Performance of preOpt introduceOutputRealDerivatives (simulation): time 0.0005669/4.988, allocations: 372.6 kB / 3.112 GB, free: 0.9685 GB / 2.092 GB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.006521/4.995, allocations: 1.835 MB / 3.114 GB, free: 0.9675 GB / 2.092 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.06308/5.058, allocations: 9.658 MB / 3.124 GB, free: 0.9658 GB / 2.092 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.05535/5.113, allocations: 31.75 MB / 3.155 GB, free: 0.9447 GB / 2.092 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.001121/5.115, allocations: 1.265 MB / 3.156 GB, free: 0.9441 GB / 2.092 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.005089/5.12, allocations: 1.519 MB / 3.157 GB, free: 0.9436 GB / 2.092 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.05189/5.172, allocations: 20.75 MB / 3.178 GB, free: 0.9317 GB / 2.092 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0005894/5.172, allocations: 15.8 kB / 3.178 GB, free: 0.9317 GB / 2.092 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.003995/5.176, allocations: 0.5842 MB / 3.178 GB, free: 0.9313 GB / 2.092 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0003694/5.176, allocations: 0.5488 MB / 3.179 GB, free: 0.9312 GB / 2.092 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.05539/5.232, allocations: 20.8 MB / 3.199 GB, free: 0.9195 GB / 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 removeSimpleEquations (simulation): time 0.1427/5.375, allocations: 95.88 MB / 3.293 GB, free: 0.8227 GB / 2.092 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.02723/5.402, allocations: 12.72 MB / 3.305 GB, free: 0.8107 GB / 2.092 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.01727/5.419, allocations: 7.902 MB / 3.313 GB, free: 0.8031 GB / 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.05052/5.47, allocations: 29.81 MB / 3.342 GB, free: 0.7741 GB / 2.092 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.01752/5.487, allocations: 8.435 MB / 3.35 GB, free: 0.7659 GB / 2.092 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.008632/5.496, allocations: 0.9469 MB / 3.351 GB, free: 0.765 GB / 2.092 GB
Notification: Performance of pre-optimization done (n=930): time 2.692e-05/5.496, allocations: 0 / 3.351 GB, free: 0.765 GB / 2.092 GB
Notification: Performance of matching and sorting (n=954): time 0.1163/5.612, allocations: 42.92 MB / 3.393 GB, free: 0.7231 GB / 2.092 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001371/5.612, allocations: 0.5567 MB / 3.393 GB, free: 0.7225 GB / 2.092 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.02832/5.641, allocations: 20.15 MB / 3.413 GB, free: 0.7029 GB / 2.092 GB
Notification: Performance of collectPreVariables (initialization): time 0.002641/5.643, allocations: 265.5 kB / 3.413 GB, free: 0.7026 GB / 2.092 GB
Notification: Performance of collectInitialEqns (initialization): time 0.007856/5.651, allocations: 10.26 MB / 3.423 GB, free: 0.6926 GB / 2.092 GB
Notification: Performance of collectInitialBindings (initialization): time 0.003836/5.655, allocations: 3.399 MB / 3.427 GB, free: 0.6894 GB / 2.092 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.005659/5.661, allocations: 3.088 MB / 3.43 GB, free: 0.6863 GB / 2.092 GB
Notification: Performance of setup shared object (initialization): time 3.245e-05/5.661, allocations: 305.1 kB / 3.43 GB, free: 0.686 GB / 2.092 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.01901/5.68, allocations: 8.985 MB / 3.439 GB, free: 0.6772 GB / 2.092 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.02257/5.702, allocations: 12.4 MB / 3.451 GB, free: 0.6639 GB / 2.092 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.218/5.92, allocations: 73.39 MB / 3.523 GB, free: 0.5913 GB / 2.092 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 6.408e-05/5.92, allocations: 20 kB / 3.523 GB, free: 0.5913 GB / 2.092 GB
Notification: Performance of matching and sorting (n=1781) (initialization): time 0.06527/5.985, allocations: 25.07 MB / 3.547 GB, free: 0.5667 GB / 2.092 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001444/5.986, allocations: 305 kB / 3.547 GB, free: 0.5664 GB / 2.092 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 9.955e-05/5.986, allocations: 72.16 kB / 3.547 GB, free: 0.5663 GB / 2.092 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.006818/5.993, allocations: 2.494 MB / 3.55 GB, free: 0.5638 GB / 2.092 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01965/6.012, allocations: 3.815 MB / 3.554 GB, free: 0.5601 GB / 2.092 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01911/6.031, allocations: 25.8 MB / 3.579 GB, free: 0.5335 GB / 2.092 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.02426/6.056, allocations: 1.583 MB / 3.58 GB, free: 0.532 GB / 2.092 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.00342/6.059, allocations: 0.7613 MB / 3.581 GB, free: 0.5313 GB / 2.092 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.03096/6.09, allocations: 13.2 MB / 3.594 GB, free: 0.5184 GB / 2.092 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.02302/6.113, allocations: 12.04 MB / 3.606 GB, free: 0.5054 GB / 2.092 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.2173/6.33, allocations: 71.5 MB / 3.676 GB, free: 444.9 MB / 2.092 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 7.861e-05/6.33, allocations: 20 kB / 3.676 GB, free: 444.9 MB / 2.092 GB
Notification: Performance of matching and sorting (n=1781) (initialization_lambda0): time 0.06497/6.395, allocations: 24.47 MB / 3.699 GB, free: 420.3 MB / 2.092 GB
Notification: Performance of prepare postOptimizeDAE: time 0.000148/6.395, allocations: 305 kB / 3.7 GB, free: 419.9 MB / 2.092 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 9.65e-05/6.396, allocations: 68 kB / 3.7 GB, free: 419.9 MB / 2.092 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.006349/6.402, allocations: 2.39 MB / 3.702 GB, free: 417.4 MB / 2.092 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01903/6.421, allocations: 3.776 MB / 3.706 GB, free: 413.6 MB / 2.092 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.02455/6.445, allocations: 30.14 MB / 3.735 GB, free: 382 MB / 2.092 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.02493/6.47, allocations: 1.657 MB / 3.737 GB, free: 380.3 MB / 2.092 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.003356/6.474, allocations: 0.7338 MB / 3.738 GB, free: 379.6 MB / 2.092 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: 312
 * Number of states: 0 ()
 * Number of discrete variables: 93 ($whenCondition9,$whenCondition8,$whenCondition7,$whenCondition6,$whenCondition5,$whenCondition4,$whenCondition3,$whenCondition2,$PRE.fraLoa.tab.nextTimeEvent,$whenCondition1,loa.loa.coi.flowRegime_nominal,loa.loa.coi.dryWetCalcs.fullyDry.cfg,loa.loa.coi.dryWetCalcs.fullyWet.cfg,loa.loa.coi.dryWetCalcs.cfg,loa.loa.coi.flowRegime,loa.loa.coiNom.flowRegime_nominal,loa.loa.coiNom.dryWetCalcs.fullyDry.cfg,loa.loa.coiNom.dryWetCalcs.fullyWet.cfg,loa.loa.coiNom.dryWetCalcs.cfg,loa.loa.coiNom.flowRegime,loa1.loa.coi.flowRegime_nominal,loa1.loa.coi.dryWetCalcs.fullyDry.cfg,loa1.loa.coi.dryWetCalcs.fullyWet.cfg,loa1.loa.coi.dryWetCalcs.cfg,loa1.loa.coi.flowRegime,loa1.loa.coiNom.flowRegime_nominal,loa1.loa.coiNom.dryWetCalcs.fullyDry.cfg,loa1.loa.coiNom.dryWetCalcs.fullyWet.cfg,loa1.loa.coiNom.dryWetCalcs.cfg,loa1.loa.coiNom.flowRegime,loa1.loa.coiNom.UAFroRated.isFulWet,loa1.loa.coiNom.UAFroRated.isFulDry,loa1.loa.coi.UAFroRated.isFulWet,loa1.loa.coi.UAFroRated.isFulDry,loa.loa.coiNom.UAFroRated.isFulWet,loa.loa.coiNom.UAFroRated.isFulDry,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 (1613):
 * Single equations (assignments): 1571
 * Array equations: 10
 * Algorithm blocks: 10
 * Record equations: 2
 * 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.00535/6.479, allocations: 1.27 MB / 3.739 GB, free: 378.3 MB / 2.092 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.006733/6.486, allocations: 2.057 MB / 3.741 GB, free: 376.2 MB / 2.092 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.0518/6.538, allocations: 18.67 MB / 3.759 GB, free: 357.4 MB / 2.092 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.0001075/6.538, allocations: 104 kB / 3.759 GB, free: 357.3 MB / 2.092 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 2.707e-05/6.538, allocations: 0 / 3.759 GB, free: 357.3 MB / 2.092 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.04142/6.579, allocations: 14.93 MB / 3.774 GB, free: 342.2 MB / 2.092 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.09718/6.676, allocations: 47.13 MB / 3.82 GB, free: 294.9 MB / 2.092 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 0.000117/6.676, allocations: 24 kB / 3.82 GB, free: 294.8 MB / 2.092 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.01296/6.689, allocations: 2.313 MB / 3.822 GB, free: 292.5 MB / 2.092 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.003044/6.692, allocations: 1.006 MB / 3.823 GB, free: 291.5 MB / 2.092 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.002418/6.695, allocations: 339.8 kB / 3.823 GB, free: 291.2 MB / 2.092 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.007052/6.702, allocations: 10.17 MB / 3.833 GB, free: 280.4 MB / 2.092 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.421e-05/6.702, allocations: 39.97 kB / 3.833 GB, free: 280.3 MB / 2.092 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.06687/6.769, allocations: 28.07 MB / 3.861 GB, free: 251.7 MB / 2.092 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.01196/6.781, allocations: 4.404 MB / 3.865 GB, free: 247.2 MB / 2.092 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.007252/6.788, allocations: 243.9 kB / 3.865 GB, free: 247 MB / 2.092 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.01809/6.806, allocations: 1.08 MB / 3.866 GB, free: 245.9 MB / 2.092 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.00201/6.808, allocations: 0.7201 MB / 3.867 GB, free: 245.2 MB / 2.092 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.001922/6.81, allocations: 0.5268 MB / 3.868 GB, free: 244.7 MB / 2.092 GB
Notification: Performance of sorting global known variables: time 0.02282/6.833, allocations: 13.65 MB / 3.881 GB, free: 231.1 MB / 2.092 GB
Notification: Performance of sort global known variables: time 4.61e-07/6.833, allocations: 0 / 3.881 GB, free: 231.1 MB / 2.092 GB
Notification: Performance of remove unused functions: time 0.0364/6.869, allocations: 9.183 MB / 3.89 GB, free: 221.9 MB / 2.092 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 (989):
 * Single equations (assignments): 934
 * 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.06457/6.934, allocations: 31.82 MB / 3.921 GB, free: 189.9 MB / 2.092 GB
Notification: Performance of simCode: created initialization part: time 0.07454/7.008, allocations: 32.67 MB / 3.953 GB, free: 156.8 MB / 2.092 GB
Notification: Performance of simCode: created event and clocks part: time 2.052e-05/7.008, allocations: 10.66 kB / 3.953 GB, free: 156.8 MB / 2.092 GB
Notification: Performance of simCode: created simulation system equations: time 0.01842/7.027, allocations: 8.491 MB / 3.961 GB, free: 148.2 MB / 2.092 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.04909/7.076, allocations: 10.99 MB / 3.972 GB, free: 137.6 MB / 2.092 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 1.022/8.098, allocations: 172.4 MB / 4.14 GB, free: 0.9083 GB / 2.092 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.01362/8.112, allocations: 9.501 MB / 4.15 GB, free: 0.9072 GB / 2.092 GB
Notification: Performance of simCode: alias equations: time 0.02654/8.138, allocations: 5.315 MB / 4.155 GB, free: 0.9069 GB / 2.092 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.01731/8.155, allocations: 10.48 MB / 4.165 GB, free: 0.9 GB / 2.092 GB
Notification: Performance of SimCode: time 1.843e-06/8.155, allocations: 0 / 4.165 GB, free: 0.9 GB / 2.092 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.7671/8.922, allocations: 0.6037 GB / 4.769 GB, free: 361.5 MB / 2.092 GB
Notification: Performance of buildModelFMU: Generate platform static: time 90.04/98.96, allocations: 6.172 kB / 4.769 GB, free: 361.5 MB / 2.092 GB
"
[Timeout remaining time 200]
(rm -f Buildings_latest_Buildings.Fluid.HydronicConfigurations.ActiveNetworks.Examples.DecouplingMixing.pipe ; mkfifo Buildings_latest_Buildings.Fluid.HydronicConfigurations.ActiveNetworks.Examples.DecouplingMixing.pipe ; head -c 1048576 < Buildings_latest_Buildings.Fluid.HydronicConfigurations.ActiveNetworks.Examples.DecouplingMixing.pipe >> ../files/Buildings_latest_Buildings.Fluid.HydronicConfigurations.ActiveNetworks.Examples.DecouplingMixing.sim & /home/hudson/saved_omc/OMSimulator/install/bin/OMSimulator -r=Buildings_latest_Buildings.Fluid.HydronicConfigurations.ActiveNetworks.Examples.DecouplingMixing_res.mat --tempDir=temp_Buildings_latest_Buildings_Fluid_HydronicConfigurations_ActiveNetworks_Examples_DecouplingMixing_fmu --startTime=0 --stopTime=86400 --stepSize=34.56 --timeout=800 --tolerance=1e-06 Buildings_latest_Buildings_Fluid_HydronicConfigurations_ActiveNetworks_Examples_DecouplingMixing.fmu > Buildings_latest_Buildings.Fluid.HydronicConfigurations.ActiveNetworks.Examples.DecouplingMixing.pipe 2>&1) [Timeout 840.0]
[Calling os._exit(0), Time elapsed: 107.35216421599034]
Failed to read output from testmodel.py, exit status != 0:
99.57853784703184 99.588763508 95.759237936
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7fb12a92f3a0>