Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IDEAS_dev_IDEAS.Fluid.HeatPumps.Validation.Carnot_y_etaCar.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.HeatPumps.Validation.Carnot_y_etaCar,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.Fluid.HeatPumps.Validation.Carnot_y_etaCar") translateModel(IDEAS.Fluid.HeatPumps.Validation.Carnot_y_etaCar,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.Fluid.HeatPumps.Validation.Carnot_y_etaCar") Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001368/0.001368, allocations: 108.2 kB / 16.41 MB, free: 5.992 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.001312/0.001312, allocations: 183.8 kB / 17.34 MB, free: 5.605 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.439/1.439, allocations: 222.9 MB / 241 MB, free: 15.09 MB / 206.1 MB Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0-master/package.mo): time 0.8851/0.8851, allocations: 135.2 MB / 426.4 MB, free: 4.051 MB / 334.1 MB Notification: Performance of FrontEnd - loaded program: time 0.001921/0.001921, allocations: 75.22 kB / 0.5864 GB, free: 21.43 MB / 446.1 MB Notification: Performance of FrontEnd - Absyn->SCode: time 0.1737/0.1756, allocations: 80.92 MB / 0.6654 GB, free: 5.656 MB / 0.4981 GB Notification: Performance of NFInst.instantiate(IDEAS.Fluid.HeatPumps.Validation.Carnot_y_etaCar): time 0.08421/0.2598, allocations: 75.33 MB / 0.739 GB, free: 10.07 MB / 0.5762 GB Notification: Performance of NFInst.instExpressions: time 0.4615/0.7213, allocations: 15.14 MB / 0.7538 GB, free: 26.03 MB / 0.5762 GB Notification: Performance of NFInst.updateImplicitVariability: time 0.002458/0.7238, allocations: 64.34 kB / 0.7538 GB, free: 26.03 MB / 0.5762 GB Notification: Performance of NFTyping.typeComponents: time 0.002389/0.7262, allocations: 0.8711 MB / 0.7547 GB, free: 26.03 MB / 0.5762 GB Notification: Performance of NFTyping.typeBindings: time 0.007031/0.7332, allocations: 2.712 MB / 0.7573 GB, free: 25.94 MB / 0.5762 GB Notification: Performance of NFTyping.typeClassSections: time 0.003552/0.7367, allocations: 1.4 MB / 0.7587 GB, free: 25.9 MB / 0.5762 GB Notification: Performance of NFFlatten.flatten: time 0.008132/0.7449, allocations: 4.389 MB / 0.763 GB, free: 25.9 MB / 0.5762 GB Notification: Performance of NFFlatten.resolveConnections: time 0.002867/0.7477, allocations: 1.19 MB / 0.7642 GB, free: 25.79 MB / 0.5762 GB Notification: Performance of NFEvalConstants.evaluate: time 0.005074/0.7528, allocations: 1.683 MB / 0.7658 GB, free: 25.69 MB / 0.5762 GB Notification: Performance of NFSimplifyModel.simplify: time 0.003004/0.7558, allocations: 1.21 MB / 0.767 GB, free: 25.48 MB / 0.5762 GB Notification: Performance of NFPackage.collectConstants: time 0.0005263/0.7563, allocations: 162.6 kB / 0.7671 GB, free: 25.48 MB / 0.5762 GB Notification: Performance of NFFlatten.collectFunctions: time 0.004394/0.7607, allocations: 1.409 MB / 0.7685 GB, free: 25.45 MB / 0.5762 GB Notification: Performance of NFScalarize.scalarize: time 0.0006494/0.7614, allocations: 416.9 kB / 0.7689 GB, free: 25.38 MB / 0.5762 GB Notification: Performance of NFVerifyModel.verify: time 0.001823/0.7632, allocations: 0.9069 MB / 0.7698 GB, free: 25.14 MB / 0.5762 GB Notification: Performance of NFConvertDAE.convert: time 0.005737/0.7689, allocations: 2.886 MB / 0.7726 GB, free: 24.78 MB / 0.5762 GB Notification: Performance of FrontEnd - DAE generated: time 5.901e-06/0.769, allocations: 1.031 kB / 0.7726 GB, free: 24.78 MB / 0.5762 GB Notification: Performance of FrontEnd: time 1.884e-06/0.769, allocations: 0 / 0.7726 GB, free: 24.78 MB / 0.5762 GB Notification: Performance of Transformations before backend: time 4.863e-05/0.769, allocations: 0 / 0.7726 GB, free: 24.78 MB / 0.5762 GB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 240 * Number of variables: 240 Notification: Performance of Generate backend data structure: time 0.004519/0.7735, allocations: 2.136 MB / 0.7747 GB, free: 23.69 MB / 0.5762 GB Notification: Performance of prepare preOptimizeDAE: time 4.238e-05/0.7736, allocations: 10.67 kB / 0.7747 GB, free: 23.69 MB / 0.5762 GB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0009945/0.7746, allocations: 243 kB / 0.7749 GB, free: 23.59 MB / 0.5762 GB Notification: Performance of preOpt evaluateParameters (simulation): time 0.002604/0.7772, allocations: 1.528 MB / 0.7764 GB, free: 23.16 MB / 0.5762 GB Notification: Performance of preOpt simplifyIfEquations (simulation): time 5.815e-05/0.7772, allocations: 76.91 kB / 0.7765 GB, free: 23.16 MB / 0.5762 GB Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001598/0.7774, allocations: 111 kB / 0.7766 GB, free: 23.15 MB / 0.5762 GB Notification: Performance of preOpt clockPartitioning (simulation): time 0.002056/0.7794, allocations: 1.105 MB / 0.7777 GB, free: 23.02 MB / 0.5762 GB Notification: Performance of preOpt findStateOrder (simulation): time 2.852e-05/0.7795, allocations: 1.094 kB / 0.7777 GB, free: 23.02 MB / 0.5762 GB Notification: Performance of preOpt replaceEdgeChange (simulation): time 9.392e-05/0.7796, allocations: 38.72 kB / 0.7777 GB, free: 23.02 MB / 0.5762 GB Notification: Performance of preOpt inlineArrayEqn (simulation): time 4.029e-05/0.7796, allocations: 26.67 kB / 0.7778 GB, free: 23.02 MB / 0.5762 GB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.001884/0.7815, allocations: 0.8944 MB / 0.7786 GB, free: 23.01 MB / 0.5762 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.005589/0.7871, allocations: 4.916 MB / 0.7834 GB, free: 19.96 MB / 0.5762 GB Notification: Performance of preOpt comSubExp (simulation): time 0.001368/0.7884, allocations: 0.5882 MB / 0.784 GB, free: 19.75 MB / 0.5762 GB Notification: Performance of preOpt resolveLoops (simulation): time 0.0006729/0.7891, allocations: 322.9 kB / 0.7843 GB, free: 19.65 MB / 0.5762 GB Notification: Performance of preOpt evalFunc (simulation): time 0.0004562/0.7896, allocations: 0.8266 MB / 0.7851 GB, free: 18.7 MB / 0.5762 GB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 2.6e-05/0.7896, allocations: 43.34 kB / 0.7852 GB, free: 18.65 MB / 0.5762 GB Notification: Performance of pre-optimization done (n=61): time 2.966e-06/0.7896, allocations: 3.75 kB / 0.7852 GB, free: 18.65 MB / 0.5762 GB Notification: Performance of matching and sorting (n=61): time 0.006918/0.7965, allocations: 1.701 MB / 0.7868 GB, free: 18.15 MB / 0.5762 GB Notification: Performance of inlineWhenForInitialization (initialization): time 2.47e-05/0.7965, allocations: 56.81 kB / 0.7869 GB, free: 18.09 MB / 0.5762 GB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001623/0.7982, allocations: 1.229 MB / 0.7881 GB, free: 17.49 MB / 0.5762 GB Notification: Performance of collectPreVariables (initialization): time 0.0001019/0.7983, allocations: 47.36 kB / 0.7881 GB, free: 17.44 MB / 0.5762 GB Notification: Performance of collectInitialEqns (initialization): time 0.0003906/0.7987, allocations: 0.6101 MB / 0.7887 GB, free: 16.9 MB / 0.5762 GB Notification: Performance of collectInitialBindings (initialization): time 0.000188/0.7988, allocations: 227.9 kB / 0.7889 GB, free: 16.71 MB / 0.5762 GB Notification: Performance of simplifyInitialFunctions (initialization): time 0.000225/0.7991, allocations: 156.5 kB / 0.7891 GB, free: 16.61 MB / 0.5762 GB Notification: Performance of setup shared object (initialization): time 5.681e-05/0.7991, allocations: 331.9 kB / 0.7894 GB, free: 16.29 MB / 0.5762 GB Notification: Performance of preBalanceInitialSystem (initialization): time 0.0006246/0.7998, allocations: 295 kB / 0.7897 GB, free: 16.14 MB / 0.5762 GB Notification: Performance of partitionIndependentBlocks (initialization): time 0.000749/0.8005, allocations: 497.5 kB / 0.7902 GB, free: 15.76 MB / 0.5762 GB Notification: Performance of analyzeInitialSystem (initialization): time 0.00123/0.8017, allocations: 0.7133 MB / 0.7909 GB, free: 15.33 MB / 0.5762 GB Notification: Performance of solveInitialSystemEqSystem (initialization): time 4.859e-06/0.8017, allocations: 1.375 kB / 0.7909 GB, free: 15.33 MB / 0.5762 GB Notification: Performance of matching and sorting (n=88) (initialization): time 0.00427/0.806, allocations: 1.28 MB / 0.7921 GB, free: 14.7 MB / 0.5762 GB Notification: Performance of prepare postOptimizeDAE: time 2.239e-05/0.806, allocations: 6.969 kB / 0.7921 GB, free: 14.7 MB / 0.5762 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 9.017e-06/0.806, allocations: 3.469 kB / 0.7921 GB, free: 14.7 MB / 0.5762 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.0005389/0.8066, allocations: 134.8 kB / 0.7922 GB, free: 14.63 MB / 0.5762 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0005539/0.8071, allocations: 153.7 kB / 0.7924 GB, free: 14.6 MB / 0.5762 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0006711/0.8078, allocations: 0.7103 MB / 0.7931 GB, free: 13.97 MB / 0.5762 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001245/0.809, allocations: 121.7 kB / 0.7932 GB, free: 13.89 MB / 0.5762 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 7.653e-05/0.8091, allocations: 30.48 kB / 0.7932 GB, free: 13.88 MB / 0.5762 GB Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.001054/0.8102, allocations: 0.5464 MB / 0.7938 GB, free: 13.55 MB / 0.5762 GB Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.0006779/0.8109, allocations: 0.4911 MB / 0.7942 GB, free: 13.16 MB / 0.5762 GB Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.001198/0.8121, allocations: 0.7097 MB / 0.7949 GB, free: 12.72 MB / 0.5762 GB Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 2.535e-06/0.8121, allocations: 0 / 0.7949 GB, free: 12.72 MB / 0.5762 GB Notification: Performance of matching and sorting (n=88) (initialization_lambda0): time 0.004285/0.8163, allocations: 1.267 MB / 0.7962 GB, free: 12.09 MB / 0.5762 GB Notification: Performance of prepare postOptimizeDAE: time 1.671e-05/0.8164, allocations: 5.938 kB / 0.7962 GB, free: 12.09 MB / 0.5762 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 7.404e-06/0.8164, allocations: 5.531 kB / 0.7962 GB, free: 12.09 MB / 0.5762 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.0004618/0.8168, allocations: 146.6 kB / 0.7963 GB, free: 12.01 MB / 0.5762 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0005642/0.8174, allocations: 152.4 kB / 0.7965 GB, free: 11.98 MB / 0.5762 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0006568/0.818, allocations: 0.6984 MB / 0.7971 GB, free: 11.36 MB / 0.5762 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001346/0.8194, allocations: 110.1 kB / 0.7973 GB, free: 11.29 MB / 0.5762 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 7.845e-05/0.8195, allocations: 28.23 kB / 0.7973 GB, free: 11.29 MB / 0.5762 GB Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 16 * 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 (78): * Single equations (assignments): 77 * Array equations: 0 * Algorithm blocks: 0 * Record equations: 0 * When equations: 0 * If-equations: 0 * Equation systems (not torn): 0 * Torn equation systems: 1 * Mixed (continuous/discrete) equation systems: 0 Notification: Torn system details for strict tearing set: * Linear torn systems (#iteration vars, #inner vars, density): 0 systems * Non-linear torn systems (#iteration vars, #inner vars): 1 system {(1,10)} Notification: Performance of prepare postOptimizeDAE: time 0.0002631/0.8197, allocations: 234 kB / 0.7975 GB, free: 11.07 MB / 0.5762 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0002635/0.82, allocations: 139.4 kB / 0.7976 GB, free: 10.99 MB / 0.5762 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.004183/0.8242, allocations: 1.273 MB / 0.7989 GB, free: 10.29 MB / 0.5762 GB Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.461e-05/0.8242, allocations: 5.5 kB / 0.7989 GB, free: 10.29 MB / 0.5762 GB Notification: Performance of postOpt constantLinearSystem (simulation): time 7.004e-06/0.8242, allocations: 0 / 0.7989 GB, free: 10.29 MB / 0.5762 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.003538/0.8277, allocations: 1.101 MB / 0.8 GB, free: 9.664 MB / 0.5762 GB Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.006226/0.834, allocations: 2.622 MB / 0.8025 GB, free: 7.867 MB / 0.5762 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 9.006e-06/0.834, allocations: 2.156 kB / 0.8025 GB, free: 7.867 MB / 0.5762 GB Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0004472/0.8344, allocations: 112.8 kB / 0.8026 GB, free: 7.836 MB / 0.5762 GB Notification: Performance of postOpt tearingSystem (simulation): time 0.0004436/0.8349, allocations: 132.2 kB / 0.8028 GB, free: 7.773 MB / 0.5762 GB Notification: Performance of postOpt inputDerivativesUsed (simulation): time 4.645e-05/0.8349, allocations: 20.75 kB / 0.8028 GB, free: 7.762 MB / 0.5762 GB Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.004171/0.8391, allocations: 2.624 MB / 0.8053 GB, free: 5.543 MB / 0.5762 GB Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 3.607e-06/0.8391, allocations: 6.188 kB / 0.8053 GB, free: 5.539 MB / 0.5762 GB Notification: Performance of postOpt symbolicJacobian (simulation): time 0.004904/0.844, allocations: 1.715 MB / 0.807 GB, free: 4.512 MB / 0.5762 GB Notification: Performance of postOpt removeConstants (simulation): time 0.0009043/0.8449, allocations: 311.1 kB / 0.8073 GB, free: 4.242 MB / 0.5762 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0002241/0.8451, allocations: 16.34 kB / 0.8073 GB, free: 4.234 MB / 0.5762 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0007965/0.8459, allocations: 52.98 kB / 0.8074 GB, free: 4.207 MB / 0.5762 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001497/0.8461, allocations: 64.22 kB / 0.8074 GB, free: 4.168 MB / 0.5762 GB Notification: Performance of postOpt collapseArrayExpressions (simulation): time 6.536e-05/0.8461, allocations: 33.16 kB / 0.8075 GB, free: 4.156 MB / 0.5762 GB Notification: Performance of sorting global known variables: time 0.001135/0.8473, allocations: 0.8782 MB / 0.8083 GB, free: 3.668 MB / 0.5762 GB Notification: Performance of sort global known variables: time 1e-07/0.8473, allocations: 0 / 0.8083 GB, free: 3.668 MB / 0.5762 GB Notification: Performance of remove unused functions: time 0.002024/0.8493, allocations: 0.7252 MB / 0.809 GB, free: 3.512 MB / 0.5762 GB Notification: Model statistics after passing the back-end for simulation: * Number of independent subsystems: 15 * Number of states: 2 (heaPum.con.vol.dynBal.U,heaPum.eva.vol.dynBal.U) * 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 (55): * Single equations (assignments): 50 * Array equations: 0 * Algorithm blocks: 0 * Record equations: 4 * When equations: 0 * If-equations: 0 * Equation systems (not torn): 0 * Torn equation systems: 1 * Mixed (continuous/discrete) equation systems: 0 Notification: Torn system details for strict tearing set: * Linear torn systems (#iteration vars, #inner vars, density): 0 systems * Non-linear torn systems (#iteration vars, #inner vars): 1 system {(1,10)} Notification: Performance of Backend phase and start with SimCode phase: time 0.0009839/0.8503, allocations: 466.9 kB / 0.8095 GB, free: 3.215 MB / 0.5762 GB Notification: Performance of simCode: created initialization part: time 0.002315/0.8526, allocations: 1.062 MB / 0.8105 GB, free: 2.156 MB / 0.5762 GB Notification: Performance of simCode: created event and clocks part: time 4.449e-06/0.8526, allocations: 192 / 0.8105 GB, free: 2.156 MB / 0.5762 GB Notification: Performance of simCode: created simulation system equations: time 0.001301/0.8539, allocations: 0.5425 MB / 0.8111 GB, free: 1.613 MB / 0.5762 GB Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.003575/0.8575, allocations: 0.8015 MB / 0.8118 GB, free: 0.8281 MB / 0.5762 GB Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.004229/0.8617, allocations: 2.364 MB / 0.8141 GB, free: 14.41 MB / 0.5919 GB Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0009237/0.8626, allocations: 1.168 MB / 0.8153 GB, free: 13.21 MB / 0.5919 GB Notification: Performance of simCode: all other stuff during SimCode phase: time 0.000426/0.863, allocations: 111.4 kB / 0.8154 GB, free: 13.11 MB / 0.5919 GB Notification: Performance of SimCode: time 1.182e-06/0.8631, allocations: 0 / 0.8154 GB, free: 13.11 MB / 0.5919 GB Notification: Performance of Templates: time 0.04698/0.91, allocations: 31.45 MB / 0.8461 GB, free: 13.84 MB / 0.6231 GB make -j1 -f IDEAS_dev_IDEAS.Fluid.HeatPumps.Validation.Carnot_y_etaCar.makefile (rm -f IDEAS_dev_IDEAS.Fluid.HeatPumps.Validation.Carnot_y_etaCar.pipe ; mkfifo IDEAS_dev_IDEAS.Fluid.HeatPumps.Validation.Carnot_y_etaCar.pipe ; head -c 1048576 < IDEAS_dev_IDEAS.Fluid.HeatPumps.Validation.Carnot_y_etaCar.pipe >> ../files/IDEAS_dev_IDEAS.Fluid.HeatPumps.Validation.Carnot_y_etaCar.sim & ./IDEAS_dev_IDEAS.Fluid.HeatPumps.Validation.Carnot_y_etaCar -abortSlowSimulation -alarm=480 -lv LOG_STATS > IDEAS_dev_IDEAS.Fluid.HeatPumps.Validation.Carnot_y_etaCar.pipe 2>&1)