Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr IDEAS_IDEAS.Fluid.MixingVolumes.Validation.MixingVolumeHeatReverseFlowPrescribedHeatFlowRate.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/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/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.Fluid.MixingVolumes.Validation.MixingVolumeHeatReverseFlowPrescribedHeatFlowRate,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IDEAS_IDEAS.Fluid.MixingVolumes.Validation.MixingVolumeHeatReverseFlowPrescribedHeatFlowRate")
translateModel(IDEAS.Fluid.MixingVolumes.Validation.MixingVolumeHeatReverseFlowPrescribedHeatFlowRate,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IDEAS_IDEAS.Fluid.MixingVolumes.Validation.MixingVolumeHeatReverseFlowPrescribedHeatFlowRate")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001068/0.001068, allocations: 182.1 kB / 15.98 MB, free: 5.77 MB / 13.93 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0/package.mo): time 0.6884/0.6884, allocations: 132.2 MB / 148.9 MB, free: 12.15 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.392/1.392, allocations: 222.9 MB / 403.3 MB, free: 7.113 MB / 314.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.00118/0.00118, allocations: 99.73 kB / 484.3 MB, free: 8.711 MB / 394.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.00101/0.00101, allocations: 51.91 kB / 0.5618 GB, free: 71.06 MB / 426.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1397/0.1407, allocations: 80.21 MB / 0.6402 GB, free: 6.785 MB / 442.7 MB
Notification: Performance of NFInst.instantiate(IDEAS.Fluid.MixingVolumes.Validation.MixingVolumeHeatReverseFlowPrescribedHeatFlowRate): time 0.5322/0.6729, allocations: 188.3 MB / 0.8241 GB, free: 6.82 MB / 0.5573 GB
Notification: Performance of NFInst.instExpressions: time 0.009696/0.6827, allocations: 5.776 MB / 0.8297 GB, free: 1.035 MB / 0.5573 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001424/0.6841, allocations: 35.75 kB / 0.8298 GB, free: 1 MB / 0.5573 GB
Notification: Performance of NFTyping.typeComponents: time 0.001534/0.6857, allocations: 0.5014 MB / 0.8302 GB, free: 0.4961 MB / 0.5573 GB
Notification: Performance of NFTyping.typeBindings: time 0.003637/0.6894, allocations: 1.533 MB / 0.8317 GB, free: 14.96 MB / 0.573 GB
Notification: Performance of NFTyping.typeClassSections: time 0.00274/0.6921, allocations: 1.08 MB / 0.8328 GB, free: 13.89 MB / 0.573 GB
Notification: Performance of NFFlatten.flatten: time 0.003483/0.6956, allocations: 3.552 MB / 0.8363 GB, free: 10.33 MB / 0.573 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.0008992/0.6965, allocations: 0.7443 MB / 0.837 GB, free: 9.566 MB / 0.573 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.00142/0.698, allocations: 0.9219 MB / 0.8379 GB, free: 8.641 MB / 0.573 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.001581/0.6996, allocations: 0.8444 MB / 0.8387 GB, free: 7.797 MB / 0.573 GB
Notification: Performance of NFPackage.collectConstants: time 0.0001252/0.6997, allocations: 52 kB / 0.8388 GB, free: 7.746 MB / 0.573 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.002699/0.7024, allocations: 1.726 MB / 0.8405 GB, free: 6.016 MB / 0.573 GB
Notification: Performance of NFScalarize.scalarize: time 0.0003573/0.7028, allocations: 358.9 kB / 0.8408 GB, free: 5.664 MB / 0.573 GB
Notification: Performance of NFVerifyModel.verify: time 0.0005468/0.7033, allocations: 0.5442 MB / 0.8413 GB, free: 5.117 MB / 0.573 GB
Notification: Performance of NFConvertDAE.convert: time 0.002232/0.7056, allocations: 2.045 MB / 0.8433 GB, free: 3.066 MB / 0.573 GB
Notification: Performance of FrontEnd - DAE generated: time 6.232e-06/0.7056, allocations: 3.984 kB / 0.8433 GB, free: 3.062 MB / 0.573 GB
Notification: Performance of FrontEnd: time 8.42e-07/0.7056, allocations: 0 / 0.8433 GB, free: 3.062 MB / 0.573 GB
Notification: Performance of Transformations before backend: time 1.439e-05/0.7056, allocations: 0 / 0.8433 GB, free: 3.062 MB / 0.573 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 187
 * Number of variables: 187
Notification: Performance of Generate backend data structure: time 0.002244/0.7079, allocations: 1.437 MB / 0.8447 GB, free: 1.574 MB / 0.573 GB
Notification: Performance of prepare preOptimizeDAE: time 3.495e-05/0.7079, allocations: 12.03 kB / 0.8447 GB, free: 1.562 MB / 0.573 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.002491/0.7104, allocations: 410.3 kB / 0.8451 GB, free: 1.16 MB / 0.573 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.001342/0.7118, allocations: 0.7648 MB / 0.8459 GB, free: 356 kB / 0.573 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.000349/0.7121, allocations: 121.9 kB / 0.846 GB, free: 236 kB / 0.573 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001232/0.7123, allocations: 75.94 kB / 0.8461 GB, free: 160 kB / 0.573 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.001837/0.7141, allocations: 0.9945 MB / 0.847 GB, free: 15.14 MB / 0.5886 GB
Notification: Performance of preOpt findStateOrder (simulation): time 2.134e-05/0.7141, allocations: 3.938 kB / 0.847 GB, free: 15.14 MB / 0.5886 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 8.127e-05/0.7142, allocations: 32 kB / 0.8471 GB, free: 15.11 MB / 0.5886 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 4.425e-05/0.7143, allocations: 26 kB / 0.8471 GB, free: 15.08 MB / 0.5886 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.001965/0.7162, allocations: 0.8822 MB / 0.848 GB, free: 14.2 MB / 0.5886 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.005955/0.7222, allocations: 3.501 MB / 0.8514 GB, free: 10.51 MB / 0.5886 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.001741/0.724, allocations: 0.6139 MB / 0.852 GB, free: 9.891 MB / 0.5886 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0008617/0.7248, allocations: 341.3 kB / 0.8523 GB, free: 9.555 MB / 0.5886 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0001947/0.725, allocations: 101.7 kB / 0.8524 GB, free: 9.438 MB / 0.5886 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.196e-05/0.7251, allocations: 46.44 kB / 0.8524 GB, free: 9.383 MB / 0.5886 GB
Notification: Performance of pre-optimization done (n=39): time 2.234e-06/0.7251, allocations: 0 / 0.8524 GB, free: 9.383 MB / 0.5886 GB
Notification: Performance of matching and sorting (n=41): time 0.008955/0.7341, allocations: 2.408 MB / 0.8548 GB, free: 6.895 MB / 0.5886 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 4.173e-05/0.7341, allocations: 59.41 kB / 0.8549 GB, free: 6.824 MB / 0.5886 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001134/0.7353, allocations: 0.7941 MB / 0.8556 GB, free: 6.023 MB / 0.5886 GB
Notification: Performance of collectPreVariables (initialization): time 5.829e-05/0.7353, allocations: 33.7 kB / 0.8557 GB, free: 5.984 MB / 0.5886 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0003606/0.7357, allocations: 451.6 kB / 0.8561 GB, free: 5.535 MB / 0.5886 GB
Notification: Performance of collectInitialBindings (initialization): time 0.000152/0.7359, allocations: 149.9 kB / 0.8562 GB, free: 5.387 MB / 0.5886 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0002243/0.7361, allocations: 102.2 kB / 0.8563 GB, free: 5.281 MB / 0.5886 GB
Notification: Performance of setup shared object (initialization): time 0.0001261/0.7362, allocations: 333.9 kB / 0.8567 GB, free: 4.949 MB / 0.5886 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001022/0.7373, allocations: 304.9 kB / 0.8569 GB, free: 4.652 MB / 0.5886 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0008913/0.7382, allocations: 425.8 kB / 0.8573 GB, free: 4.195 MB / 0.5886 GB
Warning: It was not possible to determine if the initialization problem is consistent, because of not evaluable parameters/start values during compile time: volDyn.dynBal.medium.p = volDyn.dynBal.p_start (bou.p = volDyn.dynBal.p_start)
Notification: Performance of analyzeInitialSystem (initialization): time 0.00543/0.7436, allocations: 1.894 MB / 0.8592 GB, free: 2.25 MB / 0.5886 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 2.335e-06/0.7436, allocations: 0 / 0.8592 GB, free: 2.25 MB / 0.5886 GB
Notification: Performance of matching and sorting (n=63) (initialization): time 0.003286/0.7469, allocations: 1.046 MB / 0.8602 GB, free: 1.191 MB / 0.5886 GB
Notification: Performance of prepare postOptimizeDAE: time 2.027e-05/0.7469, allocations: 8.094 kB / 0.8602 GB, free: 1.184 MB / 0.5886 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 9.968e-06/0.747, allocations: 4 kB / 0.8602 GB, free: 1.18 MB / 0.5886 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.00061/0.7476, allocations: 184.6 kB / 0.8604 GB, free: 0.9961 MB / 0.5886 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0007009/0.7483, allocations: 147.8 kB / 0.8605 GB, free: 0.8516 MB / 0.5886 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.003801/0.7521, allocations: 2.086 MB / 0.8626 GB, free: 14.64 MB / 0.6042 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0009955/0.7531, allocations: 83.89 kB / 0.8627 GB, free: 14.55 MB / 0.6042 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 5.364e-05/0.7532, allocations: 23.98 kB / 0.8627 GB, free: 14.53 MB / 0.6042 GB
Warning: The initial conditions are over specified. The following 1 initial equations are redundant, so they are removed from the initialization system:
         volDyn.dynBal.medium.p = volDyn.dynBal.p_start.
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 12
 * 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 (59):
 * Single equations (assignments): 58
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 1
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 0 systems
 * Non-linear torn systems (#iteration vars, #inner vars): 1 system
   {(1,4)}
Notification: Performance of prepare postOptimizeDAE: time 0.0004065/0.7536, allocations: 273.6 kB / 0.8629 GB, free: 14.25 MB / 0.6042 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0001418/0.7537, allocations: 90.91 kB / 0.863 GB, free: 14.16 MB / 0.6042 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.0001881/0.7539, allocations: 100.2 kB / 0.8631 GB, free: 14.07 MB / 0.6042 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 3.707e-06/0.7539, allocations: 8 kB / 0.8631 GB, free: 14.06 MB / 0.6042 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 3.606e-06/0.7539, allocations: 192 / 0.8631 GB, free: 14.06 MB / 0.6042 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.002921/0.7569, allocations: 0.9027 MB / 0.864 GB, free: 13.12 MB / 0.6042 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.005256/0.7621, allocations: 2.11 MB / 0.8661 GB, free: 10.91 MB / 0.6042 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 5.34e-06/0.7622, allocations: 12.03 kB / 0.8661 GB, free: 10.9 MB / 0.6042 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0006606/0.7628, allocations: 131.8 kB / 0.8662 GB, free: 10.77 MB / 0.6042 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.000558/0.7634, allocations: 192.6 kB / 0.8664 GB, free: 10.58 MB / 0.6042 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 3.857e-05/0.7635, allocations: 12 kB / 0.8664 GB, free: 10.57 MB / 0.6042 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.003432/0.7669, allocations: 2.038 MB / 0.8684 GB, free: 8.391 MB / 0.6042 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 4.398e-06/0.7669, allocations: 4 kB / 0.8684 GB, free: 8.387 MB / 0.6042 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.008698/0.7756, allocations: 4.522 MB / 0.8728 GB, free: 3.68 MB / 0.6042 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0003959/0.776, allocations: 240 kB / 0.8731 GB, free: 3.426 MB / 0.6042 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 9.55e-05/0.7761, allocations: 8 kB / 0.8731 GB, free: 3.418 MB / 0.6042 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0009133/0.7771, allocations: 97.69 kB / 0.8732 GB, free: 3.324 MB / 0.6042 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 9.881e-05/0.7772, allocations: 35.84 kB / 0.8732 GB, free: 3.289 MB / 0.6042 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 7.073e-05/0.7772, allocations: 35.97 kB / 0.8732 GB, free: 3.254 MB / 0.6042 GB
Notification: Performance of sorting global known variables: time 0.0006902/0.7779, allocations: 0.5537 MB / 0.8738 GB, free: 2.703 MB / 0.6042 GB
Notification: Performance of sort global known variables: time 1.8e-07/0.7779, allocations: 3.938 kB / 0.8738 GB, free: 2.699 MB / 0.6042 GB
Notification: Performance of remove unused functions: time 0.001171/0.7791, allocations: 399.9 kB / 0.8741 GB, free: 2.309 MB / 0.6042 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 14
 * Number of states: 2 (volDyn.dynBal.U,volDyn.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 (37):
 * Single equations (assignments): 36
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 1
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 0 systems
 * Non-linear torn systems (#iteration vars, #inner vars): 1 system
   {(1,4)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.0004676/0.7796, allocations: 202 kB / 0.8743 GB, free: 2.109 MB / 0.6042 GB
Notification: Performance of simCode: created initialization part: time 0.002139/0.7817, allocations: 0.8064 MB / 0.8751 GB, free: 1.293 MB / 0.6042 GB
Notification: Performance of simCode: created event and clocks part: time 5.781e-06/0.7818, allocations: 4.062 kB / 0.8751 GB, free: 1.289 MB / 0.6042 GB
Notification: Performance of simCode: created simulation system equations: time 0.001003/0.7828, allocations: 455 kB / 0.8756 GB, free: 0.832 MB / 0.6042 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.00244/0.7852, allocations: 0.5327 MB / 0.8761 GB, free: 320 kB / 0.6042 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.004668/0.7899, allocations: 2.544 MB / 0.8786 GB, free: 13.69 MB / 0.6198 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0006482/0.7906, allocations: 1.056 MB / 0.8796 GB, free: 12.61 MB / 0.6198 GB
Notification: Performance of simCode: alias equations: time 0.0007977/0.7914, allocations: 203.2 kB / 0.8798 GB, free: 12.4 MB / 0.6198 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0002245/0.7916, allocations: 67.42 kB / 0.8799 GB, free: 12.34 MB / 0.6198 GB
Notification: Performance of SimCode: time 3.3e-07/0.7916, allocations: 0 / 0.8799 GB, free: 12.34 MB / 0.6198 GB
Notification: Performance of Templates: time 0.03228/0.8239, allocations: 20.92 MB / 0.9003 GB, free: 7.617 MB / 0.6355 GB
make -j1 -f IDEAS_IDEAS.Fluid.MixingVolumes.Validation.MixingVolumeHeatReverseFlowPrescribedHeatFlowRate.makefile
(rm -f IDEAS_IDEAS.Fluid.MixingVolumes.Validation.MixingVolumeHeatReverseFlowPrescribedHeatFlowRate.pipe ; mkfifo IDEAS_IDEAS.Fluid.MixingVolumes.Validation.MixingVolumeHeatReverseFlowPrescribedHeatFlowRate.pipe ; head -c 1048576 < IDEAS_IDEAS.Fluid.MixingVolumes.Validation.MixingVolumeHeatReverseFlowPrescribedHeatFlowRate.pipe >> ../files/IDEAS_IDEAS.Fluid.MixingVolumes.Validation.MixingVolumeHeatReverseFlowPrescribedHeatFlowRate.sim & ./IDEAS_IDEAS.Fluid.MixingVolumes.Validation.MixingVolumeHeatReverseFlowPrescribedHeatFlowRate  -abortSlowSimulation -alarm=480 -lv LOG_STATS > IDEAS_IDEAS.Fluid.MixingVolumes.Validation.MixingVolumeHeatReverseFlowPrescribedHeatFlowRate.pipe 2>&1)