Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr Chemical_Chemical.Examples.AcidBase.AcidBaseBufferTest.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Chemical 1.4.0-master/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 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo", uses=false)
Using package ModelicaServices with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo)
Using package Modelica with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+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 Chemical with version 1.4.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Chemical 1.4.0-master/package.mo)
Running command: "" <> buildModelFMU(Chemical.Examples.AcidBase.AcidBaseBufferTest,fileNamePrefix="Chemical_Chemical_Examples_AcidBase_AcidBaseBufferTest",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(Chemical.Examples.AcidBase.AcidBaseBufferTest,fileNamePrefix="Chemical_Chemical_Examples_AcidBase_AcidBaseBufferTest",fmuType="me",version="2.0",platforms={"static"})
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Chemical 1.4.0-master/package.mo): time 0.07512/0.07512, allocations: 15.26 MB / 22.74 MB, free: 0.9727 MB / 18.57 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.0008579/0.0008579, allocations: 188.9 kB / 27.52 MB, free: 6.133 MB / 24.77 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.204/1.204, allocations: 221.5 MB / 253.7 MB, free: 10.41 MB / 202.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.0008405/0.0008404, allocations: 94.64 kB / 308.8 MB, free: 10.48 MB / 250.7 MB
Notification: Performance of FrontEnd - loaded program: time 1.327e-05/1.335e-05, allocations: 0 / 369.7 MB, free: 53.95 MB / 298.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.07156/0.07159, allocations: 54.64 MB / 424.3 MB, free: 13.79 MB / 298.7 MB
Notification: Performance of FrontEnd - scodeFlatten: time 0.2996/0.3712, allocations: 100.2 MB / 0.5122 GB, free: 12.34 MB / 362.7 MB
Notification: Performance of FrontEnd - mkProgramGraph: time 0.0001519/0.3714, allocations: 69.39 kB / 0.5122 GB, free: 12.34 MB / 362.7 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Chemical 1.4.0-master/package.mo:3011:6-3011:65:writable] Warning: No corresponding 'inner' declaration found for component .Modelica.Fluid.System buffer.system declared as 'outer '.
  The existing 'inner' components are:
    There are no 'inner' components defined in the model in any of the parent scopes of 'outer' component's scope: Chemical.Sources.Buffer$buffer.
  Check if you have not misspelled the 'outer' component name.
  Please declare an 'inner' component with the same name in the top scope.
  Continuing flattening by only considering the 'outer' component declaration.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Chemical 1.4.0-master/package.mo:4721:7-4721:66:writable] Warning: No corresponding 'inner' declaration found for component .Modelica.Fluid.System simpleSolution.system declared as 'outer '.
  The existing 'inner' components are:
    There are no 'inner' components defined in the model in any of the parent scopes of 'outer' component's scope: Chemical.Components.Solution.
  Check if you have not misspelled the 'outer' component name.
  Please declare an 'inner' component with the same name in the top scope.
  Continuing flattening by only considering the 'outer' component declaration.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Chemical 1.4.0-master/package.mo:3011:6-3011:65:writable] Warning: No corresponding 'inner' declaration found for component .Modelica.Fluid.System externalMoleFraction.system declared as 'outer '.
  The existing 'inner' components are:
    There are no 'inner' components defined in the model in any of the parent scopes of 'outer' component's scope: Chemical.Sources.ExternalMoleFraction$externalMoleFraction.
  Check if you have not misspelled the 'outer' component name.
  Please declare an 'inner' component with the same name in the top scope.
  Continuing flattening by only considering the 'outer' component declaration.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Chemical 1.4.0-master/package.mo:2321:8-2321:67:writable] Warning: No corresponding 'inner' declaration found for component .Modelica.Fluid.System externalMoleFraction.system declared as 'outer '.
  The existing 'inner' components are:
    There are no 'inner' components defined in the model in any of the parent scopes of 'outer' component's scope: Chemical.Sources.ExternalMoleFraction$externalMoleFraction.
  Check if you have not misspelled the 'outer' component name.
  Please declare an 'inner' component with the same name in the top scope.
  Continuing flattening by only considering the 'outer' component declaration.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Chemical 1.4.0-master/package.mo:3011:6-3011:65:writable] Warning: No corresponding 'inner' declaration found for component .Modelica.Fluid.System liquidWater.system declared as 'outer '.
  The existing 'inner' components are:
    There are no 'inner' components defined in the model in any of the parent scopes of 'outer' component's scope: Chemical.Components.Substance$liquidWater.
  Check if you have not misspelled the 'outer' component name.
  Please declare an 'inner' component with the same name in the top scope.
  Continuing flattening by only considering the 'outer' component declaration.
