Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_13_Buildings.DHC.Loads.BaseClasses.Validation.BenchmarkFlowDistribution2.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo): time 0.001169/0.001169, allocations: 80.81 kB / 21.55 MB, free: 2.941 MB / 18.57 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo): time 0.001133/0.001133, allocations: 168.4 kB / 24.97 MB, free: 9.18 MB / 18.57 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo): time 1.034/1.034, allocations: 177.1 MB / 205.4 MB, free: 5.48 MB / 186.7 MB
"
[Timeout remaining time 179]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 13.0.2-maint.13.x/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 13.0.2-maint.13.x/package.mo): time 1.95/1.95, allocations: 389.6 MB / 0.6362 GB, free: 12.28 MB / 0.6042 GB
"
[Timeout remaining time 178]
Using package Buildings with version 13.0.2 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 13.0.2-maint.13.x/package.mo)
Using package Modelica with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo)
Using package Complex with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo)
Using package ModelicaServices with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo)
Running command: translateModel(Buildings.DHC.Loads.BaseClasses.Validation.BenchmarkFlowDistribution2,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="Buildings_13_Buildings.DHC.Loads.BaseClasses.Validation.BenchmarkFlowDistribution2")
translateModel(Buildings.DHC.Loads.BaseClasses.Validation.BenchmarkFlowDistribution2,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="Buildings_13_Buildings.DHC.Loads.BaseClasses.Validation.BenchmarkFlowDistribution2") [Timeout 300]
"Notification: Performance of FrontEnd - loaded program: time 1.794e-06/1.794e-06, allocations: 0 / 0.776 GB, free: 5.359 MB / 0.7292 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 2.15e-05/2.329e-05, allocations: 2.312 kB / 0.776 GB, free: 5.355 MB / 0.7292 GB
Notification: Performance of NFInst.instantiate(Buildings.DHC.Loads.BaseClasses.Validation.BenchmarkFlowDistribution2): time 0.1867/0.1867, allocations: 206.2 MB / 0.9773 GB, free: 6.598 MB / 0.9323 GB
Notification: Performance of NFInst.instExpressions: time 0.04265/0.2293, allocations: 26.46 MB / 1.003 GB, free: 12.08 MB / 0.9636 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.008908/0.2382, allocations: 361.1 kB / 1.004 GB, free: 11.73 MB / 0.9636 GB
Notification: Performance of NFTyping.typeComponents: time 0.005401/0.2436, allocations: 2.777 MB / 1.006 GB, free: 8.934 MB / 0.9636 GB
Notification: Performance of NFTyping.typeBindings: time 0.01275/0.2564, allocations: 7.038 MB / 1.013 GB, free: 1.859 MB / 0.9636 GB
Notification: Performance of NFTyping.typeClassSections: time 0.009745/0.2661, allocations: 6.313 MB / 1.019 GB, free: 11.54 MB / 0.9792 GB
Notification: Performance of NFFlatten.flatten: time 0.9202/1.186, allocations: 91.05 MB / 1.108 GB, free: 49.11 MB / 0.9949 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.02985/1.216, allocations: 20.31 MB / 1.128 GB, free: 46.88 MB / 0.9949 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.06141/1.278, allocations: 31.52 MB / 1.159 GB, free: 36.16 MB / 0.9949 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.03065/1.308, allocations: 17.51 MB / 1.176 GB, free: 30.12 MB / 0.9949 GB
Notification: Performance of NFPackage.collectConstants: time 0.007633/1.316, allocations: 2.508 MB / 1.178 GB, free: 27.61 MB / 0.9949 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.02011/1.336, allocations: 5.303 MB / 1.184 GB, free: 23.17 MB / 0.9949 GB
Notification: Performance of NFScalarize.scalarize: time 0.01081/1.347, allocations: 8.23 MB / 1.192 GB, free: 15.29 MB / 0.9949 GB
Notification: Performance of NFVerifyModel.verify: time 0.02265/1.369, allocations: 9.823 MB / 1.201 GB, free: 5.773 MB / 0.9949 GB
Notification: Performance of NFConvertDAE.convert: time 0.03649/1.406, allocations: 26.18 MB / 1.227 GB, free: 13.16 MB / 1.026 GB
Notification: Performance of FrontEnd - DAE generated: time 7.514e-06/1.406, allocations: 0 / 1.227 GB, free: 13.16 MB / 1.026 GB
Notification: Performance of FrontEnd: time 1.142e-06/1.406, allocations: 0 / 1.227 GB, free: 13.16 MB / 1.026 GB
Notification: Performance of Transformations before backend: time 0.00137/1.407, allocations: 0.9688 kB / 1.227 GB, free: 13.16 MB / 1.026 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 3491
 * Number of variables: 3491
