Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1.Type1_reduced_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-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 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_reduced_N_1_M_1,tolerance=0.0001,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1.Type1_reduced_N_1_M_1")
translateModel(ScalableTestGrids.Models.Type1.Type1_reduced_N_1_M_1,tolerance=0.0001,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1.Type1_reduced_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.001283/0.001283, allocations: 95 kB / 16.95 MB, free: 5.965 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.001337/0.001337, allocations: 188.5 kB / 17.84 MB, free: 5.641 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.976/1.976, allocations: 205.4 MB / 224 MB, free: 13.18 MB / 190.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 1.0.2/package.mo): time 0.06093/0.06093, allocations: 14.15 MB / 286.4 MB, free: 14.1 MB / 238.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ScalableTestGrids 1.1.0-master/package.mo): time 5.15/5.15, allocations: 463.5 MB / 0.783 GB, free: 108.6 MB / 0.6545 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.0009643/0.0009646, allocations: 20 kB / 0.9684 GB, free: 348 kB / 0.7327 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 1.832/1.833, allocations: 176 MB / 1.14 GB, free: 25.62 MB / 0.8735 GB
Notification: Performance of NFInst.instantiate(ScalableTestGrids.Models.Type1.Type1_reduced_N_1_M_1): time 0.05585/1.889, allocations: 46.12 MB / 1.185 GB, free: 7.793 MB / 0.8892 GB
Notification: Performance of NFInst.instExpressions: time 0.05969/1.949, allocations: 19.52 MB / 1.204 GB, free: 7.566 MB / 0.9048 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.02367/1.972, allocations: 207.3 kB / 1.205 GB, free: 7.496 MB / 0.9048 GB
Notification: Performance of NFTyping.typeComponents: time 0.01615/1.989, allocations: 1.927 MB / 1.206 GB, free: 5.816 MB / 0.9048 GB
Notification: Performance of NFTyping.typeBindings: time 0.04587/2.035, allocations: 6.896 MB / 1.213 GB, free: 144 kB / 0.9048 GB
Notification: Performance of NFTyping.typeClassSections: time 0.01427/2.049, allocations: 2.091 MB / 1.215 GB, free: 14.52 MB / 0.9204 GB
Notification: Performance of NFFlatten.flatten: time 0.04826/2.097, allocations: 12.56 MB / 1.228 GB, free: 6.551 MB / 0.9204 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.008908/2.106, allocations: 1.771 MB / 1.229 GB, free: 5.668 MB / 0.9204 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.0216/2.128, allocations: 4.742 MB / 1.234 GB, free: 2.754 MB / 0.9204 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.01956/2.148, allocations: 4.919 MB / 1.239 GB, free: 15.63 MB / 0.936 GB
Notification: Performance of NFPackage.collectConstants: time 0.005799/2.153, allocations: 304.4 kB / 1.239 GB, free: 15.63 MB / 0.936 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.01509/2.169, allocations: 0.9952 MB / 1.24 GB, free: 15.47 MB / 0.936 GB
Notification: Performance of NFScalarize.scalarize: time 0.005801/2.174, allocations: 1.241 MB / 1.241 GB, free: 14.46 MB / 0.936 GB
Notification: Performance of NFVerifyModel.verify: time 0.01231/2.187, allocations: 1.915 MB / 1.243 GB, free: 13.38 MB / 0.936 GB
Notification: Performance of NFConvertDAE.convert: time 0.02922/2.216, allocations: 10.25 MB / 1.253 GB, free: 5.797 MB / 0.936 GB
Notification: Performance of FrontEnd - DAE generated: time 7.444e-06/2.216, allocations: 5.375 kB / 1.253 GB, free: 5.793 MB / 0.936 GB
Notification: Performance of FrontEnd: time 7.083e-06/2.216, allocations: 0 / 1.253 GB, free: 5.793 MB / 0.936 GB
Notification: Performance of Transformations before backend: time 0.0009735/2.217, allocations: 0 / 1.253 GB, free: 5.793 MB / 0.936 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 1921
 * Number of variables: 1921
