Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IBPSA_latest_IBPSA.Fluid.HeatPumps.Validation.ReciprocatingWaterToWater_VariableSpeed.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/IBPSA 4.0.0-master/package.mo", uses=false)
Using package IBPSA with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 4.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(IBPSA.Fluid.HeatPumps.Validation.ReciprocatingWaterToWater_VariableSpeed,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IBPSA_latest_IBPSA.Fluid.HeatPumps.Validation.ReciprocatingWaterToWater_VariableSpeed")
translateModel(IBPSA.Fluid.HeatPumps.Validation.ReciprocatingWaterToWater_VariableSpeed,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IBPSA_latest_IBPSA.Fluid.HeatPumps.Validation.ReciprocatingWaterToWater_VariableSpeed")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.0009929/0.0009929, allocations: 93.73 kB / 16.02 MB, free: 84 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.001285/0.001285, allocations: 172.8 kB / 16.91 MB, free: 6.68 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.367/1.367, allocations: 223.3 MB / 241 MB, free: 5.34 MB / 190.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 4.0.0-master/package.mo): time 0.6773/0.6773, allocations: 115.5 MB / 407.6 MB, free: 2.684 MB / 334.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.000285/0.0002849, allocations: 8 kB / 495.9 MB, free: 6.348 MB / 350.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1377/0.138, allocations: 77.54 MB / 0.56 GB, free: 9.023 MB / 430.1 MB
Notification: Performance of NFInst.instantiate(IBPSA.Fluid.HeatPumps.Validation.ReciprocatingWaterToWater_VariableSpeed): time 0.3154/0.4534, allocations: 68.25 MB / 0.6266 GB, free: 9.539 MB / 462.1 MB
Notification: Performance of NFInst.instExpressions: time 0.02182/0.4753, allocations: 14.51 MB / 0.6408 GB, free: 14.92 MB / 478.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.002834/0.4782, allocations: 65.53 kB / 0.6408 GB, free: 14.89 MB / 478.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.002822/0.481, allocations: 0.7556 MB / 0.6416 GB, free: 14.25 MB / 478.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.007126/0.4882, allocations: 2.353 MB / 0.6439 GB, free: 12.38 MB / 478.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.004987/0.4932, allocations: 1.789 MB / 0.6456 GB, free: 11.05 MB / 478.1 MB
Notification: Performance of NFFlatten.flatten: time 0.007185/0.5004, allocations: 5.952 MB / 0.6514 GB, free: 7.734 MB / 478.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.00208/0.5025, allocations: 1.305 MB / 0.6527 GB, free: 6.922 MB / 478.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.003126/0.5056, allocations: 1.435 MB / 0.6541 GB, free: 6.137 MB / 478.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.002289/0.5079, allocations: 1.21 MB / 0.6553 GB, free: 5.184 MB / 478.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.000304/0.5082, allocations: 68 kB / 0.6554 GB, free: 5.117 MB / 478.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.004094/0.5123, allocations: 1.743 MB / 0.6571 GB, free: 3.371 MB / 478.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.0004101/0.5128, allocations: 334.5 kB / 0.6574 GB, free: 3.043 MB / 478.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.001226/0.514, allocations: 0.9111 MB / 0.6583 GB, free: 2.121 MB / 478.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.004803/0.5188, allocations: 3.376 MB / 0.6616 GB, free: 14.73 MB / 494.1 MB
Notification: Performance of FrontEnd - DAE generated: time 4.548e-06/0.5189, allocations: 0 / 0.6616 GB, free: 14.73 MB / 494.1 MB
Notification: Performance of FrontEnd: time 1.472e-06/0.5189, allocations: 0 / 0.6616 GB, free: 14.73 MB / 494.1 MB
Notification: Performance of Transformations before backend: time 2.642e-05/0.5189, allocations: 0 / 0.6616 GB, free: 14.73 MB / 494.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 296
 * Number of variables: 296
Notification: Performance of Generate backend data structure: time 0.003678/0.5226, allocations: 2 MB / 0.6635 GB, free: 12.66 MB / 494.1 MB
Notification: Performance of prepare preOptimizeDAE: time 3.837e-05/0.5226, allocations: 8.031 kB / 0.6635 GB, free: 12.66 MB / 494.1 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.00509/0.5277, allocations: 0.6973 MB / 0.6642 GB, free: 11.96 MB / 494.1 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.002419/0.5302, allocations: 1.565 MB / 0.6657 GB, free: 10.34 MB / 494.1 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001273/0.5303, allocations: 124 kB / 0.6659 GB, free: 10.21 MB / 494.1 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0002144/0.5305, allocations: 131.8 kB / 0.666 GB, free: 10.08 MB / 494.1 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.003939/0.5345, allocations: 1.664 MB / 0.6676 GB, free: 8.324 MB / 494.1 MB
Notification: Performance of preOpt findStateOrder (simulation): time 2.806e-05/0.5345, allocations: 3.938 kB / 0.6676 GB, free: 8.32 MB / 494.1 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.000146/0.5347, allocations: 52 kB / 0.6677 GB, free: 8.27 MB / 494.1 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 4.631e-05/0.5347, allocations: 39.98 kB / 0.6677 GB, free: 8.23 MB / 494.1 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.004741/0.5395, allocations: 1.496 MB / 0.6692 GB, free: 6.727 MB / 494.1 MB
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.01045/0.5499, allocations: 7.001 MB / 0.676 GB, free: 15.38 MB / 0.4981 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.002327/0.5523, allocations: 0.7802 MB / 0.6768 GB, free: 14.59 MB / 0.4981 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001667/0.554, allocations: 0.5061 MB / 0.6772 GB, free: 14.08 MB / 0.4981 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.001255/0.5553, allocations: 1.271 MB / 0.6785 GB, free: 12.54 MB / 0.4981 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.001987/0.5573, allocations: 0.6636 MB / 0.6791 GB, free: 11.84 MB / 0.4981 GB
Notification: Performance of pre-optimization done (n=69): time 3.085e-06/0.5573, allocations: 4 kB / 0.6791 GB, free: 11.83 MB / 0.4981 GB
Notification: Performance of matching and sorting (n=69): time 0.01044/0.5677, allocations: 2.173 MB / 0.6813 GB, free: 9.629 MB / 0.4981 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001406/0.5679, allocations: 325 kB / 0.6816 GB, free: 9.238 MB / 0.4981 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002168/0.5701, allocations: 1.383 MB / 0.6829 GB, free: 7.844 MB / 0.4981 GB
Notification: Performance of collectPreVariables (initialization): time 0.0001421/0.5702, allocations: 45.7 kB / 0.683 GB, free: 7.793 MB / 0.4981 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0005942/0.5708, allocations: 0.7075 MB / 0.6837 GB, free: 7.078 MB / 0.4981 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0002508/0.5711, allocations: 244.6 kB / 0.6839 GB, free: 6.836 MB / 0.4981 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0001305/0.5712, allocations: 77.67 kB / 0.684 GB, free: 6.754 MB / 0.4981 GB
Notification: Performance of setup shared object (initialization): time 0.0001232/0.5713, allocations: 345.9 kB / 0.6843 GB, free: 6.41 MB / 0.4981 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.002018/0.5734, allocations: 0.5289 MB / 0.6848 GB, free: 5.879 MB / 0.4981 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.002218/0.5756, allocations: 0.8335 MB / 0.6856 GB, free: 4.922 MB / 0.4981 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.003848/0.5795, allocations: 1.22 MB / 0.6868 GB, free: 3.613 MB / 0.4981 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 5.13e-06/0.5795, allocations: 0 / 0.6868 GB, free: 3.613 MB / 0.4981 GB
Notification: Performance of matching and sorting (n=117) (initialization): time 0.006541/0.586, allocations: 1.689 MB / 0.6885 GB, free: 1.906 MB / 0.4981 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001889/0.5862, allocations: 299 kB / 0.6887 GB, free: 1.52 MB / 0.4981 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.61e-05/0.5863, allocations: 8 kB / 0.6888 GB, free: 1.512 MB / 0.4981 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001375/0.5876, allocations: 367.2 kB / 0.6891 GB, free: 1.152 MB / 0.4981 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001493/0.5891, allocations: 283.5 kB / 0.6894 GB, free: 0.875 MB / 0.4981 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.001224/0.5904, allocations: 0.9134 MB / 0.6903 GB, free: 15.93 MB / 0.5137 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.00249/0.5929, allocations: 283.3 kB / 0.6905 GB, free: 15.66 MB / 0.5137 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.000121/0.593, allocations: 59.94 kB / 0.6906 GB, free: 15.6 MB / 0.5137 GB
Notification: Performance of prepare postOptimizeDAE: time 9.327e-06/0.593, allocations: 4 kB / 0.6906 GB, free: 15.59 MB / 0.5137 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.006156/0.5992, allocations: 1.532 MB / 0.6921 GB, free: 14.05 MB / 0.5137 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.651e-05/0.5992, allocations: 12.44 kB / 0.6921 GB, free: 14.04 MB / 0.5137 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001294/0.6005, allocations: 375.7 kB / 0.6925 GB, free: 13.68 MB / 0.5137 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001495/0.602, allocations: 283.5 kB / 0.6927 GB, free: 13.4 MB / 0.5137 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.001145/0.6032, allocations: 0.9014 MB / 0.6936 GB, free: 12.48 MB / 0.5137 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002313/0.6055, allocations: 250.8 kB / 0.6939 GB, free: 12.23 MB / 0.5137 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001161/0.6057, allocations: 59.95 kB / 0.6939 GB, free: 12.17 MB / 0.5137 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 28
 * Number of states: 0 ()
 * Number of discrete variables: 7 (N.count,$PRE.N.count,N.T_start,$PRE.N.T_start,heaPum.com.isOn,$PRE.heaPum.com.isOn,$whenCondition1)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (98):
 * Single equations (assignments): 96
 * Array equations: 0
 * Algorithm blocks: 1
 * 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
   {(2,17)}
Notification: Performance of prepare postOptimizeDAE: time 0.0008075/0.6065, allocations: 460.8 kB / 0.6944 GB, free: 11.71 MB / 0.5137 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0002677/0.6067, allocations: 154.1 kB / 0.6945 GB, free: 11.56 MB / 0.5137 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.004136/0.6109, allocations: 1.27 MB / 0.6957 GB, free: 10.27 MB / 0.5137 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.493e-05/0.6109, allocations: 8 kB / 0.6957 GB, free: 10.27 MB / 0.5137 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 7.704e-06/0.6109, allocations: 0 / 0.6957 GB, free: 10.27 MB / 0.5137 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.003557/0.6145, allocations: 1.096 MB / 0.6968 GB, free: 9.133 MB / 0.5137 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.007703/0.6222, allocations: 3.338 MB / 0.7001 GB, free: 5.676 MB / 0.5137 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.049e-05/0.6223, allocations: 4 kB / 0.7001 GB, free: 5.672 MB / 0.5137 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.001016/0.6233, allocations: 163.8 kB / 0.7002 GB, free: 5.512 MB / 0.5137 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.001281/0.6246, allocations: 358.4 kB / 0.7006 GB, free: 5.16 MB / 0.5137 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 7.541e-05/0.6247, allocations: 27.97 kB / 0.7006 GB, free: 5.133 MB / 0.5137 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.001187/0.6259, allocations: 0.9055 MB / 0.7015 GB, free: 4.203 MB / 0.5137 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 7.814e-06/0.6259, allocations: 11.94 kB / 0.7015 GB, free: 4.191 MB / 0.5137 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.006028/0.6319, allocations: 1.957 MB / 0.7034 GB, free: 2.156 MB / 0.5137 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0008458/0.6328, allocations: 406.8 kB / 0.7038 GB, free: 1.738 MB / 0.5137 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0002258/0.633, allocations: 28.11 kB / 0.7038 GB, free: 1.711 MB / 0.5137 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001795/0.6348, allocations: 159.9 kB / 0.704 GB, free: 1.555 MB / 0.5137 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001426/0.635, allocations: 64.23 kB / 0.704 GB, free: 1.492 MB / 0.5137 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 8.495e-05/0.6351, allocations: 43.95 kB / 0.7041 GB, free: 1.449 MB / 0.5137 GB
Notification: Performance of sorting global known variables: time 0.001611/0.6367, allocations: 0.9901 MB / 0.7051 GB, free: 472 kB / 0.5137 GB
Notification: Performance of sort global known variables: time 2.1e-07/0.6367, allocations: 3.938 kB / 0.7051 GB, free: 468 kB / 0.5137 GB
Notification: Performance of remove unused functions: time 0.002471/0.6392, allocations: 0.9007 MB / 0.7059 GB, free: 15.55 MB / 0.5294 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 19
 * Number of states: 2 (heaPum.con.vol.dynBal.U,heaPum.eva.vol.dynBal.U)
 * Number of discrete variables: 4 ($whenCondition1,heaPum.com.isOn,N.T_start,N.count)
 * Number of discrete states: 2 (N.count,heaPum.com.isOn)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (51):
 * Single equations (assignments): 46
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 2
 * When equations: 2
 * 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
   {(2,17)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.001134/0.6403, allocations: 0.538 MB / 0.7065 GB, free: 15.02 MB / 0.5294 GB
Notification: Performance of simCode: created initialization part: time 0.006695/0.647, allocations: 2.023 MB / 0.7084 GB, free: 12.98 MB / 0.5294 GB
Notification: Performance of simCode: created event and clocks part: time 1.096e-05/0.6471, allocations: 4 kB / 0.7084 GB, free: 12.98 MB / 0.5294 GB
Notification: Performance of simCode: created simulation system equations: time 0.00197/0.649, allocations: 0.5681 MB / 0.709 GB, free: 12.41 MB / 0.5294 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.005022/0.6541, allocations: 0.8198 MB / 0.7098 GB, free: 11.61 MB / 0.5294 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.006166/0.6603, allocations: 3.305 MB / 0.713 GB, free: 8.219 MB / 0.5294 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0007872/0.6611, allocations: 1.219 MB / 0.7142 GB, free: 6.973 MB / 0.5294 GB
Notification: Performance of simCode: alias equations: time 0.001865/0.663, allocations: 373.1 kB / 0.7146 GB, free: 6.613 MB / 0.5294 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0003622/0.6633, allocations: 131.3 kB / 0.7147 GB, free: 6.484 MB / 0.5294 GB
Notification: Performance of SimCode: time 8.32e-07/0.6633, allocations: 4 kB / 0.7147 GB, free: 6.48 MB / 0.5294 GB
Notification: Performance of Templates: time 0.06227/0.7256, allocations: 38.07 MB / 0.7519 GB, free: 0.8242 MB / 0.5606 GB
make -j1 -f IBPSA_latest_IBPSA.Fluid.HeatPumps.Validation.ReciprocatingWaterToWater_VariableSpeed.makefile
(rm -f IBPSA_latest_IBPSA.Fluid.HeatPumps.Validation.ReciprocatingWaterToWater_VariableSpeed.pipe ; mkfifo IBPSA_latest_IBPSA.Fluid.HeatPumps.Validation.ReciprocatingWaterToWater_VariableSpeed.pipe ; head -c 1048576 < IBPSA_latest_IBPSA.Fluid.HeatPumps.Validation.ReciprocatingWaterToWater_VariableSpeed.pipe >> ../files/IBPSA_latest_IBPSA.Fluid.HeatPumps.Validation.ReciprocatingWaterToWater_VariableSpeed.sim & ./IBPSA_latest_IBPSA.Fluid.HeatPumps.Validation.ReciprocatingWaterToWater_VariableSpeed  -abortSlowSimulation -alarm=480 -lv LOG_STATS > IBPSA_latest_IBPSA.Fluid.HeatPumps.Validation.ReciprocatingWaterToWater_VariableSpeed.pipe 2>&1)