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.2/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.2 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 1.0.2/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.001117/0.001117, allocations: 92.81 kB / 17.31 MB, free: 6.52 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.001436/0.001436, allocations: 184.4 kB / 18.22 MB, free: 5.652 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.436/1.436, allocations: 205.4 MB / 224.4 MB, free: 13.07 MB / 190.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 1.0.2/package.mo): time 0.05855/0.05855, allocations: 14.17 MB / 286.9 MB, free: 13.88 MB / 238.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ScalableTestGrids 1.1.0/package.mo): time 2.834/2.834, allocations: 421.4 MB / 0.7423 GB, free: 4.148 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: Performance of FrontEnd - loaded program: time 0.0005665/0.0005665, allocations: 19.98 kB / 0.917 GB, free: 9.719 MB / 0.6548 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 1.072/1.073, allocations: 164.7 MB / 1.078 GB, free: 14.88 MB / 0.7959 GB
Notification: Performance of NFInst.instantiate(ScalableTestGrids.Models.Type1.Type1_N_4_M_4): time 2.649/3.722, allocations: 1.403 GB / 2.481 GB, free: 10.59 MB / 1.452 GB
Notification: Performance of NFInst.instExpressions: time 2.036/5.758, allocations: 499 MB / 2.968 GB, free: 10.07 MB / 1.687 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.3562/6.114, allocations: 5.067 MB / 2.973 GB, free: 8.582 MB / 1.687 GB
Notification: Performance of NFTyping.typeComponents: time 0.284/6.398, allocations: 64.42 MB / 3.036 GB, free: 12.09 MB / 1.733 GB
Notification: Performance of NFTyping.typeBindings: time 0.7066/7.105, allocations: 176.5 MB / 3.208 GB, free: 2.336 MB / 1.858 GB
Notification: Performance of NFTyping.typeClassSections: time 0.1621/7.267, allocations: 49.03 MB / 3.256 GB, free: 4.125 MB / 1.905 GB
Notification: Performance of NFFlatten.flatten: time 1.997/9.264, allocations: 484.2 MB / 3.729 GB, free: 40.38 MB / 2.03 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.1701/9.434, allocations: 48.05 MB / 3.776 GB, free: 20.12 MB / 2.046 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.2843/9.719, allocations: 121.1 MB / 3.894 GB, free: 7.828 MB / 2.124 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.28/9.999, allocations: 138.9 MB / 4.03 GB, free: 2.039 MB / 2.202 GB
Notification: Performance of NFPackage.collectConstants: time 0.115/10.11, allocations: 9.973 MB / 4.04 GB, free: 0 / 2.202 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.2198/10.33, allocations: 20.58 MB / 4.06 GB, free: 14.34 MB / 2.233 GB
Notification: Performance of NFScalarize.scalarize: time 0.09696/10.43, allocations: 32.28 MB / 4.091 GB, free: 7.738 MB / 2.249 GB
Notification: Performance of NFVerifyModel.verify: time 3.287/13.72, allocations: 128.3 MB / 4.217 GB, free: 172.6 MB / 2.312 GB
Notification: Performance of NFConvertDAE.convert: time 0.5876/14.31, allocations: 311.8 MB / 4.521 GB, free: 99.89 MB / 2.312 GB
Notification: Performance of FrontEnd - DAE generated: time 7.815e-06/14.31, allocations: 0 / 4.521 GB, free: 99.89 MB / 2.312 GB
Notification: Performance of FrontEnd: time 3.096e-06/14.31, allocations: 0 / 4.521 GB, free: 99.89 MB / 2.312 GB
Notification: Performance of Transformations before backend: time 0.01466/14.32, allocations: 0 / 4.521 GB, free: 99.89 MB / 2.312 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.17/15.49, allocations: 310.6 MB / 4.824 GB, free: 4.812 MB / 2.391 GB
Notification: Performance of prepare preOptimizeDAE: time 5.268e-05/15.49, allocations: 8.031 kB / 4.824 GB, free: 4.805 MB / 2.391 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.2047/15.7, allocations: 38.22 MB / 4.862 GB, free: 164 kB / 2.422 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.4445/16.14, allocations: 144.3 MB / 5.003 GB, free: 12.27 MB / 2.547 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.02327/16.16, allocations: 14.93 MB / 5.017 GB, free: 13.34 MB / 2.562 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.07147/16.23, allocations: 19.7 MB / 5.037 GB, free: 9.633 MB / 2.578 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 2.013/18.25, allocations: 207.8 MB / 5.24 GB, free: 1.011 GB / 2.578 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.01311/18.26, allocations: 423.7 kB / 5.24 GB, free: 1.011 GB / 2.578 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.05637/18.32, allocations: 8.071 MB / 5.248 GB, free: 1.005 GB / 2.578 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.00376/18.32, allocations: 4.839 MB / 5.253 GB, free: 1.005 GB / 2.578 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.5406/18.86, allocations: 198.1 MB / 5.446 GB, free: 0.9367 GB / 2.578 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 3.47/22.33, allocations: 1.26 GB / 6.706 GB, free: 0.5974 GB / 2.578 GB
Notification: Performance of preOpt comSubExp (simulation): time 2.854/25.19, allocations: 0.6275 GB / 7.334 GB, free: 1.007 GB / 2.672 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.2787/25.46, allocations: 95.22 MB / 7.427 GB, free: 1.005 GB / 2.672 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.02209/25.49, allocations: 2.387 MB / 7.429 GB, free: 1.005 GB / 2.672 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.004797/25.49, allocations: 2.186 MB / 7.431 GB, free: 1.005 GB / 2.672 GB
Notification: Performance of pre-optimization done (n=21307): time 0.0009033/25.49, allocations: 0 / 7.431 GB, free: 1.005 GB / 2.672 GB
Notification: Performance of matching and sorting (n=21339): time 1.759/27.25, allocations: 484.3 MB / 7.904 GB, free: 0.8445 GB / 2.672 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.002551/27.25, allocations: 5.427 MB / 7.909 GB, free: 0.8384 GB / 2.672 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.3302/27.58, allocations: 123.8 MB / 8.03 GB, free: 0.7395 GB / 2.672 GB
Notification: Performance of collectPreVariables (initialization): time 0.04158/27.63, allocations: 3.631 MB / 8.034 GB, free: 0.736 GB / 2.672 GB
Notification: Performance of collectInitialEqns (initialization): time 1.534/29.16, allocations: 100.3 MB / 8.132 GB, free: 1.021 GB / 2.672 GB
Notification: Performance of collectInitialBindings (initialization): time 0.1396/29.3, allocations: 74.14 MB / 8.204 GB, free: 0.9741 GB / 2.672 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.09841/29.4, allocations: 18.31 MB / 8.222 GB, free: 0.9659 GB / 2.672 GB
Notification: Performance of setup shared object (initialization): time 6.86e-05/29.4, allocations: 302.1 kB / 8.222 GB, free: 0.9656 GB / 2.672 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.1961/29.59, allocations: 71.54 MB / 8.292 GB, free: 0.9383 GB / 2.672 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.2391/29.83, allocations: 117.3 MB / 8.407 GB, free: 0.863 GB / 2.672 GB
Notification: Performance of analyzeInitialSystem (initialization): time 1.129/30.96, allocations: 195.3 MB / 8.597 GB, free: 0.7436 GB / 2.672 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.003337/30.97, allocations: 311.5 kB / 8.598 GB, free: 0.7436 GB / 2.672 GB
Notification: Performance of matching and sorting (n=30657) (initialization): time 2.361/33.33, allocations: 314.3 MB / 8.905 GB, free: 0.9493 GB / 2.672 GB
Notification: Performance of prepare postOptimizeDAE: time 0.02773/33.36, allocations: 34.06 MB / 8.938 GB, free: 0.9068 GB / 2.672 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.005747/33.36, allocations: 1.065 MB / 8.939 GB, free: 0.9068 GB / 2.672 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.7743/34.14, allocations: 140.8 MB / 9.077 GB, free: 0.9 GB / 2.672 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.1961/34.33, allocations: 42.98 MB / 9.118 GB, free: 0.897 GB / 2.672 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 4.129/38.46, allocations: 1.038 GB / 10.16 GB, free: 0.6946 GB / 2.672 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.2656/38.73, allocations: 12.18 MB / 10.17 GB, free: 0.6909 GB / 2.672 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.05243/38.78, allocations: 8.236 MB / 10.18 GB, free: 0.6891 GB / 2.672 GB
Notification: Performance of prepare postOptimizeDAE: time 1.348e-05/38.78, allocations: 3.344 kB / 10.18 GB, free: 0.6891 GB / 2.672 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 2.54/41.32, allocations: 262.5 MB / 10.43 GB, free: 0.7456 GB / 2.672 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.006486/41.32, allocations: 1.063 MB / 10.43 GB, free: 0.7456 GB / 2.672 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.5888/41.91, allocations: 117.6 MB / 10.55 GB, free: 0.7431 GB / 2.672 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.196/42.11, allocations: 45.26 MB / 10.59 GB, free: 0.7431 GB / 2.672 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 3.862/45.97, allocations: 0.8642 GB / 11.46 GB, free: 0.6992 GB / 2.672 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.2286/46.2, allocations: 9.971 MB / 11.47 GB, free: 0.6992 GB / 2.672 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.05308/46.25, allocations: 8.189 MB / 11.48 GB, free: 0.6992 GB / 2.672 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.1942/46.45, allocations: 34.49 MB / 11.51 GB, free: 0.699 GB / 2.672 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.09611/46.54, allocations: 20.2 MB / 11.53 GB, free: 0.6961 GB / 2.672 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.7983/47.34, allocations: 233.8 MB / 11.76 GB, free: 0.6197 GB / 2.672 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.006486/47.35, allocations: 0.9799 MB / 11.76 GB, free: 0.6197 GB / 2.672 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 0.0009723/47.35, allocations: 6.297 kB / 11.76 GB, free: 0.6197 GB / 2.672 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.1499/47.5, allocations: 33.94 MB / 11.79 GB, free: 0.5978 GB / 2.672 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.08339/47.58, allocations: 3.471 MB / 11.79 GB, free: 0.5951 GB / 2.672 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.185/47.77, allocations: 8.381 MB / 11.8 GB, free: 0.5915 GB / 2.672 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.065/47.83, allocations: 17.01 MB / 11.82 GB, free: 0.59 GB / 2.672 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.9202/48.75, allocations: 220 MB / 12.03 GB, free: 457.1 MB / 2.672 GB
Notification: Performance of postOpt detectDAEmodeSparsePattern (simulation): time 2.624/51.38, allocations: 244.9 MB / 12.27 GB, free: 0.6946 GB / 2.672 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.1992/51.58, allocations: 68.38 MB / 12.34 GB, free: 0.6934 GB / 2.672 GB
Notification: Performance of sorting global known variables: time 0.2058/51.78, allocations: 79.52 MB / 12.42 GB, free: 0.6888 GB / 2.672 GB
Notification: Performance of Backend: time 9.22e-07/51.78, allocations: 0 / 12.42 GB, free: 0.6888 GB / 2.672 GB
Notification: Performance of simCode: created initialization part: time 1.531/53.31, allocations: 0.56 GB / 12.98 GB, free: 367.9 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: time 2.636/55.95, allocations: 0.5278 GB / 13.51 GB, free: 458.3 MB / 2.672 GB
Notification: Performance of Templates: time 13.82/69.77, allocations: 3.695 GB / 17.2 GB, free: 358.3 MB / 2.672 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)