Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Chemical_master_Chemical.Examples.SimpleReactionInSolution.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo): time 0.0009282/0.0009282, allocations: 80.75 kB / 19.94 MB, free: 4.547 MB / 18.57 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo): time 0.0009079/0.0009079, allocations: 181 kB / 23.36 MB, free: 1.133 MB / 18.57 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo): time 0.9114/0.9114, allocations: 177.1 MB / 203.8 MB, free: 5.48 MB / 186.7 MB
"
[Timeout remaining time 179]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Chemical master/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Chemical master/package.mo): time 0.1057/0.1057, allocations: 17.46 MB / 277.7 MB, free: 11.45 MB / 266.7 MB
"
[Timeout remaining time 180]
Using package Chemical with version 2.0.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Chemical master/package.mo)
Using package Modelica with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo)
Using package Complex with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo)
Using package ModelicaServices with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo)
Running command: translateModel(Chemical.Examples.SimpleReactionInSolution,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="Chemical_master_Chemical.Examples.SimpleReactionInSolution")
translateModel(Chemical.Examples.SimpleReactionInSolution,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="Chemical_master_Chemical.Examples.SimpleReactionInSolution") [Timeout 660]
"Notification: Performance of FrontEnd - loaded program: time 1.011e-06/1.011e-06, allocations: 0 / 300.7 MB, free: 1.762 MB / 266.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 8.897e-06/9.908e-06, allocations: 3.406 kB / 300.7 MB, free: 1.758 MB / 266.7 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Chemical master/Boundaries.mo:1361:7-1361:76:writable] Warning: An inner declaration for outer component dropOfCommons could not be found and was automatically generated.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Chemical master/Boundaries.mo:1361:7-1361:76:writable] Notification: The diagnostics message for the missing inner is: 
Your model is using an outer \"dropOfCommons\" component but
an inner \"dropOfCommons\" component is not defined.
Use Chemical.DropOfCommons in your model
to specify system properties.
Notification: Performance of NFInst.instantiate(Chemical.Examples.SimpleReactionInSolution): time 0.02922/0.02923, allocations: 39.71 MB / 340.4 MB, free: 12.68 MB / 314.7 MB
Notification: Performance of NFInst.instExpressions: time 0.01325/0.04248, allocations: 10.65 MB / 351.1 MB, free: 1.984 MB / 314.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001787/0.04426, allocations: 63.5 kB / 351.1 MB, free: 1.922 MB / 314.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.003296/0.04756, allocations: 1.927 MB / 353.1 MB, free: 15.98 MB / 330.7 MB
Notification: Performance of NFTyping.typeBindings: time 0.002926/0.05048, allocations: 1.362 MB / 354.4 MB, free: 14.61 MB / 330.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.005159/0.05564, allocations: 4.212 MB / 358.6 MB, free: 10.38 MB / 330.7 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Chemical master/Interfaces.mo:1332:3-1332:55:writable] Warning: Parameter reaction.nextProducts[1].data.MM has no value, and is fixed during initialization (fixed=true), using available start value (start=0.0) as default value.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Chemical master/Interfaces.mo:1333:3-1333:87:writable] Warning: Parameter reaction.nextProducts[1].data.Hf has no value, and is fixed during initialization (fixed=true), using available start value (start=0.0) as default value.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Chemical master/Interfaces.mo:1334:3-1334:81:writable] Warning: Parameter reaction.nextProducts[1].data.H0 has no value, and is fixed during initialization (fixed=true), using available start value (start=0.0) as default value.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Chemical master/Interfaces.mo:1336:3-1336:82:writable] Warning: Parameter reaction.nextProducts[1].data.alow has no value, and is fixed during initialization (fixed=true), using available start value (start=fill(0.0, 7)) as default value.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Chemical master/Interfaces.mo:1337:3-1337:79:writable] Warning: Parameter reaction.nextProducts[1].data.blow has no value, and is fixed during initialization (fixed=true), using available start value (start=fill(0.0, 3)) as default value.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Chemical master/Interfaces.mo:1338:3-1338:84:writable] Warning: Parameter reaction.nextProducts[1].data.ahigh has no value, and is fixed during initialization (fixed=true), using available start value (start=fill(0.0, 7)) as default value.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Chemical master/Interfaces.mo:1339:3-1339:81:writable] Warning: Parameter reaction.nextProducts[1].data.bhigh has no value, and is fixed during initialization (fixed=true), using available start value (start=fill(0.0, 3)) as default value.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Chemical master/Interfaces.mo:1341:3-1342:83:writable] Warning: Parameter reaction.nextProducts[1].data.z has no value, and is fixed during initialization (fixed=true), using available start value (start=0.0) as default value.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Chemical master/Interfaces.mo:1344:3-1344:89:writable] Warning: Parameter reaction.nextProducts[1].data.phase has no value, and is fixed during initialization (fixed=true), using available start value (start=Chemical.Interfaces.Phase.Gas) as default value.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Chemical master/Interfaces.mo:1347:3-1347:140:writable] Warning: Parameter reaction.nextProducts[1].data.VmBase has no value, and is fixed during initialization (fixed=true), using available start value (start=0.0) as default value.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Chemical master/Interfaces.mo:1348:3-1348:137:writable] Warning: Parameter reaction.nextProducts[1].data.VmExcess has no value, and is fixed during initialization (fixed=true), using available start value (start=0.0) as default value.
Notification: Performance of NFFlatten.flatten: time 0.003253/0.0589, allocations: 2.913 MB / 361.6 MB, free: 7.457 MB / 330.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.0006323/0.05953, allocations: 0.5652 MB / 362.1 MB, free: 6.828 MB / 330.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.001613/0.06114, allocations: 1.633 MB / 363.8 MB, free: 5.191 MB / 330.7 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.001332/0.06247, allocations: 1.223 MB / 365 MB, free: 3.965 MB / 330.7 MB
Notification: Performance of NFPackage.collectConstants: time 0.0003865/0.06286, allocations: 248 kB / 365.2 MB, free: 3.723 MB / 330.7 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.003301/0.06616, allocations: 1.965 MB / 367.2 MB, free: 1.754 MB / 330.7 MB
Notification: Performance of NFScalarize.scalarize: time 0.0004597/0.06662, allocations: 0.8449 MB / 368 MB, free: 0.9062 MB / 330.7 MB
Notification: Performance of NFVerifyModel.verify: time 0.0008536/0.06747, allocations: 0.9117 MB / 368.9 MB, free: 15.99 MB / 346.7 MB
Notification: Performance of NFConvertDAE.convert: time 0.004572/0.07205, allocations: 4.108 MB / 373 MB, free: 11.87 MB / 346.7 MB
Notification: Performance of FrontEnd - DAE generated: time 4.498e-06/0.07205, allocations: 0 / 373 MB, free: 11.87 MB / 346.7 MB
Notification: Performance of FrontEnd: time 2.064e-06/0.07205, allocations: 0 / 373 MB, free: 11.87 MB / 346.7 MB
Notification: Performance of Transformations before backend: time 0.0001105/0.07216, allocations: 4 kB / 373.1 MB, free: 11.87 MB / 346.7 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 751
 * Number of variables: 751
