Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipeEnergyConservationCheck2.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo): time 0.0007961/0.0007961, allocations: 76.36 kB / 20.67 MB, free: 3.895 MB / 18.57 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo): time 0.0007711/0.0007711, allocations: 156.9 kB / 23.95 MB, free: 0.6133 MB / 18.57 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo): time 0.9313/0.9313, allocations: 177 MB / 204.1 MB, free: 5.738 MB / 186.7 MB
"
[Timeout remaining time 179]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest trunk/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest trunk/package.mo): time 0.2748/0.2748, allocations: 34.23 MB / 294.8 MB, free: 0.6875 MB / 266.7 MB
"
[Timeout remaining time 180]
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: "" <> buildModelFMU(ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipeEnergyConservationCheck2,fileNamePrefix="ModelicaTest_trunk_ModelicaTest_Fluid_TestComponents_Pipes_DynamicPipeEnergyConservationCheck2",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipeEnergyConservationCheck2,fileNamePrefix="ModelicaTest_trunk_ModelicaTest_Fluid_TestComponents_Pipes_DynamicPipeEnergyConservationCheck2",fmuType="me",version="2.0",platforms={"static"}) [Timeout 660]
"Notification: Performance of FrontEnd - loaded program: time 2.515e-06/2.515e-06, allocations: 4 kB / 442.2 MB, free: 1.559 MB / 410.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 1.556e-05/1.808e-05, allocations: 2.281 kB / 442.2 MB, free: 1.555 MB / 410.7 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipeEnergyConservationCheck2): time 0.6081/0.6081, allocations: 239.3 MB / 0.6655 GB, free: 1.664 MB / 0.5261 GB
Notification: Performance of NFInst.instExpressions: time 0.01335/0.6214, allocations: 12.01 MB / 0.6772 GB, free: 1.559 MB / 0.5261 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001981/0.6234, allocations: 147.6 kB / 0.6773 GB, free: 1.559 MB / 0.5261 GB
Notification: Performance of NFTyping.typeComponents: time 0.002226/0.6256, allocations: 1.25 MB / 0.6786 GB, free: 1.535 MB / 0.5261 GB
Notification: Performance of NFTyping.typeBindings: time 0.009436/0.6351, allocations: 5.361 MB / 0.6838 GB, free: 0.9492 MB / 0.5261 GB
Notification: Performance of NFTyping.typeClassSections: time 0.01037/0.6454, allocations: 6.713 MB / 0.6903 GB, free: 0.5977 MB / 0.5261 GB
Notification: Performance of NFFlatten.flatten: time 0.02569/0.6711, allocations: 40.81 MB / 0.7302 GB, free: 4.305 MB / 0.5417 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.01328/0.6844, allocations: 9.192 MB / 0.7392 GB, free: 13.04 MB / 0.5573 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.04039/0.7248, allocations: 23.86 MB / 0.7625 GB, free: 6.453 MB / 0.573 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.01759/0.7424, allocations: 11.36 MB / 0.7736 GB, free: 11.86 MB / 0.5886 GB
Notification: Performance of NFPackage.collectConstants: time 0.005087/0.7475, allocations: 1.648 MB / 0.7752 GB, free: 10.21 MB / 0.5886 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.01145/0.7589, allocations: 3.164 MB / 0.7783 GB, free: 7.152 MB / 0.5886 GB
Notification: Performance of NFScalarize.scalarize: time 0.009662/0.7686, allocations: 12.02 MB / 0.79 GB, free: 11.55 MB / 0.6042 GB
Notification: Performance of NFVerifyModel.verify: time 0.01493/0.7835, allocations: 10.45 MB / 0.8002 GB, free: 1.504 MB / 0.6042 GB
Notification: Performance of NFConvertDAE.convert: time 0.03611/0.8196, allocations: 38.69 MB / 0.838 GB, free: 12.28 MB / 0.6511 GB
Notification: Performance of FrontEnd - DAE generated: time 5.4e-06/0.8196, allocations: 4 kB / 0.838 GB, free: 12.27 MB / 0.6511 GB
Notification: Performance of FrontEnd: time 1.523e-06/0.8196, allocations: 0 / 0.838 GB, free: 12.27 MB / 0.6511 GB
Notification: Performance of Transformations before backend: time 0.00112/0.8208, allocations: 0 / 0.838 GB, free: 12.27 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: 7366
 * Number of variables: 7366
