Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr IDEAS_dev_IDEAS.Fluid.Examples.Performance.Example1v2.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.Examples.Performance.Example1v2,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.Fluid.Examples.Performance.Example1v2")
translateModel(IDEAS.Fluid.Examples.Performance.Example1v2,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.Fluid.Examples.Performance.Example1v2")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001581/0.001581, allocations: 174.6 kB / 12.73 MB, free: 2.59 MB / 13.93 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0-master/package.mo): time 0.8877/0.8877, allocations: 133.4 MB / 146.7 MB, free: 10.79 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.633/1.633, allocations: 221.3 MB / 400.4 MB, free: 5.789 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.0009749/0.0009749, allocations: 97.7 kB / 483.3 MB, free: 5.82 MB / 394.7 MB
Notification: Performance of FrontEnd - loaded program: time 4.797e-05/4.8e-05, allocations: 3.781 kB / 0.56 GB, free: 87.97 MB / 442.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.193/0.1931, allocations: 82.31 MB / 0.6404 GB, free: 7.824 MB / 442.7 MB
Notification: Performance of FrontEnd - scodeFlatten: time 1.403/1.597, allocations: 381.6 MB / 1.013 GB, free: 239.5 MB / 0.6823 GB
Notification: Performance of FrontEnd - mkProgramGraph: time 0.0002352/1.597, allocations: 89.83 kB / 1.013 GB, free: 239.5 MB / 0.6823 GB
Notification: Performance of FrontEnd - DAE generated: time 9.124/10.72, allocations: 2.323 GB / 3.336 GB, free: 75.71 MB / 0.7292 GB
Notification: Performance of FrontEnd: time 2.314e-06/10.72, allocations: 0 / 3.336 GB, free: 75.71 MB / 0.7292 GB
Notification: Performance of Transformations before backend: time 0.001651/10.72, allocations: 269.1 kB / 3.336 GB, free: 75.65 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: 1418
 * Number of variables: 1418
Notification: Performance of Generate backend data structure: time 0.03108/10.75, allocations: 7.362 MB / 3.344 GB, free: 70.91 MB / 0.7292 GB
Notification: Performance of prepare preOptimizeDAE: time 5.603e-05/10.75, allocations: 10.34 kB / 3.344 GB, free: 70.91 MB / 0.7292 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.009869/10.76, allocations: 1.242 MB / 3.345 GB, free: 70.31 MB / 0.7292 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.03636/10.8, allocations: 12.8 MB / 3.357 GB, free: 59.55 MB / 0.7292 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0005717/10.8, allocations: 443.1 kB / 3.358 GB, free: 59.12 MB / 0.7292 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.003354/10.8, allocations: 0.5894 MB / 3.358 GB, free: 58.53 MB / 0.7292 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.0311/10.84, allocations: 13.45 MB / 3.371 GB, free: 44.82 MB / 0.7292 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0003191/10.84, allocations: 23.78 kB / 3.371 GB, free: 44.79 MB / 0.7292 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.003137/10.84, allocations: 244 kB / 3.372 GB, free: 44.55 MB / 0.7292 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001008/10.84, allocations: 140 kB / 3.372 GB, free: 44.42 MB / 0.7292 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.02866/10.87, allocations: 18.07 MB / 3.389 GB, free: 26.33 MB / 0.7292 GB
Warning: The model contains alias variables with conflicting start and/or 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.7861/11.65, allocations: 55.4 MB / 3.444 GB, free: 67.67 MB / 0.7292 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.01862/11.67, allocations: 8.692 MB / 3.452 GB, free: 67.57 MB / 0.7292 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.01408/11.69, allocations: 9.263 MB / 3.461 GB, free: 67.32 MB / 0.7292 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.05909/11.75, allocations: 26.3 MB / 3.487 GB, free: 60.44 MB / 0.7292 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.01405/11.76, allocations: 7.315 MB / 3.494 GB, free: 60.33 MB / 0.7292 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.05173/11.81, allocations: 21.19 MB / 3.515 GB, free: 59.57 MB / 0.7292 GB
Notification: Performance of pre-optimization done (n=301): time 4.27e-05/11.81, allocations: 0 / 3.515 GB, free: 59.57 MB / 0.7292 GB
Notification: Performance of matching and sorting (n=301): time 0.03536/11.85, allocations: 14.49 MB / 3.529 GB, free: 59.12 MB / 0.7292 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 6.306e-05/11.85, allocations: 83.41 kB / 3.529 GB, free: 59.05 MB / 0.7292 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.01591/11.86, allocations: 7.51 MB / 3.536 GB, free: 58.57 MB / 0.7292 GB
Notification: Performance of collectPreVariables (initialization): time 0.002779/11.87, allocations: 101.5 kB / 3.536 GB, free: 58.54 MB / 0.7292 GB
Notification: Performance of collectInitialEqns (initialization): time 0.005163/11.87, allocations: 4.045 MB / 3.54 GB, free: 57.66 MB / 0.7292 GB
Notification: Performance of collectInitialBindings (initialization): time 0.003672/11.87, allocations: 1.084 MB / 3.541 GB, free: 57.14 MB / 0.7292 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.001103/11.88, allocations: 90.53 kB / 3.541 GB, free: 57.14 MB / 0.7292 GB
Notification: Performance of setup shared object (initialization): time 0.0003675/11.88, allocations: 495 kB / 3.542 GB, free: 56.82 MB / 0.7292 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.008948/11.89, allocations: 6.081 MB / 3.548 GB, free: 56.8 MB / 0.7292 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.01135/11.9, allocations: 7.88 MB / 3.555 GB, free: 54.56 MB / 0.7292 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.01208/11.91, allocations: 6.993 MB / 3.562 GB, free: 54.38 MB / 0.7292 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0001107/11.91, allocations: 20.02 kB / 3.562 GB, free: 54.38 MB / 0.7292 GB
Notification: Performance of matching and sorting (n=578) (initialization): time 0.03613/11.95, allocations: 16.36 MB / 3.578 GB, free: 50.66 MB / 0.7292 GB
Notification: Performance of prepare postOptimizeDAE: time 0.007322/11.95, allocations: 25.42 MB / 3.603 GB, free: 39.67 MB / 0.7448 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001767/11.95, allocations: 50.88 kB / 3.603 GB, free: 39.67 MB / 0.7448 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.06263/12.02, allocations: 10.89 MB / 3.614 GB, free: 38.61 MB / 0.7448 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0106/12.03, allocations: 1.603 MB / 3.615 GB, free: 38.57 MB / 0.7448 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.009477/12.04, allocations: 6.313 MB / 3.622 GB, free: 34.84 MB / 0.7448 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01434/12.05, allocations: 0.6088 MB / 3.622 GB, free: 34.68 MB / 0.7448 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.003328/12.05, allocations: 0.5467 MB / 3.623 GB, free: 34.64 MB / 0.7448 GB
Notification: Performance of prepare postOptimizeDAE: time 1.596e-05/12.05, allocations: 3.812 kB / 3.623 GB, free: 34.64 MB / 0.7448 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.0321/12.09, allocations: 15.7 MB / 3.638 GB, free: 29.04 MB / 0.7448 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0002057/12.09, allocations: 46.72 kB / 3.638 GB, free: 29.04 MB / 0.7448 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.06282/12.15, allocations: 10.63 MB / 3.648 GB, free: 27.11 MB / 0.7448 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.009452/12.16, allocations: 1.597 MB / 3.65 GB, free: 26.12 MB / 0.7448 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01406/12.17, allocations: 10.19 MB / 3.66 GB, free: 16.84 MB / 0.7448 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01449/12.19, allocations: 0.5732 MB / 3.66 GB, free: 16.43 MB / 0.7448 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.003261/12.19, allocations: 0.5373 MB / 3.661 GB, free: 16.11 MB / 0.7448 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 215
 * Number of states: 0 ()
 * Number of discrete variables: 7 ($whenCondition1,$PRE.pulse.T_start,pulse.T_start,$PRE.pulse.count,pulse.count,from_dp.y,allowFlowReversal.y)
 * Number of discrete states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (526):
 * Single equations (assignments): 520
 * Array equations: 1
 * Algorithm blocks: 1
 * 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: 1 {(1,100.0%) 1}
 * Non-linear torn systems: 3 {1 3,2 5,20 21}
Notification: Performance of prepare postOptimizeDAE: time 0.004492/12.19, allocations: 412.8 kB / 3.661 GB, free: 15.8 MB / 0.7448 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.004984/12.2, allocations: 0.7679 MB / 3.662 GB, free: 15.03 MB / 0.7448 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.02826/12.23, allocations: 13.47 MB / 3.675 GB, free: 3.926 MB / 0.7448 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 4.125e-05/12.23, allocations: 36 kB / 3.675 GB, free: 3.891 MB / 0.7448 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 8.816e-06/12.23, allocations: 0 / 3.675 GB, free: 3.891 MB / 0.7448 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.0189/12.25, allocations: 10.16 MB / 3.685 GB, free: 11.07 MB / 0.7605 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.7139/12.96, allocations: 23.79 MB / 3.708 GB, free: 109.9 MB / 0.7605 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.499e-05/12.96, allocations: 1.281 kB / 3.708 GB, free: 109.9 MB / 0.7605 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.00615/12.97, allocations: 0.7016 MB / 3.709 GB, free: 109.9 MB / 0.7605 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.06641/13.03, allocations: 9.937 MB / 3.719 GB, free: 109.8 MB / 0.7605 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.001835/13.04, allocations: 101.7 kB / 3.719 GB, free: 109.8 MB / 0.7605 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.00623/13.04, allocations: 4.304 MB / 3.723 GB, free: 107.1 MB / 0.7605 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 4.989e-06/13.04, allocations: 1.312 kB / 3.723 GB, free: 107.1 MB / 0.7605 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.03371/13.08, allocations: 18.22 MB / 3.741 GB, free: 106.6 MB / 0.7605 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.008866/13.08, allocations: 2.011 MB / 3.743 GB, free: 106.2 MB / 0.7605 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.004533/13.09, allocations: 77.05 kB / 3.743 GB, free: 106.2 MB / 0.7605 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.01072/13.1, allocations: 419.6 kB / 3.743 GB, free: 106.2 MB / 0.7605 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.001759/13.1, allocations: 215 kB / 3.744 GB, free: 106.2 MB / 0.7605 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0009063/13.1, allocations: 161 kB / 3.744 GB, free: 106.2 MB / 0.7605 GB
Notification: Performance of sorting global known variables: time 0.01556/13.12, allocations: 5.824 MB / 3.749 GB, free: 105.9 MB / 0.7605 GB
Notification: Performance of sort global known variables: time 1.884e-06/13.12, allocations: 0 / 3.749 GB, free: 105.9 MB / 0.7605 GB
Notification: Performance of remove unused functions: time 0.02803/13.15, allocations: 4.933 MB / 3.754 GB, free: 105.7 MB / 0.7605 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 3
 * Number of states: 22 (pump.vol.dynBal.U,hea.outCon.T,vol[1].dynBal.U,vol[2].dynBal.U,vol[3].dynBal.U,vol[4].dynBal.U,vol[5].dynBal.U,vol[6].dynBal.U,vol[7].dynBal.U,vol[8].dynBal.U,vol[9].dynBal.U,vol[10].dynBal.U,vol[11].dynBal.U,vol[12].dynBal.U,vol[13].dynBal.U,vol[14].dynBal.U,vol[15].dynBal.U,vol[16].dynBal.U,vol[17].dynBal.U,vol[18].dynBal.U,vol[19].dynBal.U,vol[20].dynBal.U)
 * Number of discrete variables: 3 ($whenCondition1,pulse.T_start,pulse.count)
 * Number of discrete states: 1 (pulse.count)
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (305):
 * Single equations (assignments): 295
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 4
 * When equations: 2
 * 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: 1 {(1,100.0%) 1}
 * Non-linear torn systems: 3 {1 3,20 21,2 5}
Notification: Performance of Backend phase and start with SimCode phase: time 0.004016/13.15, allocations: 1.284 MB / 3.756 GB, free: 105.5 MB / 0.7605 GB
Notification: Performance of simCode: created initialization part: time 0.04196/13.19, allocations: 23.51 MB / 3.778 GB, free: 104.7 MB / 0.7605 GB
Notification: Performance of simCode: created event and clocks part: time 1.402e-05/13.19, allocations: 3 kB / 3.778 GB, free: 104.7 MB / 0.7605 GB
Notification: Performance of simCode: created simulation system equations: time 0.01129/13.2, allocations: 6.088 MB / 3.784 GB, free: 104.6 MB / 0.7605 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.02827/13.23, allocations: 4.597 MB / 3.789 GB, free: 104.5 MB / 0.7605 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.04512/13.28, allocations: 17.25 MB / 3.806 GB, free: 101.7 MB / 0.7605 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.006551/13.28, allocations: 5.427 MB / 3.811 GB, free: 100.8 MB / 0.7605 GB
Notification: Performance of simCode: alias equations: time 0.03211/13.32, allocations: 7.982 MB / 3.819 GB, free: 99.55 MB / 0.7605 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.006404/13.32, allocations: 0.7713 MB / 3.82 GB, free: 99.55 MB / 0.7605 GB
Notification: Performance of SimCode: time 2.485e-06/13.32, allocations: 0 / 3.82 GB, free: 99.55 MB / 0.7605 GB
Notification: Performance of Templates: time 1.002/14.32, allocations: 227.7 MB / 4.042 GB, free: 99.75 MB / 0.7605 GB
make -j1 -f IDEAS_dev_IDEAS.Fluid.Examples.Performance.Example1v2.makefile
(rm -f IDEAS_dev_IDEAS.Fluid.Examples.Performance.Example1v2.pipe ; mkfifo IDEAS_dev_IDEAS.Fluid.Examples.Performance.Example1v2.pipe ; head -c 1048576 < IDEAS_dev_IDEAS.Fluid.Examples.Performance.Example1v2.pipe >> ../files/IDEAS_dev_IDEAS.Fluid.Examples.Performance.Example1v2.sim & ./IDEAS_dev_IDEAS.Fluid.Examples.Performance.Example1v2  -abortSlowSimulation -alarm=480 -lv LOG_STATS > IDEAS_dev_IDEAS.Fluid.Examples.Performance.Example1v2.pipe 2>&1)