Running: ./testmodel.py --libraries=/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_master_Buildings.Examples.Tutorial.CDL.System4.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 Complex with version 3.2.3 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo)
Using package Buildings with version 9.0.0 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 9.0.0-master/package.mo)
Running command: translateModel(Buildings.Examples.Tutorial.CDL.System4,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Buildings_master_Buildings.Examples.Tutorial.CDL.System4")
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 9.0.0-master/package.mo): time 4.783/4.783, allocations: 0.5623 GB / 0.5769 GB, free: 3.387 MB / 474.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo): time 0.002355/0.002355, allocations: 364.2 kB / 0.6441 GB, free: 185.6 MB / 474.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 4.126/4.126, allocations: 410.7 MB / 1.112 GB, free: 147.9 MB / 0.5886 GB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo): time 0.001678/0.001678, allocations: 176.2 kB / 1.225 GB, free: 36 MB / 0.5886 GB
Notification: Performance of FrontEnd - loaded program: time 0.0004882/0.0004885, allocations: 12.97 kB / 1.348 GB, free: 121.8 MB / 0.6042 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1536/0.1542, allocations: 115.3 MB / 1.461 GB, free: 6.656 MB / 0.6042 GB
Notification: Performance of NFInst.instantiate(Buildings.Examples.Tutorial.CDL.System4): time 1.837/1.991, allocations: 481.7 MB / 1.931 GB, free: 58.96 MB / 0.9323 GB
Notification: Performance of NFInst.instExpressions: time 0.108/2.099, allocations: 68.42 MB / 1.998 GB, free: 57.34 MB / 0.9323 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.01595/2.115, allocations: 361.8 kB / 1.998 GB, free: 57.18 MB / 0.9323 GB
Notification: Performance of NFTyping.typeComponents: time 0.01587/2.131, allocations: 4.094 MB / 2.002 GB, free: 55.99 MB / 0.9323 GB
Notification: Performance of NFTyping.typeBindings: time 0.04678/2.178, allocations: 13.49 MB / 2.015 GB, free: 51.11 MB / 0.9323 GB
Notification: Performance of NFTyping.typeClassSections: time 0.03631/2.215, allocations: 10.71 MB / 2.026 GB, free: 48.38 MB / 0.9323 GB
Notification: Performance of NFFlatten.flatten: time 0.04229/2.257, allocations: 35.3 MB / 2.06 GB, free: 36.78 MB / 0.9323 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.01656/2.273, allocations: 8.737 MB / 2.069 GB, free: 32.81 MB / 0.9323 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.0198/2.293, allocations: 8.978 MB / 2.078 GB, free: 25.24 MB / 0.9323 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.01406/2.307, allocations: 8.125 MB / 2.086 GB, free: 18.57 MB / 0.9323 GB
Notification: Performance of NFPackage.collectConstants: time 0.003209/2.311, allocations: 427.9 kB / 2.086 GB, free: 18.16 MB / 0.9323 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.01544/2.326, allocations: 3.869 MB / 2.09 GB, free: 15.18 MB / 0.9323 GB
Notification: Performance of NFScalarize.scalarize: time 0.004467/2.331, allocations: 2.371 MB / 2.092 GB, free: 13.41 MB / 0.9323 GB
Notification: Performance of NFVerifyModel.verify: time 0.005435/2.336, allocations: 2.422 MB / 2.095 GB, free: 11.86 MB / 0.9323 GB
Notification: Performance of NFConvertDAE.convert: time 0.02161/2.358, allocations: 14.84 MB / 2.109 GB, free: 15.41 MB / 0.948 GB
Notification: Performance of FrontEnd - DAE generated: time 5.974e-06/2.358, allocations: 0 / 2.109 GB, free: 15.41 MB / 0.948 GB
Notification: Performance of FrontEnd: time 2.691e-06/2.358, allocations: 4 kB / 2.109 GB, free: 15.4 MB / 0.948 GB
Notification: Performance of Transformations before backend: time 0.0004054/2.358, allocations: 0 / 2.109 GB, free: 15.4 MB / 0.948 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 1860
 * Number of variables: 1860
