Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_13_Buildings.DHC.Networks.Examples.Distribution2PipeExample.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.0008384/0.0008384, allocations: 80.81 kB / 21.55 MB, free: 2.949 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.001047/0.001047, allocations: 159.9 kB / 24.97 MB, free: 8.746 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.9471/0.9471, allocations: 177.1 MB / 205.4 MB, free: 5.504 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.995/1.995, allocations: 389.6 MB / 0.6362 GB, free: 12.33 MB / 0.6042 GB
"
[Timeout remaining time 177]
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.Distribution2PipeExample,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="Buildings_13_Buildings.DHC.Networks.Examples.Distribution2PipeExample")
translateModel(Buildings.DHC.Networks.Examples.Distribution2PipeExample,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="Buildings_13_Buildings.DHC.Networks.Examples.Distribution2PipeExample") [Timeout 300]
"Notification: Performance of FrontEnd - loaded program: time 1.733e-06/1.733e-06, allocations: 0 / 0.7759 GB, free: 5.41 MB / 0.7292 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 2.44e-05/2.613e-05, allocations: 6.438 kB / 0.776 GB, free: 5.406 MB / 0.7292 GB
Notification: Performance of NFInst.instantiate(Buildings.DHC.Networks.Examples.Distribution2PipeExample): time 0.2858/0.2858, allocations: 286.1 MB / 1.055 GB, free: 6.445 MB / 1.01 GB
Notification: Performance of NFInst.instExpressions: time 0.6019/0.8878, allocations: 53.31 MB / 1.107 GB, free: 55.79 MB / 1.01 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.02306/0.9108, allocations: 0.8368 MB / 1.108 GB, free: 55.79 MB / 1.01 GB
Notification: Performance of NFTyping.typeComponents: time 0.01442/0.9252, allocations: 5.284 MB / 1.113 GB, free: 55.13 MB / 1.01 GB
Notification: Performance of NFTyping.typeBindings: time 0.03722/0.9625, allocations: 15.92 MB / 1.129 GB, free: 49.48 MB / 1.01 GB
Notification: Performance of NFTyping.typeClassSections: time 0.02788/0.9903, allocations: 14.26 MB / 1.143 GB, free: 43.2 MB / 1.01 GB
Notification: Performance of NFFlatten.flatten: time 0.2277/1.218, allocations: 220.3 MB / 1.358 GB, free: 13.52 MB / 1.151 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.1114/1.329, allocations: 53.12 MB / 1.41 GB, free: 10.54 MB / 1.198 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.1704/1.5, allocations: 83.75 MB / 1.492 GB, free: 10.53 MB / 1.276 GB
Notification: Performance of NFSimplifyModel.simplify: time 1.134/2.634, allocations: 47.06 MB / 1.538 GB, free: 145.2 MB / 1.307 GB
Notification: Performance of NFPackage.collectConstants: time 0.04063/2.675, allocations: 7.165 MB / 1.545 GB, free: 145.2 MB / 1.307 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.04066/2.716, allocations: 10.22 MB / 1.555 GB, free: 145.2 MB / 1.307 GB
Notification: Performance of NFScalarize.scalarize: time 0.03079/2.746, allocations: 21.63 MB / 1.576 GB, free: 145.2 MB / 1.307 GB
Notification: Performance of NFVerifyModel.verify: time 0.07083/2.817, allocations: 26.24 MB / 1.601 GB, free: 145.2 MB / 1.307 GB
Notification: Performance of NFConvertDAE.convert: time 0.1126/2.93, allocations: 66.95 MB / 1.667 GB, free: 139.7 MB / 1.307 GB
Notification: Performance of FrontEnd - DAE generated: time 7.935e-06/2.93, allocations: 3.875 kB / 1.667 GB, free: 139.7 MB / 1.307 GB
Notification: Performance of FrontEnd: time 1.883e-06/2.93, allocations: 0 / 1.667 GB, free: 139.7 MB / 1.307 GB
Notification: Performance of Transformations before backend: time 0.003889/2.934, allocations: 0 / 1.667 GB, free: 139.7 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: 8964
 * Number of variables: 8964
