Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr PowerGrids_dev_PowerGrids.Examples.Tutorial.IslandOperation.TwoGeneratorsLocalInitialization.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 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 2.0.0-develop/package.mo", uses=false)
Using package PowerGrids with version 2.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 2.0.0-develop/package.mo)
Using package Modelica with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+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(PowerGrids.Examples.Tutorial.IslandOperation.TwoGeneratorsLocalInitialization,tolerance=1e-06,outputFormat="empty",numberOfIntervals=20000,variableFilter="",fileNamePrefix="PowerGrids_dev_PowerGrids.Examples.Tutorial.IslandOperation.TwoGeneratorsLocalInitialization")
translateModel(PowerGrids.Examples.Tutorial.IslandOperation.TwoGeneratorsLocalInitialization,tolerance=1e-06,outputFormat="empty",numberOfIntervals=20000,variableFilter="",fileNamePrefix="PowerGrids_dev_PowerGrids.Examples.Tutorial.IslandOperation.TwoGeneratorsLocalInitialization")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.0058/0.0058, allocations: 100.8 kB / 15.73 MB, free: 6.059 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.001312/0.001312, allocations: 193.7 kB / 16.67 MB, free: 5.969 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.389/1.389, allocations: 222.9 MB / 240.4 MB, free: 15.15 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 2.0.0-develop/package.mo): time 0.08044/0.08044, allocations: 16.68 MB / 307.2 MB, free: 14.49 MB / 254.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.001944/0.001944, allocations: 63.89 kB / 426.5 MB, free: 10.76 MB / 302.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.09699/0.09895, allocations: 53.55 MB / 480 MB, free: 5.16 MB / 350.1 MB
Notification: Performance of NFInst.instantiate(PowerGrids.Examples.Tutorial.IslandOperation.TwoGeneratorsLocalInitialization): time 0.2778/0.3768, allocations: 95.08 MB / 0.5616 GB, free: 13.81 MB / 414.1 MB
Notification: Performance of NFInst.instExpressions: time 0.0454/0.4222, allocations: 23.57 MB / 0.5847 GB, free: 8.555 MB / 430.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.01188/0.4342, allocations: 246.6 kB / 0.5849 GB, free: 8.312 MB / 430.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.01079/0.445, allocations: 3.059 MB / 0.5879 GB, free: 5.234 MB / 430.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.02675/0.4718, allocations: 8.264 MB / 0.596 GB, free: 13.04 MB / 446.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.01394/0.4857, allocations: 5.337 MB / 0.6012 GB, free: 7.777 MB / 446.1 MB
Notification: Performance of NFFlatten.flatten: time 0.03249/0.5182, allocations: 20.91 MB / 0.6216 GB, free: 2.805 MB / 462.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.01058/0.5289, allocations: 5.161 MB / 0.6266 GB, free: 13.57 MB / 478.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.0125/0.5414, allocations: 6.928 MB / 0.6334 GB, free: 6.613 MB / 478.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.01305/0.5545, allocations: 7.298 MB / 0.6405 GB, free: 15.29 MB / 494.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.004559/0.5591, allocations: 1.199 MB / 0.6417 GB, free: 14.09 MB / 494.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.008467/0.5676, allocations: 2.136 MB / 0.6438 GB, free: 11.95 MB / 494.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.004758/0.5724, allocations: 2.541 MB / 0.6463 GB, free: 9.398 MB / 494.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.01405/0.5865, allocations: 6.87 MB / 0.653 GB, free: 2.496 MB / 494.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.0306/0.6171, allocations: 17.88 MB / 0.6704 GB, free: 0.5508 MB / 0.4981 GB
Notification: Performance of FrontEnd - DAE generated: time 7.955e-06/0.6171, allocations: 4 kB / 0.6704 GB, free: 0.5469 MB / 0.4981 GB
Notification: Performance of FrontEnd: time 1.633e-06/0.6171, allocations: 0 / 0.6704 GB, free: 0.5469 MB / 0.4981 GB
Notification: Performance of Transformations before backend: time 0.0005227/0.6177, allocations: 0 / 0.6704 GB, free: 0.5469 MB / 0.4981 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 2006
 * Number of variables: 2006
