Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1.Type1_N_4_M_4.conf.json
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/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/PowerGrids 1.0.3/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ScalableTestGrids 1.1.0/package.mo", uses=false)
Using package ScalableTestGrids with version 1.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ScalableTestGrids 1.1.0/package.mo)
Using package PowerGrids with version 1.0.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 1.0.3/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)
Using package ModelicaServices with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 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_noopt_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_noopt_ScalableTestGrids.Models.Type1.Type1_N_4_M_4")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001498/0.001498, allocations: 113.1 kB / 17.73 MB, free: 5.414 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.00167/0.00167, allocations: 184.8 kB / 18.66 MB, free: 4.488 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 1.854/1.854, allocations: 205.1 MB / 224.5 MB, free: 12.23 MB / 190.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 1.0.3/package.mo): time 0.06883/0.06883, allocations: 14.17 MB / 286.1 MB, free: 13.87 MB / 238.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ScalableTestGrids 1.1.0/package.mo): time 3.582/3.582, allocations: 418.6 MB / 0.7378 GB, free: 5.137 MB / 0.5764 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: ScalableTestGrids requested package PowerGrids of version 1.0.2. PowerGrids 1.0.3 is used instead which states that it is fully compatible without conversion script needed.
Notification: Performance of FrontEnd - loaded program: time 0.002041/0.002041, allocations: 89.3 kB / 1.068 GB, free: 6.184 MB / 0.7959 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.4192/0.4212, allocations: 160.9 MB / 1.225 GB, free: 8.332 MB / 0.9209 GB
Notification: Performance of NFInst.instantiate(ScalableTestGrids.Models.Type1.Type1_N_4_M_4): time 3.806/4.228, allocations: 1.425 GB / 2.65 GB, free: 15.18 MB / 1.718 GB
Notification: Performance of NFInst.instExpressions: time 3.142/7.37, allocations: 0.4905 GB / 3.14 GB, free: 12.69 MB / 1.983 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.485/7.855, allocations: 4.985 MB / 3.145 GB, free: 12.69 MB / 1.983 GB
Notification: Performance of NFTyping.typeComponents: time 0.388/8.243, allocations: 76.02 MB / 3.219 GB, free: 11.31 MB / 1.999 GB
Notification: Performance of NFTyping.typeBindings: time 1.057/9.3, allocations: 195 MB / 3.41 GB, free: 10.64 MB / 2.124 GB
Notification: Performance of NFTyping.typeClassSections: time 0.2493/9.549, allocations: 53.32 MB / 3.462 GB, free: 244 kB / 2.155 GB
Notification: Performance of NFFlatten.flatten: time 4.347/13.9, allocations: 489 MB / 3.939 GB, free: 74.99 MB / 2.516 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.227/14.12, allocations: 51.36 MB / 3.989 GB, free: 78.31 MB / 2.531 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.4041/14.53, allocations: 160.3 MB / 4.146 GB, free: 61.75 MB / 2.531 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.3751/14.9, allocations: 174.5 MB / 4.316 GB, free: 33.07 MB / 2.531 GB
Notification: Performance of NFPackage.collectConstants: time 0.1513/15.05, allocations: 21.87 MB / 4.338 GB, free: 33.07 MB / 2.531 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.292/15.35, allocations: 40.93 MB / 4.378 GB, free: 1.672 MB / 2.531 GB
Notification: Performance of NFScalarize.scalarize: time 0.1522/15.5, allocations: 50.21 MB / 4.427 GB, free: 3.184 MB / 2.547 GB
Notification: Performance of NFVerifyModel.verify: time 0.6071/16.1, allocations: 163.5 MB / 4.586 GB, free: 5.949 MB / 2.609 GB
Notification: Performance of NFConvertDAE.convert: time 2.585/18.69, allocations: 371.5 MB / 4.949 GB, free: 292.9 MB / 2.75 GB
Notification: Performance of FrontEnd - DAE generated: time 7.023e-06/18.69, allocations: 0 / 4.949 GB, free: 292.9 MB / 2.75 GB
Notification: Performance of FrontEnd: time 1.503e-06/18.69, allocations: 0 / 4.949 GB, free: 292.9 MB / 2.75 GB
Notification: Performance of Transformations before backend: time 0.01931/18.71, allocations: 0 / 4.949 GB, free: 292.9 MB / 2.75 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 1.556/20.27, allocations: 375.3 MB / 5.316 GB, free: 100.2 MB / 2.75 GB
Notification: Performance of prepare preOptimizeDAE: time 4.929e-05/20.27, allocations: 8.031 kB / 5.316 GB, free: 100.2 MB / 2.75 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.2306/20.5, allocations: 39.51 MB / 5.354 GB, free: 62.43 MB / 2.75 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.4902/20.99, allocations: 156.1 MB / 5.507 GB, free: 7.211 MB / 2.797 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.02018/21.01, allocations: 14.92 MB / 5.521 GB, free: 14.75 MB / 2.812 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.06955/21.08, allocations: 19.7 MB / 5.541 GB, free: 1.59 MB / 2.812 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 1.964/23.04, allocations: 206.9 MB / 5.743 GB, free: 1.203 GB / 2.953 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.02158/23.06, allocations: 415.7 kB / 5.743 GB, free: 1.203 GB / 2.953 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.07518/23.14, allocations: 8.069 MB / 5.751 GB, free: 1.203 GB / 2.953 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.01055/23.15, allocations: 4.844 MB / 5.756 GB, free: 1.203 GB / 2.953 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.5359/23.68, allocations: 196.2 MB / 5.947 GB, free: 1.181 GB / 2.953 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 4.318/28, allocations: 1.341 GB / 7.288 GB, free: 0.9106 GB / 2.953 GB
Notification: Performance of preOpt comSubExp (simulation): time 1.546/29.55, allocations: 0.6257 GB / 7.914 GB, free: 0.7269 GB / 3 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.2815/29.83, allocations: 94.35 MB / 8.006 GB, free: 0.6884 GB / 3 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.03036/29.86, allocations: 2.392 MB / 8.009 GB, free: 0.6882 GB / 3 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.005825/29.87, allocations: 2.185 MB / 8.011 GB, free: 0.6866 GB / 3 GB
Notification: Performance of pre-optimization done (n=21307): time 0.002643/29.87, allocations: 0 / 8.011 GB, free: 0.6866 GB / 3 GB
Notification: Performance of matching and sorting (n=21307): time 2.692/32.56, allocations: 278.2 MB / 8.282 GB, free: 1.197 GB / 3 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.005751/32.57, allocations: 5.429 MB / 8.288 GB, free: 1.193 GB / 3 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.4057/32.97, allocations: 137.1 MB / 8.422 GB, free: 1.185 GB / 3 GB
Notification: Performance of collectPreVariables (initialization): time 0.04908/33.02, allocations: 3.63 MB / 8.425 GB, free: 1.185 GB / 3 GB
Notification: Performance of collectInitialEqns (initialization): time 0.1286/33.15, allocations: 102.1 MB / 8.525 GB, free: 1.118 GB / 3 GB
Notification: Performance of collectInitialBindings (initialization): time 0.1564/33.31, allocations: 77.79 MB / 8.601 GB, free: 1.057 GB / 3 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.2104/33.52, allocations: 38.56 MB / 8.638 GB, free: 1.039 GB / 3 GB
Notification: Performance of setup shared object (initialization): time 5.638e-05/33.52, allocations: 305.7 kB / 8.639 GB, free: 1.038 GB / 3 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.198/33.71, allocations: 71.47 MB / 8.708 GB, free: 1.01 GB / 3 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.2677/33.98, allocations: 116.2 MB / 8.822 GB, free: 0.9343 GB / 3 GB
Notification: Performance of analyzeInitialSystem (initialization): time 2.814/36.8, allocations: 193.2 MB / 9.011 GB, free: 1.075 GB / 3 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.002907/36.8, allocations: 311.2 kB / 9.011 GB, free: 1.075 GB / 3 GB
Notification: Performance of matching and sorting (n=30625) (initialization): time 1.077/37.88, allocations: 307 MB / 9.311 GB, free: 1.052 GB / 3 GB
Notification: Performance of prepare postOptimizeDAE: time 0.002539/37.88, allocations: 470.9 kB / 9.311 GB, free: 1.052 GB / 3 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.003228/37.88, allocations: 1.063 MB / 9.312 GB, free: 1.052 GB / 3 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.7028/38.59, allocations: 136.5 MB / 9.445 GB, free: 1.046 GB / 3 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.1949/38.78, allocations: 42.83 MB / 9.487 GB, free: 1.043 GB / 3 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 4.999/43.78, allocations: 1.107 GB / 10.59 GB, free: 0.7705 GB / 3 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.3294/44.11, allocations: 18.37 MB / 10.61 GB, free: 0.7566 GB / 3 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.05531/44.16, allocations: 8.233 MB / 10.62 GB, free: 0.7487 GB / 3 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.3221/44.49, allocations: 93.04 MB / 10.71 GB, free: 0.664 GB / 3 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 2.149/46.64, allocations: 112.3 MB / 10.82 GB, free: 0.9832 GB / 3 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 1.16/47.8, allocations: 188 MB / 11 GB, free: 0.9373 GB / 3 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 0.005956/47.8, allocations: 314.5 kB / 11 GB, free: 0.9373 GB / 3 GB
Notification: Performance of matching and sorting (n=30625) (initialization_lambda0): time 1.085/48.89, allocations: 279.9 MB / 11.28 GB, free: 0.8723 GB / 3 GB
Notification: Performance of prepare postOptimizeDAE: time 0.006814/48.89, allocations: 474.4 kB / 11.28 GB, free: 0.8723 GB / 3 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.007528/48.9, allocations: 1.071 MB / 11.28 GB, free: 0.8723 GB / 3 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.6179/49.52, allocations: 119.2 MB / 11.4 GB, free: 0.8453 GB / 3 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.2065/49.73, allocations: 45.18 MB / 11.44 GB, free: 0.8068 GB / 3 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 4.11/53.84, allocations: 0.942 GB / 12.38 GB, free: 0.6601 GB / 3 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.3322/54.17, allocations: 14.47 MB / 12.4 GB, free: 0.653 GB / 3 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.06818/54.24, allocations: 8.183 MB / 12.4 GB, free: 0.6512 GB / 3 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 (23425):
 * Single equations (assignments): 23135
 * 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.1399/54.38, allocations: 12.85 MB / 12.42 GB, free: 0.6434 GB / 3 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.1353/54.51, allocations: 21.2 MB / 12.44 GB, free: 0.6325 GB / 3 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 2.933/57.44, allocations: 231.6 MB / 12.66 GB, free: 0.9225 GB / 3 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.0076/57.45, allocations: 0.9815 MB / 12.66 GB, free: 0.9225 GB / 3 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 0.001002/57.45, allocations: 1.078 kB / 12.66 GB, free: 0.9225 GB / 3 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.2052/57.66, allocations: 41.42 MB / 12.71 GB, free: 0.9207 GB / 3 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.1115/57.77, allocations: 3.457 MB / 12.71 GB, free: 0.9207 GB / 3 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.2368/58.01, allocations: 5.776 MB / 12.71 GB, free: 0.9204 GB / 3 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.07336/58.08, allocations: 17 MB / 12.73 GB, free: 0.9202 GB / 3 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.9693/59.05, allocations: 214 MB / 12.94 GB, free: 0.9028 GB / 3 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 5.978/65.03, allocations: 1.003 GB / 13.94 GB, free: 0.7839 GB / 3 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.2417/65.27, allocations: 67.44 MB / 14.01 GB, free: 0.7569 GB / 3 GB
