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.3/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.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_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.001199/0.001199, allocations: 108.5 kB / 18.42 MB, free: 4.645 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.001204/0.001204, allocations: 183 kB / 19.35 MB, free: 3.719 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.474/1.474, allocations: 205.1 MB / 225.2 MB, free: 12.21 MB / 190.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 1.0.3/package.mo): time 0.06673/0.06673, allocations: 14.17 MB / 286.8 MB, free: 13.86 MB / 238.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ScalableTestGrids 1.1.0-master/package.mo): time 3.794/3.794, allocations: 461.2 MB / 0.7801 GB, free: 107.2 MB / 0.6546 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.001752/0.001752, allocations: 88.95 kB / 1.132 GB, free: 22.1 MB / 0.8735 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.3219/0.3237, allocations: 172.1 MB / 1.3 GB, free: 6.996 MB / 0.9829 GB
Notification: Performance of NFInst.instantiate(ScalableTestGrids.Models.Type1.Type1_N_1_M_1): time 0.05004/0.3738, allocations: 55.55 MB / 1.354 GB, free: 15.22 MB / 1.045 GB
Notification: Performance of NFInst.instExpressions: time 0.03546/0.4093, allocations: 20.52 MB / 1.374 GB, free: 10.63 MB / 1.061 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.01096/0.4203, allocations: 211 kB / 1.374 GB, free: 10.42 MB / 1.061 GB
Notification: Performance of NFTyping.typeComponents: time 0.009623/0.43, allocations: 2.894 MB / 1.377 GB, free: 7.508 MB / 1.061 GB
Notification: Performance of NFTyping.typeBindings: time 0.03133/0.4613, allocations: 8.18 MB / 1.385 GB, free: 15.29 MB / 1.077 GB
Notification: Performance of NFTyping.typeClassSections: time 0.009098/0.4705, allocations: 3.12 MB / 1.388 GB, free: 12.16 MB / 1.077 GB
Notification: Performance of NFFlatten.flatten: time 0.0276/0.4981, allocations: 18.58 MB / 1.406 GB, free: 9.52 MB / 1.092 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.006161/0.5043, allocations: 2.362 MB / 1.409 GB, free: 7.078 MB / 1.092 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.01194/0.5162, allocations: 6.258 MB / 1.415 GB, free: 0.7969 MB / 1.092 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.01136/0.5276, allocations: 6.63 MB / 1.421 GB, free: 10.14 MB / 1.108 GB
Notification: Performance of NFPackage.collectConstants: time 0.003686/0.5313, allocations: 0.9609 MB / 1.422 GB, free: 9.176 MB / 1.108 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.007003/0.5383, allocations: 1.839 MB / 1.424 GB, free: 7.34 MB / 1.108 GB
Notification: Performance of NFScalarize.scalarize: time 0.003508/0.5419, allocations: 2.081 MB / 1.426 GB, free: 5.25 MB / 1.108 GB
Notification: Performance of NFVerifyModel.verify: time 0.01156/0.5535, allocations: 5.925 MB / 1.432 GB, free: 15.29 MB / 1.124 GB
Notification: Performance of NFConvertDAE.convert: time 0.02964/0.5831, allocations: 14.91 MB / 1.446 GB, free: 344 kB / 1.124 GB
Notification: Performance of FrontEnd - DAE generated: time 8.075e-06/0.5832, allocations: 0 / 1.446 GB, free: 344 kB / 1.124 GB
Notification: Performance of FrontEnd: time 3.807e-06/0.5832, allocations: 4 kB / 1.446 GB, free: 340 kB / 1.124 GB
Notification: Performance of Transformations before backend: time 0.0005795/0.5838, allocations: 0 / 1.446 GB, free: 340 kB / 1.124 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.05728/0.6411, allocations: 14.55 MB / 1.46 GB, free: 1.668 MB / 1.139 GB
Notification: Performance of prepare preOptimizeDAE: time 6.635e-05/0.6412, allocations: 8.031 kB / 1.46 GB, free: 1.66 MB / 1.139 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.008659/0.6498, allocations: 1.49 MB / 1.462 GB, free: 168 kB / 1.139 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.01711/0.667, allocations: 6.388 MB / 1.468 GB, free: 9.711 MB / 1.155 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0007082/0.6677, allocations: 0.581 MB / 1.469 GB, free: 9.129 MB / 1.155 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.002708/0.6704, allocations: 0.7694 MB / 1.469 GB, free: 8.359 MB / 1.155 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.02169/0.6922, allocations: 7.879 MB / 1.477 GB, free: 164 kB / 1.155 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.000307/0.6925, allocations: 15.88 kB / 1.477 GB, free: 148 kB / 1.155 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.001668/0.6942, allocations: 316.1 kB / 1.477 GB, free: 15.83 MB / 1.17 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001833/0.6944, allocations: 184 kB / 1.478 GB, free: 15.65 MB / 1.17 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.01838/0.7128, allocations: 7.496 MB / 1.485 GB, free: 8.145 MB / 1.17 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.08889/0.8017, allocations: 48.94 MB / 1.533 GB, free: 3.109 MB / 1.217 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.0187/0.8204, allocations: 9.321 MB / 1.542 GB, free: 9.676 MB / 1.233 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.007735/0.8282, allocations: 3.549 MB / 1.545 GB, free: 6.109 MB / 1.233 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.000774/0.829, allocations: 98.14 kB / 1.545 GB, free: 6.012 MB / 1.233 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0001538/0.8292, allocations: 116.7 kB / 1.546 GB, free: 5.887 MB / 1.233 GB
Notification: Performance of pre-optimization done (n=787): time 1.576e-05/0.8292, allocations: 0 / 1.546 GB, free: 5.887 MB / 1.233 GB
Notification: Performance of matching and sorting (n=787): time 0.02879/0.858, allocations: 10.45 MB / 1.556 GB, free: 11.39 MB / 1.249 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0002087/0.8583, allocations: 339.2 kB / 1.556 GB, free: 10.99 MB / 1.249 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.01441/0.8727, allocations: 5.659 MB / 1.562 GB, free: 5.355 MB / 1.249 GB
Notification: Performance of collectPreVariables (initialization): time 0.002214/0.875, allocations: 173.7 kB / 1.562 GB, free: 5.18 MB / 1.249 GB
Notification: Performance of collectInitialEqns (initialization): time 0.005132/0.8802, allocations: 3.647 MB / 1.565 GB, free: 1.512 MB / 1.249 GB
Notification: Performance of collectInitialBindings (initialization): time 0.005216/0.8854, allocations: 2.862 MB / 1.568 GB, free: 14.62 MB / 1.264 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.006146/0.8916, allocations: 1.55 MB / 1.57 GB, free: 13.06 MB / 1.264 GB
Notification: Performance of setup shared object (initialization): time 0.0001061/0.8917, allocations: 301.1 kB / 1.57 GB, free: 12.76 MB / 1.264 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.007479/0.8992, allocations: 2.944 MB / 1.573 GB, free: 9.801 MB / 1.264 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.009616/0.9088, allocations: 4.744 MB / 1.577 GB, free: 4.398 MB / 1.264 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.01688/0.9258, allocations: 7.637 MB / 1.585 GB, free: 12.16 MB / 1.28 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 7.405e-05/0.9259, allocations: 19.98 kB / 1.585 GB, free: 12.14 MB / 1.28 GB
Notification: Performance of matching and sorting (n=1195) (initialization): time 1.235/2.16, allocations: 12.46 MB / 1.597 GB, free: 259.9 MB / 1.28 GB
Notification: Performance of prepare postOptimizeDAE: time 6.48e-05/2.161, allocations: 24.59 kB / 1.597 GB, free: 259.9 MB / 1.28 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 8.088e-05/2.161, allocations: 42.86 kB / 1.597 GB, free: 259.9 MB / 1.28 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.02792/2.189, allocations: 5.508 MB / 1.602 GB, free: 259.7 MB / 1.28 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.00798/2.197, allocations: 1.735 MB / 1.604 GB, free: 259.7 MB / 1.28 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.07628/2.273, allocations: 54.07 MB / 1.657 GB, free: 224.7 MB / 1.28 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01024/2.283, allocations: 0.7928 MB / 1.658 GB, free: 224.4 MB / 1.28 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001706/2.285, allocations: 327.9 kB / 1.658 GB, free: 224.3 MB / 1.28 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.009394/2.294, allocations: 3.81 MB / 1.662 GB, free: 222.5 MB / 1.28 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.006591/2.301, allocations: 4.5 MB / 1.666 GB, free: 219.3 MB / 1.28 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.01062/2.312, allocations: 7.315 MB / 1.673 GB, free: 214.5 MB / 1.28 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 3.722e-05/2.312, allocations: 11.84 kB / 1.673 GB, free: 214.5 MB / 1.28 GB
Notification: Performance of matching and sorting (n=1195) (initialization_lambda0): time 0.02138/2.333, allocations: 10.77 MB / 1.684 GB, free: 210 MB / 1.28 GB
Notification: Performance of prepare postOptimizeDAE: time 5.936e-05/2.333, allocations: 23.09 kB / 1.684 GB, free: 210 MB / 1.28 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 5.632e-05/2.333, allocations: 46.91 kB / 1.684 GB, free: 210 MB / 1.28 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.02163/2.355, allocations: 4.415 MB / 1.688 GB, free: 208.2 MB / 1.28 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.007636/2.363, allocations: 1.888 MB / 1.69 GB, free: 207.8 MB / 1.28 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.04403/2.407, allocations: 43.53 MB / 1.733 GB, free: 168.5 MB / 1.28 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.009461/2.416, allocations: 0.6061 MB / 1.733 GB, free: 168 MB / 1.28 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001388/2.418, allocations: 328 kB / 1.734 GB, free: 167.7 MB / 1.28 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 (949):
 * Single equations (assignments): 929
 * 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.001989/2.42, allocations: 0.6805 MB / 1.734 GB, free: 167 MB / 1.28 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.002798/2.422, allocations: 0.8346 MB / 1.735 GB, free: 166.2 MB / 1.28 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01416/2.437, allocations: 8.621 MB / 1.743 GB, free: 157.5 MB / 1.28 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 6.961e-05/2.437, allocations: 39.86 kB / 1.743 GB, free: 157.5 MB / 1.28 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.321e-05/2.437, allocations: 0 / 1.743 GB, free: 157.5 MB / 1.28 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.004515/2.441, allocations: 1.686 MB / 1.745 GB, free: 155.8 MB / 1.28 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.001926/2.443, allocations: 139.9 kB / 1.745 GB, free: 155.7 MB / 1.28 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.005776/2.449, allocations: 244.6 kB / 1.745 GB, free: 155.5 MB / 1.28 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0009923/2.45, allocations: 0.6183 MB / 1.746 GB, free: 154.8 MB / 1.28 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.01781/2.468, allocations: 8.191 MB / 1.754 GB, free: 146.8 MB / 1.28 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.07192/2.54, allocations: 42.56 MB / 1.796 GB, free: 103.9 MB / 1.28 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.004185/2.544, allocations: 2.66 MB / 1.798 GB, free: 101.2 MB / 1.28 GB
Notification: Performance of sorting global known variables: time 0.005393/2.549, allocations: 3.632 MB / 1.802 GB, free: 97.62 MB / 1.28 GB
Notification: Performance of Backend: time 9.22e-07/2.549, allocations: 0 / 1.802 GB, free: 97.62 MB / 1.28 GB
Notification: Performance of simCode: created initialization part: time 0.04406/2.593, allocations: 22.17 MB / 1.823 GB, free: 75 MB / 1.28 GB
Notification: Performance of SimCode: time 0.04037/2.634, allocations: 26.63 MB / 1.849 GB, free: 48.24 MB / 1.28 GB
Notification: Performance of Templates: time 0.3006/2.934, allocations: 189.5 MB / 2.034 GB, free: 2.723 MB / 1.421 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)