Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr Modelica_3.2.2_Modelica.Media.Examples.Tests.MediaTestModels.Water.WaterIF97_ph.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo", uses=false)
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.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo)
Using package ModelicaServices with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo)
Running command: translateModel(Modelica.Media.Examples.Tests.MediaTestModels.Water.WaterIF97_ph,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Modelica_3.2.2_Modelica.Media.Examples.Tests.MediaTestModels.Water.WaterIF97_ph")
translateModel(Modelica.Media.Examples.Tests.MediaTestModels.Water.WaterIF97_ph,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Modelica_3.2.2_Modelica.Media.Examples.Tests.MediaTestModels.Water.WaterIF97_ph")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.0009362/0.0009363, allocations: 89.67 kB / 16.65 MB, free: 6.59 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001112/0.001112, allocations: 182.5 kB / 17.56 MB, free: 6.203 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 1.484/1.484, allocations: 205.4 MB / 223.7 MB, free: 13.08 MB / 190.1 MB
Notification: Modelica requested package Complex of version 3.2.3. Complex 4.0.0 is used instead which states that it is fully compatible without conversion script needed.
Notification: Modelica requested package ModelicaServices of version 3.2.3. ModelicaServices 4.0.0 is used instead which states that it is fully compatible without conversion script needed.
Notification: Performance of FrontEnd - loaded program: time 0.000416/0.0004161, allocations: 16 kB / 280.8 MB, free: 3.402 MB / 222.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.08845/0.08887, allocations: 47.58 MB / 328.3 MB, free: 3.746 MB / 270.1 MB
Notification: Performance of NFInst.instantiate(Modelica.Media.Examples.Tests.MediaTestModels.Water.WaterIF97_ph): time 0.03318/0.1221, allocations: 32.49 MB / 360.8 MB, free: 3.133 MB / 302.1 MB
Notification: Performance of NFInst.instExpressions: time 0.01815/0.1403, allocations: 16.42 MB / 377.2 MB, free: 2.672 MB / 318.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0005253/0.1409, allocations: 0 / 377.2 MB, free: 2.672 MB / 318.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.0007879/0.1417, allocations: 238.8 kB / 377.5 MB, free: 2.438 MB / 318.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.0007942/0.1425, allocations: 346.2 kB / 377.8 MB, free: 2.098 MB / 318.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.1901/0.3325, allocations: 4.666 MB / 382.5 MB, free: 12.02 MB / 318.1 MB
Notification: Performance of NFFlatten.flatten: time 0.002276/0.3348, allocations: 1.437 MB / 383.9 MB, free: 12.02 MB / 318.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.0002468/0.3351, allocations: 85.73 kB / 384 MB, free: 12.01 MB / 318.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.005067/0.3402, allocations: 2.125 MB / 386.1 MB, free: 11.57 MB / 318.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.0005511/0.3407, allocations: 311.5 kB / 386.4 MB, free: 11.57 MB / 318.1 MB
Notification: Performance of NFPackage.collectConstants: time 4.855e-05/0.3408, allocations: 18.09 kB / 386.4 MB, free: 11.57 MB / 318.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.01407/0.3549, allocations: 6.003 MB / 392.5 MB, free: 11.55 MB / 318.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.0003456/0.3553, allocations: 89.08 kB / 392.5 MB, free: 11.55 MB / 318.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.000747/0.356, allocations: 228 kB / 392.8 MB, free: 11.52 MB / 318.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.01092/0.367, allocations: 3.753 MB / 396.5 MB, free: 10.9 MB / 318.1 MB
Notification: Performance of FrontEnd - DAE generated: time 5.3e-06/0.367, allocations: 0 / 396.5 MB, free: 10.9 MB / 318.1 MB
Notification: Performance of FrontEnd: time 2.435e-06/0.367, allocations: 4 kB / 396.5 MB, free: 10.9 MB / 318.1 MB
Notification: Performance of Transformations before backend: time 7.424e-06/0.367, allocations: 0 / 396.5 MB, free: 10.9 MB / 318.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 78
 * Number of variables: 78
Notification: Performance of Generate backend data structure: time 0.003465/0.3705, allocations: 0.9513 MB / 397.5 MB, free: 10.22 MB / 318.1 MB
Notification: Performance of prepare preOptimizeDAE: time 4.998e-05/0.3706, allocations: 13.34 kB / 397.5 MB, free: 10.22 MB / 318.1 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.00136/0.3719, allocations: 162.7 kB / 397.6 MB, free: 10.16 MB / 318.1 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.000355/0.3723, allocations: 316.4 kB / 398 MB, free: 9.906 MB / 318.1 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 4.108e-05/0.3724, allocations: 28.47 kB / 398 MB, free: 9.906 MB / 318.1 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 5.253e-05/0.3724, allocations: 31.69 kB / 398 MB, free: 9.906 MB / 318.1 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.001361/0.3738, allocations: 0.5729 MB / 398.6 MB, free: 9.668 MB / 318.1 MB
Notification: Performance of preOpt findStateOrder (simulation): time 2.018e-05/0.3738, allocations: 2.906 kB / 398.6 MB, free: 9.668 MB / 318.1 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 4.525e-05/0.3739, allocations: 18.83 kB / 398.6 MB, free: 9.664 MB / 318.1 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 1.194e-05/0.3739, allocations: 9.719 kB / 398.6 MB, free: 9.664 MB / 318.1 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.001436/0.3753, allocations: 0.5314 MB / 399.1 MB, free: 9.539 MB / 318.1 MB
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.002598/0.3779, allocations: 2.628 MB / 401.8 MB, free: 7.324 MB / 318.1 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.001462/0.3794, allocations: 479.4 kB / 402.2 MB, free: 7.199 MB / 318.1 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0003919/0.3798, allocations: 176.5 kB / 402.4 MB, free: 7.168 MB / 318.1 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.0006573/0.3805, allocations: 0.5639 MB / 403 MB, free: 6.637 MB / 318.1 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 2.385e-05/0.3805, allocations: 42.52 kB / 403 MB, free: 6.594 MB / 318.1 MB
Notification: Performance of pre-optimization done (n=30): time 2.064e-06/0.3805, allocations: 0 / 403 MB, free: 6.594 MB / 318.1 MB
Notification: Performance of matching and sorting (n=34): time 0.004516/0.3851, allocations: 1.6 MB / 404.6 MB, free: 5.926 MB / 318.1 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 2.623e-05/0.3851, allocations: 59.06 kB / 404.7 MB, free: 5.859 MB / 318.1 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0002136/0.3853, allocations: 253.4 kB / 404.9 MB, free: 5.719 MB / 318.1 MB
Notification: Performance of collectPreVariables (initialization): time 2.96e-05/0.3854, allocations: 36.52 kB / 405 MB, free: 5.688 MB / 318.1 MB
Notification: Performance of collectInitialEqns (initialization): time 8.011e-05/0.3854, allocations: 181.8 kB / 405.1 MB, free: 5.551 MB / 318.1 MB
Notification: Performance of collectInitialBindings (initialization): time 6.189e-05/0.3855, allocations: 115.9 kB / 405.3 MB, free: 5.469 MB / 318.1 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 5.115e-05/0.3856, allocations: 40.77 kB / 405.3 MB, free: 5.449 MB / 318.1 MB
Notification: Performance of setup shared object (initialization): time 5.769e-05/0.3856, allocations: 335.4 kB / 405.6 MB, free: 5.129 MB / 318.1 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0003783/0.386, allocations: 152 kB / 405.8 MB, free: 5.098 MB / 318.1 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.000401/0.3864, allocations: 254.8 kB / 406 MB, free: 4.961 MB / 318.1 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.0007554/0.3872, allocations: 414.1 kB / 406.4 MB, free: 4.816 MB / 318.1 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.664e-06/0.3872, allocations: 0 / 406.4 MB, free: 4.816 MB / 318.1 MB
Notification: Performance of matching and sorting (n=47) (initialization): time 0.001173/0.3884, allocations: 0.5384 MB / 407 MB, free: 4.668 MB / 318.1 MB
Notification: Performance of prepare postOptimizeDAE: time 2.668e-05/0.3884, allocations: 6.75 kB / 407 MB, free: 4.668 MB / 318.1 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.11e-05/0.3884, allocations: 3.344 kB / 407 MB, free: 4.668 MB / 318.1 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0005339/0.389, allocations: 121.6 kB / 407.1 MB, free: 4.617 MB / 318.1 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0003503/0.3893, allocations: 89.73 kB / 407.2 MB, free: 4.605 MB / 318.1 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.001433/0.3908, allocations: 2.422 MB / 409.6 MB, free: 2.258 MB / 318.1 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0003748/0.3912, allocations: 56.66 kB / 409.7 MB, free: 2.238 MB / 318.1 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 3.238e-05/0.3912, allocations: 16.31 kB / 409.7 MB, free: 2.238 MB / 318.1 MB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 13
 * Number of states: 0 ()
 * Number of discrete variables: 3 (fixedMassFlowRate.medium.phase,volume.medium.phase,ambient.medium.phase)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (44):
 * Single equations (assignments): 41
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 3
 * 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): 3 systems
   {(1,1), (1,1), (1,1)}
Notification: Performance of prepare postOptimizeDAE: time 0.0002189/0.3914, allocations: 169 kB / 409.8 MB, free: 2.117 MB / 318.1 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 6.378e-05/0.3915, allocations: 25.06 kB / 409.9 MB, free: 2.105 MB / 318.1 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.001812/0.3933, allocations: 1.371 MB / 411.2 MB, free: 1.781 MB / 318.1 MB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.569e-05/0.3933, allocations: 21.69 kB / 411.3 MB, free: 1.77 MB / 318.1 MB
Notification: Performance of postOpt constantLinearSystem (simulation): time 2.014e-06/0.3934, allocations: 0 / 411.3 MB, free: 1.77 MB / 318.1 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.001532/0.3949, allocations: 1.461 MB / 412.7 MB, free: 1.137 MB / 318.1 MB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.002453/0.3974, allocations: 2.144 MB / 414.9 MB, free: 432 kB / 318.1 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 5.651e-06/0.3974, allocations: 0 / 414.9 MB, free: 432 kB / 318.1 MB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.000401/0.3978, allocations: 103 kB / 415 MB, free: 408 kB / 318.1 MB
Notification: Performance of postOpt tearingSystem (simulation): time 0.0003754/0.3982, allocations: 77.41 kB / 415 MB, free: 376 kB / 318.1 MB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 2.685e-05/0.3982, allocations: 8.531 kB / 415 MB, free: 376 kB / 318.1 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.0003903/0.3986, allocations: 0.5934 MB / 415.6 MB, free: 15.84 MB / 334.1 MB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 6.342e-06/0.3986, allocations: 7.922 kB / 415.6 MB, free: 15.83 MB / 334.1 MB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.001969/0.4006, allocations: 1.313 MB / 417 MB, free: 15.5 MB / 334.1 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.0001967/0.4008, allocations: 165.1 kB / 417.1 MB, free: 15.35 MB / 334.1 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 4.795e-05/0.4009, allocations: 4.062 kB / 417.1 MB, free: 15.35 MB / 334.1 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0003216/0.4012, allocations: 44.44 kB / 417.2 MB, free: 15.34 MB / 334.1 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 8.42e-05/0.4013, allocations: 46.88 kB / 417.2 MB, free: 15.31 MB / 334.1 MB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 2.965e-05/0.4013, allocations: 13.31 kB / 417.2 MB, free: 15.31 MB / 334.1 MB
Notification: Performance of sorting global known variables: time 0.0002878/0.4016, allocations: 233.5 kB / 417.4 MB, free: 15.12 MB / 334.1 MB
Notification: Performance of sort global known variables: time 3.71e-07/0.4016, allocations: 0 / 417.4 MB, free: 15.12 MB / 334.1 MB
Notification: Performance of remove unused functions: time 0.004156/0.4058, allocations: 0.8567 MB / 418.3 MB, free: 14.29 MB / 334.1 MB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 1
 * Number of states: 2 (volume.medium.p,volume.medium.h)
 * Number of discrete variables: 11 ($cse1.phase,$cse1.region,$cse4.phase,$cse4.region,$cse5.region3boundary,$cse6.region3boundary,$cse7.phase,$cse7.region,volume.medium.phase,fixedMassFlowRate.medium.phase,ambient.medium.phase)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (38):
 * Single equations (assignments): 32
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 5
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 1
 * 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): 1 system
   {(1,1)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.004084/0.4099, allocations: 0.9788 MB / 419.3 MB, free: 13.41 MB / 334.1 MB
Notification: Performance of simCode: created initialization part: time 0.001654/0.4116, allocations: 0.6667 MB / 420 MB, free: 12.84 MB / 334.1 MB
Notification: Performance of simCode: created event and clocks part: time 5.149e-06/0.4116, allocations: 0 / 420 MB, free: 12.84 MB / 334.1 MB
Notification: Performance of simCode: created simulation system equations: time 0.0006727/0.4123, allocations: 429.2 kB / 420.4 MB, free: 12.43 MB / 334.1 MB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.001295/0.4136, allocations: 184.8 kB / 420.6 MB, free: 12.25 MB / 334.1 MB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.002169/0.4158, allocations: 1.582 MB / 422.1 MB, free: 10.66 MB / 334.1 MB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0004189/0.4162, allocations: 0.8688 MB / 423 MB, free: 9.766 MB / 334.1 MB
Notification: Performance of simCode: alias equations: time 0.0003587/0.4166, allocations: 145.5 kB / 423.1 MB, free: 9.633 MB / 334.1 MB
Notification: Performance of simCode: all other stuff during SimCode phase: time 8.691e-05/0.4166, allocations: 39.44 kB / 423.2 MB, free: 9.594 MB / 334.1 MB
Notification: Performance of SimCode: time 8.52e-07/0.4167, allocations: 0 / 423.2 MB, free: 9.594 MB / 334.1 MB
Notification: Performance of Templates: time 0.05082/0.4675, allocations: 35.24 MB / 458.4 MB, free: 6.43 MB / 366.1 MB
make -j1 -f Modelica_3.2.2_Modelica.Media.Examples.Tests.MediaTestModels.Water.WaterIF97_ph.makefile
(rm -f Modelica_3.2.2_Modelica.Media.Examples.Tests.MediaTestModels.Water.WaterIF97_ph.pipe ; mkfifo Modelica_3.2.2_Modelica.Media.Examples.Tests.MediaTestModels.Water.WaterIF97_ph.pipe ; head -c 1048576 < Modelica_3.2.2_Modelica.Media.Examples.Tests.MediaTestModels.Water.WaterIF97_ph.pipe >> ../files/Modelica_3.2.2_Modelica.Media.Examples.Tests.MediaTestModels.Water.WaterIF97_ph.sim & ./Modelica_3.2.2_Modelica.Media.Examples.Tests.MediaTestModels.Water.WaterIF97_ph  -abortSlowSimulation -alarm=480 -lv LOG_STATS > Modelica_3.2.2_Modelica.Media.Examples.Tests.MediaTestModels.Water.WaterIF97_ph.pipe 2>&1)