Running: ./testmodel.py --libraries=/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IBPSA_master_IBPSA.Fluid.HeatPumps.Validation.ReciprocatingWaterToWater_ScalingFactor.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_ScalingFactor,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IBPSA_master_IBPSA.Fluid.HeatPumps.Validation.ReciprocatingWaterToWater_ScalingFactor")
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo): time 0.001391/0.001391, allocations: 186.4 kB / 15.77 MB, free: 6 MB / 13.93 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 3.0.0-master/package.mo): time 0.6863/0.6863, allocations: 82.92 MB / 99.41 MB, free: 3.188 MB / 74.72 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 2.162/2.162, allocations: 205.4 MB / 325.4 MB, free: 3.293 MB / 250.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo): time 0.001049/0.001048, allocations: 90.91 kB / 393.6 MB, free: 15.07 MB / 330.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0004464/0.0004467, allocations: 12 kB / 471.5 MB, free: 66.51 MB / 362.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1146/0.115, allocations: 67.46 MB / 0.5264 GB, free: 15.02 MB / 378.7 MB
Notification: Performance of NFInst.instantiate(IBPSA.Fluid.HeatPumps.Validation.ReciprocatingWaterToWater_ScalingFactor): time 0.4893/0.6044, allocations: 109.3 MB / 0.6331 GB, free: 13.49 MB / 426.7 MB
Notification: Performance of NFInst.instExpressions: time 0.03418/0.6386, allocations: 21.18 MB / 0.6538 GB, free: 13.71 MB / 442.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.004813/0.6435, allocations: 112.4 kB / 0.6539 GB, free: 13.66 MB / 442.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.005735/0.6492, allocations: 1.456 MB / 0.6553 GB, free: 12.4 MB / 442.7 MB
Notification: Performance of NFTyping.typeBindings: time 0.01596/0.6652, allocations: 4.086 MB / 0.6593 GB, free: 8.965 MB / 442.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.01259/0.6778, allocations: 3.142 MB / 0.6624 GB, free: 6.773 MB / 442.7 MB
Notification: Performance of NFFlatten.flatten: time 0.01087/0.6887, allocations: 5.056 MB / 0.6673 GB, free: 3.441 MB / 442.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.004664/0.6934, allocations: 2.268 MB / 0.6695 GB, free: 1.641 MB / 442.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.006454/0.6999, allocations: 2.437 MB / 0.6719 GB, free: 15.19 MB / 458.7 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.003571/0.7035, allocations: 1.567 MB / 0.6734 GB, free: 13.62 MB / 458.7 MB
Notification: Performance of NFPackage.collectConstants: time 0.0007666/0.7043, allocations: 128 kB / 0.6735 GB, free: 13.49 MB / 458.7 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.006796/0.7111, allocations: 1.744 MB / 0.6752 GB, free: 11.75 MB / 458.7 MB
Notification: Performance of NFScalarize.scalarize: time 0.001146/0.7123, allocations: 0.568 MB / 0.6758 GB, free: 11.18 MB / 458.7 MB
Notification: Performance of NFVerifyModel.verify: time 0.001477/0.7138, allocations: 0.7304 MB / 0.6765 GB, free: 10.44 MB / 458.7 MB
Notification: Performance of NFConvertDAE.convert: time 0.009279/0.7231, allocations: 4.553 MB / 0.681 GB, free: 5.879 MB / 458.7 MB
Notification: Performance of FrontEnd - DAE generated: time 4.173e-06/0.7232, allocations: 0 / 0.681 GB, free: 5.879 MB / 458.7 MB
Notification: Performance of FrontEnd: time 2.892e-06/0.7232, allocations: 0 / 0.681 GB, free: 5.879 MB / 458.7 MB
Notification: Performance of Transformations before backend: time 0.0001104/0.7233, allocations: 0 / 0.681 GB, free: 5.879 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: 577
 * Number of variables: 577
