Running: ./testmodel.py --libraries=/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr Buildings_8.0.0_Buildings.Fluid.Sensors.Examples.TraceSubstances.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.Sensors.Examples.TraceSubstances,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Buildings_8.0.0_Buildings.Fluid.Sensors.Examples.TraceSubstances")
translateModel(Buildings.Fluid.Sensors.Examples.TraceSubstances,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Buildings_8.0.0_Buildings.Fluid.Sensors.Examples.TraceSubstances")
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 8.0.0/package.mo): time 2.756/2.756, allocations: 287.5 MB / 302.4 MB, free: 8.336 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.002293/0.002293, allocations: 169.1 kB / 371 MB, free: 10.75 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.186/2.186, allocations: 205.4 MB / 0.6297 GB, free: 10.45 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.001114/0.001113, allocations: 97.38 kB / 0.743 GB, free: 6.441 MB / 0.5573 GB
Notification: Performance of FrontEnd - loaded program: time 0.0005937/0.0005939, allocations: 20.38 kB / 0.8658 GB, free: 141.4 MB / 0.6198 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.2321/0.2327, allocations: 115.2 MB / 0.9784 GB, free: 28.27 MB / 0.6198 GB
Notification: Performance of FrontEnd - scodeFlatten: time 7.128/7.36, allocations: 2.128 GB / 3.106 GB, free: 142.4 MB / 0.948 GB
Notification: Performance of FrontEnd - mkProgramGraph: time 0.00033/7.361, allocations: 98.2 kB / 3.106 GB, free: 142.3 MB / 0.948 GB
Notification: Performance of FrontEnd - DAE generated: time 3.651/11.01, allocations: 0.6566 GB / 3.763 GB, free: 202 MB / 0.948 GB
Notification: Performance of FrontEnd: time 2.244e-06/11.01, allocations: 0 / 3.763 GB, free: 202 MB / 0.948 GB
Notification: Performance of Transformations before backend: time 9.173e-05/11.01, allocations: 26.66 kB / 3.763 GB, free: 202 MB / 0.948 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 226
 * Number of variables: 226
