Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr ScalableTestGrids_NumericalJacobian_ScalableTestGrids.Models.Type1.Type1_reduced_N_3_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_reduced_N_3_M_4,tolerance=0.0001,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="ScalableTestGrids_NumericalJacobian_ScalableTestGrids.Models.Type1.Type1_reduced_N_3_M_4")
translateModel(ScalableTestGrids.Models.Type1.Type1_reduced_N_3_M_4,tolerance=0.0001,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="ScalableTestGrids_NumericalJacobian_ScalableTestGrids.Models.Type1.Type1_reduced_N_3_M_4")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.0009367/0.0009368, allocations: 192.8 kB / 16.7 MB, free: 6.773 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.3324/0.3324, allocations: 205.5 MB / 223 MB, free: 1.316 MB / 190.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.000881/0.000881, allocations: 104 kB / 270.4 MB, free: 8.688 MB / 222.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 1.0.2/package.mo): time 0.1069/0.1069, allocations: 14.43 MB / 332.2 MB, free: 45.12 MB / 270.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ScalableTestGrids 1.1.0-master/package.mo): time 1.364/1.364, allocations: 460.6 MB / 0.8238 GB, free: 12.85 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.001203/0.001203, allocations: 79.89 kB / 1.006 GB, free: 12.03 MB / 0.7327 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.2017/0.2029, allocations: 171.9 MB / 1.174 GB, free: 15.77 MB / 0.9045 GB
Notification: Performance of NFInst.instantiate(ScalableTestGrids.Models.Type1.Type1_reduced_N_3_M_4): time 2.224/2.427, allocations: 0.7993 GB / 1.973 GB, free: 15.7 MB / 1.358 GB
Notification: Performance of NFInst.instExpressions: time 0.3503/2.777, allocations: 280.7 MB / 2.247 GB, free: 3.258 MB / 1.483 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.125/2.902, allocations: 2.901 MB / 2.25 GB, free: 352 kB / 1.483 GB
Notification: Performance of NFTyping.typeComponents: time 0.1096/3.012, allocations: 35.71 MB / 2.285 GB, free: 12.46 MB / 1.53 GB
Notification: Performance of NFTyping.typeBindings: time 0.2713/3.283, allocations: 97.99 MB / 2.38 GB, free: 10.11 MB / 1.624 GB
Notification: Performance of NFTyping.typeClassSections: time 0.7078/3.991, allocations: 27.62 MB / 2.407 GB, free: 39.13 MB / 1.624 GB
Notification: Performance of NFFlatten.flatten: time 0.267/4.258, allocations: 283 MB / 2.684 GB, free: 6.656 MB / 1.624 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.05399/4.312, allocations: 28.1 MB / 2.711 GB, free: 1.754 MB / 1.64 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.1371/4.449, allocations: 81.53 MB / 2.791 GB, free: 11.63 MB / 1.718 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.1184/4.568, allocations: 87.13 MB / 2.876 GB, free: 5.5 MB / 1.78 GB
Notification: Performance of NFPackage.collectConstants: time 0.03554/4.603, allocations: 10.1 MB / 2.886 GB, free: 11.4 MB / 1.796 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.07738/4.681, allocations: 20.64 MB / 2.906 GB, free: 7.156 MB / 1.812 GB
Notification: Performance of NFScalarize.scalarize: time 0.03293/4.714, allocations: 24.36 MB / 2.93 GB, free: 15.5 MB / 1.843 GB
Notification: Performance of NFVerifyModel.verify: time 0.1288/4.842, allocations: 81.26 MB / 3.009 GB, free: 15.95 MB / 1.921 GB
Notification: Performance of NFConvertDAE.convert: time 0.9281/5.771, allocations: 185.1 MB / 3.19 GB, free: 256.5 MB / 1.952 GB
Notification: Performance of FrontEnd - DAE generated: time 6.963e-06/5.771, allocations: 1.875 kB / 3.19 GB, free: 256.5 MB / 1.952 GB
Notification: Performance of FrontEnd: time 1.383e-06/5.771, allocations: 0 / 3.19 GB, free: 256.5 MB / 1.952 GB
Notification: Performance of Transformations before backend: time 0.00565/5.776, allocations: 0.625 kB / 3.19 GB, free: 256.5 MB / 1.952 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 28285
 * Number of variables: 28285
