Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr IDEAS_dev_IDEAS.Airflow.AHU.Validation.IehSummer.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/IDEAS 3.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 IDEAS with version 3.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.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(IDEAS.Airflow.AHU.Validation.IehSummer,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.Airflow.AHU.Validation.IehSummer")
translateModel(IDEAS.Airflow.AHU.Validation.IehSummer,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.Airflow.AHU.Validation.IehSummer")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.006107/0.006107, allocations: 169.5 kB / 15.11 MB, free: 5.973 MB / 13.93 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0-master/package.mo): time 0.6931/0.6931, allocations: 135.2 MB / 151.1 MB, free: 13.83 MB / 122.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.578/1.578, allocations: 223.2 MB / 406.9 MB, free: 3.234 MB / 330.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001414/0.001414, allocations: 96.64 kB / 489.9 MB, free: 10.93 MB / 362.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0003611/0.0003611, allocations: 8 kB / 0.5691 GB, free: 14.19 MB / 458.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.5469/0.5473, allocations: 82.3 MB / 0.6495 GB, free: 36.17 MB / 458.7 MB
Notification: Performance of FrontEnd - scodeFlatten: time 6.296/6.844, allocations: 1.919 GB / 2.569 GB, free: 18.43 MB / 0.6823 GB
Notification: Performance of FrontEnd - mkProgramGraph: time 0.0002482/6.844, allocations: 83.92 kB / 2.569 GB, free: 18.39 MB / 0.6823 GB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/Fluid/Interfaces.mo:202:5-202:64:writable] Warning: No corresponding 'inner' declaration found for component .Modelica.Fluid.System TRetOut.system declared as 'outer '.
  The existing 'inner' components are:
    There are no 'inner' components defined in the model in any of the parent scopes of 'outer' component's scope: Modelica.Fluid.Sensors.TemperatureTwoPort$TRetOut.
  Check if you have not misspelled the 'outer' component name.
  Please declare an 'inner' component with the same name in the top scope.
  Continuing flattening by only considering the 'outer' component declaration.
Notification: Performance of FrontEnd - DAE generated: time 6.068/12.91, allocations: 1.467 GB / 4.036 GB, free: 72.09 MB / 0.7292 GB
Notification: Performance of FrontEnd: time 2.344e-06/12.91, allocations: 2.406 kB / 4.036 GB, free: 72.09 MB / 0.7292 GB
Notification: Performance of Transformations before backend: time 0.0001782/12.91, allocations: 52.86 kB / 4.036 GB, free: 72.08 MB / 0.7292 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 391
 * Number of variables: 391
Notification: Performance of Generate backend data structure: time 0.008314/12.92, allocations: 2.802 MB / 4.039 GB, free: 71 MB / 0.7292 GB
Notification: Performance of prepare preOptimizeDAE: time 5.005e-05/12.92, allocations: 6.875 kB / 4.039 GB, free: 71 MB / 0.7292 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.009502/12.93, allocations: 1.179 MB / 4.04 GB, free: 70.88 MB / 0.7292 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.004603/12.94, allocations: 1.532 MB / 4.041 GB, free: 70.48 MB / 0.7292 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001155/12.94, allocations: 115.7 kB / 4.041 GB, free: 70.47 MB / 0.7292 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0003244/12.94, allocations: 157.7 kB / 4.041 GB, free: 70.47 MB / 0.7292 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.004318/12.94, allocations: 2.045 MB / 4.043 GB, free: 70.26 MB / 0.7292 GB
Notification: Performance of preOpt findStateOrder (simulation): time 4.839e-05/12.94, allocations: 9.062 kB / 4.043 GB, free: 70.26 MB / 0.7292 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0002075/12.94, allocations: 64.48 kB / 4.043 GB, free: 70.26 MB / 0.7292 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 9.604e-05/12.94, allocations: 64.25 kB / 4.044 GB, free: 70.25 MB / 0.7292 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.004336/12.94, allocations: 1.892 MB / 4.045 GB, free: 70.24 MB / 0.7292 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.01541/12.96, allocations: 7.121 MB / 4.052 GB, free: 67.42 MB / 0.7292 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.003127/12.96, allocations: 1.667 MB / 4.054 GB, free: 67.2 MB / 0.7292 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0008523/12.96, allocations: 0.5946 MB / 4.055 GB, free: 66.63 MB / 0.7292 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 4.104e-05/12.96, allocations: 45.56 kB / 4.055 GB, free: 66.59 MB / 0.7292 GB
Notification: Performance of pre-optimization done (n=119): time 3.266e-06/12.96, allocations: 3.75 kB / 4.055 GB, free: 66.59 MB / 0.7292 GB
Notification: Performance of matching and sorting (n=123): time 0.01303/12.98, allocations: 4.808 MB / 4.059 GB, free: 65.7 MB / 0.7292 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 4.135e-05/12.98, allocations: 71.11 kB / 4.059 GB, free: 65.63 MB / 0.7292 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001983/12.98, allocations: 1.279 MB / 4.061 GB, free: 65.48 MB / 0.7292 GB
Notification: Performance of collectPreVariables (initialization): time 0.0001777/12.98, allocations: 55.11 kB / 4.061 GB, free: 65.45 MB / 0.7292 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0005512/12.98, allocations: 0.796 MB / 4.061 GB, free: 65.18 MB / 0.7292 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0003619/12.98, allocations: 426.1 kB / 4.062 GB, free: 64.91 MB / 0.7292 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 8.485e-05/12.98, allocations: 22.59 kB / 4.062 GB, free: 64.91 MB / 0.7292 GB
Notification: Performance of setup shared object (initialization): time 0.0001012/12.98, allocations: 358.6 kB / 4.062 GB, free: 64.61 MB / 0.7292 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001463/12.98, allocations: 0.6555 MB / 4.063 GB, free: 64.6 MB / 0.7292 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001612/12.98, allocations: 0.9073 MB / 4.064 GB, free: 64.36 MB / 0.7292 GB
Warning: It was not possible to determine if the initialization problem is consistent, because of not evaluable parameters/start values during compile time: IEH.volBot.dynBal.medium.p = IEH.volBot.dynBal.p_start (bui.p = IEH.volBot.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: IEH.volTop.dynBal.medium.p = IEH.volTop.dynBal.p_start (bou2.p = IEH.volTop.dynBal.p_start)
Notification: Performance of analyzeInitialSystem (initialization): time 0.04182/13.03, allocations: 6.787 MB / 4.07 GB, free: 64.14 MB / 0.7292 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 7.905e-06/13.03, allocations: 0 / 4.07 GB, free: 64.14 MB / 0.7292 GB
Notification: Performance of matching and sorting (n=148) (initialization): time 0.005824/13.03, allocations: 1.963 MB / 4.072 GB, free: 63.97 MB / 0.7292 GB
Notification: Performance of prepare postOptimizeDAE: time 3.49e-05/13.03, allocations: 9.719 kB / 4.072 GB, free: 63.97 MB / 0.7292 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.497e-05/13.03, allocations: 7.594 kB / 4.072 GB, free: 63.97 MB / 0.7292 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001057/13.03, allocations: 195.4 kB / 4.073 GB, free: 63.96 MB / 0.7292 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001773/13.03, allocations: 329.7 kB / 4.073 GB, free: 63.96 MB / 0.7292 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.003587/13.04, allocations: 3.283 MB / 4.076 GB, free: 61.38 MB / 0.7292 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.00332/13.04, allocations: 267.5 kB / 4.076 GB, free: 61.37 MB / 0.7292 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0002528/13.04, allocations: 60.69 kB / 4.076 GB, free: 61.37 MB / 0.7292 GB
Warning: The initial conditions are over specified. The following 2 initial equations are redundant, so they are removed from the initialization sytem:
         IEH.volBot.dynBal.medium.p = IEH.volBot.dynBal.p_start
         IEH.volTop.dynBal.medium.p = IEH.volTop.dynBal.p_start.
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 18
 * 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 (144):
 * Single equations (assignments): 142
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 2
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 0
 * Non-linear torn systems: 2 {1 2,1 2}
Notification: Performance of prepare postOptimizeDAE: time 0.001285/13.04, allocations: 475.7 kB / 4.077 GB, free: 61.25 MB / 0.7292 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0004996/13.04, allocations: 187.8 kB / 4.077 GB, free: 61.16 MB / 0.7292 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.004909/13.05, allocations: 2.012 MB / 4.079 GB, free: 61.04 MB / 0.7292 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.579e-05/13.05, allocations: 19.38 kB / 4.079 GB, free: 61.04 MB / 0.7292 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 5.491e-06/13.05, allocations: 0 / 4.079 GB, free: 61.04 MB / 0.7292 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.003787/13.05, allocations: 1.792 MB / 4.081 GB, free: 60.74 MB / 0.7292 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.01065/13.06, allocations: 5.261 MB / 4.086 GB, free: 59.79 MB / 0.7292 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.436e-05/13.06, allocations: 7.812 kB / 4.086 GB, free: 59.79 MB / 0.7292 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.001714/13.06, allocations: 336 kB / 4.086 GB, free: 59.79 MB / 0.7292 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.0009595/13.07, allocations: 198.1 kB / 4.086 GB, free: 59.78 MB / 0.7292 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0001297/13.07, allocations: 48.5 kB / 4.086 GB, free: 59.78 MB / 0.7292 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.003289/13.07, allocations: 3.336 MB / 4.09 GB, free: 57.2 MB / 0.7292 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.325e-05/13.07, allocations: 21.88 kB / 4.09 GB, free: 57.2 MB / 0.7292 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.006977/13.08, allocations: 3.876 MB / 4.093 GB, free: 55.58 MB / 0.7292 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.001571/13.08, allocations: 441.8 kB / 4.094 GB, free: 55.39 MB / 0.7292 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0003326/13.08, allocations: 37.5 kB / 4.094 GB, free: 55.39 MB / 0.7292 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.002233/13.08, allocations: 262.6 kB / 4.094 GB, free: 55.39 MB / 0.7292 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0002361/13.08, allocations: 115.6 kB / 4.094 GB, free: 55.38 MB / 0.7292 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0001413/13.08, allocations: 73.62 kB / 4.094 GB, free: 55.38 MB / 0.7292 GB
Notification: Performance of sorting global known variables: time 0.001592/13.08, allocations: 0.9999 MB / 4.095 GB, free: 55.27 MB / 0.7292 GB
Notification: Performance of sort global known variables: time 1.31e-07/13.08, allocations: 1.719 kB / 4.095 GB, free: 55.27 MB / 0.7292 GB
Notification: Performance of remove unused functions: time 0.003623/13.09, allocations: 0.8306 MB / 4.096 GB, free: 55.24 MB / 0.7292 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 47
 * Number of states: 4 (IEH.volBot.dynBal.U,IEH.volBot.dynBal.mXi[1],IEH.volTop.dynBal.U,IEH.volTop.dynBal.mXi[1])
 * 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 (123):
 * Single equations (assignments): 121
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 2
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 0
 * Non-linear torn systems: 2 {1 3,1 3}
Notification: Performance of Backend phase and start with SimCode phase: time 0.005748/13.09, allocations: 3.445 MB / 4.1 GB, free: 53.84 MB / 0.7292 GB
Notification: Performance of simCode: created initialization part: time 0.004778/13.1, allocations: 1.832 MB / 4.101 GB, free: 53.59 MB / 0.7292 GB
Notification: Performance of simCode: created event and clocks part: time 2.45e-05/13.1, allocations: 7.453 kB / 4.101 GB, free: 53.59 MB / 0.7292 GB
Notification: Performance of simCode: created simulation system equations: time 0.002352/13.1, allocations: 1.077 MB / 4.102 GB, free: 53.36 MB / 0.7292 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.00552/13.1, allocations: 0.986 MB / 4.103 GB, free: 53.34 MB / 0.7292 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.008311/13.11, allocations: 4.624 MB / 4.108 GB, free: 51.16 MB / 0.7292 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001215/13.11, allocations: 1.527 MB / 4.109 GB, free: 50.4 MB / 0.7292 GB
Notification: Performance of simCode: alias equations: time 0.003042/13.12, allocations: 482.7 kB / 4.11 GB, free: 50.29 MB / 0.7292 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0005831/13.12, allocations: 148.1 kB / 4.11 GB, free: 50.29 MB / 0.7292 GB
Notification: Performance of SimCode: time 7.02e-07/13.12, allocations: 4 kB / 4.11 GB, free: 50.28 MB / 0.7292 GB
Notification: Performance of Templates: time 0.1026/13.22, allocations: 71.5 MB / 4.18 GB, free: 10.48 MB / 0.7292 GB
make -j1 -f IDEAS_dev_IDEAS.Airflow.AHU.Validation.IehSummer.makefile
(rm -f IDEAS_dev_IDEAS.Airflow.AHU.Validation.IehSummer.pipe ; mkfifo IDEAS_dev_IDEAS.Airflow.AHU.Validation.IehSummer.pipe ; head -c 1048576 < IDEAS_dev_IDEAS.Airflow.AHU.Validation.IehSummer.pipe >> ../files/IDEAS_dev_IDEAS.Airflow.AHU.Validation.IehSummer.sim & ./IDEAS_dev_IDEAS.Airflow.AHU.Validation.IehSummer  -abortSlowSimulation -alarm=480 -lv LOG_STATS > IDEAS_dev_IDEAS.Airflow.AHU.Validation.IehSummer.pipe 2>&1)