Notification: Performance of Generate backend data structure: time 0.004371/11.02, allocations: 1.47 MB / 3.764 GB, free: 201.1 MB / 0.948 GB
Notification: Performance of prepare preOptimizeDAE: time 4.623e-05/11.02, allocations: 10.31 kB / 3.764 GB, free: 201.1 MB / 0.948 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.002172/11.02, allocations: 245.4 kB / 3.765 GB, free: 201.1 MB / 0.948 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.004144/11.02, allocations: 1.114 MB / 3.766 GB, free: 200.5 MB / 0.948 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 7.451e-05/11.02, allocations: 68.97 kB / 3.766 GB, free: 200.5 MB / 0.948 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0002218/11.02, allocations: 105.6 kB / 3.766 GB, free: 200.5 MB / 0.948 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.002521/11.03, allocations: 1.117 MB / 3.767 GB, free: 199.9 MB / 0.948 GB
Notification: Performance of preOpt findStateOrder (simulation): time 4.486e-05/11.03, allocations: 3.969 kB / 3.767 GB, free: 199.9 MB / 0.948 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.000127/11.03, allocations: 39.56 kB / 3.767 GB, free: 199.9 MB / 0.948 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 5.296e-05/11.03, allocations: 35.28 kB / 3.767 GB, free: 199.9 MB / 0.948 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.002063/11.03, allocations: 0.8428 MB / 3.768 GB, free: 199.6 MB / 0.948 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.007889/11.04, allocations: 5.692 MB / 3.773 GB, free: 195.1 MB / 0.948 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.001193/11.04, allocations: 0.5368 MB / 3.774 GB, free: 194.8 MB / 0.948 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0007276/11.04, allocations: 309.7 kB / 3.774 GB, free: 194.5 MB / 0.948 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.211e-05/11.04, allocations: 38.66 kB / 3.774 GB, free: 194.5 MB / 0.948 GB
Notification: Performance of pre-optimization done (n=49): time 3.567e-06/11.04, allocations: 0 / 3.774 GB, free: 194.5 MB / 0.948 GB
Notification: Performance of matching and sorting (n=49): time 0.002268/11.04, allocations: 0.7868 MB / 3.775 GB, free: 194.1 MB / 0.948 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 3.575e-05/11.04, allocations: 59.48 kB / 3.775 GB, free: 194 MB / 0.948 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001209/11.04, allocations: 0.6593 MB / 3.776 GB, free: 193.7 MB / 0.948 GB
Notification: Performance of collectPreVariables (initialization): time 0.0001088/11.04, allocations: 37.55 kB / 3.776 GB, free: 193.6 MB / 0.948 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0004003/11.04, allocations: 0.4987 MB / 3.776 GB, free: 193.2 MB / 0.948 GB
Notification: Performance of collectInitialBindings (initialization): time 0.000212/11.04, allocations: 178.5 kB / 3.776 GB, free: 193 MB / 0.948 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 6.199e-05/11.04, allocations: 12 kB / 3.776 GB, free: 193 MB / 0.948 GB
Notification: Performance of setup shared object (initialization): time 9.348e-05/11.04, allocations: 336.4 kB / 3.777 GB, free: 192.7 MB / 0.948 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0005698/11.04, allocations: 240.4 kB / 3.777 GB, free: 192.6 MB / 0.948 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0007996/11.04, allocations: 0.573 MB / 3.777 GB, free: 192 MB / 0.948 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.0007714/11.04, allocations: 357.7 kB / 3.778 GB, free: 191.8 MB / 0.948 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 8.055e-06/11.04, allocations: 0 / 3.778 GB, free: 191.8 MB / 0.948 GB
Notification: Performance of matching and sorting (n=86) (initialization): time 0.001999/11.05, allocations: 0.8376 MB / 3.779 GB, free: 191.4 MB / 0.948 GB
Notification: Performance of prepare postOptimizeDAE: time 2.71e-05/11.05, allocations: 7.812 kB / 3.779 GB, free: 191.4 MB / 0.948 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.532e-05/11.05, allocations: 6.688 kB / 3.779 GB, free: 191.4 MB / 0.948 GB
Notification: Performance of postOpt tearingSystem (initialization): time 3.506e-05/11.05, allocations: 19.52 kB / 3.779 GB, free: 191.4 MB / 0.948 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.00105/11.05, allocations: 152.6 kB / 3.779 GB, free: 191.4 MB / 0.948 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.432e-05/11.05, allocations: 22.94 kB / 3.779 GB, free: 191.4 MB / 0.948 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001619/11.05, allocations: 132.3 kB / 3.779 GB, free: 191.3 MB / 0.948 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 9.82e-05/11.05, allocations: 42.8 kB / 3.779 GB, free: 191.3 MB / 0.948 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 36
 * 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 (86):
 * Single equations (assignments): 86
 * 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: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of prepare postOptimizeDAE: time 0.0007838/11.05, allocations: 328.5 kB / 3.779 GB, free: 191.1 MB / 0.948 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0001973/11.05, allocations: 87.34 kB / 3.779 GB, free: 191 MB / 0.948 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.001455/11.05, allocations: 0.5999 MB / 3.78 GB, free: 190.7 MB / 0.948 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 7.775e-06/11.05, allocations: 3.656 kB / 3.78 GB, free: 190.7 MB / 0.948 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 7.735e-06/11.05, allocations: 7.859 kB / 3.78 GB, free: 190.7 MB / 0.948 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.00104/11.05, allocations: 0.511 MB / 3.78 GB, free: 190.4 MB / 0.948 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.003821/11.06, allocations: 1.654 MB / 3.782 GB, free: 189.3 MB / 0.948 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 8.837e-06/11.06, allocations: 7.844 kB / 3.782 GB, free: 189.2 MB / 0.948 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.00101/11.06, allocations: 110.5 kB / 3.782 GB, free: 189.2 MB / 0.948 GB
