Running: ./testmodel.py --libraries=/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr Buildings_8.0.0_Buildings.Fluid.Interfaces.Examples.HeaterCooler_u.conf.json
loadFile("/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 8.0.0/package.mo", uses=false)
loadFile("/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo", uses=false)
loadFile("/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo", uses=false)
loadFile("/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo", uses=false)
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 8.0.0 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 8.0.0/package.mo)
Running command: translateModel(Buildings.Fluid.Interfaces.Examples.HeaterCooler_u,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Buildings_8.0.0_Buildings.Fluid.Interfaces.Examples.HeaterCooler_u")
translateModel(Buildings.Fluid.Interfaces.Examples.HeaterCooler_u,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Buildings_8.0.0_Buildings.Fluid.Interfaces.Examples.HeaterCooler_u")
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 8.0.0/package.mo): time 2.613/2.613, allocations: 287.5 MB / 302.4 MB, free: 8.223 MB / 234.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo): time 0.001517/0.001517, allocations: 175.4 kB / 371 MB, free: 10.77 MB / 298.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 2.113/2.113, allocations: 205.4 MB / 0.6297 GB, free: 10.42 MB / 458.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo): time 0.001102/0.001102, allocations: 82.94 kB / 0.743 GB, free: 6.43 MB / 0.5573 GB
Notification: Performance of FrontEnd - loaded program: time 0.0004837/0.0004838, allocations: 16.47 kB / 0.8658 GB, free: 141.2 MB / 0.6198 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.208/0.2085, allocations: 115.3 MB / 0.9784 GB, free: 28.28 MB / 0.6198 GB
Notification: Performance of FrontEnd - scodeFlatten: time 1.294/1.503, allocations: 410.1 MB / 1.379 GB, free: 4.109 MB / 0.9011 GB
Notification: Performance of FrontEnd - mkProgramGraph: time 0.000363/1.503, allocations: 98.45 kB / 1.379 GB, free: 4.059 MB / 0.9011 GB
Notification: Performance of FrontEnd - DAE generated: time 15.69/17.19, allocations: 2.743 GB / 4.121 GB, free: 60.16 MB / 1.073 GB
Notification: Performance of FrontEnd: time 3.086e-06/17.19, allocations: 0 / 4.121 GB, free: 60.16 MB / 1.073 GB
Notification: Performance of Transformations before backend: time 0.00121/17.19, allocations: 169 kB / 4.122 GB, free: 60.14 MB / 1.073 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 1035
 * Number of variables: 1035
