Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr ScalableTestGrids_AnalyticJacobian_ScalableTestGrids.Models.Type2.Type2_noTap___N_4_M_4.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 1.0.2/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ScalableTestGrids 1.1.0-master/package.mo", uses=false)
Using package ScalableTestGrids with version 1.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ScalableTestGrids 1.1.0-master/package.mo)
Using package PowerGrids with version 1.0.2 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 1.0.2/package.mo)
Using package ModelicaServices with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo)
Using package Modelica with version 3.2.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo)
Using package Complex with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo)
Running command: translateModel(ScalableTestGrids.Models.Type2.Type2_noTap___N_4_M_4,tolerance=1e-05,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="ScalableTestGrids_AnalyticJacobian_ScalableTestGrids.Models.Type2.Type2_noTap___N_4_M_4")
translateModel(ScalableTestGrids.Models.Type2.Type2_noTap___N_4_M_4,tolerance=1e-05,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="ScalableTestGrids_AnalyticJacobian_ScalableTestGrids.Models.Type2.Type2_noTap___N_4_M_4")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.0009135/0.0009136, allocations: 192 kB / 17.33 MB, free: 6.141 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 0.3061/0.3061, allocations: 205.5 MB / 223.6 MB, free: 0.9336 MB / 190.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.0008791/0.0008791, allocations: 111.4 kB / 271 MB, free: 8.605 MB / 222.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 1.0.2/package.mo): time 0.1128/0.1128, allocations: 14.44 MB / 332.8 MB, free: 45.07 MB / 270.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ScalableTestGrids 1.1.0-master/package.mo): time 1.351/1.351, allocations: 438.4 MB / 0.8028 GB, free: 7.879 MB / 0.592 GB
Notification: Modelica requested package Complex of version 3.2.3. Complex 4.0.0 is used instead which states that it is fully compatible without conversion script needed.
Notification: Modelica requested package ModelicaServices of version 3.2.3. ModelicaServices 4.0.0 is used instead which states that it is fully compatible without conversion script needed.
Notification: Performance of FrontEnd - loaded program: time 0.001219/0.001219, allocations: 71.89 kB / 0.9788 GB, free: 4.02 MB / 0.7017 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1861/0.1873, allocations: 166.1 MB / 1.141 GB, free: 13.64 MB / 0.8735 GB
Notification: Performance of NFInst.instantiate(ScalableTestGrids.Models.Type2.Type2_noTap___N_4_M_4): time 2.846/3.033, allocations: 1.441 GB / 2.582 GB, free: 15.07 MB / 1.608 GB
Notification: Performance of NFInst.instExpressions: time 0.6253/3.659, allocations: 0.4929 GB / 3.075 GB, free: 15.28 MB / 1.921 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.2282/3.887, allocations: 5.227 MB / 3.08 GB, free: 10.03 MB / 1.921 GB
Notification: Performance of NFTyping.typeComponents: time 1.179/5.066, allocations: 64.45 MB / 3.143 GB, free: 4.32 MB / 1.921 GB
Notification: Performance of NFTyping.typeBindings: time 0.4579/5.524, allocations: 176.5 MB / 3.316 GB, free: 5.992 MB / 1.937 GB
Notification: Performance of NFTyping.typeClassSections: time 0.1233/5.648, allocations: 49.12 MB / 3.364 GB, free: 13.52 MB / 1.952 GB
Notification: Performance of NFFlatten.flatten: time 0.5439/6.192, allocations: 0.4987 GB / 3.862 GB, free: 5.684 MB / 2.374 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.09953/6.291, allocations: 51.35 MB / 3.913 GB, free: 2.77 MB / 2.421 GB
Notification: Performance of NFEvalConstants.evaluate: time 1.288/7.579, allocations: 145.6 MB / 4.055 GB, free: 100.7 MB / 2.483 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.1946/7.773, allocations: 155.9 MB / 4.207 GB, free: 79.74 MB / 2.483 GB
Notification: Performance of NFPackage.collectConstants: time 0.06717/7.841, allocations: 18.15 MB / 4.225 GB, free: 79.74 MB / 2.483 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.1552/7.996, allocations: 37.21 MB / 4.261 GB, free: 79.74 MB / 2.483 GB
Notification: Performance of NFScalarize.scalarize: time 0.06066/8.056, allocations: 43.85 MB / 4.304 GB, free: 70.18 MB / 2.483 GB
Notification: Performance of NFVerifyModel.verify: time 0.2144/8.271, allocations: 146.1 MB / 4.447 GB, free: 31.95 MB / 2.483 GB
Notification: Performance of NFConvertDAE.convert: time 0.374/8.645, allocations: 333.4 MB / 4.772 GB, free: 4.344 MB / 2.577 GB
Notification: Performance of FrontEnd - DAE generated: time 6.562e-06/8.645, allocations: 0 / 4.772 GB, free: 4.344 MB / 2.577 GB
Notification: Performance of FrontEnd: time 1.423e-06/8.645, allocations: 3.938 kB / 4.772 GB, free: 4.34 MB / 2.577 GB
Notification: Performance of Transformations before backend: time 0.009506/8.655, allocations: 2.594 kB / 4.772 GB, free: 4.34 MB / 2.577 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 51078
 * Number of variables: 51078
