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: "" <> buildModelFMU(IDEAS.Fluid.HeatPumps.Validation.Carnot_y_etaCar,fileNamePrefix="IDEAS_dev_IDEAS_Fluid_HeatPumps_Validation_Carnot_y_etaCar",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(IDEAS.Fluid.HeatPumps.Validation.Carnot_y_etaCar,fileNamePrefix="IDEAS_dev_IDEAS_Fluid_HeatPumps_Validation_Carnot_y_etaCar",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.0009045/0.0009042, allocations: 84.38 kB / 15.06 MB, free: 1.09 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.0007891/0.0007891, allocations: 168.7 kB / 15.95 MB, free: 204 kB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.32/1.32, allocations: 223.2 MB / 240 MB, free: 5.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.8821/0.8821, allocations: 135.3 MB / 426.3 MB, free: 14.32 MB / 350.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.0003174/0.0003176, allocations: 13.06 kB / 0.5071 GB, free: 5.012 MB / 414.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1471/0.1474, allocations: 82.3 MB / 0.5875 GB, free: 2.879 MB / 494.1 MB
Notification: Performance of NFInst.instantiate(IDEAS.Fluid.HeatPumps.Validation.Carnot_y_etaCar): time 0.3226/0.4701, allocations: 69.43 MB / 0.6553 GB, free: 11.02 MB / 0.4981 GB
Notification: Performance of NFInst.instExpressions: time 0.01505/0.4852, allocations: 14.16 MB / 0.6691 GB, free: 0.8164 MB / 0.4981 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.002401/0.4876, allocations: 57.34 kB / 0.6692 GB, free: 0.793 MB / 0.4981 GB
Notification: Performance of NFTyping.typeComponents: time 0.001768/0.4894, allocations: 0.5655 MB / 0.6697 GB, free: 492 kB / 0.4981 GB
Notification: Performance of NFTyping.typeBindings: time 0.005859/0.4953, allocations: 1.987 MB / 0.6716 GB, free: 15.33 MB / 0.5137 GB
Notification: Performance of NFTyping.typeClassSections: time 0.003301/0.4986, allocations: 0.968 MB / 0.6726 GB, free: 14.87 MB / 0.5137 GB
Notification: Performance of NFFlatten.flatten: time 0.007303/0.5059, allocations: 4.802 MB / 0.6773 GB, free: 12.83 MB / 0.5137 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.002178/0.5081, allocations: 1.026 MB / 0.6783 GB, free: 12.44 MB / 0.5137 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.003325/0.5114, allocations: 1.273 MB / 0.6795 GB, free: 11.92 MB / 0.5137 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.00242/0.5139, allocations: 1.086 MB / 0.6806 GB, free: 11.47 MB / 0.5137 GB
Notification: Performance of NFPackage.collectConstants: time 0.0002295/0.5141, allocations: 59.56 kB / 0.6806 GB, free: 11.47 MB / 0.5137 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.002877/0.517, allocations: 0.9204 MB / 0.6815 GB, free: 11.17 MB / 0.5137 GB
Notification: Performance of NFScalarize.scalarize: time 0.0003748/0.5174, allocations: 271.6 kB / 0.6818 GB, free: 11.04 MB / 0.5137 GB
Notification: Performance of NFVerifyModel.verify: time 0.0006528/0.5181, allocations: 355.5 kB / 0.6821 GB, free: 10.83 MB / 0.5137 GB
Notification: Performance of NFConvertDAE.convert: time 0.003054/0.5211, allocations: 2.076 MB / 0.6842 GB, free: 10.32 MB / 0.5137 GB
Notification: Performance of FrontEnd - DAE generated: time 6.502e-06/0.5211, allocations: 3.938 kB / 0.6842 GB, free: 10.32 MB / 0.5137 GB
Notification: Performance of FrontEnd: time 2.043e-06/0.5212, allocations: 3.938 kB / 0.6842 GB, free: 10.32 MB / 0.5137 GB
Notification: Performance of Transformations before backend: time 3.153e-05/0.5212, allocations: 0 / 0.6842 GB, free: 10.32 MB / 0.5137 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.003516/0.5247, allocations: 1.8 MB / 0.6859 GB, free: 9.145 MB / 0.5137 GB
Notification: Performance of prepare preOptimizeDAE: time 4.038e-05/0.5248, allocations: 10.42 kB / 0.6859 GB, free: 9.145 MB / 0.5137 GB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.0002152/0.525, allocations: 146.2 kB / 0.6861 GB, free: 9.047 MB / 0.5137 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0007308/0.5257, allocations: 241.4 kB / 0.6863 GB, free: 8.957 MB / 0.5137 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.002491/0.5282, allocations: 1.445 MB / 0.6877 GB, free: 8.082 MB / 0.5137 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 6.221e-05/0.5283, allocations: 77.33 kB / 0.6878 GB, free: 8.051 MB / 0.5137 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001437/0.5284, allocations: 100.9 kB / 0.6879 GB, free: 8.02 MB / 0.5137 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.002136/0.5306, allocations: 1.113 MB / 0.689 GB, free: 7.523 MB / 0.5137 GB
Notification: Performance of preOpt findStateOrder (simulation): time 2.777e-05/0.5306, allocations: 5.578 kB / 0.689 GB, free: 7.52 MB / 0.5137 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 8.763e-05/0.5307, allocations: 36.75 kB / 0.689 GB, free: 7.492 MB / 0.5137 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 3.794e-05/0.5308, allocations: 30.28 kB / 0.6891 GB, free: 7.488 MB / 0.5137 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.001923/0.5327, allocations: 0.9237 MB / 0.69 GB, free: 7.176 MB / 0.5137 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.006333/0.539, allocations: 4.908 MB / 0.6947 GB, free: 3.73 MB / 0.5137 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.001386/0.5404, allocations: 0.6363 MB / 0.6954 GB, free: 3.512 MB / 0.5137 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0006789/0.5411, allocations: 367.1 kB / 0.6957 GB, free: 3.395 MB / 0.5137 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0006179/0.5418, allocations: 0.8301 MB / 0.6965 GB, free: 2.438 MB / 0.5137 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.055e-05/0.5418, allocations: 37.84 kB / 0.6966 GB, free: 2.395 MB / 0.5137 GB
Notification: Performance of pre-optimization done (n=61): time 2.695e-06/0.5418, allocations: 0 / 0.6966 GB, free: 2.395 MB / 0.5137 GB
Notification: Performance of matching and sorting (n=61): time 0.006549/0.5484, allocations: 1.902 MB / 0.6984 GB, free: 1.863 MB / 0.5137 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 3.617e-05/0.5484, allocations: 57.03 kB / 0.6985 GB, free: 1.801 MB / 0.5137 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001913/0.5504, allocations: 1.204 MB / 0.6997 GB, free: 1.301 MB / 0.5137 GB
Notification: Performance of collectPreVariables (initialization): time 0.0001614/0.5505, allocations: 43.92 kB / 0.6997 GB, free: 1.258 MB / 0.5137 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0005007/0.551, allocations: 0.6091 MB / 0.7003 GB, free: 0.7734 MB / 0.5137 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0002269/0.5513, allocations: 209 kB / 0.7005 GB, free: 0.6094 MB / 0.5137 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 3.76e-05/0.5513, allocations: 15.19 kB / 0.7005 GB, free: 0.5977 MB / 0.5137 GB
Notification: Performance of setup shared object (initialization): time 0.000105/0.5514, allocations: 336.2 kB / 0.7008 GB, free: 288 kB / 0.5137 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0006253/0.5521, allocations: 290.8 kB / 0.7011 GB, free: 196 kB / 0.5137 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0007826/0.5529, allocations: 0.5061 MB / 0.7016 GB, free: 15.84 MB / 0.5294 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.0007141/0.5536, allocations: 363.6 kB / 0.7019 GB, free: 15.66 MB / 0.5294 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 4.95e-06/0.5536, allocations: 2.219 kB / 0.7019 GB, free: 15.66 MB / 0.5294 GB
Notification: Performance of matching and sorting (n=88) (initialization): time 0.004303/0.5579, allocations: 1.394 MB / 0.7033 GB, free: 15.01 MB / 0.5294 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001197/0.558, allocations: 197.1 kB / 0.7035 GB, free: 14.78 MB / 0.5294 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.086e-05/0.5581, allocations: 7.469 kB / 0.7035 GB, free: 14.78 MB / 0.5294 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0005672/0.5586, allocations: 138.5 kB / 0.7036 GB, free: 14.72 MB / 0.5294 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0006268/0.5593, allocations: 168.9 kB / 0.7038 GB, free: 14.68 MB / 0.5294 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0007788/0.5601, allocations: 0.7238 MB / 0.7045 GB, free: 14.05 MB / 0.5294 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001349/0.5614, allocations: 169.5 kB / 0.7047 GB, free: 13.95 MB / 0.5294 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 8.076e-05/0.5615, allocations: 31.17 kB / 0.7047 GB, free: 13.95 MB / 0.5294 GB
Notification: Performance of prepare postOptimizeDAE: time 9.919e-06/0.5615, allocations: 4.062 kB / 0.7047 GB, free: 13.95 MB / 0.5294 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.003928/0.5655, allocations: 1.248 MB / 0.7059 GB, free: 13.38 MB / 0.5294 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.004e-05/0.5655, allocations: 7.781 kB / 0.7059 GB, free: 13.38 MB / 0.5294 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0004791/0.566, allocations: 146.6 kB / 0.7061 GB, free: 13.31 MB / 0.5294 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0006105/0.5666, allocations: 167.2 kB / 0.7062 GB, free: 13.27 MB / 0.5294 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0007804/0.5674, allocations: 0.7135 MB / 0.7069 GB, free: 12.65 MB / 0.5294 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001405/0.5688, allocations: 162.4 kB / 0.7071 GB, free: 12.56 MB / 0.5294 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 7.676e-05/0.5689, allocations: 34.39 kB / 0.7071 GB, free: 12.55 MB / 0.5294 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 (linear and non-linear blocks): 0
 * Torn equation systems: 1
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 0
 * Non-linear torn systems: 1 {1 10}
Notification: Performance of prepare postOptimizeDAE: time 0.0008255/0.5697, allocations: 415.7 kB / 0.7075 GB, free: 12.22 MB / 0.5294 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0002781/0.57, allocations: 135.9 kB / 0.7076 GB, free: 12.15 MB / 0.5294 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.004234/0.5743, allocations: 1.404 MB / 0.709 GB, free: 11.42 MB / 0.5294 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 2.09e-05/0.5743, allocations: 7.875 kB / 0.709 GB, free: 11.42 MB / 0.5294 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 6.552e-06/0.5743, allocations: 3.938 kB / 0.709 GB, free: 11.41 MB / 0.5294 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.003597/0.5779, allocations: 1.23 MB / 0.7102 GB, free: 10.78 MB / 0.5294 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.006474/0.5844, allocations: 2.734 MB / 0.7129 GB, free: 8.969 MB / 0.5294 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 9.778e-06/0.5845, allocations: 3.781 kB / 0.7129 GB, free: 8.969 MB / 0.5294 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.000459/0.5849, allocations: 125.6 kB / 0.713 GB, free: 8.934 MB / 0.5294 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.0004372/0.5854, allocations: 135.2 kB / 0.7131 GB, free: 8.875 MB / 0.5294 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 4.882e-05/0.5854, allocations: 22.61 kB / 0.7132 GB, free: 8.859 MB / 0.5294 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.004/0.5894, allocations: 2.483 MB / 0.7156 GB, free: 6.832 MB / 0.5294 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 3.707e-06/0.5895, allocations: 3.5 kB / 0.7156 GB, free: 6.832 MB / 0.5294 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.004662/0.5941, allocations: 1.847 MB / 0.7174 GB, free: 5.793 MB / 0.5294 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0007903/0.5949, allocations: 333.7 kB / 0.7177 GB, free: 5.504 MB / 0.5294 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001912/0.5952, allocations: 21.42 kB / 0.7177 GB, free: 5.492 MB / 0.5294 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0008174/0.596, allocations: 93.62 kB / 0.7178 GB, free: 5.453 MB / 0.5294 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001085/0.5961, allocations: 56.67 kB / 0.7179 GB, free: 5.422 MB / 0.5294 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 6.225e-05/0.5962, allocations: 31.56 kB / 0.7179 GB, free: 5.41 MB / 0.5294 GB
Notification: Performance of sorting global known variables: time 0.001169/0.5973, allocations: 0.8617 MB / 0.7187 GB, free: 4.922 MB / 0.5294 GB
Notification: Performance of sort global known variables: time 1.4e-07/0.5973, allocations: 96 / 0.7187 GB, free: 4.922 MB / 0.5294 GB
Notification: Performance of remove unused functions: time 0.001971/0.5993, allocations: 0.7119 MB / 0.7194 GB, free: 4.215 MB / 0.5294 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 (linear and non-linear blocks): 0
 * Torn equation systems: 1
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 0
 * Non-linear torn systems: 1 {1 10}
Notification: Performance of Backend phase and start with SimCode phase: time 0.005595/0.6049, allocations: 2.716 MB / 0.7221 GB, free: 1.438 MB / 0.5294 GB
Notification: Performance of simCode: created initialization part: time 0.002368/0.6073, allocations: 1.152 MB / 0.7232 GB, free: 296 kB / 0.5294 GB
Notification: Performance of simCode: created event and clocks part: time 7.534e-06/0.6073, allocations: 4 kB / 0.7232 GB, free: 292 kB / 0.5294 GB
Notification: Performance of simCode: created simulation system equations: time 0.001319/0.6087, allocations: 0.5955 MB / 0.7238 GB, free: 15.68 MB / 0.545 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.003499/0.6122, allocations: 0.7738 MB / 0.7246 GB, free: 14.93 MB / 0.545 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.01776/0.6299, allocations: 8.347 MB / 0.7327 GB, free: 6.188 MB / 0.545 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0007214/0.6307, allocations: 1.183 MB / 0.7339 GB, free: 4.973 MB / 0.545 GB
Notification: Performance of simCode: alias equations: time 0.001345/0.6321, allocations: 307.4 kB / 0.7342 GB, free: 4.668 MB / 0.545 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0006279/0.6327, allocations: 0.511 MB / 0.7347 GB, free: 4.156 MB / 0.545 GB
Notification: Performance of SimCode: time 9.82e-07/0.6327, allocations: 0 / 0.7347 GB, free: 4.156 MB / 0.545 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 3.311/3.944, allocations: 42.11 MB / 0.7758 GB, free: 10.54 MB / 0.5919 GB
Notification: Performance of buildModelFMU: configured platform static using cached values: time 0.06778/4.011, allocations: 249.8 kB / 0.776 GB, free: 10.21 MB / 0.5919 GB
Notification: Performance of buildModelFMU: Generate platform static: time 4.411/8.423, allocations: 0 / 0.776 GB, free: 10.21 MB / 0.5919 GB
(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 & /home/hudson/saved_omc/OMSimulator/install/linux/bin/OMSimulator  --tempDir=temp_IDEAS_dev_IDEAS_Fluid_HeatPumps_Validation_Carnot_y_etaCar_fmu --startTime=0 --stopTime=3600 --timeout=50 --tolerance=1e-06 IDEAS_dev_IDEAS_Fluid_HeatPumps_Validation_Carnot_y_etaCar.fmu > IDEAS_dev_IDEAS.Fluid.HeatPumps.Validation.Carnot_y_etaCar.pipe 2>&1)
Environment - environmentSimulation: