Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IDEAS_dev_IDEAS.Fluid.Movers.Validation.FlowControlled_m_flow.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo", uses=false)
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/Modelica 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)
Using package IDEAS with version 3.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0-master/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 Complex with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo)
Using package ModelicaServices with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo)
Running command: translateModel(IDEAS.Fluid.Movers.Validation.FlowControlled_m_flow,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.Fluid.Movers.Validation.FlowControlled_m_flow")
translateModel(IDEAS.Fluid.Movers.Validation.FlowControlled_m_flow,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.Fluid.Movers.Validation.FlowControlled_m_flow")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001185/0.001185, allocations: 114.3 kB / 16.42 MB, free: 6.504 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001145/0.001145, allocations: 185.5 kB / 17.34 MB, free: 5.758 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.315/1.315, allocations: 222.9 MB / 241 MB, free: 15.2 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0-master/package.mo): time 0.7956/0.7956, allocations: 135.1 MB / 426.3 MB, free: 4.113 MB / 334.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.001432/0.001432, allocations: 66.47 kB / 0.5863 GB, free: 21.67 MB / 446.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.142/0.1434, allocations: 80.91 MB / 0.6653 GB, free: 5.785 MB / 0.4981 GB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/Blocks/Math.mo:543:5-544:48:writable] Warning: Parameter floMacSta.gaiSpe.k has no value, and is fixed during initialization (fixed=true), using available start value (start=1) as default value.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/Blocks/Math.mo:543:5-544:48:writable] Warning: Parameter floMacDyn.gaiSpe.k has no value, and is fixed during initialization (fixed=true), using available start value (start=1) as default value.
Notification: Performance of NFInst.instantiate(IDEAS.Fluid.Movers.Validation.FlowControlled_m_flow): time 0.6427/0.7861, allocations: 323.5 MB / 0.9812 GB, free: 11.29 MB / 0.7481 GB
Notification: Performance of NFInst.instExpressions: time 0.0278/0.814, allocations: 20.19 MB / 1.001 GB, free: 7.035 MB / 0.7637 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.003258/0.8173, allocations: 91.5 kB / 1.001 GB, free: 6.945 MB / 0.7637 GB
Notification: Performance of NFTyping.typeComponents: time 0.00473/0.822, allocations: 1.554 MB / 1.003 GB, free: 5.383 MB / 0.7637 GB
Notification: Performance of NFTyping.typeBindings: time 0.01114/0.8332, allocations: 4.374 MB / 1.007 GB, free: 0.9961 MB / 0.7637 GB
Notification: Performance of NFTyping.typeClassSections: time 0.005875/0.8391, allocations: 2.354 MB / 1.009 GB, free: 14.66 MB / 0.7794 GB
Notification: Performance of NFFlatten.flatten: time 0.008328/0.8474, allocations: 5.945 MB / 1.015 GB, free: 8.699 MB / 0.7794 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.003646/0.8511, allocations: 2.155 MB / 1.017 GB, free: 6.496 MB / 0.7794 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.007067/0.8582, allocations: 3.324 MB / 1.02 GB, free: 3.16 MB / 0.7794 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.00344/0.8617, allocations: 1.713 MB / 1.022 GB, free: 1.445 MB / 0.7794 GB
Notification: Performance of NFPackage.collectConstants: time 0.0007194/0.8624, allocations: 216 kB / 1.022 GB, free: 1.234 MB / 0.7794 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.007425/0.8698, allocations: 3.691 MB / 1.026 GB, free: 13.54 MB / 0.795 GB
Notification: Performance of NFScalarize.scalarize: time 0.001266/0.8711, allocations: 0.8803 MB / 1.027 GB, free: 12.65 MB / 0.795 GB
Notification: Performance of NFVerifyModel.verify: time 0.002575/0.8737, allocations: 1.326 MB / 1.028 GB, free: 11.32 MB / 0.795 GB
Notification: Performance of NFConvertDAE.convert: time 0.008936/0.8827, allocations: 4.769 MB / 1.033 GB, free: 6.535 MB / 0.795 GB
Notification: Performance of FrontEnd - DAE generated: time 6.172e-06/0.8827, allocations: 3.938 kB / 1.033 GB, free: 6.531 MB / 0.795 GB
Notification: Performance of FrontEnd: time 1.753e-06/0.8827, allocations: 0 / 1.033 GB, free: 6.531 MB / 0.795 GB
Notification: Performance of Transformations before backend: time 0.0001347/0.8828, allocations: 0 / 1.033 GB, free: 6.531 MB / 0.795 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 341
 * Number of variables: 341
Notification: Performance of Generate backend data structure: time 0.007089/0.8899, allocations: 3.056 MB / 1.036 GB, free: 3.406 MB / 0.795 GB
Notification: Performance of prepare preOptimizeDAE: time 4.379e-05/0.89, allocations: 9.109 kB / 1.036 GB, free: 3.398 MB / 0.795 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.005858/0.8959, allocations: 0.8529 MB / 1.036 GB, free: 2.543 MB / 0.795 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.004455/0.9003, allocations: 1.938 MB / 1.038 GB, free: 0.5312 MB / 0.795 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001072/0.9004, allocations: 106.7 kB / 1.038 GB, free: 436 kB / 0.795 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0003696/0.9008, allocations: 155.9 kB / 1.039 GB, free: 280 kB / 0.795 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.003675/0.9045, allocations: 1.657 MB / 1.04 GB, free: 14.55 MB / 0.8106 GB
Notification: Performance of preOpt findStateOrder (simulation): time 3.585e-05/0.9046, allocations: 0 / 1.04 GB, free: 14.55 MB / 0.8106 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001617/0.9047, allocations: 60 kB / 1.04 GB, free: 14.49 MB / 0.8106 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 5.333e-05/0.9048, allocations: 50.56 kB / 1.04 GB, free: 14.44 MB / 0.8106 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.003321/0.9081, allocations: 1.353 MB / 1.042 GB, free: 13.08 MB / 0.8106 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.01108/0.9192, allocations: 7.863 MB / 1.049 GB, free: 4.625 MB / 0.8106 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.001941/0.9212, allocations: 0.9912 MB / 1.05 GB, free: 3.59 MB / 0.8106 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001091/0.9223, allocations: 499.4 kB / 1.051 GB, free: 3.102 MB / 0.8106 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0002092/0.9225, allocations: 105.7 kB / 1.051 GB, free: 2.98 MB / 0.8106 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.633e-05/0.9226, allocations: 47.2 kB / 1.051 GB, free: 2.926 MB / 0.8106 GB
Notification: Performance of pre-optimization done (n=72): time 3.226e-06/0.9226, allocations: 7.938 kB / 1.051 GB, free: 2.918 MB / 0.8106 GB
Notification: Performance of matching and sorting (n=72): time 0.00367/0.9262, allocations: 1.336 MB / 1.052 GB, free: 1.574 MB / 0.8106 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 3.417e-05/0.9263, allocations: 60.06 kB / 1.052 GB, free: 1.504 MB / 0.8106 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.3319/1.258, allocations: 1.798 MB / 1.054 GB, free: 314 MB / 0.8106 GB
Notification: Performance of collectPreVariables (initialization): time 0.0002092/1.258, allocations: 43.33 kB / 1.054 GB, free: 314 MB / 0.8106 GB
Notification: Performance of collectInitialEqns (initialization): time 0.00077/1.259, allocations: 1.003 MB / 1.055 GB, free: 313.9 MB / 0.8106 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0002446/1.26, allocations: 265.5 kB / 1.055 GB, free: 313.8 MB / 0.8106 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0003812/1.26, allocations: 213.4 kB / 1.055 GB, free: 313.8 MB / 0.8106 GB
Notification: Performance of setup shared object (initialization): time 8.205e-05/1.26, allocations: 345.7 kB / 1.056 GB, free: 313.5 MB / 0.8106 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001134/1.261, allocations: 447.7 kB / 1.056 GB, free: 313.5 MB / 0.8106 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001254/1.262, allocations: 0.8357 MB / 1.057 GB, free: 312.9 MB / 0.8106 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.002097/1.264, allocations: 1.198 MB / 1.058 GB, free: 312.3 MB / 0.8106 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 8.255e-06/1.265, allocations: 4.781 kB / 1.058 GB, free: 312.3 MB / 0.8106 GB
Notification: Performance of matching and sorting (n=122) (initialization): time 0.003003/1.268, allocations: 1.421 MB / 1.06 GB, free: 311.7 MB / 0.8106 GB
Notification: Performance of prepare postOptimizeDAE: time 2.876e-05/1.268, allocations: 9.562 kB / 1.06 GB, free: 311.7 MB / 0.8106 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.805e-05/1.268, allocations: 10.88 kB / 1.06 GB, free: 311.7 MB / 0.8106 GB
Notification: Performance of postOpt tearingSystem (initialization): time 2.972e-05/1.268, allocations: 13.69 kB / 1.06 GB, free: 311.7 MB / 0.8106 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001292/1.269, allocations: 271.3 kB / 1.06 GB, free: 311.7 MB / 0.8106 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0002701/1.269, allocations: 0.6125 MB / 1.06 GB, free: 311.1 MB / 0.8106 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001396/1.271, allocations: 145.5 kB / 1.061 GB, free: 311.1 MB / 0.8106 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001065/1.271, allocations: 53.22 kB / 1.061 GB, free: 311 MB / 0.8106 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.001586/1.272, allocations: 0.8117 MB / 1.061 GB, free: 310.7 MB / 0.8106 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.0011/1.273, allocations: 0.7837 MB / 1.062 GB, free: 310.1 MB / 0.8106 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.001893/1.275, allocations: 1.101 MB / 1.063 GB, free: 309.4 MB / 0.8106 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 6.161e-06/1.275, allocations: 4.281 kB / 1.063 GB, free: 309.4 MB / 0.8106 GB
Notification: Performance of matching and sorting (n=122) (initialization_lambda0): time 0.002947/1.278, allocations: 1.306 MB / 1.065 GB, free: 308.9 MB / 0.8106 GB
Notification: Performance of prepare postOptimizeDAE: time 2.109e-05/1.278, allocations: 14.75 kB / 1.065 GB, free: 308.9 MB / 0.8106 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.791e-05/1.278, allocations: 9.844 kB / 1.065 GB, free: 308.9 MB / 0.8106 GB
Notification: Performance of postOpt tearingSystem (initialization): time 2.584e-05/1.278, allocations: 14.78 kB / 1.065 GB, free: 308.9 MB / 0.8106 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001017/1.279, allocations: 242.6 kB / 1.065 GB, free: 308.8 MB / 0.8106 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.015e-05/1.279, allocations: 23.2 kB / 1.065 GB, free: 308.8 MB / 0.8106 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001157/1.281, allocations: 116 kB / 1.065 GB, free: 308.8 MB / 0.8106 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 8.377e-05/1.281, allocations: 48.12 kB / 1.065 GB, free: 308.8 MB / 0.8106 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 42
 * 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 (120):
 * Single equations (assignments): 117
 * Array equations: 2
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 1
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Equation system details (not torn):
 * Constant Jacobian (size): 0 systems
 * Linear Jacobian (size,density): 0 systems
 * Non-linear Jacobian (size): 1 system
   {1}
 * Without analytic Jacobian (size): 0 systems
Notification: Performance of prepare postOptimizeDAE: time 0.0002949/1.281, allocations: 252 kB / 1.065 GB, free: 308.6 MB / 0.8106 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0002271/1.281, allocations: 201.6 kB / 1.065 GB, free: 308.4 MB / 0.8106 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.002655/1.284, allocations: 1.053 MB / 1.066 GB, free: 308.1 MB / 0.8106 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.001839/1.286, allocations: 0.8861 MB / 1.067 GB, free: 307.6 MB / 0.8106 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 3.717e-06/1.286, allocations: 1.625 kB / 1.067 GB, free: 307.6 MB / 0.8106 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0005249/1.286, allocations: 367.5 kB / 1.068 GB, free: 307.4 MB / 0.8106 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0002019/1.287, allocations: 16.42 kB / 1.068 GB, free: 307.4 MB / 0.8106 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0009288/1.287, allocations: 52.88 kB / 1.068 GB, free: 307.4 MB / 0.8106 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001039/1.288, allocations: 54.06 kB / 1.068 GB, free: 307.4 MB / 0.8106 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.002736/1.29, allocations: 1.057 MB / 1.069 GB, free: 307 MB / 0.8106 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.003078/1.293, allocations: 1.699 MB / 1.071 GB, free: 306.2 MB / 0.8106 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.0009592/1.294, allocations: 426 kB / 1.071 GB, free: 306 MB / 0.8106 GB
Notification: Performance of sorting global known variables: time 0.001617/1.296, allocations: 1.221 MB / 1.072 GB, free: 305.5 MB / 0.8106 GB
Notification: Performance of Backend: time 9.22e-07/1.296, allocations: 4.906 kB / 1.072 GB, free: 305.5 MB / 0.8106 GB
Notification: Performance of simCode: created initialization part: time 0.005237/1.301, allocations: 2.049 MB / 1.074 GB, free: 305.1 MB / 0.8106 GB
Notification: Performance of SimCode: time 0.007315/1.309, allocations: 4.671 MB / 1.079 GB, free: 302.7 MB / 0.8106 GB
Notification: Performance of Templates: time 0.05999/1.369, allocations: 48.91 MB / 1.126 GB, free: 263.6 MB / 0.8106 GB
make -j1 -f IDEAS_dev_IDEAS.Fluid.Movers.Validation.FlowControlled_m_flow.makefile
(rm -f IDEAS_dev_IDEAS.Fluid.Movers.Validation.FlowControlled_m_flow.pipe ; mkfifo IDEAS_dev_IDEAS.Fluid.Movers.Validation.FlowControlled_m_flow.pipe ; head -c 1048576 < IDEAS_dev_IDEAS.Fluid.Movers.Validation.FlowControlled_m_flow.pipe >> ../files/IDEAS_dev_IDEAS.Fluid.Movers.Validation.FlowControlled_m_flow.sim & ./IDEAS_dev_IDEAS.Fluid.Movers.Validation.FlowControlled_m_flow  -abortSlowSimulation -alarm=480 -lv LOG_STATS > IDEAS_dev_IDEAS.Fluid.Movers.Validation.FlowControlled_m_flow.pipe 2>&1)