Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr BuildingSystems_BuildingSystems.Airflow.Multizone.Examples.ReverseBuoyancy3Zones.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/NcDataReader2 2.5.1-master/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildingSystems 2.0.0-master/package.mo", uses=false)
Using package BuildingSystems with version 2.0.0-beta (/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildingSystems 2.0.0-master/package.mo)
Using package NcDataReader2 with version 2.5.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/NcDataReader2 2.5.1-master/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: "" <> buildModelFMU(BuildingSystems.Airflow.Multizone.Examples.ReverseBuoyancy3Zones,fileNamePrefix="BuildingSystems_BuildingSystems_Airflow_Multizone_Examples_ReverseBuoyancy3Zones",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(BuildingSystems.Airflow.Multizone.Examples.ReverseBuoyancy3Zones,fileNamePrefix="BuildingSystems_BuildingSystems_Airflow_Multizone_Examples_ReverseBuoyancy3Zones",fmuType="me",version="2.0",platforms={"static"})
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001599/0.001598, allocations: 108 kB / 15.6 MB, free: 132 kB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001584/0.001584, allocations: 193.7 kB / 16.53 MB, free: 6.391 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.438/1.438, allocations: 222.9 MB / 240.2 MB, free: 4.238 MB / 190.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/NcDataReader2 2.5.1-master/package.mo): time 0.002636/0.002636, allocations: 293.9 kB / 290.7 MB, free: 1.836 MB / 238.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildingSystems 2.0.0-master/package.mo): time 1.104/1.104, allocations: 178.6 MB / 0.5073 GB, free: 4.539 MB / 382.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.002869/0.002869, allocations: 102.8 kB / 0.6065 GB, free: 24.73 MB / 430.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.142/0.1449, allocations: 89.14 MB / 0.6936 GB, free: 4.203 MB / 494.1 MB
Notification: Performance of NFInst.instantiate(BuildingSystems.Airflow.Multizone.Examples.ReverseBuoyancy3Zones): time 0.5607/0.7057, allocations: 295.1 MB / 0.9818 GB, free: 4.02 MB / 0.7012 GB
Notification: Performance of NFInst.instExpressions: time 0.02553/0.7313, allocations: 17.02 MB / 0.9984 GB, free: 2.961 MB / 0.7169 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.002122/0.7334, allocations: 83.56 kB / 0.9985 GB, free: 2.879 MB / 0.7169 GB
Notification: Performance of NFTyping.typeComponents: time 0.004193/0.7376, allocations: 1.9 MB / 1 GB, free: 0.9688 MB / 0.7169 GB
Notification: Performance of NFTyping.typeBindings: time 0.01407/0.7517, allocations: 6.428 MB / 1.007 GB, free: 10.52 MB / 0.7325 GB
Notification: Performance of NFTyping.typeClassSections: time 0.006751/0.7585, allocations: 2.933 MB / 1.009 GB, free: 7.586 MB / 0.7325 GB
Notification: Performance of NFFlatten.flatten: time 0.009166/0.7677, allocations: 7.696 MB / 1.017 GB, free: 15.87 MB / 0.7481 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.003306/0.771, allocations: 2.592 MB / 1.02 GB, free: 13.23 MB / 0.7481 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.004072/0.7751, allocations: 2.76 MB / 1.022 GB, free: 10.46 MB / 0.7481 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.004292/0.7794, allocations: 2.705 MB / 1.025 GB, free: 7.762 MB / 0.7481 GB
Notification: Performance of NFPackage.collectConstants: time 0.0005319/0.7799, allocations: 328 kB / 1.025 GB, free: 7.441 MB / 0.7481 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.01196/0.7919, allocations: 6.169 MB / 1.031 GB, free: 1.258 MB / 0.7481 GB
Notification: Performance of NFScalarize.scalarize: time 0.001536/0.7934, allocations: 1.332 MB / 1.032 GB, free: 15.92 MB / 0.7637 GB
Notification: Performance of NFVerifyModel.verify: time 0.002427/0.7959, allocations: 1.89 MB / 1.034 GB, free: 14.02 MB / 0.7637 GB
Notification: Performance of NFConvertDAE.convert: time 0.0119/0.8078, allocations: 6.829 MB / 1.041 GB, free: 7.176 MB / 0.7637 GB
Notification: Performance of FrontEnd - DAE generated: time 7.404e-06/0.8078, allocations: 0 / 1.041 GB, free: 7.176 MB / 0.7637 GB
Notification: Performance of FrontEnd: time 1.342e-06/0.8078, allocations: 3.938 kB / 1.041 GB, free: 7.172 MB / 0.7637 GB
Notification: Performance of Transformations before backend: time 3.627e-05/0.8079, allocations: 4 kB / 1.041 GB, free: 7.168 MB / 0.7637 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 669
 * Number of variables: 669
