Running: ./testmodel.py --libraries=/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelica/./OMCompiler/build/lib/omlibrary/ --ompython_omhome=/usr Modelica_3.2.1_Modelica.Electrical.Spice3.Examples.Spice3BenchmarkMosfetCharacterization.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.Spice3.Examples.Spice3BenchmarkMosfetCharacterization,tolerance=1e-06,outputFormat="mat",numberOfIntervals=198,variableFilter="time|VGS.p.v|M1.D.i",fileNamePrefix="Modelica_3.2.1_Modelica.Electrical.Spice3.Examples.Spice3BenchmarkMosfetCharacterization")
Notification: Performance of loadModel(Modelica): time 1.841/1.841, allocations: 171.2 MB / 186.7 MB, free: 1.129 MB / 154.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0005069/0.0005071, allocations: 12 kB / 233.9 MB, free: 2.402 MB / 186.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.09206/0.0926, allocations: 38.77 MB / 272.6 MB, free: 11.55 MB / 234.7 MB
Notification: Performance of NFInst.instantiate(Modelica.Electrical.Spice3.Examples.Spice3BenchmarkMosfetCharacterization): time 0.006949/0.09961, allocations: 4.412 MB / 277 MB, free: 7.105 MB / 234.7 MB
Notification: Performance of NFInst.instExpressions: time 0.02819/0.1278, allocations: 15.6 MB / 292.6 MB, free: 7.473 MB / 250.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.000777/0.1287, allocations: 4 kB / 292.6 MB, free: 7.469 MB / 250.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.003123/0.1318, allocations: 0.7507 MB / 293.4 MB, free: 6.715 MB / 250.7 MB
Notification: Performance of NFTyping.typeBindings: time 0.005835/0.1377, allocations: 1.336 MB / 294.7 MB, free: 5.375 MB / 250.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.004978/0.1427, allocations: 1.044 MB / 295.8 MB, free: 4.328 MB / 250.7 MB
Notification: Performance of NFFlatten.flatten: time 0.00451/0.1473, allocations: 1.499 MB / 297.3 MB, free: 2.828 MB / 250.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.0004234/0.1478, allocations: 147.8 kB / 297.4 MB, free: 2.668 MB / 250.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.0005679/0.1483, allocations: 270.7 kB / 297.7 MB, free: 2.402 MB / 250.7 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.0005461/0.1489, allocations: 326.2 kB / 298 MB, free: 2.082 MB / 250.7 MB
Notification: Performance of NFPackage.collectConstants: time 9.875e-05/0.149, allocations: 20 kB / 298 MB, free: 2.062 MB / 250.7 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.00535/0.1544, allocations: 1.199 MB / 299.2 MB, free: 0.8633 MB / 250.7 MB
Notification: Performance of NFScalarize.scalarize: time 0.0002937/0.1547, allocations: 91.39 kB / 299.3 MB, free: 0.7734 MB / 250.7 MB
Notification: Performance of NFVerifyModel.verify: time 0.0004543/0.1552, allocations: 205.1 kB / 299.5 MB, free: 0.5664 MB / 250.7 MB
Notification: Performance of NFConvertDAE.convert: time 0.2779/0.4331, allocations: 1.072 MB / 300.6 MB, free: 14.16 MB / 250.7 MB
Notification: Performance of FrontEnd - DAE generated: time 4.308e-06/0.4331, allocations: 0 / 300.6 MB, free: 14.16 MB / 250.7 MB
Notification: Performance of FrontEnd: time 3.537e-06/0.4332, allocations: 0 / 300.6 MB, free: 14.16 MB / 250.7 MB
Notification: Performance of Transformations before backend: time 5.015e-05/0.4332, allocations: 1.156 kB / 300.6 MB, free: 14.16 MB / 250.7 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 64
 * Number of variables: 64
