Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ClaRa_dev_ClaRa.Components.Mills.PhysicalMills.Volumes.Check.TestGrinder.conf.json loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/SMArtInt main/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/SMArtInt main/package.mo): time 0.01667/0.01667, allocations: 1.792 MB / 21.15 MB, free: 3.246 MB / 18.57 MB " [Timeout remaining time 180] 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.001636/0.001636, allocations: 79.19 kB / 24.88 MB, free: 6.832 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.001686/0.001686, allocations: 164.3 kB / 28.74 MB, free: 3.645 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 1.527/1.527, allocations: 177.1 MB / 209.6 MB, free: 2.402 MB / 186.7 MB " [Timeout remaining time 178] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ClaRa main/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ClaRa main/package.mo): time 1.187/1.187, allocations: 102.4 MB / 369.1 MB, free: 0.875 MB / 330.8 MB " [Timeout remaining time 179] Using package ClaRa with version 1.9.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ClaRa main/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) Using package SMArtInt with version 1.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/SMArtInt main/package.mo) Running command: translateModel(ClaRa.Components.Mills.PhysicalMills.Volumes.Check.TestGrinder,tolerance=1e-06,outputFormat="mat",numberOfIntervals=10005,variableFilter="Time|grinder.T|grinder.height.1,10.|grinder.height.1,11.|grinder.height.1,12.|grinder.height.1,13.|grinder.height.1,14.|grinder.height.1,15.|grinder.height.1,16.|grinder.height.1,17.|grinder.height.1,18.|grinder.height.1,19.|grinder.height.1,1.|grinder.height.1,20.|grinder.height.1,21.|grinder.height.1,2.|grinder.height.1,3.|grinder.height.1,4.|grinder.height.1,5.|grinder.height.1,6.|grinder.height.1,7.|grinder.height.1,8.|grinder.height.1,9.|grinder.height.10,10.|grinder.height.10,11.|grinder.height.10,12.|grinder.height.10,13.|grinder.height.10,14.|grinder.height.10,15.|grinder.height.10,16.|grinder.height.10,17.|grinder.height.10,18.|grinder.height.10,19.|grinder.height.10,1.|grinder.height.10,20.|grinder.height.10,21.|grinder.height.10,2.|grinder.height.10,3.|grinder.height.10,4.|grinder.height.10,5.|grinder.height.10,6.|grinder.height.10,7.|grinder.height.10,8.|grinder.height.10,9.|grinder.height.2,10.|grinder.height.2,11.|grinder.height.2,12.|grinder.height.2,13.|grinder.height.2,14.|grinder.height.2,15.|grinder.height.2,16.|grinder.height.2,17.|grinder.height.2,18.|grinder.height.2,19.|grinder.height.2,1.|grinder.height.2,20.|grinder.height.2,21.|grinder.height.2,2.|grinder.height.2,3.|grinder.height.2,4.|grinder.height.2,5.|grinder.height.2,6.|grinder.height.2,7.|grinder.height.2,8.|grinder.height.2,9.|grinder.height.3,10.|grinder.height.3,11.|grinder.height.3,12.|grinder.height.3,13.|grinder.height.3,14.|grinder.height.3,15.|grinder.height.3,16.|grinder.height.3,17.|grinder.height.3,18.|grinder.height.3,19.|grinder.height.3,1.|grinder.height.3,20.|grinder.height.3,21.|grinder.height.3,2.|grinder.height.3,3.|grinder.height.3,4.|grinder.height.3,5.|grinder.height.3,6.|grinder.height.3,7.|grinder.height.3,8.|grinder.height.3,9.|grinder.height.4,10.|grinder.height.4,11.|grinder.height.4,12.|grinder.height.4,13.|grinder.height.4,14.|grinder.height.4,15.|grinder.height.4,16.|grinder.height.4,17.|grinder.height.4,18.|grinder.height.4,19.|grinder.height.4,1.|grinder.height.4,20.|grinder.height.4,21.|grinder.height.4,2.|grinder.height.4,3.|grinder.height.4,4.|grinder.height.4,5.|grinder.height.4,6.|grinder.height.4,7.|grinder.height.4,8.|grinder.height.4,9.|grinder.height.5,10.|grinder.height.5,11.|grinder.height.5,12.|grinder.height.5,13.|grinder.height.5,14.|grinder.height.5,15.|grinder.height.5,16.|grinder.height.5,17.|grinder.height.5,18.|grinder.height.5,19.|grinder.height.5,1.|grinder.height.5,20.|grinder.height.5,21.|grinder.height.5,2.|grinder.height.5,3.|grinder.height.5,4.|grinder.height.5,5.|grinder.height.5,6.|grinder.height.5,7.|grinder.height.5,8.|grinder.height.5,9.|grinder.height.6,10.|grinder.height.6,11.|grinder.height.6,12.|grinder.height.6,13.|grinder.height.6,14.|grinder.height.6,15.|grinder.height.6,16.|grinder.height.6,17.|grinder.height.6,18.|grinder.height.6,19.|grinder.height.6,1.|grinder.height.6,20.|grinder.height.6,21.|grinder.height.6,2.|grinder.height.6,3.|grinder.height.6,4.|grinder.height.6,5.|grinder.height.6,6.|grinder.height.6,7.|grinder.height.6,8.|grinder.height.6,9.|grinder.height.7,10.|grinder.height.7,11.|grinder.height.7,12.|grinder.height.7,13.|grinder.height.7,14.|grinder.height.7,15.|grinder.height.7,16.|grinder.height.7,17.|grinder.height.7,18.|grinder.height.7,19.|grinder.height.7,1.|grinder.height.7,20.|grinder.height.7,21.|grinder.height.7,2.|grinder.height.7,3.|grinder.height.7,4.|grinder.height.7,5.|grinder.height.7,6.|grinder.height.7,7.|grinder.height.7,8.|grinder.height.7,9.|grinder.height.8,10.|grinder.height.8,11.|grinder.height.8,12.|grinder.height.8,13.|grinder.height.8,14.|grinder.height.8,15.|grinder.height.8,16.|grinder.height.8,17.|grinder.height.8,18.|grinder.height.8,19.|grinder.height.8,1.|grinder.height.8,20.|grinder.height.8,21.|grinder.height.8,2.|grinder.height.8,3.|grinder.height.8,4.|grinder.height.8,5.|grinder.height.8,6.|grinder.height.8,7.|grinder.height.8,8.|grinder.height.8,9.|grinder.height.9,10.|grinder.height.9,11.|grinder.height.9,12.|grinder.height.9,13.|grinder.height.9,14.|grinder.height.9,15.|grinder.height.9,16.|grinder.height.9,17.|grinder.height.9,18.|grinder.height.9,19.|grinder.height.9,1.|grinder.height.9,20.|grinder.height.9,21.|grinder.height.9,2.|grinder.height.9,3.|grinder.height.9,4.|grinder.height.9,5.|grinder.height.9,6.|grinder.height.9,7.|grinder.height.9,8.|grinder.height.9,9.|grinder.xi.1.|grinder.xi.2.|grinder.xi.3.|grinder.xi.4.|grinder.xi.5.|grinder.xi.6.",fileNamePrefix="ClaRa_dev_ClaRa.Components.Mills.PhysicalMills.Volumes.Check.TestGrinder") translateModel(ClaRa.Components.Mills.PhysicalMills.Volumes.Check.TestGrinder,tolerance=1e-06,outputFormat="mat",numberOfIntervals=10005,variableFilter="Time|grinder.T|grinder.height.1,10.|grinder.height.1,11.|grinder.height.1,12.|grinder.height.1,13.|grinder.height.1,14.|grinder.height.1,15.|grinder.height.1,16.|grinder.height.1,17.|grinder.height.1,18.|grinder.height.1,19.|grinder.height.1,1.|grinder.height.1,20.|grinder.height.1,21.|grinder.height.1,2.|grinder.height.1,3.|grinder.height.1,4.|grinder.height.1,5.|grinder.height.1,6.|grinder.height.1,7.|grinder.height.1,8.|grinder.height.1,9.|grinder.height.10,10.|grinder.height.10,11.|grinder.height.10,12.|grinder.height.10,13.|grinder.height.10,14.|grinder.height.10,15.|grinder.height.10,16.|grinder.height.10,17.|grinder.height.10,18.|grinder.height.10,19.|grinder.height.10,1.|grinder.height.10,20.|grinder.height.10,21.|grinder.height.10,2.|grinder.height.10,3.|grinder.height.10,4.|grinder.height.10,5.|grinder.height.10,6.|grinder.height.10,7.|grinder.height.10,8.|grinder.height.10,9.|grinder.height.2,10.|grinder.height.2,11.|grinder.height.2,12.|grinder.height.2,13.|grinder.height.2,14.|grinder.height.2,15.|grinder.height.2,16.|grinder.height.2,17.|grinder.height.2,18.|grinder.height.2,19.|grinder.height.2,1.|grinder.height.2,20.|grinder.height.2,21.|grinder.height.2,2.|grinder.height.2,3.|grinder.height.2,4.|grinder.height.2,5.|grinder.height.2,6.|grinder.height.2,7.|grinder.height.2,8.|grinder.height.2,9.|grinder.height.3,10.|grinder.height.3,11.|grinder.height.3,12.|grinder.height.3,13.|grinder.height.3,14.|grinder.height.3,15.|grinder.height.3,16.|grinder.height.3,17.|grinder.height.3,18.|grinder.height.3,19.|grinder.height.3,1.|grinder.height.3,20.|grinder.height.3,21.|grinder.height.3,2.|grinder.height.3,3.|grinder.height.3,4.|grinder.height.3,5.|grinder.height.3,6.|grinder.height.3,7.|grinder.height.3,8.|grinder.height.3,9.|grinder.height.4,10.|grinder.height.4,11.|grinder.height.4,12.|grinder.height.4,13.|grinder.height.4,14.|grinder.height.4,15.|grinder.height.4,16.|grinder.height.4,17.|grinder.height.4,18.|grinder.height.4,19.|grinder.height.4,1.|grinder.height.4,20.|grinder.height.4,21.|grinder.height.4,2.|grinder.height.4,3.|grinder.height.4,4.|grinder.height.4,5.|grinder.height.4,6.|grinder.height.4,7.|grinder.height.4,8.|grinder.height.4,9.|grinder.height.5,10.|grinder.height.5,11.|grinder.height.5,12.|grinder.height.5,13.|grinder.height.5,14.|grinder.height.5,15.|grinder.height.5,16.|grinder.height.5,17.|grinder.height.5,18.|grinder.height.5,19.|grinder.height.5,1.|grinder.height.5,20.|grinder.height.5,21.|grinder.height.5,2.|grinder.height.5,3.|grinder.height.5,4.|grinder.height.5,5.|grinder.height.5,6.|grinder.height.5,7.|grinder.height.5,8.|grinder.height.5,9.|grinder.height.6,10.|grinder.height.6,11.|grinder.height.6,12.|grinder.height.6,13.|grinder.height.6,14.|grinder.height.6,15.|grinder.height.6,16.|grinder.height.6,17.|grinder.height.6,18.|grinder.height.6,19.|grinder.height.6,1.|grinder.height.6,20.|grinder.height.6,21.|grinder.height.6,2.|grinder.height.6,3.|grinder.height.6,4.|grinder.height.6,5.|grinder.height.6,6.|grinder.height.6,7.|grinder.height.6,8.|grinder.height.6,9.|grinder.height.7,10.|grinder.height.7,11.|grinder.height.7,12.|grinder.height.7,13.|grinder.height.7,14.|grinder.height.7,15.|grinder.height.7,16.|grinder.height.7,17.|grinder.height.7,18.|grinder.height.7,19.|grinder.height.7,1.|grinder.height.7,20.|grinder.height.7,21.|grinder.height.7,2.|grinder.height.7,3.|grinder.height.7,4.|grinder.height.7,5.|grinder.height.7,6.|grinder.height.7,7.|grinder.height.7,8.|grinder.height.7,9.|grinder.height.8,10.|grinder.height.8,11.|grinder.height.8,12.|grinder.height.8,13.|grinder.height.8,14.|grinder.height.8,15.|grinder.height.8,16.|grinder.height.8,17.|grinder.height.8,18.|grinder.height.8,19.|grinder.height.8,1.|grinder.height.8,20.|grinder.height.8,21.|grinder.height.8,2.|grinder.height.8,3.|grinder.height.8,4.|grinder.height.8,5.|grinder.height.8,6.|grinder.height.8,7.|grinder.height.8,8.|grinder.height.8,9.|grinder.height.9,10.|grinder.height.9,11.|grinder.height.9,12.|grinder.height.9,13.|grinder.height.9,14.|grinder.height.9,15.|grinder.height.9,16.|grinder.height.9,17.|grinder.height.9,18.|grinder.height.9,19.|grinder.height.9,1.|grinder.height.9,20.|grinder.height.9,21.|grinder.height.9,2.|grinder.height.9,3.|grinder.height.9,4.|grinder.height.9,5.|grinder.height.9,6.|grinder.height.9,7.|grinder.height.9,8.|grinder.height.9,9.|grinder.xi.1.|grinder.xi.2.|grinder.xi.3.|grinder.xi.4.|grinder.xi.5.|grinder.xi.6.",fileNamePrefix="ClaRa_dev_ClaRa.Components.Mills.PhysicalMills.Volumes.Check.TestGrinder") [Timeout 800] "Notification: Performance of FrontEnd - loaded program: time 2.164e-06/2.164e-06, allocations: 0 / 469.2 MB, free: 12.93 MB / 442.8 MB Notification: Performance of FrontEnd - Absyn->SCode: time 4.414e-05/4.631e-05, allocations: 6.25 kB / 469.2 MB, free: 12.92 MB / 442.8 MB Notification: TILMedia requested package Modelica of version 4.0.0. Modelica 4.1.0 is used instead which states that it is fully compatible without conversion script needed. Notification: Automatically loaded package TILMedia 1.9.0 ClaRa due to usage. Notification: Performance of NFInst.instantiate(ClaRa.Components.Mills.PhysicalMills.Volumes.Check.TestGrinder): time 0.2053/0.2053, allocations: 57.17 MB / 0.514 GB, free: 3.754 MB / 490.8 MB Notification: Performance of NFInst.instExpressions: time 0.3521/0.5574, allocations: 10.07 MB / 0.5238 GB, free: 72.36 MB / 490.8 MB Notification: Performance of NFInst.updateImplicitVariability: time 0.00207/0.5595, allocations: 38.72 kB / 0.5239 GB, free: 72.36 MB / 490.8 MB [/home/hudson/saved_omc/libraries/.openmodelica/libraries/ClaRa main/SimCenter.mo:71:5-72:35:writable] Warning: Connector cycleSumPort is not balanced: The number of potential variables (0) is not equal to the number of flow variables (4). Notification: Performance of NFTyping.typeComponents: time 0.004174/0.5637, allocations: 1.529 MB / 0.5254 GB, free: 72.07 MB / 490.8 MB Notification: Performance of NFTyping.typeBindings: time 0.004169/0.5678, allocations: 1.818 MB / 0.5271 GB, free: 71.58 MB / 490.8 MB Notification: Performance of NFTyping.typeClassSections: time 0.003564/0.5714, allocations: 1.401 MB / 0.5285 GB, free: 71.08 MB / 490.8 MB Notification: Performance of NFFlatten.flatten: time 0.0187/0.5901, allocations: 16.96 MB / 0.5451 GB, free: 64.5 MB / 490.8 MB Notification: Performance of NFFlatten.resolveConnections: time 0.01691/0.607, allocations: 6.529 MB / 0.5514 GB, free: 60.78 MB / 490.8 MB Notification: Performance of NFEvalConstants.evaluate: time 0.02948/0.6365, allocations: 8.128 MB / 0.5594 GB, free: 57.33 MB / 490.8 MB Notification: Performance of NFSimplifyModel.simplify: time 0.03231/0.6688, allocations: 27.26 MB / 0.586 GB, free: 34.49 MB / 490.8 MB Notification: Performance of NFPackage.collectConstants: time 0.02376/0.6926, allocations: 7.156 MB / 0.593 GB, free: 27.34 MB / 490.8 MB Notification: Performance of NFFlatten.collectFunctions: time 0.026/0.7186, allocations: 8.235 MB / 0.601 GB, free: 19.1 MB / 490.8 MB Notification: Performance of NFScalarize.scalarize: time 0.03397/0.7525, allocations: 19.27 MB / 0.6198 GB, free: 15.8 MB / 0.4949 GB Notification: Performance of NFVerifyModel.verify: time 0.04947/0.802, allocations: 16.73 MB / 0.6362 GB, free: 15.05 MB / 0.5105 GB Notification: Performance of NFConvertDAE.convert: time 0.1562/0.9582, allocations: 97.11 MB / 0.731 GB, free: 13.75 MB / 0.6043 GB Notification: Performance of FrontEnd - DAE generated: time 1.4e-05/0.9582, allocations: 0 / 0.731 GB, free: 13.75 MB / 0.6043 GB Notification: Performance of FrontEnd: time 3.907e-06/0.9582, allocations: 0 / 0.731 GB, free: 13.75 MB / 0.6043 GB Notification: Performance of Transformations before backend: time 0.00139/0.9596, allocations: 0 / 0.731 GB, free: 13.75 MB / 0.6043 GB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 3256 * Number of variables: 3256 Notification: Performance of Generate backend data structure: time 0.6351/1.595, allocations: 81.62 MB / 0.8107 GB, free: 102.8 MB / 0.6043 GB Notification: Performance of prepare preOptimizeDAE: time 5.177e-05/1.595, allocations: 12.58 kB / 0.8107 GB, free: 102.7 MB / 0.6043 GB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.05974/1.655, allocations: 3.008 MB / 0.8137 GB, free: 99.73 MB / 0.6043 GB Notification: Performance of preOpt evaluateParameters (simulation): time 0.07512/1.73, allocations: 18.19 MB / 0.8314 GB, free: 82.35 MB / 0.6043 GB Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.02009/1.75, allocations: 25.19 MB / 0.856 GB, free: 51.75 MB / 0.6043 GB Notification: Performance of preOpt expandDerOperator (simulation): time 0.03171/1.781, allocations: 1.148 MB / 0.8572 GB, free: 50.61 MB / 0.6043 GB Notification: Performance of preOpt clockPartitioning (simulation): time 0.2515/2.033, allocations: 69.19 MB / 0.9247 GB, free: 12.53 MB / 0.6355 GB Notification: Performance of preOpt findStateOrder (simulation): time 0.0005513/2.034, allocations: 11.88 kB / 0.9247 GB, free: 12.52 MB / 0.6355 GB Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.02623/2.06, allocations: 452 kB / 0.9252 GB, free: 12.07 MB / 0.6355 GB Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.001249/2.061, allocations: 0.9583 MB / 0.9261 GB, free: 11.11 MB / 0.6355 GB Notification: Performance of preOpt removeEqualRHS (simulation): time 1.401/3.462, allocations: 176.9 MB / 1.099 GB, free: 188.1 MB / 0.7137 GB Notification: Performance of preOpt removeSimpleEquations (simulation): time 1.12/4.582, allocations: 0.5369 GB / 1.636 GB, free: 203.1 MB / 0.7449 GB Notification: Performance of preOpt comSubExp (simulation): time 0.04053/4.623, allocations: 13.96 MB / 1.649 GB, free: 200 MB / 0.7449 GB Notification: Performance of preOpt resolveLoops (simulation): time 0.03677/4.66, allocations: 14.67 MB / 1.664 GB, free: 186.6 MB / 0.7449 GB Notification: Performance of preOpt evalFunc (simulation): time 0.003361/4.663, allocations: 361.4 kB / 1.664 GB, free: 186.3 MB / 0.7449 GB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0001658/4.663, allocations: 205.7 kB / 1.664 GB, free: 186.1 MB / 0.7449 GB Notification: Performance of pre-optimization done (n=1447): time 2.123e-05/4.663, allocations: 0 / 1.664 GB, free: 186.1 MB / 0.7449 GB Notification: Performance of matching and sorting (n=1447): time 0.1253/4.788, allocations: 32.54 MB / 1.696 GB, free: 157.2 MB / 0.7449 GB Notification: Performance of inlineWhenForInitialization (initialization): time 0.0005561/4.789, allocations: 2.36 MB / 1.698 GB, free: 154.3 MB / 0.7449 GB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.02829/4.817, allocations: 16.3 MB / 1.714 GB, free: 138.4 MB / 0.7449 GB Notification: Performance of collectPreVariables (initialization): time 0.005625/4.823, allocations: 265.7 kB / 1.715 GB, free: 138.2 MB / 0.7449 GB Notification: Performance of collectInitialEqns (initialization): time 0.005534/4.828, allocations: 7.367 MB / 1.722 GB, free: 131.1 MB / 0.7449 GB Notification: Performance of collectInitialBindings (initialization): time 0.01026/4.839, allocations: 6.079 MB / 1.728 GB, free: 125.1 MB / 0.7449 GB Notification: Performance of simplifyInitialFunctions (initialization): time 0.03603/4.875, allocations: 5.978 MB / 1.733 GB, free: 119.1 MB / 0.7449 GB Notification: Performance of setup shared object (initialization): time 7.113e-05/4.875, allocations: 480.7 kB / 1.734 GB, free: 118.6 MB / 0.7449 GB Notification: Performance of preBalanceInitialSystem (initialization): time 0.03737/4.912, allocations: 12.67 MB / 1.746 GB, free: 105.9 MB / 0.7449 GB Notification: Performance of partitionIndependentBlocks (initialization): time 0.04642/4.959, allocations: 28.54 MB / 1.774 GB, free: 71.36 MB / 0.7449 GB Notification: Performance of analyzeInitialSystem (initialization): time 0.3923/5.351, allocations: 50.08 MB / 1.823 GB, free: 219.8 MB / 0.7449 GB Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0004346/5.351, allocations: 78.25 kB / 1.823 GB, free: 219.8 MB / 0.7449 GB Notification: Performance of matching and sorting (n=3116) (initialization): time 0.1313/5.483, allocations: 35.74 MB / 1.858 GB, free: 217.6 MB / 0.7449 GB Notification: Performance of prepare postOptimizeDAE: time 0.0002947/5.483, allocations: 122.3 kB / 1.858 GB, free: 217.6 MB / 0.7449 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.000676/5.484, allocations: 266.5 kB / 1.858 GB, free: 217.6 MB / 0.7449 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.0004651/5.484, allocations: 401.2 kB / 1.859 GB, free: 217.6 MB / 0.7449 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.04638/5.53, allocations: 8.931 MB / 1.868 GB, free: 217 MB / 0.7449 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0012/5.532, allocations: 0.5623 MB / 1.868 GB, free: 216.9 MB / 0.7449 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.03974/5.571, allocations: 6.635 MB / 1.875 GB, free: 215.9 MB / 0.7449 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.01062/5.582, allocations: 1.163 MB / 1.876 GB, free: 215.9 MB / 0.7449 GB Warning: Assuming fixed start value for the following 207 variables: grinder.T:VARIABLE(min = 0.0 start = grinder.T_start unit = \"K\" fixed = true ) \"temperature in fuel controll volume\" type: Real grinder.xi[1]:VARIABLE(min = 0.0 start = grinder.xi_fuel_start[1] unit = \"kg/kg\" fixed = true nominal = 1.0 ) \"composition in fuel control volume\" type: Real [6] grinder.xi[2]:VARIABLE(min = 0.0 start = grinder.xi_fuel_start[2] unit = \"kg/kg\" fixed = true nominal = 1.0 ) \"composition in fuel control volume\" type: Real [6] grinder.xi[3]:VARIABLE(min = 0.0 start = grinder.xi_fuel_start[3] unit = \"kg/kg\" fixed = true nominal = 1.0 ) \"composition in fuel control volume\" type: Real [6] grinder.xi[4]:VARIABLE(min = 0.0 start = grinder.xi_fuel_start[4] unit = \"kg/kg\" fixed = true nominal = 1.0 ) \"composition in fuel control volume\" type: Real [6] grinder.xi[5]:VARIABLE(min = 0.0 start = grinder.xi_fuel_start[5] unit = \"kg/kg\" fixed = true nominal = 1.0 ) \"composition in fuel control volume\" type: Real [6] grinder.xi[6]:VARIABLE(min = 0.0 start = grinder.xi_fuel_start[6] unit = \"kg/kg\" fixed = true nominal = 1.0 ) \"composition in fuel control volume\" type: Real [6] grinder.height[10,21]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[10,20]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[10,19]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[10,18]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[10,17]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[10,16]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[10,15]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[10,14]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[10,13]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[10,12]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[10,11]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[10,10]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[10,9]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[10,8]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[10,7]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[10,6]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[10,5]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[10,4]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[10,3]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[10,2]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[9,21]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[9,20]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[9,19]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[9,18]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[9,17]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[9,16]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[9,15]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[9,14]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[9,13]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[9,12]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[9,11]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[9,10]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[9,9]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[9,8]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[9,7]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[9,6]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[9,5]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[9,4]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[9,3]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[9,2]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[8,21]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[8,20]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[8,19]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[8,18]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[8,17]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[8,16]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[8,15]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[8,14]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[8,13]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[8,12]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[8,11]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[8,10]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[8,9]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[8,8]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[8,7]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[8,6]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[8,5]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[8,4]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[8,3]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[8,2]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[7,21]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[7,20]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[7,19]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[7,18]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[7,17]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[7,16]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[7,15]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[7,14]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[7,13]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[7,12]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[7,11]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[7,10]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[7,9]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[7,8]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[7,7]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[7,6]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[7,5]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[7,4]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[7,3]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[7,2]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[6,21]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[6,20]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[6,19]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[6,18]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[6,17]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[6,16]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[6,15]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[6,14]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[6,13]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[6,12]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[6,11]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[6,10]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[6,9]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[6,8]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[6,7]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[6,6]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[6,5]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[6,4]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[6,3]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[6,2]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[5,21]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[5,20]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[5,19]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[5,18]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[5,17]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[5,16]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[5,15]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[5,14]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[5,13]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[5,12]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[5,11]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[5,10]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[5,9]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[5,8]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[5,7]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[5,6]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[5,5]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[5,4]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[5,3]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[5,2]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[4,21]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[4,20]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[4,19]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[4,18]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[4,17]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[4,16]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[4,15]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[4,14]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[4,13]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[4,12]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[4,11]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[4,10]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[4,9]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[4,8]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[4,7]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[4,6]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[4,5]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[4,4]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[4,3]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[4,2]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[3,21]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[3,20]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[3,19]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[3,18]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[3,17]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[3,16]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[3,15]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[3,14]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[3,13]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[3,12]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[3,11]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[3,10]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[3,9]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[3,8]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[3,7]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[3,6]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[3,5]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[3,4]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[3,3]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[3,2]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[2,21]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[2,20]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[2,19]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[2,18]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[2,17]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[2,16]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[2,15]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[2,14]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[2,13]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[2,12]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[2,11]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[2,10]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[2,9]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[2,8]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[2,7]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[2,6]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[2,5]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[2,4]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[2,3]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[2,2]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[1,21]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[1,20]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[1,19]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[1,18]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[1,17]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[1,16]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[1,15]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[1,14]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[1,13]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[1,12]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[1,11]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[1,10]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[1,9]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[1,8]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[1,7]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[1,6]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[1,5]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[1,4]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[1,3]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] grinder.height[1,2]:VARIABLE(unit = \"m\" fixed = true nominal = 1.0 ) type: Real [10,21] Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 1219 * 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 (3116): * Single equations (assignments): 3116 * Array equations: 0 * Algorithm blocks: 0 * Record equations: 0 * When equations: 0 * If-equations: 0 * Equation systems (not torn): 0 * Torn equation systems: 0 * Mixed (continuous/discrete) equation systems: 0 Notification: Performance of prepare postOptimizeDAE: time 0.02423/5.606, allocations: 2.787 MB / 1.878 GB, free: 214.9 MB / 0.7449 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.01723/5.623, allocations: 1.876 MB / 1.88 GB, free: 214.2 MB / 0.7449 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.107/5.73, allocations: 28.58 MB / 1.908 GB, free: 195.2 MB / 0.7449 GB Notification: Performance of postOpt inlineArrayEqn (simulation): time 9.952e-05/5.73, allocations: 156 kB / 1.908 GB, free: 195 MB / 0.7449 GB Notification: Performance of postOpt constantLinearSystem (simulation): time 3.311e-05/5.731, allocations: 0.875 kB / 1.908 GB, free: 195 MB / 0.7449 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.0003608/5.731, allocations: 83.44 kB / 1.908 GB, free: 195 MB / 0.7449 GB Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.289/6.02, allocations: 85.07 MB / 1.991 GB, free: 107 MB / 0.7449 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 0.0004455/6.02, allocations: 92 kB / 1.992 GB, free: 106.9 MB / 0.7449 GB Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.03025/6.051, allocations: 6.054 MB / 1.997 GB, free: 100.9 MB / 0.7449 GB Notification: Performance of postOpt tearingSystem (simulation): time 0.0003032/6.051, allocations: 156 kB / 1.998 GB, free: 100.7 MB / 0.7449 GB Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.008102/6.059, allocations: 0.5736 MB / 1.998 GB, free: 100.1 MB / 0.7449 GB Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.005966/6.065, allocations: 16.83 MB / 2.015 GB, free: 82.21 MB / 0.7449 GB Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 6.106e-05/6.065, allocations: 143.4 kB / 2.015 GB, free: 82.07 MB / 0.7449 GB Notification: Performance of postOpt symbolicJacobian (simulation): time 0.1369/6.202, allocations: 47.04 MB / 2.061 GB, free: 32.38 MB / 0.7449 GB Notification: Performance of postOpt removeConstants (simulation): time 0.05762/6.26, allocations: 16.48 MB / 2.077 GB, free: 15.79 MB / 0.7449 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.01157/6.271, allocations: 0.5544 MB / 2.077 GB, free: 15.23 MB / 0.7449 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.02802/6.299, allocations: 3.851 MB / 2.081 GB, free: 11.38 MB / 0.7449 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.01132/6.311, allocations: 1.474 MB / 2.083 GB, free: 9.898 MB / 0.7449 GB Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.008008/6.319, allocations: 0.7264 MB / 2.083 GB, free: 9.172 MB / 0.7449 GB Notification: Performance of sorting global known variables: time 0.01879/6.337, allocations: 8.191 MB / 2.091 GB, free: 1.016 MB / 0.7449 GB Notification: Performance of sort global known variables: time 2.6e-07/6.337, allocations: 4 kB / 2.091 GB, free: 1.012 MB / 0.7449 GB Notification: Performance of remove unused functions: time 0.3901/6.727, allocations: 6.927 MB / 2.098 GB, free: 230.7 MB / 0.7605 GB Notification: Model statistics after passing the back-end for simulation: * Number of independent subsystems: 420 * Number of states: 217 (grinder.T,grinder.xi[1],grinder.xi[2],grinder.xi[3],grinder.xi[4],grinder.xi[5],grinder.xi[6],grinder.height[1,1],grinder.height[1,2],grinder.height[1,3],grinder.height[1,4],grinder.height[1,5],grinder.height[1,6],grinder.height[1,7],grinder.height[1,8],grinder.height[1,9],grinder.height[1,10],grinder.height[1,11],grinder.height[1,12],grinder.height[1,13],grinder.height[1,14],grinder.height[1,15],grinder.height[1,16],grinder.height[1,17],grinder.height[1,18],grinder.height[1,19],grinder.height[1,20],grinder.height[1,21],grinder.height[2,1],grinder.height[2,2],grinder.height[2,3],grinder.height[2,4],grinder.height[2,5],grinder.height[2,6],grinder.height[2,7],grinder.height[2,8],grinder.height[2,9],grinder.height[2,10],grinder.height[2,11],grinder.height[2,12],grinder.height[2,13],grinder.height[2,14],grinder.height[2,15],grinder.height[2,16],grinder.height[2,17],grinder.height[2,18],grinder.height[2,19],grinder.height[2,20],grinder.height[2,21],grinder.height[3,1],grinder.height[3,2],grinder.height[3,3],grinder.height[3,4],grinder.height[3,5],grinder.height[3,6],grinder.height[3,7],grinder.height[3,8],grinder.height[3,9],grinder.height[3,10],grinder.height[3,11],grinder.height[3,12],grinder.height[3,13],grinder.height[3,14],grinder.height[3,15],grinder.height[3,16],grinder.height[3,17],grinder.height[3,18],grinder.height[3,19],grinder.height[3,20],grinder.height[3,21],grinder.height[4,1],grinder.height[4,2],grinder.height[4,3],grinder.height[4,4],grinder.height[4,5],grinder.height[4,6],grinder.height[4,7],grinder.height[4,8],grinder.height[4,9],grinder.height[4,10],grinder.height[4,11],grinder.height[4,12],grinder.height[4,13],grinder.height[4,14],grinder.height[4,15],grinder.height[4,16],grinder.height[4,17],grinder.height[4,18],grinder.height[4,19],grinder.height[4,20],grinder.height[4,21],grinder.height[5,1],grinder.height[5,2],grinder.height[5,3],grinder.height[5,4],grinder.height[5,5],grinder.height[5,6],grinder.height[5,7],grinder.height[5,8],grinder.height[5,9],grinder.height[5,10],grinder.height[5,11],grinder.height[5,12],grinder.height[5,13],grinder.height[5,14],grinder.height[5,15],grinder.height[5,16],grinder.height[5,17],grinder.height[5,18],grinder.height[5,19],grinder.height[5,20],grinder.height[5,21],grinder.height[6,1],grinder.height[6,2],grinder.height[6,3],grinder.height[6,4],grinder.height[6,5],grinder.height[6,6],grinder.height[6,7],grinder.height[6,8],grinder.height[6,9],grinder.height[6,10],grinder.height[6,11],grinder.height[6,12],grinder.height[6,13],grinder.height[6,14],grinder.height[6,15],grinder.height[6,16],grinder.height[6,17],grinder.height[6,18],grinder.height[6,19],grinder.height[6,20],grinder.height[6,21],grinder.height[7,1],grinder.height[7,2],grinder.height[7,3],grinder.height[7,4],grinder.height[7,5],grinder.height[7,6],grinder.height[7,7],grinder.height[7,8],grinder.height[7,9],grinder.height[7,10],grinder.height[7,11],grinder.height[7,12],grinder.height[7,13],grinder.height[7,14],grinder.height[7,15],grinder.height[7,16],grinder.height[7,17],grinder.height[7,18],grinder.height[7,19],grinder.height[7,20],grinder.height[7,21],grinder.height[8,1],grinder.height[8,2],grinder.height[8,3],grinder.height[8,4],grinder.height[8,5],grinder.height[8,6],grinder.height[8,7],grinder.height[8,8],grinder.height[8,9],grinder.height[8,10],grinder.height[8,11],grinder.height[8,12],grinder.height[8,13],grinder.height[8,14],grinder.height[8,15],grinder.height[8,16],grinder.height[8,17],grinder.height[8,18],grinder.height[8,19],grinder.height[8,20],grinder.height[8,21],grinder.height[9,1],grinder.height[9,2],grinder.height[9,3],grinder.height[9,4],grinder.height[9,5],grinder.height[9,6],grinder.height[9,7],grinder.height[9,8],grinder.height[9,9],grinder.height[9,10],grinder.height[9,11],grinder.height[9,12],grinder.height[9,13],grinder.height[9,14],grinder.height[9,15],grinder.height[9,16],grinder.height[9,17],grinder.height[9,18],grinder.height[9,19],grinder.height[9,20],grinder.height[9,21],grinder.height[10,1],grinder.height[10,2],grinder.height[10,3],grinder.height[10,4],grinder.height[10,5],grinder.height[10,6],grinder.height[10,7],grinder.height[10,8],grinder.height[10,9],grinder.height[10,10],grinder.height[10,11],grinder.height[10,12],grinder.height[10,13],grinder.height[10,14],grinder.height[10,15],grinder.height[10,16],grinder.height[10,17],grinder.height[10,18],grinder.height[10,19],grinder.height[10,20],grinder.height[10,21]) * 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 (1680): * Single equations (assignments): 1680 * Array equations: 0 * Algorithm blocks: 0 * Record equations: 0 * When equations: 0 * If-equations: 0 * Equation systems (not torn): 0 * Torn equation systems: 0 * Mixed (continuous/discrete) equation systems: 0 Notification: Performance of Backend phase and start with SimCode phase: time 0.01332/6.741, allocations: 1.519 MB / 2.099 GB, free: 230.5 MB / 0.7605 GB Notification: Performance of simCode: created initialization part: time 0.1016/6.842, allocations: 28.79 MB / 2.128 GB, free: 228.8 MB / 0.7605 GB Notification: Performance of simCode: created event and clocks part: time 0.0001795/6.843, allocations: 20.8 kB / 2.128 GB, free: 228.8 MB / 0.7605 GB Notification: Performance of simCode: created simulation system equations: time 0.04293/6.885, allocations: 11.11 MB / 2.138 GB, free: 228.1 MB / 0.7605 GB Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.03243/6.918, allocations: 2.924 MB / 2.141 GB, free: 228 MB / 0.7605 GB Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.1387/7.057, allocations: 56.89 MB / 2.197 GB, free: 190 MB / 0.7605 GB Notification: Performance of simCode: some other stuff during SimCode phase: time 0.01041/7.067, allocations: 6.529 MB / 2.203 GB, free: 184.2 MB / 0.7605 GB Notification: Performance of simCode: alias equations: time 0.04637/7.113, allocations: 11.01 MB / 2.214 GB, free: 173.1 MB / 0.7605 GB Notification: Performance of simCode: all other stuff during SimCode phase: time 0.02572/7.139, allocations: 1.34 MB / 2.215 GB, free: 171.8 MB / 0.7605 GB Notification: Performance of SimCode: time 4.439e-06/7.139, allocations: 4 kB / 2.215 GB, free: 171.8 MB / 0.7605 GB Notification: Performance of Templates: time 0.7219/7.861, allocations: 331 MB / 2.539 GB, free: 112.8 MB / 0.7605 GB " [Timeout remaining time 792] make -j1 -f ClaRa_dev_ClaRa.Components.Mills.PhysicalMills.Volumes.Check.TestGrinder.makefile [Timeout 800] (rm -f ClaRa_dev_ClaRa.Components.Mills.PhysicalMills.Volumes.Check.TestGrinder.pipe ; mkfifo ClaRa_dev_ClaRa.Components.Mills.PhysicalMills.Volumes.Check.TestGrinder.pipe ; head -c 1048576 < ClaRa_dev_ClaRa.Components.Mills.PhysicalMills.Volumes.Check.TestGrinder.pipe >> ../files/ClaRa_dev_ClaRa.Components.Mills.PhysicalMills.Volumes.Check.TestGrinder.sim & ./ClaRa_dev_ClaRa.Components.Mills.PhysicalMills.Volumes.Check.TestGrinder -abortSlowSimulation -alarm=240 -emit_protected -lv LOG_STATS > ClaRa_dev_ClaRa.Components.Mills.PhysicalMills.Volumes.Check.TestGrinder.pipe 2>&1) [Timeout 240] diffSimulationResults("ClaRa_dev_ClaRa.Components.Mills.PhysicalMills.Volumes.Check.TestGrinder_res.mat","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/ReferenceFiles/ClaRa/ReferenceResults/ClaRa.Components.Mills.PhysicalMills.Volumes.Check.TestGrinder.mat","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/ClaRa_dev_ClaRa.Components.Mills.PhysicalMills.Volumes.Check.TestGrinder.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001) [Timeout 800] "" [Timeout remaining time 799] Reference file matches [Calling sys.exit(0), Time elapsed: 29.166256895987317]