Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr IDEAS_dev_IDEAS.Fluid.Interfaces.Examples.HeaterCooler_u.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.Fluid.Interfaces.Examples.HeaterCooler_u,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.Fluid.Interfaces.Examples.HeaterCooler_u")
translateModel(IDEAS.Fluid.Interfaces.Examples.HeaterCooler_u,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.Fluid.Interfaces.Examples.HeaterCooler_u")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.008069/0.008068, allocations: 172 kB / 15.11 MB, free: 5.969 MB / 13.93 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0-master/package.mo): time 0.772/0.772, allocations: 135.2 MB / 151.1 MB, free: 13.77 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.555/1.555, allocations: 223.2 MB / 406.9 MB, free: 3.113 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.001095/0.001095, allocations: 97.89 kB / 489.9 MB, free: 10.9 MB / 362.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.000397/0.000397, allocations: 8 kB / 0.5691 GB, free: 14.16 MB / 458.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.5123/0.5127, allocations: 82.3 MB / 0.6495 GB, free: 36.16 MB / 458.7 MB
Notification: Performance of FrontEnd - scodeFlatten: time 0.8342/1.347, allocations: 383.8 MB / 1.024 GB, free: 6.465 MB / 0.6667 GB
Notification: Performance of FrontEnd - mkProgramGraph: time 0.0002737/1.347, allocations: 97.83 kB / 1.024 GB, free: 6.414 MB / 0.6667 GB
Notification: Performance of FrontEnd - DAE generated: time 11.41/12.75, allocations: 2.797 GB / 3.821 GB, free: 35.94 MB / 0.823 GB
Notification: Performance of FrontEnd: time 4.037e-06/12.75, allocations: 1.203 kB / 3.821 GB, free: 35.94 MB / 0.823 GB
Notification: Performance of Transformations before backend: time 0.001267/12.75, allocations: 173.9 kB / 3.822 GB, free: 35.89 MB / 0.823 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 1035
 * Number of variables: 1035
Notification: Performance of Generate backend data structure: time 0.03186/12.79, allocations: 7.167 MB / 3.829 GB, free: 32.2 MB / 0.823 GB
Notification: Performance of prepare preOptimizeDAE: time 6.167e-05/12.79, allocations: 11.03 kB / 3.829 GB, free: 32.2 MB / 0.823 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.005902/12.79, allocations: 0.7762 MB / 3.829 GB, free: 31.83 MB / 0.823 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.1322/12.92, allocations: 60.99 MB / 3.889 GB, free: 7.516 MB / 0.8386 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.000554/12.93, allocations: 315 kB / 3.889 GB, free: 7.207 MB / 0.8386 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.00217/12.93, allocations: 427.8 kB / 3.89 GB, free: 6.789 MB / 0.8386 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.01295/12.94, allocations: 4.281 MB / 3.894 GB, free: 2.23 MB / 0.8386 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0001118/12.94, allocations: 11.94 kB / 3.894 GB, free: 2.219 MB / 0.8386 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0005825/12.94, allocations: 172 kB / 3.894 GB, free: 2.051 MB / 0.8386 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001518/12.94, allocations: 119.9 kB / 3.894 GB, free: 1.934 MB / 0.8386 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.8977/13.84, allocations: 2.896 MB / 3.897 GB, free: 42.12 MB / 0.8386 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.04151/13.88, allocations: 24.05 MB / 3.92 GB, free: 28.37 MB / 0.8386 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.003664/13.88, allocations: 2.949 MB / 3.923 GB, free: 27.2 MB / 0.8386 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.002739/13.89, allocations: 3.94 MB / 3.927 GB, free: 22.8 MB / 0.8386 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 9.517e-05/13.89, allocations: 61.62 kB / 3.927 GB, free: 22.76 MB / 0.8386 GB
Notification: Performance of pre-optimization done (n=225): time 4.538e-06/13.89, allocations: 1.562 kB / 3.927 GB, free: 22.76 MB / 0.8386 GB
Notification: Performance of matching and sorting (n=225): time 0.01092/13.9, allocations: 4.098 MB / 3.931 GB, free: 21.98 MB / 0.8386 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 5.007e-05/13.9, allocations: 73.95 kB / 3.931 GB, free: 21.91 MB / 0.8386 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.008473/13.91, allocations: 3.69 MB / 3.935 GB, free: 21.62 MB / 0.8386 GB
Notification: Performance of collectPreVariables (initialization): time 0.0007807/13.91, allocations: 77.83 kB / 3.935 GB, free: 21.59 MB / 0.8386 GB
Notification: Performance of collectInitialEqns (initialization): time 0.002411/13.91, allocations: 2.792 MB / 3.938 GB, free: 20.96 MB / 0.8386 GB
Notification: Performance of collectInitialBindings (initialization): time 0.001267/13.91, allocations: 0.7817 MB / 3.938 GB, free: 20.56 MB / 0.8386 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0001397/13.91, allocations: 52.28 kB / 3.938 GB, free: 20.56 MB / 0.8386 GB
Notification: Performance of setup shared object (initialization): time 0.0001538/13.91, allocations: 413.1 kB / 3.939 GB, free: 20.26 MB / 0.8386 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001443/13.91, allocations: 0.7984 MB / 3.94 GB, free: 20.25 MB / 0.8386 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001981/13.92, allocations: 1.796 MB / 3.941 GB, free: 19.09 MB / 0.8386 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.001641/13.92, allocations: 1.103 MB / 3.942 GB, free: 19.06 MB / 0.8386 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.478e-05/13.92, allocations: 8.406 kB / 3.942 GB, free: 19.06 MB / 0.8386 GB
Notification: Performance of matching and sorting (n=341) (initialization): time 0.006976/13.92, allocations: 3.355 MB / 3.946 GB, free: 18.68 MB / 0.8386 GB
Notification: Performance of prepare postOptimizeDAE: time 0.005344/13.93, allocations: 10.36 MB / 3.956 GB, free: 23.92 MB / 0.8542 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 7.145e-05/13.93, allocations: 24.97 kB / 3.956 GB, free: 23.92 MB / 0.8542 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001176/13.93, allocations: 402.7 kB / 3.956 GB, free: 23.88 MB / 0.8542 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002278/13.93, allocations: 0.5257 MB / 3.957 GB, free: 23.88 MB / 0.8542 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.002487/13.94, allocations: 2.691 MB / 3.959 GB, free: 21.79 MB / 0.8542 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.007293/13.94, allocations: 0.5572 MB / 3.96 GB, free: 21.71 MB / 0.8542 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0008191/13.94, allocations: 130 kB / 3.96 GB, free: 21.71 MB / 0.8542 GB
Notification: Performance of prepare postOptimizeDAE: time 1.631e-05/13.94, allocations: 5.906 kB / 3.96 GB, free: 21.71 MB / 0.8542 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.006095/13.95, allocations: 2.805 MB / 3.963 GB, free: 21.62 MB / 0.8542 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 3.927e-05/13.95, allocations: 27.7 kB / 3.963 GB, free: 21.62 MB / 0.8542 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0009569/13.95, allocations: 375.2 kB / 3.963 GB, free: 21.59 MB / 0.8542 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001901/13.95, allocations: 0.5253 MB / 3.964 GB, free: 21.59 MB / 0.8542 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.009219/13.96, allocations: 7.813 MB / 3.971 GB, free: 15.96 MB / 0.8542 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.006416/13.97, allocations: 0.5072 MB / 3.972 GB, free: 15.9 MB / 0.8542 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0007728/13.97, allocations: 132.6 kB / 3.972 GB, free: 15.9 MB / 0.8542 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 97
 * 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 (299):
 * Single equations (assignments): 295
 * 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: 4
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 0
 * Non-linear torn systems: 4 {1 12,1 9,1 12,1 9}
Notification: Performance of prepare postOptimizeDAE: time 0.004339/13.97, allocations: 0.9934 MB / 3.973 GB, free: 15.71 MB / 0.8542 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.002407/13.98, allocations: 0.5071 MB / 3.973 GB, free: 15.45 MB / 0.8542 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.009967/13.99, allocations: 3.785 MB / 3.977 GB, free: 15.17 MB / 0.8542 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 8.363e-05/13.99, allocations: 38.53 kB / 3.977 GB, free: 15.17 MB / 0.8542 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.756e-05/13.99, allocations: 3.625 kB / 3.977 GB, free: 15.17 MB / 0.8542 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.00509/13.99, allocations: 2.605 MB / 3.98 GB, free: 14.96 MB / 0.8542 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.0276/14.02, allocations: 8.584 MB / 3.988 GB, free: 29.46 MB / 0.8698 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.038e-05/14.02, allocations: 0 / 3.988 GB, free: 29.46 MB / 0.8698 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.001762/14.02, allocations: 386.8 kB / 3.988 GB, free: 29.46 MB / 0.8698 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.0008064/14.02, allocations: 297.1 kB / 3.989 GB, free: 29.43 MB / 0.8698 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0003742/14.02, allocations: 70.31 kB / 3.989 GB, free: 29.43 MB / 0.8698 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.002208/14.02, allocations: 2.494 MB / 3.991 GB, free: 27.34 MB / 0.8698 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 3.527e-06/14.02, allocations: 3.562 kB / 3.991 GB, free: 27.34 MB / 0.8698 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.01093/14.03, allocations: 4.759 MB / 3.996 GB, free: 26.57 MB / 0.8698 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.004855/14.04, allocations: 0.9939 MB / 3.997 GB, free: 26.2 MB / 0.8698 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.002063/14.04, allocations: 47.8 kB / 3.997 GB, free: 26.19 MB / 0.8698 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.00604/14.05, allocations: 450 kB / 3.997 GB, free: 26.17 MB / 0.8698 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0005832/14.05, allocations: 153.8 kB / 3.997 GB, free: 26.17 MB / 0.8698 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0006373/14.05, allocations: 111.1 kB / 3.998 GB, free: 26.17 MB / 0.8698 GB
Notification: Performance of sorting global known variables: time 0.01002/14.06, allocations: 2.818 MB / 4 GB, free: 25.99 MB / 0.8698 GB
Notification: Performance of sort global known variables: time 4.91e-07/14.06, allocations: 0.9062 kB / 4 GB, free: 25.99 MB / 0.8698 GB
Notification: Performance of remove unused functions: time 0.02019/14.08, allocations: 3.592 MB / 4.004 GB, free: 25.62 MB / 0.8698 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 4
 * Number of states: 10 (hea1.vol.dynBal.U,hea2.vol.dynBal.U,hea3.vol.dynBal.U,hea4.vol.dynBal.U,mix1.dynBal.U,hea5.vol.dynBal.U,hea6.vol.dynBal.U,hea7.vol.dynBal.U,hea8.vol.dynBal.U,mix2.dynBal.U)
 * 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 (227):
 * Single equations (assignments): 189
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 34
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 4
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 0
 * Non-linear torn systems: 4 {1 9,1 7,1 9,1 7}
Notification: Performance of Backend phase and start with SimCode phase: time 0.008504/14.09, allocations: 3.428 MB / 4.007 GB, free: 24.37 MB / 0.8698 GB
Notification: Performance of simCode: created initialization part: time 0.01009/14.1, allocations: 4.434 MB / 4.012 GB, free: 23.82 MB / 0.8698 GB
Notification: Performance of simCode: created event and clocks part: time 1.113e-05/14.1, allocations: 0.7188 kB / 4.012 GB, free: 23.82 MB / 0.8698 GB
Notification: Performance of simCode: created simulation system equations: time 0.002909/14.1, allocations: 1.33 MB / 4.013 GB, free: 23.8 MB / 0.8698 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.0162/14.12, allocations: 2.709 MB / 4.015 GB, free: 23.77 MB / 0.8698 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.02764/14.14, allocations: 11.19 MB / 4.026 GB, free: 18.62 MB / 0.8698 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.005035/14.15, allocations: 2.998 MB / 4.029 GB, free: 17.75 MB / 0.8698 GB
Notification: Performance of simCode: alias equations: time 0.007253/14.16, allocations: 1.21 MB / 4.03 GB, free: 17.58 MB / 0.8698 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.001744/14.16, allocations: 419.6 kB / 4.031 GB, free: 17.57 MB / 0.8698 GB
Notification: Performance of SimCode: time 1.142e-06/14.16, allocations: 0 / 4.031 GB, free: 17.57 MB / 0.8698 GB
Notification: Performance of Templates: time 0.2293/14.39, allocations: 119 MB / 4.147 GB, free: 7.797 MB / 0.8698 GB
make -j1 -f IDEAS_dev_IDEAS.Fluid.Interfaces.Examples.HeaterCooler_u.makefile
(rm -f IDEAS_dev_IDEAS.Fluid.Interfaces.Examples.HeaterCooler_u.pipe ; mkfifo IDEAS_dev_IDEAS.Fluid.Interfaces.Examples.HeaterCooler_u.pipe ; head -c 1048576 < IDEAS_dev_IDEAS.Fluid.Interfaces.Examples.HeaterCooler_u.pipe >> ../files/IDEAS_dev_IDEAS.Fluid.Interfaces.Examples.HeaterCooler_u.sim & ./IDEAS_dev_IDEAS.Fluid.Interfaces.Examples.HeaterCooler_u  -abortSlowSimulation -alarm=480 -lv LOG_STATS > IDEAS_dev_IDEAS.Fluid.Interfaces.Examples.HeaterCooler_u.pipe 2>&1)