Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr ScalableTestGrids_SymbolicJacobian_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_SymbolicJacobian_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_SymbolicJacobian_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.0009274/0.0009275, allocations: 195.1 kB / 17.37 MB, free: 6.117 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.326/0.326, allocations: 205.6 MB / 223.7 MB, free: 100 kB / 190.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.000892/0.000892, allocations: 116 kB / 271.1 MB, free: 8.527 MB / 222.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 1.0.2/package.mo): time 0.1066/0.1066, allocations: 14.43 MB / 332.9 MB, free: 44.88 MB / 270.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ScalableTestGrids 1.1.0-master/package.mo): time 1.35/1.35, allocations: 460.6 MB / 0.8245 GB, free: 12.09 MB / 0.6388 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.001206/0.001206, allocations: 67.89 kB / 1.006 GB, free: 11.94 MB / 0.7327 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1974/0.1986, allocations: 171.9 MB / 1.174 GB, free: 15.69 MB / 0.9045 GB
Notification: Performance of NFInst.instantiate(ScalableTestGrids.Models.Type1.Type1_N_4_M_4): time 3.353/3.552, allocations: 1.441 GB / 2.616 GB, free: 15.1 MB / 1.64 GB
Notification: Performance of NFInst.instExpressions: time 0.6443/4.196, allocations: 0.4933 GB / 3.109 GB, free: 6.344 MB / 1.937 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.2296/4.426, allocations: 5.219 MB / 3.114 GB, free: 1.102 MB / 1.937 GB
Notification: Performance of NFTyping.typeComponents: time 1.162/5.589, allocations: 64.45 MB / 3.177 GB, free: 6.797 MB / 1.968 GB
Notification: Performance of NFTyping.typeBindings: time 0.4616/6.05, allocations: 176.5 MB / 3.349 GB, free: 15.49 MB / 1.983 GB
Notification: Performance of NFTyping.typeClassSections: time 0.1231/6.173, allocations: 49.12 MB / 3.397 GB, free: 13.69 MB / 1.983 GB
Notification: Performance of NFFlatten.flatten: time 0.5687/6.742, allocations: 0.4987 GB / 3.896 GB, free: 0.9922 MB / 2.358 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.1149/6.857, allocations: 51.36 MB / 3.946 GB, free: 14.07 MB / 2.421 GB
Notification: Performance of NFEvalConstants.evaluate: time 1.337/8.194, allocations: 145.6 MB / 4.088 GB, free: 91.85 MB / 2.483 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.1943/8.388, allocations: 155.9 MB / 4.241 GB, free: 71.08 MB / 2.483 GB
Notification: Performance of NFPackage.collectConstants: time 0.06688/8.455, allocations: 18.15 MB / 4.258 GB, free: 71.08 MB / 2.483 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.1514/8.607, allocations: 37.21 MB / 4.295 GB, free: 71.08 MB / 2.483 GB
Notification: Performance of NFScalarize.scalarize: time 0.06057/8.667, allocations: 43.85 MB / 4.338 GB, free: 61.52 MB / 2.483 GB
Notification: Performance of NFVerifyModel.verify: time 0.2114/8.879, allocations: 146.1 MB / 4.48 GB, free: 23.29 MB / 2.483 GB
Notification: Performance of NFConvertDAE.convert: time 0.3724/9.251, allocations: 333.4 MB / 4.806 GB, free: 0.7773 MB / 2.593 GB
Notification: Performance of FrontEnd - DAE generated: time 5.811e-06/9.251, allocations: 0 / 4.806 GB, free: 0.7773 MB / 2.593 GB
Notification: Performance of FrontEnd: time 1.382e-06/9.251, allocations: 0 / 4.806 GB, free: 0.7773 MB / 2.593 GB
Notification: Performance of Transformations before backend: time 0.009399/9.26, allocations: 0 / 4.806 GB, free: 0.7773 MB / 2.593 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.282/11.54, allocations: 354.8 MB / 5.152 GB, free: 1.212 GB / 2.703 GB
Notification: Performance of prepare preOptimizeDAE: time 4.105e-05/11.54, allocations: 8.172 kB / 5.152 GB, free: 1.212 GB / 2.703 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.1603/11.7, allocations: 38.16 MB / 5.19 GB, free: 1.194 GB / 2.703 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.2855/11.99, allocations: 144.3 MB / 5.331 GB, free: 1.093 GB / 2.703 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.01493/12, allocations: 14.93 MB / 5.345 GB, free: 1.086 GB / 2.703 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.05314/12.06, allocations: 19.7 MB / 5.364 GB, free: 1.072 GB / 2.703 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.4079/12.46, allocations: 206.9 MB / 5.566 GB, free: 0.8624 GB / 2.703 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.007492/12.47, allocations: 420 kB / 5.567 GB, free: 0.862 GB / 2.703 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.04287/12.52, allocations: 8.066 MB / 5.575 GB, free: 0.8541 GB / 2.703 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.002116/12.52, allocations: 4.84 MB / 5.579 GB, free: 0.8494 GB / 2.703 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.3441/12.86, allocations: 196.2 MB / 5.771 GB, free: 0.6578 GB / 2.703 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.158/15.02, allocations: 1.257 GB / 7.028 GB, free: 0.5667 GB / 2.703 GB
Notification: Performance of preOpt comSubExp (simulation): time 1.088/16.11, allocations: 0.6257 GB / 7.654 GB, free: 237.1 MB / 2.703 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.1654/16.27, allocations: 94.36 MB / 7.746 GB, free: 176.2 MB / 2.703 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.01517/16.29, allocations: 2.388 MB / 7.748 GB, free: 173.9 MB / 2.703 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.002246/16.29, allocations: 2.182 MB / 7.75 GB, free: 171.8 MB / 2.703 GB
Notification: Performance of pre-optimization done (n=21307): time 0.0002471/16.29, allocations: 0 / 7.75 GB, free: 171.8 MB / 2.703 GB
Notification: Performance of matching and sorting (n=21339): time 1.911/18.2, allocations: 479.7 MB / 8.219 GB, free: 1.058 GB / 2.703 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.001295/18.2, allocations: 5.43 MB / 8.224 GB, free: 1.054 GB / 2.703 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.1986/18.4, allocations: 123.8 MB / 8.345 GB, free: 1.013 GB / 2.703 GB
Notification: Performance of collectPreVariables (initialization): time 0.0263/18.43, allocations: 3.633 MB / 8.348 GB, free: 1.01 GB / 2.703 GB
Notification: Performance of collectInitialEqns (initialization): time 0.06829/18.5, allocations: 100.3 MB / 8.446 GB, free: 0.937 GB / 2.703 GB
Notification: Performance of collectInitialBindings (initialization): time 0.07571/18.57, allocations: 74.13 MB / 8.519 GB, free: 0.8796 GB / 2.703 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.1058/18.68, allocations: 38.44 MB / 8.556 GB, free: 0.844 GB / 2.703 GB
Notification: Performance of setup shared object (initialization): time 3.439e-05/18.68, allocations: 305.3 kB / 8.557 GB, free: 0.8437 GB / 2.703 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.1179/18.8, allocations: 71.45 MB / 8.626 GB, free: 0.774 GB / 2.703 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 1.083/19.88, allocations: 116.1 MB / 8.74 GB, free: 1.031 GB / 2.703 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.9343/20.81, allocations: 193.3 MB / 8.929 GB, free: 0.975 GB / 2.703 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.001752/20.81, allocations: 313.8 kB / 8.929 GB, free: 0.975 GB / 2.703 GB
Notification: Performance of matching and sorting (n=30657) (initialization): time 0.666/21.48, allocations: 305.8 MB / 9.227 GB, free: 0.86 GB / 2.703 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0007586/21.48, allocations: 472 kB / 9.228 GB, free: 0.8596 GB / 2.703 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.001323/21.48, allocations: 1.062 MB / 9.229 GB, free: 0.8586 GB / 2.703 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.5722/22.05, allocations: 137.6 MB / 9.363 GB, free: 0.7323 GB / 2.703 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.1429/22.2, allocations: 42.96 MB / 9.405 GB, free: 0.6903 GB / 2.703 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 3.698/25.9, allocations: 1.104 GB / 10.51 GB, free: 0.8791 GB / 2.703 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.1688/26.06, allocations: 11.6 MB / 10.52 GB, free: 0.8791 GB / 2.703 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.03224/26.1, allocations: 8.238 MB / 10.53 GB, free: 0.8791 GB / 2.703 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.186/26.28, allocations: 93.04 MB / 10.62 GB, free: 0.8604 GB / 2.703 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.142/26.43, allocations: 112.3 MB / 10.73 GB, free: 0.7854 GB / 2.703 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.8306/27.26, allocations: 188.1 MB / 10.91 GB, free: 0.618 GB / 2.703 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 0.001838/27.26, allocations: 312 kB / 10.91 GB, free: 0.6177 GB / 2.703 GB
Notification: Performance of matching and sorting (n=30657) (initialization_lambda0): time 1.666/28.92, allocations: 279.7 MB / 11.19 GB, free: 0.7881 GB / 2.703 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0008756/28.92, allocations: 474.4 kB / 11.19 GB, free: 0.7881 GB / 2.703 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.001651/28.93, allocations: 1.062 MB / 11.19 GB, free: 0.7881 GB / 2.703 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.508/29.43, allocations: 120.2 MB / 11.3 GB, free: 0.7852 GB / 2.703 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.1562/29.59, allocations: 45.3 MB / 11.35 GB, free: 0.783 GB / 2.703 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.462/32.05, allocations: 0.9398 GB / 12.29 GB, free: 0.7154 GB / 2.703 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.1655/32.22, allocations: 10.26 MB / 12.3 GB, free: 0.7142 GB / 2.703 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0317/32.25, allocations: 8.191 MB / 12.31 GB, free: 0.7123 GB / 2.703 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.06056/32.31, allocations: 12.86 MB / 12.32 GB, free: 0.7056 GB / 2.703 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0517/32.36, allocations: 20.2 MB / 12.34 GB, free: 0.6974 GB / 2.703 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.5029/32.86, allocations: 231.8 MB / 12.57 GB, free: 0.617 GB / 2.719 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.004061/32.87, allocations: 0.9813 MB / 12.57 GB, free: 0.617 GB / 2.719 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 0.0002603/32.87, allocations: 0 / 12.57 GB, free: 0.617 GB / 2.719 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.09619/32.97, allocations: 33.93 MB / 12.6 GB, free: 0.5885 GB / 2.719 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.05144/33.02, allocations: 3.465 MB / 12.6 GB, free: 0.5851 GB / 2.719 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.127/33.14, allocations: 7.936 MB / 12.61 GB, free: 0.579 GB / 2.719 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.03974/33.18, allocations: 17.02 MB / 12.63 GB, free: 0.5698 GB / 2.719 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.5595/33.74, allocations: 214.7 MB / 12.84 GB, free: 378.9 MB / 2.719 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 3.077/36.82, allocations: 0.9789 GB / 13.82 GB, free: 321.7 MB / 2.719 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 1.285/38.1, allocations: 67.53 MB / 13.88 GB, free: 0.6665 GB / 2.719 GB
Notification: Performance of sorting global known variables: time 0.132/38.24, allocations: 79.51 MB / 13.96 GB, free: 0.662 GB / 2.719 GB
Notification: Performance of Backend: time 1.243e-06/38.24, allocations: 3.562 kB / 13.96 GB, free: 0.662 GB / 2.719 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.014/39.25, allocations: 0.5394 GB / 14.5 GB, free: 0.4986 GB / 2.719 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.097/41.35, allocations: 0.7602 GB / 15.26 GB, free: 397 MB / 2.719 GB
Notification: Performance of Templates: time 9.483/50.83, allocations: 4.364 GB / 19.62 GB, free: 280.2 MB / 3.299 GB
make -j1 -f ScalableTestGrids_SymbolicJacobian_ScalableTestGrids.Models.Type1.Type1_N_4_M_4.makefile
(rm -f ScalableTestGrids_SymbolicJacobian_ScalableTestGrids.Models.Type1.Type1_N_4_M_4.pipe ; mkfifo ScalableTestGrids_SymbolicJacobian_ScalableTestGrids.Models.Type1.Type1_N_4_M_4.pipe ; head -c 1048576 < ScalableTestGrids_SymbolicJacobian_ScalableTestGrids.Models.Type1.Type1_N_4_M_4.pipe >> ../files/ScalableTestGrids_SymbolicJacobian_ScalableTestGrids.Models.Type1.Type1_N_4_M_4.sim & ./ScalableTestGrids_SymbolicJacobian_ScalableTestGrids.Models.Type1.Type1_N_4_M_4  -nls=kinsol -lv=LOG_STATS -abortSlowSimulation -alarm=300 -lv LOG_STATS > ScalableTestGrids_SymbolicJacobian_ScalableTestGrids.Models.Type1.Type1_N_4_M_4.pipe 2>&1)