Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_13_Buildings.DHC.Networks.Examples.Distribution1PipeExample.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.0009165/0.0009165, allocations: 80.88 kB / 21.55 MB, free: 2.945 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.001001/0.001001, allocations: 163.7 kB / 24.97 MB, free: 8.656 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 0.9558/0.9558, allocations: 177.1 MB / 205.4 MB, free: 5.5 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.946/1.946, allocations: 389.6 MB / 0.6362 GB, free: 12.29 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.Networks.Examples.Distribution1PipeExample,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="Buildings_13_Buildings.DHC.Networks.Examples.Distribution1PipeExample")
translateModel(Buildings.DHC.Networks.Examples.Distribution1PipeExample,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="Buildings_13_Buildings.DHC.Networks.Examples.Distribution1PipeExample") [Timeout 300]
"Notification: Performance of FrontEnd - loaded program: time 1.243e-06/1.243e-06, allocations: 0 / 0.7759 GB, free: 5.367 MB / 0.7292 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 1.283e-05/1.408e-05, allocations: 2.312 kB / 0.7759 GB, free: 5.363 MB / 0.7292 GB
Notification: Performance of NFInst.instantiate(Buildings.DHC.Networks.Examples.Distribution1PipeExample): time 0.2289/0.2289, allocations: 285.2 MB / 1.054 GB, free: 7.363 MB / 1.01 GB
Notification: Performance of NFInst.instExpressions: time 0.6148/0.8436, allocations: 54.02 MB / 1.107 GB, free: 54.82 MB / 1.01 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0232/0.8668, allocations: 0.8725 MB / 1.108 GB, free: 54.82 MB / 1.01 GB
Notification: Performance of NFTyping.typeComponents: time 0.01495/0.8818, allocations: 5.446 MB / 1.113 GB, free: 54.52 MB / 1.01 GB
Notification: Performance of NFTyping.typeBindings: time 0.03677/0.9186, allocations: 16.04 MB / 1.129 GB, free: 48.89 MB / 1.01 GB
Notification: Performance of NFTyping.typeClassSections: time 0.02926/0.9478, allocations: 14.59 MB / 1.143 GB, free: 42.55 MB / 1.01 GB
Notification: Performance of NFFlatten.flatten: time 0.25/1.198, allocations: 286.9 MB / 1.423 GB, free: 14.14 MB / 1.214 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.08926/1.287, allocations: 52.29 MB / 1.474 GB, free: 11.96 MB / 1.26 GB
Notification: Performance of NFEvalConstants.evaluate: time 1.217/2.504, allocations: 81.8 MB / 1.554 GB, free: 169.9 MB / 1.307 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.0784/2.582, allocations: 46.53 MB / 1.6 GB, free: 169.8 MB / 1.307 GB
Notification: Performance of NFPackage.collectConstants: time 0.02444/2.607, allocations: 6.688 MB / 1.606 GB, free: 169.8 MB / 1.307 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.04495/2.652, allocations: 10.01 MB / 1.616 GB, free: 169.8 MB / 1.307 GB
Notification: Performance of NFScalarize.scalarize: time 0.04186/2.694, allocations: 22.97 MB / 1.639 GB, free: 169.8 MB / 1.307 GB
Notification: Performance of NFVerifyModel.verify: time 0.1144/2.808, allocations: 26.24 MB / 1.664 GB, free: 169.8 MB / 1.307 GB
Notification: Performance of NFConvertDAE.convert: time 0.09651/2.905, allocations: 68.15 MB / 1.731 GB, free: 163.8 MB / 1.307 GB
Notification: Performance of FrontEnd - DAE generated: time 7.945e-06/2.905, allocations: 0 / 1.731 GB, free: 163.8 MB / 1.307 GB
Notification: Performance of FrontEnd: time 1.784e-06/2.905, allocations: 2.812 kB / 1.731 GB, free: 163.8 MB / 1.307 GB
Notification: Performance of Transformations before backend: time 0.005174/2.91, allocations: 3.938 kB / 1.731 GB, free: 163.8 MB / 1.307 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 8856
 * Number of variables: 8856