Notification: Performance of Generate backend data structure: time 0.05462/0.8754, allocations: 30.08 MB / 0.8674 GB, free: 14.15 MB / 0.6823 GB
Notification: Performance of prepare preOptimizeDAE: time 5.224e-05/0.8754, allocations: 12.03 kB / 0.8674 GB, free: 14.14 MB / 0.6823 GB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.007736/0.8832, allocations: 3.497 MB / 0.8708 GB, free: 10.64 MB / 0.6823 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01854/0.9017, allocations: 4.717 MB / 0.8754 GB, free: 5.91 MB / 0.6823 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.221/1.123, allocations: 11.98 MB / 0.8871 GB, free: 281.8 MB / 0.6823 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0006177/1.123, allocations: 1.419 MB / 0.8885 GB, free: 281.2 MB / 0.6823 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0031/1.126, allocations: 1.968 MB / 0.8904 GB, free: 280.6 MB / 0.6823 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.0488/1.175, allocations: 53.28 MB / 0.9425 GB, free: 250.9 MB / 0.6823 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0004269/1.176, allocations: 107 kB / 0.9426 GB, free: 250.8 MB / 0.6823 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.00238/1.178, allocations: 0.834 MB / 0.9434 GB, free: 250.2 MB / 0.6823 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.00277/1.181, allocations: 3.982 MB / 0.9473 GB, free: 249.6 MB / 0.6823 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.0446/1.225, allocations: 39.3 MB / 0.9856 GB, free: 220.5 MB / 0.6823 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.1251/1.35, allocations: 104.3 MB / 1.088 GB, free: 117.4 MB / 0.6823 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.03279/1.383, allocations: 34.53 MB / 1.121 GB, free: 83.66 MB / 0.6823 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.01807/1.401, allocations: 18.03 MB / 1.139 GB, free: 65.57 MB / 0.6823 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.001778/1.403, allocations: 437.1 kB / 1.139 GB, free: 65.13 MB / 0.6823 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.02312/1.426, allocations: 25.71 MB / 1.164 GB, free: 37.7 MB / 0.6823 GB
Notification: Performance of pre-optimization done (n=2711): time 3.408e-05/1.426, allocations: 3.625 kB / 1.164 GB, free: 37.7 MB / 0.6823 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: pipeAV_VB.mediums[30].T
2: pipeAV_VB.mediums[28].T
3: pipeAV_VB.mediums[24].T
4: pipeAV_VB.mediums[23].T
5: pipeAV_VB.mediums[22].T
6: pipeAV_VB.mediums[19].T
7: pipeAV_VB.mediums[18].T
8: pipeAV_VB.mediums[16].T
9: pipeAV_VB.mediums[14].T
10: pipeAV_VB.mediums[11].T
11: pipeAV_VB.mediums[9].T
12: pipeAV_VB.mediums[8].T
13: pipeAV_VB.mediums[7].T
14: pipeAV_VB.mediums[5].T
15: pipeAV_VB.mediums[4].T
16: pipeAV_VB.mediums[3].T
17: pipeAV_VB.mediums[29].T
18: pipeAV_VB.mediums[27].T
19: pipeAV_VB.mediums[26].T
20: pipeAV_VB.mediums[25].T
21: pipeAV_VB.mediums[21].T
22: pipeAV_VB.mediums[20].T
23: pipeAV_VB.mediums[17].T
24: pipeAV_VB.mediums[15].T
25: pipeAV_VB.mediums[13].T
26: pipeAV_VB.mediums[12].T
27: pipeAV_VB.mediums[10].T
28: pipeAV_VB.mediums[6].T
29: pipeAV_VB.mediums[2].T
30: pipeAV_VB.mediums[1].T
31: pipeA_VB.mediums[30].T
32: pipeA_VB.mediums[29].T
33: pipeA_VB.mediums[28].T
34: pipeA_VB.mediums[26].T
35: pipeA_VB.mediums[25].T
36: pipeA_VB.mediums[24].T
37: pipeA_VB.mediums[21].T
38: pipeA_VB.mediums[19].T
39: pipeA_VB.mediums[18].T
40: pipeA_VB.mediums[16].T
41: pipeA_VB.mediums[14].T
42: pipeA_VB.mediums[12].T
43: pipeA_VB.mediums[10].T
44: pipeA_VB.mediums[8].T
45: pipeA_VB.mediums[6].T
46: pipeA_VB.mediums[5].T
47: pipeA_VB.mediums[4].T
48: pipeA_VB.mediums[3].T
49: pipeA_VB.mediums[2].T
50: pipeA_VB.mediums[1].T
51: pipeA_VB.mediums[27].T
52: pipeA_VB.mediums[23].T
53: pipeA_VB.mediums[22].T
54: pipeA_VB.mediums[20].T
55: pipeA_VB.mediums[17].T
56: pipeA_VB.mediums[15].T
57: pipeA_VB.mediums[13].T
58: pipeA_VB.mediums[11].T
59: pipeA_VB.mediums[9].T
60: pipeA_VB.mediums[7].T
61: pipeA_V_B.mediums[30].T
62: pipeA_V_B.mediums[29].T
63: pipeA_V_B.mediums[26].T
64: pipeA_V_B.mediums[24].T
65: pipeA_V_B.mediums[23].T
66: pipeA_V_B.mediums[22].T
67: pipeA_V_B.mediums[21].T
68: pipeA_V_B.mediums[20].T
69: pipeA_V_B.mediums[18].T
70: pipeA_V_B.mediums[17].T
71: pipeA_V_B.mediums[16].T
72: pipeA_V_B.mediums[11].T
73: pipeA_V_B.mediums[10].T
74: pipeA_V_B.mediums[9].T
75: pipeA_V_B.mediums[7].T
76: pipeA_V_B.mediums[3].T
77: pipeA_V_B.mediums[1].T
78: pipeA_V_B.mediums[28].T
79: pipeA_V_B.mediums[27].T
80: pipeA_V_B.mediums[25].T
81: pipeA_V_B.mediums[19].T
82: pipeA_V_B.mediums[15].T
83: pipeA_V_B.mediums[14].T
84: pipeA_V_B.mediums[13].T
85: pipeA_V_B.mediums[12].T
86: pipeA_V_B.mediums[8].T
87: pipeA_V_B.mediums[6].T
88: pipeA_V_B.mediums[5].T
89: pipeA_V_B.mediums[4].T
90: pipeA_V_B.mediums[2].T
91: pipeAV_B.mediums[30].T
92: pipeAV_B.mediums[29].T
93: pipeAV_B.mediums[28].T
94: pipeAV_B.mediums[25].T
95: pipeAV_B.mediums[24].T
96: pipeAV_B.mediums[19].T
97: pipeAV_B.mediums[18].T
98: pipeAV_B.mediums[17].T
99: pipeAV_B.mediums[16].T
100: pipeAV_B.mediums[14].T
101: pipeAV_B.mediums[12].T
102: pipeAV_B.mediums[11].T
103: pipeAV_B.mediums[9].T
104: pipeAV_B.mediums[8].T
105: pipeAV_B.mediums[7].T
106: pipeAV_B.mediums[4].T
107: pipeAV_B.mediums[2].T
108: pipeAV_B.mediums[27].T
109: pipeAV_B.mediums[26].T
110: pipeAV_B.mediums[23].T
111: pipeAV_B.mediums[22].T
112: pipeAV_B.mediums[21].T
113: pipeAV_B.mediums[20].T
114: pipeAV_B.mediums[15].T
115: pipeAV_B.mediums[13].T
116: pipeAV_B.mediums[10].T
117: pipeAV_B.mediums[6].T
118: pipeAV_B.mediums[5].T
119: pipeAV_B.mediums[3].T
120: pipeAV_B.mediums[1].T
Please use -d=bltdump for more information.
Notification: Performance of matching and sorting (n=3427): time 4.434/5.861, allocations: 1.424 GB / 2.589 GB, free: 229.9 MB / 0.6823 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0002862/5.861, allocations: 1.01 MB / 2.59 GB, free: 229.1 MB / 0.6823 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.01541/5.876, allocations: 15.71 MB / 2.605 GB, free: 225.3 MB / 0.6823 GB
Notification: Performance of collectPreVariables (initialization): time 0.008398/5.885, allocations: 0.6339 MB / 2.606 GB, free: 224.8 MB / 0.6823 GB
Notification: Performance of collectInitialEqns (initialization): time 0.005903/5.891, allocations: 10.11 MB / 2.616 GB, free: 218.4 MB / 0.6823 GB
Notification: Performance of collectInitialBindings (initialization): time 0.01208/5.903, allocations: 12.4 MB / 2.628 GB, free: 208.6 MB / 0.6823 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.01374/5.916, allocations: 7.222 MB / 2.635 GB, free: 205.8 MB / 0.6823 GB
Notification: Performance of setup shared object (initialization): time 4.557e-05/5.916, allocations: 304.6 kB / 2.635 GB, free: 205.5 MB / 0.6823 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.02959/5.946, allocations: 19.11 MB / 2.654 GB, free: 199.1 MB / 0.6823 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.03123/5.977, allocations: 27.83 MB / 2.681 GB, free: 183 MB / 0.6823 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.05728/6.035, allocations: 50.28 MB / 2.73 GB, free: 155.4 MB / 0.6823 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0002277/6.035, allocations: 66.25 kB / 2.73 GB, free: 155.4 MB / 0.6823 GB
Notification: Performance of matching and sorting (n=4791) (initialization): time 0.09877/6.134, allocations: 67.11 MB / 2.796 GB, free: 92.01 MB / 0.6823 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001472/6.134, allocations: 100.9 kB / 2.796 GB, free: 91.91 MB / 0.6823 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0002252/6.134, allocations: 220 kB / 2.796 GB, free: 91.7 MB / 0.6823 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.04393/6.178, allocations: 35.21 MB / 2.83 GB, free: 56.07 MB / 0.6823 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.02168/6.199, allocations: 8.57 MB / 2.839 GB, free: 47.49 MB / 0.6823 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.5011/6.701, allocations: 171.7 MB / 3.006 GB, free: 122.7 MB / 0.6824 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.02002/6.721, allocations: 1.878 MB / 3.008 GB, free: 122 MB / 0.6824 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.007856/6.728, allocations: 2.686 MB / 3.011 GB, free: 121.6 MB / 0.6824 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 1003
 * Number of states: 0 ()
 * Number of discrete variables: 1 ($whenCondition1)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (4073):
 * Single equations (assignments): 3947
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 126
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 0 systems
 * Non-linear torn systems (#iteration vars, #inner vars): 126 systems
   {(1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (29,117), (1,1), (1,4), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (29,117), (1,1), (1,4), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (30,121), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (30,121)}
Notification: Performance of prepare postOptimizeDAE: time 0.01803/6.747, allocations: 8.596 MB / 3.019 GB, free: 118 MB / 0.6824 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.00536/6.752, allocations: 2.389 MB / 3.022 GB, free: 118 MB / 0.6824 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.0912/6.843, allocations: 80.51 MB / 3.1 GB, free: 43.81 MB / 0.6824 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.0001501/6.843, allocations: 320 kB / 3.101 GB, free: 43.5 MB / 0.6824 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 4.916e-05/6.843, allocations: 4 kB / 3.101 GB, free: 43.49 MB / 0.6824 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.2878/7.131, allocations: 54.16 MB / 3.153 GB, free: 196.6 MB / 0.6824 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.1454/7.277, allocations: 95.2 MB / 3.246 GB, free: 172.3 MB / 0.6824 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 0.0001379/7.277, allocations: 7.75 kB / 3.246 GB, free: 172.3 MB / 0.6824 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.01803/7.295, allocations: 6.495 MB / 3.253 GB, free: 171.9 MB / 0.6824 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.03896/7.334, allocations: 24.73 MB / 3.277 GB, free: 165.5 MB / 0.6824 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.005975/7.34, allocations: 1.476 MB / 3.278 GB, free: 164.7 MB / 0.6824 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.3383/7.678, allocations: 171.4 MB / 3.446 GB, free: 187.7 MB / 0.6824 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 5.1e-06/7.678, allocations: 13.78 kB / 3.446 GB, free: 187.7 MB / 0.6824 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.1144/7.792, allocations: 86.92 MB / 3.531 GB, free: 169.1 MB / 0.6824 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.005759/7.798, allocations: 2.184 MB / 3.533 GB, free: 168.6 MB / 0.6824 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.008089/7.806, allocations: 0.9011 MB / 3.534 GB, free: 168 MB / 0.6824 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0137/7.82, allocations: 1.624 MB / 3.535 GB, free: 167.6 MB / 0.6824 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.006256/7.826, allocations: 2.619 MB / 3.538 GB, free: 167.3 MB / 0.6824 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.004162/7.83, allocations: 2.318 MB / 3.54 GB, free: 167 MB / 0.6824 GB
Notification: Performance of sorting global known variables: time 0.01055/7.841, allocations: 10.26 MB / 3.55 GB, free: 163.8 MB / 0.6824 GB
Notification: Performance of sort global known variables: time 1.8e-07/7.841, allocations: 0 / 3.55 GB, free: 163.8 MB / 0.6824 GB
Notification: Performance of remove unused functions: time 0.03092/7.872, allocations: 10.29 MB / 3.56 GB, free: 153.8 MB / 0.6824 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 17
 * Number of states: 240 (pipeAV_B.mediums[1].p,pipeAV_B.mediums[1].T,pipeAV_B.mediums[2].p,pipeAV_B.mediums[2].T,pipeAV_B.mediums[3].p,pipeAV_B.mediums[3].T,pipeAV_B.mediums[4].p,pipeAV_B.mediums[4].T,pipeAV_B.mediums[5].p,pipeAV_B.mediums[5].T,pipeAV_B.mediums[6].p,pipeAV_B.mediums[6].T,pipeAV_B.mediums[7].p,pipeAV_B.mediums[7].T,pipeAV_B.mediums[8].p,pipeAV_B.mediums[8].T,pipeAV_B.mediums[9].p,pipeAV_B.mediums[9].T,pipeAV_B.mediums[10].p,pipeAV_B.mediums[10].T,pipeAV_B.mediums[11].p,pipeAV_B.mediums[11].T,pipeAV_B.mediums[12].p,pipeAV_B.mediums[12].T,pipeAV_B.mediums[13].p,pipeAV_B.mediums[13].T,pipeAV_B.mediums[14].p,pipeAV_B.mediums[14].T,pipeAV_B.mediums[15].p,pipeAV_B.mediums[15].T,pipeAV_B.mediums[16].p,pipeAV_B.mediums[16].T,pipeAV_B.mediums[17].p,pipeAV_B.mediums[17].T,pipeAV_B.mediums[18].p,pipeAV_B.mediums[18].T,pipeAV_B.mediums[19].p,pipeAV_B.mediums[19].T,pipeAV_B.mediums[20].p,pipeAV_B.mediums[20].T,pipeAV_B.mediums[21].p,pipeAV_B.mediums[21].T,pipeAV_B.mediums[22].p,pipeAV_B.mediums[22].T,pipeAV_B.mediums[23].p,pipeAV_B.mediums[23].T,pipeAV_B.mediums[24].p,pipeAV_B.mediums[24].T,pipeAV_B.mediums[25].p,pipeAV_B.mediums[25].T,pipeAV_B.mediums[26].p,pipeAV_B.mediums[26].T,pipeAV_B.mediums[27].p,pipeAV_B.mediums[27].T,pipeAV_B.mediums[28].p,pipeAV_B.mediums[28].T,pipeAV_B.mediums[29].p,pipeAV_B.mediums[29].T,pipeAV_B.mediums[30].p,pipeAV_B.mediums[30].T,pipeA_V_B.mediums[1].p,pipeA_V_B.mediums[1].T,pipeA_V_B.mediums[2].p,pipeA_V_B.mediums[2].T,pipeA_V_B.mediums[3].p,pipeA_V_B.mediums[3].T,pipeA_V_B.mediums[4].p,pipeA_V_B.mediums[4].T,pipeA_V_B.mediums[5].p,pipeA_V_B.mediums[5].T,pipeA_V_B.mediums[6].p,pipeA_V_B.mediums[6].T,pipeA_V_B.mediums[7].p,pipeA_V_B.mediums[7].T,pipeA_V_B.mediums[8].p,pipeA_V_B.mediums[8].T,pipeA_V_B.mediums[9].p,pipeA_V_B.mediums[9].T,pipeA_V_B.mediums[10].p,pipeA_V_B.mediums[10].T,pipeA_V_B.mediums[11].p,pipeA_V_B.mediums[11].T,pipeA_V_B.mediums[12].p,pipeA_V_B.mediums[12].T,pipeA_V_B.mediums[13].p,pipeA_V_B.mediums[13].T,pipeA_V_B.mediums[14].p,pipeA_V_B.mediums[14].T,pipeA_V_B.mediums[15].p,pipeA_V_B.mediums[15].T,pipeA_V_B.mediums[16].p,pipeA_V_B.mediums[16].T,pipeA_V_B.mediums[17].p,pipeA_V_B.mediums[17].T,pipeA_V_B.mediums[18].p,pipeA_V_B.mediums[18].T,pipeA_V_B.mediums[19].p,pipeA_V_B.mediums[19].T,pipeA_V_B.mediums[20].p,pipeA_V_B.mediums[20].T,pipeA_V_B.mediums[21].p,pipeA_V_B.mediums[21].T,pipeA_V_B.mediums[22].p,pipeA_V_B.mediums[22].T,pipeA_V_B.mediums[23].p,pipeA_V_B.mediums[23].T,pipeA_V_B.mediums[24].p,pipeA_V_B.mediums[24].T,pipeA_V_B.mediums[25].p,pipeA_V_B.mediums[25].T,pipeA_V_B.mediums[26].p,pipeA_V_B.mediums[26].T,pipeA_V_B.mediums[27].p,pipeA_V_B.mediums[27].T,pipeA_V_B.mediums[28].p,pipeA_V_B.mediums[28].T,pipeA_V_B.mediums[29].p,pipeA_V_B.mediums[29].T,pipeA_V_B.mediums[30].p,pipeA_V_B.mediums[30].T,pipeA_VB.mediums[1].p,pipeA_VB.mediums[1].T,pipeA_VB.mediums[2].p,pipeA_VB.mediums[2].T,pipeA_VB.mediums[3].p,pipeA_VB.mediums[3].T,pipeA_VB.mediums[4].p,pipeA_VB.mediums[4].T,pipeA_VB.mediums[5].p,pipeA_VB.mediums[5].T,pipeA_VB.mediums[6].p,pipeA_VB.mediums[6].T,pipeA_VB.mediums[7].p,pipeA_VB.mediums[7].T,pipeA_VB.mediums[8].p,pipeA_VB.mediums[8].T,pipeA_VB.mediums[9].p,pipeA_VB.mediums[9].T,pipeA_VB.mediums[10].p,pipeA_VB.mediums[10].T,pipeA_VB.mediums[11].p,pipeA_VB.mediums[11].T,pipeA_VB.mediums[12].p,pipeA_VB.mediums[12].T,pipeA_VB.mediums[13].p,pipeA_VB.mediums[13].T,pipeA_VB.mediums[14].p,pipeA_VB.mediums[14].T,pipeA_VB.mediums[15].p,pipeA_VB.mediums[15].T,pipeA_VB.mediums[16].p,pipeA_VB.mediums[16].T,pipeA_VB.mediums[17].p,pipeA_VB.mediums[17].T,pipeA_VB.mediums[18].p,pipeA_VB.mediums[18].T,pipeA_VB.mediums[19].p,pipeA_VB.mediums[19].T,pipeA_VB.mediums[20].p,pipeA_VB.mediums[20].T,pipeA_VB.mediums[21].p,pipeA_VB.mediums[21].T,pipeA_VB.mediums[22].p,pipeA_VB.mediums[22].T,pipeA_VB.mediums[23].p,pipeA_VB.mediums[23].T,pipeA_VB.mediums[24].p,pipeA_VB.mediums[24].T,pipeA_VB.mediums[25].p,pipeA_VB.mediums[25].T,pipeA_VB.mediums[26].p,pipeA_VB.mediums[26].T,pipeA_VB.mediums[27].p,pipeA_VB.mediums[27].T,pipeA_VB.mediums[28].p,pipeA_VB.mediums[28].T,pipeA_VB.mediums[29].p,pipeA_VB.mediums[29].T,pipeA_VB.mediums[30].p,pipeA_VB.mediums[30].T,pipeAV_VB.mediums[1].p,pipeAV_VB.mediums[1].T,pipeAV_VB.mediums[2].p,pipeAV_VB.mediums[2].T,pipeAV_VB.mediums[3].p,pipeAV_VB.mediums[3].T,pipeAV_VB.mediums[4].p,pipeAV_VB.mediums[4].T,pipeAV_VB.mediums[5].p,pipeAV_VB.mediums[5].T,pipeAV_VB.mediums[6].p,pipeAV_VB.mediums[6].T,pipeAV_VB.mediums[7].p,pipeAV_VB.mediums[7].T,pipeAV_VB.mediums[8].p,pipeAV_VB.mediums[8].T,pipeAV_VB.mediums[9].p,pipeAV_VB.mediums[9].T,pipeAV_VB.mediums[10].p,pipeAV_VB.mediums[10].T,pipeAV_VB.mediums[11].p,pipeAV_VB.mediums[11].T,pipeAV_VB.mediums[12].p,pipeAV_VB.mediums[12].T,pipeAV_VB.mediums[13].p,pipeAV_VB.mediums[13].T,pipeAV_VB.mediums[14].p,pipeAV_VB.mediums[14].T,pipeAV_VB.mediums[15].p,pipeAV_VB.mediums[15].T,pipeAV_VB.mediums[16].p,pipeAV_VB.mediums[16].T,pipeAV_VB.mediums[17].p,pipeAV_VB.mediums[17].T,pipeAV_VB.mediums[18].p,pipeAV_VB.mediums[18].T,pipeAV_VB.mediums[19].p,pipeAV_VB.mediums[19].T,pipeAV_VB.mediums[20].p,pipeAV_VB.mediums[20].T,pipeAV_VB.mediums[21].p,pipeAV_VB.mediums[21].T,pipeAV_VB.mediums[22].p,pipeAV_VB.mediums[22].T,pipeAV_VB.mediums[23].p,pipeAV_VB.mediums[23].T,pipeAV_VB.mediums[24].p,pipeAV_VB.mediums[24].T,pipeAV_VB.mediums[25].p,pipeAV_VB.mediums[25].T,pipeAV_VB.mediums[26].p,pipeAV_VB.mediums[26].T,pipeAV_VB.mediums[27].p,pipeAV_VB.mediums[27].T,pipeAV_VB.mediums[28].p,pipeAV_VB.mediums[28].T,pipeAV_VB.mediums[29].p,pipeAV_VB.mediums[29].T,pipeAV_VB.mediums[30].p,pipeAV_VB.mediums[30].T)
 * Number of discrete variables: 1 ($whenCondition1)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (2707):
 * Single equations (assignments): 2581
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 126
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 1 system
   {(1,1,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 125 systems
   {(1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (30,121), (1,1), (1,1), (1,4), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (30,121), (1,1), (1,1), (1,4), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (29,117), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (29,117)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.1058/7.978, allocations: 89.14 MB / 3.647 GB, free: 72.8 MB / 0.6824 GB
Notification: Performance of simCode: created initialization part: time 0.2384/8.216, allocations: 53.56 MB / 3.699 GB, free: 213.5 MB / 0.6824 GB
Notification: Performance of simCode: created event and clocks part: time 2.487e-05/8.216, allocations: 26.2 kB / 3.699 GB, free: 213.5 MB / 0.6824 GB
Notification: Performance of simCode: created simulation system equations: time 0.04778/8.264, allocations: 31.03 MB / 3.73 GB, free: 209.4 MB / 0.6824 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.03341/8.297, allocations: 9.397 MB / 3.739 GB, free: 206.5 MB / 0.6824 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.7426/9.04, allocations: 365.2 MB / 4.096 GB, free: 117.7 MB / 0.6824 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.01226/9.052, allocations: 14.66 MB / 4.11 GB, free: 113.7 MB / 0.6824 GB
Notification: Performance of simCode: alias equations: time 0.02779/9.08, allocations: 16.52 MB / 4.126 GB, free: 104.5 MB / 0.6824 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0159/9.096, allocations: 12.76 MB / 4.138 GB, free: 92.77 MB / 0.6824 GB
Notification: Performance of SimCode: time 1.082e-06/9.096, allocations: 0 / 4.138 GB, free: 92.77 MB / 0.6824 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 1.666/10.76, allocations: 0.9207 GB / 5.059 GB, free: 117.7 MB / 0.6824 GB
Notification: Performance of buildModelFMU: Generate platform static: time 70.69/81.45, allocations: 1.422 kB / 5.059 GB, free: 117.7 MB / 0.6824 GB
"
[Timeout remaining time 578]
(rm -f ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipeEnergyConservationCheck2.pipe ; mkfifo ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipeEnergyConservationCheck2.pipe ; head -c 1048576 < ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipeEnergyConservationCheck2.pipe >> ../files/ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipeEnergyConservationCheck2.sim & python3 -m fmpy simulate  --output-file ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipeEnergyConservationCheck2_res.csv --start-time 0 --stop-time 500 --timeout 50 --relative-tolerance 1e-06 --interface-type ModelExchange --solver CVode --output-interval 0.09996 ModelicaTest_trunk_ModelicaTest_Fluid_TestComponents_Pipes_DynamicPipeEnergyConservationCheck2.fmu > ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipeEnergyConservationCheck2.pipe 2>&1) [Timeout 52.5]
diffSimulationResults("ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipeEnergyConservationCheck2_res.csv","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/Reference-modelica.org/ReferenceResults/MAP-LIB_ReferenceResults/v4.1.0/ModelicaTest/Fluid/TestComponents/Pipes/DynamicPipeEnergyConservationCheck2/DynamicPipeEnergyConservationCheck2.csv","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipeEnergyConservationCheck2.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001) [Timeout 660]
"Error: Could not read variable Time in file ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipeEnergyConservationCheck2_res.csv.
Warning: Get data of variable Time from file ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipeEnergyConservationCheck2_res.csv failed!
Error: Could not read variable total_AV_B_a in file ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipeEnergyConservationCheck2_res.csv.
Warning: Get data of variable total_AV_B_a from file ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipeEnergyConservationCheck2_res.csv failed!
Error: Could not read variable total_AV_B_b in file ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipeEnergyConservationCheck2_res.csv.
Warning: Get data of variable total_AV_B_b from file ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipeEnergyConservationCheck2_res.csv failed!
Error: Could not read variable total_A_VB_a in file ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipeEnergyConservationCheck2_res.csv.
Warning: Get data of variable total_A_VB_a from file ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipeEnergyConservationCheck2_res.csv failed!
Error: Could not read variable total_A_VB_b in file ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipeEnergyConservationCheck2_res.csv.
Warning: Get data of variable total_A_VB_b from file ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipeEnergyConservationCheck2_res.csv failed!
Error: Could not read variable total_AV_VB_a in file ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipeEnergyConservationCheck2_res.csv.
Warning: Get data of variable total_AV_VB_a from file ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipeEnergyConservationCheck2_res.csv failed!
Error: Could not read variable total_AV_VB_b in file ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipeEnergyConservationCheck2_res.csv.
Warning: Get data of variable total_AV_VB_b from file ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipeEnergyConservationCheck2_res.csv failed!
Error: Could not read variable total_A_V_B_a in file ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipeEnergyConservationCheck2_res.csv.
Warning: Get data of variable total_A_V_B_a from file ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipeEnergyConservationCheck2_res.csv failed!
Error: Could not read variable total_A_V_B_b in file ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipeEnergyConservationCheck2_res.csv.
Warning: Get data of variable total_A_V_B_b from file ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipeEnergyConservationCheck2_res.csv failed!
"
[Timeout remaining time 660]
Reference file matches
[Calling sys.exit(0), Time elapsed: 87.38729595579207]