Running: ./testmodel.py --libraries=/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_master_Buildings.Examples.Tutorial.CDL.System2.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.System2,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Buildings_master_Buildings.Examples.Tutorial.CDL.System2")
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 9.0.0-master/package.mo): time 5.079/5.079, allocations: 0.5623 GB / 0.5776 GB, free: 3.336 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.002485/0.002485, allocations: 358.8 kB / 0.6447 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.275/4.275, allocations: 410.7 MB / 1.113 GB, free: 5.898 MB / 0.6042 GB
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: 187.4 kB / 1.226 GB, free: 6.102 MB / 0.7136 GB
Notification: Performance of FrontEnd - loaded program: time 0.0006622/0.0006625, allocations: 15.98 kB / 1.349 GB, free: 8.246 MB / 0.8386 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.7371/0.7378, allocations: 115.3 MB / 1.461 GB, free: 284.3 MB / 0.8542 GB
Notification: Performance of NFInst.instantiate(Buildings.Examples.Tutorial.CDL.System2): time 1.35/2.088, allocations: 481.1 MB / 1.931 GB, free: 30.27 MB / 0.8542 GB
Notification: Performance of NFInst.instExpressions: time 0.1359/2.224, allocations: 68.2 MB / 1.998 GB, free: 10.01 MB / 0.9011 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.01661/2.24, allocations: 361.5 kB / 1.998 GB, free: 9.656 MB / 0.9011 GB
Notification: Performance of NFTyping.typeComponents: time 0.02016/2.261, allocations: 4.068 MB / 2.002 GB, free: 5.562 MB / 0.9011 GB
Notification: Performance of NFTyping.typeBindings: time 0.05695/2.318, allocations: 13.46 MB / 2.015 GB, free: 8.051 MB / 0.9167 GB
Notification: Performance of NFTyping.typeClassSections: time 0.04461/2.362, allocations: 10.63 MB / 2.026 GB, free: 13.65 MB / 0.9323 GB
Notification: Performance of NFFlatten.flatten: time 0.06311/2.425, allocations: 35.05 MB / 2.06 GB, free: 10.52 MB / 0.9636 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.02536/2.451, allocations: 8.569 MB / 2.068 GB, free: 1.863 MB / 0.9636 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.02811/2.479, allocations: 8.924 MB / 2.077 GB, free: 8.898 MB / 0.9792 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.02128/2.5, allocations: 8.058 MB / 2.085 GB, free: 0.8047 MB / 0.9792 GB
Notification: Performance of NFPackage.collectConstants: time 0.004421/2.505, allocations: 420 kB / 2.085 GB, free: 404 kB / 0.9792 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.02069/2.525, allocations: 3.862 MB / 2.089 GB, free: 12.52 MB / 0.9948 GB
Notification: Performance of NFScalarize.scalarize: time 0.007001/2.532, allocations: 2.346 MB / 2.091 GB, free: 10.17 MB / 0.9948 GB
Notification: Performance of NFVerifyModel.verify: time 0.008027/2.541, allocations: 2.374 MB / 2.094 GB, free: 7.781 MB / 0.9948 GB
Notification: Performance of NFConvertDAE.convert: time 0.03021/2.571, allocations: 14.53 MB / 2.108 GB, free: 9.23 MB / 1.01 GB
Notification: Performance of FrontEnd - DAE generated: time 6.302e-06/2.571, allocations: 0 / 2.108 GB, free: 9.23 MB / 1.01 GB
Notification: Performance of FrontEnd: time 2.174e-06/2.571, allocations: 0 / 2.108 GB, free: 9.23 MB / 1.01 GB
Notification: Performance of Transformations before backend: time 0.0007018/2.572, allocations: 0 / 2.108 GB, free: 9.23 MB / 1.01 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 1811
 * Number of variables: 1811