Notification: Performance of Generate backend data structure: time 0.05551/0.6732, allocations: 15.97 MB / 0.686 GB, free: 468 kB / 0.5137 GB
Notification: Performance of prepare preOptimizeDAE: time 5.114e-05/0.6733, allocations: 8.031 kB / 0.686 GB, free: 460 kB / 0.5137 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01606/0.6893, allocations: 2.632 MB / 0.6886 GB, free: 13.81 MB / 0.5294 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.01855/0.7079, allocations: 7.68 MB / 0.6961 GB, free: 6.055 MB / 0.5294 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0007054/0.7087, allocations: 0.7008 MB / 0.6968 GB, free: 5.344 MB / 0.5294 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.002172/0.7108, allocations: 0.8405 MB / 0.6976 GB, free: 4.504 MB / 0.5294 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.02068/0.7315, allocations: 9.492 MB / 0.7069 GB, free: 10.04 MB / 0.545 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.000194/0.7318, allocations: 47.56 kB / 0.7069 GB, free: 9.996 MB / 0.545 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.001162/0.7329, allocations: 356 kB / 0.7073 GB, free: 9.648 MB / 0.545 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001824/0.7331, allocations: 211.9 kB / 0.7075 GB, free: 9.441 MB / 0.545 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.01644/0.7496, allocations: 7.677 MB / 0.715 GB, free: 1.746 MB / 0.545 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.4469/1.196, allocations: 58.94 MB / 0.7725 GB, free: 132.7 MB / 0.545 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.01291/1.209, allocations: 8.739 MB / 0.7811 GB, free: 127.3 MB / 0.545 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.004827/1.214, allocations: 3.048 MB / 0.784 GB, free: 125.7 MB / 0.545 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0004133/1.215, allocations: 104.1 kB / 0.7841 GB, free: 125.7 MB / 0.545 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 8.714e-05/1.215, allocations: 127.6 kB / 0.7843 GB, free: 125.6 MB / 0.545 GB
Notification: Performance of pre-optimization done (n=725): time 9.428e-06/1.215, allocations: 0 / 0.7843 GB, free: 125.6 MB / 0.545 GB
Notification: Performance of matching and sorting (n=725): time 0.05441/1.269, allocations: 16.9 MB / 0.8008 GB, free: 116.3 MB / 0.545 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 9.022e-05/1.269, allocations: 364.4 kB / 0.8011 GB, free: 115.9 MB / 0.545 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.01287/1.282, allocations: 8.387 MB / 0.8093 GB, free: 107.7 MB / 0.545 GB
Notification: Performance of collectPreVariables (initialization): time 0.001539/1.284, allocations: 189.7 kB / 0.8095 GB, free: 107.5 MB / 0.545 GB
Notification: Performance of collectInitialEqns (initialization): time 0.003735/1.288, allocations: 4.453 MB / 0.8138 GB, free: 103.5 MB / 0.545 GB
Notification: Performance of collectInitialBindings (initialization): time 0.003538/1.291, allocations: 2.955 MB / 0.8167 GB, free: 101 MB / 0.545 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.008956/1.3, allocations: 3.763 MB / 0.8204 GB, free: 97.22 MB / 0.545 GB
Notification: Performance of setup shared object (initialization): time 3.993e-05/1.3, allocations: 301.1 kB / 0.8207 GB, free: 96.92 MB / 0.545 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0106/1.311, allocations: 5.929 MB / 0.8265 GB, free: 90.98 MB / 0.545 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.01237/1.323, allocations: 8.076 MB / 0.8344 GB, free: 82.46 MB / 0.545 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.01749/1.341, allocations: 11.48 MB / 0.8456 GB, free: 70.57 MB / 0.545 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 5.258e-05/1.341, allocations: 8 kB / 0.8456 GB, free: 70.56 MB / 0.545 GB
Notification: Performance of matching and sorting (n=2671) (initialization): time 0.04177/1.383, allocations: 20.68 MB / 0.8658 GB, free: 49.81 MB / 0.545 GB
Notification: Performance of prepare postOptimizeDAE: time 6.201e-05/1.383, allocations: 22.34 kB / 0.8658 GB, free: 49.79 MB / 0.545 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 6.615e-05/1.383, allocations: 28 kB / 0.8658 GB, free: 49.76 MB / 0.545 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.02819/1.411, allocations: 5.341 MB / 0.871 GB, free: 44.35 MB / 0.545 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01541/1.426, allocations: 3.955 MB / 0.8749 GB, free: 40.39 MB / 0.545 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.3024/1.729, allocations: 58.22 MB / 0.9318 GB, free: 166.5 MB / 0.5607 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01841/1.747, allocations: 1.466 MB / 0.9332 GB, free: 166.5 MB / 0.5607 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.00277/1.75, allocations: 0.6474 MB / 0.9338 GB, free: 166.5 MB / 0.5607 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.01748/1.768, allocations: 7.162 MB / 0.9408 GB, free: 166.3 MB / 0.5607 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.01493/1.783, allocations: 7.838 MB / 0.9485 GB, free: 162.7 MB / 0.5607 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.0192/1.802, allocations: 11.16 MB / 0.9594 GB, free: 156.5 MB / 0.5607 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 0.0001226/1.802, allocations: 7.656 kB / 0.9594 GB, free: 156.5 MB / 0.5607 GB
Notification: Performance of matching and sorting (n=2671) (initialization_lambda0): time 0.04049/1.842, allocations: 18.94 MB / 0.9779 GB, free: 149.3 MB / 0.5607 GB
Notification: Performance of prepare postOptimizeDAE: time 9.341e-05/1.843, allocations: 18.69 kB / 0.9779 GB, free: 149.3 MB / 0.5607 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 8.992e-05/1.843, allocations: 28.78 kB / 0.9779 GB, free: 149.3 MB / 0.5607 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.02248/1.865, allocations: 4.213 MB / 0.982 GB, free: 148.8 MB / 0.5607 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01501/1.88, allocations: 4.109 MB / 0.986 GB, free: 145.2 MB / 0.5607 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.04073/1.921, allocations: 49.72 MB / 1.035 GB, free: 95.38 MB / 0.5607 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01689/1.938, allocations: 1.143 MB / 1.036 GB, free: 94.74 MB / 0.5607 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.003052/1.941, allocations: 0.6478 MB / 1.036 GB, free: 94.11 MB / 0.5607 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 128
 * Number of states: 0 ()
 * Number of discrete variables: 20 (NTLV2.componentPF.isSlackBus,GRIDL2.componentPF.isSlackBus,GRIDL1.componentPF.isSlackBus,NTHV2.componentPF.isSlackBus,GEN2.GEN.componentPF.isSlackBus,GEN2.isSlackBus,GEN1.GEN.componentPF.isSlackBus,GEN1.isSlackBus,NTHV1.componentPF.isSlackBus,NTLV1.componentPF.isSlackBus,GEN2.PSS.firstWashoutVsi2.integrator.local_reset,GEN2.PSS.secondWashoutVsi1.integrator.local_reset,GEN2.PSS.firstWashoutVsi1.integrator.local_reset,GEN2.AVR.firstOrderLim.I.local_reset,GEN2.TGOV.firstOrderLim.I.local_reset,GEN1.PSS.firstWashoutVsi2.integrator.local_reset,GEN1.PSS.secondWashoutVsi1.integrator.local_reset,GEN1.PSS.firstWashoutVsi1.integrator.local_reset,GEN1.AVR.firstOrderLim.I.local_reset,GEN1.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 (2471):
 * Single equations (assignments): 2445
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 26
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 10 systems
   {(2,0,100.0%), (2,0,100.0%), (2,0,100.0%), (2,0,100.0%), (2,0,100.0%), (2,0,100.0%), (3,0,66.7%), (3,0,66.7%), (3,0,66.7%), (3,0,66.7%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 16 systems
   {(32,0), (10,0), (10,0), (19,0), (32,0), (32,0), (10,0), (41,0), (2,0), (2,0), (2,0), (2,0), (2,0), (2,0), (2,0), (2,0)}
Notification: Performance of prepare postOptimizeDAE: time 0.004408/1.945, allocations: 1.02 MB / 1.037 GB, free: 93.11 MB / 0.5607 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.003373/1.949, allocations: 1.012 MB / 1.038 GB, free: 92.3 MB / 0.5607 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01415/1.963, allocations: 7.936 MB / 1.046 GB, free: 85.28 MB / 0.5607 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 7.53e-05/1.963, allocations: 39.8 kB / 1.046 GB, free: 85.24 MB / 0.5607 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.217e-05/1.963, allocations: 3.812 kB / 1.046 GB, free: 85.24 MB / 0.5607 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.007547/1.971, allocations: 2.058 MB / 1.048 GB, free: 83.22 MB / 0.5607 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.003573/1.974, allocations: 132 kB / 1.048 GB, free: 83.09 MB / 0.5607 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.008592/1.983, allocations: 315.5 kB / 1.049 GB, free: 82.79 MB / 0.5607 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.001313/1.984, allocations: 0.5398 MB / 1.049 GB, free: 82.25 MB / 0.5607 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.01684/2.001, allocations: 7.908 MB / 1.057 GB, free: 74.46 MB / 0.5607 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.01441/2.015, allocations: 9.614 MB / 1.066 GB, free: 64.76 MB / 0.5607 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.004008/2.02, allocations: 2.621 MB / 1.069 GB, free: 62.12 MB / 0.5607 GB
Notification: Performance of sorting global known variables: time 0.008427/2.028, allocations: 5.096 MB / 1.074 GB, free: 57.07 MB / 0.5607 GB
Notification: Performance of Backend: time 1.332e-06/2.028, allocations: 0 / 1.074 GB, free: 57.07 MB / 0.5607 GB
Notification: Performance of simCode: created initialization part: time 0.06796/2.096, allocations: 32.58 MB / 1.106 GB, free: 23.96 MB / 0.5607 GB
Notification: Performance of SimCode: time 0.03616/2.132, allocations: 18.77 MB / 1.124 GB, free: 5.309 MB / 0.5607 GB
Notification: Performance of Templates: time 0.9273/3.06, allocations: 241.7 MB / 1.36 GB, free: 182.8 MB / 0.5919 GB
make -j1 -f PowerGrids_dev_PowerGrids.Examples.Tutorial.IslandOperation.TwoGeneratorsLocalInitialization.makefile
(rm -f PowerGrids_dev_PowerGrids.Examples.Tutorial.IslandOperation.TwoGeneratorsLocalInitialization.pipe ; mkfifo PowerGrids_dev_PowerGrids.Examples.Tutorial.IslandOperation.TwoGeneratorsLocalInitialization.pipe ; head -c 1048576 < PowerGrids_dev_PowerGrids.Examples.Tutorial.IslandOperation.TwoGeneratorsLocalInitialization.pipe >> ../files/PowerGrids_dev_PowerGrids.Examples.Tutorial.IslandOperation.TwoGeneratorsLocalInitialization.sim & ./PowerGrids_dev_PowerGrids.Examples.Tutorial.IslandOperation.TwoGeneratorsLocalInitialization  -abortSlowSimulation -alarm=50 -lv LOG_STATS > PowerGrids_dev_PowerGrids.Examples.Tutorial.IslandOperation.TwoGeneratorsLocalInitialization.pipe 2>&1)