Notification: Performance of Generate backend data structure: time 0.03906/1.446, allocations: 27.7 MB / 1.254 GB, free: 3.152 MB / 1.042 GB
Notification: Performance of prepare preOptimizeDAE: time 4.739e-05/1.446, allocations: 8.625 kB / 1.254 GB, free: 3.145 MB / 1.042 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01421/1.461, allocations: 5.463 MB / 1.259 GB, free: 13.8 MB / 1.057 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.04105/1.502, allocations: 25.09 MB / 1.284 GB, free: 5.852 MB / 1.073 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0009184/1.503, allocations: 1.089 MB / 1.285 GB, free: 4.766 MB / 1.073 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.003009/1.506, allocations: 1.473 MB / 1.286 GB, free: 3.305 MB / 1.073 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.0194/1.525, allocations: 14.58 MB / 1.3 GB, free: 3.758 MB / 1.089 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0002111/1.525, allocations: 57.36 kB / 1.3 GB, free: 3.734 MB / 1.089 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.001044/1.526, allocations: 0.5845 MB / 1.301 GB, free: 3.156 MB / 1.089 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0003288/1.527, allocations: 0.5266 MB / 1.302 GB, free: 2.629 MB / 1.089 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.007308/1.534, allocations: 4.867 MB / 1.306 GB, free: 14.05 MB / 1.104 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.07712/1.611, allocations: 64.04 MB / 1.369 GB, free: 15.69 MB / 1.167 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.004625/1.616, allocations: 3.366 MB / 1.372 GB, free: 12.44 MB / 1.167 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001714/1.617, allocations: 1.292 MB / 1.373 GB, free: 11.17 MB / 1.167 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.02346/1.641, allocations: 9.092 MB / 1.382 GB, free: 2.242 MB / 1.167 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.003378/1.644, allocations: 3.966 MB / 1.386 GB, free: 13.89 MB / 1.182 GB
Notification: Performance of pre-optimization done (n=538): time 1.196e-05/1.644, allocations: 0 / 1.386 GB, free: 13.89 MB / 1.182 GB
Notification: Performance of matching and sorting (n=538): time 0.01006/1.654, allocations: 4.355 MB / 1.39 GB, free: 9.492 MB / 1.182 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001269/1.654, allocations: 393.3 kB / 1.391 GB, free: 9.027 MB / 1.182 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0258/1.68, allocations: 19.27 MB / 1.41 GB, free: 9.148 MB / 1.198 GB
Notification: Performance of collectPreVariables (initialization): time 0.001925/1.682, allocations: 182.8 kB / 1.41 GB, free: 8.965 MB / 1.198 GB
Notification: Performance of collectInitialEqns (initialization): time 0.00662/1.689, allocations: 7.572 MB / 1.417 GB, free: 2.379 MB / 1.198 GB
Notification: Performance of collectInitialBindings (initialization): time 0.002749/1.691, allocations: 1.997 MB / 1.419 GB, free: 0.4922 MB / 1.198 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.003342/1.695, allocations: 2.417 MB / 1.421 GB, free: 14.6 MB / 1.214 GB
Notification: Performance of setup shared object (initialization): time 7.429e-05/1.695, allocations: 305.1 kB / 1.422 GB, free: 14.3 MB / 1.214 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.003114/1.698, allocations: 1.675 MB / 1.423 GB, free: 12.62 MB / 1.214 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.005951/1.704, allocations: 9.595 MB / 1.433 GB, free: 300 kB / 1.214 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.008212/1.712, allocations: 8.631 MB / 1.441 GB, free: 6.469 MB / 1.229 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 6.189e-05/1.712, allocations: 40 kB / 1.441 GB, free: 6.43 MB / 1.229 GB
Notification: Performance of matching and sorting (n=1409) (initialization): time 0.01472/1.727, allocations: 8.207 MB / 1.449 GB, free: 15.12 MB / 1.245 GB
Notification: Performance of prepare postOptimizeDAE: time 6.543e-05/1.727, allocations: 66.97 kB / 1.449 GB, free: 15.05 MB / 1.245 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001161/1.727, allocations: 152.1 kB / 1.449 GB, free: 14.91 MB / 1.245 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.006225/1.733, allocations: 3.307 MB / 1.453 GB, free: 11.64 MB / 1.245 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.02042/1.754, allocations: 7.619 MB / 1.46 GB, free: 4.203 MB / 1.245 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.006416/1.76, allocations: 9.131 MB / 1.469 GB, free: 10.99 MB / 1.261 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01267/1.773, allocations: 1.408 MB / 1.47 GB, free: 9.578 MB / 1.261 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.002377/1.775, allocations: 495.8 kB / 1.471 GB, free: 9.094 MB / 1.261 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.008933/1.784, allocations: 1.9 MB / 1.473 GB, free: 7.188 MB / 1.261 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.006013/1.79, allocations: 9.557 MB / 1.482 GB, free: 10.91 MB / 1.276 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.007552/1.798, allocations: 7.966 MB / 1.49 GB, free: 1.742 MB / 1.276 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 4.339e-05/1.798, allocations: 40 kB / 1.49 GB, free: 1.703 MB / 1.276 GB
Notification: Performance of matching and sorting (n=1409) (initialization_lambda0): time 0.01518/1.813, allocations: 8.311 MB / 1.498 GB, free: 10.3 MB / 1.292 GB
Notification: Performance of prepare postOptimizeDAE: time 6.198e-05/1.813, allocations: 68.94 kB / 1.498 GB, free: 10.23 MB / 1.292 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001087/1.813, allocations: 140 kB / 1.498 GB, free: 10.1 MB / 1.292 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.003397/1.817, allocations: 1.894 MB / 1.5 GB, free: 8.211 MB / 1.292 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.02021/1.837, allocations: 7.694 MB / 1.508 GB, free: 0.6914 MB / 1.292 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.007917/1.845, allocations: 13.35 MB / 1.521 GB, free: 3.074 MB / 1.307 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01035/1.855, allocations: 1.138 MB / 1.522 GB, free: 1.938 MB / 1.307 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0008648/1.856, allocations: 479.9 kB / 1.522 GB, free: 1.469 MB / 1.307 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 647
 * Number of states: 0 ()
 * Number of discrete variables: 15 ($PRE.loa.nextTimeEvent,$whenCondition1,ter[5].con.con1.y,ter[4].con.con1.y,ter[3].con.con1.y,ter[2].con.con1.y,ter[1].con.con1.y,ter[5].hex.flowRegime_nominal,ter[4].hex.flowRegime_nominal,ter[3].hex.flowRegime_nominal,ter[2].hex.flowRegime_nominal,ter[1].hex.flowRegime_nominal,loa.nextTimeEventScaled,$PRE.loa.nextTimeEventScaled,loa.nextTimeEvent)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (1182):
 * Single equations (assignments): 1164
 * Array equations: 6
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 11
 * Torn equation systems: 1
 * 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): 11 systems
   {1, 1, 1, 1, 1, 1, 1, 1, 1, 1, 1}
 * Without analytic Jacobian (size): 0 systems
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 0 systems
 * Non-linear torn systems (#iteration vars, #inner vars): 1 system
   {(11,211)}
Notification: Performance of prepare postOptimizeDAE: time 0.00213/1.858, allocations: 0.9475 MB / 1.523 GB, free: 0.6836 MB / 1.307 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.5084/2.366, allocations: 1.323 MB / 1.524 GB, free: 317.3 MB / 1.307 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01127/2.378, allocations: 4.573 MB / 1.529 GB, free: 316.9 MB / 1.307 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.00366/2.381, allocations: 2.282 MB / 1.531 GB, free: 316.4 MB / 1.307 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.138e-05/2.381, allocations: 2.281 kB / 1.531 GB, free: 316.4 MB / 1.307 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.006886/2.388, allocations: 2.581 MB / 1.534 GB, free: 316.3 MB / 1.307 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.002559/2.391, allocations: 113.5 kB / 1.534 GB, free: 316.3 MB / 1.307 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.004266/2.395, allocations: 390.6 kB / 1.534 GB, free: 316.3 MB / 1.307 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0006072/2.396, allocations: 329.2 kB / 1.534 GB, free: 316.3 MB / 1.307 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.009478/2.405, allocations: 5.01 MB / 1.539 GB, free: 315.4 MB / 1.307 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.006593/2.412, allocations: 5.534 MB / 1.545 GB, free: 314.1 MB / 1.307 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.001254/2.413, allocations: 0.9916 MB / 1.546 GB, free: 314 MB / 1.307 GB
Notification: Performance of sorting global known variables: time 0.008351/2.421, allocations: 8.163 MB / 1.554 GB, free: 313.4 MB / 1.307 GB
Notification: Performance of Backend: time 5.11e-07/2.421, allocations: 0.7656 kB / 1.554 GB, free: 313.4 MB / 1.307 GB
Notification: Performance of simCode: created initialization part: time 0.08646/2.508, allocations: 30.84 MB / 1.584 GB, free: 312.2 MB / 1.307 GB
Notification: Performance of SimCode: time 0.07863/2.586, allocations: 52.97 MB / 1.635 GB, free: 294.5 MB / 1.307 GB
Notification: Performance of Templates: time 1.193/3.779, allocations: 470.1 MB / 2.095 GB, free: 364.1 MB / 1.37 GB
"
[Timeout remaining time 296]
make -j1 -f Buildings_13_Buildings.DHC.Loads.BaseClasses.Validation.BenchmarkFlowDistribution2.makefile [Timeout 300]
(rm -f Buildings_13_Buildings.DHC.Loads.BaseClasses.Validation.BenchmarkFlowDistribution2.pipe ; mkfifo Buildings_13_Buildings.DHC.Loads.BaseClasses.Validation.BenchmarkFlowDistribution2.pipe ; head -c 1048576 < Buildings_13_Buildings.DHC.Loads.BaseClasses.Validation.BenchmarkFlowDistribution2.pipe >> ../files/Buildings_13_Buildings.DHC.Loads.BaseClasses.Validation.BenchmarkFlowDistribution2.sim & ./Buildings_13_Buildings.DHC.Loads.BaseClasses.Validation.BenchmarkFlowDistribution2 -abortSlowSimulation -alarm=240  -lv LOG_STATS > Buildings_13_Buildings.DHC.Loads.BaseClasses.Validation.BenchmarkFlowDistribution2.pipe 2>&1) [Timeout 240]
[Calling sys.exit(0), Time elapsed: 16.728896067477763]