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.0007336/0.0007336, allocations: 72.45 kB / 19.17 MB, free: 0.7344 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.0007884/0.0007884, allocations: 173.9 kB / 22.46 MB, free: 2.086 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.8346/0.8346, allocations: 177.1 MB / 202.8 MB, free: 5.723 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.07715/0.07715, allocations: 17.45 MB / 276.6 MB, free: 11.75 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.293e-06/1.293e-06, allocations: 0 / 411.6 MB, free: 272 kB / 378.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 1.367e-05/1.496e-05, allocations: 6.219 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.02488/0.0249, allocations: 30.28 MB / 441.9 MB, free: 2.043 MB / 410.7 MB
Notification: Performance of NFInst.instExpressions: time 0.1523/0.1772, allocations: 9.603 MB / 451.5 MB, free: 58.71 MB / 410.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0008861/0.1781, allocations: 62.69 kB / 451.5 MB, free: 58.68 MB / 410.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.002386/0.1805, allocations: 1.855 MB / 453.4 MB, free: 57.75 MB / 410.7 MB
Notification: Performance of NFTyping.typeBindings: time 0.001598/0.1821, allocations: 1.351 MB / 454.7 MB, free: 56.88 MB / 410.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.00335/0.1854, allocations: 3.977 MB / 458.7 MB, free: 54.5 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.002247/0.1877, allocations: 2.904 MB / 461.6 MB, free: 53.06 MB / 410.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.0006322/0.1883, allocations: 0.5337 MB / 462.2 MB, free: 52.79 MB / 410.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.001505/0.1898, allocations: 1.633 MB / 463.8 MB, free: 52.08 MB / 410.7 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.001317/0.1911, allocations: 1.239 MB / 465 MB, free: 51.67 MB / 410.7 MB
Notification: Performance of NFPackage.collectConstants: time 0.0003686/0.1915, allocations: 246.2 kB / 465.3 MB, free: 51.67 MB / 410.7 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.003058/0.1945, allocations: 1.99 MB / 467.3 MB, free: 51.19 MB / 410.7 MB
Notification: Performance of NFScalarize.scalarize: time 0.0003596/0.1949, allocations: 0.8408 MB / 468.1 MB, free: 50.71 MB / 410.7 MB
Notification: Performance of NFVerifyModel.verify: time 0.0006208/0.1955, allocations: 0.9144 MB / 469 MB, free: 50.3 MB / 410.7 MB
Notification: Performance of NFConvertDAE.convert: time 0.003742/0.1993, allocations: 5.199 MB / 474.2 MB, free: 48.02 MB / 410.7 MB
Notification: Performance of FrontEnd - DAE generated: time 4.108e-06/0.1993, allocations: 2.625 kB / 474.2 MB, free: 48.02 MB / 410.7 MB
Notification: Performance of FrontEnd: time 1.744e-06/0.1993, allocations: 0 / 474.2 MB, free: 48.02 MB / 410.7 MB
Notification: Performance of Transformations before backend: time 8.352e-05/0.1993, allocations: 0 / 474.2 MB, free: 48.02 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.003409/0.2028, allocations: 3.426 MB / 477.6 MB, free: 46.02 MB / 410.7 MB
Notification: Performance of prepare preOptimizeDAE: time 3.713e-05/0.2028, allocations: 9.938 kB / 477.7 MB, free: 46.02 MB / 410.7 MB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.0002347/0.203, allocations: 391.1 kB / 478 MB, free: 45.8 MB / 410.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.001062/0.2041, allocations: 0.729 MB / 478.8 MB, free: 45.53 MB / 410.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.00127/0.2054, allocations: 1.519 MB / 480.3 MB, free: 44.55 MB / 410.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001687/0.2055, allocations: 409.6 kB / 480.7 MB, free: 44.21 MB / 410.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001807/0.2057, allocations: 236.2 kB / 480.9 MB, free: 44.13 MB / 410.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.006262/0.212, allocations: 8.305 MB / 489.2 MB, free: 40.57 MB / 410.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 4.316e-05/0.212, allocations: 1.906 kB / 489.2 MB, free: 40.57 MB / 410.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001213/0.2121, allocations: 98.2 kB / 489.3 MB, free: 40.49 MB / 410.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0002228/0.2124, allocations: 309.6 kB / 489.6 MB, free: 40.43 MB / 410.7 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.009653/0.222, allocations: 14.21 MB / 0.492 GB, free: 35.15 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.01487/0.2369, allocations: 16.7 MB / 0.5083 GB, free: 20.96 MB / 410.7 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.001987/0.2389, allocations: 2.76 MB / 0.511 GB, free: 18.45 MB / 410.7 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001528/0.2404, allocations: 2.438 MB / 0.5134 GB, free: 16.22 MB / 410.7 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.009257/0.2497, allocations: 12.51 MB / 0.5256 GB, free: 4.012 MB / 410.7 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 2.097e-05/0.2497, allocations: 50.23 kB / 0.5257 GB, free: 3.957 MB / 410.7 MB
Notification: Performance of pre-optimization done (n=160): time 2.806e-06/0.2497, allocations: 0 / 0.5257 GB, free: 3.957 MB / 410.7 MB
Notification: Performance of matching and sorting (n=230): time 0.0288/0.2785, allocations: 22.58 MB / 0.5477 GB, free: 13.3 MB / 442.7 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 4.667e-05/0.2785, allocations: 72.7 kB / 0.5478 GB, free: 13.22 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.001612/0.2801, allocations: 1.447 MB / 0.5492 GB, free: 11.77 MB / 442.7 MB
Notification: Performance of collectPreVariables (initialization): time 0.0003305/0.2805, allocations: 49.7 kB / 0.5493 GB, free: 11.72 MB / 442.7 MB
Notification: Performance of collectInitialEqns (initialization): time 0.0009189/0.2814, allocations: 1.315 MB / 0.5505 GB, free: 10.39 MB / 442.7 MB
Notification: Performance of collectInitialBindings (initialization): time 0.0004716/0.2819, allocations: 0.777 MB / 0.5513 GB, free: 9.609 MB / 442.7 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0007795/0.2826, allocations: 0.5625 MB / 0.5518 GB, free: 9.039 MB / 442.7 MB
Notification: Performance of setup shared object (initialization): time 6.405e-05/0.2827, allocations: 305.1 kB / 0.5521 GB, free: 8.738 MB / 442.7 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.002951/0.2857, allocations: 3.373 MB / 0.5554 GB, free: 5.367 MB / 442.7 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.003452/0.2891, allocations: 3.907 MB / 0.5592 GB, free: 1.234 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.1618/0.4509, allocations: 57.71 MB / 0.6156 GB, free: 7.926 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.1402648240327835]
Failed to read output from testmodel.py, exit status != 0:
0.6045530438423157 0.611077088 0.41041046000000003
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x713ba93b03e0>