Notification: Performance of sorting global known variables: time 0.308/65.58, allocations: 89.18 MB / 14.1 GB, free: 0.7254 GB / 3 GB
Notification: Performance of Backend: time 2.004e-06/65.58, allocations: 3.594 kB / 14.1 GB, free: 0.7254 GB / 3 GB
Notification: Performance of simCode: created initialization part: time 3.75/69.33, allocations: 0.543 GB / 14.64 GB, free: 0.7821 GB / 3 GB
Notification: Performance of SimCode: time 5.862/75.19, allocations: 0.7021 GB / 15.34 GB, free: 0.5518 GB / 3 GB
Notification: Performance of Templates: time 23.08/98.27, allocations: 4.825 GB / 20.17 GB, free: 0.7923 GB / 3.188 GB
make -j1 -f ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1.Type1_N_4_M_4.makefile
(rm -f ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1.Type1_N_4_M_4.pipe ; mkfifo ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1.Type1_N_4_M_4.pipe ; head -c 1048576 < ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1.Type1_N_4_M_4.pipe >> ../files/ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1.Type1_N_4_M_4.sim & ./ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1.Type1_N_4_M_4  -nls=kinsol -lv=LOG_STATS -abortSlowSimulation -alarm=480 -lv LOG_STATS > ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1.Type1_N_4_M_4.pipe 2>&1)