Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_latest_Buildings.Airflow.Multizone.Examples.ReverseBuoyancy.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/Buildings 12.0.0-master/package.mo", uses=false)
Using package Buildings with version 12.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.0.0-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: translateModel(Buildings.Airflow.Multizone.Examples.ReverseBuoyancy,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|oriWesTop.port_a.m_flow|oriEasTop.port_a.m_flow|oriOutTop.port_a.m_flow|oriOutBot.port_a.m_flow|dooOpeClo.port_a1.m_flow|dooOpeClo.port_a2.m_flow|volBotWes.T|volBotEas.T|volTopWes.T|volTopEas.T|volOut.T|oriWesTop.dp|oriEasTop.dp|oriOutTop.dp|oriOutBot.dp|dooOpeClo.dpAB.1.",fileNamePrefix="Buildings_latest_Buildings.Airflow.Multizone.Examples.ReverseBuoyancy")
translateModel(Buildings.Airflow.Multizone.Examples.ReverseBuoyancy,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|oriWesTop.port_a.m_flow|oriEasTop.port_a.m_flow|oriOutTop.port_a.m_flow|oriOutBot.port_a.m_flow|dooOpeClo.port_a1.m_flow|dooOpeClo.port_a2.m_flow|volBotWes.T|volBotEas.T|volTopWes.T|volTopEas.T|volOut.T|oriWesTop.dp|oriEasTop.dp|oriOutTop.dp|oriOutBot.dp|dooOpeClo.dpAB.1.",fileNamePrefix="Buildings_latest_Buildings.Airflow.Multizone.Examples.ReverseBuoyancy")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001677/0.001677, allocations: 106.1 kB / 15.99 MB, free: 6.348 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.00177/0.00177, allocations: 188.8 kB / 16.91 MB, free: 6.188 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.585/1.585, allocations: 222.9 MB / 240.6 MB, free: 15.41 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.0.0-master/package.mo): time 2.912/2.912, allocations: 482.2 MB / 0.7548 GB, free: 7.297 MB / 0.6231 GB
Notification: Performance of FrontEnd - loaded program: time 0.00217/0.00217, allocations: 67.42 kB / 0.9238 GB, free: 0.5234 MB / 0.6856 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.8963/0.8985, allocations: 162.2 MB / 1.082 GB, free: 1.73 MB / 0.8262 GB
Notification: Performance of NFInst.instantiate(Buildings.Airflow.Multizone.Examples.ReverseBuoyancy): time 0.4292/1.328, allocations: 310.7 MB / 1.386 GB, free: 7.656 MB / 1.107 GB
Notification: Performance of NFInst.instExpressions: time 0.03396/1.362, allocations: 18.4 MB / 1.404 GB, free: 5.223 MB / 1.123 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.00552/1.367, allocations: 79.5 kB / 1.404 GB, free: 5.145 MB / 1.123 GB
Notification: Performance of NFTyping.typeComponents: time 0.007079/1.374, allocations: 1.933 MB / 1.405 GB, free: 3.203 MB / 1.123 GB
Notification: Performance of NFTyping.typeBindings: time 0.02329/1.398, allocations: 6.876 MB / 1.412 GB, free: 12.3 MB / 1.139 GB
Notification: Performance of NFTyping.typeClassSections: time 0.009577/1.407, allocations: 2.974 MB / 1.415 GB, free: 9.332 MB / 1.139 GB
Notification: Performance of NFFlatten.flatten: time 0.01521/1.423, allocations: 9.092 MB / 1.424 GB, free: 216 kB / 1.139 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.005449/1.428, allocations: 3.045 MB / 1.427 GB, free: 13.11 MB / 1.154 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.008917/1.437, allocations: 3.675 MB / 1.431 GB, free: 9.418 MB / 1.154 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.007605/1.445, allocations: 3.4 MB / 1.434 GB, free: 6.016 MB / 1.154 GB
Notification: Performance of NFPackage.collectConstants: time 0.001255/1.446, allocations: 404 kB / 1.434 GB, free: 5.621 MB / 1.154 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.01696/1.463, allocations: 7.282 MB / 1.441 GB, free: 14.32 MB / 1.17 GB
Notification: Performance of NFScalarize.scalarize: time 0.00353/1.467, allocations: 1.675 MB / 1.443 GB, free: 12.64 MB / 1.17 GB
Notification: Performance of NFVerifyModel.verify: time 0.006686/1.473, allocations: 2.314 MB / 1.445 GB, free: 10.32 MB / 1.17 GB
Notification: Performance of NFConvertDAE.convert: time 0.0126/1.486, allocations: 6.058 MB / 1.451 GB, free: 4.242 MB / 1.17 GB
Notification: Performance of FrontEnd - DAE generated: time 7.454e-06/1.486, allocations: 4 kB / 1.451 GB, free: 4.238 MB / 1.17 GB
Notification: Performance of FrontEnd: time 2.224e-06/1.486, allocations: 0 / 1.451 GB, free: 4.238 MB / 1.17 GB
Notification: Performance of Transformations before backend: time 0.0002605/1.486, allocations: 0 / 1.451 GB, free: 4.238 MB / 1.17 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 843
 * Number of variables: 843
Notification: Performance of Generate backend data structure: time 0.01723/1.503, allocations: 4.989 MB / 1.456 GB, free: 15.18 MB / 1.186 GB
Notification: Performance of prepare preOptimizeDAE: time 4.959e-05/1.504, allocations: 12.02 kB / 1.456 GB, free: 15.17 MB / 1.186 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.007675/1.511, allocations: 1.014 MB / 1.457 GB, free: 14.15 MB / 1.186 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.005836/1.517, allocations: 2.162 MB / 1.459 GB, free: 11.93 MB / 1.186 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0002832/1.517, allocations: 246.4 kB / 1.459 GB, free: 11.69 MB / 1.186 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.001225/1.519, allocations: 324 kB / 1.46 GB, free: 11.38 MB / 1.186 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.01249/1.531, allocations: 4.239 MB / 1.464 GB, free: 7.051 MB / 1.186 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.000138/1.531, allocations: 11.98 kB / 1.464 GB, free: 7.039 MB / 1.186 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0007803/1.532, allocations: 132 kB / 1.464 GB, free: 6.91 MB / 1.186 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0002133/1.532, allocations: 170.3 kB / 1.464 GB, free: 6.742 MB / 1.186 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.008908/1.541, allocations: 4.783 MB / 1.469 GB, free: 1.949 MB / 1.186 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.02449/1.566, allocations: 14.68 MB / 1.483 GB, free: 2.219 MB / 1.201 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.00746/1.573, allocations: 4.555 MB / 1.488 GB, free: 13.66 MB / 1.217 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.004115/1.577, allocations: 2.452 MB / 1.49 GB, free: 11.21 MB / 1.217 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.002043/1.579, allocations: 1.604 MB / 1.492 GB, free: 9.27 MB / 1.217 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 9.133e-05/1.58, allocations: 77.64 kB / 1.492 GB, free: 9.184 MB / 1.217 GB
Notification: Performance of pre-optimization done (n=392): time 5.3e-06/1.58, allocations: 4 kB / 1.492 GB, free: 9.18 MB / 1.217 GB
Notification: Performance of matching and sorting (n=392): time 0.01066/1.59, allocations: 5.531 MB / 1.497 GB, free: 3.625 MB / 1.217 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 8.641e-05/1.59, allocations: 94.48 kB / 1.497 GB, free: 3.52 MB / 1.217 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.003449/1.594, allocations: 1.688 MB / 1.499 GB, free: 1.789 MB / 1.217 GB
Notification: Performance of collectPreVariables (initialization): time 0.0003321/1.594, allocations: 93.7 kB / 1.499 GB, free: 1.691 MB / 1.217 GB
Notification: Performance of collectInitialEqns (initialization): time 0.001177/1.595, allocations: 1.139 MB / 1.5 GB, free: 0.5391 MB / 1.217 GB
Notification: Performance of collectInitialBindings (initialization): time 0.00157/1.597, allocations: 1.313 MB / 1.501 GB, free: 15.2 MB / 1.232 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.00114/1.598, allocations: 0.5508 MB / 1.502 GB, free: 14.64 MB / 1.232 GB
Notification: Performance of setup shared object (initialization): time 0.0001593/1.598, allocations: 305.1 kB / 1.502 GB, free: 14.34 MB / 1.232 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.002993/1.601, allocations: 1.564 MB / 1.504 GB, free: 12.78 MB / 1.232 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.003205/1.605, allocations: 1.918 MB / 1.505 GB, free: 10.79 MB / 1.232 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.006417/1.611, allocations: 3.773 MB / 1.509 GB, free: 6.934 MB / 1.232 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.486e-05/1.611, allocations: 0 / 1.509 GB, free: 6.934 MB / 1.232 GB
Notification: Performance of matching and sorting (n=430) (initialization): time 0.007944/1.619, allocations: 4.173 MB / 1.513 GB, free: 2.734 MB / 1.232 GB
Notification: Performance of prepare postOptimizeDAE: time 3.414e-05/1.619, allocations: 8 kB / 1.513 GB, free: 2.727 MB / 1.232 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.312e-05/1.619, allocations: 7.938 kB / 1.513 GB, free: 2.719 MB / 1.232 GB
Notification: Performance of postOpt tearingSystem (initialization): time 4.736e-05/1.619, allocations: 20 kB / 1.513 GB, free: 2.699 MB / 1.232 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.003074/1.622, allocations: 0.6949 MB / 1.514 GB, free: 2.004 MB / 1.232 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 8.412e-05/1.622, allocations: 23.94 kB / 1.514 GB, free: 1.98 MB / 1.232 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.003877/1.626, allocations: 484.7 kB / 1.514 GB, free: 1.504 MB / 1.232 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.000339/1.626, allocations: 116 kB / 1.515 GB, free: 1.391 MB / 1.232 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 22
 * 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 (430):
 * Single equations (assignments): 430
 * 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.002013/1.628, allocations: 0.7937 MB / 1.515 GB, free: 0.5859 MB / 1.232 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.001127/1.63, allocations: 296.5 kB / 1.516 GB, free: 300 kB / 1.232 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.008702/1.638, allocations: 4.429 MB / 1.52 GB, free: 11.83 MB / 1.248 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 3.488e-05/1.638, allocations: 36 kB / 1.52 GB, free: 11.79 MB / 1.248 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.717e-05/1.638, allocations: 4 kB / 1.52 GB, free: 11.79 MB / 1.248 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.006421/1.645, allocations: 3.796 MB / 1.524 GB, free: 7.926 MB / 1.248 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.7866/2.431, allocations: 8.641 MB / 1.532 GB, free: 409.5 MB / 1.248 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.001e-05/2.431, allocations: 3.406 kB / 1.532 GB, free: 409.5 MB / 1.248 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.004125/2.436, allocations: 0.72 MB / 1.533 GB, free: 409.5 MB / 1.248 GB
Notification: Performance of postOpt tearingSystem (simulation): time 5.165e-05/2.436, allocations: 23.3 kB / 1.533 GB, free: 409.5 MB / 1.248 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.000359/2.436, allocations: 87.17 kB / 1.533 GB, free: 409.5 MB / 1.248 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 2.533e-05/2.436, allocations: 15.62 kB / 1.533 GB, free: 409.5 MB / 1.248 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 4.608e-06/2.436, allocations: 3.375 kB / 1.533 GB, free: 409.5 MB / 1.248 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.01127/2.447, allocations: 6.566 MB / 1.539 GB, free: 407.3 MB / 1.248 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.00234/2.45, allocations: 0.7928 MB / 1.54 GB, free: 407 MB / 1.248 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0005353/2.45, allocations: 74.31 kB / 1.54 GB, free: 406.9 MB / 1.248 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.002671/2.453, allocations: 268 kB / 1.54 GB, free: 406.9 MB / 1.248 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0005888/2.454, allocations: 244.1 kB / 1.541 GB, free: 406.8 MB / 1.248 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0002465/2.454, allocations: 110.9 kB / 1.541 GB, free: 406.8 MB / 1.248 GB
Notification: Performance of sorting global known variables: time 0.001882/2.456, allocations: 1.156 MB / 1.542 GB, free: 406.4 MB / 1.248 GB
Notification: Performance of sort global known variables: time 1e-07/2.456, allocations: 1.094 kB / 1.542 GB, free: 406.4 MB / 1.248 GB
Notification: Performance of remove unused functions: time 0.00358/2.459, allocations: 1.226 MB / 1.543 GB, free: 406.2 MB / 1.248 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 11
 * Number of states: 20 (volBotEas.dynBal.medium.Xi[1],volBotEas.dynBal.U,volBotEas.dynBal.m,oriOutBot.mExc,oriOutTop.mExc,oriWesTop.mExc,dooOpeClo.mExcAB,dooOpeClo.mExcBA,volBotWes.dynBal.medium.Xi[1],volBotWes.dynBal.U,volBotWes.dynBal.m,oriEasTop.mExc,volTopEas.dynBal.medium.Xi[1],volTopEas.dynBal.U,volTopEas.dynBal.m,volTopWes.dynBal.medium.Xi[1],volTopWes.dynBal.U,volTopWes.dynBal.m,dooOpeCloTop.mExcAB,dooOpeCloTop.mExcBA)
 * 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 (392):
 * Single equations (assignments): 392
 * 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.001034/2.46, allocations: 469.3 kB / 1.544 GB, free: 406 MB / 1.248 GB
Notification: Performance of simCode: created initialization part: time 0.02342/2.484, allocations: 9.835 MB / 1.553 GB, free: 404.6 MB / 1.248 GB
Notification: Performance of simCode: created event and clocks part: time 8.646e-06/2.484, allocations: 1.188 kB / 1.553 GB, free: 404.6 MB / 1.248 GB
Notification: Performance of simCode: created simulation system equations: time 0.003535/2.487, allocations: 2.158 MB / 1.555 GB, free: 403.8 MB / 1.248 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.007472/2.495, allocations: 1.603 MB / 1.557 GB, free: 403.4 MB / 1.248 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.01408/2.509, allocations: 9.335 MB / 1.566 GB, free: 398.4 MB / 1.248 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.002485/2.512, allocations: 2.21 MB / 1.568 GB, free: 397.5 MB / 1.248 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.001991/2.514, allocations: 306.3 kB / 1.568 GB, free: 397.5 MB / 1.248 GB
Notification: Performance of SimCode: time 2.174e-06/2.514, allocations: 0 / 1.568 GB, free: 397.5 MB / 1.248 GB
Notification: Performance of Templates: time 0.09568/2.609, allocations: 54.41 MB / 1.622 GB, free: 360.9 MB / 1.248 GB
make -j1 -f Buildings_latest_Buildings.Airflow.Multizone.Examples.ReverseBuoyancy.makefile
(rm -f Buildings_latest_Buildings.Airflow.Multizone.Examples.ReverseBuoyancy.pipe ; mkfifo Buildings_latest_Buildings.Airflow.Multizone.Examples.ReverseBuoyancy.pipe ; head -c 1048576 < Buildings_latest_Buildings.Airflow.Multizone.Examples.ReverseBuoyancy.pipe >> ../files/Buildings_latest_Buildings.Airflow.Multizone.Examples.ReverseBuoyancy.sim & ./Buildings_latest_Buildings.Airflow.Multizone.Examples.ReverseBuoyancy  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > Buildings_latest_Buildings.Airflow.Multizone.Examples.ReverseBuoyancy.pipe 2>&1)
diffSimulationResults("Buildings_latest_Buildings.Airflow.Multizone.Examples.ReverseBuoyancy_res.mat","/mnt/ReferenceFiles/Buildings/csv/master/Buildings_Airflow_Multizone_Examples_ReverseBuoyancy.csv","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_latest_Buildings.Airflow.Multizone.Examples.ReverseBuoyancy.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001)
Reference file matches