Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr IBPSA_latest_IBPSA.Fluid.Storage.Examples.Stratified.conf.json
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/IBPSA 4.0.0-master/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/ModelicaServices 4.0.0+maint.om/package.mo", uses=false)
Using package ModelicaServices with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/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 IBPSA with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 4.0.0-master/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)
Running command: translateModel(IBPSA.Fluid.Storage.Examples.Stratified,tolerance=1e-08,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IBPSA_latest_IBPSA.Fluid.Storage.Examples.Stratified")
translateModel(IBPSA.Fluid.Storage.Examples.Stratified,tolerance=1e-08,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IBPSA_latest_IBPSA.Fluid.Storage.Examples.Stratified")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.0009622/0.0009624, allocations: 181 kB / 15.76 MB, free: 6.363 MB / 13.93 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 4.0.0-master/package.mo): time 0.491/0.491, allocations: 92 MB / 108.5 MB, free: 13.07 MB / 90.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.481/1.481, allocations: 223.2 MB / 354.3 MB, free: 12.23 MB / 282.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.0009664/0.0009665, allocations: 111.1 kB / 427.4 MB, free: 3.945 MB / 346.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0004839/0.000484, allocations: 8 kB / 0.4982 GB, free: 42.33 MB / 362.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.195/0.1955, allocations: 72.31 MB / 0.5689 GB, free: 1.949 MB / 394.7 MB
Notification: Performance of FrontEnd - scodeFlatten: time 1.266/1.462, allocations: 375.7 MB / 0.9357 GB, free: 91.33 MB / 0.5886 GB
Notification: Performance of FrontEnd - mkProgramGraph: time 0.0003454/1.462, allocations: 95.2 kB / 0.9358 GB, free: 91.28 MB / 0.5886 GB
Notification: Performance of FrontEnd - DAE generated: time 11.56/13.03, allocations: 3.021 GB / 3.956 GB, free: 68.17 MB / 0.6511 GB
Notification: Performance of FrontEnd: time 2.315e-06/13.03, allocations: 0 / 3.956 GB, free: 68.17 MB / 0.6511 GB
Notification: Performance of Transformations before backend: time 0.002069/13.03, allocations: 259.3 kB / 3.957 GB, free: 68.13 MB / 0.6511 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 2145
 * Number of variables: 2145
Notification: Performance of Generate backend data structure: time 0.03621/13.06, allocations: 9.915 MB / 3.966 GB, free: 64.5 MB / 0.6511 GB
Notification: Performance of prepare preOptimizeDAE: time 4.284e-05/13.06, allocations: 11.38 kB / 3.966 GB, free: 64.5 MB / 0.6511 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.007691/13.07, allocations: 1.178 MB / 3.967 GB, free: 63.95 MB / 0.6511 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.02736/13.1, allocations: 11.11 MB / 3.978 GB, free: 62.84 MB / 0.6511 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0007735/13.1, allocations: 0.611 MB / 3.979 GB, free: 62.82 MB / 0.6511 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.00427/13.11, allocations: 0.8196 MB / 3.98 GB, free: 62.82 MB / 0.6511 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.03909/13.14, allocations: 11.7 MB / 3.991 GB, free: 61.61 MB / 0.6511 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0007655/13.15, allocations: 26.78 kB / 3.991 GB, free: 61.6 MB / 0.6511 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.004041/13.15, allocations: 359.5 kB / 3.991 GB, free: 61.6 MB / 0.6511 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0003312/13.15, allocations: 247.7 kB / 3.992 GB, free: 61.6 MB / 0.6511 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.02312/13.17, allocations: 9.629 MB / 4.001 GB, free: 61.54 MB / 0.6511 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.09221/13.26, allocations: 46.63 MB / 4.047 GB, free: 40.85 MB / 0.6511 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.01218/13.28, allocations: 6.306 MB / 4.053 GB, free: 38.39 MB / 0.6511 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.001466/13.28, allocations: 0.8273 MB / 4.054 GB, free: 37.61 MB / 0.6511 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.00836/13.29, allocations: 3.403 MB / 4.057 GB, free: 36.41 MB / 0.6511 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.006938/13.29, allocations: 0.5635 MB / 4.058 GB, free: 36.04 MB / 0.6511 GB
Notification: Performance of pre-optimization done (n=449): time 2.421e-05/13.29, allocations: 0 / 4.058 GB, free: 36.04 MB / 0.6511 GB
Notification: Performance of matching and sorting (n=449): time 0.0209/13.32, allocations: 9.022 MB / 4.066 GB, free: 32.57 MB / 0.6511 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001057/13.32, allocations: 154.6 kB / 4.066 GB, free: 32.45 MB / 0.6511 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.01734/13.33, allocations: 7.199 MB / 4.073 GB, free: 30.04 MB / 0.6511 GB
Notification: Performance of collectPreVariables (initialization): time 0.001592/13.33, allocations: 119.8 kB / 4.074 GB, free: 29.94 MB / 0.6511 GB
Notification: Performance of collectInitialEqns (initialization): time 0.006464/13.34, allocations: 4.325 MB / 4.078 GB, free: 26.66 MB / 0.6511 GB
Notification: Performance of collectInitialBindings (initialization): time 0.002968/13.34, allocations: 1.558 MB / 4.079 GB, free: 25.47 MB / 0.6511 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.001301/13.34, allocations: 120.6 kB / 4.079 GB, free: 25.38 MB / 0.6511 GB
Notification: Performance of setup shared object (initialization): time 0.000671/13.35, allocations: 0.541 MB / 4.08 GB, free: 24.96 MB / 0.6511 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.005891/13.35, allocations: 2.987 MB / 4.083 GB, free: 23.46 MB / 0.6511 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.007842/13.36, allocations: 4.859 MB / 4.088 GB, free: 18.38 MB / 0.6511 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.007497/13.37, allocations: 4.024 MB / 4.092 GB, free: 14.87 MB / 0.6511 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 6.674e-05/13.37, allocations: 16 kB / 4.092 GB, free: 14.85 MB / 0.6511 GB
Notification: Performance of matching and sorting (n=754) (initialization): time 0.02328/13.39, allocations: 8.854 MB / 4.1 GB, free: 7.086 MB / 0.6511 GB
Notification: Performance of prepare postOptimizeDAE: time 0.4882/13.88, allocations: 29.26 MB / 4.129 GB, free: 71.79 MB / 0.6667 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0002314/13.88, allocations: 57.88 kB / 4.129 GB, free: 71.79 MB / 0.6667 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0002144/13.88, allocations: 98.09 kB / 4.129 GB, free: 71.79 MB / 0.6667 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.008088/13.89, allocations: 1.437 MB / 4.13 GB, free: 71.79 MB / 0.6667 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0002512/13.89, allocations: 130.8 kB / 4.131 GB, free: 71.79 MB / 0.6667 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0107/13.9, allocations: 0.6285 MB / 4.131 GB, free: 71.79 MB / 0.6667 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.002014/13.9, allocations: 282 kB / 4.131 GB, free: 71.79 MB / 0.6667 GB
Notification: Performance of prepare postOptimizeDAE: time 2.297e-05/13.9, allocations: 11.7 kB / 4.131 GB, free: 71.78 MB / 0.6667 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.01862/13.92, allocations: 8.26 MB / 4.139 GB, free: 71.63 MB / 0.6667 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0002588/13.92, allocations: 59.84 kB / 4.14 GB, free: 71.63 MB / 0.6667 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.000166/13.92, allocations: 97.53 kB / 4.14 GB, free: 71.63 MB / 0.6667 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.006383/13.93, allocations: 1.437 MB / 4.141 GB, free: 71.63 MB / 0.6667 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0001314/13.93, allocations: 129.7 kB / 4.141 GB, free: 71.63 MB / 0.6667 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.009231/13.94, allocations: 0.6047 MB / 4.142 GB, free: 71.63 MB / 0.6667 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001554/13.94, allocations: 281.2 kB / 4.142 GB, free: 71.63 MB / 0.6667 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 264
 * Number of states: 0 ()
 * Number of discrete variables: 15 ($whenCondition1,$whenCondition2,TWat.a,TWat.b,TWat.last,$PRE.TWat.nextEvent,TWat.nextEvent,TWat.nextEventScaled,P.a,P.b,P.last,$PRE.P.nextEvent,P.nextEvent,P.nextEventScaled,dH.local_reset)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (744):
 * Single equations (assignments): 742
 * Array equations: 0
 * Algorithm blocks: 2
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of prepare postOptimizeDAE: time 0.01012/13.95, allocations: 3.588 MB / 4.146 GB, free: 71.38 MB / 0.6667 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.002915/13.95, allocations: 0.7255 MB / 4.146 GB, free: 71.38 MB / 0.6667 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01497/13.96, allocations: 7.12 MB / 4.153 GB, free: 71.1 MB / 0.6667 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 6.039e-05/13.96, allocations: 42.47 kB / 4.153 GB, free: 71.1 MB / 0.6667 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.391e-05/13.96, allocations: 0.6562 kB / 4.153 GB, free: 71.1 MB / 0.6667 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.009342/13.97, allocations: 5.821 MB / 4.159 GB, free: 70.88 MB / 0.6667 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 postOpt removeSimpleEquations (simulation): time 0.03415/14.01, allocations: 16.42 MB / 4.175 GB, free: 69.96 MB / 0.6667 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.377e-05/14.01, allocations: 1.875 kB / 4.175 GB, free: 69.96 MB / 0.6667 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.003939/14.01, allocations: 0.9129 MB / 4.176 GB, free: 69.95 MB / 0.6667 GB
Notification: Performance of postOpt tearingSystem (simulation): time 3.862e-05/14.01, allocations: 15.16 kB / 4.176 GB, free: 69.95 MB / 0.6667 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0004272/14.01, allocations: 118.4 kB / 4.176 GB, free: 69.95 MB / 0.6667 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 1.927e-05/14.01, allocations: 15.06 kB / 4.176 GB, free: 69.95 MB / 0.6667 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.224e-06/14.01, allocations: 0 / 4.176 GB, free: 69.95 MB / 0.6667 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.02062/14.03, allocations: 10.78 MB / 4.186 GB, free: 69.39 MB / 0.6667 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.009984/14.04, allocations: 1.752 MB / 4.188 GB, free: 68.93 MB / 0.6667 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.004707/14.05, allocations: 98 kB / 4.188 GB, free: 68.93 MB / 0.6667 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.01205/14.06, allocations: 0.5742 MB / 4.189 GB, free: 68.91 MB / 0.6667 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.001309/14.06, allocations: 253.2 kB / 4.189 GB, free: 68.9 MB / 0.6667 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0008338/14.06, allocations: 202.7 kB / 4.189 GB, free: 68.9 MB / 0.6667 GB
Notification: Performance of sorting global known variables: time 0.0119/14.07, allocations: 5.633 MB / 4.195 GB, free: 68.68 MB / 0.6667 GB
Notification: Performance of sort global known variables: time 3.21e-07/14.07, allocations: 0 / 4.195 GB, free: 68.68 MB / 0.6667 GB
Notification: Performance of remove unused functions: time 0.0234/14.1, allocations: 4.926 MB / 4.2 GB, free: 68.33 MB / 0.6667 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 4
 * Number of states: 21 (tanSim.vol[1].dynBal.U,tanSim.vol[2].dynBal.U,tanSim.vol[3].dynBal.U,tanSim.vol[4].dynBal.U,tanSim.vol[5].dynBal.U,tanSim.vol[6].dynBal.U,tanSim.vol[7].dynBal.U,tanSim.vol[8].dynBal.U,tanSim.vol[9].dynBal.U,tanSim.vol[10].dynBal.U,tanEnh.vol[1].dynBal.U,tanEnh.vol[2].dynBal.U,tanEnh.vol[3].dynBal.U,tanEnh.vol[4].dynBal.U,tanEnh.vol[5].dynBal.U,tanEnh.vol[6].dynBal.U,tanEnh.vol[7].dynBal.U,tanEnh.vol[8].dynBal.U,tanEnh.vol[9].dynBal.U,tanEnh.vol[10].dynBal.U,dH.y)
 * Number of discrete variables: 12 ($whenCondition1,$whenCondition2,TWat.a,TWat.b,TWat.last,TWat.nextEvent,TWat.nextEventScaled,P.a,P.b,P.last,P.nextEvent,P.nextEventScaled)
 * Number of discrete states: 12 (P.nextEvent,P.last,P.nextEventScaled,P.b,P.a,$whenCondition2,TWat.nextEvent,TWat.last,TWat.nextEventScaled,TWat.b,TWat.a,$whenCondition1)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (445):
 * Single equations (assignments): 441
 * Array equations: 0
 * Algorithm blocks: 2
 * Record equations: 2
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of Backend phase and start with SimCode phase: time 0.003884/14.1, allocations: 0.9457 MB / 4.201 GB, free: 68.21 MB / 0.6667 GB
Notification: Performance of simCode: created initialization part: time 0.02129/14.12, allocations: 11.46 MB / 4.212 GB, free: 67.88 MB / 0.6667 GB
Notification: Performance of simCode: created event and clocks part: time 1.304e-05/14.12, allocations: 4.156 kB / 4.212 GB, free: 67.88 MB / 0.6667 GB
Notification: Performance of simCode: created simulation system equations: time 0.004912/14.13, allocations: 3.199 MB / 4.215 GB, free: 67.73 MB / 0.6667 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.02197/14.15, allocations: 4.377 MB / 4.219 GB, free: 67.71 MB / 0.6667 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.0405/14.19, allocations: 22.62 MB / 4.241 GB, free: 59.91 MB / 0.6667 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.009092/14.2, allocations: 6.308 MB / 4.247 GB, free: 58.92 MB / 0.6667 GB
Notification: Performance of simCode: alias equations: time 0.0164/14.22, allocations: 4.357 MB / 4.252 GB, free: 58.59 MB / 0.6667 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.003206/14.22, allocations: 0.6185 MB / 4.252 GB, free: 58.58 MB / 0.6667 GB
Notification: Performance of SimCode: time 1.413e-06/14.22, allocations: 0 / 4.252 GB, free: 58.58 MB / 0.6667 GB
Notification: Performance of Templates: time 0.71/14.93, allocations: 158.6 MB / 4.407 GB, free: 52.38 MB / 0.6823 GB
make -j1 -f IBPSA_latest_IBPSA.Fluid.Storage.Examples.Stratified.makefile
(rm -f IBPSA_latest_IBPSA.Fluid.Storage.Examples.Stratified.pipe ; mkfifo IBPSA_latest_IBPSA.Fluid.Storage.Examples.Stratified.pipe ; head -c 1048576 < IBPSA_latest_IBPSA.Fluid.Storage.Examples.Stratified.pipe >> ../files/IBPSA_latest_IBPSA.Fluid.Storage.Examples.Stratified.sim & ./IBPSA_latest_IBPSA.Fluid.Storage.Examples.Stratified  -abortSlowSimulation -alarm=480 -lv LOG_STATS > IBPSA_latest_IBPSA.Fluid.Storage.Examples.Stratified.pipe 2>&1)