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.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.001725/0.001725, allocations: 71.75 kB / 21.24 MB, free: 404 kB / 14.72 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.001581/0.001581, allocations: 166.8 kB / 24.5 MB, free: 3.457 MB / 14.72 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.489/1.489, allocations: 177.2 MB / 204.9 MB, free: 8.922 MB / 190.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerSystems master/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerSystems master/package.mo): time 0.1784/0.1784, allocations: 29.42 MB / 290.7 MB, free: 3.297 MB / 270.1 MB
"
[Timeout remaining time 180]
Using package PowerSystems with version 2.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerSystems master/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: translateModel(PowerSystems.Examples.AC3ph.Transformation.PhaseShifts,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,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=2500,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") [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.002042/0.002042, allocations: 71.89 kB / 431.2 MB, free: 3.238 MB / 398.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.339/0.341, allocations: 62.44 MB / 493.6 MB, free: 37.79 MB / 446.1 MB
Notification: Performance of NFInst.instantiate(PowerSystems.Examples.AC3ph.Transformation.PhaseShifts): time 0.00919/0.3502, allocations: 10.5 MB / 0.4923 GB, free: 30.76 MB / 446.1 MB
Notification: Performance of NFInst.instExpressions: time 0.007028/0.3572, allocations: 3.992 MB / 0.4962 GB, free: 28.07 MB / 446.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001283/0.3585, allocations: 64 kB / 0.4963 GB, free: 28.04 MB / 446.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.003422/0.3619, allocations: 1.383 MB / 0.4976 GB, free: 27.29 MB / 446.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.003442/0.3654, allocations: 1.531 MB / 0.4991 GB, free: 26.47 MB / 446.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.00263/0.368, allocations: 0.914 MB / 0.5 GB, free: 26.06 MB / 446.1 MB
Notification: Performance of NFFlatten.flatten: time 0.003587/0.3716, allocations: 3.276 MB / 0.5032 GB, free: 24.72 MB / 446.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.001222/0.3728, allocations: 0.8413 MB / 0.504 GB, free: 24.31 MB / 446.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.002386/0.3752, allocations: 1.418 MB / 0.5054 GB, free: 23.71 MB / 446.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.003033/0.3782, allocations: 2.026 MB / 0.5074 GB, free: 23.11 MB / 446.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.0003261/0.3786, allocations: 174.9 kB / 0.5076 GB, free: 23.11 MB / 446.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.001669/0.3802, allocations: 0.7659 MB / 0.5083 GB, free: 22.93 MB / 446.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.001051/0.3813, allocations: 1.31 MB / 0.5096 GB, free: 22.52 MB / 446.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.001164/0.3824, allocations: 1.008 MB / 0.5106 GB, free: 22 MB / 446.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.003813/0.3862, allocations: 3.229 MB / 0.5137 GB, free: 20.84 MB / 446.1 MB
Notification: Performance of FrontEnd - DAE generated: time 7.514e-06/0.3863, allocations: 4.562 kB / 0.5137 GB, free: 20.83 MB / 446.1 MB
Notification: Performance of FrontEnd: time 2.244e-06/0.3863, allocations: 0 / 0.5137 GB, free: 20.83 MB / 446.1 MB
Notification: Performance of Transformations before backend: time 0.0001055/0.3864, allocations: 1.531 kB / 0.5137 GB, free: 20.83 MB / 446.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.006024/0.3924, allocations: 2.54 MB / 0.5162 GB, free: 19.35 MB / 446.1 MB
Notification: Performance of prepare preOptimizeDAE: time 4.048e-05/0.3924, allocations: 12.2 kB / 0.5162 GB, free: 19.34 MB / 446.1 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.003292/0.3957, allocations: 0.6226 MB / 0.5168 GB, free: 19.2 MB / 446.1 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.003389/0.3991, allocations: 1.322 MB / 0.5181 GB, free: 18.51 MB / 446.1 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 9.594e-05/0.3992, allocations: 139.2 kB / 0.5183 GB, free: 18.45 MB / 446.1 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0004849/0.3997, allocations: 231.1 kB / 0.5185 GB, free: 18.36 MB / 446.1 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.005591/0.4053, allocations: 3.139 MB / 0.5215 GB, free: 16.92 MB / 446.1 MB
Notification: Performance of preOpt findStateOrder (simulation): time 7e-05/0.4053, allocations: 14.55 kB / 0.5216 GB, free: 16.91 MB / 446.1 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001971/0.4055, allocations: 84.48 kB / 0.5216 GB, free: 16.85 MB / 446.1 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0008443/0.4064, allocations: 326.5 kB / 0.522 GB, free: 16.81 MB / 446.1 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.005447/0.4118, allocations: 2.556 MB / 0.5245 GB, free: 15.99 MB / 446.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.019/0.4308, allocations: 11.75 MB / 0.5359 GB, free: 7.492 MB / 446.1 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.002253/0.4331, allocations: 1.231 MB / 0.5371 GB, free: 7.062 MB / 446.1 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0009688/0.4341, allocations: 0.5922 MB / 0.5377 GB, free: 6.859 MB / 446.1 MB
Notification: Performance of preOpt evalFunc (simulation): time 8.579e-05/0.4341, allocations: 19.89 kB / 0.5377 GB, free: 6.859 MB / 446.1 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.698e-05/0.4342, allocations: 50.89 kB / 0.5378 GB, free: 6.809 MB / 446.1 MB
Notification: Performance of pre-optimization done (n=132): time 4.128e-06/0.4342, allocations: 0 / 0.5378 GB, free: 6.809 MB / 446.1 MB
Notification: Performance of matching and sorting (n=134): time 0.01021/0.4444, allocations: 3.917 MB / 0.5416 GB, free: 4.949 MB / 446.1 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 8.094e-05/0.4445, allocations: 100.3 kB / 0.5417 GB, free: 4.844 MB / 446.1 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.003338/0.4478, allocations: 1.292 MB / 0.543 GB, free: 4.328 MB / 446.1 MB
Notification: Performance of collectPreVariables (initialization): time 0.0001764/0.448, allocations: 50.58 kB / 0.543 GB, free: 4.277 MB / 446.1 MB
Notification: Performance of collectInitialEqns (initialization): time 0.0008753/0.4489, allocations: 1.121 MB / 0.5441 GB, free: 3.395 MB / 446.1 MB
Notification: Performance of collectInitialBindings (initialization): time 0.0005333/0.4494, allocations: 0.498 MB / 0.5446 GB, free: 3 MB / 446.1 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0008295/0.4502, allocations: 415.1 kB / 0.545 GB, free: 2.797 MB / 446.1 MB
Notification: Performance of setup shared object (initialization): time 5.322e-05/0.4503, allocations: 303.2 kB / 0.5453 GB, free: 2.5 MB / 446.1 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001233/0.4515, allocations: 0.6788 MB / 0.5459 GB, free: 2.195 MB / 446.1 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001814/0.4533, allocations: 1.583 MB / 0.5475 GB, free: 0.6758 MB / 446.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.01125/0.4646, allocations: 4.538 MB / 0.5519 GB, free: 12.4 MB / 462.1 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 5.606e-05/0.4646, allocations: 12 kB / 0.5519 GB, free: 12.39 MB / 462.1 MB
Notification: Performance of matching and sorting (n=280) (initialization): time 0.006507/0.4711, allocations: 2.957 MB / 0.5548 GB, free: 9.41 MB / 462.1 MB
Notification: Performance of prepare postOptimizeDAE: time 5.038e-05/0.4712, allocations: 17.09 kB / 0.5548 GB, free: 9.395 MB / 462.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.001143/0.4723, allocations: 0.6161 MB / 0.5554 GB, free: 8.777 MB / 462.1 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: 3.0997365840012208]
Failed to read output from testmodel.py, exit status != 0:
0.4813073129625991 0.497752895 0.107905288
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f4db08d2e00>