Notification: Performance of Generate backend data structure: time 0.03091/17.22, allocations: 7.149 MB / 4.129 GB, free: 57.02 MB / 1.073 GB
Notification: Performance of prepare preOptimizeDAE: time 4.917e-05/17.22, allocations: 9.281 kB / 4.129 GB, free: 57.02 MB / 1.073 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.005368/17.23, allocations: 0.7819 MB / 4.129 GB, free: 56.64 MB / 1.073 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.1922/17.42, allocations: 59.82 MB / 4.188 GB, free: 53.56 MB / 1.073 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0003897/17.42, allocations: 316.1 kB / 4.188 GB, free: 53.55 MB / 1.073 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.00152/17.42, allocations: 432.4 kB / 4.189 GB, free: 53.54 MB / 1.073 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.01338/17.43, allocations: 4.27 MB / 4.193 GB, free: 52.76 MB / 1.073 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0001882/17.44, allocations: 15.12 kB / 4.193 GB, free: 52.76 MB / 1.073 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0007185/17.44, allocations: 175.3 kB / 4.193 GB, free: 52.76 MB / 1.073 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001659/17.44, allocations: 118.2 kB / 4.193 GB, free: 52.76 MB / 1.073 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.009924/17.45, allocations: 2.902 MB / 4.196 GB, free: 52.73 MB / 1.073 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.04135/17.49, allocations: 24.07 MB / 4.219 GB, free: 38.5 MB / 1.073 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.00479/17.49, allocations: 2.952 MB / 4.222 GB, free: 37.31 MB / 1.073 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.003409/17.5, allocations: 3.937 MB / 4.226 GB, free: 32.9 MB / 1.073 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 8.568e-05/17.5, allocations: 64.81 kB / 4.226 GB, free: 32.86 MB / 1.073 GB
Notification: Performance of pre-optimization done (n=225): time 5.28e-06/17.5, allocations: 0 / 4.226 GB, free: 32.86 MB / 1.073 GB
Notification: Performance of matching and sorting (n=225): time 0.01566/17.51, allocations: 4.099 MB / 4.23 GB, free: 32.09 MB / 1.073 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 5.736e-05/17.51, allocations: 75.12 kB / 4.23 GB, free: 32.02 MB / 1.073 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.009499/17.52, allocations: 3.663 MB / 4.234 GB, free: 31.71 MB / 1.073 GB
Notification: Performance of collectPreVariables (initialization): time 0.000775/17.52, allocations: 82.53 kB / 4.234 GB, free: 31.68 MB / 1.073 GB
Notification: Performance of collectInitialEqns (initialization): time 0.002946/17.52, allocations: 2.785 MB / 4.237 GB, free: 30.8 MB / 1.073 GB
Notification: Performance of collectInitialBindings (initialization): time 0.001339/17.53, allocations: 0.7748 MB / 4.237 GB, free: 30.3 MB / 1.073 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0002439/17.53, allocations: 55.16 kB / 4.237 GB, free: 30.3 MB / 1.073 GB
Notification: Performance of setup shared object (initialization): time 0.0001744/17.53, allocations: 409.6 kB / 4.238 GB, free: 29.99 MB / 1.073 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.00216/17.53, allocations: 0.8051 MB / 4.239 GB, free: 29.98 MB / 1.073 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.003007/17.53, allocations: 1.801 MB / 4.24 GB, free: 28.82 MB / 1.073 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.002988/17.54, allocations: 1.104 MB / 4.241 GB, free: 28.79 MB / 1.073 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.776e-05/17.54, allocations: 7.812 kB / 4.241 GB, free: 28.79 MB / 1.073 GB
Notification: Performance of matching and sorting (n=341) (initialization): time 0.01049/17.55, allocations: 3.366 MB / 4.245 GB, free: 28.4 MB / 1.073 GB
Notification: Performance of prepare postOptimizeDAE: time 0.002825/17.55, allocations: 10.34 MB / 4.255 GB, free: 33.64 MB / 1.089 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 8.209e-05/17.55, allocations: 21.59 kB / 4.255 GB, free: 33.64 MB / 1.089 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001804/17.55, allocations: 404.8 kB / 4.255 GB, free: 33.61 MB / 1.089 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.003796/17.55, allocations: 0.5245 MB / 4.256 GB, free: 33.61 MB / 1.089 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.003166/17.56, allocations: 2.692 MB / 4.258 GB, free: 31.51 MB / 1.089 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.008792/17.57, allocations: 0.5623 MB / 4.259 GB, free: 31.37 MB / 1.089 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0007837/17.57, allocations: 132.5 kB / 4.259 GB, free: 31.37 MB / 1.089 GB
Notification: Performance of prepare postOptimizeDAE: time 1.681e-05/17.57, allocations: 6 kB / 4.259 GB, free: 31.37 MB / 1.089 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.008997/17.58, allocations: 2.809 MB / 4.262 GB, free: 31.27 MB / 1.089 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 4.652e-05/17.58, allocations: 23 kB / 4.262 GB, free: 31.27 MB / 1.089 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001706/17.58, allocations: 384.6 kB / 4.262 GB, free: 31.24 MB / 1.089 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.003736/17.58, allocations: 0.5207 MB / 4.263 GB, free: 31.24 MB / 1.089 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01323/17.6, allocations: 7.804 MB / 4.27 GB, free: 25.59 MB / 1.089 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.008445/17.6, allocations: 0.5205 MB / 4.271 GB, free: 25.48 MB / 1.089 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0007907/17.6, allocations: 129.7 kB / 4.271 GB, free: 25.48 MB / 1.089 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 97
 * Number of states: 0 ()
 * Number of discrete variables: 0 ()
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (299):
 * Single equations (assignments): 295
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 4
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 0
 * Non-linear torn systems: 4 {1 12,1 9,1 12,1 9}
