Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_11_Buildings.Fluid.FMI.ExportContainers.Validation.RoomHVAC.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.001832/0.001832, allocations: 110.1 kB / 16.46 MB, free: 6.508 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.002125/0.002125, allocations: 216.2 kB / 19.43 MB, free: 3.648 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.444/1.444, allocations: 230.6 MB / 252.8 MB, free: 9.105 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.91/2.91, allocations: 476.7 MB / 0.7672 GB, free: 5.184 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.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.FMI.ExportContainers.Validation.RoomHVAC,fileNamePrefix="Buildings_11_Buildings_Fluid_FMI_ExportContainers_Validation_RoomHVAC",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(Buildings.Fluid.FMI.ExportContainers.Validation.RoomHVAC,fileNamePrefix="Buildings_11_Buildings_Fluid_FMI_ExportContainers_Validation_RoomHVAC",fmuType="me",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.002004/0.002004, allocations: 59.91 kB / 1.112 GB, free: 1.516 MB / 0.9044 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.7969/0.7989, allocations: 169.9 MB / 1.278 GB, free: 13.41 MB / 0.9825 GB
Notification: Performance of NFInst.instantiate(Buildings.Fluid.FMI.ExportContainers.Validation.RoomHVAC): time 3.285/4.084, allocations: 1.069 GB / 2.347 GB, free: 89.39 MB / 1.732 GB
Notification: Performance of NFInst.instExpressions: time 0.2791/4.363, allocations: 168.2 MB / 2.511 GB, free: 86.98 MB / 1.732 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.05311/4.416, allocations: 0.8697 MB / 2.512 GB, free: 86.98 MB / 1.732 GB
Notification: Performance of NFTyping.typeComponents: time 0.03653/4.453, allocations: 12.55 MB / 2.524 GB, free: 86.05 MB / 1.732 GB
Notification: Performance of NFTyping.typeBindings: time 0.1015/4.554, allocations: 33.22 MB / 2.557 GB, free: 71.81 MB / 1.732 GB
Notification: Performance of NFTyping.typeClassSections: time 0.0556/4.61, allocations: 20.47 MB / 2.577 GB, free: 58.44 MB / 1.732 GB
Notification: Performance of NFFlatten.flatten: time 0.09398/4.704, allocations: 72.2 MB / 2.647 GB, free: 15.31 MB / 1.748 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.06267/4.766, allocations: 25.85 MB / 2.673 GB, free: 5.676 MB / 1.764 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.0815/4.848, allocations: 29.22 MB / 2.701 GB, free: 10.13 MB / 1.795 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.04398/4.892, allocations: 19.35 MB / 2.72 GB, free: 7.941 MB / 1.811 GB
Notification: Performance of NFPackage.collectConstants: time 0.01824/4.91, allocations: 3.602 MB / 2.724 GB, free: 4.34 MB / 1.811 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.07299/4.983, allocations: 26.9 MB / 2.75 GB, free: 12.27 MB / 1.842 GB
Notification: Performance of NFScalarize.scalarize: time 0.01942/5.002, allocations: 9.909 MB / 2.76 GB, free: 2.48 MB / 1.842 GB
Notification: Performance of NFVerifyModel.verify: time 0.039/5.041, allocations: 16.82 MB / 2.776 GB, free: 1.738 MB / 1.857 GB
Notification: Performance of NFConvertDAE.convert: time 0.1475/5.189, allocations: 59.5 MB / 2.834 GB, free: 8.008 MB / 1.92 GB
Notification: Performance of FrontEnd - DAE generated: time 7.564e-06/5.189, allocations: 3.938 kB / 2.834 GB, free: 8.004 MB / 1.92 GB
Notification: Performance of FrontEnd: time 2.334e-06/5.189, allocations: 4 kB / 2.834 GB, free: 8 MB / 1.92 GB
Notification: Performance of Transformations before backend: time 0.001914/5.191, allocations: 0 / 2.834 GB, free: 8 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: 4773
 * Number of variables: 4773
Notification: Performance of Generate backend data structure: time 0.1507/5.342, allocations: 31.88 MB / 2.865 GB, free: 8.074 MB / 1.951 GB
Notification: Performance of prepare preOptimizeDAE: time 6.816e-05/5.342, allocations: 12.03 kB / 2.865 GB, free: 8.062 MB / 1.951 GB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.0143/5.356, allocations: 2.433 MB / 2.868 GB, free: 5.621 MB / 1.951 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.1054/5.461, allocations: 11.43 MB / 2.879 GB, free: 10.2 MB / 1.967 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.0785/5.54, allocations: 26.45 MB / 2.905 GB, free: 60 kB / 1.982 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.003/5.543, allocations: 1.843 MB / 2.906 GB, free: 14.14 MB / 1.998 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.009452/5.552, allocations: 1.863 MB / 2.908 GB, free: 12.28 MB / 1.998 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.09186/5.644, allocations: 26.87 MB / 2.934 GB, free: 0.832 MB / 2.014 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0007164/5.645, allocations: 27.7 kB / 2.934 GB, free: 0.8047 MB / 2.014 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.008039/5.653, allocations: 0.7759 MB / 2.935 GB, free: 40 kB / 2.014 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.001001/5.654, allocations: 0.7339 MB / 2.936 GB, free: 15.3 MB / 2.029 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.08668/5.741, allocations: 27.24 MB / 2.963 GB, free: 4.023 MB / 2.045 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 1.086/6.827, allocations: 107.8 MB / 3.068 GB, free: 0.9947 GB / 2.123 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.04096/6.868, allocations: 16.52 MB / 3.084 GB, free: 0.9924 GB / 2.123 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.02391/6.892, allocations: 8.633 MB / 3.092 GB, free: 0.9893 GB / 2.123 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.08071/6.973, allocations: 32.49 MB / 3.124 GB, free: 0.9712 GB / 2.123 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.02991/7.002, allocations: 10.19 MB / 3.134 GB, free: 0.9678 GB / 2.123 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.01139/7.014, allocations: 1.073 MB / 3.135 GB, free: 0.9676 GB / 2.123 GB
Notification: Performance of pre-optimization done (n=1169): time 7.552e-05/7.014, allocations: 0 / 3.135 GB, free: 0.9676 GB / 2.123 GB
Notification: Performance of matching and sorting (n=1169): time 0.1031/7.117, allocations: 27.62 MB / 3.162 GB, free: 0.9552 GB / 2.123 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0003656/7.117, allocations: 0.9367 MB / 3.163 GB, free: 0.9543 GB / 2.123 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.04822/7.166, allocations: 17.69 MB / 3.18 GB, free: 0.9455 GB / 2.123 GB
Notification: Performance of collectPreVariables (initialization): time 0.00379/7.169, allocations: 293.6 kB / 3.18 GB, free: 0.9453 GB / 2.123 GB
Notification: Performance of collectInitialEqns (initialization): time 0.01443/7.184, allocations: 10.79 MB / 3.191 GB, free: 0.937 GB / 2.123 GB
Notification: Performance of collectInitialBindings (initialization): time 0.006928/7.191, allocations: 4.128 MB / 3.195 GB, free: 0.9335 GB / 2.123 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.01826/7.209, allocations: 3.142 MB / 3.198 GB, free: 0.9317 GB / 2.123 GB
Notification: Performance of setup shared object (initialization): time 6.525e-05/7.209, allocations: 305.1 kB / 3.198 GB, free: 0.9314 GB / 2.123 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0263/7.235, allocations: 8.841 MB / 3.207 GB, free: 0.927 GB / 2.123 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.03097/7.266, allocations: 12.13 MB / 3.219 GB, free: 0.919 GB / 2.123 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.05025/7.317, allocations: 19.8 MB / 3.238 GB, free: 0.9015 GB / 2.123 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0001428/7.317, allocations: 23.94 kB / 3.238 GB, free: 0.9015 GB / 2.123 GB
Notification: Performance of matching and sorting (n=1921) (initialization): time 0.0756/7.392, allocations: 23.93 MB / 3.262 GB, free: 0.8783 GB / 2.123 GB
Notification: Performance of prepare postOptimizeDAE: time 7.179e-05/7.392, allocations: 32 kB / 3.262 GB, free: 0.8783 GB / 2.123 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 9.774e-05/7.392, allocations: 64 kB / 3.262 GB, free: 0.8782 GB / 2.123 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.005234/7.398, allocations: 1.371 MB / 3.263 GB, free: 0.8769 GB / 2.123 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.02406/7.422, allocations: 4.128 MB / 3.267 GB, free: 0.873 GB / 2.123 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01263/7.434, allocations: 16.04 MB / 3.283 GB, free: 0.8563 GB / 2.123 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.02709/7.461, allocations: 1.507 MB / 3.284 GB, free: 0.8548 GB / 2.123 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.004146/7.466, allocations: 0.644 MB / 3.285 GB, free: 0.8542 GB / 2.123 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.04255/7.508, allocations: 14.53 MB / 3.299 GB, free: 0.84 GB / 2.123 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.02808/7.536, allocations: 12.05 MB / 3.311 GB, free: 0.8271 GB / 2.123 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.04603/7.582, allocations: 19.68 MB / 3.33 GB, free: 0.8069 GB / 2.123 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 0.0001052/7.582, allocations: 20 kB / 3.33 GB, free: 0.8069 GB / 2.123 GB
Notification: Performance of matching and sorting (n=1921) (initialization_lambda0): time 0.06889/7.651, allocations: 23.72 MB / 3.353 GB, free: 0.7835 GB / 2.123 GB
Notification: Performance of prepare postOptimizeDAE: time 5.695e-05/7.651, allocations: 32 kB / 3.353 GB, free: 0.7835 GB / 2.123 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 8.708e-05/7.651, allocations: 64 kB / 3.353 GB, free: 0.7835 GB / 2.123 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.004636/7.656, allocations: 1.305 MB / 3.355 GB, free: 0.7822 GB / 2.123 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0231/7.679, allocations: 4.088 MB / 3.359 GB, free: 0.7782 GB / 2.123 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01405/7.693, allocations: 18.88 MB / 3.377 GB, free: 0.7584 GB / 2.123 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.02766/7.721, allocations: 1.601 MB / 3.379 GB, free: 0.7569 GB / 2.123 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.003973/7.725, allocations: 0.644 MB / 3.379 GB, free: 0.7562 GB / 2.123 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 293
 * Number of states: 0 ()
 * Number of discrete variables: 102 (hvaCon.cooCoi.flowRegime_nominal,hvaCon.cooCoi.dryWetCalcs.fullyDry.cfg,hvaCon.cooCoi.dryWetCalcs.fullyWet.cfg,hvaCon.cooCoi.dryWetCalcs.cfg,hvaCon.cooCoi.flowRegime,hvaCon.cooCoi.UAFroRated.isFulWet,hvaCon.cooCoi.UAFroRated.isFulDry,rooCon.weaDat.decAng.tNext,$PRE.rooCon.weaDat.decAng.tNext,rooCon.weaDat.eqnTim.tNext,$PRE.rooCon.weaDat.eqnTim.tNext,rooCon.weaDat.conTim.tNext,$PRE.rooCon.weaDat.conTim.tNext,rooCon.weaDat.conTimMin.tNext,$PRE.rooCon.weaDat.conTimMin.tNext,rooCon.weaDat.locTim.tNext,$PRE.rooCon.weaDat.locTim.tNext,hvaCon.weaDat.decAng.tNext,$PRE.hvaCon.weaDat.decAng.tNext,hvaCon.weaDat.eqnTim.tNext,$PRE.hvaCon.weaDat.eqnTim.tNext,hvaCon.weaDat.conTim.tNext,$PRE.hvaCon.weaDat.conTim.tNext,hvaCon.weaDat.conTimMin.tNext,$PRE.hvaCon.weaDat.conTimMin.tNext,hvaCon.weaDat.locTim.tNext,$PRE.hvaCon.weaDat.locTim.tNext,hvaCon.con.y,$PRE.hvaCon.con.y,$whenCondition1,$whenCondition2,$whenCondition3,$whenCondition4,$whenCondition5,$whenCondition6,$whenCondition7,$whenCondition8,$whenCondition9,$whenCondition10,baseCase.cooCoi.flowRegime_nominal,baseCase.cooCoi.dryWetCalcs.fullyDry.cfg,baseCase.cooCoi.dryWetCalcs.fullyWet.cfg,baseCase.cooCoi.dryWetCalcs.cfg,baseCase.cooCoi.flowRegime,baseCase.cooCoi.UAFroRated.isFulWet,baseCase.cooCoi.UAFroRated.isFulDry,baseCase.con.y,$PRE.baseCase.con.y,baseCase.weaDat.decAng.tNext,$PRE.baseCase.weaDat.decAng.tNext,baseCase.weaDat.eqnTim.tNext,$PRE.baseCase.weaDat.eqnTim.tNext,baseCase.weaDat.conTim.tNext,$PRE.baseCase.weaDat.conTim.tNext,baseCase.weaDat.conTimMin.tNext,$PRE.baseCase.weaDat.conTimMin.tNext,baseCase.weaDat.locTim.tNext,$PRE.baseCase.weaDat.locTim.tNext,$whenCondition11,$whenCondition12,$whenCondition13,$whenCondition14,$whenCondition15,hvaCon2.cooCoi.flowRegime_nominal,hvaCon2.cooCoi.dryWetCalcs.fullyDry.cfg,hvaCon2.cooCoi.dryWetCalcs.fullyWet.cfg,hvaCon2.cooCoi.dryWetCalcs.cfg,hvaCon2.cooCoi.flowRegime,hvaCon2.cooCoi.UAFroRated.isFulWet,hvaCon2.cooCoi.UAFroRated.isFulDry,rooCon2.weaDat.decAng.tNext,$PRE.rooCon2.weaDat.decAng.tNext,rooCon2.weaDat.eqnTim.tNext,$PRE.rooCon2.weaDat.eqnTim.tNext,rooCon2.weaDat.conTim.tNext,$PRE.rooCon2.weaDat.conTim.tNext,rooCon2.weaDat.conTimMin.tNext,$PRE.rooCon2.weaDat.conTimMin.tNext,rooCon2.weaDat.locTim.tNext,$PRE.rooCon2.weaDat.locTim.tNext,hvaCon2.weaDat.decAng.tNext,$PRE.hvaCon2.weaDat.decAng.tNext,hvaCon2.weaDat.eqnTim.tNext,$PRE.hvaCon2.weaDat.eqnTim.tNext,hvaCon2.weaDat.conTim.tNext,$PRE.hvaCon2.weaDat.conTim.tNext,hvaCon2.weaDat.conTimMin.tNext,$PRE.hvaCon2.weaDat.conTimMin.tNext,hvaCon2.weaDat.locTim.tNext,$PRE.hvaCon2.weaDat.locTim.tNext,hvaCon2.con.y,$PRE.hvaCon2.con.y,$whenCondition16,$whenCondition17,$whenCondition18,$whenCondition19,$whenCondition20,$whenCondition21,$whenCondition22,$whenCondition23,$whenCondition24,$whenCondition25)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (1742):
 * Single equations (assignments): 1712
 * Array equations: 10
 * Algorithm blocks: 0
 * Record equations: 4
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 4
 * Torn equation systems: 12
 * 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): 4 systems
   {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): 2 systems
   {(1,4,100.0%), (1,2,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 10 systems
   {(1,2), (5,2), (1,3), (1,2), (5,2), (1,3), (1,2), (1,2), (5,2), (1,3)}
Notification: Performance of prepare postOptimizeDAE: time 0.00705/7.732, allocations: 1.047 MB / 3.38 GB, free: 0.7552 GB / 2.123 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.009102/7.741, allocations: 1.989 MB / 3.382 GB, free: 0.7532 GB / 2.123 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.06708/7.808, allocations: 20.87 MB / 3.403 GB, free: 0.7328 GB / 2.123 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.000161/7.808, allocations: 124 kB / 3.403 GB, free: 0.7327 GB / 2.123 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 8.067e-05/7.808, allocations: 4 kB / 3.403 GB, free: 0.7326 GB / 2.123 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.05283/7.861, allocations: 16.87 MB / 3.419 GB, free: 0.716 GB / 2.123 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.1185/7.98, allocations: 45.58 MB / 3.464 GB, free: 0.6716 GB / 2.123 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 0.0001016/7.98, allocations: 0 / 3.464 GB, free: 0.6716 GB / 2.123 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.01818/7.998, allocations: 2.914 MB / 3.466 GB, free: 0.6688 GB / 2.123 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.003578/8.001, allocations: 0.9168 MB / 3.467 GB, free: 0.6678 GB / 2.123 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.003663/8.005, allocations: 363.7 kB / 3.468 GB, free: 0.6675 GB / 2.123 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.01267/8.018, allocations: 20.01 MB / 3.487 GB, free: 0.6464 GB / 2.123 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 5.019e-06/8.018, allocations: 11.94 kB / 3.487 GB, free: 0.6464 GB / 2.123 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.08036/8.098, allocations: 30.04 MB / 3.517 GB, free: 0.6169 GB / 2.123 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.01528/8.113, allocations: 4.567 MB / 3.521 GB, free: 0.6124 GB / 2.123 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.008436/8.122, allocations: 259.8 kB / 3.521 GB, free: 0.6121 GB / 2.123 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.02508/8.147, allocations: 1.464 MB / 3.523 GB, free: 0.6107 GB / 2.123 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.003346/8.15, allocations: 0.817 MB / 3.524 GB, free: 0.6099 GB / 2.123 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.003602/8.154, allocations: 0.519 MB / 3.524 GB, free: 0.6094 GB / 2.123 GB
Notification: Performance of sorting global known variables: time 0.02474/8.179, allocations: 11.96 MB / 3.536 GB, free: 0.5978 GB / 2.123 GB
Notification: Performance of sort global known variables: time 3.01e-07/8.179, allocations: 0 / 3.536 GB, free: 0.5978 GB / 2.123 GB
Notification: Performance of remove unused functions: time 0.04869/8.227, allocations: 11.83 MB / 3.547 GB, free: 0.5862 GB / 2.123 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 14
 * Number of states: 41 (hvaCon.fan.filter.s[1],hvaCon.fan.filter.s[2],hvaCon.cooCoi.heaCoo.vol.dynBal.U,hvaCon.cooCoi.heaCooHum_u.vol.dynBal.medium.Xi[1],hvaCon.cooCoi.heaCooHum_u.vol.dynBal.U,hvaCon.cooCoi.heaCooHum_u.vol.dynBal.m,hvaCon.cooCoi.dryWetCalcs.fullyWet.TWatOutEst,hvaCon.senTemHXOut.T,hvaCon.senTemSupAir.T,rooCon.vol.dynBal.medium.Xi[1],rooCon.vol.dynBal.U,rooCon.vol.dynBal.m,baseCase.vol.dynBal.medium.Xi[1],baseCase.vol.dynBal.U,baseCase.vol.dynBal.m,baseCase.fan.filter.s[1],baseCase.fan.filter.s[2],baseCase.cooCoi.heaCoo.vol.dynBal.U,baseCase.cooCoi.heaCooHum_u.vol.dynBal.medium.Xi[1],baseCase.cooCoi.heaCooHum_u.vol.dynBal.U,baseCase.cooCoi.heaCooHum_u.vol.dynBal.m,baseCase.cooCoi.dryWetCalcs.fullyWet.TWatOutEst,baseCase.senTemHXOut.T,baseCase.senTemSupAir.T,hvaCon2.fan.filter.s[1],hvaCon2.fan.filter.s[2],hvaCon2.cooCoi.heaCoo.vol.dynBal.U,hvaCon2.cooCoi.heaCooHum_u.vol.dynBal.medium.Xi[1],hvaCon2.cooCoi.heaCooHum_u.vol.dynBal.U,hvaCon2.cooCoi.heaCooHum_u.vol.dynBal.m,hvaCon2.cooCoi.dryWetCalcs.fullyWet.TWatOutEst,hvaCon2.senTemHXOut.T,hvaCon2.senTemSupAir.T,hvaCon2.fan2.filter.s[1],hvaCon2.fan2.filter.s[2],rooCon2.vol1.dynBal.medium.Xi[1],rooCon2.vol1.dynBal.U,rooCon2.vol1.dynBal.m,rooCon2.vol2.dynBal.medium.Xi[1],rooCon2.vol2.dynBal.U,rooCon2.vol2.dynBal.m)
 * Number of discrete variables: 53 ($whenCondition10,$whenCondition9,$whenCondition8,$whenCondition7,$whenCondition6,$whenCondition5,$whenCondition4,$whenCondition3,$whenCondition2,$whenCondition1,hvaCon.con.y,hvaCon.weaDat.locTim.tNext,hvaCon.weaDat.conTimMin.tNext,hvaCon.weaDat.conTim.tNext,hvaCon.weaDat.eqnTim.tNext,hvaCon.weaDat.decAng.tNext,rooCon.weaDat.locTim.tNext,rooCon.weaDat.conTimMin.tNext,rooCon.weaDat.conTim.tNext,rooCon.weaDat.eqnTim.tNext,rooCon.weaDat.decAng.tNext,$whenCondition15,$whenCondition14,$whenCondition13,$whenCondition12,$whenCondition11,baseCase.weaDat.locTim.tNext,baseCase.weaDat.conTimMin.tNext,baseCase.weaDat.conTim.tNext,baseCase.weaDat.eqnTim.tNext,baseCase.weaDat.decAng.tNext,baseCase.con.y,$whenCondition25,$whenCondition24,$whenCondition23,$whenCondition22,$whenCondition21,$whenCondition20,$whenCondition19,$whenCondition18,$whenCondition17,$whenCondition16,hvaCon2.con.y,hvaCon2.weaDat.locTim.tNext,hvaCon2.weaDat.conTimMin.tNext,hvaCon2.weaDat.conTim.tNext,hvaCon2.weaDat.eqnTim.tNext,hvaCon2.weaDat.decAng.tNext,rooCon2.weaDat.locTim.tNext,rooCon2.weaDat.conTimMin.tNext,rooCon2.weaDat.conTim.tNext,rooCon2.weaDat.eqnTim.tNext,rooCon2.weaDat.decAng.tNext)
 * Number of discrete states: 28 (hvaCon2.weaDat.locTim.tNext,hvaCon2.weaDat.conTim.tNext,hvaCon2.weaDat.eqnTim.tNext,hvaCon2.weaDat.decAng.tNext,hvaCon2.weaDat.conTimMin.tNext,rooCon2.weaDat.locTim.tNext,rooCon2.weaDat.conTim.tNext,rooCon2.weaDat.eqnTim.tNext,rooCon2.weaDat.decAng.tNext,rooCon2.weaDat.conTimMin.tNext,hvaCon2.con.y,baseCase.weaDat.locTim.tNext,baseCase.weaDat.conTim.tNext,baseCase.weaDat.eqnTim.tNext,baseCase.weaDat.decAng.tNext,baseCase.weaDat.conTimMin.tNext,baseCase.con.y,hvaCon.weaDat.locTim.tNext,hvaCon.weaDat.conTim.tNext,hvaCon.weaDat.eqnTim.tNext,hvaCon.weaDat.decAng.tNext,hvaCon.weaDat.conTimMin.tNext,rooCon.weaDat.locTim.tNext,rooCon.weaDat.conTim.tNext,rooCon.weaDat.eqnTim.tNext,rooCon.weaDat.decAng.tNext,rooCon.weaDat.conTimMin.tNext,hvaCon.con.y)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (1231):
 * Single equations (assignments): 1183
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 6
 * When equations: 25
 * If-equations: 0
 * Equation systems (not torn): 1
 * Torn equation systems: 16
 * 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): 6 systems
   {(1,2,100.0%), (1,2,100.0%), (1,4,100.0%), (1,2,100.0%), (1,2,100.0%), (1,2,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 10 systems
   {(1,2), (1,1), (1,3), (1,2), (1,1), (1,3), (1,3), (1,2), (1,1), (1,3)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.09217/8.32, allocations: 32.86 MB / 3.579 GB, free: 0.5543 GB / 2.123 GB
Notification: Performance of simCode: created initialization part: time 0.09109/8.411, allocations: 31.49 MB / 3.61 GB, free: 0.5235 GB / 2.123 GB
Notification: Performance of simCode: created event and clocks part: time 2.209e-05/8.411, allocations: 13.77 kB / 3.61 GB, free: 0.5234 GB / 2.123 GB
Notification: Performance of simCode: created simulation system equations: time 0.02697/8.438, allocations: 10.08 MB / 3.62 GB, free: 0.5135 GB / 2.123 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.05331/8.491, allocations: 9.138 MB / 3.629 GB, free: 0.5048 GB / 2.123 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.4286/8.919, allocations: 166.3 MB / 3.791 GB, free: 347.3 MB / 2.123 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.02264/8.942, allocations: 11.63 MB / 3.803 GB, free: 335.6 MB / 2.123 GB
Notification: Performance of simCode: alias equations: time 0.03702/8.979, allocations: 6.596 MB / 3.809 GB, free: 329 MB / 2.123 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.02317/9.002, allocations: 11.46 MB / 3.82 GB, free: 317.6 MB / 2.123 GB
Notification: Performance of SimCode: time 1.172e-06/9.002, allocations: 0 / 3.82 GB, free: 317.6 MB / 2.123 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 2.289/11.29, allocations: 0.5231 GB / 4.343 GB, free: 0.8782 GB / 2.123 GB
Notification: Performance of buildModelFMU: Generate platform static: time 82.85/94.14, allocations: 6.469 kB / 4.343 GB, free: 0.8782 GB / 2.123 GB
"
[Timeout remaining time 205]
(rm -f Buildings_11_Buildings.Fluid.FMI.ExportContainers.Validation.RoomHVAC.pipe ; mkfifo Buildings_11_Buildings.Fluid.FMI.ExportContainers.Validation.RoomHVAC.pipe ; head -c 1048576 < Buildings_11_Buildings.Fluid.FMI.ExportContainers.Validation.RoomHVAC.pipe >> ../files/Buildings_11_Buildings.Fluid.FMI.ExportContainers.Validation.RoomHVAC.sim & python3 -m fmpy simulate  --output-file Buildings_11_Buildings.Fluid.FMI.ExportContainers.Validation.RoomHVAC_res.csv --start-time 1.5552e+07 --stop-time 1.56384e+07 --timeout 400 --relative-tolerance 1e-07 --interface-type ModelExchange --solver CVode --output-interval 34.56 Buildings_11_Buildings_Fluid_FMI_ExportContainers_Validation_RoomHVAC.fmu > Buildings_11_Buildings.Fluid.FMI.ExportContainers.Validation.RoomHVAC.pipe 2>&1) [Timeout 420.0]
[Calling os._exit(0), Time elapsed: 101.1911266730167]
Failed to read output from testmodel.py, exit status != 0:
94.7005694010295 94.710358442 89.518724771
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f264219ace0>