Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ModelicaTest_4.1.0_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipesWithTraceSubstances.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.001251/0.001251, allocations: 108.2 kB / 21.19 MB, free: 0.7617 MB / 14.72 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.00136/0.00136, allocations: 213.9 kB / 24.5 MB, free: 4.145 MB / 14.72 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 1.392/1.392, allocations: 230.6 MB / 258.3 MB, free: 8.02 MB / 206.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 4.1.0+maint.om/package.mo): time 0.2162/0.2162, allocations: 46.93 MB / 361.6 MB, free: 4.266 MB / 286.1 MB
"
[Timeout remaining time 180]
Using package ModelicaTest with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 4.1.0+maint.om/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(ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipesWithTraceSubstances,tolerance=1e-05,outputFormat="mat",numberOfIntervals=5003,variableFilter="time|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.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.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.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.|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.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.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.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",fileNamePrefix="ModelicaTest_4.1.0_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipesWithTraceSubstances")
translateModel(ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipesWithTraceSubstances,tolerance=1e-05,outputFormat="mat",numberOfIntervals=5003,variableFilter="time|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.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.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.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.|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.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.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.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",fileNamePrefix="ModelicaTest_4.1.0_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipesWithTraceSubstances") [Timeout 660]
"Notification: Performance of FrontEnd - loaded program: time 0.00199/0.00199, allocations: 76.08 kB / 0.4974 GB, free: 7.387 MB / 366.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.3713/0.3733, allocations: 66.03 MB / 0.5619 GB, free: 4.422 MB / 398.1 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipesWithTraceSubstances): time 0.734/1.107, allocations: 356 MB / 0.9096 GB, free: 7.684 MB / 0.6231 GB
Notification: Performance of NFInst.instExpressions: time 0.06181/1.169, allocations: 35.2 MB / 0.9439 GB, free: 4.387 MB / 0.6544 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.007908/1.177, allocations: 269.6 kB / 0.9442 GB, free: 4.121 MB / 0.6544 GB
Notification: Performance of NFTyping.typeComponents: time 0.007642/1.185, allocations: 2.034 MB / 0.9462 GB, free: 2.074 MB / 0.6544 GB
Notification: Performance of NFTyping.typeBindings: time 0.02979/1.214, allocations: 9.13 MB / 0.9551 GB, free: 8.906 MB / 0.67 GB
Notification: Performance of NFTyping.typeClassSections: time 0.03843/1.253, allocations: 14.3 MB / 0.9691 GB, free: 10.61 MB / 0.6856 GB
Notification: Performance of NFFlatten.flatten: time 0.03906/1.292, allocations: 26.63 MB / 0.9951 GB, free: 15.91 MB / 0.7169 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.01361/1.305, allocations: 6.112 MB / 1.001 GB, free: 9.73 MB / 0.7169 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.5497/1.855, allocations: 11.88 MB / 1.013 GB, free: 12.23 MB / 0.7169 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.02069/1.876, allocations: 11.23 MB / 1.024 GB, free: 12.23 MB / 0.7169 GB
Notification: Performance of NFPackage.collectConstants: time 0.007654/1.884, allocations: 1.263 MB / 1.025 GB, free: 12.23 MB / 0.7169 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.0268/1.91, allocations: 7.348 MB / 1.032 GB, free: 12.23 MB / 0.7169 GB
Notification: Performance of NFScalarize.scalarize: time 0.01769/1.928, allocations: 7.201 MB / 1.039 GB, free: 12.09 MB / 0.7169 GB
Notification: Performance of NFVerifyModel.verify: time 0.03365/1.962, allocations: 8.153 MB / 1.047 GB, free: 10.08 MB / 0.7169 GB
Notification: Performance of NFConvertDAE.convert: time 0.05075/2.012, allocations: 25.12 MB / 1.072 GB, free: 6.949 MB / 0.7169 GB
Notification: Performance of FrontEnd - DAE generated: time 6.472e-06/2.012, allocations: 2.953 kB / 1.072 GB, free: 6.949 MB / 0.7169 GB
Notification: Performance of FrontEnd: time 1.343e-06/2.012, allocations: 0 / 1.072 GB, free: 6.949 MB / 0.7169 GB
Notification: Performance of Transformations before backend: time 0.0008815/2.013, allocations: 0 / 1.072 GB, free: 6.949 MB / 0.7169 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.07207/2.085, allocations: 19.26 MB / 1.09 GB, free: 1.273 MB / 0.7169 GB
Notification: Performance of prepare preOptimizeDAE: time 4.382e-05/2.085, allocations: 9.75 kB / 1.09 GB, free: 1.273 MB / 0.7169 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01737/2.103, allocations: 2.244 MB / 1.093 GB, free: 492 kB / 0.7169 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.02259/2.125, allocations: 7.27 MB / 1.1 GB, free: 15.07 MB / 0.7325 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.001122/2.127, allocations: 0.8708 MB / 1.101 GB, free: 15.04 MB / 0.7325 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.007394/2.134, allocations: 1.139 MB / 1.102 GB, free: 15 MB / 0.7325 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.06408/2.198, allocations: 22.83 MB / 1.124 GB, free: 5.305 MB / 0.7325 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0009678/2.199, allocations: 40.11 kB / 1.124 GB, free: 5.281 MB / 0.7325 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.008016/2.207, allocations: 468 kB / 1.124 GB, free: 5.164 MB / 0.7325 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.002556/2.21, allocations: 1.852 MB / 1.126 GB, free: 3.547 MB / 0.7325 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.0593/2.269, allocations: 22.84 MB / 1.149 GB, free: 4.043 MB / 0.7481 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.2027/2.472, allocations: 84.19 MB / 1.231 GB, free: 12.21 MB / 0.8419 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.04093/2.512, allocations: 17.9 MB / 1.248 GB, free: 10.58 MB / 0.8575 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0248/2.537, allocations: 10.21 MB / 1.258 GB, free: 348 kB / 0.8575 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.002618/2.54, allocations: 410.2 kB / 1.259 GB, free: 0 / 0.8575 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0004102/2.54, allocations: 213.2 kB / 1.259 GB, free: 15.78 MB / 0.8731 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.01118/2.551, allocations: 1.487 MB / 1.26 GB, free: 14.29 MB / 0.8731 GB
Notification: Performance of pre-optimization done (n=1487): time 4.714e-05/2.552, allocations: 0 / 1.26 GB, free: 14.29 MB / 0.8731 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.976/3.528, allocations: 135 MB / 1.392 GB, free: 239.1 MB / 0.9356 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001637/3.528, allocations: 355.6 kB / 1.392 GB, free: 238.9 MB / 0.9356 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.01509/3.543, allocations: 8.254 MB / 1.4 GB, free: 238.4 MB / 0.9356 GB
Notification: Performance of collectPreVariables (initialization): time 0.005754/3.549, allocations: 352.1 kB / 1.401 GB, free: 238.3 MB / 0.9356 GB
Notification: Performance of collectInitialEqns (initialization): time 0.004586/3.553, allocations: 5.103 MB / 1.406 GB, free: 236.3 MB / 0.9356 GB
Notification: Performance of collectInitialBindings (initialization): time 0.009512/3.563, allocations: 6.413 MB / 1.412 GB, free: 232.1 MB / 0.9356 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.01908/3.582, allocations: 3.927 MB / 1.416 GB, free: 232 MB / 0.9356 GB
Notification: Performance of setup shared object (initialization): time 7.473e-05/3.582, allocations: 301.1 kB / 1.416 GB, free: 231.7 MB / 0.9356 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0221/3.604, allocations: 10.87 MB / 1.427 GB, free: 229.6 MB / 0.9356 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.02678/3.631, allocations: 14.65 MB / 1.441 GB, free: 218 MB / 0.9356 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.04243/3.673, allocations: 26.65 MB / 1.467 GB, free: 190.2 MB / 0.9356 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0001646/3.673, allocations: 28 kB / 1.467 GB, free: 190.2 MB / 0.9356 GB
Notification: Performance of matching and sorting (n=2465) (initialization): time 0.06157/3.735, allocations: 30.07 MB / 1.496 GB, free: 160.5 MB / 0.9356 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001581/3.735, allocations: 167.4 kB / 1.497 GB, free: 160.3 MB / 0.9356 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001555/3.735, allocations: 100 kB / 1.497 GB, free: 160.2 MB / 0.9356 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.005384/3.741, allocations: 2.5 MB / 1.499 GB, free: 157.5 MB / 0.9356 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.02316/3.764, allocations: 4.999 MB / 1.504 GB, free: 152.8 MB / 0.9356 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01913/3.783, allocations: 39.57 MB / 1.543 GB, free: 111.2 MB / 0.9356 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01736/3.8, allocations: 0.8508 MB / 1.544 GB, free: 110.3 MB / 0.9356 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.006542/3.807, allocations: 1.291 MB / 1.545 GB, free: 109.1 MB / 0.9356 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.03089/3.838, allocations: 13.54 MB / 1.558 GB, free: 95.51 MB / 0.9356 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.02269/3.86, allocations: 14.01 MB / 1.572 GB, free: 80.15 MB / 0.9356 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.04061/3.901, allocations: 25.35 MB / 1.596 GB, free: 53.75 MB / 0.9356 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 0.0001437/3.901, allocations: 28 kB / 1.596 GB, free: 53.73 MB / 0.9356 GB
Notification: Performance of matching and sorting (n=2465) (initialization_lambda0): time 0.05985/3.961, allocations: 28.6 MB / 1.624 GB, free: 25.55 MB / 0.9356 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001495/3.961, allocations: 163.4 kB / 1.625 GB, free: 25.37 MB / 0.9356 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001497/3.961, allocations: 100 kB / 1.625 GB, free: 25.27 MB / 0.9356 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.004225/3.965, allocations: 2.237 MB / 1.627 GB, free: 22.9 MB / 0.9356 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.02284/3.988, allocations: 4.95 MB / 1.632 GB, free: 18.2 MB / 0.9356 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.02492/4.013, allocations: 38.69 MB / 1.669 GB, free: 9.504 MB / 0.9669 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0166/4.03, allocations: 0.8274 MB / 1.67 GB, free: 8.676 MB / 0.9669 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.006719/4.037, allocations: 1.272 MB / 1.671 GB, free: 7.406 MB / 0.9669 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.01305/4.05, allocations: 1.285 MB / 1.673 GB, free: 6.375 MB / 0.9669 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.00722/4.057, allocations: 1.231 MB / 1.674 GB, free: 5.137 MB / 0.9669 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.4202/4.477, allocations: 33.32 MB / 1.706 GB, free: 494.5 MB / 0.9669 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.0001437/4.477, allocations: 169.7 kB / 1.707 GB, free: 494.5 MB / 0.9669 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 0.0001447/4.477, allocations: 3.906 kB / 1.707 GB, free: 494.5 MB / 0.9669 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.04428/4.522, allocations: 22.47 MB / 1.729 GB, free: 486.4 MB / 0.9669 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.1002/4.622, allocations: 47.19 MB / 1.775 GB, free: 454.5 MB / 0.9669 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 0.0001221/4.622, allocations: 4 kB / 1.775 GB, free: 454.5 MB / 0.9669 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.01973/4.642, allocations: 3.886 MB / 1.778 GB, free: 451.3 MB / 0.9669 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.006356/4.648, allocations: 2.822 MB / 1.781 GB, free: 448.7 MB / 0.9669 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.005052/4.653, allocations: 0.7495 MB / 1.782 GB, free: 447.9 MB / 0.9669 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.01913/4.672, allocations: 40.13 MB / 1.821 GB, free: 405.8 MB / 0.9669 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 4.638e-06/4.672, allocations: 4.031 kB / 1.821 GB, free: 405.8 MB / 0.9669 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.07019/4.742, allocations: 37.8 MB / 1.858 GB, free: 368.4 MB / 0.9669 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.004417/4.747, allocations: 1.295 MB / 1.859 GB, free: 367.8 MB / 0.9669 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.006742/4.753, allocations: 479.8 kB / 1.86 GB, free: 367.3 MB / 0.9669 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0132/4.767, allocations: 0.6436 MB / 1.86 GB, free: 366.7 MB / 0.9669 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.005201/4.772, allocations: 1.249 MB / 1.862 GB, free: 365.4 MB / 0.9669 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.004366/4.776, allocations: 1.046 MB / 1.863 GB, free: 364.4 MB / 0.9669 GB
Notification: Performance of sorting global known variables: time 0.008889/4.785, allocations: 5.557 MB / 1.868 GB, free: 358.8 MB / 0.9669 GB
Notification: Performance of sort global known variables: time 3.11e-07/4.785, allocations: 0 / 1.868 GB, free: 358.8 MB / 0.9669 GB
Notification: Performance of remove unused functions: time 0.0382/4.823, allocations: 8.998 MB / 1.877 GB, free: 350.1 MB / 0.9669 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.008922/4.832, allocations: 2.405 MB / 1.879 GB, free: 347.9 MB / 0.9669 GB
Notification: Performance of simCode: created initialization part: time 0.07489/4.907, allocations: 40.93 MB / 1.919 GB, free: 306.7 MB / 0.9669 GB
Notification: Performance of simCode: created event and clocks part: time 1.992e-05/4.907, allocations: 12.48 kB / 1.919 GB, free: 306.7 MB / 0.9669 GB
Notification: Performance of simCode: created simulation system equations: time 0.02527/4.932, allocations: 13.11 MB / 1.932 GB, free: 293.5 MB / 0.9669 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.03228/4.965, allocations: 5.546 MB / 1.937 GB, free: 288.1 MB / 0.9669 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.07278/5.037, allocations: 44.89 MB / 1.981 GB, free: 243.5 MB / 0.9669 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.01039/5.048, allocations: 7.771 MB / 1.989 GB, free: 235.7 MB / 0.9669 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.01222/5.06, allocations: 2.041 MB / 1.991 GB, free: 233.6 MB / 0.9669 GB
Notification: Performance of SimCode: time 8.81e-07/5.06, allocations: 0 / 1.991 GB, free: 233.6 MB / 0.9669 GB
Notification: Performance of Templates: time 4.215/9.275, allocations: 2.542 GB / 4.533 GB, free: 432.2 MB / 0.9669 GB
"
[Timeout remaining time 651]
make -j1 -f ModelicaTest_4.1.0_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipesWithTraceSubstances.makefile [Timeout 660]
(rm -f ModelicaTest_4.1.0_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipesWithTraceSubstances.pipe ; mkfifo ModelicaTest_4.1.0_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipesWithTraceSubstances.pipe ; head -c 1048576 < ModelicaTest_4.1.0_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipesWithTraceSubstances.pipe >> ../files/ModelicaTest_4.1.0_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipesWithTraceSubstances.sim & ./ModelicaTest_4.1.0_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipesWithTraceSubstances  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > ModelicaTest_4.1.0_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipesWithTraceSubstances.pipe 2>&1) [Timeout 480]
diffSimulationResults("ModelicaTest_4.1.0_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipesWithTraceSubstances_res.mat","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/Reference-modelica.org/ReferenceResults/MAP-LIB_ReferenceResults/v4.1.0/ModelicaTest/Fluid/TestComponents/Pipes/DynamicPipesWithTraceSubstances/DynamicPipesWithTraceSubstances.csv","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/ModelicaTest_4.1.0_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipesWithTraceSubstances.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001) [Timeout 660]
""
[Timeout remaining time 659]
Reference file matches
[Calling sys.exit(0), Time elapsed: 127.1393676570151]