Running: ./testmodel.py --libraries=/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelica/./OMCompiler/build/lib/omlibrary/ --ompython_omhome=/usr Modelica_3.2.2_Modelica.Electrical.Spice3.Examples.Spice3BenchmarkMosfetCharacterization.conf.json
Using package ModelicaServices with version 3.2.2 (/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/build/lib/omlibrary/ModelicaServices 3.2.2/package.mo)
Using package Complex with version 3.2.2 (/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/build/lib/omlibrary/Complex 3.2.2.mo)
Using package Modelica with version 3.2.2 (/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/build/lib/omlibrary/Modelica 3.2.2/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.2_Modelica.Electrical.Spice3.Examples.Spice3BenchmarkMosfetCharacterization")
Notification: Performance of loadModel(Modelica): time 2.169/2.169, allocations: 194.9 MB / 211.7 MB, free: 3.004 MB / 170.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0003533/0.0003534, allocations: 8 kB / 264.6 MB, free: 12.93 MB / 218.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.09689/0.09727, allocations: 44.5 MB / 309.1 MB, free: 372 kB / 250.7 MB
Notification: Performance of NFInst.instantiate(Modelica.Electrical.Spice3.Examples.Spice3BenchmarkMosfetCharacterization): time 0.006717/0.104, allocations: 4.405 MB / 313.5 MB, free: 11.93 MB / 266.7 MB
Notification: Performance of NFInst.instExpressions: time 0.02604/0.1301, allocations: 15.61 MB / 329.1 MB, free: 12.29 MB / 282.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0008627/0.131, allocations: 7.938 kB / 329.1 MB, free: 12.28 MB / 282.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.003019/0.1341, allocations: 0.7392 MB / 329.8 MB, free: 11.54 MB / 282.7 MB
Notification: Performance of NFTyping.typeBindings: time 0.005602/0.1397, allocations: 1.336 MB / 331.2 MB, free: 10.2 MB / 282.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.004794/0.1445, allocations: 1.051 MB / 332.2 MB, free: 9.145 MB / 282.7 MB
Notification: Performance of NFFlatten.flatten: time 0.004386/0.149, allocations: 1.495 MB / 333.7 MB, free: 7.648 MB / 282.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.0003731/0.1494, allocations: 147.8 kB / 333.8 MB, free: 7.496 MB / 282.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.0004824/0.1499, allocations: 266.7 kB / 334.1 MB, free: 7.234 MB / 282.7 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.0005337/0.1504, allocations: 326.2 kB / 334.4 MB, free: 6.914 MB / 282.7 MB
Notification: Performance of NFPackage.collectConstants: time 0.000101/0.1505, allocations: 19.98 kB / 334.4 MB, free: 6.895 MB / 282.7 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.004982/0.1555, allocations: 1.199 MB / 335.6 MB, free: 5.695 MB / 282.7 MB
Notification: Performance of NFScalarize.scalarize: time 0.0001968/0.1558, allocations: 91.38 kB / 335.7 MB, free: 5.605 MB / 282.7 MB
Notification: Performance of NFVerifyModel.verify: time 0.0003412/0.1561, allocations: 205.1 kB / 335.9 MB, free: 5.398 MB / 282.7 MB
Notification: Performance of NFConvertDAE.convert: time 0.002006/0.1581, allocations: 1.083 MB / 337 MB, free: 4.312 MB / 282.7 MB
Notification: Performance of FrontEnd - DAE generated: time 2.966e-06/0.1582, allocations: 0 / 337 MB, free: 4.312 MB / 282.7 MB
Notification: Performance of FrontEnd: time 1.934e-06/0.1582, allocations: 0 / 337 MB, free: 4.312 MB / 282.7 MB
Notification: Performance of Transformations before backend: time 1.018e-05/0.1582, allocations: 0 / 337 MB, free: 4.312 MB / 282.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.003051/0.1612, allocations: 1.266 MB / 338.3 MB, free: 2.988 MB / 282.7 MB
Notification: Performance of prepare preOptimizeDAE: time 4.99e-05/0.1613, allocations: 8.031 kB / 338.3 MB, free: 2.98 MB / 282.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0002126/0.1615, allocations: 122.4 kB / 338.4 MB, free: 2.859 MB / 282.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.001622/0.1632, allocations: 0.7404 MB / 339.2 MB, free: 2.066 MB / 282.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 3.349e-05/0.1632, allocations: 16.56 kB / 339.2 MB, free: 2.051 MB / 282.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 9.861e-05/0.1633, allocations: 20 kB / 339.2 MB, free: 2.031 MB / 282.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.001276/0.1646, allocations: 364.6 kB / 339.5 MB, free: 1.668 MB / 282.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 1.44e-05/0.1646, allocations: 0 / 339.5 MB, free: 1.668 MB / 282.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 5.461e-05/0.1647, allocations: 8 kB / 339.6 MB, free: 1.66 MB / 282.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 1.779e-05/0.1647, allocations: 8 kB / 339.6 MB, free: 1.652 MB / 282.7 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.00163/0.1664, allocations: 386 kB / 339.9 MB, free: 1.277 MB / 282.7 MB
Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.002991/0.1694, allocations: 1.246 MB / 341.2 MB, free: 15.95 MB / 298.7 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.001512/0.1709, allocations: 310.6 kB / 341.5 MB, free: 15.64 MB / 298.7 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.0124/0.1833, allocations: 7.822 MB / 349.3 MB, free: 6.773 MB / 298.7 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0009204/0.1843, allocations: 225.1 kB / 349.5 MB, free: 6.543 MB / 298.7 MB
Notification: Performance of pre-optimization done (n=19): time 3.868e-06/0.1843, allocations: 0 / 349.5 MB, free: 6.543 MB / 298.7 MB
Notification: Performance of matching and sorting (n=19): time 0.002598/0.1869, allocations: 0.6231 MB / 350.1 MB, free: 5.895 MB / 298.7 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 5.574e-05/0.187, allocations: 59.41 kB / 350.2 MB, free: 5.824 MB / 298.7 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001612/0.1886, allocations: 0.8827 MB / 351.1 MB, free: 4.93 MB / 298.7 MB
Notification: Performance of collectPreVariables (initialization): time 4.678e-05/0.1887, allocations: 33.69 kB / 351.1 MB, free: 4.891 MB / 298.7 MB
Notification: Performance of collectInitialEqns (initialization): time 0.000563/0.1893, allocations: 456.4 kB / 351.6 MB, free: 4.438 MB / 298.7 MB
Notification: Performance of collectInitialBindings (initialization): time 8.974e-05/0.1894, allocations: 67.19 kB / 351.6 MB, free: 4.371 MB / 298.7 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 3.277e-05/0.1894, allocations: 11.98 kB / 351.6 MB, free: 4.359 MB / 298.7 MB
Notification: Performance of setup shared object (initialization): time 0.0001539/0.1896, allocations: 322 kB / 352 MB, free: 4.039 MB / 298.7 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0007089/0.1903, allocations: 135.9 kB / 352.1 MB, free: 3.906 MB / 298.7 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0008349/0.1911, allocations: 285.8 kB / 352.4 MB, free: 3.562 MB / 298.7 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.0007505/0.1919, allocations: 163.9 kB / 352.5 MB, free: 3.402 MB / 298.7 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 5.3e-06/0.1919, allocations: 0 / 352.5 MB, free: 3.402 MB / 298.7 MB
Notification: Performance of matching and sorting (n=43) (initialization): time 0.001896/0.1938, allocations: 0.5428 MB / 353.1 MB, free: 2.852 MB / 298.7 MB
Notification: Performance of prepare postOptimizeDAE: time 2.385e-05/0.1939, allocations: 8 kB / 353.1 MB, free: 2.844 MB / 298.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 5.605e-05/0.194, allocations: 20.56 kB / 353.1 MB, free: 2.824 MB / 298.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 3.178e-05/0.194, allocations: 12 kB / 353.1 MB, free: 2.812 MB / 298.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0006353/0.1946, allocations: 91.88 kB / 353.2 MB, free: 2.723 MB / 298.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.036e-05/0.1947, allocations: 11.94 kB / 353.2 MB, free: 2.711 MB / 298.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0006769/0.1954, allocations: 63.7 kB / 353.3 MB, free: 2.648 MB / 298.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 6.277e-05/0.1954, allocations: 20 kB / 353.3 MB, free: 2.629 MB / 298.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.0004038/0.1958, allocations: 211.7 kB / 353.5 MB, free: 2.414 MB / 298.7 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0001704/0.196, allocations: 110.7 kB / 353.6 MB, free: 2.305 MB / 298.7 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.002314/0.1984, allocations: 0.515 MB / 354.1 MB, free: 1.781 MB / 298.7 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 8.145e-06/0.1984, allocations: 3.953 kB / 354.1 MB, free: 1.777 MB / 298.7 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 4.027e-05/0.1984, allocations: 16 kB / 354.1 MB, free: 1.762 MB / 298.7 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.0003571/0.1988, allocations: 195.7 kB / 354.3 MB, free: 1.551 MB / 298.7 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001918/0.199, allocations: 11.98 kB / 354.4 MB, free: 1.539 MB / 298.7 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0005533/0.1996, allocations: 39.97 kB / 354.4 MB, free: 1.5 MB / 298.7 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.000137/0.1997, allocations: 27.95 kB / 354.4 MB, free: 1.473 MB / 298.7 MB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.001938/0.2017, allocations: 452.7 kB / 354.9 MB, free: 1.023 MB / 298.7 MB
Notification: Performance of postOpt detectDAEmodeSparsePattern (simulation): time 0.00182/0.2035, allocations: 0.6039 MB / 355.5 MB, free: 416 kB / 298.7 MB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.000713/0.2042, allocations: 143.9 kB / 355.6 MB, free: 272 kB / 298.7 MB
Notification: Performance of sorting global known variables: time 0.001136/0.2054, allocations: 0.5806 MB / 356.2 MB, free: 15.68 MB / 314.7 MB
Notification: Performance of Backend: time 7.71e-07/0.2054, allocations: 0 / 356.2 MB, free: 15.68 MB / 314.7 MB
Notification: Performance of simCode: created initialization part: time 0.002548/0.208, allocations: 0.8195 MB / 357 MB, free: 14.85 MB / 314.7 MB
Notification: Performance of SimCode: time 0.003717/0.2117, allocations: 2.111 MB / 359.1 MB, free: 12.68 MB / 314.7 MB
Notification: Performance of Templates: time 0.2811/0.4928, allocations: 14.4 MB / 373.5 MB, free: 66.21 MB / 314.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