Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipeEnergyConservationCheck.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.001498/0.001498, allocations: 84.86 kB / 21.5 MB, free: 2.988 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.001166/0.001166, allocations: 161 kB / 24.91 MB, free: 9.184 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.9371/0.9371, allocations: 177 MB / 205.2 MB, free: 5.449 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.2437/0.2437, allocations: 34.86 MB / 296.6 MB, free: 0.5117 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: translateModel(ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipeEnergyConservationCheck,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5002,variableFilter="time|pipeAV_B2.state_a.h|pipeAV_B2.state_b.h|pipeAV_B3.state_a.h|pipeAV_B3.state_b.h|pipeAV_B4.state_a.h|pipeAV_B4.state_b.h|pipeA_VB2.state_a.h|pipeA_VB2.state_b.h|pipeA_VB3.state_a.h|pipeA_VB3.state_b.h|pipeA_VB4.state_a.h|pipeA_VB4.state_b.h|pipeAV_VB2.state_a.h|pipeAV_VB2.state_b.h|pipeAV_VB3.state_a.h|pipeAV_VB3.state_b.h|pipeAV_VB4.state_a.h|pipeAV_VB4.state_b.h|pipeA_V_B2.state_a.h|pipeA_V_B2.state_b.h|pipeA_V_B3.state_a.h|pipeA_V_B3.state_b.h|pipeA_V_B4.state_a.h|pipeA_V_B4.state_b.h",fileNamePrefix="ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipeEnergyConservationCheck")
translateModel(ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipeEnergyConservationCheck,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5002,variableFilter="time|pipeAV_B2.state_a.h|pipeAV_B2.state_b.h|pipeAV_B3.state_a.h|pipeAV_B3.state_b.h|pipeAV_B4.state_a.h|pipeAV_B4.state_b.h|pipeA_VB2.state_a.h|pipeA_VB2.state_b.h|pipeA_VB3.state_a.h|pipeA_VB3.state_b.h|pipeA_VB4.state_a.h|pipeA_VB4.state_b.h|pipeAV_VB2.state_a.h|pipeAV_VB2.state_b.h|pipeAV_VB3.state_a.h|pipeAV_VB3.state_b.h|pipeAV_VB4.state_a.h|pipeAV_VB4.state_b.h|pipeA_V_B2.state_a.h|pipeA_V_B2.state_b.h|pipeA_V_B3.state_a.h|pipeA_V_B3.state_b.h|pipeA_V_B4.state_a.h|pipeA_V_B4.state_b.h",fileNamePrefix="ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipeEnergyConservationCheck") [Timeout 660]
"Notification: Performance of FrontEnd - loaded program: time 1.393e-06/1.393e-06, allocations: 0 / 325.9 MB, free: 7.164 MB / 298.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 1.352e-05/1.491e-05, allocations: 4.141 kB / 325.9 MB, free: 7.16 MB / 298.7 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipeEnergyConservationCheck): time 0.03674/0.03676, allocations: 61.41 MB / 387.3 MB, free: 9.535 MB / 362.7 MB
Notification: Performance of NFInst.instExpressions: time 0.04362/0.08038, allocations: 36.31 MB / 423.6 MB, free: 5.137 MB / 394.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.007739/0.08812, allocations: 424.1 kB / 424.1 MB, free: 4.719 MB / 394.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.003963/0.09208, allocations: 2.441 MB / 426.5 MB, free: 2.262 MB / 394.7 MB
Notification: Performance of NFTyping.typeBindings: time 0.02268/0.1148, allocations: 13.03 MB / 439.5 MB, free: 5.164 MB / 410.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.2135/0.3283, allocations: 19.87 MB / 459.4 MB, free: 32.76 MB / 410.7 MB
Notification: Performance of NFFlatten.flatten: time 0.03152/0.3598, allocations: 34.5 MB / 493.9 MB, free: 26.82 MB / 410.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.01188/0.3717, allocations: 7.29 MB / 0.4894 GB, free: 24.2 MB / 410.7 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/Media/Water/IF97_Utilities.mo:900:9-900:73:writable] Warning: Output parameter bpro.cv was not assigned a value
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/Media/Water/IF97_Utilities.mo:937:9-937:73:writable] Warning: Output parameter bpro.cv was not assigned a value
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/Media/Water/IF97_Utilities.mo:900:9-900:73:writable] Warning: Output parameter bpro.cv was not assigned a value
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/Media/Water/IF97_Utilities.mo:937:9-937:73:writable] Warning: Output parameter bpro.cv was not assigned a value
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/Media/Water/IF97_Utilities.mo:900:9-900:73:writable] Warning: Output parameter bpro.cv was not assigned a value
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/Media/Water/IF97_Utilities.mo:937:9-937:73:writable] Warning: Output parameter bpro.cv was not assigned a value
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/Media/Water/IF97_Utilities.mo:900:9-900:73:writable] Warning: Output parameter bpro.cv was not assigned a value
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/Media/Water/IF97_Utilities.mo:937:9-937:73:writable] Warning: Output parameter bpro.cv was not assigned a value
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/Media/Water/IF97_Utilities.mo:900:9-900:73:writable] Warning: Output parameter bpro.cv was not assigned a value
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/Media/Water/IF97_Utilities.mo:937:9-937:73:writable] Warning: Output parameter bpro.cv was not assigned a value
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/Media/Water/IF97_Utilities.mo:900:9-900:73:writable] Warning: Output parameter bpro.cv was not assigned a value
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/Media/Water/IF97_Utilities.mo:937:9-937:73:writable] Warning: Output parameter bpro.cv was not assigned a value
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/Media/Water/IF97_Utilities.mo:900:9-900:73:writable] Warning: Output parameter bpro.cv was not assigned a value
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/Media/Water/IF97_Utilities.mo:937:9-937:73:writable] Warning: Output parameter bpro.cv was not assigned a value
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/Media/Water/IF97_Utilities.mo:900:9-900:73:writable] Warning: Output parameter bpro.cv was not assigned a value
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/Media/Water/IF97_Utilities.mo:937:9-937:73:writable] Warning: Output parameter bpro.cv was not assigned a value
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/Media/Water/IF97_Utilities.mo:900:9-900:73:writable] Warning: Output parameter bpro.cv was not assigned a value
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/Media/Water/IF97_Utilities.mo:937:9-937:73:writable] Warning: Output parameter bpro.cv was not assigned a value
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/Media/Water/IF97_Utilities.mo:900:9-900:73:writable] Warning: Output parameter bpro.cv was not assigned a value
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/Media/Water/IF97_Utilities.mo:937:9-937:73:writable] Warning: Output parameter bpro.cv was not assigned a value
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/Media/Water/IF97_Utilities.mo:900:9-900:73:writable] Warning: Output parameter bpro.cv was not assigned a value
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/Media/Water/IF97_Utilities.mo:937:9-937:73:writable] Warning: Output parameter bpro.cv was not assigned a value
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/Media/Water/IF97_Utilities.mo:900:9-900:73:writable] Warning: Output parameter bpro.cv was not assigned a value
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/Media/Water/IF97_Utilities.mo:937:9-937:73:writable] Warning: Output parameter bpro.cv was not assigned a value
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/Media/Water/IF97_Utilities.mo:900:9-900:73:writable] Warning: Output parameter bpro.cv was not assigned a value
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/Media/Water/IF97_Utilities.mo:937:9-937:73:writable] Warning: Output parameter bpro.cv was not assigned a value
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/Media/Water/IF97_Utilities.mo:900:9-900:73:writable] Warning: Output parameter bpro.cv was not assigned a value
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/Media/Water/IF97_Utilities.mo:937:9-937:73:writable] Warning: Output parameter bpro.cv was not assigned a value
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/Media/Water/IF97_Utilities.mo:900:9-900:73:writable] Warning: Output parameter bpro.cv was not assigned a value
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/Media/Water/IF97_Utilities.mo:937:9-937:73:writable] Warning: Output parameter bpro.cv was not assigned a value
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/Media/Water/IF97_Utilities.mo:900:9-900:73:writable] Warning: Output parameter bpro.cv was not assigned a value
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/Media/Water/IF97_Utilities.mo:937:9-937:73:writable] Warning: Output parameter bpro.cv was not assigned a value
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/Media/Water/IF97_Utilities.mo:900:9-900:73:writable] Warning: Output parameter bpro.cv was not assigned a value
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/Media/Water/IF97_Utilities.mo:937:9-937:73:writable] Warning: Output parameter bpro.cv was not assigned a value
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/Media/Water/IF97_Utilities.mo:900:9-900:73:writable] Warning: Output parameter bpro.cv was not assigned a value
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/Media/Water/IF97_Utilities.mo:937:9-937:73:writable] Warning: Output parameter bpro.cv was not assigned a value
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/Media/Water/IF97_Utilities.mo:900:9-900:73:writable] Warning: Output parameter bpro.cv was not assigned a value
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/Media/Water/IF97_Utilities.mo:937:9-937:73:writable] Warning: Output parameter bpro.cv was not assigned a value
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/Media/Water/IF97_Utilities.mo:900:9-900:73:writable] Warning: Output parameter bpro.cv was not assigned a value
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/Media/Water/IF97_Utilities.mo:937:9-937:73:writable] Warning: Output parameter bpro.cv was not assigned a value
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/Media/Water/IF97_Utilities.mo:900:9-900:73:writable] Warning: Output parameter bpro.cv was not assigned a value
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/Media/Water/IF97_Utilities.mo:937:9-937:73:writable] Warning: Output parameter bpro.cv was not assigned a value
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/Media/Water/IF97_Utilities.mo:900:9-900:73:writable] Warning: Output parameter bpro.cv was not assigned a value
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/Media/Water/IF97_Utilities.mo:937:9-937:73:writable] Warning: Output parameter bpro.cv was not assigned a value
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/Media/Water/IF97_Utilities.mo:900:9-900:73:writable] Warning: Output parameter bpro.cv was not assigned a value
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/Media/Water/IF97_Utilities.mo:937:9-937:73:writable] Warning: Output parameter bpro.cv was not assigned a value
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/Media/Water/IF97_Utilities.mo:900:9-900:73:writable] Warning: Output parameter bpro.cv was not assigned a value
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/Media/Water/IF97_Utilities.mo:937:9-937:73:writable] Warning: Output parameter bpro.cv was not assigned a value
Notification: Performance of NFEvalConstants.evaluate: time 0.5431/0.9148, allocations: 244.3 MB / 0.728 GB, free: 66.32 MB / 0.5105 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.03622/0.951, allocations: 28.64 MB / 0.756 GB, free: 39.12 MB / 0.5105 GB
Notification: Performance of NFPackage.collectConstants: time 0.004546/0.9555, allocations: 1.145 MB / 0.7571 GB, free: 37.97 MB / 0.5105 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.01649/0.972, allocations: 7.88 MB / 0.7648 GB, free: 30.2 MB / 0.5105 GB
Notification: Performance of NFScalarize.scalarize: time 0.008484/0.9805, allocations: 6.1 MB / 0.7708 GB, free: 25.07 MB / 0.5105 GB
Notification: Performance of NFVerifyModel.verify: time 0.01478/0.9953, allocations: 5.977 MB / 0.7766 GB, free: 19.9 MB / 0.5105 GB
Notification: Performance of NFConvertDAE.convert: time 0.03115/1.026, allocations: 19.13 MB / 0.7953 GB, free: 2.625 MB / 0.5105 GB
Notification: Performance of FrontEnd - DAE generated: time 7.264e-06/1.026, allocations: 8 kB / 0.7953 GB, free: 2.617 MB / 0.5105 GB
Notification: Performance of FrontEnd: time 1.382e-06/1.026, allocations: 0 / 0.7953 GB, free: 2.617 MB / 0.5105 GB
Notification: Performance of Transformations before backend: time 0.0008316/1.027, allocations: 2.844 kB / 0.7953 GB, free: 2.617 MB / 0.5105 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 3720
 * Number of variables: 3720
