Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ScalableTestGrids_noopt_ScalableTestGrids.Models.Type2.Type2_noTap___N_3_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-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.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.Type2.Type2_noTap___N_3_M_4,tolerance=1e-05,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="ScalableTestGrids_noopt_ScalableTestGrids.Models.Type2.Type2_noTap___N_3_M_4")
translateModel(ScalableTestGrids.Models.Type2.Type2_noTap___N_3_M_4,tolerance=1e-05,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="ScalableTestGrids_noopt_ScalableTestGrids.Models.Type2.Type2_noTap___N_3_M_4")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001196/0.001196, allocations: 103.9 kB / 18.35 MB, free: 4.684 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.001234/0.001234, allocations: 190.9 kB / 19.29 MB, free: 3.754 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.392/1.392, allocations: 205.1 MB / 225.2 MB, free: 12.25 MB / 190.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 1.0.3/package.mo): time 0.05918/0.05918, allocations: 14.16 MB / 286.7 MB, free: 13.88 MB / 238.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ScalableTestGrids 1.1.0-master/package.mo): time 2.983/2.983, allocations: 461.2 MB / 0.78 GB, free: 107.2 MB / 0.6545 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.002226/0.002227, allocations: 83.88 kB / 0.963 GB, free: 2.008 MB / 0.7327 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 1.102/1.104, allocations: 172.1 MB / 1.131 GB, free: 28.93 MB / 0.8735 GB
Notification: Performance of NFInst.instantiate(ScalableTestGrids.Models.Type2.Type2_noTap___N_3_M_4): time 1.986/3.091, allocations: 0.7897 GB / 1.921 GB, free: 7.758 MB / 1.296 GB
Notification: Performance of NFInst.instExpressions: time 1.631/4.722, allocations: 279.1 MB / 2.193 GB, free: 208 kB / 1.546 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.2111/4.933, allocations: 2.77 MB / 2.196 GB, free: 208 kB / 1.546 GB
Notification: Performance of NFTyping.typeComponents: time 0.1659/5.099, allocations: 42.09 MB / 2.237 GB, free: 15.51 MB / 1.562 GB
Notification: Performance of NFTyping.typeBindings: time 0.4391/5.538, allocations: 108.3 MB / 2.343 GB, free: 5.438 MB / 1.562 GB
Notification: Performance of NFTyping.typeClassSections: time 0.1213/5.66, allocations: 30.02 MB / 2.372 GB, free: 14.41 MB / 1.577 GB
Notification: Performance of NFFlatten.flatten: time 0.5493/6.209, allocations: 271 MB / 2.637 GB, free: 3.613 MB / 1.78 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.1105/6.32, allocations: 28.11 MB / 2.664 GB, free: 7.699 MB / 1.812 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.2208/6.54, allocations: 88.89 MB / 2.751 GB, free: 15.81 MB / 1.905 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.1901/6.731, allocations: 96.7 MB / 2.846 GB, free: 1.691 MB / 1.983 GB
Notification: Performance of NFPackage.collectConstants: time 0.06668/6.797, allocations: 12.16 MB / 2.857 GB, free: 5.527 MB / 1.999 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.1241/6.921, allocations: 22.7 MB / 2.88 GB, free: 14.84 MB / 2.03 GB
Notification: Performance of NFScalarize.scalarize: time 0.07748/6.999, allocations: 27.77 MB / 2.907 GB, free: 3.844 MB / 2.046 GB
Notification: Performance of NFVerifyModel.verify: time 1.669/8.668, allocations: 84.43 MB / 2.989 GB, free: 223.1 MB / 2.046 GB
Notification: Performance of NFConvertDAE.convert: time 0.4213/9.089, allocations: 197.6 MB / 3.182 GB, free: 188.9 MB / 2.046 GB
Notification: Performance of FrontEnd - DAE generated: time 1.019e-05/9.089, allocations: 0 / 3.182 GB, free: 188.9 MB / 2.046 GB
Notification: Performance of FrontEnd: time 2.905e-06/9.089, allocations: 0 / 3.182 GB, free: 188.9 MB / 2.046 GB
Notification: Performance of Transformations before backend: time 0.01263/9.102, allocations: 0 / 3.182 GB, free: 188.9 MB / 2.046 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 28284
 * Number of variables: 28284
