Running: ./testmodel.py --libraries=/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelica/./OMCompiler/build/lib/omlibrary/ --ompython_omhome=/usr Modelica_3.2.1_Modelica.Electrical.Digital.Examples.VectorDelay.conf.json Using package ModelicaServices with version 3.2.1 (/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/build/lib/omlibrary/ModelicaServices 3.2.1/package.mo) Using package Complex with version 3.2.1 (/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/build/lib/omlibrary/Complex 3.2.1.mo) Using package Modelica with version 3.2.1 (/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/build/lib/omlibrary/Modelica 3.2.1/package.mo) Running command: translateModel(Modelica.Electrical.Digital.Examples.VectorDelay,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|delay.inertialDelaySensitive.1..x|delay.inertialDelaySensitive.1..y|delay.inertialDelaySensitive.2..x|delay.inertialDelaySensitive.2..y|delay.inertialDelaySensitive.3..x|delay.inertialDelaySensitive.3..y",fileNamePrefix="Modelica_3.2.1_Modelica.Electrical.Digital.Examples.VectorDelay") Notification: Performance of loadModel(Modelica): time 1.673/1.673, allocations: 171.2 MB / 186.7 MB, free: 1.121 MB / 154.7 MB Notification: Performance of FrontEnd - loaded program: time 0.0003409/0.000341, allocations: 8 kB / 233.9 MB, free: 2.402 MB / 186.7 MB Notification: Performance of FrontEnd - Absyn->SCode: time 0.07704/0.0774, allocations: 38.78 MB / 272.6 MB, free: 11.55 MB / 234.7 MB Notification: Performance of NFInst.instantiate(Modelica.Electrical.Digital.Examples.VectorDelay): time 0.001923/0.07938, allocations: 1.178 MB / 273.8 MB, free: 10.36 MB / 234.7 MB Notification: Performance of NFInst.instExpressions: time 0.002488/0.08188, allocations: 0.8364 MB / 274.6 MB, free: 9.516 MB / 234.7 MB Notification: Performance of NFInst.updateImplicitVariability: time 5.352e-05/0.08196, allocations: 0 / 274.6 MB, free: 9.516 MB / 234.7 MB Notification: Performance of NFTyping.typeComponents: time 0.0001128/0.08208, allocations: 11.92 kB / 274.7 MB, free: 9.504 MB / 234.7 MB Notification: Performance of NFTyping.typeBindings: time 7.786e-05/0.08217, allocations: 23.89 kB / 274.7 MB, free: 9.48 MB / 234.7 MB Notification: Performance of NFTyping.typeClassSections: time 0.0002538/0.08244, allocations: 39.91 kB / 274.7 MB, free: 9.441 MB / 234.7 MB Notification: Performance of NFFlatten.flatten: time 0.0002855/0.08274, allocations: 155.7 kB / 274.9 MB, free: 9.289 MB / 234.7 MB Notification: Performance of NFFlatten.resolveConnections: time 0.0001692/0.08292, allocations: 49.73 kB / 274.9 MB, free: 9.234 MB / 234.7 MB Notification: Performance of NFEvalConstants.evaluate: time 0.0005232/0.08346, allocations: 295.4 kB / 275.2 MB, free: 8.945 MB / 234.7 MB Notification: Performance of NFSimplifyModel.simplify: time 0.0002748/0.08375, allocations: 159.6 kB / 275.4 MB, free: 8.789 MB / 234.7 MB Notification: Performance of NFPackage.collectConstants: time 9.249e-05/0.08385, allocations: 8 kB / 275.4 MB, free: 8.781 MB / 234.7 MB Notification: Performance of NFFlatten.collectFunctions: time 9.14e-05/0.08396, allocations: 11.94 kB / 275.4 MB, free: 8.77 MB / 234.7 MB Notification: Performance of NFScalarize.scalarize: time 0.0002167/0.08418, allocations: 175.4 kB / 275.6 MB, free: 8.598 MB / 234.7 MB Notification: Performance of NFVerifyModel.verify: time 0.0001742/0.08437, allocations: 149.3 kB / 275.7 MB, free: 8.445 MB / 234.7 MB Notification: Performance of NFConvertDAE.convert: time 0.001008/0.08539, allocations: 0.7912 MB / 276.5 MB, free: 7.652 MB / 234.7 MB Notification: Performance of FrontEnd - DAE generated: time 2.875e-06/0.08541, allocations: 0 / 276.5 MB, free: 7.652 MB / 234.7 MB Notification: Performance of FrontEnd: time 1.803e-06/0.08542, allocations: 4 kB / 276.5 MB, free: 7.648 MB / 234.7 MB Notification: Performance of Transformations before backend: time 7.384e-06/0.08544, allocations: 0 / 276.5 MB, free: 7.648 MB / 234.7 MB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 30 * Number of variables: 30 Notification: Performance of Generate backend data structure: time 0.001654/0.0871, allocations: 1.153 MB / 277.7 MB, free: 6.406 MB / 234.7 MB Notification: Performance of prepare preOptimizeDAE: time 4.653e-05/0.08716, allocations: 8.031 kB / 277.7 MB, free: 6.398 MB / 234.7 MB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0002195/0.08738, allocations: 102.8 kB / 277.8 MB, free: 6.297 MB / 234.7 MB Notification: Performance of preOpt evaluateParameters (simulation): time 0.001024/0.08842, allocations: 436.7 kB / 278.2 MB, free: 5.816 MB / 234.7 MB Notification: Performance of preOpt simplifyIfEquations (simulation): time 5.805e-05/0.0885, allocations: 15.95 kB / 278.2 MB, free: 5.801 MB / 234.7 MB Notification: Performance of preOpt expandDerOperator (simulation): time 8.065e-05/0.08859, allocations: 20 kB / 278.2 MB, free: 5.781 MB / 234.7 MB Notification: Performance of preOpt clockPartitioning (simulation): time 0.0008504/0.08945, allocations: 307.9 kB / 278.5 MB, free: 5.465 MB / 234.7 MB Notification: Performance of preOpt findStateOrder (simulation): time 1.509e-05/0.08948, allocations: 7.969 kB / 278.5 MB, free: 5.457 MB / 234.7 MB Notification: Performance of preOpt replaceEdgeChange (simulation): time 5.656e-05/0.08955, allocations: 7.984 kB / 278.5 MB, free: 5.449 MB / 234.7 MB Notification: Performance of preOpt inlineArrayEqn (simulation): time 9.458e-06/0.08957, allocations: 4 kB / 278.5 MB, free: 5.445 MB / 234.7 MB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.0005404/0.09011, allocations: 167.8 kB / 278.7 MB, free: 5.281 MB / 234.7 MB Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.001876/0.09201, allocations: 0.9352 MB / 279.6 MB, free: 4.289 MB / 234.7 MB Notification: Performance of preOpt comSubExp (simulation): time 0.0006959/0.09274, allocations: 271.8 kB / 279.9 MB, free: 3.996 MB / 234.7 MB Notification: Performance of preOpt evalFunc (simulation): time 1.917e-05/0.09278, allocations: 12.03 kB / 279.9 MB, free: 3.984 MB / 234.7 MB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.001012/0.0938, allocations: 0.5156 MB / 280.4 MB, free: 3.41 MB / 234.7 MB Notification: Performance of pre-optimization done (n=30): time 3.367e-06/0.09382, allocations: 0 / 280.4 MB, free: 3.41 MB / 234.7 MB Notification: Performance of matching and sorting (n=30): time 0.002869/0.0967, allocations: 1.252 MB / 281.7 MB, free: 2.059 MB / 234.7 MB Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001827/0.09691, allocations: 281 kB / 282 MB, free: 1.723 MB / 234.7 MB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.00319/0.1001, allocations: 1.446 MB / 283.4 MB, free: 260 kB / 234.7 MB Notification: Performance of collectPreVariables (initialization): time 0.0001136/0.1003, allocations: 45.62 kB / 283.5 MB, free: 208 kB / 234.7 MB Notification: Performance of collectInitialEqns (initialization): time 0.0001292/0.1004, allocations: 118.5 kB / 283.6 MB, free: 84 kB / 234.7 MB Notification: Performance of collectInitialBindings (initialization): time 0.0001267/0.1005, allocations: 67.25 kB / 283.6 MB, free: 16 kB / 234.7 MB Notification: Performance of simplifyInitialFunctions (initialization): time 4.535e-05/0.1006, allocations: 8 kB / 283.6 MB, free: 8 kB / 234.7 MB Notification: Performance of setup shared object (initialization): time 0.000185/0.1008, allocations: 342.8 kB / 284 MB, free: 15.66 MB / 250.7 MB Notification: Performance of preBalanceInitialSystem (initialization): time 0.000498/0.1013, allocations: 167.8 kB / 284.1 MB, free: 15.5 MB / 250.7 MB Notification: Performance of partitionIndependentBlocks (initialization): time 0.0005262/0.1018, allocations: 205 kB / 284.3 MB, free: 15.28 MB / 250.7 MB Notification: Performance of analyzeInitialSystem (initialization): time 0.0006056/0.1025, allocations: 334.1 kB / 284.7 MB, free: 14.91 MB / 250.7 MB Notification: Performance of solveInitialSystemEqSystem (initialization): time 4.349e-06/0.1025, allocations: 0 / 284.7 MB, free: 14.91 MB / 250.7 MB Notification: Performance of matching and sorting (n=36) (initialization): time 0.001874/0.1044, allocations: 0.7804 MB / 285.4 MB, free: 14.09 MB / 250.7 MB Notification: Performance of prepare postOptimizeDAE: time 0.0001775/0.1046, allocations: 194.2 kB / 285.6 MB, free: 13.86 MB / 250.7 MB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 7.665e-06/0.1046, allocations: 0 / 285.6 MB, free: 13.86 MB / 250.7 MB Notification: Performance of postOpt tearingSystem (initialization): time 1.865e-05/0.1046, allocations: 4 kB / 285.6 MB, free: 13.86 MB / 250.7 MB Notification: Performance of postOpt solveSimpleEquations (initialization): time 3.671e-05/0.1047, allocations: 11.94 kB / 285.7 MB, free: 13.85 MB / 250.7 MB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 7.795e-06/0.1047, allocations: 0 / 285.7 MB, free: 13.85 MB / 250.7 MB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.000486/0.1052, allocations: 35.89 kB / 285.7 MB, free: 13.81 MB / 250.7 MB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001568/0.1053, allocations: 83.94 kB / 285.8 MB, free: 13.73 MB / 250.7 MB Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 6 * Number of states: 0 () * Number of discrete variables: 36 ($PRE.delay.inertialDelaySensitive[3].y,$whenCondition5,$whenCondition6,$PRE.delay.inertialDelaySensitive[3].x,delay.inertialDelaySensitive[3].x,delay.inertialDelaySensitive[3].y,delay.inertialDelaySensitive[3].delayTime,delay.inertialDelaySensitive[3].y_auxiliary,delay.inertialDelaySensitive[3].y_old,delay.inertialDelaySensitive[3].lh,delay.inertialDelaySensitive[3].t_next,table2.y,$PRE.delay.inertialDelaySensitive[2].y,$whenCondition3,$whenCondition4,$PRE.delay.inertialDelaySensitive[2].x,delay.inertialDelaySensitive[2].x,delay.inertialDelaySensitive[2].y,delay.inertialDelaySensitive[2].delayTime,delay.inertialDelaySensitive[2].y_auxiliary,delay.inertialDelaySensitive[2].y_old,delay.inertialDelaySensitive[2].lh,delay.inertialDelaySensitive[2].t_next,table1.y,$PRE.delay.inertialDelaySensitive[1].y,$whenCondition1,$whenCondition2,$PRE.delay.inertialDelaySensitive[1].x,delay.inertialDelaySensitive[1].x,delay.inertialDelaySensitive[1].y,delay.inertialDelaySensitive[1].delayTime,delay.inertialDelaySensitive[1].y_auxiliary,delay.inertialDelaySensitive[1].y_old,delay.inertialDelaySensitive[1].lh,delay.inertialDelaySensitive[1].t_next,table.y) * Number of discrete states: 0 () * Number of clocked states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for initialization (15): * Single equations (assignments): 9 * Array equations: 0 * Algorithm blocks: 6 * 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.001421/0.1068, allocations: 0.8016 MB / 286.6 MB, free: 12.88 MB / 250.7 MB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0001749/0.107, allocations: 98.88 kB / 286.7 MB, free: 12.79 MB / 250.7 MB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.0004376/0.1074, allocations: 195.9 kB / 286.9 MB, free: 12.59 MB / 250.7 MB Notification: Performance of postOpt simplifysemiLinear (simulation): time 7.774e-06/0.1074, allocations: 3.984 kB / 286.9 MB, free: 12.59 MB / 250.7 MB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.134e-06/0.1074, allocations: 0 / 286.9 MB, free: 12.59 MB / 250.7 MB Notification: Performance of postOpt removeConstants (simulation): time 0.0014/0.1088, allocations: 0.5851 MB / 287.4 MB, free: 11.98 MB / 250.7 MB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0002436/0.1091, allocations: 55.97 kB / 287.5 MB, free: 11.93 MB / 250.7 MB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0003836/0.1095, allocations: 27.94 kB / 287.5 MB, free: 11.9 MB / 250.7 MB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001861/0.1097, allocations: 51.84 kB / 287.6 MB, free: 11.86 MB / 250.7 MB Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.002292/0.112, allocations: 1.447 MB / 289 MB, free: 10.29 MB / 250.7 MB Notification: Performance of postOpt detectDAEmodeSparsePattern (simulation): time 0.002229/0.1143, allocations: 1.268 MB / 290.3 MB, free: 8.965 MB / 250.7 MB Notification: Performance of postOpt setEvaluationStage (simulation): time 0.0008388/0.1151, allocations: 435.8 kB / 290.7 MB, free: 8.539 MB / 250.7 MB Notification: Performance of sorting global known variables: time 0.002343/0.1175, allocations: 1.075 MB / 291.8 MB, free: 7.453 MB / 250.7 MB Notification: Performance of Backend: time 6.62e-07/0.1175, allocations: 0 / 291.8 MB, free: 7.453 MB / 250.7 MB Notification: Performance of simCode: created initialization part: time 0.001563/0.1191, allocations: 0.8307 MB / 292.6 MB, free: 6.539 MB / 250.7 MB Notification: Performance of SimCode: time 0.005019/0.1241, allocations: 2.952 MB / 295.6 MB, free: 3.461 MB / 250.7 MB Notification: Performance of Templates: time 0.2744/0.3985, allocations: 6.544 MB / 302.1 MB, free: 31.33 MB / 250.7 MB "" Variables in the reference:time,delay.inertialDelaySensitive[1].x,delay.inertialDelaySensitive[1].y,delay.inertialDelaySensitive[2].x,delay.inertialDelaySensitive[2].y,delay.inertialDelaySensitive[3].x,delay.inertialDelaySensitive[3].y Variables in the result:delay.inertialDelaySensitive[1].tHL,delay.inertialDelaySensitive[1].tLH,delay.inertialDelaySensitive[1].x,delay.inertialDelaySensitive[1].y,delay.inertialDelaySensitive[1].y0,delay.inertialDelaySensitive[2].tHL,delay.inertialDelaySensitive[2].tLH,delay.inertialDelaySensitive[2].x,delay.inertialDelaySensitive[2].y,delay.inertialDelaySensitive[2].y0,delay.inertialDelaySensitive[3].tHL,delay.inertialDelaySensitive[3].tLH,delay.inertialDelaySensitive[3].x,delay.inertialDelaySensitive[3].y,delay.inertialDelaySensitive[3].y0,delay.n,delay.tHL,delay.tLH,table.n,table.t[1],table.t[2],table.t[3],table.t[4],table.t[5],table.x[1],table.x[2],table.x[3],table.x[4],table.x[5],table.y0,table1.n,table1.t[1],table1.t[2],table1.x[1],table1.x[2],table1.y0,table2.n,table2.t[1],table2.t[2],table2.t[3],table2.x[1],table2.x[2],table2.x[3],table2.y0,time