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.001381/0.001381, allocations: 109.1 kB / 20.43 MB, free: 4.57 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.0014/0.0014, allocations: 209.5 kB / 23.73 MB, free: 2.133 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 0.9588/0.9588, allocations: 230.6 MB / 257.5 MB, free: 9.594 MB / 202.7 MB
"
[Timeout remaining time 179]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerSystems 2.1.0-master/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerSystems 2.1.0-master/package.mo): time 0.1242/0.1242, allocations: 38.59 MB / 352.5 MB, free: 11.35 MB / 282.7 MB
"
[Timeout remaining time 180]
Using package PowerSystems with version 2.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/PowerSystems 2.1.0-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: setCommandLineOptions("--fmiFlags=s:cvode")
Running command: "" <> buildModelFMU(PowerSystems.Examples.AC3ph.Transformation.PhaseShifts,fileNamePrefix="PowerSystems_latest_PowerSystems_Examples_AC3ph_Transformation_PhaseShifts",fmuType="me_cs",version="2.0",platforms={"static"})
"" <> buildModelFMU(PowerSystems.Examples.AC3ph.Transformation.PhaseShifts,fileNamePrefix="PowerSystems_latest_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.001514/0.001514, allocations: 80.16 kB / 494.1 MB, free: 3.781 MB / 346.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.08922/0.09073, allocations: 62.49 MB / 0.5435 GB, free: 5.176 MB / 410.7 MB
Notification: Performance of NFInst.instantiate(PowerSystems.Examples.AC3ph.Transformation.PhaseShifts): time 0.007803/0.09853, allocations: 10.54 MB / 0.5538 GB, free: 10.58 MB / 426.7 MB
Notification: Performance of NFInst.instExpressions: time 0.004797/0.1033, allocations: 3.984 MB / 0.5577 GB, free: 6.582 MB / 426.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0007201/0.104, allocations: 63.44 kB / 0.5578 GB, free: 6.52 MB / 426.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.001831/0.1059, allocations: 1.391 MB / 0.5591 GB, free: 5.125 MB / 426.7 MB
Notification: Performance of NFTyping.typeBindings: time 0.002358/0.1082, allocations: 1.529 MB / 0.5606 GB, free: 3.59 MB / 426.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.001692/0.1099, allocations: 0.9199 MB / 0.5615 GB, free: 2.668 MB / 426.7 MB
Notification: Performance of NFFlatten.flatten: time 0.1953/0.3053, allocations: 3.269 MB / 0.5647 GB, free: 10.98 MB / 426.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.00113/0.3064, allocations: 0.8434 MB / 0.5655 GB, free: 10.91 MB / 426.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.001795/0.3082, allocations: 1.415 MB / 0.5669 GB, free: 10.84 MB / 426.7 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.002045/0.3102, allocations: 2.013 MB / 0.5689 GB, free: 10.69 MB / 426.7 MB
Notification: Performance of NFPackage.collectConstants: time 0.0002728/0.3105, allocations: 175.9 kB / 0.5691 GB, free: 10.69 MB / 426.7 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.001274/0.3118, allocations: 0.7659 MB / 0.5698 GB, free: 10.69 MB / 426.7 MB
Notification: Performance of NFScalarize.scalarize: time 0.001025/0.3128, allocations: 1.315 MB / 0.5711 GB, free: 10.57 MB / 426.7 MB
Notification: Performance of NFVerifyModel.verify: time 0.0009046/0.3137, allocations: 0.9981 MB / 0.5721 GB, free: 10.31 MB / 426.7 MB
Notification: Performance of NFConvertDAE.convert: time 0.003316/0.317, allocations: 3.234 MB / 0.5752 GB, free: 9.828 MB / 426.7 MB
Notification: Performance of FrontEnd - DAE generated: time 5.581e-06/0.317, allocations: 2.156 kB / 0.5752 GB, free: 9.828 MB / 426.7 MB
Notification: Performance of FrontEnd: time 2.334e-06/0.317, allocations: 0 / 0.5752 GB, free: 9.828 MB / 426.7 MB
Notification: Performance of Transformations before backend: time 6.062e-05/0.3171, allocations: 0 / 0.5752 GB, free: 9.828 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.004094/0.3212, allocations: 2.543 MB / 0.5777 GB, free: 8.691 MB / 426.7 MB
Notification: Performance of prepare preOptimizeDAE: time 4.628e-05/0.3212, allocations: 9.969 kB / 0.5777 GB, free: 8.691 MB / 426.7 MB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.0003222/0.3216, allocations: 317.2 kB / 0.578 GB, free: 8.641 MB / 426.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.001985/0.3235, allocations: 0.6196 MB / 0.5786 GB, free: 8.504 MB / 426.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.002047/0.3256, allocations: 1.318 MB / 0.5799 GB, free: 8.113 MB / 426.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001098/0.3257, allocations: 145.1 kB / 0.5801 GB, free: 8.109 MB / 426.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0003918/0.3261, allocations: 226.2 kB / 0.5803 GB, free: 8.102 MB / 426.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.003883/0.33, allocations: 3.15 MB / 0.5833 GB, free: 7.539 MB / 426.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 4.617e-05/0.33, allocations: 17.17 kB / 0.5834 GB, free: 7.535 MB / 426.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001521/0.3302, allocations: 81.7 kB / 0.5834 GB, free: 7.535 MB / 426.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.00046/0.3306, allocations: 319.9 kB / 0.5837 GB, free: 7.527 MB / 426.7 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.003236/0.3339, allocations: 2.557 MB / 0.5862 GB, free: 7.125 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.009668/0.3435, allocations: 12 MB / 0.598 GB, free: 14.75 MB / 442.7 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.001432/0.345, allocations: 1.238 MB / 0.5992 GB, free: 14.28 MB / 442.7 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0006458/0.3456, allocations: 0.584 MB / 0.5997 GB, free: 14 MB / 442.7 MB
Notification: Performance of preOpt evalFunc (simulation): time 5.972e-05/0.3457, allocations: 31.42 kB / 0.5998 GB, free: 13.98 MB / 442.7 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.207e-05/0.3457, allocations: 47.28 kB / 0.5998 GB, free: 13.94 MB / 442.7 MB
Notification: Performance of pre-optimization done (n=132): time 3.046e-06/0.3457, allocations: 0 / 0.5998 GB, free: 13.94 MB / 442.7 MB
Notification: Performance of matching and sorting (n=134): time 0.004774/0.3505, allocations: 3.927 MB / 0.6037 GB, free: 11.74 MB / 442.7 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 5.104e-05/0.3505, allocations: 94.61 kB / 0.6037 GB, free: 11.64 MB / 442.7 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001199/0.3517, allocations: 1.321 MB / 0.605 GB, free: 10.91 MB / 442.7 MB
Notification: Performance of collectPreVariables (initialization): time 5.914e-05/0.3518, allocations: 45.83 kB / 0.6051 GB, free: 10.86 MB / 442.7 MB
Notification: Performance of collectInitialEqns (initialization): time 0.0004985/0.3523, allocations: 1.125 MB / 0.6062 GB, free: 9.867 MB / 442.7 MB
Notification: Performance of collectInitialBindings (initialization): time 0.0002635/0.3526, allocations: 0.4984 MB / 0.6067 GB, free: 9.438 MB / 442.7 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0003702/0.3529, allocations: 409.1 kB / 0.6071 GB, free: 9.211 MB / 442.7 MB
Notification: Performance of setup shared object (initialization): time 6.311e-05/0.353, allocations: 302.4 kB / 0.6073 GB, free: 8.914 MB / 442.7 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0007488/0.3537, allocations: 0.6803 MB / 0.608 GB, free: 8.598 MB / 442.7 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001031/0.3548, allocations: 1.588 MB / 0.6096 GB, free: 7.09 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.005619/0.3604, allocations: 4.527 MB / 0.614 GB, free: 4.242 MB / 442.7 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.513e-05/0.3604, allocations: 13.19 kB / 0.614 GB, free: 4.238 MB / 442.7 MB
Notification: Performance of matching and sorting (n=280) (initialization): time 0.003405/0.3638, allocations: 2.958 MB / 0.6169 GB, free: 2.121 MB / 442.7 MB
Notification: Performance of prepare postOptimizeDAE: time 2.555e-05/0.3638, allocations: 16 kB / 0.6169 GB, free: 2.105 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.0006639/0.3645, allocations: 0.6137 MB / 0.6175 GB, free: 1.488 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.3507514242082834]