Notification: Performance of Generate backend data structure: time 0.004258/0.4375, allocations: 1.27 MB / 301.9 MB, free: 13.36 MB / 250.7 MB
Notification: Performance of prepare preOptimizeDAE: time 8.115e-05/0.4376, allocations: 8.25 kB / 301.9 MB, free: 13.36 MB / 250.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0003542/0.438, allocations: 120.6 kB / 302 MB, free: 13.3 MB / 250.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.002578/0.4406, allocations: 0.7349 MB / 302.7 MB, free: 12.97 MB / 250.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 5.452e-05/0.4407, allocations: 18.52 kB / 302.7 MB, free: 12.97 MB / 250.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001365/0.4408, allocations: 22.28 kB / 302.8 MB, free: 12.97 MB / 250.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.001868/0.4427, allocations: 355.7 kB / 303.1 MB, free: 12.94 MB / 250.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 2.153e-05/0.4428, allocations: 2.031 kB / 303.1 MB, free: 12.94 MB / 250.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 7.728e-05/0.4429, allocations: 10.62 kB / 303.1 MB, free: 12.94 MB / 250.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 2.354e-05/0.4429, allocations: 10.58 kB / 303.1 MB, free: 12.94 MB / 250.7 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.002137/0.4451, allocations: 388.3 kB / 303.5 MB, free: 12.94 MB / 250.7 MB
Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.004111/0.4492, allocations: 1.252 MB / 304.8 MB, free: 12.49 MB / 250.7 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.001818/0.4511, allocations: 314.9 kB / 305.1 MB, free: 12.46 MB / 250.7 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.01411/0.4652, allocations: 7.804 MB / 312.9 MB, free: 6.965 MB / 250.7 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.001056/0.4663, allocations: 233.8 kB / 313.1 MB, free: 6.902 MB / 250.7 MB
Notification: Performance of pre-optimization done (n=19): time 5.4e-06/0.4664, allocations: 0 / 313.1 MB, free: 6.902 MB / 250.7 MB
Notification: Performance of matching and sorting (n=19): time 0.002887/0.4693, allocations: 0.6265 MB / 313.7 MB, free: 6.707 MB / 250.7 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 3.171e-05/0.4693, allocations: 55.53 kB / 313.8 MB, free: 6.645 MB / 250.7 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001824/0.4712, allocations: 0.8733 MB / 314.6 MB, free: 6.496 MB / 250.7 MB
Notification: Performance of collectPreVariables (initialization): time 6.276e-05/0.4712, allocations: 32.72 kB / 314.7 MB, free: 6.465 MB / 250.7 MB
Notification: Performance of collectInitialEqns (initialization): time 0.0005546/0.4718, allocations: 463.7 kB / 315.1 MB, free: 6.324 MB / 250.7 MB
Notification: Performance of collectInitialBindings (initialization): time 9.758e-05/0.4719, allocations: 64.45 kB / 315.2 MB, free: 6.285 MB / 250.7 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 3.948e-05/0.472, allocations: 7.375 kB / 315.2 MB, free: 6.285 MB / 250.7 MB
Notification: Performance of setup shared object (initialization): time 7.603e-05/0.4721, allocations: 324.2 kB / 315.5 MB, free: 5.98 MB / 250.7 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0008591/0.4729, allocations: 139 kB / 315.7 MB, free: 5.977 MB / 250.7 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0009546/0.4739, allocations: 280.9 kB / 315.9 MB, free: 5.801 MB / 250.7 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.0008906/0.4748, allocations: 165.6 kB / 316.1 MB, free: 5.793 MB / 250.7 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 8.035e-06/0.4749, allocations: 1.25 kB / 316.1 MB, free: 5.793 MB / 250.7 MB
Notification: Performance of matching and sorting (n=43) (initialization): time 0.002415/0.4773, allocations: 0.5376 MB / 316.6 MB, free: 5.695 MB / 250.7 MB
Notification: Performance of prepare postOptimizeDAE: time 2.868e-05/0.4773, allocations: 8.812 kB / 316.6 MB, free: 5.695 MB / 250.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 7.015e-05/0.4774, allocations: 20.81 kB / 316.7 MB, free: 5.695 MB / 250.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 3.2e-05/0.4775, allocations: 11.75 kB / 316.7 MB, free: 5.691 MB / 250.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0008205/0.4783, allocations: 98.36 kB / 316.8 MB, free: 5.691 MB / 250.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.06e-05/0.4783, allocations: 11 kB / 316.8 MB, free: 5.691 MB / 250.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001037/0.4794, allocations: 67.06 kB / 316.8 MB, free: 5.672 MB / 250.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 8.35e-05/0.4795, allocations: 23.38 kB / 316.9 MB, free: 5.672 MB / 250.7 MB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 21
 * Number of states: 0 ()
 * Number of discrete variables: 14 ($PRE.VDS.counter,VDS.counter,$PRE.VGS.counter,VGS.counter,$whenCondition2,$whenCondition1,$PRE.VDS.T0,VDS.T0,$PRE.VDS.counter2,VDS.counter2,$PRE.VGS.T0,VGS.T0,$PRE.VGS.counter2,VGS.counter2)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (41):
 * Single equations (assignments): 40
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 1
 * 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.0005681/0.4801, allocations: 206.8 kB / 317.1 MB, free: 5.559 MB / 250.7 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0002242/0.4803, allocations: 116 kB / 317.2 MB, free: 5.496 MB / 250.7 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.003019/0.4833, allocations: 0.5099 MB / 317.7 MB, free: 5.41 MB / 250.7 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 7.704e-06/0.4834, allocations: 0 / 317.7 MB, free: 5.41 MB / 250.7 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 5.864e-05/0.4834, allocations: 16.66 kB / 317.7 MB, free: 5.41 MB / 250.7 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.000559/0.484, allocations: 203.9 kB / 317.9 MB, free: 5.258 MB / 250.7 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0002893/0.4843, allocations: 10.52 kB / 317.9 MB, free: 5.254 MB / 250.7 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0008348/0.4852, allocations: 34.22 kB / 317.9 MB, free: 5.25 MB / 250.7 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001827/0.4854, allocations: 31.08 kB / 318 MB, free: 5.25 MB / 250.7 MB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.002552/0.4879, allocations: 456.2 kB / 318.4 MB, free: 5.133 MB / 250.7 MB
