Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr ScalableTestGrids_AnalyticJacobian_ScalableTestGrids.Models.Type1.Type1_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.Type1.Type1_N_4_M_4,tolerance=0.0001,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="ScalableTestGrids_AnalyticJacobian_ScalableTestGrids.Models.Type1.Type1_N_4_M_4")
translateModel(ScalableTestGrids.Models.Type1.Type1_N_4_M_4,tolerance=0.0001,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="ScalableTestGrids_AnalyticJacobian_ScalableTestGrids.Models.Type1.Type1_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.0008776/0.0008776, allocations: 190.2 kB / 17.34 MB, free: 6.137 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.3992/0.3992, allocations: 205.5 MB / 223.6 MB, free: 17.53 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.00084/0.00084, allocations: 104 kB / 271 MB, free: 4.129 MB / 222.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 1.0.2/package.mo): time 0.09187/0.09187, allocations: 14.46 MB / 332.8 MB, free: 46.75 MB / 270.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ScalableTestGrids 1.1.0-master/package.mo): time 1.311/1.311, allocations: 438.4 MB / 0.8028 GB, free: 13.85 MB / 0.6233 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.001175/0.001175, allocations: 79.88 kB / 0.9788 GB, free: 4.852 MB / 0.7017 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1839/0.185, allocations: 166 MB / 1.141 GB, free: 14.48 MB / 0.8735 GB
Notification: Performance of NFInst.instantiate(ScalableTestGrids.Models.Type1.Type1_N_4_M_4): time 2.559/2.744, allocations: 1.441 GB / 2.582 GB, free: 15.13 MB / 1.608 GB
Notification: Performance of NFInst.instExpressions: time 0.6154/3.36, allocations: 0.4928 GB / 3.075 GB, free: 5.012 MB / 1.905 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.2247/3.584, allocations: 5.219 MB / 3.08 GB, free: 15.77 MB / 1.921 GB
Notification: Performance of NFTyping.typeComponents: time 1.053/4.637, allocations: 64.45 MB / 3.143 GB, free: 5.066 MB / 1.921 GB
Notification: Performance of NFTyping.typeBindings: time 0.4602/5.098, allocations: 176.5 MB / 3.316 GB, free: 10.82 MB / 1.937 GB
Notification: Performance of NFTyping.typeClassSections: time 0.124/5.222, allocations: 49.11 MB / 3.364 GB, free: 2.344 MB / 1.937 GB
Notification: Performance of NFFlatten.flatten: time 0.5409/5.763, allocations: 0.4987 GB / 3.862 GB, free: 3.094 MB / 2.358 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.1029/5.865, allocations: 51.36 MB / 3.913 GB, free: 180 kB / 2.405 GB
Notification: Performance of NFEvalConstants.evaluate: time 1.171/7.036, allocations: 145.6 MB / 4.055 GB, free: 98.77 MB / 2.468 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.1977/7.234, allocations: 155.9 MB / 4.207 GB, free: 76.17 MB / 2.468 GB
Notification: Performance of NFPackage.collectConstants: time 0.06886/7.303, allocations: 18.15 MB / 4.225 GB, free: 76.17 MB / 2.468 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.1522/7.455, allocations: 37.22 MB / 4.261 GB, free: 76.17 MB / 2.468 GB
Notification: Performance of NFScalarize.scalarize: time 0.05884/7.514, allocations: 43.85 MB / 4.304 GB, free: 66.61 MB / 2.468 GB
Notification: Performance of NFVerifyModel.verify: time 0.2142/7.728, allocations: 146.1 MB / 4.447 GB, free: 28.38 MB / 2.468 GB
Notification: Performance of NFConvertDAE.convert: time 0.3764/8.105, allocations: 333.4 MB / 4.772 GB, free: 7.555 MB / 2.577 GB
Notification: Performance of FrontEnd - DAE generated: time 7.033e-06/8.105, allocations: 4 kB / 4.772 GB, free: 7.551 MB / 2.577 GB
Notification: Performance of FrontEnd: time 3.086e-06/8.105, allocations: 0 / 4.772 GB, free: 7.551 MB / 2.577 GB
Notification: Performance of Transformations before backend: time 0.00963/8.114, allocations: 3.938 kB / 4.772 GB, free: 7.547 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.035/10.15, allocations: 354.8 MB / 5.119 GB, free: 1.182 GB / 2.656 GB
Notification: Performance of prepare preOptimizeDAE: time 3.978e-05/10.15, allocations: 8.172 kB / 5.119 GB, free: 1.182 GB / 2.656 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.1608/10.31, allocations: 38.16 MB / 5.156 GB, free: 1.164 GB / 2.656 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.2915/10.6, allocations: 144.3 MB / 5.297 GB, free: 1.062 GB / 2.656 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.01312/10.61, allocations: 14.93 MB / 5.312 GB, free: 1.051 GB / 2.656 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0541/10.67, allocations: 19.7 MB / 5.331 GB, free: 1.032 GB / 2.656 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.4244/11.09, allocations: 206.9 MB / 5.533 GB, free: 0.8224 GB / 2.656 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.007627/11.1, allocations: 420 kB / 5.533 GB, free: 0.822 GB / 2.656 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.04455/11.15, allocations: 8.066 MB / 5.541 GB, free: 0.8141 GB / 2.656 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.002238/11.15, allocations: 4.84 MB / 5.546 GB, free: 0.8094 GB / 2.656 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.3558/11.5, allocations: 196.2 MB / 5.737 GB, free: 0.6178 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.075/13.58, allocations: 1.257 GB / 6.994 GB, free: 0.5037 GB / 2.656 GB
Notification: Performance of preOpt comSubExp (simulation): time 1.869/15.45, allocations: 0.6257 GB / 7.62 GB, free: 0.9695 GB / 2.656 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.1622/15.61, allocations: 94.36 MB / 7.712 GB, free: 0.968 GB / 2.656 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.01676/15.63, allocations: 2.383 MB / 7.714 GB, free: 0.9678 GB / 2.656 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.001362/15.63, allocations: 2.184 MB / 7.716 GB, free: 0.9676 GB / 2.656 GB
Notification: Performance of pre-optimization done (n=21307): time 0.0002265/15.63, allocations: 1.031 kB / 7.716 GB, free: 0.9676 GB / 2.656 GB
Notification: Performance of matching and sorting (n=21339): time 1.834/17.46, allocations: 479.7 MB / 8.185 GB, free: 1.046 GB / 2.656 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.00176/17.46, allocations: 5.43 MB / 8.19 GB, free: 1.042 GB / 2.656 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.2233/17.69, allocations: 123.8 MB / 8.311 GB, free: 1.035 GB / 2.656 GB
Notification: Performance of collectPreVariables (initialization): time 0.02672/17.71, allocations: 3.632 MB / 8.315 GB, free: 1.035 GB / 2.656 GB
Notification: Performance of collectInitialEqns (initialization): time 0.06819/17.78, allocations: 100.3 MB / 8.413 GB, free: 0.9828 GB / 2.656 GB
Notification: Performance of collectInitialBindings (initialization): time 0.07365/17.86, allocations: 74.14 MB / 8.485 GB, free: 0.9254 GB / 2.656 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.1145/17.97, allocations: 38.44 MB / 8.523 GB, free: 0.9069 GB / 2.656 GB
Notification: Performance of setup shared object (initialization): time 3.574e-05/17.97, allocations: 302.9 kB / 8.523 GB, free: 0.9066 GB / 2.656 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.1259/18.1, allocations: 71.45 MB / 8.593 GB, free: 0.8783 GB / 2.656 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.1491/18.24, allocations: 116.1 MB / 8.706 GB, free: 0.8027 GB / 2.656 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.8121/19.06, allocations: 193.3 MB / 8.895 GB, free: 0.6791 GB / 2.656 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.001385/19.06, allocations: 310.8 kB / 8.895 GB, free: 0.6791 GB / 2.656 GB
Notification: Performance of matching and sorting (n=30657) (initialization): time 1.521/20.58, allocations: 305.8 MB / 9.194 GB, free: 0.986 GB / 2.656 GB
Notification: Performance of prepare postOptimizeDAE: time 0.000629/20.58, allocations: 476.2 kB / 9.194 GB, free: 0.9859 GB / 2.656 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.001388/20.58, allocations: 1.062 MB / 9.195 GB, free: 0.9859 GB / 2.656 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.5498/21.13, allocations: 137.6 MB / 9.33 GB, free: 0.957 GB / 2.656 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.1438/21.28, allocations: 42.96 MB / 9.372 GB, free: 0.9371 GB / 2.656 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.523/23.8, allocations: 1.104 GB / 10.48 GB, free: 0.5696 GB / 2.656 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.1672/23.97, allocations: 11.6 MB / 10.49 GB, free: 0.5594 GB / 2.656 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.02913/23.99, allocations: 8.242 MB / 10.49 GB, free: 0.5513 GB / 2.656 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.1819/24.18, allocations: 93.03 MB / 10.59 GB, free: 471.5 MB / 2.656 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 1.061/25.24, allocations: 112.3 MB / 10.7 GB, free: 0.8271 GB / 2.656 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.7984/26.04, allocations: 188.1 MB / 10.88 GB, free: 0.7795 GB / 2.656 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 0.00134/26.04, allocations: 310.7 kB / 10.88 GB, free: 0.7795 GB / 2.656 GB
Notification: Performance of matching and sorting (n=30657) (initialization_lambda0): time 0.5452/26.58, allocations: 278.7 MB / 11.15 GB, free: 0.6486 GB / 2.656 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0006106/26.58, allocations: 473 kB / 11.15 GB, free: 0.6481 GB / 2.656 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.001182/26.58, allocations: 1.062 MB / 11.15 GB, free: 0.6471 GB / 2.656 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.4949/27.08, allocations: 120.2 MB / 11.27 GB, free: 0.5473 GB / 2.656 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.1497/27.23, allocations: 45.3 MB / 11.31 GB, free: 0.503 GB / 2.656 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.28/29.51, allocations: 0.9397 GB / 12.25 GB, free: 332.7 MB / 2.656 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.1658/29.67, allocations: 10.26 MB / 12.26 GB, free: 327.1 MB / 2.656 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.03142/29.71, allocations: 8.186 MB / 12.27 GB, free: 325.1 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.06061/29.77, allocations: 12.86 MB / 12.28 GB, free: 317.1 MB / 2.656 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0538/29.82, allocations: 20.2 MB / 12.3 GB, free: 297.7 MB / 2.656 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 1.445/31.27, allocations: 231.8 MB / 12.53 GB, free: 0.7384 GB / 2.656 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.004087/31.27, allocations: 0.9787 MB / 12.53 GB, free: 0.7384 GB / 2.656 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 0.0002571/31.27, allocations: 1.969 kB / 12.53 GB, free: 0.7384 GB / 2.656 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.09481/31.36, allocations: 33.92 MB / 12.56 GB, free: 0.7383 GB / 2.656 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0513/31.42, allocations: 3.47 MB / 12.57 GB, free: 0.7369 GB / 2.656 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.1279/31.54, allocations: 7.937 MB / 12.58 GB, free: 0.7344 GB / 2.656 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.03895/31.58, allocations: 17.02 MB / 12.59 GB, free: 0.7328 GB / 2.656 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.5815/32.16, allocations: 214.7 MB / 12.8 GB, free: 0.657 GB / 2.656 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 3.003/35.17, allocations: 0.9789 GB / 13.78 GB, free: 0.5169 GB / 2.672 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.1192/35.29, allocations: 67.53 MB / 13.85 GB, free: 493.3 MB / 2.672 GB
Notification: Performance of sorting global known variables: time 0.1182/35.4, allocations: 79.51 MB / 13.92 GB, free: 421.5 MB / 2.672 GB
Notification: Performance of Backend: time 6.41e-07/35.4, allocations: 0 / 13.92 GB, free: 421.5 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 1.938/37.34, allocations: 0.5394 GB / 14.46 GB, free: 0.5625 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.026/39.37, allocations: 0.7594 GB / 15.22 GB, free: 0.5636 GB / 2.672 GB
Notification: Performance of Templates: time 8.83/48.2, allocations: 4.405 GB / 19.63 GB, free: 396.3 MB / 3.252 GB
make -j1 -f ScalableTestGrids_AnalyticJacobian_ScalableTestGrids.Models.Type1.Type1_N_4_M_4.makefile
(rm -f ScalableTestGrids_AnalyticJacobian_ScalableTestGrids.Models.Type1.Type1_N_4_M_4.pipe ; mkfifo ScalableTestGrids_AnalyticJacobian_ScalableTestGrids.Models.Type1.Type1_N_4_M_4.pipe ; head -c 1048576 < ScalableTestGrids_AnalyticJacobian_ScalableTestGrids.Models.Type1.Type1_N_4_M_4.pipe >> ../files/ScalableTestGrids_AnalyticJacobian_ScalableTestGrids.Models.Type1.Type1_N_4_M_4.sim & ./ScalableTestGrids_AnalyticJacobian_ScalableTestGrids.Models.Type1.Type1_N_4_M_4  -nls=kinsol -lv=LOG_STATS -abortSlowSimulation -alarm=300 -lv LOG_STATS > ScalableTestGrids_AnalyticJacobian_ScalableTestGrids.Models.Type1.Type1_N_4_M_4.pipe 2>&1)