Notification: Performance of Generate backend data structure: time 0.0083/0.7316, allocations: 3.351 MB / 0.6842 GB, free: 2.426 MB / 458.7 MB
Notification: Performance of prepare preOptimizeDAE: time 4.284e-05/0.7317, allocations: 12.03 kB / 0.6842 GB, free: 2.414 MB / 458.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0117/0.7434, allocations: 1.369 MB / 0.6856 GB, free: 1.039 MB / 458.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.006934/0.7504, allocations: 2.679 MB / 0.6882 GB, free: 14.29 MB / 474.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0003583/0.7507, allocations: 255.9 kB / 0.6884 GB, free: 14.02 MB / 474.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0006814/0.7514, allocations: 235.9 kB / 0.6887 GB, free: 13.79 MB / 474.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.01032/0.7618, allocations: 3.126 MB / 0.6917 GB, free: 10.48 MB / 474.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 8.62e-05/0.7619, allocations: 11.92 kB / 0.6917 GB, free: 10.47 MB / 474.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0004055/0.7623, allocations: 103.9 kB / 0.6918 GB, free: 10.37 MB / 474.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001076/0.7624, allocations: 72 kB / 0.6919 GB, free: 10.3 MB / 474.7 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.0123/0.7748, allocations: 2.768 MB / 0.6946 GB, free: 7.512 MB / 474.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.02832/0.8031, allocations: 13.38 MB / 0.7077 GB, free: 9.504 MB / 490.7 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.005499/0.8087, allocations: 1.422 MB / 0.7091 GB, free: 8.074 MB / 490.7 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.002379/0.8111, allocations: 1.785 MB / 0.7108 GB, free: 5.902 MB / 490.7 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.004547/0.8157, allocations: 1.161 MB / 0.7119 GB, free: 4.676 MB / 490.7 MB
Notification: Performance of pre-optimization done (n=126): time 5.683e-06/0.8157, allocations: 336 / 0.7119 GB, free: 4.676 MB / 490.7 MB
Notification: Performance of matching and sorting (n=126): time 0.02592/0.8416, allocations: 4.242 MB / 0.7161 GB, free: 392 kB / 490.7 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0003887/0.8421, allocations: 0.5843 MB / 0.7167 GB, free: 15.66 MB / 0.4948 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.005694/0.8478, allocations: 2.575 MB / 0.7192 GB, free: 13.07 MB / 0.4948 GB
Notification: Performance of collectPreVariables (initialization): time 0.0003565/0.8482, allocations: 61.7 kB / 0.7192 GB, free: 13 MB / 0.4948 GB
Notification: Performance of collectInitialEqns (initialization): time 0.001706/0.8499, allocations: 1.344 MB / 0.7205 GB, free: 11.64 MB / 0.4948 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0006679/0.8506, allocations: 445.7 kB / 0.721 GB, free: 11.2 MB / 0.4948 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0001852/0.8508, allocations: 40 kB / 0.721 GB, free: 11.16 MB / 0.4948 GB
Notification: Performance of setup shared object (initialization): time 0.0002348/0.851, allocations: 373.9 kB / 0.7214 GB, free: 10.79 MB / 0.4948 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.00462/0.8557, allocations: 0.9603 MB / 0.7223 GB, free: 9.832 MB / 0.4948 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.005424/0.8611, allocations: 1.544 MB / 0.7238 GB, free: 8.051 MB / 0.4948 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.004845/0.866, allocations: 1.101 MB / 0.7249 GB, free: 6.941 MB / 0.4948 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.585e-05/0.866, allocations: 4 kB / 0.7249 GB, free: 6.938 MB / 0.4948 GB
Notification: Performance of matching and sorting (n=223) (initialization): time 0.0152/0.8813, allocations: 3.109 MB / 0.7279 GB, free: 3.805 MB / 0.4948 GB
Notification: Performance of prepare postOptimizeDAE: time 0.002721/0.884, allocations: 5.014 MB / 0.7328 GB, free: 14.36 MB / 0.5105 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 3.606e-05/0.8841, allocations: 12 kB / 0.7328 GB, free: 14.35 MB / 0.5105 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.003594/0.8877, allocations: 0.727 MB / 0.7335 GB, free: 13.62 MB / 0.5105 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.003514/0.8913, allocations: 0.507 MB / 0.734 GB, free: 13.11 MB / 0.5105 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.003346/0.8946, allocations: 1.792 MB / 0.7358 GB, free: 11.27 MB / 0.5105 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.005618/0.9003, allocations: 0.5287 MB / 0.7363 GB, free: 10.74 MB / 0.5105 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0004423/0.9008, allocations: 103.9 kB / 0.7364 GB, free: 10.64 MB / 0.5105 GB
Notification: Performance of prepare postOptimizeDAE: time 1.627e-05/0.9008, allocations: 4 kB / 0.7364 GB, free: 10.64 MB / 0.5105 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.01433/0.9151, allocations: 2.841 MB / 0.7392 GB, free: 7.781 MB / 0.5105 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 4.736e-05/0.9152, allocations: 20.05 kB / 0.7392 GB, free: 7.762 MB / 0.5105 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.003441/0.9187, allocations: 0.7242 MB / 0.7399 GB, free: 7.035 MB / 0.5105 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.003506/0.9222, allocations: 0.5031 MB / 0.7404 GB, free: 6.531 MB / 0.5105 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.003318/0.9256, allocations: 1.795 MB / 0.7421 GB, free: 4.688 MB / 0.5105 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.00513/0.9307, allocations: 465.8 kB / 0.7426 GB, free: 4.23 MB / 0.5105 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0004781/0.9313, allocations: 99.91 kB / 0.7427 GB, free: 4.133 MB / 0.5105 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 53
 * Number of states: 0 ()
 * Number of discrete variables: 10 ($whenCondition1,$PRE.heaPum.com.isOn,heaPum.com.isOn,$PRE.heaPum1.com.isOn,heaPum1.com.isOn,$PRE.N.T_start,N.T_start,$PRE.N.count,N.count,realToInteger.y)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (186):
 * Single equations (assignments): 183
 * 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: 2
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 0
 * Non-linear torn systems: 2 {2 17,2 17}
