Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_13_Buildings.Examples.Tutorial.Boiler.System4.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.001152/0.001152, 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.001272/0.001272, allocations: 168.8 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 0.9724/0.9724, allocations: 177.1 MB / 205.4 MB, free: 5.488 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.951/1.951, allocations: 389.6 MB / 0.6362 GB, free: 12.27 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.Examples.Tutorial.Boiler.System4,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="Buildings_13_Buildings.Examples.Tutorial.Boiler.System4")
translateModel(Buildings.Examples.Tutorial.Boiler.System4,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="Buildings_13_Buildings.Examples.Tutorial.Boiler.System4") [Timeout 300]
"Notification: Performance of FrontEnd - loaded program: time 1.804e-06/1.804e-06, allocations: 0 / 0.776 GB, free: 5.344 MB / 0.7292 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 2.644e-05/2.824e-05, allocations: 2.312 kB / 0.776 GB, free: 5.34 MB / 0.7292 GB
Notification: Performance of NFInst.instantiate(Buildings.Examples.Tutorial.Boiler.System4): time 0.1896/0.1896, allocations: 216.3 MB / 0.9872 GB, free: 12.44 MB / 0.948 GB
Notification: Performance of NFInst.instExpressions: time 0.05134/0.2409, allocations: 30.52 MB / 1.017 GB, free: 13.86 MB / 0.9792 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.01295/0.2539, allocations: 0.5656 MB / 1.018 GB, free: 13.29 MB / 0.9792 GB
Notification: Performance of NFTyping.typeComponents: time 0.01085/0.2647, allocations: 3.579 MB / 1.021 GB, free: 9.691 MB / 0.9792 GB
Notification: Performance of NFTyping.typeBindings: time 0.02324/0.288, allocations: 10.08 MB / 1.031 GB, free: 15.55 MB / 0.9948 GB
Notification: Performance of NFTyping.typeClassSections: time 0.01733/0.3053, allocations: 8.687 MB / 1.039 GB, free: 6.852 MB / 0.9948 GB
Notification: Performance of NFFlatten.flatten: time 0.5308/0.8361, allocations: 37.74 MB / 1.076 GB, free: 42.36 MB / 0.9948 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.02066/0.8568, allocations: 8.623 MB / 1.085 GB, free: 41.23 MB / 0.9948 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.03634/0.8931, allocations: 15.3 MB / 1.1 GB, free: 39.85 MB / 0.9948 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.01501/0.9081, allocations: 7.553 MB / 1.107 GB, free: 38.92 MB / 0.9948 GB
Notification: Performance of NFPackage.collectConstants: time 0.00422/0.9123, allocations: 1.026 MB / 1.108 GB, free: 38.92 MB / 0.9948 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.009584/0.9219, allocations: 2.569 MB / 1.11 GB, free: 38.88 MB / 0.9948 GB
Notification: Performance of NFScalarize.scalarize: time 0.006467/0.9284, allocations: 3.442 MB / 1.114 GB, free: 38.23 MB / 0.9948 GB
Notification: Performance of NFVerifyModel.verify: time 0.01267/0.9411, allocations: 4.36 MB / 1.118 GB, free: 37.69 MB / 0.9948 GB
Notification: Performance of NFConvertDAE.convert: time 0.0181/0.9592, allocations: 10.36 MB / 1.128 GB, free: 36.36 MB / 0.9948 GB
Notification: Performance of FrontEnd - DAE generated: time 6.813e-06/0.9592, allocations: 0 / 1.128 GB, free: 36.36 MB / 0.9948 GB
Notification: Performance of FrontEnd: time 1.814e-06/0.9592, allocations: 4.094 kB / 1.128 GB, free: 36.36 MB / 0.9948 GB
Notification: Performance of Transformations before backend: time 0.0005975/0.9598, allocations: 0 / 1.128 GB, free: 36.36 MB / 0.9948 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 1616
 * Number of variables: 1616
