Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr Chemical_Chemical.Examples.CheckSubstancesData.SimpleReaction2.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: translateModel(Chemical.Examples.CheckSubstancesData.SimpleReaction2,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Chemical_Chemical.Examples.CheckSubstancesData.SimpleReaction2")
translateModel(Chemical.Examples.CheckSubstancesData.SimpleReaction2,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Chemical_Chemical.Examples.CheckSubstancesData.SimpleReaction2")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Chemical 1.4.0-master/package.mo): time 0.08741/0.08741, allocations: 15.26 MB / 31.21 MB, free: 3.23 MB / 24.77 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.0008339/0.0008343, allocations: 178.7 kB / 36.29 MB, free: 2.266 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.448/1.448, allocations: 223.3 MB / 264.5 MB, free: 5.746 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.0008515/0.0008518, allocations: 94.27 kB / 319.9 MB, free: 2.738 MB / 250.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0004168/0.000417, allocations: 15.52 kB / 385.2 MB, free: 50.72 MB / 298.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1095/0.11, allocations: 54.64 MB / 439.8 MB, free: 15.97 MB / 314.7 MB
Notification: Performance of FrontEnd - scodeFlatten: time 0.42/0.53, allocations: 94.96 MB / 0.5223 GB, free: 15.62 MB / 378.7 MB
Notification: Performance of FrontEnd - mkProgramGraph: time 0.0002238/0.5303, allocations: 69.94 kB / 0.5223 GB, free: 15.62 MB / 378.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 A.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.PureSubstance.
  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:1535:7-1535:66:writable] Warning: No corresponding 'inner' declaration found for component .Modelica.Fluid.System reaction.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.Sensors.DissociationCoefficient$reaction.
  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 B.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.PureSubstance.
  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 C.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.PureSubstance$C.
  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.04993/0.5802, allocations: 19.39 MB / 0.5413 GB, free: 30.14 MB / 394.7 MB
Notification: Performance of FrontEnd: time 2.114e-06/0.5803, allocations: 0 / 0.5413 GB, free: 30.14 MB / 394.7 MB
Notification: Performance of Transformations before backend: time 7.578e-05/0.5804, allocations: 19.38 kB / 0.5413 GB, free: 30.14 MB / 394.7 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 76
 * Number of variables: 76
Notification: Performance of Generate backend data structure: time 0.001945/0.5823, allocations: 0.888 MB / 0.5422 GB, free: 29.5 MB / 394.7 MB
Notification: Performance of prepare preOptimizeDAE: time 4.609e-05/0.5824, allocations: 12.44 kB / 0.5422 GB, free: 29.5 MB / 394.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0008706/0.5832, allocations: 206.5 kB / 0.5424 GB, free: 29.46 MB / 394.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.0008621/0.5841, allocations: 0.5228 MB / 0.5429 GB, free: 29.17 MB / 394.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 2.308e-05/0.5842, allocations: 23.75 kB / 0.5429 GB, free: 29.17 MB / 394.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 6.784e-05/0.5842, allocations: 27.25 kB / 0.5429 GB, free: 29.17 MB / 394.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.001058/0.5853, allocations: 0.977 MB / 0.5439 GB, free: 29.05 MB / 394.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 1.751e-05/0.5853, allocations: 3.938 kB / 0.5439 GB, free: 29.04 MB / 394.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 3.995e-05/0.5854, allocations: 14.59 kB / 0.5439 GB, free: 29.04 MB / 394.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 9.257e-06/0.5854, allocations: 7.75 kB / 0.5439 GB, free: 29.04 MB / 394.7 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.001552/0.5869, allocations: 1.657 MB / 0.5455 GB, free: 29.03 MB / 394.7 MB
Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.003651/0.5906, allocations: 3.007 MB / 0.5485 GB, free: 28 MB / 394.7 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.0001044/0.5907, allocations: 69.41 kB / 0.5485 GB, free: 27.97 MB / 394.7 MB
Notification: Performance of preOpt resolveLoops (simulation): time 4.904e-05/0.5908, allocations: 29.36 kB / 0.5485 GB, free: 27.96 MB / 394.7 MB
Notification: Performance of preOpt evalFunc (simulation): time 2.314e-05/0.5908, allocations: 1.828 kB / 0.5485 GB, free: 27.96 MB / 394.7 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 2.142e-05/0.5908, allocations: 30.56 kB / 0.5486 GB, free: 27.92 MB / 394.7 MB
Notification: Performance of pre-optimization done (n=5): time 2.605e-06/0.5909, allocations: 3.938 kB / 0.5486 GB, free: 27.92 MB / 394.7 MB
Notification: Performance of matching and sorting (n=5): time 0.0003579/0.5912, allocations: 170.4 kB / 0.5487 GB, free: 27.85 MB / 394.7 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 4.074e-05/0.5913, allocations: 51.41 kB / 0.5488 GB, free: 27.79 MB / 394.7 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001805/0.5931, allocations: 1.815 MB / 0.5506 GB, free: 27.64 MB / 394.7 MB
Notification: Performance of collectPreVariables (initialization): time 1.862e-05/0.5931, allocations: 25.7 kB / 0.5506 GB, free: 27.61 MB / 394.7 MB
Notification: Performance of collectInitialEqns (initialization): time 0.0002364/0.5934, allocations: 388.8 kB / 0.551 GB, free: 27.42 MB / 394.7 MB
Notification: Performance of collectInitialBindings (initialization): time 2.235e-05/0.5934, allocations: 22.28 kB / 0.551 GB, free: 27.41 MB / 394.7 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 2.434e-05/0.5934, allocations: 11.09 kB / 0.551 GB, free: 27.41 MB / 394.7 MB
Notification: Performance of setup shared object (initialization): time 0.0001786/0.5936, allocations: 373.3 kB / 0.5513 GB, free: 27.09 MB / 394.7 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.000465/0.5941, allocations: 491.8 kB / 0.5518 GB, free: 27.09 MB / 394.7 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0004915/0.5946, allocations: 0.6596 MB / 0.5525 GB, free: 26.87 MB / 394.7 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.0006367/0.5952, allocations: 0.7346 MB / 0.5532 GB, free: 26.57 MB / 394.7 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 6.662e-06/0.5952, allocations: 3.875 kB / 0.5532 GB, free: 26.57 MB / 394.7 MB
Notification: Performance of matching and sorting (n=53) (initialization): time 0.001304/0.5965, allocations: 1.24 MB / 0.5544 GB, free: 26.32 MB / 394.7 MB
Notification: Performance of prepare postOptimizeDAE: time 2.059e-05/0.5966, allocations: 7.656 kB / 0.5544 GB, free: 26.32 MB / 394.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.127e-05/0.5966, allocations: 3.969 kB / 0.5544 GB, free: 26.32 MB / 394.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 2.396e-05/0.5966, allocations: 7.844 kB / 0.5544 GB, free: 26.32 MB / 394.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0003823/0.597, allocations: 116.3 kB / 0.5545 GB, free: 26.29 MB / 394.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 1.342e-05/0.597, allocations: 7.438 kB / 0.5545 GB, free: 26.29 MB / 394.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.000534/0.5976, allocations: 74.16 kB / 0.5546 GB, free: 26.25 MB / 394.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 4.814e-05/0.5976, allocations: 27.17 kB / 0.5546 GB, free: 26.25 MB / 394.7 MB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 26
 * Number of states: 0 ()
 * Number of discrete variables: 0 ()
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (53):
 * Single equations (assignments): 53
 * 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: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of prepare postOptimizeDAE: time 0.0002643/0.5979, allocations: 176.9 kB / 0.5548 GB, free: 26.12 MB / 394.7 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0001032/0.598, allocations: 66.09 kB / 0.5549 GB, free: 26.09 MB / 394.7 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.0002806/0.5983, allocations: 152.7 kB / 0.555 GB, free: 26.01 MB / 394.7 MB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 7.434e-06/0.5983, allocations: 7.453 kB / 0.555 GB, free: 26.01 MB / 394.7 MB
Notification: Performance of postOpt constantLinearSystem (simulation): time 5.64e-06/0.5983, allocations: 0 / 0.555 GB, free: 26.01 MB / 394.7 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 5.591e-06/0.5983, allocations: 7.938 kB / 0.555 GB, free: 26 MB / 394.7 MB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.0009792/0.5993, allocations: 0.8009 MB / 0.5558 GB, free: 25.42 MB / 394.7 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.855e-06/0.5993, allocations: 0 / 0.5558 GB, free: 25.42 MB / 394.7 MB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 6.874e-05/0.5994, allocations: 18.94 kB / 0.5558 GB, free: 25.42 MB / 394.7 MB
Notification: Performance of postOpt tearingSystem (simulation): time 4.9e-06/0.5994, allocations: 4.188 kB / 0.5558 GB, free: 25.41 MB / 394.7 MB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 1.129e-05/0.5994, allocations: 3.906 kB / 0.5558 GB, free: 25.41 MB / 394.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 3.346e-06/0.5995, allocations: 3.984 kB / 0.5558 GB, free: 25.41 MB / 394.7 MB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.665e-06/0.5995, allocations: 3.938 kB / 0.5558 GB, free: 25.41 MB / 394.7 MB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.0002238/0.5997, allocations: 211.7 kB / 0.556 GB, free: 25.25 MB / 394.7 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.0002236/0.5999, allocations: 180.1 kB / 0.5562 GB, free: 25.11 MB / 394.7 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 8.857e-05/0.6, allocations: 3.906 kB / 0.5562 GB, free: 25.11 MB / 394.7 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0002457/0.6003, allocations: 7.859 kB / 0.5562 GB, free: 25.1 MB / 394.7 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 1.97e-05/0.6003, allocations: 3.875 kB / 0.5562 GB, free: 25.1 MB / 394.7 MB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 6.402e-06/0.6003, allocations: 3.375 kB / 0.5562 GB, free: 25.1 MB / 394.7 MB
Notification: Performance of sorting global known variables: time 0.001169/0.6015, allocations: 1.375 MB / 0.5576 GB, free: 24.87 MB / 394.7 MB
Notification: Performance of sort global known variables: time 1.2e-07/0.6015, allocations: 4 kB / 0.5576 GB, free: 24.87 MB / 394.7 MB
Notification: Performance of remove unused functions: time 0.0008538/0.6024, allocations: 290 kB / 0.5578 GB, free: 24.8 MB / 394.7 MB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 6
 * Number of states: 0 ()
 * Number of discrete variables: 0 ()
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (6):
 * Single equations (assignments): 6
 * 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: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of Backend phase and start with SimCode phase: time 0.0007366/0.6031, allocations: 369.8 kB / 0.5582 GB, free: 24.61 MB / 394.7 MB
Notification: Performance of simCode: created initialization part: time 0.0006609/0.6038, allocations: 0.6037 MB / 0.5588 GB, free: 24.52 MB / 394.7 MB
Notification: Performance of simCode: created event and clocks part: time 2.334e-06/0.6038, allocations: 0 / 0.5588 GB, free: 24.52 MB / 394.7 MB
Notification: Performance of simCode: created simulation system equations: time 4.617e-05/0.6038, allocations: 34.61 kB / 0.5588 GB, free: 24.51 MB / 394.7 MB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.001065/0.6049, allocations: 220.5 kB / 0.559 GB, free: 24.44 MB / 394.7 MB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.001241/0.6062, allocations: 0.9481 MB / 0.56 GB, free: 23.81 MB / 394.7 MB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.00041/0.6066, allocations: 0.8497 MB / 0.5608 GB, free: 23.04 MB / 394.7 MB
Notification: Performance of simCode: alias equations: time 0.0004477/0.6071, allocations: 125.3 kB / 0.5609 GB, free: 22.98 MB / 394.7 MB
Notification: Performance of simCode: all other stuff during SimCode phase: time 9.682e-05/0.6072, allocations: 45.14 kB / 0.561 GB, free: 22.97 MB / 394.7 MB
Notification: Performance of SimCode: time 2.31e-07/0.6072, allocations: 4 kB / 0.561 GB, free: 22.96 MB / 394.7 MB
Notification: Performance of Templates: time 0.01912/0.6263, allocations: 11.83 MB / 0.5725 GB, free: 17.18 MB / 394.7 MB
make -j1 -f Chemical_Chemical.Examples.CheckSubstancesData.SimpleReaction2.makefile
(rm -f Chemical_Chemical.Examples.CheckSubstancesData.SimpleReaction2.pipe ; mkfifo Chemical_Chemical.Examples.CheckSubstancesData.SimpleReaction2.pipe ; head -c 1048576 < Chemical_Chemical.Examples.CheckSubstancesData.SimpleReaction2.pipe >> ../files/Chemical_Chemical.Examples.CheckSubstancesData.SimpleReaction2.sim & ./Chemical_Chemical.Examples.CheckSubstancesData.SimpleReaction2 -abortSlowSimulation -alarm=480 -lv LOG_STATS > Chemical_Chemical.Examples.CheckSubstancesData.SimpleReaction2.pipe 2>&1)