Running: ./testmodel.py --libraries=/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IBPSA_master_IBPSA.Fluid.HeatPumps.Calibration.ScrollWaterToWater.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.Calibration.ScrollWaterToWater,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IBPSA_master_IBPSA.Fluid.HeatPumps.Calibration.ScrollWaterToWater")
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo): time 0.00383/0.003835, allocations: 356.5 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.713/1.713, allocations: 165.8 MB / 183.1 MB, free: 5.434 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 4.088/4.088, allocations: 410.8 MB / 0.6001 GB, free: 15.06 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.002968/0.002968, allocations: 194 kB / 0.6668 GB, free: 6.902 MB / 298.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0007179/0.0007182, allocations: 11.94 kB / 0.7429 GB, free: 8.941 MB / 378.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.5191/0.5199, allocations: 67.45 MB / 0.8087 GB, free: 28.77 MB / 378.7 MB
Notification: Performance of NFInst.instantiate(IBPSA.Fluid.HeatPumps.Calibration.ScrollWaterToWater): time 0.1913/0.7113, allocations: 116.4 MB / 0.9224 GB, free: 8.074 MB / 474.7 MB
Notification: Performance of NFInst.instExpressions: time 0.4369/1.148, allocations: 13.68 MB / 0.9358 GB, free: 70.89 MB / 474.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.003123/1.151, allocations: 63.19 kB / 0.9358 GB, free: 70.89 MB / 474.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.004135/1.156, allocations: 0.7703 MB / 0.9366 GB, free: 70.88 MB / 474.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.01053/1.166, allocations: 2.309 MB / 0.9388 GB, free: 70.86 MB / 474.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.008996/1.175, allocations: 1.963 MB / 0.9407 GB, free: 70.82 MB / 474.7 MB
Notification: Performance of NFFlatten.flatten: time 0.01012/1.185, allocations: 5.198 MB / 0.9458 GB, free: 70.61 MB / 474.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.003198/1.189, allocations: 1.222 MB / 0.947 GB, free: 70.41 MB / 474.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.00446/1.193, allocations: 1.379 MB / 0.9484 GB, free: 70.05 MB / 474.7 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.00332/1.196, allocations: 1.182 MB / 0.9495 GB, free: 69.79 MB / 474.7 MB
Notification: Performance of NFPackage.collectConstants: time 0.0005562/1.197, allocations: 74.78 kB / 0.9496 GB, free: 69.78 MB / 474.7 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.005299/1.202, allocations: 1.135 MB / 0.9507 GB, free: 69.71 MB / 474.7 MB
Notification: Performance of NFScalarize.scalarize: time 0.001085/1.204, allocations: 343.3 kB / 0.951 GB, free: 69.64 MB / 474.7 MB
Notification: Performance of NFVerifyModel.verify: time 0.001067/1.205, allocations: 412.8 kB / 0.9514 GB, free: 69.55 MB / 474.7 MB
Notification: Performance of NFConvertDAE.convert: time 0.005527/1.21, allocations: 2.59 MB / 0.9539 GB, free: 68.73 MB / 474.7 MB
Notification: Performance of FrontEnd - DAE generated: time 8.786e-06/1.21, allocations: 2.516 kB / 0.9539 GB, free: 68.73 MB / 474.7 MB
Notification: Performance of FrontEnd: time 2.715e-06/1.21, allocations: 7.375 kB / 0.9539 GB, free: 68.73 MB / 474.7 MB
Notification: Performance of Transformations before backend: time 8.923e-05/1.21, allocations: 0 / 0.9539 GB, free: 68.73 MB / 474.7 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 312
 * Number of variables: 312
