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.001535/0.001535, allocations: 108 kB / 15.6 MB, free: 132 kB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.002795/0.002795, allocations: 198.3 kB / 16.54 MB, free: 6.672 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.459/1.459, allocations: 222.9 MB / 240.2 MB, free: 4.398 MB / 190.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0-master/package.mo): time 0.9993/0.9993, allocations: 135.1 MB / 425.5 MB, free: 11.97 MB / 350.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.00142/0.00142, allocations: 56.25 kB / 0.5053 GB, free: 5.324 MB / 414.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.2017/0.2031, allocations: 80.94 MB / 0.5844 GB, free: 4.551 MB / 494.1 MB
Notification: Performance of NFInst.instantiate(IDEAS.Fluid.Movers.Validation.FlowControlled_m_flow): time 1.093/1.297, allocations: 323.4 MB / 0.9002 GB, free: 32.95 MB / 0.67 GB
Notification: Performance of NFInst.instExpressions: time 0.03149/1.328, allocations: 20.2 MB / 0.92 GB, free: 32.8 MB / 0.67 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.004837/1.333, allocations: 93.03 kB / 0.92 GB, free: 32.8 MB / 0.67 GB
Notification: Performance of NFTyping.typeComponents: time 0.004383/1.337, allocations: 1.509 MB / 0.9215 GB, free: 32.77 MB / 0.67 GB
Notification: Performance of NFTyping.typeBindings: time 0.01223/1.35, allocations: 4.221 MB / 0.9256 GB, free: 32.61 MB / 0.67 GB
Notification: Performance of NFTyping.typeClassSections: time 0.007452/1.357, allocations: 2.336 MB / 0.9279 GB, free: 32.56 MB / 0.67 GB
Notification: Performance of NFFlatten.flatten: time 0.01091/1.368, allocations: 5.934 MB / 0.9337 GB, free: 32.55 MB / 0.67 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.004053/1.372, allocations: 2.16 MB / 0.9358 GB, free: 32.29 MB / 0.67 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.007541/1.38, allocations: 3.211 MB / 0.939 GB, free: 32.23 MB / 0.67 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.003746/1.383, allocations: 1.717 MB / 0.9406 GB, free: 31.96 MB / 0.67 GB
Notification: Performance of NFPackage.collectConstants: time 0.000798/1.384, allocations: 218.9 kB / 0.9409 GB, free: 31.96 MB / 0.67 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.007845/1.392, allocations: 3.679 MB / 0.9444 GB, free: 31.93 MB / 0.67 GB
Notification: Performance of NFScalarize.scalarize: time 0.001383/1.394, allocations: 0.8671 MB / 0.9453 GB, free: 31.83 MB / 0.67 GB
Notification: Performance of NFVerifyModel.verify: time 0.003021/1.397, allocations: 1.329 MB / 0.9466 GB, free: 31.45 MB / 0.67 GB
Notification: Performance of NFConvertDAE.convert: time 0.009023/1.406, allocations: 4.694 MB / 0.9512 GB, free: 29.87 MB / 0.67 GB
Notification: Performance of FrontEnd - DAE generated: time 4.448e-06/1.406, allocations: 4.625 kB / 0.9512 GB, free: 29.87 MB / 0.67 GB
Notification: Performance of FrontEnd: time 1.704e-06/1.406, allocations: 0 / 0.9512 GB, free: 29.87 MB / 0.67 GB
Notification: Performance of Transformations before backend: time 0.0001198/1.406, allocations: 0 / 0.9512 GB, free: 29.87 MB / 0.67 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.006126/1.412, allocations: 2.966 MB / 0.9541 GB, free: 28.12 MB / 0.67 GB
Notification: Performance of prepare preOptimizeDAE: time 3.976e-05/1.412, allocations: 11.61 kB / 0.9541 GB, free: 28.11 MB / 0.67 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.005551/1.418, allocations: 0.8334 MB / 0.9549 GB, free: 27.75 MB / 0.67 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.003569/1.421, allocations: 1.853 MB / 0.9567 GB, free: 26.7 MB / 0.67 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0003794/1.422, allocations: 173.9 kB / 0.9569 GB, free: 26.62 MB / 0.67 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0003123/1.422, allocations: 146 kB / 0.957 GB, free: 26.57 MB / 0.67 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.003127/1.425, allocations: 1.656 MB / 0.9586 GB, free: 25.55 MB / 0.67 GB
Notification: Performance of preOpt findStateOrder (simulation): time 3.227e-05/1.425, allocations: 2.531 kB / 0.9586 GB, free: 25.55 MB / 0.67 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001427/1.425, allocations: 60.5 kB / 0.9587 GB, free: 25.51 MB / 0.67 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 4.957e-05/1.425, allocations: 47.58 kB / 0.9587 GB, free: 25.51 MB / 0.67 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.003147/1.428, allocations: 1.366 MB / 0.9601 GB, free: 24.84 MB / 0.67 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.01047/1.439, allocations: 7.914 MB / 0.9678 GB, free: 18.07 MB / 0.67 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.001893/1.441, allocations: 1.007 MB / 0.9688 GB, free: 17.43 MB / 0.67 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001053/1.442, allocations: 493.4 kB / 0.9693 GB, free: 17.2 MB / 0.67 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.000188/1.442, allocations: 110.4 kB / 0.9694 GB, free: 17.1 MB / 0.67 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 4.683e-05/1.442, allocations: 50.02 kB / 0.9694 GB, free: 17.04 MB / 0.67 GB
Notification: Performance of pre-optimization done (n=72): time 3.286e-06/1.442, allocations: 7.938 kB / 0.9694 GB, free: 17.03 MB / 0.67 GB
Notification: Performance of matching and sorting (n=72): time 0.003642/1.446, allocations: 1.349 MB / 0.9707 GB, free: 16.38 MB / 0.67 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 4.021e-05/1.446, allocations: 60.06 kB / 0.9708 GB, free: 16.31 MB / 0.67 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002615/1.448, allocations: 1.799 MB / 0.9725 GB, free: 15.33 MB / 0.67 GB
Notification: Performance of collectPreVariables (initialization): time 0.0001287/1.449, allocations: 50.89 kB / 0.9726 GB, free: 15.28 MB / 0.67 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0006168/1.449, allocations: 0.9936 MB / 0.9736 GB, free: 14.41 MB / 0.67 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0002172/1.449, allocations: 248.2 kB / 0.9738 GB, free: 14.2 MB / 0.67 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0003017/1.45, allocations: 216.5 kB / 0.974 GB, free: 14.07 MB / 0.67 GB
Notification: Performance of setup shared object (initialization): time 6.468e-05/1.45, allocations: 344.4 kB / 0.9743 GB, free: 13.74 MB / 0.67 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0009923/1.451, allocations: 457.7 kB / 0.9748 GB, free: 13.52 MB / 0.67 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001151/1.452, allocations: 0.8304 MB / 0.9756 GB, free: 12.73 MB / 0.67 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.002029/1.454, allocations: 1.21 MB / 0.9768 GB, free: 11.43 MB / 0.67 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 7.565e-06/1.454, allocations: 0 / 0.9768 GB, free: 11.43 MB / 0.67 GB
Notification: Performance of matching and sorting (n=122) (initialization): time 0.00281/1.457, allocations: 1.41 MB / 0.9781 GB, free: 10.07 MB / 0.67 GB
Notification: Performance of prepare postOptimizeDAE: time 2.079e-05/1.457, allocations: 8 kB / 0.9781 GB, free: 10.06 MB / 0.67 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.814e-05/1.457, allocations: 15.98 kB / 0.9782 GB, free: 10.05 MB / 0.67 GB
Notification: Performance of postOpt tearingSystem (initialization): time 2.833e-05/1.457, allocations: 15.94 kB / 0.9782 GB, free: 10.03 MB / 0.67 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001194/1.458, allocations: 272.8 kB / 0.9784 GB, free: 9.781 MB / 0.67 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0002552/1.458, allocations: 0.6028 MB / 0.979 GB, free: 9.16 MB / 0.67 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.00152/1.46, allocations: 140.2 kB / 0.9792 GB, free: 9.023 MB / 0.67 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 9.551e-05/1.46, allocations: 55.97 kB / 0.9792 GB, free: 8.969 MB / 0.67 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.001443/1.461, allocations: 0.8181 MB / 0.98 GB, free: 8.145 MB / 0.67 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.0009541/1.462, allocations: 0.792 MB / 0.9808 GB, free: 7.188 MB / 0.67 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.001669/1.464, allocations: 1.109 MB / 0.9819 GB, free: 5.984 MB / 0.67 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 6.893e-06/1.464, allocations: 4 kB / 0.9819 GB, free: 5.98 MB / 0.67 GB
Notification: Performance of matching and sorting (n=122) (initialization_lambda0): time 0.002513/1.467, allocations: 1.312 MB / 0.9832 GB, free: 4.719 MB / 0.67 GB
Notification: Performance of prepare postOptimizeDAE: time 1.268e-05/1.467, allocations: 8 kB / 0.9832 GB, free: 4.711 MB / 0.67 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.155e-05/1.467, allocations: 8 kB / 0.9832 GB, free: 4.703 MB / 0.67 GB
Notification: Performance of postOpt tearingSystem (initialization): time 1.207e-05/1.467, allocations: 16 kB / 0.9832 GB, free: 4.688 MB / 0.67 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0008924/1.468, allocations: 247.5 kB / 0.9834 GB, free: 4.461 MB / 0.67 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 1.943e-05/1.468, allocations: 22.52 kB / 0.9834 GB, free: 4.441 MB / 0.67 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001329/1.469, allocations: 122.3 kB / 0.9836 GB, free: 4.328 MB / 0.67 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 8.035e-05/1.469, allocations: 44 kB / 0.9836 GB, free: 4.285 MB / 0.67 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.0002643/1.469, allocations: 258 kB / 0.9838 GB, free: 4.043 MB / 0.67 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0003654/1.47, allocations: 193.5 kB / 0.984 GB, free: 3.852 MB / 0.67 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.002495/1.472, allocations: 1.062 MB / 0.9851 GB, free: 2.785 MB / 0.67 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 6.352e-06/1.472, allocations: 8 kB / 0.9851 GB, free: 2.777 MB / 0.67 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 5.54e-06/1.472, allocations: 0 / 0.9851 GB, free: 2.777 MB / 0.67 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.001759/1.474, allocations: 0.8968 MB / 0.986 GB, free: 1.852 MB / 0.67 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.005414/1.479, allocations: 2.872 MB / 0.9888 GB, free: 14.89 MB / 0.6856 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 9.407e-06/1.479, allocations: 10.52 kB / 0.9888 GB, free: 14.89 MB / 0.6856 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.001086/1.481, allocations: 205.1 kB / 0.989 GB, free: 14.69 MB / 0.6856 GB
Notification: Performance of postOpt tearingSystem (simulation): time 1.151e-05/1.481, allocations: 6.531 kB / 0.989 GB, free: 14.69 MB / 0.6856 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 6.426e-05/1.481, allocations: 23.92 kB / 0.989 GB, free: 14.66 MB / 0.6856 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.0003133/1.481, allocations: 0.5822 MB / 0.9896 GB, free: 14.06 MB / 0.6856 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 4.849e-06/1.481, allocations: 2.531 kB / 0.9896 GB, free: 14.06 MB / 0.6856 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.003734/1.485, allocations: 1.638 MB / 0.9912 GB, free: 12.39 MB / 0.6856 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0008712/1.486, allocations: 358.5 kB / 0.9915 GB, free: 12.02 MB / 0.6856 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0004342/1.486, allocations: 16 kB / 0.9915 GB, free: 12 MB / 0.6856 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001227/1.487, allocations: 59.94 kB / 0.9916 GB, free: 11.95 MB / 0.6856 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001134/1.487, allocations: 44.5 kB / 0.9916 GB, free: 11.9 MB / 0.6856 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 7.719e-05/1.488, allocations: 27.98 kB / 0.9916 GB, free: 11.88 MB / 0.6856 GB
Notification: Performance of sorting global known variables: time 0.002189/1.49, allocations: 1.22 MB / 0.9928 GB, free: 10.64 MB / 0.6856 GB
Notification: Performance of sort global known variables: time 2.7e-07/1.49, allocations: 0 / 0.9928 GB, free: 10.64 MB / 0.6856 GB
Notification: Performance of remove unused functions: time 0.003071/1.493, allocations: 0.9623 MB / 0.9938 GB, free: 9.672 MB / 0.6856 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 5
 * Number of states: 3 (floMacDyn.vol.dynBal.U,floMacDyn.vol.dynBal.m,floMacDyn.vol.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 (74):
 * Single equations (assignments): 73
 * Array equations: 0
 * 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 Backend phase and start with SimCode phase: time 0.00101/1.494, allocations: 366.9 kB / 0.9941 GB, free: 9.344 MB / 0.6856 GB
Notification: Performance of simCode: created initialization part: time 0.004494/1.498, allocations: 1.684 MB / 0.9958 GB, free: 7.734 MB / 0.6856 GB
Notification: Performance of simCode: created event and clocks part: time 6.442e-06/1.498, allocations: 0 / 0.9958 GB, free: 7.734 MB / 0.6856 GB
Notification: Performance of simCode: created simulation system equations: time 0.001151/1.5, allocations: 462.7 kB / 0.9962 GB, free: 7.297 MB / 0.6856 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.005433/1.505, allocations: 1.052 MB / 0.9972 GB, free: 6.281 MB / 0.6856 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.006996/1.512, allocations: 3.516 MB / 1.001 GB, free: 2.73 MB / 0.6856 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001674/1.514, allocations: 1.568 MB / 1.002 GB, free: 1.133 MB / 0.6856 GB
Notification: Performance of simCode: alias equations: time 0.002478/1.516, allocations: 476.5 kB / 1.003 GB, free: 0.6641 MB / 0.6856 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0005137/1.517, allocations: 147.4 kB / 1.003 GB, free: 0.5195 MB / 0.6856 GB
Notification: Performance of SimCode: time 5.82e-07/1.517, allocations: 4 kB / 1.003 GB, free: 0.5156 MB / 0.6856 GB
Notification: Performance of Templates: time 0.06672/1.583, allocations: 37.99 MB / 1.04 GB, free: 11.11 MB / 0.7325 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)