Notification: Performance of Generate backend data structure: time 0.01831/0.9781, allocations: 12.17 MB / 1.14 GB, free: 30.91 MB / 0.9948 GB
Notification: Performance of prepare preOptimizeDAE: time 4.412e-05/0.9781, allocations: 11.48 kB / 1.14 GB, free: 30.91 MB / 0.9948 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.005324/0.9835, allocations: 2.055 MB / 1.142 GB, free: 30.81 MB / 0.9948 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.0144/0.9978, allocations: 7.638 MB / 1.15 GB, free: 28.7 MB / 0.9948 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0003903/0.9982, allocations: 0.497 MB / 1.15 GB, free: 28.68 MB / 0.9948 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.001584/0.9998, allocations: 0.6929 MB / 1.151 GB, free: 28.68 MB / 0.9948 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.008138/1.008, allocations: 6.169 MB / 1.157 GB, free: 26.07 MB / 0.9948 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.000178/1.008, allocations: 22.08 kB / 1.157 GB, free: 26.07 MB / 0.9948 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.00059/1.009, allocations: 272.4 kB / 1.157 GB, free: 26.07 MB / 0.9948 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001941/1.009, allocations: 258.4 kB / 1.157 GB, free: 26.05 MB / 0.9948 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.003755/1.013, allocations: 1.963 MB / 1.159 GB, free: 25.86 MB / 0.9948 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.03287/1.046, allocations: 20.32 MB / 1.179 GB, free: 15.78 MB / 0.9948 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.002365/1.048, allocations: 1.814 MB / 1.181 GB, free: 14.21 MB / 0.9948 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0009674/1.049, allocations: 0.8442 MB / 1.182 GB, free: 13.46 MB / 0.9948 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.01423/1.063, allocations: 4.268 MB / 1.186 GB, free: 9.535 MB / 0.9948 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.001675/1.065, allocations: 2.564 MB / 1.188 GB, free: 6.688 MB / 0.9948 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.002707/1.067, allocations: 325.6 kB / 1.189 GB, free: 6.367 MB / 0.9948 GB
Notification: Performance of pre-optimization done (n=321): time 1.229e-05/1.067, allocations: 4 kB / 1.189 GB, free: 6.363 MB / 0.9948 GB
Notification: Performance of matching and sorting (n=328): time 0.01341/1.081, allocations: 5.959 MB / 1.194 GB, free: 372 kB / 0.9948 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 3.399e-05/1.081, allocations: 107.7 kB / 1.195 GB, free: 244 kB / 0.9948 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.009862/1.091, allocations: 6.948 MB / 1.201 GB, free: 10.64 MB / 1.01 GB
Notification: Performance of collectPreVariables (initialization): time 0.0009489/1.092, allocations: 117.7 kB / 1.201 GB, free: 10.52 MB / 1.01 GB
Notification: Performance of collectInitialEqns (initialization): time 0.002582/1.094, allocations: 3.161 MB / 1.205 GB, free: 7.758 MB / 1.01 GB
Notification: Performance of collectInitialBindings (initialization): time 0.001376/1.096, allocations: 1.198 MB / 1.206 GB, free: 6.629 MB / 1.01 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.001376/1.097, allocations: 0.9489 MB / 1.207 GB, free: 5.781 MB / 1.01 GB
Notification: Performance of setup shared object (initialization): time 7.638e-05/1.097, allocations: 305.1 kB / 1.207 GB, free: 5.48 MB / 1.01 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001581/1.099, allocations: 0.7244 MB / 1.208 GB, free: 4.734 MB / 1.01 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.002922/1.102, allocations: 3.474 MB / 1.211 GB, free: 400 kB / 1.01 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.003492/1.105, allocations: 2.979 MB / 1.214 GB, free: 13.11 MB / 1.026 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 2.375e-05/1.105, allocations: 12 kB / 1.214 GB, free: 13.1 MB / 1.026 GB
Notification: Performance of matching and sorting (n=607) (initialization): time 0.007001/1.112, allocations: 3.578 MB / 1.217 GB, free: 9.766 MB / 1.026 GB
Notification: Performance of prepare postOptimizeDAE: time 3.512e-05/1.112, allocations: 24 kB / 1.217 GB, free: 9.742 MB / 1.026 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 4.475e-05/1.112, allocations: 36 kB / 1.218 GB, free: 9.707 MB / 1.026 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.003747/1.116, allocations: 1.316 MB / 1.219 GB, free: 8.402 MB / 1.026 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002185/1.118, allocations: 1.017 MB / 1.22 GB, free: 7.449 MB / 1.026 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.003485/1.122, allocations: 5.158 MB / 1.225 GB, free: 2.137 MB / 1.026 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.004986/1.127, allocations: 244.3 kB / 1.225 GB, free: 1.898 MB / 1.026 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0003567/1.127, allocations: 183.9 kB / 1.225 GB, free: 1.719 MB / 1.026 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.003048/1.13, allocations: 0.8153 MB / 1.226 GB, free: 0.8906 MB / 1.026 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.002464/1.133, allocations: 3.463 MB / 1.229 GB, free: 12.55 MB / 1.042 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.003462/1.136, allocations: 2.914 MB / 1.232 GB, free: 9.324 MB / 1.042 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 2.72e-05/1.136, allocations: 12 kB / 1.232 GB, free: 9.312 MB / 1.042 GB
Notification: Performance of matching and sorting (n=607) (initialization_lambda0): time 0.006335/1.142, allocations: 3.52 MB / 1.236 GB, free: 6.039 MB / 1.042 GB
Notification: Performance of prepare postOptimizeDAE: time 2.488e-05/1.142, allocations: 24 kB / 1.236 GB, free: 6.016 MB / 1.042 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 3.478e-05/1.142, allocations: 44.12 kB / 1.236 GB, free: 5.973 MB / 1.042 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.002647/1.145, allocations: 0.9919 MB / 1.237 GB, free: 4.98 MB / 1.042 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001979/1.147, allocations: 1 MB / 1.238 GB, free: 4.047 MB / 1.042 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.005441/1.152, allocations: 6.45 MB / 1.244 GB, free: 13.43 MB / 1.057 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.004671/1.157, allocations: 253.4 kB / 1.244 GB, free: 13.18 MB / 1.057 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0003012/1.157, allocations: 175.9 kB / 1.244 GB, free: 13.01 MB / 1.057 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 178
 * Number of states: 0 ()
 * Number of discrete variables: 13 ($PRE.timTab.tab.nextTimeEvent,$whenCondition1,hysPum.y,$PRE.hysPum.y,and2.y,and1.y,hysTBoi.y,$PRE.hysTBoi.y,hysTOut.y,$PRE.hysTOut.y,timTab.tab.nextTimeEventScaled,$PRE.timTab.tab.nextTimeEventScaled,timTab.tab.nextTimeEvent)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (552):
 * Single equations (assignments): 545
 * Array equations: 2
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 1
 * Torn equation systems: 4
 * 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): 1 system
   {1}
 * Without analytic Jacobian (size): 0 systems
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 2 systems
   {(1,5,100.0%), (1,4,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 2 systems
   {(4,7), (13,22)}
Notification: Performance of prepare postOptimizeDAE: time 0.001088/1.159, allocations: 493.4 kB / 1.245 GB, free: 12.59 MB / 1.057 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.001511/1.16, allocations: 0.6203 MB / 1.246 GB, free: 11.97 MB / 1.057 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.004934/1.165, allocations: 2.74 MB / 1.248 GB, free: 9.219 MB / 1.057 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.002113/1.167, allocations: 1.489 MB / 1.25 GB, free: 7.715 MB / 1.057 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.444e-05/1.167, allocations: 11.98 kB / 1.25 GB, free: 7.703 MB / 1.057 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.002976/1.17, allocations: 1.041 MB / 1.251 GB, free: 6.66 MB / 1.057 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.001066/1.171, allocations: 71.98 kB / 1.251 GB, free: 6.59 MB / 1.057 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.002125/1.173, allocations: 163.8 kB / 1.251 GB, free: 6.43 MB / 1.057 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0004584/1.174, allocations: 258.2 kB / 1.251 GB, free: 6.176 MB / 1.057 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.004163/1.178, allocations: 2.08 MB / 1.253 GB, free: 4.148 MB / 1.057 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.003683/1.182, allocations: 2.748 MB / 1.256 GB, free: 1.43 MB / 1.057 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.0007232/1.182, allocations: 0.683 MB / 1.257 GB, free: 0.7578 MB / 1.057 GB
Notification: Performance of sorting global known variables: time 0.004086/1.186, allocations: 3.439 MB / 1.26 GB, free: 13.77 MB / 1.073 GB
Notification: Performance of Backend: time 7.21e-07/1.186, allocations: 0 / 1.26 GB, free: 13.77 MB / 1.073 GB
Notification: Performance of simCode: created initialization part: time 0.01109/1.197, allocations: 5.566 MB / 1.265 GB, free: 8.781 MB / 1.073 GB
Notification: Performance of SimCode: time 0.03611/1.234, allocations: 22.07 MB / 1.287 GB, free: 2.82 MB / 1.089 GB
Notification: Performance of Templates: time 0.2449/1.478, allocations: 209.7 MB / 1.492 GB, free: 4.418 MB / 1.292 GB
"
[Timeout remaining time 299]
make -j1 -f Buildings_13_Buildings.Examples.Tutorial.Boiler.System4.makefile [Timeout 300]
(rm -f Buildings_13_Buildings.Examples.Tutorial.Boiler.System4.pipe ; mkfifo Buildings_13_Buildings.Examples.Tutorial.Boiler.System4.pipe ; head -c 1048576 < Buildings_13_Buildings.Examples.Tutorial.Boiler.System4.pipe >> ../files/Buildings_13_Buildings.Examples.Tutorial.Boiler.System4.sim & ./Buildings_13_Buildings.Examples.Tutorial.Boiler.System4 -abortSlowSimulation -alarm=240  -lv LOG_STATS > Buildings_13_Buildings.Examples.Tutorial.Boiler.System4.pipe 2>&1) [Timeout 240]
[Calling os._exit(0), Time elapsed: 9.786482122726738]