Running: ./testmodel.py --libraries=/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr ModelicaTest_3.2.2_ModelicaTest.Tables.CombiTable2D.Test9.conf.json Using package ModelicaTest with version 3.2.2 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 3.2.2+maint.om/package.mo) Using package ModelicaServices with version 3.2.2 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.2+maint.om/package.mo) Using package Modelica with version 3.2.2 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.2+maint.om/package.mo) Using package Complex with version 3.2.2 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.2+maint.om/package.mo) Running command: translateModel(ModelicaTest.Tables.CombiTable2D.Test9,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|t_new.y|clock1.y|clock2.y",fileNamePrefix="ModelicaTest_3.2.2_ModelicaTest.Tables.CombiTable2D.Test9") Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.2+maint.om/package.mo): time 0.002715/0.002714, allocations: 370.8 kB / 15.96 MB, free: 6.199 MB / 13.93 MB Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.2+maint.om/package.mo): time 3.825/3.825, allocations: 388.9 MB / 405.6 MB, free: 10.34 MB / 346.7 MB Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.2+maint.om/package.mo): time 0.00363/0.00363, allocations: 235.6 kB / 451 MB, free: 145.1 MB / 346.7 MB Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 3.2.2+maint.om/package.mo): time 0.5725/0.5725, allocations: 80.02 MB / 0.5627 GB, free: 19.86 MB / 346.7 MB Notification: Performance of FrontEnd - loaded program: time 0.0004503/0.0004505, allocations: 15.41 kB / 0.6265 GB, free: 96.57 MB / 346.7 MB Notification: Performance of FrontEnd - Absyn->SCode: time 0.09039/0.09086, allocations: 54.87 MB / 0.6801 GB, free: 41.68 MB / 346.7 MB Notification: Performance of NFInst.instantiate(ModelicaTest.Tables.CombiTable2D.Test9): time 0.00181/0.09272, allocations: 1.212 MB / 0.6813 GB, free: 40.45 MB / 346.7 MB Notification: Performance of NFInst.instExpressions: time 0.0005472/0.0933, allocations: 251.9 kB / 0.6815 GB, free: 40.2 MB / 346.7 MB Notification: Performance of NFInst.updateImplicitVariability: time 5.154e-05/0.09336, allocations: 0 / 0.6815 GB, free: 40.2 MB / 346.7 MB Notification: Performance of NFTyping.typeComponents: time 0.0005513/0.09393, allocations: 443.2 kB / 0.682 GB, free: 39.77 MB / 346.7 MB Notification: Performance of NFTyping.typeBindings: time 0.0003236/0.09427, allocations: 231.6 kB / 0.6822 GB, free: 39.54 MB / 346.7 MB Notification: Performance of NFTyping.typeClassSections: time 0.0001124/0.0944, allocations: 23.98 kB / 0.6822 GB, free: 39.52 MB / 346.7 MB Notification: Performance of NFFlatten.flatten: time 0.0001995/0.09461, allocations: 123.7 kB / 0.6823 GB, free: 39.39 MB / 346.7 MB Notification: Performance of NFFlatten.resolveConnections: time 9.549e-05/0.09472, allocations: 11.89 kB / 0.6823 GB, free: 39.38 MB / 346.7 MB Notification: Performance of NFEvalConstants.evaluate: time 0.0001107/0.09484, allocations: 107.7 kB / 0.6824 GB, free: 39.28 MB / 346.7 MB Notification: Performance of NFSimplifyModel.simplify: time 0.0002108/0.09507, allocations: 159.8 kB / 0.6826 GB, free: 39.12 MB / 346.7 MB Notification: Performance of NFPackage.collectConstants: time 2.743e-05/0.09511, allocations: 0 / 0.6826 GB, free: 39.12 MB / 346.7 MB Notification: Performance of NFFlatten.collectFunctions: time 6.749e-05/0.09518, allocations: 16 kB / 0.6826 GB, free: 39.11 MB / 346.7 MB Notification: Performance of NFScalarize.scalarize: time 8.105e-05/0.09528, allocations: 75.75 kB / 0.6827 GB, free: 39.03 MB / 346.7 MB Notification: Performance of NFVerifyModel.verify: time 3.978e-05/0.09533, allocations: 69.45 kB / 0.6827 GB, free: 38.96 MB / 346.7 MB Notification: Performance of NFConvertDAE.convert: time 0.0002004/0.09554, allocations: 155.8 kB / 0.6829 GB, free: 38.8 MB / 346.7 MB Notification: Performance of FrontEnd - DAE generated: time 5.17e-06/0.09556, allocations: 4 kB / 0.6829 GB, free: 38.8 MB / 346.7 MB Notification: Performance of FrontEnd: time 1.653e-06/0.09557, allocations: 0 / 0.6829 GB, free: 38.8 MB / 346.7 MB Notification: Performance of Transformations before backend: time 4.95e-06/0.09558, allocations: 0 / 0.6829 GB, free: 38.8 MB / 346.7 MB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 5 * Number of variables: 5 Notification: Performance of Generate backend data structure: time 0.0006814/0.09627, allocations: 0.6086 MB / 0.6835 GB, free: 38.14 MB / 346.7 MB Notification: Performance of prepare preOptimizeDAE: time 4.253e-05/0.09632, allocations: 8.031 kB / 0.6835 GB, free: 38.13 MB / 346.7 MB Notification: Performance of preOpt normalInlineFunction (simulation): time 6.019e-05/0.09639, allocations: 43.39 kB / 0.6835 GB, free: 38.09 MB / 346.7 MB Notification: Performance of preOpt evaluateParameters (simulation): time 0.0002433/0.09665, allocations: 271.4 kB / 0.6838 GB, free: 37.79 MB / 346.7 MB Notification: Performance of preOpt simplifyIfEquations (simulation): time 1.321e-05/0.09667, allocations: 3.938 kB / 0.6838 GB, free: 37.78 MB / 346.7 MB Notification: Performance of preOpt expandDerOperator (simulation): time 1.309e-05/0.0967, allocations: 4 kB / 0.6838 GB, free: 37.78 MB / 346.7 MB Notification: Performance of preOpt clockPartitioning (simulation): time 0.0001968/0.0969, allocations: 57.62 kB / 0.6838 GB, free: 37.71 MB / 346.7 MB Notification: Performance of preOpt findStateOrder (simulation): time 8.636e-06/0.09692, allocations: 0 / 0.6838 GB, free: 37.71 MB / 346.7 MB Notification: Performance of preOpt replaceEdgeChange (simulation): time 1.079e-05/0.09694, allocations: 7.938 kB / 0.6839 GB, free: 37.71 MB / 346.7 MB Notification: Performance of preOpt inlineArrayEqn (simulation): time 5.12e-06/0.09696, allocations: 0 / 0.6839 GB, free: 37.71 MB / 346.7 MB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.0002036/0.09717, allocations: 43.92 kB / 0.6839 GB, free: 37.66 MB / 346.7 MB Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.0004258/0.09761, allocations: 360.9 kB / 0.6842 GB, free: 37.26 MB / 346.7 MB Notification: Performance of preOpt comSubExp (simulation): time 0.0001521/0.09778, allocations: 50.5 kB / 0.6843 GB, free: 37.2 MB / 346.7 MB Notification: Performance of preOpt resolveLoops (simulation): time 0.0001087/0.0979, allocations: 28.94 kB / 0.6843 GB, free: 37.17 MB / 346.7 MB Notification: Performance of preOpt evalFunc (simulation): time 2.511e-05/0.09794, allocations: 0 / 0.6843 GB, free: 37.17 MB / 346.7 MB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 2.046e-05/0.09797, allocations: 34.55 kB / 0.6844 GB, free: 37.13 MB / 346.7 MB Notification: Performance of pre-optimization done (n=3): time 2.124e-06/0.09798, allocations: 7.984 kB / 0.6844 GB, free: 37.12 MB / 346.7 MB Notification: Performance of matching and sorting (n=3): time 0.0004491/0.09844, allocations: 133 kB / 0.6845 GB, free: 36.98 MB / 346.7 MB Notification: Performance of inlineWhenForInitialization (initialization): time 1.732e-05/0.09847, allocations: 51.41 kB / 0.6845 GB, free: 36.92 MB / 346.7 MB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0009491/0.09943, allocations: 0.8456 MB / 0.6854 GB, free: 36.07 MB / 346.7 MB Notification: Performance of collectPreVariables (initialization): time 1.262e-05/0.09945, allocations: 25.7 kB / 0.6854 GB, free: 36.04 MB / 346.7 MB Notification: Performance of collectInitialEqns (initialization): time 0.0001787/0.09964, allocations: 208.1 kB / 0.6856 GB, free: 35.83 MB / 346.7 MB Notification: Performance of collectInitialBindings (initialization): time 1.676e-05/0.09967, allocations: 15.83 kB / 0.6856 GB, free: 35.81 MB / 346.7 MB Notification: Performance of simplifyInitialFunctions (initialization): time 5.24e-06/0.09968, allocations: 0 / 0.6856 GB, free: 35.81 MB / 346.7 MB Notification: Performance of setup shared object (initialization): time 8.97e-05/0.09978, allocations: 354.8 kB / 0.6859 GB, free: 35.46 MB / 346.7 MB Notification: Performance of preBalanceInitialSystem (initialization): time 0.0001097/0.0999, allocations: 19.98 kB / 0.686 GB, free: 35.44 MB / 346.7 MB Notification: Performance of partitionIndependentBlocks (initialization): time 0.0001019/0.1, allocations: 27.98 kB / 0.686 GB, free: 35.41 MB / 346.7 MB Notification: Performance of analyzeInitialSystem (initialization): time 0.0001221/0.1002, allocations: 45.69 kB / 0.686 GB, free: 35.36 MB / 346.7 MB Notification: Performance of solveInitialSystemEqSystem (initialization): time 2.494e-06/0.1002, allocations: 0 / 0.686 GB, free: 35.36 MB / 346.7 MB Notification: Performance of matching and sorting (n=4) (initialization): time 0.0003101/0.1005, allocations: 146.8 kB / 0.6862 GB, free: 35.2 MB / 346.7 MB Notification: Performance of prepare postOptimizeDAE: time 3.067e-05/0.1005, allocations: 29.7 kB / 0.6862 GB, free: 35.17 MB / 346.7 MB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 5.56e-06/0.1005, allocations: 0 / 0.6862 GB, free: 35.17 MB / 346.7 MB Notification: Performance of postOpt tearingSystem (initialization): time 1.431e-05/0.1006, allocations: 0 / 0.6862 GB, free: 35.17 MB / 346.7 MB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0001165/0.1007, allocations: 19.94 kB / 0.6862 GB, free: 35.15 MB / 346.7 MB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 6.432e-06/0.1007, allocations: 0 / 0.6862 GB, free: 35.15 MB / 346.7 MB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 9.288e-05/0.1008, allocations: 7.938 kB / 0.6862 GB, free: 35.14 MB / 346.7 MB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 1.279e-05/0.1008, allocations: 7.969 kB / 0.6862 GB, free: 35.13 MB / 346.7 MB Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 1 * 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 (4): * Single equations (assignments): 3 * 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.0002007/0.101, allocations: 214.5 kB / 0.6864 GB, free: 34.91 MB / 346.7 MB Notification: Performance of postOpt lateInlineFunction (simulation): time 5.639e-05/0.1011, allocations: 35.53 kB / 0.6865 GB, free: 34.88 MB / 346.7 MB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.0003371/0.1015, allocations: 132.8 kB / 0.6866 GB, free: 34.74 MB / 346.7 MB Notification: Performance of postOpt simplifysemiLinear (simulation): time 3.857e-06/0.1015, allocations: 3.938 kB / 0.6866 GB, free: 34.74 MB / 346.7 MB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.473e-06/0.1015, allocations: 0 / 0.6866 GB, free: 34.74 MB / 346.7 MB Notification: Performance of postOpt removeConstants (simulation): time 6.094e-05/0.1016, allocations: 116.6 kB / 0.6867 GB, free: 34.61 MB / 346.7 MB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 3.534e-05/0.1016, allocations: 0 / 0.6867 GB, free: 34.61 MB / 346.7 MB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0001225/0.1017, allocations: 4 kB / 0.6867 GB, free: 34.6 MB / 346.7 MB Notification: Performance of postOpt findZeroCrossings (simulation): time 4.016e-05/0.1018, allocations: 7.984 kB / 0.6867 GB, free: 34.59 MB / 346.7 MB Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.0002876/0.1021, allocations: 156.9 kB / 0.6869 GB, free: 34.43 MB / 346.7 MB Notification: Performance of postOpt detectDAEmodeSparsePattern (simulation): time 0.0003049/0.1024, allocations: 286.3 kB / 0.6871 GB, free: 34.14 MB / 346.7 MB Notification: Performance of postOpt setEvaluationStage (simulation): time 0.0001158/0.1025, allocations: 28.45 kB / 0.6872 GB, free: 34.11 MB / 346.7 MB Notification: Performance of sorting global known variables: time 0.0007202/0.1033, allocations: 0.6355 MB / 0.6878 GB, free: 33.48 MB / 346.7 MB Notification: Performance of Backend: time 8.72e-07/0.1033, allocations: 3.938 kB / 0.6878 GB, free: 33.47 MB / 346.7 MB Notification: Performance of simCode: created initialization part: time 0.001202/0.1045, allocations: 401 kB / 0.6882 GB, free: 33.13 MB / 346.7 MB Notification: Performance of SimCode: time 0.001276/0.1058, allocations: 1.14 MB / 0.6893 GB, free: 31.94 MB / 346.7 MB Notification: Performance of Templates: time 0.005618/0.1115, allocations: 1.036 MB / 0.6903 GB, free: 30.91 MB / 346.7 MB "" Variables in the reference:time,t_new.y,clock1.y,clock2.y Variables in the result:clock1.offset,clock1.startTime,clock1.y,clock2.offset,clock2.startTime,clock2.y,t_new.smoothness,t_new.tableOnFile,t_new.tableOnFileRead,t_new.table[1,10],t_new.table[1,1],t_new.table[1,2],t_new.table[1,3],t_new.table[1,4],t_new.table[1,5],t_new.table[1,6],t_new.table[1,7],t_new.table[1,8],t_new.table[1,9],t_new.table[10,10],t_new.table[10,1],t_new.table[10,2],t_new.table[10,3],t_new.table[10,4],t_new.table[10,5],t_new.table[10,6],t_new.table[10,7],t_new.table[10,8],t_new.table[10,9],t_new.table[11,10],t_new.table[11,1],t_new.table[11,2],t_new.table[11,3],t_new.table[11,4],t_new.table[11,5],t_new.table[11,6],t_new.table[11,7],t_new.table[11,8],t_new.table[11,9],t_new.table[12,10],t_new.table[12,1],t_new.table[12,2],t_new.table[12,3],t_new.table[12,4],t_new.table[12,5],t_new.table[12,6],t_new.table[12,7],t_new.table[12,8],t_new.table[12,9],t_new.table[2,10],t_new.table[2,1],t_new.table[2,2],t_new.table[2,3],t_new.table[2,4],t_new.table[2,5],t_new.table[2,6],t_new.table[2,7],t_new.table[2,8],t_new.table[2,9],t_new.table[3,10],t_new.table[3,1],t_new.table[3,2],t_new.table[3,3],t_new.table[3,4],t_new.table[3,5],t_new.table[3,6],t_new.table[3,7],t_new.table[3,8],t_new.table[3,9],t_new.table[4,10],t_new.table[4,1],t_new.table[4,2],t_new.table[4,3],t_new.table[4,4],t_new.table[4,5],t_new.table[4,6],t_new.table[4,7],t_new.table[4,8],t_new.table[4,9],t_new.table[5,10],t_new.table[5,1],t_new.table[5,2],t_new.table[5,3],t_new.table[5,4],t_new.table[5,5],t_new.table[5,6],t_new.table[5,7],t_new.table[5,8],t_new.table[5,9],t_new.table[6,10],t_new.table[6,1],t_new.table[6,2],t_new.table[6,3],t_new.table[6,4],t_new.table[6,5],t_new.table[6,6],t_new.table[6,7],t_new.table[6,8],t_new.table[6,9],t_new.table[7,10],t_new.table[7,1],t_new.table[7,2],t_new.table[7,3],t_new.table[7,4],t_new.table[7,5],t_new.table[7,6],t_new.table[7,7],t_new.table[7,8],t_new.table[7,9],t_new.table[8,10],t_new.table[8,1],t_new.table[8,2],t_new.table[8,3],t_new.table[8,4],t_new.table[8,5],t_new.table[8,6],t_new.table[8,7],t_new.table[8,8],t_new.table[8,9],t_new.table[9,10],t_new.table[9,1],t_new.table[9,2],t_new.table[9,3],t_new.table[9,4],t_new.table[9,5],t_new.table[9,6],t_new.table[9,7],t_new.table[9,8],t_new.table[9,9],t_new.verboseRead,t_new.y,time