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.001083/0.001083, allocations: 107.8 kB / 17.29 MB, free: 6.195 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.001013/0.001013, allocations: 194 kB / 18.21 MB, free: 5.27 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.409/1.409, allocations: 205.1 MB / 224.1 MB, free: 12.43 MB / 190.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 1.0.2/package.mo): time 0.06119/0.06119, allocations: 14.18 MB / 285.6 MB, free: 14.09 MB / 238.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ScalableTestGrids 1.1.0/package.mo): time 2.871/2.871, allocations: 418.6 MB / 0.7373 GB, free: 5.344 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.002144/0.002144, allocations: 87.86 kB / 0.9083 GB, free: 12.92 MB / 0.6548 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 1.101/1.104, allocations: 160.9 MB / 1.065 GB, free: 12.45 MB / 0.7959 GB
Notification: Performance of NFInst.instantiate(ScalableTestGrids.Models.Type1.Type1_N_4_M_4): time 2.948/4.052, allocations: 1.441 GB / 2.507 GB, free: 6.332 MB / 1.53 GB
Notification: Performance of NFInst.instExpressions: time 2.263/6.315, allocations: 0.4933 GB / 3 GB, free: 12.23 MB / 1.796 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.3657/6.68, allocations: 5.225 MB / 3.005 GB, free: 12.22 MB / 1.796 GB
Notification: Performance of NFTyping.typeComponents: time 0.2797/6.96, allocations: 64.46 MB / 3.068 GB, free: 7.742 MB / 1.812 GB
Notification: Performance of NFTyping.typeBindings: time 0.7928/7.753, allocations: 176.5 MB / 3.241 GB, free: 0.543 MB / 1.921 GB
Notification: Performance of NFTyping.typeClassSections: time 0.1781/7.931, allocations: 49.12 MB / 3.289 GB, free: 5.895 MB / 1.968 GB
Notification: Performance of NFFlatten.flatten: time 2.157/10.09, allocations: 0.4987 GB / 3.787 GB, free: 71.34 MB / 2.265 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.1752/10.26, allocations: 51.35 MB / 3.837 GB, free: 74.67 MB / 2.28 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.3204/10.58, allocations: 145.6 MB / 3.98 GB, free: 57.25 MB / 2.28 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.3086/10.89, allocations: 155.9 MB / 4.132 GB, free: 17.68 MB / 2.28 GB
Notification: Performance of NFPackage.collectConstants: time 0.1196/11.01, allocations: 18.38 MB / 4.15 GB, free: 0 / 2.28 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.3734/11.39, allocations: 49.1 MB / 4.198 GB, free: 5.078 MB / 2.296 GB
Notification: Performance of NFScalarize.scalarize: time 0.1064/11.49, allocations: 43.85 MB / 4.241 GB, free: 15.77 MB / 2.327 GB
Notification: Performance of NFVerifyModel.verify: time 0.3857/11.88, allocations: 146.6 MB / 4.384 GB, free: 9.316 MB / 2.421 GB
Notification: Performance of NFConvertDAE.convert: time 3.701/15.58, allocations: 333.4 MB / 4.709 GB, free: 134.1 MB / 2.438 GB
Notification: Performance of FrontEnd - DAE generated: time 1.043e-05/15.58, allocations: 0 / 4.709 GB, free: 134.1 MB / 2.438 GB
Notification: Performance of FrontEnd: time 2.555e-06/15.58, allocations: 0 / 4.709 GB, free: 134.1 MB / 2.438 GB
Notification: Performance of Transformations before backend: time 0.01409/15.59, allocations: 0 / 4.709 GB, free: 134.1 MB / 2.438 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.42/17.01, allocations: 354.8 MB / 5.056 GB, free: 3.844 MB / 2.484 GB
Notification: Performance of prepare preOptimizeDAE: time 5.209e-05/17.01, allocations: 8.031 kB / 5.056 GB, free: 3.836 MB / 2.484 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.2131/17.23, allocations: 38.17 MB / 5.093 GB, free: 13.34 MB / 2.531 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.4849/17.71, allocations: 144.3 MB / 5.234 GB, free: 4.336 MB / 2.656 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.01775/17.73, allocations: 14.93 MB / 5.249 GB, free: 5.41 MB / 2.672 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.07636/17.81, allocations: 19.7 MB / 5.268 GB, free: 1.707 MB / 2.688 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 2.483/20.29, allocations: 206.9 MB / 5.47 GB, free: 471.9 MB / 2.719 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.01586/20.3, allocations: 420.7 kB / 5.47 GB, free: 471.9 MB / 2.719 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.06355/20.37, allocations: 8.067 MB / 5.478 GB, free: 471.9 MB / 2.719 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.006143/20.37, allocations: 4.843 MB / 5.483 GB, free: 471.9 MB / 2.719 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.5407/20.92, allocations: 196.2 MB / 5.675 GB, free: 418.2 MB / 2.719 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.323/24.24, allocations: 1.257 GB / 6.931 GB, free: 0.7643 GB / 2.891 GB
Notification: Performance of preOpt comSubExp (simulation): time 1.465/25.7, allocations: 0.6257 GB / 7.557 GB, free: 474.7 MB / 2.891 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.2924/26, allocations: 94.35 MB / 7.649 GB, free: 425.3 MB / 2.891 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.03081/26.03, allocations: 2.385 MB / 7.651 GB, free: 423.1 MB / 2.891 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.004829/26.03, allocations: 2.194 MB / 7.654 GB, free: 420.9 MB / 2.891 GB
Notification: Performance of pre-optimization done (n=21307): time 0.002176/26.03, allocations: 4 kB / 7.654 GB, free: 420.8 MB / 2.891 GB
Notification: Performance of matching and sorting (n=21339): time 1.824/27.86, allocations: 481.5 MB / 8.124 GB, free: 0 / 2.891 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 1.142/29, allocations: 5.43 MB / 8.129 GB, free: 1.283 GB / 2.891 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.4208/29.42, allocations: 123.8 MB / 8.25 GB, free: 1.276 GB / 2.891 GB
Notification: Performance of collectPreVariables (initialization): time 0.05078/29.47, allocations: 3.63 MB / 8.253 GB, free: 1.276 GB / 2.891 GB
Notification: Performance of collectInitialEqns (initialization): time 0.1136/29.59, allocations: 100.3 MB / 8.351 GB, free: 1.27 GB / 2.891 GB
Notification: Performance of collectInitialBindings (initialization): time 0.14/29.73, allocations: 74.14 MB / 8.424 GB, free: 1.222 GB / 2.891 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.2669/29.99, allocations: 38.44 MB / 8.461 GB, free: 1.209 GB / 2.891 GB
Notification: Performance of setup shared object (initialization): time 6.53e-05/29.99, allocations: 305.5 kB / 8.462 GB, free: 1.209 GB / 2.891 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.2076/30.2, allocations: 71.44 MB / 8.531 GB, free: 1.18 GB / 2.891 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.2532/30.45, allocations: 116.2 MB / 8.645 GB, free: 1.105 GB / 2.891 GB
Notification: Performance of analyzeInitialSystem (initialization): time 2.562/33.02, allocations: 193.3 MB / 8.834 GB, free: 1.195 GB / 2.891 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.002925/33.02, allocations: 311.3 kB / 8.834 GB, free: 1.195 GB / 2.891 GB
Notification: Performance of matching and sorting (n=30657) (initialization): time 1.112/34.13, allocations: 305.8 MB / 9.132 GB, free: 1.173 GB / 2.891 GB
Notification: Performance of prepare postOptimizeDAE: time 0.002255/34.13, allocations: 469.7 kB / 9.133 GB, free: 1.173 GB / 2.891 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.003611/34.14, allocations: 1.063 MB / 9.134 GB, free: 1.173 GB / 2.891 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.707/34.84, allocations: 137.6 MB / 9.268 GB, free: 1.165 GB / 2.891 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.1902/35.03, allocations: 42.96 MB / 9.31 GB, free: 1.131 GB / 2.891 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 5.792/40.83, allocations: 1.104 GB / 10.41 GB, free: 1.087 GB / 2.891 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.2507/41.08, allocations: 11.6 MB / 10.43 GB, free: 1.087 GB / 2.891 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.05711/41.13, allocations: 8.238 MB / 10.43 GB, free: 1.087 GB / 2.891 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.28/41.41, allocations: 93.03 MB / 10.52 GB, free: 1.086 GB / 2.891 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.2166/41.63, allocations: 112.3 MB / 10.63 GB, free: 1.038 GB / 2.891 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 1.045/42.68, allocations: 188.1 MB / 10.82 GB, free: 0.9185 GB / 2.891 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 0.0027/42.68, allocations: 312.5 kB / 10.82 GB, free: 0.9185 GB / 2.891 GB
Notification: Performance of matching and sorting (n=30657) (initialization_lambda0): time 2.372/45.05, allocations: 278.7 MB / 11.09 GB, free: 0.9989 GB / 2.891 GB
Notification: Performance of prepare postOptimizeDAE: time 0.00227/45.05, allocations: 471.6 kB / 11.09 GB, free: 0.9989 GB / 2.891 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.00382/45.06, allocations: 1.064 MB / 11.09 GB, free: 0.9989 GB / 2.891 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.6443/45.7, allocations: 120.2 MB / 11.21 GB, free: 0.9964 GB / 2.891 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.2066/45.91, allocations: 45.3 MB / 11.25 GB, free: 0.9964 GB / 2.891 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 3.61/49.52, allocations: 0.9397 GB / 12.19 GB, free: 0.9512 GB / 2.891 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.2238/49.74, allocations: 10.26 MB / 12.2 GB, free: 0.9471 GB / 2.891 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.04927/49.79, allocations: 8.187 MB / 12.21 GB, free: 0.9452 GB / 2.891 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.102/49.89, allocations: 12.85 MB / 12.22 GB, free: 0.9384 GB / 2.891 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0879/49.98, allocations: 20.21 MB / 12.24 GB, free: 0.9284 GB / 2.891 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.8123/50.79, allocations: 231.8 MB / 12.47 GB, free: 0.8342 GB / 2.891 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.00718/50.8, allocations: 0.9807 MB / 12.47 GB, free: 0.8342 GB / 2.891 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 0.0006913/50.8, allocations: 0 / 12.47 GB, free: 0.8342 GB / 2.891 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.1592/50.96, allocations: 33.92 MB / 12.5 GB, free: 0.8123 GB / 2.891 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.08566/51.05, allocations: 3.472 MB / 12.51 GB, free: 0.8097 GB / 2.891 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.1833/51.23, allocations: 7.94 MB / 12.51 GB, free: 0.8061 GB / 2.891 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.06465/51.29, allocations: 17.02 MB / 12.53 GB, free: 0.8045 GB / 2.891 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 2.295/53.59, allocations: 214.7 MB / 12.74 GB, free: 0.9109 GB / 2.891 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 4.727/58.32, allocations: 0.9789 GB / 13.72 GB, free: 0.8874 GB / 2.891 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.2238/58.54, allocations: 67.53 MB / 13.79 GB, free: 0.8861 GB / 2.891 GB
Notification: Performance of sorting global known variables: time 0.2224/58.76, allocations: 79.51 MB / 13.86 GB, free: 0.8816 GB / 2.891 GB
Notification: Performance of Backend: time 1.353e-06/58.76, allocations: 0 / 13.86 GB, free: 0.8816 GB / 2.891 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.599/60.36, allocations: 0.5394 GB / 14.4 GB, free: 0.6875 GB / 2.891 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.97/63.33, allocations: 0.7602 GB / 15.16 GB, free: 0.5733 GB / 2.891 GB
Notification: Performance of Templates: time 17.12/80.46, allocations: 4.363 GB / 19.53 GB, free: 0.611 GB / 2.922 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)