Notification: Performance of postOpt detectDAEmodeSparsePattern (simulation): time 0.00236/0.4903, allocations: 0.6017 MB / 319 MB, free: 4.855 MB / 250.7 MB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.0009131/0.4913, allocations: 146.3 kB / 319.2 MB, free: 4.852 MB / 250.7 MB
Notification: Performance of sorting global known variables: time 0.00144/0.4927, allocations: 0.5835 MB / 319.8 MB, free: 4.742 MB / 250.7 MB
Notification: Performance of Backend: time 9.42e-07/0.4928, allocations: 0 / 319.8 MB, free: 4.742 MB / 250.7 MB
Notification: Performance of simCode: created initialization part: time 0.00312/0.4959, allocations: 0.8135 MB / 320.6 MB, free: 4.512 MB / 250.7 MB
Notification: Performance of SimCode: time 0.003751/0.4997, allocations: 2.117 MB / 322.7 MB, free: 3.07 MB / 250.7 MB
Notification: Performance of Templates: time 0.06859/0.5683, allocations: 14.42 MB / 337.1 MB, free: 6.816 MB / 266.7 MB
""

Variables in the reference:time,VGS.p.v,M1.D.i

Variables in the result:M1.AD,M1.AS,M1.D.i,M1.G.v,M1.IC,M1.L,M1.NRD,M1.NRS,M1.OFF,M1.PD,M1.PS,M1.TEMP,M1.W,M1.c1.m_Beta,M1.c1.m_VBDcrit,M1.c1.m_VBScrit,M1.c1.m_capGBovl,M1.c1.m_capGDovl,M1.c1.m_capGSovl,M1.c1.m_capOx,M1.c1.m_capbdb,M1.c1.m_capbds,M1.c1.m_capbsb,M1.c1.m_capbss,M1.c1.m_capgb,M1.c1.m_capgd,M1.c1.m_capgs,M1.c1.m_cbd,M1.c1.m_cbs,M1.c1.m_cdrain,M1.c1.m_chargebdb,M1.c1.m_chargebds,M1.c1.m_chargebsb,M1.c1.m_chargebss,M1.c1.m_dVt,M1.c1.m_drainResistance,M1.c1.m_f1b,M1.c1.m_f1s,M1.c1.m_f2b,M1.c1.m_f2s,M1.c1.m_f3b,M1.c1.m_f3s,M1.c1.m_gbd,M1.c1.m_gbs,M1.c1.m_gds,M1.c1.m_gm,M1.c1.m_gmbs,M1.c1.m_lEff,M1.c1.m_mode,M1.c1.m_qgb,M1.c1.m_qgd,M1.c1.m_qgs,M1.c1.m_sourceResistance,M1.c1.m_tBulkPot,M1.c1.m_tCBDb,M1.c1.m_tCBDs,M1.c1.m_tCBSb,M1.c1.m_tCBSs,M1.c1.m_tCj,M1.c1.m_tCjsw,M1.c1.m_tDepCap,M1.c1.m_tDrainSatCur,M1.c1.m_tPhi,M1.c1.m_tSatCurDens,M1.c1.m_tSourceSatCur,M1.c1.m_tSurfMob,M1.c1.m_tTransconductance,M1.c1.m_tVbi,M1.c1.m_tVto,M1.c1.m_vbs,M1.c1.m_vds,M1.c1.m_vdsat,M1.c1.m_vgs,M1.c1.m_von,M1.c2.m_Beta,M1.c2.m_VBDcrit,M1.c2.m_VBScrit,M1.c2.m_capGBovl,M1.c2.m_capGDovl,M1.c2.m_capGSovl,M1.c2.m_capOx,M1.c2.m_capbdb,M1.c2.m_capbds,M1.c2.m_capbsb,M1.c2.m_capbss,M1.c2.m_capgb,M1.c2.m_capgd,M1.c2.m_capgs,M1.c2.m_cbd,M1.c2.m_cbs,M1.c2.m_cdrain,M1.c2.m_chargebdb,M1.c2.m_chargebds,M1.c2.m_chargebsb,M1.c2.m_chargebss,M1.c2.m_dVt,M1.c2.m_drainResistance,M1.c2.m_f1b,M1.c2.m_f1s,M1.c2.m_f2b,M1.c2.m_f2s,M1.c2.m_f3b,M1.c2.m_f3s,M1.c2.m_gbd,M1.c2.m_gbs,M1.c2.m_gds,M1.c2.m_gm,M1.c2.m_gmbs,M1.c2.m_lEff,M1.c2.m_mode,M1.c2.m_qgb,M1.c2.m_qgd,M1.c2.m_qgs,M1.c2.m_sourceResistance,M1.c2.m_tBulkPot,M1.c2.m_tCBDb,M1.c2.m_tCBDs,M1.c2.m_tCBSb,M1.c2.m_tCBSs,M1.c2.m_tCj,M1.c2.m_tCjsw,M1.c2.m_tDepCap,M1.c2.m_tDrainSatCur,M1.c2.m_tPhi,M1.c2.m_tSatCurDens,M1.c2.m_tSourceSatCur,M1.c2.m_tSurfMob,M1.c2.m_tTransconductance,M1.c2.m_tVbi,M1.c2.m_tVto,M1.c2.m_vbs,M1.c2.m_vds,M1.c2.m_vdsat,M1.c2.m_vgs,M1.c2.m_von,M1.m.m_bPMOS,M1.m.m_dICVBS,M1.m.m_dICVBSIsGiven,M1.m.m_dICVDS,M1.m.m_dICVDSIsGiven,M1.m.m_dICVGS,M1.m.m_dICVGSIsGiven,M1.m.m_dTemp,M1.m.m_drainArea,M1.m.m_drainPerimeter,M1.m.m_drainPerimiter,M1.m.m_drainSquares,M1.m.m_len,M1.m.m_nLevel,M1.m.m_off,M1.m.m_sourceArea,M1.m.m_sourcePerimeter,M1.m.m_sourcePerimiter,M1.m.m_sourceSquares,M1.m.m_uic,M1.m.m_width,M1.m_type,M1.modelcard.AF,M1.modelcard.CBD,M1.modelcard.CBS,M1.modelcard.CGBO,M1.modelcard.CGDO,M1.modelcard.CGSO,M1.modelcard.CJ,M1.modelcard.CJSW,M1.modelcard.FC,M1.modelcard.GAMMA,M1.modelcard.IS,M1.modelcard.JS,M1.modelcard.KF,M1.modelcard.KP,M1.modelcard.LAMBDA,M1.modelcard.LD,M1.modelcard.MJ,M1.modelcard.MJSW,M1.modelcard.NSS,M1.modelcard.NSUB,M1.modelcard.PB,M1.modelcard.PHI,M1.modelcard.RD,M1.modelcard.RS,M1.modelcard.RSH,M1.modelcard.TNOM,M1.modelcard.TOX,M1.modelcard.TPG,M1.modelcard.UO,M1.modelcard.VTO,M1.mtype,M1.p.m_bulkCapFactor,M1.p.m_bulkCapFactorIsGiven,M1.p.m_bulkJctBotGradingCoeff,M1.p.m_bulkJctPotential,M1.p.m_bulkJctSideGradingCoeff,M1.p.m_capBD,M1.p.m_capBDIsGiven,M1.p.m_capBS,M1.p.m_capBSIsGiven,M1.p.m_cgboIsGiven,M1.p.m_cgdoIsGiven,M1.p.m_cgsoIsGiven,M1.p.m_drainResistance,M1.p.m_drainResistanceIsGiven,M1.p.m_fNcoef,M1.p.m_fNexp,M1.p.m_fwdCapDepCoeff,M1.p.m_gamma,M1.p.m_gammaIsGiven,M1.p.m_gateBulkOverlapCapFactor,M1.p.m_gateDrainOverlapCapFactor,M1.p.m_gateSourceOverlapCapFactor,M1.p.m_gateType,M1.p.m_jctSatCur,M1.p.m_jctSatCurDensity,M1.p.m_lambda,M1.p.m_latDiff,M1.p.m_mjswIsGiven,M1.p.m_oxideCapFactor,M1.p.m_oxideThickness,M1.p.m_oxideThicknessIsGiven,M1.p.m_pbIsGiven,M1.p.m_phi,M1.p.m_phiIsGiven,M1.p.m_sheetResistance,M1.p.m_sideWallCapFactor,M1.p.m_sourceResistance,M1.p.m_sourceResistanceIsGiven,M1.p.m_substrateDoping,M1.p.m_substrateDopingIsGiven,M1.p.m_surfaceMobility,M1.p.m_surfaceStateDensity,M1.p.m_surfaceStateDensityIsGiven,M1.p.m_tnom,M1.p.m_transconductance,M1.p.m_transconductanceIsGiven,M1.p.m_vt0,M1.p.m_vtOIsGiven,M1.vp.m_gamma,M1.vp.m_oxideCapFactor,M1.vp.m_phi,M1.vp.m_transconductance,M1.vp.m_vt0,MOD1.AF,MOD1.CBD,MOD1.CBS,MOD1.CGBO,MOD1.CGDO,MOD1.CGSO,MOD1.CJ,MOD1.CJSW,MOD1.FC,MOD1.GAMMA,MOD1.IS,MOD1.JS,MOD1.KF,MOD1.KP,MOD1.LAMBDA,MOD1.LD,MOD1.MJ,MOD1.MJSW,MOD1.NSS,MOD1.NSUB,MOD1.PB,MOD1.PHI,MOD1.RD,MOD1.RS,MOD1.RSH,MOD1.TNOM,MOD1.TOX,MOD1.TPG,MOD1.UO,MOD1.VTO,VDS.PER,VDS.PW,VDS.TD,VDS.TF,VDS.TR,VDS.Tfalling,VDS.Trising,VDS.Twidth,VDS.V1,VDS.V2,VGS.PER,VGS.PW,VGS.TD,VGS.TF,VGS.TR,VGS.Tfalling,VGS.Trising,VGS.Twidth,VGS.V1,VGS.V2,VGS.p.v,VIDS.V,VIDS.i,VIDS.v,time