Notification: Performance of prepare postOptimizeDAE: time 0.004144/17.61, allocations: 0.9925 MB / 4.272 GB, free: 25.28 MB / 1.089 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.002061/17.61, allocations: 0.5098 MB / 4.272 GB, free: 25.01 MB / 1.089 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01256/17.62, allocations: 3.789 MB / 4.276 GB, free: 24.71 MB / 1.089 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.0001048/17.62, allocations: 38.55 kB / 4.276 GB, free: 24.71 MB / 1.089 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 8.185e-06/17.62, allocations: 3.344 kB / 4.276 GB, free: 24.71 MB / 1.089 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.0077/17.63, allocations: 2.613 MB / 4.279 GB, free: 24.5 MB / 1.089 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 postOpt removeSimpleEquations (simulation): time 0.02562/17.66, allocations: 8.574 MB / 4.287 GB, free: 22.93 MB / 1.089 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.816e-05/17.66, allocations: 3.156 kB / 4.287 GB, free: 22.93 MB / 1.089 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.003101/17.66, allocations: 383.1 kB / 4.287 GB, free: 22.93 MB / 1.089 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.001373/17.66, allocations: 308.8 kB / 4.288 GB, free: 22.89 MB / 1.089 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0004152/17.66, allocations: 68 kB / 4.288 GB, free: 22.89 MB / 1.089 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.00235/17.66, allocations: 2.493 MB / 4.29 GB, free: 20.8 MB / 1.089 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 6.512e-06/17.66, allocations: 0.6875 kB / 4.29 GB, free: 20.8 MB / 1.089 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.013/17.68, allocations: 4.771 MB / 4.295 GB, free: 19.99 MB / 1.089 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.004715/17.68, allocations: 0.9915 MB / 4.296 GB, free: 19.59 MB / 1.089 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.001977/17.68, allocations: 53.83 kB / 4.296 GB, free: 19.58 MB / 1.089 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.007794/17.69, allocations: 441.4 kB / 4.296 GB, free: 19.55 MB / 1.089 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0006677/17.69, allocations: 153.8 kB / 4.296 GB, free: 19.55 MB / 1.089 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0004405/17.69, allocations: 114.5 kB / 4.297 GB, free: 19.55 MB / 1.089 GB
Notification: Performance of sorting global known variables: time 0.008229/17.7, allocations: 2.798 MB / 4.299 GB, free: 19.37 MB / 1.089 GB
Notification: Performance of sort global known variables: time 1.142e-06/17.7, allocations: 0 / 4.299 GB, free: 19.37 MB / 1.089 GB
Notification: Performance of remove unused functions: time 0.02108/17.72, allocations: 3.595 MB / 4.303 GB, free: 18.83 MB / 1.089 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 4
 * Number of states: 10 (hea1.vol.dynBal.U,hea2.vol.dynBal.U,hea3.vol.dynBal.U,hea4.vol.dynBal.U,mix1.dynBal.U,hea5.vol.dynBal.U,hea6.vol.dynBal.U,hea7.vol.dynBal.U,hea8.vol.dynBal.U,mix2.dynBal.U)
 * Number of discrete variables: 0 ()
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (227):
 * Single equations (assignments): 189
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 34
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 4
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 0
 * Non-linear torn systems: 4 {1 9,1 7,1 9,1 7}
Notification: Performance of Backend phase and start with SimCode phase: time 0.008606/17.73, allocations: 3.431 MB / 4.306 GB, free: 17.41 MB / 1.089 GB
Notification: Performance of simCode: created initialization part: time 0.01215/17.74, allocations: 4.438 MB / 4.31 GB, free: 16.83 MB / 1.089 GB
Notification: Performance of simCode: created event and clocks part: time 1.05e-05/17.74, allocations: 6.688 kB / 4.31 GB, free: 16.83 MB / 1.089 GB
Notification: Performance of simCode: created simulation system equations: time 0.003506/17.75, allocations: 1.324 MB / 4.312 GB, free: 16.79 MB / 1.089 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.02394/17.77, allocations: 2.737 MB / 4.314 GB, free: 16.65 MB / 1.089 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.02473/17.8, allocations: 11.16 MB / 4.325 GB, free: 11.06 MB / 1.089 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.004419/17.8, allocations: 2.989 MB / 4.328 GB, free: 10.19 MB / 1.089 GB
Notification: Performance of simCode: alias equations: time 0.008421/17.81, allocations: 1.206 MB / 4.329 GB, free: 9.934 MB / 1.089 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.00209/17.81, allocations: 424.4 kB / 4.33 GB, free: 9.918 MB / 1.089 GB
Notification: Performance of SimCode: time 1.253e-06/17.81, allocations: 0 / 4.33 GB, free: 9.918 MB / 1.089 GB
Notification: Performance of Templates: time 0.3603/18.17, allocations: 119.9 MB / 4.447 GB, free: 9.266 MB / 1.104 GB
make -j1 -f Buildings_8.0.0_Buildings.Fluid.Interfaces.Examples.HeaterCooler_u.makefile
(rm -f Buildings_8.0.0_Buildings.Fluid.Interfaces.Examples.HeaterCooler_u.pipe ; mkfifo Buildings_8.0.0_Buildings.Fluid.Interfaces.Examples.HeaterCooler_u.pipe ; head -c 1048576 < Buildings_8.0.0_Buildings.Fluid.Interfaces.Examples.HeaterCooler_u.pipe >> ../files/Buildings_8.0.0_Buildings.Fluid.Interfaces.Examples.HeaterCooler_u.sim & ./Buildings_8.0.0_Buildings.Fluid.Interfaces.Examples.HeaterCooler_u -abortSlowSimulation -alarm=480 -lv LOG_STATS > Buildings_8.0.0_Buildings.Fluid.Interfaces.Examples.HeaterCooler_u.pipe 2>&1)