Notification: Performance of Generate backend data structure: time 0.0287/2.387, allocations: 11.12 MB / 2.12 GB, free: 5.223 MB / 0.948 GB
Notification: Performance of prepare preOptimizeDAE: time 4.453e-05/2.387, allocations: 16.03 kB / 2.12 GB, free: 5.207 MB / 0.948 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01213/2.399, allocations: 2.071 MB / 2.122 GB, free: 3.137 MB / 0.948 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.02878/2.428, allocations: 9.965 MB / 2.132 GB, free: 12.22 MB / 0.9636 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0006874/2.429, allocations: 0.5703 MB / 2.132 GB, free: 11.89 MB / 0.9636 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.002254/2.431, allocations: 0.7704 MB / 2.133 GB, free: 11.37 MB / 0.9636 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.0244/2.455, allocations: 8.651 MB / 2.141 GB, free: 3.586 MB / 0.9636 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0002664/2.456, allocations: 17.73 kB / 2.141 GB, free: 3.57 MB / 0.9636 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.001626/2.457, allocations: 314.9 kB / 2.142 GB, free: 3.266 MB / 0.9636 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0003629/2.458, allocations: 289.9 kB / 2.142 GB, free: 2.98 MB / 0.9636 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.02248/2.48, allocations: 7.049 MB / 2.149 GB, free: 11.92 MB / 0.9792 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.08304/2.563, allocations: 41.25 MB / 2.189 GB, free: 320 kB / 1.01 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.01099/2.574, allocations: 4.651 MB / 2.194 GB, free: 11.59 MB / 1.026 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.006293/2.581, allocations: 2.42 MB / 2.196 GB, free: 9.172 MB / 1.026 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.03172/2.612, allocations: 10.4 MB / 2.206 GB, free: 14.4 MB / 1.042 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.00697/2.619, allocations: 2.537 MB / 2.209 GB, free: 11.82 MB / 1.042 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.004475/2.624, allocations: 464.1 kB / 2.209 GB, free: 11.37 MB / 1.042 GB
Notification: Performance of pre-optimization done (n=405): time 1.504e-05/2.624, allocations: 9.906 kB / 2.209 GB, free: 11.36 MB / 1.042 GB
Notification: Performance of matching and sorting (n=414): time 0.05347/2.677, allocations: 14.86 MB / 2.224 GB, free: 12.25 MB / 1.057 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0003657/2.678, allocations: 0.581 MB / 2.224 GB, free: 11.54 MB / 1.057 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.01926/2.697, allocations: 8.187 MB / 2.232 GB, free: 3.371 MB / 1.057 GB
Notification: Performance of collectPreVariables (initialization): time 0.001088/2.698, allocations: 133.7 kB / 2.232 GB, free: 3.234 MB / 1.057 GB
Notification: Performance of collectInitialEqns (initialization): time 0.007335/2.706, allocations: 5.034 MB / 2.237 GB, free: 14.18 MB / 1.073 GB
Notification: Performance of collectInitialBindings (initialization): time 0.002387/2.708, allocations: 1.433 MB / 2.239 GB, free: 12.76 MB / 1.073 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0005481/2.709, allocations: 118.7 kB / 2.239 GB, free: 12.65 MB / 1.073 GB
Notification: Performance of setup shared object (initialization): time 0.0004919/2.709, allocations: 0.5221 MB / 2.239 GB, free: 12.12 MB / 1.073 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.006896/2.716, allocations: 2.174 MB / 2.241 GB, free: 9.938 MB / 1.073 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.009208/2.725, allocations: 3.989 MB / 2.245 GB, free: 5.184 MB / 1.073 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.008408/2.734, allocations: 2.774 MB / 2.248 GB, free: 2.379 MB / 1.073 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 4.64e-05/2.734, allocations: 12 kB / 2.248 GB, free: 2.367 MB / 1.073 GB
Notification: Performance of matching and sorting (n=733) (initialization): time 0.029/2.763, allocations: 8.114 MB / 2.256 GB, free: 10.16 MB / 1.089 GB
Notification: Performance of prepare postOptimizeDAE: time 0.001215/2.764, allocations: 1.289 MB / 2.257 GB, free: 8.301 MB / 1.089 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001011/2.764, allocations: 51.98 kB / 2.257 GB, free: 8.25 MB / 1.089 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0117/2.776, allocations: 1.859 MB / 2.259 GB, free: 6.391 MB / 1.089 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.007343/2.783, allocations: 1.24 MB / 2.26 GB, free: 5.148 MB / 1.089 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01395/2.797, allocations: 7.852 MB / 2.268 GB, free: 12.83 MB / 1.104 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01099/2.808, allocations: 0.758 MB / 2.269 GB, free: 12.07 MB / 1.104 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001374/2.81, allocations: 276.1 kB / 2.269 GB, free: 11.8 MB / 1.104 GB
Notification: Performance of prepare postOptimizeDAE: time 1.629e-05/2.81, allocations: 7.953 kB / 2.269 GB, free: 11.8 MB / 1.104 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.02439/2.834, allocations: 6.96 MB / 2.276 GB, free: 4.742 MB / 1.104 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.000153/2.834, allocations: 51.98 kB / 2.276 GB, free: 4.691 MB / 1.104 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.01096/2.845, allocations: 1.724 MB / 2.277 GB, free: 2.961 MB / 1.104 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.006854/2.852, allocations: 1.178 MB / 2.279 GB, free: 1.781 MB / 1.104 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01984/2.872, allocations: 9.795 MB / 2.288 GB, free: 7.445 MB / 1.12 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01037/2.883, allocations: 0.7268 MB / 2.289 GB, free: 6.719 MB / 1.12 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001304/2.884, allocations: 264.2 kB / 2.289 GB, free: 6.461 MB / 1.12 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 178
 * Number of states: 0 ()
 * Number of discrete variables: 17 ($whenCondition1,$PRE.timTab.tab.nextTimeEvent,conBoiRet.conPID.con1.y,$whenCondition3,$whenCondition2,timTab.tab.nextTimeEvent,$PRE.timTab.tab.nextTimeEventScaled,timTab.tab.nextTimeEventScaled,$PRE.weaDat.conTimMin.tNext,weaDat.conTimMin.tNext,$PRE.weaDat.conTim.tNext,weaDat.conTim.tNext,$PRE.conEquSta.hys.y,conEquSta.hys.y,boiSigCon.u,weaDat.conTimMin.canRepeatWeatherFile,weaDat.conTim.canRepeatWeatherFile)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (668):
 * Single equations (assignments): 652
 * Array equations: 6
 * Algorithm blocks: 0
 * Record equations: 4
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 1
 * Torn equation systems: 5
 * Mixed (continuous/discrete) equation systems: 0