Notification: Performance of FrontEnd - DAE generated: time 0.06382/0.4353, allocations: 31.47 MB / 0.543 GB, free: 21.19 MB / 378.7 MB
Notification: Performance of FrontEnd: time 1.222e-06/0.4353, allocations: 0 / 0.543 GB, free: 21.19 MB / 378.7 MB
Notification: Performance of Transformations before backend: time 3.947e-05/0.4353, allocations: 15.5 kB / 0.543 GB, free: 21.19 MB / 378.7 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 168
 * Number of variables: 168
Notification: Performance of Generate backend data structure: time 0.001694/0.437, allocations: 1.087 MB / 0.544 GB, free: 20.41 MB / 378.7 MB
Notification: Performance of prepare preOptimizeDAE: time 3.375e-05/0.4371, allocations: 15.73 kB / 0.5441 GB, free: 20.4 MB / 378.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0007299/0.4378, allocations: 234.9 kB / 0.5443 GB, free: 20.3 MB / 378.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.0008437/0.4387, allocations: 0.6023 MB / 0.5449 GB, free: 19.92 MB / 378.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 1.972e-05/0.4387, allocations: 23.09 kB / 0.5449 GB, free: 19.92 MB / 378.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001057/0.4388, allocations: 42.91 kB / 0.5449 GB, free: 19.92 MB / 378.7 MB
Notification: Performance of preOpt removeEqualFunctionCalls (simulation): time 0.001574/0.4404, allocations: 1.795 MB / 0.5467 GB, free: 19.71 MB / 378.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.001008/0.4414, allocations: 0.9653 MB / 0.5476 GB, free: 19.5 MB / 378.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 1.46e-05/0.4414, allocations: 4 kB / 0.5476 GB, free: 19.5 MB / 378.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 4.429e-05/0.4415, allocations: 0 / 0.5476 GB, free: 19.5 MB / 378.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 9.798e-06/0.4415, allocations: 15.41 kB / 0.5476 GB, free: 19.5 MB / 378.7 MB
Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.00403/0.4455, allocations: 3.495 MB / 0.5511 GB, free: 18.15 MB / 378.7 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.001291/0.4468, allocations: 1.281 MB / 0.5523 GB, free: 17.9 MB / 378.7 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.000416/0.4473, allocations: 0.5034 MB / 0.5528 GB, free: 17.85 MB / 378.7 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.0001589/0.4474, allocations: 168.4 kB / 0.553 GB, free: 17.82 MB / 378.7 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 2.064e-05/0.4474, allocations: 41.94 kB / 0.553 GB, free: 17.78 MB / 378.7 MB
Notification: Performance of pre-optimization done (n=66): time 1.783e-06/0.4475, allocations: 0 / 0.553 GB, free: 17.78 MB / 378.7 MB
Notification: Performance of matching and sorting (n=88): time 0.01747/0.4649, allocations: 4.798 MB / 0.5577 GB, free: 16.14 MB / 378.7 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 4.244e-05/0.465, allocations: 63.92 kB / 0.5577 GB, free: 16.07 MB / 378.7 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0006188/0.4656, allocations: 0.6794 MB / 0.5584 GB, free: 15.68 MB / 378.7 MB
Notification: Performance of collectPreVariables (initialization): time 5.668e-05/0.4657, allocations: 25.7 kB / 0.5584 GB, free: 15.65 MB / 378.7 MB
Notification: Performance of collectInitialEqns (initialization): time 0.0001602/0.4659, allocations: 370.8 kB / 0.5588 GB, free: 15.32 MB / 378.7 MB
Notification: Performance of collectInitialBindings (initialization): time 0.0001534/0.466, allocations: 282.7 kB / 0.5591 GB, free: 15.07 MB / 378.7 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 4.578e-05/0.4661, allocations: 4 kB / 0.5591 GB, free: 15.07 MB / 378.7 MB
Notification: Performance of setup shared object (initialization): time 0.0001406/0.4662, allocations: 386.1 kB / 0.5594 GB, free: 14.7 MB / 378.7 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0007172/0.4669, allocations: 0.6726 MB / 0.5601 GB, free: 14.36 MB / 378.7 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.000757/0.4677, allocations: 0.7751 MB / 0.5608 GB, free: 13.91 MB / 378.7 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.001821/0.4695, allocations: 0.929 MB / 0.5617 GB, free: 13.38 MB / 378.7 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 3.697e-06/0.4696, allocations: 3.75 kB / 0.5618 GB, free: 13.38 MB / 378.7 MB
Notification: Performance of matching and sorting (n=113) (initialization): time 0.005129/0.4747, allocations: 2.12 MB / 0.5638 GB, free: 11.76 MB / 378.7 MB
Notification: Performance of prepare postOptimizeDAE: time 1.789e-05/0.4747, allocations: 5.875 kB / 0.5638 GB, free: 11.75 MB / 378.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.17e-05/0.4747, allocations: 4 kB / 0.5638 GB, free: 11.75 MB / 378.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.002247/0.477, allocations: 314.2 kB / 0.5641 GB, free: 11.43 MB / 378.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0007806/0.4778, allocations: 203.7 kB / 0.5643 GB, free: 11.23 MB / 378.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.004753/0.4825, allocations: 3.686 MB / 0.5679 GB, free: 7.281 MB / 378.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0008/0.4834, allocations: 55.77 kB / 0.568 GB, free: 7.227 MB / 378.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 9.839e-05/0.4835, allocations: 43.97 kB / 0.568 GB, free: 7.184 MB / 378.7 MB
Warning: Iteration variables with default zero start attribute in torn nonlinear equation system:
         buffer.solution.I:VARIABLE(flow=false min = 0.0 max = 0.0 unit = "1" )  "Mole fraction based ionic strength of the solution" type: Real
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 10
 * Number of states: 0 ()
 * Number of discrete variables: 0 ()
 * Number of discrete states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (103):
 * Single equations (assignments): 98
 * Array equations: 2
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 3
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 1 {(1,100.0%) 2}
 * Non-linear torn systems: 2 {1 4,1 2}
