Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Chemical_Chemical.Examples.ClimateChange.HydrogenotrophicMethanogenesis.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 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Chemical 1.4.1-master/package.mo", uses=false)
Using package Chemical with version 1.4.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Chemical 1.4.1-master/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 ModelicaServices with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo)
Running command: translateModel(Chemical.Examples.ClimateChange.HydrogenotrophicMethanogenesis,tolerance=1e-08,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Chemical_Chemical.Examples.ClimateChange.HydrogenotrophicMethanogenesis")
translateModel(Chemical.Examples.ClimateChange.HydrogenotrophicMethanogenesis,tolerance=1e-08,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Chemical_Chemical.Examples.ClimateChange.HydrogenotrophicMethanogenesis")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001599/0.001599, allocations: 110.7 kB / 16.42 MB, free: 6.512 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.001867/0.001867, allocations: 189.5 kB / 17.35 MB, free: 5.738 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.318/1.318, allocations: 222.9 MB / 241 MB, free: 15.16 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Chemical 1.4.1-master/package.mo): time 0.07676/0.07676, allocations: 15.31 MB / 306.5 MB, free: 15.42 MB / 254.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.001207/0.001207, allocations: 59.91 kB / 425.9 MB, free: 11.46 MB / 302.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.08558/0.0868, allocations: 53.61 MB / 479.5 MB, free: 5.797 MB / 350.1 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Chemical 1.4.1-master/package.mo:4740:7-4740:66:writable] Warning: An inner declaration for outer component system could not be found and was automatically generated.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Chemical 1.4.1-master/package.mo:4740:7-4740:66:writable] Notification: The diagnostics message for the missing inner is: 
Your model is using an outer "system" component but
an inner "system" component is not defined.
For simulation drag Modelica.Fluid.System into your model
to specify system properties.
Notification: Performance of NFInst.instantiate(Chemical.Examples.ClimateChange.HydrogenotrophicMethanogenesis): time 0.03639/0.1232, allocations: 25.47 MB / 0.4931 GB, free: 12.41 MB / 382.1 MB
Notification: Performance of NFInst.instExpressions: time 0.214/0.3372, allocations: 16.65 MB / 0.5094 GB, free: 18.29 MB / 382.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0005274/0.3378, allocations: 14.44 kB / 0.5094 GB, free: 18.29 MB / 382.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.0008677/0.3386, allocations: 331.2 kB / 0.5097 GB, free: 18.29 MB / 382.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.00324/0.3419, allocations: 1.497 MB / 0.5112 GB, free: 18.27 MB / 382.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.004325/0.3462, allocations: 2.005 MB / 0.5131 GB, free: 17.63 MB / 382.1 MB
Notification: Performance of NFFlatten.flatten: time 0.001512/0.3478, allocations: 1.54 MB / 0.5146 GB, free: 17.33 MB / 382.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.001027/0.3488, allocations: 0.8494 MB / 0.5155 GB, free: 17.27 MB / 382.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.0008486/0.3497, allocations: 0.7708 MB / 0.5162 GB, free: 17.19 MB / 382.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.000999/0.3507, allocations: 0.853 MB / 0.517 GB, free: 17.05 MB / 382.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.000223/0.3509, allocations: 135.2 kB / 0.5172 GB, free: 17.05 MB / 382.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.005168/0.3561, allocations: 1.78 MB / 0.5189 GB, free: 16.85 MB / 382.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.0002935/0.3564, allocations: 329.6 kB / 0.5192 GB, free: 16.66 MB / 382.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.0006624/0.357, allocations: 0.681 MB / 0.5199 GB, free: 16.27 MB / 382.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.005769/0.3628, allocations: 3.346 MB / 0.5232 GB, free: 15.04 MB / 382.1 MB
Notification: Performance of FrontEnd - DAE generated: time 4.419e-06/0.3629, allocations: 4.062 kB / 0.5232 GB, free: 15.04 MB / 382.1 MB
Notification: Performance of FrontEnd: time 1.373e-06/0.3629, allocations: 0 / 0.5232 GB, free: 15.04 MB / 382.1 MB
Notification: Performance of Transformations before backend: time 2.681e-05/0.3629, allocations: 0 / 0.5232 GB, free: 15.04 MB / 382.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 276
 * Number of variables: 276
Notification: Performance of Generate backend data structure: time 0.003148/0.366, allocations: 1.804 MB / 0.5249 GB, free: 13.96 MB / 382.1 MB
Notification: Performance of prepare preOptimizeDAE: time 3.947e-05/0.3661, allocations: 11.34 kB / 0.5249 GB, free: 13.96 MB / 382.1 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.001225/0.3673, allocations: 274.5 kB / 0.5252 GB, free: 13.87 MB / 382.1 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.0009969/0.3683, allocations: 0.671 MB / 0.5258 GB, free: 13.43 MB / 382.1 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001147/0.3685, allocations: 112.4 kB / 0.526 GB, free: 13.36 MB / 382.1 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.000197/0.3687, allocations: 110.2 kB / 0.5261 GB, free: 13.33 MB / 382.1 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.002057/0.3707, allocations: 1.338 MB / 0.5274 GB, free: 12.78 MB / 382.1 MB
Notification: Performance of preOpt findStateOrder (simulation): time 2.21e-05/0.3708, allocations: 3.625 kB / 0.5274 GB, free: 12.78 MB / 382.1 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001201/0.3709, allocations: 41.59 kB / 0.5274 GB, free: 12.75 MB / 382.1 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 2.359e-05/0.3709, allocations: 28.41 kB / 0.5274 GB, free: 12.75 MB / 382.1 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.002458/0.3734, allocations: 1.698 MB / 0.5291 GB, free: 12.25 MB / 382.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.005829/0.3792, allocations: 4.291 MB / 0.5333 GB, free: 9.305 MB / 382.1 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.003024/0.3823, allocations: 2.275 MB / 0.5355 GB, free: 8.117 MB / 382.1 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0007021/0.383, allocations: 0.5879 MB / 0.5361 GB, free: 7.816 MB / 382.1 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.005674/0.3887, allocations: 5.382 MB / 0.5413 GB, free: 2.906 MB / 382.1 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 1.886e-05/0.3887, allocations: 52.31 kB / 0.5414 GB, free: 2.852 MB / 382.1 MB
Notification: Performance of pre-optimization done (n=78): time 2.635e-06/0.3887, allocations: 0 / 0.5414 GB, free: 2.852 MB / 382.1 MB
Notification: Performance of matching and sorting (n=95): time 0.01381/0.4025, allocations: 3.57 MB / 0.5449 GB, free: 15.26 MB / 398.1 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 3.617e-05/0.4026, allocations: 64.41 kB / 0.5449 GB, free: 15.18 MB / 398.1 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.000651/0.4032, allocations: 0.5861 MB / 0.5455 GB, free: 14.58 MB / 398.1 MB
Notification: Performance of collectPreVariables (initialization): time 7.722e-05/0.4033, allocations: 41.7 kB / 0.5455 GB, free: 14.54 MB / 398.1 MB
Notification: Performance of collectInitialEqns (initialization): time 0.0003236/0.4036, allocations: 0.5312 MB / 0.5461 GB, free: 14 MB / 398.1 MB
Notification: Performance of collectInitialBindings (initialization): time 0.0002482/0.4039, allocations: 333.6 kB / 0.5464 GB, free: 13.68 MB / 398.1 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0003138/0.4042, allocations: 228.1 kB / 0.5466 GB, free: 13.45 MB / 398.1 MB
Notification: Performance of setup shared object (initialization): time 0.0001736/0.4044, allocations: 398.7 kB / 0.547 GB, free: 13.05 MB / 398.1 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0006146/0.405, allocations: 358.4 kB / 0.5473 GB, free: 12.7 MB / 398.1 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0008738/0.4059, allocations: 0.7469 MB / 0.5481 GB, free: 11.79 MB / 398.1 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.001572/0.4075, allocations: 1.198 MB / 0.5492 GB, free: 10.45 MB / 398.1 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 8.997e-06/0.4075, allocations: 6.688 kB / 0.5492 GB, free: 10.45 MB / 398.1 MB
Notification: Performance of matching and sorting (n=158) (initialization): time 0.003959/0.4115, allocations: 1.483 MB / 0.5507 GB, free: 8.965 MB / 398.1 MB
Notification: Performance of prepare postOptimizeDAE: time 2.477e-05/0.4115, allocations: 12 kB / 0.5507 GB, free: 8.953 MB / 398.1 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.84e-05/0.4115, allocations: 12 kB / 0.5507 GB, free: 8.941 MB / 398.1 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001943/0.4135, allocations: 241.5 kB / 0.5509 GB, free: 8.707 MB / 398.1 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001498/0.415, allocations: 327.5 kB / 0.5512 GB, free: 8.387 MB / 398.1 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.005466/0.4205, allocations: 3.865 MB / 0.555 GB, free: 4.273 MB / 398.1 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0009966/0.4215, allocations: 40 kB / 0.5551 GB, free: 4.234 MB / 398.1 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001671/0.4217, allocations: 63.98 kB / 0.5551 GB, free: 4.172 MB / 398.1 MB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 58
 * 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 (152):
 * Single equations (assignments): 150
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 2
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 1 system
   {(1,3,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 1 system
   {(1,3)}
Notification: Performance of prepare postOptimizeDAE: time 0.0005492/0.4222, allocations: 277.4 kB / 0.5554 GB, free: 3.891 MB / 398.1 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.000269/0.4225, allocations: 89.56 kB / 0.5555 GB, free: 3.805 MB / 398.1 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.004328/0.4268, allocations: 1.337 MB / 0.5568 GB, free: 2.492 MB / 398.1 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 1.392e-05/0.4269, allocations: 3.984 kB / 0.5568 GB, free: 2.488 MB / 398.1 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 5.27e-06/0.4269, allocations: 3.938 kB / 0.5568 GB, free: 2.484 MB / 398.1 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.000312/0.4272, allocations: 150.7 kB / 0.5569 GB, free: 2.32 MB / 398.1 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0002108/0.4274, allocations: 20 kB / 0.5569 GB, free: 2.301 MB / 398.1 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.000608/0.428, allocations: 16 kB / 0.557 GB, free: 2.285 MB / 398.1 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.000196/0.4282, allocations: 91.5 kB / 0.557 GB, free: 2.199 MB / 398.1 MB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.003568/0.4318, allocations: 1.162 MB / 0.5582 GB, free: 1.051 MB / 398.1 MB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.00224/0.4341, allocations: 1.53 MB / 0.5597 GB, free: 15.51 MB / 414.1 MB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.0006283/0.4347, allocations: 415.8 kB / 0.5601 GB, free: 15.1 MB / 414.1 MB
Notification: Performance of sorting global known variables: time 0.0004845/0.4352, allocations: 391.1 kB / 0.5604 GB, free: 14.73 MB / 414.1 MB
Notification: Performance of Backend: time 2.585e-06/0.4352, allocations: 0 / 0.5604 GB, free: 14.73 MB / 414.1 MB
Notification: Performance of simCode: created initialization part: time 0.004651/0.4399, allocations: 1.921 MB / 0.5623 GB, free: 12.96 MB / 414.1 MB
Notification: Performance of SimCode: time 0.003117/0.443, allocations: 2.283 MB / 0.5645 GB, free: 10.68 MB / 414.1 MB
Notification: Performance of Templates: time 0.03717/0.4802, allocations: 26.72 MB / 0.5906 GB, free: 0.625 MB / 430.1 MB
make -j1 -f Chemical_Chemical.Examples.ClimateChange.HydrogenotrophicMethanogenesis.makefile
(rm -f Chemical_Chemical.Examples.ClimateChange.HydrogenotrophicMethanogenesis.pipe ; mkfifo Chemical_Chemical.Examples.ClimateChange.HydrogenotrophicMethanogenesis.pipe ; head -c 1048576 < Chemical_Chemical.Examples.ClimateChange.HydrogenotrophicMethanogenesis.pipe >> ../files/Chemical_Chemical.Examples.ClimateChange.HydrogenotrophicMethanogenesis.sim & ./Chemical_Chemical.Examples.ClimateChange.HydrogenotrophicMethanogenesis  -abortSlowSimulation -alarm=480 -lv LOG_STATS > Chemical_Chemical.Examples.ClimateChange.HydrogenotrophicMethanogenesis.pipe 2>&1)