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.0006979/0.0006979, allocations: 80.44 kB / 19.17 MB, free: 0.7422 MB / 13.93 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.0007367/0.0007367, allocations: 165.9 kB / 22.46 MB, free: 2.105 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.8214/0.8214, allocations: 177.1 MB / 202.8 MB, free: 5.742 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.0778/0.0778, allocations: 17.45 MB / 276.6 MB, free: 11.77 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: "" <> buildModelFMU(Chemical.Examples.SimpleReactionInSolution,fileNamePrefix="Chemical_master_Chemical_Examples_SimpleReactionInSolution",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(Chemical.Examples.SimpleReactionInSolution,fileNamePrefix="Chemical_master_Chemical_Examples_SimpleReactionInSolution",fmuType="me",version="2.0",platforms={"static"}) [Timeout 660]
"Notification: Performance of FrontEnd - loaded program: time 1.263e-06/1.263e-06, allocations: 0 / 411.6 MB, free: 268 kB / 378.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 8.185e-06/9.448e-06, allocations: 2.281 kB / 411.6 MB, free: 264 kB / 378.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.02043/0.02043, allocations: 30.29 MB / 441.9 MB, free: 2.02 MB / 410.7 MB
Notification: Performance of NFInst.instExpressions: time 0.1494/0.1699, allocations: 9.61 MB / 451.5 MB, free: 58.78 MB / 410.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0008262/0.1707, allocations: 64.03 kB / 451.6 MB, free: 58.75 MB / 410.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.002442/0.1731, allocations: 1.847 MB / 453.4 MB, free: 57.81 MB / 410.7 MB
Notification: Performance of NFTyping.typeBindings: time 0.00221/0.1753, allocations: 1.348 MB / 454.7 MB, free: 56.95 MB / 410.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.003789/0.1791, allocations: 3.977 MB / 458.7 MB, free: 54.56 MB / 410.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.002402/0.1815, allocations: 2.904 MB / 461.6 MB, free: 53.13 MB / 410.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.0005138/0.1821, allocations: 0.5324 MB / 462.2 MB, free: 52.86 MB / 410.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.001102/0.1832, allocations: 1.636 MB / 463.8 MB, free: 52.14 MB / 410.7 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.0008449/0.184, allocations: 1.237 MB / 465 MB, free: 51.73 MB / 410.7 MB
Notification: Performance of NFPackage.collectConstants: time 0.0001622/0.1842, allocations: 246.8 kB / 465.3 MB, free: 51.73 MB / 410.7 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.002707/0.1869, allocations: 1.99 MB / 467.3 MB, free: 51.25 MB / 410.7 MB
Notification: Performance of NFScalarize.scalarize: time 0.0003181/0.1872, allocations: 0.8436 MB / 468.1 MB, free: 50.77 MB / 410.7 MB
Notification: Performance of NFVerifyModel.verify: time 0.0005036/0.1877, allocations: 0.9063 MB / 469 MB, free: 50.36 MB / 410.7 MB
Notification: Performance of NFConvertDAE.convert: time 0.003863/0.1916, allocations: 5.204 MB / 474.2 MB, free: 48.09 MB / 410.7 MB
Notification: Performance of FrontEnd - DAE generated: time 4.739e-06/0.1916, allocations: 3.25 kB / 474.2 MB, free: 48.09 MB / 410.7 MB
Notification: Performance of FrontEnd: time 2.104e-06/0.1916, allocations: 0 / 474.2 MB, free: 48.09 MB / 410.7 MB
Notification: Performance of Transformations before backend: time 2.957e-05/0.1916, allocations: 0 / 474.2 MB, free: 48.09 MB / 410.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.003297/0.1949, allocations: 3.42 MB / 477.6 MB, free: 46.09 MB / 410.7 MB
Notification: Performance of prepare preOptimizeDAE: time 4.088e-05/0.1949, allocations: 9.594 kB / 477.6 MB, free: 46.09 MB / 410.7 MB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.0002408/0.1952, allocations: 393.4 kB / 478 MB, free: 45.87 MB / 410.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.001089/0.1963, allocations: 0.7278 MB / 478.8 MB, free: 45.6 MB / 410.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.001268/0.1975, allocations: 1.516 MB / 480.3 MB, free: 44.61 MB / 410.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001948/0.1977, allocations: 412.7 kB / 480.7 MB, free: 44.27 MB / 410.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001959/0.1979, allocations: 243.5 kB / 480.9 MB, free: 44.19 MB / 410.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.005914/0.2038, allocations: 8.299 MB / 489.2 MB, free: 40.63 MB / 410.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 3.662e-05/0.2039, allocations: 2.875 kB / 489.2 MB, free: 40.63 MB / 410.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001211/0.204, allocations: 100.5 kB / 489.3 MB, free: 40.55 MB / 410.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.000224/0.2042, allocations: 301.2 kB / 489.6 MB, free: 40.5 MB / 410.7 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.009294/0.2135, allocations: 14.22 MB / 0.492 GB, free: 35.21 MB / 410.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.0141/0.2276, allocations: 16.71 MB / 0.5083 GB, free: 21 MB / 410.7 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.002048/0.2297, allocations: 2.765 MB / 0.511 GB, free: 18.48 MB / 410.7 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001563/0.2312, allocations: 2.43 MB / 0.5134 GB, free: 16.26 MB / 410.7 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.009688/0.2409, allocations: 12.51 MB / 0.5256 GB, free: 3.996 MB / 410.7 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 2.168e-05/0.2409, allocations: 43.56 kB / 0.5257 GB, free: 3.945 MB / 410.7 MB
Notification: Performance of pre-optimization done (n=160): time 3.066e-06/0.2409, allocations: 2.656 kB / 0.5257 GB, free: 3.945 MB / 410.7 MB
Notification: Performance of matching and sorting (n=230): time 0.02955/0.2705, allocations: 22.59 MB / 0.5477 GB, free: 13.29 MB / 442.7 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 4.27e-05/0.2705, allocations: 68.72 kB / 0.5478 GB, free: 13.21 MB / 442.7 MB
[/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.
[/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: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: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: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: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[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[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: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[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[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[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[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[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[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: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[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[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: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[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[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[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[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[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: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: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: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.
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001473/0.272, allocations: 1.446 MB / 0.5492 GB, free: 11.75 MB / 442.7 MB
Notification: Performance of collectPreVariables (initialization): time 0.000252/0.2723, allocations: 52.39 kB / 0.5493 GB, free: 11.7 MB / 442.7 MB
Notification: Performance of collectInitialEqns (initialization): time 0.0005949/0.2728, allocations: 1.311 MB / 0.5505 GB, free: 10.38 MB / 442.7 MB
Notification: Performance of collectInitialBindings (initialization): time 0.0005403/0.2734, allocations: 0.7744 MB / 0.5513 GB, free: 9.594 MB / 442.7 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0008196/0.2742, allocations: 0.5624 MB / 0.5518 GB, free: 9.023 MB / 442.7 MB
Notification: Performance of setup shared object (initialization): time 7.044e-05/0.2743, allocations: 309 kB / 0.5521 GB, free: 8.719 MB / 442.7 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.003028/0.2773, allocations: 3.372 MB / 0.5554 GB, free: 5.348 MB / 442.7 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.003334/0.2806, allocations: 3.899 MB / 0.5592 GB, free: 1.223 MB / 442.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.1616/0.4423, allocations: 57.72 MB / 0.6156 GB, free: 7.902 MB / 0.4948 GB
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 659]
[Calling sys.exit(0), Time elapsed: 2.122363490983844]
Failed to read output from testmodel.py, exit status != 0:
0.6050299564376473 0.612118155 0.41907439799999996
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7c7a26fc0410>