Notification: Performance of prepare postOptimizeDAE: time 0.0001965/0.4837, allocations: 116.9 kB / 0.5681 GB, free: 7.062 MB / 378.7 MB
Notification: Performance of postOpt createAliasVarsForOutputStates (simulation): time 0.006027/0.4897, allocations: 1.855 MB / 0.5699 GB, free: 5.191 MB / 378.7 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0001603/0.4899, allocations: 79.05 kB / 0.57 GB, free: 5.113 MB / 378.7 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.006236/0.4961, allocations: 1.936 MB / 0.5719 GB, free: 3.152 MB / 378.7 MB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.005633/0.5018, allocations: 1.745 MB / 0.5736 GB, free: 1.395 MB / 378.7 MB
Notification: Performance of postOpt constantLinearSystem (simulation): time 7.113e-06/0.5018, allocations: 3.984 kB / 0.5736 GB, free: 1.391 MB / 378.7 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 1.077e-05/0.5018, allocations: 3.984 kB / 0.5736 GB, free: 1.387 MB / 378.7 MB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.007861/0.5097, allocations: 3.568 MB / 0.5771 GB, free: 13.71 MB / 394.7 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 9.588e-06/0.5097, allocations: 4 kB / 0.5771 GB, free: 13.71 MB / 394.7 MB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0005759/0.5103, allocations: 159.7 kB / 0.5773 GB, free: 13.55 MB / 394.7 MB
Notification: Performance of postOpt tearingSystem (simulation): time 0.00362/0.5139, allocations: 0.4944 MB / 0.5777 GB, free: 13.05 MB / 394.7 MB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 5.475e-05/0.514, allocations: 15.98 kB / 0.5778 GB, free: 13.03 MB / 394.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.005906/0.5199, allocations: 4.351 MB / 0.582 GB, free: 8.43 MB / 394.7 MB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 0.004314/0.5242, allocations: 2.014 MB / 0.584 GB, free: 6.285 MB / 394.7 MB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.006221/0.5305, allocations: 2.834 MB / 0.5867 GB, free: 3.246 MB / 394.7 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.0002569/0.5307, allocations: 168.1 kB / 0.5869 GB, free: 3.062 MB / 394.7 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001125/0.5309, allocations: 12.14 kB / 0.5869 GB, free: 3.051 MB / 394.7 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0005138/0.5314, allocations: 27.97 kB / 0.5869 GB, free: 3.023 MB / 394.7 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.000124/0.5315, allocations: 88.48 kB / 0.587 GB, free: 2.938 MB / 394.7 MB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 5.47e-05/0.5316, allocations: 39.98 kB / 0.5871 GB, free: 2.898 MB / 394.7 MB
Notification: Performance of sorting global known variables: time 0.0005678/0.5321, allocations: 0.538 MB / 0.5876 GB, free: 2.359 MB / 394.7 MB
Notification: Performance of sort global known variables: time 1.61e-07/0.5321, allocations: 0 / 0.5876 GB, free: 2.359 MB / 394.7 MB
Notification: Performance of remove unused functions: time 0.001273/0.5334, allocations: 0.4996 MB / 0.5881 GB, free: 1.859 MB / 394.7 MB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 21
 * Number of states: 3 ($STATESET1.x[2],$STATESET1.x[1],simpleSolution.mass)
 * Number of discrete variables: 0 ()
 * Number of discrete states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (87):
 * Single equations (assignments): 84
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 3
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 1 {(1,100.0%) 2}
 * Non-linear torn systems: 2 {1 4,3 5}