Notification: Performance of Generate backend data structure: time 0.00599/1.216, allocations: 2.043 MB / 0.9559 GB, free: 67.36 MB / 474.7 MB
Notification: Performance of prepare preOptimizeDAE: time 5.153e-05/1.216, allocations: 7.094 kB / 0.956 GB, free: 67.36 MB / 474.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01069/1.227, allocations: 0.749 MB / 0.9567 GB, free: 67.05 MB / 474.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.004398/1.232, allocations: 1.591 MB / 0.9582 GB, free: 66.34 MB / 474.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001919/1.232, allocations: 142.2 kB / 0.9584 GB, free: 66.29 MB / 474.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0003522/1.232, allocations: 127.2 kB / 0.9585 GB, free: 66.29 MB / 474.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.006975/1.239, allocations: 1.735 MB / 0.9602 GB, free: 65.66 MB / 474.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 5.124e-05/1.239, allocations: 3.938 kB / 0.9602 GB, free: 65.65 MB / 474.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0002507/1.24, allocations: 54.98 kB / 0.9602 GB, free: 65.65 MB / 474.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 6.697e-05/1.24, allocations: 41.38 kB / 0.9603 GB, free: 65.65 MB / 474.7 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.008881/1.248, allocations: 1.524 MB / 0.9618 GB, free: 65.34 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.01656/1.265, allocations: 7.565 MB / 0.9692 GB, free: 60.4 MB / 474.7 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.007741/1.273, allocations: 1.191 MB / 0.9703 GB, free: 59.55 MB / 474.7 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.003856/1.277, allocations: 0.6011 MB / 0.9709 GB, free: 59.13 MB / 474.7 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.00163/1.278, allocations: 1.277 MB / 0.9722 GB, free: 57.6 MB / 474.7 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.004273/1.283, allocations: 0.7036 MB / 0.9728 GB, free: 57.06 MB / 474.7 MB
Notification: Performance of pre-optimization done (n=80): time 5.68e-06/1.283, allocations: 0 / 0.9728 GB, free: 57.06 MB / 474.7 MB
Notification: Performance of matching and sorting (n=80): time 0.03279/1.316, allocations: 3.226 MB / 0.976 GB, free: 54.32 MB / 474.7 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001004/1.316, allocations: 138.8 kB / 0.9761 GB, free: 54.16 MB / 474.7 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002357/1.318, allocations: 1.259 MB / 0.9774 GB, free: 53.23 MB / 474.7 MB
Notification: Performance of collectPreVariables (initialization): time 0.0002815/1.318, allocations: 48.27 kB / 0.9774 GB, free: 53.19 MB / 474.7 MB
Notification: Performance of collectInitialEqns (initialization): time 0.0007158/1.319, allocations: 0.7128 MB / 0.9781 GB, free: 52.75 MB / 474.7 MB
Notification: Performance of collectInitialBindings (initialization): time 0.0003741/1.32, allocations: 282.1 kB / 0.9784 GB, free: 52.52 MB / 474.7 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0001052/1.32, allocations: 21.75 kB / 0.9784 GB, free: 52.51 MB / 474.7 MB
Notification: Performance of setup shared object (initialization): time 8.601e-05/1.32, allocations: 346.4 kB / 0.9787 GB, free: 52.18 MB / 474.7 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.003589/1.323, allocations: 0.5233 MB / 0.9792 GB, free: 51.82 MB / 474.7 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.004059/1.327, allocations: 0.8168 MB / 0.98 GB, free: 51.08 MB / 474.7 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.003686/1.331, allocations: 0.5786 MB / 0.9806 GB, free: 50.7 MB / 474.7 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 8.286e-06/1.331, allocations: 4 kB / 0.9806 GB, free: 50.7 MB / 474.7 MB
Notification: Performance of matching and sorting (n=119) (initialization): time 0.009226/1.34, allocations: 1.667 MB / 0.9822 GB, free: 49.36 MB / 474.7 MB
Notification: Performance of prepare postOptimizeDAE: time 0.0001638/1.341, allocations: 273.5 kB / 0.9825 GB, free: 49.01 MB / 474.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.611e-05/1.341, allocations: 8 kB / 0.9825 GB, free: 49 MB / 474.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.003108/1.344, allocations: 0.5812 MB / 0.9831 GB, free: 48.42 MB / 474.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002573/1.346, allocations: 255.6 kB / 0.9833 GB, free: 48.17 MB / 474.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.003031/1.349, allocations: 1.176 MB / 0.9845 GB, free: 46.97 MB / 474.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.00368/1.353, allocations: 243.9 kB / 0.9847 GB, free: 46.73 MB / 474.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001856/1.353, allocations: 55.95 kB / 0.9847 GB, free: 46.68 MB / 474.7 MB
Notification: Performance of prepare postOptimizeDAE: time 1.246e-05/1.353, allocations: 4 kB / 0.9847 GB, free: 46.67 MB / 474.7 MB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.0085/1.362, allocations: 1.507 MB / 0.9862 GB, free: 45.18 MB / 474.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.333e-05/1.362, allocations: 8 kB / 0.9862 GB, free: 45.17 MB / 474.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.00296/1.365, allocations: 0.5716 MB / 0.9868 GB, free: 44.6 MB / 474.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002496/1.367, allocations: 251.6 kB / 0.987 GB, free: 44.35 MB / 474.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.002926/1.37, allocations: 1.173 MB / 0.9882 GB, free: 43.15 MB / 474.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.003524/1.374, allocations: 223 kB / 0.9884 GB, free: 42.93 MB / 474.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001736/1.374, allocations: 55.95 kB / 0.9884 GB, free: 42.88 MB / 474.7 MB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 27
 * Number of states: 0 ()
 * Number of discrete variables: 7 ($whenCondition1,$PRE.calDat.nextTimeEvent,calDat.nextTimeEvent,$PRE.calDat.nextTimeEventScaled,calDat.nextTimeEventScaled,$PRE.heaPum.com.isOn,heaPum.com.isOn)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (91):
 * Single equations (assignments): 90
 * Array equations: 0
 * Algorithm blocks: 0
 * 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 {4 25}
