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.001182/0.001182, allocations: 108 kB / 15.61 MB, free: 152 kB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.00116/0.001161, allocations: 196.3 kB / 16.53 MB, free: 6.664 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.196/1.196, allocations: 222.9 MB / 240.2 MB, free: 4.379 MB / 190.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 2.0.0-develop/package.mo): time 0.1691/0.1691, allocations: 16.78 MB / 307.2 MB, free: 14.77 MB / 254.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.001158/0.001158, allocations: 55.91 kB / 371.8 MB, free: 3.582 MB / 302.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.2108/0.2119, allocations: 53.54 MB / 425.3 MB, free: 39.19 MB / 350.1 MB
Notification: Performance of NFInst.instantiate(PowerGrids.Examples.Tutorial.IslandOperation.TwoGeneratorsLocalInitialization): time 0.05864/0.2706, allocations: 95.09 MB / 0.5082 GB, free: 2.449 MB / 382.1 MB
Notification: Performance of NFInst.instExpressions: time 0.03604/0.3067, allocations: 23.58 MB / 0.5312 GB, free: 14.48 MB / 414.1 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 2.0.0-develop/Electrical/BaseClasses/OnePortACVI.mo:4:3-5:21:writable] Warning: Parameter UNom has annotation(Evaluate=true) and no binding.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 2.0.0-develop/Electrical/BaseClasses/OnePortACVI.mo:6:3-7:21:writable] Warning: Parameter SNom has annotation(Evaluate=true) and no binding.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 2.0.0-develop/Electrical/BaseClasses/OnePortACVI.mo:4:3-5:21:writable] Warning: Parameter UNom has annotation(Evaluate=true) and no binding.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 2.0.0-develop/Electrical/BaseClasses/OnePortACVI.mo:6:3-7:21:writable] Warning: Parameter SNom has annotation(Evaluate=true) and no binding.
Notification: Performance of NFInst.updateImplicitVariability: time 0.01012/0.3168, allocations: 250.6 kB / 0.5315 GB, free: 14.23 MB / 414.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.008095/0.325, allocations: 3.049 MB / 0.5345 GB, free: 11.16 MB / 414.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.02127/0.3462, allocations: 8.263 MB / 0.5425 GB, free: 2.949 MB / 414.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.01075/0.357, allocations: 5.34 MB / 0.5477 GB, free: 13.7 MB / 430.1 MB
Notification: Performance of NFFlatten.flatten: time 0.02202/0.379, allocations: 20.81 MB / 0.5681 GB, free: 8.84 MB / 446.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.00773/0.3868, allocations: 5.171 MB / 0.5731 GB, free: 3.59 MB / 446.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.1809/0.5677, allocations: 6.903 MB / 0.5799 GB, free: 27.1 MB / 446.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.009113/0.5768, allocations: 7.289 MB / 0.587 GB, free: 26.91 MB / 446.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.002729/0.5796, allocations: 1.205 MB / 0.5882 GB, free: 26.9 MB / 446.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.006332/0.5859, allocations: 2.133 MB / 0.5902 GB, free: 26.9 MB / 446.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.001495/0.5874, allocations: 2.547 MB / 0.5927 GB, free: 26.48 MB / 446.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.007255/0.5947, allocations: 6.87 MB / 0.5994 GB, free: 24.78 MB / 446.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.01766/0.6124, allocations: 17.52 MB / 0.6165 GB, free: 22.76 MB / 446.1 MB
Notification: Performance of FrontEnd - DAE generated: time 8.917e-06/0.6124, allocations: 2.594 kB / 0.6165 GB, free: 22.76 MB / 446.1 MB
Notification: Performance of FrontEnd: time 2.094e-06/0.6124, allocations: 0 / 0.6165 GB, free: 22.76 MB / 446.1 MB
Notification: Performance of Transformations before backend: time 0.0003989/0.6128, allocations: 2.406 kB / 0.6166 GB, free: 22.76 MB / 446.1 MB
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.04776/0.6606, allocations: 15.67 MB / 0.6319 GB, free: 17.75 MB / 446.1 MB
Notification: Performance of prepare preOptimizeDAE: time 3.728e-05/0.6607, allocations: 9.062 kB / 0.6319 GB, free: 17.75 MB / 446.1 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01213/0.6728, allocations: 2.572 MB / 0.6344 GB, free: 16.76 MB / 446.1 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.01262/0.6854, allocations: 7.387 MB / 0.6416 GB, free: 13.91 MB / 446.1 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0003572/0.6858, allocations: 0.7043 MB / 0.6423 GB, free: 13.55 MB / 446.1 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.001233/0.6871, allocations: 0.8378 MB / 0.6431 GB, free: 13.27 MB / 446.1 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.01095/0.698, allocations: 9.5 MB / 0.6524 GB, free: 5.219 MB / 446.1 MB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0001246/0.6982, allocations: 43.75 kB / 0.6524 GB, free: 5.203 MB / 446.1 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0006762/0.6988, allocations: 353.9 kB / 0.6527 GB, free: 4.859 MB / 446.1 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 8.947e-05/0.6989, allocations: 208 kB / 0.6529 GB, free: 4.656 MB / 446.1 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.01079/0.7097, allocations: 7.675 MB / 0.6604 GB, free: 13.21 MB / 462.1 MB
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.07182/0.7816, allocations: 59.16 MB / 0.7182 GB, free: 320 kB / 0.4981 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.01294/0.7946, allocations: 8.728 MB / 0.7267 GB, free: 7.398 MB / 0.5137 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.00441/0.799, allocations: 3.048 MB / 0.7297 GB, free: 4.336 MB / 0.5137 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0002875/0.7993, allocations: 110.9 kB / 0.7298 GB, free: 4.238 MB / 0.5137 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 9.265e-05/0.7994, allocations: 124.3 kB / 0.7299 GB, free: 4.105 MB / 0.5137 GB
Notification: Performance of pre-optimization done (n=725): time 8.546e-06/0.7994, allocations: 0 / 0.7299 GB, free: 4.105 MB / 0.5137 GB
Notification: Performance of matching and sorting (n=725): time 0.0508/0.8502, allocations: 16.84 MB / 0.7464 GB, free: 3.27 MB / 0.5294 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.000162/0.8504, allocations: 364.4 kB / 0.7467 GB, free: 2.844 MB / 0.5294 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.01216/0.8626, allocations: 8.376 MB / 0.7549 GB, free: 10.52 MB / 0.545 GB
Notification: Performance of collectPreVariables (initialization): time 0.001425/0.864, allocations: 194.8 kB / 0.7551 GB, free: 10.32 MB / 0.545 GB
Notification: Performance of collectInitialEqns (initialization): time 0.003696/0.8677, allocations: 4.33 MB / 0.7593 GB, free: 6.035 MB / 0.545 GB
Notification: Performance of collectInitialBindings (initialization): time 0.00339/0.8711, allocations: 2.837 MB / 0.7621 GB, free: 3.219 MB / 0.545 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.1685/1.04, allocations: 3.747 MB / 0.7658 GB, free: 208.3 MB / 0.545 GB
Notification: Performance of setup shared object (initialization): time 3.723e-05/1.04, allocations: 304.4 kB / 0.766 GB, free: 208 MB / 0.545 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.009307/1.049, allocations: 5.922 MB / 0.7718 GB, free: 207.8 MB / 0.545 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.009605/1.059, allocations: 8.08 MB / 0.7797 GB, free: 206.4 MB / 0.545 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.01478/1.073, allocations: 11.47 MB / 0.7909 GB, free: 202.1 MB / 0.545 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 4.442e-05/1.073, allocations: 11.25 kB / 0.7909 GB, free: 202.1 MB / 0.545 GB
Notification: Performance of matching and sorting (n=2671) (initialization): time 0.03722/1.111, allocations: 20.61 MB / 0.8111 GB, free: 194.6 MB / 0.545 GB
Notification: Performance of prepare postOptimizeDAE: time 4.892e-05/1.111, allocations: 16.67 kB / 0.8111 GB, free: 194.6 MB / 0.545 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 6.143e-05/1.111, allocations: 31.97 kB / 0.8111 GB, free: 194.6 MB / 0.545 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.02642/1.137, allocations: 5.391 MB / 0.8164 GB, free: 193.6 MB / 0.545 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01385/1.151, allocations: 3.955 MB / 0.8202 GB, free: 190.1 MB / 0.545 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.05303/1.204, allocations: 58.26 MB / 0.8771 GB, free: 133.1 MB / 0.545 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01527/1.22, allocations: 1.433 MB / 0.8785 GB, free: 132.4 MB / 0.545 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001586/1.221, allocations: 0.6476 MB / 0.8792 GB, free: 131.8 MB / 0.545 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.01125/1.232, allocations: 7.163 MB / 0.8862 GB, free: 125.1 MB / 0.545 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.008267/1.241, allocations: 7.838 MB / 0.8938 GB, free: 117.7 MB / 0.545 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.01266/1.253, allocations: 11.16 MB / 0.9047 GB, free: 106.4 MB / 0.545 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 3.025e-05/1.253, allocations: 8 kB / 0.9047 GB, free: 106.4 MB / 0.545 GB
Notification: Performance of matching and sorting (n=2671) (initialization_lambda0): time 0.02676/1.28, allocations: 18.87 MB / 0.9232 GB, free: 88.17 MB / 0.545 GB
Notification: Performance of prepare postOptimizeDAE: time 4.08e-05/1.28, allocations: 20 kB / 0.9232 GB, free: 88.15 MB / 0.545 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 5.444e-05/1.28, allocations: 31.98 kB / 0.9232 GB, free: 88.12 MB / 0.545 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.02131/1.302, allocations: 4.247 MB / 0.9273 GB, free: 83.81 MB / 0.545 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01343/1.315, allocations: 4.115 MB / 0.9314 GB, free: 79.69 MB / 0.545 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.03553/1.351, allocations: 49.73 MB / 0.9799 GB, free: 26.54 MB / 0.545 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01546/1.366, allocations: 1.124 MB / 0.981 GB, free: 25.62 MB / 0.545 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001265/1.367, allocations: 0.6483 MB / 0.9817 GB, free: 24.97 MB / 0.545 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.002301/1.37, allocations: 1.024 MB / 0.9827 GB, free: 23.96 MB / 0.545 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.001836/1.372, allocations: 0.9571 MB / 0.9836 GB, free: 22.99 MB / 0.545 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01258/1.384, allocations: 7.939 MB / 0.9913 GB, free: 14.97 MB / 0.545 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 4.772e-05/1.384, allocations: 35.86 kB / 0.9914 GB, free: 14.94 MB / 0.545 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.207e-05/1.384, allocations: 4 kB / 0.9914 GB, free: 14.93 MB / 0.545 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.003808/1.388, allocations: 2.011 MB / 0.9933 GB, free: 12.96 MB / 0.545 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.001338/1.389, allocations: 132 kB / 0.9935 GB, free: 12.83 MB / 0.545 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.005474/1.395, allocations: 319.8 kB / 0.9938 GB, free: 12.52 MB / 0.545 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0006875/1.396, allocations: 0.5475 MB / 0.9943 GB, free: 11.96 MB / 0.545 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.01493/1.41, allocations: 7.929 MB / 1.002 GB, free: 4.117 MB / 0.545 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.1882/1.599, allocations: 9.554 MB / 1.011 GB, free: 181.4 MB / 0.545 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.003331/1.602, allocations: 2.614 MB / 1.014 GB, free: 181.3 MB / 0.545 GB
Notification: Performance of sorting global known variables: time 0.00684/1.609, allocations: 5.098 MB / 1.019 GB, free: 181.1 MB / 0.545 GB
Notification: Performance of Backend: time 2.71e-07/1.609, allocations: 0 / 1.019 GB, free: 181.1 MB / 0.545 GB
Notification: Performance of simCode: created initialization part: time 0.05321/1.662, allocations: 32.49 MB / 1.051 GB, free: 171.3 MB / 0.545 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.02864/1.691, allocations: 18.66 MB / 1.069 GB, free: 162.9 MB / 0.545 GB
Notification: Performance of Templates: time 0.4431/2.134, allocations: 237.7 MB / 1.301 GB, free: 115.4 MB / 0.545 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)