Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ModelicaTest_3.2.3_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.001059/0.001059, allocations: 88.47 kB / 19.93 MB, free: 4.625 MB / 18.57 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.001188/0.001188, allocations: 173.9 kB / 23.21 MB, free: 1.352 MB / 18.57 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 0.8574/0.8574, allocations: 158.6 MB / 185 MB, free: 3.055 MB / 170.7 MB
"
[Timeout remaining time 179]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 3.2.3+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 3.2.3+maint.om/package.mo): time 0.1263/0.1263, allocations: 32.38 MB / 269.6 MB, free: 14.96 MB / 266.7 MB
"
[Timeout remaining time 180]
Using package ModelicaTest with version 3.2.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 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 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: setCommandLineOptions("--fmiFlags=s:cvode")
Running command: "" <> buildModelFMU(ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipesWithTraceSubstances,fileNamePrefix="ModelicaTest_3_2_3_ModelicaTest_Fluid_TestComponents_Pipes_DynamicPipesWithTraceSubstances",fmuType="me_cs",version="2.0",platforms={"static"})
"" <> buildModelFMU(ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipesWithTraceSubstances,fileNamePrefix="ModelicaTest_3_2_3_ModelicaTest_Fluid_TestComponents_Pipes_DynamicPipesWithTraceSubstances",fmuType="me_cs",version="2.0",platforms={"static"}) [Timeout 660]
"Notification: Performance of FrontEnd - loaded program: time 2.004e-06/2.004e-06, allocations: 0 / 408.4 MB, free: 0.6758 MB / 378.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 2.169e-05/2.37e-05, allocations: 10.08 kB / 408.4 MB, free: 0.668 MB / 378.7 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipesWithTraceSubstances): time 0.6486/0.6486, allocations: 338.8 MB / 0.7297 GB, free: 0.5625 MB / 0.5417 GB
Notification: Performance of NFInst.instExpressions: time 0.03931/0.6879, allocations: 34.44 MB / 0.7633 GB, free: 15.87 MB / 0.5573 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.004628/0.6925, allocations: 266.9 kB / 0.7636 GB, free: 15.87 MB / 0.5573 GB
Notification: Performance of NFTyping.typeComponents: time 0.004714/0.6972, allocations: 1.983 MB / 0.7655 GB, free: 15.71 MB / 0.5573 GB
Notification: Performance of NFTyping.typeBindings: time 0.02034/0.7176, allocations: 10.87 MB / 0.7762 GB, free: 13.23 MB / 0.5573 GB
Notification: Performance of NFTyping.typeClassSections: time 0.02707/0.7447, allocations: 16.31 MB / 0.7921 GB, free: 3.234 MB / 0.5573 GB
Notification: Performance of NFFlatten.flatten: time 0.02084/0.7655, allocations: 24.97 MB / 0.8165 GB, free: 15.59 MB / 0.5886 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.008798/0.7743, allocations: 6.115 MB / 0.8224 GB, free: 9.691 MB / 0.5886 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.02704/0.8013, allocations: 14.87 MB / 0.837 GB, free: 11.91 MB / 0.6042 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.01359/0.8149, allocations: 10.62 MB / 0.8473 GB, free: 2.059 MB / 0.6042 GB
Notification: Performance of NFPackage.collectConstants: time 0.004307/0.8192, allocations: 1.258 MB / 0.8486 GB, free: 0.8008 MB / 0.6042 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.01486/0.8341, allocations: 7.175 MB / 0.8556 GB, free: 9.984 MB / 0.6198 GB
Notification: Performance of NFScalarize.scalarize: time 0.007907/0.842, allocations: 7.408 MB / 0.8628 GB, free: 2.863 MB / 0.6198 GB
Notification: Performance of NFVerifyModel.verify: time 0.01106/0.8531, allocations: 5.956 MB / 0.8686 GB, free: 13.16 MB / 0.6355 GB
Notification: Performance of NFConvertDAE.convert: time 0.0324/0.8855, allocations: 27.27 MB / 0.8953 GB, free: 3.082 MB / 0.6511 GB
Notification: Performance of FrontEnd - DAE generated: time 5.149e-06/0.8855, allocations: 0 / 0.8953 GB, free: 3.082 MB / 0.6511 GB
Notification: Performance of FrontEnd: time 1.643e-06/0.8855, allocations: 0 / 0.8953 GB, free: 3.082 MB / 0.6511 GB
Notification: Performance of Transformations before backend: time 0.0005718/0.886, allocations: 4 kB / 0.8953 GB, free: 3.078 MB / 0.6511 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.04504/0.9311, allocations: 19.4 MB / 0.9142 GB, free: 15.7 MB / 0.6823 GB
Notification: Performance of prepare preOptimizeDAE: time 5.01e-05/0.9311, allocations: 12.03 kB / 0.9142 GB, free: 15.69 MB / 0.6823 GB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.006202/0.9373, allocations: 1.766 MB / 0.9159 GB, free: 13.95 MB / 0.6823 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01119/0.9485, allocations: 2.25 MB / 0.9181 GB, free: 11.69 MB / 0.6823 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.0138/0.9623, allocations: 7.304 MB / 0.9253 GB, free: 4.703 MB / 0.6823 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0007513/0.9631, allocations: 0.8677 MB / 0.9261 GB, free: 3.867 MB / 0.6823 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0045/0.9676, allocations: 1.139 MB / 0.9272 GB, free: 2.762 MB / 0.6823 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.3295/1.297, allocations: 26.41 MB / 0.953 GB, free: 327.8 MB / 0.698 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0004185/1.298, allocations: 41.78 kB / 0.9531 GB, free: 327.8 MB / 0.698 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.004504/1.302, allocations: 464.9 kB / 0.9535 GB, free: 327.7 MB / 0.698 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.001315/1.303, allocations: 1.855 MB / 0.9553 GB, free: 327.4 MB / 0.698 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.03919/1.343, allocations: 22.73 MB / 0.9775 GB, free: 319.9 MB / 0.698 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.09286/1.435, allocations: 62.27 MB / 1.038 GB, free: 281 MB / 0.698 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.01952/1.455, allocations: 17.81 MB / 1.056 GB, free: 263.5 MB / 0.698 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.01243/1.467, allocations: 10.16 MB / 1.066 GB, free: 253.3 MB / 0.698 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.002007/1.469, allocations: 1.186 MB / 1.067 GB, free: 252.1 MB / 0.698 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0001325/1.469, allocations: 206.7 kB / 1.067 GB, free: 251.9 MB / 0.698 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.00544/1.475, allocations: 1.501 MB / 1.068 GB, free: 250.7 MB / 0.698 GB
Notification: Performance of pre-optimization done (n=1487): time 2.994e-05/1.475, allocations: 0 / 1.068 GB, free: 250.7 MB / 0.698 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[4].T
2: pipe2.mediums[1].T
3: pipe2.mediums[2].T
4: pipe2.mediums[3].T
5: pipe2.mediums[5].T
6: pipe3.mediums[5].T
7: pipe3.mediums[1].T
8: pipe3.mediums[3].T
9: pipe3.mediums[4].T
10: pipe3.mediums[2].T
11: pipe1.mediums[1].T
12: pipe1.mediums[2].T
13: pipe1.mediums[3].T
14: pipe1.mediums[4].T
15: pipe1.mediums[5].T
16: pipe4.mediums[3].T
17: pipe4.mediums[5].T
18: pipe4.mediums[1].T
19: pipe4.mediums[2].T
20: pipe4.mediums[4].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.2526/1.728, allocations: 134.9 MB / 1.2 GB, free: 117.5 MB / 0.698 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001152/1.728, allocations: 364.6 kB / 1.2 GB, free: 117.1 MB / 0.698 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.008692/1.736, allocations: 8.456 MB / 1.209 GB, free: 108.8 MB / 0.698 GB
Notification: Performance of collectPreVariables (initialization): time 0.00392/1.74, allocations: 345.7 kB / 1.209 GB, free: 108.5 MB / 0.698 GB
Notification: Performance of collectInitialEqns (initialization): time 0.002398/1.743, allocations: 5.078 MB / 1.214 GB, free: 103.9 MB / 0.698 GB
Notification: Performance of collectInitialBindings (initialization): time 0.006142/1.749, allocations: 6.332 MB / 1.22 GB, free: 97.69 MB / 0.698 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0112/1.76, allocations: 3.898 MB / 1.224 GB, free: 93.79 MB / 0.698 GB
Notification: Performance of setup shared object (initialization): time 2.986e-05/1.76, allocations: 301.1 kB / 1.224 GB, free: 93.49 MB / 0.698 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.01487/1.775, allocations: 10.98 MB / 1.235 GB, free: 82.48 MB / 0.698 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.01983/1.795, allocations: 14.84 MB / 1.25 GB, free: 66.21 MB / 0.698 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.03102/1.826, allocations: 26.62 MB / 1.276 GB, free: 38.07 MB / 0.698 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.000108/1.826, allocations: 32 kB / 1.276 GB, free: 38.04 MB / 0.698 GB
Notification: Performance of matching and sorting (n=2465) (initialization): time 0.04827/1.874, allocations: 30.17 MB / 1.305 GB, free: 7.551 MB / 0.698 GB
Notification: Performance of prepare postOptimizeDAE: time 0.000119/1.874, allocations: 162.8 kB / 1.305 GB, free: 7.367 MB / 0.698 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 9.538e-05/1.874, allocations: 96.84 kB / 1.305 GB, free: 7.273 MB / 0.698 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.003407/1.878, allocations: 2.539 MB / 1.308 GB, free: 4.574 MB / 0.698 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.1871/2.065, allocations: 4.991 MB / 1.313 GB, free: 308.3 MB / 0.698 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0112/2.076, allocations: 39.47 MB / 1.351 GB, free: 274 MB / 0.698 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01022/2.086, allocations: 0.8541 MB / 1.352 GB, free: 274 MB / 0.698 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.003289/2.09, allocations: 1.292 MB / 1.353 GB, free: 274 MB / 0.698 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.01864/2.108, allocations: 13.64 MB / 1.367 GB, free: 271 MB / 0.698 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.02381/2.132, allocations: 14.2 MB / 1.38 GB, free: 263.3 MB / 0.698 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.03342/2.165, allocations: 25.33 MB / 1.405 GB, free: 251 MB / 0.698 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 0.0001742/2.166, allocations: 35.14 kB / 1.405 GB, free: 251 MB / 0.698 GB
Notification: Performance of matching and sorting (n=2465) (initialization_lambda0): time 0.04367/2.209, allocations: 28.7 MB / 1.433 GB, free: 235.2 MB / 0.698 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001411/2.209, allocations: 161.7 kB / 1.433 GB, free: 235 MB / 0.698 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001308/2.21, allocations: 103.3 kB / 1.434 GB, free: 234.9 MB / 0.698 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.002706/2.212, allocations: 2.251 MB / 1.436 GB, free: 232.9 MB / 0.698 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01422/2.226, allocations: 4.945 MB / 1.441 GB, free: 228.7 MB / 0.698 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01068/2.237, allocations: 38.62 MB / 1.478 GB, free: 189.1 MB / 0.698 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0106/2.248, allocations: 0.8313 MB / 1.479 GB, free: 188.3 MB / 0.698 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.004049/2.252, allocations: 1.27 MB / 1.48 GB, free: 187 MB / 0.698 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.01003/2.262, allocations: 1.281 MB / 1.482 GB, free: 185.8 MB / 0.698 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.006052/2.268, allocations: 1.232 MB / 1.483 GB, free: 185.2 MB / 0.698 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.04468/2.313, allocations: 31.16 MB / 1.513 GB, free: 154.6 MB / 0.698 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 8.755e-05/2.313, allocations: 168 kB / 1.513 GB, free: 154.4 MB / 0.698 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 5.032e-05/2.313, allocations: 4 kB / 1.513 GB, free: 154.4 MB / 0.698 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.03027/2.343, allocations: 22.44 MB / 1.535 GB, free: 131.7 MB / 0.698 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.07044/2.413, allocations: 42.68 MB / 1.577 GB, free: 89.36 MB / 0.698 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 0.0001231/2.414, allocations: 0 / 1.577 GB, free: 89.36 MB / 0.698 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0128/2.426, allocations: 3.882 MB / 1.581 GB, free: 85.48 MB / 0.698 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.003984/2.43, allocations: 2.866 MB / 1.584 GB, free: 82.46 MB / 0.698 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.00391/2.434, allocations: 0.7378 MB / 1.584 GB, free: 81.73 MB / 0.698 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.01095/2.445, allocations: 40.03 MB / 1.623 GB, free: 39.5 MB / 0.698 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.605e-06/2.445, allocations: 8.531 kB / 1.623 GB, free: 39.49 MB / 0.698 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.05371/2.499, allocations: 37.76 MB / 1.66 GB, free: 1.52 MB / 0.698 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.003288/2.502, allocations: 1.285 MB / 1.661 GB, free: 240 kB / 0.698 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.174/2.676, allocations: 482.9 kB / 1.662 GB, free: 291.8 MB / 0.698 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0125/2.689, allocations: 0.6413 MB / 1.663 GB, free: 291.8 MB / 0.698 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.005376/2.694, allocations: 1.24 MB / 1.664 GB, free: 291.8 MB / 0.698 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.003315/2.697, allocations: 1.049 MB / 1.665 GB, free: 291.8 MB / 0.698 GB
Notification: Performance of sorting global known variables: time 0.006546/2.704, allocations: 5.552 MB / 1.67 GB, free: 291.5 MB / 0.698 GB
Notification: Performance of sort global known variables: time 1.9e-07/2.704, allocations: 3.031 kB / 1.67 GB, free: 291.5 MB / 0.698 GB
Notification: Performance of remove unused functions: time 0.03008/2.734, allocations: 9.239 MB / 1.679 GB, free: 291.5 MB / 0.698 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 8
 * 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.06583/2.8, allocations: 41.3 MB / 1.72 GB, free: 279.2 MB / 0.698 GB
