Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IBPSA_latest_IBPSA.Airflow.Multizone.Examples.ChimneyShaftWithVolume.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.Examples.ChimneyShaftWithVolume,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IBPSA_latest_IBPSA.Airflow.Multizone.Examples.ChimneyShaftWithVolume")
translateModel(IBPSA.Airflow.Multizone.Examples.ChimneyShaftWithVolume,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IBPSA_latest_IBPSA.Airflow.Multizone.Examples.ChimneyShaftWithVolume")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.0009931/0.0009932, allocations: 99.05 kB / 16.02 MB, free: 80 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.001367/0.001367, allocations: 181.3 kB / 16.92 MB, free: 6.73 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.464/1.464, allocations: 223.3 MB / 241 MB, free: 5.352 MB / 190.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 4.0.0-master/package.mo): time 0.6834/0.6834, allocations: 115.5 MB / 407.6 MB, free: 2.66 MB / 334.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.000376/0.0003759, allocations: 8 kB / 495.9 MB, free: 6.332 MB / 350.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1786/0.179, allocations: 77.54 MB / 0.56 GB, free: 9.004 MB / 430.1 MB
Notification: Performance of NFInst.instantiate(IBPSA.Airflow.Multizone.Examples.ChimneyShaftWithVolume): time 0.6113/0.7904, allocations: 230.5 MB / 0.785 GB, free: 152 kB / 0.5919 GB
Notification: Performance of NFInst.instExpressions: time 0.01789/0.8083, allocations: 10.39 MB / 0.7952 GB, free: 5.727 MB / 0.6075 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.003218/0.8116, allocations: 55.62 kB / 0.7952 GB, free: 5.672 MB / 0.6075 GB
Notification: Performance of NFTyping.typeComponents: time 0.003652/0.8153, allocations: 1.026 MB / 0.7962 GB, free: 4.641 MB / 0.6075 GB
Notification: Performance of NFTyping.typeBindings: time 0.01108/0.8264, allocations: 3.437 MB / 0.7996 GB, free: 1.191 MB / 0.6075 GB
Notification: Performance of NFTyping.typeClassSections: time 0.00619/0.8326, allocations: 1.9 MB / 0.8014 GB, free: 15.3 MB / 0.6231 GB
Notification: Performance of NFFlatten.flatten: time 0.008952/0.8416, allocations: 6.269 MB / 0.8076 GB, free: 9.02 MB / 0.6231 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.002796/0.8444, allocations: 1.302 MB / 0.8088 GB, free: 7.68 MB / 0.6231 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.004146/0.8486, allocations: 1.33 MB / 0.8101 GB, free: 6.344 MB / 0.6231 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.004235/0.8528, allocations: 1.484 MB / 0.8116 GB, free: 4.859 MB / 0.6231 GB
Notification: Performance of NFPackage.collectConstants: time 0.0003894/0.8532, allocations: 76 kB / 0.8117 GB, free: 4.785 MB / 0.6231 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.008855/0.8621, allocations: 3.713 MB / 0.8153 GB, free: 1.062 MB / 0.6231 GB
Notification: Performance of NFScalarize.scalarize: time 0.001334/0.8635, allocations: 0.584 MB / 0.8159 GB, free: 488 kB / 0.6231 GB
Notification: Performance of NFVerifyModel.verify: time 0.002955/0.8665, allocations: 0.9615 MB / 0.8168 GB, free: 15.5 MB / 0.6387 GB
Notification: Performance of NFConvertDAE.convert: time 0.01004/0.8765, allocations: 3.89 MB / 0.8206 GB, free: 11.6 MB / 0.6387 GB
Notification: Performance of FrontEnd - DAE generated: time 7.474e-06/0.8766, allocations: 0 / 0.8206 GB, free: 11.6 MB / 0.6387 GB
Notification: Performance of FrontEnd: time 2.645e-06/0.8766, allocations: 0 / 0.8206 GB, free: 11.6 MB / 0.6387 GB
Notification: Performance of Transformations before backend: time 0.0001367/0.8768, allocations: 0 / 0.8206 GB, free: 11.6 MB / 0.6387 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 344
 * Number of variables: 344
Notification: Performance of Generate backend data structure: time 0.006826/0.8836, allocations: 2.128 MB / 0.8227 GB, free: 9.414 MB / 0.6387 GB
Notification: Performance of prepare preOptimizeDAE: time 5.137e-05/0.8837, allocations: 12.03 kB / 0.8227 GB, free: 9.402 MB / 0.6387 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.003932/0.8876, allocations: 0.5244 MB / 0.8232 GB, free: 8.875 MB / 0.6387 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.00311/0.8907, allocations: 1.217 MB / 0.8244 GB, free: 7.602 MB / 0.6387 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001369/0.8909, allocations: 110.6 kB / 0.8245 GB, free: 7.492 MB / 0.6387 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0004318/0.8913, allocations: 139.9 kB / 0.8246 GB, free: 7.355 MB / 0.6387 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.003011/0.8943, allocations: 1.678 MB / 0.8263 GB, free: 5.609 MB / 0.6387 GB
Notification: Performance of preOpt findStateOrder (simulation): time 3.79e-05/0.8944, allocations: 3.938 kB / 0.8263 GB, free: 5.605 MB / 0.6387 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001341/0.8945, allocations: 52 kB / 0.8263 GB, free: 5.555 MB / 0.6387 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 9.062e-05/0.8946, allocations: 74.56 kB / 0.8264 GB, free: 5.48 MB / 0.6387 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.002571/0.8972, allocations: 1.454 MB / 0.8278 GB, free: 4.02 MB / 0.6387 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.4112/1.308, allocations: 6.965 MB / 0.8346 GB, free: 230.1 MB / 0.6387 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.002254/1.311, allocations: 1.205 MB / 0.8358 GB, free: 229.9 MB / 0.6387 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001185/1.312, allocations: 0.6138 MB / 0.8364 GB, free: 229.8 MB / 0.6387 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0007777/1.313, allocations: 0.8635 MB / 0.8372 GB, free: 228.8 MB / 0.6387 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.001261/1.314, allocations: 0.6115 MB / 0.8378 GB, free: 228.6 MB / 0.6387 GB
Notification: Performance of pre-optimization done (n=110): time 3.667e-06/1.314, allocations: 1.156 kB / 0.8378 GB, free: 228.6 MB / 0.6387 GB
Notification: Performance of matching and sorting (n=110): time 0.003665/1.318, allocations: 1.585 MB / 0.8394 GB, free: 228.1 MB / 0.6387 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 6.499e-05/1.318, allocations: 92.22 kB / 0.8395 GB, free: 228 MB / 0.6387 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002101/1.32, allocations: 1.197 MB / 0.8406 GB, free: 227.5 MB / 0.6387 GB
Notification: Performance of collectPreVariables (initialization): time 0.0001512/1.32, allocations: 47.14 kB / 0.8407 GB, free: 227.5 MB / 0.6387 GB
Notification: Performance of collectInitialEqns (initialization): time 0.00065/1.321, allocations: 0.6763 MB / 0.8413 GB, free: 227 MB / 0.6387 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0003966/1.321, allocations: 385.9 kB / 0.8417 GB, free: 226.7 MB / 0.6387 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0001488/1.321, allocations: 88.83 kB / 0.8418 GB, free: 226.6 MB / 0.6387 GB
Notification: Performance of setup shared object (initialization): time 0.0001049/1.321, allocations: 348.5 kB / 0.8421 GB, free: 226.3 MB / 0.6387 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0008624/1.322, allocations: 424.4 kB / 0.8425 GB, free: 226.2 MB / 0.6387 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0009765/1.323, allocations: 0.5586 MB / 0.8431 GB, free: 225.9 MB / 0.6387 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.00185/1.325, allocations: 1.021 MB / 0.8441 GB, free: 225.4 MB / 0.6387 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 5.109e-06/1.325, allocations: 0 / 0.8441 GB, free: 225.4 MB / 0.6387 GB
Notification: Performance of matching and sorting (n=126) (initialization): time 0.002768/1.328, allocations: 1.231 MB / 0.8453 GB, free: 224.9 MB / 0.6387 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001097/1.328, allocations: 164.6 kB / 0.8454 GB, free: 224.7 MB / 0.6387 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.356e-05/1.328, allocations: 1.844 kB / 0.8454 GB, free: 224.7 MB / 0.6387 GB
Notification: Performance of postOpt tearingSystem (initialization): time 2.993e-05/1.328, allocations: 11.31 kB / 0.8454 GB, free: 224.7 MB / 0.6387 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.00104/1.329, allocations: 219.2 kB / 0.8456 GB, free: 224.7 MB / 0.6387 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.227e-05/1.329, allocations: 7.688 kB / 0.8457 GB, free: 224.7 MB / 0.6387 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001737/1.331, allocations: 190 kB / 0.8458 GB, free: 224.6 MB / 0.6387 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001063/1.331, allocations: 37.62 kB / 0.8459 GB, free: 224.6 MB / 0.6387 GB
Notification: Performance of prepare postOptimizeDAE: time 1.267e-05/1.331, allocations: 4.469 kB / 0.8459 GB, free: 224.6 MB / 0.6387 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.00201/1.333, allocations: 1.049 MB / 0.8469 GB, free: 224.2 MB / 0.6387 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 9.338e-06/1.333, allocations: 3.422 kB / 0.8469 GB, free: 224.2 MB / 0.6387 GB
Notification: Performance of postOpt tearingSystem (initialization): time 1.699e-05/1.333, allocations: 7.094 kB / 0.8469 GB, free: 224.2 MB / 0.6387 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.00103/1.334, allocations: 209.2 kB / 0.8471 GB, free: 224.2 MB / 0.6387 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.139e-05/1.334, allocations: 7.125 kB / 0.8471 GB, free: 224.2 MB / 0.6387 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001708/1.336, allocations: 181.3 kB / 0.8473 GB, free: 224.1 MB / 0.6387 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 8.911e-05/1.336, allocations: 36.3 kB / 0.8473 GB, free: 224.1 MB / 0.6387 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 11
 * Number of states: 0 ()
 * Number of discrete variables: 5 ($PRE.mRoo_flow.nextTimeEvent,$whenCondition1,mRoo_flow.nextTimeEventScaled,$PRE.mRoo_flow.nextTimeEventScaled,mRoo_flow.nextTimeEvent)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (126):
 * Single equations (assignments): 126
 * 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.001016/1.337, allocations: 496.4 kB / 0.8478 GB, free: 223.8 MB / 0.6387 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.000334/1.337, allocations: 152 kB / 0.8479 GB, free: 223.7 MB / 0.6387 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.002472/1.34, allocations: 1.247 MB / 0.8492 GB, free: 223.2 MB / 0.6387 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.628e-05/1.34, allocations: 10.59 kB / 0.8492 GB, free: 223.2 MB / 0.6387 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 8.416e-06/1.34, allocations: 1.188 kB / 0.8492 GB, free: 223.2 MB / 0.6387 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.001848/1.342, allocations: 1.015 MB / 0.8502 GB, free: 222.7 MB / 0.6387 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.006628/1.348, allocations: 3.18 MB / 0.8533 GB, free: 221.2 MB / 0.6387 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 8.866e-06/1.348, allocations: 3.234 kB / 0.8533 GB, free: 221.2 MB / 0.6387 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.001137/1.35, allocations: 230.7 kB / 0.8535 GB, free: 221.2 MB / 0.6387 GB
Notification: Performance of postOpt tearingSystem (simulation): time 1.827e-05/1.35, allocations: 10.41 kB / 0.8535 GB, free: 221.1 MB / 0.6387 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 9.081e-05/1.35, allocations: 30.66 kB / 0.8535 GB, free: 221.1 MB / 0.6387 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 1.514e-05/1.35, allocations: 10.42 kB / 0.8535 GB, free: 221.1 MB / 0.6387 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 4.959e-06/1.35, allocations: 2.438 kB / 0.8535 GB, free: 221.1 MB / 0.6387 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.003429/1.353, allocations: 1.923 MB / 0.8554 GB, free: 220.2 MB / 0.6387 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0009359/1.354, allocations: 364.6 kB / 0.8558 GB, free: 220 MB / 0.6387 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.000193/1.354, allocations: 26.92 kB / 0.8558 GB, free: 219.9 MB / 0.6387 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001153/1.355, allocations: 117.5 kB / 0.8559 GB, free: 219.9 MB / 0.6387 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001979/1.356, allocations: 77.52 kB / 0.856 GB, free: 219.9 MB / 0.6387 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 8.998e-05/1.356, allocations: 42.36 kB / 0.856 GB, free: 219.9 MB / 0.6387 GB
Notification: Performance of sorting global known variables: time 0.001368/1.357, allocations: 0.8241 MB / 0.8568 GB, free: 219.6 MB / 0.6387 GB
Notification: Performance of sort global known variables: time 1.4e-07/1.357, allocations: 0 / 0.8568 GB, free: 219.6 MB / 0.6387 GB
Notification: Performance of remove unused functions: time 0.002418/1.36, allocations: 0.8372 MB / 0.8576 GB, free: 219.4 MB / 0.6387 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 11
 * Number of states: 9 (roo.dynBal.medium.Xi[1],roo.dynBal.U,roo.dynBal.m,oriChiTop.mExc,oriBot.mExc,oriChiBot.mExc,sha.vol.dynBal.medium.Xi[1],sha.vol.dynBal.U,sha.vol.dynBal.m)
 * Number of discrete variables: 3 ($whenCondition1,mRoo_flow.nextTimeEvent,mRoo_flow.nextTimeEventScaled)
 * Number of discrete states: 2 (mRoo_flow.nextTimeEvent,mRoo_flow.nextTimeEventScaled)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (110):
 * Single equations (assignments): 108
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 2
 * 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.001473/1.361, allocations: 0.5738 MB / 0.8582 GB, free: 219.3 MB / 0.6387 GB
Notification: Performance of simCode: created initialization part: time 0.003178/1.364, allocations: 1.619 MB / 0.8598 GB, free: 218.7 MB / 0.6387 GB
Notification: Performance of simCode: created event and clocks part: time 8.195e-06/1.364, allocations: 4 kB / 0.8598 GB, free: 218.7 MB / 0.6387 GB
Notification: Performance of simCode: created simulation system equations: time 0.001042/1.365, allocations: 0.5759 MB / 0.8603 GB, free: 218.5 MB / 0.6387 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.005112/1.37, allocations: 0.8349 MB / 0.8612 GB, free: 218.3 MB / 0.6387 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.005844/1.376, allocations: 4.144 MB / 0.8652 GB, free: 215.8 MB / 0.6387 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.000777/1.377, allocations: 1.369 MB / 0.8665 GB, free: 215.1 MB / 0.6387 GB
Notification: Performance of simCode: alias equations: time 0.002229/1.379, allocations: 456.8 kB / 0.867 GB, free: 215 MB / 0.6387 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.000358/1.38, allocations: 113.6 kB / 0.8671 GB, free: 214.9 MB / 0.6387 GB
Notification: Performance of SimCode: time 1.253e-06/1.38, allocations: 0.5469 kB / 0.8671 GB, free: 214.9 MB / 0.6387 GB
Notification: Performance of Templates: time 0.04588/1.426, allocations: 28.51 MB / 0.8949 GB, free: 190.5 MB / 0.6387 GB
make -j1 -f IBPSA_latest_IBPSA.Airflow.Multizone.Examples.ChimneyShaftWithVolume.makefile
(rm -f IBPSA_latest_IBPSA.Airflow.Multizone.Examples.ChimneyShaftWithVolume.pipe ; mkfifo IBPSA_latest_IBPSA.Airflow.Multizone.Examples.ChimneyShaftWithVolume.pipe ; head -c 1048576 < IBPSA_latest_IBPSA.Airflow.Multizone.Examples.ChimneyShaftWithVolume.pipe >> ../files/IBPSA_latest_IBPSA.Airflow.Multizone.Examples.ChimneyShaftWithVolume.sim & ./IBPSA_latest_IBPSA.Airflow.Multizone.Examples.ChimneyShaftWithVolume  -abortSlowSimulation -alarm=480 -lv LOG_STATS > IBPSA_latest_IBPSA.Airflow.Multizone.Examples.ChimneyShaftWithVolume.pipe 2>&1)