Notification: Performance of Generate backend data structure: time 0.1597/3.07, allocations: 72.97 MB / 1.802 GB, free: 116.8 MB / 1.307 GB
Notification: Performance of prepare preOptimizeDAE: time 4.821e-05/3.07, allocations: 8.625 kB / 1.802 GB, free: 116.8 MB / 1.307 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.05788/3.127, allocations: 15.55 MB / 1.817 GB, free: 101.7 MB / 1.307 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.1388/3.266, allocations: 64.74 MB / 1.88 GB, free: 39.84 MB / 1.307 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.002684/3.269, allocations: 2.805 MB / 1.883 GB, free: 37.04 MB / 1.307 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.01803/3.287, allocations: 3.778 MB / 1.887 GB, free: 33.29 MB / 1.307 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.09506/3.382, allocations: 37.09 MB / 1.923 GB, free: 10.13 MB / 1.323 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.001482/3.384, allocations: 141.2 kB / 1.923 GB, free: 10.07 MB / 1.323 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.01279/3.396, allocations: 1.466 MB / 1.925 GB, free: 8.609 MB / 1.323 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0009893/3.397, allocations: 1.317 MB / 1.926 GB, free: 7.297 MB / 1.323 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.0525/3.45, allocations: 12.58 MB / 1.938 GB, free: 11.43 MB / 1.339 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.9195/4.369, allocations: 157.5 MB / 2.092 GB, free: 252 MB / 1.448 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.02562/4.395, allocations: 13.01 MB / 2.105 GB, free: 250.3 MB / 1.448 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.01142/4.406, allocations: 3.941 MB / 2.109 GB, free: 250.2 MB / 1.448 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.1167/4.523, allocations: 27.09 MB / 2.135 GB, free: 249.4 MB / 1.448 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0199/4.543, allocations: 11.09 MB / 2.146 GB, free: 242.8 MB / 1.448 GB
Notification: Performance of pre-optimization done (n=1497): time 3.361e-05/4.543, allocations: 0 / 2.146 GB, free: 242.8 MB / 1.448 GB
Notification: Performance of matching and sorting (n=1497): time 0.09899/4.642, allocations: 28.37 MB / 2.174 GB, free: 242 MB / 1.448 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001702/4.642, allocations: 0.7397 MB / 2.174 GB, free: 241.3 MB / 1.448 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.1152/4.757, allocations: 51.5 MB / 2.225 GB, free: 238.1 MB / 1.448 GB
Notification: Performance of collectPreVariables (initialization): time 0.007254/4.765, allocations: 468.4 kB / 2.225 GB, free: 238.1 MB / 1.448 GB
Notification: Performance of collectInitialEqns (initialization): time 0.03319/4.798, allocations: 19.04 MB / 2.244 GB, free: 235.2 MB / 1.448 GB
Notification: Performance of collectInitialBindings (initialization): time 0.01026/4.808, allocations: 5.561 MB / 2.249 GB, free: 231.2 MB / 1.448 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0302/4.838, allocations: 5.931 MB / 2.255 GB, free: 230.1 MB / 1.448 GB
Notification: Performance of setup shared object (initialization): time 3.681e-05/4.838, allocations: 301.1 kB / 2.255 GB, free: 229.8 MB / 1.448 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0209/4.859, allocations: 4.619 MB / 2.26 GB, free: 229.1 MB / 1.448 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.02584/4.885, allocations: 22.62 MB / 2.282 GB, free: 205.3 MB / 1.448 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.03897/4.924, allocations: 21.12 MB / 2.302 GB, free: 190.5 MB / 1.448 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0005088/4.925, allocations: 96.19 kB / 2.302 GB, free: 190.5 MB / 1.448 GB
Notification: Performance of matching and sorting (n=3581) (initialization): time 0.07671/5.001, allocations: 21.84 MB / 2.324 GB, free: 185.7 MB / 1.448 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0003191/5.002, allocations: 154.6 kB / 2.324 GB, free: 185.7 MB / 1.448 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0005694/5.002, allocations: 341.4 kB / 2.324 GB, free: 185.7 MB / 1.448 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.01191/5.014, allocations: 5.329 MB / 2.329 GB, free: 182.5 MB / 1.448 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.02703/5.041, allocations: 8.415 MB / 2.338 GB, free: 174.7 MB / 1.448 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01319/5.054, allocations: 21.58 MB / 2.359 GB, free: 153.3 MB / 1.448 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.04585/5.1, allocations: 3.624 MB / 2.362 GB, free: 150.1 MB / 1.448 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.009052/5.109, allocations: 1.426 MB / 2.364 GB, free: 148.9 MB / 1.448 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.04139/5.151, allocations: 5.025 MB / 2.369 GB, free: 145.3 MB / 1.448 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.02422/5.175, allocations: 22.49 MB / 2.391 GB, free: 117.2 MB / 1.448 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.03667/5.211, allocations: 20.35 MB / 2.41 GB, free: 95.41 MB / 1.448 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 0.0005509/5.212, allocations: 96 kB / 2.411 GB, free: 95.32 MB / 1.448 GB
Notification: Performance of matching and sorting (n=3581) (initialization_lambda0): time 0.0695/5.281, allocations: 21.16 MB / 2.431 GB, free: 78.23 MB / 1.448 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0002827/5.282, allocations: 151 kB / 2.431 GB, free: 78.08 MB / 1.448 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0005327/5.282, allocations: 344 kB / 2.432 GB, free: 77.75 MB / 1.448 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.009089/5.291, allocations: 4.291 MB / 2.436 GB, free: 73.76 MB / 1.448 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.02773/5.319, allocations: 8.595 MB / 2.444 GB, free: 65.84 MB / 1.448 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.008335/5.327, allocations: 15.06 MB / 2.459 GB, free: 50.97 MB / 1.448 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.03701/5.364, allocations: 2.99 MB / 2.462 GB, free: 48.44 MB / 1.448 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.007367/5.372, allocations: 1.305 MB / 2.463 GB, free: 47.36 MB / 1.448 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 1518
 * Number of states: 0 ()
 * Number of discrete variables: 25 ($PRE.loa.nextTimeEvent,$whenCondition1,terPlugFlow[5].con.con1.y,terPlugFlow[4].con.con1.y,terPlugFlow[3].con.con1.y,terPlugFlow[2].con.con1.y,terPlugFlow[1].con.con1.y,terAutoSize[5].con.con1.y,terAutoSize[4].con.con1.y,terAutoSize[3].con.con1.y,terAutoSize[2].con.con1.y,terAutoSize[1].con.con1.y,terPlugFlow[5].hex.flowRegime_nominal,terPlugFlow[4].hex.flowRegime_nominal,terPlugFlow[3].hex.flowRegime_nominal,terPlugFlow[2].hex.flowRegime_nominal,terPlugFlow[1].hex.flowRegime_nominal,terAutoSize[5].hex.flowRegime_nominal,terAutoSize[4].hex.flowRegime_nominal,terAutoSize[3].hex.flowRegime_nominal,terAutoSize[2].hex.flowRegime_nominal,terAutoSize[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 (3155):
 * Single equations (assignments): 3089
 * Array equations: 22
 * Algorithm blocks: 0
 * Record equations: 12
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 16
 * Torn equation systems: 16
 * 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): 16 systems
   {1, 1, 1, 1, 1, 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): 16 systems
   {(1,27), (1,27), (1,27), (1,27), (4,60), (2,4), (2,4), (2,4), (2,4), (2,4), (1,27), (1,27), (1,27), (1,27), (2,4), (4,60)}
Notification: Performance of prepare postOptimizeDAE: time 0.01242/5.384, allocations: 2.076 MB / 2.465 GB, free: 46.44 MB / 1.448 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.01622/5.4, allocations: 3.504 MB / 2.469 GB, free: 43.12 MB / 1.448 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.04705/5.447, allocations: 15.5 MB / 2.484 GB, free: 30.29 MB / 1.448 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.02036/5.468, allocations: 6.972 MB / 2.491 GB, free: 23.5 MB / 1.448 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 0.000175/5.468, allocations: 15.98 kB / 2.491 GB, free: 23.48 MB / 1.448 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.02794/5.496, allocations: 7.094 MB / 2.498 GB, free: 17 MB / 1.448 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.01695/5.513, allocations: 355.3 kB / 2.498 GB, free: 16.88 MB / 1.448 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.02584/5.539, allocations: 1.029 MB / 2.499 GB, free: 16.08 MB / 1.448 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.005155/5.544, allocations: 1.077 MB / 2.5 GB, free: 15.13 MB / 1.448 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.03626/5.58, allocations: 12.7 MB / 2.512 GB, free: 3.445 MB / 1.448 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.04464/5.625, allocations: 14.99 MB / 2.527 GB, free: 5.68 MB / 1.464 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.009684/5.634, allocations: 3.249 MB / 2.53 GB, free: 3.074 MB / 1.464 GB
Notification: Performance of sorting global known variables: time 0.04773/5.682, allocations: 21.6 MB / 2.551 GB, free: 1.578 MB / 1.479 GB
Notification: Performance of Backend: time 8.61e-07/5.682, allocations: 0 / 2.551 GB, free: 1.578 MB / 1.479 GB
Notification: Performance of simCode: created initialization part: time 0.1242/5.806, allocations: 33.69 MB / 2.584 GB, free: 5.199 MB / 1.511 GB
Notification: Performance of SimCode: time 1.46/7.267, allocations: 146 MB / 2.727 GB, free: 356.9 MB / 1.542 GB
Notification: Performance of Templates: time 2.592/9.859, allocations: 1.349 GB / 4.076 GB, free: 178.3 MB / 1.573 GB
"
[Timeout remaining time 290]
make -j1 -f Buildings_13_Buildings.DHC.Networks.Examples.Distribution1PipeExample.makefile [Timeout 300]
(rm -f Buildings_13_Buildings.DHC.Networks.Examples.Distribution1PipeExample.pipe ; mkfifo Buildings_13_Buildings.DHC.Networks.Examples.Distribution1PipeExample.pipe ; head -c 1048576 < Buildings_13_Buildings.DHC.Networks.Examples.Distribution1PipeExample.pipe >> ../files/Buildings_13_Buildings.DHC.Networks.Examples.Distribution1PipeExample.sim & ./Buildings_13_Buildings.DHC.Networks.Examples.Distribution1PipeExample -abortSlowSimulation -alarm=240  -lv LOG_STATS > Buildings_13_Buildings.DHC.Networks.Examples.Distribution1PipeExample.pipe 2>&1) [Timeout 240]
[Calling os._exit(0), Time elapsed: 35.22854494582862]