Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr PowerSystems_latest_PowerSystems.Examples.AC3ph.Transformation.PhaseShifts.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/PowerSystems 2.0.0-master/package.mo", uses=false)
Using package PowerSystems with version 2.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerSystems 2.0.0-master/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(PowerSystems.Examples.AC3ph.Transformation.PhaseShifts,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="Time|meter1.alpha_v|meter1.p.1.|meter1.p.2.|meter1.p.3.|meter1.v_norm|meter12.alpha_v|meter12.p.1.|meter12.p.2.|meter12.p.3.|meter12.v_norm|meter22.alpha_v|meter22.p.1.|meter22.p.2.|meter22.p.3.|meter22.v_norm|meter32.alpha_v|meter32.p.1.|meter32.p.2.|meter32.p.3.|meter32.v_norm",fileNamePrefix="PowerSystems_latest_PowerSystems.Examples.AC3ph.Transformation.PhaseShifts")
translateModel(PowerSystems.Examples.AC3ph.Transformation.PhaseShifts,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="Time|meter1.alpha_v|meter1.p.1.|meter1.p.2.|meter1.p.3.|meter1.v_norm|meter12.alpha_v|meter12.p.1.|meter12.p.2.|meter12.p.3.|meter12.v_norm|meter22.alpha_v|meter22.p.1.|meter22.p.2.|meter22.p.3.|meter22.v_norm|meter32.alpha_v|meter32.p.1.|meter32.p.2.|meter32.p.3.|meter32.v_norm",fileNamePrefix="PowerSystems_latest_PowerSystems.Examples.AC3ph.Transformation.PhaseShifts")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001781/0.001781, allocations: 108.7 kB / 17.06 MB, free: 6.023 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.0023/0.002301, allocations: 192 kB / 18 MB, free: 5.105 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.46/1.46, allocations: 222.9 MB / 241.7 MB, free: 15.17 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerSystems 2.0.0-master/package.mo): time 0.186/0.186, allocations: 38.04 MB / 329.9 MB, free: 8.754 MB / 270.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.00225/0.00225, allocations: 71.83 kB / 458.2 MB, free: 6.84 MB / 334.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.4353/0.4376, allocations: 58.05 MB / 0.5041 GB, free: 7.766 MB / 382.1 MB
Notification: Performance of NFInst.instantiate(PowerSystems.Examples.AC3ph.Transformation.PhaseShifts): time 0.01813/0.4557, allocations: 11.33 MB / 0.5152 GB, free: 15.79 MB / 398.1 MB
Notification: Performance of NFInst.instExpressions: time 0.01294/0.4687, allocations: 4.195 MB / 0.5193 GB, free: 12.84 MB / 398.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.002768/0.4716, allocations: 53.62 kB / 0.5193 GB, free: 12.81 MB / 398.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.005778/0.4774, allocations: 1.419 MB / 0.5207 GB, free: 11.99 MB / 398.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.006639/0.4841, allocations: 1.522 MB / 0.5222 GB, free: 11.17 MB / 398.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.003856/0.488, allocations: 0.8909 MB / 0.5231 GB, free: 10.77 MB / 398.1 MB
Notification: Performance of NFFlatten.flatten: time 0.006813/0.4948, allocations: 3.295 MB / 0.5263 GB, free: 9.422 MB / 398.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.00227/0.4971, allocations: 1.028 MB / 0.5273 GB, free: 8.984 MB / 398.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.004149/0.5013, allocations: 1.389 MB / 0.5286 GB, free: 8.383 MB / 398.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.004476/0.5058, allocations: 1.896 MB / 0.5305 GB, free: 7.738 MB / 398.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.00109/0.5069, allocations: 175.7 kB / 0.5307 GB, free: 7.738 MB / 398.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.002733/0.5096, allocations: 0.724 MB / 0.5314 GB, free: 7.445 MB / 398.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.003338/0.513, allocations: 1.289 MB / 0.5326 GB, free: 6.66 MB / 398.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.004918/0.5179, allocations: 1.217 MB / 0.5338 GB, free: 5.848 MB / 398.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.007894/0.5258, allocations: 3.163 MB / 0.5369 GB, free: 3.781 MB / 398.1 MB
Notification: Performance of FrontEnd - DAE generated: time 7.574e-06/0.5259, allocations: 1.125 kB / 0.5369 GB, free: 3.781 MB / 398.1 MB
Notification: Performance of FrontEnd: time 1.974e-06/0.5259, allocations: 0 / 0.5369 GB, free: 3.781 MB / 398.1 MB
Notification: Performance of Transformations before backend: time 0.0001959/0.5261, allocations: 0 / 0.5369 GB, free: 3.781 MB / 398.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 576
 * Number of variables: 576
