Running: ./testmodel.py --libraries=/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IBPSA_master_IBPSA.Fluid.HeatPumps.Validation.ReciprocatingWaterToWater_VariableSpeed.conf.json
Using package ModelicaServices with version 3.2.3 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo)
Using package Modelica with version 3.2.3 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo)
Using package IBPSA with version 3.0.0 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 3.0.0-master/package.mo)
Using package Complex with version 3.2.3 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo)
Running command: translateModel(IBPSA.Fluid.HeatPumps.Validation.ReciprocatingWaterToWater_VariableSpeed,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IBPSA_master_IBPSA.Fluid.HeatPumps.Validation.ReciprocatingWaterToWater_VariableSpeed")
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo): time 0.002558/0.002563, allocations: 359.3 kB / 16.59 MB, free: 5.562 MB / 13.93 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 3.0.0-master/package.mo): time 1.421/1.421, allocations: 165.8 MB / 183.1 MB, free: 5.391 MB / 138.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 3.976/3.976, allocations: 410.8 MB / 0.6001 GB, free: 15.16 MB / 298.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo): time 0.001901/0.001901, allocations: 188.4 kB / 0.6668 GB, free: 6.945 MB / 298.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0006518/0.0006521, allocations: 8 kB / 0.7429 GB, free: 8.984 MB / 378.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.4498/0.4505, allocations: 67.45 MB / 0.8087 GB, free: 28.8 MB / 378.7 MB
Notification: Performance of NFInst.instantiate(IBPSA.Fluid.HeatPumps.Validation.ReciprocatingWaterToWater_VariableSpeed): time 0.09441/0.545, allocations: 64.45 MB / 0.8717 GB, free: 12.18 MB / 426.7 MB
Notification: Performance of NFInst.instExpressions: time 0.0282/0.5732, allocations: 12.94 MB / 0.8843 GB, free: 15.21 MB / 442.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.002934/0.5762, allocations: 63.56 kB / 0.8844 GB, free: 15.15 MB / 442.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.003778/0.58, allocations: 0.7219 MB / 0.8851 GB, free: 14.42 MB / 442.7 MB
[/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/Fluid/Sources.mo:788:36-789:54:writable] Warning: 'each' used when modifying non-array element m_flow.
[/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/Fluid/Sources.mo:786:36-787:54:writable] Warning: 'each' used when modifying non-array element m_flow.
[/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/Fluid/Sources.mo:788:36-789:54:writable] Warning: 'each' used when modifying non-array element m_flow.
[/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/Fluid/Sources.mo:786:36-787:54:writable] Warning: 'each' used when modifying non-array element m_flow.
Notification: Performance of NFTyping.typeBindings: time 0.01046/0.5906, allocations: 2.293 MB / 0.8873 GB, free: 12.12 MB / 442.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.009192/0.5998, allocations: 1.89 MB / 0.8892 GB, free: 10.26 MB / 442.7 MB
Notification: Performance of NFFlatten.flatten: time 0.009849/0.6097, allocations: 5.131 MB / 0.8942 GB, free: 5.113 MB / 442.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.003/0.6127, allocations: 1.148 MB / 0.8953 GB, free: 3.938 MB / 442.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.005121/0.6179, allocations: 1.353 MB / 0.8966 GB, free: 2.578 MB / 442.7 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.003546/0.6215, allocations: 1.132 MB / 0.8977 GB, free: 1.441 MB / 442.7 MB
Notification: Performance of NFPackage.collectConstants: time 0.0005211/0.6221, allocations: 76 kB / 0.8978 GB, free: 1.367 MB / 442.7 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.004848/0.6269, allocations: 1.087 MB / 0.8989 GB, free: 284 kB / 442.7 MB
Notification: Performance of NFScalarize.scalarize: time 0.0009512/0.628, allocations: 318.6 kB / 0.8992 GB, free: 15.96 MB / 458.7 MB
Notification: Performance of NFVerifyModel.verify: time 0.000954/0.6289, allocations: 396.8 kB / 0.8996 GB, free: 15.57 MB / 458.7 MB
Notification: Performance of NFConvertDAE.convert: time 0.005416/0.6344, allocations: 2.47 MB / 0.902 GB, free: 13.09 MB / 458.7 MB
Notification: Performance of FrontEnd - DAE generated: time 6.923e-06/0.6344, allocations: 0 / 0.902 GB, free: 13.09 MB / 458.7 MB
Notification: Performance of FrontEnd: time 3.066e-06/0.6344, allocations: 4 kB / 0.902 GB, free: 13.09 MB / 458.7 MB
Notification: Performance of Transformations before backend: time 6.668e-05/0.6345, allocations: 0 / 0.902 GB, free: 13.09 MB / 458.7 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.006347/0.6409, allocations: 1.97 MB / 0.9039 GB, free: 11.04 MB / 458.7 MB
Notification: Performance of prepare preOptimizeDAE: time 5.151e-05/0.641, allocations: 8.031 kB / 0.9039 GB, free: 11.04 MB / 458.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.009865/0.6508, allocations: 0.6963 MB / 0.9046 GB, free: 10.34 MB / 458.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.004367/0.6553, allocations: 1.505 MB / 0.906 GB, free: 8.777 MB / 458.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0002223/0.6555, allocations: 132 kB / 0.9062 GB, free: 8.641 MB / 458.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.000459/0.656, allocations: 120 kB / 0.9063 GB, free: 8.523 MB / 458.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.007361/0.6634, allocations: 1.652 MB / 0.9079 GB, free: 6.781 MB / 458.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 6.114e-05/0.6635, allocations: 11.94 kB / 0.9079 GB, free: 6.77 MB / 458.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0002691/0.6638, allocations: 51.94 kB / 0.908 GB, free: 6.719 MB / 458.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 7.431e-05/0.6639, allocations: 36 kB / 0.908 GB, free: 6.684 MB / 458.7 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.009481/0.6734, allocations: 1.488 MB / 0.9094 GB, free: 5.188 MB / 458.7 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.0215/0.6949, allocations: 6.997 MB / 0.9163 GB, free: 13.85 MB / 474.7 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.0045/0.6995, allocations: 0.7829 MB / 0.917 GB, free: 13.06 MB / 474.7 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.003283/0.7028, allocations: 0.5022 MB / 0.9175 GB, free: 12.55 MB / 474.7 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.001969/0.7048, allocations: 1.278 MB / 0.9188 GB, free: 11 MB / 474.7 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.003945/0.7088, allocations: 0.6636 MB / 0.9194 GB, free: 10.29 MB / 474.7 MB
Notification: Performance of pre-optimization done (n=69): time 7.855e-06/0.7089, allocations: 0 / 0.9194 GB, free: 10.29 MB / 474.7 MB
Notification: Performance of matching and sorting (n=69): time 0.02006/0.7289, allocations: 2.158 MB / 0.9215 GB, free: 8.105 MB / 474.7 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001832/0.7292, allocations: 332.9 kB / 0.9219 GB, free: 7.707 MB / 474.7 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.003948/0.7331, allocations: 1.371 MB / 0.9232 GB, free: 6.324 MB / 474.7 MB
Notification: Performance of collectPreVariables (initialization): time 0.0003109/0.7335, allocations: 45.7 kB / 0.9232 GB, free: 6.273 MB / 474.7 MB
Notification: Performance of collectInitialEqns (initialization): time 0.001027/0.7346, allocations: 0.6997 MB / 0.9239 GB, free: 5.566 MB / 474.7 MB
Notification: Performance of collectInitialBindings (initialization): time 0.0004824/0.7351, allocations: 240.7 kB / 0.9242 GB, free: 5.328 MB / 474.7 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0001422/0.7352, allocations: 20 kB / 0.9242 GB, free: 5.309 MB / 474.7 MB
Notification: Performance of setup shared object (initialization): time 0.0001777/0.7354, allocations: 337.9 kB / 0.9245 GB, free: 4.973 MB / 474.7 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.005212/0.7407, allocations: 0.525 MB / 0.925 GB, free: 4.449 MB / 474.7 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.004508/0.7452, allocations: 0.8247 MB / 0.9258 GB, free: 3.504 MB / 474.7 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.0042/0.7495, allocations: 0.6143 MB / 0.9264 GB, free: 2.883 MB / 474.7 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.405e-05/0.7495, allocations: 4 kB / 0.9264 GB, free: 2.879 MB / 474.7 MB
Notification: Performance of matching and sorting (n=117) (initialization): time 0.0149/0.7645, allocations: 1.833 MB / 0.9282 GB, free: 1.027 MB / 474.7 MB
Notification: Performance of prepare postOptimizeDAE: time 0.0002852/0.7648, allocations: 306.6 kB / 0.9285 GB, free: 0.6367 MB / 474.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.719e-05/0.7648, allocations: 4 kB / 0.9285 GB, free: 0.6328 MB / 474.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.00229/0.7671, allocations: 376.1 kB / 0.9289 GB, free: 272 kB / 474.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.3722/1.139, allocations: 273.9 kB / 0.9291 GB, free: 113.7 MB / 474.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.002158/1.142, allocations: 0.8946 MB / 0.93 GB, free: 113.2 MB / 474.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.004807/1.146, allocations: 296.3 kB / 0.9303 GB, free: 113.2 MB / 474.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0003565/1.147, allocations: 56.14 kB / 0.9303 GB, free: 113.2 MB / 474.7 MB
Notification: Performance of prepare postOptimizeDAE: time 1.743e-05/1.147, allocations: 4.531 kB / 0.9303 GB, free: 113.2 MB / 474.7 MB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.01432/1.161, allocations: 1.677 MB / 0.932 GB, free: 113.1 MB / 474.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 3.763e-05/1.161, allocations: 7.297 kB / 0.932 GB, free: 113.1 MB / 474.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.002175/1.164, allocations: 369.5 kB / 0.9323 GB, free: 113 MB / 474.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.003105/1.167, allocations: 278.4 kB / 0.9326 GB, free: 113 MB / 474.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.00195/1.169, allocations: 0.9036 MB / 0.9335 GB, free: 112.3 MB / 474.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.004323/1.173, allocations: 264 kB / 0.9337 GB, free: 112.3 MB / 474.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0003159/1.173, allocations: 56.64 kB / 0.9338 GB, free: 112.3 MB / 474.7 MB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 28
 * Number of states: 0 ()
 * Number of discrete variables: 7 ($whenCondition1,$PRE.heaPum.com.isOn,heaPum.com.isOn,$PRE.N.T_start,N.T_start,$PRE.N.count,N.count)
 * 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 (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 {2 17}
Notification: Performance of prepare postOptimizeDAE: time 0.001346/1.175, allocations: 465.3 kB / 0.9342 GB, free: 112 MB / 474.7 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0005751/1.175, allocations: 147.8 kB / 0.9344 GB, free: 112 MB / 474.7 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.008351/1.184, allocations: 1.273 MB / 0.9356 GB, free: 111.5 MB / 474.7 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.006996/1.191, allocations: 1.081 MB / 0.9367 GB, free: 111.1 MB / 474.7 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.254e-05/1.191, allocations: 0.875 kB / 0.9367 GB, free: 111.1 MB / 474.7 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.001327/1.192, allocations: 394.8 kB / 0.937 GB, free: 110.9 MB / 474.7 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0005838/1.193, allocations: 13.94 kB / 0.9371 GB, free: 110.8 MB / 474.7 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.003713/1.197, allocations: 159.5 kB / 0.9372 GB, free: 110.8 MB / 474.7 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0003026/1.197, allocations: 58.06 kB / 0.9373 GB, free: 110.8 MB / 474.7 MB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.01162/1.209, allocations: 1.74 MB / 0.939 GB, free: 110.1 MB / 474.7 MB
Notification: Performance of postOpt detectDAEmodeSparsePattern (simulation): time 0.011/1.22, allocations: 2.124 MB / 0.941 GB, free: 109.1 MB / 474.7 MB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.003151/1.223, allocations: 485.2 kB / 0.9415 GB, free: 108.9 MB / 474.7 MB
Notification: Performance of sorting global known variables: time 0.00263/1.226, allocations: 0.9599 MB / 0.9424 GB, free: 108.6 MB / 474.7 MB
Notification: Performance of Backend: time 1.393e-06/1.226, allocations: 1.719 kB / 0.9424 GB, free: 108.6 MB / 474.7 MB
Notification: Performance of simCode: created initialization part: time 0.01282/1.238, allocations: 2.198 MB / 0.9446 GB, free: 107.8 MB / 474.7 MB
Notification: Performance of SimCode: time 0.01109/1.25, allocations: 3.98 MB / 0.9485 GB, free: 105.1 MB / 474.7 MB
Notification: Performance of Templates: time 0.09602/1.346, allocations: 42.75 MB / 0.9902 GB, free: 62.84 MB / 474.7 MB