Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr PowerSystems_PowerSystems.Examples.AC3ph.Transformation.PhaseShifts.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo): time 0.000978/0.000978, allocations: 107.9 kB / 20.43 MB, free: 4.598 MB / 13.93 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo): time 0.001687/0.001687, allocations: 221.5 kB / 23.74 MB, free: 2.129 MB / 13.93 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo): time 1.066/1.066, allocations: 230.6 MB / 257.5 MB, free: 9.578 MB / 202.7 MB
"
[Timeout remaining time 179]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerSystems 2.0.0/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerSystems 2.0.0/package.mo): time 0.1377/0.1377, allocations: 38.56 MB / 352.5 MB, free: 11.39 MB / 282.7 MB
"
[Timeout remaining time 180]
Using package PowerSystems with version 2.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerSystems 2.0.0/package.mo)
Using package Modelica with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo)
Using package Complex with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo)
Using package ModelicaServices with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo)
Running command: setCommandLineOptions("--fmiFlags=s:cvode")
Running command: "" <> buildModelFMU(PowerSystems.Examples.AC3ph.Transformation.PhaseShifts,fileNamePrefix="PowerSystems_PowerSystems_Examples_AC3ph_Transformation_PhaseShifts",fmuType="me_cs",version="2.0",platforms={"static"})
"" <> buildModelFMU(PowerSystems.Examples.AC3ph.Transformation.PhaseShifts,fileNamePrefix="PowerSystems_PowerSystems_Examples_AC3ph_Transformation_PhaseShifts",fmuType="me_cs",version="2.0",platforms={"static"}) [Timeout 660]
"Notification: PowerSystems requested package Modelica of version 4.0.0. Modelica 4.1.0 is used instead which states that it is fully compatible without conversion script needed.
Notification: Performance of FrontEnd - loaded program: time 0.002207/0.002207, allocations: 71.89 kB / 493.3 MB, free: 4.539 MB / 346.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1156/0.1178, allocations: 62.47 MB / 0.5427 GB, free: 5.977 MB / 410.7 MB
Notification: Performance of NFInst.instantiate(PowerSystems.Examples.AC3ph.Transformation.PhaseShifts): time 0.007955/0.1258, allocations: 10.5 MB / 0.553 GB, free: 11.43 MB / 426.7 MB
Notification: Performance of NFInst.instExpressions: time 0.005135/0.1309, allocations: 3.984 MB / 0.5569 GB, free: 7.43 MB / 426.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0005185/0.1314, allocations: 71.31 kB / 0.5569 GB, free: 7.359 MB / 426.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.001758/0.1332, allocations: 1.376 MB / 0.5583 GB, free: 5.98 MB / 426.7 MB
Notification: Performance of NFTyping.typeBindings: time 0.001843/0.135, allocations: 1.525 MB / 0.5598 GB, free: 4.449 MB / 426.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.001241/0.1363, allocations: 0.9238 MB / 0.5607 GB, free: 3.523 MB / 426.7 MB
Notification: Performance of NFFlatten.flatten: time 0.002082/0.1384, allocations: 3.279 MB / 0.5639 GB, free: 240 kB / 426.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.2024/0.3408, allocations: 0.8401 MB / 0.5647 GB, free: 10.53 MB / 426.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.00194/0.3427, allocations: 1.424 MB / 0.5661 GB, free: 10.48 MB / 426.7 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.001729/0.3445, allocations: 2.009 MB / 0.568 GB, free: 10.33 MB / 426.7 MB
Notification: Performance of NFPackage.collectConstants: time 0.0002381/0.3447, allocations: 175.9 kB / 0.5682 GB, free: 10.33 MB / 426.7 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.001177/0.3459, allocations: 0.7648 MB / 0.569 GB, free: 10.33 MB / 426.7 MB
Notification: Performance of NFScalarize.scalarize: time 0.0009756/0.3469, allocations: 1.309 MB / 0.5702 GB, free: 10.21 MB / 426.7 MB
Notification: Performance of NFVerifyModel.verify: time 0.0008929/0.3478, allocations: 1.006 MB / 0.5712 GB, free: 9.949 MB / 426.7 MB
Notification: Performance of NFConvertDAE.convert: time 0.002811/0.3506, allocations: 3.231 MB / 0.5744 GB, free: 9.473 MB / 426.7 MB
Notification: Performance of FrontEnd - DAE generated: time 5.4e-06/0.3506, allocations: 1.312 kB / 0.5744 GB, free: 9.473 MB / 426.7 MB
Notification: Performance of FrontEnd: time 1.713e-06/0.3506, allocations: 0 / 0.5744 GB, free: 9.473 MB / 426.7 MB
Notification: Performance of Transformations before backend: time 4.877e-05/0.3506, allocations: 2.438 kB / 0.5744 GB, free: 9.473 MB / 426.7 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.003214/0.3538, allocations: 2.538 MB / 0.5769 GB, free: 8.336 MB / 426.7 MB
Notification: Performance of prepare preOptimizeDAE: time 4.41e-05/0.3539, allocations: 8.5 kB / 0.5769 GB, free: 8.336 MB / 426.7 MB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.000325/0.3542, allocations: 316.5 kB / 0.5772 GB, free: 8.285 MB / 426.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.001804/0.356, allocations: 0.618 MB / 0.5778 GB, free: 8.148 MB / 426.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.001975/0.358, allocations: 1.317 MB / 0.5791 GB, free: 7.77 MB / 426.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 6.901e-05/0.3581, allocations: 142.8 kB / 0.5792 GB, free: 7.766 MB / 426.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0003557/0.3584, allocations: 223.7 kB / 0.5794 GB, free: 7.758 MB / 426.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.00397/0.3624, allocations: 3.144 MB / 0.5825 GB, free: 7.199 MB / 426.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 4.863e-05/0.3624, allocations: 24.59 kB / 0.5825 GB, free: 7.188 MB / 426.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001602/0.3626, allocations: 80.58 kB / 0.5826 GB, free: 7.188 MB / 426.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.000469/0.3631, allocations: 323.9 kB / 0.5829 GB, free: 7.18 MB / 426.7 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.003336/0.3664, allocations: 2.553 MB / 0.5854 GB, free: 7.113 MB / 426.7 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.01005/0.3764, allocations: 12.01 MB / 0.5971 GB, free: 14.73 MB / 442.7 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.001502/0.378, allocations: 1.236 MB / 0.5983 GB, free: 14.31 MB / 442.7 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0007306/0.3787, allocations: 0.5941 MB / 0.5989 GB, free: 14.09 MB / 442.7 MB
Notification: Performance of preOpt evalFunc (simulation): time 6.968e-05/0.3788, allocations: 20.42 kB / 0.5989 GB, free: 14.09 MB / 442.7 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 4.181e-05/0.3788, allocations: 54.62 kB / 0.599 GB, free: 14.03 MB / 442.7 MB
Notification: Performance of pre-optimization done (n=132): time 3.977e-06/0.3788, allocations: 0 / 0.599 GB, free: 14.03 MB / 442.7 MB
Notification: Performance of matching and sorting (n=134): time 0.005019/0.3838, allocations: 3.919 MB / 0.6028 GB, free: 11.83 MB / 442.7 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 4.625e-05/0.3839, allocations: 93.77 kB / 0.6029 GB, free: 11.74 MB / 442.7 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001148/0.385, allocations: 1.317 MB / 0.6042 GB, free: 11.01 MB / 442.7 MB
Notification: Performance of collectPreVariables (initialization): time 6.312e-05/0.3851, allocations: 50.98 kB / 0.6042 GB, free: 10.96 MB / 442.7 MB
Notification: Performance of collectInitialEqns (initialization): time 0.0005043/0.3856, allocations: 1.123 MB / 0.6053 GB, free: 9.965 MB / 442.7 MB
Notification: Performance of collectInitialBindings (initialization): time 0.0002848/0.3859, allocations: 0.4966 MB / 0.6058 GB, free: 9.539 MB / 442.7 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0003835/0.3862, allocations: 412.3 kB / 0.6062 GB, free: 9.309 MB / 442.7 MB
Notification: Performance of setup shared object (initialization): time 6.472e-05/0.3863, allocations: 301.1 kB / 0.6065 GB, free: 9.012 MB / 442.7 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0007355/0.387, allocations: 0.6781 MB / 0.6071 GB, free: 8.699 MB / 442.7 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001063/0.3881, allocations: 1.582 MB / 0.6087 GB, free: 7.195 MB / 442.7 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.005417/0.3935, allocations: 4.537 MB / 0.6131 GB, free: 4.34 MB / 442.7 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.408e-05/0.3935, allocations: 14.91 kB / 0.6131 GB, free: 4.336 MB / 442.7 MB
Notification: Performance of matching and sorting (n=280) (initialization): time 0.003152/0.3967, allocations: 2.95 MB / 0.616 GB, free: 2.484 MB / 442.7 MB
Notification: Performance of prepare postOptimizeDAE: time 2.757e-05/0.3967, allocations: 24.23 kB / 0.616 GB, free: 2.465 MB / 442.7 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.0006476/0.3974, allocations: 0.619 MB / 0.6166 GB, free: 1.844 MB / 442.7 MB
Error: post-optimization module simplifyComplexFunction (initialization) failed.
Error: No system for the symbolic initialization was generated
"
[Timeout remaining time 660]
[Calling sys.exit(0), Time elapsed: 2.5823563244193792]