Notification: Performance of Generate backend data structure: time 0.01112/0.5372, allocations: 2.546 MB / 0.5394 GB, free: 1.988 MB / 398.1 MB
Notification: Performance of prepare preOptimizeDAE: time 6.719e-05/0.5373, allocations: 9.406 kB / 0.5394 GB, free: 1.988 MB / 398.1 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.003652/0.541, allocations: 482.5 kB / 0.5399 GB, free: 1.75 MB / 398.1 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.004435/0.5454, allocations: 1.394 MB / 0.5412 GB, free: 0.793 MB / 398.1 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0002203/0.5457, allocations: 143.7 kB / 0.5413 GB, free: 0.7266 MB / 398.1 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.001073/0.5468, allocations: 222.8 kB / 0.5416 GB, free: 0.6445 MB / 398.1 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.009426/0.5562, allocations: 3.15 MB / 0.5446 GB, free: 14.63 MB / 414.1 MB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0001442/0.5564, allocations: 13.53 kB / 0.5447 GB, free: 14.62 MB / 414.1 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0004666/0.5568, allocations: 80.7 kB / 0.5447 GB, free: 14.56 MB / 414.1 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0009335/0.5578, allocations: 324 kB / 0.545 GB, free: 14.35 MB / 414.1 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.006231/0.564, allocations: 2.572 MB / 0.5475 GB, free: 11.76 MB / 414.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.02057/0.5846, allocations: 13.54 MB / 0.5608 GB, free: 13.4 MB / 430.1 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.002301/0.5869, allocations: 1.472 MB / 0.5622 GB, free: 11.88 MB / 430.1 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001018/0.588, allocations: 0.6563 MB / 0.5629 GB, free: 11.22 MB / 430.1 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.0001055/0.5881, allocations: 25.22 kB / 0.5629 GB, free: 11.2 MB / 430.1 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 4.219e-05/0.5882, allocations: 47.88 kB / 0.5629 GB, free: 11.14 MB / 430.1 MB
Notification: Performance of pre-optimization done (n=132): time 7.154e-06/0.5882, allocations: 3.984 kB / 0.5629 GB, free: 11.14 MB / 430.1 MB
Notification: Performance of matching and sorting (n=134): time 0.008173/0.5964, allocations: 4.095 MB / 0.5669 GB, free: 6.941 MB / 430.1 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 6.938e-05/0.5965, allocations: 90.42 kB / 0.567 GB, free: 6.832 MB / 430.1 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002229/0.5987, allocations: 1.261 MB / 0.5682 GB, free: 5.555 MB / 430.1 MB
Notification: Performance of collectPreVariables (initialization): time 9.45e-05/0.5988, allocations: 49.7 kB / 0.5683 GB, free: 5.5 MB / 430.1 MB
Notification: Performance of collectInitialEqns (initialization): time 0.001096/0.5999, allocations: 1.092 MB / 0.5694 GB, free: 4.391 MB / 430.1 MB
Notification: Performance of collectInitialBindings (initialization): time 0.0004958/0.6004, allocations: 489.1 kB / 0.5698 GB, free: 3.906 MB / 430.1 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0006978/0.6011, allocations: 403.6 kB / 0.5702 GB, free: 3.504 MB / 430.1 MB
Notification: Performance of setup shared object (initialization): time 0.0001272/0.6013, allocations: 301.1 kB / 0.5705 GB, free: 3.207 MB / 430.1 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001253/0.6025, allocations: 0.6835 MB / 0.5712 GB, free: 2.52 MB / 430.1 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001863/0.6044, allocations: 1.587 MB / 0.5727 GB, free: 0.5039 MB / 430.1 MB
Notification: It was not possible to check the given initialization system for consistency symbolically, because the relevant equations are part of an algebraic loop. This is not supported yet.
Notification: Performance of analyzeInitialSystem (initialization): time 0.0101/0.6145, allocations: 4.605 MB / 0.5772 GB, free: 11.46 MB / 446.1 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 3.334e-05/0.6146, allocations: 8 kB / 0.5772 GB, free: 11.45 MB / 446.1 MB
Notification: Performance of matching and sorting (n=280) (initialization): time 0.005881/0.6205, allocations: 3.039 MB / 0.5802 GB, free: 8.367 MB / 446.1 MB
Notification: Performance of prepare postOptimizeDAE: time 4.69e-05/0.6205, allocations: 23.88 kB / 0.5802 GB, free: 8.344 MB / 446.1 MB
Error: Internal error IndexReduction.pantelidesIndexReduction failed! System is structurally singular and cannot be handled because the number of unassigned equations is larger than the number of states. Use -d=bltdump to get more information.
Notification: Performance of <failed> postOpt simplifyComplexFunction (initialization): time 0.001076/0.6216, allocations: 0.621 MB / 0.5808 GB, free: 7.719 MB / 446.1 MB
Error: post-optimization module simplifyComplexFunction (initialization) failed.
Error: No system for the symbolic initialization was generated