Notification: Equation system details:
 * Constant Jacobian: 0
 * Linear Jacobian (size,density): 0
 * Non-linear Jacobian: 1 {1}
 * Without analytic Jacobian: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 2 {(2,100.0%) 4,(1,100.0%) 4}
 * Non-linear torn systems: 3 {3 8,13 22,1 2}
Notification: Performance of prepare postOptimizeDAE: time 0.007408/2.891, allocations: 2.292 MB / 2.291 GB, free: 4.16 MB / 1.12 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.002867/2.894, allocations: 0.9144 MB / 2.292 GB, free: 3.234 MB / 1.12 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 1.145/4.039, allocations: 6.158 MB / 2.298 GB, free: 484 MB / 1.12 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 7.333e-05/4.039, allocations: 46.34 kB / 2.298 GB, free: 484 MB / 1.12 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 2.555e-05/4.039, allocations: 2.562 kB / 2.298 GB, free: 484 MB / 1.12 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.01421/4.053, allocations: 4.556 MB / 2.303 GB, free: 483.6 MB / 1.12 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 postOpt removeSimpleEquations (simulation): time 0.04367/4.097, allocations: 14.01 MB / 2.316 GB, free: 478 MB / 1.12 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 4.437e-05/4.097, allocations: 1.031 kB / 2.316 GB, free: 478 MB / 1.12 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.005952/4.103, allocations: 0.8428 MB / 2.317 GB, free: 477.9 MB / 1.12 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.003114/4.106, allocations: 0.7173 MB / 2.318 GB, free: 477.7 MB / 1.12 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0009006/4.107, allocations: 126.4 kB / 2.318 GB, free: 477.6 MB / 1.12 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.01251/4.12, allocations: 13.31 MB / 2.331 GB, free: 465.3 MB / 1.12 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 5.018e-06/4.12, allocations: 2.109 kB / 2.331 GB, free: 465.3 MB / 1.12 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.02348/4.143, allocations: 8.194 MB / 2.339 GB, free: 462.3 MB / 1.12 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.00633/4.15, allocations: 1.671 MB / 2.341 GB, free: 461.8 MB / 1.12 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.002842/4.153, allocations: 104.1 kB / 2.341 GB, free: 461.7 MB / 1.12 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.01004/4.163, allocations: 0.7209 MB / 2.342 GB, free: 461.7 MB / 1.12 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.001126/4.164, allocations: 291.8 kB / 2.342 GB, free: 461.6 MB / 1.12 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0006917/4.165, allocations: 198.1 kB / 2.342 GB, free: 461.6 MB / 1.12 GB
Notification: Performance of sorting global known variables: time 0.01841/4.183, allocations: 5.392 MB / 2.347 GB, free: 459.7 MB / 1.12 GB
Notification: Performance of sort global known variables: time 1.014e-06/4.183, allocations: 0 / 2.347 GB, free: 459.7 MB / 1.12 GB
Notification: Performance of remove unused functions: time 0.02423/4.207, allocations: 4.666 MB / 2.352 GB, free: 459.4 MB / 1.12 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 4
 * Number of states: 30 (vol.dynBal.medium.Xi[1],vol.dynBal.m,heaCap.T,rad.vol[1].dynBal.U,rad.vol[2].dynBal.U,rad.vol[3].dynBal.U,rad.vol[4].dynBal.U,rad.vol[5].dynBal.U,temSup.T,pumRad.vol.dynBal.U,pumRad.filter.x[1],pumRad.filter.x[2],mix.vol.dynBal.U,spl.vol.dynBal.U,spl2.vol.dynBal.U,mix2.vol.dynBal.U,spl4.vol.dynBal.U,pumBoi.vol.dynBal.U,pumBoi.filter.x[1],pumBoi.filter.x[2],boi.heaCapDry.T,valRad.vol.dynBal.U,valRad.filter.x[1],valRad.filter.x[2],valBoi.vol.dynBal.U,valBoi.filter.x[1],valBoi.filter.x[2],temRet.T,spl1.vol.dynBal.U,conBoiRet.conPID.I.y)
 * Number of discrete variables: 9 ($whenCondition3,$whenCondition2,$whenCondition1,timTab.tab.nextTimeEvent,timTab.tab.nextTimeEventScaled,weaDat.conTimMin.tNext,weaDat.conTim.tNext,conEquSta.hys.y,boiSigCon.u)
 * Number of discrete states: 5 (timTab.tab.nextTimeEvent,weaDat.conTim.tNext,weaDat.conTimMin.tNext,conEquSta.hys.y,timTab.tab.nextTimeEventScaled)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (414):
 * Single equations (assignments): 391
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 9
 * When equations: 4
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 1
 * Torn equation systems: 9
 * Mixed (continuous/discrete) equation systems: 0