Notification: Performance of Generate backend data structure: time 0.003919/0.07608, allocations: 3.348 MB / 376.4 MB, free: 8.473 MB / 346.7 MB
Notification: Performance of prepare preOptimizeDAE: time 3.395e-05/0.07612, allocations: 8.031 kB / 376.4 MB, free: 8.465 MB / 346.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.001466/0.07758, allocations: 1.195 MB / 377.6 MB, free: 7.27 MB / 346.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.001236/0.07882, allocations: 1.078 MB / 378.7 MB, free: 6.141 MB / 346.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0002024/0.07902, allocations: 406.8 kB / 379.1 MB, free: 5.691 MB / 346.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0002007/0.07922, allocations: 248.3 kB / 379.3 MB, free: 5.449 MB / 346.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.002502/0.08172, allocations: 2.787 MB / 382.1 MB, free: 2.598 MB / 346.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 3.184e-05/0.08176, allocations: 192 / 382.1 MB, free: 2.598 MB / 346.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001062/0.08186, allocations: 100.1 kB / 382.2 MB, free: 2.5 MB / 346.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0002048/0.08207, allocations: 305.2 kB / 382.5 MB, free: 2.199 MB / 346.7 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.002627/0.08469, allocations: 3.107 MB / 385.6 MB, free: 15.06 MB / 362.7 MB
Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.01014/0.09483, allocations: 9.245 MB / 394.9 MB, free: 5.719 MB / 362.7 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.001044/0.09588, allocations: 1.002 MB / 395.9 MB, free: 4.711 MB / 362.7 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0006316/0.09651, allocations: 0.6267 MB / 396.5 MB, free: 4.082 MB / 362.7 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.008449/0.105, allocations: 7.234 MB / 403.7 MB, free: 12.82 MB / 378.7 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.026e-05/0.105, allocations: 43.56 kB / 403.8 MB, free: 12.77 MB / 378.7 MB
Notification: Performance of pre-optimization done (n=160): time 2.375e-06/0.105, allocations: 0 / 403.8 MB, free: 12.77 MB / 378.7 MB
Notification: Performance of matching and sorting (n=230): time 0.02282/0.1278, allocations: 12.9 MB / 416.7 MB, free: 15.73 MB / 394.7 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 3.749e-05/0.1278, allocations: 72.7 kB / 416.7 MB, free: 15.64 MB / 394.7 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Chemical master/Interfaces.mo:1332:3-1332:55:writable] Warning: Parameter reaction.nextProducts[1].data.MM has no value, and is fixed during initialization (fixed=true), using available start value (start=0.0) as default value.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Chemical master/Interfaces.mo:1333:3-1333:87:writable] Warning: Parameter reaction.nextProducts[1].data.Hf has no value, and is fixed during initialization (fixed=true), using available start value (start=0.0) as default value.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Chemical master/Interfaces.mo:1334:3-1334:81:writable] Warning: Parameter reaction.nextProducts[1].data.H0 has no value, and is fixed during initialization (fixed=true), using available start value (start=0.0) as default value.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Chemical master/Interfaces.mo:1336:3-1336:82:writable] Warning: Parameter reaction.nextProducts[1].data.alow[1] has no value, and is fixed during initialization (fixed=true), using available start value (start=0.0) as default value.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Chemical master/Interfaces.mo:1336:3-1336:82:writable] Warning: Parameter reaction.nextProducts[1].data.alow[2] has no value, and is fixed during initialization (fixed=true), using available start value (start=0.0) as default value.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Chemical master/Interfaces.mo:1336:3-1336:82:writable] Warning: Parameter reaction.nextProducts[1].data.alow[3] has no value, and is fixed during initialization (fixed=true), using available start value (start=0.0) as default value.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Chemical master/Interfaces.mo:1336:3-1336:82:writable] Warning: Parameter reaction.nextProducts[1].data.alow[4] has no value, and is fixed during initialization (fixed=true), using available start value (start=0.0) as default value.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Chemical master/Interfaces.mo:1336:3-1336:82:writable] Warning: Parameter reaction.nextProducts[1].data.alow[5] has no value, and is fixed during initialization (fixed=true), using available start value (start=0.0) as default value.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Chemical master/Interfaces.mo:1336:3-1336:82:writable] Warning: Parameter reaction.nextProducts[1].data.alow[6] has no value, and is fixed during initialization (fixed=true), using available start value (start=0.0) as default value.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Chemical master/Interfaces.mo:1336:3-1336:82:writable] Warning: Parameter reaction.nextProducts[1].data.alow[7] has no value, and is fixed during initialization (fixed=true), using available start value (start=0.0) as default value.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Chemical master/Interfaces.mo:1337:3-1337:79:writable] Warning: Parameter reaction.nextProducts[1].data.blow[1] has no value, and is fixed during initialization (fixed=true), using available start value (start=0.0) as default value.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Chemical master/Interfaces.mo:1337:3-1337:79:writable] Warning: Parameter reaction.nextProducts[1].data.blow[2] has no value, and is fixed during initialization (fixed=true), using available start value (start=0.0) as default value.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Chemical master/Interfaces.mo:1337:3-1337:79:writable] Warning: Parameter reaction.nextProducts[1].data.blow[3] has no value, and is fixed during initialization (fixed=true), using available start value (start=0.0) as default value.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Chemical master/Interfaces.mo:1338:3-1338:84:writable] Warning: Parameter reaction.nextProducts[1].data.ahigh[1] has no value, and is fixed during initialization (fixed=true), using available start value (start=0.0) as default value.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Chemical master/Interfaces.mo:1338:3-1338:84:writable] Warning: Parameter reaction.nextProducts[1].data.ahigh[2] has no value, and is fixed during initialization (fixed=true), using available start value (start=0.0) as default value.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Chemical master/Interfaces.mo:1338:3-1338:84:writable] Warning: Parameter reaction.nextProducts[1].data.ahigh[3] has no value, and is fixed during initialization (fixed=true), using available start value (start=0.0) as default value.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Chemical master/Interfaces.mo:1338:3-1338:84:writable] Warning: Parameter reaction.nextProducts[1].data.ahigh[4] has no value, and is fixed during initialization (fixed=true), using available start value (start=0.0) as default value.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Chemical master/Interfaces.mo:1338:3-1338:84:writable] Warning: Parameter reaction.nextProducts[1].data.ahigh[5] has no value, and is fixed during initialization (fixed=true), using available start value (start=0.0) as default value.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Chemical master/Interfaces.mo:1338:3-1338:84:writable] Warning: Parameter reaction.nextProducts[1].data.ahigh[6] has no value, and is fixed during initialization (fixed=true), using available start value (start=0.0) as default value.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Chemical master/Interfaces.mo:1338:3-1338:84:writable] Warning: Parameter reaction.nextProducts[1].data.ahigh[7] has no value, and is fixed during initialization (fixed=true), using available start value (start=0.0) as default value.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Chemical master/Interfaces.mo:1339:3-1339:81:writable] Warning: Parameter reaction.nextProducts[1].data.bhigh[1] has no value, and is fixed during initialization (fixed=true), using available start value (start=0.0) as default value.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Chemical master/Interfaces.mo:1339:3-1339:81:writable] Warning: Parameter reaction.nextProducts[1].data.bhigh[2] has no value, and is fixed during initialization (fixed=true), using available start value (start=0.0) as default value.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Chemical master/Interfaces.mo:1339:3-1339:81:writable] Warning: Parameter reaction.nextProducts[1].data.bhigh[3] has no value, and is fixed during initialization (fixed=true), using available start value (start=0.0) as default value.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Chemical master/Interfaces.mo:1341:3-1342:83:writable] Warning: Parameter reaction.nextProducts[1].data.z has no value, and is fixed during initialization (fixed=true), using available start value (start=0.0) as default value.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Chemical master/Interfaces.mo:1344:3-1344:89:writable] Warning: Parameter reaction.nextProducts[1].data.phase has no value, and is fixed during initialization (fixed=true), using available start value (start=Chemical.Interfaces.Phase.Gas) as default value.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Chemical master/Interfaces.mo:1347:3-1347:140:writable] Warning: Parameter reaction.nextProducts[1].data.VmBase has no value, and is fixed during initialization (fixed=true), using available start value (start=0.0) as default value.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Chemical master/Interfaces.mo:1348:3-1348:137:writable] Warning: Parameter reaction.nextProducts[1].data.VmExcess has no value, and is fixed during initialization (fixed=true), using available start value (start=0.0) as default value.
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001004/0.1288, allocations: 1.137 MB / 417.9 MB, free: 14.49 MB / 394.7 MB
Notification: Performance of collectPreVariables (initialization): time 0.0002878/0.1291, allocations: 49.7 kB / 417.9 MB, free: 14.43 MB / 394.7 MB
Notification: Performance of collectInitialEqns (initialization): time 0.0004758/0.1296, allocations: 1.091 MB / 419 MB, free: 13.33 MB / 394.7 MB
Notification: Performance of collectInitialBindings (initialization): time 0.000534/0.1301, allocations: 0.7859 MB / 419.8 MB, free: 12.54 MB / 394.7 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.000724/0.1309, allocations: 447.7 kB / 420.2 MB, free: 12.09 MB / 394.7 MB
Notification: Performance of setup shared object (initialization): time 6.888e-05/0.1309, allocations: 305.1 kB / 420.5 MB, free: 11.79 MB / 394.7 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001346/0.1323, allocations: 0.9642 MB / 421.5 MB, free: 10.82 MB / 394.7 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001227/0.1335, allocations: 1.444 MB / 422.9 MB, free: 9.156 MB / 394.7 MB
Notification: It was not possible to check the given initialization system for consistency symbolically, because the relevant equations are part of an algebraic loop. This is not supported yet.
Notification: Performance of analyzeInitialSystem (initialization): time 0.003882/0.1374, allocations: 4.171 MB / 427.1 MB, free: 4.809 MB / 394.7 MB
Warning: It was not possible to solve the under-determined initial system (205 equations and 233 variables)
Error: No system for the symbolic initialization was generated
"
[Timeout remaining time 660]
[Calling sys.exit(0), Time elapsed: 1.9186816839501262]