Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IDEAS_dev_IDEAS.Fluid.HeatPumps.Validation.Carnot_TCon_etaPL.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_TCon_etaPL,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.Fluid.HeatPumps.Validation.Carnot_TCon_etaPL")
translateModel(IDEAS.Fluid.HeatPumps.Validation.Carnot_TCon_etaPL,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.Fluid.HeatPumps.Validation.Carnot_TCon_etaPL")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001481/0.001481, allocations: 105.9 kB / 16.27 MB, free: 6.348 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.001455/0.001455, allocations: 187.6 kB / 17.2 MB, free: 5.949 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.336/1.336, allocations: 222.9 MB / 240.9 MB, free: 15.24 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0-master/package.mo): time 0.7979/0.7979, allocations: 135.2 MB / 426.2 MB, free: 4.156 MB / 334.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.001845/0.001845, allocations: 67.89 kB / 0.506 GB, free: 8.355 MB / 430.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.3249/0.3268, allocations: 80.92 MB / 0.5851 GB, free: 25.2 MB / 446.1 MB
Notification: Performance of NFInst.instantiate(IDEAS.Fluid.HeatPumps.Validation.Carnot_TCon_etaPL): time 0.05673/0.3835, allocations: 61.19 MB / 0.6448 GB, free: 13.23 MB / 494.1 MB
Notification: Performance of NFInst.instExpressions: time 0.01778/0.4013, allocations: 11.96 MB / 0.6565 GB, free: 1.234 MB / 494.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001841/0.4032, allocations: 59.62 kB / 0.6566 GB, free: 1.176 MB / 494.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.00203/0.4053, allocations: 0.687 MB / 0.6572 GB, free: 496 kB / 494.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.005347/0.4107, allocations: 1.962 MB / 0.6591 GB, free: 14.52 MB / 0.4981 GB
Notification: Performance of NFTyping.typeClassSections: time 0.003088/0.4138, allocations: 1.198 MB / 0.6603 GB, free: 13.32 MB / 0.4981 GB
Notification: Performance of NFFlatten.flatten: time 0.004263/0.418, allocations: 3.078 MB / 0.6633 GB, free: 10.23 MB / 0.4981 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.001781/0.4198, allocations: 1.104 MB / 0.6644 GB, free: 9.098 MB / 0.4981 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.003128/0.423, allocations: 1.324 MB / 0.6657 GB, free: 7.773 MB / 0.4981 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.001716/0.4247, allocations: 0.8983 MB / 0.6666 GB, free: 6.871 MB / 0.4981 GB
Notification: Performance of NFPackage.collectConstants: time 0.0003195/0.425, allocations: 116 kB / 0.6667 GB, free: 6.758 MB / 0.4981 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.003156/0.4282, allocations: 1.45 MB / 0.6681 GB, free: 5.305 MB / 0.4981 GB
Notification: Performance of NFScalarize.scalarize: time 0.0004136/0.4286, allocations: 286.9 kB / 0.6684 GB, free: 5.023 MB / 0.4981 GB
Notification: Performance of NFVerifyModel.verify: time 0.001091/0.4297, allocations: 0.6958 MB / 0.6691 GB, free: 4.324 MB / 0.4981 GB
Notification: Performance of NFConvertDAE.convert: time 0.003922/0.4337, allocations: 2.294 MB / 0.6713 GB, free: 2.023 MB / 0.4981 GB
Notification: Performance of FrontEnd - DAE generated: time 4.449e-06/0.4337, allocations: 0 / 0.6713 GB, free: 2.023 MB / 0.4981 GB
Notification: Performance of FrontEnd: time 1.432e-06/0.4337, allocations: 0 / 0.6713 GB, free: 2.023 MB / 0.4981 GB
Notification: Performance of Transformations before backend: time 5.083e-05/0.4337, allocations: 4 kB / 0.6713 GB, free: 2.02 MB / 0.4981 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 192
 * Number of variables: 192
Notification: Performance of Generate backend data structure: time 0.003574/0.4373, allocations: 1.726 MB / 0.673 GB, free: 236 kB / 0.4981 GB
Notification: Performance of prepare preOptimizeDAE: time 3.876e-05/0.4374, allocations: 13.11 kB / 0.673 GB, free: 224 kB / 0.4981 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.002152/0.4395, allocations: 406.9 kB / 0.6734 GB, free: 15.82 MB / 0.5137 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.002099/0.4416, allocations: 1.104 MB / 0.6745 GB, free: 14.66 MB / 0.5137 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0003529/0.442, allocations: 121.9 kB / 0.6746 GB, free: 14.54 MB / 0.5137 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.000117/0.4421, allocations: 79.94 kB / 0.6747 GB, free: 14.46 MB / 0.5137 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.002008/0.4442, allocations: 1.013 MB / 0.6756 GB, free: 13.39 MB / 0.5137 GB
Notification: Performance of preOpt findStateOrder (simulation): time 1.61e-05/0.4442, allocations: 0 / 0.6756 GB, free: 13.39 MB / 0.5137 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 8.326e-05/0.4443, allocations: 32 kB / 0.6757 GB, free: 13.36 MB / 0.5137 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 1.909e-05/0.4443, allocations: 20 kB / 0.6757 GB, free: 13.34 MB / 0.5137 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.00231/0.4466, allocations: 0.8741 MB / 0.6765 GB, free: 12.46 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.007241/0.4539, allocations: 5.274 MB / 0.6817 GB, free: 6.812 MB / 0.5137 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.003381/0.4573, allocations: 0.7968 MB / 0.6825 GB, free: 6.008 MB / 0.5137 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0007426/0.458, allocations: 308.7 kB / 0.6828 GB, free: 5.703 MB / 0.5137 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.000861/0.4589, allocations: 0.9063 MB / 0.6837 GB, free: 4.594 MB / 0.5137 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.491e-05/0.4589, allocations: 38.52 kB / 0.6837 GB, free: 4.547 MB / 0.5137 GB
Notification: Performance of pre-optimization done (n=44): time 2.414e-06/0.4589, allocations: 4 kB / 0.6837 GB, free: 4.543 MB / 0.5137 GB
Notification: Performance of matching and sorting (n=44): time 0.008663/0.4676, allocations: 1.93 MB / 0.6856 GB, free: 2.582 MB / 0.5137 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 4.837e-05/0.4677, allocations: 59.39 kB / 0.6856 GB, free: 2.512 MB / 0.5137 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001757/0.4695, allocations: 1.075 MB / 0.6867 GB, free: 1.422 MB / 0.5137 GB
Notification: Performance of collectPreVariables (initialization): time 7.928e-05/0.4695, allocations: 37.7 kB / 0.6867 GB, free: 1.379 MB / 0.5137 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0004894/0.47, allocations: 0.5273 MB / 0.6872 GB, free: 0.8477 MB / 0.5137 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0001464/0.4702, allocations: 153.8 kB / 0.6874 GB, free: 0.6953 MB / 0.5137 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.000242/0.4704, allocations: 142.1 kB / 0.6875 GB, free: 0.5508 MB / 0.5137 GB
Notification: Performance of setup shared object (initialization): time 0.0001528/0.4706, allocations: 326 kB / 0.6878 GB, free: 232 kB / 0.5137 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0009315/0.4715, allocations: 315.3 kB / 0.6881 GB, free: 15.91 MB / 0.5294 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001136/0.4727, allocations: 0.5342 MB / 0.6887 GB, free: 15.28 MB / 0.5294 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.001754/0.4744, allocations: 0.7146 MB / 0.6893 GB, free: 14.5 MB / 0.5294 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 9.879e-06/0.4745, allocations: 7.938 kB / 0.6894 GB, free: 14.49 MB / 0.5294 GB
Notification: Performance of matching and sorting (n=71) (initialization): time 0.003789/0.4783, allocations: 1.168 MB / 0.6905 GB, free: 13.31 MB / 0.5294 GB
Notification: Performance of prepare postOptimizeDAE: time 2.275e-05/0.4783, allocations: 10.41 kB / 0.6905 GB, free: 13.3 MB / 0.5294 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.104e-05/0.4783, allocations: 8 kB / 0.6905 GB, free: 13.3 MB / 0.5294 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001273/0.4796, allocations: 320.5 kB / 0.6908 GB, free: 12.98 MB / 0.5294 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0005351/0.4801, allocations: 127.8 kB / 0.6909 GB, free: 12.86 MB / 0.5294 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.001552/0.4817, allocations: 0.9142 MB / 0.6918 GB, free: 11.92 MB / 0.5294 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001202/0.4829, allocations: 159.8 kB / 0.692 GB, free: 11.76 MB / 0.5294 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 7.168e-05/0.483, allocations: 31.98 kB / 0.692 GB, free: 11.73 MB / 0.5294 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.001248/0.4843, allocations: 0.509 MB / 0.6925 GB, free: 11.21 MB / 0.5294 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.001116/0.4854, allocations: 0.5368 MB / 0.693 GB, free: 10.58 MB / 0.5294 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.001724/0.4871, allocations: 0.7174 MB / 0.6937 GB, free: 9.797 MB / 0.5294 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 4.739e-06/0.4871, allocations: 11.94 kB / 0.6938 GB, free: 9.785 MB / 0.5294 GB
Notification: Performance of matching and sorting (n=71) (initialization_lambda0): time 0.003621/0.4908, allocations: 1.156 MB / 0.6949 GB, free: 8.621 MB / 0.5294 GB
Notification: Performance of prepare postOptimizeDAE: time 1.496e-05/0.4908, allocations: 8 kB / 0.6949 GB, free: 8.613 MB / 0.5294 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.132e-05/0.4908, allocations: 4 kB / 0.6949 GB, free: 8.609 MB / 0.5294 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001113/0.4919, allocations: 316.6 kB / 0.6952 GB, free: 8.297 MB / 0.5294 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0005368/0.4925, allocations: 127.7 kB / 0.6953 GB, free: 8.172 MB / 0.5294 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.001504/0.494, allocations: 0.9152 MB / 0.6962 GB, free: 7.23 MB / 0.5294 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001251/0.4953, allocations: 131.7 kB / 0.6963 GB, free: 7.102 MB / 0.5294 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 6.856e-05/0.4953, allocations: 31.98 kB / 0.6964 GB, free: 7.07 MB / 0.5294 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 22
 * 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 (57):
 * Single equations (assignments): 56
 * 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,14)}
