Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr PowerSystems_PowerSystems.Examples.AC3ph.Inverters.InverterToGrid.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.001167/0.001167, allocations: 72.27 kB / 9.879 MB, free: 0.8203 MB / 10.45 MB
Notification: Performance of NFInstanceAPI.mkTop(<interactive>): time 0.001539/0.002707, allocations: 449.6 kB / 10.32 MB, free: 392 kB / 10.45 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.001378/0.001378, allocations: 149.9 kB / 11.2 MB, free: 2.98 MB / 13.93 MB
Notification: Performance of NFInstanceAPI.mkTop(<interactive>): time 0.001578/0.002955, allocations: 476.2 kB / 11.66 MB, free: 2.512 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.9446/0.9446, allocations: 177.1 MB / 189.5 MB, free: 3.766 MB / 186.7 MB
Notification: Performance of NFInstanceAPI.mkTop(<interactive>): time 0.1278/1.072, allocations: 53.66 MB / 243.2 MB, free: 2.359 MB / 234.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.1552/0.1552, allocations: 29.41 MB / 273.3 MB, free: 4.297 MB / 266.7 MB
Notification: Performance of NFInstanceAPI.mkTop(<interactive>): time 0.01455/0.1698, allocations: 9.538 MB / 282.9 MB, free: 10.73 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.Inverters.InverterToGrid,fileNamePrefix="PowerSystems_PowerSystems_Examples_AC3ph_Inverters_InverterToGrid",fmuType="me_cs",version="2.0+3.0",platforms={"static"})
"" <> buildModelFMU(PowerSystems.Examples.AC3ph.Inverters.InverterToGrid,fileNamePrefix="PowerSystems_PowerSystems_Examples_AC3ph_Inverters_InverterToGrid",fmuType="me_cs",version="2.0+3.0",platforms={"static"}) [Timeout 660]
"Notification: Performance of FrontEnd - loaded program: time 1.674e-06/1.674e-06, allocations: 0 / 284.1 MB, free: 9.504 MB / 282.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 1.816e-05/1.984e-05, allocations: 2.312 kB / 284.1 MB, free: 9.5 MB / 282.7 MB
Notification: Performance of NFInst.instantiate(PowerSystems.Examples.AC3ph.Inverters.InverterToGrid): time 0.008339/0.008358, allocations: 6.156 MB / 290.3 MB, free: 3.309 MB / 282.7 MB
Notification: Performance of NFInst.instExpressions: time 0.004178/0.01254, allocations: 2.383 MB / 292.7 MB, free: 0.918 MB / 282.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0003282/0.01286, allocations: 39.69 kB / 292.7 MB, free: 0.8789 MB / 282.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.0005357/0.0134, allocations: 266.2 kB / 293 MB, free: 0.6172 MB / 282.7 MB
Notification: Performance of NFTyping.typeBindings: time 0.0007557/0.01416, allocations: 0.6294 MB / 293.6 MB, free: 15.98 MB / 298.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.0006137/0.01477, allocations: 0.5377 MB / 294.1 MB, free: 15.45 MB / 298.7 MB
Notification: Performance of NFFlatten.flatten: time 0.001156/0.01593, allocations: 2.042 MB / 296.2 MB, free: 13.4 MB / 298.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.0005383/0.01646, allocations: 0.6741 MB / 296.8 MB, free: 12.71 MB / 298.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.0009322/0.0174, allocations: 1.166 MB / 298 MB, free: 11.54 MB / 298.7 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.0007045/0.0181, allocations: 0.8612 MB / 298.9 MB, free: 10.68 MB / 298.7 MB
Notification: Performance of NFPackage.collectConstants: time 0.0001341/0.01824, allocations: 140 kB / 299 MB, free: 10.54 MB / 298.7 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.0006233/0.01886, allocations: 0.663 MB / 299.7 MB, free: 9.875 MB / 298.7 MB
Notification: Performance of NFScalarize.scalarize: time 0.0003471/0.01921, allocations: 0.5536 MB / 300.2 MB, free: 9.32 MB / 298.7 MB
Notification: Performance of NFVerifyModel.verify: time 0.0003072/0.01951, allocations: 383.3 kB / 300.6 MB, free: 8.945 MB / 298.7 MB
Notification: Performance of NFConvertDAE.convert: time 0.000963/0.02048, allocations: 1.305 MB / 301.9 MB, free: 7.637 MB / 298.7 MB
Notification: Performance of FrontEnd - DAE generated: time 7.935e-06/0.02048, allocations: 0 / 301.9 MB, free: 7.637 MB / 298.7 MB
Notification: Performance of FrontEnd: time 1.012e-06/0.02048, allocations: 0 / 301.9 MB, free: 7.637 MB / 298.7 MB
Notification: Performance of Transformations before backend: time 1.405e-05/0.0205, allocations: 0 / 301.9 MB, free: 7.637 MB / 298.7 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 264
 * Number of variables: 264
