Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1.Type1_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.Type1.Type1_N_3_M_4,tolerance=0.0001,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1.Type1_N_3_M_4")
translateModel(ScalableTestGrids.Models.Type1.Type1_N_3_M_4,tolerance=0.0001,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1.Type1_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.001534/0.001534, allocations: 109.5 kB / 18.36 MB, free: 4.699 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.001747/0.001747, allocations: 188.1 kB / 19.28 MB, free: 3.777 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.761/1.761, allocations: 205.1 MB / 225.2 MB, free: 12.28 MB / 190.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 1.0.3/package.mo): time 0.06293/0.06293, allocations: 14.18 MB / 286.7 MB, free: 13.9 MB / 238.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ScalableTestGrids 1.1.0-master/package.mo): time 3.851/3.851, allocations: 461.2 MB / 0.78 GB, free: 107.2 MB / 0.6546 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.001854/0.001854, allocations: 79.89 kB / 0.963 GB, free: 2.043 MB / 0.7327 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 1.196/1.198, allocations: 172.1 MB / 1.131 GB, free: 28.9 MB / 0.8736 GB
Notification: Performance of NFInst.instantiate(ScalableTestGrids.Models.Type1.Type1_N_3_M_4): time 1.902/3.1, allocations: 0.7897 GB / 1.921 GB, free: 7.809 MB / 1.296 GB
Notification: Performance of NFInst.instExpressions: time 1.528/4.628, allocations: 279.1 MB / 2.193 GB, free: 204 kB / 1.546 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.1902/4.818, allocations: 2.767 MB / 2.196 GB, free: 204 kB / 1.546 GB
Notification: Performance of NFTyping.typeComponents: time 0.1617/4.98, allocations: 42.09 MB / 2.237 GB, free: 15.51 MB / 1.562 GB
Notification: Performance of NFTyping.typeBindings: time 0.4144/5.394, allocations: 108.3 MB / 2.343 GB, free: 5.461 MB / 1.562 GB
Notification: Performance of NFTyping.typeClassSections: time 0.1099/5.504, allocations: 30.01 MB / 2.372 GB, free: 14.36 MB / 1.577 GB
Notification: Performance of NFFlatten.flatten: time 0.4352/5.94, allocations: 271 MB / 2.637 GB, free: 3.688 MB / 1.78 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.1287/6.068, allocations: 28.11 MB / 2.664 GB, free: 7.773 MB / 1.812 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.2209/6.289, allocations: 88.89 MB / 2.751 GB, free: 15.88 MB / 1.905 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.1779/6.467, allocations: 96.7 MB / 2.845 GB, free: 1.77 MB / 1.983 GB
Notification: Performance of NFPackage.collectConstants: time 0.06491/6.532, allocations: 12.16 MB / 2.857 GB, free: 5.609 MB / 1.999 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.1266/6.659, allocations: 22.69 MB / 2.88 GB, free: 14.93 MB / 2.03 GB
Notification: Performance of NFScalarize.scalarize: time 0.06234/6.721, allocations: 27.77 MB / 2.907 GB, free: 3.934 MB / 2.046 GB
Notification: Performance of NFVerifyModel.verify: time 1.552/8.273, allocations: 84.43 MB / 2.989 GB, free: 223.2 MB / 2.046 GB
Notification: Performance of NFConvertDAE.convert: time 0.3918/8.665, allocations: 197.6 MB / 3.182 GB, free: 189 MB / 2.046 GB
Notification: Performance of FrontEnd - DAE generated: time 8.927e-06/8.665, allocations: 3.938 kB / 3.182 GB, free: 189 MB / 2.046 GB
Notification: Performance of FrontEnd: time 2.504e-06/8.665, allocations: 0 / 3.182 GB, free: 189 MB / 2.046 GB
Notification: Performance of Transformations before backend: time 0.008976/8.674, allocations: 0 / 3.182 GB, free: 189 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.9022/9.576, allocations: 205.8 MB / 3.383 GB, free: 103.6 MB / 2.046 GB
Notification: Performance of prepare preOptimizeDAE: time 7.032e-05/9.576, allocations: 9.969 kB / 3.383 GB, free: 103.6 MB / 2.046 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.1466/9.723, allocations: 21.15 MB / 3.404 GB, free: 84.95 MB / 2.046 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.3204/10.04, allocations: 85.78 MB / 3.487 GB, free: 28.39 MB / 2.046 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.01354/10.06, allocations: 8.269 MB / 3.495 GB, free: 20.36 MB / 2.046 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.05856/10.12, allocations: 10.92 MB / 3.506 GB, free: 9.441 MB / 2.046 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.4313/10.55, allocations: 114.6 MB / 3.618 GB, free: 2.566 MB / 2.155 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.007732/10.55, allocations: 229.7 kB / 3.618 GB, free: 2.477 MB / 2.155 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.04544/10.6, allocations: 4.469 MB / 3.623 GB, free: 14.02 MB / 2.171 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.003443/10.6, allocations: 2.68 MB / 3.625 GB, free: 11.34 MB / 2.171 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 1.358/11.96, allocations: 108.7 MB / 3.731 GB, free: 0.8776 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.401/13.36, allocations: 0.7414 GB / 4.473 GB, free: 280.1 MB / 2.171 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.5601/13.92, allocations: 255.4 MB / 4.722 GB, free: 67.95 MB / 2.171 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.1409/14.06, allocations: 51.62 MB / 4.773 GB, free: 16.28 MB / 2.171 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.01467/14.08, allocations: 1.319 MB / 4.774 GB, free: 15.01 MB / 2.171 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.002631/14.08, allocations: 1.23 MB / 4.775 GB, free: 13.77 MB / 2.171 GB
Notification: Performance of pre-optimization done (n=11801): time 0.0005782/14.08, allocations: 0 / 4.775 GB, free: 13.77 MB / 2.171 GB
Notification: Performance of matching and sorting (n=11801): time 1.64/15.72, allocations: 153.7 MB / 4.925 GB, free: 0.8549 GB / 2.171 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.001442/15.72, allocations: 3.052 MB / 4.928 GB, free: 0.8525 GB / 2.171 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.2543/15.98, allocations: 76.07 MB / 5.002 GB, free: 0.8333 GB / 2.171 GB
Notification: Performance of collectPreVariables (initialization): time 0.02532/16, allocations: 2.025 MB / 5.004 GB, free: 0.8318 GB / 2.171 GB
Notification: Performance of collectInitialEqns (initialization): time 0.06464/16.07, allocations: 54.22 MB / 5.057 GB, free: 0.7944 GB / 2.171 GB
Notification: Performance of collectInitialBindings (initialization): time 0.08707/16.16, allocations: 41.05 MB / 5.097 GB, free: 0.7627 GB / 2.171 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.1169/16.27, allocations: 21.3 MB / 5.118 GB, free: 0.7524 GB / 2.171 GB
Notification: Performance of setup shared object (initialization): time 6.306e-05/16.27, allocations: 302.2 kB / 5.119 GB, free: 0.7522 GB / 2.171 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.1109/16.38, allocations: 39.67 MB / 5.157 GB, free: 0.7364 GB / 2.171 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.1342/16.52, allocations: 64.45 MB / 5.22 GB, free: 0.6941 GB / 2.171 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.432/16.95, allocations: 107.1 MB / 5.325 GB, free: 0.5847 GB / 2.171 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.001667/16.95, allocations: 172 kB / 5.325 GB, free: 0.5845 GB / 2.171 GB
Notification: Performance of matching and sorting (n=16975) (initialization): time 1.6/18.55, allocations: 169.8 MB / 5.491 GB, free: 0.7855 GB / 2.171 GB
Notification: Performance of prepare postOptimizeDAE: time 0.001674/18.55, allocations: 266.2 kB / 5.491 GB, free: 0.7855 GB / 2.171 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.002184/18.55, allocations: 0.5887 MB / 5.492 GB, free: 0.7855 GB / 2.171 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.3753/18.93, allocations: 75.8 MB / 5.566 GB, free: 0.7826 GB / 2.171 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.1095/19.04, allocations: 23.76 MB / 5.589 GB, free: 0.7809 GB / 2.171 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.503/21.54, allocations: 0.6156 GB / 6.204 GB, free: 0.7207 GB / 2.171 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.1714/21.71, allocations: 9.982 MB / 6.214 GB, free: 0.7185 GB / 2.171 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.03241/21.75, allocations: 4.563 MB / 6.219 GB, free: 0.7185 GB / 2.171 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.1885/21.94, allocations: 51.64 MB / 6.269 GB, free: 0.7175 GB / 2.171 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.1492/22.08, allocations: 62.29 MB / 6.33 GB, free: 0.6763 GB / 2.171 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.4225/22.51, allocations: 104.2 MB / 6.432 GB, free: 0.6121 GB / 2.171 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 0.001519/22.51, allocations: 170.5 kB / 6.432 GB, free: 0.6121 GB / 2.171 GB
Notification: Performance of matching and sorting (n=16975) (initialization_lambda0): time 0.5119/23.02, allocations: 154.6 MB / 6.583 GB, free: 497.5 MB / 2.171 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0008697/23.02, allocations: 267.8 kB / 6.583 GB, free: 497.3 MB / 2.171 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.00145/23.02, allocations: 0.5898 MB / 6.584 GB, free: 496.7 MB / 2.171 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.3022/23.32, allocations: 66.07 MB / 6.648 GB, free: 449.1 MB / 2.171 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.1051/23.43, allocations: 25.08 MB / 6.673 GB, free: 427.2 MB / 2.171 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.397/25.83, allocations: 0.523 GB / 7.196 GB, free: 469.1 MB / 2.171 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.1591/25.99, allocations: 7.87 MB / 7.203 GB, free: 465.4 MB / 2.171 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.02886/26.01, allocations: 4.536 MB / 7.208 GB, free: 464.4 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.06223/26.08, allocations: 7.204 MB / 7.215 GB, free: 459.6 MB / 2.171 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.06522/26.14, allocations: 11.2 MB / 7.226 GB, free: 453.9 MB / 2.171 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.4608/26.6, allocations: 128.4 MB / 7.351 GB, free: 380.1 MB / 2.171 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.00436/26.61, allocations: 0.5422 MB / 7.352 GB, free: 380.1 MB / 2.171 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 0.0004518/26.61, allocations: 0 / 7.352 GB, free: 380.1 MB / 2.171 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.1154/26.72, allocations: 22.43 MB / 7.374 GB, free: 361.6 MB / 2.171 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.05772/26.78, allocations: 1.914 MB / 7.375 GB, free: 359.7 MB / 2.171 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.1234/26.9, allocations: 3.202 MB / 7.379 GB, free: 356.9 MB / 2.171 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.03986/26.94, allocations: 9.416 MB / 7.388 GB, free: 351.6 MB / 2.171 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 1.732/28.68, allocations: 118.4 MB / 7.503 GB, free: 0.6785 GB / 2.171 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 1.966/30.64, allocations: 0.5533 GB / 8.057 GB, free: 361.9 MB / 2.171 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.1093/30.75, allocations: 37.38 MB / 8.093 GB, free: 324.5 MB / 2.171 GB
Notification: Performance of sorting global known variables: time 1.514/32.27, allocations: 49.43 MB / 8.142 GB, free: 0.6331 GB / 2.171 GB
Notification: Performance of Backend: time 8.81e-07/32.27, allocations: 0 / 8.142 GB, free: 0.6331 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.9013/33.17, allocations: 305.8 MB / 8.44 GB, free: 0.5701 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.039/35.21, allocations: 388.2 MB / 8.819 GB, free: 263.2 MB / 2.171 GB
Notification: Performance of Templates: time 9.838/45.05, allocations: 2.619 GB / 11.44 GB, free: 419 MB / 2.171 GB
make -j1 -f ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1.Type1_N_3_M_4.makefile
(rm -f ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1.Type1_N_3_M_4.pipe ; mkfifo ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1.Type1_N_3_M_4.pipe ; head -c 1048576 < ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1.Type1_N_3_M_4.pipe >> ../files/ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1.Type1_N_3_M_4.sim & ./ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1.Type1_N_3_M_4  -nls=kinsol -lv=LOG_STATS -abortSlowSimulation -alarm=480 -s cvode -lv LOG_STATS > ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1.Type1_N_3_M_4.pipe 2>&1)