Notification: Performance of prepare postOptimizeDAE: time 0.0002625/0.4956, allocations: 228.9 kB / 0.6966 GB, free: 6.84 MB / 0.5294 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0001997/0.4958, allocations: 110.6 kB / 0.6967 GB, free: 6.73 MB / 0.5294 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.003921/0.4997, allocations: 1.119 MB / 0.6978 GB, free: 5.602 MB / 0.5294 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.539e-05/0.4998, allocations: 11.92 kB / 0.6978 GB, free: 5.59 MB / 0.5294 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 5.67e-06/0.4998, allocations: 0 / 0.6978 GB, free: 5.59 MB / 0.5294 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 5.851e-06/0.4998, allocations: 0 / 0.6978 GB, free: 5.59 MB / 0.5294 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.005221/0.505, allocations: 2.191 MB / 0.6999 GB, free: 3.316 MB / 0.5294 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 7.474e-06/0.505, allocations: 0 / 0.6999 GB, free: 3.316 MB / 0.5294 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0002828/0.5053, allocations: 71.83 kB / 0.7 GB, free: 3.246 MB / 0.5294 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.00104/0.5064, allocations: 300.9 kB / 0.7003 GB, free: 2.949 MB / 0.5294 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 3.971e-05/0.5064, allocations: 15.98 kB / 0.7003 GB, free: 2.934 MB / 0.5294 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.001572/0.508, allocations: 0.9425 MB / 0.7012 GB, free: 1.965 MB / 0.5294 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 6.081e-06/0.508, allocations: 7.938 kB / 0.7012 GB, free: 1.957 MB / 0.5294 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.003802/0.5118, allocations: 1.185 MB / 0.7024 GB, free: 0.7227 MB / 0.5294 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0004933/0.5123, allocations: 263.6 kB / 0.7026 GB, free: 456 kB / 0.5294 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001404/0.5125, allocations: 12 kB / 0.7027 GB, free: 444 kB / 0.5294 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0007883/0.5133, allocations: 71.91 kB / 0.7027 GB, free: 372 kB / 0.5294 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 9.205e-05/0.5134, allocations: 43.88 kB / 0.7028 GB, free: 328 kB / 0.5294 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 5.111e-05/0.5134, allocations: 23.98 kB / 0.7028 GB, free: 304 kB / 0.5294 GB
Notification: Performance of sorting global known variables: time 0.00125/0.5147, allocations: 0.7552 MB / 0.7035 GB, free: 15.53 MB / 0.545 GB
Notification: Performance of sort global known variables: time 1.71e-07/0.5147, allocations: 0 / 0.7035 GB, free: 15.53 MB / 0.545 GB
Notification: Performance of remove unused functions: time 0.001521/0.5162, allocations: 0.5731 MB / 0.7041 GB, free: 14.96 MB / 0.545 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 10
 * 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 simulation (34):
 * Single equations (assignments): 29
 * 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,16)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.0007845/0.517, allocations: 399.5 kB / 0.7045 GB, free: 14.58 MB / 0.545 GB
