Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IDEAS_dev_IDEAS.Fluid.HeatPumps.Examples.HeatPump_AirWater.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.Examples.HeatPump_AirWater,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.Fluid.HeatPumps.Examples.HeatPump_AirWater")
translateModel(IDEAS.Fluid.HeatPumps.Examples.HeatPump_AirWater,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.Fluid.HeatPumps.Examples.HeatPump_AirWater")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001184/0.001184, allocations: 108.4 kB / 16.41 MB, free: 6.395 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.001154/0.001154, allocations: 189.1 kB / 17.34 MB, free: 5.836 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.264/1.264, allocations: 222.9 MB / 241 MB, free: 15.16 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0-master/package.mo): time 0.748/0.748, allocations: 135.1 MB / 426.3 MB, free: 4.105 MB / 334.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.001233/0.001233, allocations: 64.77 kB / 0.5863 GB, free: 21.71 MB / 446.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1428/0.144, allocations: 80.92 MB / 0.6653 GB, free: 5.793 MB / 0.4981 GB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/Blocks/Math.mo:543:5-544:48:writable] Warning: Parameter pump.gaiSpe.k has no value, and is fixed during initialization (fixed=true), using available start value (start=1) as default value.
Notification: Performance of NFInst.instantiate(IDEAS.Fluid.HeatPumps.Examples.HeatPump_AirWater): time 0.04697/0.1911, allocations: 49.6 MB / 0.7137 GB, free: 4.02 MB / 0.545 GB
Notification: Performance of NFInst.instExpressions: time 0.5089/0.7, allocations: 169.9 MB / 0.8797 GB, free: 3.305 MB / 0.6387 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.003818/0.7038, allocations: 95.5 kB / 0.8798 GB, free: 3.211 MB / 0.6387 GB
Notification: Performance of NFTyping.typeComponents: time 0.004954/0.7088, allocations: 2.817 MB / 0.8825 GB, free: 392 kB / 0.6387 GB
Notification: Performance of NFTyping.typeBindings: time 0.008756/0.7176, allocations: 3.659 MB / 0.8861 GB, free: 12.71 MB / 0.6544 GB
Notification: Performance of NFTyping.typeClassSections: time 0.009055/0.7266, allocations: 3.857 MB / 0.8899 GB, free: 8.902 MB / 0.6544 GB
Notification: Performance of NFFlatten.flatten: time 0.0126/0.7393, allocations: 9.33 MB / 0.899 GB, free: 15.56 MB / 0.67 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.01027/0.7496, allocations: 6.231 MB / 0.9051 GB, free: 9.238 MB / 0.67 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.008336/0.7579, allocations: 3.875 MB / 0.9088 GB, free: 5.367 MB / 0.67 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.00614/0.7641, allocations: 3.771 MB / 0.9125 GB, free: 1.582 MB / 0.67 GB
Notification: Performance of NFPackage.collectConstants: time 0.002115/0.7662, allocations: 0.6367 MB / 0.9131 GB, free: 0.9453 MB / 0.67 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.005734/0.772, allocations: 2.443 MB / 0.9155 GB, free: 14.5 MB / 0.6856 GB
Notification: Performance of NFScalarize.scalarize: time 0.002464/0.7745, allocations: 1.826 MB / 0.9173 GB, free: 12.67 MB / 0.6856 GB
Notification: Performance of NFVerifyModel.verify: time 0.005171/0.7797, allocations: 3.256 MB / 0.9205 GB, free: 9.395 MB / 0.6856 GB
Notification: Performance of NFConvertDAE.convert: time 0.01476/0.7944, allocations: 9.917 MB / 0.9302 GB, free: 15.45 MB / 0.7012 GB
Notification: Performance of FrontEnd - DAE generated: time 1.465e-05/0.7945, allocations: 0 / 0.9302 GB, free: 15.45 MB / 0.7012 GB
Notification: Performance of FrontEnd: time 1.954e-06/0.7945, allocations: 4 kB / 0.9302 GB, free: 15.45 MB / 0.7012 GB
Notification: Performance of Transformations before backend: time 0.0003176/0.7948, allocations: 0 / 0.9302 GB, free: 15.45 MB / 0.7012 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 1044
 * Number of variables: 1044
Notification: Performance of Generate backend data structure: time 0.01757/0.8124, allocations: 7.266 MB / 0.9373 GB, free: 8.09 MB / 0.7012 GB
Notification: Performance of prepare preOptimizeDAE: time 4.754e-05/0.8125, allocations: 13.11 kB / 0.9373 GB, free: 8.078 MB / 0.7012 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01317/0.8257, allocations: 1.954 MB / 0.9392 GB, free: 6.117 MB / 0.7012 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.009158/0.8349, allocations: 4.069 MB / 0.9432 GB, free: 1.977 MB / 0.7012 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0003293/0.8352, allocations: 345.8 kB / 0.9435 GB, free: 1.629 MB / 0.7012 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.001189/0.8364, allocations: 404 kB / 0.9439 GB, free: 1.234 MB / 0.7012 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.01305/0.8495, allocations: 5.811 MB / 0.9496 GB, free: 11.26 MB / 0.7169 GB
Notification: Performance of preOpt findStateOrder (simulation): time 7.866e-05/0.8496, allocations: 7.875 kB / 0.9496 GB, free: 11.25 MB / 0.7169 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0004725/0.8501, allocations: 172 kB / 0.9497 GB, free: 11.08 MB / 0.7169 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 6.837e-05/0.8502, allocations: 100 kB / 0.9498 GB, free: 10.98 MB / 0.7169 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.01468/0.8649, allocations: 6.104 MB / 0.9558 GB, free: 4.875 MB / 0.7169 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.03588/0.9008, allocations: 21.83 MB / 0.9771 GB, free: 14.07 MB / 0.7481 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.01279/0.9136, allocations: 4.907 MB / 0.9819 GB, free: 9.172 MB / 0.7481 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.004782/0.9184, allocations: 2.049 MB / 0.9839 GB, free: 7.113 MB / 0.7481 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.01528/0.9337, allocations: 9.504 MB / 0.9932 GB, free: 13.21 MB / 0.7637 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.005422/0.9392, allocations: 2.427 MB / 0.9956 GB, free: 10.72 MB / 0.7637 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.001245/0.9405, allocations: 226.1 kB / 0.9958 GB, free: 10.5 MB / 0.7637 GB
Notification: Performance of pre-optimization done (n=272): time 7.314e-06/0.9405, allocations: 3.984 kB / 0.9958 GB, free: 10.5 MB / 0.7637 GB
Notification: Performance of matching and sorting (n=272): time 0.01909/0.9596, allocations: 6.983 MB / 1.003 GB, free: 3.375 MB / 0.7637 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001184/0.9597, allocations: 265.4 kB / 1.003 GB, free: 3.059 MB / 0.7637 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.00846/0.9682, allocations: 6.876 MB / 1.01 GB, free: 12.2 MB / 0.7794 GB
Notification: Performance of collectPreVariables (initialization): time 0.0007196/0.9689, allocations: 77.7 kB / 1.01 GB, free: 12.11 MB / 0.7794 GB
Notification: Performance of collectInitialEqns (initialization): time 0.002554/0.9715, allocations: 2.66 MB / 1.012 GB, free: 9.441 MB / 0.7794 GB
Notification: Performance of collectInitialBindings (initialization): time 0.001294/0.9728, allocations: 0.9644 MB / 1.013 GB, free: 8.469 MB / 0.7794 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.00123/0.974, allocations: 0.7134 MB / 1.014 GB, free: 7.746 MB / 0.7794 GB
Notification: Performance of setup shared object (initialization): time 9.034e-05/0.9741, allocations: 305.1 kB / 1.014 GB, free: 7.445 MB / 0.7794 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.004814/0.979, allocations: 1.944 MB / 1.016 GB, free: 5.492 MB / 0.7794 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.005473/0.9845, allocations: 2.627 MB / 1.019 GB, free: 2.602 MB / 0.7794 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.1825/1.167, allocations: 34.15 MB / 1.052 GB, free: 116 kB / 0.8106 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.655e-05/1.167, allocations: 8 kB / 1.052 GB, free: 108 kB / 0.8106 GB
Notification: Performance of matching and sorting (n=395) (initialization): time 0.01431/1.181, allocations: 5.587 MB / 1.057 GB, free: 10.45 MB / 0.8262 GB
Notification: Performance of prepare postOptimizeDAE: time 3.275e-05/1.181, allocations: 14.03 kB / 1.057 GB, free: 10.43 MB / 0.8262 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 3.078e-05/1.181, allocations: 19.98 kB / 1.057 GB, free: 10.41 MB / 0.8262 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001052/1.182, allocations: 254.7 kB / 1.058 GB, free: 10.16 MB / 0.8262 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.005153/1.188, allocations: 0.9437 MB / 1.059 GB, free: 9.211 MB / 0.8262 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.006255/1.194, allocations: 5.083 MB / 1.064 GB, free: 3.711 MB / 0.8262 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.005142/1.199, allocations: 404 kB / 1.064 GB, free: 3.316 MB / 0.8262 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.000692/1.2, allocations: 195.8 kB / 1.064 GB, free: 3.125 MB / 0.8262 GB
Warning: Assuming fixed start value for the following 1 variables:
         heater.vol.dynBal.U:VARIABLE(start = 0.004017734279107983 * heater.vol.dynBal.rho_start * IDEAS.Fluid.HeatPumps.Examples.HeatPump_AirWater.heater.vol.dynBal.Medium.specificInternalEnergy(IDEAS.Fluid.HeatPumps.Examples.HeatPump_AirWater.heater.vol.dynBal.Medium.setState_pTX(heater.vol.dynBal.p_start, heater.vol.dynBal.T_start, {})) + (heater.vol.dynBal.T_start - 298.15) * 1e4 unit = "J" fixed = true nominal = 1e5 protected = true )  "Internal energy of fluid" type: Real
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.3207/1.521, allocations: 3.542 MB / 1.068 GB, free: 315.5 MB / 0.8262 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.007119/1.528, allocations: 2.631 MB / 1.07 GB, free: 314.8 MB / 0.8262 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.1779/1.706, allocations: 34.11 MB / 1.104 GB, free: 308.6 MB / 0.8262 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 2.61e-05/1.706, allocations: 8 kB / 1.104 GB, free: 308.6 MB / 0.8262 GB
Notification: Performance of matching and sorting (n=395) (initialization_lambda0): time 0.01286/1.719, allocations: 5.595 MB / 1.109 GB, free: 303.2 MB / 0.8262 GB
Notification: Performance of prepare postOptimizeDAE: time 2.398e-05/1.719, allocations: 15.38 kB / 1.109 GB, free: 303.2 MB / 0.8262 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.337e-05/1.719, allocations: 16 kB / 1.109 GB, free: 303.2 MB / 0.8262 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0009087/1.72, allocations: 258.8 kB / 1.109 GB, free: 302.9 MB / 0.8262 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.004131/1.724, allocations: 0.9476 MB / 1.11 GB, free: 301.9 MB / 0.8262 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.004923/1.729, allocations: 5.061 MB / 1.115 GB, free: 296.5 MB / 0.8262 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.005198/1.734, allocations: 404.6 kB / 1.116 GB, free: 296.1 MB / 0.8262 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0005623/1.734, allocations: 191.8 kB / 1.116 GB, free: 295.9 MB / 0.8262 GB
Warning: Assuming fixed start value for the following 1 variables:
         heater.vol.dynBal.U:VARIABLE(start = 0.004017734279107983 * heater.vol.dynBal.rho_start * IDEAS.Fluid.HeatPumps.Examples.HeatPump_AirWater.heater.vol.dynBal.Medium.specificInternalEnergy(IDEAS.Fluid.HeatPumps.Examples.HeatPump_AirWater.heater.vol.dynBal.Medium.setState_pTX(heater.vol.dynBal.p_start, heater.vol.dynBal.T_start, {})) + (heater.vol.dynBal.T_start - 298.15) * 1e4 unit = "J" fixed = true nominal = 1e5 protected = true )  "Internal energy of fluid" type: Real
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 78
 * Number of states: 0 ()
 * Number of discrete variables: 17 (heater.booleanExpression.y,sim.weaDat.conTim.canRepeatWeatherFile,sim.weaDat.conTimMin.canRepeatWeatherFile,$PRE.heater.heatSource.onOff.y_boolean,sim.radSol[1].solAzi.outsidePolarCircle,sim.radSol[2].solAzi.outsidePolarCircle,sim.radSol[3].solAzi.outsidePolarCircle,sim.radSol[4].solAzi.outsidePolarCircle,sim.radSol[5].solAzi.outsidePolarCircle,sim.radSol[6].solAzi.outsidePolarCircle,sim.weaDat.conTim.tNext,$PRE.sim.weaDat.conTim.tNext,sim.weaDat.conTimMin.tNext,$PRE.sim.weaDat.conTimMin.tNext,heater.heatSource.onOff.y_boolean,$whenCondition1,$whenCondition2)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (388):
 * Single equations (assignments): 384
 * Array equations: 1
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 3
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 1 system
   {(1,2,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 2 systems
   {(1,2), (1,2)}
Notification: Performance of prepare postOptimizeDAE: time 0.0009114/1.735, allocations: 411.3 kB / 1.116 GB, free: 295.5 MB / 0.8262 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.00107/1.736, allocations: 0.531 MB / 1.117 GB, free: 295.3 MB / 0.8262 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01219/1.749, allocations: 5.596 MB / 1.122 GB, free: 289.7 MB / 0.8262 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.00857/1.757, allocations: 4.183 MB / 1.126 GB, free: 285.4 MB / 0.8262 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.867e-05/1.757, allocations: 4 kB / 1.126 GB, free: 285.4 MB / 0.8262 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.002028/1.759, allocations: 1.086 MB / 1.127 GB, free: 284.3 MB / 0.8262 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0007561/1.76, allocations: 77.73 kB / 1.127 GB, free: 284.2 MB / 0.8262 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.003156/1.763, allocations: 335.6 kB / 1.128 GB, free: 283.9 MB / 0.8262 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0004134/1.764, allocations: 196 kB / 1.128 GB, free: 283.7 MB / 0.8262 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.01103/1.775, allocations: 4.475 MB / 1.132 GB, free: 279.2 MB / 0.8262 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.01256/1.787, allocations: 6.932 MB / 1.139 GB, free: 272.2 MB / 0.8262 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.00349/1.791, allocations: 1.904 MB / 1.141 GB, free: 270.3 MB / 0.8262 GB
Notification: Performance of sorting global known variables: time 0.005882/1.797, allocations: 5.063 MB / 1.146 GB, free: 265.3 MB / 0.8262 GB
Notification: Performance of Backend: time 5.41e-07/1.797, allocations: 0 / 1.146 GB, free: 265.3 MB / 0.8262 GB
Notification: Performance of simCode: created initialization part: time 0.01813/1.815, allocations: 8.345 MB / 1.154 GB, free: 257.5 MB / 0.8262 GB
Notification: Performance of SimCode: time 0.01536/1.83, allocations: 11.49 MB / 1.165 GB, free: 246 MB / 0.8262 GB
Notification: Performance of Templates: time 0.1253/1.956, allocations: 100.4 MB / 1.263 GB, free: 146 MB / 0.8262 GB
make -j1 -f IDEAS_dev_IDEAS.Fluid.HeatPumps.Examples.HeatPump_AirWater.makefile
(rm -f IDEAS_dev_IDEAS.Fluid.HeatPumps.Examples.HeatPump_AirWater.pipe ; mkfifo IDEAS_dev_IDEAS.Fluid.HeatPumps.Examples.HeatPump_AirWater.pipe ; head -c 1048576 < IDEAS_dev_IDEAS.Fluid.HeatPumps.Examples.HeatPump_AirWater.pipe >> ../files/IDEAS_dev_IDEAS.Fluid.HeatPumps.Examples.HeatPump_AirWater.sim & ./IDEAS_dev_IDEAS.Fluid.HeatPumps.Examples.HeatPump_AirWater  -abortSlowSimulation -alarm=480 -lv LOG_STATS > IDEAS_dev_IDEAS.Fluid.HeatPumps.Examples.HeatPump_AirWater.pipe 2>&1)