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.00111/0.00111, allocations: 105.1 kB / 17.06 MB, free: 6.098 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.001291/0.001291, allocations: 200.1 kB / 18 MB, free: 5.168 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.441/1.441, allocations: 222.9 MB / 241.7 MB, free: 15.06 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerSystems 2.0.0-master/package.mo): time 0.2493/0.2493, allocations: 38.04 MB / 329.9 MB, free: 8.742 MB / 270.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.001706/0.001706, allocations: 63.89 kB / 458.2 MB, free: 6.852 MB / 334.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.4007/0.4024, allocations: 58.05 MB / 0.5041 GB, free: 7.699 MB / 382.1 MB
Notification: Performance of NFInst.instantiate(PowerSystems.Examples.AC3ph.Transformation.PhaseShifts): time 0.01258/0.415, allocations: 11.32 MB / 0.5152 GB, free: 15.73 MB / 398.1 MB
Notification: Performance of NFInst.instExpressions: time 0.0104/0.4255, allocations: 4.197 MB / 0.5193 GB, free: 12.77 MB / 398.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.002187/0.4277, allocations: 48.09 kB / 0.5193 GB, free: 12.75 MB / 398.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.00415/0.4318, allocations: 1.427 MB / 0.5207 GB, free: 11.93 MB / 398.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.005594/0.4375, allocations: 1.502 MB / 0.5222 GB, free: 11.12 MB / 398.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.003247/0.4407, allocations: 0.8969 MB / 0.523 GB, free: 10.72 MB / 398.1 MB
Notification: Performance of NFFlatten.flatten: time 0.0062/0.4469, allocations: 3.283 MB / 0.5262 GB, free: 9.375 MB / 398.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.001901/0.4489, allocations: 1.032 MB / 0.5273 GB, free: 8.93 MB / 398.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.003702/0.4526, allocations: 1.372 MB / 0.5286 GB, free: 8.332 MB / 398.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.003582/0.4562, allocations: 1.886 MB / 0.5304 GB, free: 7.695 MB / 398.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.0004433/0.4566, allocations: 176.5 kB / 0.5306 GB, free: 7.695 MB / 398.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.002085/0.4587, allocations: 0.7342 MB / 0.5313 GB, free: 7.438 MB / 398.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.001478/0.4602, allocations: 1.288 MB / 0.5326 GB, free: 6.652 MB / 398.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.001581/0.4618, allocations: 1.206 MB / 0.5338 GB, free: 5.852 MB / 398.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.004525/0.4663, allocations: 3.18 MB / 0.5369 GB, free: 3.766 MB / 398.1 MB
Notification: Performance of FrontEnd - DAE generated: time 8.366e-06/0.4664, allocations: 1.344 kB / 0.5369 GB, free: 3.766 MB / 398.1 MB
Notification: Performance of FrontEnd: time 2.204e-06/0.4664, allocations: 7.938 kB / 0.5369 GB, free: 3.758 MB / 398.1 MB
Notification: Performance of Transformations before backend: time 6.336e-05/0.4664, allocations: 0 / 0.5369 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.005587/0.472, allocations: 2.612 MB / 0.5394 GB, free: 1.898 MB / 398.1 MB
Notification: Performance of prepare preOptimizeDAE: time 4.654e-05/0.4721, allocations: 9.062 kB / 0.5394 GB, free: 1.898 MB / 398.1 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.002536/0.4746, allocations: 487.4 kB / 0.5399 GB, free: 1.656 MB / 398.1 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.002651/0.4773, allocations: 1.411 MB / 0.5413 GB, free: 0.6836 MB / 398.1 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001269/0.4774, allocations: 152.2 kB / 0.5414 GB, free: 0.6094 MB / 398.1 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.000483/0.4779, allocations: 226.8 kB / 0.5416 GB, free: 0.5234 MB / 398.1 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.005705/0.4836, allocations: 3.141 MB / 0.5447 GB, free: 14.52 MB / 414.1 MB
Notification: Performance of preOpt findStateOrder (simulation): time 6.219e-05/0.4837, allocations: 14.47 kB / 0.5447 GB, free: 14.51 MB / 414.1 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001949/0.4839, allocations: 79.84 kB / 0.5448 GB, free: 14.45 MB / 414.1 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0008062/0.4847, allocations: 321.8 kB / 0.5451 GB, free: 14.27 MB / 414.1 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.004084/0.4888, allocations: 2.568 MB / 0.5476 GB, free: 11.68 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.01668/0.5055, allocations: 13.58 MB / 0.5609 GB, free: 13.29 MB / 430.1 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.002432/0.508, allocations: 1.472 MB / 0.5623 GB, free: 11.77 MB / 430.1 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0009005/0.5089, allocations: 0.6464 MB / 0.5629 GB, free: 11.12 MB / 430.1 MB
Notification: Performance of preOpt evalFunc (simulation): time 8.073e-05/0.509, allocations: 25.23 kB / 0.563 GB, free: 11.09 MB / 430.1 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 4.94e-05/0.5091, allocations: 59.8 kB / 0.563 GB, free: 11.03 MB / 430.1 MB
Notification: Performance of pre-optimization done (n=132): time 4.348e-06/0.5091, allocations: 3.984 kB / 0.563 GB, free: 11.02 MB / 430.1 MB
Notification: Performance of matching and sorting (n=134): time 0.006973/0.5161, allocations: 4.14 MB / 0.5671 GB, free: 6.789 MB / 430.1 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 6.784e-05/0.5162, allocations: 94.42 kB / 0.5672 GB, free: 6.676 MB / 430.1 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001638/0.5178, allocations: 1.265 MB / 0.5684 GB, free: 5.395 MB / 430.1 MB
Notification: Performance of collectPreVariables (initialization): time 8.304e-05/0.5179, allocations: 45.7 kB / 0.5684 GB, free: 5.344 MB / 430.1 MB
Notification: Performance of collectInitialEqns (initialization): time 0.0007541/0.5187, allocations: 1.127 MB / 0.5695 GB, free: 4.203 MB / 430.1 MB
Notification: Performance of collectInitialBindings (initialization): time 0.0004073/0.5191, allocations: 0.5036 MB / 0.57 GB, free: 3.695 MB / 430.1 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0005238/0.5196, allocations: 403.9 kB / 0.5704 GB, free: 3.293 MB / 430.1 MB
Notification: Performance of setup shared object (initialization): time 0.0001129/0.5197, allocations: 309.1 kB / 0.5707 GB, free: 2.988 MB / 430.1 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001052/0.5208, allocations: 0.6796 MB / 0.5714 GB, free: 2.305 MB / 430.1 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001723/0.5225, allocations: 1.583 MB / 0.5729 GB, free: 300 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.009603/0.5321, allocations: 4.613 MB / 0.5774 GB, free: 11.24 MB / 446.1 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 2.21e-05/0.5322, allocations: 8 kB / 0.5774 GB, free: 11.23 MB / 446.1 MB
Notification: Performance of matching and sorting (n=280) (initialization): time 0.005497/0.5377, allocations: 3.056 MB / 0.5804 GB, free: 8.129 MB / 446.1 MB
Notification: Performance of prepare postOptimizeDAE: time 3.131e-05/0.5377, allocations: 19.94 kB / 0.5804 GB, free: 8.109 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.001082/0.5388, allocations: 0.6084 MB / 0.581 GB, free: 7.496 MB / 446.1 MB
Error: post-optimization module simplifyComplexFunction (initialization) failed.
Error: No system for the symbolic initialization was generated