Notification: Equation system details:
 * Constant Jacobian: 0
 * Linear Jacobian (size,density): 0
 * Non-linear Jacobian: 1 {1}
 * Without analytic Jacobian: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 7 {(1,100.0%) 3,(1,100.0%) 4,(1,100.0%) 1,(1,100.0%) 1,(1,100.0%) 1,(1,100.0%) 1,(1,100.0%) 1}
 * Non-linear torn systems: 2 {13 22,1 3}
Notification: Performance of Backend phase and start with SimCode phase: time 0.007046/4.214, allocations: 2.242 MB / 2.354 GB, free: 459 MB / 1.12 GB
Notification: Performance of simCode: created initialization part: time 0.03037/4.245, allocations: 10.35 MB / 2.364 GB, free: 455 MB / 1.12 GB
Notification: Performance of simCode: created event and clocks part: time 1.43e-05/4.245, allocations: 6 kB / 2.364 GB, free: 455 MB / 1.12 GB
Notification: Performance of simCode: created simulation system equations: time 0.008096/4.253, allocations: 3.363 MB / 2.367 GB, free: 453.3 MB / 1.12 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.03081/4.284, allocations: 4.887 MB / 2.372 GB, free: 452.3 MB / 1.12 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.07302/4.357, allocations: 22.03 MB / 2.394 GB, free: 434.4 MB / 1.12 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.01831/4.375, allocations: 5.425 MB / 2.399 GB, free: 429 MB / 1.12 GB
Notification: Performance of simCode: alias equations: time 0.01841/4.394, allocations: 2.524 MB / 2.401 GB, free: 426.5 MB / 1.12 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.003264/4.397, allocations: 0.7335 MB / 2.402 GB, free: 425.7 MB / 1.12 GB
Notification: Performance of SimCode: time 1.86e-06/4.397, allocations: 0 / 2.402 GB, free: 425.7 MB / 1.12 GB
Notification: Performance of Templates: time 0.3709/4.768, allocations: 185.1 MB / 2.583 GB, free: 242.4 MB / 1.12 GB