Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IBPSA_latest_IBPSA.Airflow.Multizone.Validation.OpenDoorBuoyancyDynamic.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/IBPSA 4.0.0-master/package.mo", uses=false)
Using package IBPSA with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 4.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(IBPSA.Airflow.Multizone.Validation.OpenDoorBuoyancyDynamic,tolerance=1e-08,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IBPSA_latest_IBPSA.Airflow.Multizone.Validation.OpenDoorBuoyancyDynamic")
translateModel(IBPSA.Airflow.Multizone.Validation.OpenDoorBuoyancyDynamic,tolerance=1e-08,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IBPSA_latest_IBPSA.Airflow.Multizone.Validation.OpenDoorBuoyancyDynamic")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001083/0.001083, allocations: 93.59 kB / 16.66 MB, free: 5.859 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.001028/0.001028, allocations: 176.7 kB / 17.57 MB, free: 5.543 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.379/1.379, allocations: 223.3 MB / 241.6 MB, free: 14.46 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 4.0.0-master/package.mo): time 0.7213/0.7213, allocations: 115.5 MB / 408.2 MB, free: 7.105 MB / 318.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.0003546/0.0003546, allocations: 12 kB / 496.5 MB, free: 15.68 MB / 414.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.4098/0.4102, allocations: 77.53 MB / 0.5606 GB, free: 35.44 MB / 446.1 MB
Notification: Performance of NFInst.instantiate(IBPSA.Airflow.Multizone.Validation.OpenDoorBuoyancyDynamic): time 0.6523/1.063, allocations: 240.1 MB / 0.7951 GB, free: 1.629 MB / 0.5762 GB
Notification: Performance of NFInst.instExpressions: time 0.02256/1.085, allocations: 14.41 MB / 0.8092 GB, free: 1.297 MB / 0.5762 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.004217/1.089, allocations: 60.22 kB / 0.8092 GB, free: 1.297 MB / 0.5762 GB
Notification: Performance of NFTyping.typeComponents: time 0.003762/1.093, allocations: 1.098 MB / 0.8103 GB, free: 1.273 MB / 0.5762 GB
Notification: Performance of NFTyping.typeBindings: time 0.01285/1.106, allocations: 4.401 MB / 0.8146 GB, free: 1.047 MB / 0.5762 GB
Notification: Performance of NFTyping.typeClassSections: time 0.005104/1.111, allocations: 1.689 MB / 0.8162 GB, free: 0.9922 MB / 0.5762 GB
Notification: Performance of NFFlatten.flatten: time 0.01007/1.121, allocations: 8.637 MB / 0.8247 GB, free: 0.6133 MB / 0.5762 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.003339/1.125, allocations: 1.623 MB / 0.8263 GB, free: 16.03 MB / 0.5919 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.005207/1.13, allocations: 1.811 MB / 0.828 GB, free: 15.82 MB / 0.5919 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.005556/1.136, allocations: 2.03 MB / 0.83 GB, free: 15.43 MB / 0.5919 GB
Notification: Performance of NFPackage.collectConstants: time 0.0006998/1.136, allocations: 107.2 kB / 0.8301 GB, free: 15.43 MB / 0.5919 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.01132/1.148, allocations: 5.151 MB / 0.8351 GB, free: 14.33 MB / 0.5919 GB
Notification: Performance of NFScalarize.scalarize: time 0.001704/1.149, allocations: 0.8988 MB / 0.836 GB, free: 14.04 MB / 0.5919 GB
Notification: Performance of NFVerifyModel.verify: time 0.002481/1.152, allocations: 1.299 MB / 0.8373 GB, free: 13.82 MB / 0.5919 GB
Notification: Performance of NFConvertDAE.convert: time 0.006849/1.159, allocations: 3.839 MB / 0.841 GB, free: 12 MB / 0.5919 GB
Notification: Performance of FrontEnd - DAE generated: time 7.794e-06/1.159, allocations: 0 / 0.841 GB, free: 12 MB / 0.5919 GB
Notification: Performance of FrontEnd: time 3.066e-06/1.159, allocations: 0 / 0.841 GB, free: 12 MB / 0.5919 GB
Notification: Performance of Transformations before backend: time 0.0001104/1.159, allocations: 0 / 0.841 GB, free: 12 MB / 0.5919 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 494
 * Number of variables: 494
Notification: Performance of Generate backend data structure: time 0.006767/1.166, allocations: 2.748 MB / 0.8437 GB, free: 10.32 MB / 0.5919 GB
Notification: Performance of prepare preOptimizeDAE: time 4.644e-05/1.166, allocations: 13.97 kB / 0.8437 GB, free: 10.31 MB / 0.5919 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.004444/1.17, allocations: 0.6797 MB / 0.8444 GB, free: 10.04 MB / 0.5919 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.002997/1.173, allocations: 1.557 MB / 0.8459 GB, free: 9.309 MB / 0.5919 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 9.381e-05/1.173, allocations: 153.9 kB / 0.8461 GB, free: 9.301 MB / 0.5919 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0003104/1.174, allocations: 192.9 kB / 0.8462 GB, free: 9.297 MB / 0.5919 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.00379/1.177, allocations: 2.426 MB / 0.8486 GB, free: 8.629 MB / 0.5919 GB
Notification: Performance of preOpt findStateOrder (simulation): time 4.206e-05/1.177, allocations: 0 / 0.8486 GB, free: 8.629 MB / 0.5919 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001838/1.178, allocations: 82.5 kB / 0.8487 GB, free: 8.57 MB / 0.5919 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 8.599e-05/1.178, allocations: 91.64 kB / 0.8488 GB, free: 8.555 MB / 0.5919 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.004099/1.182, allocations: 2.608 MB / 0.8513 GB, free: 6.305 MB / 0.5919 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.01191/1.194, allocations: 8.041 MB / 0.8592 GB, free: 13.91 MB / 0.6075 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.003524/1.197, allocations: 2.359 MB / 0.8615 GB, free: 11.54 MB / 0.6075 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.002022/1.199, allocations: 1.346 MB / 0.8628 GB, free: 10.18 MB / 0.6075 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.001537/1.201, allocations: 1.559 MB / 0.8643 GB, free: 8.301 MB / 0.6075 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 8e-05/1.201, allocations: 70.89 kB / 0.8644 GB, free: 8.219 MB / 0.6075 GB
Notification: Performance of pre-optimization done (n=222): time 4.398e-06/1.201, allocations: 0 / 0.8644 GB, free: 8.219 MB / 0.6075 GB
Notification: Performance of matching and sorting (n=226): time 0.01251/1.214, allocations: 6.858 MB / 0.8711 GB, free: 1.246 MB / 0.6075 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 8.535e-05/1.214, allocations: 154.5 kB / 0.8712 GB, free: 1.066 MB / 0.6075 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001646/1.215, allocations: 1.227 MB / 0.8724 GB, free: 15.83 MB / 0.6231 GB
Notification: Performance of collectPreVariables (initialization): time 0.0002675/1.216, allocations: 65.7 kB / 0.8725 GB, free: 15.76 MB / 0.6231 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0005431/1.216, allocations: 0.753 MB / 0.8732 GB, free: 15 MB / 0.6231 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0007071/1.217, allocations: 0.7682 MB / 0.874 GB, free: 14.23 MB / 0.6231 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0002188/1.217, allocations: 161.6 kB / 0.8741 GB, free: 14.07 MB / 0.6231 GB
Notification: Performance of setup shared object (initialization): time 9.372e-05/1.217, allocations: 305.1 kB / 0.8744 GB, free: 13.77 MB / 0.6231 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001352/1.219, allocations: 0.8628 MB / 0.8753 GB, free: 12.91 MB / 0.6231 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001499/1.22, allocations: 1.124 MB / 0.8764 GB, free: 11.72 MB / 0.6231 GB
Warning: It was not possible to determine if the initialization problem is consistent, because of not evaluable parameters/start values during compile time: bouA.dynBal.medium.p = bouA.dynBal.p_start (bou.p = bouA.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: bouADis.dynBal.medium.p = bouADis.dynBal.p_start (bou1.p = bouADis.dynBal.p_start)
Notification: Performance of analyzeInitialSystem (initialization): time 0.07214/1.292, allocations: 11.72 MB / 0.8878 GB, free: 15.92 MB / 0.6387 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.491e-05/1.292, allocations: 0 / 0.8878 GB, free: 15.92 MB / 0.6387 GB
Notification: Performance of matching and sorting (n=254) (initialization): time 0.004379/1.297, allocations: 2.396 MB / 0.8901 GB, free: 13.54 MB / 0.6387 GB
Notification: Performance of prepare postOptimizeDAE: time 3.535e-05/1.297, allocations: 8 kB / 0.8902 GB, free: 13.53 MB / 0.6387 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.484e-05/1.297, allocations: 4.594 kB / 0.8902 GB, free: 13.52 MB / 0.6387 GB
Notification: Performance of postOpt tearingSystem (initialization): time 3.45e-05/1.297, allocations: 19.94 kB / 0.8902 GB, free: 13.5 MB / 0.6387 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001817/1.299, allocations: 429.3 kB / 0.8906 GB, free: 13.11 MB / 0.6387 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.872e-05/1.299, allocations: 22.52 kB / 0.8906 GB, free: 13.09 MB / 0.6387 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002474/1.301, allocations: 180.4 kB / 0.8908 GB, free: 12.91 MB / 0.6387 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001618/1.301, allocations: 71.98 kB / 0.8909 GB, free: 12.84 MB / 0.6387 GB
Warning: The initial conditions are over specified. The following 2 initial equations are redundant, so they are removed from the initialization sytem:
         bouA.dynBal.medium.p = bouA.dynBal.p_start
         bouADis.dynBal.medium.p = bouADis.dynBal.p_start.
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 21
 * 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 (254):
 * Single equations (assignments): 254
 * 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.001208/1.303, allocations: 0.5661 MB / 0.8914 GB, free: 12.29 MB / 0.6387 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0004799/1.303, allocations: 201.7 kB / 0.8916 GB, free: 12.09 MB / 0.6387 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.004369/1.307, allocations: 2.52 MB / 0.8941 GB, free: 9.562 MB / 0.6387 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 2.248e-05/1.308, allocations: 27.94 kB / 0.8941 GB, free: 9.535 MB / 0.6387 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.335e-05/1.308, allocations: 4 kB / 0.8941 GB, free: 9.531 MB / 0.6387 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.003059/1.311, allocations: 2.096 MB / 0.8961 GB, free: 7.422 MB / 0.6387 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.009473/1.32, allocations: 5.358 MB / 0.9014 GB, free: 2.027 MB / 0.6387 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.238e-05/1.32, allocations: 12.03 kB / 0.9014 GB, free: 2.016 MB / 0.6387 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.001989/1.322, allocations: 461.3 kB / 0.9018 GB, free: 1.59 MB / 0.6387 GB
Notification: Performance of postOpt tearingSystem (simulation): time 2.409e-05/1.322, allocations: 16 kB / 0.9018 GB, free: 1.574 MB / 0.6387 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0001398/1.322, allocations: 59.98 kB / 0.9019 GB, free: 1.516 MB / 0.6387 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 1.816e-05/1.322, allocations: 18.52 kB / 0.9019 GB, free: 1.5 MB / 0.6387 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 9.007e-06/1.322, allocations: 10.53 kB / 0.9019 GB, free: 1.492 MB / 0.6387 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.005522/1.328, allocations: 4.09 MB / 0.9059 GB, free: 13.32 MB / 0.6544 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.001233/1.329, allocations: 0.4907 MB / 0.9064 GB, free: 12.8 MB / 0.6544 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.000282/1.329, allocations: 55.98 kB / 0.9064 GB, free: 12.75 MB / 0.6544 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001795/1.331, allocations: 141.7 kB / 0.9066 GB, free: 12.62 MB / 0.6544 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0002466/1.331, allocations: 154.7 kB / 0.9067 GB, free: 12.47 MB / 0.6544 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0001392/1.332, allocations: 83.91 kB / 0.9068 GB, free: 12.39 MB / 0.6544 GB
Notification: Performance of sorting global known variables: time 0.001167/1.333, allocations: 0.8356 MB / 0.9076 GB, free: 11.55 MB / 0.6544 GB
Notification: Performance of sort global known variables: time 1.5e-07/1.333, allocations: 0 / 0.9076 GB, free: 11.55 MB / 0.6544 GB
Notification: Performance of remove unused functions: time 0.00194/1.335, allocations: 0.6874 MB / 0.9083 GB, free: 10.86 MB / 0.6544 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 28
 * Number of states: 12 (bouADis.dynBal.medium.Xi[1],bouADis.dynBal.U,bouBDis.dynBal.medium.Xi[1],bouBDis.dynBal.U,bouBDis.dynBal.m,bouA.dynBal.medium.Xi[1],bouA.dynBal.U,bouB.dynBal.medium.Xi[1],bouB.dynBal.U,bouB.dynBal.m,dooDis.mExcBA,dooDis.mExcAB)
 * 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 (230):
 * Single equations (assignments): 230
 * 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.0007544/1.336, allocations: 353.7 kB / 0.9086 GB, free: 10.55 MB / 0.6544 GB
Notification: Performance of simCode: created initialization part: time 0.003381/1.339, allocations: 2.181 MB / 0.9108 GB, free: 8.418 MB / 0.6544 GB
Notification: Performance of simCode: created event and clocks part: time 9.077e-06/1.339, allocations: 4 kB / 0.9108 GB, free: 8.414 MB / 0.6544 GB
Notification: Performance of simCode: created simulation system equations: time 0.001602/1.341, allocations: 1.175 MB / 0.9119 GB, free: 7.301 MB / 0.6544 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.006969/1.348, allocations: 1.126 MB / 0.913 GB, free: 6.203 MB / 0.6544 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.009022/1.357, allocations: 6.081 MB / 0.919 GB, free: 16 kB / 0.6544 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001468/1.358, allocations: 1.656 MB / 0.9206 GB, free: 14.32 MB / 0.67 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.001084/1.359, allocations: 199.4 kB / 0.9208 GB, free: 14.13 MB / 0.67 GB
Notification: Performance of SimCode: time 1.543e-06/1.359, allocations: 0 / 0.9208 GB, free: 14.13 MB / 0.67 GB
Notification: Performance of Templates: time 0.05912/1.418, allocations: 34.48 MB / 0.9544 GB, free: 11.83 MB / 0.7012 GB
make -j1 -f IBPSA_latest_IBPSA.Airflow.Multizone.Validation.OpenDoorBuoyancyDynamic.makefile
(rm -f IBPSA_latest_IBPSA.Airflow.Multizone.Validation.OpenDoorBuoyancyDynamic.pipe ; mkfifo IBPSA_latest_IBPSA.Airflow.Multizone.Validation.OpenDoorBuoyancyDynamic.pipe ; head -c 1048576 < IBPSA_latest_IBPSA.Airflow.Multizone.Validation.OpenDoorBuoyancyDynamic.pipe >> ../files/IBPSA_latest_IBPSA.Airflow.Multizone.Validation.OpenDoorBuoyancyDynamic.sim & ./IBPSA_latest_IBPSA.Airflow.Multizone.Validation.OpenDoorBuoyancyDynamic  -abortSlowSimulation -alarm=480 -lv LOG_STATS > IBPSA_latest_IBPSA.Airflow.Multizone.Validation.OpenDoorBuoyancyDynamic.pipe 2>&1)