Notification: Performance of postOpt tearingSystem (simulation): time 1.211e-05/11.06, allocations: 3.906 kB / 3.782 GB, free: 189.2 MB / 0.948 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 5.58e-05/11.06, allocations: 15.34 kB / 3.782 GB, free: 189.2 MB / 0.948 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 9.087e-06/11.06, allocations: 7.656 kB / 3.782 GB, free: 189.2 MB / 0.948 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 3.707e-06/11.06, allocations: 0 / 3.782 GB, free: 189.2 MB / 0.948 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.002146/11.06, allocations: 1.119 MB / 3.783 GB, free: 188.4 MB / 0.948 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0006448/11.06, allocations: 225 kB / 3.784 GB, free: 188.3 MB / 0.948 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001755/11.06, allocations: 20.98 kB / 3.784 GB, free: 188.2 MB / 0.948 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.00107/11.06, allocations: 55.7 kB / 3.784 GB, free: 188.2 MB / 0.948 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 9.477e-05/11.06, allocations: 33.02 kB / 3.784 GB, free: 188.2 MB / 0.948 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 5.458e-05/11.06, allocations: 27 kB / 3.784 GB, free: 188.2 MB / 0.948 GB
Notification: Performance of sorting global known variables: time 0.0009594/11.06, allocations: 0.5015 MB / 3.784 GB, free: 187.9 MB / 0.948 GB
Notification: Performance of sort global known variables: time 6.21e-07/11.06, allocations: 3.125 kB / 3.784 GB, free: 187.9 MB / 0.948 GB
Notification: Performance of remove unused functions: time 0.002248/11.07, allocations: 486.6 kB / 3.785 GB, free: 187.7 MB / 0.948 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 8
 * Number of states: 4 (vol.dynBal.U,vol.dynBal.m,vol.dynBal.mXi[1],vol.dynBal.mC[1])
 * 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 (49):
 * Single equations (assignments): 49
 * 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: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of Backend phase and start with SimCode phase: time 0.003529/11.07, allocations: 1.9 MB / 3.786 GB, free: 186.9 MB / 0.948 GB
Notification: Performance of simCode: created initialization part: time 0.001654/11.07, allocations: 0.5915 MB / 3.787 GB, free: 186.7 MB / 0.948 GB
Notification: Performance of simCode: created event and clocks part: time 6.693e-06/11.07, allocations: 3.844 kB / 3.787 GB, free: 186.7 MB / 0.948 GB
Notification: Performance of simCode: created simulation system equations: time 0.0005494/11.07, allocations: 270 kB / 3.787 GB, free: 186.5 MB / 0.948 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.00383/11.08, allocations: 428.3 kB / 3.788 GB, free: 186.4 MB / 0.948 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.004797/11.08, allocations: 2.334 MB / 3.79 GB, free: 184.9 MB / 0.948 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0007764/11.08, allocations: 1.146 MB / 3.791 GB, free: 183.9 MB / 0.948 GB
Notification: Performance of simCode: alias equations: time 0.001562/11.08, allocations: 264.4 kB / 3.791 GB, free: 183.8 MB / 0.948 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0003134/11.08, allocations: 73.39 kB / 3.791 GB, free: 183.8 MB / 0.948 GB
Notification: Performance of SimCode: time 1.102e-06/11.08, allocations: 0 / 3.791 GB, free: 183.8 MB / 0.948 GB
Notification: Performance of Templates: time 0.09555/11.18, allocations: 36.62 MB / 3.827 GB, free: 148.9 MB / 0.948 GB
make -j1 -f Buildings_8.0.0_Buildings.Fluid.Sensors.Examples.TraceSubstances.makefile
(rm -f Buildings_8.0.0_Buildings.Fluid.Sensors.Examples.TraceSubstances.pipe ; mkfifo Buildings_8.0.0_Buildings.Fluid.Sensors.Examples.TraceSubstances.pipe ; head -c 1048576 < Buildings_8.0.0_Buildings.Fluid.Sensors.Examples.TraceSubstances.pipe >> ../files/Buildings_8.0.0_Buildings.Fluid.Sensors.Examples.TraceSubstances.sim & ./Buildings_8.0.0_Buildings.Fluid.Sensors.Examples.TraceSubstances -abortSlowSimulation -alarm=480 -lv LOG_STATS > Buildings_8.0.0_Buildings.Fluid.Sensors.Examples.TraceSubstances.pipe 2>&1)