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.001483/0.001483, allocations: 114.9 kB / 17.74 MB, free: 5.293 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.001717/0.001717, allocations: 188.4 kB / 18.67 MB, free: 4.375 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.356/1.356, allocations: 222.9 MB / 242.4 MB, free: 15.07 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerSystems 2.0.0-master/package.mo): time 0.2631/0.2631, allocations: 38.04 MB / 330.6 MB, free: 8.758 MB / 270.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.001337/0.001337, allocations: 59.91 kB / 458.8 MB, free: 6.859 MB / 334.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.3476/0.3489, allocations: 58.05 MB / 0.5048 GB, free: 7.73 MB / 382.1 MB
Notification: Performance of NFInst.instantiate(PowerSystems.Examples.AC3ph.Transformation.PhaseShifts): time 0.01081/0.3598, allocations: 11.33 MB / 0.5158 GB, free: 15.75 MB / 398.1 MB
Notification: Performance of NFInst.instExpressions: time 0.008506/0.3683, allocations: 4.199 MB / 0.5199 GB, free: 12.79 MB / 398.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001581/0.37, allocations: 46.34 kB / 0.52 GB, free: 12.78 MB / 398.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.004415/0.3744, allocations: 1.425 MB / 0.5214 GB, free: 11.95 MB / 398.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.004654/0.379, allocations: 1.517 MB / 0.5228 GB, free: 11.13 MB / 398.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.003003/0.3821, allocations: 0.8923 MB / 0.5237 GB, free: 10.73 MB / 398.1 MB
Notification: Performance of NFFlatten.flatten: time 0.005954/0.3881, allocations: 3.293 MB / 0.5269 GB, free: 9.383 MB / 398.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.001904/0.39, allocations: 1.032 MB / 0.5279 GB, free: 8.941 MB / 398.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.003573/0.3936, allocations: 1.383 MB / 0.5293 GB, free: 8.344 MB / 398.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.0039/0.3975, allocations: 1.893 MB / 0.5311 GB, free: 7.703 MB / 398.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.0007131/0.3983, allocations: 175.6 kB / 0.5313 GB, free: 7.703 MB / 398.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.002335/0.4006, allocations: 0.7376 MB / 0.532 GB, free: 7.422 MB / 398.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.001902/0.4026, allocations: 1.292 MB / 0.5333 GB, free: 6.633 MB / 398.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.002206/0.4048, allocations: 1.203 MB / 0.5345 GB, free: 5.836 MB / 398.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.004558/0.4093, allocations: 3.169 MB / 0.5376 GB, free: 3.762 MB / 398.1 MB
Notification: Performance of FrontEnd - DAE generated: time 7.504e-06/0.4094, allocations: 1.031 kB / 0.5376 GB, free: 3.762 MB / 398.1 MB
Notification: Performance of FrontEnd: time 4.559e-06/0.4094, allocations: 0 / 0.5376 GB, free: 3.762 MB / 398.1 MB
Notification: Performance of Transformations before backend: time 9.437e-05/0.4095, allocations: 3.938 kB / 0.5376 GB, free: 3.758 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.006198/0.4157, allocations: 2.534 MB / 0.54 GB, free: 1.977 MB / 398.1 MB
Notification: Performance of prepare preOptimizeDAE: time 3.809e-05/0.4157, allocations: 9.219 kB / 0.54 GB, free: 1.977 MB / 398.1 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.002549/0.4183, allocations: 478 kB / 0.5405 GB, free: 1.742 MB / 398.1 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.002719/0.421, allocations: 1.412 MB / 0.5419 GB, free: 0.7695 MB / 398.1 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001121/0.4212, allocations: 138.9 kB / 0.542 GB, free: 0.707 MB / 398.1 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0005004/0.4217, allocations: 231.6 kB / 0.5422 GB, free: 0.6172 MB / 398.1 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.005542/0.4272, allocations: 3.137 MB / 0.5453 GB, free: 14.61 MB / 414.1 MB
Notification: Performance of preOpt findStateOrder (simulation): time 7.359e-05/0.4273, allocations: 15 kB / 0.5453 GB, free: 14.61 MB / 414.1 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0002054/0.4275, allocations: 79.38 kB / 0.5454 GB, free: 14.55 MB / 414.1 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0008139/0.4284, allocations: 323 kB / 0.5457 GB, free: 14.31 MB / 414.1 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.004352/0.4327, allocations: 2.572 MB / 0.5482 GB, free: 11.72 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.01676/0.4495, allocations: 13.54 MB / 0.5614 GB, free: 13.36 MB / 430.1 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.002033/0.4516, allocations: 1.484 MB / 0.5629 GB, free: 11.82 MB / 430.1 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0009049/0.4525, allocations: 0.6486 MB / 0.5635 GB, free: 11.18 MB / 430.1 MB
Notification: Performance of preOpt evalFunc (simulation): time 7.696e-05/0.4526, allocations: 29.28 kB / 0.5635 GB, free: 11.15 MB / 430.1 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 4.834e-05/0.4526, allocations: 43.88 kB / 0.5636 GB, free: 11.1 MB / 430.1 MB
Notification: Performance of pre-optimization done (n=132): time 3.586e-06/0.4526, allocations: 3.938 kB / 0.5636 GB, free: 11.09 MB / 430.1 MB
Notification: Performance of matching and sorting (n=134): time 0.006902/0.4596, allocations: 4.095 MB / 0.5676 GB, free: 6.898 MB / 430.1 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 7.313e-05/0.4597, allocations: 90.42 kB / 0.5677 GB, free: 6.789 MB / 430.1 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001598/0.4613, allocations: 1.269 MB / 0.5689 GB, free: 5.504 MB / 430.1 MB
Notification: Performance of collectPreVariables (initialization): time 9.094e-05/0.4614, allocations: 45.7 kB / 0.569 GB, free: 5.453 MB / 430.1 MB
Notification: Performance of collectInitialEqns (initialization): time 0.000697/0.4621, allocations: 1.092 MB / 0.57 GB, free: 4.344 MB / 430.1 MB
Notification: Performance of collectInitialBindings (initialization): time 0.0003756/0.4624, allocations: 485.2 kB / 0.5705 GB, free: 3.863 MB / 430.1 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0005173/0.463, allocations: 407.6 kB / 0.5709 GB, free: 3.457 MB / 430.1 MB
Notification: Performance of setup shared object (initialization): time 9.824e-05/0.4631, allocations: 301.1 kB / 0.5712 GB, free: 3.16 MB / 430.1 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001055/0.4641, allocations: 0.6835 MB / 0.5718 GB, free: 2.473 MB / 430.1 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001608/0.4658, allocations: 1.587 MB / 0.5734 GB, free: 468 kB / 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.009797/0.4756, allocations: 4.605 MB / 0.5779 GB, free: 11.41 MB / 446.1 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 3.684e-05/0.4756, allocations: 8 kB / 0.5779 GB, free: 11.41 MB / 446.1 MB
Notification: Performance of matching and sorting (n=280) (initialization): time 0.005492/0.4811, allocations: 3.043 MB / 0.5809 GB, free: 8.316 MB / 446.1 MB
Notification: Performance of prepare postOptimizeDAE: time 3.815e-05/0.4812, allocations: 23.94 kB / 0.5809 GB, free: 8.293 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.001005/0.4822, allocations: 0.6123 MB / 0.5815 GB, free: 7.676 MB / 446.1 MB
Error: post-optimization module simplifyComplexFunction (initialization) failed.
Error: No system for the symbolic initialization was generated