Notification: Performance of Generate backend data structure: time 1.285/3.857, allocations: 10.9 MB / 2.118 GB, free: 405.9 MB / 1.011 GB
Notification: Performance of prepare preOptimizeDAE: time 5.396e-05/3.857, allocations: 13.3 kB / 2.118 GB, free: 405.9 MB / 1.011 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01657/3.873, allocations: 2.056 MB / 2.12 GB, free: 405.2 MB / 1.011 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.03383/3.907, allocations: 9.843 MB / 2.13 GB, free: 400.9 MB / 1.011 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0008427/3.908, allocations: 0.5575 MB / 2.131 GB, free: 400.6 MB / 1.011 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.00294/3.911, allocations: 0.7537 MB / 2.131 GB, free: 400.4 MB / 1.011 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.02995/3.941, allocations: 8.455 MB / 2.14 GB, free: 395.5 MB / 1.011 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0004103/3.942, allocations: 15.22 kB / 2.14 GB, free: 395.5 MB / 1.011 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.002175/3.944, allocations: 305.1 kB / 2.14 GB, free: 395.3 MB / 1.011 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0004744/3.944, allocations: 286 kB / 2.14 GB, free: 395.3 MB / 1.011 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.02468/3.969, allocations: 6.897 MB / 2.147 GB, free: 391.8 MB / 1.011 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.08854/4.058, allocations: 40.65 MB / 2.187 GB, free: 354.2 MB / 1.011 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.01231/4.07, allocations: 4.638 MB / 2.191 GB, free: 349.5 MB / 1.011 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.006897/4.077, allocations: 2.317 MB / 2.193 GB, free: 347.2 MB / 1.011 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.03777/4.115, allocations: 10.22 MB / 2.203 GB, free: 336.6 MB / 1.011 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.007822/4.123, allocations: 2.451 MB / 2.206 GB, free: 334.1 MB / 1.011 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.006523/4.129, allocations: 454 kB / 2.206 GB, free: 333.7 MB / 1.011 GB
Notification: Performance of pre-optimization done (n=390): time 1.805e-05/4.129, allocations: 0 / 2.206 GB, free: 333.7 MB / 1.011 GB
Notification: Performance of matching and sorting (n=399): time 0.06437/4.194, allocations: 14.49 MB / 2.22 GB, free: 319.1 MB / 1.011 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001877/4.194, allocations: 0.5519 MB / 2.221 GB, free: 318.4 MB / 1.011 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.01851/4.212, allocations: 8.075 MB / 2.229 GB, free: 310.4 MB / 1.011 GB
Notification: Performance of collectPreVariables (initialization): time 0.001311/4.214, allocations: 129.5 kB / 2.229 GB, free: 310.2 MB / 1.011 GB
Notification: Performance of collectInitialEqns (initialization): time 0.006108/4.22, allocations: 4.963 MB / 2.234 GB, free: 305.2 MB / 1.011 GB
Notification: Performance of collectInitialBindings (initialization): time 0.002208/4.222, allocations: 1.381 MB / 2.235 GB, free: 303.9 MB / 1.011 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.00073/4.223, allocations: 112 kB / 2.235 GB, free: 303.8 MB / 1.011 GB
Notification: Performance of setup shared object (initialization): time 0.0003826/4.223, allocations: 0.5179 MB / 2.236 GB, free: 303.2 MB / 1.011 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.007729/4.231, allocations: 2.114 MB / 2.238 GB, free: 301.1 MB / 1.011 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.009158/4.24, allocations: 3.884 MB / 2.242 GB, free: 296.6 MB / 1.011 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.009012/4.249, allocations: 2.711 MB / 2.244 GB, free: 293.9 MB / 1.011 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 4.675e-05/4.249, allocations: 12 kB / 2.244 GB, free: 293.9 MB / 1.011 GB
Notification: Performance of matching and sorting (n=714) (initialization): time 0.03337/4.283, allocations: 7.951 MB / 2.252 GB, free: 285.9 MB / 1.011 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0007337/4.284, allocations: 1.269 MB / 2.253 GB, free: 284.2 MB / 1.011 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.000105/4.284, allocations: 47.92 kB / 2.253 GB, free: 284.1 MB / 1.011 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.01667/4.3, allocations: 1.844 MB / 2.255 GB, free: 282.3 MB / 1.011 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.009449/4.31, allocations: 1.213 MB / 2.256 GB, free: 281.1 MB / 1.011 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01452/4.325, allocations: 7.845 MB / 2.264 GB, free: 272.8 MB / 1.011 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01454/4.339, allocations: 0.746 MB / 2.265 GB, free: 272.1 MB / 1.011 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001421/4.341, allocations: 267.9 kB / 2.265 GB, free: 271.8 MB / 1.011 GB
Notification: Performance of prepare postOptimizeDAE: time 1.077e-05/4.341, allocations: 8 kB / 2.265 GB, free: 271.8 MB / 1.011 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.02605/4.367, allocations: 6.856 MB / 2.272 GB, free: 264.9 MB / 1.011 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001406/4.367, allocations: 43.98 kB / 2.272 GB, free: 264.8 MB / 1.011 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.01497/4.382, allocations: 1.708 MB / 2.273 GB, free: 263.1 MB / 1.011 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.008601/4.39, allocations: 1.162 MB / 2.274 GB, free: 261.9 MB / 1.011 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.02052/4.411, allocations: 9.799 MB / 2.284 GB, free: 251.6 MB / 1.011 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01335/4.424, allocations: 0.7113 MB / 2.285 GB, free: 250.8 MB / 1.011 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001379/4.426, allocations: 263.8 kB / 2.285 GB, free: 250.6 MB / 1.011 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 175
 * Number of states: 0 ()
 * Number of discrete variables: 13 ($whenCondition1,$PRE.timTab.tab.nextTimeEvent,$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,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 (649):
 * Single equations (assignments): 633
 * 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.007175/4.433, allocations: 2.254 MB / 2.287 GB, free: 248.3 MB / 1.011 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.002971/4.436, allocations: 0.8951 MB / 2.288 GB, free: 247.4 MB / 1.011 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.02029/4.456, allocations: 6.01 MB / 2.294 GB, free: 241.4 MB / 1.011 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.01519/4.472, allocations: 4.447 MB / 2.298 GB, free: 236.9 MB / 1.011 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 3.166e-05/4.472, allocations: 0 / 2.298 GB, free: 236.9 MB / 1.011 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.006367/4.478, allocations: 1.645 MB / 2.3 GB, free: 235.2 MB / 1.011 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.003076/4.481, allocations: 92 kB / 2.3 GB, free: 235.1 MB / 1.011 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.01242/4.494, allocations: 0.6107 MB / 2.301 GB, free: 234.5 MB / 1.011 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.001144/4.495, allocations: 323.6 kB / 2.301 GB, free: 234.2 MB / 1.011 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.02197/4.517, allocations: 5.612 MB / 2.306 GB, free: 228.6 MB / 1.011 GB
Notification: Performance of postOpt detectDAEmodeSparsePattern (simulation): time 0.02199/4.539, allocations: 7.626 MB / 2.314 GB, free: 221 MB / 1.011 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.00553/4.544, allocations: 2.058 MB / 2.316 GB, free: 218.9 MB / 1.011 GB
Notification: Performance of sorting global known variables: time 0.01329/4.558, allocations: 5.32 MB / 2.321 GB, free: 213.6 MB / 1.011 GB
Notification: Performance of Backend: time 8.62e-07/4.558, allocations: 0 / 2.321 GB, free: 213.6 MB / 1.011 GB
Notification: Performance of simCode: created initialization part: time 0.04463/4.603, allocations: 11.12 MB / 2.332 GB, free: 203.2 MB / 1.011 GB
Notification: Performance of SimCode: time 0.06665/4.669, allocations: 25.03 MB / 2.356 GB, free: 178.2 MB / 1.011 GB
Notification: Performance of Templates: time 1.137/5.806, allocations: 196.3 MB / 2.548 GB, free: 378.6 MB / 1.011 GB