Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr Physiolibrary_Physiolibrary.Chemical.Examples.ExothermicReaction.conf.json
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)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Physiolibrary 3.0.0-master/package.mo", uses=false)
Using package Physiolibrary with version 3.0.0-beta1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Physiolibrary 3.0.0-master/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)
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)
Running command: translateModel(Physiolibrary.Chemical.Examples.ExothermicReaction,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Physiolibrary_Physiolibrary.Chemical.Examples.ExothermicReaction")
translateModel(Physiolibrary.Chemical.Examples.ExothermicReaction,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Physiolibrary_Physiolibrary.Chemical.Examples.ExothermicReaction")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001609/0.001609, allocations: 182.2 kB / 15.98 MB, free: 5.77 MB / 13.93 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.286/1.286, allocations: 222.9 MB / 239.7 MB, free: 10.99 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.001016/0.001016, allocations: 103.9 kB / 289.9 MB, free: 10.96 MB / 234.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Physiolibrary 3.0.0-master/package.mo): time 0.3328/0.3328, allocations: 36.67 MB / 376.7 MB, free: 41.49 MB / 298.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.00143/0.00143, allocations: 63.91 kB / 446.4 MB, free: 11.86 MB / 330.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1068/0.1083, allocations: 58.92 MB / 0.4935 GB, free: 0.8828 MB / 378.7 MB
Notification: Performance of NFInst.instantiate(Physiolibrary.Chemical.Examples.ExothermicReaction): time 0.1912/0.2995, allocations: 9.693 MB / 0.5029 GB, free: 36.66 MB / 378.7 MB
Notification: Performance of NFInst.instExpressions: time 0.02063/0.3201, allocations: 23.02 MB / 0.5254 GB, free: 20.56 MB / 378.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001961/0.3221, allocations: 42.16 kB / 0.5255 GB, free: 20.54 MB / 378.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.001492/0.3236, allocations: 475.9 kB / 0.5259 GB, free: 20.29 MB / 378.7 MB
Notification: Performance of NFTyping.typeBindings: time 0.005202/0.3289, allocations: 1.677 MB / 0.5276 GB, free: 19.28 MB / 378.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.007637/0.3366, allocations: 2.635 MB / 0.5301 GB, free: 17.72 MB / 378.7 MB
Notification: Performance of NFFlatten.flatten: time 0.003183/0.3398, allocations: 2.449 MB / 0.5325 GB, free: 16.55 MB / 378.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.001957/0.3418, allocations: 1.227 MB / 0.5337 GB, free: 16.04 MB / 378.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.002291/0.3441, allocations: 1.169 MB / 0.5349 GB, free: 15.67 MB / 378.7 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.002414/0.3465, allocations: 1.332 MB / 0.5362 GB, free: 15.16 MB / 378.7 MB
Notification: Performance of NFPackage.collectConstants: time 0.0006177/0.3471, allocations: 141.6 kB / 0.5363 GB, free: 15.16 MB / 378.7 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.0081/0.3553, allocations: 2.449 MB / 0.5387 GB, free: 14.53 MB / 378.7 MB
Notification: Performance of NFScalarize.scalarize: time 0.0007755/0.3561, allocations: 459.4 kB / 0.5391 GB, free: 14.28 MB / 378.7 MB
Notification: Performance of NFVerifyModel.verify: time 0.001212/0.3573, allocations: 1.028 MB / 0.5401 GB, free: 13.72 MB / 378.7 MB
Notification: Performance of NFConvertDAE.convert: time 0.01058/0.3679, allocations: 4.783 MB / 0.5448 GB, free: 11.75 MB / 378.7 MB
Notification: Performance of FrontEnd - DAE generated: time 7.655e-06/0.3679, allocations: 0.6094 kB / 0.5448 GB, free: 11.75 MB / 378.7 MB
Notification: Performance of FrontEnd: time 1.402e-06/0.3679, allocations: 0 / 0.5448 GB, free: 11.75 MB / 378.7 MB
Notification: Performance of Transformations before backend: time 4.767e-05/0.368, allocations: 0 / 0.5448 GB, free: 11.75 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: 455
 * Number of variables: 455
Notification: Performance of Generate backend data structure: time 0.005255/0.3733, allocations: 2.637 MB / 0.5474 GB, free: 10.22 MB / 378.7 MB
Notification: Performance of prepare preOptimizeDAE: time 4.44e-05/0.3733, allocations: 13.86 kB / 0.5474 GB, free: 10.22 MB / 378.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.001817/0.3751, allocations: 419.6 kB / 0.5478 GB, free: 10.09 MB / 378.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.001601/0.3768, allocations: 0.9319 MB / 0.5487 GB, free: 9.5 MB / 378.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001694/0.3769, allocations: 204.4 kB / 0.5489 GB, free: 9.367 MB / 378.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0002755/0.3772, allocations: 185.8 kB / 0.5491 GB, free: 9.305 MB / 378.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.003419/0.3807, allocations: 2.083 MB / 0.5511 GB, free: 8.504 MB / 378.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 3.159e-05/0.3807, allocations: 0 / 0.5511 GB, free: 8.504 MB / 378.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001543/0.3809, allocations: 79.58 kB / 0.5512 GB, free: 8.441 MB / 378.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 3.149e-05/0.3809, allocations: 48.47 kB / 0.5512 GB, free: 8.438 MB / 378.7 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.004021/0.3849, allocations: 2.582 MB / 0.5537 GB, free: 7.695 MB / 378.7 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.01105/0.396, allocations: 6.403 MB / 0.56 GB, free: 3.766 MB / 378.7 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.005053/0.4011, allocations: 2.55 MB / 0.5625 GB, free: 2.414 MB / 378.7 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001558/0.4027, allocations: 0.8626 MB / 0.5633 GB, free: 1.969 MB / 378.7 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.01123/0.4139, allocations: 8.111 MB / 0.5713 GB, free: 9.652 MB / 394.7 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.735e-05/0.414, allocations: 47.69 kB / 0.5713 GB, free: 9.594 MB / 394.7 MB
Notification: Performance of pre-optimization done (n=122): time 3.015e-06/0.414, allocations: 0 / 0.5713 GB, free: 9.594 MB / 394.7 MB
Notification: Performance of matching and sorting (n=150): time 0.02766/0.4417, allocations: 6.191 MB / 0.5773 GB, free: 3.227 MB / 394.7 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 7.128e-05/0.4418, allocations: 98.36 kB / 0.5774 GB, free: 3.109 MB / 394.7 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.00121/0.443, allocations: 0.9373 MB / 0.5784 GB, free: 2.156 MB / 394.7 MB
Notification: Performance of collectPreVariables (initialization): time 0.0001996/0.4432, allocations: 53.7 kB / 0.5784 GB, free: 2.098 MB / 394.7 MB
Notification: Performance of collectInitialEqns (initialization): time 0.0005125/0.4438, allocations: 0.8327 MB / 0.5792 GB, free: 1.25 MB / 394.7 MB
Notification: Performance of collectInitialBindings (initialization): time 0.0004873/0.4442, allocations: 0.516 MB / 0.5797 GB, free: 0.7266 MB / 394.7 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0005254/0.4448, allocations: 371.2 kB / 0.5801 GB, free: 364 kB / 394.7 MB
Notification: Performance of setup shared object (initialization): time 9.961e-05/0.4449, allocations: 305.1 kB / 0.5804 GB, free: 56 kB / 394.7 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001018/0.4459, allocations: 0.5349 MB / 0.5809 GB, free: 15.52 MB / 410.7 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001449/0.4474, allocations: 1.251 MB / 0.5821 GB, free: 13.93 MB / 410.7 MB
Warning: It was not possible to determine if the initialization problem is consistent, because of not evaluable parameters/start values during compile time: solution_at_constant_temperature.temperature = solution_at_constant_temperature.temperature_start (fixedTemperature.T = solution_at_constant_temperature.temperature_start)
Notification: Performance of analyzeInitialSystem (initialization): time 0.003054/0.4504, allocations: 2.052 MB / 0.5841 GB, free: 11.53 MB / 410.7 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.88e-05/0.4505, allocations: 8 kB / 0.5841 GB, free: 11.52 MB / 410.7 MB
Notification: Performance of matching and sorting (n=258) (initialization): time 0.01306/0.4635, allocations: 2.557 MB / 0.5866 GB, free: 8.945 MB / 410.7 MB
Notification: Performance of prepare postOptimizeDAE: time 5.238e-05/0.4636, allocations: 16 kB / 0.5866 GB, free: 8.93 MB / 410.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 4.984e-05/0.4637, allocations: 27.98 kB / 0.5867 GB, free: 8.902 MB / 410.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.01018/0.4739, allocations: 0.694 MB / 0.5873 GB, free: 8.195 MB / 410.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.005016/0.479, allocations: 0.5812 MB / 0.5879 GB, free: 7.613 MB / 410.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01901/0.498, allocations: 7.49 MB / 0.5952 GB, free: 15.58 MB / 426.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.003068/0.5011, allocations: 111.9 kB / 0.5953 GB, free: 15.47 MB / 426.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0004582/0.5016, allocations: 112 kB / 0.5954 GB, free: 15.36 MB / 426.7 MB
Warning: The initial conditions are over specified. The following 1 initial equations are redundant, so they are removed from the initialization system:
         solution_at_constant_temperature.temperature = solution_at_constant_temperature.temperature_start.
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 107
 * 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 (241):
 * Single equations (assignments): 237
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 4
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 2 systems
   {(3,6,77.8%), (1,3,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 2 systems
   {(1,3), (1,3)}
Notification: Performance of prepare postOptimizeDAE: time 0.001126/0.5028, allocations: 390.2 kB / 0.5958 GB, free: 14.97 MB / 426.7 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0005554/0.5034, allocations: 142.2 kB / 0.5959 GB, free: 14.83 MB / 426.7 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01597/0.5193, allocations: 2.486 MB / 0.5984 GB, free: 12.3 MB / 426.7 MB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 2.701e-05/0.5194, allocations: 12 kB / 0.5984 GB, free: 12.29 MB / 426.7 MB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.662e-05/0.5194, allocations: 7.938 kB / 0.5984 GB, free: 12.28 MB / 426.7 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 3.891e-05/0.5195, allocations: 7.969 kB / 0.5984 GB, free: 12.27 MB / 426.7 MB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.009231/0.5287, allocations: 2.55 MB / 0.6009 GB, free: 9.629 MB / 426.7 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.084e-05/0.5288, allocations: 4 kB / 0.6009 GB, free: 9.625 MB / 426.7 MB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.003514/0.5323, allocations: 371.8 kB / 0.6012 GB, free: 9.262 MB / 426.7 MB
Notification: Performance of postOpt tearingSystem (simulation): time 0.01133/0.5437, allocations: 0.7535 MB / 0.602 GB, free: 8.492 MB / 426.7 MB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0002465/0.5439, allocations: 43.92 kB / 0.602 GB, free: 8.449 MB / 426.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.01618/0.5602, allocations: 8.575 MB / 0.6104 GB, free: 15.2 MB / 442.7 MB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 5.691e-06/0.5602, allocations: 7.969 kB / 0.6104 GB, free: 15.19 MB / 442.7 MB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.09573/0.6559, allocations: 24.02 MB / 0.6339 GB, free: 6.359 MB / 458.7 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.0003012/0.6563, allocations: 215.2 kB / 0.6341 GB, free: 6.129 MB / 458.7 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0002178/0.6565, allocations: 28 kB / 0.6341 GB, free: 6.102 MB / 458.7 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0008674/0.6574, allocations: 56.2 kB / 0.6341 GB, free: 6.047 MB / 458.7 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0003471/0.6577, allocations: 129 kB / 0.6343 GB, free: 5.922 MB / 458.7 MB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 9.991e-05/0.6578, allocations: 51.98 kB / 0.6343 GB, free: 5.871 MB / 458.7 MB
Notification: Performance of sorting global known variables: time 0.000824/0.6587, allocations: 0.6303 MB / 0.6349 GB, free: 5.234 MB / 458.7 MB
Notification: Performance of sort global known variables: time 1.5e-07/0.6587, allocations: 3.938 kB / 0.6349 GB, free: 5.23 MB / 458.7 MB
Notification: Performance of remove unused functions: time 0.003912/0.6626, allocations: 1.288 MB / 0.6362 GB, free: 3.941 MB / 458.7 MB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 12
 * Number of states: 7 (A1.logn,B1.logn,H2O.logn,A.logn,B.logn,H2O1.amountOfBonds,H2O1.logn)
 * 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 (137):
 * Single equations (assignments): 132
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 5
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 2 systems
   {(1,3,100.0%), (2,7,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 3 systems
   {(1,3), (1,1), (2,3)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.001964/0.6646, allocations: 1.079 MB / 0.6372 GB, free: 2.848 MB / 458.7 MB
Notification: Performance of simCode: created initialization part: time 0.003791/0.6684, allocations: 2.072 MB / 0.6393 GB, free: 0.7305 MB / 458.7 MB
Notification: Performance of simCode: created event and clocks part: time 7.424e-06/0.6684, allocations: 4 kB / 0.6393 GB, free: 0.7266 MB / 458.7 MB
Notification: Performance of simCode: created simulation system equations: time 0.002204/0.6706, allocations: 1.379 MB / 0.6406 GB, free: 15.29 MB / 474.7 MB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.001759/0.6724, allocations: 295 kB / 0.6409 GB, free: 15 MB / 474.7 MB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.007534/0.68, allocations: 5.14 MB / 0.6459 GB, free: 9.734 MB / 474.7 MB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0008755/0.6809, allocations: 1.309 MB / 0.6472 GB, free: 8.395 MB / 474.7 MB
Notification: Performance of simCode: alias equations: time 0.001596/0.6825, allocations: 355.8 kB / 0.6475 GB, free: 8.047 MB / 474.7 MB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0004933/0.683, allocations: 207.3 kB / 0.6477 GB, free: 7.844 MB / 474.7 MB
Notification: Performance of SimCode: time 9.72e-07/0.683, allocations: 0 / 0.6477 GB, free: 7.844 MB / 474.7 MB
Notification: Performance of Templates: time 0.2518/0.9348, allocations: 45.02 MB / 0.6917 GB, free: 151 MB / 0.4948 GB
make -j1 -f Physiolibrary_Physiolibrary.Chemical.Examples.ExothermicReaction.makefile
(rm -f Physiolibrary_Physiolibrary.Chemical.Examples.ExothermicReaction.pipe ; mkfifo Physiolibrary_Physiolibrary.Chemical.Examples.ExothermicReaction.pipe ; head -c 1048576 < Physiolibrary_Physiolibrary.Chemical.Examples.ExothermicReaction.pipe >> ../files/Physiolibrary_Physiolibrary.Chemical.Examples.ExothermicReaction.sim & ./Physiolibrary_Physiolibrary.Chemical.Examples.ExothermicReaction  -abortSlowSimulation -alarm=480 -lv LOG_STATS > Physiolibrary_Physiolibrary.Chemical.Examples.ExothermicReaction.pipe 2>&1)