Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr Modelica_trunk_cpp_Modelica.Math.FastFourierTransform.Examples.RealFFT1.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo", uses=false)
Using package ModelicaServices with version trunk (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo)
Using package Modelica with version trunk (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo)
Using package Complex with version trunk (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo)
Running command: translateModel(Modelica.Math.FastFourierTransform.Examples.RealFFT1,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|Ai.1.|Ai.2.|Ai.3.|Ai.4.|Ai.5.|Ai.6.|Ai.7.|Ai.8.|Ai.9.|Ai.10.|Ai.11.|Ai.12.|Ai.13.|Ai.14.|Ai.15.|Ai.16.|Ai.17.|Ai.18.|Ai.19.|Ai.20.|Ai.21.|Phii.1.|Phii.2.|Phii.3.|Phii.4.|Phii.5.|Phii.6.|Phii.7.|Phii.8.|Phii.9.|Phii.10.|Phii.11.|Phii.12.|Phii.13.|Phii.14.|Phii.15.|Phii.16.|Phii.17.|Phii.18.|Phii.19.|Phii.20.|Phii.21.|info|y",fileNamePrefix="Modelica_trunk_cpp_Modelica.Math.FastFourierTransform.Examples.RealFFT1")
translateModel(Modelica.Math.FastFourierTransform.Examples.RealFFT1,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|Ai.1.|Ai.2.|Ai.3.|Ai.4.|Ai.5.|Ai.6.|Ai.7.|Ai.8.|Ai.9.|Ai.10.|Ai.11.|Ai.12.|Ai.13.|Ai.14.|Ai.15.|Ai.16.|Ai.17.|Ai.18.|Ai.19.|Ai.20.|Ai.21.|Phii.1.|Phii.2.|Phii.3.|Phii.4.|Phii.5.|Phii.6.|Phii.7.|Phii.8.|Phii.9.|Phii.10.|Phii.11.|Phii.12.|Phii.13.|Phii.14.|Phii.15.|Phii.16.|Phii.17.|Phii.18.|Phii.19.|Phii.20.|Phii.21.|info|y",fileNamePrefix="Modelica_trunk_cpp_Modelica.Math.FastFourierTransform.Examples.RealFFT1")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo): time 0.001906/0.001906, allocations: 200.1 kB / 18.07 MB, free: 3.762 MB / 13.93 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo): time 3.137/3.137, allocations: 226.5 MB / 245.3 MB, free: 8.23 MB / 202.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo): time 0.00152/0.00152, allocations: 101.7 kB / 297.4 MB, free: 6.902 MB / 234.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0005223/0.0005227, allocations: 11.98 kB / 357.4 MB, free: 10.97 MB / 298.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.5931/0.5936, allocations: 51.28 MB / 408.7 MB, free: 27.74 MB / 298.7 MB
Notification: Performance of FrontEnd - scodeFlatten: time 0.1878/0.7815, allocations: 78.89 MB / 487.5 MB, free: 12.75 MB / 362.7 MB
Notification: Performance of FrontEnd - mkProgramGraph: time 0.0004645/0.7821, allocations: 76.47 kB / 487.6 MB, free: 12.67 MB / 362.7 MB
Notification: Performance of FrontEnd - DAE generated: time 0.06949/0.8516, allocations: 13.9 MB / 0.4898 GB, free: 14.75 MB / 378.7 MB
Notification: Performance of FrontEnd: time 3.898e-06/0.8517, allocations: 0 / 0.4898 GB, free: 14.75 MB / 378.7 MB
Notification: Performance of Transformations before backend: time 4.734e-05/0.8518, allocations: 12 kB / 0.4898 GB, free: 14.74 MB / 378.7 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 245
 * Number of variables: 245
Notification: Performance of Generate backend data structure: time 0.002516/0.8543, allocations: 1.042 MB / 0.4908 GB, free: 13.64 MB / 378.7 MB
Notification: Performance of prepare preOptimizeDAE: time 5.845e-05/0.8544, allocations: 12.03 kB / 0.4908 GB, free: 13.62 MB / 378.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0004864/0.8549, allocations: 83.89 kB / 0.4909 GB, free: 13.54 MB / 378.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.001424/0.8563, allocations: 411.4 kB / 0.4913 GB, free: 13.1 MB / 378.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 2.842e-05/0.8564, allocations: 8.375 kB / 0.4913 GB, free: 13.09 MB / 378.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 7.054e-05/0.8565, allocations: 12.38 kB / 0.4913 GB, free: 13.08 MB / 378.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.001658/0.8581, allocations: 0.8685 MB / 0.4921 GB, free: 12.21 MB / 378.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 1.442e-05/0.8582, allocations: 3.938 kB / 0.4922 GB, free: 12.2 MB / 378.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 4.042e-05/0.8582, allocations: 0 / 0.4922 GB, free: 12.2 MB / 378.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 8.295e-06/0.8582, allocations: 0 / 0.4922 GB, free: 12.2 MB / 378.7 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.001306/0.8595, allocations: 0.7751 MB / 0.4929 GB, free: 11.43 MB / 378.7 MB
Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.0007206/0.8603, allocations: 415.9 kB / 0.4933 GB, free: 10.97 MB / 378.7 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.002906/0.8632, allocations: 2.078 MB / 0.4953 GB, free: 8.883 MB / 378.7 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.002984/0.8662, allocations: 2.075 MB / 0.4974 GB, free: 6.809 MB / 378.7 MB
Notification: Performance of preOpt evalFunc (simulation): time 1.995e-05/0.8663, allocations: 4 kB / 0.4974 GB, free: 6.805 MB / 378.7 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.002005/0.8683, allocations: 1.119 MB / 0.4985 GB, free: 5.668 MB / 378.7 MB
Notification: Performance of pre-optimization done (n=246): time 3.557e-06/0.8683, allocations: 0 / 0.4985 GB, free: 5.668 MB / 378.7 MB
Notification: Performance of matching and sorting (n=246): time 0.01441/0.8827, allocations: 4.903 MB / 0.5032 GB, free: 0.7578 MB / 378.7 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0005022/0.8833, allocations: 428.5 kB / 0.5037 GB, free: 320 kB / 378.7 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0003905/0.8837, allocations: 187 kB / 0.5038 GB, free: 120 kB / 378.7 MB
Notification: Performance of collectPreVariables (initialization): time 0.4956/1.379, allocations: 204.4 kB / 0.504 GB, free: 100.1 MB / 378.7 MB
Notification: Performance of collectInitialEqns (initialization): time 0.0002008/1.38, allocations: 105.7 kB / 0.5041 GB, free: 100 MB / 378.7 MB
Notification: Performance of collectInitialBindings (initialization): time 0.002378/1.382, allocations: 0.9725 MB / 0.5051 GB, free: 99.58 MB / 378.7 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0006083/1.383, allocations: 82.06 kB / 0.5052 GB, free: 99.58 MB / 378.7 MB
Notification: Performance of setup shared object (initialization): time 0.0006542/1.383, allocations: 479.2 kB / 0.5056 GB, free: 99.26 MB / 378.7 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.008936/1.392, allocations: 1.093 MB / 0.5067 GB, free: 99.24 MB / 378.7 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.006337/1.399, allocations: 2.836 MB / 0.5095 GB, free: 96.9 MB / 378.7 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.00893/1.408, allocations: 4.176 MB / 0.5135 GB, free: 93.71 MB / 378.7 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0001217/1.408, allocations: 16.59 kB / 0.5135 GB, free: 93.71 MB / 378.7 MB
Notification: Performance of matching and sorting (n=512) (initialization): time 0.0181/1.426, allocations: 3.998 MB / 0.5175 GB, free: 92.15 MB / 378.7 MB
Notification: Performance of prepare postOptimizeDAE: time 0.0002552/1.426, allocations: 57.7 kB / 0.5175 GB, free: 92.09 MB / 378.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0002359/1.427, allocations: 56 kB / 0.5176 GB, free: 92.04 MB / 378.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0002067/1.427, allocations: 84 kB / 0.5176 GB, free: 91.95 MB / 378.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.003497/1.431, allocations: 0.5712 MB / 0.5182 GB, free: 91.44 MB / 378.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0001781/1.431, allocations: 121.2 kB / 0.5183 GB, free: 91.34 MB / 378.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.007793/1.439, allocations: 332.6 kB / 0.5186 GB, free: 91.02 MB / 378.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0008943/1.44, allocations: 196 kB / 0.5188 GB, free: 90.82 MB / 378.7 MB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 267
 * Number of states: 0 ()
 * Number of discrete variables: 93 ($PRE.Phii[21],Phii[21],$PRE.Phii[20],Phii[20],$PRE.Phii[19],Phii[19],$PRE.Phii[18],Phii[18],$PRE.Phii[17],Phii[17],$PRE.Phii[16],Phii[16],$PRE.Phii[15],Phii[15],$PRE.Phii[14],Phii[14],$PRE.Phii[13],Phii[13],$PRE.Phii[12],Phii[12],$PRE.Phii[11],Phii[11],$PRE.Phii[10],Phii[10],$PRE.Phii[9],Phii[9],$PRE.Phii[8],Phii[8],$PRE.Phii[7],Phii[7],$PRE.Phii[6],Phii[6],$PRE.Phii[5],Phii[5],$PRE.Phii[4],Phii[4],$PRE.Phii[3],Phii[3],$PRE.Phii[2],Phii[2],$PRE.Phii[1],Phii[1],$PRE.Ai[21],Ai[21],$PRE.Ai[20],Ai[20],$PRE.Ai[19],Ai[19],$PRE.Ai[18],Ai[18],$PRE.Ai[17],Ai[17],$PRE.Ai[16],Ai[16],$PRE.Ai[15],Ai[15],$PRE.Ai[14],Ai[14],$PRE.Ai[13],Ai[13],$PRE.Ai[12],Ai[12],$PRE.Ai[11],Ai[11],$PRE.Ai[10],Ai[10],$PRE.Ai[9],Ai[9],$PRE.Ai[8],Ai[8],$PRE.Ai[7],Ai[7],$PRE.Ai[6],Ai[6],$PRE.Ai[5],Ai[5],$PRE.Ai[4],Ai[4],$PRE.Ai[3],Ai[3],$PRE.Ai[2],Ai[2],$PRE.Ai[1],Ai[1],$PRE.info,info,$PRE.y_buf[200],y_buf[200],$PRE.y,y,$PRE.iTick,iTick,$whenCondition1)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (512):
 * Single equations (assignments): 511
 * Array equations: 0
 * Algorithm blocks: 1
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of prepare postOptimizeDAE: time 0.002434/1.442, allocations: 0.8493 MB / 0.5196 GB, free: 90.1 MB / 378.7 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0005188/1.443, allocations: 119 kB / 0.5198 GB, free: 89.98 MB / 378.7 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 6.406e-05/1.443, allocations: 21.34 kB / 0.5198 GB, free: 89.96 MB / 378.7 MB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 7.033e-06/1.443, allocations: 0 / 0.5198 GB, free: 89.96 MB / 378.7 MB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.08e-05/1.443, allocations: 0 / 0.5198 GB, free: 89.96 MB / 378.7 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 1.007e-05/1.443, allocations: 4 kB / 0.5198 GB, free: 89.96 MB / 378.7 MB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.000986/1.444, allocations: 0.5639 MB / 0.5203 GB, free: 89.5 MB / 378.7 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 6.382e-06/1.444, allocations: 0 / 0.5203 GB, free: 89.5 MB / 378.7 MB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 5.69e-06/1.444, allocations: 8.875 kB / 0.5203 GB, free: 89.49 MB / 378.7 MB
Notification: Performance of postOpt tearingSystem (simulation): time 1.274e-05/1.444, allocations: 3.938 kB / 0.5203 GB, free: 89.49 MB / 378.7 MB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0001804/1.444, allocations: 47.94 kB / 0.5204 GB, free: 89.44 MB / 378.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 7.013e-06/1.444, allocations: 0 / 0.5204 GB, free: 89.44 MB / 378.7 MB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.655e-06/1.444, allocations: 2.438 kB / 0.5204 GB, free: 89.44 MB / 378.7 MB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.03602/1.48, allocations: 22.27 MB / 0.5421 GB, free: 67.38 MB / 378.7 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.0003211/1.48, allocations: 179.6 kB / 0.5423 GB, free: 67.18 MB / 378.7 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0003248/1.481, allocations: 72.39 kB / 0.5424 GB, free: 67.11 MB / 378.7 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0007246/1.482, allocations: 36.03 kB / 0.5424 GB, free: 67.07 MB / 378.7 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001756/1.482, allocations: 27.98 kB / 0.5424 GB, free: 67.05 MB / 378.7 MB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0002098/1.482, allocations: 75.98 kB / 0.5425 GB, free: 66.97 MB / 378.7 MB
Notification: Performance of sorting global known variables: time 0.000192/1.482, allocations: 123.2 kB / 0.5426 GB, free: 66.85 MB / 378.7 MB
Notification: Performance of sort global known variables: time 5.11e-07/1.482, allocations: 0 / 0.5426 GB, free: 66.85 MB / 378.7 MB
Notification: Performance of remove unused functions: time 0.004526/1.487, allocations: 0.5284 MB / 0.5431 GB, free: 66.34 MB / 378.7 MB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 1
 * Number of states: 0 ()
 * Number of discrete variables: 47 ($whenCondition1,y,Ai[1],Ai[2],Ai[3],Ai[4],Ai[5],Ai[6],Ai[7],Ai[8],Ai[9],Ai[10],Ai[11],Ai[12],Ai[13],Ai[14],Ai[15],Ai[16],Ai[17],Ai[18],Ai[19],Ai[20],Ai[21],Phii[1],Phii[2],Phii[3],Phii[4],Phii[5],Phii[6],Phii[7],Phii[8],Phii[9],Phii[10],Phii[11],Phii[12],Phii[13],Phii[14],Phii[15],Phii[16],Phii[17],Phii[18],Phii[19],Phii[20],Phii[21],info,iTick,y_buf[200])
 * Number of discrete states: 47 (Phii[21],Phii[20],Phii[19],Phii[18],Phii[17],Phii[16],Phii[15],Phii[14],Phii[13],Phii[12],Phii[11],Phii[10],Phii[9],Phii[8],Phii[7],Phii[6],Phii[5],Phii[4],Phii[3],Phii[2],Phii[1],Ai[21],Ai[20],Ai[19],Ai[18],Ai[17],Ai[16],Ai[15],Ai[14],Ai[13],Ai[12],Ai[11],Ai[10],Ai[9],Ai[8],Ai[7],Ai[6],Ai[5],Ai[4],Ai[3],Ai[2],Ai[1],info,y_buf[200],y,iTick,$whenCondition1)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (1):
 * Single equations (assignments): 0
 * Array equations: 0
 * Algorithm blocks: 1
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of Backend phase and start with SimCode phase: time 0.001454/1.488, allocations: 427.4 kB / 0.5436 GB, free: 66.01 MB / 378.7 MB
Notification: Performance of simCode: created initialization part: time 0.01189/1.5, allocations: 3.433 MB / 0.5469 GB, free: 62.57 MB / 378.7 MB
Notification: Performance of simCode: created event and clocks part: time 9.207e-06/1.5, allocations: 0 / 0.5469 GB, free: 62.57 MB / 378.7 MB
Notification: Performance of simCode: created simulation system equations: time 0.05884/1.559, allocations: 59.45 MB / 0.605 GB, free: 3.098 MB / 378.7 MB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.0008084/1.56, allocations: 78.09 kB / 0.605 GB, free: 3.023 MB / 378.7 MB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.004807/1.565, allocations: 2.471 MB / 0.6075 GB, free: 0.5117 MB / 378.7 MB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0008229/1.566, allocations: 1 MB / 0.6084 GB, free: 15.48 MB / 394.7 MB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0004491/1.566, allocations: 75.44 kB / 0.6085 GB, free: 15.41 MB / 394.7 MB
Notification: Performance of SimCode: time 1.473e-06/1.566, allocations: 0 / 0.6085 GB, free: 15.41 MB / 394.7 MB
Notification: Performance of Templates: time 0.06457/1.631, allocations: 16.61 MB / 0.6247 GB, free: 14.83 MB / 410.7 MB
make -j1 -f Modelica_trunk_cpp_Modelica.Math.FastFourierTransform.Examples.RealFFT1.makefile
(rm -f Modelica_trunk_cpp_Modelica.Math.FastFourierTransform.Examples.RealFFT1.pipe ; mkfifo Modelica_trunk_cpp_Modelica.Math.FastFourierTransform.Examples.RealFFT1.pipe ; head -c 1048576 < Modelica_trunk_cpp_Modelica.Math.FastFourierTransform.Examples.RealFFT1.pipe >> ../files/Modelica_trunk_cpp_Modelica.Math.FastFourierTransform.Examples.RealFFT1.sim & ./Modelica_trunk_cpp_Modelica.Math.FastFourierTransform.Examples.RealFFT1  --alarm=480   -emit_protected > Modelica_trunk_cpp_Modelica.Math.FastFourierTransform.Examples.RealFFT1.pipe 2>&1)
diffSimulationResults("Modelica_trunk_cpp_Modelica.Math.FastFourierTransform.Examples.RealFFT1_res.mat","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/Reference-modelica.org/ReferenceResults/MAP-LIB_ReferenceResults/v4.0.0/Modelica/Math/FastFourierTransform/Examples/RealFFT1/RealFFT1.csv","../files/Modelica_trunk_cpp_Modelica.Math.FastFourierTransform.Examples.RealFFT1.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001)
Reference file matches