Notification: Performance of Generate backend data structure: time 2.235/10.89, allocations: 354.8 MB / 5.119 GB, free: 1.179 GB / 2.656 GB
Notification: Performance of prepare preOptimizeDAE: time 4.43e-05/10.89, allocations: 9.328 kB / 5.119 GB, free: 1.179 GB / 2.656 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.1658/11.06, allocations: 38.17 MB / 5.156 GB, free: 1.161 GB / 2.656 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.2906/11.35, allocations: 144.3 MB / 5.297 GB, free: 1.059 GB / 2.656 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.01372/11.36, allocations: 14.93 MB / 5.312 GB, free: 1.049 GB / 2.656 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.05407/11.41, allocations: 19.7 MB / 5.331 GB, free: 1.03 GB / 2.656 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.4167/11.83, allocations: 206.9 MB / 5.533 GB, free: 0.8203 GB / 2.656 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.007764/11.84, allocations: 424 kB / 5.533 GB, free: 0.8199 GB / 2.656 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.04314/11.88, allocations: 8.07 MB / 5.541 GB, free: 0.812 GB / 2.656 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.002269/11.88, allocations: 4.84 MB / 5.546 GB, free: 0.8072 GB / 2.656 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.3475/12.23, allocations: 196.3 MB / 5.738 GB, free: 0.6156 GB / 2.656 GB
Warning: The model contains alias variables with redundant start and/or conflicting nominal values. It is recommended to resolve the conflicts, because otherwise the system could be hard to solve. To print the conflicting alias sets and the chosen candidates please use -d=aliasConflicts.
Notification: Performance of preOpt removeSimpleEquations (simulation): time 2.169/14.4, allocations: 1.256 GB / 6.994 GB, free: 0.4977 GB / 2.656 GB
Notification: Performance of preOpt comSubExp (simulation): time 2.005/16.41, allocations: 0.6229 GB / 7.617 GB, free: 0.9681 GB / 2.656 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.1678/16.57, allocations: 94.26 MB / 7.709 GB, free: 0.9666 GB / 2.656 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.01703/16.59, allocations: 2.389 MB / 7.711 GB, free: 0.9664 GB / 2.656 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.001176/16.59, allocations: 2.19 MB / 7.713 GB, free: 0.9662 GB / 2.656 GB
Notification: Performance of pre-optimization done (n=21307): time 0.0002371/16.59, allocations: 0.8438 kB / 7.713 GB, free: 0.9662 GB / 2.656 GB
Notification: Performance of matching and sorting (n=21339): time 1.917/18.51, allocations: 479.3 MB / 8.182 GB, free: 1.039 GB / 2.656 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.001904/18.51, allocations: 5.426 MB / 8.187 GB, free: 1.035 GB / 2.656 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.2206/18.73, allocations: 123.8 MB / 8.308 GB, free: 1.028 GB / 2.656 GB
Notification: Performance of collectPreVariables (initialization): time 0.02754/18.76, allocations: 3.632 MB / 8.311 GB, free: 1.028 GB / 2.656 GB
Notification: Performance of collectInitialEqns (initialization): time 0.06811/18.83, allocations: 100.3 MB / 8.409 GB, free: 0.9781 GB / 2.656 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0746/18.9, allocations: 74.13 MB / 8.482 GB, free: 0.9207 GB / 2.656 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.1129/19.02, allocations: 38.44 MB / 8.519 GB, free: 0.9023 GB / 2.656 GB
Notification: Performance of setup shared object (initialization): time 3.702e-05/19.02, allocations: 304.5 kB / 8.519 GB, free: 0.902 GB / 2.656 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.1308/19.15, allocations: 71.37 MB / 8.589 GB, free: 0.8737 GB / 2.656 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.1626/19.31, allocations: 116.1 MB / 8.702 GB, free: 0.7985 GB / 2.656 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.8438/20.15, allocations: 193.1 MB / 8.891 GB, free: 0.6759 GB / 2.656 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.001309/20.15, allocations: 310 kB / 8.891 GB, free: 0.6759 GB / 2.656 GB
Notification: Performance of matching and sorting (n=30657) (initialization): time 1.666/21.82, allocations: 305.6 MB / 9.19 GB, free: 0.9777 GB / 2.656 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0006608/21.82, allocations: 475.1 kB / 9.19 GB, free: 0.9777 GB / 2.656 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.001486/21.82, allocations: 1.062 MB / 9.191 GB, free: 0.9777 GB / 2.656 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.5877/22.41, allocations: 137.4 MB / 9.325 GB, free: 0.9498 GB / 2.656 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.1501/22.56, allocations: 42.96 MB / 9.367 GB, free: 0.9304 GB / 2.656 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.716/25.28, allocations: 1.103 GB / 10.47 GB, free: 0.5672 GB / 2.656 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.1719/25.45, allocations: 11.6 MB / 10.48 GB, free: 0.557 GB / 2.656 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.03316/25.48, allocations: 8.238 MB / 10.49 GB, free: 0.5489 GB / 2.656 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.1893/25.67, allocations: 92.95 MB / 10.58 GB, free: 469.1 MB / 2.656 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 1.175/26.85, allocations: 112.2 MB / 10.69 GB, free: 0.8203 GB / 2.656 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.825/27.67, allocations: 187.9 MB / 10.87 GB, free: 0.7743 GB / 2.656 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 0.001161/27.67, allocations: 311.4 kB / 10.87 GB, free: 0.7743 GB / 2.656 GB
Notification: Performance of matching and sorting (n=30657) (initialization_lambda0): time 0.5811/28.25, allocations: 278.5 MB / 11.15 GB, free: 0.6434 GB / 2.656 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0006656/28.25, allocations: 472 kB / 11.15 GB, free: 0.6429 GB / 2.656 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.001263/28.25, allocations: 1.064 MB / 11.15 GB, free: 0.6419 GB / 2.656 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.5181/28.77, allocations: 120 MB / 11.27 GB, free: 0.5433 GB / 2.656 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.1557/28.93, allocations: 45.31 MB / 11.31 GB, free: 0.499 GB / 2.656 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.454/31.38, allocations: 0.9395 GB / 12.25 GB, free: 330.2 MB / 2.656 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.1672/31.55, allocations: 10.26 MB / 12.26 GB, free: 324.6 MB / 2.656 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.03158/31.58, allocations: 8.195 MB / 12.27 GB, free: 322.6 MB / 2.656 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 4975
 * Number of states: 0 ()
 * Number of discrete variables: 160 (GEN_8_4.PSS.firstWashoutVsi2.integrator.local_reset,GEN_8_4.PSS.secondWashoutVsi1.integrator.local_reset,GEN_8_4.PSS.firstWashoutVsi1.integrator.local_reset,GEN_8_4.AVR.firstOrderLim.I.local_reset,GEN_8_4.TGOV.firstOrderLim.I.local_reset,GEN_8_3.PSS.firstWashoutVsi2.integrator.local_reset,GEN_8_3.PSS.secondWashoutVsi1.integrator.local_reset,GEN_8_3.PSS.firstWashoutVsi1.integrator.local_reset,GEN_8_3.AVR.firstOrderLim.I.local_reset,GEN_8_3.TGOV.firstOrderLim.I.local_reset,GEN_8_2.PSS.firstWashoutVsi2.integrator.local_reset,GEN_8_2.PSS.secondWashoutVsi1.integrator.local_reset,GEN_8_2.PSS.firstWashoutVsi1.integrator.local_reset,GEN_8_2.AVR.firstOrderLim.I.local_reset,GEN_8_2.TGOV.firstOrderLim.I.local_reset,GEN_8_1.PSS.firstWashoutVsi2.integrator.local_reset,GEN_8_1.PSS.secondWashoutVsi1.integrator.local_reset,GEN_8_1.PSS.firstWashoutVsi1.integrator.local_reset,GEN_8_1.AVR.firstOrderLim.I.local_reset,GEN_8_1.TGOV.firstOrderLim.I.local_reset,GEN_7_4.PSS.firstWashoutVsi2.integrator.local_reset,GEN_7_4.PSS.secondWashoutVsi1.integrator.local_reset,GEN_7_4.PSS.firstWashoutVsi1.integrator.local_reset,GEN_7_4.AVR.firstOrderLim.I.local_reset,GEN_7_4.TGOV.firstOrderLim.I.local_reset,GEN_7_3.PSS.firstWashoutVsi2.integrator.local_reset,GEN_7_3.PSS.secondWashoutVsi1.integrator.local_reset,GEN_7_3.PSS.firstWashoutVsi1.integrator.local_reset,GEN_7_3.AVR.firstOrderLim.I.local_reset,GEN_7_3.TGOV.firstOrderLim.I.local_reset,GEN_7_2.PSS.firstWashoutVsi2.integrator.local_reset,GEN_7_2.PSS.secondWashoutVsi1.integrator.local_reset,GEN_7_2.PSS.firstWashoutVsi1.integrator.local_reset,GEN_7_2.AVR.firstOrderLim.I.local_reset,GEN_7_2.TGOV.firstOrderLim.I.local_reset,GEN_7_1.PSS.firstWashoutVsi2.integrator.local_reset,GEN_7_1.PSS.secondWashoutVsi1.integrator.local_reset,GEN_7_1.PSS.firstWashoutVsi1.integrator.local_reset,GEN_7_1.AVR.firstOrderLim.I.local_reset,GEN_7_1.TGOV.firstOrderLim.I.local_reset,GEN_6_4.PSS.firstWashoutVsi2.integrator.local_reset,GEN_6_4.PSS.secondWashoutVsi1.integrator.local_reset,GEN_6_4.PSS.firstWashoutVsi1.integrator.local_reset,GEN_6_4.AVR.firstOrderLim.I.local_reset,GEN_6_4.TGOV.firstOrderLim.I.local_reset,GEN_6_3.PSS.firstWashoutVsi2.integrator.local_reset,GEN_6_3.PSS.secondWashoutVsi1.integrator.local_reset,GEN_6_3.PSS.firstWashoutVsi1.integrator.local_reset,GEN_6_3.AVR.firstOrderLim.I.local_reset,GEN_6_3.TGOV.firstOrderLim.I.local_reset,GEN_6_2.PSS.firstWashoutVsi2.integrator.local_reset,GEN_6_2.PSS.secondWashoutVsi1.integrator.local_reset,GEN_6_2.PSS.firstWashoutVsi1.integrator.local_reset,GEN_6_2.AVR.firstOrderLim.I.local_reset,GEN_6_2.TGOV.firstOrderLim.I.local_reset,GEN_6_1.PSS.firstWashoutVsi2.integrator.local_reset,GEN_6_1.PSS.secondWashoutVsi1.integrator.local_reset,GEN_6_1.PSS.firstWashoutVsi1.integrator.local_reset,GEN_6_1.AVR.firstOrderLim.I.local_reset,GEN_6_1.TGOV.firstOrderLim.I.local_reset,GEN_5_4.PSS.firstWashoutVsi2.integrator.local_reset,GEN_5_4.PSS.secondWashoutVsi1.integrator.local_reset,GEN_5_4.PSS.firstWashoutVsi1.integrator.local_reset,GEN_5_4.AVR.firstOrderLim.I.local_reset,GEN_5_4.TGOV.firstOrderLim.I.local_reset,GEN_5_3.PSS.firstWashoutVsi2.integrator.local_reset,GEN_5_3.PSS.secondWashoutVsi1.integrator.local_reset,GEN_5_3.PSS.firstWashoutVsi1.integrator.local_reset,GEN_5_3.AVR.firstOrderLim.I.local_reset,GEN_5_3.TGOV.firstOrderLim.I.local_reset,GEN_5_2.PSS.firstWashoutVsi2.integrator.local_reset,GEN_5_2.PSS.secondWashoutVsi1.integrator.local_reset,GEN_5_2.PSS.firstWashoutVsi1.integrator.local_reset,GEN_5_2.AVR.firstOrderLim.I.local_reset,GEN_5_2.TGOV.firstOrderLim.I.local_reset,GEN_5_1.PSS.firstWashoutVsi2.integrator.local_reset,GEN_5_1.PSS.secondWashoutVsi1.integrator.local_reset,GEN_5_1.PSS.firstWashoutVsi1.integrator.local_reset,GEN_5_1.AVR.firstOrderLim.I.local_reset,GEN_5_1.TGOV.firstOrderLim.I.local_reset,GEN_4_4.PSS.firstWashoutVsi2.integrator.local_reset,GEN_4_4.PSS.secondWashoutVsi1.integrator.local_reset,GEN_4_4.PSS.firstWashoutVsi1.integrator.local_reset,GEN_4_4.AVR.firstOrderLim.I.local_reset,GEN_4_4.TGOV.firstOrderLim.I.local_reset,GEN_4_3.PSS.firstWashoutVsi2.integrator.local_reset,GEN_4_3.PSS.secondWashoutVsi1.integrator.local_reset,GEN_4_3.PSS.firstWashoutVsi1.integrator.local_reset,GEN_4_3.AVR.firstOrderLim.I.local_reset,GEN_4_3.TGOV.firstOrderLim.I.local_reset,GEN_4_2.PSS.firstWashoutVsi2.integrator.local_reset,GEN_4_2.PSS.secondWashoutVsi1.integrator.local_reset,GEN_4_2.PSS.firstWashoutVsi1.integrator.local_reset,GEN_4_2.AVR.firstOrderLim.I.local_reset,GEN_4_2.TGOV.firstOrderLim.I.local_reset,GEN_4_1.PSS.firstWashoutVsi2.integrator.local_reset,GEN_4_1.PSS.secondWashoutVsi1.integrator.local_reset,GEN_4_1.PSS.firstWashoutVsi1.integrator.local_reset,GEN_4_1.AVR.firstOrderLim.I.local_reset,GEN_4_1.TGOV.firstOrderLim.I.local_reset,GEN_3_4.PSS.firstWashoutVsi2.integrator.local_reset,GEN_3_4.PSS.secondWashoutVsi1.integrator.local_reset,GEN_3_4.PSS.firstWashoutVsi1.integrator.local_reset,GEN_3_4.AVR.firstOrderLim.I.local_reset,GEN_3_4.TGOV.firstOrderLim.I.local_reset,GEN_3_3.PSS.firstWashoutVsi2.integrator.local_reset,GEN_3_3.PSS.secondWashoutVsi1.integrator.local_reset,GEN_3_3.PSS.firstWashoutVsi1.integrator.local_reset,GEN_3_3.AVR.firstOrderLim.I.local_reset,GEN_3_3.TGOV.firstOrderLim.I.local_reset,GEN_3_2.PSS.firstWashoutVsi2.integrator.local_reset,GEN_3_2.PSS.secondWashoutVsi1.integrator.local_reset,GEN_3_2.PSS.firstWashoutVsi1.integrator.local_reset,GEN_3_2.AVR.firstOrderLim.I.local_reset,GEN_3_2.TGOV.firstOrderLim.I.local_reset,GEN_3_1.PSS.firstWashoutVsi2.integrator.local_reset,GEN_3_1.PSS.secondWashoutVsi1.integrator.local_reset,GEN_3_1.PSS.firstWashoutVsi1.integrator.local_reset,GEN_3_1.AVR.firstOrderLim.I.local_reset,GEN_3_1.TGOV.firstOrderLim.I.local_reset,GEN_2_4.PSS.firstWashoutVsi2.integrator.local_reset,GEN_2_4.PSS.secondWashoutVsi1.integrator.local_reset,GEN_2_4.PSS.firstWashoutVsi1.integrator.local_reset,GEN_2_4.AVR.firstOrderLim.I.local_reset,GEN_2_4.TGOV.firstOrderLim.I.local_reset,GEN_2_3.PSS.firstWashoutVsi2.integrator.local_reset,GEN_2_3.PSS.secondWashoutVsi1.integrator.local_reset,GEN_2_3.PSS.firstWashoutVsi1.integrator.local_reset,GEN_2_3.AVR.firstOrderLim.I.local_reset,GEN_2_3.TGOV.firstOrderLim.I.local_reset,GEN_2_2.PSS.firstWashoutVsi2.integrator.local_reset,GEN_2_2.PSS.secondWashoutVsi1.integrator.local_reset,GEN_2_2.PSS.firstWashoutVsi1.integrator.local_reset,GEN_2_2.AVR.firstOrderLim.I.local_reset,GEN_2_2.TGOV.firstOrderLim.I.local_reset,GEN_2_1.PSS.firstWashoutVsi2.integrator.local_reset,GEN_2_1.PSS.secondWashoutVsi1.integrator.local_reset,GEN_2_1.PSS.firstWashoutVsi1.integrator.local_reset,GEN_2_1.AVR.firstOrderLim.I.local_reset,GEN_2_1.TGOV.firstOrderLim.I.local_reset,GEN_1_4.PSS.firstWashoutVsi2.integrator.local_reset,GEN_1_4.PSS.secondWashoutVsi1.integrator.local_reset,GEN_1_4.PSS.firstWashoutVsi1.integrator.local_reset,GEN_1_4.AVR.firstOrderLim.I.local_reset,GEN_1_4.TGOV.firstOrderLim.I.local_reset,GEN_1_3.PSS.firstWashoutVsi2.integrator.local_reset,GEN_1_3.PSS.secondWashoutVsi1.integrator.local_reset,GEN_1_3.PSS.firstWashoutVsi1.integrator.local_reset,GEN_1_3.AVR.firstOrderLim.I.local_reset,GEN_1_3.TGOV.firstOrderLim.I.local_reset,GEN_1_2.PSS.firstWashoutVsi2.integrator.local_reset,GEN_1_2.PSS.secondWashoutVsi1.integrator.local_reset,GEN_1_2.PSS.firstWashoutVsi1.integrator.local_reset,GEN_1_2.AVR.firstOrderLim.I.local_reset,GEN_1_2.TGOV.firstOrderLim.I.local_reset,GEN_1_1.PSS.firstWashoutVsi2.integrator.local_reset,GEN_1_1.PSS.secondWashoutVsi1.integrator.local_reset,GEN_1_1.PSS.firstWashoutVsi1.integrator.local_reset,GEN_1_1.AVR.firstOrderLim.I.local_reset,GEN_1_1.TGOV.firstOrderLim.I.local_reset)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (23457):
 * Single equations (assignments): 23167
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 290
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 128 systems
   {(2,0,100.0%), (2,0,100.0%), (3,0,66.7%), (3,0,66.7%), (2,0,100.0%), (2,0,100.0%), (3,0,66.7%), (3,0,66.7%), (2,0,100.0%), (2,0,100.0%), (3,0,66.7%), (3,0,66.7%), (2,0,100.0%), (2,0,100.0%), (3,0,66.7%), (3,0,66.7%), (2,0,100.0%), (2,0,100.0%), (3,0,66.7%), (3,0,66.7%), (2,0,100.0%), (2,0,100.0%), (3,0,66.7%), (3,0,66.7%), (2,0,100.0%), (2,0,100.0%), (3,0,66.7%), (3,0,66.7%), (2,0,100.0%), (2,0,100.0%), (3,0,66.7%), (3,0,66.7%), (2,0,100.0%), (2,0,100.0%), (3,0,66.7%), (3,0,66.7%), (2,0,100.0%), (2,0,100.0%), (3,0,66.7%), (3,0,66.7%), (2,0,100.0%), (2,0,100.0%), (3,0,66.7%), (3,0,66.7%), (2,0,100.0%), (2,0,100.0%), (3,0,66.7%), (3,0,66.7%), (2,0,100.0%), (2,0,100.0%), (3,0,66.7%), (3,0,66.7%), (2,0,100.0%), (2,0,100.0%), (3,0,66.7%), (3,0,66.7%), (2,0,100.0%), (2,0,100.0%), (3,0,66.7%), (3,0,66.7%), (2,0,100.0%), (2,0,100.0%), (3,0,66.7%), (3,0,66.7%), (2,0,100.0%), (2,0,100.0%), (3,0,66.7%), (3,0,66.7%), (2,0,100.0%), (2,0,100.0%), (3,0,66.7%), (3,0,66.7%), (2,0,100.0%), (2,0,100.0%), (3,0,66.7%), (3,0,66.7%), (2,0,100.0%), (2,0,100.0%), (3,0,66.7%), (3,0,66.7%), (2,0,100.0%), (2,0,100.0%), (3,0,66.7%), (3,0,66.7%), (2,0,100.0%), (2,0,100.0%), (3,0,66.7%), (3,0,66.7%), (2,0,100.0%), (2,0,100.0%), (3,0,66.7%), (3,0,66.7%), (2,0,100.0%), (2,0,100.0%), (3,0,66.7%), (3,0,66.7%), (2,0,100.0%), (2,0,100.0%), (3,0,66.7%), (3,0,66.7%), (2,0,100.0%), (2,0,100.0%), (3,0,66.7%), (3,0,66.7%), (2,0,100.0%), (2,0,100.0%), (3,0,66.7%), (3,0,66.7%), (2,0,100.0%), (2,0,100.0%), (3,0,66.7%), (3,0,66.7%), (2,0,100.0%), (2,0,100.0%), (3,0,66.7%), (3,0,66.7%), (2,0,100.0%), (2,0,100.0%), (3,0,66.7%), (3,0,66.7%), (2,0,100.0%), (2,0,100.0%), (3,0,66.7%), (3,0,66.7%), (2,0,100.0%), (2,0,100.0%), (3,0,66.7%), (3,0,66.7%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 162 systems
   {(38,0), (6556,0), (2,0), (2,0), (2,0), (2,0), (10,0), (2,0), (2,0), (2,0), (2,0), (10,0), (2,0), (2,0), (2,0), (2,0), (10,0), (2,0), (2,0), (2,0), (2,0), (10,0), (2,0), (2,0), (2,0), (2,0), (10,0), (2,0), (2,0), (2,0), (2,0), (10,0), (2,0), (2,0), (2,0), (2,0), (10,0), (2,0), (2,0), (2,0), (2,0), (10,0), (2,0), (2,0), (2,0), (2,0), (10,0), (2,0), (2,0), (2,0), (2,0), (10,0), (2,0), (2,0), (2,0), (2,0), (10,0), (2,0), (2,0), (2,0), (2,0), (10,0), (2,0), (2,0), (2,0), (2,0), (10,0), (2,0), (2,0), (2,0), (2,0), (10,0), (2,0), (2,0), (2,0), (2,0), (10,0), (2,0), (2,0), (2,0), (2,0), (10,0), (2,0), (2,0), (2,0), (2,0), (10,0), (2,0), (2,0), (2,0), (2,0), (10,0), (2,0), (2,0), (2,0), (2,0), (10,0), (2,0), (2,0), (2,0), (2,0), (10,0), (2,0), (2,0), (2,0), (2,0), (10,0), (2,0), (2,0), (2,0), (2,0), (10,0), (2,0), (2,0), (2,0), (2,0), (10,0), (2,0), (2,0), (2,0), (2,0), (10,0), (2,0), (2,0), (2,0), (2,0), (10,0), (2,0), (2,0), (2,0), (2,0), (10,0), (2,0), (2,0), (2,0), (2,0), (10,0), (2,0), (2,0), (2,0), (2,0), (10,0), (2,0), (2,0), (2,0), (2,0), (10,0), (2,0), (2,0), (2,0), (2,0), (10,0), (2,0), (2,0), (2,0), (2,0), (10,0), (2,0), (2,0), (2,0), (2,0), (10,0)}
Notification: Performance of prepare postOptimizeDAE: time 0.05935/31.64, allocations: 12.84 MB / 12.28 GB, free: 314.6 MB / 2.656 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.05449/31.7, allocations: 20.2 MB / 12.3 GB, free: 295.3 MB / 2.656 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 1.584/33.28, allocations: 231.6 MB / 12.53 GB, free: 0.7385 GB / 2.656 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.004532/33.28, allocations: 0.9792 MB / 12.53 GB, free: 0.7385 GB / 2.656 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 0.0003121/33.28, allocations: 1.828 kB / 12.53 GB, free: 0.7385 GB / 2.656 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0982/33.38, allocations: 33.92 MB / 12.56 GB, free: 0.7362 GB / 2.656 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.05348/33.44, allocations: 3.47 MB / 12.56 GB, free: 0.7335 GB / 2.656 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.1325/33.57, allocations: 7.935 MB / 12.57 GB, free: 0.7309 GB / 2.656 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.04112/33.61, allocations: 17.03 MB / 12.59 GB, free: 0.7294 GB / 2.656 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.6044/34.21, allocations: 214.5 MB / 12.8 GB, free: 0.6548 GB / 2.656 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 3.149/37.36, allocations: 0.9731 GB / 13.77 GB, free: 0.5175 GB / 2.672 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.1227/37.49, allocations: 67.47 MB / 13.84 GB, free: 493.9 MB / 2.672 GB
Notification: Performance of sorting global known variables: time 0.1217/37.61, allocations: 79.51 MB / 13.91 GB, free: 423.6 MB / 2.672 GB
Notification: Performance of Backend: time 6.62e-07/37.61, allocations: 2.734 kB / 13.91 GB, free: 423.6 MB / 2.672 GB
Warning: The hideResult annotation could not be evaluated, probably due to missing annotation(Evaluate=true). It is removed.
Notification: Performance of simCode: created initialization part: time 2.067/39.67, allocations: 0.5392 GB / 14.45 GB, free: 0.5565 GB / 2.672 GB
Warning: The hideResult annotation could not be evaluated, probably due to missing annotation(Evaluate=true). It is removed.
Notification: Performance of SimCode: time 2.175/41.85, allocations: 0.7602 GB / 15.21 GB, free: 0.5616 GB / 2.672 GB
Notification: Performance of Templates: time 9.494/51.34, allocations: 4.404 GB / 19.62 GB, free: 420.8 MB / 3.252 GB
make -j1 -f ScalableTestGrids_AnalyticJacobian_ScalableTestGrids.Models.Type2.Type2_noTap___N_4_M_4.makefile
(rm -f ScalableTestGrids_AnalyticJacobian_ScalableTestGrids.Models.Type2.Type2_noTap___N_4_M_4.pipe ; mkfifo ScalableTestGrids_AnalyticJacobian_ScalableTestGrids.Models.Type2.Type2_noTap___N_4_M_4.pipe ; head -c 1048576 < ScalableTestGrids_AnalyticJacobian_ScalableTestGrids.Models.Type2.Type2_noTap___N_4_M_4.pipe >> ../files/ScalableTestGrids_AnalyticJacobian_ScalableTestGrids.Models.Type2.Type2_noTap___N_4_M_4.sim & ./ScalableTestGrids_AnalyticJacobian_ScalableTestGrids.Models.Type2.Type2_noTap___N_4_M_4  -nls=kinsol -lv=LOG_STATS -abortSlowSimulation -alarm=300 -lv LOG_STATS > ScalableTestGrids_AnalyticJacobian_ScalableTestGrids.Models.Type2.Type2_noTap___N_4_M_4.pipe 2>&1)