Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr Buildings_8_Buildings.Fluid.Sources.Examples.TraceSubstancesFlowSource.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 8.1.1-maint.8.1.x/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo", uses=false)
Using package ModelicaServices with version 3.2.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo)
Using package Modelica with version 3.2.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo)
Using package Complex with version 3.2.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo)
Using package Buildings with version 8.1.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 8.1.1-maint.8.1.x/package.mo)
Running command: translateModel(Buildings.Fluid.Sources.Examples.TraceSubstancesFlowSource,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Buildings_8_Buildings.Fluid.Sources.Examples.TraceSubstancesFlowSource")
translateModel(Buildings.Fluid.Sources.Examples.TraceSubstancesFlowSource,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Buildings_8_Buildings.Fluid.Sources.Examples.TraceSubstancesFlowSource")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 8.1.1-maint.8.1.x/package.mo): time 1.727/1.727, allocations: 293 MB / 309 MB, free: 4.785 MB / 234.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo): time 0.001033/0.001033, allocations: 168.6 kB / 378.7 MB, free: 1.02 MB / 298.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 1.906/1.906, allocations: 205.4 MB / 0.6383 GB, free: 9.156 MB / 474.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo): time 0.000847/0.0008471, allocations: 88.83 kB / 0.7527 GB, free: 62.41 MB / 0.5573 GB
Notification: Performance of FrontEnd - loaded program: time 0.0004549/0.0004549, allocations: 16 kB / 0.8768 GB, free: 10.57 MB / 0.6042 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.2856/0.2861, allocations: 116.4 MB / 0.9904 GB, free: 6.016 MB / 0.7136 GB
Notification: Performance of FrontEnd - scodeFlatten: time 5.416/5.702, allocations: 2.136 GB / 3.127 GB, free: 78.86 MB / 0.948 GB
Notification: Performance of FrontEnd - mkProgramGraph: time 0.0002608/5.702, allocations: 97.06 kB / 3.127 GB, free: 78.77 MB / 0.948 GB
Notification: Performance of FrontEnd - DAE generated: time 8.205/13.91, allocations: 2.033 GB / 5.16 GB, free: 98.34 MB / 1.026 GB
Notification: Performance of FrontEnd: time 3.647e-06/13.91, allocations: 0 / 5.16 GB, free: 98.34 MB / 1.026 GB
Notification: Performance of Transformations before backend: time 0.0008858/13.91, allocations: 98.36 kB / 5.16 GB, free: 98.34 MB / 1.026 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 693
 * Number of variables: 693
Notification: Performance of Generate backend data structure: time 0.01864/13.93, allocations: 3.916 MB / 5.164 GB, free: 96.95 MB / 1.026 GB
Notification: Performance of prepare preOptimizeDAE: time 5.56e-05/13.93, allocations: 9.844 kB / 5.164 GB, free: 96.95 MB / 1.026 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.008445/13.94, allocations: 0.9211 MB / 5.165 GB, free: 96.75 MB / 1.026 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.01196/13.95, allocations: 2.859 MB / 5.168 GB, free: 96.23 MB / 1.026 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0004649/13.95, allocations: 280.2 kB / 5.168 GB, free: 96.16 MB / 1.026 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.001791/13.95, allocations: 296.3 kB / 5.168 GB, free: 96.16 MB / 1.026 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.01386/13.96, allocations: 3.236 MB / 5.172 GB, free: 95.89 MB / 1.026 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0002386/13.96, allocations: 5.672 kB / 5.172 GB, free: 95.89 MB / 1.026 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.001197/13.96, allocations: 112 kB / 5.172 GB, free: 95.89 MB / 1.026 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.000257/13.97, allocations: 107.5 kB / 5.172 GB, free: 95.88 MB / 1.026 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.008676/13.97, allocations: 2.645 MB / 5.174 GB, free: 95.85 MB / 1.026 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.02726/14, allocations: 13.23 MB / 5.187 GB, free: 88.68 MB / 1.026 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.003625/14, allocations: 1.802 MB / 5.189 GB, free: 88.65 MB / 1.026 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.00211/14.01, allocations: 1.096 MB / 5.19 GB, free: 88.64 MB / 1.026 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0005712/14.01, allocations: 334.9 kB / 5.19 GB, free: 88.36 MB / 1.026 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 7.788e-05/14.01, allocations: 62.06 kB / 5.191 GB, free: 88.31 MB / 1.026 GB
Notification: Performance of pre-optimization done (n=186): time 5.781e-06/14.01, allocations: 0 / 5.191 GB, free: 88.31 MB / 1.026 GB
Notification: Performance of matching and sorting (n=186): time 0.006555/14.01, allocations: 2.727 MB / 5.193 GB, free: 88.09 MB / 1.026 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 6.733e-05/14.01, allocations: 73.66 kB / 5.193 GB, free: 88.03 MB / 1.026 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.003629/14.02, allocations: 1.96 MB / 5.195 GB, free: 87.8 MB / 1.026 GB
Notification: Performance of collectPreVariables (initialization): time 0.0003597/14.02, allocations: 73.3 kB / 5.195 GB, free: 87.77 MB / 1.026 GB
Notification: Performance of collectInitialEqns (initialization): time 0.001007/14.02, allocations: 1.398 MB / 5.197 GB, free: 87.24 MB / 1.026 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0007197/14.02, allocations: 0.6532 MB / 5.197 GB, free: 86.82 MB / 1.026 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0001027/14.02, allocations: 40.91 kB / 5.197 GB, free: 86.82 MB / 1.026 GB
Notification: Performance of setup shared object (initialization): time 0.0001385/14.02, allocations: 392.6 kB / 5.198 GB, free: 86.51 MB / 1.026 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001201/14.02, allocations: 0.7926 MB / 5.198 GB, free: 86.5 MB / 1.026 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001764/14.02, allocations: 1.471 MB / 5.2 GB, free: 85.75 MB / 1.026 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.00329/14.03, allocations: 2.222 MB / 5.202 GB, free: 85.27 MB / 1.026 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.07e-05/14.03, allocations: 3.5 kB / 5.202 GB, free: 85.27 MB / 1.026 GB
Notification: Performance of matching and sorting (n=261) (initialization): time 0.004213/14.03, allocations: 2.478 MB / 5.204 GB, free: 85.05 MB / 1.026 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0002658/14.03, allocations: 470.8 kB / 5.205 GB, free: 84.52 MB / 1.026 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.922e-05/14.03, allocations: 11.78 kB / 5.205 GB, free: 84.52 MB / 1.026 GB
Notification: Performance of postOpt tearingSystem (initialization): time 4.179e-05/14.03, allocations: 21.75 kB / 5.205 GB, free: 84.52 MB / 1.026 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002384/14.03, allocations: 0.5737 MB / 5.206 GB, free: 84.52 MB / 1.026 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.001453/14.04, allocations: 4.159 MB / 5.21 GB, free: 80.43 MB / 1.026 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.004328/14.04, allocations: 382.3 kB / 5.21 GB, free: 80.32 MB / 1.026 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001997/14.04, allocations: 93.61 kB / 5.21 GB, free: 80.32 MB / 1.026 GB
Notification: Performance of prepare postOptimizeDAE: time 1.049e-05/14.04, allocations: 3.625 kB / 5.21 GB, free: 80.32 MB / 1.026 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.003212/14.04, allocations: 2.209 MB / 5.212 GB, free: 80.27 MB / 1.026 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.708e-05/14.04, allocations: 17.36 kB / 5.212 GB, free: 80.27 MB / 1.026 GB
Notification: Performance of postOpt tearingSystem (initialization): time 2.128e-05/14.04, allocations: 22.31 kB / 5.212 GB, free: 80.27 MB / 1.026 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001599/14.04, allocations: 480.6 kB / 5.213 GB, free: 80.27 MB / 1.026 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 3.936e-05/14.04, allocations: 28.5 kB / 5.213 GB, free: 80.27 MB / 1.026 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.003927/14.05, allocations: 361.2 kB / 5.213 GB, free: 80.18 MB / 1.026 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.000217/14.05, allocations: 90.95 kB / 5.213 GB, free: 80.18 MB / 1.026 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 56
 * 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 (261):
 * Single equations (assignments): 254
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 7
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Equation system details:
 * Constant Jacobian: 0
 * Linear Jacobian (size,density): 0
 * Non-linear Jacobian: 7 {1,1,1,1,1,1,1}
 * Without analytic Jacobian: 0
Notification: Performance of prepare postOptimizeDAE: time 0.002384/14.05, allocations: 0.8615 MB / 5.214 GB, free: 79.99 MB / 1.026 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.001149/14.05, allocations: 270.3 kB / 5.214 GB, free: 79.85 MB / 1.026 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.005293/14.06, allocations: 2.128 MB / 5.216 GB, free: 79.73 MB / 1.026 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.94e-05/14.06, allocations: 19.44 kB / 5.216 GB, free: 79.73 MB / 1.026 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.446e-05/14.06, allocations: 0 / 5.216 GB, free: 79.73 MB / 1.026 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.002958/14.06, allocations: 1.891 MB / 5.218 GB, free: 79.43 MB / 1.026 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.01359/14.07, allocations: 5.175 MB / 5.223 GB, free: 78.89 MB / 1.026 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.495e-05/14.07, allocations: 3.594 kB / 5.223 GB, free: 78.89 MB / 1.026 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.002386/14.08, allocations: 0.518 MB / 5.224 GB, free: 78.89 MB / 1.026 GB
Notification: Performance of postOpt tearingSystem (simulation): time 4.278e-05/14.08, allocations: 7.656 kB / 5.224 GB, free: 78.89 MB / 1.026 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0001923/14.08, allocations: 58.02 kB / 5.224 GB, free: 78.89 MB / 1.026 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.001609/14.08, allocations: 4.118 MB / 5.228 GB, free: 74.8 MB / 1.026 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 8.286e-06/14.08, allocations: 7.156 kB / 5.228 GB, free: 74.8 MB / 1.026 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.005946/14.08, allocations: 3.384 MB / 5.231 GB, free: 74.33 MB / 1.026 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.002762/14.09, allocations: 0.5754 MB / 5.232 GB, free: 74.08 MB / 1.026 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.001142/14.09, allocations: 45.98 kB / 5.232 GB, free: 74.08 MB / 1.026 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.003751/14.09, allocations: 248.8 kB / 5.232 GB, free: 74.06 MB / 1.026 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0003339/14.09, allocations: 118.9 kB / 5.232 GB, free: 74.05 MB / 1.026 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0002466/14.09, allocations: 75.25 kB / 5.232 GB, free: 74.05 MB / 1.026 GB
Notification: Performance of sorting global known variables: time 0.003369/14.1, allocations: 1.298 MB / 5.233 GB, free: 73.91 MB / 1.026 GB
Notification: Performance of sort global known variables: time 1.9e-07/14.1, allocations: 6.562 kB / 5.233 GB, free: 73.91 MB / 1.026 GB
Notification: Performance of remove unused functions: time 0.009457/14.11, allocations: 2.148 MB / 5.236 GB, free: 73.66 MB / 1.026 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 13
 * Number of states: 20 (vol.dynBal.U,vol.dynBal.m,vol.dynBal.mXi[1],vol.dynBal.mC[1],vol1.dynBal.U,vol1.dynBal.m,vol1.dynBal.mXi[1],vol1.dynBal.mC[1],vol2.dynBal.U,vol2.dynBal.m,vol2.dynBal.mXi[1],vol2.dynBal.mC[1],vol3.dynBal.U,vol3.dynBal.m,vol3.dynBal.mXi[1],vol3.dynBal.mC[1],vol4.dynBal.U,vol4.dynBal.m,vol4.dynBal.mXi[1],vol4.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 (186):
 * Single equations (assignments): 179
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 7
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Equation system details:
 * Constant Jacobian: 0
 * Linear Jacobian (size,density): 0
 * Non-linear Jacobian: 7 {1,1,1,1,1,1,1}
 * Without analytic Jacobian: 0
Notification: Performance of Backend phase and start with SimCode phase: time 0.008636/14.11, allocations: 4.774 MB / 5.24 GB, free: 71.38 MB / 1.026 GB
Notification: Performance of simCode: created initialization part: time 0.007706/14.12, allocations: 3.305 MB / 5.243 GB, free: 71.33 MB / 1.026 GB
Notification: Performance of simCode: created event and clocks part: time 1.897e-05/14.12, allocations: 7.469 kB / 5.243 GB, free: 71.33 MB / 1.026 GB
Notification: Performance of simCode: created simulation system equations: time 0.002116/14.12, allocations: 1.034 MB / 5.244 GB, free: 71.32 MB / 1.026 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.01175/14.14, allocations: 1.594 MB / 5.246 GB, free: 71.27 MB / 1.026 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.01476/14.15, allocations: 7.868 MB / 5.254 GB, free: 68.22 MB / 1.026 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.003157/14.15, allocations: 2.185 MB / 5.256 GB, free: 67.46 MB / 1.026 GB
Notification: Performance of simCode: alias equations: time 0.005765/14.16, allocations: 1.108 MB / 5.257 GB, free: 67.44 MB / 1.026 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.001297/14.16, allocations: 236.5 kB / 5.257 GB, free: 67.43 MB / 1.026 GB
Notification: Performance of SimCode: time 1.633e-06/14.16, allocations: 0 / 5.257 GB, free: 67.43 MB / 1.026 GB
Notification: Performance of Templates: time 0.1599/14.32, allocations: 100.1 MB / 5.355 GB, free: 61.48 MB / 1.026 GB
make -j1 -f Buildings_8_Buildings.Fluid.Sources.Examples.TraceSubstancesFlowSource.makefile
(rm -f Buildings_8_Buildings.Fluid.Sources.Examples.TraceSubstancesFlowSource.pipe ; mkfifo Buildings_8_Buildings.Fluid.Sources.Examples.TraceSubstancesFlowSource.pipe ; head -c 1048576 < Buildings_8_Buildings.Fluid.Sources.Examples.TraceSubstancesFlowSource.pipe >> ../files/Buildings_8_Buildings.Fluid.Sources.Examples.TraceSubstancesFlowSource.sim & ./Buildings_8_Buildings.Fluid.Sources.Examples.TraceSubstancesFlowSource -abortSlowSimulation -alarm=480 -lv LOG_STATS > Buildings_8_Buildings.Fluid.Sources.Examples.TraceSubstancesFlowSource.pipe 2>&1)