Notification: Performance of Generate backend data structure: time 0.02808/1.055, allocations: 16.04 MB / 0.811 GB, free: 3.625 MB / 0.5261 GB
Notification: Performance of prepare preOptimizeDAE: time 3.967e-05/1.055, allocations: 12.62 kB / 0.811 GB, free: 3.613 MB / 0.5261 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.3126/1.368, allocations: 7.215 MB / 0.818 GB, free: 205 MB / 0.5262 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.01148/1.379, allocations: 5.713 MB / 0.8236 GB, free: 204.6 MB / 0.5262 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.001135/1.381, allocations: 1.19 MB / 0.8248 GB, free: 204.6 MB / 0.5262 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.003383/1.384, allocations: 1.233 MB / 0.826 GB, free: 204.6 MB / 0.5262 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.0353/1.419, allocations: 20.4 MB / 0.8459 GB, free: 195.3 MB / 0.5262 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0002965/1.42, allocations: 57.19 kB / 0.8459 GB, free: 195.3 MB / 0.5262 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.002328/1.422, allocations: 0.547 MB / 0.8465 GB, free: 195.1 MB / 0.5262 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.001003/1.423, allocations: 1.519 MB / 0.848 GB, free: 193.8 MB / 0.5262 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.01774/1.441, allocations: 9.854 MB / 0.8576 GB, free: 184.4 MB / 0.5262 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.06414/1.505, allocations: 57.1 MB / 0.9133 GB, free: 128.5 MB / 0.5262 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.014/1.519, allocations: 9.978 MB / 0.9231 GB, free: 118.6 MB / 0.5262 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.003513/1.522, allocations: 1.62 MB / 0.9247 GB, free: 116.9 MB / 0.5262 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.07362/1.596, allocations: 48.09 MB / 0.9716 GB, free: 69.43 MB / 0.5262 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0001678/1.596, allocations: 170.4 kB / 0.9718 GB, free: 69.25 MB / 0.5262 GB
Notification: Performance of pre-optimization done (n=798): time 9.959e-06/1.596, allocations: 0 / 0.9718 GB, free: 69.25 MB / 0.5262 GB
Notification: Performance of matching and sorting (n=798): time 0.03718/1.633, allocations: 19.73 MB / 0.9911 GB, free: 50.21 MB / 0.5262 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001882/1.633, allocations: 1.339 MB / 0.9924 GB, free: 48.57 MB / 0.5262 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.005427/1.639, allocations: 5.497 MB / 0.9977 GB, free: 44.44 MB / 0.5262 GB
Notification: Performance of collectPreVariables (initialization): time 0.001866/1.641, allocations: 165.7 kB / 0.9979 GB, free: 44.27 MB / 0.5262 GB
Notification: Performance of collectInitialEqns (initialization): time 0.002651/1.643, allocations: 5.706 MB / 1.003 GB, free: 39.09 MB / 0.5262 GB
Notification: Performance of collectInitialBindings (initialization): time 0.003114/1.646, allocations: 2.804 MB / 1.006 GB, free: 36.46 MB / 0.5262 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.002821/1.649, allocations: 2.18 MB / 1.008 GB, free: 34.54 MB / 0.5262 GB
Notification: Performance of setup shared object (initialization): time 3.092e-05/1.649, allocations: 305.1 kB / 1.009 GB, free: 34.24 MB / 0.5262 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.002275/1.652, allocations: 1.931 MB / 1.011 GB, free: 32.3 MB / 0.5262 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.00319/1.655, allocations: 6.849 MB / 1.017 GB, free: 23.54 MB / 0.5262 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.007702/1.662, allocations: 9.337 MB / 1.026 GB, free: 12.49 MB / 0.5262 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0001406/1.663, allocations: 40 kB / 1.026 GB, free: 12.45 MB / 0.5262 GB
Notification: Performance of matching and sorting (n=1500) (initialization): time 0.01582/1.678, allocations: 8.856 MB / 1.035 GB, free: 3.559 MB / 0.5262 GB
Notification: Performance of prepare postOptimizeDAE: time 8.833e-05/1.679, allocations: 68.19 kB / 1.035 GB, free: 3.492 MB / 0.5262 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001345/1.679, allocations: 148 kB / 1.035 GB, free: 3.348 MB / 0.5262 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.006245/1.685, allocations: 3.212 MB / 1.038 GB, free: 132 kB / 0.5262 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.2029/1.888, allocations: 2.594 MB / 1.041 GB, free: 173.8 MB / 0.5262 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.005829/1.894, allocations: 9.279 MB / 1.05 GB, free: 167.5 MB / 0.5262 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.008366/1.902, allocations: 1.372 MB / 1.051 GB, free: 167.5 MB / 0.5262 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.002102/1.904, allocations: 493.9 kB / 1.052 GB, free: 167.5 MB / 0.5262 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 648
 * Number of states: 0 ()
 * Number of discrete variables: 96 (pipeAV_B4.state_a.phase,boundary1.state.phase,pipeAV_B2.state_a.phase,boundary3.state.phase,pipeAV_B3.state_a.phase,boundary5.state.phase,pipeA_VB4.state_b.phase,boundary7.state.phase,pipeA_VB2.state_b.phase,boundary9.state.phase,pipeA_VB3.state_b.phase,boundary11.state.phase,pipeAV_VB4.state_a.phase,pipeAV_VB4.state_b.phase,boundary13.state.phase,pipeAV_VB2.state_a.phase,pipeAV_VB2.state_b.phase,boundary15.state.phase,pipeAV_VB3.state_a.phase,pipeAV_VB3.state_b.phase,boundary17.state.phase,boundary19.state.phase,boundary21.state.phase,boundary23.state.phase,pipeAV_B4.state_b.phase,boundary1.medium.phase,boundary.medium.phase,pipeAV_B4.statesFM[4].phase,pipeAV_B4.statesFM[3].phase,pipeAV_B4.statesFM[2].phase,pipeAV_B4.statesFM[1].phase,pipeAV_B2.state_b.phase,boundary3.medium.phase,boundary2.medium.phase,pipeAV_B2.statesFM[2].phase,pipeAV_B2.statesFM[1].phase,pipeAV_B3.state_b.phase,boundary5.medium.phase,boundary4.medium.phase,pipeAV_B3.statesFM[3].phase,pipeAV_B3.statesFM[2].phase,pipeAV_B3.statesFM[1].phase,pipeA_VB4.state_a.phase,boundary7.medium.phase,boundary6.medium.phase,pipeA_VB4.statesFM[5].phase,pipeA_VB4.statesFM[4].phase,pipeA_VB4.statesFM[3].phase,pipeA_VB4.statesFM[2].phase,pipeA_VB2.state_a.phase,boundary9.medium.phase,boundary8.medium.phase,pipeA_VB2.statesFM[3].phase,pipeA_VB2.statesFM[2].phase,pipeA_VB3.state_a.phase,boundary11.medium.phase,boundary10.medium.phase,pipeA_VB3.statesFM[4].phase,pipeA_VB3.statesFM[3].phase,pipeA_VB3.statesFM[2].phase,boundary13.medium.phase,boundary12.medium.phase,pipeAV_VB4.statesFM[4].phase,pipeAV_VB4.statesFM[3].phase,pipeAV_VB4.statesFM[2].phase,pipeAV_VB4.statesFM[1].phase,boundary15.medium.phase,boundary14.medium.phase,pipeAV_VB2.statesFM[2].phase,pipeAV_VB2.statesFM[1].phase,boundary17.medium.phase,boundary16.medium.phase,pipeAV_VB3.statesFM[3].phase,pipeAV_VB3.statesFM[2].phase,pipeAV_VB3.statesFM[1].phase,pipeA_V_B4.state_a.phase,pipeA_V_B4.state_b.phase,boundary19.medium.phase,boundary18.medium.phase,pipeA_V_B4.statesFM[5].phase,pipeA_V_B4.statesFM[4].phase,pipeA_V_B4.statesFM[3].phase,pipeA_V_B4.statesFM[2].phase,pipeA_V_B2.state_a.phase,pipeA_V_B2.state_b.phase,boundary21.medium.phase,boundary20.medium.phase,pipeA_V_B2.statesFM[3].phase,pipeA_V_B2.statesFM[2].phase,pipeA_V_B3.state_a.phase,pipeA_V_B3.state_b.phase,boundary23.medium.phase,boundary22.medium.phase,pipeA_V_B3.statesFM[4].phase,pipeA_V_B3.statesFM[3].phase,pipeA_V_B3.statesFM[2].phase)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (1284):
 * Single equations (assignments): 1272
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 12
 * 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): 12 systems
   {(4,21), (2,11), (3,16), (4,21), (2,11), (3,16), (4,21), (2,11), (3,16), (4,21), (2,11), (3,16)}
