Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1.Type1_N_1_M_1.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.2/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.2 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 1.0.2/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_1,tolerance=0.0001,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1.Type1_N_1_M_1")
translateModel(ScalableTestGrids.Models.Type1.Type1_N_1_M_1,tolerance=0.0001,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1.Type1_N_1_M_1")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001431/0.001431, allocations: 107.3 kB / 17.29 MB, free: 6.195 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.001609/0.00161, allocations: 194 kB / 18.21 MB, free: 5.27 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.404/1.404, allocations: 205.1 MB / 224.1 MB, free: 12.43 MB / 190.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 1.0.2/package.mo): time 0.05964/0.05964, allocations: 14.16 MB / 285.6 MB, free: 14.09 MB / 238.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ScalableTestGrids 1.1.0/package.mo): time 2.723/2.723, allocations: 418.6 MB / 0.7373 GB, free: 5.328 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: Performance of FrontEnd - loaded program: time 0.001699/0.001699, allocations: 83.86 kB / 0.9083 GB, free: 1.223 MB / 0.686 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.3246/0.3263, allocations: 160.9 MB / 1.065 GB, free: 104 kB / 0.8423 GB
Notification: Performance of NFInst.instantiate(ScalableTestGrids.Models.Type1.Type1_N_1_M_1): time 0.8558/1.182, allocations: 56.31 MB / 1.12 GB, free: 18.77 MB / 0.8584 GB
Notification: Performance of NFInst.instExpressions: time 0.03735/1.22, allocations: 20.57 MB / 1.14 GB, free: 3.68 MB / 0.8584 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.01676/1.236, allocations: 222.4 kB / 1.141 GB, free: 3.613 MB / 0.8584 GB
Notification: Performance of NFTyping.typeComponents: time 0.01086/1.247, allocations: 2.424 MB / 1.143 GB, free: 2.559 MB / 0.8584 GB
Notification: Performance of NFTyping.typeBindings: time 0.02694/1.274, allocations: 6.977 MB / 1.15 GB, free: 13.66 MB / 0.874 GB
Notification: Performance of NFTyping.typeClassSections: time 0.01027/1.285, allocations: 2.888 MB / 1.153 GB, free: 11.64 MB / 0.874 GB
Notification: Performance of NFFlatten.flatten: time 0.03684/1.321, allocations: 19.31 MB / 1.172 GB, free: 2 MB / 0.874 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.008064/1.33, allocations: 2.363 MB / 1.174 GB, free: 0.8477 MB / 0.874 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.01416/1.344, allocations: 5.628 MB / 1.179 GB, free: 13.46 MB / 0.8896 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.01386/1.358, allocations: 5.987 MB / 1.185 GB, free: 9.336 MB / 0.8896 GB
Notification: Performance of NFPackage.collectConstants: time 0.004254/1.362, allocations: 0.8326 MB / 1.186 GB, free: 9.332 MB / 0.8896 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.00961/1.372, allocations: 1.708 MB / 1.188 GB, free: 9.148 MB / 0.8896 GB
Notification: Performance of NFScalarize.scalarize: time 0.003946/1.376, allocations: 1.873 MB / 1.19 GB, free: 7.5 MB / 0.8896 GB
Notification: Performance of NFVerifyModel.verify: time 0.01459/1.39, allocations: 5.71 MB / 1.195 GB, free: 3.41 MB / 0.8896 GB
Notification: Performance of NFConvertDAE.convert: time 0.02647/1.417, allocations: 13.56 MB / 1.208 GB, free: 9.621 MB / 0.9053 GB
Notification: Performance of FrontEnd - DAE generated: time 1.039e-05/1.417, allocations: 5.375 kB / 1.208 GB, free: 9.617 MB / 0.9053 GB
Notification: Performance of FrontEnd: time 2.184e-06/1.417, allocations: 7.938 kB / 1.208 GB, free: 9.609 MB / 0.9053 GB
Notification: Performance of Transformations before backend: time 0.0005774/1.417, allocations: 0 / 1.208 GB, free: 9.609 MB / 0.9053 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 1920
 * Number of variables: 1920
Notification: Performance of Generate backend data structure: time 0.05498/1.472, allocations: 13.8 MB / 1.222 GB, free: 0.9492 MB / 0.9053 GB
Notification: Performance of prepare preOptimizeDAE: time 6.142e-05/1.472, allocations: 8.562 kB / 1.222 GB, free: 0.9492 MB / 0.9053 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.00844/1.481, allocations: 1.439 MB / 1.223 GB, free: 240 kB / 0.9053 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.01602/1.497, allocations: 5.934 MB / 1.229 GB, free: 11.75 MB / 0.9209 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0006887/1.498, allocations: 0.5781 MB / 1.23 GB, free: 11.48 MB / 0.9209 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.002279/1.5, allocations: 0.7689 MB / 1.23 GB, free: 11.21 MB / 0.9209 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.02049/1.52, allocations: 7.881 MB / 1.238 GB, free: 6.234 MB / 0.9209 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.000169/1.521, allocations: 13.47 kB / 1.238 GB, free: 6.227 MB / 0.9209 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0008233/1.522, allocations: 313.9 kB / 1.238 GB, free: 5.988 MB / 0.9209 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001652/1.522, allocations: 185.4 kB / 1.239 GB, free: 5.988 MB / 0.9209 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.01591/1.538, allocations: 7.499 MB / 1.246 GB, free: 0.8008 MB / 0.9209 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.07581/1.613, allocations: 46.19 MB / 1.291 GB, free: 14.52 MB / 0.9834 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.0168/1.63, allocations: 9.322 MB / 1.3 GB, free: 5.082 MB / 0.9834 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.006719/1.637, allocations: 3.542 MB / 1.304 GB, free: 1.523 MB / 0.9834 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0005231/1.638, allocations: 98.12 kB / 1.304 GB, free: 1.426 MB / 0.9834 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 8.435e-05/1.638, allocations: 116.7 kB / 1.304 GB, free: 1.301 MB / 0.9834 GB
Notification: Performance of pre-optimization done (n=787): time 1.167e-05/1.638, allocations: 0 / 1.304 GB, free: 1.301 MB / 0.9834 GB
Notification: Performance of matching and sorting (n=789): time 0.04263/1.68, allocations: 17.83 MB / 1.321 GB, free: 15.34 MB / 1.015 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001673/1.681, allocations: 339.2 kB / 1.321 GB, free: 14.95 MB / 1.015 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.008125/1.689, allocations: 5.217 MB / 1.327 GB, free: 9.75 MB / 1.015 GB
Notification: Performance of collectPreVariables (initialization): time 0.001765/1.691, allocations: 169.7 kB / 1.327 GB, free: 9.578 MB / 1.015 GB
Notification: Performance of collectInitialEqns (initialization): time 0.003134/1.694, allocations: 3.591 MB / 1.33 GB, free: 5.957 MB / 1.015 GB
Notification: Performance of collectInitialBindings (initialization): time 0.003891/1.698, allocations: 2.73 MB / 1.333 GB, free: 3.188 MB / 1.015 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.002939/1.701, allocations: 1.546 MB / 1.334 GB, free: 1.629 MB / 1.015 GB
Notification: Performance of setup shared object (initialization): time 0.0001026/1.701, allocations: 305.1 kB / 1.335 GB, free: 1.328 MB / 1.015 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.005823/1.706, allocations: 2.936 MB / 1.338 GB, free: 14.38 MB / 1.03 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.007189/1.714, allocations: 4.737 MB / 1.342 GB, free: 8.977 MB / 1.03 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.01373/1.727, allocations: 7.649 MB / 1.35 GB, free: 0.7266 MB / 1.03 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 4.631e-05/1.728, allocations: 15.94 kB / 1.35 GB, free: 0.7109 MB / 1.03 GB
Notification: Performance of matching and sorting (n=1197) (initialization): time 0.03279/1.76, allocations: 12.41 MB / 1.362 GB, free: 4.219 MB / 1.046 GB
Notification: Performance of prepare postOptimizeDAE: time 5.39e-05/1.76, allocations: 24 kB / 1.362 GB, free: 4.195 MB / 1.046 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 5.873e-05/1.76, allocations: 44 kB / 1.362 GB, free: 4.152 MB / 1.046 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.02825/1.789, allocations: 5.537 MB / 1.367 GB, free: 14.55 MB / 1.062 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.008047/1.797, allocations: 1.755 MB / 1.369 GB, free: 12.79 MB / 1.062 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.07548/1.872, allocations: 53.9 MB / 1.422 GB, free: 4.031 MB / 1.108 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.009883/1.882, allocations: 485.9 kB / 1.422 GB, free: 3.555 MB / 1.108 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001827/1.884, allocations: 336 kB / 1.422 GB, free: 3.227 MB / 1.108 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.00997/1.894, allocations: 3.799 MB / 1.426 GB, free: 15.41 MB / 1.124 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.006983/1.901, allocations: 4.502 MB / 1.431 GB, free: 10.25 MB / 1.124 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.01238/1.914, allocations: 7.325 MB / 1.438 GB, free: 2.324 MB / 1.124 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 3.983e-05/1.914, allocations: 15.98 kB / 1.438 GB, free: 2.309 MB / 1.124 GB
Notification: Performance of matching and sorting (n=1197) (initialization_lambda0): time 0.02495/1.939, allocations: 10.72 MB / 1.448 GB, free: 7.52 MB / 1.14 GB
Notification: Performance of prepare postOptimizeDAE: time 4.276e-05/1.939, allocations: 24.06 kB / 1.448 GB, free: 7.496 MB / 1.14 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 5.236e-05/1.939, allocations: 44 kB / 1.448 GB, free: 7.453 MB / 1.14 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0231/1.962, allocations: 4.447 MB / 1.453 GB, free: 2.949 MB / 1.14 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.008742/1.971, allocations: 1.896 MB / 1.454 GB, free: 1.051 MB / 1.14 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.05282/2.024, allocations: 43.38 MB / 1.497 GB, free: 3.086 MB / 1.187 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.009062/2.033, allocations: 410.3 kB / 1.497 GB, free: 2.684 MB / 1.187 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001417/2.034, allocations: 332 kB / 1.497 GB, free: 2.359 MB / 1.187 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 193
 * 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 (951):
 * Single equations (assignments): 931
 * 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), (172,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.001985/2.036, allocations: 0.6796 MB / 1.498 GB, free: 1.676 MB / 1.187 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.002382/2.038, allocations: 0.799 MB / 1.499 GB, free: 0.8672 MB / 1.187 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01651/2.055, allocations: 8.646 MB / 1.507 GB, free: 8.152 MB / 1.202 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.0001274/2.055, allocations: 35.86 kB / 1.507 GB, free: 8.117 MB / 1.202 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.464e-05/2.055, allocations: 0 / 1.507 GB, free: 8.117 MB / 1.202 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.005436/2.061, allocations: 1.424 MB / 1.509 GB, free: 6.664 MB / 1.202 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.002397/2.063, allocations: 136 kB / 1.509 GB, free: 6.531 MB / 1.202 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.006212/2.069, allocations: 318.5 kB / 1.509 GB, free: 6.219 MB / 1.202 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.001222/2.07, allocations: 0.6222 MB / 1.51 GB, free: 5.594 MB / 1.202 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.02102/2.092, allocations: 8.218 MB / 1.518 GB, free: 13.33 MB / 1.218 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.6646/2.756, allocations: 41.77 MB / 1.559 GB, free: 376.5 MB / 1.233 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.004726/2.761, allocations: 2.665 MB / 1.561 GB, free: 376.4 MB / 1.233 GB
Notification: Performance of sorting global known variables: time 0.005232/2.766, allocations: 3.316 MB / 1.565 GB, free: 376.2 MB / 1.233 GB
Notification: Performance of Backend: time 4.41e-07/2.766, allocations: 3.781 kB / 1.565 GB, free: 376.2 MB / 1.233 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.05109/2.817, allocations: 22.01 MB / 1.586 GB, free: 367.9 MB / 1.233 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.05147/2.869, allocations: 28.98 MB / 1.614 GB, free: 351.9 MB / 1.233 GB
Notification: Performance of Templates: time 0.2823/3.151, allocations: 179.3 MB / 1.789 GB, free: 214.4 MB / 1.233 GB
make -j1 -f ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1.Type1_N_1_M_1.makefile
(rm -f ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1.Type1_N_1_M_1.pipe ; mkfifo ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1.Type1_N_1_M_1.pipe ; head -c 1048576 < ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1.Type1_N_1_M_1.pipe >> ../files/ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1.Type1_N_1_M_1.sim & ./ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1.Type1_N_1_M_1  -nls=kinsol -lv=LOG_STATS -abortSlowSimulation -alarm=480 -lv LOG_STATS > ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1.Type1_N_1_M_1.pipe 2>&1)