Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1_N_4_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_4_M_4,tolerance=0.0001,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1_N_4_M_4")
translateModel(ScalableTestGrids.Models.Type1_N_4_M_4,tolerance=0.0001,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1_N_4_M_4")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo): time 0.001188/0.001188, allocations: 190.4 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.254/1.254, allocations: 205.1 MB / 223.1 MB, free: 8.461 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.001113/0.001113, allocations: 115.9 kB / 270.5 MB, free: 8.426 MB / 218.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 1.0.2/package.mo): time 0.05719/0.05719, allocations: 14.18 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.442/2.442, allocations: 418.5 MB / 0.7826 GB, free: 13.89 MB / 0.5575 GB
Notification: Performance of FrontEnd - loaded program: time 0.001178/0.001179, allocations: 65.89 kB / 0.9536 GB, free: 74.52 MB / 0.714 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.2746/0.2758, allocations: 160.9 MB / 1.111 GB, free: 6.645 MB / 0.7765 GB
Notification: Performance of NFInst.instantiate(ScalableTestGrids.Models.Type1_N_4_M_4): time 4.119/4.394, allocations: 1.441 GB / 2.552 GB, free: 15.66 MB / 1.636 GB
Notification: Performance of NFInst.instExpressions: time 0.8316/5.226, allocations: 0.4926 GB / 3.045 GB, free: 11.39 MB / 1.84 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.3819/5.608, allocations: 5.224 MB / 3.05 GB, free: 6.141 MB / 1.84 GB
Notification: Performance of NFTyping.typeComponents: time 0.3002/5.908, allocations: 64.41 MB / 3.113 GB, free: 10.63 MB / 1.902 GB
Notification: Performance of NFTyping.typeBindings: time 1.9/7.809, allocations: 176.4 MB / 3.285 GB, free: 31.94 MB / 1.98 GB
Notification: Performance of NFTyping.typeClassSections: time 0.1937/8.002, allocations: 49.12 MB / 3.333 GB, free: 30.41 MB / 1.98 GB
Notification: Performance of NFFlatten.flatten: time 0.7534/8.756, allocations: 489.2 MB / 3.811 GB, free: 2.199 MB / 2.136 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.1888/8.945, allocations: 48.6 MB / 3.858 GB, free: 4.43 MB / 2.183 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.3212/9.266, allocations: 125.8 MB / 3.981 GB, free: 13.5 MB / 2.308 GB
Notification: Performance of NFSimplifyModel.simplify: time 3.09/12.36, allocations: 142.8 MB / 4.121 GB, free: 83.93 MB / 2.309 GB
Notification: Performance of NFPackage.collectConstants: time 0.1038/12.46, allocations: 8.796 MB / 4.129 GB, free: 83.93 MB / 2.309 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.2459/12.71, allocations: 21.93 MB / 4.151 GB, free: 83.93 MB / 2.309 GB
Notification: Performance of NFScalarize.scalarize: time 0.1048/12.81, allocations: 34.51 MB / 4.184 GB, free: 78.44 MB / 2.309 GB
Notification: Performance of NFVerifyModel.verify: time 0.3594/13.17, allocations: 131.1 MB / 4.312 GB, free: 40.21 MB / 2.309 GB
Notification: Performance of NFConvertDAE.convert: time 0.5438/13.71, allocations: 323.1 MB / 4.628 GB, free: 9.992 MB / 2.387 GB
Notification: Performance of FrontEnd - DAE generated: time 8.556e-06/13.71, allocations: 0 / 4.628 GB, free: 9.992 MB / 2.387 GB
Notification: Performance of FrontEnd: time 2.024e-06/13.71, allocations: 0 / 4.628 GB, free: 9.992 MB / 2.387 GB
Notification: Performance of Transformations before backend: time 0.01343/13.73, allocations: 0 / 4.628 GB, free: 9.992 MB / 2.387 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 51078
 * Number of variables: 51078
Notification: Performance of Generate backend data structure: time 2.335/16.06, allocations: 352.9 MB / 4.972 GB, free: 1.054 GB / 2.544 GB
Notification: Performance of prepare preOptimizeDAE: time 5.222e-05/16.06, allocations: 7.844 kB / 4.972 GB, free: 1.054 GB / 2.544 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.2039/16.27, allocations: 38.17 MB / 5.01 GB, free: 1.04 GB / 2.544 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.4391/16.71, allocations: 144.3 MB / 5.151 GB, free: 0.9664 GB / 2.544 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.01849/16.72, allocations: 14.93 MB / 5.165 GB, free: 0.9597 GB / 2.544 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.07295/16.8, allocations: 19.7 MB / 5.184 GB, free: 0.9532 GB / 2.544 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.5666/17.36, allocations: 206.9 MB / 5.386 GB, free: 0.8242 GB / 2.544 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.01081/17.37, allocations: 426.9 kB / 5.387 GB, free: 0.8238 GB / 2.544 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.05681/17.43, allocations: 8.066 MB / 5.395 GB, free: 0.8159 GB / 2.544 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.003479/17.43, allocations: 4.84 MB / 5.399 GB, free: 0.8112 GB / 2.544 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.4784/17.91, allocations: 196.2 MB / 5.591 GB, free: 0.6196 GB / 2.544 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 3.293/21.21, allocations: 1.257 GB / 6.848 GB, free: 403.9 MB / 2.544 GB
Notification: Performance of preOpt comSubExp (simulation): time 2.844/24.05, allocations: 0.6257 GB / 7.473 GB, free: 0.8094 GB / 2.544 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.2951/24.35, allocations: 94.36 MB / 7.566 GB, free: 0.8078 GB / 2.544 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.03225/24.38, allocations: 2.387 MB / 7.568 GB, free: 0.8076 GB / 2.544 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.005007/24.38, allocations: 2.182 MB / 7.57 GB, free: 0.8074 GB / 2.544 GB
Notification: Performance of pre-optimization done (n=21307): time 0.002058/24.38, allocations: 0 / 7.57 GB, free: 0.8074 GB / 2.544 GB
Notification: Performance of matching and sorting (n=21339): time 3.066/27.45, allocations: 479.7 MB / 8.039 GB, free: 0.9512 GB / 2.544 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.003056/27.45, allocations: 5.432 MB / 8.044 GB, free: 0.947 GB / 2.544 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.32/27.77, allocations: 123.8 MB / 8.165 GB, free: 0.9405 GB / 2.544 GB
Notification: Performance of collectPreVariables (initialization): time 0.04306/27.82, allocations: 3.629 MB / 8.168 GB, free: 0.9391 GB / 2.544 GB
Notification: Performance of collectInitialEqns (initialization): time 0.1118/27.93, allocations: 100.3 MB / 8.266 GB, free: 0.8885 GB / 2.544 GB
Notification: Performance of collectInitialBindings (initialization): time 0.1448/28.07, allocations: 74.14 MB / 8.339 GB, free: 0.8324 GB / 2.544 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.2195/28.29, allocations: 38.44 MB / 8.376 GB, free: 0.8139 GB / 2.544 GB
Notification: Performance of setup shared object (initialization): time 7.398e-05/28.29, allocations: 302.5 kB / 8.377 GB, free: 0.8136 GB / 2.544 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.2093/28.5, allocations: 71.44 MB / 8.446 GB, free: 0.7816 GB / 2.544 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.2631/28.77, allocations: 116.2 MB / 8.56 GB, free: 0.6958 GB / 2.544 GB
Notification: Performance of analyzeInitialSystem (initialization): time 2.498/31.26, allocations: 193.3 MB / 8.748 GB, free: 0.8795 GB / 2.544 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.00376/31.27, allocations: 311.2 kB / 8.749 GB, free: 0.8795 GB / 2.544 GB
Notification: Performance of matching and sorting (n=30657) (initialization): time 0.9921/32.26, allocations: 305.8 MB / 9.047 GB, free: 0.8205 GB / 2.544 GB
Notification: Performance of prepare postOptimizeDAE: time 0.003148/32.26, allocations: 471.8 kB / 9.048 GB, free: 0.8205 GB / 2.544 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0043/32.27, allocations: 1.065 MB / 9.049 GB, free: 0.8205 GB / 2.544 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.6546/32.92, allocations: 136.7 MB / 9.182 GB, free: 0.7787 GB / 2.544 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.1724/33.1, allocations: 42.95 MB / 9.224 GB, free: 0.7366 GB / 2.544 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 3.975/37.07, allocations: 1.015 GB / 10.24 GB, free: 476.6 MB / 2.544 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.2192/37.29, allocations: 11.6 MB / 10.25 GB, free: 470.1 MB / 2.544 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0478/37.34, allocations: 8.238 MB / 10.26 GB, free: 461.8 MB / 2.544 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.2751/37.61, allocations: 93.03 MB / 10.35 GB, free: 368.8 MB / 2.544 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 1.722/39.34, allocations: 112.3 MB / 10.46 GB, free: 0.7387 GB / 2.544 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 1.007/40.34, allocations: 188.1 MB / 10.64 GB, free: 0.6775 GB / 2.544 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 0.002637/40.35, allocations: 311.8 kB / 10.64 GB, free: 0.6775 GB / 2.544 GB
Notification: Performance of matching and sorting (n=30657) (initialization_lambda0): time 0.8614/41.21, allocations: 278.7 MB / 10.92 GB, free: 0.5754 GB / 2.544 GB
Notification: Performance of prepare postOptimizeDAE: time 0.002318/41.21, allocations: 475.7 kB / 10.92 GB, free: 0.5754 GB / 2.544 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.003014/41.21, allocations: 1.061 MB / 10.92 GB, free: 0.5754 GB / 2.544 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.5825/41.8, allocations: 119.4 MB / 11.03 GB, free: 489.2 MB / 2.544 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.187/41.98, allocations: 45.31 MB / 11.08 GB, free: 443.8 MB / 2.544 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 3.52/45.5, allocations: 0.8635 GB / 11.94 GB, free: 281.6 MB / 2.544 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.2257/45.73, allocations: 10.26 MB / 11.95 GB, free: 276 MB / 2.544 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.05037/45.78, allocations: 8.194 MB / 11.96 GB, free: 274 MB / 2.544 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 4975
 * Number of states: 0 ()
 * Number of discrete variables: 160 (GEN_8_4.PSS.firstWashoutVsi2.integrator.local_reset,GEN_8_4.PSS.secondWashoutVsi1.integrator.local_reset,GEN_8_4.PSS.firstWashoutVsi1.integrator.local_reset,GEN_8_4.AVR.firstOrderLim.I.local_reset,GEN_8_4.TGOV.firstOrderLim.I.local_reset,GEN_8_3.PSS.firstWashoutVsi2.integrator.local_reset,GEN_8_3.PSS.secondWashoutVsi1.integrator.local_reset,GEN_8_3.PSS.firstWashoutVsi1.integrator.local_reset,GEN_8_3.AVR.firstOrderLim.I.local_reset,GEN_8_3.TGOV.firstOrderLim.I.local_reset,GEN_8_2.PSS.firstWashoutVsi2.integrator.local_reset,GEN_8_2.PSS.secondWashoutVsi1.integrator.local_reset,GEN_8_2.PSS.firstWashoutVsi1.integrator.local_reset,GEN_8_2.AVR.firstOrderLim.I.local_reset,GEN_8_2.TGOV.firstOrderLim.I.local_reset,GEN_8_1.PSS.firstWashoutVsi2.integrator.local_reset,GEN_8_1.PSS.secondWashoutVsi1.integrator.local_reset,GEN_8_1.PSS.firstWashoutVsi1.integrator.local_reset,GEN_8_1.AVR.firstOrderLim.I.local_reset,GEN_8_1.TGOV.firstOrderLim.I.local_reset,GEN_7_4.PSS.firstWashoutVsi2.integrator.local_reset,GEN_7_4.PSS.secondWashoutVsi1.integrator.local_reset,GEN_7_4.PSS.firstWashoutVsi1.integrator.local_reset,GEN_7_4.AVR.firstOrderLim.I.local_reset,GEN_7_4.TGOV.firstOrderLim.I.local_reset,GEN_7_3.PSS.firstWashoutVsi2.integrator.local_reset,GEN_7_3.PSS.secondWashoutVsi1.integrator.local_reset,GEN_7_3.PSS.firstWashoutVsi1.integrator.local_reset,GEN_7_3.AVR.firstOrderLim.I.local_reset,GEN_7_3.TGOV.firstOrderLim.I.local_reset,GEN_7_2.PSS.firstWashoutVsi2.integrator.local_reset,GEN_7_2.PSS.secondWashoutVsi1.integrator.local_reset,GEN_7_2.PSS.firstWashoutVsi1.integrator.local_reset,GEN_7_2.AVR.firstOrderLim.I.local_reset,GEN_7_2.TGOV.firstOrderLim.I.local_reset,GEN_7_1.PSS.firstWashoutVsi2.integrator.local_reset,GEN_7_1.PSS.secondWashoutVsi1.integrator.local_reset,GEN_7_1.PSS.firstWashoutVsi1.integrator.local_reset,GEN_7_1.AVR.firstOrderLim.I.local_reset,GEN_7_1.TGOV.firstOrderLim.I.local_reset,GEN_6_4.PSS.firstWashoutVsi2.integrator.local_reset,GEN_6_4.PSS.secondWashoutVsi1.integrator.local_reset,GEN_6_4.PSS.firstWashoutVsi1.integrator.local_reset,GEN_6_4.AVR.firstOrderLim.I.local_reset,GEN_6_4.TGOV.firstOrderLim.I.local_reset,GEN_6_3.PSS.firstWashoutVsi2.integrator.local_reset,GEN_6_3.PSS.secondWashoutVsi1.integrator.local_reset,GEN_6_3.PSS.firstWashoutVsi1.integrator.local_reset,GEN_6_3.AVR.firstOrderLim.I.local_reset,GEN_6_3.TGOV.firstOrderLim.I.local_reset,GEN_6_2.PSS.firstWashoutVsi2.integrator.local_reset,GEN_6_2.PSS.secondWashoutVsi1.integrator.local_reset,GEN_6_2.PSS.firstWashoutVsi1.integrator.local_reset,GEN_6_2.AVR.firstOrderLim.I.local_reset,GEN_6_2.TGOV.firstOrderLim.I.local_reset,GEN_6_1.PSS.firstWashoutVsi2.integrator.local_reset,GEN_6_1.PSS.secondWashoutVsi1.integrator.local_reset,GEN_6_1.PSS.firstWashoutVsi1.integrator.local_reset,GEN_6_1.AVR.firstOrderLim.I.local_reset,GEN_6_1.TGOV.firstOrderLim.I.local_reset,GEN_5_4.PSS.firstWashoutVsi2.integrator.local_reset,GEN_5_4.PSS.secondWashoutVsi1.integrator.local_reset,GEN_5_4.PSS.firstWashoutVsi1.integrator.local_reset,GEN_5_4.AVR.firstOrderLim.I.local_reset,GEN_5_4.TGOV.firstOrderLim.I.local_reset,GEN_5_3.PSS.firstWashoutVsi2.integrator.local_reset,GEN_5_3.PSS.secondWashoutVsi1.integrator.local_reset,GEN_5_3.PSS.firstWashoutVsi1.integrator.local_reset,GEN_5_3.AVR.firstOrderLim.I.local_reset,GEN_5_3.TGOV.firstOrderLim.I.local_reset,GEN_5_2.PSS.firstWashoutVsi2.integrator.local_reset,GEN_5_2.PSS.secondWashoutVsi1.integrator.local_reset,GEN_5_2.PSS.firstWashoutVsi1.integrator.local_reset,GEN_5_2.AVR.firstOrderLim.I.local_reset,GEN_5_2.TGOV.firstOrderLim.I.local_reset,GEN_5_1.PSS.firstWashoutVsi2.integrator.local_reset,GEN_5_1.PSS.secondWashoutVsi1.integrator.local_reset,GEN_5_1.PSS.firstWashoutVsi1.integrator.local_reset,GEN_5_1.AVR.firstOrderLim.I.local_reset,GEN_5_1.TGOV.firstOrderLim.I.local_reset,GEN_4_4.PSS.firstWashoutVsi2.integrator.local_reset,GEN_4_4.PSS.secondWashoutVsi1.integrator.local_reset,GEN_4_4.PSS.firstWashoutVsi1.integrator.local_reset,GEN_4_4.AVR.firstOrderLim.I.local_reset,GEN_4_4.TGOV.firstOrderLim.I.local_reset,GEN_4_3.PSS.firstWashoutVsi2.integrator.local_reset,GEN_4_3.PSS.secondWashoutVsi1.integrator.local_reset,GEN_4_3.PSS.firstWashoutVsi1.integrator.local_reset,GEN_4_3.AVR.firstOrderLim.I.local_reset,GEN_4_3.TGOV.firstOrderLim.I.local_reset,GEN_4_2.PSS.firstWashoutVsi2.integrator.local_reset,GEN_4_2.PSS.secondWashoutVsi1.integrator.local_reset,GEN_4_2.PSS.firstWashoutVsi1.integrator.local_reset,GEN_4_2.AVR.firstOrderLim.I.local_reset,GEN_4_2.TGOV.firstOrderLim.I.local_reset,GEN_4_1.PSS.firstWashoutVsi2.integrator.local_reset,GEN_4_1.PSS.secondWashoutVsi1.integrator.local_reset,GEN_4_1.PSS.firstWashoutVsi1.integrator.local_reset,GEN_4_1.AVR.firstOrderLim.I.local_reset,GEN_4_1.TGOV.firstOrderLim.I.local_reset,GEN_3_4.PSS.firstWashoutVsi2.integrator.local_reset,GEN_3_4.PSS.secondWashoutVsi1.integrator.local_reset,GEN_3_4.PSS.firstWashoutVsi1.integrator.local_reset,GEN_3_4.AVR.firstOrderLim.I.local_reset,GEN_3_4.TGOV.firstOrderLim.I.local_reset,GEN_3_3.PSS.firstWashoutVsi2.integrator.local_reset,GEN_3_3.PSS.secondWashoutVsi1.integrator.local_reset,GEN_3_3.PSS.firstWashoutVsi1.integrator.local_reset,GEN_3_3.AVR.firstOrderLim.I.local_reset,GEN_3_3.TGOV.firstOrderLim.I.local_reset,GEN_3_2.PSS.firstWashoutVsi2.integrator.local_reset,GEN_3_2.PSS.secondWashoutVsi1.integrator.local_reset,GEN_3_2.PSS.firstWashoutVsi1.integrator.local_reset,GEN_3_2.AVR.firstOrderLim.I.local_reset,GEN_3_2.TGOV.firstOrderLim.I.local_reset,GEN_3_1.PSS.firstWashoutVsi2.integrator.local_reset,GEN_3_1.PSS.secondWashoutVsi1.integrator.local_reset,GEN_3_1.PSS.firstWashoutVsi1.integrator.local_reset,GEN_3_1.AVR.firstOrderLim.I.local_reset,GEN_3_1.TGOV.firstOrderLim.I.local_reset,GEN_2_4.PSS.firstWashoutVsi2.integrator.local_reset,GEN_2_4.PSS.secondWashoutVsi1.integrator.local_reset,GEN_2_4.PSS.firstWashoutVsi1.integrator.local_reset,GEN_2_4.AVR.firstOrderLim.I.local_reset,GEN_2_4.TGOV.firstOrderLim.I.local_reset,GEN_2_3.PSS.firstWashoutVsi2.integrator.local_reset,GEN_2_3.PSS.secondWashoutVsi1.integrator.local_reset,GEN_2_3.PSS.firstWashoutVsi1.integrator.local_reset,GEN_2_3.AVR.firstOrderLim.I.local_reset,GEN_2_3.TGOV.firstOrderLim.I.local_reset,GEN_2_2.PSS.firstWashoutVsi2.integrator.local_reset,GEN_2_2.PSS.secondWashoutVsi1.integrator.local_reset,GEN_2_2.PSS.firstWashoutVsi1.integrator.local_reset,GEN_2_2.AVR.firstOrderLim.I.local_reset,GEN_2_2.TGOV.firstOrderLim.I.local_reset,GEN_2_1.PSS.firstWashoutVsi2.integrator.local_reset,GEN_2_1.PSS.secondWashoutVsi1.integrator.local_reset,GEN_2_1.PSS.firstWashoutVsi1.integrator.local_reset,GEN_2_1.AVR.firstOrderLim.I.local_reset,GEN_2_1.TGOV.firstOrderLim.I.local_reset,GEN_1_4.PSS.firstWashoutVsi2.integrator.local_reset,GEN_1_4.PSS.secondWashoutVsi1.integrator.local_reset,GEN_1_4.PSS.firstWashoutVsi1.integrator.local_reset,GEN_1_4.AVR.firstOrderLim.I.local_reset,GEN_1_4.TGOV.firstOrderLim.I.local_reset,GEN_1_3.PSS.firstWashoutVsi2.integrator.local_reset,GEN_1_3.PSS.secondWashoutVsi1.integrator.local_reset,GEN_1_3.PSS.firstWashoutVsi1.integrator.local_reset,GEN_1_3.AVR.firstOrderLim.I.local_reset,GEN_1_3.TGOV.firstOrderLim.I.local_reset,GEN_1_2.PSS.firstWashoutVsi2.integrator.local_reset,GEN_1_2.PSS.secondWashoutVsi1.integrator.local_reset,GEN_1_2.PSS.firstWashoutVsi1.integrator.local_reset,GEN_1_2.AVR.firstOrderLim.I.local_reset,GEN_1_2.TGOV.firstOrderLim.I.local_reset,GEN_1_1.PSS.firstWashoutVsi2.integrator.local_reset,GEN_1_1.PSS.secondWashoutVsi1.integrator.local_reset,GEN_1_1.PSS.firstWashoutVsi1.integrator.local_reset,GEN_1_1.AVR.firstOrderLim.I.local_reset,GEN_1_1.TGOV.firstOrderLim.I.local_reset)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (23457):
 * Single equations (assignments): 23167
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 290
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 128 systems
   {(2,0,100.0%), (2,0,100.0%), (3,0,66.7%), (3,0,66.7%), (2,0,100.0%), (2,0,100.0%), (3,0,66.7%), (3,0,66.7%), (2,0,100.0%), (2,0,100.0%), (3,0,66.7%), (3,0,66.7%), (2,0,100.0%), (2,0,100.0%), (3,0,66.7%), (3,0,66.7%), (2,0,100.0%), (2,0,100.0%), (3,0,66.7%), (3,0,66.7%), (2,0,100.0%), (2,0,100.0%), (3,0,66.7%), (3,0,66.7%), (2,0,100.0%), (2,0,100.0%), (3,0,66.7%), (3,0,66.7%), (2,0,100.0%), (2,0,100.0%), (3,0,66.7%), (3,0,66.7%), (2,0,100.0%), (2,0,100.0%), (3,0,66.7%), (3,0,66.7%), (2,0,100.0%), (2,0,100.0%), (3,0,66.7%), (3,0,66.7%), (2,0,100.0%), (2,0,100.0%), (3,0,66.7%), (3,0,66.7%), (2,0,100.0%), (2,0,100.0%), (3,0,66.7%), (3,0,66.7%), (2,0,100.0%), (2,0,100.0%), (3,0,66.7%), (3,0,66.7%), (2,0,100.0%), (2,0,100.0%), (3,0,66.7%), (3,0,66.7%), (2,0,100.0%), (2,0,100.0%), (3,0,66.7%), (3,0,66.7%), (2,0,100.0%), (2,0,100.0%), (3,0,66.7%), (3,0,66.7%), (2,0,100.0%), (2,0,100.0%), (3,0,66.7%), (3,0,66.7%), (2,0,100.0%), (2,0,100.0%), (3,0,66.7%), (3,0,66.7%), (2,0,100.0%), (2,0,100.0%), (3,0,66.7%), (3,0,66.7%), (2,0,100.0%), (2,0,100.0%), (3,0,66.7%), (3,0,66.7%), (2,0,100.0%), (2,0,100.0%), (3,0,66.7%), (3,0,66.7%), (2,0,100.0%), (2,0,100.0%), (3,0,66.7%), (3,0,66.7%), (2,0,100.0%), (2,0,100.0%), (3,0,66.7%), (3,0,66.7%), (2,0,100.0%), (2,0,100.0%), (3,0,66.7%), (3,0,66.7%), (2,0,100.0%), (2,0,100.0%), (3,0,66.7%), (3,0,66.7%), (2,0,100.0%), (2,0,100.0%), (3,0,66.7%), (3,0,66.7%), (2,0,100.0%), (2,0,100.0%), (3,0,66.7%), (3,0,66.7%), (2,0,100.0%), (2,0,100.0%), (3,0,66.7%), (3,0,66.7%), (2,0,100.0%), (2,0,100.0%), (3,0,66.7%), (3,0,66.7%), (2,0,100.0%), (2,0,100.0%), (3,0,66.7%), (3,0,66.7%), (2,0,100.0%), (2,0,100.0%), (3,0,66.7%), (3,0,66.7%), (2,0,100.0%), (2,0,100.0%), (3,0,66.7%), (3,0,66.7%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 162 systems
   {(38,0), (6556,0), (2,0), (2,0), (2,0), (2,0), (10,0), (2,0), (2,0), (2,0), (2,0), (10,0), (2,0), (2,0), (2,0), (2,0), (10,0), (2,0), (2,0), (2,0), (2,0), (10,0), (2,0), (2,0), (2,0), (2,0), (10,0), (2,0), (2,0), (2,0), (2,0), (10,0), (2,0), (2,0), (2,0), (2,0), (10,0), (2,0), (2,0), (2,0), (2,0), (10,0), (2,0), (2,0), (2,0), (2,0), (10,0), (2,0), (2,0), (2,0), (2,0), (10,0), (2,0), (2,0), (2,0), (2,0), (10,0), (2,0), (2,0), (2,0), (2,0), (10,0), (2,0), (2,0), (2,0), (2,0), (10,0), (2,0), (2,0), (2,0), (2,0), (10,0), (2,0), (2,0), (2,0), (2,0), (10,0), (2,0), (2,0), (2,0), (2,0), (10,0), (2,0), (2,0), (2,0), (2,0), (10,0), (2,0), (2,0), (2,0), (2,0), (10,0), (2,0), (2,0), (2,0), (2,0), (10,0), (2,0), (2,0), (2,0), (2,0), (10,0), (2,0), (2,0), (2,0), (2,0), (10,0), (2,0), (2,0), (2,0), (2,0), (10,0), (2,0), (2,0), (2,0), (2,0), (10,0), (2,0), (2,0), (2,0), (2,0), (10,0), (2,0), (2,0), (2,0), (2,0), (10,0), (2,0), (2,0), (2,0), (2,0), (10,0), (2,0), (2,0), (2,0), (2,0), (10,0), (2,0), (2,0), (2,0), (2,0), (10,0), (2,0), (2,0), (2,0), (2,0), (10,0), (2,0), (2,0), (2,0), (2,0), (10,0), (2,0), (2,0), (2,0), (2,0), (10,0), (2,0), (2,0), (2,0), (2,0), (10,0)}
Notification: Performance of prepare postOptimizeDAE: time 0.1043/45.88, allocations: 12.85 MB / 11.97 GB, free: 265.6 MB / 2.544 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.093/45.98, allocations: 20.2 MB / 11.99 GB, free: 255.3 MB / 2.544 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 2.385/48.36, allocations: 231.8 MB / 12.22 GB, free: 0.6423 GB / 2.544 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.007867/48.37, allocations: 0.9795 MB / 12.22 GB, free: 0.6423 GB / 2.544 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 0.0011/48.37, allocations: 0.6562 kB / 12.22 GB, free: 0.6423 GB / 2.544 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.1637/48.53, allocations: 33.93 MB / 12.25 GB, free: 0.6421 GB / 2.544 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.07486/48.61, allocations: 3.47 MB / 12.26 GB, free: 0.6421 GB / 2.544 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.1706/48.78, allocations: 7.936 MB / 12.26 GB, free: 0.6421 GB / 2.544 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.06555/48.84, allocations: 17.01 MB / 12.28 GB, free: 0.6419 GB / 2.544 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.9322/49.78, allocations: 214.7 MB / 12.49 GB, free: 0.5848 GB / 2.544 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 4.727/54.5, allocations: 0.9766 GB / 13.47 GB, free: 422.2 MB / 2.544 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.2038/54.71, allocations: 67.52 MB / 13.53 GB, free: 386.3 MB / 2.544 GB
Notification: Performance of sorting global known variables: time 0.1954/54.9, allocations: 79.51 MB / 13.61 GB, free: 341.1 MB / 2.544 GB
Notification: Performance of Backend: time 1.213e-06/54.9, allocations: 0 / 13.61 GB, free: 341.1 MB / 2.544 GB
Notification: Performance of simCode: created initialization part: time 2.871/57.77, allocations: 0.5098 GB / 14.12 GB, free: 469.3 MB / 2.544 GB
Warning: The hideResult annotation could not be evaluated, probably due to missing annotation(Evaluate=true). It is removed.
Notification: Performance of SimCode: time 3.418/61.19, allocations: 0.7527 GB / 14.87 GB, free: 468.4 MB / 2.544 GB
Notification: Performance of Templates: time 15.31/76.5, allocations: 4.381 GB / 19.25 GB, free: 291.8 MB / 2.809 GB
make -j1 -f ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1_N_4_M_4.makefile
(rm -f ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1_N_4_M_4.pipe ; mkfifo ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1_N_4_M_4.pipe ; head -c 1048576 < ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1_N_4_M_4.pipe >> ../files/ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1_N_4_M_4.sim & ./ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1_N_4_M_4  -nls=kinsol -lv=LOG_STATS -abortSlowSimulation -alarm=500 -lv LOG_STATS > ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1_N_4_M_4.pipe 2>&1)