Notification: Performance of Generate backend data structure: time 0.01002/0.8179, allocations: 4.124 MB / 1.045 GB, free: 2.977 MB / 0.7637 GB
Notification: Performance of prepare preOptimizeDAE: time 3.645e-05/0.818, allocations: 8.031 kB / 1.045 GB, free: 2.969 MB / 0.7637 GB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.0005099/0.8185, allocations: 382.9 kB / 1.045 GB, free: 2.586 MB / 0.7637 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.006257/0.8247, allocations: 0.9133 MB / 1.046 GB, free: 1.668 MB / 0.7637 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.2279/1.053, allocations: 1.834 MB / 1.048 GB, free: 282.6 MB / 0.7637 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001835/1.053, allocations: 196.9 kB / 1.048 GB, free: 282.6 MB / 0.7637 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0006487/1.054, allocations: 261.8 kB / 1.049 GB, free: 282.6 MB / 0.7637 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.005464/1.059, allocations: 3.328 MB / 1.052 GB, free: 281.6 MB / 0.7637 GB
Notification: Performance of preOpt findStateOrder (simulation): time 5.809e-05/1.059, allocations: 6.016 kB / 1.052 GB, free: 281.6 MB / 0.7637 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0002449/1.059, allocations: 111.2 kB / 1.052 GB, free: 281.5 MB / 0.7637 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001533/1.059, allocations: 138.5 kB / 1.052 GB, free: 281.5 MB / 0.7637 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.005648/1.065, allocations: 3.499 MB / 1.055 GB, free: 280.4 MB / 0.7637 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.01309/1.078, allocations: 12.23 MB / 1.067 GB, free: 272.4 MB / 0.7637 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.004183/1.082, allocations: 3.504 MB / 1.071 GB, free: 270.6 MB / 0.7637 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.002569/1.085, allocations: 1.816 MB / 1.073 GB, free: 269.9 MB / 0.7637 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.001168/1.086, allocations: 1.493 MB / 1.074 GB, free: 268.3 MB / 0.7637 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.33e-05/1.086, allocations: 71.91 kB / 1.074 GB, free: 268.3 MB / 0.7637 GB
Notification: Performance of pre-optimization done (n=278): time 4.268e-06/1.086, allocations: 0 / 1.074 GB, free: 268.3 MB / 0.7637 GB
Notification: Performance of matching and sorting (n=278): time 0.006081/1.092, allocations: 3.878 MB / 1.078 GB, free: 266.8 MB / 0.7637 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 3.863e-05/1.092, allocations: 83.91 kB / 1.078 GB, free: 266.7 MB / 0.7637 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001556/1.094, allocations: 1.374 MB / 1.079 GB, free: 266.2 MB / 0.7637 GB
Notification: Performance of collectPreVariables (initialization): time 0.0001436/1.094, allocations: 77.89 kB / 1.079 GB, free: 266.1 MB / 0.7637 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0004485/1.095, allocations: 0.9862 MB / 1.08 GB, free: 265.4 MB / 0.7637 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0005122/1.095, allocations: 0.9426 MB / 1.081 GB, free: 264.6 MB / 0.7637 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0005689/1.096, allocations: 405 kB / 1.082 GB, free: 264.4 MB / 0.7637 GB
Notification: Performance of setup shared object (initialization): time 3.166e-05/1.096, allocations: 305.1 kB / 1.082 GB, free: 264.1 MB / 0.7637 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001602/1.097, allocations: 1.094 MB / 1.083 GB, free: 263.7 MB / 0.7637 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001774/1.099, allocations: 1.369 MB / 1.084 GB, free: 263.1 MB / 0.7637 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.003629/1.103, allocations: 2.644 MB / 1.087 GB, free: 261.8 MB / 0.7637 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 6.612e-06/1.103, allocations: 4.938 kB / 1.087 GB, free: 261.8 MB / 0.7637 GB
Notification: Performance of matching and sorting (n=311) (initialization): time 0.004304/1.107, allocations: 2.974 MB / 1.09 GB, free: 260.3 MB / 0.7637 GB
Notification: Performance of prepare postOptimizeDAE: time 2.084e-05/1.107, allocations: 6.156 kB / 1.09 GB, free: 260.3 MB / 0.7637 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.242e-05/1.107, allocations: 12.2 kB / 1.09 GB, free: 260.3 MB / 0.7637 GB
Notification: Performance of postOpt tearingSystem (initialization): time 2.718e-05/1.107, allocations: 15.38 kB / 1.09 GB, free: 260.3 MB / 0.7637 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002146/1.109, allocations: 0.5064 MB / 1.09 GB, free: 260.2 MB / 0.7637 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.248e-05/1.109, allocations: 22.06 kB / 1.09 GB, free: 260.2 MB / 0.7637 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.00192/1.111, allocations: 185.8 kB / 1.091 GB, free: 260 MB / 0.7637 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001534/1.111, allocations: 86.08 kB / 1.091 GB, free: 260 MB / 0.7637 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 19
 * Number of states: 0 ()
 * Number of discrete variables: 0 ()
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (311):
 * Single equations (assignments): 311
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of prepare postOptimizeDAE: time 0.0009049/1.112, allocations: 0.6474 MB / 1.091 GB, free: 259.6 MB / 0.7637 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0003634/1.113, allocations: 229.8 kB / 1.092 GB, free: 259.4 MB / 0.7637 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.004187/1.117, allocations: 3.112 MB / 1.095 GB, free: 257.7 MB / 0.7637 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.414e-05/1.117, allocations: 27.69 kB / 1.095 GB, free: 257.7 MB / 0.7637 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 7.694e-06/1.117, allocations: 0 / 1.095 GB, free: 257.7 MB / 0.7637 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.003189/1.12, allocations: 2.658 MB / 1.097 GB, free: 256.3 MB / 0.7637 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.007331/1.127, allocations: 6.222 MB / 1.103 GB, free: 252.6 MB / 0.7637 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 6.412e-06/1.127, allocations: 3 kB / 1.103 GB, free: 252.6 MB / 0.7637 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.002419/1.13, allocations: 0.5373 MB / 1.104 GB, free: 252.4 MB / 0.7637 GB
Notification: Performance of postOpt tearingSystem (simulation): time 1.171e-05/1.13, allocations: 9.25 kB / 1.104 GB, free: 252.4 MB / 0.7637 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0001419/1.13, allocations: 63.2 kB / 1.104 GB, free: 252.4 MB / 0.7637 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 9.518e-06/1.13, allocations: 15.94 kB / 1.104 GB, free: 252.4 MB / 0.7637 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.203e-06/1.13, allocations: 0 / 1.104 GB, free: 252.4 MB / 0.7637 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.005328/1.135, allocations: 4.561 MB / 1.108 GB, free: 248.3 MB / 0.7637 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0008071/1.136, allocations: 0.611 MB / 1.109 GB, free: 247.7 MB / 0.7637 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0003115/1.137, allocations: 53.69 kB / 1.109 GB, free: 247.6 MB / 0.7637 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001601/1.138, allocations: 74.59 kB / 1.109 GB, free: 247.5 MB / 0.7637 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0002831/1.138, allocations: 166 kB / 1.109 GB, free: 247.4 MB / 0.7637 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0001424/1.139, allocations: 79.97 kB / 1.109 GB, free: 247.3 MB / 0.7637 GB
Notification: Performance of sorting global known variables: time 0.0009819/1.14, allocations: 0.9462 MB / 1.11 GB, free: 246.4 MB / 0.7637 GB
Notification: Performance of sort global known variables: time 2.3e-07/1.14, allocations: 0 / 1.11 GB, free: 246.4 MB / 0.7637 GB
Notification: Performance of remove unused functions: time 0.001683/1.141, allocations: 0.9746 MB / 1.111 GB, free: 245.4 MB / 0.7637 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 1
 * Number of states: 18 (volEas.dynBal.medium.Xi[1],volEas.dynBal.U,volEas.dynBal.m,oriOutBot.mExc,oriOutTop.mExc,volOut.dynBal.medium.Xi[1],volOut.dynBal.U,volOut.dynBal.m,oriWesTop.mExc,dooOpeClo.mExcAB,dooOpeClo.mExcBA,oriEasTop.mExc,volTop.dynBal.medium.Xi[1],volTop.dynBal.U,volTop.dynBal.m,volWes.dynBal.medium.Xi[1],volWes.dynBal.U,volWes.dynBal.m)
 * Number of discrete variables: 0 ()
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (278):
 * Single equations (assignments): 278
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of Backend phase and start with SimCode phase: time 0.005798/1.147, allocations: 5.389 MB / 1.116 GB, free: 240 MB / 0.7637 GB
Notification: Performance of simCode: created initialization part: time 0.01008/1.157, allocations: 5.538 MB / 1.122 GB, free: 234.4 MB / 0.7637 GB
Notification: Performance of simCode: created event and clocks part: time 2.775e-06/1.157, allocations: 0 / 1.122 GB, free: 234.4 MB / 0.7637 GB
Notification: Performance of simCode: created simulation system equations: time 0.001634/1.159, allocations: 1.504 MB / 1.123 GB, free: 232.9 MB / 0.7637 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.005195/1.164, allocations: 1.364 MB / 1.125 GB, free: 231.7 MB / 0.7637 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.0226/1.187, allocations: 21.3 MB / 1.145 GB, free: 209.3 MB / 0.7637 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001066/1.188, allocations: 1.906 MB / 1.147 GB, free: 207.3 MB / 0.7637 GB
Notification: Performance of simCode: alias equations: time 0.002613/1.19, allocations: 0.8474 MB / 1.148 GB, free: 206.5 MB / 0.7637 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.001234/1.192, allocations: 1.085 MB / 1.149 GB, free: 205.4 MB / 0.7637 GB
Notification: Performance of SimCode: time 4.41e-07/1.192, allocations: 0 / 1.149 GB, free: 205.4 MB / 0.7637 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.08681/1.278, allocations: 67.73 MB / 1.215 GB, free: 138.5 MB / 0.7637 GB
Notification: Performance of buildModelFMU: Generate platform static: time 9.692/10.97, allocations: 0 / 1.215 GB, free: 138.5 MB / 0.7637 GB
(rm -f BuildingSystems_BuildingSystems.Airflow.Multizone.Examples.ReverseBuoyancy3Zones.pipe ; mkfifo BuildingSystems_BuildingSystems.Airflow.Multizone.Examples.ReverseBuoyancy3Zones.pipe ; head -c 1048576 < BuildingSystems_BuildingSystems.Airflow.Multizone.Examples.ReverseBuoyancy3Zones.pipe >> ../files/BuildingSystems_BuildingSystems.Airflow.Multizone.Examples.ReverseBuoyancy3Zones.sim & python3 -m fmpy simulate  --output-file BuildingSystems_BuildingSystems.Airflow.Multizone.Examples.ReverseBuoyancy3Zones_res.csv --start-time 0 --stop-time 3600 --timeout 50 --relative-tolerance 1e-06 --interface-type ModelExchange --solver CVode --output-interval 1.44 BuildingSystems_BuildingSystems_Airflow_Multizone_Examples_ReverseBuoyancy3Zones.fmu > BuildingSystems_BuildingSystems.Airflow.Multizone.Examples.ReverseBuoyancy3Zones.pipe 2>&1)