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.00142/0.00142, allocations: 101.1 kB / 16.27 MB, free: 6.414 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.001592/0.001592, allocations: 190.3 kB / 17.2 MB, free: 5.953 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.39/1.39, allocations: 222.9 MB / 240.9 MB, free: 15.28 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerGrids 2.0.0-develop/package.mo): time 0.07584/0.07584, allocations: 16.78 MB / 307.8 MB, free: 14.51 MB / 254.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.00144/0.00144, allocations: 60.64 kB / 372.4 MB, free: 48.71 MB / 302.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.09026/0.09172, allocations: 53.58 MB / 426 MB, free: 12.69 MB / 302.1 MB
Notification: Performance of NFInst.instantiate(PowerGrids.Examples.Tutorial.IslandOperation.TwoGeneratorsLocalInitialization): time 0.325/0.4168, allocations: 95.07 MB / 0.5089 GB, free: 16.12 MB / 382.1 MB
Notification: Performance of NFInst.instExpressions: time 0.04051/0.4573, allocations: 23.59 MB / 0.5319 GB, free: 13.77 MB / 382.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.01628/0.4736, allocations: 246 kB / 0.5321 GB, free: 13.77 MB / 382.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.01292/0.4866, allocations: 3.048 MB / 0.5351 GB, free: 13.32 MB / 382.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.02957/0.5162, allocations: 8.265 MB / 0.5432 GB, free: 8.48 MB / 382.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.01412/0.5303, allocations: 5.351 MB / 0.5484 GB, free: 5.094 MB / 382.1 MB
Notification: Performance of NFFlatten.flatten: time 0.03338/0.5637, allocations: 20.81 MB / 0.5687 GB, free: 8.02 MB / 398.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.01151/0.5753, allocations: 5.169 MB / 0.5738 GB, free: 2.887 MB / 398.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.01542/0.5907, allocations: 6.895 MB / 0.5805 GB, free: 12.07 MB / 414.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.01545/0.6062, allocations: 7.297 MB / 0.5876 GB, free: 4.957 MB / 414.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.005272/0.6116, allocations: 1.199 MB / 0.5888 GB, free: 3.758 MB / 414.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.01053/0.6221, allocations: 2.132 MB / 0.5909 GB, free: 1.629 MB / 414.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.00492/0.6271, allocations: 2.554 MB / 0.5934 GB, free: 15.14 MB / 430.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.01513/0.6422, allocations: 6.865 MB / 0.6001 GB, free: 8.328 MB / 430.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.02941/0.6717, allocations: 17.52 MB / 0.6172 GB, free: 7.371 MB / 446.1 MB
Notification: Performance of FrontEnd - DAE generated: time 8.135e-06/0.6717, allocations: 0 / 0.6172 GB, free: 7.371 MB / 446.1 MB
Notification: Performance of FrontEnd: time 5.04e-06/0.6718, allocations: 3.938 kB / 0.6172 GB, free: 7.367 MB / 446.1 MB
Notification: Performance of Transformations before backend: time 0.000652/0.6724, allocations: 3.938 kB / 0.6172 GB, free: 7.363 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.06085/0.7333, allocations: 15.67 MB / 0.6325 GB, free: 7.758 MB / 462.1 MB
Notification: Performance of prepare preOptimizeDAE: time 5.705e-05/0.7334, allocations: 8.031 kB / 0.6325 GB, free: 7.75 MB / 462.1 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01642/0.7498, allocations: 2.571 MB / 0.635 GB, free: 5.184 MB / 462.1 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.02067/0.7705, allocations: 7.385 MB / 0.6422 GB, free: 13.87 MB / 478.1 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.000699/0.7713, allocations: 0.7124 MB / 0.6429 GB, free: 13.15 MB / 478.1 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.002309/0.7736, allocations: 0.8399 MB / 0.6437 GB, free: 12.31 MB / 478.1 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.0177/0.7913, allocations: 9.484 MB / 0.653 GB, free: 1.859 MB / 478.1 MB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0001461/0.7915, allocations: 43.56 kB / 0.653 GB, free: 1.816 MB / 478.1 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0009426/0.7924, allocations: 352 kB / 0.6534 GB, free: 1.473 MB / 478.1 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001527/0.7926, allocations: 212 kB / 0.6536 GB, free: 1.266 MB / 478.1 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.01534/0.8079, allocations: 7.681 MB / 0.6611 GB, free: 9.566 MB / 494.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.5686/1.377, allocations: 59.16 MB / 0.7189 GB, free: 158.4 MB / 0.5138 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.01534/1.392, allocations: 8.719 MB / 0.7274 GB, free: 156.3 MB / 0.5138 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.006024/1.398, allocations: 3.053 MB / 0.7304 GB, free: 155.9 MB / 0.5138 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0003673/1.398, allocations: 109.4 kB / 0.7305 GB, free: 155.8 MB / 0.5138 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0001181/1.399, allocations: 123.5 kB / 0.7306 GB, free: 155.7 MB / 0.5138 GB
Notification: Performance of pre-optimization done (n=725): time 1.05e-05/1.399, allocations: 3.906 kB / 0.7306 GB, free: 155.7 MB / 0.5138 GB
Notification: Performance of matching and sorting (n=725): time 0.05725/1.456, allocations: 16.85 MB / 0.747 GB, free: 150.5 MB / 0.5138 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001275/1.456, allocations: 366.5 kB / 0.7474 GB, free: 150.1 MB / 0.5138 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.01635/1.472, allocations: 8.375 MB / 0.7556 GB, free: 145.9 MB / 0.5138 GB
Notification: Performance of collectPreVariables (initialization): time 0.002217/1.475, allocations: 189.8 kB / 0.7557 GB, free: 145.7 MB / 0.5138 GB
Notification: Performance of collectInitialEqns (initialization): time 0.004991/1.48, allocations: 4.321 MB / 0.76 GB, free: 142.8 MB / 0.5138 GB
Notification: Performance of collectInitialBindings (initialization): time 0.004489/1.484, allocations: 2.835 MB / 0.7627 GB, free: 140.4 MB / 0.5138 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.01212/1.496, allocations: 3.749 MB / 0.7664 GB, free: 138.1 MB / 0.5138 GB
Notification: Performance of setup shared object (initialization): time 6.086e-05/1.496, allocations: 305.1 kB / 0.7667 GB, free: 137.8 MB / 0.5138 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.01269/1.509, allocations: 5.922 MB / 0.7725 GB, free: 133.5 MB / 0.5138 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.01551/1.525, allocations: 8.075 MB / 0.7803 GB, free: 125 MB / 0.5138 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.02814/1.553, allocations: 11.48 MB / 0.7916 GB, free: 113.2 MB / 0.5138 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0001535/1.553, allocations: 10.34 kB / 0.7916 GB, free: 113.2 MB / 0.5138 GB
Notification: Performance of matching and sorting (n=2671) (initialization): time 0.06172/1.615, allocations: 20.61 MB / 0.8117 GB, free: 92.47 MB / 0.5138 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001213/1.615, allocations: 20.2 kB / 0.8117 GB, free: 92.45 MB / 0.5138 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001256/1.615, allocations: 33.56 kB / 0.8117 GB, free: 92.42 MB / 0.5138 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.02808/1.643, allocations: 5.302 MB / 0.8169 GB, free: 87.05 MB / 0.5138 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01781/1.661, allocations: 3.955 MB / 0.8208 GB, free: 83.09 MB / 0.5138 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.06/1.721, allocations: 58.26 MB / 0.8777 GB, free: 21.24 MB / 0.5138 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.02324/1.744, allocations: 1.432 MB / 0.8791 GB, free: 19.8 MB / 0.5138 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.004082/1.748, allocations: 0.6483 MB / 0.8797 GB, free: 19.15 MB / 0.5138 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.01923/1.768, allocations: 7.156 MB / 0.8867 GB, free: 11.98 MB / 0.5138 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.01512/1.783, allocations: 7.845 MB / 0.8944 GB, free: 3.695 MB / 0.5138 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.3589/2.142, allocations: 11.15 MB / 0.9053 GB, free: 160.9 MB / 0.5138 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 0.0001332/2.142, allocations: 11.14 kB / 0.9053 GB, free: 160.9 MB / 0.5138 GB
Notification: Performance of matching and sorting (n=2671) (initialization_lambda0): time 0.0563/2.198, allocations: 18.88 MB / 0.9237 GB, free: 156.5 MB / 0.5138 GB
Notification: Performance of prepare postOptimizeDAE: time 5.56e-05/2.198, allocations: 18.22 kB / 0.9237 GB, free: 156.5 MB / 0.5138 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 8.027e-05/2.199, allocations: 30.44 kB / 0.9238 GB, free: 156.5 MB / 0.5138 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.02356/2.222, allocations: 4.16 MB / 0.9278 GB, free: 156.1 MB / 0.5138 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01865/2.241, allocations: 4.111 MB / 0.9318 GB, free: 155.7 MB / 0.5138 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.04448/2.285, allocations: 49.73 MB / 0.9804 GB, free: 113.4 MB / 0.5138 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.02118/2.307, allocations: 1.123 MB / 0.9815 GB, free: 113.1 MB / 0.5138 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.004091/2.311, allocations: 0.6476 MB / 0.9821 GB, free: 112.8 MB / 0.5138 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.005265/2.316, allocations: 1.028 MB / 0.9831 GB, free: 111.7 MB / 0.5138 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.004032/2.32, allocations: 0.9596 MB / 0.9841 GB, free: 111.3 MB / 0.5138 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01618/2.336, allocations: 7.942 MB / 0.9918 GB, free: 104.4 MB / 0.5138 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.00017/2.336, allocations: 39.86 kB / 0.9919 GB, free: 104.4 MB / 0.5138 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.423e-05/2.336, allocations: 0 / 0.9919 GB, free: 104.4 MB / 0.5138 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.008375/2.345, allocations: 2.013 MB / 0.9938 GB, free: 103.1 MB / 0.5138 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.003876/2.349, allocations: 128 kB / 0.9939 GB, free: 103 MB / 0.5138 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.009717/2.359, allocations: 321.1 kB / 0.9943 GB, free: 102.8 MB / 0.5138 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.001147/2.36, allocations: 0.5382 MB / 0.9948 GB, free: 102.5 MB / 0.5138 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.01784/2.378, allocations: 7.933 MB / 1.003 GB, free: 95.56 MB / 0.5138 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.01526/2.393, allocations: 9.556 MB / 1.012 GB, free: 85.9 MB / 0.5138 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.003641/2.397, allocations: 2.618 MB / 1.014 GB, free: 83.27 MB / 0.5138 GB
Notification: Performance of sorting global known variables: time 0.009162/2.406, allocations: 5.092 MB / 1.019 GB, free: 78.22 MB / 0.5138 GB
Notification: Performance of Backend: time 3.71e-07/2.406, allocations: 4 kB / 1.019 GB, free: 78.21 MB / 0.5138 GB
Notification: Performance of simCode: created initialization part: time 0.08245/2.488, allocations: 32.48 MB / 1.051 GB, free: 45.22 MB / 0.5138 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.05593/2.544, allocations: 21.4 MB / 1.072 GB, free: 23.98 MB / 0.5138 GB
[CodegenCpp.tpl:12250:11-12250:11:writable] Error: Template error: Unsupported zero crossing at 0: GEN1.TGOV.firstOrderLim.G.y >= 0.0 and GEN1.TGOV.firstOrderLim.I.y > GEN1.TGOV.firstOrderLim.lim.uMax or GEN1.TGOV.firstOrderLim.G.y <= 0.0 and GEN1.TGOV.firstOrderLim.I.y < GEN1.TGOV.firstOrderLim.lim.uMin.
[CodegenCpp.tpl:12250:11-12250:11:writable] Error: Template error: Unsupported zero crossing at 1: GEN1.AVR.firstOrderLim.G.y >= 0.0 and GEN1.AVR.firstOrderLim.I.y > GEN1.AVR.firstOrderLim.lim.uMax or GEN1.AVR.firstOrderLim.G.y <= 0.0 and GEN1.AVR.firstOrderLim.I.y < GEN1.AVR.firstOrderLim.lim.uMin.
[CodegenCpp.tpl:12250:11-12250:11:writable] Error: Template error: Unsupported zero crossing at 2: GEN2.TGOV.firstOrderLim.G.y >= 0.0 and GEN2.TGOV.firstOrderLim.I.y > GEN2.TGOV.firstOrderLim.lim.uMax or GEN2.TGOV.firstOrderLim.G.y <= 0.0 and GEN2.TGOV.firstOrderLim.I.y < GEN2.TGOV.firstOrderLim.lim.uMin.
[CodegenCpp.tpl:12250:11-12250:11:writable] Error: Template error: Unsupported zero crossing at 3: GEN2.AVR.firstOrderLim.G.y >= 0.0 and GEN2.AVR.firstOrderLim.I.y > GEN2.AVR.firstOrderLim.lim.uMax or GEN2.AVR.firstOrderLim.G.y <= 0.0 and GEN2.AVR.firstOrderLim.I.y < GEN2.AVR.firstOrderLim.lim.uMin.
Error: Internal error SimCode DAEmode: The model PowerGrids.Examples.Tutorial.IslandOperation.TwoGeneratorsLocalInitialization could not be translated