Notification: Performance of Generate backend data structure: time 0.05997/2.277, allocations: 12.08 MB / 1.265 GB, free: 14.46 MB / 0.9517 GB
Notification: Performance of prepare preOptimizeDAE: time 9.042e-05/2.277, allocations: 8.562 kB / 1.265 GB, free: 14.46 MB / 0.9517 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01227/2.29, allocations: 1.437 MB / 1.266 GB, free: 13.75 MB / 0.9517 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.02652/2.316, allocations: 5.719 MB / 1.272 GB, free: 9.484 MB / 0.9517 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.001645/2.318, allocations: 0.5752 MB / 1.272 GB, free: 9.219 MB / 0.9517 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.005204/2.323, allocations: 0.7681 MB / 1.273 GB, free: 8.957 MB / 0.9517 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.03671/2.36, allocations: 7.828 MB / 1.281 GB, free: 2.16 MB / 0.9517 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.000709/2.361, allocations: 15.88 kB / 1.281 GB, free: 2.145 MB / 0.9517 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.003707/2.364, allocations: 311.9 kB / 1.281 GB, free: 1.84 MB / 0.9517 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0002889/2.365, allocations: 195.9 kB / 1.281 GB, free: 1.648 MB / 0.9517 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.02834/2.393, allocations: 7.555 MB / 1.289 GB, free: 10.08 MB / 0.9673 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.09918/2.492, allocations: 46.34 MB / 1.334 GB, free: 7.645 MB / 1.014 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.02202/2.515, allocations: 9.407 MB / 1.343 GB, free: 14.12 MB / 1.03 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.001138/2.516, allocations: 94.12 kB / 1.343 GB, free: 14.03 MB / 1.03 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0001934/2.516, allocations: 120.7 kB / 1.343 GB, free: 13.9 MB / 1.03 GB
Notification: Performance of pre-optimization done (n=788): time 1.973e-05/2.516, allocations: 0 / 1.343 GB, free: 13.9 MB / 1.03 GB
Notification: Performance of matching and sorting (n=790): time 0.07497/2.591, allocations: 18.02 MB / 1.361 GB, free: 11.75 MB / 1.045 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0002883/2.591, allocations: 339.2 kB / 1.361 GB, free: 11.36 MB / 1.045 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.02065/2.612, allocations: 5.162 MB / 1.366 GB, free: 6.215 MB / 1.045 GB
Notification: Performance of collectPreVariables (initialization): time 0.002817/2.615, allocations: 173.7 kB / 1.366 GB, free: 6.039 MB / 1.045 GB
Notification: Performance of collectInitialEqns (initialization): time 0.00731/2.622, allocations: 3.595 MB / 1.37 GB, free: 2.414 MB / 1.045 GB
Notification: Performance of collectInitialBindings (initialization): time 0.007251/2.63, allocations: 2.718 MB / 1.373 GB, free: 15.65 MB / 1.061 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.002692/2.632, allocations: 192 kB / 1.373 GB, free: 15.46 MB / 1.061 GB
Notification: Performance of setup shared object (initialization): time 0.001253/2.634, allocations: 0.6474 MB / 1.373 GB, free: 14.81 MB / 1.061 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.009794/2.643, allocations: 2.931 MB / 1.376 GB, free: 11.88 MB / 1.061 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.01152/2.655, allocations: 4.725 MB / 1.381 GB, free: 6.492 MB / 1.061 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.01105/2.666, allocations: 3.584 MB / 1.384 GB, free: 2.906 MB / 1.061 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 9.614e-05/2.666, allocations: 12 kB / 1.384 GB, free: 2.895 MB / 1.061 GB
Notification: Performance of matching and sorting (n=1198) (initialization): time 0.04895/2.715, allocations: 12.83 MB / 1.397 GB, free: 5.98 MB / 1.077 GB
Notification: Performance of prepare postOptimizeDAE: time 0.01627/2.732, allocations: 20.78 MB / 1.417 GB, free: 20 kB / 1.092 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0003383/2.732, allocations: 48.05 kB / 1.417 GB, free: 15.97 MB / 1.108 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.02774/2.76, allocations: 5.237 MB / 1.422 GB, free: 10.67 MB / 1.108 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.009016/2.769, allocations: 1.751 MB / 1.424 GB, free: 8.914 MB / 1.108 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.08129/2.85, allocations: 52.1 MB / 1.475 GB, free: 2.098 MB / 1.155 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01267/2.863, allocations: 0.5097 MB / 1.475 GB, free: 1.586 MB / 1.155 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.00248/2.866, allocations: 340 kB / 1.476 GB, free: 1.254 MB / 1.155 GB
Notification: Performance of prepare postOptimizeDAE: time 2.37e-05/2.866, allocations: 7.938 kB / 1.476 GB, free: 1.246 MB / 1.155 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.02489/2.891, allocations: 9.948 MB / 1.486 GB, free: 7.242 MB / 1.17 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001455/2.891, allocations: 40 kB / 1.486 GB, free: 7.203 MB / 1.17 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.02136/2.912, allocations: 4.326 MB / 1.49 GB, free: 2.82 MB / 1.17 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.009833/2.922, allocations: 1.896 MB / 1.492 GB, free: 0.9219 MB / 1.17 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.05862/2.981, allocations: 40.74 MB / 1.531 GB, free: 5.754 MB / 1.217 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01212/2.993, allocations: 390.4 kB / 1.532 GB, free: 5.371 MB / 1.217 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.002515/2.995, allocations: 332 kB / 1.532 GB, free: 5.047 MB / 1.217 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 (952):
 * Single equations (assignments): 932
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 20
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 8 {(2,100.0%) 0,(2,100.0%) 0,(3,66.7%) 0,(3,66.7%) 0,(2,100.0%) 0,(2,100.0%) 0,(3,66.7%) 0,(3,66.7%) 0}
 * Non-linear torn systems: 12 {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.007642/3.003, allocations: 1.564 MB / 1.534 GB, free: 3.473 MB / 1.217 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.003428/3.007, allocations: 0.7951 MB / 1.534 GB, free: 2.668 MB / 1.217 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.02141/3.028, allocations: 8.702 MB / 1.543 GB, free: 9.898 MB / 1.233 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.0002811/3.028, allocations: 43.8 kB / 1.543 GB, free: 9.855 MB / 1.233 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.372e-05/3.028, allocations: 0 / 1.543 GB, free: 9.855 MB / 1.233 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.01039/3.039, allocations: 1.417 MB / 1.544 GB, free: 8.41 MB / 1.233 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.005965/3.045, allocations: 136 kB / 1.544 GB, free: 8.277 MB / 1.233 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.01146/3.056, allocations: 346.5 kB / 1.545 GB, free: 7.938 MB / 1.233 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.003339/3.06, allocations: 0.6222 MB / 1.545 GB, free: 7.312 MB / 1.233 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.03088/3.091, allocations: 8.409 MB / 1.554 GB, free: 14.86 MB / 1.249 GB
Notification: Performance of postOpt detectDAEmodeSparsePattern (simulation): time 0.02675/3.118, allocations: 9.715 MB / 1.563 GB, free: 5.047 MB / 1.249 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.006101/3.124, allocations: 2.696 MB / 1.566 GB, free: 2.336 MB / 1.249 GB
Notification: Performance of sorting global known variables: time 0.008976/3.133, allocations: 3.257 MB / 1.569 GB, free: 15.1 MB / 1.264 GB
Notification: Performance of Backend: time 1.082e-06/3.133, allocations: 0 / 1.569 GB, free: 15.1 MB / 1.264 GB
Notification: Performance of simCode: created initialization part: time 0.06212/3.195, allocations: 21.55 MB / 1.59 GB, free: 9.039 MB / 1.28 GB
Warning: The hideResult annotation could not be evaluated, probably due to missing annotation(Evaluate=true). It is set to 'isProtected' (=false) by default.
Notification: Performance of SimCode: time 1.458/4.653, allocations: 21.39 MB / 1.611 GB, free: 379.2 MB / 1.28 GB
Notification: Performance of Templates: time 0.3891/5.042, allocations: 148 MB / 1.755 GB, free: 289.1 MB / 1.28 GB
make -j1 -f ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1.Type1_reduced_N_1_M_1.makefile
Environment - environmentSimulation:
(rm -f ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1.Type1_reduced_N_1_M_1.pipe ; mkfifo ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1.Type1_reduced_N_1_M_1.pipe ; head -c 1048576 < ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1.Type1_reduced_N_1_M_1.pipe >> ../files/ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1.Type1_reduced_N_1_M_1.sim & ./ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1.Type1_reduced_N_1_M_1  -nls=kinsol -lv=LOG_STATS -abortSlowSimulation -alarm=480 -lv LOG_STATS > ScalableTestGrids_noopt_ScalableTestGrids.Models.Type1.Type1_reduced_N_1_M_1.pipe 2>&1)
Environment - environmentSimulation: