Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1_N_3_M_4.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+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 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.0.0-master/package.mo", uses=false)
Using package ScalableTestGrids with version 1.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ScalableTestGrids 1.0.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 3.2.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+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 3.2.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo)
Running command: translateModel(ScalableTestGrids.Models.Type1_N_3_M_4,tolerance=0.0001,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1_N_3_M_4")
translateModel(ScalableTestGrids.Models.Type1_N_3_M_4,tolerance=0.0001,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1_N_3_M_4")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo): time 0.001028/0.001028, allocations: 192.9 kB / 17.27 MB, free: 4.5 MB / 13.93 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 1.266/1.266, allocations: 205.1 MB / 223.1 MB, free: 8.465 MB / 186.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo): time 0.001015/0.001015, allocations: 104.1 kB / 270.5 MB, free: 8.43 MB / 218.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 1.0.2/package.mo): time 0.05666/0.05666, allocations: 14.17 MB / 332 MB, free: 10.81 MB / 282.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ScalableTestGrids 1.0.0-master/package.mo): time 2.337/2.337, allocations: 418.5 MB / 0.7826 GB, free: 13.87 MB / 0.5575 GB
Notification: Performance of FrontEnd - loaded program: time 0.001121/0.001121, allocations: 65.11 kB / 0.9536 GB, free: 74.56 MB / 0.714 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.2301/0.2312, allocations: 160.9 MB / 1.111 GB, free: 6.664 MB / 0.7765 GB
Notification: Performance of NFInst.instantiate(ScalableTestGrids.Models.Type1_N_3_M_4): time 2.507/2.738, allocations: 0.799 GB / 1.91 GB, free: 15.78 MB / 1.355 GB
Notification: Performance of NFInst.instExpressions: time 0.5238/3.262, allocations: 280.3 MB / 2.183 GB, free: 8.207 MB / 1.433 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.2302/3.492, allocations: 2.902 MB / 2.186 GB, free: 7.379 MB / 1.433 GB
Notification: Performance of NFTyping.typeComponents: time 0.1666/3.659, allocations: 35.7 MB / 2.221 GB, free: 10.54 MB / 1.465 GB
Notification: Performance of NFTyping.typeBindings: time 0.4074/4.066, allocations: 97.98 MB / 2.317 GB, free: 7.547 MB / 1.543 GB
Notification: Performance of NFTyping.typeClassSections: time 0.1102/4.177, allocations: 27.63 MB / 2.344 GB, free: 13.54 MB / 1.574 GB
Notification: Performance of NFFlatten.flatten: time 1.36/5.537, allocations: 270.4 MB / 2.608 GB, free: 46.97 MB / 1.668 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.09822/5.635, allocations: 26.57 MB / 2.634 GB, free: 56.28 MB / 1.683 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.1578/5.793, allocations: 69.74 MB / 2.702 GB, free: 46.37 MB / 1.683 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.1643/5.957, allocations: 79.13 MB / 2.779 GB, free: 7.879 MB / 1.683 GB
Notification: Performance of NFPackage.collectConstants: time 0.05228/6.009, allocations: 4.883 MB / 2.784 GB, free: 2.996 MB / 1.683 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.1695/6.179, allocations: 16.03 MB / 2.8 GB, free: 0 / 1.683 GB
Notification: Performance of NFScalarize.scalarize: time 0.05391/6.233, allocations: 19.3 MB / 2.818 GB, free: 8.172 MB / 1.699 GB
Notification: Performance of NFVerifyModel.verify: time 0.2273/6.46, allocations: 72.67 MB / 2.889 GB, free: 8.258 MB / 1.746 GB
Notification: Performance of NFConvertDAE.convert: time 0.339/6.799, allocations: 178 MB / 3.063 GB, free: 2.773 MB / 1.886 GB
Notification: Performance of FrontEnd - DAE generated: time 8.907e-06/6.799, allocations: 0 / 3.063 GB, free: 2.773 MB / 1.886 GB
Notification: Performance of FrontEnd: time 1.724e-06/6.799, allocations: 0 / 3.063 GB, free: 2.773 MB / 1.886 GB
Notification: Performance of Transformations before backend: time 0.007745/6.807, allocations: 0 / 3.063 GB, free: 2.773 MB / 1.886 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 1.424/8.231, allocations: 195.6 MB / 3.254 GB, free: 0.7797 GB / 1.918 GB
Notification: Performance of prepare preOptimizeDAE: time 7e-05/8.231, allocations: 11.47 kB / 3.254 GB, free: 0.7797 GB / 1.918 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.1203/8.352, allocations: 21.15 MB / 3.275 GB, free: 0.7695 GB / 1.918 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.2548/8.607, allocations: 80.12 MB / 3.353 GB, free: 0.7131 GB / 1.918 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.01038/8.617, allocations: 8.27 MB / 3.361 GB, free: 0.7094 GB / 1.918 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.04469/8.662, allocations: 10.93 MB / 3.372 GB, free: 0.7029 GB / 1.918 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.3222/8.984, allocations: 114.6 MB / 3.484 GB, free: 0.5866 GB / 1.918 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.006963/8.991, allocations: 229.8 kB / 3.484 GB, free: 0.5864 GB / 1.918 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.03674/9.028, allocations: 4.469 MB / 3.488 GB, free: 0.5821 GB / 1.918 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.002078/9.03, allocations: 2.683 MB / 3.491 GB, free: 0.5794 GB / 1.918 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.267/9.297, allocations: 108.7 MB / 3.597 GB, free: 484.7 MB / 1.918 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.06/11.36, allocations: 0.6956 GB / 4.293 GB, free: 0.5107 GB / 1.933 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.5119/11.87, allocations: 255.4 MB / 4.542 GB, free: 385.2 MB / 1.933 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.1319/12, allocations: 51.62 MB / 4.593 GB, free: 363.5 MB / 1.933 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.01389/12.02, allocations: 1.324 MB / 4.594 GB, free: 363.4 MB / 1.933 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.002338/12.02, allocations: 1.23 MB / 4.595 GB, free: 362.5 MB / 1.933 GB
Notification: Performance of pre-optimization done (n=11801): time 0.0004078/12.02, allocations: 0 / 4.595 GB, free: 362.5 MB / 1.933 GB
Notification: Performance of matching and sorting (n=11819): time 0.8946/12.91, allocations: 262.2 MB / 4.851 GB, free: 142.2 MB / 1.933 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.001289/12.91, allocations: 3.054 MB / 4.854 GB, free: 138.6 MB / 1.933 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 1.071/13.98, allocations: 68.79 MB / 4.921 GB, free: 0.7331 GB / 1.933 GB
Notification: Performance of collectPreVariables (initialization): time 0.02119/14.01, allocations: 2.028 MB / 4.923 GB, free: 0.7315 GB / 1.933 GB
Notification: Performance of collectInitialEqns (initialization): time 0.05684/14.06, allocations: 54.76 MB / 4.977 GB, free: 0.7044 GB / 1.933 GB
Notification: Performance of collectInitialBindings (initialization): time 0.06161/14.12, allocations: 41.04 MB / 5.017 GB, free: 0.6744 GB / 1.933 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.1007/14.22, allocations: 21.32 MB / 5.038 GB, free: 0.6641 GB / 1.933 GB
Notification: Performance of setup shared object (initialization): time 4.801e-05/14.22, allocations: 305.1 kB / 5.038 GB, free: 0.6638 GB / 1.933 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.09699/14.32, allocations: 39.65 MB / 5.077 GB, free: 0.6481 GB / 1.933 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.1316/14.45, allocations: 64.43 MB / 5.139 GB, free: 0.6062 GB / 1.933 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.432/14.89, allocations: 107.1 MB / 5.244 GB, free: 0.5362 GB / 1.933 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.001431/14.89, allocations: 172 kB / 5.244 GB, free: 0.536 GB / 1.933 GB
Notification: Performance of matching and sorting (n=16993) (initialization): time 0.5183/15.41, allocations: 169.7 MB / 5.41 GB, free: 389.3 MB / 1.933 GB
Notification: Performance of prepare postOptimizeDAE: time 0.002322/15.41, allocations: 267.9 kB / 5.41 GB, free: 389.1 MB / 1.933 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.002776/15.41, allocations: 0.5859 MB / 5.411 GB, free: 388.5 MB / 1.933 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.3531/15.76, allocations: 75.92 MB / 5.485 GB, free: 312.3 MB / 1.933 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.9934/16.76, allocations: 23.83 MB / 5.508 GB, free: 0.6619 GB / 1.933 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 1.247/18, allocations: 0.5658 GB / 6.074 GB, free: 314.1 MB / 1.933 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.1362/18.14, allocations: 6.438 MB / 6.08 GB, free: 309 MB / 1.933 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.02951/18.17, allocations: 4.566 MB / 6.085 GB, free: 304.4 MB / 1.933 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.1659/18.34, allocations: 51.63 MB / 6.135 GB, free: 252.8 MB / 1.933 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.1273/18.46, allocations: 62.27 MB / 6.196 GB, free: 181.7 MB / 1.933 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 1.351/19.81, allocations: 104.2 MB / 6.298 GB, free: 0.5565 GB / 1.933 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 0.000876/19.82, allocations: 174.6 kB / 6.298 GB, free: 0.5565 GB / 1.933 GB
Notification: Performance of matching and sorting (n=16993) (initialization_lambda0): time 0.4423/20.26, allocations: 154.5 MB / 6.449 GB, free: 0.5216 GB / 1.933 GB
Notification: Performance of prepare postOptimizeDAE: time 0.001248/20.26, allocations: 264.2 kB / 6.449 GB, free: 0.5216 GB / 1.933 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.001836/20.26, allocations: 0.5928 MB / 6.45 GB, free: 0.5216 GB / 1.933 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.3155/20.58, allocations: 66.17 MB / 6.514 GB, free: 0.5146 GB / 1.933 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.1052/20.68, allocations: 25.15 MB / 6.539 GB, free: 0.5121 GB / 1.933 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.242/22.92, allocations: 492.2 MB / 7.02 GB, free: 475.8 MB / 1.933 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.1262/23.05, allocations: 5.687 MB / 7.025 GB, free: 475.8 MB / 1.933 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.02802/23.08, allocations: 4.54 MB / 7.03 GB, free: 475.8 MB / 1.933 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 (13011):
 * Single equations (assignments): 12847
 * 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.05449/23.13, allocations: 7.204 MB / 7.037 GB, free: 475.5 MB / 1.933 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.05277/23.19, allocations: 11.21 MB / 7.048 GB, free: 475.5 MB / 1.933 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.4048/23.59, allocations: 128.6 MB / 7.173 GB, free: 457.1 MB / 1.933 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.004248/23.59, allocations: 0.5434 MB / 7.174 GB, free: 457.1 MB / 1.933 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 0.0003039/23.59, allocations: 3.969 kB / 7.174 GB, free: 457.1 MB / 1.933 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.07115/23.67, allocations: 18.83 MB / 7.192 GB, free: 444.7 MB / 1.933 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.03682/23.7, allocations: 1.924 MB / 7.194 GB, free: 443.2 MB / 1.933 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.08945/23.79, allocations: 4.399 MB / 7.198 GB, free: 441.2 MB / 1.933 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.03167/23.82, allocations: 9.428 MB / 7.207 GB, free: 440.3 MB / 1.933 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.4233/24.25, allocations: 119.1 MB / 7.324 GB, free: 399.7 MB / 1.933 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 2.888/27.14, allocations: 0.5415 GB / 7.865 GB, free: 426 MB / 1.933 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.09019/27.23, allocations: 37.45 MB / 7.902 GB, free: 410.6 MB / 1.933 GB
Notification: Performance of sorting global known variables: time 0.09393/27.32, allocations: 44.09 MB / 7.945 GB, free: 395.4 MB / 1.933 GB
Notification: Performance of Backend: time 1.263e-06/27.32, allocations: 0 / 7.945 GB, free: 395.4 MB / 1.933 GB
Notification: Performance of simCode: created initialization part: time 0.7048/28.03, allocations: 289.2 MB / 8.227 GB, free: 188.6 MB / 1.933 GB
Warning: The hideResult annotation could not be evaluated, probably due to missing annotation(Evaluate=true). It is removed.
Notification: Performance of SimCode: time 1.945/29.97, allocations: 423.5 MB / 8.641 GB, free: 289.3 MB / 1.933 GB
Notification: Performance of Templates: time 7.647/37.62, allocations: 2.427 GB / 11.07 GB, free: 342.7 MB / 2.246 GB
make -j1 -f ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1_N_3_M_4.makefile
(rm -f ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1_N_3_M_4.pipe ; mkfifo ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1_N_3_M_4.pipe ; head -c 1048576 < ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1_N_3_M_4.pipe >> ../files/ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1_N_3_M_4.sim & ./ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1_N_3_M_4  -nls=kinsol -lv=LOG_STATS -abortSlowSimulation -alarm=500 -lv LOG_STATS > ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1_N_3_M_4.pipe 2>&1)