Notification: Performance of prepare postOptimizeDAE: time 0.002137/0.9334, allocations: 0.6996 MB / 0.7434 GB, free: 3.422 MB / 0.5105 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0008589/0.9343, allocations: 276.8 kB / 0.7436 GB, free: 3.148 MB / 0.5105 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01428/0.9486, allocations: 2.587 MB / 0.7462 GB, free: 0.5312 MB / 0.5105 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 3.864e-05/0.9487, allocations: 16 kB / 0.7462 GB, free: 0.5156 MB / 0.5105 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.842e-05/0.9487, allocations: 7.953 kB / 0.7462 GB, free: 0.5078 MB / 0.5105 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.01272/0.9614, allocations: 2.212 MB / 0.7483 GB, free: 14.23 MB / 0.5261 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.02091/0.9824, allocations: 6.541 MB / 0.7547 GB, free: 7.512 MB / 0.5261 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 3.224e-05/0.9825, allocations: 8 kB / 0.7547 GB, free: 7.504 MB / 0.5261 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.002411/0.9849, allocations: 304.1 kB / 0.755 GB, free: 7.207 MB / 0.5261 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.003425/0.9883, allocations: 0.7028 MB / 0.7557 GB, free: 6.504 MB / 0.5261 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0002754/0.9886, allocations: 55.94 kB / 0.7558 GB, free: 6.449 MB / 0.5261 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.003307/0.992, allocations: 1.787 MB / 0.7575 GB, free: 4.613 MB / 0.5261 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.178e-05/0.992, allocations: 8 kB / 0.7575 GB, free: 4.605 MB / 0.5261 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.01576/1.008, allocations: 4.291 MB / 0.7617 GB, free: 15.85 MB / 0.5417 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.00226/1.01, allocations: 0.6846 MB / 0.7624 GB, free: 15.14 MB / 0.5417 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0006918/1.011, allocations: 32 kB / 0.7624 GB, free: 15.11 MB / 0.5417 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.004182/1.015, allocations: 283.5 kB / 0.7627 GB, free: 14.83 MB / 0.5417 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0003533/1.015, allocations: 116.7 kB / 0.7628 GB, free: 14.71 MB / 0.5417 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0002574/1.016, allocations: 79.8 kB / 0.7629 GB, free: 14.64 MB / 0.5417 GB
Notification: Performance of sorting global known variables: time 0.004689/1.02, allocations: 1.809 MB / 0.7646 GB, free: 12.82 MB / 0.5417 GB
Notification: Performance of sort global known variables: time 1.374e-06/1.02, allocations: 4 kB / 0.7646 GB, free: 12.82 MB / 0.5417 GB
Notification: Performance of remove unused functions: time 0.006649/1.027, allocations: 1.696 MB / 0.7663 GB, free: 11.12 MB / 0.5417 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 33
 * Number of states: 4 (heaPum.con.vol.dynBal.U,heaPum.eva.vol.dynBal.U,heaPum1.con.vol.dynBal.U,heaPum1.eva.vol.dynBal.U)
 * Number of discrete variables: 6 ($whenCondition1,heaPum.com.isOn,heaPum1.com.isOn,N.T_start,N.count,realToInteger.y)
 * Number of discrete states: 3 (N.count,heaPum1.com.isOn,heaPum.com.isOn)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (88):
 * Single equations (assignments): 82
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 2
 * When equations: 2
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 2
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 0
 * Non-linear torn systems: 2 {2 17,2 17}
Notification: Performance of Backend phase and start with SimCode phase: time 0.002252/1.029, allocations: 0.8253 MB / 0.7671 GB, free: 10.29 MB / 0.5417 GB
Notification: Performance of simCode: created initialization part: time 0.01526/1.045, allocations: 3.582 MB / 0.7706 GB, free: 6.695 MB / 0.5417 GB
Notification: Performance of simCode: created event and clocks part: time 2.25e-05/1.045, allocations: 12.36 kB / 0.7706 GB, free: 6.684 MB / 0.5417 GB
Notification: Performance of simCode: created simulation system equations: time 0.0048/1.05, allocations: 1.051 MB / 0.7716 GB, free: 5.633 MB / 0.5417 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.007988/1.058, allocations: 1.384 MB / 0.773 GB, free: 4.258 MB / 0.5417 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.01767/1.075, allocations: 6.104 MB / 0.779 GB, free: 14.03 MB / 0.5573 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.002238/1.078, allocations: 1.773 MB / 0.7807 GB, free: 12.22 MB / 0.5573 GB
Notification: Performance of simCode: alias equations: time 0.005021/1.083, allocations: 0.6885 MB / 0.7814 GB, free: 11.54 MB / 0.5573 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.001042/1.084, allocations: 239.2 kB / 0.7816 GB, free: 11.3 MB / 0.5573 GB
Notification: Performance of SimCode: time 1.581e-06/1.084, allocations: 0 / 0.7816 GB, free: 11.3 MB / 0.5573 GB
Notification: Performance of Templates: time 0.5354/1.619, allocations: 66.13 MB / 0.8462 GB, free: 192.3 MB / 0.573 GB