Notification: Performance of Generate backend data structure: time 0.9572/10.06, allocations: 205.8 MB / 3.383 GB, free: 103.5 MB / 2.046 GB
Notification: Performance of prepare preOptimizeDAE: time 8.216e-05/10.06, allocations: 9.531 kB / 3.383 GB, free: 103.5 MB / 2.046 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.1569/10.22, allocations: 21.15 MB / 3.404 GB, free: 84.87 MB / 2.046 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.3098/10.53, allocations: 85.77 MB / 3.487 GB, free: 28.32 MB / 2.046 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.01171/10.54, allocations: 8.271 MB / 3.496 GB, free: 20.2 MB / 2.046 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0478/10.59, allocations: 10.91 MB / 3.506 GB, free: 9.289 MB / 2.046 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.4133/11, allocations: 114.6 MB / 3.618 GB, free: 2.406 MB / 2.155 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.008023/11.01, allocations: 229.1 kB / 3.618 GB, free: 2.316 MB / 2.155 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0429/11.05, allocations: 4.471 MB / 3.623 GB, free: 13.86 MB / 2.171 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.00293/11.05, allocations: 2.682 MB / 3.625 GB, free: 11.18 MB / 2.171 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 1.444/12.5, allocations: 108.7 MB / 3.731 GB, free: 0.8773 GB / 2.171 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 1.597/14.09, allocations: 0.7413 GB / 4.473 GB, free: 279.5 MB / 2.171 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.6054/14.7, allocations: 254.5 MB / 4.721 GB, free: 68.52 MB / 2.171 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.1682/14.87, allocations: 51.57 MB / 4.772 GB, free: 16.9 MB / 2.171 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.01756/14.89, allocations: 1.318 MB / 4.773 GB, free: 15.63 MB / 2.171 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.002958/14.89, allocations: 1.238 MB / 4.774 GB, free: 14.38 MB / 2.171 GB
Notification: Performance of pre-optimization done (n=11801): time 0.001311/14.89, allocations: 0 / 4.774 GB, free: 14.38 MB / 2.171 GB
Notification: Performance of matching and sorting (n=11801): time 1.914/16.8, allocations: 153.6 MB / 4.924 GB, free: 0.8547 GB / 2.171 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.00113/16.81, allocations: 3.06 MB / 4.927 GB, free: 0.8523 GB / 2.171 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.2725/17.08, allocations: 76.07 MB / 5.001 GB, free: 0.8333 GB / 2.171 GB
Notification: Performance of collectPreVariables (initialization): time 0.02754/17.11, allocations: 2.024 MB / 5.003 GB, free: 0.8318 GB / 2.171 GB
Notification: Performance of collectInitialEqns (initialization): time 0.07251/17.18, allocations: 54.22 MB / 5.056 GB, free: 0.7944 GB / 2.171 GB
Notification: Performance of collectInitialBindings (initialization): time 0.08802/17.27, allocations: 41.06 MB / 5.096 GB, free: 0.7627 GB / 2.171 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.1321/17.4, allocations: 21.31 MB / 5.117 GB, free: 0.7525 GB / 2.171 GB
Notification: Performance of setup shared object (initialization): time 7.357e-05/17.4, allocations: 305.1 kB / 5.118 GB, free: 0.7522 GB / 2.171 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.1217/17.52, allocations: 39.63 MB / 5.156 GB, free: 0.7364 GB / 2.171 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.1632/17.68, allocations: 64.4 MB / 5.219 GB, free: 0.6945 GB / 2.171 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.4352/18.12, allocations: 107 MB / 5.324 GB, free: 0.5856 GB / 2.171 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.00196/18.12, allocations: 173.6 kB / 5.324 GB, free: 0.5854 GB / 2.171 GB
Notification: Performance of matching and sorting (n=16975) (initialization): time 1.828/19.95, allocations: 169.7 MB / 5.489 GB, free: 0.785 GB / 2.171 GB
Notification: Performance of prepare postOptimizeDAE: time 0.002276/19.95, allocations: 264.2 kB / 5.49 GB, free: 0.785 GB / 2.171 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.002819/19.95, allocations: 0.5893 MB / 5.49 GB, free: 0.785 GB / 2.171 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.396/20.35, allocations: 75.69 MB / 5.564 GB, free: 0.7821 GB / 2.171 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.1171/20.47, allocations: 23.77 MB / 5.587 GB, free: 0.7804 GB / 2.171 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.787/23.25, allocations: 0.6155 GB / 6.203 GB, free: 0.72 GB / 2.171 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.1976/23.45, allocations: 9.995 MB / 6.213 GB, free: 0.7177 GB / 2.171 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.037/23.49, allocations: 4.562 MB / 6.217 GB, free: 0.7177 GB / 2.171 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.1992/23.69, allocations: 51.6 MB / 6.268 GB, free: 0.7166 GB / 2.171 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.1499/23.84, allocations: 62.26 MB / 6.328 GB, free: 0.6754 GB / 2.171 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.4209/24.26, allocations: 104.1 MB / 6.43 GB, free: 0.6112 GB / 2.171 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 0.001443/24.26, allocations: 171.6 kB / 6.43 GB, free: 0.6112 GB / 2.171 GB
Notification: Performance of matching and sorting (n=16975) (initialization_lambda0): time 0.5068/24.77, allocations: 154.5 MB / 6.581 GB, free: 497.8 MB / 2.171 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0007218/24.77, allocations: 264 kB / 6.581 GB, free: 497.5 MB / 2.171 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.001486/24.77, allocations: 0.5937 MB / 6.582 GB, free: 496.9 MB / 2.171 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.3114/25.08, allocations: 65.96 MB / 6.646 GB, free: 449.4 MB / 2.171 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.1079/25.19, allocations: 25.08 MB / 6.671 GB, free: 427.5 MB / 2.171 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.381/27.57, allocations: 0.5229 GB / 7.194 GB, free: 468.7 MB / 2.171 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.1673/27.74, allocations: 7.872 MB / 7.201 GB, free: 464.9 MB / 2.171 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.03178/27.77, allocations: 4.539 MB / 7.206 GB, free: 463.9 MB / 2.171 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 2755
 * Number of states: 0 ()
 * Number of discrete variables: 90 (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_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_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_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_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_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 (12993):
 * Single equations (assignments): 12829
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 164
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 72 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%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 92 systems
   {(38,0), (3604,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.05909/27.83, allocations: 7.209 MB / 7.213 GB, free: 459.2 MB / 2.171 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.06495/27.89, allocations: 11.2 MB / 7.224 GB, free: 453.4 MB / 2.171 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.4264/28.32, allocations: 128.3 MB / 7.349 GB, free: 380.5 MB / 2.171 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.004246/28.32, allocations: 0.5418 MB / 7.35 GB, free: 380.5 MB / 2.171 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 0.0003092/28.32, allocations: 2.25 kB / 7.35 GB, free: 380.5 MB / 2.171 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.1081/28.43, allocations: 22.42 MB / 7.372 GB, free: 362.1 MB / 2.171 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.05757/28.49, allocations: 1.91 MB / 7.373 GB, free: 360.2 MB / 2.171 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.124/28.61, allocations: 3.212 MB / 7.377 GB, free: 357.3 MB / 2.171 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.03446/28.65, allocations: 9.421 MB / 7.386 GB, free: 352.1 MB / 2.171 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 1.667/30.31, allocations: 118.4 MB / 7.501 GB, free: 0.6627 GB / 2.171 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 1.958/32.27, allocations: 0.5513 GB / 8.053 GB, free: 381.9 MB / 2.171 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.1076/32.38, allocations: 37.35 MB / 8.089 GB, free: 344.5 MB / 2.171 GB
Notification: Performance of sorting global known variables: time 1.511/33.89, allocations: 49.44 MB / 8.137 GB, free: 0.6021 GB / 2.171 GB
Notification: Performance of Backend: time 1.673e-06/33.89, allocations: 0 / 8.137 GB, free: 0.6021 GB / 2.171 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 0.9052/34.8, allocations: 305.7 MB / 8.436 GB, free: 0.5397 GB / 2.171 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.015/36.81, allocations: 388.2 MB / 8.815 GB, free: 287.2 MB / 2.171 GB
Notification: Performance of Templates: time 10.87/47.68, allocations: 2.619 GB / 11.43 GB, free: 420.6 MB / 2.171 GB
make -j1 -f ScalableTestGrids_noopt_ScalableTestGrids.Models.Type2.Type2_noTap___N_3_M_4.makefile
(rm -f ScalableTestGrids_noopt_ScalableTestGrids.Models.Type2.Type2_noTap___N_3_M_4.pipe ; mkfifo ScalableTestGrids_noopt_ScalableTestGrids.Models.Type2.Type2_noTap___N_3_M_4.pipe ; head -c 1048576 < ScalableTestGrids_noopt_ScalableTestGrids.Models.Type2.Type2_noTap___N_3_M_4.pipe >> ../files/ScalableTestGrids_noopt_ScalableTestGrids.Models.Type2.Type2_noTap___N_3_M_4.sim & ./ScalableTestGrids_noopt_ScalableTestGrids.Models.Type2.Type2_noTap___N_3_M_4  -nls=kinsol -lv=LOG_STATS -abortSlowSimulation -alarm=480 -s cvode -lv LOG_STATS > ScalableTestGrids_noopt_ScalableTestGrids.Models.Type2.Type2_noTap___N_3_M_4.pipe 2>&1)