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.002145/0.002145, allocations: 111.9 kB / 17.29 MB, free: 6.219 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.002677/0.002677, allocations: 197.3 kB / 18.21 MB, free: 5.289 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 2.189/2.189, allocations: 222.9 MB / 241.9 MB, free: 15.45 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerSystems 2.0.0-master/package.mo): time 0.2573/0.2573, allocations: 38.04 MB / 330.1 MB, free: 9.047 MB / 270.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.002021/0.002021, allocations: 62.58 kB / 398.9 MB, free: 34.45 MB / 302.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1646/0.1667, allocations: 58.06 MB / 457 MB, free: 8.445 MB / 334.1 MB
Notification: Performance of NFInst.instantiate(PowerSystems.Examples.AC3ph.Transformation.PhaseShifts): time 0.02322/0.19, allocations: 13.56 MB / 470.6 MB, free: 10.82 MB / 350.1 MB
Notification: Performance of NFInst.instExpressions: time 0.01577/0.2058, allocations: 4.861 MB / 475.4 MB, free: 5.945 MB / 350.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.00309/0.2089, allocations: 95.38 kB / 475.5 MB, free: 5.852 MB / 350.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.005821/0.2148, allocations: 1.342 MB / 476.9 MB, free: 4.508 MB / 350.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.006276/0.2211, allocations: 1.405 MB / 478.3 MB, free: 3.098 MB / 350.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.004133/0.2253, allocations: 0.8307 MB / 479.1 MB, free: 2.266 MB / 350.1 MB
Notification: Performance of NFFlatten.flatten: time 0.007252/0.2326, allocations: 3.307 MB / 482.4 MB, free: 14.95 MB / 366.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.002857/0.2355, allocations: 1.11 MB / 483.5 MB, free: 13.82 MB / 366.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.003975/0.2395, allocations: 1.381 MB / 484.9 MB, free: 12.44 MB / 366.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.0052/0.2447, allocations: 2.072 MB / 487 MB, free: 10.36 MB / 366.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.0006269/0.2454, allocations: 180 kB / 487.1 MB, free: 10.18 MB / 366.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.002492/0.2479, allocations: 0.7255 MB / 487.9 MB, free: 9.457 MB / 366.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.002214/0.2501, allocations: 1.298 MB / 489.2 MB, free: 8.156 MB / 366.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.002441/0.2526, allocations: 1.205 MB / 490.4 MB, free: 6.945 MB / 366.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.00465/0.2573, allocations: 2.436 MB / 492.8 MB, free: 4.504 MB / 366.1 MB
Notification: Performance of FrontEnd - DAE generated: time 8.216e-06/0.2573, allocations: 0 / 492.8 MB, free: 4.504 MB / 366.1 MB
Notification: Performance of FrontEnd: time 2.916e-06/0.2573, allocations: 0 / 492.8 MB, free: 4.504 MB / 366.1 MB
Notification: Performance of Transformations before backend: time 9.28e-05/0.2574, allocations: 0 / 492.8 MB, free: 4.504 MB / 366.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.008699/0.2661, allocations: 2.539 MB / 495.3 MB, free: 1.902 MB / 366.1 MB
Notification: Performance of prepare preOptimizeDAE: time 6.162e-05/0.2662, allocations: 11.97 kB / 495.4 MB, free: 1.891 MB / 366.1 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.004426/0.2707, allocations: 477.5 kB / 495.8 MB, free: 1.422 MB / 366.1 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.004278/0.275, allocations: 1.332 MB / 497.2 MB, free: 44 kB / 366.1 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0002124/0.2752, allocations: 148.1 kB / 497.3 MB, free: 15.89 MB / 382.1 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0008253/0.2761, allocations: 223.9 kB / 497.5 MB, free: 15.68 MB / 382.1 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.008503/0.2846, allocations: 3.139 MB / 0.4889 GB, free: 12.33 MB / 382.1 MB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0001039/0.2847, allocations: 19.84 kB / 0.4889 GB, free: 12.31 MB / 382.1 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0003435/0.2851, allocations: 79.97 kB / 0.489 GB, free: 12.23 MB / 382.1 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.001353/0.2865, allocations: 323.8 kB / 0.4893 GB, free: 11.91 MB / 382.1 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.007792/0.2943, allocations: 2.568 MB / 0.4918 GB, free: 9.328 MB / 382.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.3642/0.6585, allocations: 13.62 MB / 0.5051 GB, free: 48.36 MB / 382.1 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.003795/0.6623, allocations: 1.472 MB / 0.5066 GB, free: 48.11 MB / 382.1 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001635/0.664, allocations: 0.6479 MB / 0.5072 GB, free: 48.09 MB / 382.1 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.000128/0.6642, allocations: 26.67 kB / 0.5072 GB, free: 48.09 MB / 382.1 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 4.418e-05/0.6642, allocations: 49.45 kB / 0.5073 GB, free: 48.05 MB / 382.1 MB
Notification: Performance of pre-optimization done (n=132): time 5.641e-06/0.6642, allocations: 0 / 0.5073 GB, free: 48.05 MB / 382.1 MB
Notification: Performance of matching and sorting (n=134): time 0.0108/0.675, allocations: 4.086 MB / 0.5113 GB, free: 46.26 MB / 382.1 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 6.659e-05/0.6751, allocations: 91.95 kB / 0.5114 GB, free: 46.16 MB / 382.1 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002732/0.6779, allocations: 1.267 MB / 0.5126 GB, free: 45.68 MB / 382.1 MB
Notification: Performance of collectPreVariables (initialization): time 0.0001601/0.6781, allocations: 54.77 kB / 0.5127 GB, free: 45.62 MB / 382.1 MB
Notification: Performance of collectInitialEqns (initialization): time 0.001089/0.6792, allocations: 1.091 MB / 0.5137 GB, free: 44.78 MB / 382.1 MB
Notification: Performance of collectInitialBindings (initialization): time 0.0005836/0.6798, allocations: 479 kB / 0.5142 GB, free: 44.42 MB / 382.1 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.00087/0.6807, allocations: 410.8 kB / 0.5146 GB, free: 44.23 MB / 382.1 MB
Notification: Performance of setup shared object (initialization): time 7.181e-05/0.6808, allocations: 302.3 kB / 0.5149 GB, free: 43.93 MB / 382.1 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.002167/0.6829, allocations: 0.6785 MB / 0.5155 GB, free: 43.73 MB / 382.1 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.002548/0.6855, allocations: 1.589 MB / 0.5171 GB, free: 42.37 MB / 382.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.01806/0.7036, allocations: 4.623 MB / 0.5216 GB, free: 39.98 MB / 382.1 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 7.62e-05/0.7037, allocations: 8.125 kB / 0.5216 GB, free: 39.98 MB / 382.1 MB
Notification: Performance of matching and sorting (n=280) (initialization): time 0.00935/0.7131, allocations: 3.057 MB / 0.5246 GB, free: 38.77 MB / 382.1 MB
Notification: Performance of prepare postOptimizeDAE: time 5.803e-05/0.7132, allocations: 20.38 kB / 0.5246 GB, free: 38.77 MB / 382.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.00164/0.7148, allocations: 0.6172 MB / 0.5252 GB, free: 38.52 MB / 382.1 MB
Error: post-optimization module simplifyComplexFunction (initialization) failed.
Error: No system for the symbolic initialization was generated