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.001395/0.001395, allocations: 100.1 kB / 15.88 MB, free: 12 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.001515/0.001515, allocations: 199.9 kB / 16.79 MB, free: 6.828 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.343/1.343, allocations: 222.9 MB / 240.5 MB, free: 4.535 MB / 190.1 MB Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0-master/package.mo): time 0.9837/0.9837, allocations: 135.1 MB / 425.8 MB, free: 11.97 MB / 350.1 MB Notification: Performance of FrontEnd - loaded program: time 0.001235/0.001235, allocations: 65.42 kB / 0.5053 GB, free: 5.777 MB / 414.1 MB Notification: Performance of FrontEnd - Absyn->SCode: time 0.1802/0.1814, allocations: 80.93 MB / 0.5843 GB, free: 5.02 MB / 494.1 MB Notification: Performance of NFInst.instantiate(IDEAS.Fluid.Movers.Validation.FlowControlled_m_flow): time 1.045/1.227, allocations: 321.4 MB / 0.8982 GB, free: 32.33 MB / 0.67 GB Notification: Performance of NFInst.instExpressions: time 0.03248/1.259, allocations: 20.38 MB / 0.9181 GB, free: 32.06 MB / 0.67 GB Notification: Performance of NFInst.updateImplicitVariability: time 0.004689/1.264, allocations: 86.72 kB / 0.9182 GB, free: 32.06 MB / 0.67 GB Notification: Performance of NFTyping.typeComponents: time 0.005232/1.269, allocations: 1.314 MB / 0.9195 GB, free: 32.02 MB / 0.67 GB Notification: Performance of NFTyping.typeBindings: time 0.01243/1.282, allocations: 3.95 MB / 0.9233 GB, free: 31.82 MB / 0.67 GB Notification: Performance of NFTyping.typeClassSections: time 0.007086/1.289, allocations: 2.096 MB / 0.9254 GB, free: 31.76 MB / 0.67 GB Notification: Performance of NFFlatten.flatten: time 0.01301/1.302, allocations: 8.007 MB / 0.9332 GB, free: 31.74 MB / 0.67 GB Notification: Performance of NFFlatten.resolveConnections: time 0.003806/1.306, allocations: 1.867 MB / 0.935 GB, free: 31.44 MB / 0.67 GB Notification: Performance of NFEvalConstants.evaluate: time 0.008123/1.314, allocations: 2.878 MB / 0.9378 GB, free: 31.39 MB / 0.67 GB Notification: Performance of NFSimplifyModel.simplify: time 0.004868/1.319, allocations: 1.802 MB / 0.9396 GB, free: 31.16 MB / 0.67 GB Notification: Performance of NFPackage.collectConstants: time 0.0007911/1.319, allocations: 120 kB / 0.9397 GB, free: 31.16 MB / 0.67 GB Notification: Performance of NFFlatten.collectFunctions: time 0.009565/1.329, allocations: 4.047 MB / 0.9436 GB, free: 31.12 MB / 0.67 GB Notification: Performance of NFScalarize.scalarize: time 0.001889/1.331, allocations: 0.7922 MB / 0.9444 GB, free: 31.01 MB / 0.67 GB Notification: Performance of NFVerifyModel.verify: time 0.003071/1.334, allocations: 1.224 MB / 0.9456 GB, free: 30.64 MB / 0.67 GB Notification: Performance of NFConvertDAE.convert: time 0.006237/1.34, allocations: 3.553 MB / 0.9491 GB, free: 29.43 MB / 0.67 GB Notification: Performance of FrontEnd - DAE generated: time 8.235e-06/1.34, allocations: 2.562 kB / 0.9491 GB, free: 29.43 MB / 0.67 GB Notification: Performance of FrontEnd: time 2.344e-06/1.34, allocations: 4 kB / 0.9491 GB, free: 29.43 MB / 0.67 GB Notification: Performance of Transformations before backend: time 9.665e-05/1.34, allocations: 0 / 0.9491 GB, free: 29.43 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.005777/1.346, allocations: 2.991 MB / 0.952 GB, free: 27.66 MB / 0.67 GB Notification: Performance of prepare preOptimizeDAE: time 5.533e-05/1.346, allocations: 10.5 kB / 0.952 GB, free: 27.66 MB / 0.67 GB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.00558/1.352, allocations: 0.8342 MB / 0.9528 GB, free: 27.3 MB / 0.67 GB Notification: Performance of preOpt evaluateParameters (simulation): time 0.004142/1.356, allocations: 1.86 MB / 0.9546 GB, free: 26.39 MB / 0.67 GB Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0003869/1.357, allocations: 166.9 kB / 0.9548 GB, free: 26.37 MB / 0.67 GB Notification: Performance of preOpt expandDerOperator (simulation): time 0.000396/1.357, allocations: 143.2 kB / 0.9549 GB, free: 26.37 MB / 0.67 GB Notification: Performance of preOpt clockPartitioning (simulation): time 0.003245/1.36, allocations: 1.67 MB / 0.9566 GB, free: 25.88 MB / 0.67 GB Notification: Performance of preOpt findStateOrder (simulation): time 3.201e-05/1.36, allocations: 0 / 0.9566 GB, free: 25.88 MB / 0.67 GB Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.00013/1.36, allocations: 55.53 kB / 0.9566 GB, free: 25.88 MB / 0.67 GB Notification: Performance of preOpt inlineArrayEqn (simulation): time 5.017e-05/1.36, allocations: 48.64 kB / 0.9567 GB, free: 25.87 MB / 0.67 GB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.00294/1.363, allocations: 1.409 MB / 0.958 GB, free: 25.62 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.009293/1.373, allocations: 7.687 MB / 0.9655 GB, free: 19.34 MB / 0.67 GB Notification: Performance of preOpt comSubExp (simulation): time 0.001853/1.375, allocations: 1.068 MB / 0.9666 GB, free: 18.67 MB / 0.67 GB Notification: Performance of preOpt resolveLoops (simulation): time 0.00102/1.376, allocations: 0.5063 MB / 0.9671 GB, free: 18.42 MB / 0.67 GB Notification: Performance of preOpt evalFunc (simulation): time 0.0001957/1.376, allocations: 112 kB / 0.9672 GB, free: 18.32 MB / 0.67 GB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.216e-05/1.376, allocations: 47.78 kB / 0.9672 GB, free: 18.27 MB / 0.67 GB Notification: Performance of preOpt simplifyInStream (simulation): time 0.001117/1.377, allocations: 196.9 kB / 0.9674 GB, free: 18.16 MB / 0.67 GB Notification: Performance of pre-optimization done (n=76): time 4.058e-06/1.377, allocations: 0 / 0.9674 GB, free: 18.16 MB / 0.67 GB Notification: Performance of matching and sorting (n=76): time 0.003317/1.38, allocations: 1.396 MB / 0.9688 GB, free: 17.48 MB / 0.67 GB Notification: Performance of inlineWhenForInitialization (initialization): time 2.964e-05/1.38, allocations: 60.16 kB / 0.9688 GB, free: 17.42 MB / 0.67 GB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002233/1.383, allocations: 1.793 MB / 0.9706 GB, free: 16.44 MB / 0.67 GB Notification: Performance of collectPreVariables (initialization): time 0.0001292/1.383, allocations: 49.17 kB / 0.9706 GB, free: 16.39 MB / 0.67 GB Notification: Performance of collectInitialEqns (initialization): time 0.0006162/1.383, allocations: 0.9896 MB / 0.9716 GB, free: 15.53 MB / 0.67 GB Notification: Performance of collectInitialBindings (initialization): time 0.0001922/1.384, allocations: 269.2 kB / 0.9719 GB, free: 15.3 MB / 0.67 GB Notification: Performance of simplifyInitialFunctions (initialization): time 0.0002881/1.384, allocations: 220.2 kB / 0.9721 GB, free: 15.17 MB / 0.67 GB Notification: Performance of setup shared object (initialization): time 7.003e-05/1.384, allocations: 352.3 kB / 0.9724 GB, free: 14.83 MB / 0.67 GB Notification: Performance of preBalanceInitialSystem (initialization): time 0.0009682/1.385, allocations: 462.9 kB / 0.9729 GB, free: 14.61 MB / 0.67 GB Notification: Performance of partitionIndependentBlocks (initialization): time 0.001144/1.386, allocations: 0.8611 MB / 0.9737 GB, free: 13.87 MB / 0.67 GB Notification: Performance of analyzeInitialSystem (initialization): time 0.001982/1.388, allocations: 1.246 MB / 0.9749 GB, free: 12.77 MB / 0.67 GB Notification: Performance of solveInitialSystemEqSystem (initialization): time 7.815e-06/1.388, allocations: 4 kB / 0.9749 GB, free: 12.77 MB / 0.67 GB Notification: Performance of matching and sorting (n=126) (initialization): time 0.002792/1.391, allocations: 1.453 MB / 0.9763 GB, free: 11.36 MB / 0.67 GB Notification: Performance of prepare postOptimizeDAE: time 2.319e-05/1.391, allocations: 10.34 kB / 0.9763 GB, free: 11.35 MB / 0.67 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.364e-05/1.391, allocations: 8 kB / 0.9764 GB, free: 11.34 MB / 0.67 GB Notification: Performance of postOpt tearingSystem (initialization): time 2.672e-05/1.391, allocations: 16 kB / 0.9764 GB, free: 11.33 MB / 0.67 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001199/1.392, allocations: 277.5 kB / 0.9766 GB, free: 11.07 MB / 0.67 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.000281/1.392, allocations: 0.6083 MB / 0.9772 GB, free: 10.45 MB / 0.67 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.00176/1.394, allocations: 147.6 kB / 0.9774 GB, free: 10.31 MB / 0.67 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001057/1.394, allocations: 51.98 kB / 0.9774 GB, free: 10.26 MB / 0.67 GB Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.001548/1.396, allocations: 0.8337 MB / 0.9782 GB, free: 9.422 MB / 0.67 GB Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.0009229/1.397, allocations: 0.8115 MB / 0.979 GB, free: 8.445 MB / 0.67 GB Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.001622/1.398, allocations: 1.15 MB / 0.9801 GB, free: 7.195 MB / 0.67 GB Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 5.42e-06/1.398, allocations: 4 kB / 0.9802 GB, free: 7.191 MB / 0.67 GB Notification: Performance of matching and sorting (n=126) (initialization_lambda0): time 0.002402/1.401, allocations: 1.343 MB / 0.9815 GB, free: 5.895 MB / 0.67 GB Notification: Performance of prepare postOptimizeDAE: time 1.381e-05/1.401, allocations: 8 kB / 0.9815 GB, free: 5.887 MB / 0.67 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.02e-05/1.401, allocations: 8 kB / 0.9815 GB, free: 5.879 MB / 0.67 GB Notification: Performance of postOpt tearingSystem (initialization): time 1.214e-05/1.401, allocations: 19.98 kB / 0.9815 GB, free: 5.859 MB / 0.67 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0008923/1.402, allocations: 255.5 kB / 0.9817 GB, free: 5.625 MB / 0.67 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 1.431e-05/1.402, allocations: 21 kB / 0.9818 GB, free: 5.609 MB / 0.67 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.00166/1.404, allocations: 140.4 kB / 0.9819 GB, free: 5.477 MB / 0.67 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 7.71e-05/1.404, allocations: 55.98 kB / 0.9819 GB, free: 5.422 MB / 0.67 GB Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 43 * 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 (124): * Single equations (assignments): 121 * 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.000328/1.404, allocations: 256 kB / 0.9822 GB, free: 5.184 MB / 0.67 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0002673/1.404, allocations: 189.6 kB / 0.9824 GB, free: 4.996 MB / 0.67 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.002459/1.407, allocations: 1.097 MB / 0.9834 GB, free: 3.895 MB / 0.67 GB Notification: Performance of postOpt inlineArrayEqn (simulation): time 7.444e-06/1.407, allocations: 11.94 kB / 0.9835 GB, free: 3.883 MB / 0.67 GB Notification: Performance of postOpt constantLinearSystem (simulation): time 6.523e-06/1.407, allocations: 0 / 0.9835 GB, free: 3.883 MB / 0.67 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.00165/1.408, allocations: 0.9319 MB / 0.9844 GB, free: 2.922 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 postOpt removeSimpleEquations (simulation): time 0.005072/1.413, allocations: 3.035 MB / 0.9873 GB, free: 15.79 MB / 0.6856 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 5.27e-06/1.413, allocations: 0 / 0.9873 GB, free: 15.79 MB / 0.6856 GB Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.001054/1.415, allocations: 218.2 kB / 0.9875 GB, free: 15.59 MB / 0.6856 GB Notification: Performance of postOpt tearingSystem (simulation): time 8.045e-06/1.415, allocations: 4 kB / 0.9875 GB, free: 15.58 MB / 0.6856 GB Notification: Performance of postOpt inputDerivativesUsed (simulation): time 5.949e-05/1.415, allocations: 23.98 kB / 0.9876 GB, free: 15.56 MB / 0.6856 GB Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.0003007/1.415, allocations: 0.5923 MB / 0.9881 GB, free: 14.95 MB / 0.6856 GB Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 4.258e-06/1.415, allocations: 4.031 kB / 0.9881 GB, free: 14.94 MB / 0.6856 GB Notification: Performance of postOpt symbolicJacobian (simulation): time 0.003497/1.418, allocations: 1.668 MB / 0.9898 GB, free: 13.25 MB / 0.6856 GB Notification: Performance of postOpt removeConstants (simulation): time 0.0009255/1.419, allocations: 358.5 kB / 0.9901 GB, free: 12.88 MB / 0.6856 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0002128/1.42, allocations: 15.98 kB / 0.9901 GB, free: 12.86 MB / 0.6856 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001203/1.421, allocations: 135.7 kB / 0.9903 GB, free: 12.73 MB / 0.6856 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001174/1.421, allocations: 44.59 kB / 0.9903 GB, free: 12.68 MB / 0.6856 GB Notification: Performance of postOpt collapseArrayExpressions (simulation): time 6.777e-05/1.421, allocations: 39.97 kB / 0.9903 GB, free: 12.64 MB / 0.6856 GB Notification: Performance of sorting global known variables: time 0.001796/1.423, allocations: 1.223 MB / 0.9915 GB, free: 11.41 MB / 0.6856 GB Notification: Performance of sort global known variables: time 1.61e-07/1.423, allocations: 0 / 0.9915 GB, free: 11.41 MB / 0.6856 GB Notification: Performance of remove unused functions: time 0.002729/1.426, allocations: 0.9586 MB / 0.9925 GB, free: 10.45 MB / 0.6856 GB Notification: Model statistics after passing the back-end for simulation: * Number of independent subsystems: 6 * 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 (78): * Single equations (assignments): 77 * 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.0009328/1.427, allocations: 365.3 kB / 0.9928 GB, free: 10.11 MB / 0.6856 GB Notification: Performance of simCode: created initialization part: time 0.003729/1.43, allocations: 1.655 MB / 0.9944 GB, free: 8.531 MB / 0.6856 GB Notification: Performance of simCode: created event and clocks part: time 1.309e-05/1.43, allocations: 0.6875 kB / 0.9944 GB, free: 8.531 MB / 0.6856 GB Notification: Performance of simCode: created simulation system equations: time 0.00105/1.431, allocations: 481.8 kB / 0.9949 GB, free: 8.082 MB / 0.6856 GB Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.004328/1.436, allocations: 1.001 MB / 0.9959 GB, free: 7.109 MB / 0.6856 GB Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.006693/1.442, allocations: 4.383 MB / 1 GB, free: 2.68 MB / 0.6856 GB Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001091/1.444, allocations: 1.57 MB / 1.002 GB, free: 1.074 MB / 0.6856 GB Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0005954/1.444, allocations: 151.4 kB / 1.002 GB, free: 0.9297 MB / 0.6856 GB Notification: Performance of SimCode: time 1.062e-06/1.444, allocations: 0 / 1.002 GB, free: 0.9297 MB / 0.6856 GB Notification: Performance of Templates: time 0.05758/1.502, allocations: 43.45 MB / 1.044 GB, free: 5.75 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)