Notification: Performance of simCode: created initialization part: time 0.05855/2.858, allocations: 41.11 MB / 1.76 GB, free: 251.7 MB / 0.698 GB
Notification: Performance of simCode: created event and clocks part: time 1.992e-05/2.858, allocations: 12.48 kB / 1.76 GB, free: 251.7 MB / 0.698 GB
Notification: Performance of simCode: created simulation system equations: time 0.01787/2.876, allocations: 13.09 MB / 1.773 GB, free: 240.5 MB / 0.698 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.02102/2.897, allocations: 5.544 MB / 1.778 GB, free: 236.5 MB / 0.698 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.4018/3.299, allocations: 163.1 MB / 1.937 GB, free: 281.2 MB / 0.698 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.009778/3.309, allocations: 7.429 MB / 1.945 GB, free: 280.5 MB / 0.698 GB
Notification: Performance of simCode: alias equations: time 0.03446/3.343, allocations: 13.55 MB / 1.958 GB, free: 280.2 MB / 0.698 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.01383/3.357, allocations: 6.637 MB / 1.964 GB, free: 279.7 MB / 0.698 GB
Notification: Performance of SimCode: time 1.623e-06/3.357, allocations: 0 / 1.964 GB, free: 279.7 MB / 0.698 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.8433/4.2, allocations: 487.4 MB / 2.44 GB, free: 234.7 MB / 0.698 GB
Notification: Performance of buildModelFMU: Generate platform static: time 31.54/35.74, allocations: 13.06 kB / 2.44 GB, free: 234.7 MB / 0.698 GB
"
[Timeout remaining time 624]
(rm -f ModelicaTest_3.2.3_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipesWithTraceSubstances.pipe ; mkfifo ModelicaTest_3.2.3_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipesWithTraceSubstances.pipe ; head -c 1048576 < ModelicaTest_3.2.3_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipesWithTraceSubstances.pipe >> ../files/ModelicaTest_3.2.3_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipesWithTraceSubstances.sim & (cd run_OMSimulator && /home/hudson/saved_omc/OMSimulator/install/bin/OMSimulator --resultFile=../ModelicaTest_3.2.3_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipesWithTraceSubstances_res.mat --stripRoot --tempDir=temp_ModelicaTest_3_2_3_ModelicaTest_Fluid_TestComponents_Pipes_DynamicPipesWithTraceSubstances_fmu --startTime=0 --stopTime=20 --stepSize=0.0039976 --mode=me --timeout=240 --tolerance=1e-05 ../ModelicaTest_3_2_3_ModelicaTest_Fluid_TestComponents_Pipes_DynamicPipesWithTraceSubstances.fmu) > ModelicaTest_3.2.3_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipesWithTraceSubstances.pipe 2>&1) [Timeout 252.0]
OMSimulator failed or timed out simulating it; the others still get to run it
(rm -f ModelicaTest_3.2.3_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipesWithTraceSubstances_OMSimulator-cs-cvode.pipe ; mkfifo ModelicaTest_3.2.3_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipesWithTraceSubstances_OMSimulator-cs-cvode.pipe ; head -c 1048576 < ModelicaTest_3.2.3_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipesWithTraceSubstances_OMSimulator-cs-cvode.pipe >> /var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/ModelicaTest_3.2.3_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipesWithTraceSubstances_OMSimulator-cs-cvode.sim & (cd run_OMSimulator-cs-cvode && /home/hudson/saved_omc/OMSimulator/install/bin/OMSimulator --resultFile=../ModelicaTest_3.2.3_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipesWithTraceSubstances_OMSimulator-cs-cvode_res.mat --stripRoot --tempDir=temp_ModelicaTest_3_2_3_ModelicaTest_Fluid_TestComponents_Pipes_DynamicPipesWithTraceSubstances_OMSimulator-cs-cvode_fmu --startTime=0 --stopTime=20 --stepSize=0.0039976 --mode=cs --timeout=240 --tolerance=1e-05 ../ModelicaTest_3_2_3_ModelicaTest_Fluid_TestComponents_Pipes_DynamicPipesWithTraceSubstances_OMSimulator-cs-cvode.fmu) > ModelicaTest_3.2.3_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipesWithTraceSubstances_OMSimulator-cs-cvode.pipe 2>&1) [Timeout 252.0]
OMSimulator-cs-cvode timed out simulating the FMU
(rm -f ModelicaTest_3.2.3_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipesWithTraceSubstances_OMSimulator-cs-euler.pipe ; mkfifo ModelicaTest_3.2.3_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipesWithTraceSubstances_OMSimulator-cs-euler.pipe ; head -c 1048576 < ModelicaTest_3.2.3_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipesWithTraceSubstances_OMSimulator-cs-euler.pipe >> /var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/ModelicaTest_3.2.3_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipesWithTraceSubstances_OMSimulator-cs-euler.sim & (cd run_OMSimulator-cs-euler && /home/hudson/saved_omc/OMSimulator/install/bin/OMSimulator --resultFile=../ModelicaTest_3.2.3_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipesWithTraceSubstances_OMSimulator-cs-euler_res.mat --stripRoot --tempDir=temp_ModelicaTest_3_2_3_ModelicaTest_Fluid_TestComponents_Pipes_DynamicPipesWithTraceSubstances_OMSimulator-cs-euler_fmu --startTime=0 --stopTime=20 --stepSize=0.0039976 --mode=cs --timeout=240 --tolerance=1e-05 ../ModelicaTest_3_2_3_ModelicaTest_Fluid_TestComponents_Pipes_DynamicPipesWithTraceSubstances_OMSimulator-cs-euler.fmu) > ModelicaTest_3.2.3_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipesWithTraceSubstances_OMSimulator-cs-euler.pipe 2>&1) [Timeout 252.0]
OMSimulator-cs-euler timed out simulating the FMU
(rm -f ModelicaTest_3.2.3_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipesWithTraceSubstances_fmpy.pipe ; mkfifo ModelicaTest_3.2.3_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipesWithTraceSubstances_fmpy.pipe ; head -c 1048576 < ModelicaTest_3.2.3_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipesWithTraceSubstances_fmpy.pipe >> /var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/ModelicaTest_3.2.3_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipesWithTraceSubstances_fmpy.sim & (cd run_fmpy && python3 -m fmpy simulate --output-file ../ModelicaTest_3.2.3_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipesWithTraceSubstances_fmpy_res.csv --output-variables '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' --start-time 0 --stop-time 20 --timeout 240 --relative-tolerance 1e-05 --interface-type ModelExchange --solver CVode --output-interval 0.0039976 ../ModelicaTest_3_2_3_ModelicaTest_Fluid_TestComponents_Pipes_DynamicPipesWithTraceSubstances.fmu) > ModelicaTest_3.2.3_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipesWithTraceSubstances_fmpy.pipe 2>&1) [Timeout 252.0]
fmpy timed out simulating the FMU
[Calling sys.exit(0), Time elapsed: 40.443372246809304]