Notification: Performance of Generate backend data structure: time 0.1442/3.078, allocations: 69.27 MB / 1.734 GB, free: 110.7 MB / 1.307 GB
Notification: Performance of prepare preOptimizeDAE: time 4.997e-05/3.078, allocations: 13.44 kB / 1.734 GB, free: 110.7 MB / 1.307 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.05731/3.135, allocations: 14.47 MB / 1.749 GB, free: 110.2 MB / 1.307 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.1208/3.256, allocations: 55.78 MB / 1.803 GB, free: 93.77 MB / 1.307 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.002773/3.259, allocations: 2.827 MB / 1.806 GB, free: 92.5 MB / 1.307 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.01213/3.271, allocations: 3.855 MB / 1.81 GB, free: 91.26 MB / 1.307 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.07597/3.347, allocations: 36.99 MB / 1.846 GB, free: 58.11 MB / 1.307 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.001272/3.348, allocations: 151.4 kB / 1.846 GB, free: 58.03 MB / 1.307 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.007601/3.356, allocations: 1.489 MB / 1.847 GB, free: 56.56 MB / 1.307 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0007935/3.357, allocations: 1.352 MB / 1.849 GB, free: 55.21 MB / 1.307 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.04661/3.403, allocations: 12.39 MB / 1.861 GB, free: 43.54 MB / 1.307 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.2878/3.691, allocations: 159.4 MB / 2.016 GB, free: 0.9414 MB / 1.417 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.02615/3.717, allocations: 13.81 MB / 2.03 GB, free: 3.266 MB / 1.432 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.01158/3.729, allocations: 3.562 MB / 2.033 GB, free: 15.8 MB / 1.448 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.1272/3.856, allocations: 31.09 MB / 2.064 GB, free: 1.371 MB / 1.464 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.6385/4.495, allocations: 11.23 MB / 2.075 GB, free: 373.6 MB / 1.464 GB
Notification: Performance of pre-optimization done (n=1598): time 5.302e-05/4.495, allocations: 1.062 kB / 2.075 GB, free: 373.6 MB / 1.464 GB
Notification: Performance of matching and sorting (n=1598): time 0.05438/4.549, allocations: 13.41 MB / 2.088 GB, free: 373 MB / 1.464 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001842/4.549, allocations: 0.7432 MB / 2.088 GB, free: 372.3 MB / 1.464 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.1101/4.659, allocations: 45.81 MB / 2.133 GB, free: 369.4 MB / 1.464 GB
Notification: Performance of collectPreVariables (initialization): time 0.005869/4.665, allocations: 483.6 kB / 2.134 GB, free: 369.4 MB / 1.464 GB
Notification: Performance of collectInitialEqns (initialization): time 0.03114/4.696, allocations: 18.42 MB / 2.152 GB, free: 368.9 MB / 1.464 GB
Notification: Performance of collectInitialBindings (initialization): time 0.01216/4.708, allocations: 5.986 MB / 2.157 GB, free: 365.8 MB / 1.464 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0294/4.738, allocations: 6.208 MB / 2.164 GB, free: 365.3 MB / 1.464 GB
Notification: Performance of setup shared object (initialization): time 4.763e-05/4.738, allocations: 312.2 kB / 2.164 GB, free: 365 MB / 1.464 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.02021/4.758, allocations: 4.715 MB / 2.168 GB, free: 364.8 MB / 1.464 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.02934/4.787, allocations: 22.57 MB / 2.19 GB, free: 342.1 MB / 1.464 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.04067/4.828, allocations: 22.17 MB / 2.212 GB, free: 329.9 MB / 1.464 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0007051/4.829, allocations: 94.03 kB / 2.212 GB, free: 329.9 MB / 1.464 GB
Notification: Performance of matching and sorting (n=3811) (initialization): time 0.08077/4.91, allocations: 21.89 MB / 2.234 GB, free: 328.9 MB / 1.464 GB
Notification: Performance of prepare postOptimizeDAE: time 0.000253/4.91, allocations: 145.9 kB / 2.234 GB, free: 328.9 MB / 1.464 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0006305/4.91, allocations: 352.3 kB / 2.234 GB, free: 328.9 MB / 1.464 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.01929/4.93, allocations: 8.091 MB / 2.242 GB, free: 326.8 MB / 1.464 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.02947/4.959, allocations: 10 MB / 2.252 GB, free: 324.4 MB / 1.464 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01389/4.973, allocations: 17.6 MB / 2.269 GB, free: 310.7 MB / 1.464 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0414/5.014, allocations: 3.643 MB / 2.272 GB, free: 308.7 MB / 1.464 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.008829/5.023, allocations: 1.24 MB / 2.274 GB, free: 308.6 MB / 1.464 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.04122/5.065, allocations: 5.204 MB / 2.279 GB, free: 308 MB / 1.464 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.02617/5.091, allocations: 22.5 MB / 2.301 GB, free: 284.3 MB / 1.464 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.03685/5.128, allocations: 20.54 MB / 2.321 GB, free: 266.4 MB / 1.464 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 0.0004424/5.128, allocations: 96 kB / 2.321 GB, free: 266.3 MB / 1.464 GB
Notification: Performance of matching and sorting (n=3811) (initialization_lambda0): time 0.07728/5.205, allocations: 23.06 MB / 2.343 GB, free: 247.4 MB / 1.464 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0002116/5.205, allocations: 145.6 kB / 2.344 GB, free: 247.3 MB / 1.464 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0005749/5.206, allocations: 352 kB / 2.344 GB, free: 246.9 MB / 1.464 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.01125/5.217, allocations: 5.154 MB / 2.349 GB, free: 242.2 MB / 1.464 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.02842/5.246, allocations: 10.19 MB / 2.359 GB, free: 232.7 MB / 1.464 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01381/5.26, allocations: 26.4 MB / 2.385 GB, free: 207.4 MB / 1.464 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.03619/5.296, allocations: 2.985 MB / 2.388 GB, free: 204.9 MB / 1.464 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.007097/5.303, allocations: 1.214 MB / 2.389 GB, free: 203.9 MB / 1.464 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 1494
 * 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 (3285):
 * Single equations (assignments): 3228
 * Array equations: 12
 * Algorithm blocks: 0
 * Record equations: 22
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 11
 * Torn equation systems: 12
 * 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): 12 systems
   {(10,212), (2,4), (2,4), (2,4), (2,4), (2,4), (2,4), (2,4), (2,4), (2,4), (2,4), (10,212)}