Notification: Performance of Backend phase and start with SimCode phase: time 0.007484/0.5409, allocations: 5.215 MB / 0.5932 GB, free: 12.51 MB / 410.7 MB
Notification: Performance of simCode: created initialization part: time 0.001922/0.5429, allocations: 1.577 MB / 0.5947 GB, free: 10.91 MB / 410.7 MB
Notification: Performance of simCode: created event and clocks part: time 2.725e-06/0.5429, allocations: 4.062 kB / 0.5947 GB, free: 10.91 MB / 410.7 MB
Notification: Performance of simCode: created simulation system equations: time 0.001053/0.5439, allocations: 0.8663 MB / 0.5956 GB, free: 10.02 MB / 410.7 MB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.001087/0.545, allocations: 254.8 kB / 0.5958 GB, free: 9.773 MB / 410.7 MB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.002782/0.5478, allocations: 1.787 MB / 0.5975 GB, free: 7.875 MB / 410.7 MB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0005001/0.5483, allocations: 0.9953 MB / 0.5985 GB, free: 6.852 MB / 410.7 MB
Notification: Performance of simCode: alias equations: time 0.0005422/0.5489, allocations: 146.1 kB / 0.5987 GB, free: 6.707 MB / 410.7 MB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0004342/0.5493, allocations: 351.3 kB / 0.599 GB, free: 6.363 MB / 410.7 MB
Notification: Performance of SimCode: time 6.61e-07/0.5493, allocations: 0 / 0.599 GB, free: 6.363 MB / 410.7 MB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.04645/0.5958, allocations: 27.21 MB / 0.6256 GB, free: 11.27 MB / 442.7 MB
Notification: Performance of buildModelFMU: configured platform static using cached values: time 0.0001642/0.596, allocations: 139.1 kB / 0.6257 GB, free: 11.06 MB / 442.7 MB
Notification: Performance of buildModelFMU: Generate platform static: time 2.488/3.084, allocations: 0 / 0.6257 GB, free: 11.06 MB / 442.7 MB
(rm -f Chemical_Chemical.Examples.AcidBase.AcidBaseBufferTest.pipe ; mkfifo Chemical_Chemical.Examples.AcidBase.AcidBaseBufferTest.pipe ; head -c 1048576 < Chemical_Chemical.Examples.AcidBase.AcidBaseBufferTest.pipe >> ../files/Chemical_Chemical.Examples.AcidBase.AcidBaseBufferTest.sim & /home/hudson/saved_omc/OMSimulator/install/linux/bin/OMSimulator  --tempDir=temp_Chemical_Chemical_Examples_AcidBase_AcidBaseBufferTest_fmu --startTime=0 --stopTime=0.05 --timeout=50 --tolerance=1e-06 Chemical_Chemical_Examples_AcidBase_AcidBaseBufferTest.fmu > Chemical_Chemical.Examples.AcidBase.AcidBaseBufferTest.pipe 2>&1)