Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipesWithTraceSubstances.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest trunk/package.mo", uses=false)
Using package ModelicaTest with version trunk (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest trunk/package.mo)
Using package Modelica with version trunk (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo)
Using package Complex with version trunk (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo)
Using package ModelicaServices with version trunk (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo)
Running command: translateModel(ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipesWithTraceSubstances,tolerance=1e-05,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|junction1.mC_scaled.1.|junction1.mC_scaled.2.|junction1.medium.T|junction1.medium.p|junction2.mC_scaled.1.|junction2.mC_scaled.2.|junction2.medium.T|junction2.medium.p|pipe1.mediums.1..T|pipe1.mediums.1..p|pipe1.mediums.2..T|pipe1.mediums.2..p|pipe1.mediums.3..T|pipe1.mediums.3..p|pipe1.mediums.4..T|pipe1.mediums.4..p|pipe1.mediums.5..T|pipe1.mediums.5..p|pipe2.mediums.1..T|pipe2.mediums.1..p|pipe2.mediums.2..T|pipe2.mediums.2..p|pipe2.mediums.3..T|pipe2.mediums.3..p|pipe2.mediums.4..T|pipe2.mediums.4..p|pipe2.mediums.5..T|pipe2.mediums.5..p|pipe3.mediums.1..T|pipe3.mediums.1..p|pipe3.mediums.2..T|pipe3.mediums.2..p|pipe3.mediums.3..T|pipe3.mediums.3..p|pipe3.mediums.4..T|pipe3.mediums.4..p|pipe3.mediums.5..T|pipe3.mediums.5..p|pipe4.mediums.1..T|pipe4.mediums.1..p|pipe4.mediums.2..T|pipe4.mediums.2..p|pipe4.mediums.3..T|pipe4.mediums.3..p|pipe4.mediums.4..T|pipe4.mediums.4..p|pipe4.mediums.5..T|pipe4.mediums.5..p|pipe5.mediums.1..T|pipe5.mediums.1..p|pipe5.mediums.2..T|pipe5.mediums.2..p|pipe5.mediums.3..T|pipe5.mediums.3..p|pipe5.mediums.4..T|pipe5.mediums.4..p|pipe5.mediums.5..T|pipe5.mediums.5..p|pipe6.mediums.1..T|pipe6.mediums.1..p|pipe6.mediums.2..T|pipe6.mediums.2..p|pipe6.mediums.3..T|pipe6.mediums.3..p|pipe6.mediums.4..T|pipe6.mediums.4..p|pipe6.mediums.5..T|pipe6.mediums.5..p|pipe7.mediums.1..T|pipe7.mediums.1..p|pipe7.mediums.2..T|pipe7.mediums.2..p|pipe7.mediums.3..T|pipe7.mediums.3..p|pipe7.mediums.4..T|pipe7.mediums.4..p|pipe7.mediums.5..T|pipe7.mediums.5..p|pipe8.mediums.1..T|pipe8.mediums.1..p|pipe8.mediums.2..T|pipe8.mediums.2..p|pipe8.mediums.3..T|pipe8.mediums.3..p|pipe8.mediums.4..T|pipe8.mediums.4..p|pipe8.mediums.5..T|pipe8.mediums.5..p",fileNamePrefix="ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipesWithTraceSubstances")
translateModel(ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipesWithTraceSubstances,tolerance=1e-05,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|junction1.mC_scaled.1.|junction1.mC_scaled.2.|junction1.medium.T|junction1.medium.p|junction2.mC_scaled.1.|junction2.mC_scaled.2.|junction2.medium.T|junction2.medium.p|pipe1.mediums.1..T|pipe1.mediums.1..p|pipe1.mediums.2..T|pipe1.mediums.2..p|pipe1.mediums.3..T|pipe1.mediums.3..p|pipe1.mediums.4..T|pipe1.mediums.4..p|pipe1.mediums.5..T|pipe1.mediums.5..p|pipe2.mediums.1..T|pipe2.mediums.1..p|pipe2.mediums.2..T|pipe2.mediums.2..p|pipe2.mediums.3..T|pipe2.mediums.3..p|pipe2.mediums.4..T|pipe2.mediums.4..p|pipe2.mediums.5..T|pipe2.mediums.5..p|pipe3.mediums.1..T|pipe3.mediums.1..p|pipe3.mediums.2..T|pipe3.mediums.2..p|pipe3.mediums.3..T|pipe3.mediums.3..p|pipe3.mediums.4..T|pipe3.mediums.4..p|pipe3.mediums.5..T|pipe3.mediums.5..p|pipe4.mediums.1..T|pipe4.mediums.1..p|pipe4.mediums.2..T|pipe4.mediums.2..p|pipe4.mediums.3..T|pipe4.mediums.3..p|pipe4.mediums.4..T|pipe4.mediums.4..p|pipe4.mediums.5..T|pipe4.mediums.5..p|pipe5.mediums.1..T|pipe5.mediums.1..p|pipe5.mediums.2..T|pipe5.mediums.2..p|pipe5.mediums.3..T|pipe5.mediums.3..p|pipe5.mediums.4..T|pipe5.mediums.4..p|pipe5.mediums.5..T|pipe5.mediums.5..p|pipe6.mediums.1..T|pipe6.mediums.1..p|pipe6.mediums.2..T|pipe6.mediums.2..p|pipe6.mediums.3..T|pipe6.mediums.3..p|pipe6.mediums.4..T|pipe6.mediums.4..p|pipe6.mediums.5..T|pipe6.mediums.5..p|pipe7.mediums.1..T|pipe7.mediums.1..p|pipe7.mediums.2..T|pipe7.mediums.2..p|pipe7.mediums.3..T|pipe7.mediums.3..p|pipe7.mediums.4..T|pipe7.mediums.4..p|pipe7.mediums.5..T|pipe7.mediums.5..p|pipe8.mediums.1..T|pipe8.mediums.1..p|pipe8.mediums.2..T|pipe8.mediums.2..p|pipe8.mediums.3..T|pipe8.mediums.3..p|pipe8.mediums.4..T|pipe8.mediums.4..p|pipe8.mediums.5..T|pipe8.mediums.5..p",fileNamePrefix="ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipesWithTraceSubstances")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo): time 0.001283/0.001283, allocations: 109.6 kB / 18.3 MB, free: 4.836 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo): time 0.001471/0.001471, allocations: 216 kB / 19.25 MB, free: 3.891 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo): time 1.3/1.3, allocations: 227.4 MB / 247.4 MB, free: 10.59 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest trunk/package.mo): time 0.2046/0.2046, allocations: 46.09 MB / 344.8 MB, free: 11.6 MB / 286.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.001425/0.001426, allocations: 76.84 kB / 418.3 MB, free: 19.74 MB / 302.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1224/0.1239, allocations: 62.45 MB / 480.7 MB, free: 5.277 MB / 350.1 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipesWithTraceSubstances): time 0.8554/0.9793, allocations: 353.3 MB / 0.8144 GB, free: 15.64 MB / 0.545 GB
Notification: Performance of NFInst.instExpressions: time 0.05421/1.034, allocations: 35.02 MB / 0.8486 GB, free: 296 kB / 0.545 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.00623/1.04, allocations: 193.3 kB / 0.8488 GB, free: 180 kB / 0.545 GB
Notification: Performance of NFTyping.typeComponents: time 0.006625/1.047, allocations: 1.976 MB / 0.8507 GB, free: 14.93 MB / 0.5606 GB
Notification: Performance of NFTyping.typeBindings: time 0.02623/1.073, allocations: 8.804 MB / 0.8593 GB, free: 9.059 MB / 0.5606 GB
Notification: Performance of NFTyping.typeClassSections: time 0.03558/1.108, allocations: 13.26 MB / 0.8723 GB, free: 12.51 MB / 0.5763 GB
Notification: Performance of NFFlatten.flatten: time 0.02846/1.137, allocations: 25.48 MB / 0.8972 GB, free: 2.961 MB / 0.5919 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.01294/1.15, allocations: 7.074 MB / 0.9041 GB, free: 11.83 MB / 0.6075 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.02432/1.174, allocations: 11.21 MB / 0.915 GB, free: 0.5859 MB / 0.6075 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.0167/1.191, allocations: 10.52 MB / 0.9253 GB, free: 6.035 MB / 0.6231 GB
Notification: Performance of NFPackage.collectConstants: time 0.005339/1.196, allocations: 1.258 MB / 0.9265 GB, free: 4.777 MB / 0.6231 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.01898/1.215, allocations: 7.193 MB / 0.9336 GB, free: 13.57 MB / 0.6388 GB
Notification: Performance of NFScalarize.scalarize: time 0.01073/1.226, allocations: 7.101 MB / 0.9405 GB, free: 6.457 MB / 0.6388 GB
Notification: Performance of NFVerifyModel.verify: time 0.01696/1.243, allocations: 8.137 MB / 0.9484 GB, free: 14.28 MB / 0.6544 GB
Notification: Performance of NFConvertDAE.convert: time 0.6827/1.926, allocations: 24.65 MB / 0.9725 GB, free: 49.21 MB / 0.6544 GB
Notification: Performance of FrontEnd - DAE generated: time 6.312e-06/1.926, allocations: 0 / 0.9725 GB, free: 49.21 MB / 0.6544 GB
Notification: Performance of FrontEnd: time 1.893e-06/1.926, allocations: 1.156 kB / 0.9725 GB, free: 49.21 MB / 0.6544 GB
Notification: Performance of Transformations before backend: time 0.0007918/1.927, allocations: 3.688 kB / 0.9725 GB, free: 49.21 MB / 0.6544 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 3585
 * Number of variables: 3585
Notification: Performance of Generate backend data structure: time 0.07914/2.006, allocations: 19 MB / 0.9911 GB, free: 44.2 MB / 0.6544 GB
Notification: Performance of prepare preOptimizeDAE: time 4.502e-05/2.006, allocations: 10.53 kB / 0.9911 GB, free: 44.2 MB / 0.6544 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01958/2.026, allocations: 2.18 MB / 0.9932 GB, free: 43.46 MB / 0.6544 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.02259/2.048, allocations: 7.04 MB / 1 GB, free: 42.18 MB / 0.6544 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.001516/2.05, allocations: 0.8759 MB / 1.001 GB, free: 42.16 MB / 0.6544 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.008514/2.058, allocations: 1.143 MB / 1.002 GB, free: 42.12 MB / 0.6544 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.06854/2.127, allocations: 22.83 MB / 1.024 GB, free: 40.5 MB / 0.6544 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0008588/2.128, allocations: 41.5 kB / 1.024 GB, free: 40.49 MB / 0.6544 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.00923/2.137, allocations: 457.9 kB / 1.025 GB, free: 40.49 MB / 0.6544 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.00218/2.139, allocations: 1.864 MB / 1.027 GB, free: 40.46 MB / 0.6544 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.05192/2.191, allocations: 22.77 MB / 1.049 GB, free: 39.04 MB / 0.6544 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.1594/2.351, allocations: 85.04 MB / 1.132 GB, free: 2.172 MB / 0.7013 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.0377/2.388, allocations: 21.64 MB / 1.153 GB, free: 12.07 MB / 0.7326 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.02306/2.411, allocations: 10.86 MB / 1.164 GB, free: 1.184 MB / 0.7326 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.002482/2.414, allocations: 1.065 MB / 1.165 GB, free: 12 kB / 0.7326 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0003121/2.414, allocations: 209.3 kB / 1.165 GB, free: 15.8 MB / 0.7482 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.009531/2.424, allocations: 1.384 MB / 1.166 GB, free: 14.41 MB / 0.7482 GB
Notification: Performance of pre-optimization done (n=1487): time 4.554e-05/2.424, allocations: 0 / 1.166 GB, free: 14.41 MB / 0.7482 GB
Warning: Some equations could not be differentiated for following variables having attribute stateSelect=StateSelect.prefer. They will be treated as if they had stateSelect=StateSelect.default
========================================
1: pipe2.mediums[3].T
2: pipe2.mediums[1].T
3: pipe2.mediums[5].T
4: pipe2.mediums[2].T
5: pipe2.mediums[4].T
6: pipe3.mediums[1].T
7: pipe3.mediums[3].T
8: pipe3.mediums[4].T
9: pipe3.mediums[2].T
10: pipe3.mediums[5].T
11: pipe1.mediums[2].T
12: pipe1.mediums[1].T
13: pipe1.mediums[3].T
14: pipe1.mediums[4].T
15: pipe1.mediums[5].T
16: pipe4.mediums[2].T
17: pipe4.mediums[4].T
18: pipe4.mediums[1].T
19: pipe4.mediums[3].T
20: pipe4.mediums[5].T
21: junction1.medium.T
22: junction2.medium.T
Please use -d=bltdump for more information.
Notification: Performance of matching and sorting (n=1737): time 0.7429/3.167, allocations: 137.7 MB / 1.301 GB, free: 426.7 MB / 0.8263 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001642/3.167, allocations: 355.7 kB / 1.301 GB, free: 426.5 MB / 0.8263 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.01309/3.18, allocations: 8.246 MB / 1.309 GB, free: 423.7 MB / 0.8263 GB
Notification: Performance of collectPreVariables (initialization): time 0.00597/3.186, allocations: 349 kB / 1.309 GB, free: 423.4 MB / 0.8263 GB
Notification: Performance of collectInitialEqns (initialization): time 0.004003/3.19, allocations: 4.955 MB / 1.314 GB, free: 419.6 MB / 0.8263 GB
Notification: Performance of collectInitialBindings (initialization): time 0.01299/3.203, allocations: 6.117 MB / 1.32 GB, free: 414.9 MB / 0.8263 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.02088/3.224, allocations: 3.916 MB / 1.324 GB, free: 413.4 MB / 0.8263 GB
Notification: Performance of setup shared object (initialization): time 5.198e-05/3.224, allocations: 301.1 kB / 1.324 GB, free: 413.1 MB / 0.8263 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.02234/3.247, allocations: 10.88 MB / 1.335 GB, free: 409.6 MB / 0.8263 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0265/3.273, allocations: 14.64 MB / 1.349 GB, free: 399.1 MB / 0.8263 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.04895/3.322, allocations: 26.64 MB / 1.375 GB, free: 374 MB / 0.8263 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0001732/3.322, allocations: 28 kB / 1.375 GB, free: 374 MB / 0.8263 GB
Notification: Performance of matching and sorting (n=2465) (initialization): time 0.07855/3.401, allocations: 30.04 MB / 1.405 GB, free: 344.4 MB / 0.8263 GB
Notification: Performance of prepare postOptimizeDAE: time 0.000212/3.401, allocations: 162.8 kB / 1.405 GB, free: 344.3 MB / 0.8263 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001908/3.401, allocations: 103.2 kB / 1.405 GB, free: 344.2 MB / 0.8263 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.005489/3.407, allocations: 2.52 MB / 1.407 GB, free: 341.5 MB / 0.8263 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.03045/3.437, allocations: 4.996 MB / 1.412 GB, free: 336.5 MB / 0.8263 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.02902/3.466, allocations: 40.58 MB / 1.452 GB, free: 293.5 MB / 0.8263 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.02528/3.492, allocations: 0.8508 MB / 1.453 GB, free: 292.7 MB / 0.8263 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.008152/3.5, allocations: 1.293 MB / 1.454 GB, free: 291.4 MB / 0.8263 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.03289/3.533, allocations: 13.53 MB / 1.467 GB, free: 277.8 MB / 0.8263 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.02527/3.558, allocations: 14.01 MB / 1.481 GB, free: 262.4 MB / 0.8263 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.04294/3.601, allocations: 25.35 MB / 1.506 GB, free: 235.6 MB / 0.8263 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 0.0001519/3.601, allocations: 28 kB / 1.506 GB, free: 235.6 MB / 0.8263 GB
Notification: Performance of matching and sorting (n=2465) (initialization_lambda0): time 0.07424/3.676, allocations: 28.57 MB / 1.534 GB, free: 206.8 MB / 0.8263 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0002396/3.676, allocations: 162.8 kB / 1.534 GB, free: 206.6 MB / 0.8263 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0002229/3.676, allocations: 100 kB / 1.534 GB, free: 206.5 MB / 0.8263 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.004796/3.681, allocations: 2.237 MB / 1.536 GB, free: 204.1 MB / 0.8263 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.02408/3.705, allocations: 4.957 MB / 1.541 GB, free: 199.1 MB / 0.8263 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.02047/3.726, allocations: 39.72 MB / 1.58 GB, free: 156.9 MB / 0.8263 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.02076/3.746, allocations: 0.8351 MB / 1.58 GB, free: 156.1 MB / 0.8263 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.007364/3.754, allocations: 1.265 MB / 1.582 GB, free: 154.8 MB / 0.8263 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 452
 * Number of states: 0 ()
 * Number of discrete variables: 4 (traceSubstance4.ind,traceSubstance3.ind,traceSubstance2.ind,traceSubstance1.ind)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (2405):
 * Single equations (assignments): 2348
 * Array equations: 0
 * Algorithm blocks: 4
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 53
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 10 systems
   {(1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 43 systems
   {(1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (2,7), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1)}
Notification: Performance of prepare postOptimizeDAE: time 0.01318/3.767, allocations: 1.28 MB / 1.583 GB, free: 153.6 MB / 0.8263 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.008124/3.775, allocations: 1.17 MB / 1.584 GB, free: 152.4 MB / 0.8263 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.09465/3.87, allocations: 33.35 MB / 1.617 GB, free: 118.9 MB / 0.8263 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.0002066/3.87, allocations: 168 kB / 1.617 GB, free: 118.7 MB / 0.8263 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 0.0001311/3.87, allocations: 4 kB / 1.617 GB, free: 118.7 MB / 0.8263 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.06299/3.933, allocations: 22.49 MB / 1.639 GB, free: 95.89 MB / 0.8263 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.1281/4.061, allocations: 48.12 MB / 1.686 GB, free: 47.24 MB / 0.8263 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 0.0001507/4.061, allocations: 4 kB / 1.686 GB, free: 47.23 MB / 0.8263 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.02132/4.083, allocations: 3.882 MB / 1.69 GB, free: 43.35 MB / 0.8263 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.007931/4.091, allocations: 2.83 MB / 1.692 GB, free: 40.36 MB / 0.8263 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.006534/4.097, allocations: 0.7495 MB / 1.693 GB, free: 39.61 MB / 0.8263 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.3801/4.477, allocations: 41.25 MB / 1.733 GB, free: 399.9 MB / 0.8263 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 7.364e-06/4.478, allocations: 3.594 kB / 1.733 GB, free: 399.9 MB / 0.8263 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.09987/4.577, allocations: 37.75 MB / 1.77 GB, free: 393.4 MB / 0.8263 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.006243/4.584, allocations: 1.304 MB / 1.772 GB, free: 393.2 MB / 0.8263 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.01112/4.595, allocations: 478.8 kB / 1.772 GB, free: 392.9 MB / 0.8263 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.02454/4.619, allocations: 0.6487 MB / 1.773 GB, free: 392.7 MB / 0.8263 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.009056/4.629, allocations: 1.193 MB / 1.774 GB, free: 392.5 MB / 0.8263 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.008272/4.637, allocations: 1.047 MB / 1.775 GB, free: 392.4 MB / 0.8263 GB
Notification: Performance of sorting global known variables: time 0.01437/4.651, allocations: 5.554 MB / 1.78 GB, free: 390.5 MB / 0.8263 GB
Notification: Performance of sort global known variables: time 6.11e-07/4.651, allocations: 3.969 kB / 1.78 GB, free: 390.5 MB / 0.8263 GB
Notification: Performance of remove unused functions: time 0.05806/4.709, allocations: 8.972 MB / 1.789 GB, free: 389.6 MB / 0.8263 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 10
 * Number of states: 168 (pipe5.mCs_scaled[1,1],pipe5.mCs_scaled[1,2],pipe5.mCs_scaled[2,1],pipe5.mCs_scaled[2,2],pipe5.mCs_scaled[3,1],pipe5.mCs_scaled[3,2],pipe5.mCs_scaled[4,1],pipe5.mCs_scaled[4,2],pipe5.mCs_scaled[5,1],pipe5.mCs_scaled[5,2],pipe5.mediums[1].p,pipe5.mediums[1].T,pipe5.mediums[2].p,pipe5.mediums[2].T,pipe5.mediums[3].p,pipe5.mediums[3].T,pipe5.mediums[4].p,pipe5.mediums[4].T,pipe5.mediums[5].p,pipe5.mediums[5].T,pipe6.mCs_scaled[1,1],pipe6.mCs_scaled[1,2],pipe6.mCs_scaled[2,1],pipe6.mCs_scaled[2,2],pipe6.mCs_scaled[3,1],pipe6.mCs_scaled[3,2],pipe6.mCs_scaled[4,1],pipe6.mCs_scaled[4,2],pipe6.mCs_scaled[5,1],pipe6.mCs_scaled[5,2],pipe6.mediums[1].p,pipe6.mediums[1].T,pipe6.mediums[2].p,pipe6.mediums[2].T,pipe6.mediums[3].p,pipe6.mediums[3].T,pipe6.mediums[4].p,pipe6.mediums[4].T,pipe6.mediums[5].p,pipe6.mediums[5].T,pipe7.mCs_scaled[1,1],pipe7.mCs_scaled[1,2],pipe7.mCs_scaled[2,1],pipe7.mCs_scaled[2,2],pipe7.mCs_scaled[3,1],pipe7.mCs_scaled[3,2],pipe7.mCs_scaled[4,1],pipe7.mCs_scaled[4,2],pipe7.mCs_scaled[5,1],pipe7.mCs_scaled[5,2],pipe7.mediums[1].p,pipe7.mediums[1].T,pipe7.mediums[2].p,pipe7.mediums[2].T,pipe7.mediums[3].p,pipe7.mediums[3].T,pipe7.mediums[4].p,pipe7.mediums[4].T,pipe7.mediums[5].p,pipe7.mediums[5].T,pipe8.mCs_scaled[1,1],pipe8.mCs_scaled[1,2],pipe8.mCs_scaled[2,1],pipe8.mCs_scaled[2,2],pipe8.mCs_scaled[3,1],pipe8.mCs_scaled[3,2],pipe8.mCs_scaled[4,1],pipe8.mCs_scaled[4,2],pipe8.mCs_scaled[5,1],pipe8.mCs_scaled[5,2],pipe8.mediums[1].p,pipe8.mediums[1].T,pipe8.mediums[2].p,pipe8.mediums[2].T,pipe8.mediums[3].p,pipe8.mediums[3].T,pipe8.mediums[4].p,pipe8.mediums[4].T,pipe8.mediums[5].p,pipe8.mediums[5].T,pipe2.mCs_scaled[1,1],pipe2.mCs_scaled[1,2],pipe2.mCs_scaled[2,1],pipe2.mCs_scaled[2,2],pipe2.mCs_scaled[3,1],pipe2.mCs_scaled[3,2],pipe2.mCs_scaled[4,1],pipe2.mCs_scaled[4,2],pipe2.mCs_scaled[5,1],pipe2.mCs_scaled[5,2],pipe2.mediums[1].p,pipe2.mediums[1].T,pipe2.mediums[2].p,pipe2.mediums[2].T,pipe2.mediums[3].p,pipe2.mediums[3].T,pipe2.mediums[4].p,pipe2.mediums[4].T,pipe2.mediums[5].p,pipe2.mediums[5].T,pipe3.mCs_scaled[1,1],pipe3.mCs_scaled[1,2],pipe3.mCs_scaled[2,1],pipe3.mCs_scaled[2,2],pipe3.mCs_scaled[3,1],pipe3.mCs_scaled[3,2],pipe3.mCs_scaled[4,1],pipe3.mCs_scaled[4,2],pipe3.mCs_scaled[5,1],pipe3.mCs_scaled[5,2],pipe3.mediums[1].p,pipe3.mediums[1].T,pipe3.mediums[2].p,pipe3.mediums[2].T,pipe3.mediums[3].p,pipe3.mediums[3].T,pipe3.mediums[4].p,pipe3.mediums[4].T,pipe3.mediums[5].p,pipe3.mediums[5].T,pipe1.mCs_scaled[1,1],pipe1.mCs_scaled[1,2],pipe1.mCs_scaled[2,1],pipe1.mCs_scaled[2,2],pipe1.mCs_scaled[3,1],pipe1.mCs_scaled[3,2],pipe1.mCs_scaled[4,1],pipe1.mCs_scaled[4,2],pipe1.mCs_scaled[5,1],pipe1.mCs_scaled[5,2],pipe1.mediums[1].p,pipe1.mediums[1].T,pipe1.mediums[2].p,pipe1.mediums[2].T,pipe1.mediums[3].p,pipe1.mediums[3].T,pipe1.mediums[4].p,pipe1.mediums[4].T,pipe1.mediums[5].p,pipe1.mediums[5].T,pipe4.mCs_scaled[1,1],pipe4.mCs_scaled[1,2],pipe4.mCs_scaled[2,1],pipe4.mCs_scaled[2,2],pipe4.mCs_scaled[3,1],pipe4.mCs_scaled[3,2],pipe4.mCs_scaled[4,1],pipe4.mCs_scaled[4,2],pipe4.mCs_scaled[5,1],pipe4.mCs_scaled[5,2],pipe4.mediums[1].p,pipe4.mediums[1].T,pipe4.mediums[2].p,pipe4.mediums[2].T,pipe4.mediums[3].p,pipe4.mediums[3].T,pipe4.mediums[4].p,pipe4.mediums[4].T,pipe4.mediums[5].p,pipe4.mediums[5].T,junction1.medium.p,junction1.medium.T,junction1.mC_scaled[1],junction1.mC_scaled[2],junction2.medium.p,junction2.medium.T,junction2.mC_scaled[1],junction2.mC_scaled[2])
 * 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 (1723):
 * Single equations (assignments): 1670
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 53
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 11 systems
   {(1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%), (1,1,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 42 systems
   {(1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (2,12), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.0136/4.723, allocations: 2.381 MB / 1.791 GB, free: 388.9 MB / 0.8263 GB
Notification: Performance of simCode: created initialization part: time 0.278/5.001, allocations: 153.4 MB / 1.941 GB, free: 250.6 MB / 0.8263 GB
Notification: Performance of simCode: created event and clocks part: time 3.082e-05/5.001, allocations: 12.48 kB / 1.941 GB, free: 250.6 MB / 0.8263 GB
Notification: Performance of simCode: created simulation system equations: time 0.03146/5.033, allocations: 13.82 MB / 1.955 GB, free: 238.6 MB / 0.8263 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.04537/5.078, allocations: 5.571 MB / 1.96 GB, free: 234.6 MB / 0.8263 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.1082/5.186, allocations: 44.45 MB / 2.003 GB, free: 195.6 MB / 0.8263 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.01041/5.197, allocations: 7.784 MB / 2.011 GB, free: 189.4 MB / 0.8263 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.01839/5.215, allocations: 2.049 MB / 2.013 GB, free: 187.3 MB / 0.8263 GB
Notification: Performance of SimCode: time 1.253e-06/5.215, allocations: 3.938 kB / 2.013 GB, free: 187.3 MB / 0.8263 GB
Notification: Performance of Templates: time 4.975/10.19, allocations: 2.539 GB / 4.552 GB, free: 338.2 MB / 0.8263 GB
make -j1 -f ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipesWithTraceSubstances.makefile
(rm -f ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipesWithTraceSubstances.pipe ; mkfifo ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipesWithTraceSubstances.pipe ; head -c 1048576 < ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipesWithTraceSubstances.pipe >> ../files/ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipesWithTraceSubstances.sim & ./ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipesWithTraceSubstances  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipesWithTraceSubstances.pipe 2>&1)
diffSimulationResults("ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipesWithTraceSubstances_res.mat","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/Reference-modelica.org/ReferenceResults/MAP-LIB_ReferenceResults/v4.0.0/ModelicaTest/Fluid/TestComponents/Pipes/DynamicPipesWithTraceSubstances/DynamicPipesWithTraceSubstances.csv","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipesWithTraceSubstances.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001)
""

Variables in the reference:time,junction1.mC_scaled[1],junction1.mC_scaled[2],junction1.medium.T,junction1.medium.p,junction2.mC_scaled[1],junction2.mC_scaled[2],junction2.medium.T,junction2.medium.p,pipe1.mediums[1].T,pipe1.mediums[1].p,pipe1.mediums[2].T,pipe1.mediums[2].p,pipe1.mediums[3].T,pipe1.mediums[3].p,pipe1.mediums[4].T,pipe1.mediums[4].p,pipe1.mediums[5].T,pipe1.mediums[5].p,pipe2.mediums[1].T,pipe2.mediums[1].p,pipe2.mediums[2].T,pipe2.mediums[2].p,pipe2.mediums[3].T,pipe2.mediums[3].p,pipe2.mediums[4].T,pipe2.mediums[4].p,pipe2.mediums[5].T,pipe2.mediums[5].p,pipe3.mediums[1].T,pipe3.mediums[1].p,pipe3.mediums[2].T,pipe3.mediums[2].p,pipe3.mediums[3].T,pipe3.mediums[3].p,pipe3.mediums[4].T,pipe3.mediums[4].p,pipe3.mediums[5].T,pipe3.mediums[5].p,pipe4.mediums[1].T,pipe4.mediums[1].p,pipe4.mediums[2].T,pipe4.mediums[2].p,pipe4.mediums[3].T,pipe4.mediums[3].p,pipe4.mediums[4].T,pipe4.mediums[4].p,pipe4.mediums[5].T,pipe4.mediums[5].p,pipe5.mediums[1].T,pipe5.mediums[1].p,pipe5.mediums[2].T,pipe5.mediums[2].p,pipe5.mediums[3].T,pipe5.mediums[3].p,pipe5.mediums[4].T,pipe5.mediums[4].p,pipe5.mediums[5].T,pipe5.mediums[5].p,pipe6.mediums[1].T,pipe6.mediums[1].p,pipe6.mediums[2].T,pipe6.mediums[2].p,pipe6.mediums[3].T,pipe6.mediums[3].p,pipe6.mediums[4].T,pipe6.mediums[4].p,pipe6.mediums[5].T,pipe6.mediums[5].p,pipe7.mediums[1].T,pipe7.mediums[1].p,pipe7.mediums[2].T,pipe7.mediums[2].p,pipe7.mediums[3].T,pipe7.mediums[3].p,pipe7.mediums[4].T,pipe7.mediums[4].p,pipe7.mediums[5].T,pipe7.mediums[5].p,pipe8.mediums[1].T,pipe8.mediums[1].p,pipe8.mediums[2].T,pipe8.mediums[2].p,pipe8.mediums[3].T,pipe8.mediums[3].p,pipe8.mediums[4].T,pipe8.mediums[4].p,pipe8.mediums[5].T,pipe8.mediums[5].p

Variables in the result:junction1.mC_scaled[1],junction1.mC_scaled[2],junction1.medium.T,junction1.medium.p,junction2.mC_scaled[1],junction2.mC_scaled[2],junction2.medium.T,junction2.medium.p,pipe1.mediums[1].T,pipe1.mediums[1].p,pipe1.mediums[2].T,pipe1.mediums[2].p,pipe1.mediums[3].T,pipe1.mediums[3].p,pipe1.mediums[4].T,pipe1.mediums[4].p,pipe1.mediums[5].T,pipe1.mediums[5].p,pipe2.mediums[1].T,pipe2.mediums[1].p,pipe2.mediums[2].T,pipe2.mediums[2].p,pipe2.mediums[3].T,pipe2.mediums[3].p,pipe2.mediums[4].T,pipe2.mediums[4].p,pipe2.mediums[5].T,pipe2.mediums[5].p,pipe3.mediums[1].T,pipe3.mediums[1].p,pipe3.mediums[2].T,pipe3.mediums[2].p,pipe3.mediums[3].T,pipe3.mediums[3].p,pipe3.mediums[4].T,pipe3.mediums[4].p,pipe3.mediums[5].T,pipe3.mediums[5].p,pipe4.mediums[1].T,pipe4.mediums[1].p,pipe4.mediums[2].T,pipe4.mediums[2].p,pipe4.mediums[3].T,pipe4.mediums[3].p,pipe4.mediums[4].T,pipe4.mediums[4].p,pipe4.mediums[5].T,pipe4.mediums[5].p,pipe5.mediums[1].T,pipe5.mediums[1].p,pipe5.mediums[2].T,pipe5.mediums[2].p,pipe5.mediums[3].T,pipe5.mediums[3].p,pipe5.mediums[4].T,pipe5.mediums[4].p,pipe5.mediums[5].T,pipe5.mediums[5].p,pipe6.mediums[1].T,pipe6.mediums[1].p,pipe6.mediums[2].T,pipe6.mediums[2].p,pipe6.mediums[3].T,pipe6.mediums[3].p,pipe6.mediums[4].T,pipe6.mediums[4].p,pipe6.mediums[5].T,pipe6.mediums[5].p,pipe7.mediums[1].T,pipe7.mediums[1].p,pipe7.mediums[2].T,pipe7.mediums[2].p,pipe7.mediums[3].T,pipe7.mediums[3].p,pipe7.mediums[4].T,pipe7.mediums[4].p,pipe7.mediums[5].T,pipe7.mediums[5].p,pipe8.mediums[1].T,pipe8.mediums[1].p,pipe8.mediums[2].T,pipe8.mediums[2].p,pipe8.mediums[3].T,pipe8.mediums[3].p,pipe8.mediums[4].T,pipe8.mediums[4].p,pipe8.mediums[5].T,pipe8.mediums[5].p,time