Notification: Performance of prepare postOptimizeDAE: time 0.01139/5.314, allocations: 2.12 MB / 2.391 GB, free: 203 MB / 1.464 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.01485/5.329, allocations: 3.33 MB / 2.394 GB, free: 199.8 MB / 1.464 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.04162/5.371, allocations: 14.38 MB / 2.408 GB, free: 185.6 MB / 1.464 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.0199/5.391, allocations: 6.688 MB / 2.415 GB, free: 178.9 MB / 1.464 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 0.00025/5.391, allocations: 27.97 kB / 2.415 GB, free: 178.9 MB / 1.464 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.02518/5.416, allocations: 6.61 MB / 2.421 GB, free: 172.2 MB / 1.464 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.01442/5.43, allocations: 415.9 kB / 2.422 GB, free: 171.8 MB / 1.464 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0249/5.455, allocations: 0.9477 MB / 2.422 GB, free: 170.9 MB / 1.464 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.004989/5.46, allocations: 1.166 MB / 2.424 GB, free: 169.7 MB / 1.464 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.0351/5.495, allocations: 13.46 MB / 2.437 GB, free: 156.9 MB / 1.464 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.04147/5.537, allocations: 15.29 MB / 2.452 GB, free: 142 MB / 1.464 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.008756/5.546, allocations: 3.317 MB / 2.455 GB, free: 138.8 MB / 1.464 GB
Notification: Performance of sorting global known variables: time 0.03825/5.584, allocations: 19.47 MB / 2.474 GB, free: 122 MB / 1.464 GB
Notification: Performance of Backend: time 8.72e-07/5.584, allocations: 0 / 2.474 GB, free: 122 MB / 1.464 GB
Notification: Performance of simCode: created initialization part: time 0.1441/5.728, allocations: 43.28 MB / 2.516 GB, free: 81.71 MB / 1.464 GB
Notification: Performance of SimCode: time 1.443/7.171, allocations: 134.2 MB / 2.647 GB, free: 302.2 MB / 1.464 GB
Notification: Performance of Templates: time 2.938/10.11, allocations: 1.226 GB / 3.873 GB, free: 318.8 MB / 1.542 GB
"
[Timeout remaining time 290]
make -j1 -f Buildings_13_Buildings.DHC.Networks.Examples.Distribution2PipeExample.makefile [Timeout 300]
(rm -f Buildings_13_Buildings.DHC.Networks.Examples.Distribution2PipeExample.pipe ; mkfifo Buildings_13_Buildings.DHC.Networks.Examples.Distribution2PipeExample.pipe ; head -c 1048576 < Buildings_13_Buildings.DHC.Networks.Examples.Distribution2PipeExample.pipe >> ../files/Buildings_13_Buildings.DHC.Networks.Examples.Distribution2PipeExample.sim & ./Buildings_13_Buildings.DHC.Networks.Examples.Distribution2PipeExample -abortSlowSimulation -alarm=240  -lv LOG_STATS > Buildings_13_Buildings.DHC.Networks.Examples.Distribution2PipeExample.pipe 2>&1) [Timeout 240]
[Calling os._exit(0), Time elapsed: 33.37956577166915]