Notification: Performance of prepare postOptimizeDAE: time 0.005577/1.91, allocations: 0.9675 MB / 1.053 GB, free: 167.4 MB / 0.5262 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.002317/1.912, allocations: 0.8174 MB / 1.053 GB, free: 167.4 MB / 0.5262 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.02103/1.933, allocations: 20.35 MB / 1.073 GB, free: 164.4 MB / 0.5262 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.0003326/1.933, allocations: 0.5128 MB / 1.074 GB, free: 164.4 MB / 0.5262 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 6.954e-05/1.933, allocations: 7.469 kB / 1.074 GB, free: 164.4 MB / 0.5262 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.01352/1.947, allocations: 13.62 MB / 1.087 GB, free: 156.9 MB / 0.5262 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.05114/1.998, allocations: 31.31 MB / 1.118 GB, free: 134.4 MB / 0.5262 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 7.569e-05/1.998, allocations: 36 kB / 1.118 GB, free: 134.4 MB / 0.5262 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.002634/2.001, allocations: 1.082 MB / 1.119 GB, free: 133.6 MB / 0.5262 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.007183/2.008, allocations: 6.114 MB / 1.125 GB, free: 128.9 MB / 0.5262 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.001518/2.01, allocations: 221.2 kB / 1.125 GB, free: 128.7 MB / 0.5262 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.00731/2.017, allocations: 11.37 MB / 1.136 GB, free: 117.9 MB / 0.5262 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.048e-05/2.017, allocations: 59.38 kB / 1.136 GB, free: 117.9 MB / 0.5262 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.0173/2.034, allocations: 17.15 MB / 1.153 GB, free: 100.4 MB / 0.5262 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.003403/2.038, allocations: 1.788 MB / 1.155 GB, free: 99.05 MB / 0.5262 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.003051/2.041, allocations: 493 kB / 1.155 GB, free: 98.67 MB / 0.5262 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.01091/2.052, allocations: 0.4895 MB / 1.156 GB, free: 98.19 MB / 0.5262 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.005719/2.057, allocations: 0.9659 MB / 1.157 GB, free: 97.25 MB / 0.5262 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.001147/2.058, allocations: 263.8 kB / 1.157 GB, free: 97 MB / 0.5262 GB
Notification: Performance of sorting global known variables: time 0.01079/2.069, allocations: 3.619 MB / 1.16 GB, free: 93.82 MB / 0.5262 GB
Notification: Performance of sort global known variables: time 2.1e-07/2.069, allocations: 0 / 1.16 GB, free: 93.82 MB / 0.5262 GB
Notification: Performance of remove unused functions: time 0.03143/2.101, allocations: 5.404 MB / 1.166 GB, free: 88.77 MB / 0.5262 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 174
 * Number of states: 0 ()
 * Number of discrete variables: 300 ($cse187.region3boundary,$cse188.region3boundary,$cse189.phase,$cse189.region,$cse190.region3boundary,$cse191.region3boundary,$cse192.phase,$cse192.region,$cse193.region3boundary,$cse194.region3boundary,$cse195.phase,$cse195.region,$cse196.phase,$cse196.region,$cse197.phase,$cse197.region,$cse198.region3boundary,$cse199.region3boundary,$cse200.phase,$cse200.region,$cse203.phase,$cse203.region,pipeA_V_B3.statesFM[2].phase,pipeA_V_B3.statesFM[3].phase,pipeA_V_B3.statesFM[4].phase,boundary22.medium.phase,boundary23.medium.phase,$cse172.region3boundary,$cse173.region3boundary,$cse174.phase,$cse174.region,$cse175.region3boundary,$cse176.region3boundary,$cse177.phase,$cse177.region,$cse178.phase,$cse178.region,$cse179.phase,$cse179.region,$cse180.region3boundary,$cse181.region3boundary,$cse182.phase,$cse182.region,$cse185.phase,$cse185.region,pipeA_V_B2.statesFM[2].phase,pipeA_V_B2.statesFM[3].phase,boundary20.medium.phase,boundary21.medium.phase,$cse151.region3boundary,$cse152.region3boundary,$cse153.phase,$cse153.region,$cse154.region3boundary,$cse155.region3boundary,$cse156.phase,$cse156.region,$cse157.region3boundary,$cse158.region3boundary,$cse159.phase,$cse159.region,$cse160.region3boundary,$cse161.region3boundary,$cse162.phase,$cse162.region,$cse163.phase,$cse163.region,$cse164.phase,$cse164.region,$cse165.region3boundary,$cse166.region3boundary,$cse167.phase,$cse167.region,$cse170.phase,$cse170.region,pipeA_V_B4.statesFM[2].phase,pipeA_V_B4.statesFM[3].phase,pipeA_V_B4.statesFM[4].phase,pipeA_V_B4.statesFM[5].phase,boundary18.medium.phase,boundary19.medium.phase,$cse137.region3boundary,$cse138.region3boundary,$cse139.phase,$cse139.region,$cse140.region3boundary,$cse141.region3boundary,$cse142.phase,$cse142.region,$cse145.phase,$cse145.region,$cse146.phase,$cse146.region,$cse147.phase,$cse147.region,$cse148.phase,$cse148.region,$cse149.phase,$cse149.region,pipeAV_VB3.statesFM[1].phase,pipeAV_VB3.statesFM[2].phase,pipeAV_VB3.statesFM[3].phase,boundary16.medium.phase,boundary17.medium.phase,$cse126.region3boundary,$cse127.region3boundary,$cse128.phase,$cse128.region,$cse131.phase,$cse131.region,$cse132.phase,$cse132.region,$cse133.phase,$cse133.region,$cse134.phase,$cse134.region,$cse135.phase,$cse135.region,pipeAV_VB2.statesFM[1].phase,pipeAV_VB2.statesFM[2].phase,boundary14.medium.phase,boundary15.medium.phase,$cse109.region3boundary,$cse110.region3boundary,$cse111.phase,$cse111.region,$cse112.region3boundary,$cse113.region3boundary,$cse114.phase,$cse114.region,$cse115.region3boundary,$cse116.region3boundary,$cse117.phase,$cse117.region,$cse120.phase,$cse120.region,$cse121.phase,$cse121.region,$cse122.phase,$cse122.region,$cse123.phase,$cse123.region,$cse124.phase,$cse124.region,pipeAV_VB4.statesFM[1].phase,pipeAV_VB4.statesFM[2].phase,pipeAV_VB4.statesFM[3].phase,pipeAV_VB4.statesFM[4].phase,boundary12.medium.phase,boundary13.medium.phase,$cse93.region3boundary,$cse94.region3boundary,$cse95.phase,$cse95.region,$cse96.region3boundary,$cse97.region3boundary,$cse98.phase,$cse98.region,$cse101.phase,$cse101.region,$cse102.phase,$cse102.region,$cse103.phase,$cse103.region,$cse104.region3boundary,$cse105.region3boundary,$cse106.phase,$cse106.region,$cse107.phase,$cse107.region,pipeA_VB3.statesFM[2].phase,pipeA_VB3.statesFM[3].phase,pipeA_VB3.statesFM[4].phase,boundary10.medium.phase,boundary11.medium.phase,$cse80.region3boundary,$cse81.region3boundary,$cse82.phase,$cse82.region,$cse85.phase,$cse85.region,$cse86.phase,$cse86.region,$cse87.phase,$cse87.region,$cse88.region3boundary,$cse89.region3boundary,$cse90.phase,$cse90.region,$cse91.phase,$cse91.region,pipeA_VB2.statesFM[2].phase,pipeA_VB2.statesFM[3].phase,boundary8.medium.phase,boundary9.medium.phase,$cse61.region3boundary,$cse62.region3boundary,$cse63.phase,$cse63.region,$cse64.region3boundary,$cse65.region3boundary,$cse66.phase,$cse66.region,$cse67.region3boundary,$cse68.region3boundary,$cse69.phase,$cse69.region,$cse72.phase,$cse72.region,$cse73.phase,$cse73.region,$cse74.phase,$cse74.region,$cse75.region3boundary,$cse76.region3boundary,$cse77.phase,$cse77.region,$cse78.phase,$cse78.region,pipeA_VB4.statesFM[2].phase,pipeA_VB4.statesFM[3].phase,pipeA_VB4.statesFM[4].phase,pipeA_VB4.statesFM[5].phase,boundary6.medium.phase,boundary7.medium.phase,$cse45.region3boundary,$cse46.region3boundary,$cse47.phase,$cse47.region,$cse48.region3boundary,$cse49.region3boundary,$cse50.phase,$cse50.region,$cse51.region3boundary,$cse52.region3boundary,$cse53.phase,$cse53.region,$cse54.phase,$cse54.region,$cse55.phase,$cse55.region,$cse56.phase,$cse56.region,$cse59.phase,$cse59.region,pipeAV_B3.statesFM[1].phase,pipeAV_B3.statesFM[2].phase,pipeAV_B3.statesFM[3].phase,boundary4.medium.phase,boundary5.medium.phase,$cse32.region3boundary,$cse33.region3boundary,$cse34.phase,$cse34.region,$cse35.region3boundary,$cse36.region3boundary,$cse37.phase,$cse37.region,$cse38.phase,$cse38.region,$cse39.phase,$cse39.region,$cse40.phase,$cse40.region,$cse43.phase,$cse43.region,pipeAV_B2.statesFM[1].phase,pipeAV_B2.statesFM[2].phase,boundary2.medium.phase,boundary3.medium.phase,$cse13.region3boundary,$cse14.region3boundary,$cse15.phase,$cse15.region,$cse16.region3boundary,$cse17.region3boundary,$cse18.phase,$cse18.region,$cse19.region3boundary,$cse20.region3boundary,$cse21.phase,$cse21.region,$cse22.region3boundary,$cse23.region3boundary,$cse24.phase,$cse24.region,$cse25.phase,$cse25.region,$cse26.phase,$cse26.region,$cse27.phase,$cse27.region,$cse30.phase,$cse30.region,pipeAV_B4.statesFM[1].phase,pipeAV_B4.statesFM[2].phase,pipeAV_B4.statesFM[3].phase,pipeAV_B4.statesFM[4].phase,boundary.medium.phase,boundary1.medium.phase)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (702):
 * Single equations (assignments): 570
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 120
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 12
 * 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): 12 systems
   {(3,19), (2,13), (4,25), (3,19), (2,13), (4,25), (3,19), (2,13), (4,25), (3,19), (2,13), (4,25)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.01094/2.112, allocations: 1.792 MB / 1.167 GB, free: 87.2 MB / 0.5262 GB
Notification: Performance of simCode: created initialization part: time 0.01275/2.124, allocations: 7.681 MB / 1.175 GB, free: 80.23 MB / 0.5262 GB
Notification: Performance of simCode: created event and clocks part: time 0.0004442/2.125, allocations: 171.2 kB / 1.175 GB, free: 80.05 MB / 0.5262 GB
Notification: Performance of simCode: created simulation system equations: time 0.007034/2.132, allocations: 4.574 MB / 1.18 GB, free: 75.91 MB / 0.5262 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.02072/2.153, allocations: 4.855 MB / 1.184 GB, free: 71.22 MB / 0.5262 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.04692/2.199, allocations: 35.37 MB / 1.219 GB, free: 35.5 MB / 0.5262 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.006811/2.206, allocations: 4.193 MB / 1.223 GB, free: 31.29 MB / 0.5262 GB
Notification: Performance of simCode: alias equations: time 0.007493/2.214, allocations: 4.086 MB / 1.227 GB, free: 27.22 MB / 0.5262 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.008345/2.222, allocations: 3.297 MB / 1.23 GB, free: 23.88 MB / 0.5262 GB
Notification: Performance of SimCode: time 1.623e-06/2.222, allocations: 0 / 1.23 GB, free: 23.88 MB / 0.5262 GB
Notification: Performance of Templates: time 0.5736/2.796, allocations: 262.6 MB / 1.487 GB, free: 137.4 MB / 0.5262 GB
"
[Timeout remaining time 657]
make -j1 -f ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipeEnergyConservationCheck.makefile [Timeout 660]
(rm -f ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipeEnergyConservationCheck.pipe ; mkfifo ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipeEnergyConservationCheck.pipe ; head -c 1048576 < ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipeEnergyConservationCheck.pipe >> ../files/ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipeEnergyConservationCheck.sim & ./ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipeEnergyConservationCheck -abortSlowSimulation -alarm=240  -emit_protected -lv LOG_STATS > ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipeEnergyConservationCheck.pipe 2>&1) [Timeout 240]
diffSimulationResults("ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Pipes.DynamicPipeEnergyConservationCheck_res.mat","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/Reference-modelica.org/ReferenceResults/MAP-LIB_ReferenceResults/v4.1.0/ModelicaTest/Fluid/TestComponents/Pipes/DynamicPipeEnergyConservationCheck/DynamicPipeEnergyConservationCheck.csv","",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001) [Timeout 660]
""
[Timeout remaining time 660]
Reference file matches
[Calling sys.exit(0), Time elapsed: 12.486899411771446]