Notification: Performance of prepare postOptimizeDAE: time 0.001147/1.375, allocations: 482.3 kB / 0.9889 GB, free: 42.4 MB / 474.7 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0003673/1.376, allocations: 146.2 kB / 0.989 GB, free: 42.25 MB / 474.7 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.023/1.399, allocations: 2.162 MB / 0.9911 GB, free: 40.09 MB / 474.7 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.02259/1.421, allocations: 1.994 MB / 0.9931 GB, free: 38.07 MB / 474.7 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.634e-05/1.421, allocations: 4 kB / 0.9931 GB, free: 38.06 MB / 474.7 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.001333/1.423, allocations: 406.8 kB / 0.9935 GB, free: 37.64 MB / 474.7 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0004116/1.423, allocations: 23.98 kB / 0.9935 GB, free: 37.62 MB / 474.7 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.003303/1.426, allocations: 151.7 kB / 0.9936 GB, free: 37.47 MB / 474.7 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001846/1.427, allocations: 52.58 kB / 0.9937 GB, free: 37.42 MB / 474.7 MB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.01414/1.441, allocations: 1.804 MB / 0.9955 GB, free: 35.64 MB / 474.7 MB
Notification: Performance of postOpt detectDAEmodeSparsePattern (simulation): time 0.0118/1.453, allocations: 2.12 MB / 0.9975 GB, free: 33.53 MB / 474.7 MB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.003572/1.456, allocations: 0.5519 MB / 0.9981 GB, free: 32.98 MB / 474.7 MB
Notification: Performance of sorting global known variables: time 0.001797/1.458, allocations: 0.8554 MB / 0.9989 GB, free: 32.12 MB / 474.7 MB
Notification: Performance of Backend: time 6.62e-07/1.458, allocations: 0 / 0.9989 GB, free: 32.12 MB / 474.7 MB
Notification: Performance of simCode: created initialization part: time 0.01287/1.471, allocations: 2.54 MB / 1.001 GB, free: 29.84 MB / 474.7 MB
Notification: Performance of SimCode: time 0.01019/1.481, allocations: 4.09 MB / 1.005 GB, free: 25.72 MB / 474.7 MB
Notification: Performance of Templates: time 0.1054/1.587, allocations: 41.58 MB / 1.046 GB, free: 0.6016 MB / 490.7 MB