Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1.Type1_N_1_M_2.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/package.mo", uses=false)
Using package ScalableTestGrids with version 1.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ScalableTestGrids 1.1.0/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_1_M_2,tolerance=0.0001,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1.Type1_N_1_M_2")
translateModel(ScalableTestGrids.Models.Type1.Type1_N_1_M_2,tolerance=0.0001,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1.Type1_N_1_M_2")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001764/0.001772, allocations: 116.2 kB / 17.74 MB, free: 5.359 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.001861/0.001862, allocations: 183.8 kB / 18.67 MB, free: 4.434 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.708/1.708, allocations: 205.1 MB / 224.5 MB, free: 12.25 MB / 190.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 1.0.3/package.mo): time 0.0671/0.0671, allocations: 14.17 MB / 286.1 MB, free: 13.86 MB / 238.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ScalableTestGrids 1.1.0/package.mo): time 3.756/3.756, allocations: 418.6 MB / 0.7378 GB, free: 5.129 MB / 0.5764 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.002063/0.002063, allocations: 88.84 kB / 1.067 GB, free: 14.48 MB / 0.8579 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 1.673/1.675, allocations: 160.9 MB / 1.224 GB, free: 480 kB / 0.9053 GB
Notification: Performance of NFInst.instantiate(ScalableTestGrids.Models.Type1.Type1_N_1_M_2): time 0.06069/1.736, allocations: 63.82 MB / 1.287 GB, free: 412 kB / 0.9678 GB
Notification: Performance of NFInst.instExpressions: time 0.05504/1.791, allocations: 23.28 MB / 1.309 GB, free: 9.047 MB / 0.999 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.01796/1.809, allocations: 234.9 kB / 1.31 GB, free: 8.816 MB / 0.999 GB
Notification: Performance of NFTyping.typeComponents: time 0.01432/1.823, allocations: 3.322 MB / 1.313 GB, free: 5.473 MB / 0.999 GB
Notification: Performance of NFTyping.typeBindings: time 0.04094/1.864, allocations: 9.406 MB / 1.322 GB, free: 12.03 MB / 1.015 GB
Notification: Performance of NFTyping.typeClassSections: time 0.01252/1.877, allocations: 3.269 MB / 1.325 GB, free: 8.758 MB / 1.015 GB
Notification: Performance of NFFlatten.flatten: time 0.03893/1.916, allocations: 21.26 MB / 1.346 GB, free: 3.426 MB / 1.03 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.006258/1.922, allocations: 2.511 MB / 1.348 GB, free: 0.8359 MB / 1.03 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.0175/1.94, allocations: 7.149 MB / 1.355 GB, free: 9.66 MB / 1.046 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.01903/1.959, allocations: 7.567 MB / 1.363 GB, free: 2.062 MB / 1.046 GB
Notification: Performance of NFPackage.collectConstants: time 0.006331/1.965, allocations: 1.047 MB / 1.364 GB, free: 1.016 MB / 1.046 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.01232/1.978, allocations: 2.043 MB / 1.366 GB, free: 14.97 MB / 1.062 GB
Notification: Performance of NFScalarize.scalarize: time 0.005469/1.983, allocations: 2.319 MB / 1.368 GB, free: 12.64 MB / 1.062 GB
Notification: Performance of NFVerifyModel.verify: time 0.01946/2.003, allocations: 6.714 MB / 1.375 GB, free: 5.898 MB / 1.062 GB
Notification: Performance of NFConvertDAE.convert: time 0.03948/2.042, allocations: 16.72 MB / 1.391 GB, free: 5.133 MB / 1.077 GB
Notification: Performance of FrontEnd - DAE generated: time 1.095e-05/2.042, allocations: 0 / 1.391 GB, free: 5.133 MB / 1.077 GB
Notification: Performance of FrontEnd: time 4.168e-06/2.042, allocations: 0 / 1.391 GB, free: 5.133 MB / 1.077 GB
Notification: Performance of Transformations before backend: time 0.0009142/2.043, allocations: 0 / 1.391 GB, free: 5.133 MB / 1.077 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 2196
 * Number of variables: 2196
Notification: Performance of Generate backend data structure: time 0.0717/2.115, allocations: 16.24 MB / 1.407 GB, free: 4.773 MB / 1.093 GB
Notification: Performance of prepare preOptimizeDAE: time 6.339e-05/2.115, allocations: 8.031 kB / 1.407 GB, free: 4.766 MB / 1.093 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.00925/2.124, allocations: 1.646 MB / 1.409 GB, free: 3.105 MB / 1.093 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.02034/2.144, allocations: 7.075 MB / 1.415 GB, free: 11.93 MB / 1.108 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0006902/2.145, allocations: 0.6574 MB / 1.416 GB, free: 11.27 MB / 1.108 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.003062/2.148, allocations: 0.867 MB / 1.417 GB, free: 10.41 MB / 1.108 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.01958/2.168, allocations: 8.984 MB / 1.426 GB, free: 1.02 MB / 1.108 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0001292/2.168, allocations: 11.88 kB / 1.426 GB, free: 1.008 MB / 1.108 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0007091/2.169, allocations: 356 kB / 1.426 GB, free: 0.6602 MB / 1.108 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001587/2.169, allocations: 216 kB / 1.426 GB, free: 460 kB / 1.108 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.01849/2.187, allocations: 8.515 MB / 1.435 GB, free: 7.91 MB / 1.124 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 0.1069/2.294, allocations: 57.07 MB / 1.49 GB, free: 9.922 MB / 1.187 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.02058/2.315, allocations: 10.67 MB / 1.501 GB, free: 15.22 MB / 1.202 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.007658/2.323, allocations: 4.02 MB / 1.505 GB, free: 11.18 MB / 1.202 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0004064/2.323, allocations: 107.1 kB / 1.505 GB, free: 11.08 MB / 1.202 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0001014/2.323, allocations: 133.7 kB / 1.505 GB, free: 10.94 MB / 1.202 GB
Notification: Performance of pre-optimization done (n=909): time 1.031e-05/2.323, allocations: 7.938 kB / 1.505 GB, free: 10.93 MB / 1.202 GB
Notification: Performance of matching and sorting (n=909): time 0.02651/2.35, allocations: 12 MB / 1.517 GB, free: 14.91 MB / 1.218 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0002233/2.35, allocations: 352.1 kB / 1.517 GB, free: 14.5 MB / 1.218 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.01283/2.363, allocations: 6.321 MB / 1.523 GB, free: 8.227 MB / 1.218 GB
Notification: Performance of collectPreVariables (initialization): time 0.001997/2.365, allocations: 189.7 kB / 1.523 GB, free: 8.035 MB / 1.218 GB
Notification: Performance of collectInitialEqns (initialization): time 0.00433/2.369, allocations: 4.027 MB / 1.527 GB, free: 3.969 MB / 1.218 GB
Notification: Performance of collectInitialBindings (initialization): time 0.006059/2.375, allocations: 3.142 MB / 1.53 GB, free: 0.7812 MB / 1.218 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.003499/2.379, allocations: 1.729 MB / 1.532 GB, free: 15.04 MB / 1.233 GB
Notification: Performance of setup shared object (initialization): time 0.0001384/2.379, allocations: 305.1 kB / 1.532 GB, free: 14.74 MB / 1.233 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.006906/2.386, allocations: 3.272 MB / 1.535 GB, free: 11.46 MB / 1.233 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.008167/2.394, allocations: 5.27 MB / 1.541 GB, free: 5.461 MB / 1.233 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.01509/2.409, allocations: 8.58 MB / 1.549 GB, free: 12.16 MB / 1.249 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 4.784e-05/2.409, allocations: 16 kB / 1.549 GB, free: 12.15 MB / 1.249 GB
Notification: Performance of matching and sorting (n=1351) (initialization): time 1.046/3.455, allocations: 13.89 MB / 1.563 GB, free: 291.5 MB / 1.249 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001405/3.455, allocations: 26.3 kB / 1.563 GB, free: 291.5 MB / 1.249 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001602/3.456, allocations: 50.78 kB / 1.563 GB, free: 291.5 MB / 1.249 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.03373/3.489, allocations: 6.178 MB / 1.569 GB, free: 291.4 MB / 1.249 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01275/3.502, allocations: 1.947 MB / 1.571 GB, free: 291.3 MB / 1.249 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.08847/3.591, allocations: 58.02 MB / 1.627 GB, free: 254.2 MB / 1.249 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01495/3.606, allocations: 0.8556 MB / 1.628 GB, free: 253.9 MB / 1.249 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.00253/3.608, allocations: 374.3 kB / 1.628 GB, free: 253.8 MB / 1.249 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.01101/3.619, allocations: 4.255 MB / 1.633 GB, free: 251.8 MB / 1.249 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.007304/3.627, allocations: 5.029 MB / 1.637 GB, free: 248 MB / 1.249 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.01312/3.64, allocations: 8.262 MB / 1.646 GB, free: 242.4 MB / 1.249 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 6.094e-05/3.64, allocations: 11.38 kB / 1.646 GB, free: 242.4 MB / 1.249 GB
Notification: Performance of matching and sorting (n=1351) (initialization_lambda0): time 0.03261/3.672, allocations: 12.2 MB / 1.657 GB, free: 236.1 MB / 1.249 GB
Notification: Performance of prepare postOptimizeDAE: time 9.274e-05/3.673, allocations: 28 kB / 1.657 GB, free: 236.1 MB / 1.249 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001085/3.673, allocations: 51.56 kB / 1.658 GB, free: 236.1 MB / 1.249 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.02357/3.696, allocations: 5.107 MB / 1.663 GB, free: 231.6 MB / 1.249 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.009861/3.706, allocations: 2.087 MB / 1.665 GB, free: 229.5 MB / 1.249 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.05473/3.761, allocations: 47.58 MB / 1.711 GB, free: 179.4 MB / 1.249 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01919/3.78, allocations: 0.6578 MB / 1.712 GB, free: 178.8 MB / 1.249 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.003615/3.784, allocations: 368 kB / 1.712 GB, free: 178.5 MB / 1.249 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 215
 * Number of states: 0 ()
 * Number of discrete variables: 10 (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_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 (1061):
 * Single equations (assignments): 1041
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 20
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 8 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%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 12 systems
   {(38,0), (216,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.006235/3.79, allocations: 0.745 MB / 1.713 GB, free: 177.7 MB / 1.249 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.005817/3.796, allocations: 0.9033 MB / 1.714 GB, free: 176.8 MB / 1.249 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.02758/3.824, allocations: 9.959 MB / 1.723 GB, free: 166.8 MB / 1.249 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.000264/3.824, allocations: 39.84 kB / 1.723 GB, free: 166.8 MB / 1.249 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.643e-05/3.824, allocations: 4 kB / 1.723 GB, free: 166.8 MB / 1.249 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.009279/3.833, allocations: 1.856 MB / 1.725 GB, free: 165 MB / 1.249 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.005218/3.839, allocations: 160 kB / 1.725 GB, free: 164.8 MB / 1.249 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.01207/3.851, allocations: 265.6 kB / 1.726 GB, free: 164.6 MB / 1.249 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.003248/3.854, allocations: 0.7245 MB / 1.726 GB, free: 163.8 MB / 1.249 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.03501/3.889, allocations: 9.351 MB / 1.735 GB, free: 154.7 MB / 1.249 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.1293/4.018, allocations: 47.55 MB / 1.782 GB, free: 106.8 MB / 1.249 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.006959/4.025, allocations: 3 MB / 1.785 GB, free: 103.8 MB / 1.249 GB
Notification: Performance of sorting global known variables: time 0.01197/4.037, allocations: 4.066 MB / 1.789 GB, free: 99.79 MB / 1.249 GB
Notification: Performance of Backend: time 1.713e-06/4.037, allocations: 0 / 1.789 GB, free: 99.79 MB / 1.249 GB
Notification: Performance of simCode: created initialization part: time 0.07178/4.109, allocations: 24.71 MB / 1.813 GB, free: 74.62 MB / 1.249 GB
Notification: Performance of SimCode: time 0.06889/4.178, allocations: 29.88 MB / 1.842 GB, free: 44.62 MB / 1.249 GB
Notification: Performance of Templates: time 0.4311/4.609, allocations: 216.8 MB / 2.054 GB, free: 3.711 MB / 1.421 GB
make -j1 -f ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1.Type1_N_1_M_2.makefile
(rm -f ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1.Type1_N_1_M_2.pipe ; mkfifo ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1.Type1_N_1_M_2.pipe ; head -c 1048576 < ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1.Type1_N_1_M_2.pipe >> ../files/ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1.Type1_N_1_M_2.sim & ./ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1.Type1_N_1_M_2  -nls=kinsol -lv=LOG_STATS -abortSlowSimulation -alarm=480 -lv LOG_STATS > ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1.Type1_N_1_M_2.pipe 2>&1)