Notification: Performance of Generate backend data structure: time 0.5751/6.351, allocations: 196.7 MB / 3.382 GB, free: 178 MB / 1.952 GB
Notification: Performance of prepare preOptimizeDAE: time 4.379e-05/6.351, allocations: 8.234 kB / 3.382 GB, free: 178 MB / 1.952 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0885/6.44, allocations: 21.14 MB / 3.403 GB, free: 165.1 MB / 1.952 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.1635/6.603, allocations: 80.12 MB / 3.481 GB, free: 109.5 MB / 1.952 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.005851/6.609, allocations: 8.271 MB / 3.489 GB, free: 101.2 MB / 1.952 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.02649/6.636, allocations: 10.92 MB / 3.5 GB, free: 90.27 MB / 1.952 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.2085/6.844, allocations: 114.6 MB / 3.611 GB, free: 3.395 MB / 1.983 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.003708/6.848, allocations: 230 kB / 3.612 GB, free: 3.305 MB / 1.983 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.01792/6.866, allocations: 4.471 MB / 3.616 GB, free: 14.84 MB / 1.999 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.001667/6.868, allocations: 2.684 MB / 3.619 GB, free: 12.15 MB / 1.999 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.1978/7.066, allocations: 108.7 MB / 3.725 GB, free: 0.6484 MB / 2.093 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.332/8.397, allocations: 0.6955 GB / 4.42 GB, free: 370.3 MB / 2.14 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.4181/8.815, allocations: 255.5 MB / 4.67 GB, free: 190.6 MB / 2.14 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.07524/8.891, allocations: 51.62 MB / 4.72 GB, free: 138.9 MB / 2.14 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.005923/8.897, allocations: 1.32 MB / 4.721 GB, free: 137.6 MB / 2.14 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0005579/8.897, allocations: 1.232 MB / 4.723 GB, free: 136.4 MB / 2.14 GB
Notification: Performance of pre-optimization done (n=11802): time 0.0001265/8.897, allocations: 0 / 4.723 GB, free: 136.4 MB / 2.14 GB
Notification: Performance of matching and sorting (n=11820): time 1.177/10.07, allocations: 262.2 MB / 4.979 GB, free: 0.8863 GB / 2.14 GB
Notification: Performance of evaluateOutputsOnly (n=11820 -> n=4614): time 721/731.1, allocations: 89.84 GB / 94.82 GB, free: 3.789 GB / 24.59 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0008101/731.1, allocations: 2.35 MB / 94.82 GB, free: 3.786 GB / 24.59 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.1437/731.2, allocations: 94.46 MB / 94.91 GB, free: 3.713 GB / 24.59 GB
Notification: Performance of collectPreVariables (initialization): time 0.01381/731.2, allocations: 2.017 MB / 94.91 GB, free: 3.711 GB / 24.59 GB
Notification: Performance of collectInitialEqns (initialization): time 0.04267/731.3, allocations: 43.93 MB / 94.96 GB, free: 3.675 GB / 24.59 GB
Notification: Performance of collectInitialBindings (initialization): time 0.01641/731.3, allocations: 16.52 MB / 94.97 GB, free: 3.66 GB / 24.59 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.05709/731.3, allocations: 25.99 MB / 95 GB, free: 3.637 GB / 24.59 GB
Notification: Performance of setup shared object (initialization): time 5.92e-05/731.3, allocations: 301.1 kB / 95 GB, free: 3.637 GB / 24.59 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.06418/731.4, allocations: 39.93 MB / 95.04 GB, free: 3.602 GB / 24.59 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.08059/731.5, allocations: 64.71 MB / 95.1 GB, free: 3.536 GB / 24.59 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.143/731.6, allocations: 89.81 MB / 95.19 GB, free: 3.443 GB / 24.59 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0005198/731.6, allocations: 172 kB / 95.19 GB, free: 3.442 GB / 24.59 GB
Notification: Performance of matching and sorting (n=16994) (initialization): time 0.3483/732, allocations: 170.3 MB / 95.35 GB, free: 3.295 GB / 24.59 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0003298/732, allocations: 264 kB / 95.35 GB, free: 3.294 GB / 24.59 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0005671/732, allocations: 0.5868 MB / 95.35 GB, free: 3.294 GB / 24.59 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.2993/732.3, allocations: 76.42 MB / 95.43 GB, free: 3.24 GB / 24.59 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.07952/732.4, allocations: 23.83 MB / 95.45 GB, free: 3.219 GB / 24.59 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.8076/733.2, allocations: 0.6151 GB / 96.07 GB, free: 2.638 GB / 24.59 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.1077/733.3, allocations: 7.99 MB / 96.08 GB, free: 2.631 GB / 24.59 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.01653/733.3, allocations: 4.566 MB / 96.08 GB, free: 2.626 GB / 24.59 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.09412/733.4, allocations: 48.36 MB / 96.13 GB, free: 2.583 GB / 24.59 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.07544/733.5, allocations: 62.56 MB / 96.19 GB, free: 2.518 GB / 24.59 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.1339/733.6, allocations: 86.89 MB / 96.27 GB, free: 2.425 GB / 24.59 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 0.0005061/733.6, allocations: 172 kB / 96.27 GB, free: 2.425 GB / 24.59 GB
Notification: Performance of matching and sorting (n=16994) (initialization_lambda0): time 0.2914/733.9, allocations: 155 MB / 96.42 GB, free: 2.273 GB / 24.59 GB
Notification: Performance of prepare postOptimizeDAE: time 0.000322/733.9, allocations: 268.1 kB / 96.43 GB, free: 2.272 GB / 24.59 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0005633/733.9, allocations: 0.5859 MB / 96.43 GB, free: 2.272 GB / 24.59 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.2622/734.1, allocations: 66.63 MB / 96.49 GB, free: 2.206 GB / 24.59 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.08329/734.2, allocations: 25.15 MB / 96.52 GB, free: 2.182 GB / 24.59 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.6387/734.9, allocations: 0.523 GB / 97.04 GB, free: 1.637 GB / 24.59 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.1028/735, allocations: 5.692 MB / 97.04 GB, free: 1.631 GB / 24.59 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.01592/735, allocations: 4.539 MB / 97.05 GB, free: 1.627 GB / 24.59 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 (13012):
 * Single equations (assignments): 12848
 * 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
   {(3604,0), (38,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.02515/735, allocations: 6.121 MB / 97.05 GB, free: 1.621 GB / 24.59 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.02207/735, allocations: 10.32 MB / 97.06 GB, free: 1.61 GB / 24.59 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.1378/735.2, allocations: 78.15 MB / 97.14 GB, free: 1.534 GB / 24.59 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.0004688/735.2, allocations: 219.1 kB / 97.14 GB, free: 1.534 GB / 24.59 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 5.694e-05/735.2, allocations: 3.938 kB / 97.14 GB, free: 1.534 GB / 24.59 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0457/735.2, allocations: 14.75 MB / 97.16 GB, free: 1.519 GB / 24.59 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.02901/735.2, allocations: 0.8164 MB / 97.16 GB, free: 1.518 GB / 24.59 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0527/735.3, allocations: 1.614 MB / 97.16 GB, free: 1.517 GB / 24.59 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.009696/735.3, allocations: 5.841 MB / 97.16 GB, free: 1.511 GB / 24.59 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.1727/735.5, allocations: 73.48 MB / 97.24 GB, free: 1.441 GB / 24.59 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.1009/735.6, allocations: 73.5 MB / 97.31 GB, free: 1.369 GB / 24.59 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.02449/735.6, allocations: 17.87 MB / 97.32 GB, free: 1.351 GB / 24.59 GB
Notification: Performance of sorting global known variables: time 0.09205/735.7, allocations: 57.74 MB / 97.38 GB, free: 1.295 GB / 24.59 GB
Notification: Performance of Backend: time 7.81e-07/735.7, allocations: 0 / 97.38 GB, free: 1.295 GB / 24.59 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.5005/736.2, allocations: 303.1 MB / 97.68 GB, free: 0.9955 GB / 24.59 GB
Warning: The hideResult annotation could not be evaluated, probably due to missing annotation(Evaluate=true). It is removed.
Notification: Performance of SimCode: time 0.258/736.5, allocations: 229.4 MB / 97.9 GB, free: 0.7716 GB / 24.59 GB
Notification: Performance of Templates: time 1.271/737.7, allocations: 1.96 GB / 99.86 GB, free: 11.88 MB / 25.81 GB
make -j1 -f ScalableTestGrids_NumericalJacobian_ScalableTestGrids.Models.Type1.Type1_reduced_N_3_M_4.makefile
(rm -f ScalableTestGrids_NumericalJacobian_ScalableTestGrids.Models.Type1.Type1_reduced_N_3_M_4.pipe ; mkfifo ScalableTestGrids_NumericalJacobian_ScalableTestGrids.Models.Type1.Type1_reduced_N_3_M_4.pipe ; head -c 1048576 < ScalableTestGrids_NumericalJacobian_ScalableTestGrids.Models.Type1.Type1_reduced_N_3_M_4.pipe >> ../files/ScalableTestGrids_NumericalJacobian_ScalableTestGrids.Models.Type1.Type1_reduced_N_3_M_4.sim & ./ScalableTestGrids_NumericalJacobian_ScalableTestGrids.Models.Type1.Type1_reduced_N_3_M_4  -nls=kinsol -lv=LOG_STATS -abortSlowSimulation -alarm=300 -lv LOG_STATS > ScalableTestGrids_NumericalJacobian_ScalableTestGrids.Models.Type1.Type1_reduced_N_3_M_4.pipe 2>&1)