Notification: Performance of Generate backend data structure: time 0.001818/0.02232, allocations: 1.607 MB / 303.5 MB, free: 5.973 MB / 298.7 MB
Notification: Performance of prepare preOptimizeDAE: time 2.996e-05/0.02235, allocations: 8.031 kB / 303.5 MB, free: 5.965 MB / 298.7 MB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.0001376/0.02248, allocations: 172.6 kB / 303.7 MB, free: 5.785 MB / 298.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0006073/0.02309, allocations: 361.7 kB / 304 MB, free: 5.414 MB / 298.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.0006454/0.02374, allocations: 0.6547 MB / 304.7 MB, free: 4.734 MB / 298.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0004485/0.02419, allocations: 1.094 MB / 305.8 MB, free: 3.418 MB / 298.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001588/0.02434, allocations: 112.4 kB / 305.9 MB, free: 3.309 MB / 298.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.001045/0.02539, allocations: 1.037 MB / 306.9 MB, free: 2.207 MB / 298.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 1.961e-05/0.02541, allocations: 0 / 306.9 MB, free: 2.207 MB / 298.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 7.381e-05/0.02548, allocations: 32 kB / 307 MB, free: 2.176 MB / 298.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001047/0.02559, allocations: 85.95 kB / 307 MB, free: 2.094 MB / 298.7 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.0007118/0.0263, allocations: 0.5511 MB / 307.6 MB, free: 1.539 MB / 298.7 MB
Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.003659/0.02996, allocations: 3.712 MB / 311.3 MB, free: 13.71 MB / 314.7 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.0006953/0.03065, allocations: 0.5394 MB / 311.8 MB, free: 13.14 MB / 314.7 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0003391/0.03099, allocations: 283.4 kB / 312.1 MB, free: 12.86 MB / 314.7 MB
Notification: Performance of preOpt evalFunc (simulation): time 5.865e-05/0.03105, allocations: 17 kB / 312.1 MB, free: 12.85 MB / 314.7 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0005319/0.03158, allocations: 0.581 MB / 312.7 MB, free: 12.25 MB / 314.7 MB
Notification: Performance of pre-optimization done (n=116): time 2.114e-06/0.03158, allocations: 4 kB / 312.7 MB, free: 12.24 MB / 314.7 MB
Notification: Performance of matching and sorting (n=118): time 0.00612/0.0377, allocations: 3.428 MB / 316.2 MB, free: 8.777 MB / 314.7 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 4.386e-05/0.03775, allocations: 110 kB / 316.3 MB, free: 8.652 MB / 314.7 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0003427/0.03809, allocations: 455 kB / 316.7 MB, free: 8.195 MB / 314.7 MB
Notification: Performance of collectPreVariables (initialization): time 7.243e-05/0.03816, allocations: 53.69 kB / 316.8 MB, free: 8.137 MB / 314.7 MB
Notification: Performance of collectInitialEqns (initialization): time 0.0001352/0.0383, allocations: 350.5 kB / 317.1 MB, free: 7.789 MB / 314.7 MB
Notification: Performance of collectInitialBindings (initialization): time 0.0002/0.0385, allocations: 400.5 kB / 317.5 MB, free: 7.395 MB / 314.7 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0002279/0.03873, allocations: 210.7 kB / 317.7 MB, free: 7.184 MB / 314.7 MB
Notification: Performance of setup shared object (initialization): time 9.783e-05/0.03882, allocations: 402.6 kB / 318.1 MB, free: 6.781 MB / 314.7 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0003132/0.03914, allocations: 283.1 kB / 318.4 MB, free: 6.496 MB / 314.7 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0003547/0.03949, allocations: 459.8 kB / 318.8 MB, free: 5.988 MB / 314.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.001168/0.04066, allocations: 1.065 MB / 319.9 MB, free: 4.852 MB / 314.7 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 2.605e-06/0.04066, allocations: 0 / 319.9 MB, free: 4.852 MB / 314.7 MB
Notification: Performance of matching and sorting (n=158) (initialization): time 0.003121/0.04378, allocations: 1.973 MB / 321.9 MB, free: 2.855 MB / 314.7 MB
Notification: Performance of prepare postOptimizeDAE: time 4.768e-05/0.04383, allocations: 53.62 kB / 321.9 MB, free: 2.797 MB / 314.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.0004112/0.04424, allocations: 371.3 kB / 322.3 MB, free: 2.43 MB / 314.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: 1.6144614424556494]