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: "" <> buildModelFMU(IDEAS.Fluid.Movers.Validation.FlowControlled_m_flow,fileNamePrefix="IDEAS_dev_IDEAS_Fluid_Movers_Validation_FlowControlled_m_flow",fmuType="me",version="2.0",platforms={"static"}) "" <> buildModelFMU(IDEAS.Fluid.Movers.Validation.FlowControlled_m_flow,fileNamePrefix="IDEAS_dev_IDEAS_Fluid_Movers_Validation_FlowControlled_m_flow",fmuType="me",version="2.0",platforms={"static"}) Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001/0.001, allocations: 108 kB / 15.61 MB, free: 152 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.00104/0.00104, allocations: 195.8 kB / 16.53 MB, free: 6.699 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.305/1.305, allocations: 222.9 MB / 240.2 MB, free: 4.383 MB / 190.1 MB Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0-master/package.mo): time 0.9004/0.9004, allocations: 135.1 MB / 425.5 MB, free: 12.01 MB / 350.1 MB Notification: Performance of FrontEnd - loaded program: time 0.001268/0.001268, allocations: 67.83 kB / 0.5054 GB, free: 5.223 MB / 414.1 MB Notification: Performance of FrontEnd - Absyn->SCode: time 0.1302/0.1315, allocations: 80.92 MB / 0.5845 GB, free: 4.457 MB / 494.1 MB Notification: Performance of NFInst.instantiate(IDEAS.Fluid.Movers.Validation.FlowControlled_m_flow): time 0.81/0.9416, allocations: 323.5 MB / 0.9003 GB, free: 32.82 MB / 0.67 GB Notification: Performance of NFInst.instExpressions: time 0.02365/0.9653, allocations: 20.2 MB / 0.9201 GB, free: 32.67 MB / 0.67 GB Notification: Performance of NFInst.updateImplicitVariability: time 0.002732/0.968, allocations: 93.75 kB / 0.9201 GB, free: 32.67 MB / 0.67 GB Notification: Performance of NFTyping.typeComponents: time 0.003243/0.9713, allocations: 1.508 MB / 0.9216 GB, free: 32.64 MB / 0.67 GB Notification: Performance of NFTyping.typeBindings: time 0.009774/0.9811, allocations: 4.222 MB / 0.9257 GB, free: 32.47 MB / 0.67 GB Notification: Performance of NFTyping.typeClassSections: time 0.005664/0.9868, allocations: 2.337 MB / 0.928 GB, free: 32.43 MB / 0.67 GB Notification: Performance of NFFlatten.flatten: time 0.008704/0.9955, allocations: 5.93 MB / 0.9338 GB, free: 32.42 MB / 0.67 GB Notification: Performance of NFFlatten.resolveConnections: time 0.003036/0.9986, allocations: 2.159 MB / 0.9359 GB, free: 32.16 MB / 0.67 GB Notification: Performance of NFEvalConstants.evaluate: time 0.006504/1.005, allocations: 3.209 MB / 0.9391 GB, free: 32.11 MB / 0.67 GB Notification: Performance of NFSimplifyModel.simplify: time 0.002562/1.008, allocations: 1.722 MB / 0.9407 GB, free: 31.83 MB / 0.67 GB Notification: Performance of NFPackage.collectConstants: time 0.0003266/1.008, allocations: 217.6 kB / 0.9409 GB, free: 31.83 MB / 0.67 GB Notification: Performance of NFFlatten.collectFunctions: time 0.006451/1.014, allocations: 3.681 MB / 0.9445 GB, free: 31.79 MB / 0.67 GB Notification: Performance of NFScalarize.scalarize: time 0.0007189/1.015, allocations: 0.8675 MB / 0.9454 GB, free: 31.69 MB / 0.67 GB Notification: Performance of NFVerifyModel.verify: time 0.001267/1.016, allocations: 1.33 MB / 0.9467 GB, free: 31.32 MB / 0.67 GB Notification: Performance of NFConvertDAE.convert: time 0.005611/1.022, allocations: 4.692 MB / 0.9513 GB, free: 29.88 MB / 0.67 GB Notification: Performance of FrontEnd - DAE generated: time 4.118e-06/1.022, allocations: 0 / 0.9513 GB, free: 29.88 MB / 0.67 GB Notification: Performance of FrontEnd: time 1.302e-06/1.022, allocations: 0 / 0.9513 GB, free: 29.88 MB / 0.67 GB Notification: Performance of Transformations before backend: time 3.429e-05/1.022, allocations: 0 / 0.9513 GB, free: 29.88 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.004032/1.026, allocations: 2.969 MB / 0.9542 GB, free: 28.12 MB / 0.67 GB Notification: Performance of prepare preOptimizeDAE: time 3.613e-05/1.026, allocations: 9.094 kB / 0.9542 GB, free: 28.12 MB / 0.67 GB Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.0001996/1.026, allocations: 198.6 kB / 0.9544 GB, free: 28.05 MB / 0.67 GB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.00525/1.032, allocations: 0.8403 MB / 0.9552 GB, free: 27.68 MB / 0.67 GB Notification: Performance of preOpt evaluateParameters (simulation): time 0.002771/1.034, allocations: 1.856 MB / 0.957 GB, free: 26.53 MB / 0.67 GB Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0003684/1.035, allocations: 167.1 kB / 0.9572 GB, free: 26.46 MB / 0.67 GB Notification: Performance of preOpt expandDerOperator (simulation): time 0.000183/1.035, allocations: 149.4 kB / 0.9573 GB, free: 26.41 MB / 0.67 GB Notification: Performance of preOpt clockPartitioning (simulation): time 0.002663/1.038, allocations: 1.655 MB / 0.9589 GB, free: 25.39 MB / 0.67 GB Notification: Performance of preOpt findStateOrder (simulation): time 3.051e-05/1.038, allocations: 5.031 kB / 0.9589 GB, free: 25.39 MB / 0.67 GB Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001282/1.038, allocations: 57.75 kB / 0.959 GB, free: 25.34 MB / 0.67 GB Notification: Performance of preOpt inlineArrayEqn (simulation): time 4.045e-05/1.038, allocations: 46.11 kB / 0.959 GB, free: 25.34 MB / 0.67 GB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.002897/1.041, allocations: 1.365 MB / 0.9604 GB, free: 24.67 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.007777/1.049, allocations: 7.922 MB / 0.9681 GB, free: 17.89 MB / 0.67 GB Notification: Performance of preOpt comSubExp (simulation): time 0.001786/1.05, allocations: 1.006 MB / 0.9691 GB, free: 17.27 MB / 0.67 GB Notification: Performance of preOpt resolveLoops (simulation): time 0.00103/1.051, allocations: 499 kB / 0.9696 GB, free: 17.03 MB / 0.67 GB Notification: Performance of preOpt evalFunc (simulation): time 0.0001759/1.052, allocations: 111.8 kB / 0.9697 GB, free: 16.92 MB / 0.67 GB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 2.517e-05/1.052, allocations: 41.97 kB / 0.9697 GB, free: 16.87 MB / 0.67 GB Notification: Performance of pre-optimization done (n=72): time 2.264e-06/1.052, allocations: 0 / 0.9697 GB, free: 16.87 MB / 0.67 GB Notification: Performance of matching and sorting (n=72): time 0.003408/1.055, allocations: 1.35 MB / 0.971 GB, free: 16.21 MB / 0.67 GB Notification: Performance of inlineWhenForInitialization (initialization): time 3.735e-05/1.055, allocations: 64.5 kB / 0.9711 GB, free: 16.15 MB / 0.67 GB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001863/1.057, allocations: 1.798 MB / 0.9728 GB, free: 15.16 MB / 0.67 GB Notification: Performance of collectPreVariables (initialization): time 7.094e-05/1.057, allocations: 50.11 kB / 0.9729 GB, free: 15.12 MB / 0.67 GB Notification: Performance of collectInitialEqns (initialization): time 0.0005376/1.058, allocations: 0.9885 MB / 0.9738 GB, free: 14.25 MB / 0.67 GB Notification: Performance of collectInitialBindings (initialization): time 0.0001731/1.058, allocations: 252.7 kB / 0.9741 GB, free: 14.04 MB / 0.67 GB Notification: Performance of simplifyInitialFunctions (initialization): time 0.0002812/1.058, allocations: 214 kB / 0.9743 GB, free: 13.91 MB / 0.67 GB Notification: Performance of setup shared object (initialization): time 5.724e-05/1.058, allocations: 342.6 kB / 0.9746 GB, free: 13.58 MB / 0.67 GB Notification: Performance of preBalanceInitialSystem (initialization): time 0.0009969/1.059, allocations: 454.9 kB / 0.9751 GB, free: 13.36 MB / 0.67 GB Notification: Performance of partitionIndependentBlocks (initialization): time 0.001196/1.06, allocations: 0.8391 MB / 0.9759 GB, free: 12.53 MB / 0.67 GB Notification: Performance of analyzeInitialSystem (initialization): time 0.002078/1.062, allocations: 1.206 MB / 0.977 GB, free: 11.23 MB / 0.67 GB Notification: Performance of solveInitialSystemEqSystem (initialization): time 5.19e-06/1.063, allocations: 4 kB / 0.9771 GB, free: 11.23 MB / 0.67 GB Notification: Performance of matching and sorting (n=122) (initialization): time 0.00259/1.065, allocations: 1.407 MB / 0.9784 GB, free: 9.867 MB / 0.67 GB Notification: Performance of prepare postOptimizeDAE: time 2.011e-05/1.065, allocations: 10.03 kB / 0.9784 GB, free: 9.859 MB / 0.67 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.272e-05/1.065, allocations: 8 kB / 0.9784 GB, free: 9.852 MB / 0.67 GB Notification: Performance of postOpt tearingSystem (initialization): time 2.676e-05/1.065, allocations: 19.94 kB / 0.9785 GB, free: 9.832 MB / 0.67 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001231/1.066, allocations: 275.5 kB / 0.9787 GB, free: 9.578 MB / 0.67 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0002301/1.067, allocations: 0.6053 MB / 0.9793 GB, free: 8.957 MB / 0.67 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.00127/1.068, allocations: 145.5 kB / 0.9795 GB, free: 8.816 MB / 0.67 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 7.921e-05/1.068, allocations: 51.98 kB / 0.9795 GB, free: 8.766 MB / 0.67 GB Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.001329/1.069, allocations: 0.8202 MB / 0.9803 GB, free: 7.941 MB / 0.67 GB Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.0009514/1.07, allocations: 0.7825 MB / 0.9811 GB, free: 6.992 MB / 0.67 GB Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.001704/1.072, allocations: 1.117 MB / 0.9822 GB, free: 5.781 MB / 0.67 GB Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 4.117e-06/1.072, allocations: 4 kB / 0.9822 GB, free: 5.777 MB / 0.67 GB Notification: Performance of matching and sorting (n=122) (initialization_lambda0): time 0.002226/1.074, allocations: 1.304 MB / 0.9834 GB, free: 4.52 MB / 0.67 GB Notification: Performance of prepare postOptimizeDAE: time 1.146e-05/1.074, allocations: 12 kB / 0.9835 GB, free: 4.508 MB / 0.67 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 8.046e-06/1.074, allocations: 8 kB / 0.9835 GB, free: 4.5 MB / 0.67 GB Notification: Performance of postOpt tearingSystem (initialization): time 1.094e-05/1.074, allocations: 16.34 kB / 0.9835 GB, free: 4.484 MB / 0.67 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0009167/1.075, allocations: 251.2 kB / 0.9837 GB, free: 4.254 MB / 0.67 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 1.23e-05/1.075, allocations: 18.53 kB / 0.9837 GB, free: 4.238 MB / 0.67 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001132/1.076, allocations: 119.7 kB / 0.9838 GB, free: 4.125 MB / 0.67 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 6.618e-05/1.077, allocations: 55.92 kB / 0.9839 GB, free: 4.07 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.0001942/1.077, allocations: 247.4 kB / 0.9841 GB, free: 3.836 MB / 0.67 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0002057/1.077, allocations: 197.6 kB / 0.9843 GB, free: 3.641 MB / 0.67 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.002386/1.079, allocations: 1.064 MB / 0.9854 GB, free: 2.574 MB / 0.67 GB Notification: Performance of postOpt inlineArrayEqn (simulation): time 6.593e-06/1.079, allocations: 8 kB / 0.9854 GB, free: 2.566 MB / 0.67 GB Notification: Performance of postOpt constantLinearSystem (simulation): time 5.129e-06/1.079, allocations: 0 / 0.9854 GB, free: 2.566 MB / 0.67 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.001824/1.081, allocations: 0.8969 MB / 0.9862 GB, free: 1.641 MB / 0.67 GB Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.004475/1.086, allocations: 2.87 MB / 0.989 GB, free: 14.68 MB / 0.6856 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 3.807e-06/1.086, allocations: 0 / 0.989 GB, free: 14.68 MB / 0.6856 GB Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.001072/1.087, allocations: 207.6 kB / 0.9892 GB, free: 14.49 MB / 0.6856 GB Notification: Performance of postOpt tearingSystem (simulation): time 8.676e-06/1.087, allocations: 7.938 kB / 0.9893 GB, free: 14.48 MB / 0.6856 GB Notification: Performance of postOpt inputDerivativesUsed (simulation): time 5.663e-05/1.087, allocations: 23.98 kB / 0.9893 GB, free: 14.46 MB / 0.6856 GB Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.0002731/1.087, allocations: 0.5844 MB / 0.9898 GB, free: 13.86 MB / 0.6856 GB Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 4.207e-06/1.087, allocations: 8.125 kB / 0.9899 GB, free: 13.85 MB / 0.6856 GB Notification: Performance of postOpt symbolicJacobian (simulation): time 0.003432/1.091, allocations: 1.63 MB / 0.9914 GB, free: 12.19 MB / 0.6856 GB Notification: Performance of postOpt removeConstants (simulation): time 0.0005679/1.091, allocations: 358.5 kB / 0.9918 GB, free: 11.82 MB / 0.6856 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0002109/1.091, allocations: 16 kB / 0.9918 GB, free: 11.8 MB / 0.6856 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001001/1.092, allocations: 54.48 kB / 0.9919 GB, free: 11.75 MB / 0.6856 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001085/1.092, allocations: 48.5 kB / 0.9919 GB, free: 11.7 MB / 0.6856 GB Notification: Performance of postOpt collapseArrayExpressions (simulation): time 6.271e-05/1.093, allocations: 27.97 kB / 0.9919 GB, free: 11.68 MB / 0.6856 GB Notification: Performance of sorting global known variables: time 0.001537/1.094, allocations: 1.224 MB / 0.9931 GB, free: 10.43 MB / 0.6856 GB Notification: Performance of sort global known variables: time 1.6e-07/1.094, allocations: 4 kB / 0.9931 GB, free: 10.43 MB / 0.6856 GB Notification: Performance of remove unused functions: time 0.002134/1.096, allocations: 0.9584 MB / 0.9941 GB, free: 9.469 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.004423/1.101, allocations: 2.441 MB / 0.9964 GB, free: 7.027 MB / 0.6856 GB Notification: Performance of simCode: created initialization part: time 0.004172/1.105, allocations: 1.678 MB / 0.9981 GB, free: 5.426 MB / 0.6856 GB Notification: Performance of simCode: created event and clocks part: time 3.186e-06/1.105, allocations: 0 / 0.9981 GB, free: 5.426 MB / 0.6856 GB Notification: Performance of simCode: created simulation system equations: time 0.001098/1.106, allocations: 472 kB / 0.9985 GB, free: 4.984 MB / 0.6856 GB Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.004016/1.11, allocations: 1.038 MB / 0.9996 GB, free: 3.992 MB / 0.6856 GB Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.02078/1.131, allocations: 14.79 MB / 1.014 GB, free: 4.164 MB / 0.7012 GB Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001067/1.132, allocations: 1.57 MB / 1.016 GB, free: 2.562 MB / 0.7012 GB Notification: Performance of simCode: alias equations: time 0.002019/1.134, allocations: 480.5 kB / 1.016 GB, free: 2.09 MB / 0.7012 GB Notification: Performance of simCode: all other stuff during SimCode phase: time 0.001026/1.135, allocations: 0.8351 MB / 1.017 GB, free: 1.258 MB / 0.7012 GB Notification: Performance of SimCode: time 5.81e-07/1.135, allocations: 4 kB / 1.017 GB, free: 1.254 MB / 0.7012 GB Notification: Performance of buildModelFMU: Generate the FMI files: time 0.08872/1.224, allocations: 52.51 MB / 1.068 GB, free: 13.39 MB / 0.7637 GB Notification: Performance of buildModelFMU: Generate platform static: time 12.14/13.36, allocations: 15.06 kB / 1.068 GB, free: 13.38 MB / 0.7637 GB (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 & python3 -m fmpy simulate --output-file IDEAS_dev_IDEAS.Fluid.Movers.Validation.FlowControlled_m_flow_res.csv --start-time 0 --stop-time 1 --timeout 50 --relative-tolerance 1e-06 --interface-type ModelExchange --solver CVode --output-interval 0.0004 IDEAS_dev_IDEAS_Fluid_Movers_Validation_FlowControlled_m_flow.fmu > IDEAS_dev_IDEAS.Fluid.Movers.Validation.FlowControlled_m_flow.pipe 2>&1)