Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_latest_Buildings.DHC.ETS.Combined.Subsystems.Validation.HeatPumpDHWTank.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/Buildings 11.0.1-master/package.mo", uses=false)
Using package Buildings with version 11.0.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.0.1-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(Buildings.DHC.ETS.Combined.Subsystems.Validation.HeatPumpDHWTank,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|theMixVal.TMixSet|theMixVal.senTMix.T|theMixVal.senTHot.T|sch.y.1.|heaPum.PHea|heaPum.PPum|heaPum.heaPumTan.charge|heaPum.heaPumTan.conCha.TTanTopSet|heaPum.heaPumTan.conCha.TTanTop|heaPum.heaPumTan.conCha.TTanBot|heaPum.COP_nominal|heaPum.heaPum.COP",fileNamePrefix="Buildings_latest_Buildings.DHC.ETS.Combined.Subsystems.Validation.HeatPumpDHWTank")
translateModel(Buildings.DHC.ETS.Combined.Subsystems.Validation.HeatPumpDHWTank,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|theMixVal.TMixSet|theMixVal.senTMix.T|theMixVal.senTHot.T|sch.y.1.|heaPum.PHea|heaPum.PPum|heaPum.heaPumTan.charge|heaPum.heaPumTan.conCha.TTanTopSet|heaPum.heaPumTan.conCha.TTanTop|heaPum.heaPumTan.conCha.TTanBot|heaPum.COP_nominal|heaPum.heaPum.COP",fileNamePrefix="Buildings_latest_Buildings.DHC.ETS.Combined.Subsystems.Validation.HeatPumpDHWTank")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001485/0.001485, allocations: 118.6 kB / 16.42 MB, free: 6.496 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.001532/0.001532, allocations: 183.9 kB / 17.35 MB, free: 5.762 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.55/1.55, allocations: 222.9 MB / 241.1 MB, free: 15.14 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.0.1-master/package.mo): time 2.952/2.952, allocations: 469.4 MB / 0.7428 GB, free: 3.488 MB / 0.6075 GB
Notification: Performance of FrontEnd - loaded program: time 0.001666/0.001666, allocations: 63.91 kB / 1.065 GB, free: 13.79 MB / 0.8419 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 1.098/1.1, allocations: 159.1 MB / 1.221 GB, free: 2.355 MB / 0.9356 GB
Notification: Performance of NFInst.instantiate(Buildings.DHC.ETS.Combined.Subsystems.Validation.HeatPumpDHWTank): time 1.657/2.757, allocations: 420.9 MB / 1.632 GB, free: 60.12 MB / 1.279 GB
Notification: Performance of NFInst.instExpressions: time 0.1443/2.901, allocations: 89.67 MB / 1.72 GB, free: 51.75 MB / 1.279 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.02643/2.928, allocations: 466.5 kB / 1.72 GB, free: 51.75 MB / 1.279 GB
Notification: Performance of NFTyping.typeComponents: time 0.02138/2.949, allocations: 6.161 MB / 1.726 GB, free: 50.23 MB / 1.279 GB
Notification: Performance of NFTyping.typeBindings: time 0.04715/2.996, allocations: 13.91 MB / 1.74 GB, free: 44.03 MB / 1.279 GB
Notification: Performance of NFTyping.typeClassSections: time 0.02787/3.024, allocations: 10.62 MB / 1.75 GB, free: 36.8 MB / 1.279 GB
Notification: Performance of NFFlatten.flatten: time 0.07239/3.097, allocations: 49.14 MB / 1.798 GB, free: 12.05 MB / 1.295 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.03061/3.127, allocations: 13.64 MB / 1.811 GB, free: 14.47 MB / 1.311 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.04369/3.171, allocations: 13.48 MB / 1.824 GB, free: 1.715 MB / 1.311 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.02429/3.195, allocations: 9.361 MB / 1.834 GB, free: 8.98 MB / 1.326 GB
Notification: Performance of NFPackage.collectConstants: time 0.008672/3.204, allocations: 1.699 MB / 1.835 GB, free: 7.281 MB / 1.326 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.03318/3.237, allocations: 6.462 MB / 1.842 GB, free: 1.094 MB / 1.326 GB
Notification: Performance of NFScalarize.scalarize: time 0.01107/3.249, allocations: 4.062 MB / 1.845 GB, free: 13.08 MB / 1.342 GB
Notification: Performance of NFVerifyModel.verify: time 0.03127/3.28, allocations: 8.004 MB / 1.853 GB, free: 5.102 MB / 1.342 GB
Notification: Performance of NFConvertDAE.convert: time 0.05832/3.338, allocations: 26.46 MB / 1.879 GB, free: 11.27 MB / 1.373 GB
Notification: Performance of FrontEnd - DAE generated: time 9.738e-06/3.338, allocations: 4 kB / 1.879 GB, free: 11.27 MB / 1.373 GB
Notification: Performance of FrontEnd: time 3.336e-06/3.338, allocations: 0 / 1.879 GB, free: 11.27 MB / 1.373 GB
Notification: Performance of Transformations before backend: time 0.000973/3.339, allocations: 0 / 1.879 GB, free: 11.27 MB / 1.373 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 1838
 * Number of variables: 1838
Notification: Performance of Generate backend data structure: time 0.05619/3.396, allocations: 14.4 MB / 1.893 GB, free: 12.85 MB / 1.389 GB
Notification: Performance of prepare preOptimizeDAE: time 6.901e-05/3.396, allocations: 12.62 kB / 1.893 GB, free: 12.84 MB / 1.389 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01616/3.412, allocations: 2.427 MB / 1.896 GB, free: 10.39 MB / 1.389 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.04392/3.456, allocations: 15.54 MB / 1.911 GB, free: 11.05 MB / 1.404 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.001021/3.457, allocations: 0.5633 MB / 1.911 GB, free: 10.49 MB / 1.404 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.004135/3.461, allocations: 0.752 MB / 1.912 GB, free: 9.738 MB / 1.404 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.03659/3.498, allocations: 10.25 MB / 1.922 GB, free: 15.18 MB / 1.42 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0004265/3.498, allocations: 19.78 kB / 1.922 GB, free: 15.16 MB / 1.42 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.003049/3.501, allocations: 304 kB / 1.922 GB, free: 14.86 MB / 1.42 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0003213/3.502, allocations: 261.6 kB / 1.923 GB, free: 14.6 MB / 1.42 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.02797/3.53, allocations: 8.493 MB / 1.931 GB, free: 6.098 MB / 1.42 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.1148/3.644, allocations: 52.42 MB / 1.982 GB, free: 14.79 MB / 1.482 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.01521/3.66, allocations: 5.49 MB / 1.987 GB, free: 9.266 MB / 1.482 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.008907/3.669, allocations: 3.454 MB / 1.991 GB, free: 5.816 MB / 1.482 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 evalFunc (simulation): time 0.04/3.709, allocations: 15.62 MB / 2.006 GB, free: 5.359 MB / 1.498 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.01052/3.719, allocations: 3.532 MB / 2.01 GB, free: 1.781 MB / 1.498 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.007318/3.727, allocations: 0.6279 MB / 2.01 GB, free: 1.156 MB / 1.498 GB
Notification: Performance of pre-optimization done (n=372): time 2.644e-05/3.727, allocations: 0 / 2.01 GB, free: 1.156 MB / 1.498 GB
Notification: Performance of matching and sorting (n=372): time 0.04609/3.773, allocations: 10.64 MB / 2.021 GB, free: 6.344 MB / 1.514 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001821/3.773, allocations: 244.5 kB / 2.021 GB, free: 6.055 MB / 1.514 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.03374/3.807, allocations: 10.9 MB / 2.031 GB, free: 11.18 MB / 1.529 GB
Notification: Performance of collectPreVariables (initialization): time 0.001792/3.809, allocations: 129.7 kB / 2.032 GB, free: 11.05 MB / 1.529 GB
Notification: Performance of collectInitialEqns (initialization): time 0.01001/3.819, allocations: 5.36 MB / 2.037 GB, free: 5.699 MB / 1.529 GB
Notification: Performance of collectInitialBindings (initialization): time 0.003261/3.822, allocations: 1.296 MB / 2.038 GB, free: 4.414 MB / 1.529 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.006912/3.829, allocations: 1.493 MB / 2.039 GB, free: 2.914 MB / 1.529 GB
Notification: Performance of setup shared object (initialization): time 0.0001273/3.829, allocations: 305.1 kB / 2.04 GB, free: 2.613 MB / 1.529 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.009811/3.839, allocations: 4.067 MB / 2.044 GB, free: 14.54 MB / 1.545 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.01208/3.851, allocations: 6.143 MB / 2.05 GB, free: 7.508 MB / 1.545 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.02251/3.874, allocations: 9.666 MB / 2.059 GB, free: 13.1 MB / 1.561 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 9.709e-05/3.874, allocations: 16 kB / 2.059 GB, free: 13.08 MB / 1.561 GB
Notification: Performance of matching and sorting (n=865) (initialization): time 0.03571/3.91, allocations: 11.97 MB / 2.071 GB, free: 1.008 MB / 1.561 GB
Notification: Performance of prepare postOptimizeDAE: time 8.625e-05/3.91, allocations: 30.03 kB / 2.071 GB, free: 0.9805 MB / 1.561 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001056/3.91, allocations: 48 kB / 2.071 GB, free: 0.9336 MB / 1.561 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.004611/3.914, allocations: 1.12 MB / 2.072 GB, free: 15.8 MB / 1.576 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.007881/3.922, allocations: 1.396 MB / 2.073 GB, free: 14.4 MB / 1.576 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01107/3.933, allocations: 9.042 MB / 2.082 GB, free: 4.941 MB / 1.576 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01151/3.945, allocations: 489.7 kB / 2.083 GB, free: 4.469 MB / 1.576 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.002086/3.947, allocations: 355.9 kB / 2.083 GB, free: 4.121 MB / 1.576 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.01799/3.965, allocations: 6.483 MB / 2.089 GB, free: 13.63 MB / 1.592 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.01154/3.977, allocations: 5.717 MB / 2.095 GB, free: 7.031 MB / 1.592 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.01901/3.996, allocations: 8.851 MB / 2.104 GB, free: 13.44 MB / 1.607 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 7.629e-05/3.996, allocations: 12 kB / 2.104 GB, free: 13.43 MB / 1.607 GB
Notification: Performance of matching and sorting (n=865) (initialization_lambda0): time 0.03447/4.03, allocations: 11.12 MB / 2.114 GB, free: 2.195 MB / 1.607 GB
Notification: Performance of prepare postOptimizeDAE: time 8.247e-05/4.03, allocations: 28 kB / 2.115 GB, free: 2.168 MB / 1.607 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001061/4.031, allocations: 48 kB / 2.115 GB, free: 2.121 MB / 1.607 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.004508/4.035, allocations: 1.084 MB / 2.116 GB, free: 1.023 MB / 1.607 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.007298/4.042, allocations: 1.373 MB / 2.117 GB, free: 15.65 MB / 1.623 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01704/4.059, allocations: 12.71 MB / 2.129 GB, free: 2.238 MB / 1.623 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01151/4.071, allocations: 496.6 kB / 2.13 GB, free: 1.754 MB / 1.623 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001929/4.073, allocations: 327.9 kB / 2.13 GB, free: 1.434 MB / 1.623 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 223
 * Number of states: 0 ()
 * Number of discrete variables: 22 ($whenCondition4,$PRE.sch.nextTimeEvent,$whenCondition3,theMixVal.conPID.con1.y,heaPum.heaPumTan.conVal.ram.local_reset,sch.nextTimeEventScaled,$PRE.sch.nextTimeEventScaled,sch.nextTimeEvent,heaPum.and2.y,heaPum.heaPumTan.conVal.cha.y,$PRE.heaPum.heaPumTan.conVal.cha.y,heaPum.heaPumTan.conCha.cha1.y,$PRE.heaPum.heaPumTan.conCha.cha1.y,heaPum.heaPumTan.conCha.cha.y,$PRE.heaPum.heaPumTan.conCha.cha.y,heaPum.heaPumTan.conCha.lat.y,heaPum.heaPumTan.conPum.hysMasFlo.y,$PRE.heaPum.heaPumTan.conPum.hysMasFlo.y,$whenCondition1,$whenCondition2,$whenCondition5,$whenCondition6)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (710):
 * Single equations (assignments): 696
 * Array equations: 3
 * Algorithm blocks: 0
 * Record equations: 3
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 2
 * Torn equation systems: 6
 * Mixed (continuous/discrete) equation systems: 0
Notification: Equation system details (not torn):
 * Constant Jacobian (size): 0 systems
 * Linear Jacobian (size,density): 0 systems
 * Non-linear Jacobian (size): 2 systems
   {1, 1}
 * Without analytic Jacobian (size): 0 systems
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 2 systems
   {(1,3,100.0%), (1,10,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 4 systems
   {(1,4), (3,16), (1,9), (1,6)}
Notification: Performance of prepare postOptimizeDAE: time 0.003341/4.076, allocations: 0.5681 MB / 2.131 GB, free: 0.8594 MB / 1.623 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.004861/4.081, allocations: 1.009 MB / 2.132 GB, free: 15.84 MB / 1.639 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.02703/4.108, allocations: 7.912 MB / 2.139 GB, free: 7.957 MB / 1.639 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.01841/4.127, allocations: 6.17 MB / 2.145 GB, free: 1.691 MB / 1.639 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 4.012e-05/4.127, allocations: 4 kB / 2.145 GB, free: 1.688 MB / 1.639 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.008363/4.135, allocations: 1.964 MB / 2.147 GB, free: 15.7 MB / 1.654 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.00509/4.14, allocations: 87.98 kB / 2.147 GB, free: 15.61 MB / 1.654 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.009153/4.149, allocations: 355.5 kB / 2.148 GB, free: 15.27 MB / 1.654 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.001427/4.151, allocations: 318.8 kB / 2.148 GB, free: 14.95 MB / 1.654 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.02388/4.175, allocations: 7.285 MB / 2.155 GB, free: 7.707 MB / 1.654 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.02902/4.204, allocations: 10.4 MB / 2.165 GB, free: 13.25 MB / 1.67 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.007036/4.211, allocations: 2.857 MB / 2.168 GB, free: 10.39 MB / 1.67 GB
Notification: Performance of sorting global known variables: time 0.02003/4.231, allocations: 7.379 MB / 2.175 GB, free: 3.047 MB / 1.67 GB
Notification: Performance of Backend: time 9.92e-07/4.231, allocations: 0 / 2.175 GB, free: 3.047 MB / 1.67 GB
Notification: Performance of simCode: created initialization part: time 0.04963/4.281, allocations: 14.31 MB / 2.189 GB, free: 5.059 MB / 1.686 GB
Notification: Performance of SimCode: time 1.654/5.935, allocations: 24.35 MB / 2.213 GB, free: 0.6731 GB / 1.686 GB
Notification: Performance of Templates: time 0.356/6.291, allocations: 251.1 MB / 2.458 GB, free: 473.4 MB / 1.686 GB
make -j1 -f Buildings_latest_Buildings.DHC.ETS.Combined.Subsystems.Validation.HeatPumpDHWTank.makefile
(rm -f Buildings_latest_Buildings.DHC.ETS.Combined.Subsystems.Validation.HeatPumpDHWTank.pipe ; mkfifo Buildings_latest_Buildings.DHC.ETS.Combined.Subsystems.Validation.HeatPumpDHWTank.pipe ; head -c 1048576 < Buildings_latest_Buildings.DHC.ETS.Combined.Subsystems.Validation.HeatPumpDHWTank.pipe >> ../files/Buildings_latest_Buildings.DHC.ETS.Combined.Subsystems.Validation.HeatPumpDHWTank.sim & ./Buildings_latest_Buildings.DHC.ETS.Combined.Subsystems.Validation.HeatPumpDHWTank  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > Buildings_latest_Buildings.DHC.ETS.Combined.Subsystems.Validation.HeatPumpDHWTank.pipe 2>&1)