Notification: Performance of simCode: created initialization part: time 0.003342/0.5204, allocations: 1.163 MB / 0.7056 GB, free: 13.41 MB / 0.545 GB
Notification: Performance of simCode: created event and clocks part: time 4.018e-06/0.5204, allocations: 0 / 0.7056 GB, free: 13.41 MB / 0.545 GB
Notification: Performance of simCode: created simulation system equations: time 0.0009008/0.5213, allocations: 350.7 kB / 0.7059 GB, free: 13.07 MB / 0.545 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.002196/0.5235, allocations: 0.5099 MB / 0.7064 GB, free: 12.59 MB / 0.545 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.005264/0.5288, allocations: 2.078 MB / 0.7085 GB, free: 10.46 MB / 0.545 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0007178/0.5295, allocations: 1.065 MB / 0.7095 GB, free: 9.359 MB / 0.545 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.000247/0.5298, allocations: 91.3 kB / 0.7096 GB, free: 9.27 MB / 0.545 GB
Notification: Performance of SimCode: time 4.21e-07/0.5298, allocations: 0 / 0.7096 GB, free: 9.27 MB / 0.545 GB
Notification: Performance of Templates: time 0.03522/0.565, allocations: 24.2 MB / 0.7332 GB, free: 1.23 MB / 0.5606 GB
make -j1 -f IDEAS_dev_IDEAS.Fluid.HeatPumps.Validation.Carnot_TCon_etaPL.makefile
(rm -f IDEAS_dev_IDEAS.Fluid.HeatPumps.Validation.Carnot_TCon_etaPL.pipe ; mkfifo IDEAS_dev_IDEAS.Fluid.HeatPumps.Validation.Carnot_TCon_etaPL.pipe ; head -c 1048576 < IDEAS_dev_IDEAS.Fluid.HeatPumps.Validation.Carnot_TCon_etaPL.pipe >> ../files/IDEAS_dev_IDEAS.Fluid.HeatPumps.Validation.Carnot_TCon_etaPL.sim & ./IDEAS_dev_IDEAS.Fluid.HeatPumps.Validation.Carnot_TCon_etaPL  -abortSlowSimulation -alarm=480 -lv LOG_STATS > IDEAS_dev_IDEAS.Fluid.HeatPumps.Validation.Carnot_TCon_etaPL.pipe 2>&1)